Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo): time 0.01045/0.01045, allocations: 1.769 MB / 18.12 MB, free: 4.906 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001198/0.001198, allocations: 103.7 kB / 21.36 MB, free: 1.684 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001576/0.001576, allocations: 218.4 kB / 24.75 MB, free: 3.695 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.564/1.564, allocations: 230.6 MB / 258.5 MB, free: 13.11 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/package.mo): time 1.15/1.15, allocations: 130.5 MB / 445.5 MB, free: 14.59 MB / 350.1 MB
"
[Timeout remaining time 179]
Using package ClaRa with version 1.9.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Using package SMArtInt with version 0.3.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo)
Running command: translateModel(ClaRa.StaticCycles.Storage.Check.TestSeparator,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="CPUtime|EventCounter|Time|_derdummy|_dummy|simCenter.MaxSimTime|simCenter.T_amb|simCenter.T_amb_start|simCenter.contributeToCycleSummary|simCenter.cycleSumPort.power_aux|simCenter.cycleSumPort.power_in|simCenter.cycleSumPort.power_out_elMech|simCenter.cycleSumPort.power_out_th|simCenter.fuelModel1.C_LHV.1.|simCenter.fuelModel1.C_LHV.2.|simCenter.fuelModel1.C_LHV.3.|simCenter.fuelModel1.C_cp.1.|simCenter.fuelModel1.C_cp.2.|simCenter.fuelModel1.C_cp.3.|simCenter.fuelModel1.C_rho.1.|simCenter.fuelModel1.C_rho.2.|simCenter.fuelModel1.C_rho.3.|simCenter.fuelModel1.N_c|simCenter.fuelModel1.N_e|simCenter.fuelModel1.T_ref|simCenter.fuelModel1.ashIndex|simCenter.fuelModel1.defaultComposition.1.|simCenter.fuelModel1.defaultComposition.2.|simCenter.fuelModel1.waterIndex|simCenter.fuelModel1.xi_e_waf.1,1.|simCenter.fuelModel1.xi_e_waf.1,2.|simCenter.fuelModel1.xi_e_waf.1,3.|simCenter.fuelModel1.xi_e_waf.1,4.|simCenter.fuelModel2.C_LHV.1.|simCenter.fuelModel2.C_LHV.2.|simCenter.fuelModel2.C_LHV.3.|simCenter.fuelModel2.C_cp.1.|simCenter.fuelModel2.C_cp.2.|simCenter.fuelModel2.C_cp.3.|simCenter.fuelModel2.C_rho.1.|simCenter.fuelModel2.C_rho.2.|simCenter.fuelModel2.C_rho.3.|simCenter.fuelModel2.N_c|simCenter.fuelModel2.N_e|simCenter.fuelModel2.T_ref|simCenter.fuelModel2.ashIndex|simCenter.fuelModel2.defaultComposition.1.|simCenter.fuelModel2.defaultComposition.2.|simCenter.fuelModel2.waterIndex|simCenter.fuelModel2.xi_e_waf.1,1.|simCenter.fuelModel2.xi_e_waf.1,2.|simCenter.fuelModel2.xi_e_waf.1,3.|simCenter.fuelModel2.xi_e_waf.1,4.|simCenter.h_amb_fluid1|simCenter.h_amb_fluid2|simCenter.h_amb_fluid3|simCenter.largeFonts|simCenter.p_amb|simCenter.p_amb_start|simCenter.rh_amb|simCenter.s_amb_fluid1|simCenter.s_amb_fluid2|simCenter.s_amb_fluid3|simCenter.showExpertSummary|simCenter.slagModel.cp|simCenter.steamCycleAllowFlowReversal|simCenter.summary.eta_gross|simCenter.summary.eta_net|simCenter.summary.eta_util|simCenter.summary.spec_heat_cons|simCenter.useClaRaDelay|simCenter.useHomotopy|simCenter.vleFluid_amb1.computeSurfaceTension|simCenter.vleFluid_amb1.computeTransportProperties|simCenter.vleFluid_amb1.deactivateDensityDerivatives|simCenter.vleFluid_amb1.deactivateTwoPhaseRegion|simCenter.vleFluid_amb1.interpolateTransportProperties|simCenter.vleFluid_amb1.vleFluidPointer.id|simCenter.vleFluid_amb2.computeSurfaceTension|simCenter.vleFluid_amb2.computeTransportProperties|simCenter.vleFluid_amb2.deactivateDensityDerivatives|simCenter.vleFluid_amb2.deactivateTwoPhaseRegion|simCenter.vleFluid_amb2.interpolateTransportProperties|simCenter.vleFluid_amb2.vleFluidPointer.id|simCenter.vleFluid_amb3.computeSurfaceTension|simCenter.vleFluid_amb3.computeTransportProperties|simCenter.vleFluid_amb3.deactivateDensityDerivatives|simCenter.vleFluid_amb3.deactivateTwoPhaseRegion|simCenter.vleFluid_amb3.interpolateTransportProperties|simCenter.vleFluid_amb3.vleFluidPointer.id|sink_blue.h|sink_blue.inlet.h|sink_blue.inlet.m_flow|sink_blue.inlet.p|sink_blue.m_flow|sink_blue.p|sink_blue1.h|sink_blue1.inlet.h|sink_blue1.inlet.m_flow|sink_blue1.inlet.p|sink_blue1.m_flow|sink_blue1.p|source_blue.h|source_blue.m_flow|source_blue.outlet.h|source_blue.outlet.m_flow|source_blue.outlet.p|source_blue.p|steamDrum.h1|steamDrum.h_bub|steamDrum.h_dew|steamDrum.inlet.h|steamDrum.inlet.m_flow|steamDrum.inlet.p|steamDrum.m_flow_1|steamDrum.m_flow_bub|steamDrum.m_flow_dew|steamDrum.outlet1.h|steamDrum.outlet1.m_flow|steamDrum.outlet1.p|steamDrum.outlet2.h|steamDrum.outlet2.m_flow|steamDrum.outlet2.p|steamDrum.p|steamDrum.p_check|steamDrum.steamQuality_1|steamDrum.summary.inlet.h|steamDrum.summary.inlet.m_flow|steamDrum.summary.inlet.p|steamDrum.summary.outlet_bub.h|steamDrum.summary.outlet_bub.m_flow|steamDrum.summary.outlet_bub.p|steamDrum.summary.outlet_dew.h|steamDrum.summary.outlet_dew.m_flow|steamDrum.summary.outlet_dew.p",fileNamePrefix="ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator")
translateModel(ClaRa.StaticCycles.Storage.Check.TestSeparator,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="CPUtime|EventCounter|Time|_derdummy|_dummy|simCenter.MaxSimTime|simCenter.T_amb|simCenter.T_amb_start|simCenter.contributeToCycleSummary|simCenter.cycleSumPort.power_aux|simCenter.cycleSumPort.power_in|simCenter.cycleSumPort.power_out_elMech|simCenter.cycleSumPort.power_out_th|simCenter.fuelModel1.C_LHV.1.|simCenter.fuelModel1.C_LHV.2.|simCenter.fuelModel1.C_LHV.3.|simCenter.fuelModel1.C_cp.1.|simCenter.fuelModel1.C_cp.2.|simCenter.fuelModel1.C_cp.3.|simCenter.fuelModel1.C_rho.1.|simCenter.fuelModel1.C_rho.2.|simCenter.fuelModel1.C_rho.3.|simCenter.fuelModel1.N_c|simCenter.fuelModel1.N_e|simCenter.fuelModel1.T_ref|simCenter.fuelModel1.ashIndex|simCenter.fuelModel1.defaultComposition.1.|simCenter.fuelModel1.defaultComposition.2.|simCenter.fuelModel1.waterIndex|simCenter.fuelModel1.xi_e_waf.1,1.|simCenter.fuelModel1.xi_e_waf.1,2.|simCenter.fuelModel1.xi_e_waf.1,3.|simCenter.fuelModel1.xi_e_waf.1,4.|simCenter.fuelModel2.C_LHV.1.|simCenter.fuelModel2.C_LHV.2.|simCenter.fuelModel2.C_LHV.3.|simCenter.fuelModel2.C_cp.1.|simCenter.fuelModel2.C_cp.2.|simCenter.fuelModel2.C_cp.3.|simCenter.fuelModel2.C_rho.1.|simCenter.fuelModel2.C_rho.2.|simCenter.fuelModel2.C_rho.3.|simCenter.fuelModel2.N_c|simCenter.fuelModel2.N_e|simCenter.fuelModel2.T_ref|simCenter.fuelModel2.ashIndex|simCenter.fuelModel2.defaultComposition.1.|simCenter.fuelModel2.defaultComposition.2.|simCenter.fuelModel2.waterIndex|simCenter.fuelModel2.xi_e_waf.1,1.|simCenter.fuelModel2.xi_e_waf.1,2.|simCenter.fuelModel2.xi_e_waf.1,3.|simCenter.fuelModel2.xi_e_waf.1,4.|simCenter.h_amb_fluid1|simCenter.h_amb_fluid2|simCenter.h_amb_fluid3|simCenter.largeFonts|simCenter.p_amb|simCenter.p_amb_start|simCenter.rh_amb|simCenter.s_amb_fluid1|simCenter.s_amb_fluid2|simCenter.s_amb_fluid3|simCenter.showExpertSummary|simCenter.slagModel.cp|simCenter.steamCycleAllowFlowReversal|simCenter.summary.eta_gross|simCenter.summary.eta_net|simCenter.summary.eta_util|simCenter.summary.spec_heat_cons|simCenter.useClaRaDelay|simCenter.useHomotopy|simCenter.vleFluid_amb1.computeSurfaceTension|simCenter.vleFluid_amb1.computeTransportProperties|simCenter.vleFluid_amb1.deactivateDensityDerivatives|simCenter.vleFluid_amb1.deactivateTwoPhaseRegion|simCenter.vleFluid_amb1.interpolateTransportProperties|simCenter.vleFluid_amb1.vleFluidPointer.id|simCenter.vleFluid_amb2.computeSurfaceTension|simCenter.vleFluid_amb2.computeTransportProperties|simCenter.vleFluid_amb2.deactivateDensityDerivatives|simCenter.vleFluid_amb2.deactivateTwoPhaseRegion|simCenter.vleFluid_amb2.interpolateTransportProperties|simCenter.vleFluid_amb2.vleFluidPointer.id|simCenter.vleFluid_amb3.computeSurfaceTension|simCenter.vleFluid_amb3.computeTransportProperties|simCenter.vleFluid_amb3.deactivateDensityDerivatives|simCenter.vleFluid_amb3.deactivateTwoPhaseRegion|simCenter.vleFluid_amb3.interpolateTransportProperties|simCenter.vleFluid_amb3.vleFluidPointer.id|sink_blue.h|sink_blue.inlet.h|sink_blue.inlet.m_flow|sink_blue.inlet.p|sink_blue.m_flow|sink_blue.p|sink_blue1.h|sink_blue1.inlet.h|sink_blue1.inlet.m_flow|sink_blue1.inlet.p|sink_blue1.m_flow|sink_blue1.p|source_blue.h|source_blue.m_flow|source_blue.outlet.h|source_blue.outlet.m_flow|source_blue.outlet.p|source_blue.p|steamDrum.h1|steamDrum.h_bub|steamDrum.h_dew|steamDrum.inlet.h|steamDrum.inlet.m_flow|steamDrum.inlet.p|steamDrum.m_flow_1|steamDrum.m_flow_bub|steamDrum.m_flow_dew|steamDrum.outlet1.h|steamDrum.outlet1.m_flow|steamDrum.outlet1.p|steamDrum.outlet2.h|steamDrum.outlet2.m_flow|steamDrum.outlet2.p|steamDrum.p|steamDrum.p_check|steamDrum.steamQuality_1|steamDrum.summary.inlet.h|steamDrum.summary.inlet.m_flow|steamDrum.summary.inlet.p|steamDrum.summary.outlet_bub.h|steamDrum.summary.outlet_bub.m_flow|steamDrum.summary.outlet_bub.p|steamDrum.summary.outlet_dew.h|steamDrum.summary.outlet_dew.m_flow|steamDrum.summary.outlet_dew.p",fileNamePrefix="ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator") [Timeout 800]
"Notification: SMArtInt requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: ClaRa requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Automatically loaded package TILMedia 1.9.0 ClaRa due to uses annotation from ClaRa.
Notification: TILMedia requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Warning: Requested package SMArtInt of version 0.5.1, but this package was already loaded with version 0.3.1. There are no conversion annotations for this version but 0.5.1 is newer than 0.3.1. There is a possibility that 0.3.1 remains backwards compatible, but it is not loaded so OpenModelica cannot verify this.
Notification: Performance of FrontEnd - loaded program: time 0.4271/0.4271, allocations: 46.15 MB / 0.6549 GB, free: 30.8 MB / 0.4982 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1972/0.6243, allocations: 89.04 MB / 0.7419 GB, free: 2.383 MB / 0.545 GB
Notification: Performance of NFInst.instantiate(ClaRa.StaticCycles.Storage.Check.TestSeparator): time 0.006665/0.6309, allocations: 4.306 MB / 0.7461 GB, free: 14.07 MB / 0.5607 GB
Notification: Performance of NFInst.instExpressions: time 0.01552/0.6464, allocations: 10.05 MB / 0.7559 GB, free: 3.98 MB / 0.5607 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000515/0.647, allocations: 19.94 kB / 0.7559 GB, free: 3.961 MB / 0.5607 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/SimCenter.mo:71:5-72:35:writable] Warning: Connector cycleSumPort is not balanced: The number of potential variables (0) is not equal to the number of flow variables (4).
Notification: Performance of NFTyping.typeComponents: time 0.001887/0.6488, allocations: 0.5404 MB / 0.7565 GB, free: 3.418 MB / 0.5607 GB
Notification: Performance of NFTyping.typeBindings: time 0.00118/0.65, allocations: 445.6 kB / 0.7569 GB, free: 2.98 MB / 0.5607 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0004962/0.6505, allocations: 195.3 kB / 0.7571 GB, free: 2.789 MB / 0.5607 GB
Notification: Performance of NFFlatten.flatten: time 0.0009466/0.6515, allocations: 0.6573 MB / 0.7577 GB, free: 2.129 MB / 0.5607 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003695/0.6518, allocations: 153.8 kB / 0.7579 GB, free: 1.965 MB / 0.5607 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005066/0.6523, allocations: 354.4 kB / 0.7582 GB, free: 1.617 MB / 0.5607 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0006457/0.653, allocations: 452.9 kB / 0.7586 GB, free: 1.176 MB / 0.5607 GB
Notification: Performance of NFPackage.collectConstants: time 0.00011/0.6531, allocations: 76 kB / 0.7587 GB, free: 1.102 MB / 0.5607 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001524/0.6546, allocations: 0.8647 MB / 0.7595 GB, free: 244 kB / 0.5607 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003465/0.655, allocations: 334.8 kB / 0.7599 GB, free: 15.91 MB / 0.5763 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004276/0.6554, allocations: 441.4 kB / 0.7603 GB, free: 15.48 MB / 0.5763 GB
Notification: Performance of NFConvertDAE.convert: time 0.002413/0.6578, allocations: 1.763 MB / 0.762 GB, free: 13.71 MB / 0.5763 GB
Notification: Performance of FrontEnd - DAE generated: time 5.37e-06/0.6578, allocations: 0 / 0.762 GB, free: 13.71 MB / 0.5763 GB
Notification: Performance of FrontEnd: time 1.493e-06/0.6578, allocations: 0 / 0.762 GB, free: 13.71 MB / 0.5763 GB
Notification: Performance of Transformations before backend: time 1.145e-05/0.6578, allocations: 0 / 0.762 GB, free: 13.71 MB / 0.5763 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 35
 * Number of variables: 35
Notification: Performance of Generate backend data structure: time 0.002644/0.6605, allocations: 1.528 MB / 0.7635 GB, free: 12.12 MB / 0.5763 GB
Notification: Performance of prepare preOptimizeDAE: time 4.602e-05/0.6605, allocations: 12.03 kB / 0.7635 GB, free: 12.11 MB / 0.5763 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004551/0.661, allocations: 132.2 kB / 0.7636 GB, free: 11.98 MB / 0.5763 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003444/0.6644, allocations: 2.024 MB / 0.7656 GB, free: 9.91 MB / 0.5763 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.972e-05/0.6644, allocations: 20.38 kB / 0.7656 GB, free: 9.891 MB / 0.5763 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 3.182e-05/0.6645, allocations: 19.94 kB / 0.7656 GB, free: 9.871 MB / 0.5763 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0007798/0.6653, allocations: 327 kB / 0.766 GB, free: 9.473 MB / 0.5763 GB
Notification: Performance of preOpt findStateOrder (simulation): time 9.698e-06/0.6653, allocations: 3.938 kB / 0.766 GB, free: 9.469 MB / 0.5763 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 2.593e-05/0.6653, allocations: 8 kB / 0.766 GB, free: 9.461 MB / 0.5763 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.251e-05/0.6653, allocations: 7.984 kB / 0.766 GB, free: 9.453 MB / 0.5763 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0004231/0.6657, allocations: 147.8 kB / 0.7661 GB, free: 9.309 MB / 0.5763 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.00205/0.6678, allocations: 1.719 MB / 0.7678 GB, free: 7.5 MB / 0.5763 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0004328/0.6682, allocations: 222.1 kB / 0.768 GB, free: 7.191 MB / 0.5763 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0001343/0.6683, allocations: 100.6 kB / 0.7681 GB, free: 7.062 MB / 0.5763 GB
Notification: Performance of preOpt evalFunc (simulation): time 7.15e-05/0.6684, allocations: 27.98 kB / 0.7681 GB, free: 7.035 MB / 0.5763 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.558e-05/0.6685, allocations: 42.5 kB / 0.7682 GB, free: 6.984 MB / 0.5763 GB
Notification: Performance of pre-optimization done (n=15): time 1.623e-06/0.6685, allocations: 0 / 0.7682 GB, free: 6.984 MB / 0.5763 GB
Notification: Performance of matching and sorting (n=15): time 0.001192/0.6697, allocations: 324.6 kB / 0.7685 GB, free: 6.66 MB / 0.5763 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002692/0.6699, allocations: 372.9 kB / 0.7688 GB, free: 6.211 MB / 0.5763 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001621/0.6715, allocations: 1.144 MB / 0.77 GB, free: 5.055 MB / 0.5763 GB
Notification: Performance of collectPreVariables (initialization): time 2.67e-05/0.6716, allocations: 29.7 kB / 0.77 GB, free: 5.02 MB / 0.5763 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003443/0.6719, allocations: 345.6 kB / 0.7703 GB, free: 4.68 MB / 0.5763 GB
Notification: Performance of collectInitialBindings (initialization): time 4.95e-05/0.672, allocations: 55.53 kB / 0.7704 GB, free: 4.625 MB / 0.5763 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002115/0.6722, allocations: 153.9 kB / 0.7705 GB, free: 4.469 MB / 0.5763 GB
Notification: Performance of setup shared object (initialization): time 0.0001844/0.6724, allocations: 325.9 kB / 0.7708 GB, free: 4.145 MB / 0.5763 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001764/0.6725, allocations: 93.08 kB / 0.7709 GB, free: 4.055 MB / 0.5763 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0003618/0.6729, allocations: 210.4 kB / 0.7711 GB, free: 3.801 MB / 0.5763 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0003909/0.6733, allocations: 246.8 kB / 0.7713 GB, free: 3.52 MB / 0.5763 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.881e-06/0.6733, allocations: 4 kB / 0.7714 GB, free: 3.516 MB / 0.5763 GB
Notification: Performance of matching and sorting (n=56) (initialization): time 0.0006875/0.674, allocations: 428.3 kB / 0.7718 GB, free: 3.09 MB / 0.5763 GB
Notification: Performance of prepare postOptimizeDAE: time 3.215e-05/0.674, allocations: 8 kB / 0.7718 GB, free: 3.082 MB / 0.5763 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.328e-06/0.674, allocations: 4 kB / 0.7718 GB, free: 3.078 MB / 0.5763 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.137e-05/0.674, allocations: 4 kB / 0.7718 GB, free: 3.074 MB / 0.5763 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003045/0.6743, allocations: 95.83 kB / 0.7719 GB, free: 2.98 MB / 0.5763 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.058e-05/0.6744, allocations: 8 kB / 0.7719 GB, free: 2.973 MB / 0.5763 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002964/0.6747, allocations: 43.98 kB / 0.7719 GB, free: 2.93 MB / 0.5763 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.254e-05/0.6747, allocations: 19.94 kB / 0.7719 GB, free: 2.91 MB / 0.5763 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 12
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (56):
 * Single equations (assignments): 56
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0004409/0.6751, allocations: 301.5 kB / 0.7722 GB, free: 2.605 MB / 0.5763 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002878/0.6754, allocations: 107.3 kB / 0.7723 GB, free: 2.5 MB / 0.5763 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0003634/0.6758, allocations: 178.8 kB / 0.7725 GB, free: 2.305 MB / 0.5763 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.767e-06/0.6758, allocations: 0 / 0.7725 GB, free: 2.305 MB / 0.5763 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.232e-06/0.6758, allocations: 4 kB / 0.7725 GB, free: 2.301 MB / 0.5763 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.462e-06/0.6758, allocations: 4 kB / 0.7725 GB, free: 2.297 MB / 0.5763 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001729/0.6775, allocations: 1.449 MB / 0.7739 GB, free: 0.7617 MB / 0.5763 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.244e-06/0.6775, allocations: 0 / 0.7739 GB, free: 0.7617 MB / 0.5763 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 5.777e-05/0.6776, allocations: 23.88 kB / 0.7739 GB, free: 0.7383 MB / 0.5763 GB
Notification: Performance of postOpt tearingSystem (simulation): time 6.302e-06/0.6776, allocations: 4 kB / 0.7739 GB, free: 0.7344 MB / 0.5763 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.114e-05/0.6776, allocations: 4.25 kB / 0.7739 GB, free: 0.7305 MB / 0.5763 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 9.397e-06/0.6776, allocations: 12.36 kB / 0.774 GB, free: 0.7188 MB / 0.5763 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.834e-06/0.6776, allocations: 7.938 kB / 0.774 GB, free: 0.7109 MB / 0.5763 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0003005/0.6779, allocations: 252.9 kB / 0.7742 GB, free: 432 kB / 0.5763 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004006/0.6783, allocations: 264.2 kB / 0.7745 GB, free: 148 kB / 0.5763 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 6.973e-05/0.6784, allocations: 11.98 kB / 0.7745 GB, free: 136 kB / 0.5763 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0001403/0.6785, allocations: 0 / 0.7745 GB, free: 136 kB / 0.5763 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 2.162e-05/0.6786, allocations: 11.94 kB / 0.7745 GB, free: 124 kB / 0.5763 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 1.093e-05/0.6786, allocations: 15.98 kB / 0.7745 GB, free: 108 kB / 0.5763 GB
Notification: Performance of sorting global known variables: time 0.001139/0.6797, allocations: 0.8115 MB / 0.7753 GB, free: 15.29 MB / 0.5919 GB
Notification: Performance of sort global known variables: time 9.1e-08/0.6797, allocations: 0 / 0.7753 GB, free: 15.29 MB / 0.5919 GB
Notification: Performance of remove unused functions: time 0.0006139/0.6803, allocations: 159.7 kB / 0.7754 GB, free: 15.13 MB / 0.5919 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 9
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (9):
 * Single equations (assignments): 9
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.001117/0.6814, allocations: 413 kB / 0.7758 GB, free: 14.79 MB / 0.5919 GB
Notification: Performance of simCode: created initialization part: time 0.0003634/0.6818, allocations: 175.7 kB / 0.776 GB, free: 14.62 MB / 0.5919 GB
Notification: Performance of simCode: created event and clocks part: time 3.186e-06/0.6818, allocations: 0 / 0.776 GB, free: 14.62 MB / 0.5919 GB
Notification: Performance of simCode: created simulation system equations: time 4.318e-05/0.6818, allocations: 32.8 kB / 0.776 GB, free: 14.59 MB / 0.5919 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00049/0.6823, allocations: 96.95 kB / 0.7761 GB, free: 14.49 MB / 0.5919 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002173/0.6845, allocations: 1.329 MB / 0.7774 GB, free: 13.1 MB / 0.5919 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007845/0.6853, allocations: 1.026 MB / 0.7784 GB, free: 12.05 MB / 0.5919 GB
Notification: Performance of simCode: alias equations: time 0.0002921/0.6856, allocations: 132.7 kB / 0.7786 GB, free: 11.92 MB / 0.5919 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001346/0.6857, allocations: 63.41 kB / 0.7786 GB, free: 11.86 MB / 0.5919 GB
Notification: Performance of SimCode: time 3.2e-07/0.6857, allocations: 0 / 0.7786 GB, free: 11.86 MB / 0.5919 GB
Notification: Performance of Templates: time 0.0156/0.7013, allocations: 6.121 MB / 0.7846 GB, free: 5.84 MB / 0.5919 GB
"
[Timeout remaining time 799]
make -j1 -f ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator.makefile [Timeout 800]
(rm -f ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator.pipe ; mkfifo ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator.pipe ; head -c 1048576 < ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator.pipe >> ../files/ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator.sim & ./ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator  -abortSlowSimulation -alarm=800  -emit_protected -lv LOG_STATS > ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator.pipe 2>&1) [Timeout 800]
diffSimulationResults("ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/ClaRa/ReferenceResults/ClaRa.StaticCycles.Storage.Check.TestSeparator.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 800]
"Error: Could not read variable CPUtime in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable CPUtime from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable EventCounter in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable EventCounter from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable _derdummy in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable _derdummy from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable _dummy in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable _dummy from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.C_rho[1] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.C_rho[1] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.C_rho[2] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.C_rho[2] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.C_rho[3] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.C_rho[3] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.N_c in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.N_c from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.N_e in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.N_e from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.T_ref in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.T_ref from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.ashIndex in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.ashIndex from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.defaultComposition[1] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.defaultComposition[1] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.defaultComposition[2] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.defaultComposition[2] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel1.waterIndex in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel1.waterIndex from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.C_rho[1] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.C_rho[1] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.C_rho[2] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.C_rho[2] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.C_rho[3] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.C_rho[3] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.N_c in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.N_c from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.N_e in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.N_e from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.T_ref in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.T_ref from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.ashIndex in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.ashIndex from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.defaultComposition[1] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.defaultComposition[1] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.defaultComposition[2] in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.defaultComposition[2] from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.fuelModel2.waterIndex in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.fuelModel2.waterIndex from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.slagModel.cp in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.slagModel.cp from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.vleFluid_amb1.vleFluidPointer.id in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.vleFluid_amb1.vleFluidPointer.id from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.vleFluid_amb2.vleFluidPointer.id in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.vleFluid_amb2.vleFluidPointer.id from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
Error: Could not read variable simCenter.vleFluid_amb3.vleFluidPointer.id in file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat.
Warning: Get data of variable simCenter.vleFluid_amb3.vleFluidPointer.id from file ClaRa_dev_ClaRa.StaticCycles.Storage.Check.TestSeparator_res.mat failed!
"
[Timeout remaining time 800]
Reference file matches
[Calling sys.exit(0), Time elapsed: 6.869758152999566]