Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo", uses=false)
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.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh")
translateModel(ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo): time 0.8501/0.8501, allocations: 150.9 MB / 167.2 MB, free: 14.5 MB / 142.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003999/0.0004, allocations: 14.86 kB / 237.7 MB, free: 1.812 MB / 190.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.05889/0.05931, allocations: 31.35 MB / 269.1 MB, free: 7.098 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.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh): time 1.795/1.854, allocations: 297.4 MB / 0.5532 GB, free: 10.48 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.547/2.401, allocations: 196.2 MB / 0.7448 GB, free: 1.605 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0009024/2.402, allocations: 20.81 kB / 0.7448 GB, free: 1.605 MB / 0.5919 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/Volumes/VolumeATh.mo:104:3-105:67:writable] Warning: Connector Ce1 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/Volumes/VolumeATh.mo:106:3-108:57:writable] Warning: Connector Ce2 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/Volumes/VolumeATh.mo:109:3-110:73:writable] Warning: Connector Cs1 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/Volumes/VolumeATh.mo:111:3-112:75:writable] Warning: Connector Cs2 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/BoundaryConditions/SinkP.mo:46:3-47:67:writable] Warning: Connector C is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/PressureLosses/ControlValve.mo:44:3-45:68:writable] Warning: Connector C1 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/PressureLosses/ControlValve.mo:46:3-47:66:writable] Warning: Connector C2 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/PressureLosses/ControlValve.mo:44:3-45:68:writable] Warning: Connector C1 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/PressureLosses/ControlValve.mo:46:3-47:66:writable] Warning: Connector C2 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/BoundaryConditions/SourceQ.mo:62:3-63:65:writable] Warning: Connector C is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/BoundaryConditions/SourceP.mo:58:3-59:65:writable] Warning: Connector C is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/PressureLosses/LumpedStraightPipe.mo:54:3-55:67:writable] Warning: Connector C1 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Fluid/PressureLosses/LumpedStraightPipe.mo:56:3-57:65:writable] Warning: Connector C2 is not balanced: The number of potential variables (9) is not equal to the number of flow variables (0).
Notification: Performance of NFTyping.typeComponents: time 0.000477/2.403, allocations: 170.9 kB / 0.745 GB, free: 1.605 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.0008476/2.403, allocations: 401.5 kB / 0.7454 GB, free: 1.602 MB / 0.5919 GB
[/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.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/Properties/Fluid/derDensity_derP_derh.mo:63:5-63:84:writable] Warning: T 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.03636/2.44, allocations: 14.24 MB / 0.7593 GB, free: 1.281 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.001886/2.442, allocations: 1.376 MB / 0.7606 GB, free: 1.277 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0007306/2.442, allocations: 0.7061 MB / 0.7613 GB, free: 1.215 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.000716/2.443, allocations: 0.5478 MB / 0.7618 GB, free: 1.215 MB / 0.5919 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005607/2.444, allocations: 0.6115 MB / 0.7624 GB, free: 1.215 MB / 0.5919 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001282/2.444, allocations: 124.9 kB / 0.7626 GB, free: 1.215 MB / 0.5919 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03664/2.481, allocations: 19.23 MB / 0.7813 GB, free: 15.24 MB / 0.6075 GB
Notification: Performance of NFScalarize.scalarize: time 0.0007381/2.481, allocations: 299.6 kB / 0.7816 GB, free: 15.19 MB / 0.6075 GB
Notification: Performance of NFVerifyModel.verify: time 0.001161/2.483, allocations: 0.6204 MB / 0.7822 GB, free: 15.07 MB / 0.6075 GB
Notification: Performance of NFConvertDAE.convert: time 0.03219/2.515, allocations: 10.96 MB / 0.7929 GB, free: 10.95 MB / 0.6075 GB
Notification: Performance of FrontEnd - DAE generated: time 7.965e-06/2.515, allocations: 3.625 kB / 0.7929 GB, free: 10.95 MB / 0.6075 GB
Notification: Performance of FrontEnd: time 2.004e-06/2.515, allocations: 0 / 0.7929 GB, free: 10.95 MB / 0.6075 GB
Notification: Performance of Transformations before backend: time 7.061e-05/2.515, allocations: 2.312 kB / 0.7929 GB, free: 10.95 MB / 0.6075 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 286
 * Number of variables: 286
Notification: Performance of Generate backend data structure: time 0.00769/2.523, allocations: 2.779 MB / 0.7957 GB, free: 9.176 MB / 0.6075 GB
Notification: Performance of prepare preOptimizeDAE: time 4.72e-05/2.523, allocations: 9.188 kB / 0.7957 GB, free: 9.176 MB / 0.6075 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0003731/2.523, allocations: 149.6 kB / 0.7958 GB, free: 9.102 MB / 0.6075 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001346/2.524, allocations: 0.6587 MB / 0.7965 GB, free: 8.68 MB / 0.6075 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.163e-05/2.524, allocations: 86.81 kB / 0.7965 GB, free: 8.676 MB / 0.6075 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002674/2.525, allocations: 113.5 kB / 0.7966 GB, free: 8.672 MB / 0.6075 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002426/2.527, allocations: 1.218 MB / 0.7978 GB, free: 7.891 MB / 0.6075 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.547e-05/2.527, allocations: 4.969 kB / 0.7978 GB, free: 7.891 MB / 0.6075 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.68e-05/2.527, allocations: 47.53 kB / 0.7979 GB, free: 7.855 MB / 0.6075 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.645e-05/2.527, allocations: 30.41 kB / 0.7979 GB, free: 7.855 MB / 0.6075 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002058/2.529, allocations: 0.9152 MB / 0.7988 GB, free: 7.441 MB / 0.6075 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.1546/2.684, allocations: 70.18 MB / 0.8673 GB, free: 11.33 MB / 0.6856 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009759/2.685, allocations: 456.3 kB / 0.8678 GB, free: 10.87 MB / 0.6856 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003375/2.685, allocations: 168.7 kB / 0.8679 GB, free: 10.7 MB / 0.6856 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.8237/3.509, allocations: 316.3 MB / 1.177 GB, free: 283.1 MB / 0.8262 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.611e-05/3.509, allocations: 34.56 kB / 1.177 GB, free: 283 MB / 0.8262 GB
Notification: Performance of pre-optimization done (n=35): time 4.85e-06/3.509, allocations: 0 / 1.177 GB, free: 283 MB / 0.8262 GB
Notification: Performance of matching and sorting (n=35): time 0.003107/3.512, allocations: 0.9921 MB / 1.178 GB, free: 282.2 MB / 0.8262 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 1.823e-05/3.512, allocations: 55.41 kB / 1.178 GB, free: 282.1 MB / 0.8262 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001139/3.513, allocations: 0.8093 MB / 1.179 GB, free: 281.5 MB / 0.8262 GB
Notification: Performance of collectPreVariables (initialization): time 3.034e-05/3.513, allocations: 37.58 kB / 1.179 GB, free: 281.5 MB / 0.8262 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003419/3.514, allocations: 0.6138 MB / 1.179 GB, free: 281.2 MB / 0.8262 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001133/3.514, allocations: 143.6 kB / 1.179 GB, free: 281.1 MB / 0.8262 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002425/3.514, allocations: 200.5 kB / 1.18 GB, free: 280.9 MB / 0.8262 GB
Notification: Performance of setup shared object (initialization): time 8.974e-05/3.514, allocations: 385.9 kB / 1.18 GB, free: 280.6 MB / 0.8262 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003686/3.515, allocations: 192 kB / 1.18 GB, free: 280.4 MB / 0.8262 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005233/3.515, allocations: 0.6153 MB / 1.181 GB, free: 279.7 MB / 0.8262 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0009883/3.516, allocations: 0.8735 MB / 1.182 GB, free: 278.8 MB / 0.8262 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.448e-05/3.516, allocations: 11.94 kB / 1.182 GB, free: 278.8 MB / 0.8262 GB
Notification: Performance of matching and sorting (n=109) (initialization): time 0.001968/3.518, allocations: 1.03 MB / 1.183 GB, free: 278.1 MB / 0.8262 GB
Notification: Performance of prepare postOptimizeDAE: time 2.236e-05/3.518, allocations: 8.938 kB / 1.183 GB, free: 278.1 MB / 0.8262 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.859e-05/3.518, allocations: 16 kB / 1.183 GB, free: 278.1 MB / 0.8262 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002185/3.52, allocations: 419.7 kB / 1.183 GB, free: 277.7 MB / 0.8262 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004494/3.521, allocations: 158.5 kB / 1.183 GB, free: 277.6 MB / 0.8262 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001064/3.522, allocations: 1.339 MB / 1.184 GB, free: 276.3 MB / 0.8262 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007388/3.523, allocations: 124.6 kB / 1.185 GB, free: 276.2 MB / 0.8262 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.694e-05/3.523, allocations: 52.48 kB / 1.185 GB, free: 276.2 MB / 0.8262 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 68
 * Number of states: 0 ()
 * Number of discrete variables: 21 (sourceQ.C.ftype,sourceP2.C.ftype,volumeATh.Cs1.ftype,volumeATh.Cs2.ftype,volumeATh.fluids[1],controlValve1.fluid,controlValve2.fluid,lumpedStraightPipe1.fluid,sink.fluid,sourceP2.fluid1,sourceQ.fluid1,volumeATh.fluid1,volumeATh.Ce1.diff_on_2,controlValve1.C2.diff_on_1,volumeATh.Cs1.diff_on_2,volumeATh.Cs1.diff_on_1,controlValve2.C2.diff_on_1,volumeATh.Ce2.diff_on_2,sourceP2.C.diff_on_2,volumeATh.Cs2.diff_on_1,volumeATh.Cs2.diff_on_2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (91):
 * Single equations (assignments): 89
 * 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
   {(1,4), (3,12)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004191/3.523, allocations: 284.7 kB / 1.185 GB, free: 276 MB / 0.8262 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001652/3.523, allocations: 87.44 kB / 1.185 GB, free: 275.9 MB / 0.8262 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001275/3.525, allocations: 0.5898 MB / 1.186 GB, free: 275.4 MB / 0.8262 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.093e-06/3.525, allocations: 0 / 1.186 GB, free: 275.4 MB / 0.8262 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.895e-06/3.525, allocations: 0 / 1.186 GB, free: 275.4 MB / 0.8262 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003042/3.525, allocations: 212.5 kB / 1.186 GB, free: 275.2 MB / 0.8262 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001233/3.525, allocations: 8.797 kB / 1.186 GB, free: 275.2 MB / 0.8262 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003021/3.525, allocations: 15.86 kB / 1.186 GB, free: 275.2 MB / 0.8262 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001028/3.526, allocations: 31.77 kB / 1.186 GB, free: 275.2 MB / 0.8262 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.00136/3.527, allocations: 0.5674 MB / 1.186 GB, free: 274.7 MB / 0.8262 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.000962/3.528, allocations: 0.7533 MB / 1.187 GB, free: 274.1 MB / 0.8262 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0002699/3.528, allocations: 138.8 kB / 1.187 GB, free: 274 MB / 0.8262 GB
Notification: Performance of sorting global known variables: time 0.0006402/3.529, allocations: 0.51 MB / 1.188 GB, free: 273.6 MB / 0.8262 GB
Notification: Performance of Backend: time 5.01e-07/3.529, allocations: 0 / 1.188 GB, free: 273.6 MB / 0.8262 GB
Notification: Performance of simCode: created initialization part: time 0.01886/3.548, allocations: 4.164 MB / 1.192 GB, free: 270.3 MB / 0.8262 GB
Notification: Performance of SimCode: time 0.004111/3.552, allocations: 2.284 MB / 1.194 GB, free: 268.1 MB / 0.8262 GB
Notification: Performance of Templates: time 0.08362/3.636, allocations: 79.33 MB / 1.272 GB, free: 189.6 MB / 0.8262 GB
make -j1 -f ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh.makefile
(rm -f ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh.pipe >> ../files/ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh.sim & ./ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh  -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoSysPro_ThermoSysPro.Fluid.Examples.Book.SimpleExamples.Volume.TestVolumeATh.pipe 2>&1)