Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_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/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/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: translateModel(IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading")
translateModel(IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001378/0.001378, allocations: 108 kB / 15.6 MB, free: 128 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.001281/0.001281, allocations: 196.6 kB / 16.53 MB, free: 6.672 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.295/1.295, allocations: 222.9 MB / 240.2 MB, free: 4.422 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.725/0.725, allocations: 132.2 MB / 422.6 MB, free: 1.777 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001387/0.001387, allocations: 64.23 kB / 0.5018 GB, free: 3.852 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5013/0.5027, allocations: 80.2 MB / 0.5801 GB, free: 4.535 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading): time 0.0578/0.5605, allocations: 55.98 MB / 0.6348 GB, free: 9.375 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02551/0.5861, allocations: 17.94 MB / 0.6523 GB, free: 7.379 MB / 494.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004265/0.5904, allocations: 75.56 kB / 0.6523 GB, free: 7.305 MB / 494.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.003338/0.5938, allocations: 0.8923 MB / 0.6532 GB, free: 6.406 MB / 494.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.009681/0.6035, allocations: 2.51 MB / 0.6557 GB, free: 3.883 MB / 494.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0045/0.608, allocations: 1.517 MB / 0.6571 GB, free: 2.379 MB / 494.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0221/0.6302, allocations: 21.21 MB / 0.6779 GB, free: 13.12 MB / 0.5137 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01443/0.6446, allocations: 10.7 MB / 0.6883 GB, free: 2.293 MB / 0.5137 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01433/0.659, allocations: 7.143 MB / 0.6953 GB, free: 11.17 MB / 0.5294 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01055/0.6696, allocations: 6.374 MB / 0.7015 GB, free: 4.77 MB / 0.5294 GB
Notification: Performance of NFPackage.collectConstants: time 0.002948/0.6725, allocations: 0.9375 MB / 0.7024 GB, free: 3.832 MB / 0.5294 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006564/0.6791, allocations: 1.69 MB / 0.7041 GB, free: 2.141 MB / 0.5294 GB
Notification: Performance of NFScalarize.scalarize: time 0.004004/0.6831, allocations: 2.349 MB / 0.7064 GB, free: 15.78 MB / 0.545 GB
Notification: Performance of NFVerifyModel.verify: time 0.01012/0.6933, allocations: 4.7 MB / 0.711 GB, free: 11.06 MB / 0.545 GB
Notification: Performance of NFConvertDAE.convert: time 0.01459/0.7079, allocations: 13.05 MB / 0.7237 GB, free: 13.97 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 7.183e-06/0.7079, allocations: 4 kB / 0.7237 GB, free: 13.97 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 1.383e-06/0.7079, allocations: 0 / 0.7237 GB, free: 13.97 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 0.0003157/0.7083, allocations: 0 / 0.7237 GB, free: 13.97 MB / 0.5606 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.01585/0.7241, allocations: 8.522 MB / 0.732 GB, free: 5.352 MB / 0.5606 GB
Notification: Performance of prepare preOptimizeDAE: time 4.153e-05/0.7242, allocations: 8.031 kB / 0.732 GB, free: 5.344 MB / 0.5606 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002561/0.7267, allocations: 0.8626 MB / 0.7329 GB, free: 4.473 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01088/0.7376, allocations: 6.425 MB / 0.7392 GB, free: 13.99 MB / 0.5762 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003102/0.738, allocations: 460.2 kB / 0.7396 GB, free: 13.54 MB / 0.5762 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001188/0.7392, allocations: 0.5897 MB / 0.7402 GB, free: 12.95 MB / 0.5762 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01687/0.756, allocations: 9.025 MB / 0.749 GB, free: 3.602 MB / 0.5762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001286/0.7562, allocations: 23.78 kB / 0.749 GB, free: 3.578 MB / 0.5762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007286/0.757, allocations: 264 kB / 0.7493 GB, free: 3.32 MB / 0.5762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001734/0.7571, allocations: 187.9 kB / 0.7494 GB, free: 3.137 MB / 0.5762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01244/0.7696, allocations: 7.441 MB / 0.7567 GB, free: 11.69 MB / 0.5919 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.04204/0.8116, allocations: 36.25 MB / 0.7921 GB, free: 5.371 MB / 0.6231 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005609/0.8173, allocations: 4.276 MB / 0.7963 GB, free: 1.105 MB / 0.6231 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004085/0.8214, allocations: 3.312 MB / 0.7995 GB, free: 13.79 MB / 0.6387 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001153/0.8226, allocations: 0.9583 MB / 0.8005 GB, free: 12.64 MB / 0.6387 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00338/0.826, allocations: 2.39 MB / 0.8028 GB, free: 10.21 MB / 0.6387 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002211/0.8282, allocations: 367.8 kB / 0.8031 GB, free: 9.852 MB / 0.6387 GB
Notification: Performance of pre-optimization done (n=317): time 7.203e-06/0.8282, allocations: 0 / 0.8031 GB, free: 9.852 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=317): time 0.01175/0.8399, allocations: 7.132 MB / 0.8101 GB, free: 2.629 MB / 0.6387 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.665e-05/0.84, allocations: 85.91 kB / 0.8102 GB, free: 2.531 MB / 0.6387 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.3177/1.158, allocations: 5.667 MB / 0.8157 GB, free: 201.1 MB / 0.6387 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007942/1.159, allocations: 87.14 kB / 0.8158 GB, free: 201 MB / 0.6387 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003134/1.162, allocations: 3.194 MB / 0.8189 GB, free: 199.3 MB / 0.6387 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00161/1.163, allocations: 1.111 MB / 0.82 GB, free: 198.4 MB / 0.6387 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001362/1.165, allocations: 0.858 MB / 0.8208 GB, free: 198 MB / 0.6387 GB
Notification: Performance of setup shared object (initialization): time 5.307e-05/1.165, allocations: 305.4 kB / 0.8211 GB, free: 197.7 MB / 0.6387 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003857/1.169, allocations: 2.162 MB / 0.8232 GB, free: 197 MB / 0.6387 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004944/1.174, allocations: 3.696 MB / 0.8269 GB, free: 194.4 MB / 0.6387 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01143/1.185, allocations: 6.325 MB / 0.833 GB, free: 190.5 MB / 0.6387 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001143/1.185, allocations: 18.59 kB / 0.8331 GB, free: 190.5 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=569) (initialization): time 0.01405/1.199, allocations: 6.775 MB / 0.8397 GB, free: 187.9 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 7.867e-05/1.199, allocations: 56.33 kB / 0.8397 GB, free: 187.9 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.373e-05/1.199, allocations: 48.75 kB / 0.8398 GB, free: 187.9 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009562/1.2, allocations: 438.4 kB / 0.8402 GB, free: 187.8 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003279/1.204, allocations: 1.004 MB / 0.8412 GB, free: 187.7 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004569/1.208, allocations: 5.703 MB / 0.8467 GB, free: 183.5 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004369/1.213, allocations: 283.7 kB / 0.847 GB, free: 183.4 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004019/1.213, allocations: 216.5 kB / 0.8472 GB, free: 183.4 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.003623/1.217, allocations: 2.489 MB / 0.8496 GB, free: 182.3 MB / 0.6387 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00115/1.218, allocations: 0.5257 MB / 0.8502 GB, free: 182 MB / 0.6387 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007831/1.226, allocations: 5.262 MB / 0.8553 GB, free: 179.1 MB / 0.6387 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.915e-05/1.226, allocations: 42.36 kB / 0.8553 GB, free: 179.1 MB / 0.6387 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.036e-05/1.226, allocations: 11.53 kB / 0.8553 GB, free: 179.1 MB / 0.6387 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.005223/1.231, allocations: 4.524 MB / 0.8598 GB, free: 175.8 MB / 0.6387 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0214/1.252, allocations: 12.04 MB / 0.8715 GB, free: 163.6 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.219e-05/1.253, allocations: 0 / 0.8715 GB, free: 163.6 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00242/1.255, allocations: 0.6435 MB / 0.8722 GB, free: 163 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.000745/1.256, allocations: 376.4 kB / 0.8725 GB, free: 162.6 MB / 0.6387 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002023/1.256, allocations: 83.95 kB / 0.8726 GB, free: 162.5 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.004112/1.26, allocations: 5.617 MB / 0.8781 GB, free: 156.7 MB / 0.6387 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.364e-06/1.26, allocations: 4 kB / 0.8781 GB, free: 156.7 MB / 0.6387 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00958/1.27, allocations: 7.759 MB / 0.8857 GB, free: 148.8 MB / 0.6387 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002872/1.273, allocations: 1.154 MB / 0.8868 GB, free: 147.7 MB / 0.6387 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001162/1.274, allocations: 71.98 kB / 0.8869 GB, free: 147.6 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003454/1.277, allocations: 202.2 kB / 0.887 GB, free: 147.4 MB / 0.6387 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000446/1.278, allocations: 201.5 kB / 0.8872 GB, free: 147.2 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002764/1.278, allocations: 139.9 kB / 0.8874 GB, free: 147.1 MB / 0.6387 GB
Notification: Performance of sorting global known variables: time 0.005228/1.283, allocations: 3.959 MB / 0.8912 GB, free: 143.1 MB / 0.6387 GB
Notification: Performance of sort global known variables: time 2.61e-07/1.283, allocations: 0 / 0.8912 GB, free: 143.1 MB / 0.6387 GB
Notification: Performance of remove unused functions: time 0.006035/1.289, allocations: 2.007 MB / 0.8932 GB, free: 141.1 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.001176/1.29, allocations: 497.8 kB / 0.8937 GB, free: 140.7 MB / 0.6387 GB
Notification: Performance of simCode: created initialization part: time 0.01948/1.31, allocations: 11.63 MB / 0.905 GB, free: 129 MB / 0.6387 GB
Notification: Performance of simCode: created event and clocks part: time 1.366e-05/1.31, allocations: 4 kB / 0.905 GB, free: 129 MB / 0.6387 GB
Notification: Performance of simCode: created simulation system equations: time 0.003352/1.313, allocations: 2.547 MB / 0.9075 GB, free: 126.5 MB / 0.6387 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01569/1.329, allocations: 3.391 MB / 0.9108 GB, free: 123.3 MB / 0.6387 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02097/1.35, allocations: 14.06 MB / 0.9246 GB, free: 109.3 MB / 0.6387 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003503/1.354, allocations: 4.628 MB / 0.9291 GB, free: 104.6 MB / 0.6387 GB
Notification: Performance of simCode: alias equations: time 0.006568/1.36, allocations: 2.071 MB / 0.9311 GB, free: 102.5 MB / 0.6387 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001641/1.362, allocations: 475.1 kB / 0.9316 GB, free: 102.1 MB / 0.6387 GB
Notification: Performance of SimCode: time 1.002e-06/1.362, allocations: 0 / 0.9316 GB, free: 102.1 MB / 0.6387 GB
Notification: Performance of Templates: time 0.168/1.53, allocations: 122 MB / 1.051 GB, free: 13.22 MB / 0.67 GB
make -j1 -f IDEAS_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.makefile
(rm -f IDEAS_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe ; mkfifo IDEAS_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe >> ../files/IDEAS_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.sim & ./IDEAS_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Fluid.Storage.Validation.StratifiedLoadingUnloading.pipe 2>&1)