Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank.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/ModelicaTest 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaTest with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/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: translateModel(ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|tank.level|tank.medium.T|timeTable.a|timeTable.b|timeTable.last|timeTable.nextEvent",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank")
translateModel(ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|tank.level|tank.medium.T|timeTable.a|timeTable.b|timeTable.last|timeTable.nextEvent",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001132/0.001132, allocations: 105.7 kB / 17.08 MB, free: 5.797 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.0009807/0.0009807, allocations: 198.1 kB / 18.02 MB, free: 4.918 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.337/1.337, allocations: 205.1 MB / 223.9 MB, free: 12.23 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo): time 0.19/0.19, allocations: 43.53 MB / 314.8 MB, free: 464 kB / 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.001545/0.001545, allocations: 65.97 kB / 442.5 MB, free: 5.664 MB / 318.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1048/0.1063, allocations: 57.79 MB / 0.4885 GB, free: 11.8 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank): time 0.01899/0.1254, allocations: 16.7 MB / 0.5048 GB, free: 11.03 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01005/0.1355, allocations: 6.899 MB / 0.5116 GB, free: 4.113 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0007977/0.1363, allocations: 19.88 kB / 0.5116 GB, free: 4.094 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001119/0.1375, allocations: 389.8 kB / 0.512 GB, free: 3.711 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.002611/0.1401, allocations: 1.007 MB / 0.513 GB, free: 2.699 MB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00494/0.1451, allocations: 1.991 MB / 0.5149 GB, free: 0.7031 MB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002829/0.1479, allocations: 2.203 MB / 0.5171 GB, free: 14.49 MB / 414.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001231/0.1492, allocations: 0.6411 MB / 0.5177 GB, free: 13.84 MB / 414.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001689/0.1509, allocations: 0.8489 MB / 0.5185 GB, free: 12.98 MB / 414.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001522/0.1524, allocations: 0.8332 MB / 0.5193 GB, free: 12.15 MB / 414.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002823/0.1527, allocations: 87.94 kB / 0.5194 GB, free: 12.06 MB / 414.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002654/0.1554, allocations: 1.303 MB / 0.5207 GB, free: 10.76 MB / 414.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004372/0.1558, allocations: 339.1 kB / 0.521 GB, free: 10.43 MB / 414.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.000694/0.1565, allocations: 493.7 kB / 0.5215 GB, free: 9.941 MB / 414.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.00295/0.1595, allocations: 1.979 MB / 0.5234 GB, free: 7.957 MB / 414.1 MB
Notification: Performance of FrontEnd - DAE generated: time 3.457e-06/0.1595, allocations: 0 / 0.5234 GB, free: 7.957 MB / 414.1 MB
Notification: Performance of FrontEnd: time 1.433e-06/0.1595, allocations: 0 / 0.5234 GB, free: 7.957 MB / 414.1 MB
Notification: Performance of Transformations before backend: time 3.55e-05/0.1596, allocations: 4 kB / 0.5234 GB, free: 7.953 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: 153
 * Number of variables: 153
Notification: Performance of Generate backend data structure: time 0.003301/0.1629, allocations: 1.388 MB / 0.5248 GB, free: 6.508 MB / 414.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.363e-05/0.1629, allocations: 11.89 kB / 0.5248 GB, free: 6.496 MB / 414.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004618/0.1634, allocations: 107.8 kB / 0.5249 GB, free: 6.391 MB / 414.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001109/0.1645, allocations: 0.6594 MB / 0.5255 GB, free: 5.684 MB / 414.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001308/0.1647, allocations: 112.6 kB / 0.5256 GB, free: 5.562 MB / 414.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001239/0.1648, allocations: 55.89 kB / 0.5257 GB, free: 5.508 MB / 414.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001626/0.1664, allocations: 1.011 MB / 0.5267 GB, free: 4.453 MB / 414.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.933e-05/0.1665, allocations: 0 / 0.5267 GB, free: 4.453 MB / 414.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.886e-05/0.1666, allocations: 27.98 kB / 0.5267 GB, free: 4.426 MB / 414.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.053e-05/0.1666, allocations: 49.28 kB / 0.5267 GB, free: 4.379 MB / 414.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001494/0.1682, allocations: 0.9223 MB / 0.5276 GB, free: 3.457 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.2118/0.3799, allocations: 4.04 MB / 0.5316 GB, free: 40.18 MB / 414.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009606/0.3809, allocations: 0.6522 MB / 0.5322 GB, free: 40.15 MB / 414.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005337/0.3815, allocations: 400.8 kB / 0.5326 GB, free: 40.14 MB / 414.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.002802/0.3843, allocations: 2.338 MB / 0.5349 GB, free: 38.74 MB / 414.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.000701/0.385, allocations: 0.4933 MB / 0.5354 GB, free: 38.63 MB / 414.1 MB
Notification: Performance of pre-optimization done (n=48): time 2.364e-06/0.385, allocations: 0 / 0.5354 GB, free: 38.63 MB / 414.1 MB
Notification: Performance of matching and sorting (n=53): time 0.005027/0.39, allocations: 2.613 MB / 0.5379 GB, free: 37.91 MB / 414.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.615e-05/0.3901, allocations: 249.5 kB / 0.5382 GB, free: 37.63 MB / 414.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0009422/0.3911, allocations: 0.8398 MB / 0.539 GB, free: 37.29 MB / 414.1 MB
Notification: Performance of collectPreVariables (initialization): time 5.751e-05/0.3911, allocations: 38.11 kB / 0.539 GB, free: 37.25 MB / 414.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002378/0.3914, allocations: 418 kB / 0.5394 GB, free: 36.92 MB / 414.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001248/0.3915, allocations: 181.5 kB / 0.5396 GB, free: 36.79 MB / 414.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002524/0.3918, allocations: 161.5 kB / 0.5397 GB, free: 36.72 MB / 414.1 MB
Notification: Performance of setup shared object (initialization): time 6.229e-05/0.3918, allocations: 345 kB / 0.5401 GB, free: 36.4 MB / 414.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005479/0.3924, allocations: 379.2 kB / 0.5404 GB, free: 36.27 MB / 414.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006541/0.393, allocations: 0.6125 MB / 0.541 GB, free: 35.85 MB / 414.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001132/0.3942, allocations: 0.9722 MB / 0.542 GB, free: 35.28 MB / 414.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.412e-06/0.3942, allocations: 2.406 kB / 0.542 GB, free: 35.28 MB / 414.1 MB
Notification: Performance of matching and sorting (n=97) (initialization): time 0.002041/0.3962, allocations: 1.274 MB / 0.5432 GB, free: 34.79 MB / 414.1 MB
Notification: Performance of prepare postOptimizeDAE: time 4.105e-05/0.3963, allocations: 38.39 kB / 0.5433 GB, free: 34.75 MB / 414.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.116e-05/0.3963, allocations: 8.5 kB / 0.5433 GB, free: 34.75 MB / 414.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009376/0.3973, allocations: 364.7 kB / 0.5436 GB, free: 34.67 MB / 414.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006036/0.3979, allocations: 153.4 kB / 0.5438 GB, free: 34.66 MB / 414.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001262/0.3992, allocations: 1.453 MB / 0.5452 GB, free: 33.46 MB / 414.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007175/0.3999, allocations: 35.69 kB / 0.5452 GB, free: 33.45 MB / 414.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001146/0.4, allocations: 35.53 kB / 0.5453 GB, free: 33.45 MB / 414.1 MB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0009649/0.401, allocations: 0.5707 MB / 0.5458 GB, free: 33.19 MB / 414.1 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0007437/0.4017, allocations: 0.6191 MB / 0.5464 GB, free: 32.75 MB / 414.1 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001231/0.403, allocations: 0.9644 MB / 0.5474 GB, free: 32.16 MB / 414.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 8.997e-06/0.403, allocations: 5.25 kB / 0.5474 GB, free: 32.16 MB / 414.1 MB
Notification: Performance of matching and sorting (n=97) (initialization_lambda0): time 0.002126/0.4051, allocations: 1.255 MB / 0.5486 GB, free: 31.66 MB / 414.1 MB
Notification: Performance of prepare postOptimizeDAE: time 3.301e-05/0.4052, allocations: 39.31 kB / 0.5486 GB, free: 31.63 MB / 414.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.868e-06/0.4052, allocations: 7.484 kB / 0.5486 GB, free: 31.63 MB / 414.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007932/0.406, allocations: 344.6 kB / 0.549 GB, free: 31.55 MB / 414.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006123/0.4066, allocations: 153.6 kB / 0.5491 GB, free: 31.54 MB / 414.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001095/0.4077, allocations: 1.434 MB / 0.5505 GB, free: 30.35 MB / 414.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009435/0.4087, allocations: 40.59 kB / 0.5506 GB, free: 30.34 MB / 414.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.873e-05/0.4088, allocations: 39.81 kB / 0.5506 GB, free: 30.33 MB / 414.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 29
 * Number of states: 0 ()
 * Number of discrete variables: 11 (timeTable.nextEventScaled,timeTable.nextEvent,$PRE.timeTable.nextEvent,timeTable.last,timeTable.b,timeTable.a,tank.inFlow[2],tank.inFlow[1],tank.regularFlow[2],tank.regularFlow[1],$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (85):
 * Single equations (assignments): 82
 * Array equations: 0
 * Algorithm blocks: 1
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(2,1), (2,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004764/0.4093, allocations: 273.2 kB / 0.5509 GB, free: 30.07 MB / 414.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001726/0.4094, allocations: 88.25 kB / 0.5509 GB, free: 30.03 MB / 414.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002306/0.4118, allocations: 1.104 MB / 0.552 GB, free: 29.6 MB / 414.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.015e-05/0.4118, allocations: 2.578 kB / 0.552 GB, free: 29.6 MB / 414.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.518e-06/0.4118, allocations: 5.344 kB / 0.552 GB, free: 29.6 MB / 414.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003664/0.4122, allocations: 248.6 kB / 0.5523 GB, free: 29.42 MB / 414.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001421/0.4123, allocations: 17.66 kB / 0.5523 GB, free: 29.41 MB / 414.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005081/0.4128, allocations: 32.88 kB / 0.5523 GB, free: 29.4 MB / 414.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001385/0.413, allocations: 46.44 kB / 0.5524 GB, free: 29.39 MB / 414.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002002/0.415, allocations: 1.127 MB / 0.5535 GB, free: 28.89 MB / 414.1 MB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.00196/0.417, allocations: 1.495 MB / 0.5549 GB, free: 28.21 MB / 414.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0005347/0.4175, allocations: 405.2 kB / 0.5553 GB, free: 28.07 MB / 414.1 MB
Notification: Performance of sorting global known variables: time 0.0007142/0.4182, allocations: 0.5804 MB / 0.5559 GB, free: 27.84 MB / 414.1 MB
Notification: Performance of Backend: time 2.4e-07/0.4182, allocations: 0 / 0.5559 GB, free: 27.84 MB / 414.1 MB
Notification: Performance of simCode: created initialization part: time 0.004435/0.4227, allocations: 1.801 MB / 0.5576 GB, free: 27.2 MB / 414.1 MB
Notification: Performance of SimCode: time 0.002764/0.4254, allocations: 2.31 MB / 0.5599 GB, free: 25.82 MB / 414.1 MB
Notification: Performance of Templates: time 0.03058/0.456, allocations: 26.3 MB / 0.5856 GB, free: 2.293 MB / 414.1 MB
make -j1 -f ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank.makefile
(rm -f ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank.pipe ; mkfifo ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank.pipe ; head -c 1048576 < ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank.pipe >> ../files/ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank.sim & ./ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Vessels.TestSimpleTank.pipe 2>&1)