Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger.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.SimpleExamples.TestDynamicWaterWaterExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger")
translateModel(ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo): time 0.839/0.839, allocations: 150.9 MB / 166.5 MB, free: 14.73 MB / 142.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003199/0.0003198, allocations: 16.61 kB / 237.1 MB, free: 1.73 MB / 190.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.04994/0.05028, allocations: 31.35 MB / 268.4 MB, free: 7.062 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.SimpleExamples.TestDynamicWaterWaterExchanger): time 1.593/1.643, allocations: 296.4 MB / 0.5516 GB, free: 11.41 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02768/1.671, allocations: 23.08 MB / 0.5742 GB, free: 4.242 MB / 462.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003914/1.671, allocations: 8 kB / 0.5742 GB, free: 4.234 MB / 462.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/WaterSteam/HeatExchangers/DynamicWaterWaterExchanger.mo:117:3-118:48: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 4.0.0-master/WaterSteam/HeatExchangers/DynamicWaterWaterExchanger.mo:119:3-120:48: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 4.0.0-master/WaterSteam/HeatExchangers/DynamicWaterWaterExchanger.mo:121:3-122:46: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 4.0.0-master/WaterSteam/HeatExchangers/DynamicWaterWaterExchanger.mo:123:3-124:46: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 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.0006022/1.672, allocations: 218.5 kB / 0.5744 GB, free: 4.023 MB / 462.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0008673/1.673, allocations: 421.7 kB / 0.5748 GB, free: 3.609 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.01784/1.691, allocations: 7.373 MB / 0.582 GB, free: 12.23 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002613/1.693, allocations: 2.553 MB / 0.5845 GB, free: 9.668 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.000895/1.694, allocations: 0.6727 MB / 0.5851 GB, free: 8.984 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001162/1.695, allocations: 0.8844 MB / 0.586 GB, free: 8.098 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00133/1.697, allocations: 0.8646 MB / 0.5869 GB, free: 7.23 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002626/1.697, allocations: 120 kB / 0.587 GB, free: 7.113 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02486/1.722, allocations: 15.45 MB / 0.6021 GB, free: 7.648 MB / 494.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0006613/1.723, allocations: 478.7 kB / 0.6025 GB, free: 7.18 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001323/1.724, allocations: 0.7544 MB / 0.6032 GB, free: 6.422 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01301/1.737, allocations: 7.901 MB / 0.611 GB, free: 14.5 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 4.409e-06/1.737, allocations: 0 / 0.611 GB, free: 14.5 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 3.958e-06/1.737, allocations: 4 kB / 0.611 GB, free: 14.5 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 4.114e-05/1.737, allocations: 7.875 kB / 0.611 GB, free: 14.49 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: 418
 * Number of variables: 418
Notification: Performance of Generate backend data structure: time 0.007501/1.744, allocations: 2.303 MB / 0.6132 GB, free: 12.13 MB / 0.4981 GB
Notification: Performance of prepare preOptimizeDAE: time 3.613e-05/1.745, allocations: 12.03 kB / 0.6132 GB, free: 12.12 MB / 0.4981 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0003198/1.745, allocations: 131.2 kB / 0.6134 GB, free: 11.99 MB / 0.4981 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.000825/1.746, allocations: 0.5693 MB / 0.6139 GB, free: 11.38 MB / 0.4981 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001091/1.746, allocations: 98 kB / 0.614 GB, free: 11.28 MB / 0.4981 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001953/1.746, allocations: 103.9 kB / 0.6141 GB, free: 11.18 MB / 0.4981 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003256/1.749, allocations: 1.97 MB / 0.616 GB, free: 9.145 MB / 0.4981 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.51e-05/1.749, allocations: 3.938 kB / 0.616 GB, free: 9.141 MB / 0.4981 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001258/1.749, allocations: 40 kB / 0.6161 GB, free: 9.102 MB / 0.4981 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.391e-05/1.749, allocations: 67.94 kB / 0.6161 GB, free: 9.035 MB / 0.4981 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003478/1.753, allocations: 1.906 MB / 0.618 GB, free: 7.125 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.08501/1.838, allocations: 39.75 MB / 0.6568 GB, free: 11.47 MB / 0.545 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002795/1.841, allocations: 1.709 MB / 0.6585 GB, free: 9.758 MB / 0.545 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001968/1.843, allocations: 1.193 MB / 0.6596 GB, free: 8.559 MB / 0.545 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0793/1.922, allocations: 33.85 MB / 0.6927 GB, free: 3.414 MB / 0.5762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.391e-05/1.922, allocations: 47.88 kB / 0.6927 GB, free: 3.359 MB / 0.5762 GB
Notification: Performance of pre-optimization done (n=292): time 3.276e-06/1.922, allocations: 0 / 0.6927 GB, free: 3.359 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=292): time 0.03137/1.954, allocations: 7.318 MB / 0.6999 GB, free: 11.91 MB / 0.5919 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.187e-05/1.954, allocations: 64.72 kB / 0.7 GB, free: 11.84 MB / 0.5919 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.000434/1.954, allocations: 357.5 kB / 0.7003 GB, free: 11.48 MB / 0.5919 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001326/1.954, allocations: 53.7 kB / 0.7003 GB, free: 11.42 MB / 0.5919 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001791/1.954, allocations: 275.7 kB / 0.7006 GB, free: 11.14 MB / 0.5919 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007424/1.955, allocations: 0.9543 MB / 0.7015 GB, free: 10.17 MB / 0.5919 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005531/1.956, allocations: 339.9 kB / 0.7019 GB, free: 9.832 MB / 0.5919 GB
Notification: Performance of setup shared object (initialization): time 0.0001119/1.956, allocations: 322 kB / 0.7022 GB, free: 9.512 MB / 0.5919 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001927/1.958, allocations: 1.026 MB / 0.7032 GB, free: 8.484 MB / 0.5919 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002068/1.96, allocations: 1.212 MB / 0.7044 GB, free: 7.242 MB / 0.5919 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004284/1.964, allocations: 2.46 MB / 0.7068 GB, free: 4.73 MB / 0.5919 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.761e-06/1.964, allocations: 0 / 0.7068 GB, free: 4.73 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=316) (initialization): time 0.006895/1.971, allocations: 3.745 MB / 0.7104 GB, free: 0.9453 MB / 0.5919 GB
Notification: Performance of prepare postOptimizeDAE: time 2.13e-05/1.971, allocations: 8 kB / 0.7104 GB, free: 0.9375 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.213e-05/1.971, allocations: 0 / 0.7104 GB, free: 0.9375 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.191/2.162, allocations: 4.82 MB / 0.7151 GB, free: 214.2 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0001447/2.162, allocations: 33.44 kB / 0.7152 GB, free: 214.2 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00813/2.17, allocations: 4.899 MB / 0.72 GB, free: 213.6 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001047/2.172, allocations: 189.6 kB / 0.7201 GB, free: 213.6 MB / 0.5919 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001197/2.172, allocations: 64.47 kB / 0.7202 GB, free: 213.6 MB / 0.5919 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 (puitsP1.C.a,puitsP.C.a,sourceP1.C.b,sourceP.C.b,echangeurAPlaques1D.Sc.b,echangeurAPlaques1D.Sf.b,echangeurAPlaques1D.Ef.a,echangeurAPlaques1D.Ec.a)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (33):
 * Single equations (assignments): 24
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 8
 * 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
   {(22,100)}
Notification: Performance of prepare postOptimizeDAE: time 0.0005439/2.172, allocations: 368.6 kB / 0.7205 GB, free: 213.5 MB / 0.5919 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000202/2.172, allocations: 102.5 kB / 0.7206 GB, free: 213.5 MB / 0.5919 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01033/2.183, allocations: 10.91 MB / 0.7313 GB, free: 212.7 MB / 0.5919 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.005751/2.189, allocations: 4.014 MB / 0.7352 GB, free: 211.6 MB / 0.5919 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.535e-05/2.189, allocations: 2.656 kB / 0.7352 GB, free: 211.6 MB / 0.5919 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.363e-05/2.189, allocations: 15.7 kB / 0.7352 GB, free: 211.6 MB / 0.5919 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01401/2.203, allocations: 7.971 MB / 0.743 GB, free: 208.2 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.018e-05/2.203, allocations: 3.938 kB / 0.743 GB, free: 208.2 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00133/2.204, allocations: 351.1 kB / 0.7434 GB, free: 208.1 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004082/2.208, allocations: 1.916 MB / 0.7452 GB, free: 207.4 MB / 0.5919 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001583/2.208, allocations: 73.03 kB / 0.7453 GB, free: 207.3 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.006191/2.214, allocations: 6.9 MB / 0.752 GB, free: 201.4 MB / 0.5919 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.422e-06/2.214, allocations: 0 / 0.752 GB, free: 201.4 MB / 0.5919 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01079/2.225, allocations: 6.198 MB / 0.7581 GB, free: 195.2 MB / 0.5919 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002612/2.226, allocations: 266.4 kB / 0.7583 GB, free: 194.9 MB / 0.5919 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002319/2.226, allocations: 67.16 kB / 0.7584 GB, free: 194.8 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001033/2.227, allocations: 71.95 kB / 0.7585 GB, free: 194.7 MB / 0.5919 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002948/2.227, allocations: 173.8 kB / 0.7586 GB, free: 194.6 MB / 0.5919 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000148/2.227, allocations: 88.5 kB / 0.7587 GB, free: 194.5 MB / 0.5919 GB
Notification: Performance of sorting global known variables: time 0.0003921/2.228, allocations: 391.1 kB / 0.7591 GB, free: 194.1 MB / 0.5919 GB
Notification: Performance of sort global known variables: time 1.4e-07/2.228, allocations: 0 / 0.7591 GB, free: 194.1 MB / 0.5919 GB
Notification: Performance of remove unused functions: time 0.002872/2.231, allocations: 1.359 MB / 0.7604 GB, free: 192.8 MB / 0.5919 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 10 (echangeurAPlaques1D.Hmc[1],echangeurAPlaques1D.Hmc[2],echangeurAPlaques1D.Hmc[3],echangeurAPlaques1D.Hmc[4],echangeurAPlaques1D.Hmc[5],echangeurAPlaques1D.Hmf[1],echangeurAPlaques1D.Hmf[2],echangeurAPlaques1D.Hmf[3],echangeurAPlaques1D.Hmf[4],echangeurAPlaques1D.Hmf[5])
 * 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 (188):
 * Single equations (assignments): 180
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,5,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(5,35), (5,35)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.004224/2.235, allocations: 1.246 MB / 0.7616 GB, free: 191.8 MB / 0.5919 GB
Notification: Performance of simCode: created initialization part: time 0.006416/2.241, allocations: 4.03 MB / 0.7656 GB, free: 187.6 MB / 0.5919 GB
Notification: Performance of simCode: created event and clocks part: time 3.066e-06/2.241, allocations: 0 / 0.7656 GB, free: 187.6 MB / 0.5919 GB
Notification: Performance of simCode: created simulation system equations: time 0.003717/2.245, allocations: 2.169 MB / 0.7677 GB, free: 185.5 MB / 0.5919 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004111/2.249, allocations: 0.8852 MB / 0.7686 GB, free: 184.7 MB / 0.5919 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008202/2.257, allocations: 5.117 MB / 0.7736 GB, free: 179.7 MB / 0.5919 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007707/2.258, allocations: 1.534 MB / 0.7751 GB, free: 178.1 MB / 0.5919 GB
Notification: Performance of simCode: alias equations: time 0.0008436/2.259, allocations: 312.8 kB / 0.7754 GB, free: 177.8 MB / 0.5919 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002783/2.259, allocations: 107.4 kB / 0.7755 GB, free: 177.7 MB / 0.5919 GB
Notification: Performance of SimCode: time 4.01e-07/2.259, allocations: 0 / 0.7755 GB, free: 177.7 MB / 0.5919 GB
Notification: Performance of Templates: time 0.08756/2.347, allocations: 84.42 MB / 0.8579 GB, free: 94.71 MB / 0.5919 GB
make -j1 -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger.makefile
(rm -f ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger.pipe >> ../files/ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger.sim & ./ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger  -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoSysPro_ThermoSysPro.Examples.SimpleExamples.TestDynamicWaterWaterExchanger.pipe 2>&1)