Notification: Performance of loadModel(Modelica): time 1.505/1.505, allocations: 194.3 MB / 200.5 MB, free: 5.305 MB / 168.6 MB
Notification: Performance of FrontEnd - loaded program: time 9.498e-06/9.499e-06, allocations: 1.312 kB / 247.1 MB, free: 4.809 MB / 200.6 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.05832/0.0584, allocations: 44.31 MB / 291.4 MB, free: 9.531 MB / 248.6 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.3355/0.394, allocations: 184.8 MB / 476.3 MB, free: 4.23 MB / 376.6 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002357/0.3943, allocations: 92.17 kB / 476.4 MB, free: 4.18 MB / 376.6 MB
Notification: Performance of FrontEnd: time 1.008/1.402, allocations: 299.9 MB / 0.7581 GB, free: 37.53 MB / 392.6 MB
Notification: Performance of Transformations before backend: time 2.333e-05/1.402, allocations: 4 kB / 0.7581 GB, free: 37.53 MB / 392.6 MB
Notification: Performance of Generate backend data structure: time 0.001826/1.404, allocations: 0.98 MB / 0.759 GB, free: 36.5 MB / 392.6 MB
Notification: Performance of prepare preOptimizeDAE: time 4.044e-05/1.404, allocations: 8.031 kB / 0.759 GB, free: 36.5 MB / 392.6 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004811/1.405, allocations: 47.61 kB / 0.7591 GB, free: 36.45 MB / 392.6 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.000452/1.405, allocations: 310.3 kB / 0.7594 GB, free: 36.11 MB / 392.6 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 1.914e-05/1.405, allocations: 9.031 kB / 0.7594 GB, free: 36.1 MB / 392.6 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 5.05e-05/1.406, allocations: 16 kB / 0.7594 GB, free: 36.08 MB / 392.6 MB
Notification: Performance of preOpt removeEqualFunctionCalls (simulation): time 0.0004176/1.406, allocations: 177.2 kB / 0.7596 GB, free: 35.91 MB / 392.6 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.000523/1.407, allocations: 302.2 kB / 0.7598 GB, free: 35.57 MB / 392.6 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.032e-05/1.407, allocations: 4 kB / 0.7598 GB, free: 35.57 MB / 392.6 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.238e-05/1.407, allocations: 3.906 kB / 0.7598 GB, free: 35.57 MB / 392.6 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.131e-05/1.407, allocations: 12 kB / 0.7599 GB, free: 35.55 MB / 392.6 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.002173/1.409, allocations: 2.073 MB / 0.7619 GB, free: 33.29 MB / 392.6 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0002971/1.41, allocations: 149.5 kB / 0.762 GB, free: 33.13 MB / 392.6 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0001653/1.41, allocations: 79.23 kB / 0.7621 GB, free: 33.05 MB / 392.6 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002294/1.41, allocations: 279.9 kB / 0.7624 GB, free: 32.72 MB / 392.6 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.493e-05/1.41, allocations: 34.5 kB / 0.7624 GB, free: 32.68 MB / 392.6 MB
Notification: Performance of pre-optimization done (n=24): time 6.006e-06/1.41, allocations: 8 kB / 0.7624 GB, free: 32.67 MB / 392.6 MB
Notification: Performance of matching and sorting (n=30): time 0.004625/1.415, allocations: 0.9804 MB / 0.7634 GB, free: 31.61 MB / 392.6 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.207e-05/1.415, allocations: 55.34 kB / 0.7634 GB, free: 31.55 MB / 392.6 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0002413/1.415, allocations: 204 kB / 0.7636 GB, free: 31.34 MB / 392.6 MB
Notification: Performance of collectPreVariables (initialization): time 3.632e-05/1.415, allocations: 25.7 kB / 0.7636 GB, free: 31.31 MB / 392.6 MB
Notification: Performance of collectInitialEqns (initialization): time 7.257e-05/1.416, allocations: 168.1 kB / 0.7638 GB, free: 31.14 MB / 392.6 MB
Notification: Performance of collectInitialBindings (initialization): time 7.201e-05/1.416, allocations: 98.5 kB / 0.7639 GB, free: 31.05 MB / 392.6 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 2.486e-05/1.416, allocations: 4 kB / 0.7639 GB, free: 31.04 MB / 392.6 MB
Notification: Performance of setup shared object (initialization): time 6.865e-05/1.416, allocations: 338.7 kB / 0.7642 GB, free: 30.7 MB / 392.6 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00019/1.416, allocations: 84.73 kB / 0.7643 GB, free: 30.62 MB / 392.6 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0002204/1.416, allocations: 158.3 kB / 0.7645 GB, free: 30.43 MB / 392.6 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001242/1.418, allocations: 151.8 kB / 0.7646 GB, free: 30.28 MB / 392.6 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.562e-06/1.418, allocations: 4 kB / 0.7646 GB, free: 30.28 MB / 392.6 MB
Notification: Performance of matching and sorting (n=45) (initialization): time 0.001757/1.42, allocations: 401.5 kB / 0.765 GB, free: 29.88 MB / 392.6 MB
Notification: Performance of prepare postOptimizeDAE: time 1.9e-05/1.42, allocations: 4 kB / 0.765 GB, free: 29.87 MB / 392.6 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.187e-05/1.42, allocations: 8 kB / 0.765 GB, free: 29.86 MB / 392.6 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004582/1.42, allocations: 88.8 kB / 0.7651 GB, free: 29.77 MB / 392.6 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003813/1.421, allocations: 79.89 kB / 0.7652 GB, free: 29.7 MB / 392.6 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0009392/1.422, allocations: 0.7047 MB / 0.7658 GB, free: 28.96 MB / 392.6 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0003487/1.422, allocations: 4 kB / 0.7658 GB, free: 28.96 MB / 392.6 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.579e-05/1.422, allocations: 40 kB / 0.7659 GB, free: 28.92 MB / 392.6 MB
Warning: There are iteration variables with default zero start attribute. For more information set -d=initialization. In OMEdit Tools->Options->Simulation->OMCFlags, in OMNotebook call setCommandLineOptions("-d=initialization").
Notification: Performance of prepare postOptimizeDAE: time 0.0001129/1.422, allocations: 75.28 kB / 0.766 GB, free: 28.85 MB / 392.6 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 9.771e-05/1.423, allocations: 31.62 kB / 0.766 GB, free: 28.82 MB / 392.6 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002852/1.425, allocations: 0.755 MB / 0.7667 GB, free: 28.05 MB / 392.6 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.77e-05/1.426, allocations: 8 kB / 0.7667 GB, free: 28.04 MB / 392.6 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.124e-06/1.426, allocations: 4 kB / 0.7667 GB, free: 28.04 MB / 392.6 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001418/1.427, allocations: 0.7425 MB / 0.7675 GB, free: 27.21 MB / 392.6 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00226/1.429, allocations: 0.9296 MB / 0.7684 GB, free: 26.22 MB / 392.6 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.705e-06/1.43, allocations: 7.938 kB / 0.7684 GB, free: 26.21 MB / 392.6 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002592/1.43, allocations: 39.92 kB / 0.7684 GB, free: 26.18 MB / 392.6 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003585/1.43, allocations: 76.8 kB / 0.7685 GB, free: 26.1 MB / 392.6 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.604e-05/1.43, allocations: 8 kB / 0.7685 GB, free: 26.09 MB / 392.6 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.000812/1.431, allocations: 0.6849 MB / 0.7692 GB, free: 25.38 MB / 392.6 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.959e-06/1.431, allocations: 0 / 0.7692 GB, free: 25.38 MB / 392.6 MB
Notification: Performance of postOpt detectJacobianSparsePattern (simulation): time 0.001793/1.433, allocations: 0.7404 MB / 0.7699 GB, free: 24.62 MB / 392.6 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001022/1.433, allocations: 100.7 kB / 0.77 GB, free: 24.5 MB / 392.6 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 7.969e-05/1.434, allocations: 12.11 kB / 0.77 GB, free: 24.49 MB / 392.6 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003882/1.434, allocations: 7.906 kB / 0.77 GB, free: 24.48 MB / 392.6 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 5.462e-05/1.434, allocations: 24.06 kB / 0.77 GB, free: 24.46 MB / 392.6 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.677e-05/1.434, allocations: 43.92 kB / 0.7701 GB, free: 24.42 MB / 392.6 MB
Notification: Performance of sort global known variables: time 0.0001626/1.434, allocations: 160.5 kB / 0.7702 GB, free: 24.26 MB / 392.6 MB
Notification: Performance of remove unused functions: time 0.00104/1.436, allocations: 227.8 kB / 0.7704 GB, free: 24.04 MB / 392.6 MB
Notification: Performance of Backend phase and start with SimCode phase: time 0.0007475/1.436, allocations: 325.7 kB / 0.7707 GB, free: 23.71 MB / 392.6 MB
Notification: Performance of simCode: created initialization part: time 0.0008377/1.437, allocations: 327 kB / 0.7711 GB, free: 23.4 MB / 392.6 MB
Notification: Performance of simCode: created event and clocks part: time 6.076e-06/1.437, allocations: 4 kB / 0.7711 GB, free: 23.39 MB / 392.6 MB
Notification: Performance of simCode: created simulation system equations: time 0.0005436/1.438, allocations: 216.7 kB / 0.7713 GB, free: 23.18 MB / 392.6 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001038/1.439, allocations: 120.2 kB / 0.7714 GB, free: 23.06 MB / 392.6 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.04247/1.482, allocations: 16 MB / 0.787 GB, free: 6.969 MB / 392.6 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006953/1.482, allocations: 0.8951 MB / 0.7879 GB, free: 6.043 MB / 392.6 MB
Notification: Performance of SimCode: time 2.305e-06/1.482, allocations: 0 / 0.7879 GB, free: 6.043 MB / 392.6 MB
Notification: Performance of Templates: time 0.1999/1.682, allocations: 9.476 MB / 0.7971 GB, free: 119.2 MB / 392.6 MB
"Error: Could not read variable volume.port.der(h) in file Modelica_3.2.2__O1_Modelica.Media.Examples.Tests.MediaTestModels.Incompressible.Essotherm650_res.mat.
Warning: Get data of variable volume.port.der(h) from file Modelica_3.2.2__O1_Modelica.Media.Examples.Tests.MediaTestModels.Incompressible.Essotherm650_res.mat failed!
"

Variables in the reference:T_start,Time,X_start[1],ambient.T_ambient,ambient.X_ambient[1],ambient.d_ambient,ambient.h_ambient,ambient.medium.MM,ambient.medium.R,ambient.medium.T,ambient.medium.T_degC,ambient.medium.T_start,ambient.medium.X[1],ambient.medium.cp,ambient.medium.d,ambient.medium.h,ambient.medium.p,ambient.medium.p_bar,ambient.medium.preferredMediumStates,ambient.medium.standardOrderComponents,ambient.medium.state.T,ambient.medium.state.p,ambient.medium.u,ambient.p_ambient,ambient.port.H_flow,ambient.port.h,ambient.port.m_flow,ambient.port.p,ambient.use_T_ambient,ambient.use_p_ambient,fixedMassFlowRate.T_ambient,fixedMassFlowRate.X_ambient[1],fixedMassFlowRate.h_ambient,fixedMassFlowRate.m_flow,fixedMassFlowRate.medium.MM,fixedMassFlowRate.medium.R,fixedMassFlowRate.medium.T,fixedMassFlowRate.medium.T_degC,fixedMassFlowRate.medium.T_start,fixedMassFlowRate.medium.X[1],fixedMassFlowRate.medium.cp,fixedMassFlowRate.medium.d,fixedMassFlowRate.medium.h,fixedMassFlowRate.medium.p,fixedMassFlowRate.medium.p_bar,fixedMassFlowRate.medium.preferredMediumStates,fixedMassFlowRate.medium.standardOrderComponents,fixedMassFlowRate.medium.state.T,fixedMassFlowRate.medium.state.p,fixedMassFlowRate.medium.u,fixedMassFlowRate.port.H_flow,fixedMassFlowRate.port.h,fixedMassFlowRate.port.m_flow,fixedMassFlowRate.port.p,fixedMassFlowRate.use_T_ambient,h_start,p_start,shortPipe.dp,shortPipe.dp_nominal,shortPipe.m_flow,shortPipe.m_flow_nominal,shortPipe.port_a.H_flow,shortPipe.port_a.h,shortPipe.port_a.m_flow,shortPipe.port_a.p,shortPipe.port_b.H_flow,shortPipe.port_b.h,shortPipe.port_b.m_flow,shortPipe.port_b.p,volume.T_start,volume.U,volume.V,volume.X_start[1],volume.d_start,der(volume.U),der(volume.m),volume.h_start,volume.m,volume.medium.MM,volume.medium.R,volume.medium.T,volume.medium.T_degC,volume.medium.T_start,volume.medium.X[1],volume.medium.cp,volume.medium.d,der(volume.medium.T),der(volume.medium.d),der(volume.medium.u),volume.medium.h,volume.medium.p,volume.medium.p_bar,volume.medium.preferredMediumStates,volume.medium.standardOrderComponents,volume.medium.state.T,volume.medium.state.p,volume.medium.u,volume.p_start,volume.port.H_flow,der(volume.port.h),volume.port.h,volume.port.m_flow,volume.port.p,volume.use_T_start,volume.use_p_start

Variables in the result:T_start,X_start[1],ambient.T_ambient,ambient.X_ambient[1],ambient.d_ambient,ambient.h_ambient,ambient.medium.MM,ambient.medium.R,ambient.medium.T,ambient.medium.T_degC,ambient.medium.T_start,ambient.medium.X[1],ambient.medium.cp,ambient.medium.d,ambient.medium.h,ambient.medium.p,ambient.medium.p_bar,ambient.medium.preferredMediumStates,ambient.medium.standardOrderComponents,ambient.medium.state.T,ambient.medium.state.p,ambient.medium.u,ambient.p_ambient,ambient.port.H_flow,ambient.port.h,ambient.port.m_flow,ambient.port.p,ambient.use_T_ambient,ambient.use_p_ambient,der(volume.U),der(volume.m),der(volume.medium.T),der(volume.medium.d),der(volume.medium.u),fixedMassFlowRate.T_ambient,fixedMassFlowRate.X_ambient[1],fixedMassFlowRate.h_ambient,fixedMassFlowRate.m_flow,fixedMassFlowRate.medium.MM,fixedMassFlowRate.medium.R,fixedMassFlowRate.medium.T,fixedMassFlowRate.medium.T_degC,fixedMassFlowRate.medium.T_start,fixedMassFlowRate.medium.X[1],fixedMassFlowRate.medium.cp,fixedMassFlowRate.medium.d,fixedMassFlowRate.medium.h,fixedMassFlowRate.medium.p,fixedMassFlowRate.medium.p_bar,fixedMassFlowRate.medium.preferredMediumStates,fixedMassFlowRate.medium.standardOrderComponents,fixedMassFlowRate.medium.state.T,fixedMassFlowRate.medium.state.p,fixedMassFlowRate.medium.u,fixedMassFlowRate.port.H_flow,fixedMassFlowRate.port.h,fixedMassFlowRate.port.m_flow,fixedMassFlowRate.port.p,fixedMassFlowRate.use_T_ambient,h_start,p_start,shortPipe.dp,shortPipe.dp_nominal,shortPipe.m_flow,shortPipe.m_flow_nominal,shortPipe.port_a.H_flow,shortPipe.port_a.h,shortPipe.port_a.m_flow,shortPipe.port_a.p,shortPipe.port_b.H_flow,shortPipe.port_b.h,shortPipe.port_b.m_flow,shortPipe.port_b.p,time,volume.T_start,volume.U,volume.V,volume.X_start[1],volume.d_start,volume.h_start,volume.m,volume.medium.MM,volume.medium.R,volume.medium.T,volume.medium.T_degC,volume.medium.T_start,volume.medium.X[1],volume.medium.cp,volume.medium.d,volume.medium.h,volume.medium.p,volume.medium.p_bar,volume.medium.preferredMediumStates,volume.medium.standardOrderComponents,volume.medium.state.T,volume.medium.state.p,volume.medium.u,volume.p_start,volume.port.H_flow,volume.port.h,volume.port.m_flow,volume.port.p,volume.use_T_start,volume.use_p_start