Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.Volume.TestTank.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: "" <> buildModelFMU(ThermoSysPro.Examples.Book.SimpleExamples.Volume.TestTank,fileNamePrefix="ThermoSysPro_ThermoSysPro_Examples_Book_SimpleExamples_Volume_TestTank",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ThermoSysPro.Examples.Book.SimpleExamples.Volume.TestTank,fileNamePrefix="ThermoSysPro_ThermoSysPro_Examples_Book_SimpleExamples_Volume_TestTank",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo): time 0.7796/0.7796, allocations: 150.8 MB / 166.1 MB, free: 15.39 MB / 142.1 MB
Notification: Performance of FrontEnd - loaded program: time 1.423e-05/1.445e-05, allocations: 4 kB / 204.9 MB, free: 9.965 MB / 174.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1382/0.1382, allocations: 31.98 MB / 236.8 MB, free: 5.434 MB / 190.1 MB
Notification: Automatically loaded package Complex 4.0.0 due to uses annotation.
Notification: Automatically loaded package ModelicaServices 4.0.0 due to uses annotation.
Notification: Automatically loaded package Modelica 4.0.0 due to usage.
Notification: Performance of NFInst.instantiate(ThermoSysPro.Examples.Book.SimpleExamples.Volume.TestTank): time 1.487/1.625, allocations: 296.7 MB / 0.521 GB, free: 11.17 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.1739/1.799, allocations: 186.2 MB / 0.7028 GB, free: 0.5859 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003968/1.8, allocations: 8 kB / 0.7028 GB, free: 0.5781 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.0004553/1.8, allocations: 147.1 kB / 0.703 GB, free: 444 kB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.0006683/1.801, allocations: 269.9 kB / 0.7032 GB, free: 172 kB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.2682/2.069, allocations: 9.068 MB / 0.7121 GB, free: 4.152 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.0009994/2.07, allocations: 1.129 MB / 0.7132 GB, free: 4.152 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.000362/2.07, allocations: 381.5 kB / 0.7135 GB, free: 4.105 MB / 0.5762 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003689/2.071, allocations: 400.2 kB / 0.7139 GB, free: 4.105 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003478/2.071, allocations: 410.9 kB / 0.7143 GB, free: 4.105 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 6.218e-05/2.071, allocations: 34.72 kB / 0.7143 GB, free: 4.105 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02791/2.099, allocations: 20.18 MB / 0.734 GB, free: 3.832 MB / 0.5762 GB
Notification: Performance of NFScalarize.scalarize: time 0.0001935/2.099, allocations: 139.8 kB / 0.7342 GB, free: 3.801 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005037/2.1, allocations: 443.9 kB / 0.7346 GB, free: 3.738 MB / 0.5762 GB
Notification: Performance of NFConvertDAE.convert: time 0.01789/2.118, allocations: 10.32 MB / 0.7447 GB, free: 15.68 MB / 0.5919 GB
Notification: Performance of FrontEnd - DAE generated: time 4.268e-06/2.118, allocations: 0 / 0.7447 GB, free: 15.68 MB / 0.5919 GB
Notification: Performance of FrontEnd: time 1.743e-06/2.118, allocations: 0 / 0.7447 GB, free: 15.68 MB / 0.5919 GB
Notification: Performance of Transformations before backend: time 9.438e-06/2.118, allocations: 0 / 0.7447 GB, free: 15.68 MB / 0.5919 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 224
 * Number of variables: 224
Notification: Performance of Generate backend data structure: time 0.005826/2.124, allocations: 2.318 MB / 0.7469 GB, free: 14.26 MB / 0.5919 GB
Notification: Performance of prepare preOptimizeDAE: time 3.453e-05/2.124, allocations: 12.75 kB / 0.747 GB, free: 14.26 MB / 0.5919 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001192/2.124, allocations: 134.2 kB / 0.7471 GB, free: 14.2 MB / 0.5919 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0001187/2.124, allocations: 96.66 kB / 0.7472 GB, free: 14.15 MB / 0.5919 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0004115/2.124, allocations: 440.3 kB / 0.7476 GB, free: 13.83 MB / 0.5919 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.108e-05/2.124, allocations: 82.25 kB / 0.7477 GB, free: 13.8 MB / 0.5919 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 8.423e-05/2.125, allocations: 72.91 kB / 0.7477 GB, free: 13.79 MB / 0.5919 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001547/2.126, allocations: 1.006 MB / 0.7487 GB, free: 13.4 MB / 0.5919 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.655e-05/2.126, allocations: 2.875 kB / 0.7487 GB, free: 13.4 MB / 0.5919 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.213e-05/2.126, allocations: 28 kB / 0.7488 GB, free: 13.4 MB / 0.5919 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.566e-05/2.126, allocations: 38.59 kB / 0.7488 GB, free: 13.39 MB / 0.5919 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001854/2.128, allocations: 0.8818 MB / 0.7497 GB, free: 13.22 MB / 0.5919 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.05185/2.18, allocations: 29.95 MB / 0.7789 GB, free: 6.078 MB / 0.6075 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002284/2.182, allocations: 0.8499 MB / 0.7797 GB, free: 5.457 MB / 0.6075 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009169/2.183, allocations: 464.2 kB / 0.7802 GB, free: 5.164 MB / 0.6075 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.2834/2.467, allocations: 151.7 MB / 0.9284 GB, free: 15.68 MB / 0.7794 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.09e-05/2.467, allocations: 38.52 kB / 0.9284 GB, free: 15.64 MB / 0.7794 GB
Notification: Performance of pre-optimization done (n=110): time 2.164e-06/2.467, allocations: 0 / 0.9284 GB, free: 15.64 MB / 0.7794 GB
Notification: Performance of matching and sorting (n=110): time 0.007424/2.474, allocations: 2.504 MB / 0.9309 GB, free: 13.48 MB / 0.7794 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.653e-05/2.474, allocations: 59.78 kB / 0.9309 GB, free: 13.41 MB / 0.7794 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0005546/2.475, allocations: 0.5028 MB / 0.9314 GB, free: 13.01 MB / 0.7794 GB
Notification: Performance of collectPreVariables (initialization): time 5.089e-05/2.475, allocations: 33.39 kB / 0.9314 GB, free: 12.98 MB / 0.7794 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001821/2.475, allocations: 322.7 kB / 0.9317 GB, free: 12.74 MB / 0.7794 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002305/2.475, allocations: 370.4 kB / 0.9321 GB, free: 12.43 MB / 0.7794 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 9.985e-05/2.475, allocations: 90 kB / 0.9322 GB, free: 12.37 MB / 0.7794 GB
Notification: Performance of setup shared object (initialization): time 0.0001328/2.475, allocations: 384.1 kB / 0.9325 GB, free: 12.02 MB / 0.7794 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000934/2.476, allocations: 391.9 kB / 0.9329 GB, free: 11.75 MB / 0.7794 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001017/2.477, allocations: 0.5522 MB / 0.9335 GB, free: 11.26 MB / 0.7794 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001978/2.479, allocations: 0.9935 MB / 0.9344 GB, free: 10.5 MB / 0.7794 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.232e-06/2.479, allocations: 4 kB / 0.9344 GB, free: 10.49 MB / 0.7794 GB
Notification: Performance of matching and sorting (n=137) (initialization): time 0.002906/2.482, allocations: 1.338 MB / 0.9357 GB, free: 9.52 MB / 0.7794 GB
Notification: Performance of prepare postOptimizeDAE: time 1.663e-05/2.482, allocations: 4 kB / 0.9357 GB, free: 9.516 MB / 0.7794 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.145e-05/2.482, allocations: 11.84 kB / 0.9358 GB, free: 9.508 MB / 0.7794 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004471/2.487, allocations: 1.128 MB / 0.9369 GB, free: 8.449 MB / 0.7794 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007803/2.488, allocations: 185.3 kB / 0.937 GB, free: 8.277 MB / 0.7794 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002158/2.49, allocations: 2.707 MB / 0.9397 GB, free: 5.738 MB / 0.7794 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007491/2.491, allocations: 146.1 kB / 0.9398 GB, free: 5.605 MB / 0.7794 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.586e-05/2.491, allocations: 35.47 kB / 0.9399 GB, free: 5.574 MB / 0.7794 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 21
 * Number of states: 0 ()
 * Number of discrete variables: 14 (PuitsP2.C.a,PerteDP2.C2.b,PerteDP2.C1.a,Tank1.Cs1.b,Tank1.Ce2.a,Tank1.Cs2.b,Tank1.Ce1.a,PuitsP1.C.a,SourceP1.C.b,VanneReglante1.C2.b,VanneReglante1.C1.a,PerteDP1.C2.b,PerteDP1.C1.a,Tank1.Ce2.b)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (50):
 * Single equations (assignments): 43
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 3
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(2,7), (2,6), (2,7), (1,1)}
Notification: Performance of prepare postOptimizeDAE: time 0.000275/2.491, allocations: 206.6 kB / 0.94 GB, free: 5.414 MB / 0.7794 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001092/2.491, allocations: 74.97 kB / 0.9401 GB, free: 5.34 MB / 0.7794 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004266/2.495, allocations: 2.987 MB / 0.943 GB, free: 3.238 MB / 0.7794 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.002939/2.498, allocations: 1.336 MB / 0.9443 GB, free: 2.242 MB / 0.7794 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.743e-06/2.498, allocations: 0 / 0.9443 GB, free: 2.242 MB / 0.7794 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.537e-06/2.498, allocations: 3.984 kB / 0.9443 GB, free: 2.238 MB / 0.7794 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.005147/2.503, allocations: 2.872 MB / 0.9472 GB, free: 15.72 MB / 0.795 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.659e-06/2.503, allocations: 0 / 0.9472 GB, free: 15.72 MB / 0.795 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0009213/2.504, allocations: 221.7 kB / 0.9474 GB, free: 15.51 MB / 0.795 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003165/2.508, allocations: 0.9497 MB / 0.9483 GB, free: 14.55 MB / 0.795 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.435e-05/2.508, allocations: 23.98 kB / 0.9483 GB, free: 14.53 MB / 0.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002157/2.51, allocations: 2.795 MB / 0.951 GB, free: 11.65 MB / 0.795 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.683e-06/2.51, allocations: 0 / 0.951 GB, free: 11.65 MB / 0.795 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004172/2.514, allocations: 2.045 MB / 0.953 GB, free: 9.582 MB / 0.795 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003254/2.514, allocations: 271.5 kB / 0.9533 GB, free: 9.297 MB / 0.795 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 9.682e-05/2.514, allocations: 16 kB / 0.9533 GB, free: 9.281 MB / 0.795 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006456/2.515, allocations: 91.83 kB / 0.9534 GB, free: 9.191 MB / 0.795 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000143/2.515, allocations: 64.91 kB / 0.9535 GB, free: 9.129 MB / 0.795 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.719e-05/2.515, allocations: 27.98 kB / 0.9535 GB, free: 9.102 MB / 0.795 GB
Notification: Performance of sorting global known variables: time 0.0005443/2.516, allocations: 466 kB / 0.9539 GB, free: 8.648 MB / 0.795 GB
Notification: Performance of sort global known variables: time 3.41e-07/2.516, allocations: 0 / 0.9539 GB, free: 8.648 MB / 0.795 GB
Notification: Performance of remove unused functions: time 0.004019/2.52, allocations: 1.635 MB / 0.9555 GB, free: 7.012 MB / 0.795 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 2 (Tank1.z,Tank1.h)
 * 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 (64):
 * Single equations (assignments): 60
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(2,8), (2,9), (2,9), (1,1)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01127/2.531, allocations: 4.829 MB / 0.9602 GB, free: 2.441 MB / 0.795 GB
Notification: Performance of simCode: created initialization part: time 0.003099/2.534, allocations: 1.303 MB / 0.9615 GB, free: 1.129 MB / 0.795 GB
Notification: Performance of simCode: created event and clocks part: time 2.755e-06/2.534, allocations: 3.938 kB / 0.9615 GB, free: 1.125 MB / 0.795 GB
Notification: Performance of simCode: created simulation system equations: time 0.001762/2.536, allocations: 0.6802 MB / 0.9622 GB, free: 468 kB / 0.795 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001644/2.538, allocations: 341.7 kB / 0.9625 GB, free: 124 kB / 0.795 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01407/2.552, allocations: 8.619 MB / 0.9709 GB, free: 7.309 MB / 0.8106 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005115/2.552, allocations: 1.027 MB / 0.9719 GB, free: 6.258 MB / 0.8106 GB
Notification: Performance of simCode: alias equations: time 0.0003927/2.553, allocations: 97.39 kB / 0.972 GB, free: 6.164 MB / 0.8106 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004047/2.553, allocations: 375.3 kB / 0.9724 GB, free: 5.797 MB / 0.8106 GB
Notification: Performance of SimCode: time 4.91e-07/2.553, allocations: 0 / 0.9724 GB, free: 5.797 MB / 0.8106 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.9157/3.469, allocations: 70.07 MB / 1.041 GB, free: 423 MB / 0.8106 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001632/3.469, allocations: 282.4 kB / 1.041 GB, free: 422.6 MB / 0.8106 GB
Notification: Performance of buildModelFMU: Generate platform static: time 4.718/8.187, allocations: 0 / 1.041 GB, free: 422.6 MB / 0.8106 GB
(rm -f ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.Volume.TestTank.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.Volume.TestTank.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.Volume.TestTank.pipe >> ../files/ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.Volume.TestTank.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_ThermoSysPro_ThermoSysPro_Examples_Book_SimpleExamples_Volume_TestTank_fmu --startTime=0 --stopTime=20 --timeout=50 --tolerance=1e-06 ThermoSysPro_ThermoSysPro_Examples_Book_SimpleExamples_Volume_TestTank.fmu > ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.Volume.TestTank.pipe 2>&1)