Running command: translateModel(ModelicaTest.Fluid.TestComponents.Fittings.TestMultiPortTraceSubstances,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|volume1.mC_scaled.1.|volume1.medium.T|volume1.medium.Xi.1.|volume1.medium.p|volume2.mC_scaled.1.|volume2.medium.T|volume2.medium.Xi.1.|volume2.medium.p|volume3.mC_scaled.1.|volume3.medium.T|volume3.medium.Xi.1.|volume3.medium.p",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Fluid.TestComponents.Fittings.TestMultiPortTraceSubstances")
Notification: Performance of loadModel(ModelicaTest): time 2.034/2.034, allocations: 209.3 MB / 223.8 MB, free: 452 kB / 186.7 MB
Notification: Performance of FrontEnd - loaded program: time 3.82e-05/3.832e-05, allocations: 8 kB / 276.2 MB, free: 15.2 MB / 234.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3637/0.3638, allocations: 48.71 MB / 324.9 MB, free: 3.367 MB / 266.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Fittings.TestMultiPortTraceSubstances): time 0.7908/1.155, allocations: 245.9 MB / 0.5574 GB, free: 14.21 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.06271/1.217, allocations: 31.76 MB / 0.5884 GB, free: 1.332 MB / 426.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004719/1.222, allocations: 106.4 kB / 0.5885 GB, free: 1.281 MB / 426.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.005477/1.228, allocations: 1.004 MB / 0.5895 GB, free: 492 kB / 426.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.03419/1.262, allocations: 7.159 MB / 0.5965 GB, free: 9.699 MB / 442.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.02763/1.29, allocations: 4.969 MB / 0.6013 GB, free: 4.852 MB / 442.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01452/1.304, allocations: 3.71 MB / 0.605 GB, free: 1.129 MB / 442.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.006677/1.311, allocations: 1.784 MB / 0.6067 GB, free: 15.34 MB / 458.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.01898/1.33, allocations: 4.053 MB / 0.6107 GB, free: 11.28 MB / 458.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.007441/1.337, allocations: 2.53 MB / 0.6131 GB, free: 8.746 MB / 458.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.04772/1.385, allocations: 15.76 MB / 0.6285 GB, free: 8.969 MB / 474.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.006305/1.392, allocations: 0.6641 MB / 0.6292 GB, free: 8.305 MB / 474.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.003455/1.395, allocations: 1.438 MB / 0.6306 GB, free: 6.863 MB / 474.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.002262/1.397, allocations: 388 kB / 0.6309 GB, free: 6.484 MB / 474.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.03653/1.434, allocations: 9.433 MB / 0.6402 GB, free: 13.04 MB / 490.7 MB
Notification: Performance of FrontEnd - DAE generated: time 6.061e-06/1.434, allocations: 0 / 0.6402 GB, free: 13.04 MB / 490.7 MB
Notification: Performance of FrontEnd: time 7.975e-06/1.434, allocations: 3.984 kB / 0.6402 GB, free: 13.03 MB / 490.7 MB
Notification: Performance of Transformations before backend: time 0.0002049/1.434, allocations: 0 / 0.6402 GB, free: 13.03 MB / 490.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 752
 * Number of variables: 752
Notification: Performance of Generate backend data structure: time 0.02224/1.457, allocations: 5.138 MB / 0.6452 GB, free: 7.797 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.255e-05/1.457, allocations: 12.02 kB / 0.6452 GB, free: 7.785 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002354/1.459, allocations: 399.7 kB / 0.6456 GB, free: 7.391 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006301/1.465, allocations: 1.89 MB / 0.6474 GB, free: 5.445 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007431/1.466, allocations: 0.5006 MB / 0.6479 GB, free: 4.887 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001327/1.467, allocations: 283.9 kB / 0.6482 GB, free: 4.609 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01622/1.484, allocations: 4.939 MB / 0.653 GB, free: 15.44 MB / 0.4948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001281/1.484, allocations: 19.83 kB / 0.653 GB, free: 15.42 MB / 0.4948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007792/1.485, allocations: 123.9 kB / 0.6531 GB, free: 15.3 MB / 0.4948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006188/1.485, allocations: 277.2 kB / 0.6534 GB, free: 15.02 MB / 0.4948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01783/1.503, allocations: 5.115 MB / 0.6584 GB, free: 9.895 MB / 0.4948 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.3541/1.857, allocations: 21.14 MB / 0.679 GB, free: 205.2 MB / 0.4948 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.009484/1.867, allocations: 2.631 MB / 0.6816 GB, free: 204.3 MB / 0.4948 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.004436/1.871, allocations: 3.38 MB / 0.6849 GB, free: 200.7 MB / 0.4948 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001081/1.872, allocations: 61.31 kB / 0.685 GB, free: 200.6 MB / 0.4948 GB
Notification: Performance of pre-optimization done (n=235): time 7.294e-06/1.872, allocations: 0 / 0.685 GB, free: 200.6 MB / 0.4948 GB
Notification: Performance of matching and sorting (n=271): time 0.1121/1.984, allocations: 15.93 MB / 0.7005 GB, free: 196.2 MB / 0.4948 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001052/1.984, allocations: 243.5 kB / 0.7008 GB, free: 195.9 MB / 0.4948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004739/1.989, allocations: 2.013 MB / 0.7027 GB, free: 194.8 MB / 0.4948 GB
Notification: Performance of collectPreVariables (initialization): time 0.001002/1.99, allocations: 81.11 kB / 0.7028 GB, free: 194.8 MB / 0.4948 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001454/1.991, allocations: 1.478 MB / 0.7042 GB, free: 193.5 MB / 0.4948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001825/1.993, allocations: 0.9575 MB / 0.7052 GB, free: 192.6 MB / 0.4948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000674/1.994, allocations: 83.62 kB / 0.7053 GB, free: 192.6 MB / 0.4948 GB
Notification: Performance of setup shared object (initialization): time 0.0003301/1.994, allocations: 464.8 kB / 0.7057 GB, free: 192.1 MB / 0.4948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007457/2.002, allocations: 1.975 MB / 0.7076 GB, free: 191.1 MB / 0.4948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008431/2.01, allocations: 3.27 MB / 0.7108 GB, free: 188.4 MB / 0.4948 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008572/2.019, allocations: 2.54 MB / 0.7133 GB, free: 187 MB / 0.4948 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.379e-05/2.019, allocations: 12 kB / 0.7133 GB, free: 187 MB / 0.4948 GB
Notification: Performance of matching and sorting (n=514) (initialization): time 0.02434/2.043, allocations: 6.199 MB / 0.7194 GB, free: 183.8 MB / 0.4948 GB
Notification: Performance of prepare postOptimizeDAE: time 0.003591/2.047, allocations: 16.63 MB / 0.7356 GB, free: 165.9 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001264/2.047, allocations: 39.53 kB / 0.7356 GB, free: 165.9 MB / 0.4948 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007537/2.055, allocations: 0.95 MB / 0.7366 GB, free: 165.5 MB / 0.4948 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007361/2.062, allocations: 0.9336 MB / 0.7375 GB, free: 165.2 MB / 0.4948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007963/2.07, allocations: 2.795 MB / 0.7402 GB, free: 162.9 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007668/2.078, allocations: 383.5 kB / 0.7406 GB, free: 162.5 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001345/2.079, allocations: 284.1 kB / 0.7408 GB, free: 162.2 MB / 0.4948 GB
Notification: Performance of prepare postOptimizeDAE: time 1.851e-05/2.079, allocations: 4 kB / 0.7409 GB, free: 162.2 MB / 0.4948 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.02145/2.101, allocations: 5.838 MB / 0.7466 GB, free: 156.3 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001968/2.101, allocations: 40 kB / 0.7466 GB, free: 156.3 MB / 0.4948 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01144/2.112, allocations: 0.9617 MB / 0.7475 GB, free: 155.3 MB / 0.4948 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01159/2.124, allocations: 0.9282 MB / 0.7484 GB, free: 154.4 MB / 0.4948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008298/2.132, allocations: 2.793 MB / 0.7512 GB, free: 151.5 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006709/2.139, allocations: 379.5 kB / 0.7515 GB, free: 151.2 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001453/2.141, allocations: 280.6 kB / 0.7518 GB, free: 150.9 MB / 0.4948 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 183
 * Number of states: 0 ()
 * Number of discrete variables: 22 (traceSubstance1.ind,traceSubstance2.ind,traceSubstance3.ind,traceSubstance.ind,volume1.regularFlow[1],volume1.regularFlow[2],volume1.regularFlow[3],volume2.regularFlow[1],volume2.regularFlow[2],volume2.regularFlow[3],volume3.regularFlow[1],volume3.regularFlow[2],volume3.regularFlow[3],volume3.inFlow[3],volume3.inFlow[2],volume3.inFlow[1],volume2.inFlow[3],volume2.inFlow[2],volume2.inFlow[1],volume1.inFlow[3],volume1.inFlow[2],volume1.inFlow[1])
 * Number of discrete states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (493):
 * Single equations (assignments): 486
 * Array equations: 0
 * Algorithm blocks: 4
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 3 {2 6,2 6,2 6}
Notification: Performance of prepare postOptimizeDAE: time 0.00346/2.144, allocations: 0.8928 MB / 0.7527 GB, free: 150 MB / 0.4948 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001223/2.145, allocations: 296.4 kB / 0.7529 GB, free: 149.7 MB / 0.4948 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02355/2.169, allocations: 6.134 MB / 0.7589 GB, free: 143.5 MB / 0.4948 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.657e-05/2.169, allocations: 43.92 kB / 0.759 GB, free: 143.5 MB / 0.4948 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.721e-05/2.169, allocations: 3.953 kB / 0.759 GB, free: 143.5 MB / 0.4948 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.52e-05/2.169, allocations: 19.88 kB / 0.759 GB, free: 143.5 MB / 0.4948 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02817/2.197, allocations: 8.89 MB / 0.7677 GB, free: 134.5 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.492e-05/2.198, allocations: 7.391 kB / 0.7677 GB, free: 134.5 MB / 0.4948 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.005169/2.203, allocations: 0.5736 MB / 0.7683 GB, free: 134 MB / 0.4948 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.008911/2.212, allocations: 1.129 MB / 0.7694 GB, free: 132.8 MB / 0.4948 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0008949/2.213, allocations: 119.9 kB / 0.7695 GB, free: 132.7 MB / 0.4948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.006501/2.219, allocations: 2.666 MB / 0.7721 GB, free: 130 MB / 0.4948 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.943e-06/2.219, allocations: 7.969 kB / 0.7721 GB, free: 130 MB / 0.4948 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02438/2.244, allocations: 7.415 MB / 0.7793 GB, free: 122.4 MB / 0.4948 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002987/2.247, allocations: 0.8871 MB / 0.7802 GB, free: 121.5 MB / 0.4948 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001191/2.248, allocations: 75.98 kB / 0.7803 GB, free: 121.4 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.005259/2.253, allocations: 271.6 kB / 0.7805 GB, free: 121.2 MB / 0.4948 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007784/2.254, allocations: 214.1 kB / 0.7807 GB, free: 121 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0005906/2.255, allocations: 175.9 kB / 0.7809 GB, free: 120.8 MB / 0.4948 GB
Notification: Performance of sorting global known variables: time 0.002951/2.258, allocations: 1.474 MB / 0.7823 GB, free: 119.3 MB / 0.4948 GB
Notification: Performance of sort global known variables: time 7.52e-07/2.258, allocations: 0 / 0.7823 GB, free: 119.3 MB / 0.4948 GB
Notification: Performance of remove unused functions: time 0.01491/2.273, allocations: 3.726 MB / 0.786 GB, free: 116 MB / 0.4948 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 12 (volume1.medium.p,volume1.medium.Xi[1],volume1.medium.T,volume1.mC_scaled[1],volume2.medium.p,volume2.medium.Xi[1],volume2.medium.T,volume2.mC_scaled[1],volume3.medium.p,volume3.medium.Xi[1],volume3.medium.T,volume3.mC_scaled[1])
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (297):
 * Single equations (assignments): 285
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 9
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 3 {2 6,2 6,2 6}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01361/2.286, allocations: 3.285 MB / 0.7892 GB, free: 113.3 MB / 0.4948 GB
Notification: Performance of simCode: created initialization part: time 0.03637/2.323, allocations: 8.397 MB / 0.7974 GB, free: 104.8 MB / 0.4948 GB
Notification: Performance of simCode: created event and clocks part: time 1.552e-05/2.323, allocations: 0.5625 kB / 0.7974 GB, free: 104.8 MB / 0.4948 GB
Notification: Performance of simCode: created simulation system equations: time 0.01048/2.333, allocations: 2.369 MB / 0.7997 GB, free: 102.4 MB / 0.4948 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01251/2.346, allocations: 1.217 MB / 0.8009 GB, free: 101.2 MB / 0.4948 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02565/2.371, allocations: 8.895 MB / 0.8096 GB, free: 92.29 MB / 0.4948 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002701/2.374, allocations: 2.292 MB / 0.8118 GB, free: 89.96 MB / 0.4948 GB
Notification: Performance of simCode: alias equations: time 0.01521/2.389, allocations: 2.441 MB / 0.8142 GB, free: 87.52 MB / 0.4948 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002695/2.392, allocations: 363.2 kB / 0.8145 GB, free: 87.16 MB / 0.4948 GB
Notification: Performance of SimCode: time 1.884e-06/2.392, allocations: 0 / 0.8145 GB, free: 87.16 MB / 0.4948 GB
Notification: Performance of Templates: time 0.6022/2.994, allocations: 112.5 MB / 0.9244 GB, free: 191.6 MB / 0.4948 GB