Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.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.001474/0.001474, allocations: 80.73 kB / 19.43 MB, free: 360 kB / 13.93 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.00158/0.00158, allocations: 157.7 kB / 22.75 MB, free: 1.684 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 1.551/1.551, allocations: 177.1 MB / 203.1 MB, free: 5.609 MB / 186.7 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-535:34:writable] Warning: Lexer treating \\ as \\\\, since \\e is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-535:42:writable] Warning: Lexer treating \\ as \\\\, since \\< is not a valid Modelica escape sequence.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo): time 1.239/1.239, allocations: 154.8 MB / 414.4 MB, free: 468 kB / 378.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Utilities/Cryptographics/BaseClasses/sha.mo:2:1-19:8:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Utilities/File/sha2.mo:2:1-9:9:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 178]
Using package IDEAS with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/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(IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice")
translateModel(IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.314e-06/2.314e-06, allocations: 0 / 0.5198 GB, free: 2.293 MB / 490.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 3e-05/3.231e-05, allocations: 4.203 kB / 0.5199 GB, free: 2.289 MB / 490.7 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice): time 0.1464/0.1464, allocations: 99.53 MB / 0.6171 GB, free: 14.63 MB / 0.5886 GB
Notification: Performance of NFInst.instExpressions: time 0.06461/0.211, allocations: 32.6 MB / 0.6489 GB, free: 13.95 MB / 0.6198 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007205/0.2182, allocations: 190.5 kB / 0.6491 GB, free: 13.77 MB / 0.6198 GB
Notification: Performance of NFTyping.typeComponents: time 0.01038/0.2286, allocations: 2.809 MB / 0.6518 GB, free: 10.94 MB / 0.6198 GB
Notification: Performance of NFTyping.typeBindings: time 0.01966/0.2482, allocations: 6.059 MB / 0.6577 GB, free: 4.852 MB / 0.6198 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01246/0.2607, allocations: 4.108 MB / 0.6617 GB, free: 0.7344 MB / 0.6198 GB
Notification: Performance of NFFlatten.flatten: time 0.5357/0.7964, allocations: 206.8 MB / 0.8637 GB, free: 12.34 MB / 0.6823 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1399/0.9364, allocations: 54.04 MB / 0.9165 GB, free: 8.297 MB / 0.7292 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.9693/1.906, allocations: 83.86 MB / 0.9984 GB, free: 69.41 MB / 0.7605 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1007/2.006, allocations: 50.01 MB / 1.047 GB, free: 69.39 MB / 0.7605 GB
Notification: Performance of NFPackage.collectConstants: time 0.02867/2.035, allocations: 6.807 MB / 1.054 GB, free: 69.39 MB / 0.7605 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.06423/2.099, allocations: 9.485 MB / 1.063 GB, free: 69.39 MB / 0.7605 GB
Notification: Performance of NFScalarize.scalarize: time 0.04403/2.143, allocations: 19.31 MB / 1.082 GB, free: 69.39 MB / 0.7605 GB
Notification: Performance of NFVerifyModel.verify: time 0.08959/2.233, allocations: 25.78 MB / 1.107 GB, free: 68.84 MB / 0.7605 GB
Notification: Performance of NFConvertDAE.convert: time 0.1612/2.394, allocations: 107.7 MB / 1.212 GB, free: 7.047 MB / 0.7918 GB
Notification: Performance of FrontEnd - DAE generated: time 6.532e-06/2.394, allocations: 0 / 1.212 GB, free: 7.047 MB / 0.7918 GB
Notification: Performance of FrontEnd: time 1.734e-06/2.394, allocations: 0 / 1.212 GB, free: 7.047 MB / 0.7918 GB
Notification: Performance of Transformations before backend: time 0.004403/2.398, allocations: 0.9688 kB / 1.212 GB, free: 7.047 MB / 0.7918 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.9128/3.311, allocations: 67.3 MB / 1.278 GB, free: 281.4 MB / 0.8388 GB
Notification: Performance of prepare preOptimizeDAE: time 4.761e-05/3.311, allocations: 11.47 kB / 1.278 GB, free: 281.4 MB / 0.8388 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06996/3.381, allocations: 12.44 MB / 1.29 GB, free: 276.2 MB / 0.8388 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1758/3.557, allocations: 70.53 MB / 1.359 GB, free: 233.9 MB / 0.8388 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.004825/3.562, allocations: 2.997 MB / 1.362 GB, free: 230.9 MB / 0.8388 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.02326/3.585, allocations: 4.378 MB / 1.366 GB, free: 226.5 MB / 0.8388 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1931/3.778, allocations: 74.88 MB / 1.439 GB, free: 146.6 MB / 0.8388 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.004212/3.782, allocations: 266.3 kB / 1.44 GB, free: 146.3 MB / 0.8388 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.01944/3.802, allocations: 1.714 MB / 1.441 GB, free: 144.6 MB / 0.8388 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001626/3.804, allocations: 1.821 MB / 1.443 GB, free: 142.8 MB / 0.8388 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1342/3.938, allocations: 50.7 MB / 1.493 GB, free: 92.11 MB / 0.8388 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.8735/4.811, allocations: 200.8 MB / 1.689 GB, free: 138.4 MB / 0.8388 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.05267/4.864, allocations: 28.55 MB / 1.717 GB, free: 126.9 MB / 0.8388 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0351/4.899, allocations: 17.84 MB / 1.734 GB, free: 120.8 MB / 0.8388 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.174/5.073, allocations: 51.96 MB / 1.785 GB, free: 95.37 MB / 0.8388 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0004879/5.073, allocations: 394 kB / 1.785 GB, free: 95.11 MB / 0.8388 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0261/5.1, allocations: 1.957 MB / 1.787 GB, free: 94.73 MB / 0.8388 GB
Notification: Performance of pre-optimization done (n=2331): time 0.0001909/5.1, allocations: 0.7656 kB / 1.787 GB, free: 94.73 MB / 0.8388 GB
Notification: Performance of matching and sorting (n=2666): time 0.7935/5.893, allocations: 119.5 MB / 1.904 GB, free: 225.8 MB / 0.8388 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001902/5.893, allocations: 324.1 kB / 1.904 GB, free: 225.7 MB / 0.8388 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1104/6.004, allocations: 45.04 MB / 1.948 GB, free: 213 MB / 0.8388 GB
Notification: Performance of collectPreVariables (initialization): time 0.00878/6.013, allocations: 0.5931 MB / 1.949 GB, free: 212.5 MB / 0.8388 GB
Notification: Performance of collectInitialEqns (initialization): time 0.03188/6.045, allocations: 24.6 MB / 1.973 GB, free: 200.1 MB / 0.8388 GB
Notification: Performance of collectInitialBindings (initialization): time 0.02387/6.068, allocations: 9.823 MB / 1.982 GB, free: 193.2 MB / 0.8388 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.05063/6.119, allocations: 8.366 MB / 1.99 GB, free: 189.4 MB / 0.8388 GB
Notification: Performance of setup shared object (initialization): time 7.278e-05/6.119, allocations: 301.1 kB / 1.991 GB, free: 189.1 MB / 0.8388 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.07211/6.191, allocations: 21.02 MB / 2.011 GB, free: 181.7 MB / 0.8388 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.09314/6.284, allocations: 29.97 MB / 2.041 GB, free: 164.4 MB / 0.8388 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1232/6.408, allocations: 48.85 MB / 2.088 GB, free: 129.2 MB / 0.8388 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0005539/6.408, allocations: 66.53 kB / 2.088 GB, free: 129.2 MB / 0.8388 GB
Notification: Performance of matching and sorting (n=5384) (initialization): time 0.1838/6.592, allocations: 69.06 MB / 2.156 GB, free: 59.87 MB / 0.8388 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002197/6.592, allocations: 104 kB / 2.156 GB, free: 59.77 MB / 0.8388 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000402/6.593, allocations: 220 kB / 2.156 GB, free: 59.55 MB / 0.8388 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03668/6.629, allocations: 12.46 MB / 2.168 GB, free: 46.81 MB / 0.8388 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04865/6.678, allocations: 11.06 MB / 2.179 GB, free: 35.88 MB / 0.8388 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.6941/7.372, allocations: 289.2 MB / 2.461 GB, free: 42.98 MB / 0.9013 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04857/7.421, allocations: 2.659 MB / 2.464 GB, free: 42.32 MB / 0.9013 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01082/7.431, allocations: 1.773 MB / 2.466 GB, free: 41.98 MB / 0.9013 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.08538/7.517, allocations: 39.83 MB / 2.505 GB, free: 27.72 MB / 0.9013 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.05811/7.575, allocations: 29.88 MB / 2.534 GB, free: 8.184 MB / 0.9013 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.5322/8.107, allocations: 48.66 MB / 2.581 GB, free: 206.4 MB / 0.9013 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0004891/8.108, allocations: 63.75 kB / 2.581 GB, free: 206.4 MB / 0.9013 GB
Notification: Performance of matching and sorting (n=5384) (initialization_lambda0): time 0.1807/8.288, allocations: 68.74 MB / 2.649 GB, free: 185.8 MB / 0.9013 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001916/8.288, allocations: 104.6 kB / 2.649 GB, free: 185.8 MB / 0.9013 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003926/8.289, allocations: 221 kB / 2.649 GB, free: 185.8 MB / 0.9013 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03653/8.325, allocations: 12.34 MB / 2.661 GB, free: 181.5 MB / 0.9013 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04881/8.374, allocations: 11.04 MB / 2.672 GB, free: 179.7 MB / 0.9013 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.6627/9.037, allocations: 289.5 MB / 2.954 GB, free: 184.4 MB / 0.9638 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04496/9.082, allocations: 2.676 MB / 2.957 GB, free: 184.4 MB / 0.9638 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01026/9.092, allocations: 1.745 MB / 2.959 GB, free: 184.4 MB / 0.9638 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.01649/9.109, allocations: 2.458 MB / 2.961 GB, free: 184.2 MB / 0.9638 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.02302/9.132, allocations: 5.096 MB / 2.966 GB, free: 184.2 MB / 0.9638 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1116/9.243, allocations: 44.49 MB / 3.01 GB, free: 181.9 MB / 0.9638 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0003166/9.243, allocations: 254.6 kB / 3.01 GB, free: 181.9 MB / 0.9638 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0005987/9.244, allocations: 103.7 kB / 3.01 GB, free: 181.9 MB / 0.9638 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.08116/9.325, allocations: 37.81 MB / 3.047 GB, free: 169.4 MB / 0.9638 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.2191/9.544, allocations: 83.43 MB / 3.128 GB, free: 116.7 MB / 0.9638 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0003185/9.545, allocations: 0 / 3.128 GB, free: 116.7 MB / 0.9638 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.03054/9.575, allocations: 6.497 MB / 3.135 GB, free: 110.4 MB / 0.9638 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.03166/9.607, allocations: 10.99 MB / 3.145 GB, free: 99.13 MB / 0.9638 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.006935/9.614, allocations: 0.6949 MB / 3.146 GB, free: 98.44 MB / 0.9638 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.7618/10.38, allocations: 286.2 MB / 3.426 GB, free: 123.4 MB / 1.011 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.799e-06/10.38, allocations: 1.812 kB / 3.426 GB, free: 123.4 MB / 1.011 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.142/10.52, allocations: 64.46 MB / 3.489 GB, free: 108.3 MB / 1.011 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.03433/10.55, allocations: 9.728 MB / 3.498 GB, free: 105.8 MB / 1.011 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01655/10.57, allocations: 0.5435 MB / 3.499 GB, free: 105.4 MB / 1.011 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0411/10.61, allocations: 2.06 MB / 3.501 GB, free: 105 MB / 1.011 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.009457/10.62, allocations: 1.996 MB / 3.503 GB, free: 104.7 MB / 1.011 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.006977/10.63, allocations: 1.316 MB / 3.504 GB, free: 104.5 MB / 1.011 GB
Notification: Performance of sorting global known variables: time 0.06915/10.7, allocations: 31.05 MB / 3.534 GB, free: 94.41 MB / 1.011 GB
Notification: Performance of sort global known variables: time 8.42e-07/10.7, allocations: 0 / 3.534 GB, free: 94.41 MB / 1.011 GB
Notification: Performance of remove unused functions: time 0.1408/10.84, allocations: 25.7 MB / 3.559 GB, free: 77.38 MB / 1.011 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,16)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.009463/10.85, allocations: 1.881 MB / 3.561 GB, free: 76.04 MB / 1.011 GB
Notification: Performance of simCode: created initialization part: time 0.6854/11.53, allocations: 112.1 MB / 3.671 GB, free: 227.5 MB / 1.042 GB
Notification: Performance of simCode: created event and clocks part: time 5.573e-05/11.53, allocations: 34.73 kB / 3.671 GB, free: 227.5 MB / 1.042 GB
Notification: Performance of simCode: created simulation system equations: time 0.05171/11.58, allocations: 37.8 MB / 3.708 GB, free: 210.5 MB / 1.042 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.1584/11.74, allocations: 28.09 MB / 3.735 GB, free: 207.5 MB / 1.042 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2609/12, allocations: 123.8 MB / 3.856 GB, free: 171.6 MB / 1.042 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.07457/12.08, allocations: 34.38 MB / 3.89 GB, free: 152.9 MB / 1.042 GB
Notification: Performance of simCode: alias equations: time 0.09727/12.17, allocations: 27.21 MB / 3.916 GB, free: 129.3 MB / 1.042 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01762/12.19, allocations: 3.384 MB / 3.919 GB, free: 125.9 MB / 1.042 GB
Notification: Performance of SimCode: time 2.535e-06/12.19, allocations: 4 kB / 3.919 GB, free: 125.9 MB / 1.042 GB
Notification: Performance of Templates: time 3.104/15.3, allocations: 1.056 GB / 4.975 GB, free: 291.7 MB / 1.151 GB
"
[Timeout remaining time 645]
make -j1 -f IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.makefile [Timeout 660]
(rm -f IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.sim & ./IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 59.82814015704207]