Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F.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.0006879/0.0006879, allocations: 76.17 kB / 9.9 MB, free: 0.7891 MB / 10.45 MB Notification: Performance of NFInstanceAPI.mkTop(): time 0.0009341/0.001622, allocations: 445.7 kB / 10.34 MB, free: 364 kB / 10.45 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.0009593/0.0009593, allocations: 153.2 kB / 11.22 MB, free: 2.953 MB / 13.93 MB Notification: Performance of NFInstanceAPI.mkTop(): time 0.000891/0.00185, allocations: 471.6 kB / 11.68 MB, free: 2.488 MB / 13.93 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 0.9177/0.9177, allocations: 177.2 MB / 189.6 MB, free: 5.297 MB / 186.7 MB Notification: Performance of NFInstanceAPI.mkTop(): time 0.08769/1.005, allocations: 53.66 MB / 243.2 MB, free: 15.56 MB / 250.7 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 4.0.0-dev/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 4.0.0-dev/package.mo): time 0.1182/0.1182, allocations: 19.74 MB / 263.7 MB, free: 11.05 MB / 266.7 MB Notification: Performance of NFInstanceAPI.mkTop(): time 0.01033/0.1285, allocations: 7.556 MB / 271.3 MB, free: 3.473 MB / 266.7 MB " [Timeout remaining time 180] Using package ThermoPower with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 4.0.0-dev/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(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F") translateModel(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 1.814e-06/1.814e-06, allocations: 0 / 272.6 MB, free: 2.16 MB / 266.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 1.972e-05/2.153e-05, allocations: 6.312 kB / 272.6 MB, free: 2.152 MB / 266.7 MB Notification: Performance of NFInst.instantiate(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F): time 0.148/0.148, allocations: 28.23 MB / 300.8 MB, free: 0.875 MB / 282.7 MB Notification: Performance of NFInst.instExpressions: time 0.0171/0.1651, allocations: 14.03 MB / 314.8 MB, free: 3.395 MB / 298.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.002312/0.1674, allocations: 75.31 kB / 314.9 MB, free: 3.32 MB / 298.7 MB Notification: Performance of NFTyping.typeComponents: time 0.001686/0.1691, allocations: 0.702 MB / 315.6 MB, free: 2.613 MB / 298.7 MB Notification: Performance of NFTyping.typeBindings: time 0.004083/0.1732, allocations: 2.042 MB / 317.7 MB, free: 0.5547 MB / 298.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.01492/0.1881, allocations: 6.359 MB / 324 MB, free: 10.18 MB / 314.7 MB Notification: Performance of NFFlatten.flatten: time 0.02227/0.2104, allocations: 32.68 MB / 356.7 MB, free: 9.422 MB / 346.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.01263/0.223, allocations: 10.26 MB / 367 MB, free: 15.06 MB / 362.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.02344/0.2464, allocations: 13.34 MB / 380.3 MB, free: 1.688 MB / 362.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0181/0.2645, allocations: 13.96 MB / 394.2 MB, free: 3.707 MB / 378.7 MB Notification: Performance of NFPackage.collectConstants: time 0.008608/0.2731, allocations: 3.93 MB / 398.2 MB, free: 15.77 MB / 394.7 MB Notification: Performance of NFFlatten.collectFunctions: time 0.01879/0.2919, allocations: 10.36 MB / 408.5 MB, free: 5.41 MB / 394.7 MB Notification: Performance of NFScalarize.scalarize: time 0.01156/0.3035, allocations: 9.008 MB / 417.5 MB, free: 12.39 MB / 410.7 MB Notification: Performance of NFVerifyModel.verify: time 0.02094/0.3244, allocations: 8.23 MB / 425.8 MB, free: 4.145 MB / 410.7 MB Notification: Performance of NFConvertDAE.convert: time 0.3054/0.6298, allocations: 28.57 MB / 454.3 MB, free: 60.12 MB / 410.8 MB Notification: Performance of FrontEnd - DAE generated: time 1.914e-05/0.6298, allocations: 3.891 kB / 454.4 MB, free: 60.12 MB / 410.8 MB Notification: Performance of FrontEnd: time 1.372e-06/0.6298, allocations: 0 / 454.4 MB, free: 60.12 MB / 410.8 MB Notification: Performance of Transformations before backend: time 0.001292/0.6311, allocations: 0 / 454.4 MB, free: 60.12 MB / 410.8 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 6412 * Number of variables: 6412 Notification: Performance of Generate backend data structure: time 0.08396/0.7151, allocations: 35.68 MB / 490 MB, free: 52.11 MB / 410.8 MB Notification: Performance of prepare preOptimizeDAE: time 3.865e-05/0.7151, allocations: 8.156 kB / 490 MB, free: 52.11 MB / 410.8 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02803/0.7431, allocations: 6.853 MB / 496.9 MB, free: 47.27 MB / 410.8 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.01852/0.7617, allocations: 7.471 MB / 0.4925 GB, free: 40.4 MB / 410.8 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002084/0.7638, allocations: 2.024 MB / 0.4945 GB, free: 38.33 MB / 410.8 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.009968/0.7737, allocations: 2.33 MB / 0.4968 GB, free: 36.02 MB / 410.8 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.08086/0.8546, allocations: 38.19 MB / 0.5341 GB, free: 14.41 MB / 426.8 MB Notification: Performance of preOpt findStateOrder (simulation): time 0.0009142/0.8555, allocations: 7.188 kB / 0.5341 GB, free: 14.41 MB / 426.8 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.01002/0.8655, allocations: 0.9491 MB / 0.535 GB, free: 13.46 MB / 426.8 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0008366/0.8663, allocations: 1.259 MB / 0.5363 GB, free: 12.2 MB / 426.8 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1031/0.9694, allocations: 32.71 MB / 0.5682 GB, free: 11.54 MB / 458.8 MB 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.2873/1.257, allocations: 53.46 MB / 0.6204 GB, free: 121.4 MB / 474.8 MB Notification: Performance of preOpt comSubExp (simulation): time 0.03935/1.296, allocations: 21.41 MB / 0.6413 GB, free: 117 MB / 474.8 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.008433/1.304, allocations: 3.169 MB / 0.6444 GB, free: 116.5 MB / 474.8 MB Notification: Performance of preOpt evalFunc (simulation): time 0.1928/1.497, allocations: 117 MB / 0.7587 GB, free: 12.9 MB / 474.8 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001297/1.497, allocations: 181.5 kB / 0.7589 GB, free: 12.71 MB / 474.8 MB Notification: Performance of pre-optimization done (n=1312): time 1.382e-05/1.497, allocations: 1.531 kB / 0.7589 GB, free: 12.71 MB / 474.8 MB Notification: Performance of matching and sorting (n=1312): time 0.4112/1.909, allocations: 92.1 MB / 0.8488 GB, free: 95.7 MB / 474.8 MB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001144/1.909, allocations: 245.1 kB / 0.8491 GB, free: 95.44 MB / 474.8 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0123/1.921, allocations: 11.76 MB / 0.8606 GB, free: 86.82 MB / 474.8 MB Notification: Performance of collectPreVariables (initialization): time 0.0048/1.926, allocations: 261.6 kB / 0.8608 GB, free: 86.73 MB / 474.8 MB Notification: Performance of collectInitialEqns (initialization): time 0.0057/1.932, allocations: 12.83 MB / 0.8733 GB, free: 75.45 MB / 474.8 MB Notification: Performance of collectInitialBindings (initialization): time 0.00835/1.94, allocations: 5.334 MB / 0.8785 GB, free: 71.02 MB / 474.8 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.02219/1.962, allocations: 7.412 MB / 0.8858 GB, free: 66.1 MB / 474.8 MB Notification: Performance of setup shared object (initialization): time 3.007e-05/1.962, allocations: 309.1 kB / 0.8861 GB, free: 65.8 MB / 474.8 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0127/1.975, allocations: 7.699 MB / 0.8936 GB, free: 58.14 MB / 474.8 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.01941/1.994, allocations: 27 MB / 0.92 GB, free: 22.21 MB / 474.8 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.1936/2.188, allocations: 39.26 MB / 0.9583 GB, free: 99.19 MB / 490.8 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0004953/2.188, allocations: 194.3 kB / 0.9585 GB, free: 99.19 MB / 490.8 MB Notification: Performance of matching and sorting (n=4570) (initialization): time 0.08155/2.27, allocations: 42.94 MB / 1 GB, free: 95.16 MB / 490.8 MB Notification: Performance of prepare postOptimizeDAE: time 0.000398/2.27, allocations: 291 kB / 1.001 GB, free: 95.16 MB / 490.8 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0007142/2.271, allocations: 0.6458 MB / 1.001 GB, free: 95.16 MB / 490.8 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.1317/2.403, allocations: 54.94 MB / 1.055 GB, free: 50.09 MB / 490.8 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01332/2.416, allocations: 7.456 MB / 1.062 GB, free: 42.62 MB / 490.8 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04511/2.461, allocations: 22.35 MB / 1.084 GB, free: 20.48 MB / 490.8 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02533/2.487, allocations: 4.378 MB / 1.088 GB, free: 18.06 MB / 490.8 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.008264/2.495, allocations: 2.147 MB / 1.09 GB, free: 15.91 MB / 490.8 MB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02282/2.518, allocations: 8.222 MB / 1.098 GB, free: 7.695 MB / 490.8 MB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02421/2.542, allocations: 27.23 MB / 1.125 GB, free: 3.977 MB / 0.5105 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.2067/2.749, allocations: 39.41 MB / 1.164 GB, free: 108.2 MB / 0.5262 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0004215/2.749, allocations: 194 kB / 1.164 GB, free: 108.2 MB / 0.5262 GB Notification: Performance of matching and sorting (n=4570) (initialization_lambda0): time 0.06844/2.817, allocations: 39.97 MB / 1.203 GB, free: 103.5 MB / 0.5262 GB Notification: Performance of prepare postOptimizeDAE: time 0.000408/2.818, allocations: 296 kB / 1.203 GB, free: 103.2 MB / 0.5262 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0006317/2.818, allocations: 0.6602 MB / 1.204 GB, free: 102.5 MB / 0.5262 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.1296/2.948, allocations: 54.95 MB / 1.257 GB, free: 56.02 MB / 0.5262 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01282/2.961, allocations: 7.344 MB / 1.265 GB, free: 48.66 MB / 0.5262 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03577/2.997, allocations: 22.17 MB / 1.286 GB, free: 26.7 MB / 0.5262 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01827/3.015, allocations: 3.136 MB / 1.289 GB, free: 24.5 MB / 0.5262 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.006606/3.022, allocations: 2.139 MB / 1.291 GB, free: 22.36 MB / 0.5262 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 3025 * Number of states: 0 () * Number of discrete variables: 76 (refData.SensT_A_in.fluidState.phase,refData.SensT_B_in.fluidState.phase,refData.SensT_A_out.fluidState.phase,refData.SensT_B_out.fluidState.phase,SensT_A_in.fluidState.phase,SensT_B_in.fluidState.phase,SensT_A_out.fluidState.phase,SensT_B_out.fluidState.phase,refData.hexA.friction.NoFriction,refData.hexB.friction.NoFriction,hexA.friction.NoFriction,hexB.friction.NoFriction,refData.hexA.fluidState[1].phase,refData.hexA.fluidState[2].phase,refData.hexA.fluidState[3].phase,refData.hexA.fluidState[4].phase,refData.hexA.fluidState[5].phase,refData.hexA.fluidState[6].phase,refData.hexA.fluidState[7].phase,refData.hexA.fluidState[8].phase,refData.hexA.fluidState[9].phase,refData.hexA.fluidState[10].phase,refData.hexA.fluidState[11].phase,refData.hexA.fluidState[12].phase,refData.hexA.fluidState[13].phase,refData.hexA.fluidState[14].phase,refData.hexA.fluidState[15].phase,refData.hexA.fluidState[16].phase,refData.hexB.fluidState[1].phase,refData.hexB.fluidState[2].phase,refData.hexB.fluidState[3].phase,refData.hexB.fluidState[4].phase,refData.hexB.fluidState[5].phase,refData.hexB.fluidState[6].phase,refData.hexB.fluidState[7].phase,refData.hexB.fluidState[8].phase,refData.hexB.fluidState[9].phase,refData.hexB.fluidState[10].phase,refData.hexB.fluidState[11].phase,refData.hexB.fluidState[12].phase,refData.hexB.fluidState[13].phase,refData.hexB.fluidState[14].phase,refData.hexB.fluidState[15].phase,refData.hexB.fluidState[16].phase,hexA.fluidState[1].phase,hexA.fluidState[2].phase,hexA.fluidState[3].phase,hexA.fluidState[4].phase,hexA.fluidState[5].phase,hexA.fluidState[6].phase,hexA.fluidState[7].phase,hexA.fluidState[8].phase,hexA.fluidState[9].phase,hexA.fluidState[10].phase,hexA.fluidState[11].phase,hexA.fluidState[12].phase,hexA.fluidState[13].phase,hexA.fluidState[14].phase,hexA.fluidState[15].phase,hexA.fluidState[16].phase,hexB.fluidState[1].phase,hexB.fluidState[2].phase,hexB.fluidState[3].phase,hexB.fluidState[4].phase,hexB.fluidState[5].phase,hexB.fluidState[6].phase,hexB.fluidState[7].phase,hexB.fluidState[8].phase,hexB.fluidState[9].phase,hexB.fluidState[10].phase,hexB.fluidState[11].phase,hexB.fluidState[12].phase,hexB.fluidState[13].phase,hexB.fluidState[14].phase,hexB.fluidState[15].phase,hexB.fluidState[16].phase) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (3652): * Single equations (assignments): 3650 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 2 systems {(43,573), (43,261)} Notification: Performance of prepare postOptimizeDAE: time 0.01088/3.032, allocations: 2.842 MB / 1.294 GB, free: 19.5 MB / 0.5262 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004392/3.037, allocations: 1.26 MB / 1.295 GB, free: 18.23 MB / 0.5262 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.2708/3.308, allocations: 92.74 MB / 1.386 GB, free: 144.1 MB / 0.5574 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0003207/3.308, allocations: 69.94 kB / 1.386 GB, free: 144.1 MB / 0.5574 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.223e-05/3.308, allocations: 3.75 kB / 1.386 GB, free: 144.1 MB / 0.5574 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.004139/3.312, allocations: 0.6288 MB / 1.387 GB, free: 144.1 MB / 0.5574 GB Notification: Performance of postOpt removeConstants (simulation): time 0.008182/3.32, allocations: 3.354 MB / 1.39 GB, free: 143.3 MB / 0.5574 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005223/3.325, allocations: 0.4934 MB / 1.39 GB, free: 143.3 MB / 0.5574 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01052/3.336, allocations: 0.9754 MB / 1.391 GB, free: 143.3 MB / 0.5574 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.006902/3.343, allocations: 1.703 MB / 1.393 GB, free: 143.3 MB / 0.5574 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0538/3.397, allocations: 20.95 MB / 1.413 GB, free: 132.8 MB / 0.5574 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.03166/3.428, allocations: 18.29 MB / 1.431 GB, free: 118.7 MB / 0.5574 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.008117/3.436, allocations: 4.764 MB / 1.436 GB, free: 115.4 MB / 0.5574 GB Notification: Performance of sorting global known variables: time 0.005383/3.442, allocations: 4.562 MB / 1.44 GB, free: 112.5 MB / 0.5574 GB Notification: Performance of Backend: time 5.11e-07/3.442, allocations: 0 / 1.44 GB, free: 112.5 MB / 0.5574 GB Notification: Performance of simCode: created initialization part: time 0.08884/3.531, allocations: 47.19 MB / 1.486 GB, free: 68.33 MB / 0.5574 GB Notification: Performance of SimCode: time 0.04319/3.574, allocations: 46.37 MB / 1.532 GB, free: 22.54 MB / 0.5574 GB Notification: Performance of Templates: time 1.304/4.878, allocations: 0.7956 GB / 2.327 GB, free: 46.17 MB / 0.573 GB " [Timeout remaining time 655] make -j1 -f ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F.makefile [Timeout 660] (rm -f ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F.pipe ; mkfifo ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F.pipe ; head -c 1048576 < ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F.pipe >> ../files/ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F.sim & ./ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F -abortSlowSimulation -alarm=240 -lv LOG_STATS > ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEMnm_F.pipe 2>&1) [Timeout 240] [Calling sys.exit(0), Time elapsed: 20.403386916965246]