| node3 | 0.000ns | 2025-09-21 11:24:58.980 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node3 | 86.000ms | 2025-09-21 11:24:59.066 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node3 | 101.000ms | 2025-09-21 11:24:59.081 | 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 | 102.000ms | 2025-09-21 11:24:59.082 | 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 | 210.000ms | 2025-09-21 11:24:59.190 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [3] are set to run locally | |
| node3 | 216.000ms | 2025-09-21 11:24:59.196 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node3 | 242.000ms | 2025-09-21 11:24:59.222 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 243.000ms | 2025-09-21 11:24:59.223 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 243.000ms | 2025-09-21 11:24:59.223 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 244.000ms | 2025-09-21 11:24:59.224 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 244.000ms | 2025-09-21 11:24:59.224 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 245.000ms | 2025-09-21 11:24:59.225 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 245.000ms | 2025-09-21 11:24:59.225 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 246.000ms | 2025-09-21 11:24:59.226 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 246.000ms | 2025-09-21 11:24:59.226 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 246.000ms | 2025-09-21 11:24:59.226 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 247.000ms | 2025-09-21 11:24:59.227 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 247.000ms | 2025-09-21 11:24:59.227 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 248.000ms | 2025-09-21 11:24:59.228 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 248.000ms | 2025-09-21 11:24:59.228 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 249.000ms | 2025-09-21 11:24:59.229 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node3 | 615.000ms | 2025-09-21 11:24:59.595 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node1 | 1.198s | 2025-09-21 11:25:00.178 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node1 | 1.285s | 2025-09-21 11:25:00.265 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node1 | 1.301s | 2025-09-21 11:25:00.281 | 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.301s | 2025-09-21 11:25:00.281 | 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.419s | 2025-09-21 11:25:00.399 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [1] are set to run locally | |
| node1 | 1.427s | 2025-09-21 11:25:00.407 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node3 | 1.451s | 2025-09-21 11:25:00.431 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 836ms | |
| node1 | 1.458s | 2025-09-21 11:25:00.438 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 1.459s | 2025-09-21 11:25:00.439 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 1.459s | 2025-09-21 11:25:00.439 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.460s | 2025-09-21 11:25:00.440 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 1.460s | 2025-09-21 11:25:00.440 | 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 | 1.461s | 2025-09-21 11:25:00.441 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.461s | 2025-09-21 11:25:00.441 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 1.461s | 2025-09-21 11:25:00.441 | 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 | 1.462s | 2025-09-21 11:25:00.442 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.462s | 2025-09-21 11:25:00.442 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 1.463s | 2025-09-21 11:25:00.443 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 1.463s | 2025-09-21 11:25:00.443 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.463s | 2025-09-21 11:25:00.443 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 1.464s | 2025-09-21 11:25:00.444 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.464s | 2025-09-21 11:25:00.444 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 1.465s | 2025-09-21 11:25:00.445 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 1.465s | 2025-09-21 11:25:00.445 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node3 | 1.501s | 2025-09-21 11:25:00.481 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node3 | 1.557s | 2025-09-21 11:25:00.537 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node3 | 1.557s | 2025-09-21 11:25:00.537 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node2 | 1.706s | 2025-09-21 11:25:00.686 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node2 | 1.794s | 2025-09-21 11:25:00.774 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node2 | 1.810s | 2025-09-21 11:25:00.790 | 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 | 1.811s | 2025-09-21 11:25:00.791 | 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.883s | 2025-09-21 11:25:00.863 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node2 | 1.927s | 2025-09-21 11:25:00.907 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [2] are set to run locally | |
| node2 | 1.935s | 2025-09-21 11:25:00.915 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node2 | 1.964s | 2025-09-21 11:25:00.944 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 1.966s | 2025-09-21 11:25:00.946 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 1.966s | 2025-09-21 11:25:00.946 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.967s | 2025-09-21 11:25:00.947 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 1.967s | 2025-09-21 11:25:00.947 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.968s | 2025-09-21 11:25:00.948 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 1.968s | 2025-09-21 11:25:00.948 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.969s | 2025-09-21 11:25:00.949 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 1.969s | 2025-09-21 11:25:00.949 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 1.969s | 2025-09-21 11:25:00.949 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.970s | 2025-09-21 11:25:00.950 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 1.970s | 2025-09-21 11:25:00.950 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.971s | 2025-09-21 11:25:00.951 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 1.971s | 2025-09-21 11:25:00.951 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 1.972s | 2025-09-21 11:25:00.952 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node2 | 2.388s | 2025-09-21 11:25:01.368 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node0 | 2.412s | 2025-09-21 11:25:01.392 | 1 | INFO | STARTUP | <main> | StaticPlatformBuilder: | ||
| ////////////////////// // Node is Starting // ////////////////////// | |||||||||
| node0 | 2.522s | 2025-09-21 11:25:01.502 | 2 | DEBUG | STARTUP | <main> | StaticPlatformBuilder: | main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload] | |
| node0 | 2.540s | 2025-09-21 11:25:01.520 | 3 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 2.542s | 2025-09-21 11:25:01.522 | 4 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 2.676s | 2025-09-21 11:25:01.656 | 5 | INFO | STARTUP | <main> | Browser: | The following nodes [0] are set to run locally | |
| node0 | 2.684s | 2025-09-21 11:25:01.664 | 6 | INFO | STARTUP | <main> | PlatformTestingToolMain: | Registering PlatformTestingToolState with ConstructableRegistry | |
| node0 | 2.717s | 2025-09-21 11:25:01.697 | 7 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 2.719s | 2025-09-21 11:25:01.699 | 8 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 2.719s | 2025-09-21 11:25:01.699 | 9 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.720s | 2025-09-21 11:25:01.700 | 10 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 2.720s | 2025-09-21 11:25:01.700 | 11 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.721s | 2025-09-21 11:25:01.701 | 12 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 2.721s | 2025-09-21 11:25:01.701 | 13 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.722s | 2025-09-21 11:25:01.702 | 14 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 2.722s | 2025-09-21 11:25:01.702 | 15 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 2.723s | 2025-09-21 11:25:01.703 | 16 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.723s | 2025-09-21 11:25:01.703 | 17 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 2.724s | 2025-09-21 11:25:01.704 | 18 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.724s | 2025-09-21 11:25:01.704 | 19 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 2.725s | 2025-09-21 11:25:01.705 | 20 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 2.726s | 2025-09-21 11:25:01.706 | 21 | INFO | STARTUP | <main> | PlatformTestingToolMain: | PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298 | |
| node1 | 2.875s | 2025-09-21 11:25:01.855 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 992ms | |
| node1 | 2.882s | 2025-09-21 11:25:01.862 | 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.882s | 2025-09-21 11:25:01.862 | 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.923s | 2025-09-21 11:25:01.903 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node1 | 2.982s | 2025-09-21 11:25:01.962 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node1 | 2.983s | 2025-09-21 11:25:01.963 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node0 | 3.190s | 2025-09-21 11:25:02.170 | 24 | DEBUG | STARTUP | <main> | BootstrapUtils: | Scanning the classpath for RuntimeConstructable classes | |
| node2 | 3.395s | 2025-09-21 11:25:02.375 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 1006ms | |
| node2 | 3.402s | 2025-09-21 11:25:02.382 | 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 | 3.403s | 2025-09-21 11:25:02.383 | 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 | 3.446s | 2025-09-21 11:25:02.426 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node3 | 3.503s | 2025-09-21 11:25:02.483 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node2 | 3.512s | 2025-09-21 11:25:02.492 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node2 | 3.513s | 2025-09-21 11:25:02.493 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node3 | 3.583s | 2025-09-21 11:25:02.563 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node3 | 3.583s | 2025-09-21 11:25:02.563 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node3 | 3.584s | 2025-09-21 11:25:02.564 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node3 | 3.584s | 2025-09-21 11:25:02.564 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 3.584s | 2025-09-21 11:25:02.564 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node3 | 3.584s | 2025-09-21 11:25:02.564 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 3.585s | 2025-09-21 11:25:02.565 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node3 | 3.585s | 2025-09-21 11:25:02.565 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 4.265s | 2025-09-21 11:25:03.245 | 25 | DEBUG | STARTUP | <main> | BootstrapUtils: | Done with registerConstructables, time taken 1074ms | |
| node0 | 4.274s | 2025-09-21 11:25:03.254 | 26 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 4.275s | 2025-09-21 11:25:03.255 | 27 | WARN | STARTUP | <main> | PlatformConfigUtils: | Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name. | |
| node0 | 4.327s | 2025-09-21 11:25:03.307 | 28 | INFO | STARTUP | <main> | PrometheusEndpoint: | PrometheusEndpoint: Starting server listing on port: 9999 | |
| node3 | 4.340s | 2025-09-21 11:25:03.320 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node3 | 4.345s | 2025-09-21 11:25:03.325 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node0 | 4.403s | 2025-09-21 11:25:03.383 | 29 | WARN | STARTUP | <main> | CryptoStatic: | There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB. | |
| node0 | 4.404s | 2025-09-21 11:25:03.384 | 30 | DEBUG | STARTUP | <main> | CryptoStatic: | Started generating keys | |
| node1 | 5.034s | 2025-09-21 11:25:04.014 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node1 | 5.109s | 2025-09-21 11:25:04.089 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node1 | 5.110s | 2025-09-21 11:25:04.090 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node1 | 5.110s | 2025-09-21 11:25:04.090 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node1 | 5.110s | 2025-09-21 11:25:04.090 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 5.111s | 2025-09-21 11:25:04.091 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node1 | 5.111s | 2025-09-21 11:25:04.091 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 5.111s | 2025-09-21 11:25:04.091 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node1 | 5.111s | 2025-09-21 11:25:04.091 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 5.450s | 2025-09-21 11:25:04.430 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=27567081] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=170471, randomLong=-8931497105698012227, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=7110, randomLong=-423961742553495155, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1154000, data=35, exception=null] OS Health Check Report - Complete (took 1020 ms) | |||||||||
| node3 | 5.477s | 2025-09-21 11:25:04.457 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node3 | 5.484s | 2025-09-21 11:25:04.464 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node3 | 5.489s | 2025-09-21 11:25:04.469 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node2 | 5.521s | 2025-09-21 11:25:04.501 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node3 | 5.567s | 2025-09-21 11:25:04.547 | 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": "Inpgfg==", "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": "Ih5wlw==", "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+AcDA==", "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": "aMUq6w==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] } | |||||||||
| node2 | 5.605s | 2025-09-21 11:25:04.585 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node2 | 5.606s | 2025-09-21 11:25:04.586 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node2 | 5.606s | 2025-09-21 11:25:04.586 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node2 | 5.606s | 2025-09-21 11:25:04.586 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 5.607s | 2025-09-21 11:25:04.587 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node2 | 5.607s | 2025-09-21 11:25:04.587 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node2 | 5.607s | 2025-09-21 11:25:04.587 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node2 | 5.608s | 2025-09-21 11:25:04.588 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node3 | 5.656s | 2025-09-21 11:25:04.636 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node3 | 5.657s | 2025-09-21 11:25:04.637 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node3 | 5.671s | 2025-09-21 11:25:04.651 | 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: d9f1367c4edd382c8c77c7e5695053c05d5d058fe73f51e1c6c4d16d4e4e2fa3f14ebc9330575e63479c6a9eea354c44 (root) PlatformTestingToolState / sea-sort-sweet-airport 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 neglect-talk-hundred-bag 2 SingletonNode RosterService.ROSTER_STATE /2 winter-bar-smile-fat 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node3 | 5.844s | 2025-09-21 11:25:04.824 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node3 | 5.848s | 2025-09-21 11:25:04.828 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node3 | 5.856s | 2025-09-21 11:25:04.836 | 64 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node3 | 5.857s | 2025-09-21 11:25:04.837 | 65 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node3 | 5.857s | 2025-09-21 11:25:04.837 | 66 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node3 | 5.857s | 2025-09-21 11:25:04.837 | 67 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node3 | 5.857s | 2025-09-21 11:25:04.837 | 68 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node3 | 5.858s | 2025-09-21 11:25:04.838 | 69 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node3 | 5.858s | 2025-09-21 11:25:04.838 | 70 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node3 | 5.858s | 2025-09-21 11:25:04.838 | 71 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node3 | 5.859s | 2025-09-21 11:25:04.839 | 72 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node3 | 5.859s | 2025-09-21 11:25:04.839 | 73 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node3 | 5.859s | 2025-09-21 11:25:04.839 | 74 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node3 | 5.859s | 2025-09-21 11:25:04.839 | 75 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node3 | 5.860s | 2025-09-21 11:25:04.840 | 76 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node3 | 5.860s | 2025-09-21 11:25:04.840 | 77 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node3 | 5.860s | 2025-09-21 11:25:04.840 | 78 | INFO | STARTUP | <<start-node-3>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node3 | 5.876s | 2025-09-21 11:25:04.856 | 79 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | insertSeq = true | |
| node3 | 5.877s | 2025-09-21 11:25:04.857 | 80 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | appendSig = true | |
| node3 | 5.877s | 2025-09-21 11:25:04.857 | 81 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | variedSize = false | |
| node3 | 5.877s | 2025-09-21 11:25:04.857 | 82 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | payloadByteSize = 100 | |
| node3 | 5.878s | 2025-09-21 11:25:04.858 | 83 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | maxByteSize = 100 | |
| node3 | 5.878s | 2025-09-21 11:25:04.858 | 84 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node3 | 5.879s | 2025-09-21 11:25:04.859 | 85 | INFO | DEMO_INFO | <<start-node-3>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node3 | 5.880s | 2025-09-21 11:25:04.860 | 86 | INFO | DEMO_INFO | <<start-node-3>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node3 | 5.885s | 2025-09-21 11:25:04.865 | 87 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@4ac51292 | |
| node3 | 5.885s | 2025-09-21 11:25:04.865 | 88 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node3 | 5.886s | 2025-09-21 11:25:04.866 | 89 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node3 | 5.893s | 2025-09-21 11:25:04.873 | 94 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@47ee5b73, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@5a2ec050,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@3bffb485,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@2ef4394,snapshotInProgress=false] | |
| node3 | 5.900s | 2025-09-21 11:25:04.880 | 95 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node3 | 5.901s | 2025-09-21 11:25:04.881 | 96 | INFO | DEMO_INFO | <<start-node-3>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node3 | 5.905s | 2025-09-21 11:25:04.885 | 97 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 2180629843079635169 | |
| node3 | 5.906s | 2025-09-21 11:25:04.886 | 98 | INFO | DEMO_INFO | <<start-node-3>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node1 | 5.927s | 2025-09-21 11:25:04.907 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node1 | 5.933s | 2025-09-21 11:25:04.913 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node3 | 5.981s | 2025-09-21 11:25:04.961 | 99 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | Starting platform 3 | |
| node3 | 5.982s | 2025-09-21 11:25:04.962 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node3 | 5.986s | 2025-09-21 11:25:04.966 | 101 | INFO | STARTUP | <<start-node-3>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node3 | 5.987s | 2025-09-21 11:25:04.967 | 102 | INFO | STARTUP | <<start-node-3>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node3 | 5.987s | 2025-09-21 11:25:04.967 | 103 | INFO | STARTUP | <<start-node-3>> | InputWireChecks: | All input wires have been bound. | |
| node3 | 5.989s | 2025-09-21 11:25:04.969 | 104 | WARN | STARTUP | <<start-node-3>> | PcesFileTracker: | No preconsensus event files available | |
| node3 | 5.989s | 2025-09-21 11:25:04.969 | 105 | INFO | STARTUP | <<start-node-3>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node3 | 5.991s | 2025-09-21 11:25:04.971 | 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 | 5.992s | 2025-09-21 11:25:04.972 | 107 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 starts transactions ........ | |
| node3 | 5.992s | 2025-09-21 11:25:04.972 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 270.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node3 | 5.995s | 2025-09-21 11:25:04.975 | 109 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node3 | 5.996s | 2025-09-21 11:25:04.976 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 3.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node3 | 5.996s | 2025-09-21 11:25:04.976 | 111 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node2 | 6.452s | 2025-09-21 11:25:05.432 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node2 | 6.458s | 2025-09-21 11:25:05.438 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node0 | 6.573s | 2025-09-21 11:25:05.553 | 31 | DEBUG | STARTUP | <main> | CryptoStatic: | Done generating keys | |
| node0 | 6.670s | 2025-09-21 11:25:05.650 | 34 | INFO | STARTUP | <main> | StartupStateUtils: | No saved states were found on disk. | |
| node0 | 6.671s | 2025-09-21 11:25:05.651 | 35 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set ExpectedMap initial capacity to be: 4000 | |
| node0 | 6.672s | 2025-09-21 11:25:05.652 | 36 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountList initial capacity to be: 1000 | |
| node0 | 6.672s | 2025-09-21 11:25:05.652 | 37 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set accountSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 6.673s | 2025-09-21 11:25:05.653 | 38 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqList initial capacity to be: 1000 | |
| node0 | 6.673s | 2025-09-21 11:25:05.653 | 39 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set fcqSelfEntitiesList initial capacity to be: 1000 | |
| node0 | 6.673s | 2025-09-21 11:25:05.653 | 40 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountList initial capacity to be: 1000 | |
| node0 | 6.674s | 2025-09-21 11:25:05.654 | 41 | INFO | DEMO_INFO | <main> | ExpectedFCMFamily: | Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000 | |
| node1 | 7.060s | 2025-09-21 11:25:06.040 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26417450] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=176769, randomLong=2940082484253137861, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=13590, randomLong=430980811134355564, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=923899, data=35, exception=null] OS Health Check Report - Complete (took 1023 ms) | |||||||||
| node1 | 7.096s | 2025-09-21 11:25:06.076 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node1 | 7.104s | 2025-09-21 11:25:06.084 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node1 | 7.111s | 2025-09-21 11:25:06.091 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node1 | 7.205s | 2025-09-21 11:25:06.185 | 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": "Inpgfg==", "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": "Ih5wlw==", "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+AcDA==", "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": "aMUq6w==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] } | |||||||||
| node1 | 7.317s | 2025-09-21 11:25:06.297 | 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.318s | 2025-09-21 11:25:06.298 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node1 | 7.334s | 2025-09-21 11:25:06.314 | 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: d9f1367c4edd382c8c77c7e5695053c05d5d058fe73f51e1c6c4d16d4e4e2fa3f14ebc9330575e63479c6a9eea354c44 (root) PlatformTestingToolState / sea-sort-sweet-airport 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 neglect-talk-hundred-bag 2 SingletonNode RosterService.ROSTER_STATE /2 winter-bar-smile-fat 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 | 7.523s | 2025-09-21 11:25:06.503 | 51 | INFO | STARTUP | <main> | BootstrapUtils: | Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=]. | |
| node0 | 7.531s | 2025-09-21 11:25:06.511 | 52 | INFO | STARTUP | <main> | AddressBookInitializer: | Starting from genesis: using the config address book. | |
| node1 | 7.537s | 2025-09-21 11:25:06.517 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node1 | 7.542s | 2025-09-21 11:25:06.522 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node1 | 7.551s | 2025-09-21 11:25:06.531 | 64 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node1 | 7.552s | 2025-09-21 11:25:06.532 | 65 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node1 | 7.552s | 2025-09-21 11:25:06.532 | 66 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node1 | 7.553s | 2025-09-21 11:25:06.533 | 67 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node1 | 7.553s | 2025-09-21 11:25:06.533 | 68 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node1 | 7.553s | 2025-09-21 11:25:06.533 | 69 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node1 | 7.553s | 2025-09-21 11:25:06.533 | 70 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node1 | 7.554s | 2025-09-21 11:25:06.534 | 71 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node1 | 7.554s | 2025-09-21 11:25:06.534 | 72 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node1 | 7.554s | 2025-09-21 11:25:06.534 | 73 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node1 | 7.554s | 2025-09-21 11:25:06.534 | 74 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node1 | 7.555s | 2025-09-21 11:25:06.535 | 75 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node1 | 7.555s | 2025-09-21 11:25:06.535 | 76 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node1 | 7.555s | 2025-09-21 11:25:06.535 | 77 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node1 | 7.556s | 2025-09-21 11:25:06.536 | 78 | INFO | STARTUP | <<start-node-1>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node1 | 7.574s | 2025-09-21 11:25:06.554 | 79 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | insertSeq = true | |
| node1 | 7.574s | 2025-09-21 11:25:06.554 | 80 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | appendSig = true | |
| node1 | 7.575s | 2025-09-21 11:25:06.555 | 81 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | variedSize = false | |
| node1 | 7.575s | 2025-09-21 11:25:06.555 | 82 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | payloadByteSize = 100 | |
| node1 | 7.576s | 2025-09-21 11:25:06.556 | 83 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | maxByteSize = 100 | |
| node1 | 7.576s | 2025-09-21 11:25:06.556 | 84 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node1 | 7.577s | 2025-09-21 11:25:06.557 | 85 | INFO | DEMO_INFO | <<start-node-1>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node1 | 7.578s | 2025-09-21 11:25:06.558 | 86 | INFO | DEMO_INFO | <<start-node-1>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node1 | 7.583s | 2025-09-21 11:25:06.563 | 87 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@6d594cd5 | |
| node1 | 7.584s | 2025-09-21 11:25:06.564 | 88 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node1 | 7.584s | 2025-09-21 11:25:06.564 | 89 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node1 | 7.592s | 2025-09-21 11:25:06.572 | 94 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@2d2131d3, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@5399b3b3,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@65e8fb1c,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1dc1e7dd,snapshotInProgress=false] | |
| node2 | 7.592s | 2025-09-21 11:25:06.572 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26286964] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=289560, randomLong=-834200392532804367, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=9380, randomLong=5356470579692318763, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1340680, data=35, exception=null] OS Health Check Report - Complete (took 1022 ms) | |||||||||
| node1 | 7.601s | 2025-09-21 11:25:06.581 | 95 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node1 | 7.601s | 2025-09-21 11:25:06.581 | 96 | INFO | DEMO_INFO | <<start-node-1>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node1 | 7.606s | 2025-09-21 11:25:06.586 | 97 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | Random seed for FCMTransactionPool is -5651234431626198863 | |
| node1 | 7.606s | 2025-09-21 11:25:06.586 | 98 | INFO | DEMO_INFO | <<start-node-1>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node2 | 7.622s | 2025-09-21 11:25:06.602 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node2 | 7.630s | 2025-09-21 11:25:06.610 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node2 | 7.635s | 2025-09-21 11:25:06.615 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node1 | 7.685s | 2025-09-21 11:25:06.665 | 99 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | Starting platform 1 | |
| node1 | 7.686s | 2025-09-21 11:25:06.666 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node1 | 7.690s | 2025-09-21 11:25:06.670 | 101 | INFO | STARTUP | <<start-node-1>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node1 | 7.691s | 2025-09-21 11:25:06.671 | 102 | INFO | STARTUP | <<start-node-1>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node1 | 7.692s | 2025-09-21 11:25:06.672 | 103 | INFO | STARTUP | <<start-node-1>> | InputWireChecks: | All input wires have been bound. | |
| node1 | 7.694s | 2025-09-21 11:25:06.674 | 104 | WARN | STARTUP | <<start-node-1>> | PcesFileTracker: | No preconsensus event files available | |
| node1 | 7.695s | 2025-09-21 11:25:06.675 | 105 | INFO | STARTUP | <<start-node-1>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node1 | 7.696s | 2025-09-21 11:25:06.676 | 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.697s | 2025-09-21 11:25:06.677 | 107 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 starts transactions ........ | |
| node1 | 7.697s | 2025-09-21 11:25:06.677 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 312.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node1 | 7.701s | 2025-09-21 11:25:06.681 | 109 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node1 | 7.702s | 2025-09-21 11:25:06.682 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node1 | 7.703s | 2025-09-21 11:25:06.683 | 111 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node2 | 7.721s | 2025-09-21 11:25:06.701 | 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": "Inpgfg==", "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": "Ih5wlw==", "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+AcDA==", "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": "aMUq6w==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] } | |||||||||
| node2 | 7.824s | 2025-09-21 11:25:06.804 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node2 | 7.824s | 2025-09-21 11:25:06.804 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node2 | 7.841s | 2025-09-21 11:25:06.821 | 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: d9f1367c4edd382c8c77c7e5695053c05d5d058fe73f51e1c6c4d16d4e4e2fa3f14ebc9330575e63479c6a9eea354c44 (root) PlatformTestingToolState / sea-sort-sweet-airport 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 neglect-talk-hundred-bag 2 SingletonNode RosterService.ROSTER_STATE /2 winter-bar-smile-fat 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 | 8.048s | 2025-09-21 11:25:07.028 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node2 | 8.053s | 2025-09-21 11:25:07.033 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node2 | 8.064s | 2025-09-21 11:25:07.044 | 64 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node2 | 8.064s | 2025-09-21 11:25:07.044 | 65 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node2 | 8.065s | 2025-09-21 11:25:07.045 | 66 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node2 | 8.065s | 2025-09-21 11:25:07.045 | 67 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node2 | 8.066s | 2025-09-21 11:25:07.046 | 68 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node2 | 8.066s | 2025-09-21 11:25:07.046 | 69 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node2 | 8.066s | 2025-09-21 11:25:07.046 | 70 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node2 | 8.066s | 2025-09-21 11:25:07.046 | 71 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node2 | 8.067s | 2025-09-21 11:25:07.047 | 72 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node2 | 8.067s | 2025-09-21 11:25:07.047 | 73 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node2 | 8.067s | 2025-09-21 11:25:07.047 | 74 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node2 | 8.068s | 2025-09-21 11:25:07.048 | 75 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node2 | 8.068s | 2025-09-21 11:25:07.048 | 76 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node2 | 8.068s | 2025-09-21 11:25:07.048 | 77 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node2 | 8.068s | 2025-09-21 11:25:07.048 | 78 | INFO | STARTUP | <<start-node-2>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node2 | 8.086s | 2025-09-21 11:25:07.066 | 79 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | insertSeq = true | |
| node2 | 8.087s | 2025-09-21 11:25:07.067 | 80 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | appendSig = true | |
| node2 | 8.088s | 2025-09-21 11:25:07.068 | 81 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | variedSize = false | |
| node2 | 8.088s | 2025-09-21 11:25:07.068 | 82 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | payloadByteSize = 100 | |
| node2 | 8.089s | 2025-09-21 11:25:07.069 | 83 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | maxByteSize = 100 | |
| node2 | 8.089s | 2025-09-21 11:25:07.069 | 84 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node2 | 8.090s | 2025-09-21 11:25:07.070 | 85 | INFO | DEMO_INFO | <<start-node-2>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node2 | 8.091s | 2025-09-21 11:25:07.071 | 86 | INFO | DEMO_INFO | <<start-node-2>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node2 | 8.096s | 2025-09-21 11:25:07.076 | 87 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@6d594cd5 | |
| node2 | 8.097s | 2025-09-21 11:25:07.077 | 88 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node2 | 8.098s | 2025-09-21 11:25:07.078 | 89 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node2 | 8.105s | 2025-09-21 11:25:07.085 | 94 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@2d2131d3, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@5399b3b3,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@65e8fb1c,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@1dc1e7dd,snapshotInProgress=false] | |
| node2 | 8.113s | 2025-09-21 11:25:07.093 | 95 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node2 | 8.114s | 2025-09-21 11:25:07.094 | 96 | INFO | DEMO_INFO | <<start-node-2>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node2 | 8.119s | 2025-09-21 11:25:07.099 | 97 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | Random seed for FCMTransactionPool is -1840102864736679969 | |
| node2 | 8.119s | 2025-09-21 11:25:07.099 | 98 | INFO | DEMO_INFO | <<start-node-2>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node2 | 8.199s | 2025-09-21 11:25:07.179 | 99 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | Starting platform 2 | |
| node2 | 8.201s | 2025-09-21 11:25:07.181 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node2 | 8.204s | 2025-09-21 11:25:07.184 | 101 | INFO | STARTUP | <<start-node-2>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node2 | 8.205s | 2025-09-21 11:25:07.185 | 102 | INFO | STARTUP | <<start-node-2>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node2 | 8.206s | 2025-09-21 11:25:07.186 | 103 | INFO | STARTUP | <<start-node-2>> | InputWireChecks: | All input wires have been bound. | |
| node2 | 8.213s | 2025-09-21 11:25:07.193 | 104 | WARN | STARTUP | <<start-node-2>> | PcesFileTracker: | No preconsensus event files available | |
| node2 | 8.215s | 2025-09-21 11:25:07.195 | 105 | INFO | STARTUP | <<start-node-2>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node2 | 8.216s | 2025-09-21 11:25:07.196 | 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 | 8.217s | 2025-09-21 11:25:07.197 | 107 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 starts transactions ........ | |
| node2 | 8.218s | 2025-09-21 11:25:07.198 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 319.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node2 | 8.222s | 2025-09-21 11:25:07.202 | 109 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node2 | 8.222s | 2025-09-21 11:25:07.202 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node2 | 8.223s | 2025-09-21 11:25:07.203 | 111 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node0 | 8.668s | 2025-09-21 11:25:07.648 | 53 | INFO | STARTUP | <main> | OSHealthChecker: | ||
| PASSED - Clock Source Speed Check Report[callsPerSec=26220209] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=218890, randomLong=-1992613536848163682, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=15780, randomLong=-4584672642416687154, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1441170, data=35, exception=null] OS Health Check Report - Complete (took 1026 ms) | |||||||||
| node0 | 8.706s | 2025-09-21 11:25:07.686 | 54 | DEBUG | STARTUP | <main> | BootstrapUtils: | jvmPauseDetectorThread started | |
| node0 | 8.715s | 2025-09-21 11:25:07.695 | 55 | INFO | STARTUP | <main> | StandardScratchpad: | Scratchpad platform.iss contents: | |
| LAST_ISS_ROUND null | |||||||||
| node0 | 8.721s | 2025-09-21 11:25:07.701 | 56 | INFO | STARTUP | <main> | PlatformBuilder: | Default platform pool parallelism: 8 | |
| node0 | 8.821s | 2025-09-21 11:25:07.801 | 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": "Inpgfg==", "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": "Ih5wlw==", "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+AcDA==", "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": "aMUq6w==", "port": 30127 }, { "ipAddressV4": "CoAP6w==", "port": 30127 }] }] } | |||||||||
| node3 | 8.863s | 2025-09-21 11:25:07.843 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting3.csv' ] | |
| node3 | 8.864s | 2025-09-21 11:25:07.844 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node0 | 8.942s | 2025-09-21 11:25:07.922 | 58 | INFO | STARTUP | <main> | PlatformTestingToolState: | Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload] | |
| node0 | 8.943s | 2025-09-21 11:25:07.923 | 59 | INFO | STARTUP | <main> | PlatformTestingToolState: | Set QuorumResult from genesisInit() | |
| node0 | 8.962s | 2025-09-21 11:25:07.942 | 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: d9f1367c4edd382c8c77c7e5695053c05d5d058fe73f51e1c6c4d16d4e4e2fa3f14ebc9330575e63479c6a9eea354c44 (root) PlatformTestingToolState / sea-sort-sweet-airport 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 VirtualMap RosterService.ROSTERS /1 neglect-talk-hundred-bag 2 SingletonNode RosterService.ROSTER_STATE /2 winter-bar-smile-fat 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node0 | 9.204s | 2025-09-21 11:25:08.184 | 62 | INFO | EVENT_STREAM | <main> | DefaultConsensusEventStream: | EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b | |
| node0 | 9.209s | 2025-09-21 11:25:08.189 | 63 | INFO | STARTUP | <platformForkJoinThread-2> | Shadowgraph: | Shadowgraph starting from expiration threshold 1 | |
| node0 | 9.220s | 2025-09-21 11:25:08.200 | 64 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xms32g | |
| node0 | 9.221s | 2025-09-21 11:25:08.201 | 65 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xmx118g | |
| node0 | 9.221s | 2025-09-21 11:25:08.201 | 66 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UnlockExperimentalVMOptions | |
| node0 | 9.222s | 2025-09-21 11:25:08.202 | 67 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+UseZGC | |
| node0 | 9.222s | 2025-09-21 11:25:08.202 | 68 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZAllocationSpikeTolerance=2 | |
| node0 | 9.223s | 2025-09-21 11:25:08.203 | 69 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ConcGCThreads=14 | |
| node0 | 9.223s | 2025-09-21 11:25:08.203 | 70 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:ZMarkStackSpaceLimit=16g | |
| node0 | 9.224s | 2025-09-21 11:25:08.204 | 71 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MaxDirectMemorySize=64g | |
| node0 | 9.225s | 2025-09-21 11:25:08.205 | 72 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:MetaspaceSize=100M | |
| node0 | 9.225s | 2025-09-21 11:25:08.205 | 73 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -XX:+ZGenerational | |
| node0 | 9.225s | 2025-09-21 11:25:08.205 | 74 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Xlog:gc*:gc.log | |
| node0 | 9.226s | 2025-09-21 11:25:08.206 | 75 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED | |
| node0 | 9.226s | 2025-09-21 11:25:08.206 | 76 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED | |
| node0 | 9.226s | 2025-09-21 11:25:08.206 | 77 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | JVM arg: -Dio.netty.tryReflectionSetAccessible=true | |
| node0 | 9.227s | 2025-09-21 11:25:08.207 | 78 | INFO | STARTUP | <<start-node-0>> | PlatformTestingToolMain: | Parsing JSON FCM-VM-NIReconnect-125-10m.json | |
| node0 | 9.250s | 2025-09-21 11:25:08.230 | 79 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | insertSeq = true | |
| node0 | 9.250s | 2025-09-21 11:25:08.230 | 80 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | appendSig = true | |
| node0 | 9.251s | 2025-09-21 11:25:08.231 | 81 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | variedSize = false | |
| node0 | 9.251s | 2025-09-21 11:25:08.231 | 82 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | payloadByteSize = 100 | |
| node0 | 9.252s | 2025-09-21 11:25:08.232 | 83 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | maxByteSize = 100 | |
| node0 | 9.252s | 2025-09-21 11:25:08.232 | 84 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | type = TYPE_FCM_VIRTUAL_MIX | |
| node0 | 9.253s | 2025-09-21 11:25:08.233 | 85 | INFO | DEMO_INFO | <<start-node-0>> | PayloadConfig: | invalidSigRatio = 0.0 | |
| node0 | 9.255s | 2025-09-21 11:25:08.235 | 86 | INFO | DEMO_INFO | <<start-node-0>> | TransactionSubmitter: | Goal is TRANS_PER_SECOND_PER_NODE targe 125.0 | |
| node0 | 9.260s | 2025-09-21 11:25:08.240 | 87 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | State = com.swirlds.demo.platform.PlatformTestingToolState@1d86f5ba | |
| node0 | 9.262s | 2025-09-21 11:25:08.242 | 88 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total accounts = 2400 | |
| node0 | 9.262s | 2025-09-21 11:25:08.242 | 89 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | Creating virtualmap for 2400 accounts. | |
| node0 | 9.271s | 2025-09-21 11:25:08.251 | 94 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | accounts VM = com.swirlds.virtualmap.VirtualMap@78a2a88, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@34a3fe7e,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@22886122,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@5b3dcc66,snapshotInProgress=false] | |
| node0 | 9.281s | 2025-09-21 11:25:08.261 | 95 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | max KV pairs = 0 | |
| node0 | 9.282s | 2025-09-21 11:25:08.262 | 96 | INFO | DEMO_INFO | <<start-node-0>> | VirtualMerkleStateInitializer: | total SC = 0 | |
| node0 | 9.289s | 2025-09-21 11:25:08.269 | 97 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | Random seed for FCMTransactionPool is 4766549818964472658 | |
| node0 | 9.289s | 2025-09-21 11:25:08.269 | 98 | INFO | DEMO_INFO | <<start-node-0>> | FCMTransactionPool: | This test will generate sequential FCM payload: | |
| node0 | 9.395s | 2025-09-21 11:25:08.375 | 99 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | Starting platform 0 | |
| node0 | 9.399s | 2025-09-21 11:25:08.379 | 100 | INFO | STARTUP | <<platform: recycle-bin-cleanup>> | RecycleBinImpl: | Deleted 0 files from the recycle bin. | |
| node0 | 9.404s | 2025-09-21 11:25:08.384 | 101 | INFO | STARTUP | <<start-node-0>> | CycleFinder: | No cyclical back pressure detected in wiring model. | |
| node0 | 9.405s | 2025-09-21 11:25:08.385 | 102 | INFO | STARTUP | <<start-node-0>> | DirectSchedulerChecks: | No illegal direct scheduler use detected in the wiring model. | |
| node0 | 9.406s | 2025-09-21 11:25:08.386 | 103 | INFO | STARTUP | <<start-node-0>> | InputWireChecks: | All input wires have been bound. | |
| node0 | 9.409s | 2025-09-21 11:25:08.389 | 104 | WARN | STARTUP | <<start-node-0>> | PcesFileTracker: | No preconsensus event files available | |
| node0 | 9.410s | 2025-09-21 11:25:08.390 | 105 | INFO | STARTUP | <<start-node-0>> | SwirldsPlatform: | replaying preconsensus event stream starting at 0 | |
| node0 | 9.412s | 2025-09-21 11:25:08.392 | 106 | INFO | STARTUP | <<start-node-0>> | PcesReplayer: | Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds. | |
| node0 | 9.414s | 2025-09-21 11:25:08.394 | 107 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 starts transactions ........ | |
| node0 | 9.416s | 2025-09-21 11:25:08.396 | 108 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 390.0 ms in STARTING_UP. Now in REPLAYING_EVENTS | |
| node0 | 9.422s | 2025-09-21 11:25:08.402 | 109 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change REPLAYING_EVENTS | |
| node0 | 9.424s | 2025-09-21 11:25:08.404 | 110 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 6.0 ms in REPLAYING_EVENTS. Now in OBSERVING | |
| node0 | 9.424s | 2025-09-21 11:25:08.404 | 111 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change OBSERVING | |
| node1 | 10.559s | 2025-09-21 11:25:09.539 | 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.562s | 2025-09-21 11:25:09.542 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node2 | 11.071s | 2025-09-21 11:25:10.051 | 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 | 11.073s | 2025-09-21 11:25:10.053 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node0 | 12.229s | 2025-09-21 11:25:11.209 | 112 | INFO | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting0.csv' ] | |
| node0 | 12.232s | 2025-09-21 11:25:11.212 | 113 | DEBUG | STARTUP | <<platform-core: MetricsThread #0>> | LegacyCsvWriter: | CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ] | |
| node3 | 16.089s | 2025-09-21 11:25:15.069 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-3> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node3 | 16.089s | 2025-09-21 11:25:15.069 | 115 | INFO | STARTUP | <platformForkJoinThread-3> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 17.793s | 2025-09-21 11:25:16.773 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node1 | 17.794s | 2025-09-21 11:25:16.774 | 115 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node2 | 18.307s | 2025-09-21 11:25:17.287 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-7> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node2 | 18.307s | 2025-09-21 11:25:17.287 | 115 | INFO | STARTUP | <platformForkJoinThread-7> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 19.508s | 2025-09-21 11:25:18.488 | 114 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 10.1 s in OBSERVING. Now in CHECKING | |
| node0 | 19.509s | 2025-09-21 11:25:18.489 | 115 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 19.838s | 2025-09-21 11:25:18.818 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node3 | 19.838s | 2025-09-21 11:25:18.818 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 3.7 s in CHECKING. Now in ACTIVE | |
| node3 | 19.839s | 2025-09-21 11:25:18.819 | 118 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node0 | 19.910s | 2025-09-21 11:25:18.890 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node3 | 19.912s | 2025-09-21 11:25:18.892 | 119 | TRACE | STARTUP | <<app: appMain 3>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x8328D7DA7AA71A86542BC263C51591AC7040A0D265A8C45F31757F1EE4FF80CE', privateKey ='0x8328D7DA7AA71A86542BC263C51591AC7040A0D265A8C45F31757F1EE4FF80CE', signature = '0xD85BDB514D6BB0A5FF149E6D30756D3FABB0C7E6B69FF2C89F17C0AB97AEC75550DF741F97A265F542DE7BE97E6E0215515AEF30AB31F0996668DC7FC1297E0C',message = '0x12660A1A0803100318A03820A03828A03830A0384089D3ABB7F0A2FFB90D3244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038034001' } | |
| node2 | 19.922s | 2025-09-21 11:25:18.902 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node1 | 19.968s | 2025-09-21 11:25:18.948 | 116 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | resetting transaction counters | |
| node1 | 20.601s | 2025-09-21 11:25:19.581 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-4> | DefaultStatusStateMachine: | Platform spent 2.8 s in CHECKING. Now in ACTIVE | |
| node1 | 20.602s | 2025-09-21 11:25:19.582 | 118 | INFO | STARTUP | <platformForkJoinThread-4> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node1 | 20.628s | 2025-09-21 11:25:19.608 | 119 | TRACE | STARTUP | <<app: appMain 1>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0xFD0E8B1ECE88922C295CFB85B4D1871E007D8C8D0C41D1F563EA9886387367E0', privateKey ='0xFD0E8B1ECE88922C295CFB85B4D1871E007D8C8D0C41D1F563EA9886387367E0', signature = '0x442CBCCA9B62234E777D9114A339DE9D93C6FF10F644719E61EF2EA8526E1DFAA8D3A753755EF3DD6037A038BFB61501532EF13B1A458B310D9266551ADEE10B',message = '0x1A6B0A1B08011001180120A18D0628914E30914E40ECA28AAEBEABFACBB5012A4900000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00101' } | |
| node2 | 20.836s | 2025-09-21 11:25:19.816 | 117 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | DefaultStatusStateMachine: | Platform spent 2.5 s in CHECKING. Now in ACTIVE | |
| node2 | 20.836s | 2025-09-21 11:25:19.816 | 118 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node2 | 20.856s | 2025-09-21 11:25:19.836 | 119 | TRACE | STARTUP | <<app: appMain 2>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x6426BA3BB97720A611DCD653AC8C2AA8745A64650C3644080AE537210B5AAF92', privateKey ='0x6426BA3BB97720A611DCD653AC8C2AA8745A64650C3644080AE537210B5AAF92', signature = '0x0B368F6EB923E23EF8F6AB2391100D3C14832E8DADA13B0B8CDF32E6B2ACA41EA856665E13C3EF91269B7AD5BD726FCA8152451C602877D5CB89A99CAC1B5109',message = '0x1A6B0A1A08021002180120A18D0628914E30914E40C0BFF3B3F1CAAAFC412A4A0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00102' } | |
| node3 | 21.238s | 2025-09-21 11:25:20.218 | 122 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node0 | 21.311s | 2025-09-21 11:25:20.291 | 119 | INFO | STATE_TO_DISK | <<scheduler TransactionHandler>> | DefaultSavedStateController: | Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS | |
| node2 | 21.338s | 2025-09-21 11:25:20.318 | 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 | 21.584s | 2025-09-21 11:25:20.564 | 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 | 21.646s | 2025-09-21 11:25:20.626 | 137 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 | |
| node1 | 21.648s | 2025-09-21 11:25:20.628 | 138 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node1 | 21.921s | 2025-09-21 11:25:20.901 | 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 | 21.925s | 2025-09-21 11:25:20.905 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-09-21T11:25:18.867579416Z Next consensus number: 13 Legacy running event hash: 4ebba2a8b5da6be57702ebacb938168fe60e10a157f26ba578b337868803eb913da41361764664aacf3cde5731968c54 Legacy running event mnemonic: student-prison-dynamic-lake Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 5e8750d8d1971ace99ceaa2bd9d43a4d433c90e1c00097fe24145be349b156e1030a42edccaf65bd6b567ccd3744c711 (root) PlatformTestingToolState / special-brand-snake-flush 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 tuition-ready-myth-machine 1 VirtualMap RosterService.ROSTERS /1 neglect-talk-hundred-bag 2 SingletonNode RosterService.ROSTER_STATE /2 winter-bar-smile-fat 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node1 | 21.955s | 2025-09-21 11:25:20.935 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/1/2025/09/21/2025-09-21T11+25+15.489341331Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 21.955s | 2025-09-21 11:25:20.935 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/1/2025/09/21/2025-09-21T11+25+15.489341331Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node1 | 21.955s | 2025-09-21 11:25:20.935 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node1 | 21.956s | 2025-09-21 11:25:20.936 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node1 | 21.961s | 2025-09-21 11:25:20.941 | 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] | |
| node3 | 22.076s | 2025-09-21 11:25:21.056 | 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 | 22.078s | 2025-09-21 11:25:21.058 | 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 | 22.100s | 2025-09-21 11:25:21.080 | 134 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Started writing round 3 state to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 | |
| node0 | 22.103s | 2025-09-21 11:25:21.083 | 135 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node2 | 22.171s | 2025-09-21 11:25:21.151 | 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 | 22.173s | 2025-09-21 11:25:21.153 | 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 | 22.289s | 2025-09-21 11:25:21.269 | 150 | INFO | PLATFORM_STATUS | <platformForkJoinThread-6> | DefaultStatusStateMachine: | Platform spent 2.8 s in CHECKING. Now in ACTIVE | |
| node0 | 22.290s | 2025-09-21 11:25:21.270 | 151 | INFO | STARTUP | <platformForkJoinThread-6> | PlatformTestingToolMain: | Platform Status Change ACTIVE | |
| node0 | 22.302s | 2025-09-21 11:25:21.282 | 153 | TRACE | STARTUP | <<app: appMain 0>> | PttTransactionPool: | Signed Message { signatureType = 'ED25519', publicKey = '0x329D7AF99E0101A61A87586B50A29A6344D9CADAF4CFA8BF34832BAB0913A4E9', privateKey ='0x329D7AF99E0101A61A87586B50A29A6344D9CADAF4CFA8BF34832BAB0913A4E9', signature = '0x0D734E1215ABDBFB3F17BC659CEF47B99A179913547DD028A6A398454004B16FCF1FDCD542F372D70532F313C7B213D7EC027E8952343644175DB875A0506E09',message = '0x1A680A1A18A33820C3C50628B3860130B38601409798E587A1D0D8B1BA012A4A0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000' } | |
| node3 | 22.361s | 2025-09-21 11:25:21.341 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node3 | 22.364s | 2025-09-21 11:25:21.344 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-09-21T11:25:18.867579416Z Next consensus number: 13 Legacy running event hash: 4ebba2a8b5da6be57702ebacb938168fe60e10a157f26ba578b337868803eb913da41361764664aacf3cde5731968c54 Legacy running event mnemonic: student-prison-dynamic-lake Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 5e8750d8d1971ace99ceaa2bd9d43a4d433c90e1c00097fe24145be349b156e1030a42edccaf65bd6b567ccd3744c711 (root) PlatformTestingToolState / special-brand-snake-flush 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 tuition-ready-myth-machine 1 VirtualMap RosterService.ROSTERS /1 neglect-talk-hundred-bag 2 SingletonNode RosterService.ROSTER_STATE /2 winter-bar-smile-fat 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 | 22.395s | 2025-09-21 11:25:21.375 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/3/2025/09/21/2025-09-21T11+25+15.098984256Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 22.396s | 2025-09-21 11:25:21.376 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/3/2025/09/21/2025-09-21T11+25+15.098984256Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node3 | 22.396s | 2025-09-21 11:25:21.376 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node3 | 22.397s | 2025-09-21 11:25:21.377 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node3 | 22.401s | 2025-09-21 11:25:21.381 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/3/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node0 | 22.408s | 2025-09-21 11:25:21.388 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node0 | 22.412s | 2025-09-21 11:25:21.392 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-09-21T11:25:18.867579416Z Next consensus number: 13 Legacy running event hash: 4ebba2a8b5da6be57702ebacb938168fe60e10a157f26ba578b337868803eb913da41361764664aacf3cde5731968c54 Legacy running event mnemonic: student-prison-dynamic-lake Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 5e8750d8d1971ace99ceaa2bd9d43a4d433c90e1c00097fe24145be349b156e1030a42edccaf65bd6b567ccd3744c711 (root) PlatformTestingToolState / special-brand-snake-flush 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 tuition-ready-myth-machine 1 VirtualMap RosterService.ROSTERS /1 neglect-talk-hundred-bag 2 SingletonNode RosterService.ROSTER_STATE /2 winter-bar-smile-fat 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node0 | 22.448s | 2025-09-21 11:25:21.428 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/0/2025/09/21/2025-09-21T11+25+15.344265039Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 22.449s | 2025-09-21 11:25:21.429 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/0/2025/09/21/2025-09-21T11+25+15.344265039Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node0 | 22.449s | 2025-09-21 11:25:21.429 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node0 | 22.451s | 2025-09-21 11:25:21.431 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node2 | 22.455s | 2025-09-21 11:25:21.435 | 195 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | MerkleTreeSnapshotWriter: | Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/1 for round 3 | |
| node0 | 22.456s | 2025-09-21 11:25:21.436 | 201 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/0/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload] | |
| node2 | 22.458s | 2025-09-21 11:25:21.438 | 196 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | SignedStateFileWriter: | Information for state written to disk: | |
| Round: 3 Timestamp: 2025-09-21T11:25:18.867579416Z Next consensus number: 13 Legacy running event hash: 4ebba2a8b5da6be57702ebacb938168fe60e10a157f26ba578b337868803eb913da41361764664aacf3cde5731968c54 Legacy running event mnemonic: student-prison-dynamic-lake Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 5e8750d8d1971ace99ceaa2bd9d43a4d433c90e1c00097fe24145be349b156e1030a42edccaf65bd6b567ccd3744c711 (root) PlatformTestingToolState / special-brand-snake-flush 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 tuition-ready-myth-machine 1 VirtualMap RosterService.ROSTERS /1 neglect-talk-hundred-bag 2 SingletonNode RosterService.ROSTER_STATE /2 winter-bar-smile-fat 3 PayloadCfgSimple /3 potato-pill-swear-author 4 NextSeqConsList /4 sniff-wear-know-arrow 5 FCMFamily /5 coconut-machine-scrap-dish 0 MerkleMap /5/0 fall-topple-alarm-witness 1 MerkleMap /5/1 fall-topple-alarm-witness 6 TransactionCounterList /6 talk-valve-shift-secret 7 IssLeaf /7 biology-capable-expose-purpose 8 NftLedger /8 chicken-butter-size-happy 0 MerkleMap /8/0 fall-topple-alarm-witness 1 null /8/1 bid-belt-culture-decorate 9 VirtualMap accounts /9 absent-boy-buddy-wear 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop | |||||||||
| node2 | 22.490s | 2025-09-21 11:25:21.470 | 197 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus file on disk. | |
| File: data/saved/preconsensus-events/2/2025/09/21/2025-09-21T11+25+15.413399405Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 22.491s | 2025-09-21 11:25:21.471 | 198 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Found 1 preconsensus event file meeting specified criteria to copy. | |
| Lower bound: 1 File: data/saved/preconsensus-events/2/2025/09/21/2025-09-21T11+25+15.413399405Z_seq0_minr1_maxr501_orgn0.pces | |||||||||
| node2 | 22.491s | 2025-09-21 11:25:21.471 | 199 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Copying 1 preconsensus event file(s) | |
| node2 | 22.492s | 2025-09-21 11:25:21.472 | 200 | INFO | STATE_TO_DISK | <<scheduler StateSnapshotManager>> | BestEffortPcesFileCopy: | Finished copying 1 preconsensus event file(s) | |
| node2 | 22.497s | 2025-09-21 11:25:21.477 | 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] | |
| node3 | 26.323s | 2025-09-21 11:25:25.303 | 226 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node1 | 27.434s | 2025-09-21 11:25:26.414 | 242 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 27.531s | 2025-09-21 11:25:26.511 | 242 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 27.945s | 2025-09-21 11:25:26.925 | 243 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node0 | 28.766s | 2025-09-21 11:25:27.746 | 262 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 28.949s | 2025-09-21 11:25:27.929 | 263 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 28.952s | 2025-09-21 11:25:27.932 | 263 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node0 | 30.338s | 2025-09-21 11:25:29.318 | 267 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node3 | 59.705s | 2025-09-21 11:25:58.685 | 564 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 1.016m | 2025-09-21 11:25:59.935 | 584 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node2 | 1m 1.443s | 2025-09-21 11:26:00.423 | 584 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node0 | 1m 2.825s | 2025-09-21 11:26:01.805 | 588 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 1m 24.274s | 2025-09-21 11:26:23.254 | 789 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node1 | 1m 24.276s | 2025-09-21 11:26:23.256 | 790 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node1 | 1m 24.279s | 2025-09-21 11:26:23.259 | 791 | INFO | DEMO_INFO | <<app: appMain 1>> | FCMTransactionPool: | node1 submits a transaction SAVE_EXPECTED_MAP | |
| node3 | 1m 24.489s | 2025-09-21 11:26:23.469 | 805 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node3 | 1m 24.491s | 2025-09-21 11:26:23.471 | 806 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node3 | 1m 24.493s | 2025-09-21 11:26:23.473 | 807 | INFO | DEMO_INFO | <<app: appMain 3>> | FCMTransactionPool: | node3 submits a transaction SAVE_EXPECTED_MAP | |
| node2 | 1m 25.179s | 2025-09-21 11:26:24.159 | 805 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node2 | 1m 25.180s | 2025-09-21 11:26:24.160 | 806 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node2 | 1m 25.181s | 2025-09-21 11:26:24.161 | 807 | INFO | DEMO_INFO | <<app: appMain 2>> | FCMTransactionPool: | node2 submits a transaction SAVE_EXPECTED_MAP | |
| node0 | 1m 25.449s | 2025-09-21 11:26:24.429 | 805 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type TYPE_FCM_CREATE | |
| node0 | 1m 25.451s | 2025-09-21 11:26:24.431 | 806 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | Generated enough FCM transaction for type SAVE_EXPECTED_MAP | |
| node0 | 1m 25.452s | 2025-09-21 11:26:24.432 | 807 | INFO | DEMO_INFO | <<app: appMain 0>> | FCMTransactionPool: | node0 submits a transaction SAVE_EXPECTED_MAP | |
| node2 | 1m 26.385s | 2025-09-21 11:26:25.365 | 812 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node3 | 1m 26.487s | 2025-09-21 11:26:25.467 | 812 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node0 | 1m 26.537s | 2025-09-21 11:26:25.517 | 812 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node1 | 1m 26.551s | 2025-09-21 11:26:25.531 | 828 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 3 | |
| node1 | 1m 27.170s | 2025-09-21 11:26:26.150 | 829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node1 | 1m 27.183s | 2025-09-21 11:26:26.163 | 830 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node0 | 1m 27.304s | 2025-09-21 11:26:26.284 | 829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node3 | 1m 27.305s | 2025-09-21 11:26:26.285 | 829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node0 | 1m 27.316s | 2025-09-21 11:26:26.296 | 830 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node3 | 1m 27.316s | 2025-09-21 11:26:26.296 | 830 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node2 | 1m 27.324s | 2025-09-21 11:26:26.304 | 829 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 1 | |
| node2 | 1m 27.338s | 2025-09-21 11:26:26.318 | 830 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Received SAVE_EXPECTED_MAP transaction from node 2 | |
| node0 | 1m 27.810s | 2025-09-21 11:26:26.790 | 831 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1758453985013_13132410.json.gz | |
| node3 | 1m 27.889s | 2025-09-21 11:26:26.869 | 831 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1758453985013_13132410.json.gz | |
| node1 | 1m 27.934s | 2025-09-21 11:26:26.914 | 831 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1758453985013_13132410.json.gz | |
| node2 | 1m 27.948s | 2025-09-21 11:26:26.928 | 831 | INFO | SAVE_EXPECTED_MAP | <<scheduler TransactionHandler>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1758453985013_13132410.json.gz | |
| node0 | 1m 28.123s | 2025-09-21 11:26:27.103 | 832 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node3 | 1m 28.178s | 2025-09-21 11:26:27.158 | 832 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node1 | 1m 28.226s | 2025-09-21 11:26:27.206 | 832 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node2 | 1m 28.240s | 2025-09-21 11:26:27.220 | 832 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | handling SAVE_EXPECTED_MAP | |
| node3 | 1m 31.552s | 2025-09-21 11:26:30.532 | 873 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node2 | 1m 32.493s | 2025-09-21 11:26:31.473 | 877 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node1 | 1m 32.900s | 2025-09-21 11:26:31.880 | 893 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node3 | 1m 33.215s | 2025-09-21 11:26:32.195 | 894 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node2 | 1m 34.005s | 2025-09-21 11:26:32.985 | 898 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node1 | 1m 34.411s | 2025-09-21 11:26:33.391 | 898 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node0 | 1m 35.288s | 2025-09-21 11:26:34.268 | 913 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions | |
| node0 | 1m 37.002s | 2025-09-21 11:26:35.982 | 934 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions | |
| node3 | 2m 4.254s | 2025-09-21 11:27:03.234 | 1215 | INFO | DEMO_INFO | <<app: appMain 3>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node3 | 2m 4.306s | 2025-09-21 11:27:03.286 | 1216 | INFO | DEMO_INFO | <<app: appMain 3>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node3 | 2m 4.306s | 2025-09-21 11:27:03.286 | 1217 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Stop generating transactions | |
| node3 | 2m 4.309s | 2025-09-21 11:27:03.289 | 1218 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | node 3 sent ENTER_VALIDATION Message | |
| node3 | 2m 4.311s | 2025-09-21 11:27:03.291 | 1219 | INFO | DEMO_INFO | <<app: appMain 3>> | PlatformTestingToolMain: | Node 3 finished generating all transactions. | |
| node2 | 2m 5.798s | 2025-09-21 11:27:04.778 | 1235 | INFO | DEMO_INFO | <<app: appMain 2>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node2 | 2m 5.850s | 2025-09-21 11:27:04.830 | 1236 | INFO | DEMO_INFO | <<app: appMain 2>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node2 | 2m 5.850s | 2025-09-21 11:27:04.830 | 1237 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Stop generating transactions | |
| node2 | 2m 5.850s | 2025-09-21 11:27:04.830 | 1238 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | node 2 sent ENTER_VALIDATION Message | |
| node2 | 2m 5.853s | 2025-09-21 11:27:04.833 | 1239 | INFO | DEMO_INFO | <<app: appMain 2>> | PlatformTestingToolMain: | Node 2 finished generating all transactions. | |
| node3 | 2m 6.426s | 2025-09-21 11:27:05.406 | 1240 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:03.637588826Z ] | |
| node3 | 2m 6.427s | 2025-09-21 11:27:05.407 | 1241 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-21T11:27:03.637588826Z,type=ENTER_VALIDATION] | |
| node1 | 2m 6.482s | 2025-09-21 11:27:05.462 | 1235 | INFO | DEMO_INFO | <<app: appMain 1>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 2m 6.533s | 2025-09-21 11:27:05.513 | 1236 | INFO | DEMO_INFO | <<app: appMain 1>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node1 | 2m 6.534s | 2025-09-21 11:27:05.514 | 1237 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Stop generating transactions | |
| node1 | 2m 6.534s | 2025-09-21 11:27:05.514 | 1238 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | node 1 sent ENTER_VALIDATION Message | |
| node1 | 2m 6.537s | 2025-09-21 11:27:05.517 | 1239 | INFO | DEMO_INFO | <<app: appMain 1>> | PlatformTestingToolMain: | Node 1 finished generating all transactions. | |
| node1 | 2m 6.551s | 2025-09-21 11:27:05.531 | 1240 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:03.637588826Z ] | |
| node1 | 2m 6.551s | 2025-09-21 11:27:05.531 | 1241 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-21T11:27:03.637588826Z,type=ENTER_VALIDATION] | |
| node0 | 2m 6.587s | 2025-09-21 11:27:05.567 | 1235 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:03.637588826Z ] | |
| node0 | 2m 6.589s | 2025-09-21 11:27:05.569 | 1236 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-21T11:27:03.637588826Z,type=ENTER_VALIDATION] | |
| node2 | 2m 6.625s | 2025-09-21 11:27:05.605 | 1240 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:03.637588826Z ] | |
| node2 | 2m 6.626s | 2025-09-21 11:27:05.606 | 1241 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-21T11:27:03.637588826Z,type=ENTER_VALIDATION] | |
| node0 | 2m 8.555s | 2025-09-21 11:27:07.535 | 1257 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:05.522856552Z ] | |
| node0 | 2m 8.556s | 2025-09-21 11:27:07.536 | 1258 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-21T11:27:05.522856552Z,type=ENTER_VALIDATION] | |
| node0 | 2m 8.559s | 2025-09-21 11:27:07.539 | 1259 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:05.836601Z ] | |
| node0 | 2m 8.559s | 2025-09-21 11:27:07.539 | 1260 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-21T11:27:05.836601Z,type=ENTER_VALIDATION] | |
| node0 | 2m 8.595s | 2025-09-21 11:27:07.575 | 1265 | INFO | DEMO_INFO | <<app: appMain 0>> | SequentialTransactionRequestSupplier: | Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions | |
| node1 | 2m 8.629s | 2025-09-21 11:27:07.609 | 1262 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:05.522856552Z ] | |
| node1 | 2m 8.629s | 2025-09-21 11:27:07.609 | 1263 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-21T11:27:05.522856552Z,type=ENTER_VALIDATION] | |
| node1 | 2m 8.631s | 2025-09-21 11:27:07.611 | 1264 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:05.836601Z ] | |
| node1 | 2m 8.631s | 2025-09-21 11:27:07.611 | 1265 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-21T11:27:05.836601Z,type=ENTER_VALIDATION] | |
| node0 | 2m 8.646s | 2025-09-21 11:27:07.626 | 1266 | INFO | DEMO_INFO | <<app: appMain 0>> | PttTransactionPool: | Generated enough virtual merkle test for sequential mode | |
| node0 | 2m 8.646s | 2025-09-21 11:27:07.626 | 1267 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Stop generating transactions | |
| node0 | 2m 8.646s | 2025-09-21 11:27:07.626 | 1268 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | node 0 sent ENTER_VALIDATION Message | |
| node0 | 2m 8.647s | 2025-09-21 11:27:07.627 | 1269 | INFO | DEMO_INFO | <<app: appMain 0>> | PlatformTestingToolMain: | Node 0 finished generating all transactions. | |
| node3 | 2m 8.756s | 2025-09-21 11:27:07.736 | 1262 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:05.522856552Z ] | |
| node3 | 2m 8.757s | 2025-09-21 11:27:07.737 | 1263 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-21T11:27:05.522856552Z,type=ENTER_VALIDATION] | |
| node3 | 2m 8.758s | 2025-09-21 11:27:07.738 | 1264 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:05.836601Z ] | |
| node3 | 2m 8.758s | 2025-09-21 11:27:07.738 | 1265 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-21T11:27:05.836601Z,type=ENTER_VALIDATION] | |
| node2 | 2m 8.822s | 2025-09-21 11:27:07.802 | 1262 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:05.522856552Z ] | |
| node2 | 2m 8.822s | 2025-09-21 11:27:07.802 | 1263 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-21T11:27:05.522856552Z,type=ENTER_VALIDATION] | |
| node2 | 2m 8.824s | 2025-09-21 11:27:07.804 | 1264 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:05.836601Z ] | |
| node2 | 2m 8.824s | 2025-09-21 11:27:07.804 | 1265 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-21T11:27:05.836601Z,type=ENTER_VALIDATION] | |
| node2 | 2m 10.555s | 2025-09-21 11:27:09.535 | 1286 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:08.022868098Z ] | |
| node2 | 2m 10.556s | 2025-09-21 11:27:09.536 | 1287 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-21T11:27:08.022868098Z,type=ENTER_VALIDATION] | |
| node2 | 2m 10.557s | 2025-09-21 11:27:09.537 | 1288 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node2 | 2m 10.558s | 2025-09-21 11:27:09.538 | 1290 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1758454028022_22868098.json, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node2 | 2m 10.580s | 2025-09-21 11:27:09.560 | 1294 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 2>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0002_ExpectedMap_1758454028022_22868098.json.gz | |
| node3 | 2m 10.626s | 2025-09-21 11:27:09.606 | 1286 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:08.022868098Z ] | |
| node3 | 2m 10.626s | 2025-09-21 11:27:09.606 | 1287 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-21T11:27:08.022868098Z,type=ENTER_VALIDATION] | |
| node3 | 2m 10.627s | 2025-09-21 11:27:09.607 | 1288 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node3 | 2m 10.629s | 2025-09-21 11:27:09.609 | 1291 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1758454028022_22868098.json, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node3 | 2m 10.648s | 2025-09-21 11:27:09.628 | 1294 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 3>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0003_ExpectedMap_1758454028022_22868098.json.gz | |
| node0 | 2m 10.839s | 2025-09-21 11:27:09.819 | 1286 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:08.022868098Z ] | |
| node0 | 2m 10.839s | 2025-09-21 11:27:09.819 | 1287 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-21T11:27:08.022868098Z,type=ENTER_VALIDATION] | |
| node0 | 2m 10.840s | 2025-09-21 11:27:09.820 | 1288 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node0 | 2m 10.842s | 2025-09-21 11:27:09.822 | 1291 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1758454028022_22868098.json, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node0 | 2m 10.872s | 2025-09-21 11:27:09.852 | 1294 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 0>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0000_ExpectedMap_1758454028022_22868098.json.gz | |
| node1 | 2m 10.884s | 2025-09-21 11:27:09.864 | 1286 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-09-21T11:27:08.022868098Z ] | |
| node1 | 2m 10.884s | 2025-09-21 11:27:09.864 | 1287 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-21T11:27:08.022868098Z,type=ENTER_VALIDATION] | |
| node1 | 2m 10.885s | 2025-09-21 11:27:09.865 | 1288 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node1 | 2m 10.887s | 2025-09-21 11:27:09.867 | 1290 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1758454028022_22868098.json, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node2 | 2m 10.889s | 2025-09-21 11:27:09.869 | 1295 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1758454028022_22868098.json, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node2 | 2m 10.890s | 2025-09-21 11:27:09.870 | 1296 | INFO | DEMO_QUORUM | <<PTT: enter-validator 2>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node1 | 2m 10.907s | 2025-09-21 11:27:09.887 | 1294 | INFO | SAVE_EXPECTED_MAP | <<PTT: enter-validator 1>> | SaveExpectedMapHandler: | Serializing ExpectedMap Node0001_ExpectedMap_1758454028022_22868098.json.gz | |
| node3 | 2m 10.936s | 2025-09-21 11:27:09.916 | 1295 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1758454028022_22868098.json, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node3 | 2m 10.936s | 2025-09-21 11:27:09.916 | 1296 | INFO | DEMO_QUORUM | <<PTT: enter-validator 3>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node0 | 2m 11.198s | 2025-09-21 11:27:10.178 | 1295 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1758454028022_22868098.json, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node0 | 2m 11.199s | 2025-09-21 11:27:10.179 | 1296 | INFO | DEMO_QUORUM | <<PTT: enter-validator 0>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node1 | 2m 11.215s | 2025-09-21 11:27:10.195 | 1295 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1758454028022_22868098.json, consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node1 | 2m 11.215s | 2025-09-21 11:27:10.195 | 1296 | INFO | DEMO_QUORUM | <<PTT: enter-validator 1>> | PlatformTestingToolMain: | Sent EXIT_VALIDATION transaction [ consensusTime = 2025-09-21T11:27:08.022868098Z ] | |
| node2 | 2m 12.962s | 2025-09-21 11:27:11.942 | 1313 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.247512Z ] | |
| node2 | 2m 12.963s | 2025-09-21 11:27:11.943 | 1314 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-21T11:27:10.247512Z,type=EXIT_VALIDATION] | |
| node2 | 2m 12.963s | 2025-09-21 11:27:11.943 | 1315 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.316773151Z ] | |
| node2 | 2m 12.963s | 2025-09-21 11:27:11.943 | 1316 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-21T11:27:10.316773151Z,type=EXIT_VALIDATION] | |
| node3 | 2m 13.034s | 2025-09-21 11:27:12.014 | 1313 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.247512Z ] | |
| node3 | 2m 13.034s | 2025-09-21 11:27:12.014 | 1314 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-21T11:27:10.247512Z,type=EXIT_VALIDATION] | |
| node3 | 2m 13.035s | 2025-09-21 11:27:12.015 | 1315 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.316773151Z ] | |
| node3 | 2m 13.035s | 2025-09-21 11:27:12.015 | 1316 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-21T11:27:10.316773151Z,type=EXIT_VALIDATION] | |
| node0 | 2m 13.108s | 2025-09-21 11:27:12.088 | 1313 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.247512Z ] | |
| node0 | 2m 13.109s | 2025-09-21 11:27:12.089 | 1314 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-21T11:27:10.247512Z,type=EXIT_VALIDATION] | |
| node0 | 2m 13.109s | 2025-09-21 11:27:12.089 | 1315 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.316773151Z ] | |
| node0 | 2m 13.109s | 2025-09-21 11:27:12.089 | 1316 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-21T11:27:10.316773151Z,type=EXIT_VALIDATION] | |
| node1 | 2m 13.140s | 2025-09-21 11:27:12.120 | 1313 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.247512Z ] | |
| node1 | 2m 13.140s | 2025-09-21 11:27:12.120 | 1314 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 2 apply state ControlAction[timestamp=2025-09-21T11:27:10.247512Z,type=EXIT_VALIDATION] | |
| node1 | 2m 13.141s | 2025-09-21 11:27:12.121 | 1315 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.316773151Z ] | |
| node1 | 2m 13.141s | 2025-09-21 11:27:12.121 | 1316 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 3 apply state ControlAction[timestamp=2025-09-21T11:27:10.316773151Z,type=EXIT_VALIDATION] | |
| node2 | 2m 13.663s | 2025-09-21 11:27:12.643 | 1321 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.428137972Z ] | |
| node2 | 2m 13.664s | 2025-09-21 11:27:12.644 | 1322 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-21T11:27:10.428137972Z,type=EXIT_VALIDATION] | |
| node2 | 2m 13.664s | 2025-09-21 11:27:12.644 | 1323 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.787312666Z ] | |
| node2 | 2m 13.664s | 2025-09-21 11:27:12.644 | 1324 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-21T11:27:10.787312666Z,type=EXIT_VALIDATION] | |
| node2 | 2m 13.664s | 2025-09-21 11:27:12.644 | 1325 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node2 | 2m 13.665s | 2025-09-21 11:27:12.645 | 1326 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node2 | 2m 13.665s | 2025-09-21 11:27:12.645 | 1327 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node2 | 2m 13.668s | 2025-09-21 11:27:12.648 | 1328 | INFO | DEMO_INFO | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-21T11:27:10.787312666Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node0 | 2m 13.694s | 2025-09-21 11:27:12.674 | 1321 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.428137972Z ] | |
| node0 | 2m 13.694s | 2025-09-21 11:27:12.674 | 1322 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-21T11:27:10.428137972Z,type=EXIT_VALIDATION] | |
| node0 | 2m 13.695s | 2025-09-21 11:27:12.675 | 1323 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.787312666Z ] | |
| node0 | 2m 13.695s | 2025-09-21 11:27:12.675 | 1324 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-21T11:27:10.787312666Z,type=EXIT_VALIDATION] | |
| node0 | 2m 13.695s | 2025-09-21 11:27:12.675 | 1325 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node0 | 2m 13.696s | 2025-09-21 11:27:12.676 | 1326 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node0 | 2m 13.698s | 2025-09-21 11:27:12.678 | 1327 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Sending Freeze Transaction... | |
| node0 | 2m 13.698s | 2025-09-21 11:27:12.678 | 1328 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | TransactionSubmitter: | Finished Sending Freeze Transaction. | |
| node0 | 2m 13.698s | 2025-09-21 11:27:12.678 | 1329 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node0 | 2m 13.701s | 2025-09-21 11:27:12.681 | 1330 | INFO | DEMO_INFO | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-21T11:27:10.787312666Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node1 | 2m 13.758s | 2025-09-21 11:27:12.738 | 1337 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.428137972Z ] | |
| node1 | 2m 13.758s | 2025-09-21 11:27:12.738 | 1338 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-21T11:27:10.428137972Z,type=EXIT_VALIDATION] | |
| node1 | 2m 13.759s | 2025-09-21 11:27:12.739 | 1339 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.787312666Z ] | |
| node1 | 2m 13.759s | 2025-09-21 11:27:12.739 | 1340 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-21T11:27:10.787312666Z,type=EXIT_VALIDATION] | |
| node1 | 2m 13.759s | 2025-09-21 11:27:12.739 | 1341 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node1 | 2m 13.760s | 2025-09-21 11:27:12.740 | 1342 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node1 | 2m 13.760s | 2025-09-21 11:27:12.740 | 1343 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node1 | 2m 13.762s | 2025-09-21 11:27:12.742 | 1344 | INFO | DEMO_INFO | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-21T11:27:10.787312666Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node3 | 2m 13.829s | 2025-09-21 11:27:12.809 | 1337 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.428137972Z ] | |
| node3 | 2m 13.829s | 2025-09-21 11:27:12.809 | 1338 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 0 apply state ControlAction[timestamp=2025-09-21T11:27:10.428137972Z,type=EXIT_VALIDATION] | |
| node3 | 2m 13.830s | 2025-09-21 11:27:12.810 | 1339 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolState: | Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-09-21T11:27:10.787312666Z ] | |
| node3 | 2m 13.830s | 2025-09-21 11:27:12.810 | 1340 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | QuorumTriggeredAction: | Node 1 apply state ControlAction[timestamp=2025-09-21T11:27:10.787312666Z,type=EXIT_VALIDATION] | |
| node3 | 2m 13.830s | 2025-09-21 11:27:12.810 | 1341 | INFO | DEMO_INFO | <<scheduler TransactionHandler>> | PlatformTestingToolMain: | Handling Quorum Transition [ triggeringNodeId = 1, type = EXIT_VALIDATION, consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node3 | 2m 13.831s | 2025-09-21 11:27:12.811 | 1342 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node3 | 2m 13.831s | 2025-09-21 11:27:12.811 | 1343 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node3 | 2m 13.833s | 2025-09-21 11:27:12.813 | 1344 | INFO | DEMO_INFO | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-09-21T11:27:10.787312666Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload] | |
| node2 | 2m 15.811s | 2025-09-21 11:27:14.791 | 1365 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1758454092 | |
| node3 | 2m 15.885s | 2025-09-21 11:27:14.865 | 1365 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1758454092 | |
| node0 | 2m 15.955s | 2025-09-21 11:27:14.935 | 1367 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1758454092 | |
| node1 | 2m 15.963s | 2025-09-21 11:27:14.943 | 1365 | DEBUG | FREEZE | <<scheduler TransactionHandler>> | FreezeTransactionHandler: | Handling FreezeTransaction: startTimeEpochSecond: 1758454092 | |
| node2 | 2m 58.354s | 2025-09-21 11:27:57.334 | 1746 | 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-09-21T11:27:57.330975478Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-21T11:27:57.330975478Z 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 | 2m 58.415s | 2025-09-21 11:27:57.395 | 1747 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith3 2 to 3>> | NetworkUtils: | Connection broken: 2 -> 3 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-21T11:27:57.395335384Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-21T11:27:57.395335384Z 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 | |||||||||
| node0 | 2m 58.426s | 2025-09-21 11:27:57.406 | 1748 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 0 to 2>> | NetworkUtils: | Connection broken: 0 -> 2 | |
| java.io.IOException: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-21T11:27:57.402315598Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-21T11:27:57.402315598Z 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 58.446s | 2025-09-21 11:27:57.426 | 1748 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith1 2 to 1>> | NetworkUtils: | Connection broken: 2 <- 1 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentKeepalive.transition(SentKeepalive.java:44) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node3 | 2m 58.491s | 2025-09-21 11:27:57.471 | 1746 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 3 to 2>> | NetworkUtils: | Connection broken: 3 <- 2 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.SentInitiate.transition(SentInitiate.java:73) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node1 | 2m 58.520s | 2025-09-21 11:27:57.500 | 1746 | WARN | SOCKET_EXCEPTIONS | <<platform-core: SyncProtocolWith2 1 to 2>> | NetworkUtils: | Connection broken: 1 -> 2 | |
| java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:325) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:312) at java.base/java.io.FilterInputStream.read(FilterInputStream.java:71) at org.hiero.base.io.streams.AugmentedDataInputStream.read(AugmentedDataInputStream.java:57) at com.swirlds.platform.network.communication.states.WaitForAcceptReject.transition(WaitForAcceptReject.java:48) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) | |||||||||
| node3 | 2m 58.713s | 2025-09-21 11:27:57.693 | 1747 | 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) | |||||||||
| node3 | 2m 58.742s | 2025-09-21 11:27:57.722 | 1748 | 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-09-21T11:27:57.722048732Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-21T11:27:57.722048732Z 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 | |||||||||
| node0 | 2m 58.783s | 2025-09-21 11:27:57.763 | 1749 | 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) | |||||||||
| node1 | 2m 58.812s | 2025-09-21 11:27:57.792 | 1747 | 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-09-21T11:27:57.792205770Z at com.swirlds.platform.gossip.sync.protocol.SyncPeerProtocol.runProtocol(SyncPeerProtocol.java:246) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:70) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-09-21T11:27:57.792205770Z 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 | 3m 3.107s | 2025-09-21 11:28:02.087 | 1749 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node2 | 3m 3.108s | 2025-09-21 11:28:02.088 | 1750 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node0 | 3m 3.708s | 2025-09-21 11:28:02.688 | 1750 | INFO | PLATFORM_STATUS | <platformForkJoinThread-1> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node0 | 3m 3.710s | 2025-09-21 11:28:02.690 | 1751 | INFO | STARTUP | <platformForkJoinThread-1> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node3 | 3m 3.789s | 2025-09-21 11:28:02.769 | 1749 | INFO | PLATFORM_STATUS | <platformForkJoinThread-8> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node3 | 3m 3.790s | 2025-09-21 11:28:02.770 | 1750 | INFO | STARTUP | <platformForkJoinThread-8> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node1 | 3m 3.893s | 2025-09-21 11:28:02.873 | 1748 | INFO | PLATFORM_STATUS | <platformForkJoinThread-2> | DefaultStatusStateMachine: | Platform spent 2.7 m in ACTIVE. Now in CHECKING | |
| node1 | 3m 3.894s | 2025-09-21 11:28:02.874 | 1749 | INFO | STARTUP | <platformForkJoinThread-2> | PlatformTestingToolMain: | Platform Status Change CHECKING | |
| node2 | 3m 43.668s | 2025-09-21 11:28:42.648 | 1751 | INFO | DEMO_QUORUM | <<PTT: exit-validator 2>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node2 | 3m 43.672s | 2025-09-21 11:28:42.652 | 1752 | 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 43.675s | 2025-09-21 11:28:42.655 | 1753 | INFO | STARTUP | <<PTT: exit-validator 2>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node2 | 3m 43.676s | 2025-09-21 11:28:42.656 | 1754 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node0 | 3m 43.701s | 2025-09-21 11:28:42.681 | 1752 | INFO | DEMO_QUORUM | <<PTT: exit-validator 0>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node0 | 3m 43.705s | 2025-09-21 11:28:42.685 | 1753 | 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 43.707s | 2025-09-21 11:28:42.687 | 1754 | INFO | STARTUP | <<PTT: exit-validator 0>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node0 | 3m 43.709s | 2025-09-21 11:28:42.689 | 1755 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node1 | 3m 43.763s | 2025-09-21 11:28:42.743 | 1750 | INFO | DEMO_QUORUM | <<PTT: exit-validator 1>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node1 | 3m 43.766s | 2025-09-21 11:28:42.746 | 1751 | 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 43.768s | 2025-09-21 11:28:42.748 | 1752 | INFO | STARTUP | <<PTT: exit-validator 1>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node1 | 3m 43.769s | 2025-09-21 11:28:42.749 | 1753 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |
| node3 | 3m 43.834s | 2025-09-21 11:28:42.814 | 1751 | INFO | DEMO_QUORUM | <<PTT: exit-validator 3>> | PlatformTestingToolMain: | Terminating the JVM [ consensusTime = 2025-09-21T11:27:10.787312666Z ] | |
| node3 | 3m 43.836s | 2025-09-21 11:28:42.816 | 1752 | 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 43.838s | 2025-09-21 11:28:42.818 | 1753 | INFO | STARTUP | <<PTT: exit-validator 3>> | SystemExitUtils: | Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload] | |
| node3 | 3m 43.840s | 2025-09-21 11:28:42.820 | 1754 | INFO | STARTUP | <<browser: shutdown-hook>> | Log4jSetup: | JVM is shutting down. | |