Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.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/IDEAS 3.0.0-master/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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(IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_Storage_Validation_StratifiedLoadingUnloading",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading,fileNamePrefix="IDEAS_dev_IDEAS_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.0064/0.0064, allocations: 96.42 kB / 15.73 MB, free: 5.988 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001477/0.001477, allocations: 188.4 kB / 16.67 MB, free: 5.918 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.352/1.352, allocations: 222.9 MB / 240.4 MB, free: 4.332 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9172/0.9172, allocations: 135.5 MB / 426.1 MB, free: 11.82 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.00197/0.00197, allocations: 67.89 kB / 0.5857 GB, free: 3.238 MB / 494.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.342/0.344, allocations: 81.03 MB / 0.6649 GB, free: 7.051 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading): time 0.05502/0.399, allocations: 55.97 MB / 0.7195 GB, free: 8.793 MB / 0.545 GB
Notification: Performance of NFInst.instExpressions: time 0.02407/0.4231, allocations: 17.93 MB / 0.737 GB, free: 6.816 MB / 0.5606 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002532/0.4257, allocations: 75.56 kB / 0.7371 GB, free: 6.742 MB / 0.5606 GB
Notification: Performance of NFTyping.typeComponents: time 0.002253/0.428, allocations: 0.8924 MB / 0.738 GB, free: 5.844 MB / 0.5606 GB
Notification: Performance of NFTyping.typeBindings: time 0.006235/0.4342, allocations: 2.506 MB / 0.7404 GB, free: 3.324 MB / 0.5606 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003371/0.4376, allocations: 1.532 MB / 0.7419 GB, free: 1.801 MB / 0.5606 GB
Notification: Performance of NFFlatten.flatten: time 0.02168/0.4593, allocations: 21.21 MB / 0.7626 GB, free: 12.54 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0131/0.4724, allocations: 10.72 MB / 0.7731 GB, free: 1.695 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01317/0.4857, allocations: 7.163 MB / 0.7801 GB, free: 10.55 MB / 0.6075 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01075/0.4964, allocations: 6.381 MB / 0.7863 GB, free: 4.145 MB / 0.6075 GB
Notification: Performance of NFPackage.collectConstants: time 0.002585/0.499, allocations: 0.9375 MB / 0.7872 GB, free: 3.207 MB / 0.6075 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005735/0.5048, allocations: 1.694 MB / 0.7889 GB, free: 1.512 MB / 0.6075 GB
Notification: Performance of NFScalarize.scalarize: time 0.00335/0.5082, allocations: 2.341 MB / 0.7912 GB, free: 15.16 MB / 0.6231 GB
Notification: Performance of NFVerifyModel.verify: time 0.008249/0.5164, allocations: 4.707 MB / 0.7958 GB, free: 10.44 MB / 0.6231 GB
Notification: Performance of NFConvertDAE.convert: time 0.01593/0.5324, allocations: 13.24 MB / 0.8087 GB, free: 13.16 MB / 0.6387 GB
Notification: Performance of FrontEnd - DAE generated: time 5.701e-06/0.5324, allocations: 0 / 0.8087 GB, free: 13.16 MB / 0.6387 GB
Notification: Performance of FrontEnd: time 1.553e-06/0.5324, allocations: 0 / 0.8087 GB, free: 13.16 MB / 0.6387 GB
Notification: Performance of Transformations before backend: time 0.0003139/0.5328, allocations: 0 / 0.8087 GB, free: 13.16 MB / 0.6387 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.0185/0.5513, allocations: 8.725 MB / 0.8172 GB, free: 4.328 MB / 0.6387 GB
Notification: Performance of prepare preOptimizeDAE: time 4.687e-05/0.5513, allocations: 16.02 kB / 0.8173 GB, free: 4.312 MB / 0.6387 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00152/0.5529, allocations: 0.8344 MB / 0.8181 GB, free: 3.469 MB / 0.6387 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002717/0.5556, allocations: 0.8981 MB / 0.8189 GB, free: 2.566 MB / 0.6387 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01274/0.5683, allocations: 6.742 MB / 0.8255 GB, free: 11.77 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004046/0.5688, allocations: 456.2 kB / 0.826 GB, free: 11.32 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001503/0.5703, allocations: 0.5976 MB / 0.8265 GB, free: 10.72 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01669/0.587, allocations: 9.028 MB / 0.8354 GB, free: 1.367 MB / 0.6544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001339/0.5872, allocations: 19.83 kB / 0.8354 GB, free: 1.348 MB / 0.6544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007068/0.5879, allocations: 260 kB / 0.8356 GB, free: 1.094 MB / 0.6544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001819/0.5881, allocations: 188 kB / 0.8358 GB, free: 0.9102 MB / 0.6544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01366/0.6017, allocations: 7.453 MB / 0.8431 GB, free: 9.449 MB / 0.67 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.5763/1.178, allocations: 36.05 MB / 0.8783 GB, free: 158.7 MB / 0.6857 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006321/1.184, allocations: 4.284 MB / 0.8825 GB, free: 158 MB / 0.6857 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004109/1.189, allocations: 3.291 MB / 0.8857 GB, free: 156.9 MB / 0.6857 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00102/1.19, allocations: 0.9597 MB / 0.8866 GB, free: 155.9 MB / 0.6857 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003239/1.193, allocations: 2.388 MB / 0.889 GB, free: 155.1 MB / 0.6857 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001948/1.195, allocations: 381.2 kB / 0.8893 GB, free: 155 MB / 0.6857 GB
Notification: Performance of pre-optimization done (n=317): time 6.302e-06/1.195, allocations: 0 / 0.8893 GB, free: 155 MB / 0.6857 GB
Notification: Performance of matching and sorting (n=317): time 0.01147/1.206, allocations: 7.155 MB / 0.8963 GB, free: 152 MB / 0.6857 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.928e-05/1.206, allocations: 90.95 kB / 0.8964 GB, free: 152 MB / 0.6857 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007157/1.214, allocations: 5.67 MB / 0.9019 GB, free: 149.2 MB / 0.6857 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005115/1.214, allocations: 86.58 kB / 0.902 GB, free: 149.1 MB / 0.6857 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002216/1.216, allocations: 3.27 MB / 0.9052 GB, free: 146.6 MB / 0.6857 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001071/1.217, allocations: 1.17 MB / 0.9064 GB, free: 145.8 MB / 0.6857 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001056/1.218, allocations: 0.8686 MB / 0.9072 GB, free: 145.3 MB / 0.6857 GB
Notification: Performance of setup shared object (initialization): time 3.659e-05/1.219, allocations: 305.1 kB / 0.9075 GB, free: 145 MB / 0.6857 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002613/1.221, allocations: 2.161 MB / 0.9096 GB, free: 143.9 MB / 0.6857 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002995/1.224, allocations: 3.701 MB / 0.9132 GB, free: 140.7 MB / 0.6857 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005746/1.23, allocations: 6.317 MB / 0.9194 GB, free: 136.2 MB / 0.6857 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.128e-05/1.23, allocations: 12.53 kB / 0.9194 GB, free: 136.2 MB / 0.6857 GB
Notification: Performance of matching and sorting (n=569) (initialization): time 0.008568/1.239, allocations: 6.807 MB / 0.926 GB, free: 132.7 MB / 0.6857 GB
Notification: Performance of prepare postOptimizeDAE: time 4.865e-05/1.239, allocations: 54.17 kB / 0.9261 GB, free: 132.6 MB / 0.6857 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.108e-05/1.239, allocations: 48.72 kB / 0.9261 GB, free: 132.6 MB / 0.6857 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008255/1.239, allocations: 435.4 kB / 0.9266 GB, free: 132.5 MB / 0.6857 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003158/1.243, allocations: 1.01 MB / 0.9275 GB, free: 132.2 MB / 0.6857 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004216/1.247, allocations: 5.707 MB / 0.9331 GB, free: 127.3 MB / 0.6857 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004395/1.251, allocations: 291.5 kB / 0.9334 GB, free: 127 MB / 0.6857 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004644/1.252, allocations: 216 kB / 0.9336 GB, free: 126.8 MB / 0.6857 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.003251/1.255, allocations: 2.476 MB / 0.936 GB, free: 124.4 MB / 0.6857 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001194/1.256, allocations: 0.5551 MB / 0.9366 GB, free: 123.8 MB / 0.6857 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006795/1.263, allocations: 5.268 MB / 0.9417 GB, free: 118.5 MB / 0.6857 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.335e-05/1.263, allocations: 32 kB / 0.9417 GB, free: 118.5 MB / 0.6857 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.947e-06/1.263, allocations: 4 kB / 0.9417 GB, free: 118.5 MB / 0.6857 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004977/1.268, allocations: 4.529 MB / 0.9462 GB, free: 113.8 MB / 0.6857 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01671/1.285, allocations: 12 MB / 0.9579 GB, free: 101.8 MB / 0.6857 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.046e-05/1.285, allocations: 4 kB / 0.9579 GB, free: 101.8 MB / 0.6857 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002464/1.287, allocations: 0.6438 MB / 0.9585 GB, free: 101.1 MB / 0.6857 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0006982/1.288, allocations: 363.4 kB / 0.9589 GB, free: 100.8 MB / 0.6857 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001839/1.288, allocations: 91.89 kB / 0.959 GB, free: 100.7 MB / 0.6857 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003943/1.292, allocations: 5.623 MB / 0.9644 GB, free: 94.83 MB / 0.6857 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.743e-06/1.292, allocations: 0 / 0.9644 GB, free: 94.83 MB / 0.6857 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008965/1.301, allocations: 7.784 MB / 0.972 GB, free: 86.95 MB / 0.6857 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002338/1.303, allocations: 1.187 MB / 0.9732 GB, free: 85.74 MB / 0.6857 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0008217/1.304, allocations: 71.92 kB / 0.9733 GB, free: 85.67 MB / 0.6857 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002603/1.307, allocations: 198.8 kB / 0.9735 GB, free: 85.48 MB / 0.6857 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003585/1.307, allocations: 198.2 kB / 0.9736 GB, free: 85.29 MB / 0.6857 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002456/1.308, allocations: 139.8 kB / 0.9738 GB, free: 85.15 MB / 0.6857 GB
Notification: Performance of sorting global known variables: time 0.004343/1.312, allocations: 3.963 MB / 0.9777 GB, free: 81.21 MB / 0.6857 GB
Notification: Performance of sort global known variables: time 2.91e-07/1.312, allocations: 0 / 0.9777 GB, free: 81.21 MB / 0.6857 GB
Notification: Performance of remove unused functions: time 0.004738/1.317, allocations: 2.025 MB / 0.9796 GB, free: 79.33 MB / 0.6857 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.009874/1.327, allocations: 8.748 MB / 0.9882 GB, free: 70.54 MB / 0.6857 GB
Notification: Performance of simCode: created initialization part: time 0.006533/1.333, allocations: 5.439 MB / 0.9935 GB, free: 65.05 MB / 0.6857 GB
Notification: Performance of simCode: created event and clocks part: time 5.71e-06/1.333, allocations: 4 kB / 0.9935 GB, free: 65.05 MB / 0.6857 GB
Notification: Performance of simCode: created simulation system equations: time 0.002857/1.336, allocations: 2.551 MB / 0.996 GB, free: 62.47 MB / 0.6857 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0138/1.35, allocations: 3.388 MB / 0.9993 GB, free: 59.18 MB / 0.6857 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.06259/1.412, allocations: 52.56 MB / 1.051 GB, free: 4.527 MB / 0.6857 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003043/1.416, allocations: 4.62 MB / 1.055 GB, free: 15.87 MB / 0.7013 GB
Notification: Performance of simCode: alias equations: time 0.005694/1.421, allocations: 2.081 MB / 1.057 GB, free: 13.79 MB / 0.7013 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004087/1.425, allocations: 2.678 MB / 1.06 GB, free: 11.11 MB / 0.7013 GB
Notification: Performance of SimCode: time 2.926e-06/1.425, allocations: 0 / 1.06 GB, free: 11.11 MB / 0.7013 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.5382/1.964, allocations: 159.9 MB / 1.216 GB, free: 248.4 MB / 0.795 GB
Notification: Performance of buildModelFMU: Generate platform static: time 20.28/22.24, allocations: 9 kB / 1.216 GB, free: 248.4 MB / 0.795 GB
(rm -f IDEAS_dev_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.sim & python3 -m fmpy simulate  --output-file IDEAS_dev_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading_res.csv --start-time 0 --stop-time 14400 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 5.76 IDEAS_dev_IDEAS_Fluid_Storage_Validation_StratifiedLoadingUnloading.fmu > IDEAS_dev_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe 2>&1)