Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0-beta.om_Modelica.Fluid.Examples.Tanks.TanksWithOverflow.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001273/0.001273, allocations: 114.3 kB / 21.18 MB, free: 0.6289 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001355/0.001355, allocations: 210.9 kB / 24.48 MB, free: 4.035 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/package.mo): time 1.427/1.427, allocations: 230.4 MB / 258.1 MB, free: 8.164 MB / 206.1 MB
"
[Timeout remaining time 178]
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(Modelica.Fluid.Examples.Tanks.TanksWithOverflow,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|lowerTank.level|lowerTank.medium.h|upperTank.level|upperTank.medium.h|hysteresis.y",fileNamePrefix="Modelica_4.1.0-beta.om_Modelica.Fluid.Examples.Tanks.TanksWithOverflow")
translateModel(Modelica.Fluid.Examples.Tanks.TanksWithOverflow,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|lowerTank.level|lowerTank.medium.h|upperTank.level|upperTank.medium.h|hysteresis.y",fileNamePrefix="Modelica_4.1.0-beta.om_Modelica.Fluid.Examples.Tanks.TanksWithOverflow") [Timeout 660]
"Warning: Requested package Modelica of version trunk, but this package was already loaded with version 4.1.0. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Warning: Requested package Complex of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Warning: Requested package ModelicaServices of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Notification: Performance of FrontEnd - loaded program: time 0.001952/0.001952, allocations: 71.83 kB / 378.7 MB, free: 2.91 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2092/0.2112, allocations: 53.32 MB / 432 MB, free: 7.41 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.Tanks.TanksWithOverflow): time 0.0346/0.2458, allocations: 30.8 MB / 462.8 MB, free: 8.508 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01484/0.2606, allocations: 10.38 MB / 473.2 MB, free: 14.1 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0006328/0.2612, allocations: 31.81 kB / 473.3 MB, free: 14.07 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00116/0.2624, allocations: 496.9 kB / 473.7 MB, free: 13.58 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003922/0.2663, allocations: 1.901 MB / 475.6 MB, free: 11.67 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005875/0.2722, allocations: 2.757 MB / 478.4 MB, free: 8.922 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.004195/0.2764, allocations: 3.705 MB / 482.1 MB, free: 5.207 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001308/0.2777, allocations: 0.9704 MB / 483.1 MB, free: 4.227 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002287/0.28, allocations: 1.542 MB / 484.6 MB, free: 2.68 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002175/0.2821, allocations: 1.523 MB / 486.1 MB, free: 1.152 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002523/0.2824, allocations: 152 kB / 486.3 MB, free: 1.004 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003842/0.2862, allocations: 2.133 MB / 488.4 MB, free: 14.87 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0006323/0.2869, allocations: 0.5882 MB / 489 MB, free: 14.28 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0008756/0.2877, allocations: 0.805 MB / 489.8 MB, free: 13.47 MB / 398.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.004268/0.292, allocations: 3.368 MB / 493.2 MB, free: 10.09 MB / 398.1 MB
Notification: Performance of FrontEnd - DAE generated: time 2.775e-06/0.292, allocations: 0 / 493.2 MB, free: 10.09 MB / 398.1 MB
Notification: Performance of FrontEnd: time 1.273e-06/0.292, allocations: 0 / 493.2 MB, free: 10.09 MB / 398.1 MB
Notification: Performance of Transformations before backend: time 1.371e-05/0.292, allocations: 0 / 493.2 MB, free: 10.09 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: 271
 * Number of variables: 271
Notification: Performance of Generate backend data structure: time 0.005053/0.2971, allocations: 2.104 MB / 495.3 MB, free: 7.926 MB / 398.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.673e-05/0.2971, allocations: 12.03 kB / 495.3 MB, free: 7.914 MB / 398.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0005429/0.2977, allocations: 167 kB / 495.5 MB, free: 7.75 MB / 398.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001786/0.2994, allocations: 0.9572 MB / 496.4 MB, free: 6.75 MB / 398.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002045/0.2997, allocations: 230.5 kB / 496.6 MB, free: 6.496 MB / 398.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002113/0.2999, allocations: 103.9 kB / 496.7 MB, free: 6.395 MB / 398.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003084/0.3029, allocations: 1.79 MB / 498.5 MB, free: 4.547 MB / 398.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.136e-05/0.303, allocations: 7.953 kB / 498.5 MB, free: 4.539 MB / 398.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001599/0.3031, allocations: 43.92 kB / 498.6 MB, free: 4.496 MB / 398.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001405/0.3033, allocations: 106 kB / 498.7 MB, free: 4.391 MB / 398.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003171/0.3065, allocations: 1.776 MB / 0.4887 GB, free: 2.605 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.01241/0.3189, allocations: 6.929 MB / 0.4955 GB, free: 11.37 MB / 414.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002806/0.3217, allocations: 1.4 MB / 0.4969 GB, free: 9.965 MB / 414.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001439/0.3231, allocations: 0.8197 MB / 0.4977 GB, free: 9.145 MB / 414.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0009249/0.324, allocations: 0.6451 MB / 0.4983 GB, free: 8.367 MB / 414.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.452e-05/0.3241, allocations: 47.5 kB / 0.4983 GB, free: 8.312 MB / 414.1 MB
Notification: Performance of pre-optimization done (n=116): time 3.126e-06/0.3241, allocations: 0 / 0.4983 GB, free: 8.312 MB / 414.1 MB
Notification: Performance of matching and sorting (n=128): time 0.01738/0.3415, allocations: 6.619 MB / 0.5048 GB, free: 1.574 MB / 414.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001065/0.3416, allocations: 175.5 kB / 0.505 GB, free: 1.367 MB / 414.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001458/0.343, allocations: 1.1 MB / 0.506 GB, free: 256 kB / 414.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001266/0.3432, allocations: 49.7 kB / 0.5061 GB, free: 200 kB / 414.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004645/0.3436, allocations: 0.5013 MB / 0.5066 GB, free: 15.69 MB / 430.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004286/0.344, allocations: 456.1 kB / 0.507 GB, free: 15.24 MB / 430.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005221/0.3446, allocations: 267.5 kB / 0.5073 GB, free: 14.97 MB / 430.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001783/0.3447, allocations: 365.9 kB / 0.5076 GB, free: 14.61 MB / 430.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001555/0.3463, allocations: 0.848 MB / 0.5085 GB, free: 13.75 MB / 430.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00176/0.3481, allocations: 1.08 MB / 0.5095 GB, free: 12.6 MB / 430.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003109/0.3512, allocations: 1.804 MB / 0.5113 GB, free: 10.73 MB / 430.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.456e-06/0.3512, allocations: 4 kB / 0.5113 GB, free: 10.72 MB / 430.1 MB
Notification: Performance of matching and sorting (n=170) (initialization): time 0.005/0.3562, allocations: 2.608 MB / 0.5138 GB, free: 8.09 MB / 430.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.632e-05/0.3562, allocations: 11.94 kB / 0.5138 GB, free: 8.078 MB / 430.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.053e-05/0.3562, allocations: 4 kB / 0.5138 GB, free: 8.074 MB / 430.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00377/0.36, allocations: 1.295 MB / 0.5151 GB, free: 6.766 MB / 430.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001012/0.361, allocations: 215.6 kB / 0.5153 GB, free: 6.555 MB / 430.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007419/0.3684, allocations: 6.72 MB / 0.5219 GB, free: 15.48 MB / 446.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001105/0.3695, allocations: 75.88 kB / 0.5219 GB, free: 15.41 MB / 446.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001539/0.3697, allocations: 59.97 kB / 0.522 GB, free: 15.35 MB / 446.1 MB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001925/0.3716, allocations: 1.097 MB / 0.5231 GB, free: 14.25 MB / 446.1 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001722/0.3733, allocations: 1.066 MB / 0.5241 GB, free: 13.11 MB / 446.1 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003019/0.3763, allocations: 1.77 MB / 0.5258 GB, free: 11.26 MB / 446.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.571e-06/0.3763, allocations: 11.94 kB / 0.5258 GB, free: 11.25 MB / 446.1 MB
Notification: Performance of matching and sorting (n=170) (initialization_lambda0): time 0.00478/0.3811, allocations: 2.491 MB / 0.5283 GB, free: 8.734 MB / 446.1 MB
Notification: Performance of prepare postOptimizeDAE: time 1.129e-05/0.3811, allocations: 4 kB / 0.5283 GB, free: 8.73 MB / 446.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.129e-05/0.3811, allocations: 8 kB / 0.5283 GB, free: 8.723 MB / 446.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002598/0.3837, allocations: 1.016 MB / 0.5293 GB, free: 7.691 MB / 446.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001045/0.3848, allocations: 231.6 kB / 0.5295 GB, free: 7.465 MB / 446.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006924/0.3917, allocations: 6.476 MB / 0.5358 GB, free: 0.6328 MB / 446.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001169/0.3929, allocations: 72.02 kB / 0.5359 GB, free: 0.5625 MB / 446.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001504/0.393, allocations: 55.97 kB / 0.536 GB, free: 0.5078 MB / 446.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 21
 * Number of states: 0 ()
 * Number of discrete variables: 12 (hysteresis.y,$PRE.hysteresis.y,lowerTank.inFlow[2],lowerTank.inFlow[1],lowerTank.regularFlow[2],lowerTank.regularFlow[1],upperTank.inFlow[3],upperTank.inFlow[2],upperTank.inFlow[1],upperTank.regularFlow[3],upperTank.regularFlow[2],upperTank.regularFlow[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (126):
 * Single equations (assignments): 121
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * 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): 2 systems
   {(1,6,100.0%), (1,6,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(2,3), (4,11), (4,11)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004311/0.3935, allocations: 268.8 kB / 0.5362 GB, free: 244 kB / 446.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003026/0.3938, allocations: 143 kB / 0.5363 GB, free: 100 kB / 446.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1756/0.5694, allocations: 2.764 MB / 0.539 GB, free: 106.4 MB / 446.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.929e-05/0.5694, allocations: 7.125 kB / 0.5391 GB, free: 106.4 MB / 446.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.611e-06/0.5694, allocations: 0.7969 kB / 0.5391 GB, free: 106.4 MB / 446.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009013/0.5703, allocations: 440.3 kB / 0.5395 GB, free: 106.2 MB / 446.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002444/0.5705, allocations: 33.8 kB / 0.5395 GB, free: 106.2 MB / 446.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001015/0.5716, allocations: 64.08 kB / 0.5396 GB, free: 106.2 MB / 446.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000297/0.5718, allocations: 146.5 kB / 0.5397 GB, free: 106.1 MB / 446.1 MB
Error: Internal error IndexReduction.pantelidesIndexReduction failed! System is structurally singular and cannot be handled because the number of unassigned equations is larger than the number of states. Use -d=bltdump to get more information.
Error: Internal error Transformation Module PFPlusExt index Reduction Method Pantelides failed!
Notification: Performance of <failed> postOpt createDAEmodeBDAE (simulation): time 0.004086/0.5759, allocations: 1.763 MB / 0.5414 GB, free: 105.5 MB / 446.1 MB
Error: post-optimization module createDAEmodeBDAE (simulation) failed.
Error: Internal error SimCode DAEmode: The model Modelica.Fluid.Examples.Tanks.TanksWithOverflow could not be translated
"
[Timeout remaining time 659]
[Calling sys.exit(0), Time elapsed: 2.6700770361348987]
Failed to read output from testmodel.py, exit status != 0:
['time', 'lowerTank.level', 'lowerTank.medium.h', 'upperTank.level', 'upperTank.medium.h', 'hysteresis.y']
0.5832745172083378 0.591856553 0.29765744899999996
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fad11a22050>