Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo", uses=false) [Timeout 90] Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo): time 0.7743/0.7743, allocations: 152.6 MB / 170.7 MB, free: 6.301 MB / 142.1 MB [Timeout remaining time 89] Using package ThermoSysPro with version 4.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo) Running command: translateModel(ThermoSysPro.Examples.SimpleExamples.TestBend,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend") translateModel(ThermoSysPro.Examples.SimpleExamples.TestBend,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend") [Timeout 660] Notification: Performance of FrontEnd - loaded program: time 0.0004863/0.0004863, allocations: 19.97 kB / 247.3 MB, free: 6.383 MB / 206.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1535/0.154, allocations: 33.04 MB / 280.3 MB, free: 3.836 MB / 222.1 MB Notification: Automatically loaded package Complex 4.0.0 due to uses annotation from Modelica. Notification: Automatically loaded package ModelicaServices 4.0.0 due to uses annotation from Modelica. Notification: Automatically loaded package Modelica 4.0.0 due to usage. Notification: Performance of NFInst.instantiate(ThermoSysPro.Examples.SimpleExamples.TestBend): time 1.419/1.573, allocations: 301.1 MB / 0.5678 GB, free: 6.117 MB / 478.1 MB Notification: Performance of NFInst.instExpressions: time 0.2405/1.814, allocations: 35.22 MB / 0.6022 GB, free: 5.855 MB / 478.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0001987/1.814, allocations: 2.312 kB / 0.6022 GB, free: 5.855 MB / 478.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/WaterSteam/BoundaryConditions/SourceP.mo:30:3-31:45:writable] Warning: Connector C is not balanced: The number of potential variables (4) is not equal to the number of flow variables (0). [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/WaterSteam/BoundaryConditions/SinkP.mo:33:3-34:47:writable] Warning: Connector C is not balanced: The number of potential variables (4) is not equal to the number of flow variables (0). [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/WaterSteam/PressureLosses/Bend.mo:55:3-57:42:writable] Warning: Connector C1 is not balanced: The number of potential variables (4) is not equal to the number of flow variables (0). [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/WaterSteam/PressureLosses/Bend.mo:58:3-60:43:writable] Warning: Connector C2 is not balanced: The number of potential variables (4) is not equal to the number of flow variables (0). Notification: Performance of NFTyping.typeComponents: time 0.0004692/1.814, allocations: 293.4 kB / 0.6025 GB, free: 5.777 MB / 478.1 MB Notification: Performance of NFTyping.typeBindings: time 0.0002695/1.815, allocations: 278.9 kB / 0.6028 GB, free: 5.684 MB / 478.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Properties/WaterSteam/IF97_packages.mo:783:9-783:27:writable] Warning: cv was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Properties/WaterSteam/IF97_packages.mo:850:9-850:27:writable] Warning: cv was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Properties/WaterSteam/IF97_packages.mo:1088:9-1088:27:writable] Warning: cv was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Properties/WaterSteamSimple/prop4_Ph.mo:69:3-69:60:writable] Warning: dh1satp was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Properties/WaterSteamSimple/prop4_Ph.mo:69:3-69:60:writable] Warning: dh2satp was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Properties/WaterSteamSimple/prop4_Ph_der.mo:167:3-170:49:writable] Warning: du1satp_der was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Properties/WaterSteamSimple/prop4_Ph_der.mo:167:3-170:49:writable] Warning: du2satp_der was used before it was defined (given a value). Additional such uses may exist for the variable, but some messages were suppressed. Notification: Performance of NFTyping.typeClassSections: time 0.02314/1.838, allocations: 10.05 MB / 0.6126 GB, free: 0.9258 MB / 478.1 MB Notification: Performance of NFFlatten.flatten: time 0.0006071/1.838, allocations: 0.4926 MB / 0.6131 GB, free: 0.6406 MB / 478.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0001905/1.838, allocations: 156.5 kB / 0.6132 GB, free: 0.5469 MB / 478.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0002393/1.839, allocations: 238.5 kB / 0.6135 GB, free: 424 kB / 478.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0002694/1.839, allocations: 313.7 kB / 0.6138 GB, free: 272 kB / 478.1 MB Notification: Performance of NFPackage.collectConstants: time 4.007e-05/1.839, allocations: 25.25 kB / 0.6138 GB, free: 272 kB / 478.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.03217/1.871, allocations: 18.06 MB / 0.6314 GB, free: 304 kB / 494.1 MB Notification: Performance of NFScalarize.scalarize: time 0.000276/1.871, allocations: 172.2 kB / 0.6316 GB, free: 132 kB / 494.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0003815/1.872, allocations: 274.2 kB / 0.6319 GB, free: 15.86 MB / 0.4981 GB Notification: Performance of NFConvertDAE.convert: time 0.01988/1.892, allocations: 8.88 MB / 0.6405 GB, free: 6.953 MB / 0.4981 GB Notification: Performance of FrontEnd - DAE generated: time 5.41e-06/1.892, allocations: 0.5312 kB / 0.6405 GB, free: 6.953 MB / 0.4981 GB Notification: Performance of FrontEnd: time 2.194e-06/1.892, allocations: 0 / 0.6405 GB, free: 6.953 MB / 0.4981 GB Notification: Performance of Transformations before backend: time 1.982e-05/1.892, allocations: 3.531 kB / 0.6405 GB, free: 6.953 MB / 0.4981 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 89 * Number of variables: 89 Notification: Performance of Generate backend data structure: time 0.004488/1.896, allocations: 1.883 MB / 0.6424 GB, free: 5.012 MB / 0.4981 GB Notification: Performance of prepare preOptimizeDAE: time 4.553e-05/1.896, allocations: 12.02 kB / 0.6424 GB, free: 5 MB / 0.4981 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0001275/1.896, allocations: 76.61 kB / 0.6425 GB, free: 4.926 MB / 0.4981 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.000664/1.897, allocations: 0.4909 MB / 0.6429 GB, free: 4.391 MB / 0.4981 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.32e-05/1.897, allocations: 16.56 kB / 0.6429 GB, free: 4.371 MB / 0.4981 GB Notification: Performance of preOpt expandDerOperator (simulation): time 3.756e-05/1.897, allocations: 24 kB / 0.643 GB, free: 4.348 MB / 0.4981 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0006093/1.898, allocations: 433.4 kB / 0.6434 GB, free: 3.895 MB / 0.4981 GB Notification: Performance of preOpt findStateOrder (simulation): time 1.118e-05/1.898, allocations: 0 / 0.6434 GB, free: 3.895 MB / 0.4981 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 2.61e-05/1.898, allocations: 12 kB / 0.6434 GB, free: 3.883 MB / 0.4981 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.858e-05/1.898, allocations: 16.61 kB / 0.6434 GB, free: 3.867 MB / 0.4981 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0004719/1.898, allocations: 346.6 kB / 0.6437 GB, free: 3.531 MB / 0.4981 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.03781/1.936, allocations: 18.71 MB / 0.662 GB, free: 15 MB / 0.5294 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0006009/1.937, allocations: 146.6 kB / 0.6622 GB, free: 14.84 MB / 0.5294 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0001339/1.937, allocations: 78.25 kB / 0.6622 GB, free: 14.77 MB / 0.5294 GB Notification: Performance of preOpt evalFunc (simulation): time 0.1536/2.09, allocations: 77.92 MB / 0.7383 GB, free: 8.031 MB / 0.6075 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.353e-05/2.09, allocations: 34.56 kB / 0.7384 GB, free: 7.988 MB / 0.6075 GB Notification: Performance of pre-optimization done (n=38): time 2.134e-06/2.09, allocations: 0 / 0.7384 GB, free: 7.988 MB / 0.6075 GB Notification: Performance of matching and sorting (n=38): time 0.001863/2.092, allocations: 0.5882 MB / 0.7389 GB, free: 7.375 MB / 0.6075 GB Notification: Performance of inlineWhenForInitialization (initialization): time 7.268e-05/2.092, allocations: 110.8 kB / 0.739 GB, free: 7.242 MB / 0.6075 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001424/2.094, allocations: 1.008 MB / 0.74 GB, free: 6.223 MB / 0.6075 GB Notification: Performance of collectPreVariables (initialization): time 2.432e-05/2.094, allocations: 29.7 kB / 0.7401 GB, free: 6.188 MB / 0.6075 GB Notification: Performance of collectInitialEqns (initialization): time 0.0002656/2.094, allocations: 304.5 kB / 0.7403 GB, free: 5.887 MB / 0.6075 GB Notification: Performance of collectInitialBindings (initialization): time 0.0001165/2.094, allocations: 138.7 kB / 0.7405 GB, free: 5.75 MB / 0.6075 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001091/2.094, allocations: 61.69 kB / 0.7405 GB, free: 5.684 MB / 0.6075 GB Notification: Performance of setup shared object (initialization): time 0.0002/2.095, allocations: 378.8 kB / 0.7409 GB, free: 5.305 MB / 0.6075 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002114/2.095, allocations: 160.4 kB / 0.741 GB, free: 5.148 MB / 0.6075 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0002889/2.095, allocations: 236.6 kB / 0.7413 GB, free: 4.891 MB / 0.6075 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0004357/2.095, allocations: 345.3 kB / 0.7416 GB, free: 4.527 MB / 0.6075 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.158e-06/2.095, allocations: 1.375 kB / 0.7416 GB, free: 4.527 MB / 0.6075 GB Notification: Performance of matching and sorting (n=52) (initialization): time 0.0008214/2.096, allocations: 0.5311 MB / 0.7421 GB, free: 3.988 MB / 0.6075 GB Notification: Performance of prepare postOptimizeDAE: time 1.918e-05/2.096, allocations: 7.938 kB / 0.7421 GB, free: 3.98 MB / 0.6075 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.676e-06/2.096, allocations: 4 kB / 0.7421 GB, free: 3.977 MB / 0.6075 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.001613/2.098, allocations: 217.3 kB / 0.7423 GB, free: 3.762 MB / 0.6075 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 8.292e-05/2.098, allocations: 19.98 kB / 0.7424 GB, free: 3.742 MB / 0.6075 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007166/2.099, allocations: 0.6701 MB / 0.743 GB, free: 3.047 MB / 0.6075 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002473/2.099, allocations: 47.78 kB / 0.7431 GB, free: 3 MB / 0.6075 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 2.562e-05/2.099, allocations: 15.98 kB / 0.7431 GB, free: 2.984 MB / 0.6075 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 8 * Number of states: 0 () * Number of discrete variables: 4 (Bend.C2.b,Bend.C1.a,SinkP1.C.a,SourceP1.C.b) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (18): * Single equations (assignments): 15 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 2 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * 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): 1 system {(1,7)} Notification: Performance of prepare postOptimizeDAE: time 0.0002754/2.099, allocations: 249.6 kB / 0.7433 GB, free: 2.73 MB / 0.6075 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001154/2.099, allocations: 63.58 kB / 0.7434 GB, free: 2.668 MB / 0.6075 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.000884/2.1, allocations: 0.6763 MB / 0.744 GB, free: 1.918 MB / 0.6075 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.000405/2.101, allocations: 251.6 kB / 0.7443 GB, free: 1.664 MB / 0.6075 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 5.059e-06/2.101, allocations: 0.9375 kB / 0.7443 GB, free: 1.664 MB / 0.6075 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.038e-06/2.101, allocations: 0 / 0.7443 GB, free: 1.664 MB / 0.6075 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001337/2.102, allocations: 0.9699 MB / 0.7452 GB, free: 0.6367 MB / 0.6075 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.254e-06/2.102, allocations: 0 / 0.7452 GB, free: 0.6367 MB / 0.6075 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 5.662e-05/2.102, allocations: 19.98 kB / 0.7452 GB, free: 0.6172 MB / 0.6075 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0008762/2.103, allocations: 177.4 kB / 0.7454 GB, free: 452 kB / 0.6075 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.402e-05/2.103, allocations: 4.875 kB / 0.7454 GB, free: 448 kB / 0.6075 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0006736/2.104, allocations: 0.706 MB / 0.7461 GB, free: 15.71 MB / 0.6231 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.874e-06/2.104, allocations: 1.406 kB / 0.7461 GB, free: 15.71 MB / 0.6231 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0005093/2.104, allocations: 413.6 kB / 0.7465 GB, free: 15.28 MB / 0.6231 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0001996/2.104, allocations: 173.2 kB / 0.7467 GB, free: 15.09 MB / 0.6231 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 6.074e-05/2.104, allocations: 11.95 kB / 0.7467 GB, free: 15.08 MB / 0.6231 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002029/2.105, allocations: 16.05 kB / 0.7467 GB, free: 15.07 MB / 0.6231 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 4.005e-05/2.105, allocations: 17.67 kB / 0.7467 GB, free: 15.05 MB / 0.6231 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 1.447e-05/2.105, allocations: 8 kB / 0.7467 GB, free: 15.04 MB / 0.6231 GB Notification: Performance of sorting global known variables: time 0.0009356/2.106, allocations: 0.8114 MB / 0.7475 GB, free: 14.24 MB / 0.6231 GB Notification: Performance of sort global known variables: time 1.01e-07/2.106, allocations: 0 / 0.7475 GB, free: 14.24 MB / 0.6231 GB Notification: Performance of remove unused functions: time 0.003065/2.109, allocations: 1.274 MB / 0.7488 GB, free: 12.96 MB / 0.6231 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 2 * 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 simulation (12): * Single equations (assignments): 11 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * 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): 1 system {(1,8)} Notification: Performance of Backend phase and start with SimCode phase: time 0.004356/2.113, allocations: 1.797 MB / 0.7505 GB, free: 11.18 MB / 0.6231 GB Notification: Performance of simCode: created initialization part: time 0.000699/2.114, allocations: 335.5 kB / 0.7508 GB, free: 10.85 MB / 0.6231 GB Notification: Performance of simCode: created event and clocks part: time 3.096e-06/2.114, allocations: 448 / 0.7508 GB, free: 10.85 MB / 0.6231 GB Notification: Performance of simCode: created simulation system equations: time 0.0002814/2.114, allocations: 105.7 kB / 0.7509 GB, free: 10.75 MB / 0.6231 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.000753/2.115, allocations: 149.2 kB / 0.7511 GB, free: 10.62 MB / 0.6231 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.001733/2.117, allocations: 1.178 MB / 0.7522 GB, free: 9.398 MB / 0.6231 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005818/2.117, allocations: 0.9338 MB / 0.7531 GB, free: 8.441 MB / 0.6231 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 6.348e-05/2.117, allocations: 31.44 kB / 0.7532 GB, free: 8.41 MB / 0.6231 GB Notification: Performance of SimCode: time 3.8e-07/2.117, allocations: 3.938 kB / 0.7532 GB, free: 8.406 MB / 0.6231 GB Notification: Performance of Templates: time 0.04409/2.161, allocations: 29.89 MB / 0.7824 GB, free: 10.96 MB / 0.6544 GB [Timeout remaining time 658] make -j1 -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend.makefile [Timeout 660] (rm -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend.pipe >> ../files/ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend.sim & ./ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestBend.pipe 2>&1) [Timeout 480]