Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances.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.TestComponents.Fittings.TestJunctionTraceSubstances,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junction1.mC_scaled.1.|junction1.medium.T|junction1.medium.Xi.1.|junction1.medium.p",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances")
translateModel(ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junction1.mC_scaled.1.|junction1.medium.T|junction1.medium.Xi.1.|junction1.medium.p",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001265/0.001266, allocations: 118.3 kB / 18.46 MB, free: 4.613 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001299/0.0013, allocations: 210.7 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.447/1.447, allocations: 227.4 MB / 247.6 MB, free: 10.49 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2254/0.2254, allocations: 46.1 MB / 345 MB, free: 11.52 MB / 286.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001536/0.001536, allocations: 79.88 kB / 482 MB, free: 4.07 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3968/0.3984, allocations: 62.44 MB / 0.5317 GB, free: 13.59 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances): time 0.7651/1.164, allocations: 319 MB / 0.8432 GB, free: 11.04 MB / 0.5763 GB
Notification: Performance of NFInst.instExpressions: time 0.03222/1.196, allocations: 23.25 MB / 0.8659 GB, free: 7.82 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003047/1.199, allocations: 61.03 kB / 0.8659 GB, free: 7.785 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.003289/1.202, allocations: 1.123 MB / 0.867 GB, free: 6.988 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.02588/1.228, allocations: 7.148 MB / 0.874 GB, free: 0.582 MB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02636/1.255, allocations: 8.45 MB / 0.8823 GB, free: 8.125 MB / 0.6075 GB
Notification: Performance of NFFlatten.flatten: time 0.009657/1.264, allocations: 6.223 MB / 0.8883 GB, free: 1.891 MB / 0.6075 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004389/1.269, allocations: 2.065 MB / 0.8904 GB, free: 15.79 MB / 0.6231 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01122/1.28, allocations: 4.143 MB / 0.8944 GB, free: 11.63 MB / 0.6231 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.006713/1.287, allocations: 2.847 MB / 0.8972 GB, free: 8.777 MB / 0.6231 GB
Notification: Performance of NFPackage.collectConstants: time 0.001681/1.288, allocations: 288 kB / 0.8975 GB, free: 8.496 MB / 0.6231 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03736/1.326, allocations: 16.36 MB / 0.9134 GB, free: 8.109 MB / 0.6388 GB
Notification: Performance of NFScalarize.scalarize: time 0.002913/1.329, allocations: 1.224 MB / 0.9146 GB, free: 6.883 MB / 0.6388 GB
Notification: Performance of NFVerifyModel.verify: time 0.004304/1.333, allocations: 1.49 MB / 0.9161 GB, free: 5.387 MB / 0.6388 GB
Notification: Performance of NFConvertDAE.convert: time 0.03496/1.368, allocations: 11.95 MB / 0.9278 GB, free: 9.41 MB / 0.6544 GB
Notification: Performance of FrontEnd - DAE generated: time 6.532e-06/1.368, allocations: 0 / 0.9278 GB, free: 9.41 MB / 0.6544 GB
Notification: Performance of FrontEnd: time 1.613e-06/1.368, allocations: 0 / 0.9278 GB, free: 9.41 MB / 0.6544 GB
Notification: Performance of Transformations before backend: time 0.0001607/1.368, allocations: 0 / 0.9278 GB, free: 9.41 MB / 0.6544 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 498
 * Number of variables: 498
Notification: Performance of Generate backend data structure: time 0.01704/1.385, allocations: 4.708 MB / 0.9324 GB, free: 4.629 MB / 0.6544 GB
Notification: Performance of prepare preOptimizeDAE: time 6.333e-05/1.385, allocations: 9.469 kB / 0.9324 GB, free: 4.621 MB / 0.6544 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002104/1.388, allocations: 288.8 kB / 0.9326 GB, free: 4.336 MB / 0.6544 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005931/1.393, allocations: 1.529 MB / 0.9341 GB, free: 2.75 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002308/1.394, allocations: 151.5 kB / 0.9343 GB, free: 2.602 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0009396/1.395, allocations: 184 kB / 0.9345 GB, free: 2.422 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007567/1.402, allocations: 3.142 MB / 0.9375 GB, free: 15.23 MB / 0.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.128e-05/1.402, allocations: 0 / 0.9375 GB, free: 15.23 MB / 0.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003997/1.403, allocations: 79.95 kB / 0.9376 GB, free: 15.15 MB / 0.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002691/1.403, allocations: 195.7 kB / 0.9378 GB, free: 14.96 MB / 0.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006656/1.41, allocations: 3.513 MB / 0.9412 GB, free: 11.45 MB / 0.67 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.02364/1.433, allocations: 12.82 MB / 0.9537 GB, free: 13.68 MB / 0.6856 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003532/1.437, allocations: 1.709 MB / 0.9554 GB, free: 11.97 MB / 0.6856 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001928/1.439, allocations: 1.133 MB / 0.9565 GB, free: 10.84 MB / 0.6856 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001591/1.44, allocations: 1.666 MB / 0.9581 GB, free: 8.824 MB / 0.6856 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.675e-05/1.441, allocations: 59.88 kB / 0.9582 GB, free: 8.754 MB / 0.6856 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001587/1.442, allocations: 293.5 kB / 0.9585 GB, free: 8.465 MB / 0.6856 GB
Notification: Performance of pre-optimization done (n=153): time 9.748e-06/1.442, allocations: 0 / 0.9585 GB, free: 8.465 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=165): time 0.02857/1.471, allocations: 8.878 MB / 0.9671 GB, free: 15.49 MB / 0.7013 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001415/1.471, allocations: 197.2 kB / 0.9673 GB, free: 15.26 MB / 0.7013 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0049/1.476, allocations: 2.065 MB / 0.9693 GB, free: 13.15 MB / 0.7013 GB
Notification: Performance of collectPreVariables (initialization): time 0.000583/1.476, allocations: 61.7 kB / 0.9694 GB, free: 13.09 MB / 0.7013 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001177/1.478, allocations: 0.9854 MB / 0.9704 GB, free: 12.09 MB / 0.7013 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001165/1.479, allocations: 0.5777 MB / 0.9709 GB, free: 11.5 MB / 0.7013 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00203/1.481, allocations: 0.4919 MB / 0.9714 GB, free: 11 MB / 0.7013 GB
Notification: Performance of setup shared object (initialization): time 0.0002044/1.481, allocations: 301.1 kB / 0.9717 GB, free: 10.7 MB / 0.7013 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003088/1.484, allocations: 1.353 MB / 0.973 GB, free: 9.34 MB / 0.7013 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003406/1.488, allocations: 1.726 MB / 0.9747 GB, free: 7.469 MB / 0.7013 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006141/1.494, allocations: 3 MB / 0.9776 GB, free: 4.336 MB / 0.7013 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.31e-05/1.494, allocations: 4 kB / 0.9776 GB, free: 4.332 MB / 0.7013 GB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.009269/1.503, allocations: 3.967 MB / 0.9815 GB, free: 344 kB / 0.7013 GB
Notification: Performance of prepare postOptimizeDAE: time 6.679e-05/1.503, allocations: 63.39 kB / 0.9816 GB, free: 268 kB / 0.7013 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.18e-05/1.503, allocations: 8 kB / 0.9816 GB, free: 260 kB / 0.7013 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007713/1.511, allocations: 1.286 MB / 0.9828 GB, free: 14.96 MB / 0.7169 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002484/1.513, allocations: 495.2 kB / 0.9833 GB, free: 14.48 MB / 0.7169 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003587/1.517, allocations: 2.112 MB / 0.9854 GB, free: 12.32 MB / 0.7169 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002778/1.52, allocations: 115.9 kB / 0.9855 GB, free: 12.2 MB / 0.7169 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005218/1.52, allocations: 131.9 kB / 0.9856 GB, free: 12.07 MB / 0.7169 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003954/1.524, allocations: 1.738 MB / 0.9873 GB, free: 10.33 MB / 0.7169 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003173/1.528, allocations: 1.693 MB / 0.989 GB, free: 8.48 MB / 0.7169 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.005588/1.533, allocations: 2.926 MB / 0.9918 GB, free: 5.414 MB / 0.7169 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.318e-05/1.533, allocations: 0 / 0.9918 GB, free: 5.414 MB / 0.7169 GB
Notification: Performance of matching and sorting (n=280) (initialization_lambda0): time 0.01129/1.544, allocations: 4.053 MB / 0.9958 GB, free: 1.332 MB / 0.7169 GB
Notification: Performance of prepare postOptimizeDAE: time 6.992e-05/1.545, allocations: 63.41 kB / 0.9958 GB, free: 1.258 MB / 0.7169 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.389e-05/1.545, allocations: 8 kB / 0.9958 GB, free: 1.25 MB / 0.7169 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005107/1.55, allocations: 0.9229 MB / 0.9967 GB, free: 328 kB / 0.7169 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.488/2.038, allocations: 0.4883 MB / 0.9972 GB, free: 95.32 MB / 0.7169 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003492/2.041, allocations: 1.902 MB / 0.9991 GB, free: 94.29 MB / 0.7169 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003067/2.044, allocations: 113.6 kB / 0.9992 GB, free: 94.29 MB / 0.7169 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003921/2.045, allocations: 132.3 kB / 0.9993 GB, free: 94.29 MB / 0.7169 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 38
 * Number of states: 0 ()
 * Number of discrete variables: 2 (traceSubstance2.ind,traceSubstance.ind)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (255):
 * Single equations (assignments): 251
 * Array equations: 0
 * Algorithm blocks: 2
 * 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,6), (4,15)}
Notification: Performance of prepare postOptimizeDAE: time 0.000938/2.046, allocations: 313.2 kB / 0.9996 GB, free: 94.11 MB / 0.7169 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008011/2.046, allocations: 225.1 kB / 0.9998 GB, free: 94.11 MB / 0.7169 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008583/2.055, allocations: 4.156 MB / 1.004 GB, free: 93.9 MB / 0.7169 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.343e-05/2.055, allocations: 11.2 kB / 1.004 GB, free: 93.9 MB / 0.7169 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.927e-06/2.055, allocations: 8.734 kB / 1.004 GB, free: 93.9 MB / 0.7169 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008069/2.056, allocations: 301.7 kB / 1.004 GB, free: 93.8 MB / 0.7169 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004669/2.056, allocations: 37.19 kB / 1.004 GB, free: 93.8 MB / 0.7169 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001723/2.058, allocations: 100.2 kB / 1.004 GB, free: 93.8 MB / 0.7169 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000301/2.058, allocations: 124.1 kB / 1.004 GB, free: 93.8 MB / 0.7169 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0079/2.066, allocations: 3.013 MB / 1.007 GB, free: 93.63 MB / 0.7169 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.007018/2.073, allocations: 3.883 MB / 1.011 GB, free: 93.28 MB / 0.7169 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001814/2.075, allocations: 1.104 MB / 1.012 GB, free: 93.27 MB / 0.7169 GB
Notification: Performance of sorting global known variables: time 0.002341/2.078, allocations: 1.548 MB / 1.014 GB, free: 93.12 MB / 0.7169 GB
Notification: Performance of Backend: time 3.91e-07/2.078, allocations: 0 / 1.014 GB, free: 93.12 MB / 0.7169 GB
Notification: Performance of simCode: created initialization part: time 0.02236/2.1, allocations: 7.671 MB / 1.021 GB, free: 92.57 MB / 0.7169 GB
Notification: Performance of SimCode: time 0.008844/2.109, allocations: 5.17 MB / 1.026 GB, free: 90.48 MB / 0.7169 GB
Notification: Performance of Templates: time 0.1654/2.274, allocations: 127 MB / 1.15 GB, free: 6.324 MB / 0.7325 GB
make -j1 -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances.makefile
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances.sim & ./ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances.pipe 2>&1)