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.001164/0.001164, allocations: 114.5 kB / 18.46 MB, free: 4.594 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001455/0.001455, allocations: 208 kB / 19.41 MB, free: 3.652 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.372/1.372, allocations: 227.4 MB / 247.6 MB, free: 10.41 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2076/0.2076, allocations: 46.1 MB / 345 MB, free: 11.48 MB / 286.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001486/0.001486, allocations: 75.88 kB / 482 MB, free: 4.039 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3191/0.3206, allocations: 62.43 MB / 0.5317 GB, free: 13.59 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances): time 0.6804/1.001, allocations: 319 MB / 0.8431 GB, free: 11.06 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.03029/1.031, allocations: 23.27 MB / 0.8659 GB, free: 7.84 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002764/1.034, allocations: 57.19 kB / 0.8659 GB, free: 7.805 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.003126/1.037, allocations: 1.106 MB / 0.867 GB, free: 7.027 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.01979/1.057, allocations: 7.086 MB / 0.8739 GB, free: 0.6719 MB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02111/1.078, allocations: 8.431 MB / 0.8822 GB, free: 8.234 MB / 0.6075 GB
Notification: Performance of NFFlatten.flatten: time 0.009343/1.088, allocations: 6.211 MB / 0.8882 GB, free: 2.012 MB / 0.6075 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003721/1.091, allocations: 2.077 MB / 0.8902 GB, free: 15.9 MB / 0.6231 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.009117/1.101, allocations: 4.119 MB / 0.8943 GB, free: 11.77 MB / 0.6231 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00524/1.106, allocations: 2.836 MB / 0.897 GB, free: 8.922 MB / 0.6231 GB
Notification: Performance of NFPackage.collectConstants: time 0.0008885/1.107, allocations: 288 kB / 0.8973 GB, free: 8.641 MB / 0.6231 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03019/1.137, allocations: 16.35 MB / 0.9133 GB, free: 8.262 MB / 0.6387 GB
Notification: Performance of NFScalarize.scalarize: time 0.002624/1.14, allocations: 1.224 MB / 0.9145 GB, free: 7.035 MB / 0.6387 GB
Notification: Performance of NFVerifyModel.verify: time 0.003181/1.143, allocations: 1.49 MB / 0.9159 GB, free: 5.539 MB / 0.6387 GB
Notification: Performance of NFConvertDAE.convert: time 0.03183/1.175, allocations: 11.96 MB / 0.9276 GB, free: 9.555 MB / 0.6544 GB
Notification: Performance of FrontEnd - DAE generated: time 6.602e-06/1.175, allocations: 0 / 0.9276 GB, free: 9.555 MB / 0.6544 GB
Notification: Performance of FrontEnd: time 1.573e-06/1.175, allocations: 0 / 0.9276 GB, free: 9.555 MB / 0.6544 GB
Notification: Performance of Transformations before backend: time 7.934e-05/1.175, allocations: 4 kB / 0.9276 GB, free: 9.551 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.01339/1.188, allocations: 4.708 MB / 0.9322 GB, free: 4.77 MB / 0.6544 GB
Notification: Performance of prepare preOptimizeDAE: time 5.294e-05/1.188, allocations: 9.469 kB / 0.9322 GB, free: 4.762 MB / 0.6544 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001481/1.19, allocations: 284.9 kB / 0.9325 GB, free: 4.48 MB / 0.6544 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00298/1.193, allocations: 1.521 MB / 0.934 GB, free: 2.902 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001161/1.193, allocations: 155.5 kB / 0.9341 GB, free: 2.75 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003326/1.193, allocations: 180 kB / 0.9343 GB, free: 2.574 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005197/1.198, allocations: 3.15 MB / 0.9374 GB, free: 15.38 MB / 0.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.126e-05/1.198, allocations: 0 / 0.9374 GB, free: 15.38 MB / 0.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002642/1.199, allocations: 83.95 kB / 0.9375 GB, free: 15.29 MB / 0.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002152/1.199, allocations: 187.7 kB / 0.9376 GB, free: 15.11 MB / 0.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006134/1.205, allocations: 3.513 MB / 0.9411 GB, free: 11.59 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.026/1.231, allocations: 12.82 MB / 0.9536 GB, free: 13.83 MB / 0.6856 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003751/1.235, allocations: 1.713 MB / 0.9553 GB, free: 12.11 MB / 0.6856 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002034/1.237, allocations: 1.13 MB / 0.9564 GB, free: 10.98 MB / 0.6856 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001529/1.238, allocations: 1.67 MB / 0.958 GB, free: 8.965 MB / 0.6856 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.772e-05/1.239, allocations: 51.88 kB / 0.958 GB, free: 8.902 MB / 0.6856 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001635/1.24, allocations: 297.5 kB / 0.9583 GB, free: 8.609 MB / 0.6856 GB
Notification: Performance of pre-optimization done (n=153): time 9.417e-06/1.24, allocations: 0 / 0.9583 GB, free: 8.609 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=165): time 0.02858/1.269, allocations: 8.873 MB / 0.967 GB, free: 15.64 MB / 0.7012 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.112e-05/1.269, allocations: 205.2 kB / 0.9672 GB, free: 15.39 MB / 0.7012 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003201/1.272, allocations: 2.061 MB / 0.9692 GB, free: 13.29 MB / 0.7012 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002785/1.272, allocations: 61.7 kB / 0.9693 GB, free: 13.23 MB / 0.7012 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007631/1.273, allocations: 0.9854 MB / 0.9702 GB, free: 12.23 MB / 0.7012 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0005564/1.274, allocations: 0.5777 MB / 0.9708 GB, free: 11.64 MB / 0.7012 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001025/1.275, allocations: 499.7 kB / 0.9713 GB, free: 11.14 MB / 0.7012 GB
Notification: Performance of setup shared object (initialization): time 9.127e-05/1.275, allocations: 305.1 kB / 0.9716 GB, free: 10.84 MB / 0.7012 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002685/1.278, allocations: 1.349 MB / 0.9729 GB, free: 9.484 MB / 0.7012 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003116/1.281, allocations: 1.727 MB / 0.9746 GB, free: 7.613 MB / 0.7012 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005465/1.286, allocations: 3.004 MB / 0.9775 GB, free: 4.477 MB / 0.7012 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.131e-05/1.286, allocations: 3.938 kB / 0.9775 GB, free: 4.473 MB / 0.7012 GB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.008511/1.295, allocations: 3.955 MB / 0.9814 GB, free: 500 kB / 0.7012 GB
Notification: Performance of prepare postOptimizeDAE: time 6.334e-05/1.295, allocations: 67.41 kB / 0.9814 GB, free: 420 kB / 0.7012 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.518e-05/1.295, allocations: 12.17 kB / 0.9814 GB, free: 408 kB / 0.7012 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007929/1.303, allocations: 1.292 MB / 0.9827 GB, free: 15.1 MB / 0.7169 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002565/1.305, allocations: 495.2 kB / 0.9832 GB, free: 14.62 MB / 0.7169 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003283/1.309, allocations: 2.118 MB / 0.9852 GB, free: 12.45 MB / 0.7169 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002934/1.312, allocations: 103.9 kB / 0.9853 GB, free: 12.35 MB / 0.7169 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005094/1.312, allocations: 139.9 kB / 0.9855 GB, free: 12.21 MB / 0.7169 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.00367/1.316, allocations: 1.734 MB / 0.9872 GB, free: 10.47 MB / 0.7169 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003015/1.319, allocations: 1.689 MB / 0.9888 GB, free: 8.625 MB / 0.7169 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.005355/1.324, allocations: 2.918 MB / 0.9917 GB, free: 5.566 MB / 0.7169 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.216e-05/1.324, allocations: 8 kB / 0.9917 GB, free: 5.559 MB / 0.7169 GB
Notification: Performance of matching and sorting (n=280) (initialization_lambda0): time 0.0106/1.335, allocations: 4.049 MB / 0.9956 GB, free: 1.48 MB / 0.7169 GB
Notification: Performance of prepare postOptimizeDAE: time 6.856e-05/1.335, allocations: 67.41 kB / 0.9957 GB, free: 1.402 MB / 0.7169 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.225e-05/1.335, allocations: 15.94 kB / 0.9957 GB, free: 1.387 MB / 0.7169 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005365/1.34, allocations: 0.9253 MB / 0.9966 GB, free: 468 kB / 0.7169 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.2845/1.625, allocations: 0.4924 MB / 0.9971 GB, free: 319.5 MB / 0.7169 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003979/1.629, allocations: 1.882 MB / 0.9989 GB, free: 318.5 MB / 0.7169 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003567/1.633, allocations: 121.9 kB / 0.999 GB, free: 318.5 MB / 0.7169 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007556/1.633, allocations: 132.2 kB / 0.9992 GB, free: 318.5 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.001023/1.634, allocations: 303.8 kB / 0.9995 GB, free: 318.3 MB / 0.7169 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000994/1.635, allocations: 231.2 kB / 0.9997 GB, free: 318.3 MB / 0.7169 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008078/1.643, allocations: 4.163 MB / 1.004 GB, free: 317.2 MB / 0.7169 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.187e-05/1.643, allocations: 11.7 kB / 1.004 GB, free: 317.2 MB / 0.7169 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.033e-06/1.643, allocations: 3.844 kB / 1.004 GB, free: 317.2 MB / 0.7169 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006582/1.644, allocations: 304 kB / 1.004 GB, free: 317.1 MB / 0.7169 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000671/1.645, allocations: 39.47 kB / 1.004 GB, free: 317.1 MB / 0.7169 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00197/1.647, allocations: 96.89 kB / 1.004 GB, free: 317.1 MB / 0.7169 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002872/1.647, allocations: 122.8 kB / 1.004 GB, free: 317 MB / 0.7169 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.008007/1.655, allocations: 3.022 MB / 1.007 GB, free: 316.1 MB / 0.7169 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.006934/1.662, allocations: 3.883 MB / 1.011 GB, free: 314.5 MB / 0.7169 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001705/1.664, allocations: 1.102 MB / 1.012 GB, free: 314.2 MB / 0.7169 GB
Notification: Performance of sorting global known variables: time 0.002316/1.666, allocations: 1.547 MB / 1.014 GB, free: 313.6 MB / 0.7169 GB
Notification: Performance of Backend: time 4.4e-07/1.666, allocations: 3.094 kB / 1.014 GB, free: 313.6 MB / 0.7169 GB
Notification: Performance of simCode: created initialization part: time 0.02116/1.687, allocations: 7.67 MB / 1.021 GB, free: 311 MB / 0.7169 GB
Notification: Performance of SimCode: time 0.01059/1.698, allocations: 5.171 MB / 1.026 GB, free: 308.1 MB / 0.7169 GB
Notification: Performance of Templates: time 0.1417/1.84, allocations: 128.6 MB / 1.152 GB, free: 183.9 MB / 0.7169 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)