Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle.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/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/PowerSystems 2.0.0-master/package.mo", uses=false)
Using package PowerSystems with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0-master/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)
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(PowerSystems.Examples.AC3ph.Generation.PowerAngle,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="Time|generator.powerAngle|sensor.p.1.|sensor.p.2.|sensor.p.3.|sensor1.p.1.|sensor1.p.2.|sensor1.p.3.",fileNamePrefix="PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle")
translateModel(PowerSystems.Examples.AC3ph.Generation.PowerAngle,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="Time|generator.powerAngle|sensor.p.1.|sensor.p.2.|sensor.p.3.|sensor1.p.1.|sensor1.p.2.|sensor1.p.3.",fileNamePrefix="PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00148/0.00148, allocations: 108.7 kB / 17.75 MB, free: 5.223 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001863/0.001863, allocations: 190.4 kB / 18.67 MB, free: 4.305 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.364/1.364, allocations: 222.9 MB / 242.4 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0-master/package.mo): time 0.185/0.185, allocations: 38.03 MB / 330.6 MB, free: 8.773 MB / 270.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001343/0.001343, allocations: 64.03 kB / 458.8 MB, free: 6.879 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3016/0.3029, allocations: 58.06 MB / 0.5048 GB, free: 7.727 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Generation.PowerAngle): time 0.007264/0.3102, allocations: 7.456 MB / 0.5121 GB, free: 2.539 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.003953/0.3142, allocations: 2.976 MB / 0.515 GB, free: 456 kB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003818/0.3146, allocations: 25.5 kB / 0.515 GB, free: 448 kB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001953/0.3166, allocations: 0.7879 MB / 0.5158 GB, free: 15.96 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001604/0.3182, allocations: 0.6893 MB / 0.5164 GB, free: 15.59 MB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.000943/0.3192, allocations: 377.5 kB / 0.5168 GB, free: 15.41 MB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.001842/0.321, allocations: 1.33 MB / 0.5181 GB, free: 14.84 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001125/0.3222, allocations: 0.752 MB / 0.5188 GB, free: 14.52 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001027/0.3232, allocations: 0.5626 MB / 0.5194 GB, free: 14.27 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000901/0.3241, allocations: 0.6236 MB / 0.52 GB, free: 14.02 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001315/0.3243, allocations: 73.88 kB / 0.5201 GB, free: 14.02 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0009524/0.3252, allocations: 471.8 kB / 0.5205 GB, free: 13.89 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0005179/0.3257, allocations: 459.1 kB / 0.5209 GB, free: 13.74 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0005532/0.3263, allocations: 0.5056 MB / 0.5214 GB, free: 13.44 MB / 398.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.001864/0.3282, allocations: 1.425 MB / 0.5228 GB, free: 12.95 MB / 398.1 MB
Notification: Performance of FrontEnd - DAE generated: time 1.171e-05/0.3282, allocations: 4 kB / 0.5228 GB, free: 12.95 MB / 398.1 MB
Notification: Performance of FrontEnd: time 1.883e-06/0.3282, allocations: 0 / 0.5228 GB, free: 12.95 MB / 398.1 MB
Notification: Performance of Transformations before backend: time 2.29e-05/0.3282, allocations: 5.375 kB / 0.5228 GB, free: 12.95 MB / 398.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 223
 * Number of variables: 223
Notification: Performance of Generate backend data structure: time 0.002808/0.3311, allocations: 1.259 MB / 0.5241 GB, free: 12.1 MB / 398.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.813e-05/0.3311, allocations: 12.77 kB / 0.5241 GB, free: 12.1 MB / 398.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001363/0.3325, allocations: 206 kB / 0.5243 GB, free: 12.04 MB / 398.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001606/0.3341, allocations: 0.7221 MB / 0.525 GB, free: 11.62 MB / 398.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.345e-05/0.3342, allocations: 63.36 kB / 0.525 GB, free: 11.59 MB / 398.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002368/0.3344, allocations: 95.73 kB / 0.5251 GB, free: 11.55 MB / 398.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001997/0.3364, allocations: 1.115 MB / 0.5262 GB, free: 11.06 MB / 398.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.112e-05/0.3365, allocations: 11.27 kB / 0.5262 GB, free: 11.05 MB / 398.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.646e-05/0.3366, allocations: 31.84 kB / 0.5263 GB, free: 11.03 MB / 398.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001818/0.3367, allocations: 80.72 kB / 0.5263 GB, free: 11.01 MB / 398.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001515/0.3383, allocations: 0.8868 MB / 0.5272 GB, free: 10.73 MB / 398.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.005592/0.3439, allocations: 4.056 MB / 0.5312 GB, free: 7.84 MB / 398.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0005691/0.3445, allocations: 415 kB / 0.5316 GB, free: 7.559 MB / 398.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003711/0.3448, allocations: 273.2 kB / 0.5318 GB, free: 7.418 MB / 398.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 3.743e-05/0.3449, allocations: 13.27 kB / 0.5318 GB, free: 7.41 MB / 398.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.195e-05/0.3449, allocations: 41.06 kB / 0.5319 GB, free: 7.363 MB / 398.1 MB
Notification: Performance of pre-optimization done (n=45): time 2.525e-06/0.3449, allocations: 0 / 0.5319 GB, free: 7.363 MB / 398.1 MB
Notification: Performance of matching and sorting (n=52): time 0.004301/0.3492, allocations: 1.982 MB / 0.5338 GB, free: 6.184 MB / 398.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.059e-05/0.3493, allocations: 82.73 kB / 0.5339 GB, free: 6.09 MB / 398.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006392/0.3499, allocations: 0.5618 MB / 0.5344 GB, free: 5.758 MB / 398.1 MB
Notification: Performance of collectPreVariables (initialization): time 4.695e-05/0.35, allocations: 36.14 kB / 0.5345 GB, free: 5.719 MB / 398.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002845/0.3503, allocations: 468.6 kB / 0.5349 GB, free: 5.305 MB / 398.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001527/0.3504, allocations: 194.7 kB / 0.5351 GB, free: 5.137 MB / 398.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002088/0.3507, allocations: 147.8 kB / 0.5352 GB, free: 5.047 MB / 398.1 MB
Notification: Performance of setup shared object (initialization): time 0.000139/0.3508, allocations: 381 kB / 0.5356 GB, free: 4.684 MB / 398.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004132/0.3512, allocations: 272.2 kB / 0.5359 GB, free: 4.551 MB / 398.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005628/0.3518, allocations: 0.5102 MB / 0.5364 GB, free: 4.102 MB / 398.1 MB
Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet.
Notification: Performance of analyzeInitialSystem (initialization): time 0.003075/0.3549, allocations: 1.402 MB / 0.5377 GB, free: 3.203 MB / 398.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.611e-06/0.3549, allocations: 2.469 kB / 0.5377 GB, free: 3.203 MB / 398.1 MB
Notification: Performance of matching and sorting (n=96) (initialization): time 0.00187/0.3568, allocations: 1.096 MB / 0.5388 GB, free: 2.566 MB / 398.1 MB
Notification: Performance of prepare postOptimizeDAE: time 1.937e-05/0.3568, allocations: 7.5 kB / 0.5388 GB, free: 2.566 MB / 398.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001246/0.3581, allocations: 0.7582 MB / 0.5396 GB, free: 2.125 MB / 398.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00051/0.3586, allocations: 157.2 kB / 0.5397 GB, free: 2.043 MB / 398.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006148/0.3592, allocations: 178.6 kB / 0.5399 GB, free: 1.996 MB / 398.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003864/0.3631, allocations: 4.855 MB / 0.5446 GB, free: 13.29 MB / 414.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005851/0.3637, allocations: 38.56 kB / 0.5447 GB, free: 13.27 MB / 414.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.655e-05/0.3638, allocations: 34.91 kB / 0.5447 GB, free: 13.27 MB / 414.1 MB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         generator.w_el = generator.omega[1] + generator.omega[2].
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 34
 * Number of states: 0 ()
 * Number of discrete variables: 1 (system.initime)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (87):
 * Single equations (assignments): 84
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 3 systems
   {(1,3,100.0%), (1,3,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0005648/0.3643, allocations: 311.1 kB / 0.545 GB, free: 13.04 MB / 414.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001492/0.3645, allocations: 78.09 kB / 0.5451 GB, free: 12.99 MB / 414.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001107/0.3656, allocations: 0.6393 MB / 0.5457 GB, free: 12.62 MB / 414.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.019e-05/0.3656, allocations: 9.172 kB / 0.5457 GB, free: 12.61 MB / 414.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.385e-06/0.3656, allocations: 0 / 0.5457 GB, free: 12.61 MB / 414.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003448/0.366, allocations: 185.4 kB / 0.5459 GB, free: 12.45 MB / 414.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001325/0.3661, allocations: 13.5 kB / 0.5459 GB, free: 12.44 MB / 414.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003802/0.3665, allocations: 26.97 kB / 0.5459 GB, free: 12.43 MB / 414.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.842e-05/0.3666, allocations: 31.52 kB / 0.5459 GB, free: 12.41 MB / 414.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001482/0.3681, allocations: 0.8199 MB / 0.5467 GB, free: 11.91 MB / 414.1 MB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001407/0.3695, allocations: 1.152 MB / 0.5479 GB, free: 11.18 MB / 414.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0003705/0.3699, allocations: 273.8 kB / 0.5481 GB, free: 10.96 MB / 414.1 MB
Notification: Performance of sorting global known variables: time 0.0004947/0.3704, allocations: 411 kB / 0.5485 GB, free: 10.55 MB / 414.1 MB
Notification: Performance of Backend: time 3.31e-07/0.3704, allocations: 0 / 0.5485 GB, free: 10.55 MB / 414.1 MB
Notification: Performance of simCode: created initialization part: time 0.002338/0.3727, allocations: 1.052 MB / 0.5495 GB, free: 9.461 MB / 414.1 MB
Notification: Performance of SimCode: time 0.003288/0.376, allocations: 2.278 MB / 0.5518 GB, free: 7.141 MB / 414.1 MB
Notification: Performance of Templates: time 0.02001/0.3961, allocations: 11.2 MB / 0.5627 GB, free: 11.98 MB / 430.1 MB
make -j1 -f PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle.makefile
(rm -f PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle.pipe ; mkfifo PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle.pipe ; head -c 1048576 < PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle.pipe >> ../files/PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle.sim & ./PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle.pipe 2>&1)
diffSimulationResults("PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/PowerSystems/PowerSystems.Examples.AC3ph.Generation.PowerAngle.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/PowerSystems_latest_PowerSystems.Examples.AC3ph.Generation.PowerAngle.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches