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.7838/0.7838, allocations: 150.9 MB / 166.1 MB, free: 14.56 MB / 142.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.000286/0.0002861, allocations: 19.95 kB / 204.2 MB, free: 10.05 MB / 174.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1355/0.1358, allocations: 31.32 MB / 235.5 MB, free: 5.445 MB / 190.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.491/1.627, allocations: 295.3 MB / 0.5183 GB, free: 12.03 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02434/1.652, allocations: 23.51 MB / 0.5413 GB, free: 4.664 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003541/1.652, allocations: 7.938 kB / 0.5413 GB, free: 4.656 MB / 430.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.000506/1.653, allocations: 168.3 kB / 0.5414 GB, free: 4.492 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0005685/1.653, allocations: 337.1 kB / 0.5418 GB, free: 4.164 MB / 430.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.01524/1.668, allocations: 6.378 MB / 0.548 GB, free: 13.82 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002236/1.671, allocations: 2.549 MB / 0.5505 GB, free: 11.26 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0007959/1.671, allocations: 0.6803 MB / 0.5511 GB, free: 10.59 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0009693/1.672, allocations: 0.8996 MB / 0.552 GB, free: 9.684 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0009787/1.673, allocations: 0.8997 MB / 0.5529 GB, free: 8.781 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001714/1.674, allocations: 120 kB / 0.553 GB, free: 8.664 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02183/1.695, allocations: 15.31 MB / 0.568 GB, free: 9.34 MB / 462.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0006759/1.696, allocations: 482.7 kB / 0.5684 GB, free: 8.867 MB / 462.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0009348/1.697, allocations: 0.7544 MB / 0.5692 GB, free: 8.109 MB / 462.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01349/1.711, allocations: 7.916 MB / 0.5769 GB, free: 180 kB / 462.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.4e-06/1.711, allocations: 0 / 0.5769 GB, free: 180 kB / 462.1 MB
Notification: Performance of FrontEnd: time 1.894e-06/1.711, allocations: 0 / 0.5769 GB, free: 180 kB / 462.1 MB
Notification: Performance of Transformations before backend: time 1.673e-05/1.711, allocations: 0 / 0.5769 GB, free: 180 kB / 462.1 MB
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.006845/1.717, allocations: 2.307 MB / 0.5791 GB, free: 13.81 MB / 478.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.75e-05/1.718, allocations: 16.03 kB / 0.5792 GB, free: 13.8 MB / 478.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.000242/1.718, allocations: 135.2 kB / 0.5793 GB, free: 13.66 MB / 478.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0006849/1.718, allocations: 0.5693 MB / 0.5798 GB, free: 13.05 MB / 478.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.941e-05/1.719, allocations: 94 kB / 0.5799 GB, free: 12.96 MB / 478.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000176/1.719, allocations: 104 kB / 0.58 GB, free: 12.86 MB / 478.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002818/1.722, allocations: 1.958 MB / 0.5819 GB, free: 10.84 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.416e-05/1.722, allocations: 4 kB / 0.5819 GB, free: 10.83 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001156/1.722, allocations: 45.44 kB / 0.582 GB, free: 10.79 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.053e-05/1.722, allocations: 75.94 kB / 0.5821 GB, free: 10.71 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003014/1.725, allocations: 1.898 MB / 0.5839 GB, free: 8.812 MB / 478.1 MB
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.07043/1.795, allocations: 39.55 MB / 0.6225 GB, free: 13.38 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002347/1.798, allocations: 1.713 MB / 0.6242 GB, free: 11.66 MB / 0.5137 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00168/1.799, allocations: 1.201 MB / 0.6254 GB, free: 10.45 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0657/1.865, allocations: 33.61 MB / 0.6582 GB, free: 5.551 MB / 0.545 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.455e-05/1.865, allocations: 51.88 kB / 0.6583 GB, free: 5.492 MB / 0.545 GB
Notification: Performance of pre-optimization done (n=292): time 3.466e-06/1.865, allocations: 0 / 0.6583 GB, free: 5.492 MB / 0.545 GB
Notification: Performance of matching and sorting (n=292): time 0.03161/1.897, allocations: 7.311 MB / 0.6654 GB, free: 14.05 MB / 0.5606 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.045e-05/1.897, allocations: 64.72 kB / 0.6655 GB, free: 13.97 MB / 0.5606 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0003677/1.897, allocations: 353.6 kB / 0.6658 GB, free: 13.62 MB / 0.5606 GB
Notification: Performance of collectPreVariables (initialization): time 0.000113/1.897, allocations: 45.7 kB / 0.6658 GB, free: 13.57 MB / 0.5606 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001545/1.897, allocations: 283.7 kB / 0.6661 GB, free: 13.28 MB / 0.5606 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0006324/1.898, allocations: 0.9465 MB / 0.667 GB, free: 12.32 MB / 0.5606 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005015/1.899, allocations: 343.8 kB / 0.6674 GB, free: 11.98 MB / 0.5606 GB
Notification: Performance of setup shared object (initialization): time 9.54e-05/1.899, allocations: 334 kB / 0.6677 GB, free: 11.65 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001703/1.9, allocations: 1.019 MB / 0.6687 GB, free: 10.63 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001816/1.902, allocations: 1.212 MB / 0.6699 GB, free: 9.387 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003746/1.906, allocations: 2.46 MB / 0.6723 GB, free: 6.871 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.404e-06/1.906, allocations: 0 / 0.6723 GB, free: 6.871 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=316) (initialization): time 0.006193/1.912, allocations: 3.745 MB / 0.6759 GB, free: 3.09 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 2.149e-05/1.912, allocations: 4 kB / 0.6759 GB, free: 3.086 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.489e-05/1.912, allocations: 4 kB / 0.6759 GB, free: 3.082 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01612/1.928, allocations: 4.84 MB / 0.6807 GB, free: 14.23 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0001361/1.929, allocations: 31.92 kB / 0.6807 GB, free: 14.2 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008302/1.937, allocations: 4.892 MB / 0.6855 GB, free: 9.285 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001176/1.938, allocations: 193.7 kB / 0.6856 GB, free: 9.094 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001365/1.938, allocations: 63.94 kB / 0.6857 GB, free: 9.031 MB / 0.5762 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.0006143/1.939, allocations: 361.6 kB / 0.6861 GB, free: 8.668 MB / 0.5762 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002216/1.939, allocations: 98.59 kB / 0.6861 GB, free: 8.57 MB / 0.5762 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1636/2.103, allocations: 10.93 MB / 0.6968 GB, free: 226.1 MB / 0.5762 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.005903/2.109, allocations: 4.02 MB / 0.7007 GB, free: 225.8 MB / 0.5762 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.36e-05/2.109, allocations: 8.469 kB / 0.7008 GB, free: 225.8 MB / 0.5762 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.191e-05/2.109, allocations: 13.08 kB / 0.7008 GB, free: 225.8 MB / 0.5762 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01411/2.123, allocations: 8.253 MB / 0.7088 GB, free: 224.9 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.164e-05/2.123, allocations: 2.844 kB / 0.7088 GB, free: 224.9 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001347/2.124, allocations: 354.1 kB / 0.7092 GB, free: 224.9 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004185/2.128, allocations: 1.922 MB / 0.711 GB, free: 224.8 MB / 0.5762 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001955/2.129, allocations: 69.69 kB / 0.7111 GB, free: 224.8 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.006097/2.135, allocations: 6.903 MB / 0.7179 GB, free: 220.9 MB / 0.5762 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.914e-06/2.135, allocations: 2.562 kB / 0.7179 GB, free: 220.9 MB / 0.5762 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01113/2.146, allocations: 6.197 MB / 0.7239 GB, free: 219.2 MB / 0.5762 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003288/2.146, allocations: 268.6 kB / 0.7242 GB, free: 219 MB / 0.5762 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002186/2.146, allocations: 61.47 kB / 0.7242 GB, free: 218.9 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001088/2.148, allocations: 96.47 kB / 0.7243 GB, free: 218.9 MB / 0.5762 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002981/2.148, allocations: 171.2 kB / 0.7245 GB, free: 218.9 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001293/2.148, allocations: 82.73 kB / 0.7246 GB, free: 218.8 MB / 0.5762 GB
Notification: Performance of sorting global known variables: time 0.0003459/2.148, allocations: 395.8 kB / 0.7249 GB, free: 218.7 MB / 0.5762 GB
Notification: Performance of sort global known variables: time 1.2e-07/2.148, allocations: 0 / 0.7249 GB, free: 218.7 MB / 0.5762 GB
Notification: Performance of remove unused functions: time 0.002703/2.151, allocations: 1.357 MB / 0.7263 GB, free: 218.5 MB / 0.5762 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.003516/2.155, allocations: 1.245 MB / 0.7275 GB, free: 218.3 MB / 0.5762 GB
Notification: Performance of simCode: created initialization part: time 0.0125/2.167, allocations: 6.525 MB / 0.7338 GB, free: 214.2 MB / 0.5762 GB
Notification: Performance of simCode: created event and clocks part: time 4.839e-06/2.167, allocations: 0.5 kB / 0.7338 GB, free: 214.2 MB / 0.5762 GB
Notification: Performance of simCode: created simulation system equations: time 0.003545/2.171, allocations: 2.167 MB / 0.736 GB, free: 212.3 MB / 0.5762 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00358/2.174, allocations: 0.884 MB / 0.7368 GB, free: 211.8 MB / 0.5762 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007909/2.182, allocations: 5.916 MB / 0.7426 GB, free: 206.4 MB / 0.5762 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007157/2.183, allocations: 1.546 MB / 0.7441 GB, free: 204.8 MB / 0.5762 GB
Notification: Performance of simCode: alias equations: time 0.001037/2.184, allocations: 307.4 kB / 0.7444 GB, free: 204.5 MB / 0.5762 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000262/2.184, allocations: 107.4 kB / 0.7445 GB, free: 204.4 MB / 0.5762 GB
Notification: Performance of SimCode: time 1.282e-06/2.184, allocations: 0 / 0.7445 GB, free: 204.4 MB / 0.5762 GB
Notification: Performance of Templates: time 0.08223/2.266, allocations: 83.34 MB / 0.8259 GB, free: 122.4 MB / 0.5762 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)