Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe.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.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe")
translateModel(ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo): time 0.8268/0.8268, allocations: 150.9 MB / 167.2 MB, free: 14.52 MB / 142.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003343/0.0003344, allocations: 20.44 kB / 237.7 MB, free: 1.84 MB / 190.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.0523/0.05265, allocations: 31.34 MB / 269.1 MB, free: 7.121 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.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe): time 1.659/1.712, allocations: 296.3 MB / 0.5521 GB, free: 11.44 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03172/1.744, allocations: 24.94 MB / 0.5765 GB, free: 2.402 MB / 462.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005059/1.744, allocations: 11.94 kB / 0.5765 GB, free: 2.391 MB / 462.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/WaterSteam/HeatExchangers/DynamicTwoPhaseFlowPipe.mo:184:3-185:48:writable] Warning: Connector C1 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 4.0.0-master/WaterSteam/HeatExchangers/DynamicTwoPhaseFlowPipe.mo:188:3-189:46:writable] Warning: Connector C2 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 4.0.0-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 4.0.0-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.0006849/1.745, allocations: 247.5 kB / 0.5767 GB, free: 2.148 MB / 462.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0009344/1.746, allocations: 0.5325 MB / 0.5773 GB, free: 1.613 MB / 462.1 MB
[/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.
Notification: Performance of NFTyping.typeClassSections: time 0.02016/1.766, allocations: 7.841 MB / 0.5849 GB, free: 9.77 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007771/1.774, allocations: 8.853 MB / 0.5936 GB, free: 0.8906 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004342/1.778, allocations: 2.917 MB / 0.5964 GB, free: 13.95 MB / 494.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004635/1.783, allocations: 2.986 MB / 0.5993 GB, free: 10.96 MB / 494.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.005611/1.789, allocations: 3.37 MB / 0.6026 GB, free: 7.578 MB / 494.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001493/1.79, allocations: 0.5195 MB / 0.6031 GB, free: 7.059 MB / 494.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0258/1.816, allocations: 13.77 MB / 0.6166 GB, free: 9.27 MB / 0.4981 GB
Notification: Performance of NFScalarize.scalarize: time 0.002707/1.819, allocations: 2.061 MB / 0.6186 GB, free: 7.203 MB / 0.4981 GB
Notification: Performance of NFVerifyModel.verify: time 0.005022/1.824, allocations: 2.7 MB / 0.6212 GB, free: 4.492 MB / 0.4981 GB
Notification: Performance of NFConvertDAE.convert: time 0.02159/1.845, allocations: 12.22 MB / 0.6332 GB, free: 8.246 MB / 0.5137 GB
Notification: Performance of FrontEnd - DAE generated: time 9.558e-06/1.846, allocations: 0 / 0.6332 GB, free: 8.246 MB / 0.5137 GB
Notification: Performance of FrontEnd: time 1.804e-06/1.846, allocations: 3.938 kB / 0.6332 GB, free: 8.242 MB / 0.5137 GB
Notification: Performance of Transformations before backend: time 0.0001748/1.846, allocations: 0 / 0.6332 GB, free: 8.242 MB / 0.5137 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1241
 * Number of variables: 1241
Notification: Performance of Generate backend data structure: time 0.03278/1.878, allocations: 7.672 MB / 0.6407 GB, free: 0.5 MB / 0.5137 GB
Notification: Performance of prepare preOptimizeDAE: time 5.517e-05/1.879, allocations: 12.03 kB / 0.6407 GB, free: 500 kB / 0.5137 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001146/1.88, allocations: 439.9 kB / 0.6411 GB, free: 56 kB / 0.5137 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00406/1.884, allocations: 1.758 MB / 0.6428 GB, free: 14.25 MB / 0.5294 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001913/1.886, allocations: 1.735 MB / 0.6445 GB, free: 12.25 MB / 0.5294 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008532/1.887, allocations: 315.8 kB / 0.6448 GB, free: 11.95 MB / 0.5294 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02121/1.908, allocations: 9.054 MB / 0.6536 GB, free: 2.816 MB / 0.5294 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.53e-05/1.908, allocations: 3.938 kB / 0.6536 GB, free: 2.812 MB / 0.5294 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005337/1.908, allocations: 120 kB / 0.6538 GB, free: 2.695 MB / 0.5294 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001008/1.909, allocations: 135.9 kB / 0.6539 GB, free: 2.562 MB / 0.5294 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03141/1.94, allocations: 12.02 MB / 0.6656 GB, free: 6.52 MB / 0.545 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.03382/1.974, allocations: 20.67 MB / 0.6858 GB, free: 0.832 MB / 0.5606 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02219/1.996, allocations: 9.185 MB / 0.6948 GB, free: 7.633 MB / 0.5762 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01692/2.013, allocations: 7.226 MB / 0.7018 GB, free: 396 kB / 0.5762 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.3445/2.358, allocations: 70.33 MB / 0.7705 GB, free: 173.3 MB / 0.5919 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.599e-05/2.358, allocations: 84.08 kB / 0.7706 GB, free: 173.2 MB / 0.5919 GB
Notification: Performance of pre-optimization done (n=1026): time 8.115e-06/2.358, allocations: 0 / 0.7706 GB, free: 173.2 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=1026): time 0.1096/2.467, allocations: 31.52 MB / 0.8014 GB, free: 146.5 MB / 0.5919 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.217e-05/2.467, allocations: 111.5 kB / 0.8015 GB, free: 146.4 MB / 0.5919 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0007125/2.468, allocations: 0.6186 MB / 0.8021 GB, free: 145.8 MB / 0.5919 GB
Notification: Performance of collectPreVariables (initialization): time 0.001615/2.47, allocations: 113.7 kB / 0.8022 GB, free: 145.7 MB / 0.5919 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/WaterSteam/HeatExchangers/DynamicTwoPhaseFlowPipe.mo:11:3-12:73:writable] Warning: The parameter dynamicTwoPhaseFlowPipe1.dpfCorr has fixed = false and a binding equation dynamicTwoPhaseFlowPipe1.dpfCorr = 1.0, which is probably redundant.
Setting fixed = false usually means there is an additional initial equation to determine the parameter value. The binding was ignored by old Modelica tools, but this is not according to the Modelica specification. Please remove the parameter binding, or bind the parameter to another parameter with fixed = false and no binding.
Notification: Performance of collectInitialEqns (initialization): time 0.0002711/2.47, allocations: 486.2 kB / 0.8027 GB, free: 145.2 MB / 0.5919 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003017/2.473, allocations: 3.392 MB / 0.806 GB, free: 141.8 MB / 0.5919 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002176/2.475, allocations: 1.251 MB / 0.8072 GB, free: 140.6 MB / 0.5919 GB
Notification: Performance of setup shared object (initialization): time 6.614e-05/2.475, allocations: 349.9 kB / 0.8075 GB, free: 140.2 MB / 0.5919 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01342/2.489, allocations: 6.339 MB / 0.8137 GB, free: 133.9 MB / 0.5919 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01396/2.503, allocations: 6.939 MB / 0.8205 GB, free: 126.9 MB / 0.5919 GB
Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet.
Notification: Performance of analyzeInitialSystem (initialization): time 0.1554/2.658, allocations: 41.61 MB / 0.8611 GB, free: 85.33 MB / 0.5919 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.192e-05/2.658, allocations: 5.062 kB / 0.8611 GB, free: 85.32 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=1084) (initialization): time 0.0434/2.702, allocations: 17.64 MB / 0.8784 GB, free: 67.6 MB / 0.5919 GB
Notification: Performance of prepare postOptimizeDAE: time 3.281e-05/2.702, allocations: 11.19 kB / 0.8784 GB, free: 67.59 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.423e-05/2.702, allocations: 23.98 kB / 0.8784 GB, free: 67.57 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.04319/2.745, allocations: 17.08 MB / 0.8951 GB, free: 50.49 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00948/2.754, allocations: 1.558 MB / 0.8966 GB, free: 48.96 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02238/2.777, allocations: 12.47 MB / 0.9088 GB, free: 36.38 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009208/2.786, allocations: 1.449 MB / 0.9102 GB, free: 34.92 MB / 0.5919 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001877/2.788, allocations: 271.6 kB / 0.9105 GB, free: 34.66 MB / 0.5919 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         $DER.dynamicTwoPhaseFlowPipe1.h[2] = 0.0.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 18
 * Number of states: 0 ()
 * Number of discrete variables: 4 (sinkP1.C.a,sourceP1.C.b,dynamicTwoPhaseFlowPipe1.C2.b,dynamicTwoPhaseFlowPipe1.C1.a)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (360):
 * Single equations (assignments): 345
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 14
 * 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
   {(21,206)}
Notification: Performance of prepare postOptimizeDAE: time 0.003602/2.792, allocations: 1.138 MB / 0.9116 GB, free: 33.54 MB / 0.5919 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001106/2.793, allocations: 335.5 kB / 0.9119 GB, free: 33.21 MB / 0.5919 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05957/2.852, allocations: 22.06 MB / 0.9334 GB, free: 11.09 MB / 0.5919 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001781/2.853, allocations: 27.89 kB / 0.9335 GB, free: 11.06 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.216e-05/2.853, allocations: 21.58 kB / 0.9335 GB, free: 11.04 MB / 0.5919 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004728/2.857, allocations: 1.66 MB / 0.9351 GB, free: 9.352 MB / 0.5919 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001078/2.858, allocations: 124 kB / 0.9352 GB, free: 9.23 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007537/2.866, allocations: 1.045 MB / 0.9362 GB, free: 8.184 MB / 0.5919 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001389/2.867, allocations: 493.1 kB / 0.9367 GB, free: 7.699 MB / 0.5919 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.264/3.131, allocations: 21.55 MB / 0.9578 GB, free: 194.9 MB / 0.5919 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0535/3.185, allocations: 25.83 MB / 0.983 GB, free: 189.9 MB / 0.5919 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01668/3.202, allocations: 8.418 MB / 0.9912 GB, free: 187.2 MB / 0.5919 GB
Notification: Performance of sorting global known variables: time 0.0005867/3.202, allocations: 484.8 kB / 0.9917 GB, free: 187 MB / 0.5919 GB
Notification: Performance of Backend: time 1.893e-06/3.202, allocations: 2.078 kB / 0.9917 GB, free: 187 MB / 0.5919 GB
Notification: Performance of simCode: created initialization part: time 0.04022/3.243, allocations: 13.86 MB / 1.005 GB, free: 174.2 MB / 0.5919 GB
Notification: Performance of SimCode: time 0.01589/3.258, allocations: 15.61 MB / 1.02 GB, free: 158.3 MB / 0.5919 GB
Notification: Performance of Templates: time 0.4299/3.688, allocations: 190.7 MB / 1.207 GB, free: 171.3 MB / 0.5919 GB
make -j1 -f ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe.makefile
(rm -f ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe.pipe >> ../files/ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe.sim & ./ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe  -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.HeatExchanger.TestDynamicTwoPhaseFlowPipe.pipe 2>&1)