Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Storage.Examples.StratifiedUnloadAtMinimumTemperature.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.Storage.Examples.StratifiedUnloadAtMinimumTemperature,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Storage.Examples.StratifiedUnloadAtMinimumTemperature")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.003596/0.003601, allocations: 359.9 kB / 16.59 MB, free: 5.562 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.335/1.335, allocations: 165.8 MB / 183.1 MB, free: 5.902 MB / 90.72 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.24/4.24, allocations: 410.8 MB / 0.6001 GB, free: 2.195 MB / 410.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001798/0.001798, allocations: 191.5 kB / 0.6668 GB, free: 14.04 MB / 490.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004799/0.00048, allocations: 16 kB / 0.7429 GB, free: 40 kB / 0.5417 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4531/0.4536, allocations: 67.44 MB / 0.8087 GB, free: 245.4 MB / 0.5886 GB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Storage.Examples.StratifiedUnloadAtMinimumTemperature): time 0.04707/0.5007, allocations: 34.87 MB / 0.8428 GB, free: 220.5 MB / 0.5886 GB
Notification: Performance of NFInst.instExpressions: time 0.0223/0.523, allocations: 11.61 MB / 0.8541 GB, free: 211.1 MB / 0.5886 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002284/0.5254, allocations: 44.53 kB / 0.8542 GB, free: 211.1 MB / 0.5886 GB
Notification: Performance of NFTyping.typeComponents: time 0.002678/0.5281, allocations: 0.5732 MB / 0.8547 GB, free: 210.5 MB / 0.5886 GB
Notification: Performance of NFTyping.typeBindings: time 0.006426/0.5345, allocations: 1.595 MB / 0.8563 GB, free: 208.9 MB / 0.5886 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01018/0.5448, allocations: 2.594 MB / 0.8588 GB, free: 206.4 MB / 0.5886 GB
Notification: Performance of NFFlatten.flatten: time 0.01037/0.5551, allocations: 8.858 MB / 0.8675 GB, free: 197.5 MB / 0.5886 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004575/0.5598, allocations: 2.749 MB / 0.8702 GB, free: 194.8 MB / 0.5886 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004988/0.5648, allocations: 2.062 MB / 0.8722 GB, free: 192.7 MB / 0.5886 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004669/0.5695, allocations: 2.137 MB / 0.8743 GB, free: 190.6 MB / 0.5886 GB
Notification: Performance of NFPackage.collectConstants: time 0.0006939/0.5703, allocations: 132 kB / 0.8744 GB, free: 190.5 MB / 0.5886 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003207/0.5735, allocations: 0.6276 MB / 0.875 GB, free: 189.8 MB / 0.5886 GB
Notification: Performance of NFScalarize.scalarize: time 0.0009417/0.5745, allocations: 0.5914 MB / 0.8756 GB, free: 189.2 MB / 0.5886 GB
Notification: Performance of NFVerifyModel.verify: time 0.001205/0.5757, allocations: 0.6369 MB / 0.8762 GB, free: 188.6 MB / 0.5886 GB
Notification: Performance of NFConvertDAE.convert: time 0.005502/0.5812, allocations: 3.947 MB / 0.88 GB, free: 184.6 MB / 0.5886 GB
Notification: Performance of FrontEnd - DAE generated: time 7.144e-06/0.5813, allocations: 0 / 0.88 GB, free: 184.6 MB / 0.5886 GB
Notification: Performance of FrontEnd: time 2.956e-06/0.5813, allocations: 0 / 0.88 GB, free: 184.6 MB / 0.5886 GB
Notification: Performance of Transformations before backend: time 0.0001537/0.5814, allocations: 2.156 kB / 0.88 GB, free: 184.6 MB / 0.5886 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 586
 * Number of variables: 586
Notification: Performance of Generate backend data structure: time 0.008259/0.5897, allocations: 2.992 MB / 0.883 GB, free: 181.6 MB / 0.5886 GB
Notification: Performance of prepare preOptimizeDAE: time 5.026e-05/0.5898, allocations: 8.031 kB / 0.883 GB, free: 181.6 MB / 0.5886 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001506/0.5913, allocations: 360 kB / 0.8833 GB, free: 181.2 MB / 0.5886 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006263/0.5976, allocations: 2.521 MB / 0.8858 GB, free: 178.7 MB / 0.5886 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001567/0.5978, allocations: 180.6 kB / 0.886 GB, free: 178.5 MB / 0.5886 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005252/0.5983, allocations: 235.9 kB / 0.8862 GB, free: 178.3 MB / 0.5886 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007563/0.6059, allocations: 3.212 MB / 0.8893 GB, free: 174.9 MB / 0.5886 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.924e-05/0.606, allocations: 8 kB / 0.8893 GB, free: 174.9 MB / 0.5886 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003697/0.6064, allocations: 102.9 kB / 0.8894 GB, free: 174.8 MB / 0.5886 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.836e-05/0.6065, allocations: 63.94 kB / 0.8895 GB, free: 174.7 MB / 0.5886 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00646/0.613, allocations: 2.57 MB / 0.892 GB, free: 172.1 MB / 0.5886 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.02332/0.6363, allocations: 13.75 MB / 0.9054 GB, free: 157.4 MB / 0.5886 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00407/0.6405, allocations: 1.622 MB / 0.907 GB, free: 155.7 MB / 0.5886 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002496/0.643, allocations: 1.17 MB / 0.9081 GB, free: 154.6 MB / 0.5886 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001061/0.6441, allocations: 0.7205 MB / 0.9088 GB, free: 153.7 MB / 0.5886 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.98e-05/0.6442, allocations: 59.48 kB / 0.9089 GB, free: 153.6 MB / 0.5886 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002013/0.6462, allocations: 183.8 kB / 0.9091 GB, free: 153.4 MB / 0.5886 GB
Notification: Performance of pre-optimization done (n=126): time 6.001e-06/0.6462, allocations: 0 / 0.9091 GB, free: 153.4 MB / 0.5886 GB
Notification: Performance of matching and sorting (n=126): time 0.01544/0.6617, allocations: 3.452 MB / 0.9125 GB, free: 149.9 MB / 0.5886 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.992e-05/0.6618, allocations: 141.5 kB / 0.9126 GB, free: 149.8 MB / 0.5886 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003433/0.6652, allocations: 1.939 MB / 0.9145 GB, free: 147.8 MB / 0.5886 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003605/0.6656, allocations: 57.7 kB / 0.9145 GB, free: 147.7 MB / 0.5886 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001194/0.6668, allocations: 1.26 MB / 0.9158 GB, free: 146.5 MB / 0.5886 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0006698/0.6675, allocations: 445.8 kB / 0.9162 GB, free: 146 MB / 0.5886 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001432/0.6677, allocations: 28 kB / 0.9162 GB, free: 146 MB / 0.5886 GB
Notification: Performance of setup shared object (initialization): time 0.0001275/0.6678, allocations: 373.9 kB / 0.9166 GB, free: 145.6 MB / 0.5886 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001735/0.6696, allocations: 0.7261 MB / 0.9173 GB, free: 144.9 MB / 0.5886 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002001/0.6716, allocations: 1.236 MB / 0.9185 GB, free: 143.5 MB / 0.5886 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002194/0.6738, allocations: 0.9471 MB / 0.9194 GB, free: 142.5 MB / 0.5886 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.361e-05/0.6738, allocations: 4 kB / 0.9194 GB, free: 142.5 MB / 0.5886 GB
Notification: Performance of matching and sorting (n=213) (initialization): time 0.005964/0.6798, allocations: 2.41 MB / 0.9218 GB, free: 140.1 MB / 0.5886 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002834/0.6801, allocations: 0.4992 MB / 0.9223 GB, free: 139.4 MB / 0.5886 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.324e-05/0.6802, allocations: 16 kB / 0.9223 GB, free: 139.4 MB / 0.5886 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003489/0.6837, allocations: 0.5177 MB / 0.9228 GB, free: 138.8 MB / 0.5886 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00256/0.6863, allocations: 347.4 kB / 0.9231 GB, free: 138.5 MB / 0.5886 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004455/0.6908, allocations: 3.142 MB / 0.9262 GB, free: 135.2 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003441/0.6942, allocations: 231.4 kB / 0.9264 GB, free: 135 MB / 0.5886 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002892/0.6946, allocations: 79.97 kB / 0.9265 GB, free: 134.9 MB / 0.5886 GB
Notification: Performance of prepare postOptimizeDAE: time 1.113e-05/0.6946, allocations: 4 kB / 0.9265 GB, free: 134.9 MB / 0.5886 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.005284/0.6999, allocations: 2.175 MB / 0.9286 GB, free: 132.7 MB / 0.5886 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.033e-05/0.7, allocations: 16.94 kB / 0.9286 GB, free: 132.7 MB / 0.5886 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000937/0.7009, allocations: 249.5 kB / 0.9289 GB, free: 132.5 MB / 0.5886 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002667/0.7036, allocations: 369.9 kB / 0.9292 GB, free: 132.1 MB / 0.5886 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005411/0.709, allocations: 4.18 MB / 0.9333 GB, free: 127.7 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003281/0.7123, allocations: 215.6 kB / 0.9335 GB, free: 127.5 MB / 0.5886 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003541/0.7127, allocations: 79.97 kB / 0.9336 GB, free: 127.4 MB / 0.5886 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 63
 * Number of states: 0 ()
 * Number of discrete variables: 8 ($PRE.onOffBot.y,onOffBot.y,$PRE.onOffMid.y,onOffMid.y,and2.y,yTop.u,$PRE.onOffHea.y,onOffHea.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (179):
 * Single equations (assignments): 177
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(1,100.0%) 10}
 * Non-linear torn systems: 1 {3 22}
Notification: Performance of prepare postOptimizeDAE: time 0.002136/0.7149, allocations: 1.006 MB / 0.9346 GB, free: 126.4 MB / 0.5886 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006166/0.7155, allocations: 205.5 kB / 0.9348 GB, free: 126.2 MB / 0.5886 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005203/0.7207, allocations: 2.059 MB / 0.9368 GB, free: 124.1 MB / 0.5886 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0038/0.7246, allocations: 1.667 MB / 0.9384 GB, free: 122.4 MB / 0.5886 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.143e-05/0.7246, allocations: 3.438 kB / 0.9384 GB, free: 122.4 MB / 0.5886 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001619/0.7263, allocations: 0.51 MB / 0.9389 GB, free: 121.9 MB / 0.5886 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004372/0.7267, allocations: 28 kB / 0.9389 GB, free: 121.8 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00266/0.7294, allocations: 198.1 kB / 0.9391 GB, free: 121.6 MB / 0.5886 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000301/0.7297, allocations: 105.1 kB / 0.9392 GB, free: 121.5 MB / 0.5886 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.006447/0.7362, allocations: 2.146 MB / 0.9413 GB, free: 119.4 MB / 0.5886 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.006079/0.7423, allocations: 2.877 MB / 0.9441 GB, free: 116.5 MB / 0.5886 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001644/0.744, allocations: 0.789 MB / 0.9449 GB, free: 115.7 MB / 0.5886 GB
Notification: Performance of sorting global known variables: time 0.002712/0.7467, allocations: 1.337 MB / 0.9462 GB, free: 114.3 MB / 0.5886 GB
Notification: Performance of Backend: time 2.034e-06/0.7468, allocations: 0 / 0.9462 GB, free: 114.3 MB / 0.5886 GB
Notification: Performance of simCode: created initialization part: time 0.00871/0.7555, allocations: 3.072 MB / 0.9492 GB, free: 111.3 MB / 0.5886 GB
Notification: Performance of SimCode: time 0.01725/0.7728, allocations: 7.203 MB / 0.9562 GB, free: 104.1 MB / 0.5886 GB
Notification: Performance of Templates: time 0.1097/0.8826, allocations: 47.62 MB / 1.003 GB, free: 57.22 MB / 0.5886 GB