| node0 | 0.000ns | 2025-10-14 11:25:50.943 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node0 | 86.000ms | 2025-10-14 11:25:51.029 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node0 | 101.000ms | 2025-10-14 11:25:51.044 | 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 | 102.000ms | 2025-10-14 11:25:51.045 | 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 | 211.000ms | 2025-10-14 11:25:51.154 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [0] are set to run locally | |
| node0 | 218.000ms | 2025-10-14 11:25:51.161 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node0 | 246.000ms | 2025-10-14 11:25:51.189 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 247.000ms | 2025-10-14 11:25:51.190 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 247.000ms | 2025-10-14 11:25:51.190 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 248.000ms | 2025-10-14 11:25:51.191 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 248.000ms | 2025-10-14 11:25:51.191 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 249.000ms | 2025-10-14 11:25:51.192 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 249.000ms | 2025-10-14 11:25:51.192 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 250.000ms | 2025-10-14 11:25:51.193 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 251.000ms | 2025-10-14 11:25:51.194 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 251.000ms | 2025-10-14 11:25:51.194 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 251.000ms | 2025-10-14 11:25:51.194 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 252.000ms | 2025-10-14 11:25:51.195 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 252.000ms | 2025-10-14 11:25:51.195 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 253.000ms | 2025-10-14 11:25:51.196 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 253.000ms | 2025-10-14 11:25:51.196 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node0 | 651.000ms | 2025-10-14 11:25:51.594 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node3 | 693.000ms | 2025-10-14 11:25:51.636 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node2 | 732.000ms | 2025-10-14 11:25:51.675 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node3 | 791.000ms | 2025-10-14 11:25:51.734 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node3 | 809.000ms | 2025-10-14 11:25:51.752 | 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 | 810.000ms | 2025-10-14 11:25:51.753 | 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 | 824.000ms | 2025-10-14 11:25:51.767 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node2 | 841.000ms | 2025-10-14 11:25:51.784 | 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 | 842.000ms | 2025-10-14 11:25:51.785 | 4 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node3 | 938.000ms | 2025-10-14 11:25:51.881 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [3] are set to run locally | |
| node3 | 947.000ms | 2025-10-14 11:25:51.890 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node2 | 968.000ms | 2025-10-14 11:25:51.911 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [2] are set to run locally | |
| node2 | 975.000ms | 2025-10-14 11:25:51.918 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node3 | 980.000ms | 2025-10-14 11:25:51.923 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 982.000ms | 2025-10-14 11:25:51.925 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 982.000ms | 2025-10-14 11:25:51.925 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 983.000ms | 2025-10-14 11:25:51.926 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 983.000ms | 2025-10-14 11:25:51.926 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 984.000ms | 2025-10-14 11:25:51.927 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 984.000ms | 2025-10-14 11:25:51.927 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 985.000ms | 2025-10-14 11:25:51.928 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 985.000ms | 2025-10-14 11:25:51.928 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 986.000ms | 2025-10-14 11:25:51.929 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 986.000ms | 2025-10-14 11:25:51.929 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 987.000ms | 2025-10-14 11:25:51.930 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 987.000ms | 2025-10-14 11:25:51.930 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 988.000ms | 2025-10-14 11:25:51.931 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 988.000ms | 2025-10-14 11:25:51.931 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node2 | 1.006s | 2025-10-14 11:25:51.949 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 1.008s | 2025-10-14 11:25:51.951 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 1.008s | 2025-10-14 11:25:51.951 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.009s | 2025-10-14 11:25:51.952 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 1.009s | 2025-10-14 11:25:51.952 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.009s | 2025-10-14 11:25:51.952 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 1.010s | 2025-10-14 11:25:51.953 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.011s | 2025-10-14 11:25:51.954 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 1.011s | 2025-10-14 11:25:51.954 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 1.012s | 2025-10-14 11:25:51.955 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.012s | 2025-10-14 11:25:51.955 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 1.013s | 2025-10-14 11:25:51.956 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.013s | 2025-10-14 11:25:51.956 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 1.013s | 2025-10-14 11:25:51.956 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.014s | 2025-10-14 11:25:51.957 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node1 | 1.026s | 2025-10-14 11:25:51.969 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node1 | 1.120s | 2025-10-14 11:25:52.063 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node1 | 1.137s | 2025-10-14 11:25:52.080 | 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 | 1.138s | 2025-10-14 11:25:52.081 | 4 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node1 | 1.260s | 2025-10-14 11:25:52.203 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [1] are set to run locally | |
| node1 | 1.269s | 2025-10-14 11:25:52.212 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node1 | 1.303s | 2025-10-14 11:25:52.246 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 1.304s | 2025-10-14 11:25:52.247 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 1.305s | 2025-10-14 11:25:52.248 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.305s | 2025-10-14 11:25:52.248 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 1.306s | 2025-10-14 11:25:52.249 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.306s | 2025-10-14 11:25:52.249 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 1.307s | 2025-10-14 11:25:52.250 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.308s | 2025-10-14 11:25:52.251 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 1.308s | 2025-10-14 11:25:52.251 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 1.308s | 2025-10-14 11:25:52.251 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.309s | 2025-10-14 11:25:52.252 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 1.309s | 2025-10-14 11:25:52.252 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.309s | 2025-10-14 11:25:52.252 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 1.310s | 2025-10-14 11:25:52.253 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.310s | 2025-10-14 11:25:52.253 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node3 | 1.425s | 2025-10-14 11:25:52.368 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node2 | 1.432s | 2025-10-14 11:25:52.375 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node0 | 1.529s | 2025-10-14 11:25:52.472 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 876ms | |
| node0 | 1.536s | 2025-10-14 11:25:52.479 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 1.536s | 2025-10-14 11:25:52.479 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 1.578s | 2025-10-14 11:25:52.521 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node0 | 1.638s | 2025-10-14 11:25:52.581 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node0 | 1.639s | 2025-10-14 11:25:52.582 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node1 | 1.728s | 2025-10-14 11:25:52.671 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node2 | 2.368s | 2025-10-14 11:25:53.311 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 936ms | |
| node2 | 2.376s | 2025-10-14 11:25:53.319 | 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.376s | 2025-10-14 11:25:53.319 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node2 | 2.416s | 2025-10-14 11:25:53.359 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node2 | 2.486s | 2025-10-14 11:25:53.429 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node2 | 2.487s | 2025-10-14 11:25:53.430 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node3 | 2.537s | 2025-10-14 11:25:53.480 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 1111ms | |
| node3 | 2.543s | 2025-10-14 11:25:53.486 | 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 | 2.544s | 2025-10-14 11:25:53.487 | 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 | 2.584s | 2025-10-14 11:25:53.527 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node3 | 2.643s | 2025-10-14 11:25:53.586 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node3 | 2.644s | 2025-10-14 11:25:53.587 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node1 | 2.667s | 2025-10-14 11:25:53.610 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 938ms | |
| node1 | 2.674s | 2025-10-14 11:25:53.617 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node1 | 2.675s | 2025-10-14 11:25:53.618 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node1 | 2.723s | 2025-10-14 11:25:53.666 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node1 | 2.795s | 2025-10-14 11:25:53.738 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node1 | 2.796s | 2025-10-14 11:25:53.739 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node0 | 3.658s | 2025-10-14 11:25:54.601 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node0 | 3.738s | 2025-10-14 11:25:54.681 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node0 | 3.739s | 2025-10-14 11:25:54.682 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 3.739s | 2025-10-14 11:25:54.682 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 3.739s | 2025-10-14 11:25:54.682 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 3.740s | 2025-10-14 11:25:54.683 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 3.740s | 2025-10-14 11:25:54.683 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 3.740s | 2025-10-14 11:25:54.683 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 3.741s | 2025-10-14 11:25:54.684 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 4.500s | 2025-10-14 11:25:55.443 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node0 | 4.553s | 2025-10-14 11:25:55.496 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node0 | 4.560s | 2025-10-14 11:25:55.503 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node2 | 4.593s | 2025-10-14 11:25:55.536 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node2 | 4.594s | 2025-10-14 11:25:55.537 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 4.595s | 2025-10-14 11:25:55.538 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 4.595s | 2025-10-14 11:25:55.538 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 4.595s | 2025-10-14 11:25:55.538 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 4.596s | 2025-10-14 11:25:55.539 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 4.596s | 2025-10-14 11:25:55.539 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 4.596s | 2025-10-14 11:25:55.539 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 4.709s | 2025-10-14 11:25:55.652 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node3 | 4.795s | 2025-10-14 11:25:55.738 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node3 | 4.795s | 2025-10-14 11:25:55.738 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 4.796s | 2025-10-14 11:25:55.739 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 4.796s | 2025-10-14 11:25:55.739 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 4.796s | 2025-10-14 11:25:55.739 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 4.797s | 2025-10-14 11:25:55.740 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 4.797s | 2025-10-14 11:25:55.740 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 4.797s | 2025-10-14 11:25:55.740 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 4.856s | 2025-10-14 11:25:55.799 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node1 | 4.936s | 2025-10-14 11:25:55.879 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node1 | 4.937s | 2025-10-14 11:25:55.880 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 4.938s | 2025-10-14 11:25:55.881 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 4.938s | 2025-10-14 11:25:55.881 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 4.938s | 2025-10-14 11:25:55.881 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 4.938s | 2025-10-14 11:25:55.881 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 4.939s | 2025-10-14 11:25:55.882 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 4.939s | 2025-10-14 11:25:55.882 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 5.394s | 2025-10-14 11:25:56.337 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node2 | 5.399s | 2025-10-14 11:25:56.342 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node3 | 5.606s | 2025-10-14 11:25:56.549 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node3 | 5.611s | 2025-10-14 11:25:56.554 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node0 | 5.684s | 2025-10-14 11:25:56.627 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26238371] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=257920, randomLong=-7461716918387135447, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=14340, randomLong=-6652039613372609863, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1322360, data=35, exception=null] OS Health Check Report - Complete (took 1019 ms) | |||||||||
| node0 | 5.711s | 2025-10-14 11:25:56.654 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node0 | 5.718s | 2025-10-14 11:25:56.661 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node0 | 5.723s | 2025-10-14 11:25:56.666 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node1 | 5.758s | 2025-10-14 11:25:56.701 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node1 | 5.763s | 2025-10-14 11:25:56.706 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node0 | 5.799s | 2025-10-14 11:25:56.742 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "Ih3DIw==", "port": 30124 }, { "ipAddressV4": "CoAP6A==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "IjyF0A==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "I+AD8w==", "port": 30126 }, { "ipAddressV4": "CoAP6Q==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "iHNpbw==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] } | |||||||||
| node0 | 5.892s | 2025-10-14 11:25:56.835 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node0 | 5.893s | 2025-10-14 11:25:56.836 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node0 | 5.907s | 2025-10-14 11:25:56.850 | 60 | INFO | STARTUP | <main> | StateInitializer: | The platform is using the following initial state: | |
| Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 554926cdd50283b760aa580b741feec993834e7a0a005b955a88ef88d7e22a3ea593a91fe4f68f96fcd8027a248245df (root) PlatformTestingToolState / powder-super-garlic-matrix 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 canvas-fetch-drop-device 2 SingletonNode RosterService.ROSTER_STATE /2 once-hammer-dentist-split 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.120s | 2025-10-14 11:25:57.063 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node0 | 6.124s | 2025-10-14 11:25:57.067 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node0 | 6.133s | 2025-10-14 11:25:57.076 | 64 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node0 | 6.133s | 2025-10-14 11:25:57.076 | 65 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node0 | 6.133s | 2025-10-14 11:25:57.076 | 66 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node0 | 6.134s | 2025-10-14 11:25:57.077 | 67 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node0 | 6.134s | 2025-10-14 11:25:57.077 | 68 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node0 | 6.134s | 2025-10-14 11:25:57.077 | 69 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node0 | 6.135s | 2025-10-14 11:25:57.078 | 70 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node0 | 6.135s | 2025-10-14 11:25:57.078 | 71 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node0 | 6.135s | 2025-10-14 11:25:57.078 | 72 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node0 | 6.135s | 2025-10-14 11:25:57.078 | 73 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node0 | 6.136s | 2025-10-14 11:25:57.079 | 74 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node0 | 6.136s | 2025-10-14 11:25:57.079 | 75 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node0 | 6.136s | 2025-10-14 11:25:57.079 | 76 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node0 | 6.136s | 2025-10-14 11:25:57.079 | 77 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node0 | 6.137s | 2025-10-14 11:25:57.080 | 78 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node0 | 6.153s | 2025-10-14 11:25:57.096 | 79 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | insertSeq = true | |
| node0 | 6.153s | 2025-10-14 11:25:57.096 | 80 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | appendSig = true | |
| node0 | 6.154s | 2025-10-14 11:25:57.097 | 81 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | variedSize = false | |
| node0 | 6.154s | 2025-10-14 11:25:57.097 | 82 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | payloadByteSize = 100 | |
| node0 | 6.154s | 2025-10-14 11:25:57.097 | 83 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | maxByteSize = 100 | |
| node0 | 6.155s | 2025-10-14 11:25:57.098 | 84 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node0 | 6.155s | 2025-10-14 11:25:57.098 | 85 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node0 | 6.157s | 2025-10-14 11:25:57.100 | 86 | INFO | DEMO_INFO | <<start-node-0>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node0 | 6.161s | 2025-10-14 11:25:57.104 | 87 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@5e05073a | |
| node0 | 6.162s | 2025-10-14 11:25:57.105 | 88 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node0 | 6.163s | 2025-10-14 11:25:57.106 | 89 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node0 | 6.170s | 2025-10-14 11:25:57.113 | 94 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@17cb2dd, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@419ec2e4,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@7bfed3ac,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@52ccd010,snapshotInProgress=false] | |
| node0 | 6.178s | 2025-10-14 11:25:57.121 | 95 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node0 | 6.178s | 2025-10-14 11:25:57.121 | 96 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node0 | 6.183s | 2025-10-14 11:25:57.126 | 97 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 6860142293302928642 | |
| node0 | 6.183s | 2025-10-14 11:25:57.126 | 98 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node0 | 6.260s | 2025-10-14 11:25:57.203 | 99 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | Starting platform 0 | |
| node0 | 6.261s | 2025-10-14 11:25:57.204 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node0 | 6.265s | 2025-10-14 11:25:57.208 | 101 | INFO | STARTUP | <<start-node-0>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node0 | 6.266s | 2025-10-14 11:25:57.209 | 102 | INFO | STARTUP | <<start-node-0>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node0 | 6.266s | 2025-10-14 11:25:57.209 | 103 | INFO | STARTUP | <<start-node-0>> | InputWireChecks: | All input wires have been bound. | |
| node0 | 6.268s | 2025-10-14 11:25:57.211 | 104 | WARN | STARTUP | <<start-node-0>> | PcesFileTracker: | No preconsensus event files available | |
| node0 | 6.269s | 2025-10-14 11:25:57.212 | 105 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node0 | 6.270s | 2025-10-14 11:25:57.213 | 106 | INFO | STARTUP | <<start-node-0>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node0 | 6.270s | 2025-10-14 11:25:57.213 | 107 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 starts transactions ........ | |
| node0 | 6.271s | 2025-10-14 11:25:57.214 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 313.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node0 | 6.275s | 2025-10-14 11:25:57.218 | 109 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node0 | 6.276s | 2025-10-14 11:25:57.219 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node0 | 6.276s | 2025-10-14 11:25:57.219 | 111 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node2 | 6.518s | 2025-10-14 11:25:57.461 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26258900] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=132420, randomLong=6267769032429610805, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=11820, randomLong=5753699296062731698, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1038020, data=35, exception=null] OS Health Check Report - Complete (took 1022 ms) | |||||||||
| node2 | 6.549s | 2025-10-14 11:25:57.492 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node2 | 6.556s | 2025-10-14 11:25:57.499 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node2 | 6.561s | 2025-10-14 11:25:57.504 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node2 | 6.642s | 2025-10-14 11:25:57.585 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "Ih3DIw==", "port": 30124 }, { "ipAddressV4": "CoAP6A==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "IjyF0A==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "I+AD8w==", "port": 30126 }, { "ipAddressV4": "CoAP6Q==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "iHNpbw==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] } | |||||||||
| node2 | 6.735s | 2025-10-14 11:25:57.678 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node2 | 6.736s | 2025-10-14 11:25:57.679 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node3 | 6.744s | 2025-10-14 11:25:57.687 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26215446] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=188110, randomLong=-6277105033402663545, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=12910, randomLong=475654957390528641, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1238620, data=35, exception=null] OS Health Check Report - Complete (took 1021 ms) | |||||||||
| node2 | 6.751s | 2025-10-14 11:25:57.694 | 60 | INFO | STARTUP | <main> | StateInitializer: | The platform is using the following initial state: | |
| Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 554926cdd50283b760aa580b741feec993834e7a0a005b955a88ef88d7e22a3ea593a91fe4f68f96fcd8027a248245df (root) PlatformTestingToolState / powder-super-garlic-matrix 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 canvas-fetch-drop-device 2 SingletonNode RosterService.ROSTER_STATE /2 once-hammer-dentist-split 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.774s | 2025-10-14 11:25:57.717 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node3 | 6.783s | 2025-10-14 11:25:57.726 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node3 | 6.788s | 2025-10-14 11:25:57.731 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node3 | 6.872s | 2025-10-14 11:25:57.815 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "Ih3DIw==", "port": 30124 }, { "ipAddressV4": "CoAP6A==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "IjyF0A==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "I+AD8w==", "port": 30126 }, { "ipAddressV4": "CoAP6Q==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "iHNpbw==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] } | |||||||||
| node1 | 6.880s | 2025-10-14 11:25:57.823 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26198870] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=176070, randomLong=-6003017887500799353, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=9800, randomLong=5770247578538727050, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=970690, data=35, exception=null] OS Health Check Report - Complete (took 1023 ms) | |||||||||
| node1 | 6.910s | 2025-10-14 11:25:57.853 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node1 | 6.919s | 2025-10-14 11:25:57.862 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node1 | 6.924s | 2025-10-14 11:25:57.867 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node2 | 6.934s | 2025-10-14 11:25:57.877 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node2 | 6.938s | 2025-10-14 11:25:57.881 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node2 | 6.946s | 2025-10-14 11:25:57.889 | 64 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node2 | 6.947s | 2025-10-14 11:25:57.890 | 65 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node2 | 6.947s | 2025-10-14 11:25:57.890 | 66 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node2 | 6.947s | 2025-10-14 11:25:57.890 | 67 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node2 | 6.948s | 2025-10-14 11:25:57.891 | 68 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node2 | 6.948s | 2025-10-14 11:25:57.891 | 69 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node2 | 6.948s | 2025-10-14 11:25:57.891 | 70 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node2 | 6.949s | 2025-10-14 11:25:57.892 | 71 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node2 | 6.949s | 2025-10-14 11:25:57.892 | 72 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node2 | 6.949s | 2025-10-14 11:25:57.892 | 73 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node2 | 6.949s | 2025-10-14 11:25:57.892 | 74 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node2 | 6.950s | 2025-10-14 11:25:57.893 | 75 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node2 | 6.950s | 2025-10-14 11:25:57.893 | 76 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node2 | 6.950s | 2025-10-14 11:25:57.893 | 77 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node2 | 6.950s | 2025-10-14 11:25:57.893 | 78 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node2 | 6.967s | 2025-10-14 11:25:57.910 | 79 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | insertSeq = true | |
| node2 | 6.968s | 2025-10-14 11:25:57.911 | 80 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | appendSig = true | |
| node2 | 6.968s | 2025-10-14 11:25:57.911 | 81 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | variedSize = false | |
| node2 | 6.968s | 2025-10-14 11:25:57.911 | 82 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | payloadByteSize = 100 | |
| node2 | 6.969s | 2025-10-14 11:25:57.912 | 83 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | maxByteSize = 100 | |
| node2 | 6.969s | 2025-10-14 11:25:57.912 | 84 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node2 | 6.969s | 2025-10-14 11:25:57.912 | 85 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node2 | 6.971s | 2025-10-14 11:25:57.914 | 86 | INFO | DEMO_INFO | <<start-node-2>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node3 | 6.972s | 2025-10-14 11:25:57.915 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node3 | 6.973s | 2025-10-14 11:25:57.916 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node2 | 6.975s | 2025-10-14 11:25:57.918 | 87 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@72a01c1a | |
| node2 | 6.976s | 2025-10-14 11:25:57.919 | 88 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node2 | 6.976s | 2025-10-14 11:25:57.919 | 89 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node2 | 6.984s | 2025-10-14 11:25:57.927 | 94 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@29575042, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1edde003,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@3579ce5a,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@7f5b0100,snapshotInProgress=false] | |
| node3 | 6.988s | 2025-10-14 11:25:57.931 | 60 | INFO | STARTUP | <main> | StateInitializer: | The platform is using the following initial state: | |
| Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 554926cdd50283b760aa580b741feec993834e7a0a005b955a88ef88d7e22a3ea593a91fe4f68f96fcd8027a248245df (root) PlatformTestingToolState / powder-super-garlic-matrix 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 canvas-fetch-drop-device 2 SingletonNode RosterService.ROSTER_STATE /2 once-hammer-dentist-split 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.992s | 2025-10-14 11:25:57.935 | 95 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node2 | 6.992s | 2025-10-14 11:25:57.935 | 96 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node2 | 6.997s | 2025-10-14 11:25:57.940 | 97 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | Random seed for FCMTransactionPool is -825680121424082681 | |
| node2 | 6.997s | 2025-10-14 11:25:57.940 | 98 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node1 | 7.009s | 2025-10-14 11:25:57.952 | 57 | INFO | STARTUP | <main> | SwirldsPlatform: | Starting with roster history: | |
| RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAK05TS8KZeb1MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTEwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTEwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDBoP9dI3K1PRLRK7h90D9eNCfgzuHTyJi70yDEs90XJXlE6jmgf1NE2av83VAhQHLxu8Ehc/55M9Ayx9IQc0zJLSS+IrRM9QwqoG8ZvNdRgNw+je3V/8rAK/mHId+cPnnyDplCyskyi5kWCv6kTULIewFH8/KVZwhe0/hB2+N6ujWixURrxjjGLHA6b2gPoGAb/nxiVOn+L0cWcOzcyiYShxagj0FBWV7AxKx65Ynzfe7eF0gOzBUA+IM10OM5KXJejk53Xz5KpEyGe8htO/bXFlpLdm3UzrYiIhY0oKPYKECAC1s+VAZA6i+MV0nDpqDgxHRRXD8O2arauPhEI6iVT9f05AtzElrs7U95HbpQUuP1sxkaQw+bLdMOQHHMVCgMgw2g0eDdVDAMJD7wjZ+Bs6kDc/EJELb0l1uy2GEnOZMiHkK4K1r4IyZ/ed6QpyIRKfBCNyT5IIpMoVpzRYxVXgjgFdudd8iErKyvSXHThU6nu92c+vSd+FLBFHPpb6ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdga5NYtV48uDCd4vIsmpGWpKuUHtDVDlCvzHc2ij8DxAR6OFp+hIRNEBXkzg1KS5qP8Wba5ptmGoV4f89HemP+AL3Azde+HjpYRtffdfTdQwmMbw7xJg2lKkEo11gDo5+zPZnVbfb3FsZ+IXKji0QshQBfg+ddTkFG3TJG1ttq3ZDw94RxFQivVnkj1p+Ogel/DuBNRWQobFVe5VrmJqbuwwN8AdrPae1dMrkZatF91On5+cpVLGfk96fYUhDohDt6KKQ6DdhvFk5rhd0vsHGMQq2gAW2+Or6ZVsKkHKx8CPINpJVKAdpE0tItI+loMO02jf9oRI/8cThWP1vNAeWnr0D6m275EZf/4qem/DdJ0FJIVou3P7tsq7eSdueDnj5RmcbW/vOBtvlXpD3SqsVRn6sltZ0sk24p+6ZMzopevCZEMf/nL3OzGvSadisXb39H9DgwkNLlefju1QLgHWf0TGfeNHluDgVDhU8+/1/KUGtr2SnZ5EVO1l59FWHALj", "gossipEndpoint": [{ "ipAddressV4": "Ih3DIw==", "port": 30124 }, { "ipAddressV4": "CoAP6A==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIHWg7e2Q/smQwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMjAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMjCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBAKr5WsBepS3+y/0/yfBjzMWje7zianEz7sszrNWV3cGu2KUlR7v2+9wp/EtX1+BdcGlTTojgFs5nEBN4lM76Cp6JjFH461yN8GSkIkpe8GZnb1w4KEjZj5UYMbq+qOUI6QmwmgLeO8RHAsS6lCP1AyGFalb2ZVJ09DcYDxCRXeFj4BqvNbtD5r5DTCtpVT4ax3eb3pzNSGsjQUG9zhyp/WcsAmwmzKdMl72tk6qF8tlAWXyzwiCujWHS0Kln0C5pyEjeFNsG299toC4pgT8juxijgseTeIFRnNHmGSeSmXpAkEELlwLKR8HOnqeiS5UXNqdbxNemx/EpJSc5rTB6kzLX24dIuRsgyIIFWx73goOzmaHUolN4xmenifoMYlSNNM07WrsvmjRC5OLc/uGhdWqhZGBCH6AJB8Cmw84QLXVdHE6LiueP1oMd7g++N4X880wJkuh0ebfV3i7etUIn0jLlM50AkRucG9kwZDJ/M4LY7FT2F85R1/o2FaB/537ARQIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQB5lTkqYw0hEW+BJTFsQ8jEHfIDNRJ0kNbVuibfP+u7kzlJy15lCEi+Qw6E3d8hA1QBX3xJMxNBlrtYPrdG26hh/tOwo5Np/OfxQC5jo0Q7n7hu7aLxZRUB/q7AfdDbOun4Za6rJhT3+EsFocyARWp8bYSk3YILBMkP+2VYDRkgQidzKgKtO5yv21Y9sEgziSprc+dQb/tqn5aQZLWavFwCLwnB3t4r4qwLHkkH00Jw51uOvLeM49/t333V5Caa7wmWzMcE+KSWW0QWFRxeJrodSyjPdmDi4D8lKN5WJHSAU5L2yWIODUyWD/cvsAapTv7xXk9ja/Ssb9DpMQnM1xh0hYaESajNeL1QbGuZgPxAwrw981h7kprR2P2iMGRVGA6u4ezxmhW3s7D+yJ3+Yxs/x2J/sw65Z16mRYXRWYWHQmhgaVQjIviiAkVB6CWZo1kHl/eYaVedQzKlrTpbr3JtmwGwhYEOnrkzsC63h8/AG9gRtIAIGWGqTPWbn2pEm8M=", "gossipEndpoint": [{ "ipAddressV4": "IjyF0A==", "port": 30125 }, { "ipAddressV4": "CoAP6g==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJg3GRFp5bT9MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQCl5ut2dCleDmgEneRYpAKa9Pe2qnXzgF+BEIuTfizG2OcPQi/ltv+6HxSrJXtuWNaiX/G4iP7iBzWj2ysaAYwfYj0ezTSMLRqM9hXzVgLtW0LJEF6a8vUXPsJt4GEJkUKiYCCO1MP1NLd3y/3SVJrFhwJSPqKYm2pQNg84WfPDWSkzSneOIO4Z0uWDXgs+vzSNyChWOxVieFQhLjcELtyj6narmLox+Jdo/SxUzPuktuFB3ebNgUqWPkjljgZpl00BTmbRIVHgHfDVulo2PBpXd0VplIDgdPr5zMKdTrKCuDKey8Mft72RkPKMe9LZVZ/21+rXVEh+olvvUCySsP2RkWPUJJD90c8wKo01rZsjAOXscJKQcBYlam5XXO4ZBRYzEdxuivbkPwsOoQ83swCR3alPvwfbg11Va+zXE6sRbUM9LqkYo/M3Hwg8tSIXu8oah6csputanz867dzWwyVJEPzmiXZ6ncVDQO31QlB7RndWCqKTjOQpnpblUMsrE9MCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAnUA8+kz7L+eSOm/iVvUNYF10PKO2nZtxWWL7R1vwK/2Up765PwqxKb0eSEM4bjgvZq1GuGXs9X/Y7dos42yntXvgeUY+/2JzCnw4J5tzxytZ+IKX6DR67NjDzDzVZQfptjLQrb8E7yzml0uxsqrhNPWl57Bmfe66Kg2lD11jImeeEhExlRggFukoiUWVwRNU21Q1jMUWrg2ZwfP+6fFTgRt0WR+X5zkyYPbvI6/yv7reYGjPDuZTOFhbwG8LUTQxdttDswPjnQ606kMyninL+aNelSdV/UIII7lpr/dTvgQAnrlBaGXvdy6brh3wWEwia0FZFZcKEs6M+jZ3MrFxvlTfUIdI3jRq12L10cCDi2VhORg4JmvlM+Tk6kJeSku30ZLAVo3S7GbTdvkuesOxz3UwnF7yfOA1KYOPvhv1oLxGV5z05glsn1OBKnXMdzsKFbAYYHj81bgBni2WLuIpv3oXlai2uc4y9m8LvWAQ+h/ivyog34Ai3Pvr5ZZOFgjy", "gossipEndpoint": [{ "ipAddressV4": "I+AD8w==", "port": 30126 }, { "ipAddressV4": "CoAP6Q==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAN7hww13zBZEMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDK/bVyv0ZUeJZ4cIOImM+wmqtYjCw4jPAC549WQPPV1vG0lzSpgV+nRKqmWBexhLlKN3bsvrfNCUpKSq8meFyCtdppT1dhUOmEZcoNhLZzqxXb2HYYqRPv82tR+tbh+27WFsBOOqYrYTvr72ECD7qDOuw/Xob6KImaw/b/SIAPecMoYy25fkgYkJSETwd8HUpwssYH/JTLBF8eGjjTTMuu14ARQKeH8BXSs+jjV1+3IItXERS8ryUGDjqc5vC8ZW1kDVQbb91IDxRjqZbFyhuasocCqTAcZuiEgE8Wilwp2g1vbAUnHnvKNfiaEAHoEV6vF4lelaWhOnN2U5tnox/ns6PiDqIbOfs0pmXxjAK0vxc6oZM3TwdRtzo6cSb/AYfQdnmQzkra980kHN12r3f7PK2PzGBuVUPT7fLGA4S3vQDYO4rqcgTc/OLobtqLtdBusOFjZscfIfUW4GVWJUI1j+fwvHacxWLmyZwlQ5Q47UtrtjWpFru7CTn5S477lqMCAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAdW6AWDhT0eOJw+0O6MYngmCgkXfFsgBC/B1plaE596hHo58FHxzCNiLFdvfRj37rxujvqsDAkADWUmOzLzLHYMXu302HzDqAMNY6FZJc32y4ZDsIQpaUOAuiNHAHwFXuPRInVpCqztfJMgw4RhOhcCTEsoIJsqoIN1t4M0pEVAv6x3nJwFKZqSNOZrQ7sOW32FjwWS3kHwRsCTtqdk5n2KxU6wr/fggV3QsSPRMYro8sUfwu93mqggtswwWqfeKlsz5WiaR9aqLnb8z1R6HLvA0bcoPWzjgn8RdP+9we4z06iZ5vdBuNpwBjrCKUELWISyAoekLGGxyS8pPqYiSBRNUoaPITSuUjcCBbJ9EFvm72QgCBesbwF71KPabTPbMPhLmf+uAi+zmeu8ZeVvT6DrX9OHSkIvIEQFry9BrqOT3ce6KBHSO1HpXIetj5Wcd3WHXtz9ulBL9ikWC8eh7/+we51ucmLvFzNKznElhT2Dp+czXUVNEUjp3u/66pyRA4", "gossipEndpoint": [{ "ipAddressV4": "iHNpbw==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] } | |||||||||
| node2 | 7.077s | 2025-10-14 11:25:58.020 | 99 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | Starting platform 2 | |
| node2 | 7.078s | 2025-10-14 11:25:58.021 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node2 | 7.082s | 2025-10-14 11:25:58.025 | 101 | INFO | STARTUP | <<start-node-2>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node2 | 7.083s | 2025-10-14 11:25:58.026 | 102 | INFO | STARTUP | <<start-node-2>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node2 | 7.084s | 2025-10-14 11:25:58.027 | 103 | INFO | STARTUP | <<start-node-2>> | InputWireChecks: | All input wires have been bound. | |
| node2 | 7.086s | 2025-10-14 11:25:58.029 | 104 | WARN | STARTUP | <<start-node-2>> | PcesFileTracker: | No preconsensus event files available | |
| node2 | 7.087s | 2025-10-14 11:25:58.030 | 105 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node2 | 7.088s | 2025-10-14 11:25:58.031 | 106 | INFO | STARTUP | <<start-node-2>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node2 | 7.088s | 2025-10-14 11:25:58.031 | 107 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 starts transactions ........ | |
| node2 | 7.089s | 2025-10-14 11:25:58.032 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 287.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node2 | 7.092s | 2025-10-14 11:25:58.035 | 109 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node2 | 7.093s | 2025-10-14 11:25:58.036 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node2 | 7.093s | 2025-10-14 11:25:58.036 | 111 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node1 | 7.119s | 2025-10-14 11:25:58.062 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node1 | 7.120s | 2025-10-14 11:25:58.063 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node1 | 7.139s | 2025-10-14 11:25:58.082 | 60 | INFO | STARTUP | <main> | StateInitializer: | The platform is using the following initial state: | |
| Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: 554926cdd50283b760aa580b741feec993834e7a0a005b955a88ef88d7e22a3ea593a91fe4f68f96fcd8027a248245df (root) PlatformTestingToolState / powder-super-garlic-matrix 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 canvas-fetch-drop-device 2 SingletonNode RosterService.ROSTER_STATE /2 once-hammer-dentist-split 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 | 7.175s | 2025-10-14 11:25:58.118 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node3 | 7.180s | 2025-10-14 11:25:58.123 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node3 | 7.190s | 2025-10-14 11:25:58.133 | 64 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node3 | 7.190s | 2025-10-14 11:25:58.133 | 65 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node3 | 7.191s | 2025-10-14 11:25:58.134 | 66 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node3 | 7.191s | 2025-10-14 11:25:58.134 | 67 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node3 | 7.191s | 2025-10-14 11:25:58.134 | 68 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node3 | 7.192s | 2025-10-14 11:25:58.135 | 69 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node3 | 7.192s | 2025-10-14 11:25:58.135 | 70 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node3 | 7.192s | 2025-10-14 11:25:58.135 | 71 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node3 | 7.193s | 2025-10-14 11:25:58.136 | 72 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node3 | 7.193s | 2025-10-14 11:25:58.136 | 73 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node3 | 7.193s | 2025-10-14 11:25:58.136 | 74 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node3 | 7.194s | 2025-10-14 11:25:58.137 | 75 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node3 | 7.194s | 2025-10-14 11:25:58.137 | 76 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node3 | 7.194s | 2025-10-14 11:25:58.137 | 77 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node3 | 7.195s | 2025-10-14 11:25:58.138 | 78 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node3 | 7.215s | 2025-10-14 11:25:58.158 | 79 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | insertSeq = true | |
| node3 | 7.216s | 2025-10-14 11:25:58.159 | 80 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | appendSig = true | |
| node3 | 7.217s | 2025-10-14 11:25:58.160 | 81 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | variedSize = false | |
| node3 | 7.217s | 2025-10-14 11:25:58.160 | 82 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | payloadByteSize = 100 | |
| node3 | 7.218s | 2025-10-14 11:25:58.161 | 83 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | maxByteSize = 100 | |
| node3 | 7.218s | 2025-10-14 11:25:58.161 | 84 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node3 | 7.219s | 2025-10-14 11:25:58.162 | 85 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node3 | 7.221s | 2025-10-14 11:25:58.164 | 86 | INFO | DEMO_INFO | <<start-node-3>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node3 | 7.226s | 2025-10-14 11:25:58.169 | 87 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@7226627 | |
| node3 | 7.227s | 2025-10-14 11:25:58.170 | 88 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node3 | 7.228s | 2025-10-14 11:25:58.171 | 89 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node3 | 7.236s | 2025-10-14 11:25:58.179 | 94 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@74e4234, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@3166bd2c,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@462e47ab,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@788bd71,snapshotInProgress=false] | |
| node3 | 7.245s | 2025-10-14 11:25:58.188 | 95 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node3 | 7.245s | 2025-10-14 11:25:58.188 | 96 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node3 | 7.250s | 2025-10-14 11:25:58.193 | 97 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 1761544180220591870 | |
| node3 | 7.251s | 2025-10-14 11:25:58.194 | 98 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node3 | 7.331s | 2025-10-14 11:25:58.274 | 99 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | Starting platform 3 | |
| node3 | 7.333s | 2025-10-14 11:25:58.276 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node3 | 7.336s | 2025-10-14 11:25:58.279 | 101 | INFO | STARTUP | <<start-node-3>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node3 | 7.337s | 2025-10-14 11:25:58.280 | 102 | INFO | STARTUP | <<start-node-3>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node3 | 7.337s | 2025-10-14 11:25:58.280 | 103 | INFO | STARTUP | <<start-node-3>> | InputWireChecks: | All input wires have been bound. | |
| node3 | 7.340s | 2025-10-14 11:25:58.283 | 104 | WARN | STARTUP | <<start-node-3>> | PcesFileTracker: | No preconsensus event files available | |
| node3 | 7.340s | 2025-10-14 11:25:58.283 | 105 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node3 | 7.341s | 2025-10-14 11:25:58.284 | 106 | INFO | STARTUP | <<start-node-3>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node3 | 7.342s | 2025-10-14 11:25:58.285 | 107 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 starts transactions ........ | |
| node3 | 7.343s | 2025-10-14 11:25:58.286 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 299.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node3 | 7.346s | 2025-10-14 11:25:58.289 | 109 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node3 | 7.347s | 2025-10-14 11:25:58.290 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node3 | 7.347s | 2025-10-14 11:25:58.290 | 111 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node1 | 7.356s | 2025-10-14 11:25:58.299 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node1 | 7.361s | 2025-10-14 11:25:58.304 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node1 | 7.371s | 2025-10-14 11:25:58.314 | 64 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node1 | 7.372s | 2025-10-14 11:25:58.315 | 65 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node1 | 7.373s | 2025-10-14 11:25:58.316 | 66 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node1 | 7.373s | 2025-10-14 11:25:58.316 | 67 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node1 | 7.373s | 2025-10-14 11:25:58.316 | 68 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node1 | 7.374s | 2025-10-14 11:25:58.317 | 69 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node1 | 7.374s | 2025-10-14 11:25:58.317 | 70 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node1 | 7.374s | 2025-10-14 11:25:58.317 | 71 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node1 | 7.374s | 2025-10-14 11:25:58.317 | 72 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node1 | 7.375s | 2025-10-14 11:25:58.318 | 73 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node1 | 7.375s | 2025-10-14 11:25:58.318 | 74 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node1 | 7.375s | 2025-10-14 11:25:58.318 | 75 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node1 | 7.375s | 2025-10-14 11:25:58.318 | 76 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node1 | 7.376s | 2025-10-14 11:25:58.319 | 77 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node1 | 7.376s | 2025-10-14 11:25:58.319 | 78 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node1 | 7.393s | 2025-10-14 11:25:58.336 | 79 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | insertSeq = true | |
| node1 | 7.394s | 2025-10-14 11:25:58.337 | 80 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | appendSig = true | |
| node1 | 7.394s | 2025-10-14 11:25:58.337 | 81 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | variedSize = false | |
| node1 | 7.394s | 2025-10-14 11:25:58.337 | 82 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | payloadByteSize = 100 | |
| node1 | 7.395s | 2025-10-14 11:25:58.338 | 83 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | maxByteSize = 100 | |
| node1 | 7.395s | 2025-10-14 11:25:58.338 | 84 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node1 | 7.396s | 2025-10-14 11:25:58.339 | 85 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node1 | 7.398s | 2025-10-14 11:25:58.341 | 86 | INFO | DEMO_INFO | <<start-node-1>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node1 | 7.403s | 2025-10-14 11:25:58.346 | 87 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@bff3fe0 | |
| node1 | 7.404s | 2025-10-14 11:25:58.347 | 88 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node1 | 7.404s | 2025-10-14 11:25:58.347 | 89 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node1 | 7.412s | 2025-10-14 11:25:58.355 | 94 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@4da1e750, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@10a468d9,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@335a8a2f,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@4bcea603,snapshotInProgress=false] | |
| node1 | 7.421s | 2025-10-14 11:25:58.364 | 95 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node1 | 7.421s | 2025-10-14 11:25:58.364 | 96 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node1 | 7.426s | 2025-10-14 11:25:58.369 | 97 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 2457084456636011034 | |
| node1 | 7.426s | 2025-10-14 11:25:58.369 | 98 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node1 | 7.508s | 2025-10-14 11:25:58.451 | 99 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | Starting platform 1 | |
| node1 | 7.509s | 2025-10-14 11:25:58.452 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node1 | 7.513s | 2025-10-14 11:25:58.456 | 101 | INFO | STARTUP | <<start-node-1>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node1 | 7.514s | 2025-10-14 11:25:58.457 | 102 | INFO | STARTUP | <<start-node-1>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node1 | 7.515s | 2025-10-14 11:25:58.458 | 103 | INFO | STARTUP | <<start-node-1>> | InputWireChecks: | All input wires have been bound. | |
| node1 | 7.517s | 2025-10-14 11:25:58.460 | 104 | WARN | STARTUP | <<start-node-1>> | PcesFileTracker: | No preconsensus event files available | |
| node1 | 7.517s | 2025-10-14 11:25:58.460 | 105 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node1 | 7.522s | 2025-10-14 11:25:58.465 | 106 | INFO | STARTUP | <<start-node-1>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node1 | 7.524s | 2025-10-14 11:25:58.467 | 107 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 starts transactions ........ | |
| node1 | 7.524s | 2025-10-14 11:25:58.467 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | DefaultStatusStateMachine: | Platform spent 325.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node1 | 7.529s | 2025-10-14 11:25:58.472 | 109 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node1 | 7.530s | 2025-10-14 11:25:58.473 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | DefaultStatusStateMachine: | Platform spent 5.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node1 | 7.531s | 2025-10-14 11:25:58.474 | 111 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node0 | 9.141s | 2025-10-14 11:26:00.084 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting0.csv' ] | |
| node0 | 9.144s | 2025-10-14 11:26:00.087 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node2 | 9.958s | 2025-10-14 11:26:00.901 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting2.csv' ] | |
| node2 | 9.962s | 2025-10-14 11:26:00.905 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node3 | 10.197s | 2025-10-14 11:26:01.140 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting3.csv' ] | |
| node3 | 10.199s | 2025-10-14 11:26:01.142 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node1 | 10.380s | 2025-10-14 11:26:01.323 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting1.csv' ] | |
| node1 | 10.386s | 2025-10-14 11:26:01.329 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node0 | 16.369s | 2025-10-14 11:26:07.312 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-5> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node0 | 16.370s | 2025-10-14 11:26:07.313 | 115 | INFO | STARTUP | <platformForkJoinThread-5> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node2 | 17.185s | 2025-10-14 11:26:08.128 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node2 | 17.187s | 2025-10-14 11:26:08.130 | 115 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 17.439s | 2025-10-14 11:26:08.382 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node3 | 17.439s | 2025-10-14 11:26:08.382 | 115 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 17.616s | 2025-10-14 11:26:08.559 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node1 | 17.617s | 2025-10-14 11:26:08.560 | 115 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 18.413s | 2025-10-14 11:26:09.356 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node0 | 18.413s | 2025-10-14 11:26:09.356 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 2.0 s in CHECKING. Now in ACTIVE | |
| node0 | 18.413s | 2025-10-14 11:26:09.356 | 118 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node0 | 18.480s | 2025-10-14 11:26:09.423 | 119 | TRACE | STARTUP | <<app: appMain 0>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x33AB52EE91726A4B3C96FBFA0345173C3D3E2272779725597B7BC364B5BD929D', privateKey ='0x33AB52EE91726A4B3C96FBFA0345173C3D3E2272779725597B7BC364B5BD929D', signature = '0x634878EFAFEDE82C26033890915182CA7CAE6A33D45BF5FD127E1B8B4F93964700C3071B137254C7B2D9AA87094D11634F2B54EE3037B7350D3A74F157B9B404',message = '0x12660A0A4090B6DCD4CBDE9DC067325600000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000004001' } | |
| node3 | 18.563s | 2025-10-14 11:26:09.506 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node2 | 18.752s | 2025-10-14 11:26:09.695 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node1 | 18.794s | 2025-10-14 11:26:09.737 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node2 | 19.054s | 2025-10-14 11:26:09.997 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 1.9 s in CHECKING. Now in ACTIVE | |
| node2 | 19.054s | 2025-10-14 11:26:09.997 | 118 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node2 | 19.070s | 2025-10-14 11:26:10.013 | 119 | TRACE | STARTUP | <<app: appMain 2>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x29BEC3A3F87A31DD6DA34B3B4EA682F1580F1544E54A42B80E7472377D6A63C5', privateKey ='0x29BEC3A3F87A31DD6DA34B3B4EA682F1580F1544E54A42B80E7472377D6A63C5', signature = '0xCE1CE9C692CA43ED5973FD660EAE44D46C54C9B636C5ECF138CC70CDDD02E77DC6062F47005C89FCDBF4D3EA657CC11AE1CD5AD850758EDCC3F800DB27E5A20A',message = '0x1A6B0A1A08021002180120A18D0628914E30914E40EB92CFE2D9A182C7242A4A0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00102' } | |
| node1 | 19.354s | 2025-10-14 11:26:10.297 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 1.7 s in CHECKING. Now in ACTIVE | |
| node1 | 19.355s | 2025-10-14 11:26:10.298 | 118 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node1 | 19.408s | 2025-10-14 11:26:10.351 | 119 | TRACE | STARTUP | <<app: appMain 1>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x9B274684E1CFDB8E94F7ECD933E47CE94EFE97F69DB84C0C641FDB5A7C3BE4BA', privateKey ='0x9B274684E1CFDB8E94F7ECD933E47CE94EFE97F69DB84C0C641FDB5A7C3BE4BA', signature = '0xC4E01203683A5A77F6B433E890DB47F7728CCBC36BCC2CBB0916C2E94C52B0955F2BB87943A3DD76DC16AE2E55F1FEAD30C264370E364B31BE808E37C411870E',message = '0x12660A1A0801100118E01220E01228E01230E01240ECEBC0EDAEF7D0FF4A3244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038014001' } | |
| node3 | 19.408s | 2025-10-14 11:26:10.351 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 2.0 s in CHECKING. Now in ACTIVE | |
| node3 | 19.409s | 2025-10-14 11:26:10.352 | 118 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node3 | 19.425s | 2025-10-14 11:26:10.368 | 119 | TRACE | STARTUP | <<app: appMain 3>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x9C80EFE91F6B8736441188DB4BBA2F29473A04B18BDFCA139CE2FEF1B1093280', privateKey ='0x9C80EFE91F6B8736441188DB4BBA2F29473A04B18BDFCA139CE2FEF1B1093280', signature = '0xE63AC9694D5D53924574E826657C601021D2E1CC826E3EBE1963B3CB603FD854D3F486C8DC8424C0EC46DB2E1A01AFB1DBA24735912E5EA689DF66FDCE115C02',message = '0x1A6B0A1B08031003180120A18D0628914E30914E409A8C84A48BDAD99394012A4900000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00103' } | |
| node0 | 19.970s | 2025-10-14 11:26:10.913 | 122 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node2 | 20.040s | 2025-10-14 11:26:10.983 | 122 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node3 | 20.121s | 2025-10-14 11:26:11.064 | 122 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node1 | 20.218s | 2025-10-14 11:26:11.161 | 122 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node0 | 20.453s | 2025-10-14 11:26:11.396 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 | |
| node0 | 20.455s | 2025-10-14 11:26:11.398 | 138 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node1 | 20.485s | 2025-10-14 11:26:11.428 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 | |
| node1 | 20.487s | 2025-10-14 11:26:11.430 | 138 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node3 | 20.526s | 2025-10-14 11:26:11.469 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 | |
| node3 | 20.528s | 2025-10-14 11:26:11.471 | 138 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node2 | 20.555s | 2025-10-14 11:26:11.498 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3 | |
| node2 | 20.557s | 2025-10-14 11:26:11.500 | 138 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node0 | 20.710s | 2025-10-14 11:26:11.653 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node0 | 20.714s | 2025-10-14 11:26:11.657 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-14T11:26:09.687513Z Next consensus number: 24 Legacy running event hash: 676728a1603c85aa230d6aa90a36c221421deffee1ec0a38c1dda3dc7613cb622e2c274a3e3b8ef9a87be958d3f815d9 Legacy running event mnemonic: undo-before-always-enlist Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: a7622ddd376c9f4fdf1c18e503000dd5e6638a7b12a107eda8515d190b6879a0be2aeb63fd6200be05d6e7519e6ab160 (root) PlatformTestingToolState / because-roof-unique-bike 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 finish-feature-giant-around 1 VirtualMap RosterService.ROSTERS /1 canvas-fetch-drop-device 2 SingletonNode RosterService.ROSTER_STATE /2 once-hammer-dentist-split 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 | 20.744s | 2025-10-14 11:26:11.687 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/0/2025/10/14/2025-10-14T11+26+07.350086771Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 20.745s | 2025-10-14 11:26:11.688 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/0/2025/10/14/2025-10-14T11+26+07.350086771Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 20.745s | 2025-10-14 11:26:11.688 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node0 | 20.747s | 2025-10-14 11:26:11.690 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node0 | 20.753s | 2025-10-14 11:26:11.696 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node1 | 20.767s | 2025-10-14 11:26:11.710 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node1 | 20.771s | 2025-10-14 11:26:11.714 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-14T11:26:09.687513Z Next consensus number: 24 Legacy running event hash: 676728a1603c85aa230d6aa90a36c221421deffee1ec0a38c1dda3dc7613cb622e2c274a3e3b8ef9a87be958d3f815d9 Legacy running event mnemonic: undo-before-always-enlist Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: a7622ddd376c9f4fdf1c18e503000dd5e6638a7b12a107eda8515d190b6879a0be2aeb63fd6200be05d6e7519e6ab160 (root) PlatformTestingToolState / because-roof-unique-bike 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 finish-feature-giant-around 1 VirtualMap RosterService.ROSTERS /1 canvas-fetch-drop-device 2 SingletonNode RosterService.ROSTER_STATE /2 once-hammer-dentist-split 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node3 | 20.790s | 2025-10-14 11:26:11.733 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node3 | 20.794s | 2025-10-14 11:26:11.737 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-14T11:26:09.687513Z Next consensus number: 24 Legacy running event hash: 676728a1603c85aa230d6aa90a36c221421deffee1ec0a38c1dda3dc7613cb622e2c274a3e3b8ef9a87be958d3f815d9 Legacy running event mnemonic: undo-before-always-enlist Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: a7622ddd376c9f4fdf1c18e503000dd5e6638a7b12a107eda8515d190b6879a0be2aeb63fd6200be05d6e7519e6ab160 (root) PlatformTestingToolState / because-roof-unique-bike 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 finish-feature-giant-around 1 VirtualMap RosterService.ROSTERS /1 canvas-fetch-drop-device 2 SingletonNode RosterService.ROSTER_STATE /2 once-hammer-dentist-split 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 | 20.807s | 2025-10-14 11:26:11.750 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/1/2025/10/14/2025-10-14T11+26+07.517592075Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 20.808s | 2025-10-14 11:26:11.751 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/1/2025/10/14/2025-10-14T11+26+07.517592075Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 20.808s | 2025-10-14 11:26:11.751 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node1 | 20.810s | 2025-10-14 11:26:11.753 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node1 | 20.816s | 2025-10-14 11:26:11.759 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node2 | 20.817s | 2025-10-14 11:26:11.760 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node2 | 20.820s | 2025-10-14 11:26:11.763 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-10-14T11:26:09.687513Z Next consensus number: 24 Legacy running event hash: 676728a1603c85aa230d6aa90a36c221421deffee1ec0a38c1dda3dc7613cb622e2c274a3e3b8ef9a87be958d3f815d9 Legacy running event mnemonic: undo-before-always-enlist Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: a7622ddd376c9f4fdf1c18e503000dd5e6638a7b12a107eda8515d190b6879a0be2aeb63fd6200be05d6e7519e6ab160 (root) PlatformTestingToolState / because-roof-unique-bike 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 finish-feature-giant-around 1 VirtualMap RosterService.ROSTERS /1 canvas-fetch-drop-device 2 SingletonNode RosterService.ROSTER_STATE /2 once-hammer-dentist-split 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node3 | 20.827s | 2025-10-14 11:26:11.770 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/3/2025/10/14/2025-10-14T11+26+07.664018732Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 20.828s | 2025-10-14 11:26:11.771 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/3/2025/10/14/2025-10-14T11+26+07.664018732Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 20.828s | 2025-10-14 11:26:11.771 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node3 | 20.829s | 2025-10-14 11:26:11.772 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node3 | 20.834s | 2025-10-14 11:26:11.777 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node2 | 20.851s | 2025-10-14 11:26:11.794 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/2/2025/10/14/2025-10-14T11+26+08.013943581Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 20.852s | 2025-10-14 11:26:11.795 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/2/2025/10/14/2025-10-14T11+26+08.013943581Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 20.852s | 2025-10-14 11:26:11.795 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node2 | 20.853s | 2025-10-14 11:26:11.796 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node2 | 20.857s | 2025-10-14 11:26:11.800 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/2/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node0 | 24.992s | 2025-10-14 11:26:15.935 | 226 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 25.265s | 2025-10-14 11:26:16.208 | 242 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node1 | 25.783s | 2025-10-14 11:26:16.726 | 242 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 26.027s | 2025-10-14 11:26:16.970 | 242 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 26.459s | 2025-10-14 11:26:17.402 | 243 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 26.786s | 2025-10-14 11:26:17.729 | 247 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 27.153s | 2025-10-14 11:26:18.096 | 263 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node3 | 27.495s | 2025-10-14 11:26:18.438 | 263 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 59.084s | 2025-10-14 11:26:50.027 | 564 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 59.214s | 2025-10-14 11:26:50.157 | 564 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 59.333s | 2025-10-14 11:26:50.276 | 564 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node2 | 59.524s | 2025-10-14 11:26:50.467 | 564 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 1m 21.546s | 2025-10-14 11:27:12.489 | 769 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node0 | 1m 21.548s | 2025-10-14 11:27:12.491 | 770 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node0 | 1m 21.550s | 2025-10-14 11:27:12.493 | 771 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | node0 submits a transaction SAVE_EXPECTED_MAP | |
| node2 | 1m 22.315s | 2025-10-14 11:27:13.258 | 785 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node2 | 1m 22.316s | 2025-10-14 11:27:13.259 | 786 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node2 | 1m 22.318s | 2025-10-14 11:27:13.261 | 787 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | node2 submits a transaction SAVE_EXPECTED_MAP | |
| node3 | 1m 23.193s | 2025-10-14 11:27:14.136 | 785 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node3 | 1m 23.195s | 2025-10-14 11:27:14.138 | 786 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node3 | 1m 23.196s | 2025-10-14 11:27:14.139 | 787 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | node3 submits a transaction SAVE_EXPECTED_MAP | |
| node2 | 1m 23.699s | 2025-10-14 11:27:14.642 | 788 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1760441233097_97593876.json.gz | |
| node1 | 1m 23.701s | 2025-10-14 11:27:14.644 | 785 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node1 | 1m 23.703s | 2025-10-14 11:27:14.646 | 786 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node1 | 1m 23.705s | 2025-10-14 11:27:14.648 | 787 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | node1 submits a transaction SAVE_EXPECTED_MAP | |
| node0 | 1m 23.732s | 2025-10-14 11:27:14.675 | 788 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1760441233097_97593876.json.gz | |
| node3 | 1m 23.801s | 2025-10-14 11:27:14.744 | 788 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1760441233097_97593876.json.gz | |
| node1 | 1m 23.810s | 2025-10-14 11:27:14.753 | 788 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1760441233097_97593876.json.gz | |
| node2 | 1m 23.985s | 2025-10-14 11:27:14.928 | 789 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node0 | 1m 24.015s | 2025-10-14 11:27:14.958 | 789 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node3 | 1m 24.087s | 2025-10-14 11:27:15.030 | 789 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node1 | 1m 24.095s | 2025-10-14 11:27:15.038 | 789 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node0 | 1m 24.217s | 2025-10-14 11:27:15.160 | 794 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node2 | 1m 24.255s | 2025-10-14 11:27:15.198 | 794 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node3 | 1m 24.345s | 2025-10-14 11:27:15.288 | 794 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node1 | 1m 24.457s | 2025-10-14 11:27:15.400 | 794 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node2 | 1m 25.099s | 2025-10-14 11:27:16.042 | 811 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node0 | 1m 25.142s | 2025-10-14 11:27:16.085 | 811 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node3 | 1m 25.212s | 2025-10-14 11:27:16.155 | 811 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node1 | 1m 25.218s | 2025-10-14 11:27:16.161 | 811 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node0 | 1m 25.628s | 2025-10-14 11:27:16.571 | 812 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node2 | 1m 25.665s | 2025-10-14 11:27:16.608 | 812 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node3 | 1m 25.755s | 2025-10-14 11:27:16.698 | 812 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node1 | 1m 25.868s | 2025-10-14 11:27:16.811 | 812 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node1 | 1m 31.284s | 2025-10-14 11:27:22.227 | 873 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 1m 31.636s | 2025-10-14 11:27:22.579 | 873 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 1m 31.912s | 2025-10-14 11:27:22.855 | 873 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 1m 32.028s | 2025-10-14 11:27:22.971 | 873 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node1 | 1m 32.950s | 2025-10-14 11:27:23.893 | 894 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node0 | 1m 33.048s | 2025-10-14 11:27:23.991 | 894 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 1m 33.526s | 2025-10-14 11:27:24.469 | 894 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node3 | 1m 33.593s | 2025-10-14 11:27:24.536 | 894 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 2m 4.230s | 2025-10-14 11:27:55.173 | 1179 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 2m 4.232s | 2025-10-14 11:27:55.175 | 1180 | INFO | DEMO_INFO | <<app: appMain 1>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node1 | 2m 4.232s | 2025-10-14 11:27:55.175 | 1181 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Stop generating transactions | |
| node1 | 2m 4.234s | 2025-10-14 11:27:55.177 | 1182 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | node 1 sent ENTER_VALIDATION Message | |
| node1 | 2m 4.237s | 2025-10-14 11:27:55.180 | 1183 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 finished generating all transactions. | |
| node2 | 2m 5.087s | 2025-10-14 11:27:56.030 | 1195 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node2 | 2m 5.088s | 2025-10-14 11:27:56.031 | 1196 | INFO | DEMO_INFO | <<app: appMain 2>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node2 | 2m 5.088s | 2025-10-14 11:27:56.031 | 1197 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Stop generating transactions | |
| node2 | 2m 5.089s | 2025-10-14 11:27:56.032 | 1198 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | node 2 sent ENTER_VALIDATION Message | |
| node2 | 2m 5.092s | 2025-10-14 11:27:56.035 | 1199 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 finished generating all transactions. | |
| node0 | 2m 5.291s | 2025-10-14 11:27:56.234 | 1195 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 2m 5.293s | 2025-10-14 11:27:56.236 | 1196 | INFO | DEMO_INFO | <<app: appMain 0>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node0 | 2m 5.293s | 2025-10-14 11:27:56.236 | 1197 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Stop generating transactions | |
| node0 | 2m 5.293s | 2025-10-14 11:27:56.236 | 1198 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | node 0 sent ENTER_VALIDATION Message | |
| node0 | 2m 5.296s | 2025-10-14 11:27:56.239 | 1199 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 finished generating all transactions. | |
| node3 | 2m 5.541s | 2025-10-14 11:27:56.484 | 1195 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 2m 5.593s | 2025-10-14 11:27:56.536 | 1196 | INFO | DEMO_INFO | <<app: appMain 3>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node3 | 2m 5.594s | 2025-10-14 11:27:56.537 | 1197 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Stop generating transactions | |
| node3 | 2m 5.594s | 2025-10-14 11:27:56.537 | 1198 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | node 3 sent ENTER_VALIDATION Message | |
| node3 | 2m 5.597s | 2025-10-14 11:27:56.540 | 1199 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 finished generating all transactions. | |
| node0 | 2m 6.606s | 2025-10-14 11:27:57.549 | 1204 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:55.848148Z ] | |
| node0 | 2m 6.606s | 2025-10-14 11:27:57.549 | 1205 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:27:55.848148Z,type=ENTER_VALIDATION] | |
| node2 | 2m 6.753s | 2025-10-14 11:27:57.696 | 1220 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:55.848148Z ] | |
| node2 | 2m 6.754s | 2025-10-14 11:27:57.697 | 1221 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:27:55.848148Z,type=ENTER_VALIDATION] | |
| node1 | 2m 6.824s | 2025-10-14 11:27:57.767 | 1204 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:55.848148Z ] | |
| node1 | 2m 6.825s | 2025-10-14 11:27:57.768 | 1205 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:27:55.848148Z,type=ENTER_VALIDATION] | |
| node3 | 2m 6.897s | 2025-10-14 11:27:57.840 | 1220 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:55.848148Z ] | |
| node3 | 2m 6.898s | 2025-10-14 11:27:57.841 | 1221 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:27:55.848148Z,type=ENTER_VALIDATION] | |
| node3 | 2m 7.396s | 2025-10-14 11:27:58.339 | 1222 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:56.348984461Z ] | |
| node3 | 2m 7.397s | 2025-10-14 11:27:58.340 | 1223 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:27:56.348984461Z,type=ENTER_VALIDATION] | |
| node3 | 2m 7.399s | 2025-10-14 11:27:58.342 | 1224 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:56.927482342Z ] | |
| node3 | 2m 7.400s | 2025-10-14 11:27:58.343 | 1225 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:27:56.927482342Z,type=ENTER_VALIDATION] | |
| node2 | 2m 7.402s | 2025-10-14 11:27:58.345 | 1222 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:56.348984461Z ] | |
| node2 | 2m 7.402s | 2025-10-14 11:27:58.345 | 1223 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:27:56.348984461Z,type=ENTER_VALIDATION] | |
| node2 | 2m 7.405s | 2025-10-14 11:27:58.348 | 1224 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:56.927482342Z ] | |
| node2 | 2m 7.405s | 2025-10-14 11:27:58.348 | 1225 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:27:56.927482342Z,type=ENTER_VALIDATION] | |
| node0 | 2m 7.465s | 2025-10-14 11:27:58.408 | 1222 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:56.348984461Z ] | |
| node0 | 2m 7.466s | 2025-10-14 11:27:58.409 | 1223 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:27:56.348984461Z,type=ENTER_VALIDATION] | |
| node0 | 2m 7.468s | 2025-10-14 11:27:58.411 | 1224 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:56.927482342Z ] | |
| node0 | 2m 7.468s | 2025-10-14 11:27:58.411 | 1225 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:27:56.927482342Z,type=ENTER_VALIDATION] | |
| node1 | 2m 7.523s | 2025-10-14 11:27:58.466 | 1222 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:56.348984461Z ] | |
| node1 | 2m 7.523s | 2025-10-14 11:27:58.466 | 1223 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:27:56.348984461Z,type=ENTER_VALIDATION] | |
| node1 | 2m 7.525s | 2025-10-14 11:27:58.468 | 1224 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:56.927482342Z ] | |
| node1 | 2m 7.525s | 2025-10-14 11:27:58.468 | 1225 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:27:56.927482342Z,type=ENTER_VALIDATION] | |
| node0 | 2m 7.953s | 2025-10-14 11:27:58.896 | 1226 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:57.137756437Z ] | |
| node0 | 2m 7.954s | 2025-10-14 11:27:58.897 | 1227 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:27:57.137756437Z,type=ENTER_VALIDATION] | |
| node0 | 2m 7.954s | 2025-10-14 11:27:58.897 | 1228 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node0 | 2m 7.956s | 2025-10-14 11:27:58.899 | 1230 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1760441277137_137756437.json, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node0 | 2m 7.976s | 2025-10-14 11:27:58.919 | 1234 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 0>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1760441277137_137756437.json.gz | |
| node2 | 2m 8.161s | 2025-10-14 11:27:59.104 | 1226 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:57.137756437Z ] | |
| node2 | 2m 8.161s | 2025-10-14 11:27:59.104 | 1227 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:27:57.137756437Z,type=ENTER_VALIDATION] | |
| node2 | 2m 8.162s | 2025-10-14 11:27:59.105 | 1228 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node2 | 2m 8.164s | 2025-10-14 11:27:59.107 | 1231 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1760441277137_137756437.json, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node2 | 2m 8.187s | 2025-10-14 11:27:59.130 | 1234 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 2>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1760441277137_137756437.json.gz | |
| node1 | 2m 8.232s | 2025-10-14 11:27:59.175 | 1226 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:57.137756437Z ] | |
| node1 | 2m 8.233s | 2025-10-14 11:27:59.176 | 1227 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:27:57.137756437Z,type=ENTER_VALIDATION] | |
| node1 | 2m 8.233s | 2025-10-14 11:27:59.176 | 1228 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node1 | 2m 8.235s | 2025-10-14 11:27:59.178 | 1231 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1760441277137_137756437.json, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node1 | 2m 8.257s | 2025-10-14 11:27:59.200 | 1234 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 1>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1760441277137_137756437.json.gz | |
| node0 | 2m 8.276s | 2025-10-14 11:27:59.219 | 1235 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1760441277137_137756437.json, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node0 | 2m 8.276s | 2025-10-14 11:27:59.219 | 1236 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node3 | 2m 8.305s | 2025-10-14 11:27:59.248 | 1226 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-10-14T11:27:57.137756437Z ] | |
| node3 | 2m 8.306s | 2025-10-14 11:27:59.249 | 1227 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:27:57.137756437Z,type=ENTER_VALIDATION] | |
| node3 | 2m 8.307s | 2025-10-14 11:27:59.250 | 1228 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 3, type = ENTER_VALIDATION, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node3 | 2m 8.309s | 2025-10-14 11:27:59.252 | 1231 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1760441277137_137756437.json, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node3 | 2m 8.332s | 2025-10-14 11:27:59.275 | 1234 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 3>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1760441277137_137756437.json.gz | |
| node2 | 2m 8.497s | 2025-10-14 11:27:59.440 | 1235 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1760441277137_137756437.json, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node2 | 2m 8.498s | 2025-10-14 11:27:59.441 | 1236 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node1 | 2m 8.557s | 2025-10-14 11:27:59.500 | 1235 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1760441277137_137756437.json, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node1 | 2m 8.558s | 2025-10-14 11:27:59.501 | 1236 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node3 | 2m 8.637s | 2025-10-14 11:27:59.580 | 1235 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1760441277137_137756437.json, consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node3 | 2m 8.637s | 2025-10-14 11:27:59.580 | 1236 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:27:57.137756437Z ] | |
| node2 | 2m 10.081s | 2025-10-14 11:28:01.024 | 1253 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.747498756Z ] | |
| node2 | 2m 10.082s | 2025-10-14 11:28:01.025 | 1254 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:27:59.747498756Z,type=EXIT_VALIDATION] | |
| node1 | 2m 10.194s | 2025-10-14 11:28:01.137 | 1253 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.747498756Z ] | |
| node1 | 2m 10.195s | 2025-10-14 11:28:01.138 | 1254 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:27:59.747498756Z,type=EXIT_VALIDATION] | |
| node3 | 2m 10.215s | 2025-10-14 11:28:01.158 | 1253 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.747498756Z ] | |
| node3 | 2m 10.217s | 2025-10-14 11:28:01.160 | 1254 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:27:59.747498756Z,type=EXIT_VALIDATION] | |
| node0 | 2m 10.294s | 2025-10-14 11:28:01.237 | 1253 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.747498756Z ] | |
| node0 | 2m 10.295s | 2025-10-14 11:28:01.238 | 1254 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-10-14T11:27:59.747498756Z,type=EXIT_VALIDATION] | |
| node0 | 2m 10.714s | 2025-10-14 11:28:01.657 | 1259 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.747502Z ] | |
| node0 | 2m 10.715s | 2025-10-14 11:28:01.658 | 1260 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:27:59.747502Z,type=EXIT_VALIDATION] | |
| node0 | 2m 10.715s | 2025-10-14 11:28:01.658 | 1261 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.957447741Z ] | |
| node0 | 2m 10.716s | 2025-10-14 11:28:01.659 | 1262 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:27:59.957447741Z,type=EXIT_VALIDATION] | |
| node0 | 2m 10.716s | 2025-10-14 11:28:01.659 | 1263 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:28:00.087260Z ] | |
| node0 | 2m 10.716s | 2025-10-14 11:28:01.659 | 1264 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:28:00.087260Z,type=EXIT_VALIDATION] | |
| node0 | 2m 10.716s | 2025-10-14 11:28:01.659 | 1265 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node0 | 2m 10.717s | 2025-10-14 11:28:01.660 | 1266 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node0 | 2m 10.719s | 2025-10-14 11:28:01.662 | 1267 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Sending Freeze Transaction... | |
| node0 | 2m 10.719s | 2025-10-14 11:28:01.662 | 1268 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Finished Sending Freeze Transaction. | |
| node0 | 2m 10.719s | 2025-10-14 11:28:01.662 | 1269 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node0 | 2m 10.721s | 2025-10-14 11:28:01.664 | 1270 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-14T11:28:00.087260Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node3 | 2m 10.785s | 2025-10-14 11:28:01.728 | 1275 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.747502Z ] | |
| node3 | 2m 10.786s | 2025-10-14 11:28:01.729 | 1276 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:27:59.747502Z,type=EXIT_VALIDATION] | |
| node3 | 2m 10.786s | 2025-10-14 11:28:01.729 | 1277 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.957447741Z ] | |
| node3 | 2m 10.787s | 2025-10-14 11:28:01.730 | 1278 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:27:59.957447741Z,type=EXIT_VALIDATION] | |
| node3 | 2m 10.787s | 2025-10-14 11:28:01.730 | 1279 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:28:00.087260Z ] | |
| node3 | 2m 10.787s | 2025-10-14 11:28:01.730 | 1280 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:28:00.087260Z,type=EXIT_VALIDATION] | |
| node3 | 2m 10.788s | 2025-10-14 11:28:01.731 | 1281 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node3 | 2m 10.790s | 2025-10-14 11:28:01.733 | 1282 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node3 | 2m 10.790s | 2025-10-14 11:28:01.733 | 1283 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node3 | 2m 10.793s | 2025-10-14 11:28:01.736 | 1284 | INFO | DEMO_INFO | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-14T11:28:00.087260Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node2 | 2m 10.981s | 2025-10-14 11:28:01.924 | 1275 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.747502Z ] | |
| node2 | 2m 10.981s | 2025-10-14 11:28:01.924 | 1276 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:27:59.747502Z,type=EXIT_VALIDATION] | |
| node2 | 2m 10.982s | 2025-10-14 11:28:01.925 | 1277 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.957447741Z ] | |
| node2 | 2m 10.982s | 2025-10-14 11:28:01.925 | 1278 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:27:59.957447741Z,type=EXIT_VALIDATION] | |
| node2 | 2m 10.982s | 2025-10-14 11:28:01.925 | 1279 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:28:00.087260Z ] | |
| node2 | 2m 10.982s | 2025-10-14 11:28:01.925 | 1280 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:28:00.087260Z,type=EXIT_VALIDATION] | |
| node2 | 2m 10.983s | 2025-10-14 11:28:01.926 | 1281 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node2 | 2m 10.984s | 2025-10-14 11:28:01.927 | 1282 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node2 | 2m 10.984s | 2025-10-14 11:28:01.927 | 1283 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node2 | 2m 10.987s | 2025-10-14 11:28:01.930 | 1284 | INFO | DEMO_INFO | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-14T11:28:00.087260Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node1 | 2m 11.042s | 2025-10-14 11:28:01.985 | 1275 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.747502Z ] | |
| node1 | 2m 11.042s | 2025-10-14 11:28:01.985 | 1276 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-10-14T11:27:59.747502Z,type=EXIT_VALIDATION] | |
| node1 | 2m 11.043s | 2025-10-14 11:28:01.986 | 1277 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:27:59.957447741Z ] | |
| node1 | 2m 11.043s | 2025-10-14 11:28:01.986 | 1278 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-10-14T11:27:59.957447741Z,type=EXIT_VALIDATION] | |
| node1 | 2m 11.044s | 2025-10-14 11:28:01.987 | 1279 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-10-14T11:28:00.087260Z ] | |
| node1 | 2m 11.044s | 2025-10-14 11:28:01.987 | 1280 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-10-14T11:28:00.087260Z,type=EXIT_VALIDATION] | |
| node1 | 2m 11.044s | 2025-10-14 11:28:01.987 | 1281 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node1 | 2m 11.045s | 2025-10-14 11:28:01.988 | 1282 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node1 | 2m 11.045s | 2025-10-14 11:28:01.988 | 1283 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node1 | 2m 11.048s | 2025-10-14 11:28:01.991 | 1284 | INFO | DEMO_INFO | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-10-14T11:28:00.087260Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node2 | 2m 12.970s | 2025-10-14 11:28:03.913 | 1289 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760441341 | |
| node1 | 2m 13.032s | 2025-10-14 11:28:03.975 | 1305 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760441341 | |
| node3 | 2m 13.047s | 2025-10-14 11:28:03.990 | 1289 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760441341 | |
| node0 | 2m 13.123s | 2025-10-14 11:28:04.066 | 1307 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1760441341 | |
| node2 | 2m 57.164s | 2025-10-14 11:28:48.107 | 1666 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith1 2 to 1>> | NetworkUtils: | Connection broken: 2 <- 1 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentInitiate.transition(SentInitiate.java:73) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node2 | 2m 57.167s | 2025-10-14 11:28:48.110 | 1667 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 2 to 3>> | NetworkUtils: | Connection broken: 2 -> 3 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.109473951Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.109473951Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.sendAndReceiveEvents(ShadowgraphSynchronizer.java:217) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:184) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 6 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.DataInputStream.readUnsignedByte(DataInputStream.java:295) at java.base/java.io.DataInputStream.readByte(DataInputStream.java:275) at org.hiero.base.io.streams.AugmentedDataInputStream.readByte(AugmentedDataInputStream.java:144) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readEventsINeed$9(SyncUtils.java:272) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 11 more | |||||||||
| node2 | 2m 57.229s | 2025-10-14 11:28:48.172 | 1668 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith0 2 to 0>> | NetworkUtils: | Connection broken: 2 <- 0 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.172017141Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.172017141Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.sendAndReceiveEvents(ShadowgraphSynchronizer.java:217) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:184) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 6 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.DataInputStream.readUnsignedByte(DataInputStream.java:295) at java.base/java.io.DataInputStream.readByte(DataInputStream.java:275) at org.hiero.base.io.streams.AugmentedDataInputStream.readByte(AugmentedDataInputStream.java:144) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readEventsINeed$9(SyncUtils.java:272) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 11 more | |||||||||
| node1 | 2m 57.234s | 2025-10-14 11:28:48.177 | 1670 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 1 to 2>> | NetworkUtils: | Connection broken: 1 -> 2 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.173377398Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.173377398Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:137) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 6 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readLong(DataInputStream.java:407) at org.hiero.base.io.streams.AugmentedDataInputStream.readLong(AugmentedDataInputStream.java:186) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.deserializeEventWindow(SyncUtils.java:623) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readTheirTipsAndEventWindow$3(SyncUtils.java:104) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more | |||||||||
| node3 | 2m 57.240s | 2025-10-14 11:28:48.183 | 1670 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 3 to 2>> | NetworkUtils: | Connection broken: 3 <- 2 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentKeepalive.transition(SentKeepalive.java:44) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node0 | 2m 57.303s | 2025-10-14 11:28:48.246 | 1672 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 0 to 2>> | NetworkUtils: | Connection broken: 0 -> 2 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentKeepalive.transition(SentKeepalive.java:44) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node3 | 2m 57.513s | 2025-10-14 11:28:48.456 | 1671 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith0 3 to 0>> | NetworkUtils: | Connection broken: 3 <- 0 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentKeepalive.transition(SentKeepalive.java:44) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node0 | 2m 57.583s | 2025-10-14 11:28:48.526 | 1673 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 0 to 3>> | NetworkUtils: | Connection broken: 0 -> 3 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.WaitForAcceptReject.transition(WaitForAcceptReject.java:48) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node3 | 2m 57.585s | 2025-10-14 11:28:48.528 | 1672 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith1 3 to 1>> | NetworkUtils: | Connection broken: 3 <- 1 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.527255701Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.527255701Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:137) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 6 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readLong(DataInputStream.java:407) at org.hiero.base.io.streams.AugmentedDataInputStream.readLong(AugmentedDataInputStream.java:186) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.deserializeEventWindow(SyncUtils.java:623) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readTheirTipsAndEventWindow$3(SyncUtils.java:104) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more | |||||||||
| node1 | 2m 57.655s | 2025-10-14 11:28:48.598 | 1671 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 1 to 3>> | NetworkUtils: | Connection broken: 1 -> 3 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.597480059Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-10-14T11:28:48.597480059Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:145) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.readWriteParallel(ShadowgraphSynchronizer.java:279) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.reserveSynchronize(ShadowgraphSynchronizer.java:167) at com.swirlds.platform.gossip.shadowgraph.ShadowgraphSynchronizer.synchronize(ShadowgraphSynchronizer.java:105) at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:243) ... 6 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readInt(DataInputStream.java:385) at org.hiero.base.io.streams.AugmentedDataInputStream.readInt(AugmentedDataInputStream.java:179) at org.hiero.base.io.streams.AugmentedDataInputStream.readBooleanList(AugmentedDataInputStream.java:359) at com.swirlds.platform.gossip.shadowgraph.SyncUtils.lambda$readMyTipsTheyHave$7(SyncUtils.java:159) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallel(CachedPoolParallelExecutor.java:143) ... 10 more | |||||||||
| node2 | 3m 1.885s | 2025-10-14 11:28:52.828 | 1669 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node2 | 3m 1.886s | 2025-10-14 11:28:52.829 | 1670 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 3m 2.538s | 2025-10-14 11:28:53.481 | 1673 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node3 | 3m 2.540s | 2025-10-14 11:28:53.483 | 1674 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 3m 2.716s | 2025-10-14 11:28:53.659 | 1672 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node1 | 3m 2.717s | 2025-10-14 11:28:53.660 | 1673 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 3m 2.767s | 2025-10-14 11:28:53.710 | 1674 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node0 | 3m 2.768s | 2025-10-14 11:28:53.711 | 1675 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 3m 40.722s | 2025-10-14 11:29:31.665 | 1676 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node0 | 3m 40.725s | 2025-10-14 11:29:31.668 | 1677 | INFO | STARTUP | <<PTT: exit-validator 0>> | SystemExitUtils: | System exit requested (NO_ERROR) | |
| thread requesting exit: <PTT: exit-validator 0> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node0 | 3m 40.728s | 2025-10-14 11:29:31.671 | 1678 | INFO | STARTUP | <<PTT: exit-validator 0>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node0 | 3m 40.729s | 2025-10-14 11:29:31.672 | 1679 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node3 | 3m 40.793s | 2025-10-14 11:29:31.736 | 1675 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node3 | 3m 40.795s | 2025-10-14 11:29:31.738 | 1676 | INFO | STARTUP | <<PTT: exit-validator 3>> | SystemExitUtils: | System exit requested (NO_ERROR) | |
| thread requesting exit: <PTT: exit-validator 3> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node3 | 3m 40.797s | 2025-10-14 11:29:31.740 | 1677 | INFO | STARTUP | <<PTT: exit-validator 3>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node3 | 3m 40.798s | 2025-10-14 11:29:31.741 | 1678 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node2 | 3m 40.987s | 2025-10-14 11:29:31.930 | 1671 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node2 | 3m 40.989s | 2025-10-14 11:29:31.932 | 1672 | INFO | STARTUP | <<PTT: exit-validator 2>> | SystemExitUtils: | System exit requested (NO_ERROR) | |
| thread requesting exit: <PTT: exit-validator 2> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node2 | 3m 40.991s | 2025-10-14 11:29:31.934 | 1673 | INFO | STARTUP | <<PTT: exit-validator 2>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node2 | 3m 40.992s | 2025-10-14 11:29:31.935 | 1674 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node1 | 3m 41.048s | 2025-10-14 11:29:31.991 | 1674 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-10-14T11:28:00.087260Z ] | |
| node1 | 3m 41.052s | 2025-10-14 11:29:31.995 | 1675 | INFO | STARTUP | <<PTT: exit-validator 1>> | SystemExitUtils: | System exit requested (NO_ERROR) | |
| thread requesting exit: <PTT: exit-validator 1> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1217) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$21(PlatformTestingToolMain.java:1164) at java.lang.Thread.run(Thread.java:1583) | |||||||||
| node1 | 3m 41.054s | 2025-10-14 11:29:31.997 | 1676 | INFO | STARTUP | <<PTT: exit-validator 1>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node1 | 3m 41.056s | 2025-10-14 11:29:31.999 | 1677 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |