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.8287/0.8287, allocations: 150.9 MB / 167.2 MB, free: 14.55 MB / 142.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003364/0.0003364, allocations: 17.86 kB / 237.7 MB, free: 1.828 MB / 190.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.0579/0.05825, allocations: 31.34 MB / 269.1 MB, free: 7.105 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.651/1.71, allocations: 297.2 MB / 0.553 GB, free: 10.54 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.5192/2.229, allocations: 196.2 MB / 0.7447 GB, free: 1.625 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008459/2.23, allocations: 20.75 kB / 0.7447 GB, free: 1.625 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.0004488/2.23, allocations: 176 kB / 0.7448 GB, free: 1.625 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.0007811/2.231, allocations: 395.2 kB / 0.7452 GB, free: 1.621 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.03393/2.265, allocations: 13.98 MB / 0.7589 GB, free: 1.301 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.001653/2.267, allocations: 1.374 MB / 0.7602 GB, free: 1.297 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006869/2.267, allocations: 0.7072 MB / 0.7609 GB, free: 1.227 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005352/2.268, allocations: 0.5487 MB / 0.7614 GB, free: 1.227 MB / 0.5919 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0004987/2.268, allocations: 0.6159 MB / 0.762 GB, free: 1.227 MB / 0.5919 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001231/2.269, allocations: 116.5 kB / 0.7622 GB, free: 1.227 MB / 0.5919 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03192/2.3, allocations: 19.22 MB / 0.7809 GB, free: 15.23 MB / 0.6075 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004255/2.301, allocations: 295 kB / 0.7812 GB, free: 15.19 MB / 0.6075 GB
Notification: Performance of NFVerifyModel.verify: time 0.0008399/2.302, allocations: 0.6281 MB / 0.7818 GB, free: 15.07 MB / 0.6075 GB
Notification: Performance of NFConvertDAE.convert: time 0.02537/2.327, allocations: 10.93 MB / 0.7925 GB, free: 10.98 MB / 0.6075 GB
Notification: Performance of FrontEnd - DAE generated: time 6.011e-06/2.327, allocations: 0 / 0.7925 GB, free: 10.98 MB / 0.6075 GB
Notification: Performance of FrontEnd: time 3.216e-06/2.327, allocations: 0 / 0.7925 GB, free: 10.98 MB / 0.6075 GB
Notification: Performance of Transformations before backend: time 2.06e-05/2.327, allocations: 4.969 kB / 0.7925 GB, free: 10.98 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.006378/2.334, allocations: 2.676 MB / 0.7951 GB, free: 9.32 MB / 0.6075 GB
Notification: Performance of prepare preOptimizeDAE: time 4.626e-05/2.334, allocations: 10.22 kB / 0.7951 GB, free: 9.32 MB / 0.6075 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0002097/2.334, allocations: 139.1 kB / 0.7952 GB, free: 9.254 MB / 0.6075 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0009259/2.335, allocations: 0.6591 MB / 0.7959 GB, free: 8.832 MB / 0.6075 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.811e-05/2.335, allocations: 87.69 kB / 0.796 GB, free: 8.828 MB / 0.6075 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000188/2.335, allocations: 116.7 kB / 0.7961 GB, free: 8.824 MB / 0.6075 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001782/2.337, allocations: 1.214 MB / 0.7973 GB, free: 8.211 MB / 0.6075 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.637e-05/2.337, allocations: 6.438 kB / 0.7973 GB, free: 8.211 MB / 0.6075 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.493e-05/2.337, allocations: 47 kB / 0.7973 GB, free: 8.176 MB / 0.6075 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.804e-05/2.337, allocations: 29.12 kB / 0.7974 GB, free: 8.176 MB / 0.6075 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001648/2.339, allocations: 0.9167 MB / 0.7982 GB, free: 7.762 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.1523/2.491, allocations: 70.16 MB / 0.8668 GB, free: 11.8 MB / 0.6856 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0008637/2.492, allocations: 455.4 kB / 0.8672 GB, free: 11.34 MB / 0.6856 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002993/2.492, allocations: 164.7 kB / 0.8674 GB, free: 11.17 MB / 0.6856 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.831/3.323, allocations: 316.2 MB / 1.176 GB, free: 283.9 MB / 0.8262 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.234e-05/3.323, allocations: 34.5 kB / 1.176 GB, free: 283.9 MB / 0.8262 GB
Notification: Performance of pre-optimization done (n=35): time 3.266e-06/3.323, allocations: 0 / 1.176 GB, free: 283.9 MB / 0.8262 GB
Notification: Performance of matching and sorting (n=35): time 0.003132/3.326, allocations: 0.9891 MB / 1.177 GB, free: 283 MB / 0.8262 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 1.852e-05/3.327, allocations: 51.41 kB / 1.177 GB, free: 283 MB / 0.8262 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001139/3.328, allocations: 0.8115 MB / 1.178 GB, free: 282.4 MB / 0.8262 GB
Notification: Performance of collectPreVariables (initialization): time 3.251e-05/3.328, allocations: 29.64 kB / 1.178 GB, free: 282.3 MB / 0.8262 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003463/3.328, allocations: 0.6024 MB / 1.179 GB, free: 281.9 MB / 0.8262 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000113/3.328, allocations: 144 kB / 1.179 GB, free: 281.8 MB / 0.8262 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002566/3.328, allocations: 192 kB / 1.179 GB, free: 281.7 MB / 0.8262 GB
Notification: Performance of setup shared object (initialization): time 9.84e-05/3.329, allocations: 388 kB / 1.179 GB, free: 281.3 MB / 0.8262 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003927/3.329, allocations: 188.6 kB / 1.179 GB, free: 281.2 MB / 0.8262 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005338/3.329, allocations: 0.6195 MB / 1.18 GB, free: 280.5 MB / 0.8262 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.000902/3.33, allocations: 0.8742 MB / 1.181 GB, free: 279.6 MB / 0.8262 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.092e-05/3.33, allocations: 4 kB / 1.181 GB, free: 279.6 MB / 0.8262 GB
Notification: Performance of matching and sorting (n=109) (initialization): time 0.001876/3.332, allocations: 1.029 MB / 1.182 GB, free: 278.9 MB / 0.8262 GB
Notification: Performance of prepare postOptimizeDAE: time 2.372e-05/3.332, allocations: 12 kB / 1.182 GB, free: 278.9 MB / 0.8262 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.66e-05/3.332, allocations: 17.17 kB / 1.182 GB, free: 278.8 MB / 0.8262 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002243/3.335, allocations: 423 kB / 1.182 GB, free: 278.5 MB / 0.8262 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004093/3.335, allocations: 156.2 kB / 1.183 GB, free: 278.3 MB / 0.8262 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001052/3.336, allocations: 1.332 MB / 1.184 GB, free: 277.1 MB / 0.8262 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007552/3.337, allocations: 122.5 kB / 1.184 GB, free: 277 MB / 0.8262 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.868e-05/3.337, allocations: 55.73 kB / 1.184 GB, free: 276.9 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.0004818/3.337, allocations: 282.2 kB / 1.184 GB, free: 276.7 MB / 0.8262 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001806/3.338, allocations: 82.97 kB / 1.184 GB, free: 276.6 MB / 0.8262 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00132/3.339, allocations: 0.5885 MB / 1.185 GB, free: 276.2 MB / 0.8262 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.087e-06/3.339, allocations: 6.156 kB / 1.185 GB, free: 276.2 MB / 0.8262 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.186e-06/3.339, allocations: 4 kB / 1.185 GB, free: 276.2 MB / 0.8262 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003381/3.339, allocations: 199.6 kB / 1.185 GB, free: 276 MB / 0.8262 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001316/3.339, allocations: 15.98 kB / 1.185 GB, free: 276 MB / 0.8262 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003209/3.34, allocations: 11.94 kB / 1.185 GB, free: 276 MB / 0.8262 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.92e-05/3.34, allocations: 39.62 kB / 1.185 GB, free: 275.9 MB / 0.8262 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001319/3.341, allocations: 0.561 MB / 1.186 GB, free: 275.5 MB / 0.8262 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0009441/3.342, allocations: 0.745 MB / 1.186 GB, free: 274.8 MB / 0.8262 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0002483/3.342, allocations: 131.1 kB / 1.187 GB, free: 274.8 MB / 0.8262 GB
Notification: Performance of sorting global known variables: time 0.000586/3.343, allocations: 0.5186 MB / 1.187 GB, free: 274.4 MB / 0.8262 GB
Notification: Performance of Backend: time 8.32e-07/3.343, allocations: 0 / 1.187 GB, free: 274.4 MB / 0.8262 GB
Notification: Performance of simCode: created initialization part: time 0.01518/3.358, allocations: 4.127 MB / 1.191 GB, free: 271.1 MB / 0.8262 GB
Notification: Performance of SimCode: time 0.002867/3.361, allocations: 2.249 MB / 1.193 GB, free: 269 MB / 0.8262 GB
Notification: Performance of Templates: time 0.08234/3.444, allocations: 79.33 MB / 1.271 GB, free: 190.5 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)