Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo", uses=false)
Using package OpenIPSL with version 3.1.0-dev (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(OpenIPSL.Tests.Controls.PSSE.TG.IEESGO,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO")
translateModel(OpenIPSL.Tests.Controls.PSSE.TG.IEESGO,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001821/0.001821, allocations: 115.2 kB / 16.42 MB, free: 6.457 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.384/1.384, allocations: 222.9 MB / 240.1 MB, free: 4.574 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001376/0.001376, allocations: 196.4 kB / 290.4 MB, free: 2.285 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.5329/0.5329, allocations: 91.9 MB / 432.4 MB, free: 9.211 MB / 302.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001522/0.001522, allocations: 82.72 kB / 0.5734 GB, free: 33.8 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1364/0.1379, allocations: 71.28 MB / 0.643 GB, free: 3.602 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.TG.IEESGO): time 0.009506/0.1475, allocations: 8.81 MB / 0.6516 GB, free: 10.74 MB / 462.1 MB
Notification: Performance of NFInst.instExpressions: time 0.006299/0.1538, allocations: 2.754 MB / 0.6543 GB, free: 7.98 MB / 462.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001818/0.1557, allocations: 19.94 kB / 0.6543 GB, free: 7.961 MB / 462.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001268/0.157, allocations: 361 kB / 0.6547 GB, free: 7.605 MB / 462.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003391/0.1604, allocations: 1.122 MB / 0.6558 GB, free: 6.48 MB / 462.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002227/0.1627, allocations: 0.9193 MB / 0.6567 GB, free: 5.566 MB / 462.1 MB
Notification: Performance of NFFlatten.flatten: time 0.003439/0.1661, allocations: 2.532 MB / 0.6591 GB, free: 3.031 MB / 462.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0007588/0.1669, allocations: 0.5103 MB / 0.6596 GB, free: 2.492 MB / 462.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001246/0.1681, allocations: 0.9922 MB / 0.6606 GB, free: 1.496 MB / 462.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001202/0.1693, allocations: 1.229 MB / 0.6618 GB, free: 268 kB / 462.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002799/0.1696, allocations: 208 kB / 0.662 GB, free: 60 kB / 462.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0007716/0.1704, allocations: 439.7 kB / 0.6624 GB, free: 15.63 MB / 478.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004257/0.1709, allocations: 0.5175 MB / 0.6629 GB, free: 15.11 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0007876/0.1717, allocations: 1.026 MB / 0.6639 GB, free: 14.08 MB / 478.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.002573/0.1742, allocations: 2.626 MB / 0.6665 GB, free: 11.44 MB / 478.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.659e-06/0.1743, allocations: 0 / 0.6665 GB, free: 11.44 MB / 478.1 MB
Notification: Performance of FrontEnd: time 1.272e-06/0.1743, allocations: 0 / 0.6665 GB, free: 11.44 MB / 478.1 MB
Notification: Performance of Transformations before backend: time 3.772e-05/0.1743, allocations: 0 / 0.6665 GB, free: 11.44 MB / 478.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 282
 * Number of variables: 282
Notification: Performance of Generate backend data structure: time 0.01371/0.188, allocations: 3.973 MB / 0.6704 GB, free: 7.398 MB / 478.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.733e-05/0.1881, allocations: 12.03 kB / 0.6704 GB, free: 7.387 MB / 478.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004966/0.1931, allocations: 0.7792 MB / 0.6712 GB, free: 6.605 MB / 478.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002786/0.1959, allocations: 1.256 MB / 0.6724 GB, free: 5.301 MB / 478.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006091/0.1965, allocations: 0.5681 MB / 0.6729 GB, free: 4.633 MB / 478.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000396/0.1969, allocations: 128 kB / 0.6731 GB, free: 4.508 MB / 478.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003817/0.2007, allocations: 1.595 MB / 0.6746 GB, free: 2.867 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.974e-05/0.2008, allocations: 0 / 0.6746 GB, free: 2.867 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00015/0.2009, allocations: 47.94 kB / 0.6747 GB, free: 2.82 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.339e-05/0.201, allocations: 28 kB / 0.6747 GB, free: 2.793 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003621/0.2046, allocations: 1.492 MB / 0.6761 GB, free: 1.293 MB / 478.1 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.01131/0.2159, allocations: 5.592 MB / 0.6816 GB, free: 11.47 MB / 494.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.008875/0.2248, allocations: 3.129 MB / 0.6847 GB, free: 8.207 MB / 494.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002223/0.2271, allocations: 0.9947 MB / 0.6856 GB, free: 7.203 MB / 494.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001825/0.2273, allocations: 21.3 kB / 0.6857 GB, free: 7.184 MB / 494.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002607/0.2299, allocations: 1.158 MB / 0.6868 GB, free: 6 MB / 494.1 MB
Notification: Performance of pre-optimization done (n=140): time 8.365e-06/0.2299, allocations: 0 / 0.6868 GB, free: 6 MB / 494.1 MB
Notification: Performance of matching and sorting (n=140): time 0.03987/0.2698, allocations: 9.624 MB / 0.6962 GB, free: 12.34 MB / 0.4981 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001029/0.27, allocations: 179.5 kB / 0.6964 GB, free: 12.12 MB / 0.4981 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003232/0.2732, allocations: 1.58 MB / 0.6979 GB, free: 10.54 MB / 0.4981 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004182/0.2736, allocations: 49.7 kB / 0.6979 GB, free: 10.48 MB / 0.4981 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008151/0.2745, allocations: 0.6842 MB / 0.6986 GB, free: 9.789 MB / 0.4981 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00131/0.2758, allocations: 0.5229 MB / 0.6991 GB, free: 9.262 MB / 0.4981 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002091/0.2779, allocations: 367.5 kB / 0.6995 GB, free: 8.895 MB / 0.4981 GB
Notification: Performance of setup shared object (initialization): time 0.0001918/0.2781, allocations: 309 kB / 0.6998 GB, free: 8.59 MB / 0.4981 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003133/0.2813, allocations: 1.055 MB / 0.7008 GB, free: 7.523 MB / 0.4981 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002822/0.2841, allocations: 1.265 MB / 0.702 GB, free: 6.195 MB / 0.4981 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005289/0.2894, allocations: 2.273 MB / 0.7043 GB, free: 3.871 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.116e-05/0.2894, allocations: 0 / 0.7043 GB, free: 3.871 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=259) (initialization): time 0.01877/0.3082, allocations: 5.624 MB / 0.7097 GB, free: 14.22 MB / 0.5137 GB
Notification: Performance of prepare postOptimizeDAE: time 8.189e-05/0.3083, allocations: 33.7 kB / 0.7098 GB, free: 14.18 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.244e-05/0.3084, allocations: 0 / 0.7098 GB, free: 14.18 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00969/0.3181, allocations: 2.592 MB / 0.7123 GB, free: 11.59 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001851/0.32, allocations: 319.5 kB / 0.7126 GB, free: 11.27 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007557/0.3276, allocations: 2.909 MB / 0.7155 GB, free: 8.336 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003078/0.3307, allocations: 302.5 kB / 0.7157 GB, free: 8.039 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003888/0.3311, allocations: 71.92 kB / 0.7158 GB, free: 7.969 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003384/0.3345, allocations: 1.285 MB / 0.7171 GB, free: 6.676 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002733/0.3372, allocations: 1.248 MB / 0.7183 GB, free: 5.367 MB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.00497/0.3422, allocations: 2.242 MB / 0.7205 GB, free: 3.074 MB / 0.5137 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.04e-05/0.3423, allocations: 4 kB / 0.7205 GB, free: 3.07 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=259) (initialization_lambda0): time 0.01814/0.3604, allocations: 5.604 MB / 0.726 GB, free: 13.44 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 5.294e-05/0.3605, allocations: 30.95 kB / 0.726 GB, free: 13.41 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.511e-05/0.3605, allocations: 4 kB / 0.726 GB, free: 13.4 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009424/0.37, allocations: 2.588 MB / 0.7285 GB, free: 10.81 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001786/0.3718, allocations: 315.5 kB / 0.7288 GB, free: 10.5 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007296/0.3791, allocations: 2.932 MB / 0.7317 GB, free: 7.547 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002743/0.3819, allocations: 262.8 kB / 0.7319 GB, free: 7.289 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003513/0.3822, allocations: 67.98 kB / 0.732 GB, free: 7.223 MB / 0.5294 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 15
 * Number of states: 0 ()
 * Number of discrete variables: 2 ($whenCondition2,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (187):
 * Single equations (assignments): 185
 * Array equations: 0
 * Algorithm blocks: 1
 * 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
   {(29,44)}
Notification: Performance of prepare postOptimizeDAE: time 0.0006322/0.3829, allocations: 275.9 kB / 0.7323 GB, free: 6.945 MB / 0.5294 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006052/0.3835, allocations: 190.8 kB / 0.7324 GB, free: 6.758 MB / 0.5294 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01684/0.4003, allocations: 4.965 MB / 0.7373 GB, free: 1.766 MB / 0.5294 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.991e-05/0.4004, allocations: 3.984 kB / 0.7373 GB, free: 1.762 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.443e-06/0.4004, allocations: 4 kB / 0.7373 GB, free: 1.758 MB / 0.5294 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006967/0.4011, allocations: 303.5 kB / 0.7376 GB, free: 1.441 MB / 0.5294 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005545/0.4017, allocations: 32 kB / 0.7376 GB, free: 1.41 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002014/0.4037, allocations: 159.8 kB / 0.7378 GB, free: 1.254 MB / 0.5294 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001741/0.4055, allocations: 0.5629 MB / 0.7383 GB, free: 0.6875 MB / 0.5294 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.009383/0.4149, allocations: 3.065 MB / 0.7413 GB, free: 13.62 MB / 0.545 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.007011/0.4219, allocations: 3.322 MB / 0.7446 GB, free: 10.27 MB / 0.545 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002042/0.424, allocations: 0.8535 MB / 0.7454 GB, free: 9.422 MB / 0.545 GB
Notification: Performance of sorting global known variables: time 0.002271/0.4263, allocations: 1.068 MB / 0.7464 GB, free: 8.359 MB / 0.545 GB
Notification: Performance of Backend: time 8.52e-07/0.4263, allocations: 3.938 kB / 0.7464 GB, free: 8.355 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.01706/0.4433, allocations: 4.566 MB / 0.7509 GB, free: 3.758 MB / 0.545 GB
Notification: Performance of SimCode: time 0.006869/0.4503, allocations: 4.017 MB / 0.7548 GB, free: 15.69 MB / 0.5606 GB
Notification: Performance of Templates: time 0.3493/0.7996, allocations: 41.7 MB / 0.7955 GB, free: 106.6 MB / 0.5606 GB
make -j1 -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO.makefile
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO.sim & ./OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.IEESGO.pipe 2>&1)