Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false)
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/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(ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipe.mediums.1..h|pipe.mediums.1..p|pipe.mediums.2..h|pipe.mediums.2..p|pipe.mediums.3..h|pipe.mediums.3..p|pipe.mediums.4..h|pipe.mediums.4..p|pipe.mediums.5..h|pipe.mediums.5..p|m_flow_initial",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization")
translateModel(ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipe.mediums.1..h|pipe.mediums.1..p|pipe.mediums.2..h|pipe.mediums.2..p|pipe.mediums.3..h|pipe.mediums.3..p|pipe.mediums.4..h|pipe.mediums.4..p|pipe.mediums.5..h|pipe.mediums.5..p|m_flow_initial",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001078/0.001078, allocations: 114.3 kB / 18.46 MB, free: 4.617 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001115/0.001115, allocations: 214.8 kB / 19.41 MB, free: 3.668 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.404/1.404, allocations: 227.4 MB / 247.6 MB, free: 10.48 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2493/0.2493, allocations: 46.1 MB / 345 MB, free: 11.5 MB / 286.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001563/0.001563, allocations: 67.88 kB / 482 MB, free: 4.09 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3759/0.3775, allocations: 62.44 MB / 0.5317 GB, free: 13.61 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization): time 0.04894/0.4264, allocations: 47.85 MB / 0.5784 GB, free: 1.773 MB / 430.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03222/0.4587, allocations: 25.93 MB / 0.6037 GB, free: 7.77 MB / 462.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001379/0.4601, allocations: 35.75 kB / 0.6037 GB, free: 7.734 MB / 462.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001579/0.4618, allocations: 0.5008 MB / 0.6042 GB, free: 7.23 MB / 462.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01862/0.4804, allocations: 5.892 MB / 0.61 GB, free: 1.336 MB / 462.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01135/0.4918, allocations: 3.972 MB / 0.6139 GB, free: 13.36 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005364/0.4972, allocations: 4.301 MB / 0.6181 GB, free: 9.043 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.00208/0.4993, allocations: 1.003 MB / 0.619 GB, free: 8.016 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.07278/0.5721, allocations: 29.46 MB / 0.6478 GB, free: 10.25 MB / 0.4981 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02916/0.6013, allocations: 12.3 MB / 0.6598 GB, free: 13.79 MB / 0.5137 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007648/0.6021, allocations: 184 kB / 0.66 GB, free: 13.61 MB / 0.5137 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0215/0.6236, allocations: 8.589 MB / 0.6684 GB, free: 5.012 MB / 0.5137 GB
Notification: Performance of NFScalarize.scalarize: time 0.001504/0.6251, allocations: 0.7986 MB / 0.6692 GB, free: 4.211 MB / 0.5137 GB
Notification: Performance of NFVerifyModel.verify: time 0.002423/0.6276, allocations: 1.186 MB / 0.6703 GB, free: 3.02 MB / 0.5137 GB
Notification: Performance of NFConvertDAE.convert: time 0.01625/0.6438, allocations: 7.619 MB / 0.6778 GB, free: 11.38 MB / 0.5294 GB
Notification: Performance of FrontEnd - DAE generated: time 5.039e-06/0.6439, allocations: 0 / 0.6778 GB, free: 11.38 MB / 0.5294 GB
Notification: Performance of FrontEnd: time 1.613e-06/0.6439, allocations: 0 / 0.6778 GB, free: 11.38 MB / 0.5294 GB
Notification: Performance of Transformations before backend: time 9.359e-05/0.644, allocations: 0 / 0.6778 GB, free: 11.38 MB / 0.5294 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 509
 * Number of variables: 509
Notification: Performance of Generate backend data structure: time 0.0111/0.6551, allocations: 3.444 MB / 0.6811 GB, free: 7.879 MB / 0.5294 GB
Notification: Performance of prepare preOptimizeDAE: time 4.938e-05/0.6552, allocations: 11.97 kB / 0.6811 GB, free: 7.867 MB / 0.5294 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005289/0.6604, allocations: 0.6613 MB / 0.6818 GB, free: 7.203 MB / 0.5294 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002996/0.6635, allocations: 1.254 MB / 0.683 GB, free: 5.906 MB / 0.5294 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002136/0.6637, allocations: 163.2 kB / 0.6832 GB, free: 5.746 MB / 0.5294 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005544/0.6643, allocations: 171.9 kB / 0.6833 GB, free: 5.578 MB / 0.5294 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008157/0.6724, allocations: 3.522 MB / 0.6868 GB, free: 1.93 MB / 0.5294 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.239e-05/0.6725, allocations: 7.938 kB / 0.6868 GB, free: 1.922 MB / 0.5294 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002864/0.6728, allocations: 71.98 kB / 0.6868 GB, free: 1.852 MB / 0.5294 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002276/0.673, allocations: 227.4 kB / 0.6871 GB, free: 1.629 MB / 0.5294 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007865/0.6809, allocations: 3.437 MB / 0.6904 GB, free: 14.19 MB / 0.545 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.02044/0.7014, allocations: 14.08 MB / 0.7042 GB, free: 15.06 MB / 0.5606 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005759/0.7072, allocations: 2.191 MB / 0.7063 GB, free: 12.83 MB / 0.5606 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002365/0.7096, allocations: 1.167 MB / 0.7074 GB, free: 11.64 MB / 0.5606 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.4781/1.188, allocations: 70.99 MB / 0.7768 GB, free: 58.62 MB / 0.5606 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004207/1.192, allocations: 1.674 MB / 0.7784 GB, free: 57.49 MB / 0.5606 GB
Notification: Performance of pre-optimization done (n=154): time 4.128e-06/1.192, allocations: 0 / 0.7784 GB, free: 57.49 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=174): time 0.01861/1.211, allocations: 9.249 MB / 0.7874 GB, free: 50.62 MB / 0.5606 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001037/1.211, allocations: 281.2 kB / 0.7877 GB, free: 50.29 MB / 0.5606 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001469/1.212, allocations: 1.337 MB / 0.789 GB, free: 49.29 MB / 0.5606 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001632/1.212, allocations: 57.27 kB / 0.7891 GB, free: 49.25 MB / 0.5606 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004787/1.213, allocations: 0.8355 MB / 0.7899 GB, free: 48.64 MB / 0.5606 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003911/1.213, allocations: 0.5993 MB / 0.7905 GB, free: 48.13 MB / 0.5606 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005978/1.214, allocations: 458.6 kB / 0.7909 GB, free: 47.84 MB / 0.5606 GB
Notification: Performance of setup shared object (initialization): time 4.382e-05/1.214, allocations: 301.1 kB / 0.7912 GB, free: 47.54 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001997/1.216, allocations: 1.292 MB / 0.7925 GB, free: 46.66 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002286/1.218, allocations: 1.863 MB / 0.7943 GB, free: 45.02 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004282/1.223, allocations: 3.173 MB / 0.7974 GB, free: 42.67 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.317e-06/1.223, allocations: 4 kB / 0.7974 GB, free: 42.67 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=275) (initialization): time 0.006902/1.229, allocations: 4.343 MB / 0.8016 GB, free: 39.75 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 2.49e-05/1.23, allocations: 12 kB / 0.8016 GB, free: 39.74 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.489e-05/1.23, allocations: 23.88 kB / 0.8017 GB, free: 39.72 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01382/1.243, allocations: 3.568 MB / 0.8051 GB, free: 36.57 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001288/1.245, allocations: 343.4 kB / 0.8055 GB, free: 36.28 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006056/1.251, allocations: 3.952 MB / 0.8093 GB, free: 33.39 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002151/1.253, allocations: 150 kB / 0.8095 GB, free: 33.29 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001887/1.253, allocations: 110.8 kB / 0.8096 GB, free: 33.2 MB / 0.5606 GB
Warning: Assuming fixed start value for the following 1 variables:
         m_flow_initial:DISCRETE(unit = "kg/s" fixed = true )  type: Real
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002798/1.256, allocations: 1.695 MB / 0.8112 GB, free: 32.04 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002183/1.258, allocations: 1.776 MB / 0.813 GB, free: 30.46 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.004077/1.262, allocations: 2.981 MB / 0.8159 GB, free: 27.99 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.002e-05/1.262, allocations: 4 kB / 0.8159 GB, free: 27.99 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=275) (initialization_lambda0): time 0.006985/1.269, allocations: 4.058 MB / 0.8198 GB, free: 24.02 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 2.332e-05/1.269, allocations: 12 kB / 0.8199 GB, free: 24.01 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.412e-05/1.269, allocations: 16.88 kB / 0.8199 GB, free: 24 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007958/1.277, allocations: 2.327 MB / 0.8221 GB, free: 21.66 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001451/1.279, allocations: 367.7 kB / 0.8225 GB, free: 21.33 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004593/1.283, allocations: 3.269 MB / 0.8257 GB, free: 18.05 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001968/1.285, allocations: 155.1 kB / 0.8258 GB, free: 17.9 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003086/1.286, allocations: 104 kB / 0.8259 GB, free: 17.8 MB / 0.5606 GB
Warning: Assuming fixed start value for the following 1 variables:
         m_flow_initial:DISCRETE(unit = "kg/s" fixed = true )  type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 77
 * Number of states: 0 ()
 * Number of discrete variables: 17 (source.medium.phase,$PRE.m_flow_initial,m_flow_initial,$whenCondition2,$whenCondition1,pipe.state_a.phase,valve.state_b.phase,valve.state_a.phase,pipe.statesFM[6].phase,pipe.statesFM[5].phase,pipe.statesFM[4].phase,pipe.statesFM[3].phase,pipe.statesFM[2].phase,sink.state.phase,sink.medium.phase,pipe.state_b.phase,source.state.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (171):
 * Single equations (assignments): 170
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * 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): 1 system
   {(14,91)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007537/1.286, allocations: 320.7 kB / 0.8262 GB, free: 17.51 MB / 0.5606 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005057/1.287, allocations: 158.1 kB / 0.8264 GB, free: 17.35 MB / 0.5606 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008946/1.296, allocations: 6.684 MB / 0.8329 GB, free: 10.65 MB / 0.5606 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00613/1.302, allocations: 5.401 MB / 0.8382 GB, free: 5.145 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.285e-05/1.302, allocations: 0 / 0.8382 GB, free: 5.145 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001273/1.303, allocations: 0.6026 MB / 0.8388 GB, free: 4.52 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005424/1.304, allocations: 102.6 kB / 0.8389 GB, free: 4.422 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001589/1.306, allocations: 147.8 kB / 0.839 GB, free: 4.277 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003506/1.306, allocations: 185.7 kB / 0.8392 GB, free: 4.094 MB / 0.5606 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.007516/1.313, allocations: 5.017 MB / 0.8441 GB, free: 15.09 MB / 0.5762 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.009988/1.323, allocations: 7.034 MB / 0.851 GB, free: 8.023 MB / 0.5762 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003057/1.327, allocations: 2.216 MB / 0.8531 GB, free: 5.812 MB / 0.5762 GB
Notification: Performance of sorting global known variables: time 0.00213/1.329, allocations: 1.252 MB / 0.8544 GB, free: 4.566 MB / 0.5762 GB
Notification: Performance of Backend: time 4.61e-07/1.329, allocations: 4 kB / 0.8544 GB, free: 4.562 MB / 0.5762 GB
Notification: Performance of simCode: created initialization part: time 0.01896/1.348, allocations: 5.588 MB / 0.8598 GB, free: 15.43 MB / 0.5919 GB
Notification: Performance of SimCode: time 0.01051/1.358, allocations: 5.618 MB / 0.8653 GB, free: 9.824 MB / 0.5919 GB
Notification: Performance of Templates: time 0.156/1.514, allocations: 98 MB / 0.961 GB, free: 8.238 MB / 0.6856 GB
make -j1 -f ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization.makefile
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization.sim & ./ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization.pipe 2>&1)
diffSimulationResults("ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/ModelicaTest/Fluid/TestPipesAndValves/DynamicPipeInitialization/DynamicPipeInitialization.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches