Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.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/Buildings 10.1.1-maint.10.0.x/package.mo", uses=false)
Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/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(Buildings.Fluid.Storage.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTanDyn.port_a.m_flow|senTanDyn.T|senTanSte.T|tanDyn.QHex_flow|tanSte.QHex_flow|tanDyn.vol.1..T|tanDyn.vol.5..T|tanDyn.vol.7..T|tanSte.vol.1..T|tanSte.vol.5..T|tanSte.vol.7..T",fileNamePrefix="Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics")
translateModel(Buildings.Fluid.Storage.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTanDyn.port_a.m_flow|senTanDyn.T|senTanSte.T|tanDyn.QHex_flow|tanSte.QHex_flow|tanDyn.vol.1..T|tanDyn.vol.5..T|tanDyn.vol.7..T|tanSte.vol.1..T|tanSte.vol.5..T|tanSte.vol.7..T",fileNamePrefix="Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001566/0.001566, allocations: 108.1 kB / 16.41 MB, free: 6.512 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.001747/0.001747, allocations: 192.3 kB / 17.35 MB, free: 5.738 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.351/1.351, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.456/2.456, allocations: 437 MB / 0.7112 GB, free: 4.391 MB / 0.5762 GB
Notification: Performance of FrontEnd - loaded program: time 0.001406/0.001406, allocations: 68.09 kB / 1.019 GB, free: 9.414 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7644/0.7658, allocations: 151.6 MB / 1.167 GB, free: 3.816 MB / 0.8887 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Storage.Validation.HeatExchangerDynamics): time 0.1063/0.8721, allocations: 112.1 MB / 1.277 GB, free: 3.312 MB / 0.9981 GB
Notification: Performance of NFInst.instExpressions: time 0.04164/0.9138, allocations: 32.03 MB / 1.308 GB, free: 3.199 MB / 1.029 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005169/0.919, allocations: 159.1 kB / 1.308 GB, free: 3.043 MB / 1.029 GB
Notification: Performance of NFTyping.typeComponents: time 0.005391/0.9244, allocations: 1.847 MB / 1.31 GB, free: 1.184 MB / 1.029 GB
Notification: Performance of NFTyping.typeBindings: time 0.01411/0.9386, allocations: 4.838 MB / 1.315 GB, free: 12.32 MB / 1.045 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009483/0.9481, allocations: 3.604 MB / 1.318 GB, free: 8.734 MB / 1.045 GB
Notification: Performance of NFFlatten.flatten: time 0.04833/0.9964, allocations: 47.79 MB / 1.365 GB, free: 8.828 MB / 1.092 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0299/1.026, allocations: 23.8 MB / 1.388 GB, free: 0.8711 MB / 1.107 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02933/1.056, allocations: 16.36 MB / 1.404 GB, free: 0.5469 MB / 1.123 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02301/1.079, allocations: 14.03 MB / 1.418 GB, free: 2.461 MB / 1.139 GB
Notification: Performance of NFPackage.collectConstants: time 0.0074/1.086, allocations: 2.434 MB / 1.42 GB, free: 28 kB / 1.139 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01684/1.103, allocations: 4.75 MB / 1.425 GB, free: 11.27 MB / 1.154 GB
Notification: Performance of NFScalarize.scalarize: time 0.01157/1.115, allocations: 5.501 MB / 1.43 GB, free: 5.758 MB / 1.154 GB
Notification: Performance of NFVerifyModel.verify: time 0.02558/1.14, allocations: 11.09 MB / 1.441 GB, free: 10.62 MB / 1.17 GB
Notification: Performance of NFConvertDAE.convert: time 0.04361/1.184, allocations: 34.59 MB / 1.475 GB, free: 7.941 MB / 1.201 GB
Notification: Performance of FrontEnd - DAE generated: time 6.542e-06/1.184, allocations: 0 / 1.475 GB, free: 7.941 MB / 1.201 GB
Notification: Performance of FrontEnd: time 2.094e-06/1.184, allocations: 0 / 1.475 GB, free: 7.941 MB / 1.201 GB
Notification: Performance of Transformations before backend: time 0.001183/1.185, allocations: 0 / 1.475 GB, free: 7.941 MB / 1.201 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3345
 * Number of variables: 3345
Notification: Performance of Generate backend data structure: time 0.0579/1.243, allocations: 19.84 MB / 1.494 GB, free: 3.961 MB / 1.217 GB
Notification: Performance of prepare preOptimizeDAE: time 5.635e-05/1.243, allocations: 8.922 kB / 1.494 GB, free: 3.953 MB / 1.217 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01173/1.255, allocations: 1.976 MB / 1.496 GB, free: 1.957 MB / 1.217 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03777/1.293, allocations: 16.34 MB / 1.512 GB, free: 1.52 MB / 1.232 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00107/1.294, allocations: 0.9982 MB / 1.513 GB, free: 0.5195 MB / 1.232 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005549/1.299, allocations: 1.336 MB / 1.514 GB, free: 15.18 MB / 1.248 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0499/1.349, allocations: 20.26 MB / 1.534 GB, free: 10.36 MB / 1.264 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005821/1.35, allocations: 39.64 kB / 1.534 GB, free: 10.32 MB / 1.264 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004056/1.354, allocations: 0.543 MB / 1.535 GB, free: 9.781 MB / 1.264 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003743/1.354, allocations: 391.8 kB / 1.535 GB, free: 9.398 MB / 1.264 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03769/1.392, allocations: 18.14 MB / 1.553 GB, free: 7.23 MB / 1.279 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 1.171/2.563, allocations: 86.46 MB / 1.637 GB, free: 284.6 MB / 1.279 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01646/2.58, allocations: 12.96 MB / 1.65 GB, free: 272.4 MB / 1.279 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00896/2.589, allocations: 7.392 MB / 1.657 GB, free: 265 MB / 1.279 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 evalFunc (simulation): time 0.04841/2.637, allocations: 26.92 MB / 1.683 GB, free: 237.4 MB / 1.279 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.009008/2.646, allocations: 6.053 MB / 1.689 GB, free: 231.3 MB / 1.279 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.005024/2.651, allocations: 0.8313 MB / 1.69 GB, free: 230.5 MB / 1.279 GB
Notification: Performance of pre-optimization done (n=772): time 1.945e-05/2.651, allocations: 0 / 1.69 GB, free: 230.5 MB / 1.279 GB
Notification: Performance of matching and sorting (n=772): time 0.09863/2.75, allocations: 32.37 MB / 1.722 GB, free: 198 MB / 1.279 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.188e-05/2.75, allocations: 155.1 kB / 1.722 GB, free: 197.8 MB / 1.279 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01698/2.767, allocations: 12.83 MB / 1.734 GB, free: 185 MB / 1.279 GB
Notification: Performance of collectPreVariables (initialization): time 0.002214/2.769, allocations: 205.7 kB / 1.735 GB, free: 184.8 MB / 1.279 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005916/2.775, allocations: 7.032 MB / 1.742 GB, free: 177.8 MB / 1.279 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003681/2.779, allocations: 2.692 MB / 1.744 GB, free: 175.1 MB / 1.279 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003572/2.782, allocations: 2.313 MB / 1.746 GB, free: 172.7 MB / 1.279 GB
Notification: Performance of setup shared object (initialization): time 3.984e-05/2.782, allocations: 305.1 kB / 1.747 GB, free: 172.4 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00796/2.79, allocations: 6.326 MB / 1.753 GB, free: 166.1 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009621/2.8, allocations: 9.602 MB / 1.762 GB, free: 155.1 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01828/2.818, allocations: 15.95 MB / 1.778 GB, free: 137.7 MB / 1.279 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.675e-05/2.818, allocations: 31.94 kB / 1.778 GB, free: 137.7 MB / 1.279 GB
Notification: Performance of matching and sorting (n=1474) (initialization): time 0.02967/2.848, allocations: 18.88 MB / 1.796 GB, free: 118.7 MB / 1.279 GB
Notification: Performance of prepare postOptimizeDAE: time 8.227e-05/2.848, allocations: 73.7 kB / 1.796 GB, free: 118.6 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001204/2.848, allocations: 100 kB / 1.796 GB, free: 118.5 MB / 1.279 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0614/2.91, allocations: 9.117 MB / 1.805 GB, free: 109.3 MB / 1.279 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009871/2.92, allocations: 2.461 MB / 1.808 GB, free: 106.9 MB / 1.279 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01008/2.93, allocations: 10.82 MB / 1.818 GB, free: 95.76 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01259/2.942, allocations: 0.7292 MB / 1.819 GB, free: 95.03 MB / 1.279 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002297/2.945, allocations: 0.5179 MB / 1.82 GB, free: 94.52 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01822/2.963, allocations: 11.72 MB / 1.831 GB, free: 82.78 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01097/2.974, allocations: 9.59 MB / 1.84 GB, free: 71.8 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01858/2.993, allocations: 15.95 MB / 1.856 GB, free: 54.39 MB / 1.279 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.16e-05/2.993, allocations: 28 kB / 1.856 GB, free: 54.36 MB / 1.279 GB
Notification: Performance of matching and sorting (n=1474) (initialization_lambda0): time 0.03248/3.025, allocations: 18.87 MB / 1.874 GB, free: 35.37 MB / 1.279 GB
Notification: Performance of prepare postOptimizeDAE: time 7.55e-05/3.025, allocations: 77.64 kB / 1.874 GB, free: 35.29 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.479e-05/3.025, allocations: 96 kB / 1.875 GB, free: 35.19 MB / 1.279 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06189/3.087, allocations: 9.123 MB / 1.883 GB, free: 26.05 MB / 1.279 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01016/3.097, allocations: 2.453 MB / 1.886 GB, free: 23.59 MB / 1.279 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01039/3.108, allocations: 10.82 MB / 1.896 GB, free: 12.47 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01163/3.119, allocations: 0.7137 MB / 1.897 GB, free: 11.75 MB / 1.279 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002261/3.122, allocations: 0.5194 MB / 1.898 GB, free: 11.23 MB / 1.279 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 448
 * Number of states: 0 ()
 * Number of discrete variables: 5 (mHex_flow_in.count,$PRE.mHex_flow_in.count,mHex_flow_in.T_start,$PRE.mHex_flow_in.T_start,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1286):
 * Single equations (assignments): 1282
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * 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): 1 system
   {(16,144)}
Notification: Performance of prepare postOptimizeDAE: time 0.002573/3.124, allocations: 0.8606 MB / 1.898 GB, free: 10.37 MB / 1.279 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003694/3.128, allocations: 1.169 MB / 1.9 GB, free: 9.188 MB / 1.279 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.022/3.15, allocations: 13.37 MB / 1.913 GB, free: 11.77 MB / 1.295 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01781/3.168, allocations: 11.04 MB / 1.923 GB, free: 0.6484 MB / 1.295 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.909e-05/3.168, allocations: 384 / 1.923 GB, free: 0.6484 MB / 1.295 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008453/3.176, allocations: 2.779 MB / 1.926 GB, free: 13.83 MB / 1.311 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00399/3.18, allocations: 163.9 kB / 1.926 GB, free: 13.67 MB / 1.311 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009473/3.19, allocations: 463.1 kB / 1.927 GB, free: 13.22 MB / 1.311 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00191/3.192, allocations: 457.5 kB / 1.927 GB, free: 12.77 MB / 1.311 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.03318/3.225, allocations: 14.32 MB / 1.941 GB, free: 14.39 MB / 1.326 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.03387/3.259, allocations: 18.92 MB / 1.96 GB, free: 11.37 MB / 1.342 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.009168/3.268, allocations: 5.522 MB / 1.965 GB, free: 5.832 MB / 1.342 GB
Notification: Performance of sorting global known variables: time 0.01841/3.287, allocations: 8.904 MB / 1.974 GB, free: 12.96 MB / 1.358 GB
Notification: Performance of Backend: time 1.192e-06/3.287, allocations: 0 / 1.974 GB, free: 12.96 MB / 1.358 GB
Notification: Performance of simCode: created initialization part: time 0.04703/3.334, allocations: 19.79 MB / 1.993 GB, free: 9.207 MB / 1.373 GB
Notification: Performance of SimCode: time 0.07405/3.408, allocations: 36.06 MB / 2.028 GB, free: 5.289 MB / 1.404 GB
Notification: Performance of Templates: time 1.532/4.94, allocations: 333.2 MB / 2.354 GB, free: 308.9 MB / 1.483 GB
make -j1 -f Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.makefile
(rm -f Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; mkfifo Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; head -c 1048576 < Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.pipe >> ../files/Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.sim & ./Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Fluid.Storage.Validation.HeatExchangerDynamics.pipe 2>&1)