Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST.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.GAST,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST")
translateModel(OpenIPSL.Tests.Controls.PSSE.TG.GAST,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001467/0.001467, allocations: 107.7 kB / 15.99 MB, free: 5.91 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.312/1.312, allocations: 222.9 MB / 239.6 MB, free: 4.641 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.001426/0.001426, allocations: 188.5 kB / 289.9 MB, free: 2.379 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.4984/0.4984, allocations: 91.89 MB / 432 MB, free: 9.383 MB / 302.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001448/0.001448, allocations: 83.86 kB / 0.502 GB, free: 8.035 MB / 382.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3476/0.3491, allocations: 71.26 MB / 0.5716 GB, free: 36.35 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.TG.GAST): time 0.007732/0.3569, allocations: 9.571 MB / 0.581 GB, free: 30.54 MB / 430.1 MB
Notification: Performance of NFInst.instExpressions: time 0.00538/0.3623, allocations: 2.901 MB / 0.5838 GB, free: 28.48 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001572/0.3639, allocations: 25.81 kB / 0.5838 GB, free: 28.47 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001085/0.365, allocations: 288.1 kB / 0.5841 GB, free: 28.35 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003091/0.3681, allocations: 1.027 MB / 0.5851 GB, free: 27.69 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001719/0.3699, allocations: 0.7661 MB / 0.5859 GB, free: 27.27 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002956/0.3728, allocations: 2.591 MB / 0.5884 GB, free: 26 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008151/0.3737, allocations: 0.5441 MB / 0.5889 GB, free: 25.72 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001585/0.3753, allocations: 1.034 MB / 0.5899 GB, free: 25.2 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001488/0.3768, allocations: 1.273 MB / 0.5912 GB, free: 24.59 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003801/0.3772, allocations: 225.1 kB / 0.5914 GB, free: 24.58 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0008968/0.3781, allocations: 480.5 kB / 0.5918 GB, free: 24.5 MB / 430.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003721/0.3784, allocations: 0.5338 MB / 0.5924 GB, free: 24.15 MB / 430.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0009029/0.3793, allocations: 1.065 MB / 0.5934 GB, free: 23.42 MB / 430.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.002116/0.3815, allocations: 2.106 MB / 0.5955 GB, free: 22.66 MB / 430.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.28e-06/0.3815, allocations: 4 kB / 0.5955 GB, free: 22.65 MB / 430.1 MB
Notification: Performance of FrontEnd: time 2.404e-06/0.3815, allocations: 0 / 0.5955 GB, free: 22.65 MB / 430.1 MB
Notification: Performance of Transformations before backend: time 4.739e-05/0.3816, allocations: 0 / 0.5955 GB, free: 22.65 MB / 430.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 291
 * Number of variables: 291
Notification: Performance of Generate backend data structure: time 0.01354/0.3951, allocations: 3.954 MB / 0.5993 GB, free: 20.96 MB / 430.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.545e-05/0.3952, allocations: 9.375 kB / 0.5993 GB, free: 20.96 MB / 430.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004987/0.4002, allocations: 0.7827 MB / 0.6001 GB, free: 20.77 MB / 430.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002748/0.4029, allocations: 1.29 MB / 0.6014 GB, free: 19.96 MB / 430.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004265/0.4034, allocations: 476.7 kB / 0.6018 GB, free: 19.53 MB / 430.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002886/0.4037, allocations: 133.7 kB / 0.6019 GB, free: 19.48 MB / 430.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003422/0.4071, allocations: 1.614 MB / 0.6035 GB, free: 18.84 MB / 430.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.857e-05/0.4072, allocations: 5.938 kB / 0.6035 GB, free: 18.83 MB / 430.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001366/0.4073, allocations: 50.42 kB / 0.6036 GB, free: 18.79 MB / 430.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.94e-05/0.4073, allocations: 27.28 kB / 0.6036 GB, free: 18.79 MB / 430.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003292/0.4106, allocations: 1.499 MB / 0.6051 GB, free: 18.28 MB / 430.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.01124/0.4219, allocations: 5.824 MB / 0.6108 GB, free: 14.98 MB / 430.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.00856/0.4305, allocations: 3.18 MB / 0.6139 GB, free: 13.68 MB / 430.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002325/0.4328, allocations: 0.9944 MB / 0.6148 GB, free: 13.28 MB / 430.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004894/0.4333, allocations: 0.7328 MB / 0.6155 GB, free: 12.42 MB / 430.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002633/0.436, allocations: 1.204 MB / 0.6167 GB, free: 11.96 MB / 430.1 MB
Notification: Performance of pre-optimization done (n=148): time 3.957e-06/0.436, allocations: 1.969 kB / 0.6167 GB, free: 11.96 MB / 430.1 MB
Notification: Performance of matching and sorting (n=148): time 0.03944/0.4755, allocations: 9.982 MB / 0.6265 GB, free: 5.867 MB / 430.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.576e-05/0.4755, allocations: 145.8 kB / 0.6266 GB, free: 5.695 MB / 430.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002514/0.4781, allocations: 1.638 MB / 0.6282 GB, free: 4.055 MB / 430.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0005719/0.4787, allocations: 57.77 kB / 0.6283 GB, free: 3.992 MB / 430.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005498/0.4792, allocations: 0.7107 MB / 0.629 GB, free: 3.27 MB / 430.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0006291/0.4799, allocations: 0.5276 MB / 0.6295 GB, free: 2.734 MB / 430.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006465/0.4805, allocations: 395.9 kB / 0.6299 GB, free: 2.34 MB / 430.1 MB
Notification: Performance of setup shared object (initialization): time 3.754e-05/0.4806, allocations: 301.1 kB / 0.6301 GB, free: 2.043 MB / 430.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001978/0.4825, allocations: 1.074 MB / 0.6312 GB, free: 0.9648 MB / 430.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002211/0.4848, allocations: 1.318 MB / 0.6325 GB, free: 15.58 MB / 446.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004595/0.4894, allocations: 2.327 MB / 0.6347 GB, free: 13.16 MB / 446.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.556e-06/0.4894, allocations: 0 / 0.6347 GB, free: 13.16 MB / 446.1 MB
Notification: Performance of matching and sorting (n=279) (initialization): time 0.009973/0.4994, allocations: 4.01 MB / 0.6387 GB, free: 9.094 MB / 446.1 MB
Notification: Performance of prepare postOptimizeDAE: time 5.464e-05/0.4995, allocations: 37.77 kB / 0.6387 GB, free: 9.051 MB / 446.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.482e-05/0.4995, allocations: 4 kB / 0.6387 GB, free: 9.047 MB / 446.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009093/0.5086, allocations: 2.655 MB / 0.6413 GB, free: 6.379 MB / 446.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002069/0.5107, allocations: 387.5 kB / 0.6417 GB, free: 6 MB / 446.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006406/0.5171, allocations: 2.692 MB / 0.6443 GB, free: 3.285 MB / 446.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003132/0.5203, allocations: 290.1 kB / 0.6446 GB, free: 3 MB / 446.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003219/0.5206, allocations: 79.97 kB / 0.6446 GB, free: 2.922 MB / 446.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 17
 * Number of states: 0 ()
 * Number of discrete variables: 5 ($whenCondition2,$whenCondition1,$whenCondition4,$whenCondition3,iEEET1.rotatingExciter.sISO.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (222):
 * Single equations (assignments): 219
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 1
 * 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
   {(30,26)}
Notification: Performance of prepare postOptimizeDAE: time 0.0008591/0.5215, allocations: 352.6 kB / 0.645 GB, free: 2.57 MB / 446.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004955/0.522, allocations: 189.7 kB / 0.6452 GB, free: 2.383 MB / 446.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01691/0.5389, allocations: 5.175 MB / 0.6502 GB, free: 13.18 MB / 462.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.311e-05/0.539, allocations: 12 kB / 0.6502 GB, free: 13.17 MB / 462.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.302e-05/0.539, allocations: 4 kB / 0.6502 GB, free: 13.16 MB / 462.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.686e-05/0.539, allocations: 3.984 kB / 0.6502 GB, free: 13.16 MB / 462.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 postOpt removeSimpleEquations (simulation): time 0.02051/0.5595, allocations: 7.647 MB / 0.6577 GB, free: 5.375 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.264e-05/0.5596, allocations: 4.062 kB / 0.6577 GB, free: 5.371 MB / 462.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001169/0.5608, allocations: 171.7 kB / 0.6579 GB, free: 5.203 MB / 462.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.007577/0.5684, allocations: 2.244 MB / 0.6601 GB, free: 2.949 MB / 462.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003707/0.5688, allocations: 31.98 kB / 0.6601 GB, free: 2.918 MB / 462.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02765/0.5964, allocations: 12.08 MB / 0.6719 GB, free: 6.555 MB / 478.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.37e-06/0.5965, allocations: 8 kB / 0.6719 GB, free: 6.547 MB / 478.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02008/0.6166, allocations: 6.363 MB / 0.6781 GB, free: 152 kB / 478.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009545/0.6176, allocations: 302.5 kB / 0.6784 GB, free: 15.83 MB / 494.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004703/0.6181, allocations: 28 kB / 0.6784 GB, free: 15.8 MB / 494.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001909/0.62, allocations: 167.8 kB / 0.6786 GB, free: 15.64 MB / 494.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0009817/0.621, allocations: 285.3 kB / 0.6789 GB, free: 15.36 MB / 494.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001377/0.6211, allocations: 47.98 kB / 0.6789 GB, free: 15.32 MB / 494.1 MB
Notification: Performance of sorting global known variables: time 0.001963/0.6231, allocations: 1.097 MB / 0.68 GB, free: 14.23 MB / 494.1 MB
Notification: Performance of sort global known variables: time 1.4e-07/0.6231, allocations: 0 / 0.68 GB, free: 14.23 MB / 494.1 MB
Notification: Performance of remove unused functions: time 0.001968/0.6251, allocations: 0.6048 MB / 0.6806 GB, free: 13.62 MB / 494.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 16 (gENCLS.omega,gENCLS.delta,gENCLS.eq,gENROU.w,gENROU.delta,gENROU.Epd,gENROU.Epq,gENROU.PSIkd,gENROU.PSIkq,iEEET1.derivativeLag.x,iEEET1.simpleLagLim.state,iEEET1.rotatingExciter.sISO.y,iEEET1.TransducerDelay.state,gAST.transferFunction1.x_scaled[1],gAST.transferFunction2.x_scaled[1],gAST.simpleLagLim.state)
 * Number of discrete variables: 4 ($whenCondition3,$whenCondition4,$whenCondition1,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (99):
 * Single equations (assignments): 97
 * 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
   {(26,23), (1,6)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0004859/0.6256, allocations: 171 kB / 0.6807 GB, free: 13.44 MB / 494.1 MB
Notification: Performance of simCode: created initialization part: time 0.01035/0.6359, allocations: 3.244 MB / 0.6839 GB, free: 10.18 MB / 494.1 MB
Notification: Performance of simCode: created event and clocks part: time 6.312e-06/0.636, allocations: 3.938 kB / 0.6839 GB, free: 10.17 MB / 494.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.006655/0.6426, allocations: 2.187 MB / 0.686 GB, free: 7.957 MB / 494.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001822/0.6445, allocations: 166 kB / 0.6862 GB, free: 7.793 MB / 494.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007261/0.6518, allocations: 4.27 MB / 0.6904 GB, free: 3.488 MB / 494.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008687/0.6527, allocations: 1.339 MB / 0.6917 GB, free: 2.113 MB / 494.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006776/0.6534, allocations: 123.4 kB / 0.6918 GB, free: 1.996 MB / 494.1 MB
Notification: Performance of SimCode: time 7.81e-07/0.6534, allocations: 0 / 0.6918 GB, free: 1.996 MB / 494.1 MB
Notification: Performance of Templates: time 0.04332/0.6967, allocations: 33.85 MB / 0.7248 GB, free: 132 kB / 0.5137 GB
make -j1 -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST.makefile
(rm -f OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST.sim & ./OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_dev_OpenIPSL.Tests.Controls.PSSE.TG.GAST.pipe 2>&1)