Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.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/Buildings 12.0.0-master/package.mo", uses=false)
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.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(Buildings.Fluid.Storage.Validation.HeatExchangerLocation,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|tan_aTop.vol.1..T|tan_bTop.vol.1..T|tan_aTop.vol.9..T|tan_aTop.vol.10..T|tan_aTop.vol.11..T|tan_aTop.vol.12..T|tan_bTop.vol.9..T|tan_bTop.vol.10..T|tan_bTop.vol.11..T|tan_bTop.vol.12..T",fileNamePrefix="Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation")
translateModel(Buildings.Fluid.Storage.Validation.HeatExchangerLocation,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|tan_aTop.vol.1..T|tan_bTop.vol.1..T|tan_aTop.vol.9..T|tan_aTop.vol.10..T|tan_aTop.vol.11..T|tan_aTop.vol.12..T|tan_bTop.vol.9..T|tan_bTop.vol.10..T|tan_bTop.vol.11..T|tan_bTop.vol.12..T",fileNamePrefix="Buildings_latest_Buildings.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.001248/0.001248, allocations: 109.3 kB / 16.41 MB, free: 6.445 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.00106/0.00106, allocations: 189.5 kB / 17.35 MB, free: 5.707 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.317/1.317, allocations: 222.9 MB / 241 MB, free: 15.1 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.595/2.595, allocations: 472.7 MB / 0.746 GB, free: 488 kB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001294/0.001294, allocations: 63.89 kB / 1.07 GB, free: 9.586 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7331/0.7345, allocations: 159.9 MB / 1.226 GB, free: 13.74 MB / 0.9512 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Storage.Validation.HeatExchangerLocation): time 0.09577/0.8303, allocations: 109.7 MB / 1.333 GB, free: 15.71 MB / 1.061 GB
Notification: Performance of NFInst.instExpressions: time 0.0389/0.8692, allocations: 31.5 MB / 1.364 GB, free: 128 kB / 1.076 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005176/0.8744, allocations: 151.2 kB / 1.364 GB, free: 15.97 MB / 1.092 GB
Notification: Performance of NFTyping.typeComponents: time 0.004825/0.8793, allocations: 1.801 MB / 1.366 GB, free: 14.16 MB / 1.092 GB
Notification: Performance of NFTyping.typeBindings: time 0.01141/0.8907, allocations: 4.617 MB / 1.371 GB, free: 9.527 MB / 1.092 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008201/0.8989, allocations: 3.567 MB / 1.374 GB, free: 5.973 MB / 1.092 GB
Notification: Performance of NFFlatten.flatten: time 0.04949/0.9484, allocations: 56.45 MB / 1.429 GB, free: 13.38 MB / 1.154 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03675/0.9852, allocations: 28.03 MB / 1.457 GB, free: 1.195 MB / 1.17 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03205/1.017, allocations: 19.19 MB / 1.475 GB, free: 14.05 MB / 1.201 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02558/1.043, allocations: 16.69 MB / 1.492 GB, free: 13.29 MB / 1.217 GB
Notification: Performance of NFPackage.collectConstants: time 0.007806/1.051, allocations: 2.766 MB / 1.494 GB, free: 10.53 MB / 1.217 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01795/1.069, allocations: 4.977 MB / 1.499 GB, free: 5.547 MB / 1.217 GB
Notification: Performance of NFScalarize.scalarize: time 0.01079/1.08, allocations: 6.436 MB / 1.505 GB, free: 15.09 MB / 1.232 GB
Notification: Performance of NFVerifyModel.verify: time 0.02708/1.107, allocations: 12.91 MB / 1.518 GB, free: 2.133 MB / 1.232 GB
Notification: Performance of NFConvertDAE.convert: time 0.04667/1.153, allocations: 39.57 MB / 1.557 GB, free: 10.44 MB / 1.279 GB
Notification: Performance of FrontEnd - DAE generated: time 6.572e-06/1.153, allocations: 0 / 1.557 GB, free: 10.44 MB / 1.279 GB
Notification: Performance of FrontEnd: time 1.924e-06/1.153, allocations: 3.938 kB / 1.557 GB, free: 10.44 MB / 1.279 GB
Notification: Performance of Transformations before backend: time 0.001144/1.155, allocations: 0 / 1.557 GB, free: 10.44 MB / 1.279 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 1.29/2.445, allocations: 23.44 MB / 1.58 GB, free: 295.1 MB / 1.279 GB
Notification: Performance of prepare preOptimizeDAE: time 6.012e-05/2.445, allocations: 10.06 kB / 1.58 GB, free: 295.1 MB / 1.279 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01545/2.46, allocations: 2.396 MB / 1.582 GB, free: 293.9 MB / 1.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04184/2.502, allocations: 19.38 MB / 1.601 GB, free: 284.5 MB / 1.279 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00124/2.503, allocations: 1.177 MB / 1.602 GB, free: 283.9 MB / 1.279 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.006491/2.51, allocations: 1.589 MB / 1.604 GB, free: 282.3 MB / 1.279 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05797/2.568, allocations: 24.13 MB / 1.627 GB, free: 257.6 MB / 1.279 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0009597/2.569, allocations: 63.52 kB / 1.627 GB, free: 257.6 MB / 1.279 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00562/2.575, allocations: 0.6527 MB / 1.628 GB, free: 256.9 MB / 1.279 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004068/2.575, allocations: 463.8 kB / 1.628 GB, free: 256.5 MB / 1.279 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04285/2.618, allocations: 21.22 MB / 1.649 GB, free: 235.2 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 0.1377/2.756, allocations: 99.59 MB / 1.746 GB, free: 131.4 MB / 1.279 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02624/2.782, allocations: 14.85 MB / 1.761 GB, free: 116.7 MB / 1.279 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01756/2.799, allocations: 9.425 MB / 1.77 GB, free: 107.2 MB / 1.279 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.06944/2.869, allocations: 28.22 MB / 1.798 GB, free: 78.17 MB / 1.279 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001232/2.869, allocations: 154.6 kB / 1.798 GB, free: 78.01 MB / 1.279 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.007427/2.876, allocations: 0.9555 MB / 1.799 GB, free: 77.05 MB / 1.279 GB
Notification: Performance of pre-optimization done (n=893): time 2.085e-05/2.877, allocations: 0 / 1.799 GB, free: 77.05 MB / 1.279 GB
Notification: Performance of matching and sorting (n=893): time 0.03856/2.915, allocations: 19.59 MB / 1.818 GB, free: 57.37 MB / 1.279 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.495e-05/2.915, allocations: 142.4 kB / 1.818 GB, free: 57.21 MB / 1.279 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02242/2.938, allocations: 14.68 MB / 1.832 GB, free: 42.59 MB / 1.279 GB
Notification: Performance of collectPreVariables (initialization): time 0.002366/2.94, allocations: 213.7 kB / 1.832 GB, free: 42.37 MB / 1.279 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005725/2.946, allocations: 8.433 MB / 1.841 GB, free: 33.89 MB / 1.279 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003597/2.949, allocations: 3.265 MB / 1.844 GB, free: 30.6 MB / 1.279 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003565/2.953, allocations: 2.569 MB / 1.846 GB, free: 28.02 MB / 1.279 GB
Notification: Performance of setup shared object (initialization): time 3.586e-05/2.953, allocations: 309.1 kB / 1.847 GB, free: 27.71 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008394/2.961, allocations: 6.83 MB / 1.853 GB, free: 20.86 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01088/2.972, allocations: 10.81 MB / 1.864 GB, free: 8.285 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02458/2.997, allocations: 18.3 MB / 1.882 GB, free: 4.184 MB / 1.295 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.993e-05/2.997, allocations: 36 kB / 1.882 GB, free: 4.148 MB / 1.295 GB
Notification: Performance of matching and sorting (n=1659) (initialization): time 0.03769/3.035, allocations: 19.98 MB / 1.901 GB, free: 84 kB / 1.311 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001193/3.035, allocations: 60 kB / 1.901 GB, free: 24 kB / 1.311 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002056/3.035, allocations: 120 kB / 1.901 GB, free: 15.9 MB / 1.326 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00188/3.037, allocations: 0.8057 MB / 1.902 GB, free: 15.1 MB / 1.326 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01275/3.05, allocations: 2.98 MB / 1.905 GB, free: 12.11 MB / 1.326 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00937/3.059, allocations: 8.405 MB / 1.913 GB, free: 3.406 MB / 1.326 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01339/3.072, allocations: 0.7021 MB / 1.914 GB, free: 2.703 MB / 1.326 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002963/3.075, allocations: 0.5975 MB / 1.915 GB, free: 2.105 MB / 1.326 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02814/3.104, allocations: 13.09 MB / 1.927 GB, free: 5 MB / 1.342 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01627/3.12, allocations: 10.8 MB / 1.938 GB, free: 8.434 MB / 1.358 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02862/3.149, allocations: 18.29 MB / 1.956 GB, free: 4.34 MB / 1.373 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001507/3.149, allocations: 36 kB / 1.956 GB, free: 4.305 MB / 1.373 GB
Notification: Performance of matching and sorting (n=1659) (initialization_lambda0): time 0.04405/3.193, allocations: 19.94 MB / 1.975 GB, free: 268 kB / 1.389 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001089/3.193, allocations: 56 kB / 1.975 GB, free: 212 kB / 1.389 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001853/3.193, allocations: 124 kB / 1.976 GB, free: 88 kB / 1.389 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001643/3.195, allocations: 0.7834 MB / 1.976 GB, free: 15.29 MB / 1.404 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01257/3.207, allocations: 2.984 MB / 1.979 GB, free: 12.3 MB / 1.404 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01033/3.218, allocations: 9.595 MB / 1.989 GB, free: 2.301 MB / 1.404 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01285/3.231, allocations: 0.6827 MB / 1.989 GB, free: 1.617 MB / 1.404 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002526/3.233, allocations: 0.5936 MB / 1.99 GB, free: 1.023 MB / 1.404 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.004318/3.237, allocations: 0.9919 MB / 1.991 GB, free: 20 kB / 1.404 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005273/3.243, allocations: 1.44 MB / 1.992 GB, free: 14.57 MB / 1.42 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.031/3.274, allocations: 14.68 MB / 2.007 GB, free: 15.86 MB / 1.436 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01956/3.293, allocations: 12.22 MB / 2.018 GB, free: 3.531 MB / 1.436 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.992e-05/3.293, allocations: 4 kB / 2.018 GB, free: 3.527 MB / 1.436 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008682/3.302, allocations: 3.198 MB / 2.022 GB, free: 308 kB / 1.436 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003581/3.306, allocations: 192 kB / 2.022 GB, free: 116 kB / 1.436 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008422/3.314, allocations: 495.2 kB / 2.022 GB, free: 15.63 MB / 1.451 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001085/3.315, allocations: 0.5296 MB / 2.023 GB, free: 15.1 MB / 1.451 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02488/3.34, allocations: 14.26 MB / 2.037 GB, free: 0.7969 MB / 1.451 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.03158/3.372, allocations: 22.24 MB / 2.058 GB, free: 10.48 MB / 1.483 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.008003/3.38, allocations: 6.33 MB / 2.065 GB, free: 4.137 MB / 1.483 GB
Notification: Performance of sorting global known variables: time 0.01748/3.397, allocations: 10.2 MB / 2.075 GB, free: 9.988 MB / 1.498 GB
Notification: Performance of Backend: time 1.713e-06/3.397, allocations: 7.938 kB / 2.075 GB, free: 9.98 MB / 1.498 GB
Notification: Performance of simCode: created initialization part: time 0.04258/3.44, allocations: 21.35 MB / 2.095 GB, free: 4.613 MB / 1.514 GB
Notification: Performance of SimCode: time 0.08196/3.522, allocations: 42.11 MB / 2.137 GB, free: 10.68 MB / 1.561 GB
Notification: Performance of Templates: time 1.61/5.132, allocations: 370.9 MB / 2.499 GB, free: 254.2 MB / 1.576 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.makefile
(rm -f Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.pipe >> ../files/Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.sim & ./Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Storage_Validation_HeatExchangerLocation.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches