Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSystems_latest_PowerSystems.Examples.Wind.WindFarm.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001614/0.001614, allocations: 112 kB / 20.43 MB, free: 1.309 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001607/0.001607, allocations: 188.8 kB / 23.72 MB, free: 4.555 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.479/1.479, allocations: 225.6 MB / 252.5 MB, free: 13.02 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0-master/package.mo): time 0.1853/0.1853, allocations: 38.54 MB / 346.3 MB, free: 2.199 MB / 270.1 MB
"
[Timeout remaining time 180]
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.Wind.WindFarm,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|meter.i.1.|meter.i.2.|meter.i.3.|meter.p.1.|meter.p.2.|meter.p.3.|meter.v.1.|meter.v.2.|meter.v.3.",fileNamePrefix="PowerSystems_latest_PowerSystems.Examples.Wind.WindFarm")
translateModel(PowerSystems.Examples.Wind.WindFarm,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|meter.i.1.|meter.i.2.|meter.i.3.|meter.p.1.|meter.p.2.|meter.p.3.|meter.v.1.|meter.v.2.|meter.v.3.",fileNamePrefix="PowerSystems_latest_PowerSystems.Examples.Wind.WindFarm") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.002012/0.002012, allocations: 67.91 kB / 484.5 MB, free: 11.16 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3481/0.3501, allocations: 61.29 MB / 0.533 GB, free: 5.578 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.Wind.WindFarm): time 0.04603/0.3962, allocations: 39.63 MB / 0.5717 GB, free: 4.418 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03915/0.4353, allocations: 17.41 MB / 0.5887 GB, free: 2.953 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.008191/0.4435, allocations: 329.3 kB / 0.589 GB, free: 2.629 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.05503/0.4985, allocations: 25.59 MB / 0.614 GB, free: 8.992 MB / 462.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01456/0.5131, allocations: 5.025 MB / 0.6189 GB, free: 3.945 MB / 462.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.009637/0.5227, allocations: 3.362 MB / 0.6222 GB, free: 0.5781 MB / 462.1 MB
Notification: Performance of NFFlatten.flatten: time 0.03101/0.5537, allocations: 17.46 MB / 0.6393 GB, free: 15.08 MB / 494.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01093/0.5647, allocations: 3.984 MB / 0.6432 GB, free: 11.03 MB / 494.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.01238/0.577, allocations: 5.695 MB / 0.6487 GB, free: 5.312 MB / 494.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01285/0.5899, allocations: 7.079 MB / 0.6556 GB, free: 14.21 MB / 0.4981 GB
Notification: Performance of NFPackage.collectConstants: time 0.003978/0.5939, allocations: 0.8789 MB / 0.6565 GB, free: 13.33 MB / 0.4981 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.007229/0.6011, allocations: 1.842 MB / 0.6583 GB, free: 11.49 MB / 0.4981 GB
Notification: Performance of NFScalarize.scalarize: time 0.00798/0.6091, allocations: 4.352 MB / 0.6625 GB, free: 7.125 MB / 0.4981 GB
Notification: Performance of NFVerifyModel.verify: time 0.01173/0.6208, allocations: 4.775 MB / 0.6672 GB, free: 2.328 MB / 0.4981 GB
Notification: Performance of NFConvertDAE.convert: time 0.02124/0.642, allocations: 13.11 MB / 0.68 GB, free: 5.172 MB / 0.5137 GB
Notification: Performance of FrontEnd - DAE generated: time 5.68e-06/0.6421, allocations: 0 / 0.68 GB, free: 5.172 MB / 0.5137 GB
Notification: Performance of FrontEnd: time 1.653e-06/0.6421, allocations: 4 kB / 0.68 GB, free: 5.168 MB / 0.5137 GB
Notification: Performance of Transformations before backend: time 0.0003837/0.6424, allocations: 0 / 0.68 GB, free: 5.168 MB / 0.5137 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1835
 * Number of variables: 1835
Notification: Performance of Generate backend data structure: time 0.02452/0.667, allocations: 8.992 MB / 0.6888 GB, free: 12.08 MB / 0.5294 GB
Notification: Performance of prepare preOptimizeDAE: time 3.848e-05/0.667, allocations: 8.031 kB / 0.6888 GB, free: 12.07 MB / 0.5294 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008782/0.6758, allocations: 1.404 MB / 0.6902 GB, free: 10.66 MB / 0.5294 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0175/0.6933, allocations: 5.884 MB / 0.6959 GB, free: 4.668 MB / 0.5294 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007715/0.694, allocations: 484.5 kB / 0.6964 GB, free: 4.191 MB / 0.5294 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005689/0.6997, allocations: 0.9562 MB / 0.6973 GB, free: 3.234 MB / 0.5294 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02351/0.7232, allocations: 10.03 MB / 0.7071 GB, free: 8.902 MB / 0.545 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002112/0.7235, allocations: 35.77 kB / 0.7071 GB, free: 8.867 MB / 0.545 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008336/0.7243, allocations: 267.9 kB / 0.7074 GB, free: 8.605 MB / 0.545 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002708/0.727, allocations: 0.8403 MB / 0.7082 GB, free: 7.762 MB / 0.545 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01782/0.7448, allocations: 8.265 MB / 0.7163 GB, free: 15.48 MB / 0.5606 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.5754/1.32, allocations: 35.84 MB / 0.7513 GB, free: 90.54 MB / 0.5607 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0102/1.33, allocations: 6.225 MB / 0.7574 GB, free: 89.95 MB / 0.5607 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00534/1.336, allocations: 2.91 MB / 0.7602 GB, free: 89.82 MB / 0.5607 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003596/1.336, allocations: 87.2 kB / 0.7603 GB, free: 89.8 MB / 0.5607 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.501e-05/1.336, allocations: 100.9 kB / 0.7604 GB, free: 89.76 MB / 0.5607 GB
Notification: Performance of pre-optimization done (n=559): time 7.995e-06/1.336, allocations: 0 / 0.7604 GB, free: 89.76 MB / 0.5607 GB
Notification: Performance of matching and sorting (n=617): time 0.0476/1.384, allocations: 31.58 MB / 0.7912 GB, free: 76.53 MB / 0.5607 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001223/1.384, allocations: 405.1 kB / 0.7916 GB, free: 76.06 MB / 0.5607 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004735/1.389, allocations: 4.167 MB / 0.7957 GB, free: 72.63 MB / 0.5607 GB
Notification: Performance of collectPreVariables (initialization): time 0.00104/1.39, allocations: 140.7 kB / 0.7958 GB, free: 72.49 MB / 0.5607 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001532/1.391, allocations: 3.339 MB / 0.7991 GB, free: 69.85 MB / 0.5607 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002123/1.393, allocations: 2.3 MB / 0.8013 GB, free: 68.07 MB / 0.5607 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001678/1.395, allocations: 1.249 MB / 0.8026 GB, free: 66.93 MB / 0.5607 GB
Notification: Performance of setup shared object (initialization): time 3.553e-05/1.395, allocations: 305.1 kB / 0.8028 GB, free: 66.63 MB / 0.5607 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004078/1.399, allocations: 3.108 MB / 0.8059 GB, free: 63.95 MB / 0.5607 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004727/1.404, allocations: 4.941 MB / 0.8107 GB, free: 58.8 MB / 0.5607 GB
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.04658/1.45, allocations: 26.93 MB / 0.837 GB, free: 31.81 MB / 0.5607 GB
Warning: It was not possible to solve the under-determined initial system (646 equations and 676 variables)
Error: No system for the symbolic initialization was generated
"
[Timeout remaining time 659]
[Calling sys.exit(0), Time elapsed: 4.179946945980191]
Failed to read output from testmodel.py, exit status != 0:
1.4722016528248787 1.480772983 0.836150492
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f4ff97d97b0>