Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser.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.8688/0.8688, allocations: 153.8 MB / 173.4 MB, free: 4.879 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.TestSimpleStaticCondenser,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser")
translateModel(ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.0005534/0.0005534, allocations: 15.97 kB / 251 MB, free: 3.852 MB / 206.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1532/0.1538, allocations: 33.36 MB / 284.4 MB, free: 2.035 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.TestSimpleStaticCondenser): time 1.828/1.981, allocations: 308.9 MB / 0.5794 GB, free: 17.26 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02509/2.006, allocations: 21.58 MB / 0.6005 GB, free: 7.918 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005061/2.007, allocations: 6.781 kB / 0.6005 GB, free: 7.918 MB / 478.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro master/WaterSteam/HeatExchangers/SimpleStaticCondenser.mo:58:3-60:44: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/SimpleStaticCondenser.mo:61:3-63: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/SimpleStaticCondenser.mo:64:3-66:36: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/SimpleStaticCondenser.mo:67:3-69:37:writable] Warning: Connector Sc 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/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 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).
Notification: Performance of NFTyping.typeComponents: time 0.0006516/2.008, allocations: 198 kB / 0.6007 GB, free: 7.828 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0009176/2.009, allocations: 322 kB / 0.601 GB, free: 7.609 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.01938/2.028, allocations: 7.423 MB / 0.6082 GB, free: 4.215 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.00111/2.029, allocations: 0.88 MB / 0.6091 GB, free: 3.672 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003355/2.029, allocations: 187 kB / 0.6093 GB, free: 3.543 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005939/2.03, allocations: 373.8 kB / 0.6096 GB, free: 3.324 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000383/2.03, allocations: 240.4 kB / 0.6099 GB, free: 3.184 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 5.744e-05/2.03, allocations: 37.88 kB / 0.6099 GB, free: 3.184 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02683/2.057, allocations: 15.11 MB / 0.6247 GB, free: 5.73 MB / 494.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001652/2.057, allocations: 100.1 kB / 0.6247 GB, free: 5.633 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004878/2.058, allocations: 262.7 kB / 0.625 GB, free: 5.375 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01514/2.073, allocations: 7.109 MB / 0.6319 GB, free: 14.24 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 4.869e-06/2.073, allocations: 0 / 0.6319 GB, free: 14.24 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 1.162e-06/2.073, allocations: 0 / 0.6319 GB, free: 14.24 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 8.726e-06/2.073, allocations: 1.156 kB / 0.6319 GB, free: 14.24 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: 205
 * Number of variables: 205
Notification: Performance of Generate backend data structure: time 0.003483/2.077, allocations: 1.442 MB / 0.6334 GB, free: 12.77 MB / 0.4981 GB
Notification: Performance of prepare preOptimizeDAE: time 3.79e-05/2.077, allocations: 12.03 kB / 0.6334 GB, free: 12.76 MB / 0.4981 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.000114/2.077, allocations: 72.92 kB / 0.6334 GB, free: 12.69 MB / 0.4981 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0003596/2.077, allocations: 262.9 kB / 0.6337 GB, free: 12.41 MB / 0.4981 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.28e-05/2.077, allocations: 30.34 kB / 0.6337 GB, free: 12.38 MB / 0.4981 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 5.928e-05/2.077, allocations: 36.38 kB / 0.6337 GB, free: 12.34 MB / 0.4981 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0009998/2.078, allocations: 0.706 MB / 0.6344 GB, free: 11.59 MB / 0.4981 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.777e-05/2.078, allocations: 4 kB / 0.6344 GB, free: 11.59 MB / 0.4981 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 3.621e-05/2.078, allocations: 16 kB / 0.6345 GB, free: 11.57 MB / 0.4981 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.553e-05/2.078, allocations: 33.09 kB / 0.6345 GB, free: 11.54 MB / 0.4981 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0006905/2.079, allocations: 472.6 kB / 0.6349 GB, free: 11.07 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.07467/2.154, allocations: 21.64 MB / 0.6561 GB, free: 5.387 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0006335/2.154, allocations: 299.7 kB / 0.6564 GB, free: 5.086 MB / 0.5137 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003214/2.155, allocations: 215.5 kB / 0.6566 GB, free: 4.875 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.08699/2.242, allocations: 23.86 MB / 0.6799 GB, free: 13 MB / 0.545 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.59e-05/2.242, allocations: 35.16 kB / 0.6799 GB, free: 12.96 MB / 0.545 GB
Notification: Performance of pre-optimization done (n=124): time 2.415e-06/2.242, allocations: 0 / 0.6799 GB, free: 12.96 MB / 0.545 GB
Notification: Performance of matching and sorting (n=124): time 0.002341/2.244, allocations: 1.049 MB / 0.6809 GB, free: 11.9 MB / 0.545 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.44e-05/2.244, allocations: 55.41 kB / 0.681 GB, free: 11.83 MB / 0.545 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0002821/2.244, allocations: 240.8 kB / 0.6812 GB, free: 11.58 MB / 0.545 GB
Notification: Performance of collectPreVariables (initialization): time 2.724e-05/2.244, allocations: 29.7 kB / 0.6812 GB, free: 11.55 MB / 0.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001681/2.244, allocations: 229.7 kB / 0.6814 GB, free: 11.32 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003228/2.245, allocations: 425 kB / 0.6818 GB, free: 10.9 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001632/2.245, allocations: 117.6 kB / 0.682 GB, free: 10.78 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 0.0001833/2.245, allocations: 362.8 kB / 0.6823 GB, free: 10.41 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003438/2.245, allocations: 229.2 kB / 0.6825 GB, free: 10.19 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004359/2.246, allocations: 332.5 kB / 0.6828 GB, free: 9.84 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0008512/2.247, allocations: 0.6253 MB / 0.6835 GB, free: 9.191 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.555e-06/2.247, allocations: 4 kB / 0.6835 GB, free: 9.188 MB / 0.545 GB
Notification: Performance of matching and sorting (n=138) (initialization): time 0.001191/2.248, allocations: 0.7625 MB / 0.6842 GB, free: 8.414 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 1.573e-05/2.248, allocations: 4 kB / 0.6842 GB, free: 8.41 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.122e-05/2.248, allocations: 4.562 kB / 0.6842 GB, free: 8.406 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001725/2.25, allocations: 342.3 kB / 0.6845 GB, free: 8.066 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 6.541e-05/2.25, allocations: 15.94 kB / 0.6846 GB, free: 8.051 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00123/2.251, allocations: 1.293 MB / 0.6858 GB, free: 6.707 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.000217/2.251, allocations: 63.34 kB / 0.6859 GB, free: 6.645 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 2.895e-05/2.251, allocations: 12 kB / 0.6859 GB, free: 6.633 MB / 0.545 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 9
 * Number of states: 0 ()
 * Number of discrete variables: 8 (sinkP1.C.a,sinkP.C.a,sourceP1.C.b,sourceP.C.b,simpleStaticCondenser.Sc.b,simpleStaticCondenser.Sf.b,simpleStaticCondenser.Ef.a,simpleStaticCondenser.Ec.a)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (26):
 * Single equations (assignments): 15
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 9
 * 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
   {(3,3), (2,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.000223/2.251, allocations: 178.7 kB / 0.6861 GB, free: 6.449 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 8.785e-05/2.252, allocations: 51.61 kB / 0.6861 GB, free: 6.398 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004226/2.256, allocations: 4.043 MB / 0.6901 GB, free: 2.184 MB / 0.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.001211/2.257, allocations: 0.8196 MB / 0.6909 GB, free: 1.348 MB / 0.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.29e-06/2.257, allocations: 0 / 0.6909 GB, free: 1.348 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.275e-06/2.257, allocations: 3.984 kB / 0.6909 GB, free: 1.344 MB / 0.545 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002902/2.26, allocations: 1.921 MB / 0.6927 GB, free: 15.38 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.509e-06/2.26, allocations: 0.9375 kB / 0.6927 GB, free: 15.38 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002694/2.26, allocations: 95.84 kB / 0.6928 GB, free: 15.29 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0007543/2.261, allocations: 243.2 kB / 0.6931 GB, free: 15.04 MB / 0.5606 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.669e-05/2.261, allocations: 15.98 kB / 0.6931 GB, free: 15.03 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001195/2.262, allocations: 1.345 MB / 0.6944 GB, free: 13.63 MB / 0.5606 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.124e-06/2.262, allocations: 0.6875 kB / 0.6944 GB, free: 13.63 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001399/2.264, allocations: 0.9628 MB / 0.6953 GB, free: 12.65 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000183/2.264, allocations: 111.2 kB / 0.6954 GB, free: 12.54 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 8.139e-05/2.264, allocations: 36.66 kB / 0.6955 GB, free: 12.5 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002143/2.264, allocations: 12 kB / 0.6955 GB, free: 12.49 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.601e-05/2.264, allocations: 48.62 kB / 0.6955 GB, free: 12.45 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.083e-05/2.264, allocations: 20.69 kB / 0.6955 GB, free: 12.43 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.0004302/2.265, allocations: 351.1 kB / 0.6959 GB, free: 12.08 MB / 0.5606 GB
Notification: Performance of sort global known variables: time 7e-08/2.265, allocations: 0 / 0.6959 GB, free: 12.08 MB / 0.5606 GB
Notification: Performance of remove unused functions: time 0.002421/2.267, allocations: 1.014 MB / 0.6969 GB, free: 11.07 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 (67):
 * Single equations (assignments): 61
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 4
 * 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
   {(3,4), (2,4)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.003416/2.27, allocations: 1.17 MB / 0.698 GB, free: 9.906 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.001389/2.272, allocations: 0.9483 MB / 0.6989 GB, free: 8.922 MB / 0.5606 GB
Notification: Performance of simCode: created event and clocks part: time 2.114e-06/2.272, allocations: 0 / 0.6989 GB, free: 8.922 MB / 0.5606 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005994/2.272, allocations: 354.4 kB / 0.6993 GB, free: 8.582 MB / 0.5606 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001949/2.274, allocations: 405.2 kB / 0.6997 GB, free: 8.242 MB / 0.5606 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002194/2.277, allocations: 1.51 MB / 0.7011 GB, free: 6.707 MB / 0.5606 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004077/2.277, allocations: 392 kB / 0.7015 GB, free: 6.297 MB / 0.5606 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 7.662e-05/2.277, allocations: 47.44 kB / 0.7016 GB, free: 6.25 MB / 0.5606 GB
Notification: Performance of SimCode: time 4.01e-07/2.277, allocations: 0 / 0.7016 GB, free: 6.25 MB / 0.5606 GB
Notification: Performance of Templates: time 0.04316/2.32, allocations: 31.77 MB / 0.7326 GB, free: 6.965 MB / 0.5919 GB
"
[Timeout remaining time 658]
make -j1 -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser.makefile [Timeout 660]
(rm -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser.pipe >> ../files/ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser.sim & ./ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser  -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 10.735585215967149]
Failed to read output from testmodel.py, exit status != 0:
2.4799429229460657 2.4942855919999998 0.41809241299999994
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc0cd532fe0>