Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo): time 0.05921/0.05921, allocations: 9.523 MB / 28.61 MB, free: 464 kB / 18.57 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0008889/0.0008889, allocations: 88.45 kB / 34.65 MB, free: 1.012 MB / 24.77 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 0.9943/0.9943, allocations: 158.6 MB / 199.2 MB, free: 7.254 MB / 186.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001151/0.001151, allocations: 160.6 kB / 254.4 MB, free: 15.95 MB / 250.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.189/0.189, allocations: 59.71 MB / 369.2 MB, free: 12.76 MB / 298.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
Using package OpenIPSL with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Using package Modelica_Synchronous with version 0.93.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo)
Running command: "" <> buildModelFMU(OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_ES_ESAC2A",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_ES_ESAC2A",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.763e-06/1.763e-06, allocations: 0 / 0.5175 GB, free: 11.39 MB / 394.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.67e-05/1.846e-05, allocations: 13.52 kB / 0.5175 GB, free: 11.38 MB / 394.7 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A): time 0.007179/0.007198, allocations: 8.24 MB / 0.5256 GB, free: 3.086 MB / 394.7 MB
Notification: Performance of NFInst.instExpressions: time 0.005231/0.01243, allocations: 2.835 MB / 0.5284 GB, free: 252 kB / 394.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0006723/0.0131, allocations: 19.94 kB / 0.5284 GB, free: 232 kB / 394.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0007876/0.01389, allocations: 364.8 kB / 0.5287 GB, free: 15.86 MB / 410.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.00194/0.01583, allocations: 1.316 MB / 0.53 GB, free: 14.55 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001276/0.0171, allocations: 0.9356 MB / 0.5309 GB, free: 13.62 MB / 410.7 MB
Notification: Performance of NFFlatten.flatten: time 0.002021/0.01913, allocations: 2.817 MB / 0.5337 GB, free: 10.79 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004822/0.01961, allocations: 412.8 kB / 0.5341 GB, free: 10.36 MB / 410.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001183/0.02079, allocations: 1.489 MB / 0.5355 GB, free: 8.867 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0008942/0.02169, allocations: 1.051 MB / 0.5365 GB, free: 7.812 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002519/0.02194, allocations: 240 kB / 0.5368 GB, free: 7.578 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0005236/0.02246, allocations: 447.6 kB / 0.5372 GB, free: 7.141 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003239/0.02278, allocations: 0.572 MB / 0.5378 GB, free: 6.566 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0005295/0.02331, allocations: 0.7594 MB / 0.5385 GB, free: 5.805 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002264/0.02558, allocations: 3.029 MB / 0.5415 GB, free: 2.766 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 6.081e-06/0.02558, allocations: 0 / 0.5415 GB, free: 2.766 MB / 410.7 MB
Notification: Performance of FrontEnd: time 1.382e-06/0.02559, allocations: 3.938 kB / 0.5415 GB, free: 2.762 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 3.219e-05/0.02562, allocations: 4 kB / 0.5415 GB, free: 2.758 MB / 410.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 314
 * Number of variables: 314
Notification: Performance of Generate backend data structure: time 0.007835/0.03345, allocations: 4.481 MB / 0.5458 GB, free: 14.22 MB / 426.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.065e-05/0.0335, allocations: 8.031 kB / 0.5459 GB, free: 14.21 MB / 426.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001958/0.0337, allocations: 189.9 kB / 0.546 GB, free: 14.02 MB / 426.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002267/0.03597, allocations: 0.8143 MB / 0.5468 GB, free: 13.2 MB / 426.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001541/0.03751, allocations: 1.235 MB / 0.548 GB, free: 11.93 MB / 426.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005434/0.03805, allocations: 0.9428 MB / 0.549 GB, free: 10.8 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001936/0.03824, allocations: 140 kB / 0.5491 GB, free: 10.66 MB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002307/0.04055, allocations: 1.827 MB / 0.5509 GB, free: 8.777 MB / 426.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.021e-05/0.04057, allocations: 3.938 kB / 0.5509 GB, free: 8.773 MB / 426.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001038/0.04067, allocations: 52 kB / 0.5509 GB, free: 8.723 MB / 426.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.762e-05/0.04069, allocations: 28 kB / 0.551 GB, free: 8.695 MB / 426.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002287/0.04298, allocations: 1.643 MB / 0.5526 GB, free: 7.039 MB / 426.7 MB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.006345/0.04932, allocations: 4.679 MB / 0.5571 GB, free: 2.277 MB / 426.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.004782/0.05411, allocations: 2.745 MB / 0.5598 GB, free: 15.51 MB / 442.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001303/0.05541, allocations: 0.9997 MB / 0.5608 GB, free: 14.49 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.000231/0.05564, allocations: 57.27 kB / 0.5608 GB, free: 14.44 MB / 442.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001604/0.05724, allocations: 1.301 MB / 0.5621 GB, free: 13.1 MB / 442.7 MB
Notification: Performance of pre-optimization done (n=156): time 3.637e-06/0.05725, allocations: 0 / 0.5621 GB, free: 13.1 MB / 442.7 MB
Notification: Performance of matching and sorting (n=156): time 0.02197/0.07921, allocations: 10.38 MB / 0.5722 GB, free: 2.664 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.267e-05/0.0793, allocations: 175.5 kB / 0.5724 GB, free: 2.457 MB / 442.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001822/0.08112, allocations: 1.622 MB / 0.574 GB, free: 0.832 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001742/0.08129, allocations: 57.7 kB / 0.5741 GB, free: 0.7695 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004403/0.08173, allocations: 0.7197 MB / 0.5748 GB, free: 40 kB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.00049/0.08222, allocations: 0.5617 MB / 0.5753 GB, free: 15.47 MB / 458.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005042/0.08273, allocations: 403.9 kB / 0.5757 GB, free: 15.07 MB / 458.7 MB
Notification: Performance of setup shared object (initialization): time 8.914e-05/0.08282, allocations: 305.1 kB / 0.576 GB, free: 14.77 MB / 458.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001641/0.08446, allocations: 1.171 MB / 0.5771 GB, free: 13.58 MB / 458.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001859/0.08632, allocations: 1.414 MB / 0.5785 GB, free: 12.09 MB / 458.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003232/0.08955, allocations: 2.448 MB / 0.5809 GB, free: 9.555 MB / 458.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.518e-06/0.08956, allocations: 4 kB / 0.5809 GB, free: 9.551 MB / 458.7 MB
Notification: Performance of matching and sorting (n=278) (initialization): time 0.009909/0.09947, allocations: 5.969 MB / 0.5867 GB, free: 3.504 MB / 458.7 MB
Notification: Performance of prepare postOptimizeDAE: time 5.292e-05/0.09952, allocations: 41.69 kB / 0.5868 GB, free: 3.457 MB / 458.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.092e-05/0.09953, allocations: 0 / 0.5868 GB, free: 3.457 MB / 458.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005976/0.1055, allocations: 3.499 MB / 0.5902 GB, free: 15.94 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006921/0.1062, allocations: 287.6 kB / 0.5905 GB, free: 15.66 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005167/0.1114, allocations: 3.875 MB / 0.5942 GB, free: 11.74 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001313/0.1127, allocations: 298.5 kB / 0.5945 GB, free: 11.45 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001131/0.1128, allocations: 71.98 kB / 0.5946 GB, free: 11.38 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002015/0.1148, allocations: 1.416 MB / 0.596 GB, free: 9.949 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001687/0.1165, allocations: 1.403 MB / 0.5974 GB, free: 8.473 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003215/0.1197, allocations: 2.428 MB / 0.5997 GB, free: 5.957 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.782e-06/0.1197, allocations: 4 kB / 0.5997 GB, free: 5.953 MB / 474.7 MB
Notification: Performance of matching and sorting (n=278) (initialization_lambda0): time 0.009534/0.1292, allocations: 5.942 MB / 0.6055 GB, free: 15.93 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 3.785e-05/0.1293, allocations: 40.2 kB / 0.6056 GB, free: 15.89 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.215e-06/0.1293, allocations: 4 kB / 0.6056 GB, free: 15.89 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005949/0.1352, allocations: 3.464 MB / 0.609 GB, free: 12.41 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000705/0.1359, allocations: 287.6 kB / 0.6092 GB, free: 12.12 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005209/0.1412, allocations: 3.809 MB / 0.6129 GB, free: 8.27 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001798/0.143, allocations: 266.8 kB / 0.6132 GB, free: 8.008 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001343/0.1431, allocations: 83.92 kB / 0.6133 GB, free: 7.926 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 15
 * Number of states: 0 ()
 * Number of discrete variables: 8 (eSAC2A.rotatingExciterWithDemagnetization.sISO.ReachUpper,eSAC2A.rotatingExciterWithDemagnetization.sISO.ReachLower,eSAC2A.rotatingExciterWithDemagnetization.sISO.Rising,eSAC2A.rotatingExciterWithDemagnetization.sISO.Falling,eSAC2A.rotatingExciterWithDemagnetization.sISO.Reinit,$whenCondition2,$whenCondition1,$whenCondition3)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (170):
 * Single equations (assignments): 169
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(35,69)}
Notification: Performance of prepare postOptimizeDAE: time 0.0005647/0.1437, allocations: 321.3 kB / 0.6136 GB, free: 7.598 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002458/0.1439, allocations: 206.7 kB / 0.6138 GB, free: 7.395 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.009235/0.1531, allocations: 5.426 MB / 0.6191 GB, free: 1.922 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.071e-05/0.1531, allocations: 16 kB / 0.6191 GB, free: 1.906 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.043e-06/0.1532, allocations: 3.938 kB / 0.6191 GB, free: 1.902 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.303e-05/0.1532, allocations: 7.969 kB / 0.6191 GB, free: 1.895 MB / 490.7 MB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.2485/0.4017, allocations: 7.36 MB / 0.6263 GB, free: 101.6 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.468e-06/0.4017, allocations: 0.5469 kB / 0.6263 GB, free: 101.6 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004658/0.4022, allocations: 142.6 kB / 0.6264 GB, free: 101.6 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.00508/0.4073, allocations: 2.594 MB / 0.629 GB, free: 101.1 MB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001269/0.4074, allocations: 44.69 kB / 0.629 GB, free: 101.1 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01661/0.424, allocations: 11 MB / 0.6398 GB, free: 96.02 MB / 490.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.434e-06/0.424, allocations: 0.7656 kB / 0.6398 GB, free: 96.02 MB / 490.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01054/0.4345, allocations: 6.88 MB / 0.6465 GB, free: 93.92 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.000435/0.435, allocations: 240.2 kB / 0.6467 GB, free: 93.78 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000185/0.4352, allocations: 42.28 kB / 0.6467 GB, free: 93.76 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000866/0.436, allocations: 161.5 kB / 0.6469 GB, free: 93.73 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005654/0.4366, allocations: 311 kB / 0.6472 GB, free: 93.66 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.535e-05/0.4367, allocations: 42.2 kB / 0.6472 GB, free: 93.65 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.001007/0.4377, allocations: 1.085 MB / 0.6483 GB, free: 92.68 MB / 490.7 MB
Notification: Performance of sort global known variables: time 3.51e-07/0.4377, allocations: 0 / 0.6483 GB, free: 92.68 MB / 490.7 MB
Notification: Performance of remove unused functions: time 0.001516/0.4392, allocations: 0.9959 MB / 0.6493 GB, free: 91.72 MB / 490.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 14 (gENCLS.omega,eSAC2A.rotatingExciterWithDemagnetization.sISO.w,eSAC2A.derivative.x,eSAC2A.simpleLagLim.state,eSAC2A.imSimpleLag.state,eSAC2A.imLeadLag.TF.x_scaled[1],gENROU.PSIkq,gENROU.PSIkd,gENROU.Epq,gENROU.Epd,gENROU.delta,gENROU.w,gENCLS.eq,gENCLS.delta)
 * Number of discrete variables: 8 ($whenCondition3,$whenCondition1,$whenCondition2,eSAC2A.rotatingExciterWithDemagnetization.sISO.Reinit,eSAC2A.rotatingExciterWithDemagnetization.sISO.Falling,eSAC2A.rotatingExciterWithDemagnetization.sISO.Rising,eSAC2A.rotatingExciterWithDemagnetization.sISO.ReachLower,eSAC2A.rotatingExciterWithDemagnetization.sISO.ReachUpper)
 * Number of discrete states: 5 (eSAC2A.rotatingExciterWithDemagnetization.sISO.Reinit,eSAC2A.rotatingExciterWithDemagnetization.sISO.ReachLower,eSAC2A.rotatingExciterWithDemagnetization.sISO.ReachUpper,eSAC2A.rotatingExciterWithDemagnetization.sISO.Falling,eSAC2A.rotatingExciterWithDemagnetization.sISO.Rising)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (85):
 * Single equations (assignments): 83
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,23), (26,23)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0102/0.4494, allocations: 7.515 MB / 0.6566 GB, free: 84.15 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.008702/0.4581, allocations: 5.473 MB / 0.662 GB, free: 78.63 MB / 490.7 MB
Notification: Performance of simCode: created event and clocks part: time 5.952e-06/0.4581, allocations: 0 / 0.662 GB, free: 78.63 MB / 490.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.00342/0.4615, allocations: 2.146 MB / 0.6641 GB, free: 76.45 MB / 490.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001138/0.4627, allocations: 181.7 kB / 0.6642 GB, free: 76.28 MB / 490.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02559/0.4883, allocations: 20.82 MB / 0.6846 GB, free: 55.09 MB / 490.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004488/0.4887, allocations: 0.77 MB / 0.6853 GB, free: 54.28 MB / 490.7 MB
Notification: Performance of simCode: alias equations: time 0.0004897/0.4892, allocations: 187.7 kB / 0.6855 GB, free: 54.09 MB / 490.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000542/0.4897, allocations: 0.7268 MB / 0.6862 GB, free: 53.37 MB / 490.7 MB
Notification: Performance of SimCode: time 1.463e-06/0.4897, allocations: 0 / 0.6862 GB, free: 53.37 MB / 490.7 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06519/0.5549, allocations: 62.83 MB / 0.7476 GB, free: 6.684 MB / 0.4948 GB
Notification: Performance of buildModelFMU: Generate platform static: time 9.408/9.963, allocations: 7.938 kB / 0.7476 GB, free: 6.676 MB / 0.4948 GB
"
[Timeout remaining time 650]
(rm -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A.sim & python3 -m fmpy simulate  --output-file OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A_res.csv --start-time 0 --stop-time 10 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.004 OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_ES_ESAC2A.fmu > OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.ESAC2A.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 12.691132564097643]
Failed to read output from testmodel.py, exit status != 0:
10.081028712913394 10.089994766 10.062584465
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f9a9ebc8230>