Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001289/0.001289, allocations: 111.7 kB / 17.08 MB, free: 6.012 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001302/0.001302, allocations: 191.7 kB / 20.03 MB, free: 3.082 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.452/1.452, allocations: 222.9 MB / 245.7 MB, free: 4.234 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/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 3.0.0-master/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 3.0.0-master/package.mo): time 1.239/1.239, allocations: 173.4 MB / 471.3 MB, free: 6.672 MB / 366.1 MB
"
[Timeout remaining time 179]
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells")
translateModel(IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.00194/0.00194, allocations: 75.25 kB / 0.649 GB, free: 22.82 MB / 0.4981 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1695/0.1715, allocations: 89.52 MB / 0.7364 GB, free: 3.734 MB / 0.545 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells): time 0.5525/0.724, allocations: 163.3 MB / 0.8959 GB, free: 3.895 MB / 0.67 GB
Notification: Performance of NFInst.instExpressions: time 0.0625/0.7865, allocations: 56.4 MB / 0.9509 GB, free: 12.61 MB / 0.6856 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.009793/0.7963, allocations: 246.1 kB / 0.9512 GB, free: 12.61 MB / 0.6856 GB
Notification: Performance of NFTyping.typeComponents: time 0.01291/0.8093, allocations: 3.972 MB / 0.955 GB, free: 10.94 MB / 0.6856 GB
Notification: Performance of NFTyping.typeBindings: time 0.02766/0.837, allocations: 9.148 MB / 0.964 GB, free: 4.816 MB / 0.6856 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01805/0.855, allocations: 6.619 MB / 0.9704 GB, free: 240 kB / 0.6856 GB
Notification: Performance of NFFlatten.flatten: time 0.2546/1.11, allocations: 249 MB / 1.214 GB, free: 48 kB / 0.92 GB
Notification: Performance of NFFlatten.resolveConnections: time 1.141/2.25, allocations: 100.8 MB / 1.312 GB, free: 13.46 MB / 0.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1388/2.389, allocations: 72.96 MB / 1.383 GB, free: 5.512 MB / 0.92 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1113/2.5, allocations: 61.56 MB / 1.443 GB, free: 14.25 MB / 0.9513 GB
Notification: Performance of NFPackage.collectConstants: time 0.03627/2.537, allocations: 8.668 MB / 1.452 GB, free: 5.582 MB / 0.9513 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.07115/2.608, allocations: 12.82 MB / 1.464 GB, free: 10.07 MB / 0.9669 GB
Notification: Performance of NFScalarize.scalarize: time 0.05296/2.661, allocations: 23.01 MB / 1.487 GB, free: 11.48 MB / 0.9825 GB
Notification: Performance of NFVerifyModel.verify: time 0.1081/2.769, allocations: 46.97 MB / 1.533 GB, free: 13.4 MB / 1.029 GB
Notification: Performance of NFConvertDAE.convert: time 1.275/4.044, allocations: 141.9 MB / 1.671 GB, free: 169 MB / 1.108 GB
Notification: Performance of FrontEnd - DAE generated: time 8.436e-06/4.044, allocations: 0 / 1.671 GB, free: 169 MB / 1.108 GB
Notification: Performance of FrontEnd: time 2.425e-06/4.044, allocations: 0 / 1.671 GB, free: 169 MB / 1.108 GB
Notification: Performance of Transformations before backend: time 0.005981/4.05, allocations: 1.906 kB / 1.671 GB, free: 169 MB / 1.108 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.2835/4.333, allocations: 86.36 MB / 1.756 GB, free: 138.6 MB / 1.108 GB
Notification: Performance of prepare preOptimizeDAE: time 4.499e-05/4.333, allocations: 11.5 kB / 1.756 GB, free: 138.6 MB / 1.108 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06377/4.397, allocations: 9.99 MB / 1.765 GB, free: 134.1 MB / 1.108 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1898/4.587, allocations: 84.81 MB / 1.848 GB, free: 107 MB / 1.108 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.004309/4.591, allocations: 3.801 MB / 1.852 GB, free: 105.3 MB / 1.108 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.03262/4.624, allocations: 5.264 MB / 1.857 GB, free: 103.5 MB / 1.108 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.2671/4.891, allocations: 79.37 MB / 1.935 GB, free: 33.59 MB / 1.108 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.004552/4.896, allocations: 334.4 kB / 1.935 GB, free: 33.34 MB / 1.108 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.03143/4.927, allocations: 2.169 MB / 1.937 GB, free: 31.21 MB / 1.108 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002047/4.929, allocations: 2.295 MB / 1.939 GB, free: 28.95 MB / 1.108 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1831/5.112, allocations: 64.66 MB / 2.002 GB, free: 12.94 MB / 1.155 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 1.375/6.487, allocations: 335 MB / 2.33 GB, free: 241.6 MB / 1.201 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.08887/6.576, allocations: 38.87 MB / 2.368 GB, free: 215.4 MB / 1.201 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0545/6.63, allocations: 24.69 MB / 2.392 GB, free: 190.6 MB / 1.201 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.2777/6.908, allocations: 92.18 MB / 2.482 GB, free: 100.1 MB / 1.201 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0007147/6.909, allocations: 494.4 kB / 2.482 GB, free: 99.64 MB / 1.201 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.03637/6.945, allocations: 2.534 MB / 2.485 GB, free: 97.78 MB / 1.201 GB
Notification: Performance of pre-optimization done (n=2952): time 0.0001159/6.946, allocations: 0 / 2.485 GB, free: 97.78 MB / 1.201 GB
Notification: Performance of matching and sorting (n=3374): time 1.16/8.106, allocations: 148.3 MB / 2.629 GB, free: 430.8 MB / 1.201 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0005614/8.106, allocations: 397 kB / 2.63 GB, free: 430.7 MB / 1.201 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.167/8.273, allocations: 57.36 MB / 2.686 GB, free: 412.2 MB / 1.201 GB
Notification: Performance of collectPreVariables (initialization): time 0.01457/8.288, allocations: 0.7438 MB / 2.687 GB, free: 411.7 MB / 1.201 GB
Notification: Performance of collectInitialEqns (initialization): time 0.04732/8.335, allocations: 31.65 MB / 2.717 GB, free: 387.3 MB / 1.201 GB
Notification: Performance of collectInitialBindings (initialization): time 0.02934/8.365, allocations: 12.65 MB / 2.73 GB, free: 377.5 MB / 1.201 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.05901/8.424, allocations: 11.18 MB / 2.741 GB, free: 371.8 MB / 1.201 GB
Notification: Performance of setup shared object (initialization): time 6.282e-05/8.424, allocations: 303.9 kB / 2.741 GB, free: 371.5 MB / 1.201 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.06297/8.487, allocations: 28.43 MB / 2.769 GB, free: 352.2 MB / 1.201 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.07572/8.563, allocations: 39.39 MB / 2.807 GB, free: 309.1 MB / 1.201 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1287/8.691, allocations: 65.48 MB / 2.871 GB, free: 240.2 MB / 1.201 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0005025/8.692, allocations: 84 kB / 2.871 GB, free: 240.1 MB / 1.201 GB
Notification: Performance of matching and sorting (n=7073) (initialization): time 0.2358/8.928, allocations: 88.96 MB / 2.958 GB, free: 150.6 MB / 1.201 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0009947/8.929, allocations: 124.8 kB / 2.958 GB, free: 150.5 MB / 1.201 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001104/8.93, allocations: 288 kB / 2.959 GB, free: 150.2 MB / 1.201 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03228/8.962, allocations: 14.19 MB / 2.972 GB, free: 135.4 MB / 1.201 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.8471/9.809, allocations: 14.15 MB / 2.986 GB, free: 401.7 MB / 1.201 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.2348/10.04, allocations: 389.1 MB / 3.366 GB, free: 93.48 MB / 1.217 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.06369/10.11, allocations: 3.362 MB / 3.369 GB, free: 92.25 MB / 1.217 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01513/10.12, allocations: 2.321 MB / 3.372 GB, free: 91.8 MB / 1.217 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1185/10.24, allocations: 51.97 MB / 3.423 GB, free: 52.35 MB / 1.217 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.07638/10.32, allocations: 38.89 MB / 3.46 GB, free: 9.434 MB / 1.217 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.006/11.32, allocations: 64.49 MB / 3.523 GB, free: 329.1 MB / 1.217 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0005841/11.32, allocations: 82.72 kB / 3.524 GB, free: 329.1 MB / 1.217 GB
Notification: Performance of matching and sorting (n=7073) (initialization_lambda0): time 0.2431/11.57, allocations: 87.67 MB / 3.609 GB, free: 306.1 MB / 1.217 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000319/11.57, allocations: 128 kB / 3.609 GB, free: 306.1 MB / 1.217 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0007891/11.57, allocations: 288.6 kB / 3.61 GB, free: 306.1 MB / 1.217 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03541/11.6, allocations: 14.14 MB / 3.623 GB, free: 300.4 MB / 1.217 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.06429/11.67, allocations: 14.12 MB / 3.637 GB, free: 288.9 MB / 1.217 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.093/12.76, allocations: 389.7 MB / 4.018 GB, free: 234.7 MB / 1.248 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.07171/12.83, allocations: 3.357 MB / 4.021 GB, free: 234.7 MB / 1.248 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0169/12.85, allocations: 2.279 MB / 4.023 GB, free: 234.7 MB / 1.248 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 (6093):
 * Single equations (assignments): 5881
 * Array equations: 4
 * Algorithm blocks: 0
 * Record equations: 4
 * 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.0324/12.88, allocations: 3.107 MB / 4.026 GB, free: 234.5 MB / 1.248 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.03461/12.92, allocations: 5.509 MB / 4.032 GB, free: 234.5 MB / 1.248 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1653/13.08, allocations: 57.32 MB / 4.088 GB, free: 231.4 MB / 1.248 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0003956/13.08, allocations: 333 kB / 4.088 GB, free: 231.4 MB / 1.248 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0006911/13.08, allocations: 125.2 kB / 4.088 GB, free: 231.4 MB / 1.248 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1209/13.21, allocations: 48.36 MB / 4.135 GB, free: 219 MB / 1.248 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.3747/13.58, allocations: 121.3 MB / 4.254 GB, free: 116.4 MB / 1.248 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0004162/13.58, allocations: 0 / 4.254 GB, free: 116.4 MB / 1.248 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.04052/13.62, allocations: 8.268 MB / 4.262 GB, free: 108.4 MB / 1.248 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.03041/13.65, allocations: 12.13 MB / 4.274 GB, free: 95.72 MB / 1.248 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.008739/13.66, allocations: 0.894 MB / 4.275 GB, free: 94.83 MB / 1.248 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.13/14.79, allocations: 384.7 MB / 4.65 GB, free: 127.4 MB / 1.295 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.547e-06/14.79, allocations: 3.719 kB / 4.65 GB, free: 127.4 MB / 1.295 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1974/14.99, allocations: 81.97 MB / 4.73 GB, free: 104.9 MB / 1.295 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.05369/15.04, allocations: 11.8 MB / 4.742 GB, free: 99.64 MB / 1.295 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0263/15.07, allocations: 0.6868 MB / 4.742 GB, free: 99.17 MB / 1.295 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.05661/15.12, allocations: 2.565 MB / 4.745 GB, free: 98.59 MB / 1.295 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.01319/15.14, allocations: 2.417 MB / 4.747 GB, free: 98.23 MB / 1.295 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.01257/15.15, allocations: 1.68 MB / 4.749 GB, free: 97.94 MB / 1.295 GB
Notification: Performance of sorting global known variables: time 0.1042/15.25, allocations: 39.75 MB / 4.788 GB, free: 71.21 MB / 1.295 GB
Notification: Performance of sort global known variables: time 6.51e-07/15.25, allocations: 0 / 4.788 GB, free: 71.21 MB / 1.295 GB
Notification: Performance of remove unused functions: time 0.2117/15.47, allocations: 32.87 MB / 4.82 GB, free: 38.5 MB / 1.295 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.02016/15.49, allocations: 2.656 MB / 4.822 GB, free: 36.7 MB / 1.295 GB
Notification: Performance of simCode: created initialization part: time 1.093/16.58, allocations: 151 MB / 4.97 GB, free: 304 MB / 1.342 GB
Notification: Performance of simCode: created event and clocks part: time 4.692e-05/16.58, allocations: 46.48 kB / 4.97 GB, free: 304 MB / 1.342 GB
Notification: Performance of simCode: created simulation system equations: time 0.07558/16.66, allocations: 48.99 MB / 5.018 GB, free: 281.3 MB / 1.342 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.2193/16.87, allocations: 34.36 MB / 5.051 GB, free: 276.9 MB / 1.342 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4435/17.32, allocations: 160.6 MB / 5.208 GB, free: 182.7 MB / 1.342 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.1161/17.43, allocations: 43.89 MB / 5.251 GB, free: 142.8 MB / 1.342 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02743/17.46, allocations: 4.634 MB / 5.256 GB, free: 138.1 MB / 1.342 GB
Notification: Performance of SimCode: time 1.453e-06/17.46, allocations: 0 / 5.256 GB, free: 138.1 MB / 1.342 GB
Notification: Performance of Templates: time 196.7/214.2, allocations: 81.66 GB / 86.92 GB, free: 0.5021 GB / 1.702 GB
"
[Timeout remaining time 446]
make -j1 -f IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.makefile [Timeout 660]
(rm -f IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.sim & ./IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.NumberWells.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 741.395239623962]
Failed to read output from testmodel.py, exit status != 0:
214.1929027698934 214.201693979 210.155867002
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fbe757f6050>