Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading,fileNamePrefix="IBPSA_latest_IBPSA_Fluid_Storage_Validation_StratifiedLoadingUnloading",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading,fileNamePrefix="IBPSA_latest_IBPSA_Fluid_Storage_Validation_StratifiedLoadingUnloading",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0009865/0.0009865, allocations: 93.34 kB / 16.02 MB, free: 84 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001243/0.001243, allocations: 177 kB / 16.92 MB, free: 6.68 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.36/1.36, allocations: 223.3 MB / 241 MB, free: 5.375 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6252/0.6252, allocations: 115.5 MB / 407.6 MB, free: 2.77 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0002799/0.0002799, allocations: 8 kB / 495.9 MB, free: 6.332 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1263/0.1266, allocations: 77.53 MB / 0.56 GB, free: 9.008 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading): time 0.2755/0.4022, allocations: 54.53 MB / 0.6133 GB, free: 3.238 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02066/0.4229, allocations: 17.71 MB / 0.6306 GB, free: 6.52 MB / 462.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002139/0.4251, allocations: 68.12 kB / 0.6306 GB, free: 6.492 MB / 462.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.002053/0.4271, allocations: 0.7176 MB / 0.6313 GB, free: 6.07 MB / 462.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005791/0.4329, allocations: 2.327 MB / 0.6336 GB, free: 4.547 MB / 462.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003205/0.4362, allocations: 1.394 MB / 0.635 GB, free: 3.469 MB / 462.1 MB
Notification: Performance of NFFlatten.flatten: time 0.02369/0.4599, allocations: 27.81 MB / 0.6621 GB, free: 14.05 MB / 494.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.009453/0.4693, allocations: 8.414 MB / 0.6704 GB, free: 5.531 MB / 494.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.007459/0.4768, allocations: 5.213 MB / 0.6754 GB, free: 304 kB / 494.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006547/0.4834, allocations: 5.791 MB / 0.6811 GB, free: 10.48 MB / 0.4981 GB
Notification: Performance of NFPackage.collectConstants: time 0.0006188/0.484, allocations: 348 kB / 0.6814 GB, free: 10.14 MB / 0.4981 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002731/0.4867, allocations: 1.018 MB / 0.6824 GB, free: 9.121 MB / 0.4981 GB
Notification: Performance of NFScalarize.scalarize: time 0.001346/0.4881, allocations: 1.595 MB / 0.684 GB, free: 7.52 MB / 0.4981 GB
Notification: Performance of NFVerifyModel.verify: time 0.003865/0.492, allocations: 3.893 MB / 0.6878 GB, free: 3.602 MB / 0.4981 GB
Notification: Performance of NFConvertDAE.convert: time 0.01007/0.5021, allocations: 12.31 MB / 0.6998 GB, free: 7.25 MB / 0.5137 GB
Notification: Performance of FrontEnd - DAE generated: time 4.268e-06/0.5021, allocations: 0 / 0.6998 GB, free: 7.25 MB / 0.5137 GB
Notification: Performance of FrontEnd: time 1.653e-06/0.5021, allocations: 4 kB / 0.6998 GB, free: 7.246 MB / 0.5137 GB
Notification: Performance of Transformations before backend: time 0.0001467/0.5022, allocations: 0 / 0.6998 GB, free: 7.246 MB / 0.5137 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1564
 * Number of variables: 1564
Notification: Performance of Generate backend data structure: time 0.0111/0.5133, allocations: 6.874 MB / 0.7065 GB, free: 288 kB / 0.5137 GB
Notification: Performance of prepare preOptimizeDAE: time 3.776e-05/0.5134, allocations: 15.97 kB / 0.7065 GB, free: 272 kB / 0.5137 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00102/0.5144, allocations: 0.8422 MB / 0.7074 GB, free: 15.41 MB / 0.5294 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001844/0.5163, allocations: 0.8547 MB / 0.7082 GB, free: 14.55 MB / 0.5294 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008849/0.5251, allocations: 6.62 MB / 0.7147 GB, free: 7.879 MB / 0.5294 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003147/0.5255, allocations: 460.2 kB / 0.7151 GB, free: 7.426 MB / 0.5294 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008278/0.5263, allocations: 0.6014 MB / 0.7157 GB, free: 6.824 MB / 0.5294 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01326/0.5396, allocations: 9.028 MB / 0.7245 GB, free: 13.47 MB / 0.545 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001084/0.5397, allocations: 23.78 kB / 0.7245 GB, free: 13.45 MB / 0.545 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005597/0.5402, allocations: 264 kB / 0.7248 GB, free: 13.19 MB / 0.545 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001544/0.5404, allocations: 183.9 kB / 0.725 GB, free: 13.01 MB / 0.545 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01098/0.5514, allocations: 7.457 MB / 0.7322 GB, free: 5.543 MB / 0.545 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.03658/0.588, allocations: 35.99 MB / 0.7674 GB, free: 15.49 MB / 0.5919 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005665/0.5937, allocations: 4.29 MB / 0.7716 GB, free: 11.2 MB / 0.5919 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00429/0.598, allocations: 3.332 MB / 0.7748 GB, free: 7.855 MB / 0.5919 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001206/0.5992, allocations: 0.974 MB / 0.7758 GB, free: 6.695 MB / 0.5919 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003356/0.6026, allocations: 2.402 MB / 0.7781 GB, free: 4.258 MB / 0.5919 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002122/0.6047, allocations: 447.8 kB / 0.7786 GB, free: 3.816 MB / 0.5919 GB
Notification: Performance of pre-optimization done (n=317): time 4.569e-06/0.6047, allocations: 0 / 0.7786 GB, free: 3.816 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=317): time 0.01089/0.6156, allocations: 7.14 MB / 0.7855 GB, free: 12.59 MB / 0.6075 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.555e-05/0.6157, allocations: 81.91 kB / 0.7856 GB, free: 12.49 MB / 0.6075 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006417/0.6221, allocations: 5.471 MB / 0.7909 GB, free: 7.043 MB / 0.6075 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002198/0.6223, allocations: 89.7 kB / 0.791 GB, free: 6.949 MB / 0.6075 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002536/0.6249, allocations: 3.192 MB / 0.7941 GB, free: 3.723 MB / 0.6075 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0008971/0.6258, allocations: 1.113 MB / 0.7952 GB, free: 2.594 MB / 0.6075 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004287/0.6262, allocations: 363.3 kB / 0.7956 GB, free: 2.23 MB / 0.6075 GB
Notification: Performance of setup shared object (initialization): time 7.634e-05/0.6263, allocations: 309.1 kB / 0.7959 GB, free: 1.926 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002893/0.6292, allocations: 2.16 MB / 0.798 GB, free: 15.76 MB / 0.6231 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003794/0.633, allocations: 3.689 MB / 0.8016 GB, free: 11.37 MB / 0.6231 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007169/0.6402, allocations: 6.307 MB / 0.8077 GB, free: 4.348 MB / 0.6231 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.039e-05/0.6402, allocations: 12 kB / 0.8078 GB, free: 4.336 MB / 0.6231 GB
Notification: Performance of matching and sorting (n=569) (initialization): time 0.009214/0.6494, allocations: 6.764 MB / 0.8144 GB, free: 13.52 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 5.404e-05/0.6495, allocations: 53.7 kB / 0.8144 GB, free: 13.46 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.485e-05/0.6495, allocations: 52.89 kB / 0.8145 GB, free: 13.41 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008598/0.6504, allocations: 435.7 kB / 0.8149 GB, free: 12.98 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003244/0.6537, allocations: 1.014 MB / 0.8159 GB, free: 11.96 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004905/0.6586, allocations: 5.266 MB / 0.821 GB, free: 6.434 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003839/0.6624, allocations: 466.7 kB / 0.8215 GB, free: 5.977 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002973/0.6627, allocations: 223.9 kB / 0.8217 GB, free: 5.758 MB / 0.6387 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 222
 * Number of states: 0 ()
 * Number of discrete variables: 7 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,dHTan.local_reset,dHTanEnh.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (540):
 * Single equations (assignments): 537
 * Array equations: 0
 * Algorithm blocks: 1
 * 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): 2 systems
   {(1,14,100.0%), (1,14,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.00342/0.6662, allocations: 2.483 MB / 0.8241 GB, free: 3.262 MB / 0.6387 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006491/0.6668, allocations: 0.5365 MB / 0.8246 GB, free: 2.719 MB / 0.6387 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.2312/0.8981, allocations: 5.246 MB / 0.8297 GB, free: 212.1 MB / 0.6387 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.409e-05/0.8981, allocations: 35.7 kB / 0.8298 GB, free: 212.1 MB / 0.6387 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.147e-05/0.8981, allocations: 3.875 kB / 0.8298 GB, free: 212.1 MB / 0.6387 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006215/0.9044, allocations: 4.531 MB / 0.8342 GB, free: 211.2 MB / 0.6387 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 postOpt removeSimpleEquations (simulation): time 0.01833/0.9227, allocations: 11.98 MB / 0.8459 GB, free: 206.6 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.789e-06/0.9227, allocations: 4.609 kB / 0.8459 GB, free: 206.6 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002484/0.9252, allocations: 0.6508 MB / 0.8465 GB, free: 206.6 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0007262/0.926, allocations: 371.6 kB / 0.8469 GB, free: 206.5 MB / 0.6387 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001771/0.9262, allocations: 83.03 kB / 0.847 GB, free: 206.5 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00403/0.9302, allocations: 5.178 MB / 0.852 GB, free: 202.7 MB / 0.6387 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.675e-06/0.9302, allocations: 3.375 kB / 0.852 GB, free: 202.7 MB / 0.6387 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00937/0.9396, allocations: 7.624 MB / 0.8595 GB, free: 199.9 MB / 0.6387 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002192/0.9418, allocations: 1.222 MB / 0.8607 GB, free: 199.5 MB / 0.6387 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000542/0.9423, allocations: 69.45 kB / 0.8607 GB, free: 199.5 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003162/0.9455, allocations: 468 kB / 0.8612 GB, free: 199.4 MB / 0.6387 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00034/0.9459, allocations: 201.9 kB / 0.8614 GB, free: 199.4 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002157/0.9461, allocations: 145.9 kB / 0.8615 GB, free: 199.4 MB / 0.6387 GB
Notification: Performance of sorting global known variables: time 0.004176/0.9503, allocations: 3.801 MB / 0.8652 GB, free: 197.8 MB / 0.6387 GB
Notification: Performance of sort global known variables: time 1.5e-07/0.9503, allocations: 0 / 0.8652 GB, free: 197.8 MB / 0.6387 GB
Notification: Performance of remove unused functions: time 0.003736/0.954, allocations: 1.989 MB / 0.8672 GB, free: 197.5 MB / 0.6387 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 16 (tanEnh.vol[1].dynBal.U,tanEnh.vol[2].dynBal.U,tanEnh.vol[3].dynBal.U,tanEnh.vol[4].dynBal.U,tanEnh.vol[5].dynBal.U,tanEnh.vol[6].dynBal.U,tanEnh.vol[7].dynBal.U,tan.vol[1].dynBal.U,tan.vol[2].dynBal.U,tan.vol[3].dynBal.U,tan.vol[4].dynBal.U,tan.vol[5].dynBal.U,tan.vol[6].dynBal.U,tan.vol[7].dynBal.U,dHTanEnh.y,dHTan.y)
 * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count)
 * Number of discrete states: 1 (pulse.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (296):
 * Single equations (assignments): 289
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 3
 * When equations: 2
 * 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): 2 systems
   {(1,14,100.0%), (1,14,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.008707/0.9627, allocations: 8.581 MB / 0.8756 GB, free: 192.1 MB / 0.6387 GB
Notification: Performance of simCode: created initialization part: time 0.005718/0.9685, allocations: 5.381 MB / 0.8808 GB, free: 186.7 MB / 0.6387 GB
Notification: Performance of simCode: created event and clocks part: time 4.529e-06/0.9685, allocations: 4 kB / 0.8808 GB, free: 186.7 MB / 0.6387 GB
Notification: Performance of simCode: created simulation system equations: time 0.002464/0.9709, allocations: 2.513 MB / 0.8833 GB, free: 184.2 MB / 0.6387 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01212/0.9831, allocations: 3.239 MB / 0.8864 GB, free: 181.2 MB / 0.6387 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1058/1.089, allocations: 65.7 MB / 0.9506 GB, free: 109.7 MB / 0.6387 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002851/1.092, allocations: 4.624 MB / 0.9551 GB, free: 105.1 MB / 0.6387 GB
Notification: Performance of simCode: alias equations: time 0.004934/1.097, allocations: 1.984 MB / 0.957 GB, free: 103.1 MB / 0.6387 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002644/1.099, allocations: 2.667 MB / 0.9597 GB, free: 100.4 MB / 0.6387 GB
Notification: Performance of SimCode: time 5.71e-07/1.099, allocations: 0 / 0.9597 GB, free: 100.4 MB / 0.6387 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 13.63/14.73, allocations: 157.9 MB / 1.114 GB, free: 205.9 MB / 0.6544 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0002246/14.73, allocations: 278 kB / 1.114 GB, free: 205.5 MB / 0.6544 GB
Notification: Performance of buildModelFMU: Generate platform static: time 5.287/20.02, allocations: 0 / 1.114 GB, free: 205.5 MB / 0.6544 GB
(rm -f IBPSA_latest_IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_IBPSA_latest_IBPSA_Fluid_Storage_Validation_StratifiedLoadingUnloading_fmu --startTime=0 --stopTime=14400 --timeout=50 --tolerance=1e-06 IBPSA_latest_IBPSA_Fluid_Storage_Validation_StratifiedLoadingUnloading.fmu > IBPSA_latest_IBPSA.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe 2>&1)