Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard.conf.json 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.002171/0.002171, allocations: 84.44 kB / 19.17 MB, free: 0.7383 MB / 13.93 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.711/1.711, allocations: 177.1 MB / 199.4 MB, free: 5.953 MB / 186.7 MB " [Timeout remaining time 178] 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.002431/0.002431, allocations: 168.5 kB / 256 MB, free: 13.35 MB / 250.7 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/package.mo): time 0.5482/0.5482, allocations: 84.91 MB / 397.3 MB, free: 13.86 MB / 330.7 MB " [Timeout remaining time 179] Using package OpenIPSL with version 3.2.0-dev (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL master/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 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+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) Running command: translateModel(OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard") translateModel(OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 1.693e-06/1.693e-06, allocations: 0 / 0.563 GB, free: 4.027 MB / 490.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 3.592e-05/3.761e-05, allocations: 6.281 kB / 0.563 GB, free: 4.02 MB / 490.7 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard): time 0.00946/0.009498, allocations: 5.994 MB / 0.5688 GB, free: 13.99 MB / 0.4948 GB Notification: Performance of NFInst.instExpressions: time 0.005648/0.01515, allocations: 1.937 MB / 0.5707 GB, free: 12.05 MB / 0.4948 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001373/0.01652, allocations: 12 kB / 0.5707 GB, free: 12.04 MB / 0.4948 GB Notification: Performance of NFTyping.typeComponents: time 0.001054/0.01757, allocations: 233.9 kB / 0.571 GB, free: 11.81 MB / 0.4948 GB Notification: Performance of NFTyping.typeBindings: time 0.003759/0.02133, allocations: 0.8307 MB / 0.5718 GB, free: 10.97 MB / 0.4948 GB Notification: Performance of NFTyping.typeClassSections: time 0.001975/0.02331, allocations: 0.5887 MB / 0.5724 GB, free: 10.39 MB / 0.4948 GB Notification: Performance of NFFlatten.flatten: time 0.002934/0.02624, allocations: 1.505 MB / 0.5738 GB, free: 8.875 MB / 0.4948 GB Notification: Performance of NFFlatten.resolveConnections: time 0.0006809/0.02692, allocations: 217.1 kB / 0.574 GB, free: 8.648 MB / 0.4948 GB Notification: Performance of NFEvalConstants.evaluate: time 0.002142/0.02907, allocations: 0.857 MB / 0.5749 GB, free: 7.789 MB / 0.4948 GB Notification: Performance of NFSimplifyModel.simplify: time 0.00129/0.03036, allocations: 0.5918 MB / 0.5754 GB, free: 7.195 MB / 0.4948 GB Notification: Performance of NFPackage.collectConstants: time 0.0004276/0.03078, allocations: 112 kB / 0.5756 GB, free: 7.086 MB / 0.4948 GB Notification: Performance of NFFlatten.collectFunctions: time 0.0008493/0.03163, allocations: 251.8 kB / 0.5758 GB, free: 6.84 MB / 0.4948 GB Notification: Performance of NFScalarize.scalarize: time 0.0004098/0.03204, allocations: 302.6 kB / 0.5761 GB, free: 6.543 MB / 0.4948 GB Notification: Performance of NFVerifyModel.verify: time 0.0008326/0.03288, allocations: 438.5 kB / 0.5765 GB, free: 6.113 MB / 0.4948 GB Notification: Performance of NFConvertDAE.convert: time 0.002972/0.03585, allocations: 1.647 MB / 0.5781 GB, free: 4.461 MB / 0.4948 GB Notification: Performance of FrontEnd - DAE generated: time 6.462e-06/0.03585, allocations: 4 kB / 0.5781 GB, free: 4.457 MB / 0.4948 GB Notification: Performance of FrontEnd: time 1.773e-06/0.03586, allocations: 0 / 0.5781 GB, free: 4.457 MB / 0.4948 GB Notification: Performance of Transformations before backend: time 6.321e-05/0.03592, allocations: 0 / 0.5781 GB, free: 4.457 MB / 0.4948 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 200 * Number of variables: 200 Notification: Performance of Generate backend data structure: time 0.009812/0.04573, allocations: 2.542 MB / 0.5806 GB, free: 1.875 MB / 0.4948 GB Notification: Performance of prepare preOptimizeDAE: time 4.998e-05/0.04578, allocations: 8.031 kB / 0.5806 GB, free: 1.867 MB / 0.4948 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005279/0.05106, allocations: 0.7913 MB / 0.5814 GB, free: 1.074 MB / 0.4948 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.001957/0.05302, allocations: 0.7444 MB / 0.5821 GB, free: 296 kB / 0.4948 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005159/0.05353, allocations: 315.6 kB / 0.5824 GB, free: 15.93 MB / 0.5105 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003529/0.05388, allocations: 79.95 kB / 0.5825 GB, free: 15.86 MB / 0.5105 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.003064/0.05695, allocations: 1.096 MB / 0.5835 GB, free: 14.75 MB / 0.5105 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.158e-05/0.05697, allocations: 0 / 0.5835 GB, free: 14.75 MB / 0.5105 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001171/0.05709, allocations: 31.94 kB / 0.5836 GB, free: 14.72 MB / 0.5105 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.592e-05/0.05711, allocations: 20 kB / 0.5836 GB, free: 14.7 MB / 0.5105 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002953/0.06007, allocations: 1.077 MB / 0.5847 GB, free: 13.62 MB / 0.5105 GB 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.008907/0.06897, allocations: 2.783 MB / 0.5874 GB, free: 10.81 MB / 0.5105 GB Notification: Performance of preOpt comSubExp (simulation): time 0.01459/0.08356, allocations: 3.024 MB / 0.5903 GB, free: 7.777 MB / 0.5105 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.002094/0.08566, allocations: 0.6991 MB / 0.591 GB, free: 7.078 MB / 0.5105 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0001833/0.08584, allocations: 13 kB / 0.591 GB, free: 7.066 MB / 0.5105 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002438/0.08828, allocations: 0.8279 MB / 0.5918 GB, free: 6.23 MB / 0.5105 GB Notification: Performance of pre-optimization done (n=104): time 5.13e-06/0.08828, allocations: 0 / 0.5918 GB, free: 6.23 MB / 0.5105 GB Notification: Performance of matching and sorting (n=104): time 0.2967/0.385, allocations: 6.775 MB / 0.5984 GB, free: 85.7 MB / 0.5105 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.77e-05/0.3851, allocations: 66.19 kB / 0.5985 GB, free: 85.64 MB / 0.5105 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001185/0.3862, allocations: 0.9514 MB / 0.5994 GB, free: 85.5 MB / 0.5105 GB Notification: Performance of collectPreVariables (initialization): time 0.0002556/0.3865, allocations: 43.98 kB / 0.5995 GB, free: 85.46 MB / 0.5105 GB Notification: Performance of collectInitialEqns (initialization): time 0.0003425/0.3868, allocations: 0.5119 MB / 0.6 GB, free: 85.38 MB / 0.5105 GB Notification: Performance of collectInitialBindings (initialization): time 0.0004584/0.3873, allocations: 365 kB / 0.6003 GB, free: 85.2 MB / 0.5105 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004359/0.3877, allocations: 209.5 kB / 0.6005 GB, free: 85.14 MB / 0.5105 GB Notification: Performance of setup shared object (initialization): time 7.406e-05/0.3878, allocations: 353.6 kB / 0.6009 GB, free: 84.81 MB / 0.5105 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001513/0.3893, allocations: 0.7189 MB / 0.6016 GB, free: 84.56 MB / 0.5105 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001671/0.391, allocations: 0.8591 MB / 0.6024 GB, free: 84.2 MB / 0.5105 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.003082/0.3941, allocations: 1.544 MB / 0.6039 GB, free: 83.52 MB / 0.5105 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.058e-05/0.3941, allocations: 2.812 kB / 0.6039 GB, free: 83.52 MB / 0.5105 GB Notification: Performance of matching and sorting (n=154) (initialization): time 0.01318/0.4073, allocations: 4.178 MB / 0.608 GB, free: 82.57 MB / 0.5105 GB Notification: Performance of prepare postOptimizeDAE: time 2.649e-05/0.4073, allocations: 9.5 kB / 0.608 GB, free: 82.57 MB / 0.5105 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.28e-05/0.4073, allocations: 4.312 kB / 0.608 GB, free: 82.57 MB / 0.5105 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.007489/0.4148, allocations: 2.068 MB / 0.61 GB, free: 82.22 MB / 0.5105 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009564/0.4157, allocations: 167.5 kB / 0.6102 GB, free: 82.21 MB / 0.5105 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02319/0.4389, allocations: 8.732 MB / 0.6187 GB, free: 78.2 MB / 0.5105 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001749/0.4407, allocations: 187.4 kB / 0.6189 GB, free: 78.14 MB / 0.5105 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000308/0.441, allocations: 41.03 kB / 0.6189 GB, free: 78.14 MB / 0.5105 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 11 * Number of states: 0 () * Number of discrete variables: 14 (statcom.lagLimWindupGuard.inputLow,statcom.lagLimWindupGuard.inputBelow,statcom.lagLimWindupGuard.stateLow,statcom.lagLimWindupGuard.inputHigh,statcom.lagLimWindupGuard.inputAbove,statcom.lagLimWindupGuard.stateHigh,statcom.lagLimWindupGuard.atMin,$PRE.statcom.lagLimWindupGuard.atMin,statcom.lagLimWindupGuard.atMax,$PRE.statcom.lagLimWindupGuard.atMax,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (113): * Single equations (assignments): 110 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 2 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 2 systems {(2,100.0%), (2,100.0%)} * Non-linear Jacobian (size): 0 systems * Without analytic Jacobian (size): 0 systems 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 {(24,16)} Notification: Performance of prepare postOptimizeDAE: time 0.0008333/0.4418, allocations: 253.1 kB / 0.6192 GB, free: 77.94 MB / 0.5105 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000432/0.4423, allocations: 133.9 kB / 0.6193 GB, free: 77.86 MB / 0.5105 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01426/0.4565, allocations: 3.956 MB / 0.6232 GB, free: 76.94 MB / 0.5105 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.841e-05/0.4565, allocations: 15.38 kB / 0.6232 GB, free: 76.94 MB / 0.5105 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 7.675e-06/0.4565, allocations: 0 / 0.6232 GB, free: 76.94 MB / 0.5105 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.232e-05/0.4566, allocations: 13.17 kB / 0.6232 GB, free: 76.93 MB / 0.5105 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01639/0.473, allocations: 4.917 MB / 0.628 GB, free: 75.5 MB / 0.5105 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.327e-05/0.473, allocations: 0.9688 kB / 0.628 GB, free: 75.5 MB / 0.5105 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007079/0.4737, allocations: 97.7 kB / 0.6281 GB, free: 75.49 MB / 0.5105 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.007074/0.4808, allocations: 1.93 MB / 0.63 GB, free: 75.14 MB / 0.5105 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002606/0.481, allocations: 20.28 kB / 0.63 GB, free: 75.12 MB / 0.5105 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01854/0.4996, allocations: 7.717 MB / 0.6375 GB, free: 70.95 MB / 0.5105 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.609e-06/0.4996, allocations: 1.125 kB / 0.6375 GB, free: 70.95 MB / 0.5105 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01456/0.5141, allocations: 4.92 MB / 0.6423 GB, free: 68.45 MB / 0.5105 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0005962/0.5147, allocations: 144.5 kB / 0.6425 GB, free: 68.35 MB / 0.5105 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005453/0.5153, allocations: 19.75 kB / 0.6425 GB, free: 68.34 MB / 0.5105 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001405/0.5167, allocations: 121 kB / 0.6426 GB, free: 68.28 MB / 0.5105 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0009833/0.5177, allocations: 248 kB / 0.6428 GB, free: 68.11 MB / 0.5105 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002287/0.5179, allocations: 26.78 kB / 0.6429 GB, free: 68.1 MB / 0.5105 GB Notification: Performance of sorting global known variables: time 0.001189/0.5191, allocations: 0.6356 MB / 0.6435 GB, free: 67.62 MB / 0.5105 GB Notification: Performance of sort global known variables: time 6.1e-08/0.5191, allocations: 0 / 0.6435 GB, free: 67.62 MB / 0.5105 GB Notification: Performance of remove unused functions: time 0.002233/0.5213, allocations: 475.1 kB / 0.6439 GB, free: 67.18 MB / 0.5105 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * Number of states: 3 (machine.delta,machine.w,statcom.lagLimWindupGuard.state) * Number of discrete variables: 12 ($whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,statcom.lagLimWindupGuard.atMax,statcom.lagLimWindupGuard.atMin,statcom.lagLimWindupGuard.stateHigh,statcom.lagLimWindupGuard.inputAbove,statcom.lagLimWindupGuard.inputHigh,statcom.lagLimWindupGuard.stateLow,statcom.lagLimWindupGuard.inputBelow,statcom.lagLimWindupGuard.inputLow) * Number of discrete states: 2 (statcom.lagLimWindupGuard.atMax,statcom.lagLimWindupGuard.atMin) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (65): * Single equations (assignments): 60 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 2 * If-equations: 0 * Equation systems (not torn): 2 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 2 systems {(2,100.0%), (2,100.0%)} * Non-linear Jacobian (size): 0 systems * Without analytic Jacobian (size): 0 systems 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 {(24,16)} Notification: Performance of Backend phase and start with SimCode phase: time 0.0004909/0.5218, allocations: 145.2 kB / 0.6441 GB, free: 67.03 MB / 0.5105 GB Notification: Performance of simCode: created initialization part: time 0.007547/0.5293, allocations: 2.447 MB / 0.6465 GB, free: 64.57 MB / 0.5105 GB Notification: Performance of simCode: created event and clocks part: time 5.922e-06/0.5293, allocations: 1.641 kB / 0.6465 GB, free: 64.57 MB / 0.5105 GB Notification: Performance of simCode: created simulation system equations: time 0.005067/0.5344, allocations: 1.598 MB / 0.648 GB, free: 62.96 MB / 0.5105 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001302/0.5357, allocations: 108.8 kB / 0.6481 GB, free: 62.85 MB / 0.5105 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004223/0.5399, allocations: 2.003 MB / 0.6501 GB, free: 60.85 MB / 0.5105 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005837/0.5405, allocations: 0.5184 MB / 0.6506 GB, free: 60.3 MB / 0.5105 GB Notification: Performance of simCode: alias equations: time 0.0004674/0.541, allocations: 95.64 kB / 0.6507 GB, free: 60.2 MB / 0.5105 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003012/0.5413, allocations: 72.48 kB / 0.6508 GB, free: 60.13 MB / 0.5105 GB Notification: Performance of SimCode: time 1.452e-06/0.5413, allocations: 3.062 kB / 0.6508 GB, free: 60.13 MB / 0.5105 GB Notification: Performance of Templates: time 0.03586/0.5772, allocations: 27.19 MB / 0.6773 GB, free: 33.1 MB / 0.5105 GB " [Timeout remaining time 659] make -j1 -f OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard.makefile [Timeout 660] (rm -f OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard.sim & ./OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard -abortSlowSimulation -alarm=240 -lv LOG_STATS > OpenIPSL_dev_OpenIPSL.Tests.FACTS.PSAT.STATCOM_LagLimWindupGuard.pipe 2>&1) [Timeout 240] [Calling sys.exit(0), Time elapsed: 7.64658537809737]