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.8303/0.8303, allocations: 153.8 MB / 173.4 MB, free: 4.875 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: "" <> buildModelFMU(ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser,fileNamePrefix="ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestSimpleStaticCondenser",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser,fileNamePrefix="ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestSimpleStaticCondenser",fmuType="cs",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.0004955/0.0004955, allocations: 11.98 kB / 250.6 MB, free: 4.395 MB / 206.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1749/0.1754, allocations: 33.36 MB / 283.9 MB, free: 1.934 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.816/1.991, allocations: 308.5 MB / 0.5786 GB, free: 17.28 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02277/2.014, allocations: 21.56 MB / 0.5996 GB, free: 8.125 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0004812/2.015, allocations: 5 kB / 0.5996 GB, free: 8.125 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.0005369/2.015, allocations: 205.1 kB / 0.5998 GB, free: 8.027 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0005283/2.016, allocations: 321.6 kB / 0.6001 GB, free: 7.809 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.01754/2.033, allocations: 7.433 MB / 0.6074 GB, free: 4.34 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.001105/2.034, allocations: 0.8784 MB / 0.6083 GB, free: 3.797 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002725/2.035, allocations: 191.2 kB / 0.6084 GB, free: 3.664 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0004415/2.035, allocations: 363.1 kB / 0.6088 GB, free: 3.453 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00025/2.035, allocations: 269.5 kB / 0.609 GB, free: 3.285 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 5.293e-05/2.035, allocations: 39.72 kB / 0.6091 GB, free: 3.285 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02831/2.064, allocations: 15.96 MB / 0.6247 GB, free: 5.141 MB / 494.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001852/2.064, allocations: 99.52 kB / 0.6248 GB, free: 5.043 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0005161/2.064, allocations: 259.5 kB / 0.625 GB, free: 4.789 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01712/2.081, allocations: 7.108 MB / 0.632 GB, free: 13.66 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 6.963e-06/2.081, allocations: 0.625 kB / 0.632 GB, free: 13.66 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 2.305e-06/2.081, allocations: 5.219 kB / 0.632 GB, free: 13.66 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 3.276e-05/2.081, allocations: 0 / 0.632 GB, free: 13.66 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.004337/2.086, allocations: 1.445 MB / 0.6334 GB, free: 12.18 MB / 0.4981 GB
Notification: Performance of prepare preOptimizeDAE: time 4.814e-05/2.086, allocations: 13.06 kB / 0.6334 GB, free: 12.16 MB / 0.4981 GB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 3.294e-05/2.086, allocations: 13.88 kB / 0.6334 GB, free: 12.15 MB / 0.4981 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001403/2.086, allocations: 119.2 kB / 0.6335 GB, free: 12.02 MB / 0.4981 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0001275/2.086, allocations: 74.52 kB / 0.6336 GB, free: 11.95 MB / 0.4981 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0003915/2.087, allocations: 258.8 kB / 0.6338 GB, free: 11.68 MB / 0.4981 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.933e-05/2.087, allocations: 29.38 kB / 0.6339 GB, free: 11.65 MB / 0.4981 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 5.821e-05/2.087, allocations: 39.94 kB / 0.6339 GB, free: 11.61 MB / 0.4981 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001052/2.088, allocations: 0.7027 MB / 0.6346 GB, free: 10.87 MB / 0.4981 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.629e-05/2.088, allocations: 3.266 kB / 0.6346 GB, free: 10.87 MB / 0.4981 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.454e-05/2.088, allocations: 16 kB / 0.6346 GB, free: 10.85 MB / 0.4981 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.968e-05/2.088, allocations: 39.95 kB / 0.6346 GB, free: 10.81 MB / 0.4981 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0006967/2.088, allocations: 465 kB / 0.6351 GB, free: 10.36 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.07087/2.159, allocations: 21.78 MB / 0.6563 GB, free: 4.508 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0006902/2.16, allocations: 287.6 kB / 0.6566 GB, free: 4.219 MB / 0.5137 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003489/2.16, allocations: 224.2 kB / 0.6568 GB, free: 4 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.08253/2.243, allocations: 23.85 MB / 0.6801 GB, free: 12.12 MB / 0.545 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.121e-05/2.243, allocations: 38.5 kB / 0.6802 GB, free: 12.07 MB / 0.545 GB
Notification: Performance of pre-optimization done (n=124): time 2.575e-06/2.243, allocations: 0 / 0.6802 GB, free: 12.07 MB / 0.545 GB
Notification: Performance of matching and sorting (n=124): time 0.002445/2.245, allocations: 1.058 MB / 0.6812 GB, free: 11 MB / 0.545 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.319e-05/2.245, allocations: 55.41 kB / 0.6813 GB, free: 10.94 MB / 0.545 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0004726/2.246, allocations: 324.5 kB / 0.6816 GB, free: 10.62 MB / 0.545 GB
Notification: Performance of collectPreVariables (initialization): time 3.304e-05/2.246, allocations: 33.7 kB / 0.6816 GB, free: 10.58 MB / 0.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002159/2.246, allocations: 217.8 kB / 0.6818 GB, free: 10.36 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000432/2.247, allocations: 416.1 kB / 0.6822 GB, free: 9.949 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001724/2.247, allocations: 117.6 kB / 0.6823 GB, free: 9.828 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 0.000192/2.247, allocations: 367.9 kB / 0.6827 GB, free: 9.461 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003394/2.247, allocations: 229.2 kB / 0.6829 GB, free: 9.238 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004701/2.248, allocations: 328.6 kB / 0.6832 GB, free: 8.891 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0008009/2.249, allocations: 0.6331 MB / 0.6838 GB, free: 8.234 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.59e-06/2.249, allocations: 3.938 kB / 0.6838 GB, free: 8.23 MB / 0.545 GB
Notification: Performance of matching and sorting (n=138) (initialization): time 0.001198/2.25, allocations: 0.7699 MB / 0.6846 GB, free: 7.445 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 2.115e-05/2.25, allocations: 12 kB / 0.6846 GB, free: 7.434 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.772e-05/2.25, allocations: 4.547 kB / 0.6846 GB, free: 7.43 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001783/2.252, allocations: 334.5 kB / 0.6849 GB, free: 7.098 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 6.566e-05/2.252, allocations: 19.94 kB / 0.6849 GB, free: 7.078 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001262/2.253, allocations: 1.289 MB / 0.6862 GB, free: 5.738 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002606/2.253, allocations: 80 kB / 0.6863 GB, free: 5.66 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.367e-05/2.253, allocations: 13 kB / 0.6863 GB, free: 5.648 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.0002358/2.253, allocations: 175.3 kB / 0.6864 GB, free: 5.469 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 9.348e-05/2.254, allocations: 55.58 kB / 0.6865 GB, free: 5.414 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00434/2.258, allocations: 4.032 MB / 0.6904 GB, free: 1.211 MB / 0.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.001182/2.259, allocations: 0.8234 MB / 0.6912 GB, free: 380 kB / 0.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.212e-05/2.259, allocations: 7.922 kB / 0.6912 GB, free: 372 kB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.136e-05/2.259, allocations: 6.609 kB / 0.6912 GB, free: 368 kB / 0.545 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00334/2.262, allocations: 2.012 MB / 0.6932 GB, free: 14.29 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.1e-06/2.262, allocations: 0 / 0.6932 GB, free: 14.29 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002522/2.263, allocations: 96.47 kB / 0.6933 GB, free: 14.2 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0008043/2.263, allocations: 238.6 kB / 0.6935 GB, free: 13.96 MB / 0.5606 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.17e-05/2.264, allocations: 16 kB / 0.6935 GB, free: 13.94 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001222/2.265, allocations: 1.341 MB / 0.6949 GB, free: 12.55 MB / 0.5606 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.135e-06/2.265, allocations: 2.062 kB / 0.6949 GB, free: 12.55 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001507/2.266, allocations: 0.9784 MB / 0.6958 GB, free: 11.55 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002083/2.266, allocations: 119.2 kB / 0.6959 GB, free: 11.43 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001009/2.267, allocations: 31.78 kB / 0.696 GB, free: 11.4 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002401/2.267, allocations: 16 kB / 0.696 GB, free: 11.39 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.005e-05/2.267, allocations: 44.5 kB / 0.696 GB, free: 11.34 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.076e-05/2.267, allocations: 20 kB / 0.696 GB, free: 11.32 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.0005021/2.267, allocations: 418.8 kB / 0.6964 GB, free: 10.91 MB / 0.5606 GB
Notification: Performance of sort global known variables: time 1e-07/2.267, allocations: 0 / 0.6964 GB, free: 10.91 MB / 0.5606 GB
Notification: Performance of remove unused functions: time 0.002676/2.27, allocations: 1.01 MB / 0.6974 GB, free: 9.902 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.006143/2.276, allocations: 2.598 MB / 0.7 GB, free: 7.301 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.001573/2.278, allocations: 0.9418 MB / 0.7009 GB, free: 6.316 MB / 0.5606 GB
Notification: Performance of simCode: created event and clocks part: time 2.915e-06/2.278, allocations: 0 / 0.7009 GB, free: 6.316 MB / 0.5606 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005652/2.278, allocations: 360.2 kB / 0.7012 GB, free: 5.965 MB / 0.5606 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00205/2.28, allocations: 436 kB / 0.7016 GB, free: 5.598 MB / 0.5606 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008519/2.289, allocations: 5.765 MB / 0.7073 GB, free: 15.69 MB / 0.5762 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0003946/2.289, allocations: 396.3 kB / 0.7076 GB, free: 15.27 MB / 0.5762 GB
Notification: Performance of simCode: alias equations: time 0.0002972/2.29, allocations: 72.94 kB / 0.7077 GB, free: 15.21 MB / 0.5762 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003432/2.29, allocations: 307.3 kB / 0.708 GB, free: 14.91 MB / 0.5762 GB
Notification: Performance of SimCode: time 8.11e-07/2.29, allocations: 4 kB / 0.708 GB, free: 14.91 MB / 0.5762 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.09662/2.387, allocations: 56.29 MB / 0.763 GB, free: 7.703 MB / 0.6231 GB
Notification: Performance of buildModelFMU: Generate platform static: time 15.99/18.37, allocations: 7.656 kB / 0.763 GB, free: 7.699 MB / 0.6231 GB
"
[Timeout remaining time 641]
(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 & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestSimpleStaticCondenser_fmu --startTime=0 --stopTime=1000 --stepSize=0.4 --timeout=50 --tolerance=1e-06 ThermoSysPro_ThermoSysPro_Examples_SimpleExamples_TestSimpleStaticCondenser.fmu > ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestSimpleStaticCondenser.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 20.373701813980006]
Failed to read output from testmodel.py, exit status != 0:
18.935171794029884 18.945397546 16.861594687
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc22d0173a0>