Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.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.001445/0.001445, allocations: 82.8 kB / 19.18 MB, free: 2.363 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.00183/0.00183, allocations: 170.2 kB / 22.45 MB, free: 4.984 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.451/1.451, allocations: 177.2 MB / 202.8 MB, free: 9.188 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Examples/PPD12/Structure.mo:531:21-531:686:writable] Warning: Lexer treating \\ as \\\\, since \\e is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Examples/PPD12/Structure.mo:531:21-531:694:writable] Warning: Lexer treating \\ as \\\\, since \\< is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Media/Refrigerants/R410A/package.order:0:0-0:0:readonly] Warning: Found duplicate names in package.order file: A, B, C.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Media/Refrigerants/R410A/package.mo:2:1-70:10:writable] Warning: C was referenced in the package.order file, but was not found in package.mo, C/package.mo or C.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/package.mo): time 1.186/1.186, allocations: 154.7 MB / 413.9 MB, free: 5.16 MB / 382.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/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 4.0.0/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 4.0.0/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.Validation.NumberWells,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells")
translateModel(IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.573e-06/1.573e-06, allocations: 0 / 0.6187 GB, free: 4.578 MB / 0.5294 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.965e-05/3.122e-05, allocations: 4.953 kB / 0.6187 GB, free: 4.574 MB / 0.5294 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells): time 0.5933/0.5933, allocations: 148.5 MB / 0.7637 GB, free: 2.703 MB / 0.6075 GB
Notification: Performance of NFInst.instExpressions: time 0.0983/0.6916, allocations: 52.72 MB / 0.8152 GB, free: 11.38 MB / 0.6544 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01166/0.7033, allocations: 328.2 kB / 0.8155 GB, free: 11.21 MB / 0.6544 GB
Notification: Performance of NFTyping.typeComponents: time 0.01394/0.7172, allocations: 4.005 MB / 0.8194 GB, free: 8.109 MB / 0.6544 GB
Notification: Performance of NFTyping.typeBindings: time 0.0322/0.7494, allocations: 9.755 MB / 0.8289 GB, free: 15.58 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02229/0.7717, allocations: 6.912 MB / 0.8357 GB, free: 8.719 MB / 0.67 GB
Notification: Performance of NFFlatten.flatten: time 1.157/1.928, allocations: 268 MB / 1.097 GB, free: 50.31 MB / 0.8575 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1384/2.067, allocations: 66.16 MB / 1.162 GB, free: 43.72 MB / 0.8575 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.2615/2.328, allocations: 104.7 MB / 1.264 GB, free: 1.027 MB / 0.8732 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1381/2.466, allocations: 62.91 MB / 1.326 GB, free: 10.08 MB / 0.9357 GB
Notification: Performance of NFPackage.collectConstants: time 0.03403/2.5, allocations: 8.594 MB / 1.334 GB, free: 1.484 MB / 0.9357 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.07294/2.573, allocations: 12.01 MB / 1.346 GB, free: 5.895 MB / 0.9513 GB
Notification: Performance of NFScalarize.scalarize: time 0.05366/2.627, allocations: 24.09 MB / 1.369 GB, free: 15.57 MB / 0.9825 GB
Notification: Performance of NFVerifyModel.verify: time 0.09951/2.726, allocations: 32.53 MB / 1.401 GB, free: 0.9414 MB / 0.9982 GB
Notification: Performance of NFConvertDAE.convert: time 1.306/4.032, allocations: 143 MB / 1.541 GB, free: 102.7 MB / 0.9983 GB
Notification: Performance of FrontEnd - DAE generated: time 8.857e-06/4.032, allocations: 0 / 1.541 GB, free: 102.7 MB / 0.9983 GB
Notification: Performance of FrontEnd: time 3.277e-06/4.032, allocations: 4.5 kB / 1.541 GB, free: 102.7 MB / 0.9983 GB
Notification: Performance of Transformations before backend: time 0.005973/4.038, allocations: 0.75 kB / 1.541 GB, free: 102.7 MB / 0.9983 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 13116
 * Number of variables: 13116
Notification: Performance of Generate backend data structure: time 0.2825/4.321, allocations: 86.26 MB / 1.625 GB, free: 60.73 MB / 0.9983 GB
Notification: Performance of prepare preOptimizeDAE: time 4.221e-05/4.321, allocations: 11.16 kB / 1.625 GB, free: 60.73 MB / 0.9983 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.07221/4.393, allocations: 10.95 MB / 1.636 GB, free: 55.32 MB / 0.9983 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1969/4.59, allocations: 85.73 MB / 1.719 GB, free: 5.5 MB / 0.9983 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.003942/4.594, allocations: 3.799 MB / 1.723 GB, free: 1.73 MB / 0.9983 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.02905/4.623, allocations: 5.267 MB / 1.728 GB, free: 12.5 MB / 1.014 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.8645/5.487, allocations: 94.73 MB / 1.821 GB, free: 322.2 MB / 1.076 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.006805/5.494, allocations: 333.1 kB / 1.821 GB, free: 322.1 MB / 1.076 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.02915/5.523, allocations: 2.165 MB / 1.823 GB, free: 322.1 MB / 1.076 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.007061/5.53, allocations: 2.297 MB / 1.825 GB, free: 322 MB / 1.076 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1968/5.727, allocations: 64.13 MB / 1.888 GB, free: 304 MB / 1.076 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.6063/6.334, allocations: 251.9 MB / 2.134 GB, free: 111.4 MB / 1.076 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.07503/6.409, allocations: 36.36 MB / 2.17 GB, free: 74.77 MB / 1.076 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.05121/6.46, allocations: 22.68 MB / 2.192 GB, free: 52.02 MB / 1.076 GB
Notification: Performance of preOpt evalFunc (simulation): time 1.028/7.488, allocations: 80.76 MB / 2.271 GB, free: 305.9 MB / 1.076 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001291/7.49, allocations: 490.8 kB / 2.271 GB, free: 305.9 MB / 1.076 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.04062/7.53, allocations: 2.489 MB / 2.274 GB, free: 305.9 MB / 1.076 GB
Notification: Performance of pre-optimization done (n=2952): time 0.0002486/7.53, allocations: 2.906 kB / 2.274 GB, free: 305.9 MB / 1.076 GB
Notification: Performance of matching and sorting (n=3374): time 0.4775/8.008, allocations: 147.2 MB / 2.417 GB, free: 252 MB / 1.076 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002508/8.008, allocations: 392.4 kB / 2.418 GB, free: 251.9 MB / 1.076 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1661/8.174, allocations: 57.25 MB / 2.474 GB, free: 214.9 MB / 1.076 GB
Notification: Performance of collectPreVariables (initialization): time 0.01285/8.187, allocations: 0.7418 MB / 2.474 GB, free: 214.2 MB / 1.076 GB
Notification: Performance of collectInitialEqns (initialization): time 0.04629/8.233, allocations: 31.66 MB / 2.505 GB, free: 183.8 MB / 1.076 GB
Notification: Performance of collectInitialBindings (initialization): time 0.02921/8.263, allocations: 12.62 MB / 2.517 GB, free: 171.4 MB / 1.076 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.05813/8.321, allocations: 10.74 MB / 2.528 GB, free: 160.6 MB / 1.076 GB
Notification: Performance of setup shared object (initialization): time 6.931e-05/8.321, allocations: 305.1 kB / 2.528 GB, free: 160.3 MB / 1.076 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.06582/8.387, allocations: 26.95 MB / 2.555 GB, free: 133.3 MB / 1.076 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.07957/8.466, allocations: 38.39 MB / 2.592 GB, free: 90.77 MB / 1.076 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.7745/9.241, allocations: 62.72 MB / 2.653 GB, free: 254.6 MB / 1.076 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0007755/9.241, allocations: 81.81 kB / 2.653 GB, free: 254.6 MB / 1.076 GB
Notification: Performance of matching and sorting (n=6809) (initialization): time 0.2191/9.461, allocations: 85.63 MB / 2.737 GB, free: 234.2 MB / 1.076 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002318/9.461, allocations: 128.1 kB / 2.737 GB, free: 234.2 MB / 1.076 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0005441/9.461, allocations: 283.4 kB / 2.737 GB, free: 234.2 MB / 1.076 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03347/9.495, allocations: 14.31 MB / 2.751 GB, free: 228.8 MB / 1.076 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.06145/9.556, allocations: 13.98 MB / 2.765 GB, free: 227.8 MB / 1.076 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.8496/10.41, allocations: 361.9 MB / 3.118 GB, free: 240.8 MB / 1.155 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.06781/10.47, allocations: 3.317 MB / 3.122 GB, free: 240.8 MB / 1.155 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01661/10.49, allocations: 2.331 MB / 3.124 GB, free: 240.8 MB / 1.155 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1164/10.61, allocations: 50.79 MB / 3.174 GB, free: 240.6 MB / 1.155 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.07801/10.68, allocations: 38.2 MB / 3.211 GB, free: 219 MB / 1.155 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.1184/10.8, allocations: 62.37 MB / 3.272 GB, free: 186.9 MB / 1.155 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0009619/10.8, allocations: 79.09 kB / 3.272 GB, free: 186.9 MB / 1.155 GB
Notification: Performance of matching and sorting (n=6809) (initialization_lambda0): time 0.2119/11.02, allocations: 84.95 MB / 3.355 GB, free: 123.8 MB / 1.155 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002261/11.02, allocations: 128 kB / 3.355 GB, free: 123.7 MB / 1.155 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0004039/11.02, allocations: 288.6 kB / 3.355 GB, free: 123.4 MB / 1.155 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0302/11.05, allocations: 14.26 MB / 3.369 GB, free: 108.6 MB / 1.155 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.05998/11.11, allocations: 13.93 MB / 3.383 GB, free: 94.72 MB / 1.155 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.8683/11.98, allocations: 362.5 MB / 3.737 GB, free: 92.77 MB / 1.217 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.06578/12.04, allocations: 3.329 MB / 3.74 GB, free: 91.93 MB / 1.217 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01395/12.05, allocations: 2.273 MB / 3.742 GB, free: 91.49 MB / 1.217 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1302
 * 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 (5957):
 * Single equations (assignments): 5749
 * Array equations: 4
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 204
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 200 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%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (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): 4 systems
   {(1,10), (1,10), (1,10), (1,10)}
Notification: Performance of prepare postOptimizeDAE: time 0.02458/12.08, allocations: 3.075 MB / 3.745 GB, free: 89.47 MB / 1.217 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.02777/12.11, allocations: 5.507 MB / 3.751 GB, free: 89.47 MB / 1.217 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1522/12.26, allocations: 56.98 MB / 3.806 GB, free: 67.09 MB / 1.217 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.000298/12.26, allocations: 331.4 kB / 3.807 GB, free: 67.09 MB / 1.217 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0005567/12.26, allocations: 125.1 kB / 3.807 GB, free: 67.09 MB / 1.217 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1123/12.37, allocations: 47.87 MB / 3.854 GB, free: 48.37 MB / 1.217 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.8927/13.27, allocations: 105.7 MB / 3.957 GB, free: 271.9 MB / 1.217 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0002712/13.27, allocations: 2.344 kB / 3.957 GB, free: 271.9 MB / 1.217 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.03985/13.31, allocations: 8.263 MB / 3.965 GB, free: 271.9 MB / 1.217 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.02823/13.33, allocations: 12.15 MB / 3.977 GB, free: 270.2 MB / 1.217 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.007187/13.34, allocations: 0.8992 MB / 3.978 GB, free: 270.2 MB / 1.217 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.2454/13.59, allocations: 357.1 MB / 4.326 GB, free: 56.56 MB / 1.295 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.308e-06/13.59, allocations: 6.406 kB / 4.326 GB, free: 56.55 MB / 1.295 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1689/13.75, allocations: 81.32 MB / 4.406 GB, free: 31.77 MB / 1.311 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.04471/13.8, allocations: 12.09 MB / 4.418 GB, free: 22.51 MB / 1.311 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.02208/13.82, allocations: 0.6835 MB / 4.418 GB, free: 21.83 MB / 1.311 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.05243/13.87, allocations: 2.575 MB / 4.421 GB, free: 19.57 MB / 1.311 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.01159/13.89, allocations: 2.548 MB / 4.423 GB, free: 17.02 MB / 1.311 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.009055/13.89, allocations: 1.71 MB / 4.425 GB, free: 15.3 MB / 1.311 GB
Notification: Performance of sorting global known variables: time 0.7762/14.67, allocations: 39.49 MB / 4.463 GB, free: 308.9 MB / 1.311 GB
Notification: Performance of sort global known variables: time 3.31e-07/14.67, allocations: 0 / 4.463 GB, free: 308.9 MB / 1.311 GB
Notification: Performance of remove unused functions: time 0.2065/14.88, allocations: 32.5 MB / 4.495 GB, free: 308.9 MB / 1.311 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * Number of states: 210 (aquWel1.pumCol.vol.dynBal.U,aquWel1.pumCol.motSpe.y,aquWel1.pumHot.vol.dynBal.U,aquWel1.pumHot.motSpe.y,aquWel1.resAqu.mExc,aquWel1.heaCapCol[1].T,aquWel1.heaCapCol[2].T,aquWel1.heaCapCol[3].T,aquWel1.heaCapCol[4].T,aquWel1.heaCapCol[5].T,aquWel1.heaCapCol[6].T,aquWel1.heaCapCol[7].T,aquWel1.heaCapCol[8].T,aquWel1.heaCapCol[9].T,aquWel1.heaCapCol[10].T,aquWel1.heaCapCol[11].T,aquWel1.heaCapCol[12].T,aquWel1.heaCapCol[13].T,aquWel1.heaCapCol[14].T,aquWel1.heaCapCol[15].T,aquWel1.heaCapCol[16].T,aquWel1.heaCapCol[17].T,aquWel1.heaCapCol[18].T,aquWel1.heaCapCol[19].T,aquWel1.heaCapCol[20].T,aquWel1.heaCapCol[21].T,aquWel1.heaCapCol[22].T,aquWel1.heaCapCol[23].T,aquWel1.heaCapCol[24].T,aquWel1.heaCapCol[25].T,aquWel1.heaCapCol[26].T,aquWel1.heaCapCol[27].T,aquWel1.heaCapCol[28].T,aquWel1.heaCapCol[29].T,aquWel1.heaCapCol[30].T,aquWel1.heaCapCol[31].T,aquWel1.heaCapCol[32].T,aquWel1.heaCapCol[33].T,aquWel1.heaCapCol[34].T,aquWel1.heaCapCol[35].T,aquWel1.heaCapCol[36].T,aquWel1.heaCapCol[37].T,aquWel1.heaCapCol[38].T,aquWel1.heaCapCol[39].T,aquWel1.heaCapCol[40].T,aquWel1.heaCapCol[41].T,aquWel1.heaCapCol[42].T,aquWel1.heaCapCol[43].T,aquWel1.heaCapCol[44].T,aquWel1.heaCapCol[45].T,aquWel1.heaCapCol[46].T,aquWel1.heaCapCol[47].T,aquWel1.heaCapCol[48].T,aquWel1.heaCapCol[49].T,aquWel1.heaCapCol[50].T,aquWel1.heaCapHot[1].T,aquWel1.heaCapHot[2].T,aquWel1.heaCapHot[3].T,aquWel1.heaCapHot[4].T,aquWel1.heaCapHot[5].T,aquWel1.heaCapHot[6].T,aquWel1.heaCapHot[7].T,aquWel1.heaCapHot[8].T,aquWel1.heaCapHot[9].T,aquWel1.heaCapHot[10].T,aquWel1.heaCapHot[11].T,aquWel1.heaCapHot[12].T,aquWel1.heaCapHot[13].T,aquWel1.heaCapHot[14].T,aquWel1.heaCapHot[15].T,aquWel1.heaCapHot[16].T,aquWel1.heaCapHot[17].T,aquWel1.heaCapHot[18].T,aquWel1.heaCapHot[19].T,aquWel1.heaCapHot[20].T,aquWel1.heaCapHot[21].T,aquWel1.heaCapHot[22].T,aquWel1.heaCapHot[23].T,aquWel1.heaCapHot[24].T,aquWel1.heaCapHot[25].T,aquWel1.heaCapHot[26].T,aquWel1.heaCapHot[27].T,aquWel1.heaCapHot[28].T,aquWel1.heaCapHot[29].T,aquWel1.heaCapHot[30].T,aquWel1.heaCapHot[31].T,aquWel1.heaCapHot[32].T,aquWel1.heaCapHot[33].T,aquWel1.heaCapHot[34].T,aquWel1.heaCapHot[35].T,aquWel1.heaCapHot[36].T,aquWel1.heaCapHot[37].T,aquWel1.heaCapHot[38].T,aquWel1.heaCapHot[39].T,aquWel1.heaCapHot[40].T,aquWel1.heaCapHot[41].T,aquWel1.heaCapHot[42].T,aquWel1.heaCapHot[43].T,aquWel1.heaCapHot[44].T,aquWel1.heaCapHot[45].T,aquWel1.heaCapHot[46].T,aquWel1.heaCapHot[47].T,aquWel1.heaCapHot[48].T,aquWel1.heaCapHot[49].T,aquWel1.heaCapHot[50].T,aquWel2.pumCol.vol.dynBal.U,aquWel2.pumCol.motSpe.y,aquWel2.pumHot.vol.dynBal.U,aquWel2.pumHot.motSpe.y,aquWel2.resAqu.mExc,aquWel2.heaCapCol[1].T,aquWel2.heaCapCol[2].T,aquWel2.heaCapCol[3].T,aquWel2.heaCapCol[4].T,aquWel2.heaCapCol[5].T,aquWel2.heaCapCol[6].T,aquWel2.heaCapCol[7].T,aquWel2.heaCapCol[8].T,aquWel2.heaCapCol[9].T,aquWel2.heaCapCol[10].T,aquWel2.heaCapCol[11].T,aquWel2.heaCapCol[12].T,aquWel2.heaCapCol[13].T,aquWel2.heaCapCol[14].T,aquWel2.heaCapCol[15].T,aquWel2.heaCapCol[16].T,aquWel2.heaCapCol[17].T,aquWel2.heaCapCol[18].T,aquWel2.heaCapCol[19].T,aquWel2.heaCapCol[20].T,aquWel2.heaCapCol[21].T,aquWel2.heaCapCol[22].T,aquWel2.heaCapCol[23].T,aquWel2.heaCapCol[24].T,aquWel2.heaCapCol[25].T,aquWel2.heaCapCol[26].T,aquWel2.heaCapCol[27].T,aquWel2.heaCapCol[28].T,aquWel2.heaCapCol[29].T,aquWel2.heaCapCol[30].T,aquWel2.heaCapCol[31].T,aquWel2.heaCapCol[32].T,aquWel2.heaCapCol[33].T,aquWel2.heaCapCol[34].T,aquWel2.heaCapCol[35].T,aquWel2.heaCapCol[36].T,aquWel2.heaCapCol[37].T,aquWel2.heaCapCol[38].T,aquWel2.heaCapCol[39].T,aquWel2.heaCapCol[40].T,aquWel2.heaCapCol[41].T,aquWel2.heaCapCol[42].T,aquWel2.heaCapCol[43].T,aquWel2.heaCapCol[44].T,aquWel2.heaCapCol[45].T,aquWel2.heaCapCol[46].T,aquWel2.heaCapCol[47].T,aquWel2.heaCapCol[48].T,aquWel2.heaCapCol[49].T,aquWel2.heaCapCol[50].T,aquWel2.heaCapHot[1].T,aquWel2.heaCapHot[2].T,aquWel2.heaCapHot[3].T,aquWel2.heaCapHot[4].T,aquWel2.heaCapHot[5].T,aquWel2.heaCapHot[6].T,aquWel2.heaCapHot[7].T,aquWel2.heaCapHot[8].T,aquWel2.heaCapHot[9].T,aquWel2.heaCapHot[10].T,aquWel2.heaCapHot[11].T,aquWel2.heaCapHot[12].T,aquWel2.heaCapHot[13].T,aquWel2.heaCapHot[14].T,aquWel2.heaCapHot[15].T,aquWel2.heaCapHot[16].T,aquWel2.heaCapHot[17].T,aquWel2.heaCapHot[18].T,aquWel2.heaCapHot[19].T,aquWel2.heaCapHot[20].T,aquWel2.heaCapHot[21].T,aquWel2.heaCapHot[22].T,aquWel2.heaCapHot[23].T,aquWel2.heaCapHot[24].T,aquWel2.heaCapHot[25].T,aquWel2.heaCapHot[26].T,aquWel2.heaCapHot[27].T,aquWel2.heaCapHot[28].T,aquWel2.heaCapHot[29].T,aquWel2.heaCapHot[30].T,aquWel2.heaCapHot[31].T,aquWel2.heaCapHot[32].T,aquWel2.heaCapHot[33].T,aquWel2.heaCapHot[34].T,aquWel2.heaCapHot[35].T,aquWel2.heaCapHot[36].T,aquWel2.heaCapHot[37].T,aquWel2.heaCapHot[38].T,aquWel2.heaCapHot[39].T,aquWel2.heaCapHot[40].T,aquWel2.heaCapHot[41].T,aquWel2.heaCapHot[42].T,aquWel2.heaCapHot[43].T,aquWel2.heaCapHot[44].T,aquWel2.heaCapHot[45].T,aquWel2.heaCapHot[46].T,aquWel2.heaCapHot[47].T,aquWel2.heaCapHot[48].T,aquWel2.heaCapHot[49].T,aquWel2.heaCapHot[50].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 (2600):
 * Single equations (assignments): 2383
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 13
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 204
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 200 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%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (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): 4 systems
   {(1,10), (1,12), (1,13), (1,13)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01616/14.89, allocations: 2.486 MB / 4.498 GB, free: 308.7 MB / 1.311 GB
Notification: Performance of simCode: created initialization part: time 0.238/15.13, allocations: 141.5 MB / 4.636 GB, free: 254.4 MB / 1.311 GB
Notification: Performance of simCode: created event and clocks part: time 6.794e-05/15.13, allocations: 46.27 kB / 4.636 GB, free: 254.4 MB / 1.311 GB
Notification: Performance of simCode: created simulation system equations: time 0.06857/15.2, allocations: 47.4 MB / 4.682 GB, free: 220.7 MB / 1.311 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.1875/15.39, allocations: 34.68 MB / 4.716 GB, free: 194.8 MB / 1.311 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2937/15.68, allocations: 155.8 MB / 4.868 GB, free: 46.26 MB / 1.311 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.08546/15.77, allocations: 43.82 MB / 4.911 GB, free: 2.359 MB / 1.311 GB
Notification: Performance of simCode: alias equations: time 0.7842/16.55, allocations: 33.46 MB / 4.944 GB, free: 240.2 MB / 1.342 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02596/16.58, allocations: 4.362 MB / 4.948 GB, free: 240.2 MB / 1.342 GB
Notification: Performance of SimCode: time 1.423e-06/16.58, allocations: 0 / 4.948 GB, free: 240.2 MB / 1.342 GB
Notification: Performance of Templates: time 3.878/20.45, allocations: 1.357 GB / 6.305 GB, free: 223.9 MB / 1.452 GB
"
[Timeout remaining time 640]
make -j1 -f IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.makefile [Timeout 660]
(rm -f IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.pipe ; mkfifo IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.pipe >> ../files/IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.sim & ./IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 70.61700777895749]
Failed to read output from testmodel.py, exit status != 0:
20.465493654832244 20.475215894 16.440154379
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f9cc20151e0>