Node ID






Columns











Log Level






Log Marker












Class













































node1 0.000ns 2025-11-19 07:23:50.660 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 94.000ms 2025-11-19 07:23:50.754 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node1 111.000ms 2025-11-19 07:23:50.771 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 112.000ms 2025-11-19 07:23:50.772 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 232.000ms 2025-11-19 07:23:50.892 5 INFO STARTUP <main> Browser: The following nodes [1] are set to run locally
node2 255.000ms 2025-11-19 07:23:50.915 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node1 264.000ms 2025-11-19 07:23:50.924 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node3 309.000ms 2025-11-19 07:23:50.969 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node2 353.000ms 2025-11-19 07:23:51.013 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node2 370.000ms 2025-11-19 07:23:51.030 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 371.000ms 2025-11-19 07:23:51.031 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 406.000ms 2025-11-19 07:23:51.066 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node3 423.000ms 2025-11-19 07:23:51.083 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 424.000ms 2025-11-19 07:23:51.084 4 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node2 487.000ms 2025-11-19 07:23:51.147 5 INFO STARTUP <main> Browser: The following nodes [2] are set to run locally
node2 517.000ms 2025-11-19 07:23:51.177 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node3 544.000ms 2025-11-19 07:23:51.204 5 INFO STARTUP <main> Browser: The following nodes [3] are set to run locally
node3 575.000ms 2025-11-19 07:23:51.235 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node1 677.000ms 2025-11-19 07:23:51.337 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 678.000ms 2025-11-19 07:23:51.338 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 679.000ms 2025-11-19 07:23:51.339 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 679.000ms 2025-11-19 07:23:51.339 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 680.000ms 2025-11-19 07:23:51.340 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 680.000ms 2025-11-19 07:23:51.340 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 680.000ms 2025-11-19 07:23:51.340 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 681.000ms 2025-11-19 07:23:51.341 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 682.000ms 2025-11-19 07:23:51.342 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 682.000ms 2025-11-19 07:23:51.342 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 682.000ms 2025-11-19 07:23:51.342 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 683.000ms 2025-11-19 07:23:51.343 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 683.000ms 2025-11-19 07:23:51.343 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 684.000ms 2025-11-19 07:23:51.344 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 684.000ms 2025-11-19 07:23:51.344 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node1 738.000ms 2025-11-19 07:23:51.398 24 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node2 947.000ms 2025-11-19 07:23:51.607 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 948.000ms 2025-11-19 07:23:51.608 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 949.000ms 2025-11-19 07:23:51.609 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 949.000ms 2025-11-19 07:23:51.609 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 950.000ms 2025-11-19 07:23:51.610 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 950.000ms 2025-11-19 07:23:51.610 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 950.000ms 2025-11-19 07:23:51.610 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 952.000ms 2025-11-19 07:23:51.612 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 952.000ms 2025-11-19 07:23:51.612 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 952.000ms 2025-11-19 07:23:51.612 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 953.000ms 2025-11-19 07:23:51.613 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 953.000ms 2025-11-19 07:23:51.613 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 953.000ms 2025-11-19 07:23:51.613 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 954.000ms 2025-11-19 07:23:51.614 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node2 955.000ms 2025-11-19 07:23:51.615 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node2 1.007s 2025-11-19 07:23:51.667 24 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node3 1.021s 2025-11-19 07:23:51.681 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.023s 2025-11-19 07:23:51.683 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.023s 2025-11-19 07:23:51.683 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.024s 2025-11-19 07:23:51.684 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.024s 2025-11-19 07:23:51.684 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.024s 2025-11-19 07:23:51.684 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.025s 2025-11-19 07:23:51.685 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.026s 2025-11-19 07:23:51.686 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 1.026s 2025-11-19 07:23:51.686 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 1.026s 2025-11-19 07:23:51.686 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 1.027s 2025-11-19 07:23:51.687 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 1.027s 2025-11-19 07:23:51.687 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 1.028s 2025-11-19 07:23:51.688 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 1.028s 2025-11-19 07:23:51.688 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 1.029s 2025-11-19 07:23:51.689 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node3 1.083s 2025-11-19 07:23:51.743 24 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node0 1.179s 2025-11-19 07:23:51.839 1 INFO STARTUP <main> StaticPlatformBuilder:
////////////////////// // Node is Starting // //////////////////////
node0 1.274s 2025-11-19 07:23:51.934 2 DEBUG STARTUP <main> StaticPlatformBuilder: main() started {} [com.swirlds.logging.legacy.payload.NodeStartPayload]
node0 1.291s 2025-11-19 07:23:51.951 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 1.292s 2025-11-19 07:23:51.952 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 1.412s 2025-11-19 07:23:52.072 5 INFO STARTUP <main> Browser: The following nodes [0] are set to run locally
node0 1.441s 2025-11-19 07:23:52.101 6 INFO STARTUP <main> PlatformTestingToolMain: Registering PlatformTestingToolState with ConstructableRegistry
node1 1.640s 2025-11-19 07:23:52.300 25 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 900ms
node1 1.650s 2025-11-19 07:23:52.310 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.650s 2025-11-19 07:23:52.310 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.690s 2025-11-19 07:23:52.350 28 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node1 1.758s 2025-11-19 07:23:52.418 29 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node1 1.758s 2025-11-19 07:23:52.418 30 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node0 1.876s 2025-11-19 07:23:52.536 7 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 1.877s 2025-11-19 07:23:52.537 8 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 1.878s 2025-11-19 07:23:52.538 9 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 1.878s 2025-11-19 07:23:52.538 10 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 1.879s 2025-11-19 07:23:52.539 11 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 1.879s 2025-11-19 07:23:52.539 12 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 1.879s 2025-11-19 07:23:52.539 13 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 1.880s 2025-11-19 07:23:52.540 14 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 1.881s 2025-11-19 07:23:52.541 15 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 1.881s 2025-11-19 07:23:52.541 16 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 1.881s 2025-11-19 07:23:52.541 17 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 1.882s 2025-11-19 07:23:52.542 18 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 1.882s 2025-11-19 07:23:52.542 19 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 1.883s 2025-11-19 07:23:52.543 20 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 1.883s 2025-11-19 07:23:52.543 21 INFO STARTUP <main> PlatformTestingToolMain: PlatformTestingToolState is registered with ConstructableRegistry: -4571139351850460298
node0 1.937s 2025-11-19 07:23:52.597 24 DEBUG STARTUP <main> BootstrapUtils: Scanning the classpath for RuntimeConstructable classes
node2 2.042s 2025-11-19 07:23:52.702 25 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1035ms
node2 2.054s 2025-11-19 07:23:52.714 26 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node2 2.055s 2025-11-19 07:23:52.715 27 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node2 2.097s 2025-11-19 07:23:52.757 28 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node3 2.139s 2025-11-19 07:23:52.799 25 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1054ms
node3 2.149s 2025-11-19 07:23:52.809 26 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node3 2.149s 2025-11-19 07:23:52.809 27 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'state.roundsExpired' was renamed to 'consensus.roundsExpired'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node2 2.162s 2025-11-19 07:23:52.822 29 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node2 2.163s 2025-11-19 07:23:52.823 30 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node3 2.212s 2025-11-19 07:23:52.872 28 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node3 2.282s 2025-11-19 07:23:52.942 29 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node3 2.282s 2025-11-19 07:23:52.942 30 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node1 2.580s 2025-11-19 07:23:53.240 31 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node1 2.666s 2025-11-19 07:23:53.326 34 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node1 2.667s 2025-11-19 07:23:53.327 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node1 2.667s 2025-11-19 07:23:53.327 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node1 2.667s 2025-11-19 07:23:53.327 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node1 2.668s 2025-11-19 07:23:53.328 38 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node1 2.668s 2025-11-19 07:23:53.328 39 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node1 2.668s 2025-11-19 07:23:53.328 40 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node1 2.668s 2025-11-19 07:23:53.328 41 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node0 2.971s 2025-11-19 07:23:53.631 25 DEBUG STARTUP <main> BootstrapUtils: Done with registerConstructables, time taken 1033ms
node0 2.982s 2025-11-19 07:23:53.642 26 WARN STARTUP <main> PlatformConfigUtils: Configuration property 'reconnect.asyncOutputStreamFlushMilliseconds' was renamed to 'reconnect.asyncOutputStreamFlush'. This build is currently backwards compatible with the old name, but this may not be true in a future release, so it is important to switch to the new name.
node0 2.982s 2025-11-19 07:23:53.642 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.020s 2025-11-19 07:23:53.680 31 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node0 3.026s 2025-11-19 07:23:53.686 28 INFO STARTUP <main> PrometheusEndpoint: PrometheusEndpoint: Starting server listing on port: 9999
node0 3.095s 2025-11-19 07:23:53.755 29 WARN STARTUP <main> CryptoStatic: There are no keys on disk, Adhoc keys will be generated, but this is incompatible with DAB.
node0 3.096s 2025-11-19 07:23:53.756 30 DEBUG STARTUP <main> CryptoStatic: Started generating keys
node2 3.103s 2025-11-19 07:23:53.763 34 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node2 3.104s 2025-11-19 07:23:53.764 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node2 3.105s 2025-11-19 07:23:53.765 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node2 3.105s 2025-11-19 07:23:53.765 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node2 3.105s 2025-11-19 07:23:53.765 38 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node2 3.106s 2025-11-19 07:23:53.766 39 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node2 3.106s 2025-11-19 07:23:53.766 40 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node2 3.106s 2025-11-19 07:23:53.766 41 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 3.144s 2025-11-19 07:23:53.804 31 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node3 3.230s 2025-11-19 07:23:53.890 34 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node3 3.231s 2025-11-19 07:23:53.891 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node3 3.231s 2025-11-19 07:23:53.891 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node3 3.232s 2025-11-19 07:23:53.892 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node3 3.232s 2025-11-19 07:23:53.892 38 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node3 3.232s 2025-11-19 07:23:53.892 39 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node3 3.233s 2025-11-19 07:23:53.893 40 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node3 3.233s 2025-11-19 07:23:53.893 41 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node1 3.488s 2025-11-19 07:23:54.148 50 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node1 3.494s 2025-11-19 07:23:54.154 51 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 3.934s 2025-11-19 07:23:54.594 50 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node0 3.935s 2025-11-19 07:23:54.595 31 DEBUG STARTUP <main> CryptoStatic: Done generating keys
node2 3.941s 2025-11-19 07:23:54.601 51 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node0 4.024s 2025-11-19 07:23:54.684 34 INFO STARTUP <main> StartupStateUtils: No saved states were found on disk.
node0 4.025s 2025-11-19 07:23:54.685 35 INFO DEMO_INFO <main> ExpectedFCMFamily: Set ExpectedMap initial capacity to be: 4000
node0 4.025s 2025-11-19 07:23:54.685 36 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountList initial capacity to be: 1000
node0 4.026s 2025-11-19 07:23:54.686 37 INFO DEMO_INFO <main> ExpectedFCMFamily: Set accountSelfEntitiesList initial capacity to be: 1000
node0 4.026s 2025-11-19 07:23:54.686 38 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqList initial capacity to be: 1000
node0 4.026s 2025-11-19 07:23:54.686 39 INFO DEMO_INFO <main> ExpectedFCMFamily: Set fcqSelfEntitiesList initial capacity to be: 1000
node0 4.026s 2025-11-19 07:23:54.686 40 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountList initial capacity to be: 1000
node0 4.027s 2025-11-19 07:23:54.687 41 INFO DEMO_INFO <main> ExpectedFCMFamily: Set virtual-merkle-accountSelfEntitiesList initial capacity to be: 1000
node3 4.115s 2025-11-19 07:23:54.775 50 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node3 4.122s 2025-11-19 07:23:54.782 51 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node1 4.626s 2025-11-19 07:23:55.286 52 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26159662] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=213150, randomLong=3082874955841602008, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=11889, randomLong=5955685861741808558, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1263350, data=35, exception=null] OS Health Check Report - Complete (took 1022 ms)
node1 4.657s 2025-11-19 07:23:55.317 53 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node1 4.664s 2025-11-19 07:23:55.324 54 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node1 4.666s 2025-11-19 07:23:55.326 55 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node1 4.745s 2025-11-19 07:23:55.405 56 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIdUmpLKzyXgUwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMTAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBALXCoDQ+HOVsEDTZpFuJITSaGwaKX2is5K1P/lV+G+ll6u36IdqKNnZIirJrpX2N0Ad6NeF/oFcMhietrKt818PDA9Tbb2tqcHNKTxxZAEj7amQTsrU4EsNmUhaPgMs89yj9WLxCXVzW05cQjqYEA/hymzohWs1BdU3Y2KdmELe0v5fzRgDpNgYHhUN7IrlrlgXEWpuKRskBYc4PIvyACijY0/zkeEAyHOshYYGKhQbNm/NGWhFq83ro77CZZhX3Vl7hRnHLaEoCEE8atY8R1Txhy8aObhiS6R8ZVRTkZLar/FG/xe78RQfwHHD1al2w5oHR7xgTZylhbD+nVQ09Zmi25USpvqwumbMBE0OWhV+VH1WLCHfLQs6/5yuDjeZ/0D9tpQ8pfkiEkGLedzUzQkq+4/HmN4IFTOhgJHlu1tVUqohZIPZ5zSzqkqFzFQGRo2uAX8C2EJ3qgQMAEOpH8iOjiSKsezlIPuwvmrVDPxVfpY2Cq60oxRu6B8bZdbQkfwIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQAloxwiVu7pBhkO4fLqYRw4FC0VEx+c47W4xnrq3G/uXMGwE2Mfwple9FZnfT9JgSoT1UVw+cigo4720WdrPqkK8qnA3/PzGXlfJ3k6eFcBuli/KY1TakIJUAxFt5biNKatheMwAKsbF/JyVyaqG2dbSaXQ6hZBLQTYmLrmFWMvi9QdM1S8vNVMjn0hE2qQJtnVRuVwqRaAQ225jDv2CUCT28t0EWE6ccbiRi74l8KoW1Lo3v2EQ6ZZ89Xt3CwFSQHa6YVT685ECy82qMysU+YHBe9WmwJW05UAAY7JRsOo+RuuU/r4acNLmzprG+l7qsqqPkwXTcziw9Y2OYsFgY4bTlIOV0JC0AYApctDB3gbn83LM73CWccGrXq0liSV0wL11wscH3gFohXrwb646+6hgncZiDshlZlWaFSkHQJAxTR9bsbsCwKdZpzIIVOVTOT/3oLQKCCQvPriTpJiNa0P6gB0pq64lNcyG9fL8vS3YFFnWJTZwb8ZzGK+LZ91/2Y=", "gossipEndpoint": [{ "ipAddressV4": "Ij3b7Q==", "port": 30124 }, { "ipAddressV4": "CoAACw==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJguXwyGFpb8MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTIwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTIwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDYXoYHBtw8adD5sxLZSnlG9XgBLWVbIDl3YA4rZZ11cgl6FG2TvF8UVNXQ177cRm1xUUJRI5ulSgDofnm7Iuf6c/GoQrud2nP1yMWewGslwiEi1h2pxbN7doFvn/92Y0lJVwSV/vOpbIyPRoMeF0jXd7TEI7dYj4S7gV9uWmQCIWjwTZqVsjIAtzEkYnmS0/m5XuD9MJsin8OQRu/PEFL8qaVPQJ2GhOhpUJqvADQ/Lsq/FHcPjylcRcnUQlFRojk2jqugtoRegByjPrAOSYGJeWUCVYmd7W51L/AkVx1rDLeHj0zLTTzQRF5G56i+S+tAcpY/uiCrwLvszFlDlD1diOuaucmu54lalrSTlVe5eOyq2ga2tKi11LQ+w09105zLyRWk7DBU93f5dTYNSmokI7b4sVRxu6SP0p/F9wND77wv2Ax5OpIWWty8zy8Y+xOuRyFu/rJ4ddDmRYvRmptM0rCAfv6hgd3m5Y/OAadQm/OuN91Uq9PIJdlMtjDbIfECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEANutmL3V1PlvlsZ6xG8Sx9cKTok3kf3rBf7D7eE8Nn8ryHi3cw9CvCaj1E6zmTTh9k23DAZVWulhjTY5GWcx5NO7QAWjKau44g/HecNNrWsD/+nIrhmAk2WxKp175CwqJaIWA7CM6VMfFktjaflUPcB6RJnHrAa8M1HUpEsBz0mFmLz7lIaDemxYCE8M8slb6wTMjpL83GB+ejudRe7YK2ZWixM+CGp0ARkV+EecHaCXgEoROUNwP6mZVJcgSVR1QBQwcGAMIrutsKENM8HR9o3LWacigoJXf+IX8c6aJhrHfFvm62q+hi3baj7iR6gebEdWPtmEXgoVWOk230fLGyPU1oBxaDdYa8V4+ZFv03O91By9tuFrwZOcLCb4CPRyr8A47lHNjRIeo2nUF/c+SjV0eBcPKCnn1nW/AQWCxJ0QzzG6tEeMAGdDrE2ujPlB+Y9Sn8vB0zjYQHTr1NKyyXNogB4y48jofLDLDGOQYI6uP2fDgZeiq4dV8w91WbPHV", "gossipEndpoint": [{ "ipAddressV4": "IjtL0A==", "port": 30125 }, { "ipAddressV4": "CoAADA==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJwswl59m488MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDAqlNMpfduuW0ETQVjdKf5ZBe3Ug/ybRMoCWIlue8UoxFzamAtoeFEW3GVi862iImRVyHbkBZzDQUw4ABwMdxfzTL9voozkMaOZb4KQ9yZ9zNLAAmSSuE6RFmSJnBtfufxFXqiu6esbcvyropjZLc65F2uoMCpKN0CHFpWEb2GZAaipp7WCOon0NllDLqkjPylluXO4mjbzzMSDPbBWRD8VjjkxZeszWSXYxz9hqcRYX01CGg+jhooCQ6j2yB8sfFAffIeTG6GSV1uCFa4san2emhQWpr+cHaVYJMtejL43HaEVQnF3vh5Z10T/7co63C63aay2hs6Bx5SschosyYiafI7GtbQ4qpOgjEDFT1jlydK21gy6MV3SFEYwcUfxvxxRj6pS7xiMFn4FYnBKPJWkaDkwTqboEshxstvASQOW993uEwzh4EjctRHSjSuTU6S9OsWi5I5cRF+xK6GaWsTp0KyO8uVpuM9kZfpOcor294quyKJ9nylNyIt/m8Q8/ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAqPLB/xr0Yv1l9w/RO+bqFtl8TkxF/6jOqoEUXY06dEInopLYpmkksZZ9G8vebt6hAoLjaxNMdRqCkzKgy4jn7/SQZNV9FMbZ7ckiDxsBxYZ2ZaBootuWzzVD6hCSO3Tg6JgkIzldtFtNcDVBRgZnHg+Rl6hn+gFV5S2OTTTPHWK7GHwgHXLhK7N0RL4YVrRCi/HTUZnuYCjBwvdDte5iqytY05cAO4p72P6YtDaOdAfL/IIKd1ylCWITDqTp/JDBz1uxjQmsXLVD/KEEtlvYlGjIr+wUUqIUPhFvB6ajl2NO0D/r+t1BH454zbodU92QnOJpXpoNuOv7jjALHCqo70mCSwTNUSZuVP6/KLmQe8sSzYs7O/c25FzHKBYy+aZujoa/X7aI6XVmsUkj6ae9MSvQurk0jMNg/Jy5EtWOMy7WEuyadrAv6KSP3oIfmL9jWoPcyOMfvjRHxGqOfZuFZatAwswY6O0E3ATTrN03t/BVqNHIYIXc6UOiUTo2Nx56", "gossipEndpoint": [{ "ipAddressV4": "I+/v/w==", "port": 30126 }, { "ipAddressV4": "CoAABg==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAOxH0o7YkAUoMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDf6+SJl+puqRNd5r2Tb802jQTqPm7k3NXIeU8NQ3Hy9p0G+9p4Hgnt3ftipar7lKPKnp4PFrOP7E7XSKpafxK2OVQ0jTMvc6Yjqt+9mzyNSI1I8cSHTmhJ7kMBt0+NwVM8QN+fbKcbQaoNiPwMcckVtGeMad4aZM6hRyxzI0H3wgMj4JiM9VRwx7JbEo3R7akRwLwGr9ZQm2EQwqiyReNkBnXrsyP4KPPVAoeMfGchoAuBbV+r6v1OeYddocYmZkrsvMXUKF/uEcgd8gTu+pv3jObwIEVqXo1yC6ZlCFqO7LIvT8jTAAljkszoo67ykXTbKS0PZeLDg6nvdPvBMQ50yjfswR88S6N8VU6pud7Y+VbMYUiGzlrFi4MB9dikAjEj4PEetQyZdn84ZXGxerXlU/vTO2Fp4i1ec5rmX1P0WYMlbNELE408j5nfCfzD/qdcF5HZAiUVTYU/SWpzWcn34++KGpuqZZQdsGwCLQWeMeA/OEemYChis4cO94aOzrECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAlj5YIsbYXk2JGP9kRCBLDgz27ymYi1KDbO8g18V4T0zj2Zl7858U7mF9UBSSW+Cjl1UtUdvqFWZhh8jRoO3Jov1QGTULHRfyyPElD4VpwFribiu4GYJaodYy6NE50WwSJf32gLG0jHQWt7q+cOrn6WaG2h8O1sIxbTlnu1kqKQUQtu4oX8u23b5m9QXVJfJVdecwD5Rmab2d3dq/NNv2iNELH0myqtcoqw26xwIvXwaS4Gqi+Y0cOfjWL5Gv5AHIwvBXGIh3KUU7pbyBzqjkigbzSeoZw0C8G2cRTl0+QTuet2SVYlFh5J9/FBLvIfMfIpguglaU6xTVoRpo7RF24qQKFt2IlBROpqcwl0FyfE+2c19FGt1V8E5dYqE4T2mHT6FSOI3DckA2afBm1OCeMNtkqCQT8x+JvdKrgUh44QDm4PIVZDzaxog/zOzRWPCgpCPq0HcNMzgCVFt+4q8eTL9Ju/rQcS9bDosjMA69NGLIOCdPW2i/gkS9x9rTXgyp", "gossipEndpoint": [{ "ipAddressV4": "IjrhRA==", "port": 30127 }, { "ipAddressV4": "CoAACA==", "port": 30127 }] }] }
node1 4.852s 2025-11-19 07:23:55.512 57 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node1 4.853s 2025-11-19 07:23:55.513 58 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node1 4.868s 2025-11-19 07:23:55.528 59 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: d67377adf26f12b0b042a128fad44ae62272b93a83cc596ae9e18825bf069691d8ecf9a6e831f01ae5a525a73be9dba0 (root) PlatformTestingToolState / coyote-volcano-rate-figure 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 SingletonNode RosterService.ROSTER_STATE /1 win-shrimp-key-daughter 2 VirtualMap RosterService.ROSTERS /2 easy-improve-raven-vacant 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 4.871s 2025-11-19 07:23:55.531 61 INFO RECONNECT <<platform-core: reconnectController>> ReconnectController: Starting the ReconnectController
node0 4.888s 2025-11-19 07:23:55.548 50 INFO STARTUP <main> BootstrapUtils: Not upgrading software, current software is version SemanticVersion[major=1, minor=0, patch=0, pre=, build=].
node0 4.894s 2025-11-19 07:23:55.554 51 INFO STARTUP <main> AddressBookInitializer: Starting from genesis: using the config address book.
node2 5.058s 2025-11-19 07:23:55.718 52 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26189846] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=259190, randomLong=7120976998679321546, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=12960, randomLong=2773284570478436666, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1605880, data=35, exception=null] OS Health Check Report - Complete (took 1024 ms)
node1 5.090s 2025-11-19 07:23:55.750 62 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node2 5.090s 2025-11-19 07:23:55.750 53 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node1 5.095s 2025-11-19 07:23:55.755 63 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node2 5.098s 2025-11-19 07:23:55.758 54 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node2 5.100s 2025-11-19 07:23:55.760 55 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node1 5.105s 2025-11-19 07:23:55.765 64 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xms32g
node1 5.106s 2025-11-19 07:23:55.766 65 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xmx118g
node1 5.107s 2025-11-19 07:23:55.767 66 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node1 5.107s 2025-11-19 07:23:55.767 67 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node1 5.109s 2025-11-19 07:23:55.769 68 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node1 5.109s 2025-11-19 07:23:55.769 69 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node1 5.109s 2025-11-19 07:23:55.769 70 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node1 5.110s 2025-11-19 07:23:55.770 71 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node1 5.110s 2025-11-19 07:23:55.770 72 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node1 5.111s 2025-11-19 07:23:55.771 73 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node1 5.111s 2025-11-19 07:23:55.771 74 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node1 5.111s 2025-11-19 07:23:55.771 75 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node1 5.112s 2025-11-19 07:23:55.772 76 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node1 5.112s 2025-11-19 07:23:55.772 77 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node1 5.113s 2025-11-19 07:23:55.773 78 INFO STARTUP <<start-node-1>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node1 5.133s 2025-11-19 07:23:55.793 79 INFO DEMO_INFO <<start-node-1>> PayloadConfig: insertSeq = true
node1 5.133s 2025-11-19 07:23:55.793 80 INFO DEMO_INFO <<start-node-1>> PayloadConfig: appendSig = true
node1 5.134s 2025-11-19 07:23:55.794 81 INFO DEMO_INFO <<start-node-1>> PayloadConfig: variedSize = false
node1 5.134s 2025-11-19 07:23:55.794 82 INFO DEMO_INFO <<start-node-1>> PayloadConfig: payloadByteSize = 100
node1 5.134s 2025-11-19 07:23:55.794 83 INFO DEMO_INFO <<start-node-1>> PayloadConfig: maxByteSize = 100
node1 5.135s 2025-11-19 07:23:55.795 84 INFO DEMO_INFO <<start-node-1>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node1 5.135s 2025-11-19 07:23:55.795 85 INFO DEMO_INFO <<start-node-1>> PayloadConfig: invalidSigRatio = 0.0
node1 5.137s 2025-11-19 07:23:55.797 86 INFO DEMO_INFO <<start-node-1>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node1 5.138s 2025-11-19 07:23:55.798 87 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@7fbb625a
node1 5.139s 2025-11-19 07:23:55.799 88 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total accounts = 2400
node1 5.140s 2025-11-19 07:23:55.800 89 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node1 5.147s 2025-11-19 07:23:55.807 94 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@7506d161, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@3d928cf5,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@589261ee,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@79747223,snapshotInProgress=false]
node1 5.156s 2025-11-19 07:23:55.816 95 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: max KV pairs = 0
node1 5.156s 2025-11-19 07:23:55.816 96 INFO DEMO_INFO <<start-node-1>> VirtualMerkleStateInitializer: total SC = 0
node1 5.162s 2025-11-19 07:23:55.822 97 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: Random seed for FCMTransactionPool is 5023811500882161881
node1 5.163s 2025-11-19 07:23:55.823 98 INFO DEMO_INFO <<start-node-1>> FCMTransactionPool: This test will generate sequential FCM payload:
node2 5.181s 2025-11-19 07:23:55.841 56 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIdUmpLKzyXgUwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMTAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBALXCoDQ+HOVsEDTZpFuJITSaGwaKX2is5K1P/lV+G+ll6u36IdqKNnZIirJrpX2N0Ad6NeF/oFcMhietrKt818PDA9Tbb2tqcHNKTxxZAEj7amQTsrU4EsNmUhaPgMs89yj9WLxCXVzW05cQjqYEA/hymzohWs1BdU3Y2KdmELe0v5fzRgDpNgYHhUN7IrlrlgXEWpuKRskBYc4PIvyACijY0/zkeEAyHOshYYGKhQbNm/NGWhFq83ro77CZZhX3Vl7hRnHLaEoCEE8atY8R1Txhy8aObhiS6R8ZVRTkZLar/FG/xe78RQfwHHD1al2w5oHR7xgTZylhbD+nVQ09Zmi25USpvqwumbMBE0OWhV+VH1WLCHfLQs6/5yuDjeZ/0D9tpQ8pfkiEkGLedzUzQkq+4/HmN4IFTOhgJHlu1tVUqohZIPZ5zSzqkqFzFQGRo2uAX8C2EJ3qgQMAEOpH8iOjiSKsezlIPuwvmrVDPxVfpY2Cq60oxRu6B8bZdbQkfwIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQAloxwiVu7pBhkO4fLqYRw4FC0VEx+c47W4xnrq3G/uXMGwE2Mfwple9FZnfT9JgSoT1UVw+cigo4720WdrPqkK8qnA3/PzGXlfJ3k6eFcBuli/KY1TakIJUAxFt5biNKatheMwAKsbF/JyVyaqG2dbSaXQ6hZBLQTYmLrmFWMvi9QdM1S8vNVMjn0hE2qQJtnVRuVwqRaAQ225jDv2CUCT28t0EWE6ccbiRi74l8KoW1Lo3v2EQ6ZZ89Xt3CwFSQHa6YVT685ECy82qMysU+YHBe9WmwJW05UAAY7JRsOo+RuuU/r4acNLmzprG+l7qsqqPkwXTcziw9Y2OYsFgY4bTlIOV0JC0AYApctDB3gbn83LM73CWccGrXq0liSV0wL11wscH3gFohXrwb646+6hgncZiDshlZlWaFSkHQJAxTR9bsbsCwKdZpzIIVOVTOT/3oLQKCCQvPriTpJiNa0P6gB0pq64lNcyG9fL8vS3YFFnWJTZwb8ZzGK+LZ91/2Y=", "gossipEndpoint": [{ "ipAddressV4": "Ij3b7Q==", "port": 30124 }, { "ipAddressV4": "CoAACw==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJguXwyGFpb8MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTIwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTIwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDYXoYHBtw8adD5sxLZSnlG9XgBLWVbIDl3YA4rZZ11cgl6FG2TvF8UVNXQ177cRm1xUUJRI5ulSgDofnm7Iuf6c/GoQrud2nP1yMWewGslwiEi1h2pxbN7doFvn/92Y0lJVwSV/vOpbIyPRoMeF0jXd7TEI7dYj4S7gV9uWmQCIWjwTZqVsjIAtzEkYnmS0/m5XuD9MJsin8OQRu/PEFL8qaVPQJ2GhOhpUJqvADQ/Lsq/FHcPjylcRcnUQlFRojk2jqugtoRegByjPrAOSYGJeWUCVYmd7W51L/AkVx1rDLeHj0zLTTzQRF5G56i+S+tAcpY/uiCrwLvszFlDlD1diOuaucmu54lalrSTlVe5eOyq2ga2tKi11LQ+w09105zLyRWk7DBU93f5dTYNSmokI7b4sVRxu6SP0p/F9wND77wv2Ax5OpIWWty8zy8Y+xOuRyFu/rJ4ddDmRYvRmptM0rCAfv6hgd3m5Y/OAadQm/OuN91Uq9PIJdlMtjDbIfECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEANutmL3V1PlvlsZ6xG8Sx9cKTok3kf3rBf7D7eE8Nn8ryHi3cw9CvCaj1E6zmTTh9k23DAZVWulhjTY5GWcx5NO7QAWjKau44g/HecNNrWsD/+nIrhmAk2WxKp175CwqJaIWA7CM6VMfFktjaflUPcB6RJnHrAa8M1HUpEsBz0mFmLz7lIaDemxYCE8M8slb6wTMjpL83GB+ejudRe7YK2ZWixM+CGp0ARkV+EecHaCXgEoROUNwP6mZVJcgSVR1QBQwcGAMIrutsKENM8HR9o3LWacigoJXf+IX8c6aJhrHfFvm62q+hi3baj7iR6gebEdWPtmEXgoVWOk230fLGyPU1oBxaDdYa8V4+ZFv03O91By9tuFrwZOcLCb4CPRyr8A47lHNjRIeo2nUF/c+SjV0eBcPKCnn1nW/AQWCxJ0QzzG6tEeMAGdDrE2ujPlB+Y9Sn8vB0zjYQHTr1NKyyXNogB4y48jofLDLDGOQYI6uP2fDgZeiq4dV8w91WbPHV", "gossipEndpoint": [{ "ipAddressV4": "IjtL0A==", "port": 30125 }, { "ipAddressV4": "CoAADA==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJwswl59m488MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDAqlNMpfduuW0ETQVjdKf5ZBe3Ug/ybRMoCWIlue8UoxFzamAtoeFEW3GVi862iImRVyHbkBZzDQUw4ABwMdxfzTL9voozkMaOZb4KQ9yZ9zNLAAmSSuE6RFmSJnBtfufxFXqiu6esbcvyropjZLc65F2uoMCpKN0CHFpWEb2GZAaipp7WCOon0NllDLqkjPylluXO4mjbzzMSDPbBWRD8VjjkxZeszWSXYxz9hqcRYX01CGg+jhooCQ6j2yB8sfFAffIeTG6GSV1uCFa4san2emhQWpr+cHaVYJMtejL43HaEVQnF3vh5Z10T/7co63C63aay2hs6Bx5SschosyYiafI7GtbQ4qpOgjEDFT1jlydK21gy6MV3SFEYwcUfxvxxRj6pS7xiMFn4FYnBKPJWkaDkwTqboEshxstvASQOW993uEwzh4EjctRHSjSuTU6S9OsWi5I5cRF+xK6GaWsTp0KyO8uVpuM9kZfpOcor294quyKJ9nylNyIt/m8Q8/ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAqPLB/xr0Yv1l9w/RO+bqFtl8TkxF/6jOqoEUXY06dEInopLYpmkksZZ9G8vebt6hAoLjaxNMdRqCkzKgy4jn7/SQZNV9FMbZ7ckiDxsBxYZ2ZaBootuWzzVD6hCSO3Tg6JgkIzldtFtNcDVBRgZnHg+Rl6hn+gFV5S2OTTTPHWK7GHwgHXLhK7N0RL4YVrRCi/HTUZnuYCjBwvdDte5iqytY05cAO4p72P6YtDaOdAfL/IIKd1ylCWITDqTp/JDBz1uxjQmsXLVD/KEEtlvYlGjIr+wUUqIUPhFvB6ajl2NO0D/r+t1BH454zbodU92QnOJpXpoNuOv7jjALHCqo70mCSwTNUSZuVP6/KLmQe8sSzYs7O/c25FzHKBYy+aZujoa/X7aI6XVmsUkj6ae9MSvQurk0jMNg/Jy5EtWOMy7WEuyadrAv6KSP3oIfmL9jWoPcyOMfvjRHxGqOfZuFZatAwswY6O0E3ATTrN03t/BVqNHIYIXc6UOiUTo2Nx56", "gossipEndpoint": [{ "ipAddressV4": "I+/v/w==", "port": 30126 }, { "ipAddressV4": "CoAABg==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAOxH0o7YkAUoMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDf6+SJl+puqRNd5r2Tb802jQTqPm7k3NXIeU8NQ3Hy9p0G+9p4Hgnt3ftipar7lKPKnp4PFrOP7E7XSKpafxK2OVQ0jTMvc6Yjqt+9mzyNSI1I8cSHTmhJ7kMBt0+NwVM8QN+fbKcbQaoNiPwMcckVtGeMad4aZM6hRyxzI0H3wgMj4JiM9VRwx7JbEo3R7akRwLwGr9ZQm2EQwqiyReNkBnXrsyP4KPPVAoeMfGchoAuBbV+r6v1OeYddocYmZkrsvMXUKF/uEcgd8gTu+pv3jObwIEVqXo1yC6ZlCFqO7LIvT8jTAAljkszoo67ykXTbKS0PZeLDg6nvdPvBMQ50yjfswR88S6N8VU6pud7Y+VbMYUiGzlrFi4MB9dikAjEj4PEetQyZdn84ZXGxerXlU/vTO2Fp4i1ec5rmX1P0WYMlbNELE408j5nfCfzD/qdcF5HZAiUVTYU/SWpzWcn34++KGpuqZZQdsGwCLQWeMeA/OEemYChis4cO94aOzrECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAlj5YIsbYXk2JGP9kRCBLDgz27ymYi1KDbO8g18V4T0zj2Zl7858U7mF9UBSSW+Cjl1UtUdvqFWZhh8jRoO3Jov1QGTULHRfyyPElD4VpwFribiu4GYJaodYy6NE50WwSJf32gLG0jHQWt7q+cOrn6WaG2h8O1sIxbTlnu1kqKQUQtu4oX8u23b5m9QXVJfJVdecwD5Rmab2d3dq/NNv2iNELH0myqtcoqw26xwIvXwaS4Gqi+Y0cOfjWL5Gv5AHIwvBXGIh3KUU7pbyBzqjkigbzSeoZw0C8G2cRTl0+QTuet2SVYlFh5J9/FBLvIfMfIpguglaU6xTVoRpo7RF24qQKFt2IlBROpqcwl0FyfE+2c19FGt1V8E5dYqE4T2mHT6FSOI3DckA2afBm1OCeMNtkqCQT8x+JvdKrgUh44QDm4PIVZDzaxog/zOzRWPCgpCPq0HcNMzgCVFt+4q8eTL9Ju/rQcS9bDosjMA69NGLIOCdPW2i/gkS9x9rTXgyp", "gossipEndpoint": [{ "ipAddressV4": "IjrhRA==", "port": 30127 }, { "ipAddressV4": "CoAACA==", "port": 30127 }] }] }
node1 5.256s 2025-11-19 07:23:55.916 99 INFO STARTUP <<start-node-1>> SwirldsPlatform: Starting platform 1
node1 5.259s 2025-11-19 07:23:55.919 100 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node1 5.264s 2025-11-19 07:23:55.924 101 INFO STARTUP <<start-node-1>> CycleFinder: No cyclical back pressure detected in wiring model.
node1 5.265s 2025-11-19 07:23:55.925 102 INFO STARTUP <<start-node-1>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node1 5.267s 2025-11-19 07:23:55.927 103 INFO STARTUP <<start-node-1>> InputWireChecks: All input wires have been bound.
node1 5.269s 2025-11-19 07:23:55.929 104 WARN STARTUP <<start-node-1>> PcesFileTracker: No preconsensus event files available
node1 5.270s 2025-11-19 07:23:55.930 105 INFO STARTUP <<start-node-1>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node1 5.272s 2025-11-19 07:23:55.932 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 5.274s 2025-11-19 07:23:55.934 107 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 starts transactions ........
node3 5.277s 2025-11-19 07:23:55.937 52 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26106089] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=337310, randomLong=8868081962590692704, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=9980, randomLong=-6661280351751734884, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1080000, data=35, exception=null] OS Health Check Report - Complete (took 1024 ms)
node1 5.279s 2025-11-19 07:23:55.939 108 INFO PLATFORM_STATUS <platformForkJoinThread-6> StatusStateMachine: Platform spent 349.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node1 5.280s 2025-11-19 07:23:55.940 109 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node1 5.285s 2025-11-19 07:23:55.945 110 INFO PLATFORM_STATUS <platformForkJoinThread-6> StatusStateMachine: Platform spent 5.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node1 5.286s 2025-11-19 07:23:55.946 111 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change OBSERVING
node2 5.302s 2025-11-19 07:23:55.962 57 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node2 5.303s 2025-11-19 07:23:55.963 58 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node3 5.309s 2025-11-19 07:23:55.969 53 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node3 5.317s 2025-11-19 07:23:55.977 54 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node3 5.319s 2025-11-19 07:23:55.979 55 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node2 5.321s 2025-11-19 07:23:55.981 59 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: d67377adf26f12b0b042a128fad44ae62272b93a83cc596ae9e18825bf069691d8ecf9a6e831f01ae5a525a73be9dba0 (root) PlatformTestingToolState / coyote-volcano-rate-figure 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 SingletonNode RosterService.ROSTER_STATE /1 win-shrimp-key-daughter 2 VirtualMap RosterService.ROSTERS /2 easy-improve-raven-vacant 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 5.324s 2025-11-19 07:23:55.984 61 INFO RECONNECT <<platform-core: reconnectController>> ReconnectController: Starting the ReconnectController
node3 5.408s 2025-11-19 07:23:56.068 56 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIdUmpLKzyXgUwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMTAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBALXCoDQ+HOVsEDTZpFuJITSaGwaKX2is5K1P/lV+G+ll6u36IdqKNnZIirJrpX2N0Ad6NeF/oFcMhietrKt818PDA9Tbb2tqcHNKTxxZAEj7amQTsrU4EsNmUhaPgMs89yj9WLxCXVzW05cQjqYEA/hymzohWs1BdU3Y2KdmELe0v5fzRgDpNgYHhUN7IrlrlgXEWpuKRskBYc4PIvyACijY0/zkeEAyHOshYYGKhQbNm/NGWhFq83ro77CZZhX3Vl7hRnHLaEoCEE8atY8R1Txhy8aObhiS6R8ZVRTkZLar/FG/xe78RQfwHHD1al2w5oHR7xgTZylhbD+nVQ09Zmi25USpvqwumbMBE0OWhV+VH1WLCHfLQs6/5yuDjeZ/0D9tpQ8pfkiEkGLedzUzQkq+4/HmN4IFTOhgJHlu1tVUqohZIPZ5zSzqkqFzFQGRo2uAX8C2EJ3qgQMAEOpH8iOjiSKsezlIPuwvmrVDPxVfpY2Cq60oxRu6B8bZdbQkfwIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQAloxwiVu7pBhkO4fLqYRw4FC0VEx+c47W4xnrq3G/uXMGwE2Mfwple9FZnfT9JgSoT1UVw+cigo4720WdrPqkK8qnA3/PzGXlfJ3k6eFcBuli/KY1TakIJUAxFt5biNKatheMwAKsbF/JyVyaqG2dbSaXQ6hZBLQTYmLrmFWMvi9QdM1S8vNVMjn0hE2qQJtnVRuVwqRaAQ225jDv2CUCT28t0EWE6ccbiRi74l8KoW1Lo3v2EQ6ZZ89Xt3CwFSQHa6YVT685ECy82qMysU+YHBe9WmwJW05UAAY7JRsOo+RuuU/r4acNLmzprG+l7qsqqPkwXTcziw9Y2OYsFgY4bTlIOV0JC0AYApctDB3gbn83LM73CWccGrXq0liSV0wL11wscH3gFohXrwb646+6hgncZiDshlZlWaFSkHQJAxTR9bsbsCwKdZpzIIVOVTOT/3oLQKCCQvPriTpJiNa0P6gB0pq64lNcyG9fL8vS3YFFnWJTZwb8ZzGK+LZ91/2Y=", "gossipEndpoint": [{ "ipAddressV4": "Ij3b7Q==", "port": 30124 }, { "ipAddressV4": "CoAACw==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJguXwyGFpb8MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTIwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTIwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDYXoYHBtw8adD5sxLZSnlG9XgBLWVbIDl3YA4rZZ11cgl6FG2TvF8UVNXQ177cRm1xUUJRI5ulSgDofnm7Iuf6c/GoQrud2nP1yMWewGslwiEi1h2pxbN7doFvn/92Y0lJVwSV/vOpbIyPRoMeF0jXd7TEI7dYj4S7gV9uWmQCIWjwTZqVsjIAtzEkYnmS0/m5XuD9MJsin8OQRu/PEFL8qaVPQJ2GhOhpUJqvADQ/Lsq/FHcPjylcRcnUQlFRojk2jqugtoRegByjPrAOSYGJeWUCVYmd7W51L/AkVx1rDLeHj0zLTTzQRF5G56i+S+tAcpY/uiCrwLvszFlDlD1diOuaucmu54lalrSTlVe5eOyq2ga2tKi11LQ+w09105zLyRWk7DBU93f5dTYNSmokI7b4sVRxu6SP0p/F9wND77wv2Ax5OpIWWty8zy8Y+xOuRyFu/rJ4ddDmRYvRmptM0rCAfv6hgd3m5Y/OAadQm/OuN91Uq9PIJdlMtjDbIfECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEANutmL3V1PlvlsZ6xG8Sx9cKTok3kf3rBf7D7eE8Nn8ryHi3cw9CvCaj1E6zmTTh9k23DAZVWulhjTY5GWcx5NO7QAWjKau44g/HecNNrWsD/+nIrhmAk2WxKp175CwqJaIWA7CM6VMfFktjaflUPcB6RJnHrAa8M1HUpEsBz0mFmLz7lIaDemxYCE8M8slb6wTMjpL83GB+ejudRe7YK2ZWixM+CGp0ARkV+EecHaCXgEoROUNwP6mZVJcgSVR1QBQwcGAMIrutsKENM8HR9o3LWacigoJXf+IX8c6aJhrHfFvm62q+hi3baj7iR6gebEdWPtmEXgoVWOk230fLGyPU1oBxaDdYa8V4+ZFv03O91By9tuFrwZOcLCb4CPRyr8A47lHNjRIeo2nUF/c+SjV0eBcPKCnn1nW/AQWCxJ0QzzG6tEeMAGdDrE2ujPlB+Y9Sn8vB0zjYQHTr1NKyyXNogB4y48jofLDLDGOQYI6uP2fDgZeiq4dV8w91WbPHV", "gossipEndpoint": [{ "ipAddressV4": "IjtL0A==", "port": 30125 }, { "ipAddressV4": "CoAADA==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJwswl59m488MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDAqlNMpfduuW0ETQVjdKf5ZBe3Ug/ybRMoCWIlue8UoxFzamAtoeFEW3GVi862iImRVyHbkBZzDQUw4ABwMdxfzTL9voozkMaOZb4KQ9yZ9zNLAAmSSuE6RFmSJnBtfufxFXqiu6esbcvyropjZLc65F2uoMCpKN0CHFpWEb2GZAaipp7WCOon0NllDLqkjPylluXO4mjbzzMSDPbBWRD8VjjkxZeszWSXYxz9hqcRYX01CGg+jhooCQ6j2yB8sfFAffIeTG6GSV1uCFa4san2emhQWpr+cHaVYJMtejL43HaEVQnF3vh5Z10T/7co63C63aay2hs6Bx5SschosyYiafI7GtbQ4qpOgjEDFT1jlydK21gy6MV3SFEYwcUfxvxxRj6pS7xiMFn4FYnBKPJWkaDkwTqboEshxstvASQOW993uEwzh4EjctRHSjSuTU6S9OsWi5I5cRF+xK6GaWsTp0KyO8uVpuM9kZfpOcor294quyKJ9nylNyIt/m8Q8/ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAqPLB/xr0Yv1l9w/RO+bqFtl8TkxF/6jOqoEUXY06dEInopLYpmkksZZ9G8vebt6hAoLjaxNMdRqCkzKgy4jn7/SQZNV9FMbZ7ckiDxsBxYZ2ZaBootuWzzVD6hCSO3Tg6JgkIzldtFtNcDVBRgZnHg+Rl6hn+gFV5S2OTTTPHWK7GHwgHXLhK7N0RL4YVrRCi/HTUZnuYCjBwvdDte5iqytY05cAO4p72P6YtDaOdAfL/IIKd1ylCWITDqTp/JDBz1uxjQmsXLVD/KEEtlvYlGjIr+wUUqIUPhFvB6ajl2NO0D/r+t1BH454zbodU92QnOJpXpoNuOv7jjALHCqo70mCSwTNUSZuVP6/KLmQe8sSzYs7O/c25FzHKBYy+aZujoa/X7aI6XVmsUkj6ae9MSvQurk0jMNg/Jy5EtWOMy7WEuyadrAv6KSP3oIfmL9jWoPcyOMfvjRHxGqOfZuFZatAwswY6O0E3ATTrN03t/BVqNHIYIXc6UOiUTo2Nx56", "gossipEndpoint": [{ "ipAddressV4": "I+/v/w==", "port": 30126 }, { "ipAddressV4": "CoAABg==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAOxH0o7YkAUoMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDf6+SJl+puqRNd5r2Tb802jQTqPm7k3NXIeU8NQ3Hy9p0G+9p4Hgnt3ftipar7lKPKnp4PFrOP7E7XSKpafxK2OVQ0jTMvc6Yjqt+9mzyNSI1I8cSHTmhJ7kMBt0+NwVM8QN+fbKcbQaoNiPwMcckVtGeMad4aZM6hRyxzI0H3wgMj4JiM9VRwx7JbEo3R7akRwLwGr9ZQm2EQwqiyReNkBnXrsyP4KPPVAoeMfGchoAuBbV+r6v1OeYddocYmZkrsvMXUKF/uEcgd8gTu+pv3jObwIEVqXo1yC6ZlCFqO7LIvT8jTAAljkszoo67ykXTbKS0PZeLDg6nvdPvBMQ50yjfswR88S6N8VU6pud7Y+VbMYUiGzlrFi4MB9dikAjEj4PEetQyZdn84ZXGxerXlU/vTO2Fp4i1ec5rmX1P0WYMlbNELE408j5nfCfzD/qdcF5HZAiUVTYU/SWpzWcn34++KGpuqZZQdsGwCLQWeMeA/OEemYChis4cO94aOzrECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAlj5YIsbYXk2JGP9kRCBLDgz27ymYi1KDbO8g18V4T0zj2Zl7858U7mF9UBSSW+Cjl1UtUdvqFWZhh8jRoO3Jov1QGTULHRfyyPElD4VpwFribiu4GYJaodYy6NE50WwSJf32gLG0jHQWt7q+cOrn6WaG2h8O1sIxbTlnu1kqKQUQtu4oX8u23b5m9QXVJfJVdecwD5Rmab2d3dq/NNv2iNELH0myqtcoqw26xwIvXwaS4Gqi+Y0cOfjWL5Gv5AHIwvBXGIh3KUU7pbyBzqjkigbzSeoZw0C8G2cRTl0+QTuet2SVYlFh5J9/FBLvIfMfIpguglaU6xTVoRpo7RF24qQKFt2IlBROpqcwl0FyfE+2c19FGt1V8E5dYqE4T2mHT6FSOI3DckA2afBm1OCeMNtkqCQT8x+JvdKrgUh44QDm4PIVZDzaxog/zOzRWPCgpCPq0HcNMzgCVFt+4q8eTL9Ju/rQcS9bDosjMA69NGLIOCdPW2i/gkS9x9rTXgyp", "gossipEndpoint": [{ "ipAddressV4": "IjrhRA==", "port": 30127 }, { "ipAddressV4": "CoAACA==", "port": 30127 }] }] }
node3 5.523s 2025-11-19 07:23:56.183 57 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node3 5.524s 2025-11-19 07:23:56.184 58 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node3 5.541s 2025-11-19 07:23:56.201 59 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: d67377adf26f12b0b042a128fad44ae62272b93a83cc596ae9e18825bf069691d8ecf9a6e831f01ae5a525a73be9dba0 (root) PlatformTestingToolState / coyote-volcano-rate-figure 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 SingletonNode RosterService.ROSTER_STATE /1 win-shrimp-key-daughter 2 VirtualMap RosterService.ROSTERS /2 easy-improve-raven-vacant 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.544s 2025-11-19 07:23:56.204 61 INFO RECONNECT <<platform-core: reconnectController>> ReconnectController: Starting the ReconnectController
node2 5.558s 2025-11-19 07:23:56.218 62 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node2 5.564s 2025-11-19 07:23:56.224 63 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node2 5.573s 2025-11-19 07:23:56.233 64 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xms32g
node2 5.574s 2025-11-19 07:23:56.234 65 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xmx118g
node2 5.574s 2025-11-19 07:23:56.234 66 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node2 5.575s 2025-11-19 07:23:56.235 67 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node2 5.575s 2025-11-19 07:23:56.235 68 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node2 5.575s 2025-11-19 07:23:56.235 69 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node2 5.576s 2025-11-19 07:23:56.236 70 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node2 5.576s 2025-11-19 07:23:56.236 71 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node2 5.576s 2025-11-19 07:23:56.236 72 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node2 5.577s 2025-11-19 07:23:56.237 73 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node2 5.577s 2025-11-19 07:23:56.237 74 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node2 5.577s 2025-11-19 07:23:56.237 75 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node2 5.578s 2025-11-19 07:23:56.238 76 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node2 5.578s 2025-11-19 07:23:56.238 77 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node2 5.579s 2025-11-19 07:23:56.239 78 INFO STARTUP <<start-node-2>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node2 5.597s 2025-11-19 07:23:56.257 79 INFO DEMO_INFO <<start-node-2>> PayloadConfig: insertSeq = true
node2 5.598s 2025-11-19 07:23:56.258 80 INFO DEMO_INFO <<start-node-2>> PayloadConfig: appendSig = true
node2 5.598s 2025-11-19 07:23:56.258 81 INFO DEMO_INFO <<start-node-2>> PayloadConfig: variedSize = false
node2 5.599s 2025-11-19 07:23:56.259 82 INFO DEMO_INFO <<start-node-2>> PayloadConfig: payloadByteSize = 100
node2 5.599s 2025-11-19 07:23:56.259 83 INFO DEMO_INFO <<start-node-2>> PayloadConfig: maxByteSize = 100
node2 5.599s 2025-11-19 07:23:56.259 84 INFO DEMO_INFO <<start-node-2>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node2 5.600s 2025-11-19 07:23:56.260 85 INFO DEMO_INFO <<start-node-2>> PayloadConfig: invalidSigRatio = 0.0
node2 5.602s 2025-11-19 07:23:56.262 86 INFO DEMO_INFO <<start-node-2>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node2 5.603s 2025-11-19 07:23:56.263 87 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@31553d63
node2 5.604s 2025-11-19 07:23:56.264 88 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total accounts = 2400
node2 5.605s 2025-11-19 07:23:56.265 89 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node2 5.612s 2025-11-19 07:23:56.272 94 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@1f933de1, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@4abf378a,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@3e8dba09,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@a97b2cf,snapshotInProgress=false]
node2 5.622s 2025-11-19 07:23:56.282 95 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: max KV pairs = 0
node2 5.623s 2025-11-19 07:23:56.283 96 INFO DEMO_INFO <<start-node-2>> VirtualMerkleStateInitializer: total SC = 0
node2 5.628s 2025-11-19 07:23:56.288 97 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: Random seed for FCMTransactionPool is 780995363391181478
node2 5.629s 2025-11-19 07:23:56.289 98 INFO DEMO_INFO <<start-node-2>> FCMTransactionPool: This test will generate sequential FCM payload:
node2 5.718s 2025-11-19 07:23:56.378 99 INFO STARTUP <<start-node-2>> SwirldsPlatform: Starting platform 2
node2 5.719s 2025-11-19 07:23:56.379 100 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node2 5.723s 2025-11-19 07:23:56.383 101 INFO STARTUP <<start-node-2>> CycleFinder: No cyclical back pressure detected in wiring model.
node2 5.724s 2025-11-19 07:23:56.384 102 INFO STARTUP <<start-node-2>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node2 5.725s 2025-11-19 07:23:56.385 103 INFO STARTUP <<start-node-2>> InputWireChecks: All input wires have been bound.
node2 5.728s 2025-11-19 07:23:56.388 104 WARN STARTUP <<start-node-2>> PcesFileTracker: No preconsensus event files available
node2 5.728s 2025-11-19 07:23:56.388 105 INFO STARTUP <<start-node-2>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node2 5.730s 2025-11-19 07:23:56.390 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 5.731s 2025-11-19 07:23:56.391 107 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 starts transactions ........
node2 5.732s 2025-11-19 07:23:56.392 108 INFO PLATFORM_STATUS <platformForkJoinThread-4> StatusStateMachine: Platform spent 344.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node2 5.732s 2025-11-19 07:23:56.392 109 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node2 5.737s 2025-11-19 07:23:56.397 110 INFO PLATFORM_STATUS <platformForkJoinThread-4> StatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node2 5.737s 2025-11-19 07:23:56.397 111 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change OBSERVING
node3 5.764s 2025-11-19 07:23:56.424 62 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node3 5.769s 2025-11-19 07:23:56.429 63 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node3 5.778s 2025-11-19 07:23:56.438 64 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xms32g
node3 5.779s 2025-11-19 07:23:56.439 65 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xmx118g
node3 5.780s 2025-11-19 07:23:56.440 66 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node3 5.780s 2025-11-19 07:23:56.440 67 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node3 5.781s 2025-11-19 07:23:56.441 68 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node3 5.781s 2025-11-19 07:23:56.441 69 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node3 5.782s 2025-11-19 07:23:56.442 70 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node3 5.782s 2025-11-19 07:23:56.442 71 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node3 5.782s 2025-11-19 07:23:56.442 72 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node3 5.783s 2025-11-19 07:23:56.443 73 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node3 5.783s 2025-11-19 07:23:56.443 74 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node3 5.783s 2025-11-19 07:23:56.443 75 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node3 5.784s 2025-11-19 07:23:56.444 76 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node3 5.784s 2025-11-19 07:23:56.444 77 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node3 5.785s 2025-11-19 07:23:56.445 78 INFO STARTUP <<start-node-3>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node3 5.805s 2025-11-19 07:23:56.465 79 INFO DEMO_INFO <<start-node-3>> PayloadConfig: insertSeq = true
node3 5.806s 2025-11-19 07:23:56.466 80 INFO DEMO_INFO <<start-node-3>> PayloadConfig: appendSig = true
node3 5.807s 2025-11-19 07:23:56.467 81 INFO DEMO_INFO <<start-node-3>> PayloadConfig: variedSize = false
node3 5.807s 2025-11-19 07:23:56.467 82 INFO DEMO_INFO <<start-node-3>> PayloadConfig: payloadByteSize = 100
node3 5.807s 2025-11-19 07:23:56.467 83 INFO DEMO_INFO <<start-node-3>> PayloadConfig: maxByteSize = 100
node3 5.808s 2025-11-19 07:23:56.468 84 INFO DEMO_INFO <<start-node-3>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node3 5.809s 2025-11-19 07:23:56.469 85 INFO DEMO_INFO <<start-node-3>> PayloadConfig: invalidSigRatio = 0.0
node3 5.810s 2025-11-19 07:23:56.470 86 INFO DEMO_INFO <<start-node-3>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node3 5.812s 2025-11-19 07:23:56.472 87 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@151ae98d
node3 5.813s 2025-11-19 07:23:56.473 88 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total accounts = 2400
node3 5.814s 2025-11-19 07:23:56.474 89 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node3 5.821s 2025-11-19 07:23:56.481 94 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@120e8c24, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@49aaff7f,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@4934c21e,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@4bdc645,snapshotInProgress=false]
node3 5.830s 2025-11-19 07:23:56.490 95 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: max KV pairs = 0
node3 5.831s 2025-11-19 07:23:56.491 96 INFO DEMO_INFO <<start-node-3>> VirtualMerkleStateInitializer: total SC = 0
node3 5.835s 2025-11-19 07:23:56.495 97 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: Random seed for FCMTransactionPool is 1046569274146448397
node3 5.836s 2025-11-19 07:23:56.496 98 INFO DEMO_INFO <<start-node-3>> FCMTransactionPool: This test will generate sequential FCM payload:
node3 5.921s 2025-11-19 07:23:56.581 99 INFO STARTUP <<start-node-3>> SwirldsPlatform: Starting platform 3
node3 5.922s 2025-11-19 07:23:56.582 100 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node3 5.925s 2025-11-19 07:23:56.585 101 INFO STARTUP <<start-node-3>> CycleFinder: No cyclical back pressure detected in wiring model.
node3 5.926s 2025-11-19 07:23:56.586 102 INFO STARTUP <<start-node-3>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node3 5.928s 2025-11-19 07:23:56.588 103 INFO STARTUP <<start-node-3>> InputWireChecks: All input wires have been bound.
node3 5.929s 2025-11-19 07:23:56.589 104 WARN STARTUP <<start-node-3>> PcesFileTracker: No preconsensus event files available
node3 5.930s 2025-11-19 07:23:56.590 105 INFO STARTUP <<start-node-3>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node3 5.931s 2025-11-19 07:23:56.591 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.932s 2025-11-19 07:23:56.592 107 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 starts transactions ........
node3 5.934s 2025-11-19 07:23:56.594 108 INFO PLATFORM_STATUS <platformForkJoinThread-3> StatusStateMachine: Platform spent 331.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node3 5.934s 2025-11-19 07:23:56.594 109 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node3 5.938s 2025-11-19 07:23:56.598 110 INFO PLATFORM_STATUS <platformForkJoinThread-3> StatusStateMachine: Platform spent 4.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node3 5.939s 2025-11-19 07:23:56.599 111 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change OBSERVING
node0 6.050s 2025-11-19 07:23:56.710 52 INFO STARTUP <main> OSHealthChecker:
PASSED - Clock Source Speed Check Report[callsPerSec=26211524] PASSED - Entropy Check Report[success=true, entropySource=Strong Instance, elapsedNanos=152420, randomLong=4772420090127517523, exception=null] PASSED - Entropy Check Report[success=true, entropySource=NativePRNGBlocking:SUN, elapsedNanos=15830, randomLong=9138064095487988574, exception=null] PASSED - File System Check Report[code=SUCCESS, readNanos=1268101, data=35, exception=null] OS Health Check Report - Complete (took 1026 ms)
node0 6.083s 2025-11-19 07:23:56.743 53 DEBUG STARTUP <main> BootstrapUtils: jvmPauseDetectorThread started
node0 6.092s 2025-11-19 07:23:56.752 54 INFO STARTUP <main> StandardScratchpad: Scratchpad platform.iss contents:
LAST_ISS_ROUND null
node0 6.094s 2025-11-19 07:23:56.754 55 INFO STARTUP <main> PlatformBuilder: Default platform pool parallelism: 8
node0 6.186s 2025-11-19 07:23:56.846 56 INFO STARTUP <main> SwirldsPlatform: Starting with roster history:
RosterHistory[ currentRosterRound: 0 ][ no previous roster set ] Current Roster: { "rosterEntries": [{ "weight": "3125000000", "gossipCaCertificate": "MIIDpjCCAg6gAwIBAgIIdUmpLKzyXgUwDQYJKoZIhvcNAQEMBQAwEjEQMA4GA1UEAxMHcy1ub2RlMTAgFw0wMDAxMDEwMDAwMDBaGA8yMTAwMDEwMTAwMDAwMFowEjEQMA4GA1UEAxMHcy1ub2RlMTCCAaIwDQYJKoZIhvcNAQEBBQADggGPADCCAYoCggGBALXCoDQ+HOVsEDTZpFuJITSaGwaKX2is5K1P/lV+G+ll6u36IdqKNnZIirJrpX2N0Ad6NeF/oFcMhietrKt818PDA9Tbb2tqcHNKTxxZAEj7amQTsrU4EsNmUhaPgMs89yj9WLxCXVzW05cQjqYEA/hymzohWs1BdU3Y2KdmELe0v5fzRgDpNgYHhUN7IrlrlgXEWpuKRskBYc4PIvyACijY0/zkeEAyHOshYYGKhQbNm/NGWhFq83ro77CZZhX3Vl7hRnHLaEoCEE8atY8R1Txhy8aObhiS6R8ZVRTkZLar/FG/xe78RQfwHHD1al2w5oHR7xgTZylhbD+nVQ09Zmi25USpvqwumbMBE0OWhV+VH1WLCHfLQs6/5yuDjeZ/0D9tpQ8pfkiEkGLedzUzQkq+4/HmN4IFTOhgJHlu1tVUqohZIPZ5zSzqkqFzFQGRo2uAX8C2EJ3qgQMAEOpH8iOjiSKsezlIPuwvmrVDPxVfpY2Cq60oxRu6B8bZdbQkfwIDAQABMA0GCSqGSIb3DQEBDAUAA4IBgQAloxwiVu7pBhkO4fLqYRw4FC0VEx+c47W4xnrq3G/uXMGwE2Mfwple9FZnfT9JgSoT1UVw+cigo4720WdrPqkK8qnA3/PzGXlfJ3k6eFcBuli/KY1TakIJUAxFt5biNKatheMwAKsbF/JyVyaqG2dbSaXQ6hZBLQTYmLrmFWMvi9QdM1S8vNVMjn0hE2qQJtnVRuVwqRaAQ225jDv2CUCT28t0EWE6ccbiRi74l8KoW1Lo3v2EQ6ZZ89Xt3CwFSQHa6YVT685ECy82qMysU+YHBe9WmwJW05UAAY7JRsOo+RuuU/r4acNLmzprG+l7qsqqPkwXTcziw9Y2OYsFgY4bTlIOV0JC0AYApctDB3gbn83LM73CWccGrXq0liSV0wL11wscH3gFohXrwb646+6hgncZiDshlZlWaFSkHQJAxTR9bsbsCwKdZpzIIVOVTOT/3oLQKCCQvPriTpJiNa0P6gB0pq64lNcyG9fL8vS3YFFnWJTZwb8ZzGK+LZ91/2Y=", "gossipEndpoint": [{ "ipAddressV4": "Ij3b7Q==", "port": 30124 }, { "ipAddressV4": "CoAACw==", "port": 30124 }] }, { "nodeId": "1", "weight": "16000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJguXwyGFpb8MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTIwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTIwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDYXoYHBtw8adD5sxLZSnlG9XgBLWVbIDl3YA4rZZ11cgl6FG2TvF8UVNXQ177cRm1xUUJRI5ulSgDofnm7Iuf6c/GoQrud2nP1yMWewGslwiEi1h2pxbN7doFvn/92Y0lJVwSV/vOpbIyPRoMeF0jXd7TEI7dYj4S7gV9uWmQCIWjwTZqVsjIAtzEkYnmS0/m5XuD9MJsin8OQRu/PEFL8qaVPQJ2GhOhpUJqvADQ/Lsq/FHcPjylcRcnUQlFRojk2jqugtoRegByjPrAOSYGJeWUCVYmd7W51L/AkVx1rDLeHj0zLTTzQRF5G56i+S+tAcpY/uiCrwLvszFlDlD1diOuaucmu54lalrSTlVe5eOyq2ga2tKi11LQ+w09105zLyRWk7DBU93f5dTYNSmokI7b4sVRxu6SP0p/F9wND77wv2Ax5OpIWWty8zy8Y+xOuRyFu/rJ4ddDmRYvRmptM0rCAfv6hgd3m5Y/OAadQm/OuN91Uq9PIJdlMtjDbIfECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEANutmL3V1PlvlsZ6xG8Sx9cKTok3kf3rBf7D7eE8Nn8ryHi3cw9CvCaj1E6zmTTh9k23DAZVWulhjTY5GWcx5NO7QAWjKau44g/HecNNrWsD/+nIrhmAk2WxKp175CwqJaIWA7CM6VMfFktjaflUPcB6RJnHrAa8M1HUpEsBz0mFmLz7lIaDemxYCE8M8slb6wTMjpL83GB+ejudRe7YK2ZWixM+CGp0ARkV+EecHaCXgEoROUNwP6mZVJcgSVR1QBQwcGAMIrutsKENM8HR9o3LWacigoJXf+IX8c6aJhrHfFvm62q+hi3baj7iR6gebEdWPtmEXgoVWOk230fLGyPU1oBxaDdYa8V4+ZFv03O91By9tuFrwZOcLCb4CPRyr8A47lHNjRIeo2nUF/c+SjV0eBcPKCnn1nW/AQWCxJ0QzzG6tEeMAGdDrE2ujPlB+Y9Sn8vB0zjYQHTr1NKyyXNogB4y48jofLDLDGOQYI6uP2fDgZeiq4dV8w91WbPHV", "gossipEndpoint": [{ "ipAddressV4": "IjtL0A==", "port": 30125 }, { "ipAddressV4": "CoAADA==", "port": 30125 }] }, { "nodeId": "2", "weight": "15875000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAJwswl59m488MA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTMwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTMwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDAqlNMpfduuW0ETQVjdKf5ZBe3Ug/ybRMoCWIlue8UoxFzamAtoeFEW3GVi862iImRVyHbkBZzDQUw4ABwMdxfzTL9voozkMaOZb4KQ9yZ9zNLAAmSSuE6RFmSJnBtfufxFXqiu6esbcvyropjZLc65F2uoMCpKN0CHFpWEb2GZAaipp7WCOon0NllDLqkjPylluXO4mjbzzMSDPbBWRD8VjjkxZeszWSXYxz9hqcRYX01CGg+jhooCQ6j2yB8sfFAffIeTG6GSV1uCFa4san2emhQWpr+cHaVYJMtejL43HaEVQnF3vh5Z10T/7co63C63aay2hs6Bx5SschosyYiafI7GtbQ4qpOgjEDFT1jlydK21gy6MV3SFEYwcUfxvxxRj6pS7xiMFn4FYnBKPJWkaDkwTqboEshxstvASQOW993uEwzh4EjctRHSjSuTU6S9OsWi5I5cRF+xK6GaWsTp0KyO8uVpuM9kZfpOcor294quyKJ9nylNyIt/m8Q8/ECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAqPLB/xr0Yv1l9w/RO+bqFtl8TkxF/6jOqoEUXY06dEInopLYpmkksZZ9G8vebt6hAoLjaxNMdRqCkzKgy4jn7/SQZNV9FMbZ7ckiDxsBxYZ2ZaBootuWzzVD6hCSO3Tg6JgkIzldtFtNcDVBRgZnHg+Rl6hn+gFV5S2OTTTPHWK7GHwgHXLhK7N0RL4YVrRCi/HTUZnuYCjBwvdDte5iqytY05cAO4p72P6YtDaOdAfL/IIKd1ylCWITDqTp/JDBz1uxjQmsXLVD/KEEtlvYlGjIr+wUUqIUPhFvB6ajl2NO0D/r+t1BH454zbodU92QnOJpXpoNuOv7jjALHCqo70mCSwTNUSZuVP6/KLmQe8sSzYs7O/c25FzHKBYy+aZujoa/X7aI6XVmsUkj6ae9MSvQurk0jMNg/Jy5EtWOMy7WEuyadrAv6KSP3oIfmL9jWoPcyOMfvjRHxGqOfZuFZatAwswY6O0E3ATTrN03t/BVqNHIYIXc6UOiUTo2Nx56", "gossipEndpoint": [{ "ipAddressV4": "I+/v/w==", "port": 30126 }, { "ipAddressV4": "CoAABg==", "port": 30126 }] }, { "nodeId": "3", "weight": "15000000000", "gossipCaCertificate": "MIIDpzCCAg+gAwIBAgIJAOxH0o7YkAUoMA0GCSqGSIb3DQEBDAUAMBIxEDAOBgNVBAMTB3Mtbm9kZTQwIBcNMDAwMTAxMDAwMDAwWhgPMjEwMDAxMDEwMDAwMDBaMBIxEDAOBgNVBAMTB3Mtbm9kZTQwggGiMA0GCSqGSIb3DQEBAQUAA4IBjwAwggGKAoIBgQDf6+SJl+puqRNd5r2Tb802jQTqPm7k3NXIeU8NQ3Hy9p0G+9p4Hgnt3ftipar7lKPKnp4PFrOP7E7XSKpafxK2OVQ0jTMvc6Yjqt+9mzyNSI1I8cSHTmhJ7kMBt0+NwVM8QN+fbKcbQaoNiPwMcckVtGeMad4aZM6hRyxzI0H3wgMj4JiM9VRwx7JbEo3R7akRwLwGr9ZQm2EQwqiyReNkBnXrsyP4KPPVAoeMfGchoAuBbV+r6v1OeYddocYmZkrsvMXUKF/uEcgd8gTu+pv3jObwIEVqXo1yC6ZlCFqO7LIvT8jTAAljkszoo67ykXTbKS0PZeLDg6nvdPvBMQ50yjfswR88S6N8VU6pud7Y+VbMYUiGzlrFi4MB9dikAjEj4PEetQyZdn84ZXGxerXlU/vTO2Fp4i1ec5rmX1P0WYMlbNELE408j5nfCfzD/qdcF5HZAiUVTYU/SWpzWcn34++KGpuqZZQdsGwCLQWeMeA/OEemYChis4cO94aOzrECAwEAATANBgkqhkiG9w0BAQwFAAOCAYEAlj5YIsbYXk2JGP9kRCBLDgz27ymYi1KDbO8g18V4T0zj2Zl7858U7mF9UBSSW+Cjl1UtUdvqFWZhh8jRoO3Jov1QGTULHRfyyPElD4VpwFribiu4GYJaodYy6NE50WwSJf32gLG0jHQWt7q+cOrn6WaG2h8O1sIxbTlnu1kqKQUQtu4oX8u23b5m9QXVJfJVdecwD5Rmab2d3dq/NNv2iNELH0myqtcoqw26xwIvXwaS4Gqi+Y0cOfjWL5Gv5AHIwvBXGIh3KUU7pbyBzqjkigbzSeoZw0C8G2cRTl0+QTuet2SVYlFh5J9/FBLvIfMfIpguglaU6xTVoRpo7RF24qQKFt2IlBROpqcwl0FyfE+2c19FGt1V8E5dYqE4T2mHT6FSOI3DckA2afBm1OCeMNtkqCQT8x+JvdKrgUh44QDm4PIVZDzaxog/zOzRWPCgpCPq0HcNMzgCVFt+4q8eTL9Ju/rQcS9bDosjMA69NGLIOCdPW2i/gkS9x9rTXgyp", "gossipEndpoint": [{ "ipAddressV4": "IjrhRA==", "port": 30127 }, { "ipAddressV4": "CoAACA==", "port": 30127 }] }] }
node0 6.298s 2025-11-19 07:23:56.958 57 INFO STARTUP <main> PlatformTestingToolState: Trigger and PreviousSoftwareVersion state received in init function {"trigger":"GENESIS","previousSoftwareVersion":"null"} [com.swirlds.logging.legacy.payload.SoftwareVersionPayload]
node0 6.299s 2025-11-19 07:23:56.959 58 INFO STARTUP <main> PlatformTestingToolState: Set QuorumResult from genesisInit()
node0 6.317s 2025-11-19 07:23:56.977 59 INFO STARTUP <main> StateInitializer: The platform is using the following initial state:
Round: 0 Timestamp: 1970-01-01T00:00:00Z Next consensus number: 0 Legacy running event hash: null Legacy running event mnemonic: null Rounds non-ancient: 0 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 1 Root hash: d67377adf26f12b0b042a128fad44ae62272b93a83cc596ae9e18825bf069691d8ecf9a6e831f01ae5a525a73be9dba0 (root) PlatformTestingToolState / coyote-volcano-rate-figure 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 method-topple-elite-gate 1 SingletonNode RosterService.ROSTER_STATE /1 win-shrimp-key-daughter 2 VirtualMap RosterService.ROSTERS /2 easy-improve-raven-vacant 3 PayloadCfgSimple /3 potato-pill-swear-author 4 null /4 bid-belt-culture-decorate 5 null /5 bid-belt-culture-decorate 6 null /6 bid-belt-culture-decorate 7 IssLeaf /7 biology-capable-expose-purpose 8 null /8 bid-belt-culture-decorate 9 null /9 bid-belt-culture-decorate 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 6.322s 2025-11-19 07:23:56.982 61 INFO RECONNECT <<platform-core: reconnectController>> ReconnectController: Starting the ReconnectController
node0 6.568s 2025-11-19 07:23:57.228 62 INFO EVENT_STREAM <main> DefaultConsensusEventStream: EventStreamManager::updateRunningHash: 38b060a751ac96384cd9327eb1b1e36a21fdb71114be07434c0cc7bf63f6e1da274edebfe76f65fbd51ad2f14898b95b
node0 6.574s 2025-11-19 07:23:57.234 63 INFO STARTUP <platformForkJoinThread-2> Shadowgraph: Shadowgraph starting from expiration threshold 1
node0 6.584s 2025-11-19 07:23:57.244 64 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xms32g
node0 6.585s 2025-11-19 07:23:57.245 65 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xmx118g
node0 6.585s 2025-11-19 07:23:57.245 66 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UnlockExperimentalVMOptions
node0 6.586s 2025-11-19 07:23:57.246 67 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+UseZGC
node0 6.586s 2025-11-19 07:23:57.246 68 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZAllocationSpikeTolerance=2
node0 6.586s 2025-11-19 07:23:57.246 69 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ConcGCThreads=14
node0 6.587s 2025-11-19 07:23:57.247 70 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:ZMarkStackSpaceLimit=16g
node0 6.587s 2025-11-19 07:23:57.247 71 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MaxDirectMemorySize=64g
node0 6.587s 2025-11-19 07:23:57.247 72 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:MetaspaceSize=100M
node0 6.588s 2025-11-19 07:23:57.248 73 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -XX:+ZGenerational
node0 6.588s 2025-11-19 07:23:57.248 74 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Xlog:gc*:gc.log
node0 6.588s 2025-11-19 07:23:57.248 75 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/jdk.internal.misc=ALL-UNNAMED
node0 6.588s 2025-11-19 07:23:57.248 76 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: --add-opens=java.base/java.nio=ALL-UNNAMED
node0 6.589s 2025-11-19 07:23:57.249 77 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: JVM arg: -Dio.netty.tryReflectionSetAccessible=true
node0 6.590s 2025-11-19 07:23:57.250 78 INFO STARTUP <<start-node-0>> PlatformTestingToolMain: Parsing JSON FCM-VM-NIReconnect-125-10m.json
node0 6.608s 2025-11-19 07:23:57.268 79 INFO DEMO_INFO <<start-node-0>> PayloadConfig: insertSeq = true
node0 6.609s 2025-11-19 07:23:57.269 80 INFO DEMO_INFO <<start-node-0>> PayloadConfig: appendSig = true
node0 6.609s 2025-11-19 07:23:57.269 81 INFO DEMO_INFO <<start-node-0>> PayloadConfig: variedSize = false
node0 6.610s 2025-11-19 07:23:57.270 82 INFO DEMO_INFO <<start-node-0>> PayloadConfig: payloadByteSize = 100
node0 6.610s 2025-11-19 07:23:57.270 83 INFO DEMO_INFO <<start-node-0>> PayloadConfig: maxByteSize = 100
node0 6.611s 2025-11-19 07:23:57.271 84 INFO DEMO_INFO <<start-node-0>> PayloadConfig: type = TYPE_FCM_VIRTUAL_MIX
node0 6.611s 2025-11-19 07:23:57.271 85 INFO DEMO_INFO <<start-node-0>> PayloadConfig: invalidSigRatio = 0.0
node0 6.613s 2025-11-19 07:23:57.273 86 INFO DEMO_INFO <<start-node-0>> TransactionSubmitter: Goal is TRANS_PER_SECOND_PER_NODE targe 125.0
node0 6.614s 2025-11-19 07:23:57.274 87 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: State = com.swirlds.demo.platform.PlatformTestingToolState@64b2ce1f
node0 6.615s 2025-11-19 07:23:57.275 88 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total accounts = 2400
node0 6.616s 2025-11-19 07:23:57.276 89 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: Creating virtualmap for 2400 accounts.
node0 6.623s 2025-11-19 07:23:57.283 94 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: accounts VM = com.swirlds.virtualmap.VirtualMap@f814c3a, DS = MerkleDbDataSource[initialCapacity=1000000,preferDiskBasedIndexes=false,pathToDiskLocationInternalNodes.size=0,pathToDiskLocationLeafNodes.size=0,hashesRamToDiskThreshold=8388608,hashStoreRam.size=0,hashStoreDisk=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@5e8c5769,hasDiskStoreForHashes=true,keyToPath=com.swirlds.merkledb.files.hashmap.HalfDiskHashMap@54fc5f,pathToKeyValue=com.swirlds.merkledb.files.MemoryIndexDiskKeyValueStore@719f1862,snapshotInProgress=false]
node0 6.646s 2025-11-19 07:23:57.306 95 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: max KV pairs = 0
node0 6.650s 2025-11-19 07:23:57.310 96 INFO DEMO_INFO <<start-node-0>> VirtualMerkleStateInitializer: total SC = 0
node0 6.659s 2025-11-19 07:23:57.319 97 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: Random seed for FCMTransactionPool is -5491830792283158079
node0 6.660s 2025-11-19 07:23:57.320 98 INFO DEMO_INFO <<start-node-0>> FCMTransactionPool: This test will generate sequential FCM payload:
node0 6.755s 2025-11-19 07:23:57.415 99 INFO STARTUP <<start-node-0>> SwirldsPlatform: Starting platform 0
node0 6.757s 2025-11-19 07:23:57.417 100 INFO STARTUP <<platform: recycle-bin-cleanup>> RecycleBinImpl: Deleted 0 files from the recycle bin.
node0 6.761s 2025-11-19 07:23:57.421 101 INFO STARTUP <<start-node-0>> CycleFinder: No cyclical back pressure detected in wiring model.
node0 6.763s 2025-11-19 07:23:57.423 102 INFO STARTUP <<start-node-0>> DirectSchedulerChecks: No illegal direct scheduler use detected in the wiring model.
node0 6.764s 2025-11-19 07:23:57.424 103 INFO STARTUP <<start-node-0>> InputWireChecks: All input wires have been bound.
node0 6.766s 2025-11-19 07:23:57.426 104 WARN STARTUP <<start-node-0>> PcesFileTracker: No preconsensus event files available
node0 6.766s 2025-11-19 07:23:57.426 105 INFO STARTUP <<start-node-0>> SwirldsPlatform: replaying preconsensus event stream starting at 0
node0 6.768s 2025-11-19 07:23:57.428 106 INFO STARTUP <<start-node-0>> PcesReplayer: Replayed 0 preconsensus events with max birth round -1. These events contained 0 transactions. 0 rounds reached consensus spanning 0.0 nanoseconds of consensus time. The latest round to reach consensus is round 0. Replay took 0.0 nanoseconds.
node0 6.770s 2025-11-19 07:23:57.430 107 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 starts transactions ........
node0 6.774s 2025-11-19 07:23:57.434 108 INFO PLATFORM_STATUS <platformForkJoinThread-5> StatusStateMachine: Platform spent 387.0 ms in STARTING_UP. Now in REPLAYING_EVENTS
node0 6.775s 2025-11-19 07:23:57.435 109 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change REPLAYING_EVENTS
node0 6.781s 2025-11-19 07:23:57.441 110 INFO PLATFORM_STATUS <platformForkJoinThread-5> StatusStateMachine: Platform spent 5.0 ms in REPLAYING_EVENTS. Now in OBSERVING
node0 6.782s 2025-11-19 07:23:57.442 111 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change OBSERVING
node1 8.114s 2025-11-19 07:23:58.774 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 8.116s 2025-11-19 07:23:58.776 113 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node2 8.584s 2025-11-19 07:23:59.244 112 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting2.csv' ]
node2 8.587s 2025-11-19 07:23:59.247 113 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node3 8.790s 2025-11-19 07:23:59.450 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.794s 2025-11-19 07:23:59.454 113 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node0 9.595s 2025-11-19 07:24:00.255 112 INFO STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Initializing statistics output in CSV format [ csvOutputFolder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats', csvFileName = 'PlatformTesting0.csv' ]
node0 9.606s 2025-11-19 07:24:00.266 113 DEBUG STARTUP <<platform-core: MetricsThread #0>> LegacyCsvWriter: CsvWriter: Using the existing metrics folder [ folder = '/opt/hgcapp/services-hedera/HapiApp2.0/data/stats' ]
node1 15.369s 2025-11-19 07:24:06.029 114 INFO PLATFORM_STATUS <platformForkJoinThread-6> StatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node1 15.371s 2025-11-19 07:24:06.031 115 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change CHECKING
node2 15.827s 2025-11-19 07:24:06.487 114 INFO PLATFORM_STATUS <platformForkJoinThread-6> StatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node2 15.829s 2025-11-19 07:24:06.489 115 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change CHECKING
node3 16.029s 2025-11-19 07:24:06.689 114 INFO PLATFORM_STATUS <platformForkJoinThread-2> StatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node3 16.032s 2025-11-19 07:24:06.692 115 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change CHECKING
node0 16.867s 2025-11-19 07:24:07.527 114 INFO PLATFORM_STATUS <platformForkJoinThread-6> StatusStateMachine: Platform spent 10.1 s in OBSERVING. Now in CHECKING
node0 16.868s 2025-11-19 07:24:07.528 115 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change CHECKING
node1 16.916s 2025-11-19 07:24:07.576 116 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node1 16.917s 2025-11-19 07:24:07.577 117 INFO PLATFORM_STATUS <platformForkJoinThread-5> StatusStateMachine: Platform spent 1.5 s in CHECKING. Now in ACTIVE
node1 16.918s 2025-11-19 07:24:07.578 118 INFO STARTUP <platformForkJoinThread-5> PlatformTestingToolMain: Platform Status Change ACTIVE
node0 16.963s 2025-11-19 07:24:07.623 116 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node1 16.997s 2025-11-19 07:24:07.657 119 TRACE STARTUP <<app: appMain 1>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0x3949A17059A911734467650F79DB5F29E181A40528816E20B62CDCDB136D70EB', privateKey ='0x3949A17059A911734467650F79DB5F29E181A40528816E20B62CDCDB136D70EB', signature = '0xADC627ACA52F33AB734ACF64514284BB756AAE749CC46FFF65ED97468DA1BA37D676F147522DB86B0AAD4FCBA085EB474AC75D94BC013212645D195FFAE16106',message = '0x1A6B0A1A08011001180120A18D0628914E30914E40B4E0ED9DAEBAB4B94B2A4A0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00101' }
node2 17.022s 2025-11-19 07:24:07.682 116 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node3 17.053s 2025-11-19 07:24:07.713 116 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: resetting transaction counters
node2 17.445s 2025-11-19 07:24:08.105 117 INFO PLATFORM_STATUS <platformForkJoinThread-8> StatusStateMachine: Platform spent 1.6 s in CHECKING. Now in ACTIVE
node2 17.445s 2025-11-19 07:24:08.105 118 INFO STARTUP <platformForkJoinThread-8> PlatformTestingToolMain: Platform Status Change ACTIVE
node2 17.465s 2025-11-19 07:24:08.125 119 TRACE STARTUP <<app: appMain 2>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0xC5163F209EF6659DC043F374621C4ED88093D4D6DB80FAB68BB4DCEECACD3BFA', privateKey ='0xC5163F209EF6659DC043F374621C4ED88093D4D6DB80FAB68BB4DCEECACD3BFA', signature = '0x842B32155E674A25C599F435BC88E0E9634CEA44F097760AB809356C08524A6E9B80714F4E409A62E13975D4B89B6615D5B680D8CF2A2C545562B4440FFCE00D',message = '0x1A6B0A1B08021002180120A18D0628914E30914E40F1A2A3A582B7C8F2C2012A4900000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000D00102' }
node3 17.523s 2025-11-19 07:24:08.183 117 INFO PLATFORM_STATUS <platformForkJoinThread-6> StatusStateMachine: Platform spent 1.5 s in CHECKING. Now in ACTIVE
node3 17.523s 2025-11-19 07:24:08.183 118 INFO STARTUP <platformForkJoinThread-6> PlatformTestingToolMain: Platform Status Change ACTIVE
node3 17.563s 2025-11-19 07:24:08.223 119 TRACE STARTUP <<app: appMain 3>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0xB045C5AABF63B554362626DEA7C7EB2107BE8DD1EED40ABCB0C726C75A6DFAC0', privateKey ='0xB045C5AABF63B554362626DEA7C7EB2107BE8DD1EED40ABCB0C726C75A6DFAC0', signature = '0xEDBE1F381B555AD0803FFCD1D139CD27CCEDEFC257D579B0BEF535105BD9634E6CF77A92575DEECF7573CE7D91D607598225A1D95488EFC503579823A4E06C07',message = '0x12660A1A0803100318A03820A03828A03830A03840E196D88380DDDBDD103244000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000038034001' }
node0 17.818s 2025-11-19 07:24:08.478 119 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node1 17.818s 2025-11-19 07:24:08.478 122 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node3 17.819s 2025-11-19 07:24:08.479 122 INFO STATE_TO_DISK <<scheduler TransactionHandler>> DefaultSavedStateController: Signed state from round 3 created, will eventually be written to disk, for reason: FIRST_ROUND_AFTER_GENESIS
node2 17.967s 2025-11-19 07:24:08.627 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 18.006s 2025-11-19 07:24:08.666 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 18.008s 2025-11-19 07:24:08.668 138 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for 3
node2 18.036s 2025-11-19 07:24:08.696 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 18.038s 2025-11-19 07:24:08.698 138 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for 3
node3 18.059s 2025-11-19 07:24:08.719 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 18.061s 2025-11-19 07:24:08.721 138 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for 3
node0 18.179s 2025-11-19 07:24:08.839 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 18.182s 2025-11-19 07:24:08.842 135 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Creating a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for 3
node1 18.261s 2025-11-19 07:24:08.921 192 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for 3
node1 18.266s 2025-11-19 07:24:08.926 193 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-11-19T07:24:07.608490689Z Next consensus number: 14 Legacy running event hash: 33fa4eed9e61918b97f370933e783679aa33b0b15fbfe087d0be7f6998285ea8de8cacb5dcdf88fbb585e480f2a37d90 Legacy running event mnemonic: leg-tank-crop-solid Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 9d20b01289f03442804f78e3602364c0bf2a195a708842a1e5c58c4e64f9f5b505720a29fe8bc08beadcfdd73a1a1400 (root) PlatformTestingToolState / foster-worry-search-marriage 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 brush-topic-town-benefit 1 SingletonNode RosterService.ROSTER_STATE /1 win-shrimp-key-daughter 2 VirtualMap RosterService.ROSTERS /2 easy-improve-raven-vacant 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 chimney-custom-narrow-palm 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node1 18.303s 2025-11-19 07:24:08.963 194 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/1/2025/11/19/2025-11-19T07+24+06.063163708Z_seq0_minr1_maxr501_orgn0.pces
node1 18.303s 2025-11-19 07:24:08.963 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/1/2025/11/19/2025-11-19T07+24+06.063163708Z_seq0_minr1_maxr501_orgn0.pces
node1 18.304s 2025-11-19 07:24:08.964 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node1 18.305s 2025-11-19 07:24:08.965 197 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node1 18.310s 2025-11-19 07:24:08.970 198 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3 {"round":3,"freezeState":false,"reason":"FIRST_ROUND_AFTER_GENESIS","directory":"file:///opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/1/123/3/"} [com.swirlds.logging.legacy.payload.StateSavedToDiskPayload]
node2 18.311s 2025-11-19 07:24:08.971 192 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for 3
node2 18.315s 2025-11-19 07:24:08.975 193 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-11-19T07:24:07.608490689Z Next consensus number: 14 Legacy running event hash: 33fa4eed9e61918b97f370933e783679aa33b0b15fbfe087d0be7f6998285ea8de8cacb5dcdf88fbb585e480f2a37d90 Legacy running event mnemonic: leg-tank-crop-solid Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 9d20b01289f03442804f78e3602364c0bf2a195a708842a1e5c58c4e64f9f5b505720a29fe8bc08beadcfdd73a1a1400 (root) PlatformTestingToolState / foster-worry-search-marriage 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 brush-topic-town-benefit 1 SingletonNode RosterService.ROSTER_STATE /1 win-shrimp-key-daughter 2 VirtualMap RosterService.ROSTERS /2 easy-improve-raven-vacant 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 chimney-custom-narrow-palm 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node3 18.344s 2025-11-19 07:24:09.004 192 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for 3
node3 18.348s 2025-11-19 07:24:09.008 193 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-11-19T07:24:07.608490689Z Next consensus number: 14 Legacy running event hash: 33fa4eed9e61918b97f370933e783679aa33b0b15fbfe087d0be7f6998285ea8de8cacb5dcdf88fbb585e480f2a37d90 Legacy running event mnemonic: leg-tank-crop-solid Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 9d20b01289f03442804f78e3602364c0bf2a195a708842a1e5c58c4e64f9f5b505720a29fe8bc08beadcfdd73a1a1400 (root) PlatformTestingToolState / foster-worry-search-marriage 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 brush-topic-town-benefit 1 SingletonNode RosterService.ROSTER_STATE /1 win-shrimp-key-daughter 2 VirtualMap RosterService.ROSTERS /2 easy-improve-raven-vacant 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 chimney-custom-narrow-palm 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node2 18.356s 2025-11-19 07:24:09.016 194 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/2/2025/11/19/2025-11-19T07+24+06.311851947Z_seq0_minr1_maxr501_orgn0.pces
node2 18.356s 2025-11-19 07:24:09.016 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/2/2025/11/19/2025-11-19T07+24+06.311851947Z_seq0_minr1_maxr501_orgn0.pces
node2 18.357s 2025-11-19 07:24:09.017 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node2 18.358s 2025-11-19 07:24:09.018 197 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node2 18.363s 2025-11-19 07:24:09.023 198 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/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 18.386s 2025-11-19 07:24:09.046 194 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/3/2025/11/19/2025-11-19T07+24+06.393397776Z_seq0_minr1_maxr501_orgn0.pces
node3 18.387s 2025-11-19 07:24:09.047 195 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus event file meeting specified criteria to copy.
Lower bound: 1 File: data/saved/preconsensus-events/3/2025/11/19/2025-11-19T07+24+06.393397776Z_seq0_minr1_maxr501_orgn0.pces
node3 18.387s 2025-11-19 07:24:09.047 196 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node3 18.388s 2025-11-19 07:24:09.048 197 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node3 18.394s 2025-11-19 07:24:09.054 198 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Finished writing state for round 3 to disk. Reason: FIRST_ROUND_AFTER_GENESIS, directory: /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/com.swirlds.demo.platform.PlatformTestingToolMain/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 18.473s 2025-11-19 07:24:09.133 189 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Successfully created a snapshot on demand in /opt/hgcapp/services-hedera/HapiApp2.0/data/saved/swirlds-tmp/2 for 3
node0 18.477s 2025-11-19 07:24:09.137 190 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> SignedStateFileWriter: Information for state written to disk:
Round: 3 Timestamp: 2025-11-19T07:24:07.608490689Z Next consensus number: 14 Legacy running event hash: 33fa4eed9e61918b97f370933e783679aa33b0b15fbfe087d0be7f6998285ea8de8cacb5dcdf88fbb585e480f2a37d90 Legacy running event mnemonic: leg-tank-crop-solid Rounds non-ancient: 26 Creation version: SemanticVersion[major=1, minor=0, patch=0, pre=, build=] Minimum judge hash code: 2044907021 Root hash: 9d20b01289f03442804f78e3602364c0bf2a195a708842a1e5c58c4e64f9f5b505720a29fe8bc08beadcfdd73a1a1400 (root) PlatformTestingToolState / foster-worry-search-marriage 0 SingletonNode PlatformStateService.PLATFORM_STATE /0 brush-topic-town-benefit 1 SingletonNode RosterService.ROSTER_STATE /1 win-shrimp-key-daughter 2 VirtualMap RosterService.ROSTERS /2 easy-improve-raven-vacant 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 chimney-custom-narrow-palm 10 null /10 bid-belt-culture-decorate 11 null /11 bid-belt-culture-decorate 12 QuorumResult /12 globe-math-mass-loop
node0 18.518s 2025-11-19 07:24:09.178 191 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Found 1 preconsensus file on disk.
File: data/saved/preconsensus-events/0/2025/11/19/2025-11-19T07+24+06.265144886Z_seq0_minr1_maxr501_orgn0.pces
node0 18.518s 2025-11-19 07:24:09.178 192 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/11/19/2025-11-19T07+24+06.265144886Z_seq0_minr1_maxr501_orgn0.pces
node0 18.519s 2025-11-19 07:24:09.179 193 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Copying 1 preconsensus event file(s)
node0 18.520s 2025-11-19 07:24:09.180 194 INFO STATE_TO_DISK <<scheduler StateSnapshotManager>> BestEffortPcesFileCopy: Finished copying 1 preconsensus event file(s)
node0 18.526s 2025-11-19 07:24:09.186 195 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]
node0 18.686s 2025-11-19 07:24:09.346 196 INFO PLATFORM_STATUS <platformForkJoinThread-1> StatusStateMachine: Platform spent 1.8 s in CHECKING. Now in ACTIVE
node0 18.687s 2025-11-19 07:24:09.347 197 INFO STARTUP <platformForkJoinThread-1> PlatformTestingToolMain: Platform Status Change ACTIVE
node0 18.706s 2025-11-19 07:24:09.366 198 TRACE STARTUP <<app: appMain 0>> PttTransactionPool: Signed Message { signatureType = 'ED25519', publicKey = '0xF8D0D62E81106A43B40749FA121E82EBAA4B7F815D3C6711BE7A1D07236CAE04', privateKey ='0xF8D0D62E81106A43B40749FA121E82EBAA4B7F815D3C6711BE7A1D07236CAE04', signature = '0x740921C71CDCB15CC0AD979AEC784CE857B8EA5EEBC813DB5E475F4F254E7E131841EC341A0C9C6F572E70527EFD4485AAE31B83DA7B7C754B1A9AB6E2C58605',message = '0x1A680A16180120A18D0628914E30914E40F9E7DDB8ACBDE6D1302A4E000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000' }
node1 23.320s 2025-11-19 07:24:13.980 279 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 24.048s 2025-11-19 07:24:14.708 279 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 24.199s 2025-11-19 07:24:14.859 279 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node1 24.790s 2025-11-19 07:24:15.450 300 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 25.043s 2025-11-19 07:24:15.703 299 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 25.726s 2025-11-19 07:24:16.386 300 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node3 25.825s 2025-11-19 07:24:16.485 304 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 26.619s 2025-11-19 07:24:17.279 320 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node1 56.744s 2025-11-19 07:24:47.404 781 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 57.634s 2025-11-19 07:24:48.294 801 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 57.940s 2025-11-19 07:24:48.600 801 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 59.135s 2025-11-19 07:24:49.795 821 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 1m 20.844s 2025-11-19 07:25:11.504 1162 INFO DEMO_INFO <<app: appMain 3>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node3 1m 20.846s 2025-11-19 07:25:11.506 1163 INFO DEMO_INFO <<app: appMain 3>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node3 1m 20.848s 2025-11-19 07:25:11.508 1164 INFO DEMO_INFO <<app: appMain 3>> FCMTransactionPool: node3 submits a transaction SAVE_EXPECTED_MAP
node1 1m 21.100s 2025-11-19 07:25:11.760 1162 INFO DEMO_INFO <<app: appMain 1>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node1 1m 21.153s 2025-11-19 07:25:11.813 1163 INFO DEMO_INFO <<app: appMain 1>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node1 1m 21.155s 2025-11-19 07:25:11.815 1164 INFO DEMO_INFO <<app: appMain 1>> FCMTransactionPool: node1 submits a transaction SAVE_EXPECTED_MAP
node2 1m 21.227s 2025-11-19 07:25:11.887 1162 INFO DEMO_INFO <<app: appMain 2>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node2 1m 21.229s 2025-11-19 07:25:11.889 1163 INFO DEMO_INFO <<app: appMain 2>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node2 1m 21.230s 2025-11-19 07:25:11.890 1164 INFO DEMO_INFO <<app: appMain 2>> FCMTransactionPool: node2 submits a transaction SAVE_EXPECTED_MAP
node1 1m 22.104s 2025-11-19 07:25:12.764 1185 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node2 1m 22.133s 2025-11-19 07:25:12.793 1185 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node0 1m 22.178s 2025-11-19 07:25:12.838 1182 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node3 1m 22.186s 2025-11-19 07:25:12.846 1185 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 3
node0 1m 22.502s 2025-11-19 07:25:13.162 1183 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type TYPE_FCM_CREATE
node1 1m 22.533s 2025-11-19 07:25:13.193 1186 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node1 1m 22.536s 2025-11-19 07:25:13.196 1187 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node0 1m 22.553s 2025-11-19 07:25:13.213 1184 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: Generated enough FCM transaction for type SAVE_EXPECTED_MAP
node0 1m 22.554s 2025-11-19 07:25:13.214 1185 INFO DEMO_INFO <<app: appMain 0>> FCMTransactionPool: node0 submits a transaction SAVE_EXPECTED_MAP
node0 1m 22.612s 2025-11-19 07:25:13.272 1186 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node0 1m 22.615s 2025-11-19 07:25:13.275 1187 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node3 1m 22.624s 2025-11-19 07:25:13.284 1186 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node3 1m 22.627s 2025-11-19 07:25:13.287 1187 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node2 1m 22.633s 2025-11-19 07:25:13.293 1186 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 1
node2 1m 22.636s 2025-11-19 07:25:13.296 1187 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Received SAVE_EXPECTED_MAP transaction from node 2
node1 1m 23.840s 2025-11-19 07:25:14.500 1208 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1763537113492_492877534.json.gz
node2 1m 23.895s 2025-11-19 07:25:14.555 1208 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1763537113492_492877534.json.gz
node3 1m 23.914s 2025-11-19 07:25:14.574 1208 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1763537113492_492877534.json.gz
node0 1m 23.923s 2025-11-19 07:25:14.583 1208 INFO SAVE_EXPECTED_MAP <<scheduler TransactionHandler>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1763537113492_492877534.json.gz
node1 1m 24.139s 2025-11-19 07:25:14.799 1209 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node2 1m 24.197s 2025-11-19 07:25:14.857 1209 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node0 1m 24.238s 2025-11-19 07:25:14.898 1209 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node3 1m 24.238s 2025-11-19 07:25:14.898 1209 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: handling SAVE_EXPECTED_MAP
node1 1m 29.233s 2025-11-19 07:25:19.893 1290 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 1m 29.615s 2025-11-19 07:25:20.275 1294 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node3 1m 30.445s 2025-11-19 07:25:21.105 1310 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node1 1m 30.898s 2025-11-19 07:25:21.558 1315 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 1m 30.994s 2025-11-19 07:25:21.654 1314 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_CREATE transactions
node2 1m 31.128s 2025-11-19 07:25:21.788 1315 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node3 1m 32.060s 2025-11-19 07:25:22.720 1331 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node0 1m 32.760s 2025-11-19 07:25:23.420 1351 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_DELETE transactions
node2 1m 55.361s 2025-11-19 07:25:46.021 1692 WARN SOCKET_EXCEPTIONS <<peer_sync_server #1>> InboundConnectionHandler: Inbound connection from /167.94.146.63 to 2 had IOException: Caused by exception: SSLPeerUnverifiedException Message: peer not authenticated
node1 2m 2.517s 2025-11-19 07:25:53.177 1796 INFO DEMO_INFO <<app: appMain 1>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node1 2m 2.518s 2025-11-19 07:25:53.178 1797 INFO DEMO_INFO <<app: appMain 1>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node1 2m 2.519s 2025-11-19 07:25:53.179 1798 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Stop generating transactions
node1 2m 2.522s 2025-11-19 07:25:53.182 1799 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: node 1 sent ENTER_VALIDATION Message
node1 2m 2.523s 2025-11-19 07:25:53.183 1800 INFO DEMO_INFO <<app: appMain 1>> PlatformTestingToolMain: Node 1 finished generating all transactions.
node2 2m 3.787s 2025-11-19 07:25:54.447 1817 INFO DEMO_INFO <<app: appMain 2>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node2 2m 3.788s 2025-11-19 07:25:54.448 1818 INFO DEMO_INFO <<app: appMain 2>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node2 2m 3.791s 2025-11-19 07:25:54.451 1819 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Stop generating transactions
node2 2m 3.792s 2025-11-19 07:25:54.452 1820 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: node 2 sent ENTER_VALIDATION Message
node2 2m 3.792s 2025-11-19 07:25:54.452 1821 INFO DEMO_INFO <<app: appMain 2>> PlatformTestingToolMain: Node 2 finished generating all transactions.
node0 2m 3.984s 2025-11-19 07:25:54.644 1832 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:53.414047198Z ]
node0 2m 3.986s 2025-11-19 07:25:54.646 1833 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-11-19T07:25:53.414047198Z,type=ENTER_VALIDATION]
node2 2m 4.003s 2025-11-19 07:25:54.663 1838 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:53.414047198Z ]
node2 2m 4.003s 2025-11-19 07:25:54.663 1839 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-11-19T07:25:53.414047198Z,type=ENTER_VALIDATION]
node1 2m 4.043s 2025-11-19 07:25:54.703 1837 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:53.414047198Z ]
node1 2m 4.044s 2025-11-19 07:25:54.704 1838 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-11-19T07:25:53.414047198Z,type=ENTER_VALIDATION]
node3 2m 4.046s 2025-11-19 07:25:54.706 1832 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:53.414047198Z ]
node3 2m 4.047s 2025-11-19 07:25:54.707 1833 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-11-19T07:25:53.414047198Z,type=ENTER_VALIDATION]
node3 2m 4.340s 2025-11-19 07:25:55.000 1834 INFO DEMO_INFO <<app: appMain 3>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node3 2m 4.343s 2025-11-19 07:25:55.003 1835 INFO DEMO_INFO <<app: appMain 3>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node3 2m 4.344s 2025-11-19 07:25:55.004 1836 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Stop generating transactions
node3 2m 4.344s 2025-11-19 07:25:55.004 1837 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: node 3 sent ENTER_VALIDATION Message
node3 2m 4.344s 2025-11-19 07:25:55.004 1838 INFO DEMO_INFO <<app: appMain 3>> PlatformTestingToolMain: Node 3 finished generating all transactions.
node0 2m 5.034s 2025-11-19 07:25:55.694 1838 INFO DEMO_INFO <<app: appMain 0>> SequentialTransactionRequestSupplier: Finished generating TYPE_VIRTUAL_MERKLE_UPDATE transactions
node0 2m 5.039s 2025-11-19 07:25:55.699 1839 INFO DEMO_INFO <<app: appMain 0>> PttTransactionPool: Generated enough virtual merkle test for sequential mode
node0 2m 5.039s 2025-11-19 07:25:55.699 1840 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Stop generating transactions
node0 2m 5.040s 2025-11-19 07:25:55.700 1841 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: node 0 sent ENTER_VALIDATION Message
node0 2m 5.040s 2025-11-19 07:25:55.700 1842 INFO DEMO_INFO <<app: appMain 0>> PlatformTestingToolMain: Node 0 finished generating all transactions.
node0 2m 5.292s 2025-11-19 07:25:55.952 1843 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:54.692618Z ]
node0 2m 5.292s 2025-11-19 07:25:55.952 1844 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-11-19T07:25:54.692618Z,type=ENTER_VALIDATION]
node2 2m 5.313s 2025-11-19 07:25:55.973 1860 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:54.692618Z ]
node2 2m 5.314s 2025-11-19 07:25:55.974 1861 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-11-19T07:25:54.692618Z,type=ENTER_VALIDATION]
node1 2m 5.343s 2025-11-19 07:25:56.003 1859 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:54.692618Z ]
node1 2m 5.344s 2025-11-19 07:25:56.004 1860 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-11-19T07:25:54.692618Z,type=ENTER_VALIDATION]
node3 2m 5.355s 2025-11-19 07:25:56.015 1859 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:54.692618Z ]
node3 2m 5.355s 2025-11-19 07:25:56.015 1860 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-11-19T07:25:54.692618Z,type=ENTER_VALIDATION]
node0 2m 5.721s 2025-11-19 07:25:56.381 1861 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:55.241739910Z ]
node0 2m 5.722s 2025-11-19 07:25:56.382 1862 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-11-19T07:25:55.241739910Z,type=ENTER_VALIDATION]
node2 2m 5.742s 2025-11-19 07:25:56.402 1862 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:55.241739910Z ]
node2 2m 5.743s 2025-11-19 07:25:56.403 1863 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-11-19T07:25:55.241739910Z,type=ENTER_VALIDATION]
node1 2m 5.783s 2025-11-19 07:25:56.443 1861 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:55.241739910Z ]
node1 2m 5.783s 2025-11-19 07:25:56.443 1862 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-11-19T07:25:55.241739910Z,type=ENTER_VALIDATION]
node3 2m 5.784s 2025-11-19 07:25:56.444 1861 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:55.241739910Z ]
node3 2m 5.784s 2025-11-19 07:25:56.444 1862 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-11-19T07:25:55.241739910Z,type=ENTER_VALIDATION]
node0 2m 6.151s 2025-11-19 07:25:56.811 1863 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:55.825818Z ]
node0 2m 6.152s 2025-11-19 07:25:56.812 1864 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-11-19T07:25:55.825818Z,type=ENTER_VALIDATION]
node0 2m 6.153s 2025-11-19 07:25:56.813 1865 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-11-19T07:25:55.825818Z ]
node0 2m 6.156s 2025-11-19 07:25:56.816 1868 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0000_ExpectedMap_1763537155825_825818000.json, consensusTime = 2025-11-19T07:25:55.825818Z ]
node2 2m 6.183s 2025-11-19 07:25:56.843 1864 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:55.825818Z ]
node2 2m 6.183s 2025-11-19 07:25:56.843 1865 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-11-19T07:25:55.825818Z,type=ENTER_VALIDATION]
node0 2m 6.185s 2025-11-19 07:25:56.845 1871 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 0>> SaveExpectedMapHandler: Serializing ExpectedMap Node0000_ExpectedMap_1763537155825_825818000.json.gz
node2 2m 6.185s 2025-11-19 07:25:56.845 1866 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-11-19T07:25:55.825818Z ]
node2 2m 6.187s 2025-11-19 07:25:56.847 1868 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0002_ExpectedMap_1763537155825_825818000.json, consensusTime = 2025-11-19T07:25:55.825818Z ]
node2 2m 6.210s 2025-11-19 07:25:56.870 1872 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 2>> SaveExpectedMapHandler: Serializing ExpectedMap Node0002_ExpectedMap_1763537155825_825818000.json.gz
node1 2m 6.213s 2025-11-19 07:25:56.873 1863 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:55.825818Z ]
node1 2m 6.213s 2025-11-19 07:25:56.873 1864 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-11-19T07:25:55.825818Z,type=ENTER_VALIDATION]
node1 2m 6.214s 2025-11-19 07:25:56.874 1865 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-11-19T07:25:55.825818Z ]
node1 2m 6.216s 2025-11-19 07:25:56.876 1868 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0001_ExpectedMap_1763537155825_825818000.json, consensusTime = 2025-11-19T07:25:55.825818Z ]
node3 2m 6.226s 2025-11-19 07:25:56.886 1863 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = ENTER_VALIDATION, consensusTimestamp = 2025-11-19T07:25:55.825818Z ]
node3 2m 6.227s 2025-11-19 07:25:56.887 1864 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-11-19T07:25:55.825818Z,type=ENTER_VALIDATION]
node3 2m 6.229s 2025-11-19 07:25:56.889 1865 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 0, type = ENTER_VALIDATION, consensusTime = 2025-11-19T07:25:55.825818Z ]
node3 2m 6.232s 2025-11-19 07:25:56.892 1867 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Achieved Quorum on ENTER_VALIDATION transaction [ expectedMapFile = Node0003_ExpectedMap_1763537155825_825818000.json, consensusTime = 2025-11-19T07:25:55.825818Z ]
node1 2m 6.237s 2025-11-19 07:25:56.897 1871 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 1>> SaveExpectedMapHandler: Serializing ExpectedMap Node0001_ExpectedMap_1763537155825_825818000.json.gz
node3 2m 6.264s 2025-11-19 07:25:56.924 1871 INFO SAVE_EXPECTED_MAP <<PTT: enter-validator 3>> SaveExpectedMapHandler: Serializing ExpectedMap Node0003_ExpectedMap_1763537155825_825818000.json.gz
node0 2m 6.518s 2025-11-19 07:25:57.178 1872 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0000_ExpectedMap_1763537155825_825818000.json, consensusTime = 2025-11-19T07:25:55.825818Z ]
node0 2m 6.519s 2025-11-19 07:25:57.179 1873 INFO DEMO_QUORUM <<PTT: enter-validator 0>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-11-19T07:25:55.825818Z ]
node2 2m 6.521s 2025-11-19 07:25:57.181 1873 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0002_ExpectedMap_1763537155825_825818000.json, consensusTime = 2025-11-19T07:25:55.825818Z ]
node2 2m 6.521s 2025-11-19 07:25:57.181 1874 INFO DEMO_QUORUM <<PTT: enter-validator 2>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-11-19T07:25:55.825818Z ]
node1 2m 6.545s 2025-11-19 07:25:57.205 1888 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0001_ExpectedMap_1763537155825_825818000.json, consensusTime = 2025-11-19T07:25:55.825818Z ]
node1 2m 6.545s 2025-11-19 07:25:57.205 1889 INFO DEMO_QUORUM <<PTT: enter-validator 1>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-11-19T07:25:55.825818Z ]
node3 2m 6.598s 2025-11-19 07:25:57.258 1888 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Successfully wrote expected map to file [ expectedMapFile = Node0003_ExpectedMap_1763537155825_825818000.json, consensusTime = 2025-11-19T07:25:55.825818Z ]
node3 2m 6.599s 2025-11-19 07:25:57.259 1889 INFO DEMO_QUORUM <<PTT: enter-validator 3>> PlatformTestingToolMain: Sent EXIT_VALIDATION transaction [ consensusTime = 2025-11-19T07:25:55.825818Z ]
node1 2m 7.952s 2025-11-19 07:25:58.612 1910 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.328270Z ]
node1 2m 7.952s 2025-11-19 07:25:58.612 1911 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-11-19T07:25:57.328270Z,type=EXIT_VALIDATION]
node1 2m 7.952s 2025-11-19 07:25:58.612 1912 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.388936Z ]
node1 2m 7.952s 2025-11-19 07:25:58.612 1913 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-11-19T07:25:57.388936Z,type=EXIT_VALIDATION]
node1 2m 7.953s 2025-11-19 07:25:58.613 1914 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.418531761Z ]
node1 2m 7.953s 2025-11-19 07:25:58.613 1915 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-11-19T07:25:57.418531761Z,type=EXIT_VALIDATION]
node1 2m 7.953s 2025-11-19 07:25:58.613 1916 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.516086482Z ]
node1 2m 7.953s 2025-11-19 07:25:58.613 1917 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-11-19T07:25:57.516086482Z,type=EXIT_VALIDATION]
node1 2m 7.953s 2025-11-19 07:25:58.613 1918 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = EXIT_VALIDATION, consensusTime = 2025-11-19T07:25:57.516086482Z ]
node1 2m 7.954s 2025-11-19 07:25:58.614 1919 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-11-19T07:25:57.516086482Z ]
node1 2m 7.954s 2025-11-19 07:25:58.614 1920 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-11-19T07:25:57.516086482Z ]
node1 2m 7.956s 2025-11-19 07:25:58.616 1921 INFO DEMO_INFO <<PTT: exit-validator 1>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-11-19T07:25:57.516086482Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node2 2m 7.972s 2025-11-19 07:25:58.632 1911 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.328270Z ]
node2 2m 7.972s 2025-11-19 07:25:58.632 1912 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-11-19T07:25:57.328270Z,type=EXIT_VALIDATION]
node2 2m 7.973s 2025-11-19 07:25:58.633 1913 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.388936Z ]
node2 2m 7.973s 2025-11-19 07:25:58.633 1914 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-11-19T07:25:57.388936Z,type=EXIT_VALIDATION]
node2 2m 7.973s 2025-11-19 07:25:58.633 1915 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.418531761Z ]
node2 2m 7.973s 2025-11-19 07:25:58.633 1916 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-11-19T07:25:57.418531761Z,type=EXIT_VALIDATION]
node2 2m 7.974s 2025-11-19 07:25:58.634 1917 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.516086482Z ]
node2 2m 7.974s 2025-11-19 07:25:58.634 1918 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-11-19T07:25:57.516086482Z,type=EXIT_VALIDATION]
node2 2m 7.974s 2025-11-19 07:25:58.634 1919 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = EXIT_VALIDATION, consensusTime = 2025-11-19T07:25:57.516086482Z ]
node2 2m 7.975s 2025-11-19 07:25:58.635 1920 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-11-19T07:25:57.516086482Z ]
node2 2m 7.975s 2025-11-19 07:25:58.635 1921 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-11-19T07:25:57.516086482Z ]
node2 2m 7.978s 2025-11-19 07:25:58.638 1922 INFO DEMO_INFO <<PTT: exit-validator 2>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-11-19T07:25:57.516086482Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node0 2m 7.980s 2025-11-19 07:25:58.640 1910 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.328270Z ]
node0 2m 7.981s 2025-11-19 07:25:58.641 1911 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-11-19T07:25:57.328270Z,type=EXIT_VALIDATION]
node0 2m 7.981s 2025-11-19 07:25:58.641 1912 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.388936Z ]
node0 2m 7.982s 2025-11-19 07:25:58.642 1913 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-11-19T07:25:57.388936Z,type=EXIT_VALIDATION]
node0 2m 7.982s 2025-11-19 07:25:58.642 1914 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.418531761Z ]
node0 2m 7.982s 2025-11-19 07:25:58.642 1915 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-11-19T07:25:57.418531761Z,type=EXIT_VALIDATION]
node0 2m 7.982s 2025-11-19 07:25:58.642 1916 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.516086482Z ]
node0 2m 7.982s 2025-11-19 07:25:58.642 1917 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-11-19T07:25:57.516086482Z,type=EXIT_VALIDATION]
node0 2m 7.982s 2025-11-19 07:25:58.642 1918 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = EXIT_VALIDATION, consensusTime = 2025-11-19T07:25:57.516086482Z ]
node0 2m 7.983s 2025-11-19 07:25:58.643 1919 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-11-19T07:25:57.516086482Z ]
node0 2m 7.985s 2025-11-19 07:25:58.645 1920 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Sending Freeze Transaction...
node0 2m 7.986s 2025-11-19 07:25:58.646 1921 INFO DEMO_INFO <<PTT: exit-validator 0>> TransactionSubmitter: Finished Sending Freeze Transaction.
node0 2m 7.986s 2025-11-19 07:25:58.646 1922 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-11-19T07:25:57.516086482Z ]
node0 2m 7.990s 2025-11-19 07:25:58.650 1923 INFO DEMO_INFO <<PTT: exit-validator 0>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-11-19T07:25:57.516086482Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node3 2m 8.024s 2025-11-19 07:25:58.684 1910 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 2, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.328270Z ]
node3 2m 8.025s 2025-11-19 07:25:58.685 1911 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 2 apply state ControlAction[timestamp=2025-11-19T07:25:57.328270Z,type=EXIT_VALIDATION]
node3 2m 8.026s 2025-11-19 07:25:58.686 1912 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 0, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.388936Z ]
node3 2m 8.026s 2025-11-19 07:25:58.686 1913 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 0 apply state ControlAction[timestamp=2025-11-19T07:25:57.388936Z,type=EXIT_VALIDATION]
node3 2m 8.026s 2025-11-19 07:25:58.686 1914 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 1, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.418531761Z ]
node3 2m 8.026s 2025-11-19 07:25:58.686 1915 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 1 apply state ControlAction[timestamp=2025-11-19T07:25:57.418531761Z,type=EXIT_VALIDATION]
node3 2m 8.027s 2025-11-19 07:25:58.687 1916 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolState: Handling Control Transaction [ originatingNodeId = 3, type = EXIT_VALIDATION, consensusTimestamp = 2025-11-19T07:25:57.516086482Z ]
node3 2m 8.027s 2025-11-19 07:25:58.687 1917 INFO DEMO_INFO <<scheduler TransactionHandler>> QuorumTriggeredAction: Node 3 apply state ControlAction[timestamp=2025-11-19T07:25:57.516086482Z,type=EXIT_VALIDATION]
node3 2m 8.027s 2025-11-19 07:25:58.687 1918 INFO DEMO_INFO <<scheduler TransactionHandler>> PlatformTestingToolMain: Handling Quorum Transition [ triggeringNodeId = 3, type = EXIT_VALIDATION, consensusTime = 2025-11-19T07:25:57.516086482Z ]
node3 2m 8.028s 2025-11-19 07:25:58.688 1919 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Achieved Quorum on EXIT_VALIDATION transaction [ consensusTime = 2025-11-19T07:25:57.516086482Z ]
node3 2m 8.029s 2025-11-19 07:25:58.689 1920 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Preparing to terminate the JVM [ sleepAfterTestMs = 90000, consensusTime = 2025-11-19T07:25:57.516086482Z ]
node3 2m 8.032s 2025-11-19 07:25:58.692 1921 INFO DEMO_INFO <<PTT: exit-validator 3>> PlatformTestingToolMain: Test success: Reached quorum on the EXIT_VALIDATION transaction, consensus time = 2025-11-19T07:25:57.516086482Z {} [com.swirlds.logging.legacy.payload.ApplicationFinishedPayload]
node1 2m 9.270s 2025-11-19 07:25:59.930 1942 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1763537218
node2 2m 9.290s 2025-11-19 07:25:59.950 1943 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1763537218
node0 2m 9.332s 2025-11-19 07:25:59.992 1944 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1763537218
node3 2m 9.343s 2025-11-19 07:26:00.003 1942 DEBUG FREEZE <<scheduler TransactionHandler>> FreezeTransactionHandler: Handling FreezeTransaction: startTimeEpochSecond: 1763537218
node2 2m 55.514s 2025-11-19 07:26:46.174 2565 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith3 2 to 3>> NetworkUtils: Connection broken: 2 -> 3
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.170098292Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:387) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node2 2m 55.514s 2025-11-19 07:26:46.174 2564 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith0 2 to 0>> NetworkUtils: Connection broken: 2 <- 0
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.170121601Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:387) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node2 2m 55.571s 2025-11-19 07:26:46.231 2566 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith1 2 to 1>> NetworkUtils: Connection broken: 2 <- 1
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.226764916Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:387) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node0 2m 55.586s 2025-11-19 07:26:46.246 2585 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith2 0 to 2>> NetworkUtils: Connection broken: 0 -> 2
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.241846819Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has been closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has been closed at java.base/sun.security.ssl.SSLSocketOutputRecord.deliver(SSLSocketOutputRecord.java:291) at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1304) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:387) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node3 2m 55.595s 2025-11-19 07:26:46.255 2567 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith2 3 to 2>> NetworkUtils: Connection broken: 3 <- 2
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.250549706Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has been closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has been closed at java.base/sun.security.ssl.SSLSocketOutputRecord.deliver(SSLSocketOutputRecord.java:291) at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1304) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:387) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node1 2m 55.641s 2025-11-19 07:26:46.301 2583 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith2 1 to 2>> NetworkUtils: Connection broken: 1 -> 2
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.298001064Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node3 2m 55.844s 2025-11-19 07:26:46.504 2568 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith1 3 to 1>> NetworkUtils: Connection broken: 3 <- 1
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.503850658Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:387) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node1 2m 55.920s 2025-11-19 07:26:46.580 2584 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith3 1 to 3>> NetworkUtils: Connection broken: 1 -> 3
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.579794557Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:387) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node3 2m 55.922s 2025-11-19 07:26:46.582 2569 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith0 3 to 0>> NetworkUtils: Connection broken: 3 <- 0
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.580092942Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:387) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node0 2m 55.995s 2025-11-19 07:26:46.655 2586 WARN SOCKET_EXCEPTIONS <<platform-core: SyncProtocolWith3 0 to 3>> NetworkUtils: Connection broken: 0 -> 3
com.swirlds.common.threading.pool.ParallelExecutionException: Time thrown: 2025-11-19T07:26:46.650936585Z at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:160) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.runProtocol(RpcPeerProtocol.java:293) at com.swirlds.platform.network.communication.states.ProtocolNegotiated.transition(ProtocolNegotiated.java:47) at com.swirlds.platform.network.communication.Negotiator.execute(Negotiator.java:79) at com.swirlds.platform.network.communication.ProtocolNegotiatorThread.run(ProtocolNegotiatorThread.java:65) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.doWork(StoppableThreadImpl.java:599) at com.swirlds.common.threading.framework.internal.StoppableThreadImpl.run(StoppableThreadImpl.java:200) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.base/java.lang.Thread.run(Thread.java:1583) Suppressed: java.util.concurrent.ExecutionException: java.net.SocketException: Connection or outbound has closed at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketException: Connection or outbound has closed at java.base/sun.security.ssl.SSLSocketImpl$AppOutputStream.write(SSLSocketImpl.java:1297) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.write(AbstractStreamExtension.java:115) at com.swirlds.common.io.extendable.ExtendableOutputStream.write(ExtendableOutputStream.java:64) at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) at java.base/java.io.DataOutputStream.flush(DataOutputStream.java:131) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.writeMessages(RpcPeerProtocol.java:387) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$2(RpcPeerProtocol.java:297) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more Caused by: java.util.concurrent.ExecutionException: java.net.SocketTimeoutException: Read timed out at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:191) at com.swirlds.common.threading.pool.CachedPoolParallelExecutor.doParallelWithHandler(CachedPoolParallelExecutor.java:154) ... 8 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:278) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:304) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:346) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:796) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:1099) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:489) at java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInputRecord.java:483) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:70) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1461) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1066) at com.swirlds.common.io.extendable.extensions.AbstractStreamExtension.read(AbstractStreamExtension.java:73) at com.swirlds.common.io.extendable.ExtendableInputStream.read(ExtendableInputStream.java:63) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:291) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:347) at java.base/java.io.BufferedInputStream.implRead(BufferedInputStream.java:420) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:399) at java.base/java.io.DataInputStream.readFully(DataInputStream.java:208) at java.base/java.io.DataInputStream.readShort(DataInputStream.java:319) at org.hiero.base.io.streams.AugmentedDataInputStream.readShort(AugmentedDataInputStream.java:158) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.readMessages(RpcPeerProtocol.java:431) at com.swirlds.platform.network.protocol.rpc.RpcPeerProtocol.lambda$runProtocol$1(RpcPeerProtocol.java:296) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:24) at org.hiero.base.concurrent.ThrowingRunnable.call(ThrowingRunnable.java:9) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ... 2 more
node2 3.005m 2025-11-19 07:26:50.987 2567 INFO PLATFORM_STATUS <platformForkJoinThread-3> StatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node2 3.005m 2025-11-19 07:26:50.988 2568 INFO STARTUP <platformForkJoinThread-3> PlatformTestingToolMain: Platform Status Change CHECKING
node1 3.011m 2025-11-19 07:26:51.327 2585 INFO PLATFORM_STATUS <platformForkJoinThread-2> StatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node1 3.011m 2025-11-19 07:26:51.329 2586 INFO STARTUP <platformForkJoinThread-2> PlatformTestingToolMain: Platform Status Change CHECKING
node3 3.012m 2025-11-19 07:26:51.389 2570 INFO PLATFORM_STATUS <platformForkJoinThread-7> StatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node3 3.012m 2025-11-19 07:26:51.390 2571 INFO STARTUP <platformForkJoinThread-7> PlatformTestingToolMain: Platform Status Change CHECKING
node0 3.013m 2025-11-19 07:26:51.426 2587 INFO PLATFORM_STATUS <platformForkJoinThread-4> StatusStateMachine: Platform spent 2.7 m in ACTIVE. Now in CHECKING
node0 3.013m 2025-11-19 07:26:51.426 2588 INFO STARTUP <platformForkJoinThread-4> PlatformTestingToolMain: Platform Status Change CHECKING
node1 3m 37.957s 2025-11-19 07:27:28.617 2587 INFO DEMO_QUORUM <<PTT: exit-validator 1>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-11-19T07:25:57.516086482Z ]
node1 3m 37.959s 2025-11-19 07:27:28.619 2588 INFO STARTUP <<PTT: exit-validator 1>> SystemExitUtils: System exit requested (NO_ERROR)
thread requesting exit: <PTT: exit-validator 1> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1239) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$22(PlatformTestingToolMain.java:1185) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.lang.Thread.run(Thread.java:1583)
node1 3m 37.960s 2025-11-19 07:27:28.620 2589 INFO STARTUP <<PTT: exit-validator 1>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node1 3m 37.962s 2025-11-19 07:27:28.622 2590 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.
node2 3m 37.978s 2025-11-19 07:27:28.638 2569 INFO DEMO_QUORUM <<PTT: exit-validator 2>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-11-19T07:25:57.516086482Z ]
node2 3m 37.982s 2025-11-19 07:27:28.642 2570 INFO STARTUP <<PTT: exit-validator 2>> SystemExitUtils: System exit requested (NO_ERROR)
thread requesting exit: <PTT: exit-validator 2> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1239) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$22(PlatformTestingToolMain.java:1185) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.lang.Thread.run(Thread.java:1583)
node2 3m 37.984s 2025-11-19 07:27:28.644 2571 INFO STARTUP <<PTT: exit-validator 2>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node2 3m 37.986s 2025-11-19 07:27:28.646 2572 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.
node0 3m 37.991s 2025-11-19 07:27:28.651 2589 INFO DEMO_QUORUM <<PTT: exit-validator 0>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-11-19T07:25:57.516086482Z ]
node0 3m 37.993s 2025-11-19 07:27:28.653 2590 INFO STARTUP <<PTT: exit-validator 0>> SystemExitUtils: System exit requested (NO_ERROR)
thread requesting exit: <PTT: exit-validator 0> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1239) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$22(PlatformTestingToolMain.java:1185) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.lang.Thread.run(Thread.java:1583)
node0 3m 37.995s 2025-11-19 07:27:28.655 2591 INFO STARTUP <<PTT: exit-validator 0>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node0 3m 37.996s 2025-11-19 07:27:28.656 2592 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.
node3 3m 38.032s 2025-11-19 07:27:28.692 2572 INFO DEMO_QUORUM <<PTT: exit-validator 3>> PlatformTestingToolMain: Terminating the JVM [ consensusTime = 2025-11-19T07:25:57.516086482Z ]
node3 3m 38.035s 2025-11-19 07:27:28.695 2573 INFO STARTUP <<PTT: exit-validator 3>> SystemExitUtils: System exit requested (NO_ERROR)
thread requesting exit: <PTT: exit-validator 3> com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:37) at com.swirlds.platform.system.SystemExitUtils.exitSystem(SystemExitUtils.java:73) at com.swirlds.demo.platform.PlatformTestingToolMain.logSuccessMessageAndFinishTest(PlatformTestingToolMain.java:1239) at com.swirlds.demo.platform.PlatformTestingToolMain.lambda$handleExitValidation$22(PlatformTestingToolMain.java:1185) at com.swirlds.common.threading.framework.internal.AbstractThreadConfiguration.lambda$wrapRunnableWithSnapshot$3(AbstractThreadConfiguration.java:654) at java.lang.Thread.run(Thread.java:1583)
node3 3m 38.037s 2025-11-19 07:27:28.697 2574 INFO STARTUP <<PTT: exit-validator 3>> SystemExitUtils: Exiting system {"reason":"NO_ERROR","code":0} [com.swirlds.logging.legacy.payload.SystemExitPayload]
node3 3m 38.038s 2025-11-19 07:27:28.698 2575 INFO STARTUP <<browser: shutdown-hook>> Log4jSetup: JVM is shutting down.