Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSystems_PowerSystems.Examples.Wind.WindTurbine_PSGR.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 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 1.0.1/package.mo", uses=false)
Using package PowerSystems with version 1.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 1.0.1/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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: "" <> buildModelFMU(PowerSystems.Examples.Wind.WindTurbine_PSGR,fileNamePrefix="PowerSystems_PowerSystems_Examples_Wind_WindTurbine_PSGR",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(PowerSystems.Examples.Wind.WindTurbine_PSGR,fileNamePrefix="PowerSystems_PowerSystems_Examples_Wind_WindTurbine_PSGR",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001287/0.001287, allocations: 104.8 kB / 17.06 MB, free: 6.016 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.001274/0.001274, allocations: 196 kB / 18 MB, free: 5.094 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.343/1.343, allocations: 205.1 MB / 223.9 MB, free: 12.25 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 1.0.1/package.mo): time 0.1857/0.1857, allocations: 37.99 MB / 309.2 MB, free: 5.957 MB / 254.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001556/0.001556, allocations: 71.89 kB / 431.4 MB, free: 16.27 MB / 318.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1085/0.1101, allocations: 55.24 MB / 486.6 MB, free: 8.969 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.Wind.WindTurbine_PSGR): time 0.02234/0.1325, allocations: 10.95 MB / 497.5 MB, free: 13.97 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01846/0.151, allocations: 7.131 MB / 0.4928 GB, free: 6.82 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001773/0.1528, allocations: 47.75 kB / 0.4929 GB, free: 6.773 MB / 382.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Math/package.mo:1895:3-1973:18:writable] Warning: Pure function 'Modelica.Math.Matrices.eigenValues' contains a call to impure function 'Modelica.Math.Matrices.LAPACK.dgeev_eigenValues'.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Math/package.mo:2829:3-2870:10:writable] Warning: Pure function 'Modelica.Math.Matrices.inv' contains a call to impure function 'Modelica.Math.Matrices.LAPACK.dgetrf'.
Notification: Performance of NFTyping.typeComponents: time 0.03199/0.1848, allocations: 12.9 MB / 0.5055 GB, free: 9.852 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.004135/0.189, allocations: 1.101 MB / 0.5066 GB, free: 8.746 MB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002589/0.1916, allocations: 0.6511 MB / 0.5072 GB, free: 8.094 MB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007491/0.1991, allocations: 3.899 MB / 0.511 GB, free: 4.188 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002253/0.2014, allocations: 0.9924 MB / 0.512 GB, free: 3.168 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002518/0.2039, allocations: 1.097 MB / 0.5131 GB, free: 2.066 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00264/0.2066, allocations: 1.402 MB / 0.5144 GB, free: 0.6602 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0006099/0.2072, allocations: 144 kB / 0.5146 GB, free: 0.5195 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001616/0.2088, allocations: 0.511 MB / 0.5151 GB, free: 8 kB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001505/0.2103, allocations: 0.8845 MB / 0.5159 GB, free: 15.12 MB / 414.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.00208/0.2124, allocations: 0.9562 MB / 0.5169 GB, free: 14.16 MB / 414.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.003978/0.2164, allocations: 2.492 MB / 0.5193 GB, free: 11.66 MB / 414.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.499e-06/0.2165, allocations: 4 kB / 0.5193 GB, free: 11.66 MB / 414.1 MB
Notification: Performance of FrontEnd: time 1.292e-06/0.2165, allocations: 0 / 0.5193 GB, free: 11.66 MB / 414.1 MB
Notification: Performance of Transformations before backend: time 8.483e-05/0.2166, allocations: 0 / 0.5193 GB, free: 11.66 MB / 414.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 397
 * Number of variables: 397
Notification: Performance of Generate backend data structure: time 0.005245/0.2218, allocations: 2.154 MB / 0.5214 GB, free: 9.441 MB / 414.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.459e-05/0.2219, allocations: 15.89 kB / 0.5214 GB, free: 9.426 MB / 414.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003926/0.2223, allocations: 224.2 kB / 0.5216 GB, free: 9.195 MB / 414.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001821/0.2241, allocations: 326.1 kB / 0.5219 GB, free: 8.875 MB / 414.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002815/0.2269, allocations: 1.284 MB / 0.5232 GB, free: 7.547 MB / 414.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.205e-05/0.227, allocations: 102.6 kB / 0.5233 GB, free: 7.445 MB / 414.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005748/0.2276, allocations: 235.8 kB / 0.5235 GB, free: 7.215 MB / 414.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003228/0.2308, allocations: 2.146 MB / 0.5256 GB, free: 4.961 MB / 414.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 5.161e-05/0.2309, allocations: 15.84 kB / 0.5256 GB, free: 4.945 MB / 414.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001407/0.2311, allocations: 51.98 kB / 0.5257 GB, free: 4.895 MB / 414.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006409/0.2317, allocations: 186.7 kB / 0.5259 GB, free: 4.711 MB / 414.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002973/0.2347, allocations: 1.756 MB / 0.5276 GB, free: 2.949 MB / 414.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.207/0.4417, allocations: 8.555 MB / 0.5359 GB, free: 47.71 MB / 414.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.00229/0.444, allocations: 1.813 MB / 0.5377 GB, free: 46.84 MB / 414.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001264/0.4453, allocations: 0.7681 MB / 0.5384 GB, free: 46.58 MB / 414.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 9.025e-05/0.4454, allocations: 20.33 kB / 0.5385 GB, free: 46.57 MB / 414.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.852e-05/0.4454, allocations: 49.19 kB / 0.5385 GB, free: 46.53 MB / 414.1 MB
Notification: Performance of pre-optimization done (n=122): time 2.996e-06/0.4454, allocations: 0 / 0.5385 GB, free: 46.53 MB / 414.1 MB
Notification: Performance of matching and sorting (n=150): time 0.01924/0.4647, allocations: 7.567 MB / 0.5459 GB, free: 43.43 MB / 414.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.206e-05/0.4648, allocations: 98.8 kB / 0.546 GB, free: 43.33 MB / 414.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001613/0.4664, allocations: 1.034 MB / 0.547 GB, free: 42.93 MB / 414.1 MB
Notification: Performance of collectPreVariables (initialization): time 9.77e-05/0.4665, allocations: 51.42 kB / 0.5471 GB, free: 42.88 MB / 414.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005387/0.467, allocations: 0.7667 MB / 0.5478 GB, free: 42.28 MB / 414.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004259/0.4675, allocations: 0.5324 MB / 0.5483 GB, free: 41.87 MB / 414.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005045/0.468, allocations: 334.1 kB / 0.5486 GB, free: 41.72 MB / 414.1 MB
Notification: Performance of setup shared object (initialization): time 4.798e-05/0.4681, allocations: 307 kB / 0.5489 GB, free: 41.42 MB / 414.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001201/0.4693, allocations: 0.7762 MB / 0.5497 GB, free: 41.17 MB / 414.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001434/0.4707, allocations: 1.245 MB / 0.5509 GB, free: 40.36 MB / 414.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.01513/0.4858, allocations: 5.697 MB / 0.5565 GB, free: 38.23 MB / 414.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.869e-05/0.4859, allocations: 3.906 kB / 0.5565 GB, free: 38.23 MB / 414.1 MB
Notification: Performance of matching and sorting (n=236) (initialization): time 0.008188/0.4941, allocations: 3.908 MB / 0.5603 GB, free: 36.11 MB / 414.1 MB
Notification: Performance of prepare postOptimizeDAE: time 3.582e-05/0.4941, allocations: 17.55 kB / 0.5603 GB, free: 36.11 MB / 414.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.784e-05/0.4942, allocations: 14.69 kB / 0.5603 GB, free: 36.11 MB / 414.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005271/0.4994, allocations: 1.744 MB / 0.562 GB, free: 34.78 MB / 414.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00104/0.5005, allocations: 259.6 kB / 0.5623 GB, free: 34.53 MB / 414.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02131/0.5218, allocations: 18.47 MB / 0.5803 GB, free: 15.52 MB / 414.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001581/0.5234, allocations: 83.45 kB / 0.5804 GB, free: 15.44 MB / 414.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001388/0.5236, allocations: 84.05 kB / 0.5805 GB, free: 15.36 MB / 414.1 MB
Warning: The initial conditions are over specified. The following 6 initial equations are redundant, so they are removed from the initialization system:
         inverter2.switch_dq0[1] = 1.224744871391589 * cos(select2.alpha0) * select2.v0
         $DER.generator.psi_rq[1] = 0.0
         $DER.generator.psi_s[2] = 0.0
         $DER.generator.psi_s[1] = 0.0
         infBus.V = 15000.0 * infBus.v0
         line.omega[1] = 0.0.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 63
 * Number of states: 0 ()
 * Number of discrete variables: 3 (system.initime,trafo.tap_2_internal,trafo.tap_1_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (130):
 * Single equations (assignments): 126
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(2,11,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(5,49), (21,20)}
Notification: Performance of prepare postOptimizeDAE: time 0.000918/0.5245, allocations: 0.5288 MB / 0.581 GB, free: 14.83 MB / 414.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002196/0.5247, allocations: 150.1 kB / 0.5811 GB, free: 14.68 MB / 414.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004448/0.5292, allocations: 2.401 MB / 0.5835 GB, free: 12.21 MB / 414.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.857e-06/0.5292, allocations: 16 kB / 0.5835 GB, free: 12.19 MB / 414.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.864e-06/0.5292, allocations: 4 kB / 0.5835 GB, free: 12.19 MB / 414.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.431e-05/0.5293, allocations: 11.97 kB / 0.5835 GB, free: 12.18 MB / 414.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00756/0.5368, allocations: 4.324 MB / 0.5877 GB, free: 7.754 MB / 414.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.798e-06/0.5369, allocations: 4 kB / 0.5877 GB, free: 7.75 MB / 414.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001436/0.5383, allocations: 307.9 kB / 0.588 GB, free: 7.449 MB / 414.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002399/0.5407, allocations: 0.5528 MB / 0.5886 GB, free: 6.887 MB / 414.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001243/0.5409, allocations: 51.97 kB / 0.5886 GB, free: 6.836 MB / 414.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.008821/0.5497, allocations: 10.13 MB / 0.5985 GB, free: 12.02 MB / 430.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.77e-06/0.5497, allocations: 4 kB / 0.5985 GB, free: 12.02 MB / 430.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006406/0.5561, allocations: 3.218 MB / 0.6017 GB, free: 8.695 MB / 430.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009516/0.5571, allocations: 347.2 kB / 0.602 GB, free: 8.336 MB / 430.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000188/0.5573, allocations: 51.98 kB / 0.602 GB, free: 8.285 MB / 430.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007905/0.5581, allocations: 59.94 kB / 0.6021 GB, free: 8.227 MB / 430.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002938/0.5584, allocations: 117 kB / 0.6022 GB, free: 8.113 MB / 430.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 9.871e-05/0.5585, allocations: 47.97 kB / 0.6023 GB, free: 8.066 MB / 430.1 MB
Notification: Performance of sorting global known variables: time 0.0009507/0.5595, allocations: 0.6931 MB / 0.6029 GB, free: 7.367 MB / 430.1 MB
Notification: Performance of sort global known variables: time 1.8e-07/0.5595, allocations: 4 kB / 0.6029 GB, free: 7.363 MB / 430.1 MB
Notification: Performance of remove unused functions: time 0.002176/0.5617, allocations: 0.5653 MB / 0.6035 GB, free: 6.801 MB / 430.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 12
 * Number of states: 23 (inertia.w,generator.phi_el,generator.i_s[3],generator.psi_s[1],generator.psi_s[2],meterDC.pav,inverter2.vDC1,line.v[1,2],line.v[1,3],line.v[2,2],line.v[2,3],line.v[3,1],line.v[3,2],line.v[3,3],line.i[1,1],line.i[1,2],line.i[1,3],line.i[2,1],line.i[2,2],line.i[2,3],line.i[3,1],line.i[3,2],line.i[3,3])
 * 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 simulation (119):
 * Single equations (assignments): 113
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 1
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(2,9,100.0%), (1,1,100.0%), (1,8,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,11)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.00665/0.5683, allocations: 3.835 MB / 0.6072 GB, free: 2.863 MB / 430.1 MB
Notification: Performance of simCode: created initialization part: time 0.005779/0.5741, allocations: 3.121 MB / 0.6103 GB, free: 15.7 MB / 446.1 MB
Notification: Performance of simCode: created event and clocks part: time 7.775e-06/0.5741, allocations: 4 kB / 0.6103 GB, free: 15.7 MB / 446.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.002439/0.5766, allocations: 1.587 MB / 0.6118 GB, free: 14.05 MB / 446.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001565/0.5782, allocations: 327 kB / 0.6121 GB, free: 13.73 MB / 446.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03628/0.6144, allocations: 18.9 MB / 0.6306 GB, free: 10.22 MB / 462.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001752/0.6162, allocations: 1.592 MB / 0.6321 GB, free: 8.602 MB / 462.1 MB
Notification: Performance of simCode: alias equations: time 0.001142/0.6174, allocations: 400.5 kB / 0.6325 GB, free: 8.203 MB / 462.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0009152/0.6183, allocations: 0.6555 MB / 0.6332 GB, free: 7.547 MB / 462.1 MB
Notification: Performance of SimCode: time 5.71e-07/0.6183, allocations: 0 / 0.6332 GB, free: 7.547 MB / 462.1 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1052/0.7235, allocations: 47.68 MB / 0.6797 GB, free: 7.734 MB / 0.4981 GB
Notification: Performance of buildModelFMU: Generate platform static: time 14.53/15.25, allocations: 3.906 kB / 0.6797 GB, free: 7.73 MB / 0.4981 GB
(rm -f PowerSystems_PowerSystems.Examples.Wind.WindTurbine_PSGR.pipe ; mkfifo PowerSystems_PowerSystems.Examples.Wind.WindTurbine_PSGR.pipe ; head -c 1048576 < PowerSystems_PowerSystems.Examples.Wind.WindTurbine_PSGR.pipe >> ../files/PowerSystems_PowerSystems.Examples.Wind.WindTurbine_PSGR.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_PowerSystems_PowerSystems_Examples_Wind_WindTurbine_PSGR_fmu --startTime=0 --stopTime=100 --timeout=50 --tolerance=1e-06 PowerSystems_PowerSystems_Examples_Wind_WindTurbine_PSGR.fmu > PowerSystems_PowerSystems.Examples.Wind.WindTurbine_PSGR.pipe 2>&1)