Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/package.mo): time 0.8578/0.8578, allocations: 153.8 MB / 173.4 MB, free: 4.93 MB / 142.1 MB " [Timeout remaining time 179] Using package ThermoSysPro with version 4.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/package.mo) Running command: translateModel(ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff") translateModel(ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 0.0005227/0.0005227, allocations: 19.97 kB / 251.1 MB, free: 3.945 MB / 206.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1576/0.1582, allocations: 33.36 MB / 284.5 MB, free: 2.133 MB / 222.1 MB Notification: Automatically loaded package Complex 4.1.0 due to uses annotation from Modelica. Notification: Automatically loaded package ModelicaServices 4.1.0 due to uses annotation from Modelica. Notification: Automatically loaded package Modelica 4.1.0 due to usage. Notification: Performance of NFInst.instantiate(ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff): time 1.825/1.983, allocations: 308.8 MB / 0.5794 GB, free: 16.14 MB / 478.1 MB Notification: Performance of NFInst.instExpressions: time 0.02418/2.008, allocations: 23.98 MB / 0.6028 GB, free: 5.332 MB / 478.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0004259/2.008, allocations: 5.062 kB / 0.6028 GB, free: 5.332 MB / 478.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/WaterSteam/BoundaryConditions/SourceQ.mo:24:3-25:52: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 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 master/WaterSteam/BoundaryConditions/SourceQ.mo:24:3-25:52: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 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 master/WaterSteam/HeatExchangers/StaticWaterWaterExchangerDTorWorEff.mo:69:3-71:37:writable] Warning: Connector Ec 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 master/WaterSteam/HeatExchangers/StaticWaterWaterExchangerDTorWorEff.mo:72:3-74:42:writable] Warning: Connector Ef 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 master/WaterSteam/HeatExchangers/StaticWaterWaterExchangerDTorWorEff.mo:75:3-77:37:writable] Warning: Connector Sf 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 master/WaterSteam/HeatExchangers/StaticWaterWaterExchangerDTorWorEff.mo:78:3-80:36:writable] Warning: Connector Sc 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.000582/2.009, allocations: 278.5 kB / 0.603 GB, free: 5.199 MB / 478.1 MB Notification: Performance of NFTyping.typeBindings: time 0.0004053/2.009, allocations: 280.9 kB / 0.6033 GB, free: 5.008 MB / 478.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 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 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 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. Notification: Performance of NFTyping.typeClassSections: time 0.01814/2.027, allocations: 7.713 MB / 0.6108 GB, free: 1.395 MB / 478.1 MB Notification: Performance of NFFlatten.flatten: time 0.0009749/2.028, allocations: 0.8111 MB / 0.6116 GB, free: 0.8945 MB / 478.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0002719/2.028, allocations: 188.8 kB / 0.6118 GB, free: 0.7656 MB / 478.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0004208/2.029, allocations: 340.6 kB / 0.6121 GB, free: 0.5664 MB / 478.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0002674/2.029, allocations: 254.6 kB / 0.6124 GB, free: 412 kB / 478.1 MB Notification: Performance of NFPackage.collectConstants: time 5.501e-05/2.029, allocations: 40.44 kB / 0.6124 GB, free: 412 kB / 478.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.03155/2.061, allocations: 17.18 MB / 0.6292 GB, free: 1.141 MB / 494.1 MB Notification: Performance of NFScalarize.scalarize: time 0.0001694/2.061, allocations: 103.5 kB / 0.6293 GB, free: 1.039 MB / 494.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0005122/2.061, allocations: 290.5 kB / 0.6296 GB, free: 0.7539 MB / 494.1 MB Notification: Performance of NFConvertDAE.convert: time 0.01837/2.08, allocations: 7.223 MB / 0.6366 GB, free: 9.512 MB / 0.4981 GB Notification: Performance of FrontEnd - DAE generated: time 7.013e-06/2.08, allocations: 0 / 0.6366 GB, free: 9.512 MB / 0.4981 GB Notification: Performance of FrontEnd: time 1.513e-06/2.08, allocations: 0 / 0.6366 GB, free: 9.512 MB / 0.4981 GB Notification: Performance of Transformations before backend: time 9.227e-06/2.08, allocations: 0 / 0.6366 GB, free: 9.512 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: 178 * Number of variables: 178 Notification: Performance of Generate backend data structure: time 0.004216/2.084, allocations: 1.417 MB / 0.638 GB, free: 8.062 MB / 0.4981 GB Notification: Performance of prepare preOptimizeDAE: time 4.415e-05/2.084, allocations: 8.781 kB / 0.638 GB, free: 8.055 MB / 0.4981 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0001159/2.084, allocations: 64.52 kB / 0.6381 GB, free: 7.992 MB / 0.4981 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0003626/2.084, allocations: 250.9 kB / 0.6383 GB, free: 7.723 MB / 0.4981 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001714/2.085, allocations: 119.5 kB / 0.6384 GB, free: 7.59 MB / 0.4981 GB Notification: Performance of preOpt expandDerOperator (simulation): time 6.064e-05/2.085, allocations: 40.12 kB / 0.6385 GB, free: 7.551 MB / 0.4981 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0009784/2.086, allocations: 0.6446 MB / 0.6391 GB, free: 6.875 MB / 0.4981 GB Notification: Performance of preOpt findStateOrder (simulation): time 1.498e-05/2.086, allocations: 0 / 0.6391 GB, free: 6.875 MB / 0.4981 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 3.847e-05/2.086, allocations: 20.05 kB / 0.6391 GB, free: 6.859 MB / 0.4981 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.532e-05/2.086, allocations: 27.97 kB / 0.6391 GB, free: 6.832 MB / 0.4981 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0007729/2.087, allocations: 450.9 kB / 0.6396 GB, free: 6.395 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.03784/2.124, allocations: 12.57 MB / 0.6518 GB, free: 9.629 MB / 0.5137 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0006854/2.125, allocations: 279.8 kB / 0.6521 GB, free: 9.348 MB / 0.5137 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0004224/2.125, allocations: 211.8 kB / 0.6523 GB, free: 9.141 MB / 0.5137 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0916/2.217, allocations: 25.77 MB / 0.6775 GB, free: 15.34 MB / 0.545 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.421e-05/2.217, allocations: 38.55 kB / 0.6775 GB, free: 15.29 MB / 0.545 GB Notification: Performance of pre-optimization done (n=103): time 2.755e-06/2.217, allocations: 0 / 0.6775 GB, free: 15.29 MB / 0.545 GB Notification: Performance of matching and sorting (n=103): time 0.004962/2.222, allocations: 1.343 MB / 0.6788 GB, free: 13.94 MB / 0.545 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.925e-05/2.222, allocations: 59.39 kB / 0.6789 GB, free: 13.87 MB / 0.545 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0005027/2.223, allocations: 345.5 kB / 0.6792 GB, free: 13.52 MB / 0.545 GB Notification: Performance of collectPreVariables (initialization): time 3.403e-05/2.223, allocations: 33.64 kB / 0.6792 GB, free: 13.48 MB / 0.545 GB Notification: Performance of collectInitialEqns (initialization): time 0.0001704/2.223, allocations: 205.6 kB / 0.6794 GB, free: 13.28 MB / 0.545 GB Notification: Performance of collectInitialBindings (initialization): time 0.0003092/2.223, allocations: 344.8 kB / 0.6798 GB, free: 12.94 MB / 0.545 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001637/2.223, allocations: 101.6 kB / 0.6799 GB, free: 12.84 MB / 0.545 GB Notification: Performance of setup shared object (initialization): time 0.000191/2.223, allocations: 366.8 kB / 0.6802 GB, free: 12.47 MB / 0.545 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004032/2.224, allocations: 200.9 kB / 0.6804 GB, free: 12.27 MB / 0.545 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004773/2.224, allocations: 290.5 kB / 0.6807 GB, free: 11.96 MB / 0.545 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0009838/2.225, allocations: 0.5608 MB / 0.6812 GB, free: 11.38 MB / 0.545 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.618e-06/2.225, allocations: 0 / 0.6812 GB, free: 11.38 MB / 0.545 GB Notification: Performance of matching and sorting (n=114) (initialization): time 0.001426/2.227, allocations: 0.7387 MB / 0.682 GB, free: 10.62 MB / 0.545 GB Notification: Performance of prepare postOptimizeDAE: time 2.166e-05/2.227, allocations: 8.766 kB / 0.682 GB, free: 10.61 MB / 0.545 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.344e-05/2.227, allocations: 4 kB / 0.682 GB, free: 10.61 MB / 0.545 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.002203/2.229, allocations: 0.7164 MB / 0.6827 GB, free: 9.895 MB / 0.545 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 6.061e-05/2.229, allocations: 8 kB / 0.6827 GB, free: 9.887 MB / 0.545 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001867/2.231, allocations: 1.058 MB / 0.6837 GB, free: 8.809 MB / 0.545 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0003141/2.231, allocations: 80.16 kB / 0.6838 GB, free: 8.73 MB / 0.545 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.447e-05/2.231, allocations: 12 kB / 0.6838 GB, free: 8.719 MB / 0.545 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 10 * Number of states: 0 () * Number of discrete variables: 8 (exchangerWaterSteamDTorWorEFF.Sc.b,exchangerWaterSteamDTorWorEFF.Sf.b,exchangerWaterSteamDTorWorEFF.Ef.a,exchangerWaterSteamDTorWorEFF.Ec.a,sinkWaterSteam_FC.C.a,sourceWaterSteam_FC.C.b,sinkWaterSteam_FF.C.a,sourceWaterSteam_FF.C.b) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (17): * Single equations (assignments): 11 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 5 * 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 {(5,12)} Notification: Performance of prepare postOptimizeDAE: time 0.0002239/2.232, allocations: 174.7 kB / 0.684 GB, free: 8.539 MB / 0.545 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000105/2.232, allocations: 51.62 kB / 0.684 GB, free: 8.488 MB / 0.545 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002721/2.234, allocations: 2.026 MB / 0.686 GB, free: 6.398 MB / 0.545 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.001621/2.236, allocations: 0.991 MB / 0.687 GB, free: 5.398 MB / 0.545 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 6.582e-06/2.236, allocations: 0 / 0.687 GB, free: 5.398 MB / 0.545 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.568e-06/2.236, allocations: 3.984 kB / 0.687 GB, free: 5.395 MB / 0.545 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003742/2.24, allocations: 2.265 MB / 0.6892 GB, free: 3.074 MB / 0.545 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.473e-06/2.24, allocations: 4 kB / 0.6892 GB, free: 3.07 MB / 0.545 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000285/2.24, allocations: 91.91 kB / 0.6893 GB, free: 2.98 MB / 0.545 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0008344/2.241, allocations: 497.7 kB / 0.6897 GB, free: 2.492 MB / 0.545 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.696e-05/2.241, allocations: 13.88 kB / 0.6898 GB, free: 2.48 MB / 0.545 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001693/2.243, allocations: 1.132 MB / 0.6909 GB, free: 1.316 MB / 0.545 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.944e-06/2.243, allocations: 0 / 0.6909 GB, free: 1.316 MB / 0.545 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001765/2.244, allocations: 1.121 MB / 0.692 GB, free: 184 kB / 0.545 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0002916/2.245, allocations: 127.2 kB / 0.6921 GB, free: 56 kB / 0.545 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001013/2.245, allocations: 19.89 kB / 0.6921 GB, free: 36 kB / 0.545 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002964/2.245, allocations: 21.44 kB / 0.6921 GB, free: 16 kB / 0.545 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001213/2.245, allocations: 56.55 kB / 0.6922 GB, free: 15.96 MB / 0.5606 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.17e-05/2.245, allocations: 19.98 kB / 0.6922 GB, free: 15.94 MB / 0.5606 GB Notification: Performance of sorting global known variables: time 0.0003901/2.246, allocations: 319.1 kB / 0.6925 GB, free: 15.63 MB / 0.5606 GB Notification: Performance of sort global known variables: time 9e-08/2.246, allocations: 1.031 kB / 0.6925 GB, free: 15.63 MB / 0.5606 GB Notification: Performance of remove unused functions: time 0.002728/2.248, allocations: 0.9825 MB / 0.6935 GB, free: 14.64 MB / 0.5606 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * 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 (64): * Single equations (assignments): 60 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 3 * 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 {(5,12)} Notification: Performance of Backend phase and start with SimCode phase: time 0.004425/2.253, allocations: 1.155 MB / 0.6946 GB, free: 13.5 MB / 0.5606 GB Notification: Performance of simCode: created initialization part: time 0.002119/2.255, allocations: 0.9539 MB / 0.6955 GB, free: 12.52 MB / 0.5606 GB Notification: Performance of simCode: created event and clocks part: time 3.607e-06/2.255, allocations: 0 / 0.6955 GB, free: 12.52 MB / 0.5606 GB Notification: Performance of simCode: created simulation system equations: time 0.001122/2.256, allocations: 443.1 kB / 0.6959 GB, free: 12.08 MB / 0.5606 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001964/2.258, allocations: 395.3 kB / 0.6963 GB, free: 11.75 MB / 0.5606 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002396/2.26, allocations: 1.468 MB / 0.6977 GB, free: 10.26 MB / 0.5606 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006606/2.261, allocations: 0.9671 MB / 0.6987 GB, free: 9.262 MB / 0.5606 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 8.497e-05/2.261, allocations: 43.44 kB / 0.6987 GB, free: 9.219 MB / 0.5606 GB Notification: Performance of SimCode: time 8.42e-07/2.261, allocations: 0 / 0.6987 GB, free: 9.219 MB / 0.5606 GB Notification: Performance of Templates: time 0.04224/2.303, allocations: 26.93 MB / 0.725 GB, free: 14.84 MB / 0.5919 GB " [Timeout remaining time 658] make -j1 -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff.makefile [Timeout 660] (rm -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff.pipe >> ../files/ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff.sim & ./ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestStaticWaterWaterExchangerDTorWorEff.pipe 2>&1) [Timeout 480] [Calling sys.exit(0), Time elapsed: 10.787864461075515] Failed to read output from testmodel.py, exit status != 0: 2.4682962498627603 2.483923424 0.400884687 Calling exit ...