Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1.conf.json 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/Modelica 4.0.0+maint.om/package.mo", uses=false) 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/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 ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 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 Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo) Running command: translateModel(OpenIPSL.Tests.Banks.PSSE.CSVGN1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1") translateModel(OpenIPSL.Tests.Banks.PSSE.CSVGN1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0008815/0.000886, allocations: 175.2 kB / 16.07 MB, free: 5.727 MB / 13.93 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.255/1.255, allocations: 222.9 MB / 239.7 MB, free: 11.92 MB / 202.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.000764/0.000764, allocations: 88.38 kB / 290.4 MB, free: 11.23 MB / 234.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.4215/0.4215, allocations: 78.42 MB / 419.6 MB, free: 9.844 MB / 298.7 MB Notification: Performance of FrontEnd - loaded program: time 0.0003522/0.0003523, allocations: 15.94 kB / 499.1 MB, free: 10.71 MB / 378.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.2815/0.2818, allocations: 68.75 MB / 0.5545 GB, free: 20.22 MB / 378.7 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Banks.PSSE.CSVGN1): time 0.006174/0.2881, allocations: 8.972 MB / 0.5633 GB, free: 11.2 MB / 378.7 MB Notification: Performance of NFInst.instExpressions: time 0.004191/0.2923, allocations: 2.754 MB / 0.566 GB, free: 8.441 MB / 378.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0009883/0.2933, allocations: 16 kB / 0.566 GB, free: 8.426 MB / 378.7 MB Notification: Performance of NFTyping.typeComponents: time 0.0007257/0.294, allocations: 270.3 kB / 0.5662 GB, free: 8.16 MB / 378.7 MB Notification: Performance of NFTyping.typeBindings: time 0.002414/0.2965, allocations: 1.161 MB / 0.5674 GB, free: 7 MB / 378.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.001306/0.2978, allocations: 0.7425 MB / 0.5681 GB, free: 6.266 MB / 378.7 MB Notification: Performance of NFFlatten.flatten: time 0.001869/0.2997, allocations: 2.408 MB / 0.5704 GB, free: 3.852 MB / 378.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0004678/0.3002, allocations: 422.6 kB / 0.5709 GB, free: 3.41 MB / 378.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0007464/0.3009, allocations: 0.8322 MB / 0.5717 GB, free: 2.574 MB / 378.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0008295/0.3018, allocations: 1.112 MB / 0.5728 GB, free: 1.457 MB / 378.7 MB Notification: Performance of NFPackage.collectConstants: time 0.0001929/0.302, allocations: 96 kB / 0.5728 GB, free: 1.363 MB / 378.7 MB Notification: Performance of NFFlatten.collectFunctions: time 0.000653/0.3026, allocations: 299.8 kB / 0.5731 GB, free: 1.07 MB / 378.7 MB Notification: Performance of NFScalarize.scalarize: time 0.0002782/0.3029, allocations: 402 kB / 0.5735 GB, free: 0.6758 MB / 378.7 MB Notification: Performance of NFVerifyModel.verify: time 0.0005859/0.3035, allocations: 0.8618 MB / 0.5744 GB, free: 15.8 MB / 394.7 MB Notification: Performance of NFConvertDAE.convert: time 0.00166/0.3052, allocations: 1.819 MB / 0.5761 GB, free: 13.98 MB / 394.7 MB Notification: Performance of FrontEnd - DAE generated: time 5.18e-06/0.3052, allocations: 0 / 0.5761 GB, free: 13.98 MB / 394.7 MB Notification: Performance of FrontEnd: time 1.844e-06/0.3052, allocations: 4 kB / 0.5761 GB, free: 13.98 MB / 394.7 MB Notification: Performance of Transformations before backend: time 4.14e-05/0.3053, allocations: 0 / 0.5761 GB, free: 13.98 MB / 394.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 261 * Number of variables: 261 Notification: Performance of Generate backend data structure: time 0.01367/0.319, allocations: 3.763 MB / 0.5798 GB, free: 10.16 MB / 394.7 MB Notification: Performance of prepare preOptimizeDAE: time 4.152e-05/0.319, allocations: 12.03 kB / 0.5798 GB, free: 10.15 MB / 394.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004617/0.3236, allocations: 0.7508 MB / 0.5806 GB, free: 9.395 MB / 394.7 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002076/0.3257, allocations: 1.188 MB / 0.5817 GB, free: 8.156 MB / 394.7 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004121/0.3262, allocations: 437.1 kB / 0.5821 GB, free: 7.66 MB / 394.7 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002052/0.3264, allocations: 119.8 kB / 0.5822 GB, free: 7.543 MB / 394.7 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002782/0.3292, allocations: 1.507 MB / 0.5837 GB, free: 5.984 MB / 394.7 MB Notification: Performance of preOpt findStateOrder (simulation): time 2.07e-05/0.3292, allocations: 3.938 kB / 0.5837 GB, free: 5.98 MB / 394.7 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001214/0.3293, allocations: 48 kB / 0.5838 GB, free: 5.934 MB / 394.7 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.889e-05/0.3294, allocations: 24 kB / 0.5838 GB, free: 5.91 MB / 394.7 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00288/0.3322, allocations: 1.409 MB / 0.5852 GB, free: 4.492 MB / 394.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.008175/0.3404, allocations: 5.157 MB / 0.5902 GB, free: 15.12 MB / 410.7 MB Notification: Performance of preOpt comSubExp (simulation): time 0.007851/0.3483, allocations: 3.128 MB / 0.5933 GB, free: 11.84 MB / 410.7 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.001777/0.3501, allocations: 0.966 MB / 0.5942 GB, free: 10.87 MB / 410.7 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0001343/0.3502, allocations: 21.3 kB / 0.5942 GB, free: 10.84 MB / 410.7 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002002/0.3522, allocations: 1.108 MB / 0.5953 GB, free: 9.719 MB / 410.7 MB Notification: Performance of pre-optimization done (n=137): time 2.905e-06/0.3523, allocations: 0 / 0.5953 GB, free: 9.719 MB / 410.7 MB Notification: Performance of matching and sorting (n=137): time 0.05129/0.4036, allocations: 12.65 MB / 0.6077 GB, free: 13.02 MB / 426.7 MB Notification: Performance of inlineWhenForInitialization (initialization): time 7.788e-05/0.4037, allocations: 120.1 kB / 0.6078 GB, free: 12.88 MB / 426.7 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002159/0.4058, allocations: 1.486 MB / 0.6092 GB, free: 11.39 MB / 426.7 MB Notification: Performance of collectPreVariables (initialization): time 0.000271/0.4061, allocations: 53.7 kB / 0.6093 GB, free: 11.33 MB / 426.7 MB Notification: Performance of collectInitialEqns (initialization): time 0.0004751/0.4066, allocations: 0.6244 MB / 0.6099 GB, free: 10.7 MB / 426.7 MB Notification: Performance of collectInitialBindings (initialization): time 0.0005382/0.4071, allocations: 0.4891 MB / 0.6104 GB, free: 10.2 MB / 426.7 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002292/0.4074, allocations: 181.6 kB / 0.6105 GB, free: 10.02 MB / 426.7 MB Notification: Performance of setup shared object (initialization): time 9.662e-05/0.4075, allocations: 305.1 kB / 0.6108 GB, free: 9.719 MB / 426.7 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.002059/0.4095, allocations: 0.9878 MB / 0.6118 GB, free: 8.73 MB / 426.7 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.00218/0.4117, allocations: 1.208 MB / 0.613 GB, free: 7.465 MB / 426.7 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.004104/0.4159, allocations: 2.177 MB / 0.6151 GB, free: 5.242 MB / 426.7 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.721e-06/0.4159, allocations: 0 / 0.6151 GB, free: 5.242 MB / 426.7 MB Notification: Performance of matching and sorting (n=243) (initialization): time 0.01752/0.4334, allocations: 5.734 MB / 0.6207 GB, free: 15.49 MB / 442.7 MB Notification: Performance of prepare postOptimizeDAE: time 0.0001392/0.4336, allocations: 208.6 kB / 0.6209 GB, free: 15.24 MB / 442.7 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.271e-05/0.4336, allocations: 8 kB / 0.6209 GB, free: 15.23 MB / 442.7 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.009242/0.4428, allocations: 2.845 MB / 0.6237 GB, free: 12.38 MB / 442.7 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001311/0.4442, allocations: 291.5 kB / 0.624 GB, free: 12.1 MB / 442.7 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006818/0.451, allocations: 3.066 MB / 0.6269 GB, free: 9.004 MB / 442.7 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002375/0.4534, allocations: 270.1 kB / 0.6272 GB, free: 8.738 MB / 442.7 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001743/0.4536, allocations: 67.97 kB / 0.6273 GB, free: 8.672 MB / 442.7 MB Notification: Performance of prepare postOptimizeDAE: time 1.095e-05/0.4536, allocations: 4 kB / 0.6273 GB, free: 8.668 MB / 442.7 MB Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01679/0.4704, allocations: 5.48 MB / 0.6326 GB, free: 3.18 MB / 442.7 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.298e-05/0.4704, allocations: 4 kB / 0.6326 GB, free: 3.176 MB / 442.7 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.008845/0.4793, allocations: 2.83 MB / 0.6354 GB, free: 348 kB / 442.7 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001303/0.4806, allocations: 279.6 kB / 0.6357 GB, free: 68 kB / 442.7 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006446/0.4871, allocations: 2.987 MB / 0.6386 GB, free: 13.05 MB / 458.7 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002019/0.4891, allocations: 238.5 kB / 0.6388 GB, free: 12.81 MB / 458.7 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001363/0.4893, allocations: 67.97 kB / 0.6389 GB, free: 12.75 MB / 458.7 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 17 * Number of states: 0 () * Number of discrete variables: 3 ($whenCondition2,$whenCondition1,cSVGN1.leadLagLim.integrator.local_reset) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (169): * Single equations (assignments): 168 * 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 {(31,44)} Notification: Performance of prepare postOptimizeDAE: time 0.0006969/0.49, allocations: 392.7 kB / 0.6392 GB, free: 12.35 MB / 458.7 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002683/0.4902, allocations: 177.8 kB / 0.6394 GB, free: 12.18 MB / 458.7 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02141/0.5117, allocations: 5.101 MB / 0.6444 GB, free: 7.047 MB / 458.7 MB Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.604e-05/0.5117, allocations: 16 kB / 0.6444 GB, free: 7.031 MB / 458.7 MB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.261e-05/0.5117, allocations: 3.938 kB / 0.6444 GB, free: 7.027 MB / 458.7 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.064e-05/0.5118, allocations: 11.91 kB / 0.6444 GB, free: 7.016 MB / 458.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.03035/0.5421, allocations: 7.345 MB / 0.6516 GB, free: 15.52 MB / 474.7 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.427e-05/0.5422, allocations: 8 kB / 0.6516 GB, free: 15.51 MB / 474.7 MB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00111/0.5433, allocations: 127.8 kB / 0.6517 GB, free: 15.39 MB / 474.7 MB Notification: Performance of postOpt tearingSystem (simulation): time 0.01242/0.5558, allocations: 2.539 MB / 0.6542 GB, free: 12.84 MB / 474.7 MB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.00027/0.5561, allocations: 31.98 kB / 0.6542 GB, free: 12.81 MB / 474.7 MB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03559/0.5917, allocations: 10.88 MB / 0.6649 GB, free: 1.77 MB / 474.7 MB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.405e-06/0.5917, allocations: 0 / 0.6649 GB, free: 1.77 MB / 474.7 MB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01963/0.6113, allocations: 6.288 MB / 0.671 GB, free: 11.45 MB / 490.7 MB Notification: Performance of postOpt removeConstants (simulation): time 0.0006379/0.612, allocations: 286.5 kB / 0.6713 GB, free: 11.15 MB / 490.7 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002308/0.6123, allocations: 20 kB / 0.6713 GB, free: 11.13 MB / 490.7 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001629/0.6139, allocations: 147.8 kB / 0.6714 GB, free: 10.99 MB / 490.7 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008445/0.6148, allocations: 273.4 kB / 0.6717 GB, free: 10.72 MB / 490.7 MB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 9.89e-05/0.6149, allocations: 35.98 kB / 0.6717 GB, free: 10.69 MB / 490.7 MB Notification: Performance of sorting global known variables: time 0.001536/0.6164, allocations: 0.9999 MB / 0.6727 GB, free: 9.691 MB / 490.7 MB Notification: Performance of sort global known variables: time 2e-07/0.6164, allocations: 0 / 0.6727 GB, free: 9.691 MB / 490.7 MB Notification: Performance of remove unused functions: time 0.002193/0.6186, allocations: 0.8973 MB / 0.6736 GB, free: 8.793 MB / 490.7 MB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 2 * Number of states: 11 (gENCLS.omega,gENCLS.delta,gENCLS.eq,gENSAL.w,gENSAL.delta,gENSAL.Epq,gENSAL.PSIkd,gENSAL.PSIppq,cSVGN1.LagLim.state,cSVGN1.leadLag.TF.x_scaled[1],cSVGN1.leadLagLim.integrator.y) * Number of discrete variables: 2 ($whenCondition1,$whenCondition2) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (75): * Single equations (assignments): 74 * 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 {(27,41)} Notification: Performance of Backend phase and start with SimCode phase: time 0.0003274/0.619, allocations: 155 kB / 0.6737 GB, free: 8.629 MB / 490.7 MB Notification: Performance of simCode: created initialization part: time 0.01541/0.6344, allocations: 4.976 MB / 0.6786 GB, free: 3.66 MB / 490.7 MB Notification: Performance of simCode: created event and clocks part: time 1.001e-05/0.6344, allocations: 4.047 kB / 0.6786 GB, free: 3.656 MB / 490.7 MB Notification: Performance of simCode: created simulation system equations: time 0.006257/0.6407, allocations: 2.032 MB / 0.6806 GB, free: 1.605 MB / 490.7 MB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001514/0.6422, allocations: 162.6 kB / 0.6807 GB, free: 1.445 MB / 490.7 MB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2392/0.8815, allocations: 3.773 MB / 0.6844 GB, free: 117.7 MB / 490.7 MB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008401/0.8824, allocations: 1.266 MB / 0.6857 GB, free: 117 MB / 490.7 MB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005965/0.883, allocations: 99.53 kB / 0.6858 GB, free: 117 MB / 490.7 MB Notification: Performance of SimCode: time 8.21e-07/0.883, allocations: 1.594 kB / 0.6858 GB, free: 117 MB / 490.7 MB Notification: Performance of Templates: time 0.03594/0.9189, allocations: 27.31 MB / 0.7124 GB, free: 100.5 MB / 490.7 MB make -j1 -f OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1.makefile (rm -f OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1.pipe ; mkfifo OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1.pipe ; head -c 1048576 < OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1.pipe >> ../files/OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1.sim & ./OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1 -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_release_OpenIPSL.Tests.Banks.PSSE.CSVGN1.pipe 2>&1)