Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation.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.HeatExchangerLocation,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation")
translateModel(IDEAS.Fluid.Storage.Validation.HeatExchangerLocation,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001085/0.001085, allocations: 110.1 kB / 16.42 MB, free: 6.453 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.001054/0.001054, allocations: 187.9 kB / 17.35 MB, free: 5.715 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.291/1.291, allocations: 222.9 MB / 241 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.7814/0.7814, allocations: 132.2 MB / 423.4 MB, free: 6.539 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001206/0.001206, allocations: 62.19 kB / 0.582 GB, free: 23.91 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.139/0.1403, allocations: 80.21 MB / 0.6603 GB, free: 10.25 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Storage.Validation.HeatExchangerLocation): time 0.4221/0.5624, allocations: 109.6 MB / 0.7673 GB, free: 3.676 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.03441/0.5969, allocations: 31.46 MB / 0.7981 GB, free: 1.738 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004763/0.6017, allocations: 152.5 kB / 0.7982 GB, free: 1.738 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.003702/0.6054, allocations: 1.801 MB / 0.8 GB, free: 1.301 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.01089/0.6163, allocations: 4.615 MB / 0.8045 GB, free: 15.19 MB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009012/0.6253, allocations: 3.557 MB / 0.808 GB, free: 13.45 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.04698/0.6723, allocations: 56.43 MB / 0.8631 GB, free: 2.562 MB / 0.6231 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03178/0.7041, allocations: 28.11 MB / 0.8905 GB, free: 6.629 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03339/0.7376, allocations: 19.25 MB / 0.9093 GB, free: 4.293 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02567/0.7633, allocations: 16.73 MB / 0.9257 GB, free: 4.617 MB / 0.6856 GB
Notification: Performance of NFPackage.collectConstants: time 0.007271/0.7706, allocations: 2.77 MB / 0.9284 GB, free: 1.848 MB / 0.6856 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01849/0.7891, allocations: 4.982 MB / 0.9332 GB, free: 12.98 MB / 0.7012 GB
Notification: Performance of NFScalarize.scalarize: time 0.01092/0.8, allocations: 6.421 MB / 0.9395 GB, free: 6.648 MB / 0.7012 GB
Notification: Performance of NFVerifyModel.verify: time 0.02417/0.8242, allocations: 12.92 MB / 0.9521 GB, free: 9.801 MB / 0.7169 GB
Notification: Performance of NFConvertDAE.convert: time 0.04455/0.8688, allocations: 39.51 MB / 0.9907 GB, free: 3.02 MB / 0.7481 GB
Notification: Performance of FrontEnd - DAE generated: time 9.959e-06/0.8688, allocations: 0 / 0.9907 GB, free: 3.02 MB / 0.7481 GB
Notification: Performance of FrontEnd: time 2.454e-06/0.8689, allocations: 4 kB / 0.9907 GB, free: 3.016 MB / 0.7481 GB
Notification: Performance of Transformations before backend: time 0.001806/0.8707, allocations: 0 / 0.9907 GB, free: 3.016 MB / 0.7481 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4015
 * Number of variables: 4015
Notification: Performance of Generate backend data structure: time 0.06158/0.9323, allocations: 22.91 MB / 1.013 GB, free: 12.13 MB / 0.7794 GB
Notification: Performance of prepare preOptimizeDAE: time 4.913e-05/0.9323, allocations: 8.031 kB / 1.013 GB, free: 12.12 MB / 0.7794 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01162/0.944, allocations: 2.311 MB / 1.015 GB, free: 9.785 MB / 0.7794 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04104/0.985, allocations: 19.26 MB / 1.034 GB, free: 6.777 MB / 0.795 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00116/0.9862, allocations: 1.181 MB / 1.035 GB, free: 5.602 MB / 0.795 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005742/0.992, allocations: 1.588 MB / 1.037 GB, free: 4.02 MB / 0.795 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.6396/1.632, allocations: 24.12 MB / 1.06 GB, free: 264.4 MB / 0.8107 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005025/1.632, allocations: 53.98 kB / 1.06 GB, free: 264.4 MB / 0.8107 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002617/1.635, allocations: 0.6528 MB / 1.061 GB, free: 264.1 MB / 0.8107 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004224/1.635, allocations: 468.2 kB / 1.062 GB, free: 264.1 MB / 0.8107 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04047/1.676, allocations: 21.23 MB / 1.082 GB, free: 256.7 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 removeSimpleEquations (simulation): time 0.1246/1.8, allocations: 99.39 MB / 1.179 GB, free: 172.8 MB / 0.8107 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01921/1.819, allocations: 14.86 MB / 1.194 GB, free: 158.1 MB / 0.8107 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01157/1.831, allocations: 9.423 MB / 1.203 GB, free: 148.7 MB / 0.8107 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.04708/1.878, allocations: 28.19 MB / 1.231 GB, free: 119.8 MB / 0.8107 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.882e-05/1.878, allocations: 146.6 kB / 1.231 GB, free: 119.6 MB / 0.8107 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.00474/1.883, allocations: 0.9238 MB / 1.232 GB, free: 118.7 MB / 0.8107 GB
Notification: Performance of pre-optimization done (n=893): time 2.052e-05/1.883, allocations: 4 kB / 1.232 GB, free: 118.7 MB / 0.8107 GB
Notification: Performance of matching and sorting (n=893): time 0.02959/1.913, allocations: 19.53 MB / 1.251 GB, free: 99.07 MB / 0.8107 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.34e-05/1.913, allocations: 142.4 kB / 1.251 GB, free: 98.91 MB / 0.8107 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02032/1.933, allocations: 14.67 MB / 1.265 GB, free: 84.29 MB / 0.8107 GB
Notification: Performance of collectPreVariables (initialization): time 0.00208/1.935, allocations: 217.7 kB / 1.265 GB, free: 84.07 MB / 0.8107 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005314/1.941, allocations: 8.227 MB / 1.273 GB, free: 75.83 MB / 0.8107 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003361/1.944, allocations: 3.108 MB / 1.276 GB, free: 72.75 MB / 0.8107 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003375/1.947, allocations: 2.56 MB / 1.279 GB, free: 70.17 MB / 0.8107 GB
Notification: Performance of setup shared object (initialization): time 3.539e-05/1.947, allocations: 309.1 kB / 1.279 GB, free: 69.87 MB / 0.8107 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008489/1.956, allocations: 6.826 MB / 1.286 GB, free: 63.02 MB / 0.8107 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01182/1.968, allocations: 10.81 MB / 1.296 GB, free: 50.45 MB / 0.8107 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02335/1.991, allocations: 18.3 MB / 1.314 GB, free: 30.35 MB / 0.8107 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001169/1.991, allocations: 36 kB / 1.314 GB, free: 30.31 MB / 0.8107 GB
Notification: Performance of matching and sorting (n=1659) (initialization): time 0.03884/2.03, allocations: 19.91 MB / 1.334 GB, free: 10.3 MB / 0.8107 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001174/2.03, allocations: 57.25 kB / 1.334 GB, free: 10.25 MB / 0.8107 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001529/2.03, allocations: 127.9 kB / 1.334 GB, free: 10.12 MB / 0.8107 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00169/2.032, allocations: 0.8027 MB / 1.335 GB, free: 9.309 MB / 0.8107 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01212/2.044, allocations: 2.984 MB / 1.338 GB, free: 6.32 MB / 0.8107 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008291/2.053, allocations: 8.384 MB / 1.346 GB, free: 13.65 MB / 0.8263 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01302/2.066, allocations: 0.7017 MB / 1.347 GB, free: 12.95 MB / 0.8263 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002658/2.068, allocations: 0.5936 MB / 1.347 GB, free: 12.35 MB / 0.8263 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02378/2.092, allocations: 13.09 MB / 1.36 GB, free: 15.25 MB / 0.8419 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01572/2.108, allocations: 10.8 MB / 1.37 GB, free: 2.68 MB / 0.8419 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.6275/2.735, allocations: 18.29 MB / 1.388 GB, free: 267.2 MB / 0.842 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001143/2.736, allocations: 34.09 kB / 1.388 GB, free: 267.2 MB / 0.842 GB
Notification: Performance of matching and sorting (n=1659) (initialization_lambda0): time 0.03181/2.767, allocations: 19.87 MB / 1.408 GB, free: 260.3 MB / 0.842 GB
Notification: Performance of prepare postOptimizeDAE: time 7.135e-05/2.767, allocations: 57.75 kB / 1.408 GB, free: 260.3 MB / 0.842 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001358/2.768, allocations: 124.1 kB / 1.408 GB, free: 260.3 MB / 0.842 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001372/2.769, allocations: 0.7794 MB / 1.409 GB, free: 260.1 MB / 0.842 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01018/2.779, allocations: 2.988 MB / 1.412 GB, free: 259.8 MB / 0.842 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008069/2.787, allocations: 9.576 MB / 1.421 GB, free: 253.2 MB / 0.842 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01326/2.801, allocations: 0.6836 MB / 1.422 GB, free: 253 MB / 0.842 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002223/2.803, allocations: 0.5947 MB / 1.422 GB, free: 252.9 MB / 0.842 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 561
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1607):
 * Single equations (assignments): 1604
 * Array equations: 0
 * Algorithm blocks: 0
 * 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,24,100.0%), (1,24,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.002869/2.806, allocations: 0.9893 MB / 1.423 GB, free: 252.1 MB / 0.842 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003728/2.809, allocations: 1.369 MB / 1.424 GB, free: 252.1 MB / 0.842 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01964/2.829, allocations: 14.68 MB / 1.439 GB, free: 246.5 MB / 0.842 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01347/2.842, allocations: 12.21 MB / 1.451 GB, free: 238.6 MB / 0.842 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.831e-05/2.843, allocations: 3.938 kB / 1.451 GB, free: 238.6 MB / 0.842 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006725/2.849, allocations: 3.135 MB / 1.454 GB, free: 235.8 MB / 0.842 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002706/2.852, allocations: 191.2 kB / 1.454 GB, free: 235.6 MB / 0.842 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00753/2.86, allocations: 493 kB / 1.454 GB, free: 235.3 MB / 0.842 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008812/2.86, allocations: 0.5366 MB / 1.455 GB, free: 235 MB / 0.842 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02011/2.881, allocations: 14.26 MB / 1.469 GB, free: 221.2 MB / 0.842 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.02383/2.904, allocations: 22.17 MB / 1.491 GB, free: 199 MB / 0.842 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.006204/2.911, allocations: 6.326 MB / 1.497 GB, free: 192.6 MB / 0.842 GB
Notification: Performance of sorting global known variables: time 0.01546/2.926, allocations: 10.2 MB / 1.507 GB, free: 182.5 MB / 0.842 GB
Notification: Performance of Backend: time 6.41e-07/2.926, allocations: 0 / 1.507 GB, free: 182.5 MB / 0.842 GB
Notification: Performance of simCode: created initialization part: time 0.03848/2.965, allocations: 21.32 MB / 1.528 GB, free: 161.4 MB / 0.842 GB
Notification: Performance of SimCode: time 0.07263/3.037, allocations: 41.56 MB / 1.568 GB, free: 120.1 MB / 0.842 GB
Notification: Performance of Templates: time 0.7506/3.788, allocations: 370.8 MB / 1.93 GB, free: 80.89 MB / 0.8577 GB
make -j1 -f IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation.makefile
(rm -f IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation.pipe ; mkfifo IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation.pipe >> ../files/IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation.sim & ./IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Fluid.Storage.Validation.HeatExchangerLocation.pipe 2>&1)