Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.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.002129/0.002129, allocations: 78.09 kB / 19.76 MB, free: 2.031 MB / 14.72 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.003194/0.003194, allocations: 156.1 kB / 23.01 MB, free: 4.945 MB / 14.72 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 1.527/1.527, allocations: 177.2 MB / 203.4 MB, free: 8.957 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.855/2.855, allocations: 377.9 MB / 0.6228 GB, free: 12.6 MB / 0.5919 GB
"
[Timeout remaining time 176]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.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.Geothermal.Aquifer.Examples.CoolingOffice,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|aquWel.TAquHot.50.",fileNamePrefix="Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice")
translateModel(Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|aquWel.TAquHot.50.",fileNamePrefix="Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice") [Timeout 300]
"Notification: Buildings requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002208/0.002208, allocations: 68.19 kB / 0.9819 GB, free: 12.23 MB / 0.9356 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.9843/0.9865, allocations: 176.1 MB / 1.154 GB, free: 33.35 MB / 1.076 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice): time 0.11/1.097, allocations: 100.4 MB / 1.252 GB, free: 13.96 MB / 1.123 GB
Notification: Performance of NFInst.instExpressions: time 0.06018/1.157, allocations: 32.38 MB / 1.284 GB, free: 7.859 MB / 1.139 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.008237/1.165, allocations: 191.3 kB / 1.284 GB, free: 7.766 MB / 1.139 GB
Notification: Performance of NFTyping.typeComponents: time 0.01267/1.178, allocations: 2.786 MB / 1.286 GB, free: 6.41 MB / 1.139 GB
Notification: Performance of NFTyping.typeBindings: time 0.02379/1.201, allocations: 5.882 MB / 1.292 GB, free: 2.328 MB / 1.139 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01269/1.214, allocations: 4.031 MB / 1.296 GB, free: 15.21 MB / 1.154 GB
Notification: Performance of NFFlatten.flatten: time 0.2341/1.448, allocations: 201.6 MB / 1.493 GB, free: 13.22 MB / 1.342 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1097/1.558, allocations: 51.55 MB / 1.543 GB, free: 9.434 MB / 1.389 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1363/1.694, allocations: 59.16 MB / 1.601 GB, free: 14.59 MB / 1.451 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1189/1.813, allocations: 54.73 MB / 1.655 GB, free: 7.664 MB / 1.498 GB
Notification: Performance of NFPackage.collectConstants: time 0.03251/1.846, allocations: 6.805 MB / 1.661 GB, free: 0.8594 MB / 1.498 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.05743/1.903, allocations: 9.375 MB / 1.67 GB, free: 7.48 MB / 1.514 GB
Notification: Performance of NFScalarize.scalarize: time 0.04677/1.95, allocations: 18.75 MB / 1.689 GB, free: 4.672 MB / 1.529 GB
Notification: Performance of NFVerifyModel.verify: time 0.09756/2.047, allocations: 29.84 MB / 1.718 GB, free: 6.715 MB / 1.561 GB
Notification: Performance of NFConvertDAE.convert: time 1.889/3.936, allocations: 106.7 MB / 1.822 GB, free: 262.2 MB / 1.561 GB
Notification: Performance of FrontEnd - DAE generated: time 9.207e-06/3.936, allocations: 4.406 kB / 1.822 GB, free: 262.2 MB / 1.561 GB
Notification: Performance of FrontEnd: time 3.016e-06/3.936, allocations: 0 / 1.822 GB, free: 262.2 MB / 1.561 GB
Notification: Performance of Transformations before backend: time 0.005936/3.942, allocations: 0 / 1.822 GB, free: 262.2 MB / 1.561 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 10353
 * Number of variables: 10353
Notification: Performance of Generate backend data structure: time 0.2995/4.242, allocations: 67.88 MB / 1.888 GB, free: 229.3 MB / 1.561 GB
Notification: Performance of prepare preOptimizeDAE: time 6.28e-05/4.242, allocations: 15.81 kB / 1.888 GB, free: 229.3 MB / 1.561 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06971/4.312, allocations: 8.338 MB / 1.896 GB, free: 225.1 MB / 1.561 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.181/4.493, allocations: 66.41 MB / 1.961 GB, free: 190.6 MB / 1.561 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.003964/4.497, allocations: 2.998 MB / 1.964 GB, free: 189.2 MB / 1.561 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.02832/4.525, allocations: 4.159 MB / 1.968 GB, free: 187.8 MB / 1.561 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.2338/4.759, allocations: 74.87 MB / 2.041 GB, free: 115.8 MB / 1.561 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.004202/4.763, allocations: 264.9 kB / 2.042 GB, free: 115.6 MB / 1.561 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.03281/4.796, allocations: 1.713 MB / 2.043 GB, free: 113.9 MB / 1.561 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002326/4.798, allocations: 1.815 MB / 2.045 GB, free: 112.1 MB / 1.561 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1519/4.95, allocations: 50.66 MB / 2.095 GB, free: 61.93 MB / 1.561 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.5845/5.534, allocations: 199 MB / 2.289 GB, free: 8.453 MB / 1.701 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.07264/5.607, allocations: 28.5 MB / 2.317 GB, free: 12.01 MB / 1.733 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.04846/5.655, allocations: 17.78 MB / 2.334 GB, free: 10.2 MB / 1.748 GB
Notification: Performance of preOpt evalFunc (simulation): time 1.396/7.051, allocations: 51.69 MB / 2.385 GB, free: 0.5865 GB / 1.779 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0008672/7.052, allocations: 400.7 kB / 2.385 GB, free: 0.5864 GB / 1.779 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.03664/7.089, allocations: 1.95 MB / 2.387 GB, free: 0.5864 GB / 1.779 GB
Notification: Performance of pre-optimization done (n=2331): time 0.0003201/7.089, allocations: 0 / 2.387 GB, free: 0.5864 GB / 1.779 GB
Notification: Performance of matching and sorting (n=2666): time 0.4248/7.514, allocations: 116.9 MB / 2.501 GB, free: 0.549 GB / 1.779 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003953/7.515, allocations: 320.2 kB / 2.501 GB, free: 0.5487 GB / 1.779 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1365/7.651, allocations: 45.04 MB / 2.545 GB, free: 0.5132 GB / 1.779 GB
Notification: Performance of collectPreVariables (initialization): time 0.01207/7.663, allocations: 0.5942 MB / 2.546 GB, free: 0.5126 GB / 1.779 GB
Notification: Performance of collectInitialEqns (initialization): time 0.04201/7.705, allocations: 24.65 MB / 2.57 GB, free: 0.4896 GB / 1.779 GB
Notification: Performance of collectInitialBindings (initialization): time 0.02524/7.73, allocations: 9.943 MB / 2.58 GB, free: 491.5 MB / 1.779 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.05784/7.788, allocations: 8.448 MB / 2.588 GB, free: 483 MB / 1.779 GB
Notification: Performance of setup shared object (initialization): time 7.57e-05/7.788, allocations: 305.1 kB / 2.588 GB, free: 482.7 MB / 1.779 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.05365/7.842, allocations: 20.9 MB / 2.609 GB, free: 461.8 MB / 1.779 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.06923/7.911, allocations: 29.85 MB / 2.638 GB, free: 428.7 MB / 1.779 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1093/8.02, allocations: 48.62 MB / 2.685 GB, free: 377 MB / 1.779 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0005425/8.021, allocations: 64 kB / 2.685 GB, free: 376.9 MB / 1.779 GB
Notification: Performance of matching and sorting (n=5384) (initialization): time 0.2023/8.223, allocations: 66.54 MB / 2.75 GB, free: 309.8 MB / 1.779 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002921/8.224, allocations: 104.1 kB / 2.75 GB, free: 309.7 MB / 1.779 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0004418/8.224, allocations: 223.9 kB / 2.751 GB, free: 309.5 MB / 1.779 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02531/8.249, allocations: 10.74 MB / 2.761 GB, free: 298.2 MB / 1.779 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.05223/8.302, allocations: 11.06 MB / 2.772 GB, free: 287.2 MB / 1.779 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.425/9.727, allocations: 288 MB / 3.053 GB, free: 497.3 MB / 1.795 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.06701/9.794, allocations: 2.644 MB / 3.056 GB, free: 497.3 MB / 1.795 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01669/9.81, allocations: 1.769 MB / 3.057 GB, free: 497.3 MB / 1.795 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1355/9.946, allocations: 39.71 MB / 3.096 GB, free: 497.1 MB / 1.795 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.07896/10.02, allocations: 29.76 MB / 3.125 GB, free: 487.9 MB / 1.795 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.1225/10.15, allocations: 48.45 MB / 3.173 GB, free: 465.4 MB / 1.795 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.001056/10.15, allocations: 61.62 kB / 3.173 GB, free: 465.4 MB / 1.795 GB
Notification: Performance of matching and sorting (n=5384) (initialization_lambda0): time 0.2352/10.38, allocations: 66.19 MB / 3.237 GB, free: 438.7 MB / 1.795 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0009892/10.38, allocations: 103.3 kB / 3.237 GB, free: 438.6 MB / 1.795 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001123/10.39, allocations: 223.8 kB / 3.238 GB, free: 438.3 MB / 1.795 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02794/10.41, allocations: 10.7 MB / 3.248 GB, free: 429.1 MB / 1.795 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.05354/10.47, allocations: 11.03 MB / 3.259 GB, free: 420.2 MB / 1.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.1827/10.65, allocations: 288.3 MB / 3.54 GB, free: 124.6 MB / 1.795 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.06647/10.72, allocations: 2.656 MB / 3.543 GB, free: 122 MB / 1.795 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01539/10.73, allocations: 1.742 MB / 3.545 GB, free: 120.3 MB / 1.795 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1015
 * 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 (4710):
 * Single equations (assignments): 4546
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 162
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 160 systems
   {(1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,14), (1,14)}
Notification: Performance of prepare postOptimizeDAE: time 0.02822/10.76, allocations: 2.466 MB / 3.547 GB, free: 117.9 MB / 1.795 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.03781/10.8, allocations: 4.277 MB / 3.551 GB, free: 116 MB / 1.795 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1393/10.94, allocations: 44 MB / 3.594 GB, free: 71.45 MB / 1.795 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0003054/10.94, allocations: 256 kB / 3.594 GB, free: 71.2 MB / 1.795 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.000731/10.94, allocations: 103.9 kB / 3.594 GB, free: 71.1 MB / 1.795 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1041/11.04, allocations: 37.31 MB / 3.631 GB, free: 33.08 MB / 1.795 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.317/11.36, allocations: 82.44 MB / 3.711 GB, free: 14.58 MB / 1.858 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0002594/11.36, allocations: 4 kB / 3.711 GB, free: 14.57 MB / 1.858 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.03629/11.4, allocations: 6.504 MB / 3.718 GB, free: 8.062 MB / 1.858 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.02757/11.42, allocations: 9.431 MB / 3.727 GB, free: 14.13 MB / 1.873 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.007924/11.43, allocations: 0.6949 MB / 3.728 GB, free: 13.44 MB / 1.873 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.547/12.98, allocations: 285.1 MB / 4.006 GB, free: 327.9 MB / 1.889 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.595e-06/12.98, allocations: 3.531 kB / 4.006 GB, free: 327.9 MB / 1.889 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1533/13.13, allocations: 63.01 MB / 4.068 GB, free: 305 MB / 1.889 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.04651/13.18, allocations: 9.56 MB / 4.077 GB, free: 302.5 MB / 1.889 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.03079/13.21, allocations: 0.5396 MB / 4.077 GB, free: 302.2 MB / 1.889 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.05173/13.26, allocations: 2.043 MB / 4.079 GB, free: 301.7 MB / 1.889 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.01302/13.27, allocations: 1.998 MB / 4.081 GB, free: 301.4 MB / 1.889 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.01385/13.29, allocations: 1.308 MB / 4.083 GB, free: 301.2 MB / 1.889 GB
Notification: Performance of sorting global known variables: time 0.1052/13.39, allocations: 31.04 MB / 4.113 GB, free: 291.1 MB / 1.889 GB
Notification: Performance of sort global known variables: time 1.1e-07/13.39, allocations: 3.5 kB / 4.113 GB, free: 291.1 MB / 1.889 GB
Notification: Performance of remove unused functions: time 0.2207/13.61, allocations: 25.68 MB / 4.138 GB, free: 273.9 MB / 1.889 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 166 (hea.vol.dynBal.U,aquWel.pumCol.vol.dynBal.U,aquWel.pumCol.motSpe.y,aquWel.pumHot.vol.dynBal.U,aquWel.pumHot.motSpe.y,aquWel.resAqu.mExc,aquWel.heaCapCol[1].T,aquWel.heaCapCol[2].T,aquWel.heaCapCol[3].T,aquWel.heaCapCol[4].T,aquWel.heaCapCol[5].T,aquWel.heaCapCol[6].T,aquWel.heaCapCol[7].T,aquWel.heaCapCol[8].T,aquWel.heaCapCol[9].T,aquWel.heaCapCol[10].T,aquWel.heaCapCol[11].T,aquWel.heaCapCol[12].T,aquWel.heaCapCol[13].T,aquWel.heaCapCol[14].T,aquWel.heaCapCol[15].T,aquWel.heaCapCol[16].T,aquWel.heaCapCol[17].T,aquWel.heaCapCol[18].T,aquWel.heaCapCol[19].T,aquWel.heaCapCol[20].T,aquWel.heaCapCol[21].T,aquWel.heaCapCol[22].T,aquWel.heaCapCol[23].T,aquWel.heaCapCol[24].T,aquWel.heaCapCol[25].T,aquWel.heaCapCol[26].T,aquWel.heaCapCol[27].T,aquWel.heaCapCol[28].T,aquWel.heaCapCol[29].T,aquWel.heaCapCol[30].T,aquWel.heaCapCol[31].T,aquWel.heaCapCol[32].T,aquWel.heaCapCol[33].T,aquWel.heaCapCol[34].T,aquWel.heaCapCol[35].T,aquWel.heaCapCol[36].T,aquWel.heaCapCol[37].T,aquWel.heaCapCol[38].T,aquWel.heaCapCol[39].T,aquWel.heaCapCol[40].T,aquWel.heaCapCol[41].T,aquWel.heaCapCol[42].T,aquWel.heaCapCol[43].T,aquWel.heaCapCol[44].T,aquWel.heaCapCol[45].T,aquWel.heaCapCol[46].T,aquWel.heaCapCol[47].T,aquWel.heaCapCol[48].T,aquWel.heaCapCol[49].T,aquWel.heaCapCol[50].T,aquWel.heaCapCol[51].T,aquWel.heaCapCol[52].T,aquWel.heaCapCol[53].T,aquWel.heaCapCol[54].T,aquWel.heaCapCol[55].T,aquWel.heaCapCol[56].T,aquWel.heaCapCol[57].T,aquWel.heaCapCol[58].T,aquWel.heaCapCol[59].T,aquWel.heaCapCol[60].T,aquWel.heaCapCol[61].T,aquWel.heaCapCol[62].T,aquWel.heaCapCol[63].T,aquWel.heaCapCol[64].T,aquWel.heaCapCol[65].T,aquWel.heaCapCol[66].T,aquWel.heaCapCol[67].T,aquWel.heaCapCol[68].T,aquWel.heaCapCol[69].T,aquWel.heaCapCol[70].T,aquWel.heaCapCol[71].T,aquWel.heaCapCol[72].T,aquWel.heaCapCol[73].T,aquWel.heaCapCol[74].T,aquWel.heaCapCol[75].T,aquWel.heaCapCol[76].T,aquWel.heaCapCol[77].T,aquWel.heaCapCol[78].T,aquWel.heaCapCol[79].T,aquWel.heaCapCol[80].T,aquWel.heaCapHot[1].T,aquWel.heaCapHot[2].T,aquWel.heaCapHot[3].T,aquWel.heaCapHot[4].T,aquWel.heaCapHot[5].T,aquWel.heaCapHot[6].T,aquWel.heaCapHot[7].T,aquWel.heaCapHot[8].T,aquWel.heaCapHot[9].T,aquWel.heaCapHot[10].T,aquWel.heaCapHot[11].T,aquWel.heaCapHot[12].T,aquWel.heaCapHot[13].T,aquWel.heaCapHot[14].T,aquWel.heaCapHot[15].T,aquWel.heaCapHot[16].T,aquWel.heaCapHot[17].T,aquWel.heaCapHot[18].T,aquWel.heaCapHot[19].T,aquWel.heaCapHot[20].T,aquWel.heaCapHot[21].T,aquWel.heaCapHot[22].T,aquWel.heaCapHot[23].T,aquWel.heaCapHot[24].T,aquWel.heaCapHot[25].T,aquWel.heaCapHot[26].T,aquWel.heaCapHot[27].T,aquWel.heaCapHot[28].T,aquWel.heaCapHot[29].T,aquWel.heaCapHot[30].T,aquWel.heaCapHot[31].T,aquWel.heaCapHot[32].T,aquWel.heaCapHot[33].T,aquWel.heaCapHot[34].T,aquWel.heaCapHot[35].T,aquWel.heaCapHot[36].T,aquWel.heaCapHot[37].T,aquWel.heaCapHot[38].T,aquWel.heaCapHot[39].T,aquWel.heaCapHot[40].T,aquWel.heaCapHot[41].T,aquWel.heaCapHot[42].T,aquWel.heaCapHot[43].T,aquWel.heaCapHot[44].T,aquWel.heaCapHot[45].T,aquWel.heaCapHot[46].T,aquWel.heaCapHot[47].T,aquWel.heaCapHot[48].T,aquWel.heaCapHot[49].T,aquWel.heaCapHot[50].T,aquWel.heaCapHot[51].T,aquWel.heaCapHot[52].T,aquWel.heaCapHot[53].T,aquWel.heaCapHot[54].T,aquWel.heaCapHot[55].T,aquWel.heaCapHot[56].T,aquWel.heaCapHot[57].T,aquWel.heaCapHot[58].T,aquWel.heaCapHot[59].T,aquWel.heaCapHot[60].T,aquWel.heaCapHot[61].T,aquWel.heaCapHot[62].T,aquWel.heaCapHot[63].T,aquWel.heaCapHot[64].T,aquWel.heaCapHot[65].T,aquWel.heaCapHot[66].T,aquWel.heaCapHot[67].T,aquWel.heaCapHot[68].T,aquWel.heaCapHot[69].T,aquWel.heaCapHot[70].T,aquWel.heaCapHot[71].T,aquWel.heaCapHot[72].T,aquWel.heaCapHot[73].T,aquWel.heaCapHot[74].T,aquWel.heaCapHot[75].T,aquWel.heaCapHot[76].T,aquWel.heaCapHot[77].T,aquWel.heaCapHot[78].T,aquWel.heaCapHot[79].T,aquWel.heaCapHot[80].T)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (2034):
 * Single equations (assignments): 1865
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 7
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 162
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 160 systems
   {(1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,14), (1,17)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01805/13.63, allocations: 1.877 MB / 4.14 GB, free: 272.4 MB / 1.889 GB
Notification: Performance of simCode: created initialization part: time 0.2377/13.87, allocations: 111.5 MB / 4.249 GB, free: 170 MB / 1.889 GB
Notification: Performance of simCode: created event and clocks part: time 7.047e-05/13.87, allocations: 38.67 kB / 4.249 GB, free: 170 MB / 1.889 GB
Notification: Performance of simCode: created simulation system equations: time 0.06829/13.94, allocations: 37.51 MB / 4.285 GB, free: 131 MB / 1.889 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.2009/14.14, allocations: 26.97 MB / 4.312 GB, free: 105 MB / 1.889 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3751/14.51, allocations: 125.7 MB / 4.434 GB, free: 11.91 MB / 1.92 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.1337/14.65, allocations: 34.37 MB / 4.468 GB, free: 9.473 MB / 1.951 GB
Notification: Performance of simCode: alias equations: time 2.367/17.01, allocations: 27.16 MB / 4.495 GB, free: 463.6 MB / 1.967 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02525/17.04, allocations: 3.382 MB / 4.498 GB, free: 463.6 MB / 1.967 GB
Notification: Performance of SimCode: time 2.375e-06/17.04, allocations: 4.828 kB / 4.498 GB, free: 463.6 MB / 1.967 GB
Notification: Performance of Templates: time 2.93/19.97, allocations: 1.057 GB / 5.555 GB, free: 0.4952 GB / 2.108 GB
"
[Timeout remaining time 280]
make -j1 -f Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe ; mkfifo Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe >> ../files/Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.sim & ./Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice  -abortSlowSimulation -alarm=400 -s ida -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe 2>&1) [Timeout 400]
Could not SIGINT process: 3697190.
Could not SIGINT process: 3697191.
Could not SIGINT process: 3697194.
Could not SIGINT process: 3695947.
[Calling os._exit(0), Time elapsed: 464.9074507410405]
Failed to read output from testmodel.py, exit status != 0:
19.98328551603481 19.994125276 16.054533139
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f0a2764efe0>