Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest.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.00126/0.00126, allocations: 114.9 kB / 18.71 MB, free: 3.25 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.001229/0.001229, allocations: 196.4 kB / 21.97 MB, free: 4 kB / 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.429/1.429, allocations: 225.6 MB / 250.7 MB, free: 13.35 MB / 206.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.091/1.091, allocations: 175.7 MB / 481.6 MB, free: 7.863 MB / 382.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.SimulationTest,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest")
translateModel(IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.002133/0.002133, allocations: 68.61 kB / 0.67 GB, free: 14.24 MB / 0.4981 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5375/0.5396, allocations: 94.52 MB / 0.7623 GB, free: 10.01 MB / 0.5762 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest): time 0.09056/0.6302, allocations: 86.78 MB / 0.847 GB, free: 10.89 MB / 0.6387 GB
Notification: Performance of NFInst.instExpressions: time 0.04931/0.6795, allocations: 31.6 MB / 0.8779 GB, free: 404 kB / 0.6544 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006503/0.686, allocations: 123.4 kB / 0.878 GB, free: 280 kB / 0.6544 GB
Notification: Performance of NFTyping.typeComponents: time 0.008647/0.6947, allocations: 2.654 MB / 0.8806 GB, free: 13.61 MB / 0.67 GB
Notification: Performance of NFTyping.typeBindings: time 0.01472/0.7094, allocations: 5.105 MB / 0.8856 GB, free: 8.488 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009572/0.7189, allocations: 3.685 MB / 0.8892 GB, free: 4.828 MB / 0.67 GB
Notification: Performance of NFFlatten.flatten: time 1.313/2.032, allocations: 0.4993 GB / 1.388 GB, free: 108 kB / 0.9513 GB
Notification: Performance of NFFlatten.resolveConnections: time 1.695/3.726, allocations: 146.3 MB / 1.531 GB, free: 32.82 MB / 1.045 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.298/4.024, allocations: 160.7 MB / 1.688 GB, free: 9.812 MB / 1.045 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.292/4.316, allocations: 142.2 MB / 1.827 GB, free: 5.352 MB / 1.123 GB
Notification: Performance of NFPackage.collectConstants: time 0.08451/4.401, allocations: 18.84 MB / 1.845 GB, free: 2.512 MB / 1.139 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1638/4.565, allocations: 23.27 MB / 1.868 GB, free: 11.52 MB / 1.17 GB
Notification: Performance of NFScalarize.scalarize: time 0.1264/4.691, allocations: 51.45 MB / 1.918 GB, free: 9.816 MB / 1.217 GB
Notification: Performance of NFVerifyModel.verify: time 1.733/6.424, allocations: 102.1 MB / 2.018 GB, free: 126.3 MB / 1.233 GB
Notification: Performance of NFConvertDAE.convert: time 0.3872/6.812, allocations: 293 MB / 2.304 GB, free: 50.38 MB / 1.233 GB
Notification: Performance of FrontEnd - DAE generated: time 6.492e-06/6.812, allocations: 0 / 2.304 GB, free: 50.38 MB / 1.233 GB
Notification: Performance of FrontEnd: time 1.973e-06/6.812, allocations: 2.906 kB / 2.304 GB, free: 50.38 MB / 1.233 GB
Notification: Performance of Transformations before backend: time 0.0118/6.823, allocations: 0 / 2.304 GB, free: 50.38 MB / 1.233 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 29129
 * Number of variables: 29129
Notification: Performance of Generate backend data structure: time 2.142/8.965, allocations: 187.2 MB / 2.487 GB, free: 280.9 MB / 1.249 GB
Notification: Performance of prepare preOptimizeDAE: time 6.27e-05/8.965, allocations: 9.406 kB / 2.487 GB, free: 280.9 MB / 1.249 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1447/9.11, allocations: 20.23 MB / 2.507 GB, free: 271.3 MB / 1.249 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.3878/9.498, allocations: 179.4 MB / 2.682 GB, free: 125.7 MB / 1.249 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00834/9.506, allocations: 8.414 MB / 2.69 GB, free: 117.2 MB / 1.249 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0571/9.563, allocations: 11.65 MB / 2.702 GB, free: 105.6 MB / 1.249 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.508/10.07, allocations: 176.6 MB / 2.874 GB, free: 3.059 MB / 1.327 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.008999/10.08, allocations: 0.7498 MB / 2.875 GB, free: 2.305 MB / 1.327 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.05365/10.13, allocations: 4.819 MB / 2.88 GB, free: 13.49 MB / 1.343 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.007258/10.14, allocations: 5.136 MB / 2.885 GB, free: 8.348 MB / 1.343 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 1.127/11.27, allocations: 144.2 MB / 3.025 GB, free: 378.7 MB / 1.374 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 2.04/13.31, allocations: 0.7224 GB / 3.748 GB, free: 132.7 MB / 1.405 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.2076/13.52, allocations: 90.53 MB / 3.836 GB, free: 118.4 MB / 1.405 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.09899/13.61, allocations: 51.15 MB / 3.886 GB, free: 96.63 MB / 1.405 GB
Notification: Performance of preOpt evalFunc (simulation): time 1.34/14.95, allocations: 200 MB / 4.081 GB, free: 334.2 MB / 1.405 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.1034/15.06, allocations: 45.01 MB / 4.125 GB, free: 333.2 MB / 1.405 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.07366/15.13, allocations: 5.463 MB / 4.131 GB, free: 333.2 MB / 1.405 GB
Notification: Performance of pre-optimization done (n=6576): time 0.0002399/15.13, allocations: 1.922 kB / 4.131 GB, free: 333.2 MB / 1.405 GB
Notification: Performance of matching and sorting (n=7515): time 1.522/16.65, allocations: 374 MB / 4.496 GB, free: 309.6 MB / 1.405 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.001013/16.65, allocations: 0.7972 MB / 4.497 GB, free: 309.5 MB / 1.405 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.3177/16.97, allocations: 122.6 MB / 4.616 GB, free: 302.4 MB / 1.405 GB
Notification: Performance of collectPreVariables (initialization): time 0.02291/16.99, allocations: 1.618 MB / 4.618 GB, free: 301.2 MB / 1.405 GB
Notification: Performance of collectInitialEqns (initialization): time 0.1058/17.1, allocations: 69.58 MB / 4.686 GB, free: 265.5 MB / 1.405 GB
Notification: Performance of collectInitialBindings (initialization): time 0.05279/17.15, allocations: 28.37 MB / 4.714 GB, free: 243.7 MB / 1.405 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1155/17.27, allocations: 23.95 MB / 4.737 GB, free: 232.8 MB / 1.405 GB
Notification: Performance of setup shared object (initialization): time 5.267e-05/17.27, allocations: 311 kB / 4.737 GB, free: 232.5 MB / 1.405 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1193/17.39, allocations: 58.75 MB / 4.795 GB, free: 211.9 MB / 1.405 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.153/17.54, allocations: 82.29 MB / 4.875 GB, free: 159.1 MB / 1.405 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.2774/17.82, allocations: 136.3 MB / 5.008 GB, free: 41.27 MB / 1.405 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.001184/17.82, allocations: 176 kB / 5.008 GB, free: 41.1 MB / 1.405 GB
Notification: Performance of matching and sorting (n=15373) (initialization): time 1.283/19.1, allocations: 184.6 MB / 5.189 GB, free: 276.9 MB / 1.405 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0006277/19.1, allocations: 274.7 kB / 5.189 GB, free: 276.9 MB / 1.405 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001421/19.1, allocations: 0.6069 MB / 5.189 GB, free: 276.9 MB / 1.405 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06018/19.16, allocations: 28.21 MB / 5.217 GB, free: 266.2 MB / 1.405 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1315/19.3, allocations: 31.59 MB / 5.248 GB, free: 263.4 MB / 1.405 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.195/21.49, allocations: 0.8706 GB / 6.118 GB, free: 401.6 MB / 1.655 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1245/21.62, allocations: 7.544 MB / 6.126 GB, free: 401.6 MB / 1.655 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02796/21.64, allocations: 4.753 MB / 6.13 GB, free: 401.6 MB / 1.655 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.2153/21.86, allocations: 111.8 MB / 6.24 GB, free: 401.2 MB / 1.655 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.1372/22, allocations: 82.04 MB / 6.32 GB, free: 373.5 MB / 1.655 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.2398/22.24, allocations: 135.8 MB / 6.452 GB, free: 287.1 MB / 1.655 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.00119/22.24, allocations: 176 kB / 6.453 GB, free: 286.9 MB / 1.655 GB
Notification: Performance of matching and sorting (n=15373) (initialization_lambda0): time 0.41/22.65, allocations: 183.9 MB / 6.632 GB, free: 108.6 MB / 1.655 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0007459/22.65, allocations: 272 kB / 6.632 GB, free: 108.4 MB / 1.655 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.00109/22.65, allocations: 0.6063 MB / 6.633 GB, free: 107.8 MB / 1.655 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.05728/22.71, allocations: 28.18 MB / 6.66 GB, free: 78.16 MB / 1.655 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.128/22.83, allocations: 31.57 MB / 6.691 GB, free: 46.54 MB / 1.655 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.161/24.99, allocations: 0.8709 GB / 7.562 GB, free: 267.9 MB / 1.843 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1209/25.12, allocations: 7.54 MB / 7.57 GB, free: 267.9 MB / 1.843 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02858/25.14, allocations: 4.738 MB / 7.574 GB, free: 267.9 MB / 1.843 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 2837
 * Number of states: 0 ()
 * Number of discrete variables: 5 ($PRE.uPum.nextTimeEvent,$whenCondition1,uPum.nextTimeEventScaled,$PRE.uPum.nextTimeEventScaled,uPum.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (13427):
 * Single equations (assignments): 12957
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 2
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 466
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 464 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%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (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,10), (1,10)}
Notification: Performance of prepare postOptimizeDAE: time 0.05202/25.2, allocations: 6.635 MB / 7.581 GB, free: 267.7 MB / 1.843 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.05746/25.25, allocations: 11.78 MB / 7.592 GB, free: 267.7 MB / 1.843 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.2877/25.54, allocations: 120.8 MB / 7.71 GB, free: 253.6 MB / 1.843 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.2104/25.75, allocations: 103.6 MB / 7.811 GB, free: 212.2 MB / 1.843 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0004251/25.75, allocations: 0 / 7.811 GB, free: 212.2 MB / 1.843 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.07957/25.83, allocations: 25.4 MB / 7.836 GB, free: 205.5 MB / 1.843 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.04138/25.87, allocations: 1.515 MB / 7.838 GB, free: 204.4 MB / 1.843 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.09271/25.97, allocations: 5.551 MB / 7.843 GB, free: 202.6 MB / 1.843 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.01702/25.98, allocations: 5.564 MB / 7.848 GB, free: 199.8 MB / 1.843 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.2823/26.27, allocations: 141.2 MB / 7.986 GB, free: 72.85 MB / 1.843 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 1.128/27.39, allocations: 150.1 MB / 8.133 GB, free: 394 MB / 1.843 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.07214/27.47, allocations: 43.62 MB / 8.176 GB, free: 393.5 MB / 1.843 GB
Notification: Performance of sorting global known variables: time 0.1675/27.63, allocations: 85.03 MB / 8.259 GB, free: 382.4 MB / 1.843 GB
Notification: Performance of Backend: time 8.92e-07/27.63, allocations: 0 / 8.259 GB, free: 382.4 MB / 1.843 GB
Notification: Performance of simCode: created initialization part: time 0.5012/28.13, allocations: 285 MB / 8.537 GB, free: 189.6 MB / 1.843 GB
Notification: Performance of SimCode: time 1.636/29.77, allocations: 409.7 MB / 8.937 GB, free: 294.9 MB / 1.843 GB
Notification: Performance of Templates: time 8.525/38.3, allocations: 3.166 GB / 12.1 GB, free: 352.9 MB / 1.874 GB
"
[Timeout remaining time 622]
make -j1 -f IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest.makefile [Timeout 660]
(rm -f IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest.sim & ./IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Geothermal.Aquifer.Validation.SimulationTest.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 177.3778251609765]
Failed to read output from testmodel.py, exit status != 0:
38.30666789400857 38.316895696 31.502269498
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f1f9c912050>