Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSystems_PowerSystems.Examples.Wind.WindTurbine_IG.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_IG,fileNamePrefix="PowerSystems_PowerSystems_Examples_Wind_WindTurbine_IG",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(PowerSystems.Examples.Wind.WindTurbine_IG,fileNamePrefix="PowerSystems_PowerSystems_Examples_Wind_WindTurbine_IG",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.00122/0.00122, allocations: 115.1 kB / 17.07 MB, free: 5.969 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.001258/0.001258, allocations: 198.9 kB / 18.01 MB, free: 5.055 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.258/1.258, allocations: 205.1 MB / 223.9 MB, free: 12.21 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 1.0.1/package.mo): time 0.1709/0.1709, allocations: 37.98 MB / 309.2 MB, free: 5.953 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.001323/0.001323, allocations: 75.89 kB / 431.4 MB, free: 16.27 MB / 318.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08681/0.08814, allocations: 55.23 MB / 486.6 MB, free: 8.973 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.Wind.WindTurbine_IG): time 0.008017/0.09619, allocations: 8.086 MB / 494.7 MB, free: 0.8477 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.007339/0.1036, allocations: 5.514 MB / 0.4885 GB, free: 11.31 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005559/0.1041, allocations: 31.81 kB / 0.4885 GB, free: 11.28 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'.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Math/package.mo:1125:3-1182:12:writable] Warning: Pure function 'Modelica.Math.Matrices.solve' contains a call to impure function 'Modelica.Math.Matrices.LAPACK.dgesv_vec'.
Notification: Performance of NFTyping.typeComponents: time 0.009128/0.1133, allocations: 5.232 MB / 0.4936 GB, free: 6.039 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001892/0.1152, allocations: 0.8402 MB / 0.4944 GB, free: 5.195 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001197/0.1164, allocations: 495 kB / 0.4949 GB, free: 4.711 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.003157/0.1196, allocations: 2.53 MB / 0.4974 GB, free: 2.176 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009554/0.1206, allocations: 0.6221 MB / 0.498 GB, free: 1.543 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001283/0.1219, allocations: 0.7784 MB / 0.4987 GB, free: 0.7617 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001788/0.1237, allocations: 1.028 MB / 0.4997 GB, free: 15.73 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003356/0.124, allocations: 104 kB / 0.4998 GB, free: 15.63 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0009018/0.1249, allocations: 371.5 kB / 0.5002 GB, free: 15.27 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0007292/0.1257, allocations: 0.6547 MB / 0.5008 GB, free: 14.61 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001249/0.1269, allocations: 0.6959 MB / 0.5015 GB, free: 13.91 MB / 398.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.002051/0.129, allocations: 1.721 MB / 0.5032 GB, free: 12.18 MB / 398.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.498e-06/0.129, allocations: 0 / 0.5032 GB, free: 12.18 MB / 398.1 MB
Notification: Performance of FrontEnd: time 1.863e-06/0.129, allocations: 0 / 0.5032 GB, free: 12.18 MB / 398.1 MB
Notification: Performance of Transformations before backend: time 5.201e-05/0.1291, allocations: 0 / 0.5032 GB, free: 12.18 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: 281
 * Number of variables: 281
Notification: Performance of Generate backend data structure: time 0.003463/0.1325, allocations: 1.589 MB / 0.5048 GB, free: 10.54 MB / 398.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.113e-05/0.1326, allocations: 19.89 kB / 0.5048 GB, free: 10.52 MB / 398.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002522/0.1329, allocations: 169.2 kB / 0.5049 GB, free: 10.35 MB / 398.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001221/0.1341, allocations: 211.1 kB / 0.5051 GB, free: 10.14 MB / 398.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002098/0.1362, allocations: 0.9566 MB / 0.5061 GB, free: 9.141 MB / 398.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.601e-05/0.1363, allocations: 73.98 kB / 0.5061 GB, free: 9.066 MB / 398.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004514/0.1367, allocations: 183.8 kB / 0.5063 GB, free: 8.887 MB / 398.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002281/0.139, allocations: 1.564 MB / 0.5078 GB, free: 7.242 MB / 398.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.879e-05/0.1391, allocations: 11.84 kB / 0.5079 GB, free: 7.23 MB / 398.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001036/0.1392, allocations: 39.98 kB / 0.5079 GB, free: 7.191 MB / 398.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0005836/0.1398, allocations: 153.9 kB / 0.508 GB, free: 7.039 MB / 398.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002064/0.1418, allocations: 1.245 MB / 0.5093 GB, free: 5.785 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.008684/0.1505, allocations: 6.458 MB / 0.5156 GB, free: 14.95 MB / 414.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001502/0.1521, allocations: 0.9205 MB / 0.5165 GB, free: 14.01 MB / 414.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007331/0.1528, allocations: 0.5005 MB / 0.5169 GB, free: 13.5 MB / 414.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 6.99e-05/0.1529, allocations: 20.98 kB / 0.517 GB, free: 13.48 MB / 414.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.857e-05/0.1529, allocations: 39.56 kB / 0.517 GB, free: 13.44 MB / 414.1 MB
Notification: Performance of pre-optimization done (n=91): time 2.916e-06/0.1529, allocations: 0 / 0.517 GB, free: 13.44 MB / 414.1 MB
Notification: Performance of matching and sorting (n=96): time 0.006219/0.1592, allocations: 3.671 MB / 0.5206 GB, free: 9.625 MB / 414.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.625e-05/0.1592, allocations: 86.11 kB / 0.5207 GB, free: 9.523 MB / 414.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0008365/0.1601, allocations: 0.7312 MB / 0.5214 GB, free: 8.785 MB / 414.1 MB
Notification: Performance of collectPreVariables (initialization): time 6.609e-05/0.1602, allocations: 41.7 kB / 0.5214 GB, free: 8.738 MB / 414.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003542/0.1605, allocations: 0.5574 MB / 0.522 GB, free: 8.172 MB / 414.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0002781/0.1608, allocations: 366.8 kB / 0.5223 GB, free: 7.809 MB / 414.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003391/0.1611, allocations: 234.8 kB / 0.5225 GB, free: 7.574 MB / 414.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001596/0.1613, allocations: 410.7 kB / 0.5229 GB, free: 7.164 MB / 414.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000893/0.1622, allocations: 0.5608 MB / 0.5235 GB, free: 6.602 MB / 414.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001047/0.1633, allocations: 0.897 MB / 0.5244 GB, free: 5.574 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.008034/0.1713, allocations: 3.236 MB / 0.5275 GB, free: 2.211 MB / 414.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.658e-06/0.1713, allocations: 4 kB / 0.5275 GB, free: 2.207 MB / 414.1 MB
Notification: Performance of matching and sorting (n=164) (initialization): time 0.1782/0.3495, allocations: 2.724 MB / 0.5302 GB, free: 50.7 MB / 414.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.58e-05/0.3496, allocations: 12.42 kB / 0.5302 GB, free: 50.7 MB / 414.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.998e-05/0.3496, allocations: 11.72 kB / 0.5302 GB, free: 50.7 MB / 414.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002914/0.3525, allocations: 1.161 MB / 0.5313 GB, free: 50.67 MB / 414.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008035/0.3534, allocations: 199.2 kB / 0.5315 GB, free: 50.67 MB / 414.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01638/0.3698, allocations: 12.27 MB / 0.5435 GB, free: 45.36 MB / 414.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008282/0.3706, allocations: 64.47 kB / 0.5436 GB, free: 45.34 MB / 414.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.974e-05/0.3707, allocations: 51.89 kB / 0.5436 GB, free: 45.33 MB / 414.1 MB
Warning: The initial conditions are over specified. The following 3 initial equations are redundant, so they are removed from the initialization system:
         $DER.inertia.w = 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: 43
 * 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 (96):
 * Single equations (assignments): 94
 * 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): 1 system
   {(1,17,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(24,28)}
Notification: Performance of prepare postOptimizeDAE: time 0.000561/0.3713, allocations: 398.4 kB / 0.544 GB, free: 45.1 MB / 414.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001372/0.3714, allocations: 97.75 kB / 0.5441 GB, free: 45.09 MB / 414.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002004/0.3734, allocations: 1.405 MB / 0.5455 GB, free: 44.42 MB / 414.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.047e-06/0.3735, allocations: 10.81 kB / 0.5455 GB, free: 44.42 MB / 414.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.19e-06/0.3735, allocations: 7.594 kB / 0.5455 GB, free: 44.41 MB / 414.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.157e-05/0.3735, allocations: 4.969 kB / 0.5455 GB, free: 44.41 MB / 414.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004323/0.3778, allocations: 2.663 MB / 0.5481 GB, free: 43.21 MB / 414.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.775e-06/0.3778, allocations: 2.578 kB / 0.5481 GB, free: 43.21 MB / 414.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001465/0.3793, allocations: 277.1 kB / 0.5484 GB, free: 43.2 MB / 414.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0001519/0.3795, allocations: 58.14 kB / 0.5484 GB, free: 43.18 MB / 414.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.711e-05/0.3796, allocations: 37.89 kB / 0.5484 GB, free: 43.16 MB / 414.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001215/0.3808, allocations: 2.838 MB / 0.5512 GB, free: 40.36 MB / 414.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.895e-06/0.3808, allocations: 3.094 kB / 0.5512 GB, free: 40.36 MB / 414.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002264/0.3831, allocations: 1.9 MB / 0.5531 GB, free: 39.43 MB / 414.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004138/0.3835, allocations: 253.1 kB / 0.5533 GB, free: 39.26 MB / 414.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001129/0.3836, allocations: 43.2 kB / 0.5534 GB, free: 39.24 MB / 414.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004986/0.3841, allocations: 42.42 kB / 0.5534 GB, free: 39.22 MB / 414.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001326/0.3843, allocations: 67.17 kB / 0.5535 GB, free: 39.21 MB / 414.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.535e-05/0.3843, allocations: 31.36 kB / 0.5535 GB, free: 39.2 MB / 414.1 MB
Notification: Performance of sorting global known variables: time 0.0004953/0.3848, allocations: 500 kB / 0.554 GB, free: 39 MB / 414.1 MB
Notification: Performance of sort global known variables: time 1.61e-07/0.3848, allocations: 0 / 0.554 GB, free: 39 MB / 414.1 MB
Notification: Performance of remove unused functions: time 0.001205/0.386, allocations: 376.4 kB / 0.5543 GB, free: 38.96 MB / 414.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 9
 * Number of states: 25 (generator.i[3],generator.psi_s[1],generator.psi_s[2],generator.psi_rd[1],generator.psi_rq[1],line.v[1,1],line.v[1,2],line.v[1,3],line.v[2,1],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],inertia.phi,inertia.w)
 * 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 (95):
 * Single equations (assignments): 92
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 1
 * 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): 2 systems
   {(1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.002322/0.3884, allocations: 2.479 MB / 0.5568 GB, free: 37.46 MB / 414.1 MB
Notification: Performance of simCode: created initialization part: time 0.003013/0.3914, allocations: 2.124 MB / 0.5588 GB, free: 36.53 MB / 414.1 MB
Notification: Performance of simCode: created event and clocks part: time 2.845e-06/0.3914, allocations: 0 / 0.5588 GB, free: 36.53 MB / 414.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.0008338/0.3923, allocations: 0.7551 MB / 0.5596 GB, free: 36.07 MB / 414.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0008774/0.3931, allocations: 223.7 kB / 0.5598 GB, free: 35.94 MB / 414.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01793/0.4111, allocations: 13.97 MB / 0.5734 GB, free: 22.21 MB / 414.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000626/0.4118, allocations: 1.306 MB / 0.5747 GB, free: 20.88 MB / 414.1 MB
Notification: Performance of simCode: alias equations: time 0.0007207/0.4125, allocations: 312 kB / 0.575 GB, free: 20.57 MB / 414.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004656/0.413, allocations: 467.2 kB / 0.5754 GB, free: 20.11 MB / 414.1 MB
Notification: Performance of SimCode: time 1.533e-06/0.413, allocations: 0 / 0.5754 GB, free: 20.11 MB / 414.1 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.05001/0.463, allocations: 30.88 MB / 0.6056 GB, free: 5.137 MB / 430.1 MB
Notification: Performance of buildModelFMU: Generate platform static: time 13.13/13.59, allocations: 1.484 kB / 0.6056 GB, free: 5.137 MB / 430.1 MB
(rm -f PowerSystems_PowerSystems.Examples.Wind.WindTurbine_IG.pipe ; mkfifo PowerSystems_PowerSystems.Examples.Wind.WindTurbine_IG.pipe ; head -c 1048576 < PowerSystems_PowerSystems.Examples.Wind.WindTurbine_IG.pipe >> ../files/PowerSystems_PowerSystems.Examples.Wind.WindTurbine_IG.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_PowerSystems_PowerSystems_Examples_Wind_WindTurbine_IG_fmu --startTime=0 --stopTime=100 --timeout=50 --tolerance=1e-06 PowerSystems_PowerSystems_Examples_Wind_WindTurbine_IG.fmu > PowerSystems_PowerSystems.Examples.Wind.WindTurbine_IG.pipe 2>&1)