Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.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/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: translateModel(IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics")
translateModel(IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.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.001241/0.001241, allocations: 112.5 kB / 17.09 MB, free: 5.984 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.001186/0.001186, allocations: 193.6 kB / 18.02 MB, free: 5.07 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.221/1.221, allocations: 222.9 MB / 241.7 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6718/0.6718, allocations: 115.3 MB / 407.2 MB, free: 6.242 MB / 318.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001139/0.001139, allocations: 70.94 kB / 0.5583 GB, free: 32.31 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1126/0.1138, allocations: 76.17 MB / 0.6327 GB, free: 4.438 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics): time 0.1002/0.2141, allocations: 112.1 MB / 0.7422 GB, free: 3.977 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.3206/0.5347, allocations: 32.02 MB / 0.7734 GB, free: 3.059 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004623/0.5394, allocations: 154.8 kB / 0.7736 GB, free: 3.059 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.003808/0.5432, allocations: 1.801 MB / 0.7753 GB, free: 3.035 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.0101/0.5533, allocations: 4.617 MB / 0.7799 GB, free: 2.852 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007328/0.5607, allocations: 3.589 MB / 0.7834 GB, free: 2.77 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.03742/0.5981, allocations: 47.73 MB / 0.83 GB, free: 11.08 MB / 0.6075 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02783/0.626, allocations: 23.79 MB / 0.8532 GB, free: 3.43 MB / 0.6231 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02788/0.6539, allocations: 16.38 MB / 0.8692 GB, free: 3.797 MB / 0.6387 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02186/0.6758, allocations: 14.04 MB / 0.8829 GB, free: 6.656 MB / 0.6544 GB
Notification: Performance of NFPackage.collectConstants: time 0.005155/0.6809, allocations: 2.434 MB / 0.8853 GB, free: 4.223 MB / 0.6544 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01328/0.6942, allocations: 4.739 MB / 0.8899 GB, free: 15.62 MB / 0.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.006128/0.7004, allocations: 5.499 MB / 0.8953 GB, free: 10.21 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.01774/0.7181, allocations: 11.09 MB / 0.9061 GB, free: 15.17 MB / 0.6856 GB
Notification: Performance of NFConvertDAE.convert: time 0.03581/0.754, allocations: 34.6 MB / 0.9399 GB, free: 13.23 MB / 0.7169 GB
Notification: Performance of FrontEnd - DAE generated: time 5.941e-06/0.754, allocations: 0 / 0.9399 GB, free: 13.23 MB / 0.7169 GB
Notification: Performance of FrontEnd: time 1.583e-06/0.754, allocations: 0 / 0.9399 GB, free: 13.23 MB / 0.7169 GB
Notification: Performance of Transformations before backend: time 0.0006956/0.7547, allocations: 8 kB / 0.9399 GB, free: 13.22 MB / 0.7169 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.04334/0.7981, allocations: 19.83 MB / 0.9593 GB, free: 9.395 MB / 0.7325 GB
Notification: Performance of prepare preOptimizeDAE: time 4.198e-05/0.7981, allocations: 8.031 kB / 0.9593 GB, free: 9.387 MB / 0.7325 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007904/0.806, allocations: 1.979 MB / 0.9612 GB, free: 7.387 MB / 0.7325 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02697/0.833, allocations: 16.34 MB / 0.9772 GB, free: 7.262 MB / 0.7481 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006809/0.8337, allocations: 1.004 MB / 0.9782 GB, free: 6.262 MB / 0.7481 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003008/0.8367, allocations: 1.338 MB / 0.9795 GB, free: 4.93 MB / 0.7481 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03744/0.8742, allocations: 20.25 MB / 0.9992 GB, free: 132 kB / 0.7637 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002441/0.8745, allocations: 35.66 kB / 0.9993 GB, free: 96 kB / 0.7637 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00152/0.876, allocations: 0.5488 MB / 0.9998 GB, free: 15.55 MB / 0.7794 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003085/0.8763, allocations: 391.8 kB / 1 GB, free: 15.18 MB / 0.7794 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02859/0.9049, allocations: 18.14 MB / 1.018 GB, free: 13.01 MB / 0.795 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.6259/1.531, allocations: 86.47 MB / 1.102 GB, free: 252.5 MB / 0.8107 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01493/1.546, allocations: 12.96 MB / 1.115 GB, free: 245.4 MB / 0.8107 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007873/1.554, allocations: 7.394 MB / 1.122 GB, free: 241.6 MB / 0.8107 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.03667/1.59, allocations: 26.94 MB / 1.149 GB, free: 219.5 MB / 0.8107 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.006786/1.597, allocations: 6.053 MB / 1.154 GB, free: 213.3 MB / 0.8107 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.003794/1.601, allocations: 0.8232 MB / 1.155 GB, free: 212.6 MB / 0.8107 GB
Notification: Performance of pre-optimization done (n=772): time 1.188e-05/1.601, allocations: 0 / 1.155 GB, free: 212.6 MB / 0.8107 GB
Notification: Performance of matching and sorting (n=772): time 0.08781/1.689, allocations: 32.38 MB / 1.187 GB, free: 180.2 MB / 0.8107 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.318e-05/1.689, allocations: 155.1 kB / 1.187 GB, free: 180 MB / 0.8107 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01437/1.703, allocations: 12.83 MB / 1.2 GB, free: 167.2 MB / 0.8107 GB
Notification: Performance of collectPreVariables (initialization): time 0.001434/1.705, allocations: 201.7 kB / 1.2 GB, free: 167 MB / 0.8107 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005306/1.71, allocations: 7.033 MB / 1.207 GB, free: 160 MB / 0.8107 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00243/1.713, allocations: 2.696 MB / 1.209 GB, free: 157.3 MB / 0.8107 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002937/1.716, allocations: 2.313 MB / 1.211 GB, free: 155 MB / 0.8107 GB
Notification: Performance of setup shared object (initialization): time 3.515e-05/1.716, allocations: 301.1 kB / 1.212 GB, free: 154.7 MB / 0.8107 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007078/1.723, allocations: 6.329 MB / 1.218 GB, free: 148.3 MB / 0.8107 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008164/1.731, allocations: 9.601 MB / 1.227 GB, free: 137.3 MB / 0.8107 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01573/1.747, allocations: 15.96 MB / 1.243 GB, free: 119.9 MB / 0.8107 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.984e-05/1.747, allocations: 28 kB / 1.243 GB, free: 119.9 MB / 0.8107 GB
Notification: Performance of matching and sorting (n=1474) (initialization): time 0.02449/1.771, allocations: 18.88 MB / 1.261 GB, free: 100.9 MB / 0.8107 GB
Notification: Performance of prepare postOptimizeDAE: time 7.122e-05/1.771, allocations: 73.7 kB / 1.261 GB, free: 100.8 MB / 0.8107 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.435e-05/1.771, allocations: 100 kB / 1.262 GB, free: 100.7 MB / 0.8107 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.05654/1.828, allocations: 9.119 MB / 1.27 GB, free: 91.58 MB / 0.8107 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008708/1.837, allocations: 2.457 MB / 1.273 GB, free: 89.12 MB / 0.8107 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009619/1.846, allocations: 10.81 MB / 1.283 GB, free: 78.01 MB / 0.8107 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01036/1.857, allocations: 0.7332 MB / 1.284 GB, free: 77.28 MB / 0.8107 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001214/1.858, allocations: 0.5194 MB / 1.285 GB, free: 76.76 MB / 0.8107 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01358/1.871, allocations: 11.73 MB / 1.296 GB, free: 65.02 MB / 0.8107 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.008053/1.879, allocations: 9.586 MB / 1.305 GB, free: 54.05 MB / 0.8107 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01499/1.894, allocations: 15.95 MB / 1.321 GB, free: 36.63 MB / 0.8107 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.226e-05/1.895, allocations: 28 kB / 1.321 GB, free: 36.61 MB / 0.8107 GB
Notification: Performance of matching and sorting (n=1474) (initialization_lambda0): time 0.02337/1.918, allocations: 18.87 MB / 1.339 GB, free: 17.61 MB / 0.8107 GB
Notification: Performance of prepare postOptimizeDAE: time 6.072e-05/1.918, allocations: 74.64 kB / 1.34 GB, free: 17.53 MB / 0.8107 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.624e-05/1.918, allocations: 96 kB / 1.34 GB, free: 17.44 MB / 0.8107 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.05658/1.975, allocations: 9.124 MB / 1.349 GB, free: 8.301 MB / 0.8107 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008879/1.984, allocations: 2.449 MB / 1.351 GB, free: 5.848 MB / 0.8107 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.5339/2.518, allocations: 10.81 MB / 1.361 GB, free: 279.1 MB / 0.8108 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01115/2.529, allocations: 0.7164 MB / 1.362 GB, free: 279.1 MB / 0.8108 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001894/2.531, allocations: 0.5193 MB / 1.363 GB, free: 279.1 MB / 0.8108 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.002586/2.533, allocations: 0.8662 MB / 1.364 GB, free: 279 MB / 0.8108 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002959/2.536, allocations: 1.166 MB / 1.365 GB, free: 279 MB / 0.8108 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02019/2.556, allocations: 13.38 MB / 1.378 GB, free: 275 MB / 0.8108 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01251/2.569, allocations: 11.04 MB / 1.389 GB, free: 270.8 MB / 0.8108 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.776e-05/2.569, allocations: 2.094 kB / 1.389 GB, free: 270.8 MB / 0.8108 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005658/2.575, allocations: 2.769 MB / 1.391 GB, free: 269.5 MB / 0.8108 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002086/2.577, allocations: 159.4 kB / 1.391 GB, free: 269.4 MB / 0.8108 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006319/2.583, allocations: 461.1 kB / 1.392 GB, free: 269.3 MB / 0.8108 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007731/2.584, allocations: 466.5 kB / 1.392 GB, free: 269.2 MB / 0.8108 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02156/2.605, allocations: 14.31 MB / 1.406 GB, free: 263.7 MB / 0.8108 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.02022/2.626, allocations: 18.92 MB / 1.425 GB, free: 247.5 MB / 0.8108 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.005077/2.631, allocations: 5.517 MB / 1.43 GB, free: 242 MB / 0.8108 GB
Notification: Performance of sorting global known variables: time 0.0104/2.641, allocations: 8.912 MB / 1.439 GB, free: 233.1 MB / 0.8108 GB
Notification: Performance of Backend: time 3.81e-07/2.641, allocations: 2.219 kB / 1.439 GB, free: 233.1 MB / 0.8108 GB
Notification: Performance of simCode: created initialization part: time 0.02837/2.67, allocations: 19.77 MB / 1.458 GB, free: 213.7 MB / 0.8108 GB
Notification: Performance of SimCode: time 0.05553/2.725, allocations: 36.06 MB / 1.493 GB, free: 178.1 MB / 0.8108 GB
Notification: Performance of Templates: time 0.6333/3.358, allocations: 333.1 MB / 1.819 GB, free: 142.7 MB / 0.8108 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.sim & ./IBPSA_latest_IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.pipe 2>&1)