Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0009056/0.0009056, allocations: 80.81 kB / 21.55 MB, free: 2.941 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.00104/0.00104, allocations: 168.4 kB / 24.97 MB, free: 9.18 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.981/0.981, allocations: 177.1 MB / 205.4 MB, free: 5.488 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 2.003/2.003, allocations: 389.6 MB / 0.6362 GB, free: 12.27 MB / 0.6042 GB
"
[Timeout remaining time 177]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.Fluid.Storage.Validation.HeatExchangerLocation,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation")
translateModel(Buildings.Fluid.Storage.Validation.HeatExchangerLocation,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 2.244e-06/2.244e-06, allocations: 0 / 0.776 GB, free: 5.359 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.422e-05/2.646e-05, allocations: 2.312 kB / 0.776 GB, free: 5.355 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Storage.Validation.HeatExchangerLocation): time 0.02817/0.0282, allocations: 27.34 MB / 0.8027 GB, free: 9.965 MB / 0.7605 GB
Notification: Performance of NFInst.instExpressions: time 0.02201/0.05021, allocations: 11.72 MB / 0.8141 GB, free: 14.34 MB / 0.7761 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003337/0.05355, allocations: 203 kB / 0.8143 GB, free: 14.14 MB / 0.7761 GB
Notification: Performance of NFTyping.typeComponents: time 0.001553/0.0551, allocations: 1.009 MB / 0.8153 GB, free: 13.12 MB / 0.7761 GB
Notification: Performance of NFTyping.typeBindings: time 0.004497/0.0596, allocations: 3.283 MB / 0.8185 GB, free: 9.848 MB / 0.7761 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004671/0.06427, allocations: 3.153 MB / 0.8216 GB, free: 6.695 MB / 0.7761 GB
Notification: Performance of NFFlatten.flatten: time 0.03809/0.1024, allocations: 57.86 MB / 0.8781 GB, free: 12.66 MB / 0.8386 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02477/0.1271, allocations: 19.22 MB / 0.8968 GB, free: 9.57 MB / 0.8542 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04906/0.1762, allocations: 27 MB / 0.9232 GB, free: 14.78 MB / 0.8855 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03593/0.2121, allocations: 16.19 MB / 0.939 GB, free: 14.55 MB / 0.9011 GB
Notification: Performance of NFPackage.collectConstants: time 0.0117/0.2238, allocations: 2.664 MB / 0.9416 GB, free: 11.89 MB / 0.9011 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01636/0.2402, allocations: 3.709 MB / 0.9452 GB, free: 8.176 MB / 0.9011 GB
Notification: Performance of NFScalarize.scalarize: time 0.01068/0.2509, allocations: 6.67 MB / 0.9517 GB, free: 1.484 MB / 0.9011 GB
Notification: Performance of NFVerifyModel.verify: time 0.02156/0.2724, allocations: 9.018 MB / 0.9606 GB, free: 8.445 MB / 0.9167 GB
Notification: Performance of NFConvertDAE.convert: time 0.02856/0.301, allocations: 22 MB / 0.982 GB, free: 2.383 MB / 0.9323 GB
Notification: Performance of FrontEnd - DAE generated: time 6.402e-06/0.301, allocations: 3.938 kB / 0.982 GB, free: 2.379 MB / 0.9323 GB
Notification: Performance of FrontEnd: time 1.512e-06/0.301, allocations: 0 / 0.982 GB, free: 2.379 MB / 0.9323 GB
Notification: Performance of Transformations before backend: time 0.001025/0.302, allocations: 0 / 0.982 GB, free: 2.379 MB / 0.9323 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.03372/0.3357, allocations: 20.38 MB / 1.002 GB, free: 13.86 MB / 0.9636 GB
Notification: Performance of prepare preOptimizeDAE: time 4.494e-05/0.3358, allocations: 9.344 kB / 1.002 GB, free: 13.85 MB / 0.9636 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006895/0.3427, allocations: 3.093 MB / 1.005 GB, free: 10.75 MB / 0.9636 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01867/0.3613, allocations: 10.28 MB / 1.015 GB, free: 320 kB / 0.9636 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006931/0.362, allocations: 1.183 MB / 1.016 GB, free: 15.12 MB / 0.9792 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002639/0.3647, allocations: 1.632 MB / 1.018 GB, free: 13.5 MB / 0.9792 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02209/0.3868, allocations: 15.44 MB / 1.033 GB, free: 12.74 MB / 0.9948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003091/0.3871, allocations: 47.58 kB / 1.033 GB, free: 12.7 MB / 0.9948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001622/0.3887, allocations: 0.6562 MB / 1.034 GB, free: 12.04 MB / 0.9948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003246/0.389, allocations: 463.9 kB / 1.034 GB, free: 11.59 MB / 0.9948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01147/0.4005, allocations: 5.688 MB / 1.04 GB, free: 5.867 MB / 0.9948 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.5313/0.9318, allocations: 50.56 MB / 1.089 GB, free: 198 MB / 1.01 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006509/0.9383, allocations: 6.103 MB / 1.095 GB, free: 196.9 MB / 1.01 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003353/0.9416, allocations: 3.107 MB / 1.098 GB, free: 196.8 MB / 1.01 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.02313/0.9648, allocations: 11.35 MB / 1.109 GB, free: 196.4 MB / 1.01 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.846e-05/0.9649, allocations: 150.2 kB / 1.109 GB, free: 196.3 MB / 1.01 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.003159/0.968, allocations: 0.8664 MB / 1.11 GB, free: 196.3 MB / 1.01 GB
Notification: Performance of pre-optimization done (n=892): time 3.473e-05/0.9681, allocations: 0 / 1.11 GB, free: 196.3 MB / 1.01 GB
Notification: Performance of matching and sorting (n=892): time 0.0097/0.9778, allocations: 6.132 MB / 1.116 GB, free: 195.9 MB / 1.01 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.593e-05/0.9778, allocations: 142.8 kB / 1.116 GB, free: 195.8 MB / 1.01 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008682/0.9865, allocations: 9.859 MB / 1.126 GB, free: 195.2 MB / 1.01 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005982/0.9871, allocations: 213.5 kB / 1.126 GB, free: 195.1 MB / 1.01 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002531/0.9896, allocations: 6.373 MB / 1.132 GB, free: 192.3 MB / 1.01 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001686/0.9913, allocations: 3.231 MB / 1.135 GB, free: 190.2 MB / 1.01 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002278/0.9936, allocations: 2.351 MB / 1.138 GB, free: 190 MB / 1.01 GB
Notification: Performance of setup shared object (initialization): time 3.027e-05/0.9936, allocations: 311.5 kB / 1.138 GB, free: 189.7 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002224/0.9959, allocations: 1.718 MB / 1.14 GB, free: 189.5 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003125/0.999, allocations: 5.411 MB / 1.145 GB, free: 184 MB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006286/1.005, allocations: 8.126 MB / 1.153 GB, free: 175.2 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.48e-05/1.005, allocations: 36 kB / 1.153 GB, free: 175.2 MB / 1.01 GB
Notification: Performance of matching and sorting (n=1658) (initialization): time 0.009493/1.015, allocations: 7.667 MB / 1.16 GB, free: 168.7 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 5.137e-05/1.015, allocations: 60.03 kB / 1.16 GB, free: 168.7 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.975e-05/1.015, allocations: 116 kB / 1.16 GB, free: 168.6 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007335/1.016, allocations: 0.52 MB / 1.161 GB, free: 168.1 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005664/1.021, allocations: 3.022 MB / 1.164 GB, free: 165.4 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002654/1.024, allocations: 5.048 MB / 1.169 GB, free: 160.8 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006386/1.03, allocations: 455.8 kB / 1.169 GB, free: 160.6 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005961/1.031, allocations: 470.7 kB / 1.17 GB, free: 160.2 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.005581/1.037, allocations: 2.006 MB / 1.172 GB, free: 158.5 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003242/1.04, allocations: 5.412 MB / 1.177 GB, free: 151.6 MB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.006677/1.046, allocations: 8.082 MB / 1.185 GB, free: 142.6 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.468e-05/1.047, allocations: 32 kB / 1.185 GB, free: 142.6 MB / 1.01 GB
Notification: Performance of matching and sorting (n=1658) (initialization_lambda0): time 0.009747/1.056, allocations: 7.649 MB / 1.192 GB, free: 135.5 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 4.681e-05/1.056, allocations: 55.94 kB / 1.192 GB, free: 135.4 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.712e-05/1.056, allocations: 120 kB / 1.193 GB, free: 135.3 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005748/1.057, allocations: 497.7 kB / 1.193 GB, free: 134.8 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005685/1.063, allocations: 3.014 MB / 1.196 GB, free: 131.8 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003/1.066, allocations: 5.91 MB / 1.202 GB, free: 125.7 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007031/1.073, allocations: 447.5 kB / 1.202 GB, free: 125.3 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0006195/1.073, allocations: 471.9 kB / 1.203 GB, free: 124.8 MB / 1.01 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 537
 * 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 (1606):
 * Single equations (assignments): 1603
 * 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.00216/1.075, allocations: 0.9725 MB / 1.204 GB, free: 123.8 MB / 1.01 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002228/1.078, allocations: 1.042 MB / 1.205 GB, free: 122.8 MB / 1.01 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007016/1.085, allocations: 5.432 MB / 1.21 GB, free: 117.4 MB / 1.01 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003639/1.088, allocations: 3.34 MB / 1.213 GB, free: 113.9 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.497e-05/1.088, allocations: 3.938 kB / 1.213 GB, free: 113.9 MB / 1.01 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003983/1.092, allocations: 1.669 MB / 1.215 GB, free: 112.2 MB / 1.01 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001074/1.093, allocations: 192.4 kB / 1.215 GB, free: 112 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002878/1.096, allocations: 295.5 kB / 1.215 GB, free: 111.7 MB / 1.01 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006534/1.097, allocations: 0.541 MB / 1.216 GB, free: 111.2 MB / 1.01 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.006155/1.103, allocations: 4.46 MB / 1.22 GB, free: 107 MB / 1.01 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.006554/1.11, allocations: 6.074 MB / 1.226 GB, free: 101 MB / 1.01 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001633/1.111, allocations: 1.906 MB / 1.228 GB, free: 99.14 MB / 1.01 GB
Notification: Performance of sorting global known variables: time 0.004449/1.116, allocations: 4.234 MB / 1.232 GB, free: 95.47 MB / 1.01 GB
Notification: Performance of Backend: time 4.11e-07/1.116, allocations: 0 / 1.232 GB, free: 95.47 MB / 1.01 GB
Notification: Performance of simCode: created initialization part: time 0.01393/1.13, allocations: 9.73 MB / 1.242 GB, free: 85.99 MB / 1.01 GB
Notification: Performance of SimCode: time 0.06293/1.193, allocations: 35.71 MB / 1.276 GB, free: 50.47 MB / 1.01 GB
Notification: Performance of Templates: time 0.7743/1.967, allocations: 369.1 MB / 1.637 GB, free: 287.6 MB / 1.182 GB
"
[Timeout remaining time 298]
make -j1 -f Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.pipe ; mkfifo Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.pipe ; head -c 1048576 < Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.pipe >> ../files/Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.sim & ./Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Fluid.Storage.Validation.HeatExchangerLocation.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 11.969706599600613]