Notification: Performance of loadModel(Modelica): time 1.482/1.482, allocations: 194.3 MB / 200.6 MB, free: 5.301 MB / 168.6 MB
Notification: Performance of FrontEnd - loaded program: time 1.02e-05/1.027e-05, allocations: 2.406 kB / 247.1 MB, free: 4.812 MB / 200.6 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.05872/0.05881, allocations: 44.31 MB / 291.4 MB, free: 9.531 MB / 248.6 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.3123/0.3712, allocations: 184.8 MB / 476.3 MB, free: 4.156 MB / 376.6 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.000233/0.3715, allocations: 93.38 kB / 476.4 MB, free: 4.105 MB / 376.6 MB
Notification: Performance of FrontEnd: time 0.9877/1.359, allocations: 299.9 MB / 0.7581 GB, free: 18.88 MB / 392.6 MB
Notification: Performance of Transformations before backend: time 2.172e-05/1.359, allocations: 8 kB / 0.7581 GB, free: 18.87 MB / 392.6 MB
Notification: Performance of Generate backend data structure: time 0.001686/1.361, allocations: 0.9724 MB / 0.759 GB, free: 17.85 MB / 392.6 MB
Notification: Performance of prepare preOptimizeDAE: time 3.981e-05/1.361, allocations: 11.97 kB / 0.759 GB, free: 17.84 MB / 392.6 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004047/1.362, allocations: 43.61 kB / 0.7591 GB, free: 17.8 MB / 392.6 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.000398/1.362, allocations: 310 kB / 0.7594 GB, free: 17.46 MB / 392.6 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 1.956e-05/1.362, allocations: 8 kB / 0.7594 GB, free: 17.45 MB / 392.6 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 4.994e-05/1.362, allocations: 19.94 kB / 0.7594 GB, free: 17.43 MB / 392.6 MB
Notification: Performance of preOpt removeEqualFunctionCalls (simulation): time 0.0003642/1.363, allocations: 177.2 kB / 0.7596 GB, free: 17.26 MB / 392.6 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0004655/1.363, allocations: 306.2 kB / 0.7599 GB, free: 16.92 MB / 392.6 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.844e-05/1.363, allocations: 0 / 0.7599 GB, free: 16.92 MB / 392.6 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.61e-05/1.364, allocations: 0 / 0.7599 GB, free: 16.92 MB / 392.6 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.01e-06/1.364, allocations: 8 kB / 0.7599 GB, free: 16.91 MB / 392.6 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.001962/1.366, allocations: 2.083 MB / 0.7619 GB, free: 14.64 MB / 392.6 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0002564/1.366, allocations: 145.7 kB / 0.762 GB, free: 14.5 MB / 392.6 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000146/1.366, allocations: 79.28 kB / 0.7621 GB, free: 14.42 MB / 392.6 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001997/1.366, allocations: 278.9 kB / 0.7624 GB, free: 14.09 MB / 392.6 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.354e-05/1.366, allocations: 34.56 kB / 0.7624 GB, free: 14.05 MB / 392.6 MB
Notification: Performance of pre-optimization done (n=24): time 3.073e-06/1.367, allocations: 4 kB / 0.7624 GB, free: 14.05 MB / 392.6 MB
Notification: Performance of matching and sorting (n=30): time 0.004041/1.371, allocations: 0.9718 MB / 0.7634 GB, free: 13 MB / 392.6 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.053e-05/1.371, allocations: 55.41 kB / 0.7634 GB, free: 12.93 MB / 392.6 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0002197/1.371, allocations: 196 kB / 0.7636 GB, free: 12.74 MB / 392.6 MB
Notification: Performance of collectPreVariables (initialization): time 3.632e-05/1.371, allocations: 37.69 kB / 0.7636 GB, free: 12.7 MB / 392.6 MB
Notification: Performance of collectInitialEqns (initialization): time 6.817e-05/1.371, allocations: 168 kB / 0.7638 GB, free: 12.53 MB / 392.6 MB
Notification: Performance of collectInitialBindings (initialization): time 6.614e-05/1.371, allocations: 98.47 kB / 0.7639 GB, free: 12.43 MB / 392.6 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 2.207e-05/1.371, allocations: 0 / 0.7639 GB, free: 12.43 MB / 392.6 MB
Notification: Performance of setup shared object (initialization): time 6.851e-05/1.372, allocations: 342.8 kB / 0.7642 GB, free: 12.09 MB / 392.6 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001643/1.372, allocations: 76.75 kB / 0.7643 GB, free: 12.01 MB / 392.6 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0001974/1.372, allocations: 158.3 kB / 0.7644 GB, free: 11.82 MB / 392.6 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001084/1.373, allocations: 151.8 kB / 0.7646 GB, free: 11.67 MB / 392.6 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.073e-06/1.373, allocations: 0 / 0.7646 GB, free: 11.67 MB / 392.6 MB
Notification: Performance of matching and sorting (n=45) (initialization): time 0.001546/1.375, allocations: 409.5 kB / 0.765 GB, free: 11.26 MB / 392.6 MB
Notification: Performance of prepare postOptimizeDAE: time 1.599e-05/1.375, allocations: 4 kB / 0.765 GB, free: 11.26 MB / 392.6 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.708e-06/1.375, allocations: 7.938 kB / 0.765 GB, free: 11.25 MB / 392.6 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003938/1.375, allocations: 88.8 kB / 0.7651 GB, free: 11.16 MB / 392.6 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003287/1.376, allocations: 72.22 kB / 0.7651 GB, free: 11.09 MB / 392.6 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0008407/1.377, allocations: 0.7083 MB / 0.7658 GB, free: 10.36 MB / 392.6 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0003028/1.377, allocations: 11.94 kB / 0.7658 GB, free: 10.34 MB / 392.6 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.202e-05/1.377, allocations: 47.98 kB / 0.7659 GB, free: 10.3 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.0001187/1.377, allocations: 79.19 kB / 0.766 GB, free: 10.22 MB / 392.6 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 8.765e-05/1.378, allocations: 27.72 kB / 0.766 GB, free: 10.19 MB / 392.6 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002618/1.38, allocations: 0.7508 MB / 0.7667 GB, free: 9.43 MB / 392.6 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.498e-05/1.38, allocations: 12.08 kB / 0.7667 GB, free: 9.418 MB / 392.6 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.099e-06/1.38, allocations: 3.938 kB / 0.7667 GB, free: 9.414 MB / 392.6 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001284/1.382, allocations: 0.7425 MB / 0.7675 GB, free: 8.582 MB / 392.6 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001954/1.384, allocations: 0.9247 MB / 0.7684 GB, free: 7.609 MB / 392.6 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.448e-06/1.384, allocations: 0 / 0.7684 GB, free: 7.609 MB / 392.6 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002271/1.384, allocations: 43.91 kB / 0.7684 GB, free: 7.566 MB / 392.6 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.000313/1.385, allocations: 72.81 kB / 0.7685 GB, free: 7.492 MB / 392.6 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.206e-05/1.385, allocations: 11.98 kB / 0.7685 GB, free: 7.48 MB / 392.6 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0007166/1.385, allocations: 0.6771 MB / 0.7692 GB, free: 6.777 MB / 392.6 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.47e-06/1.385, allocations: 0 / 0.7692 GB, free: 6.777 MB / 392.6 MB
Notification: Performance of postOpt detectJacobianSparsePattern (simulation): time 0.001567/1.387, allocations: 0.7482 MB / 0.7699 GB, free: 6.008 MB / 392.6 MB
Notification: Performance of postOpt removeConstants (simulation): time 9.191e-05/1.387, allocations: 104.7 kB / 0.77 GB, free: 5.887 MB / 392.6 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 6.628e-05/1.387, allocations: 4.125 kB / 0.77 GB, free: 5.883 MB / 392.6 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003343/1.388, allocations: 11.98 kB / 0.77 GB, free: 5.871 MB / 392.6 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 4.833e-05/1.388, allocations: 23.97 kB / 0.77 GB, free: 5.848 MB / 392.6 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.314e-05/1.388, allocations: 39.98 kB / 0.7701 GB, free: 5.809 MB / 392.6 MB
Notification: Performance of sort global known variables: time 0.0001423/1.388, allocations: 152.5 kB / 0.7702 GB, free: 5.66 MB / 392.6 MB
Notification: Performance of remove unused functions: time 0.0008953/1.389, allocations: 243.7 kB / 0.7704 GB, free: 5.422 MB / 392.6 MB
Notification: Performance of Backend phase and start with SimCode phase: time 0.0007058/1.39, allocations: 322.5 kB / 0.7707 GB, free: 5.117 MB / 392.6 MB
Notification: Performance of simCode: created initialization part: time 0.0006942/1.391, allocations: 331 kB / 0.7711 GB, free: 4.793 MB / 392.6 MB
Notification: Performance of simCode: created event and clocks part: time 3.143e-06/1.391, allocations: 3.938 kB / 0.7711 GB, free: 4.789 MB / 392.6 MB
Notification: Performance of simCode: created simulation system equations: time 0.0004772/1.391, allocations: 216.8 kB / 0.7713 GB, free: 4.578 MB / 392.6 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0008271/1.392, allocations: 128.1 kB / 0.7714 GB, free: 4.453 MB / 392.6 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.04024/1.432, allocations: 16.01 MB / 0.787 GB, free: 4.68 MB / 408.6 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0008547/1.433, allocations: 0.8935 MB / 0.7879 GB, free: 3.754 MB / 408.6 MB
Notification: Performance of SimCode: time 2.165e-06/1.434, allocations: 0 / 0.7879 GB, free: 3.754 MB / 408.6 MB
Notification: Performance of Templates: time 0.2565/1.69, allocations: 9.465 MB / 0.7971 GB, free: 109.5 MB / 408.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