Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR.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.04886/0.04886, allocations: 9.517 MB / 29.38 MB, free: 448 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.0007293/0.0007293, allocations: 87.58 kB / 35.4 MB, free: 0.9922 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.9019/0.9019, allocations: 158.6 MB / 200 MB, free: 7.246 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.001118/0.001118, allocations: 168.5 kB / 255.2 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.1864/0.1864, allocations: 59.72 MB / 370 MB, free: 12.75 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: translateModel(OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR,tolerance=0.001,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR")
translateModel(OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR,tolerance=0.001,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.833e-06/1.833e-06, allocations: 0 / 0.5187 GB, free: 11.11 MB / 394.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.653e-05/2.836e-05, allocations: 2.281 kB / 0.5187 GB, free: 11.11 MB / 394.7 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR): time 0.01107/0.0111, allocations: 16.51 MB / 0.5349 GB, free: 10.51 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01019/0.02128, allocations: 6.166 MB / 0.5409 GB, free: 4.32 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002617/0.0239, allocations: 43.94 kB / 0.5409 GB, free: 4.277 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001857/0.02576, allocations: 0.9682 MB / 0.5419 GB, free: 3.301 MB / 410.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.00498/0.03074, allocations: 2.893 MB / 0.5447 GB, free: 424 kB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003228/0.03397, allocations: 2.283 MB / 0.5469 GB, free: 14.15 MB / 426.7 MB
Notification: Performance of NFFlatten.flatten: time 0.006608/0.04057, allocations: 7.236 MB / 0.554 GB, free: 6.891 MB / 426.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001185/0.04176, allocations: 0.8419 MB / 0.5548 GB, free: 5.992 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004387/0.04615, allocations: 3.854 MB / 0.5586 GB, free: 2.129 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002428/0.04858, allocations: 2.691 MB / 0.5612 GB, free: 15.43 MB / 442.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0007477/0.04932, allocations: 0.6719 MB / 0.5619 GB, free: 14.75 MB / 442.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001023/0.05035, allocations: 0.8903 MB / 0.5627 GB, free: 13.86 MB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0007779/0.05112, allocations: 1.51 MB / 0.5642 GB, free: 12.35 MB / 442.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001363/0.05249, allocations: 1.936 MB / 0.5661 GB, free: 10.41 MB / 442.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.0064/0.05889, allocations: 8.47 MB / 0.5744 GB, free: 1.906 MB / 442.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.15e-06/0.05889, allocations: 0 / 0.5744 GB, free: 1.906 MB / 442.7 MB
Notification: Performance of FrontEnd: time 2.214e-06/0.05889, allocations: 0 / 0.5744 GB, free: 1.906 MB / 442.7 MB
Notification: Performance of Transformations before backend: time 0.0001417/0.05904, allocations: 0 / 0.5744 GB, free: 1.906 MB / 442.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 691
 * Number of variables: 691
Notification: Performance of Generate backend data structure: time 0.02382/0.08286, allocations: 12.54 MB / 0.5866 GB, free: 5.266 MB / 458.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.895e-05/0.08291, allocations: 12.03 kB / 0.5866 GB, free: 5.254 MB / 458.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005819/0.08873, allocations: 1.963 MB / 0.5885 GB, free: 3.289 MB / 458.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004606/0.09333, allocations: 3.295 MB / 0.5917 GB, free: 15.93 MB / 474.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000814/0.09415, allocations: 1.422 MB / 0.5931 GB, free: 14.25 MB / 474.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004251/0.09457, allocations: 327.9 kB / 0.5934 GB, free: 13.93 MB / 474.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005353/0.09993, allocations: 3.949 MB / 0.5973 GB, free: 9.91 MB / 474.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.035e-05/0.09997, allocations: 3.938 kB / 0.5973 GB, free: 9.906 MB / 474.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002339/0.1002, allocations: 112 kB / 0.5974 GB, free: 9.797 MB / 474.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.198e-05/0.1002, allocations: 68 kB / 0.5975 GB, free: 9.73 MB / 474.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00503/0.1053, allocations: 3.773 MB / 0.6012 GB, free: 5.945 MB / 474.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.01509/0.1203, allocations: 11.52 MB / 0.6124 GB, free: 10.24 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.008633/0.129, allocations: 5.291 MB / 0.6176 GB, free: 4.945 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0037/0.1327, allocations: 2.229 MB / 0.6198 GB, free: 2.695 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004013/0.1331, allocations: 82.45 kB / 0.6198 GB, free: 2.613 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.2298/0.3629, allocations: 2.867 MB / 0.6226 GB, free: 96.21 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=331): time 9.648e-06/0.3629, allocations: 0 / 0.6226 GB, free: 96.21 MB / 490.7 MB
Notification: Performance of matching and sorting (n=331): time 0.05922/0.4222, allocations: 25.68 MB / 0.6477 GB, free: 89.29 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.282e-05/0.4222, allocations: 194.1 kB / 0.6479 GB, free: 89.1 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006389/0.4286, allocations: 4.309 MB / 0.6521 GB, free: 85.17 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.001214/0.4298, allocations: 105.7 kB / 0.6522 GB, free: 85.06 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0009607/0.4308, allocations: 1.803 MB / 0.654 GB, free: 83.57 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001839/0.4326, allocations: 1.238 MB / 0.6552 GB, free: 82.51 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001814/0.4344, allocations: 1.027 MB / 0.6562 GB, free: 81.48 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 3.479e-05/0.4345, allocations: 301.9 kB / 0.6565 GB, free: 81.18 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003819/0.4383, allocations: 2.994 MB / 0.6594 GB, free: 78.18 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00429/0.4426, allocations: 3.496 MB / 0.6628 GB, free: 74.59 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008486/0.4511, allocations: 6.067 MB / 0.6687 GB, free: 68.39 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.406e-05/0.4511, allocations: 4 kB / 0.6687 GB, free: 68.39 MB / 490.7 MB
Notification: Performance of matching and sorting (n=719) (initialization): time 0.01467/0.4658, allocations: 9.178 MB / 0.6777 GB, free: 59.14 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 3.725e-05/0.4658, allocations: 10.19 kB / 0.6777 GB, free: 59.14 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.31e-05/0.4659, allocations: 15.83 kB / 0.6777 GB, free: 59.12 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01276/0.4786, allocations: 10.26 MB / 0.6877 GB, free: 48.86 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003373/0.482, allocations: 0.9518 MB / 0.6887 GB, free: 47.91 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009339/0.4913, allocations: 6.277 MB / 0.6948 GB, free: 41.61 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005421/0.4967, allocations: 0.7096 MB / 0.6955 GB, free: 40.99 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005476/0.4973, allocations: 188 kB / 0.6957 GB, free: 40.81 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 27
 * Number of states: 0 ()
 * Number of discrete variables: 10 ($whenCondition2,$whenCondition1,$whenCondition4,$whenCondition3,$whenCondition6,$whenCondition5,$whenCondition8,$whenCondition7,g4.eSDC1A.rotatingExciterLimited.sISO.local_reset,g2.eSDC1A.rotatingExciterLimited.sISO.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (564):
 * Single equations (assignments): 561
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 2
 * 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
   {(80,72)}
Notification: Performance of prepare postOptimizeDAE: time 0.001557/0.4989, allocations: 0.7737 MB / 0.6964 GB, free: 40.03 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009818/0.4998, allocations: 468.9 kB / 0.6969 GB, free: 39.57 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01857/0.5184, allocations: 11.51 MB / 0.7081 GB, free: 28 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.793e-05/0.5184, allocations: 33.25 kB / 0.7082 GB, free: 27.97 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.256e-05/0.5185, allocations: 0 / 0.7082 GB, free: 27.97 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.866e-05/0.5186, allocations: 19.94 kB / 0.7082 GB, free: 27.95 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.03027/0.5488, allocations: 15.54 MB / 0.7234 GB, free: 12.43 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.233e-05/0.5489, allocations: 0 / 0.7234 GB, free: 12.43 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002017/0.5509, allocations: 435.6 kB / 0.7238 GB, free: 12.01 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.008655/0.5595, allocations: 4.749 MB / 0.7284 GB, free: 7.254 MB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0009393/0.5605, allocations: 79.97 kB / 0.7285 GB, free: 7.176 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03305/0.5935, allocations: 20.77 MB / 0.7488 GB, free: 2.344 MB / 0.4948 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.288e-06/0.5935, allocations: 0 / 0.7488 GB, free: 2.344 MB / 0.4948 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02956/0.6231, allocations: 14.68 MB / 0.7631 GB, free: 3.574 MB / 0.5105 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00217/0.6252, allocations: 0.6172 MB / 0.7637 GB, free: 3 MB / 0.5105 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001976/0.6272, allocations: 68 kB / 0.7638 GB, free: 2.934 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003856/0.6311, allocations: 389.5 kB / 0.7641 GB, free: 2.555 MB / 0.5105 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002306/0.6334, allocations: 0.647 MB / 0.7648 GB, free: 1.906 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004095/0.6338, allocations: 95.91 kB / 0.7649 GB, free: 1.812 MB / 0.5105 GB
Notification: Performance of sorting global known variables: time 0.004966/0.6388, allocations: 2.841 MB / 0.7676 GB, free: 14.98 MB / 0.5261 GB
Notification: Performance of sort global known variables: time 7e-08/0.6388, allocations: 0 / 0.7676 GB, free: 14.98 MB / 0.5261 GB
Notification: Performance of remove unused functions: time 0.005455/0.6442, allocations: 1.453 MB / 0.7691 GB, free: 13.57 MB / 0.5261 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 38 (g1.g1.w,g1.g1.delta,g1.g1.Epd,g1.g1.Epq,g1.g1.PSIkd,g1.g1.PSIkq,g1.sEXS.simpleLagLim.state,g1.sEXS.leadLag.TF.x_scaled[1],g2.g2.w,g2.g2.delta,g2.g2.Epd,g2.g2.Epq,g2.g2.PSIkd,g2.g2.PSIkq,g2.eSDC1A.imDerivativeLag.x,g2.eSDC1A.imLeadLag.TF.x_scaled[1],g2.eSDC1A.simpleLagLim.state,g2.eSDC1A.rotatingExciterLimited.sISO.y,g2.eSDC1A.TransducerDelay.state,g3.g3.w,g3.g3.delta,g3.g3.Epd,g3.g3.Epq,g3.g3.PSIkd,g3.g3.PSIkq,g3.sEXS.simpleLagLim.state,g3.sEXS.leadLag.TF.x_scaled[1],g4.gENSAL.w,g4.gENSAL.delta,g4.gENSAL.Epd,g4.gENSAL.Epq,g4.gENSAL.PSIkd,g4.gENSAL.PSIkq,g4.eSDC1A.imDerivativeLag.x,g4.eSDC1A.imLeadLag.TF.x_scaled[1],g4.eSDC1A.simpleLagLim.state,g4.eSDC1A.rotatingExciterLimited.sISO.y,g4.eSDC1A.TransducerDelay.state)
 * Number of discrete variables: 8 ($whenCondition7,$whenCondition8,$whenCondition5,$whenCondition6,$whenCondition3,$whenCondition4,$whenCondition1,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (238):
 * Single equations (assignments): 237
 * 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
   {(54,52)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0008087/0.645, allocations: 235.9 kB / 0.7693 GB, free: 13.34 MB / 0.5261 GB
Notification: Performance of simCode: created initialization part: time 0.01623/0.6613, allocations: 7.388 MB / 0.7765 GB, free: 5.941 MB / 0.5261 GB
Notification: Performance of simCode: created event and clocks part: time 1.08e-05/0.6613, allocations: 448 / 0.7765 GB, free: 5.941 MB / 0.5261 GB
Notification: Performance of simCode: created simulation system equations: time 0.008841/0.6701, allocations: 4.261 MB / 0.7807 GB, free: 1.668 MB / 0.5261 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003643/0.6738, allocations: 393.1 kB / 0.781 GB, free: 1.285 MB / 0.5261 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01517/0.6889, allocations: 8.801 MB / 0.7896 GB, free: 8.508 MB / 0.5417 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001859/0.6908, allocations: 1.814 MB / 0.7914 GB, free: 6.648 MB / 0.5417 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002073/0.6929, allocations: 292.4 kB / 0.7917 GB, free: 6.363 MB / 0.5417 GB
Notification: Performance of SimCode: time 1.763e-06/0.6929, allocations: 0 / 0.7917 GB, free: 6.363 MB / 0.5417 GB
Notification: Performance of Templates: time 0.303/0.9958, allocations: 81.69 MB / 0.8714 GB, free: 188.3 MB / 0.5886 GB
"
[Timeout remaining time 659]
make -j1 -f OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR.makefile [Timeout 660]
(rm -f OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR.sim & ./OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_2.0.0_OpenIPSL.Examples.TwoAreas.Two_Areas_PSSE_AVR.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 10.839964143000543]
Failed to read output from testmodel.py, exit status != 0:
1.003020935691893 1.010236706 0.949889766
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7e66ef209b20>