Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve.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.PressureLoss.TestControlValve,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve")
translateModel(ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo): time 0.7462/0.7462, allocations: 150.8 MB / 166.1 MB, free: 15.39 MB / 142.1 MB
Notification: Performance of FrontEnd - loaded program: time 1.788e-05/1.791e-05, allocations: 0 / 204.8 MB, free: 10.07 MB / 174.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.14/0.14, allocations: 31.97 MB / 236.8 MB, free: 5.406 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.PressureLoss.TestControlValve): time 1.422/1.562, allocations: 293.6 MB / 0.5179 GB, free: 13.46 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03755/1.6, allocations: 37.35 MB / 0.5544 GB, free: 8.262 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000165/1.6, allocations: 0 / 0.5544 GB, free: 8.262 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003595/1.6, allocations: 135.5 kB / 0.5545 GB, free: 8.129 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.000238/1.6, allocations: 135.2 kB / 0.5546 GB, free: 7.996 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01761/1.618, allocations: 7.421 MB / 0.5619 GB, free: 0.5742 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0004543/1.618, allocations: 362.4 kB / 0.5622 GB, free: 224 kB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001795/1.619, allocations: 121.6 kB / 0.5623 GB, free: 100 kB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0001935/1.619, allocations: 135.3 kB / 0.5625 GB, free: 15.96 MB / 462.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001648/1.619, allocations: 155.3 kB / 0.5626 GB, free: 15.81 MB / 462.1 MB
Notification: Performance of NFPackage.collectConstants: time 2.015e-05/1.619, allocations: 8 kB / 0.5626 GB, free: 15.8 MB / 462.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0247/1.644, allocations: 17.87 MB / 0.5801 GB, free: 13.91 MB / 478.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001203/1.644, allocations: 63.7 kB / 0.5801 GB, free: 13.84 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001677/1.644, allocations: 172.8 kB / 0.5803 GB, free: 13.67 MB / 478.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01433/1.658, allocations: 8.444 MB / 0.5885 GB, free: 5.203 MB / 478.1 MB
Notification: Performance of FrontEnd - DAE generated: time 3.617e-06/1.658, allocations: 4 kB / 0.5886 GB, free: 5.199 MB / 478.1 MB
Notification: Performance of FrontEnd: time 1.163e-06/1.658, allocations: 0 / 0.5886 GB, free: 5.199 MB / 478.1 MB
Notification: Performance of Transformations before backend: time 7.955e-06/1.658, allocations: 0 / 0.5886 GB, free: 5.199 MB / 478.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 77
 * Number of variables: 77
Notification: Performance of Generate backend data structure: time 0.003438/1.662, allocations: 1.472 MB / 0.59 GB, free: 3.68 MB / 478.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.486e-05/1.662, allocations: 8.031 kB / 0.59 GB, free: 3.672 MB / 478.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 6.498e-05/1.662, allocations: 43.47 kB / 0.59 GB, free: 3.629 MB / 478.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0002729/1.662, allocations: 282.1 kB / 0.5903 GB, free: 3.316 MB / 478.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.154e-05/1.662, allocations: 20.38 kB / 0.5903 GB, free: 3.293 MB / 478.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 2.786e-05/1.662, allocations: 24 kB / 0.5903 GB, free: 3.27 MB / 478.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0003877/1.663, allocations: 319.4 kB / 0.5907 GB, free: 2.934 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 9.928e-06/1.663, allocations: 0 / 0.5907 GB, free: 2.934 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 2.309e-05/1.663, allocations: 12 kB / 0.5907 GB, free: 2.922 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.337e-05/1.663, allocations: 11.98 kB / 0.5907 GB, free: 2.91 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0002594/1.663, allocations: 213 kB / 0.5909 GB, free: 2.703 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.03335/1.696, allocations: 18.24 MB / 0.6087 GB, free: 14.59 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0001846/1.697, allocations: 146.5 kB / 0.6088 GB, free: 14.44 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0001072/1.697, allocations: 104.8 kB / 0.6089 GB, free: 14.33 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1411/1.838, allocations: 77.94 MB / 0.6851 GB, free: 7.617 MB / 0.5762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.568e-05/1.838, allocations: 34.55 kB / 0.6851 GB, free: 7.574 MB / 0.5762 GB
Notification: Performance of pre-optimization done (n=34): time 3.016e-06/1.838, allocations: 10.19 kB / 0.6851 GB, free: 7.566 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=34): time 0.001056/1.839, allocations: 495.2 kB / 0.6856 GB, free: 7.055 MB / 0.5762 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.734e-05/1.839, allocations: 55.41 kB / 0.6856 GB, free: 6.988 MB / 0.5762 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.000367/1.839, allocations: 364.3 kB / 0.686 GB, free: 6.621 MB / 0.5762 GB
Notification: Performance of collectPreVariables (initialization): time 1.517e-05/1.839, allocations: 25.7 kB / 0.686 GB, free: 6.59 MB / 0.5762 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001217/1.84, allocations: 188.5 kB / 0.6862 GB, free: 6.402 MB / 0.5762 GB
Notification: Performance of collectInitialBindings (initialization): time 6.597e-05/1.84, allocations: 110.3 kB / 0.6863 GB, free: 6.293 MB / 0.5762 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 4.518e-05/1.84, allocations: 33.7 kB / 0.6863 GB, free: 6.254 MB / 0.5762 GB
Notification: Performance of setup shared object (initialization): time 0.000134/1.84, allocations: 346.8 kB / 0.6866 GB, free: 5.906 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001238/1.84, allocations: 91.95 kB / 0.6867 GB, free: 5.816 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0001409/1.84, allocations: 137.3 kB / 0.6869 GB, free: 5.668 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0002658/1.84, allocations: 252.5 kB / 0.6871 GB, free: 5.406 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.228e-06/1.84, allocations: 4 kB / 0.6871 GB, free: 5.402 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=42) (initialization): time 0.0004518/1.841, allocations: 341.5 kB / 0.6874 GB, free: 5.059 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 1.521e-05/1.841, allocations: 4 kB / 0.6874 GB, free: 5.055 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.426e-06/1.841, allocations: 4 kB / 0.6874 GB, free: 5.051 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008407/1.842, allocations: 172.8 kB / 0.6876 GB, free: 4.879 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 6.238e-05/1.842, allocations: 11.94 kB / 0.6876 GB, free: 4.867 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0005063/1.842, allocations: 0.6157 MB / 0.6882 GB, free: 4.227 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0001205/1.842, allocations: 27.62 kB / 0.6882 GB, free: 4.199 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 1.306e-05/1.842, allocations: 4 kB / 0.6882 GB, free: 4.195 MB / 0.5762 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 5
 * Number of states: 0 ()
 * Number of discrete variables: 4 (ControlValve.C2.b,ControlValve.C1.a,PuitsP1.C.a,SourceP1.C.b)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (13):
 * Single equations (assignments): 10
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 2
 * 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
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0001611/1.843, allocations: 161.8 kB / 0.6884 GB, free: 4.027 MB / 0.5762 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 5.006e-05/1.843, allocations: 31.56 kB / 0.6884 GB, free: 3.996 MB / 0.5762 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0008139/1.844, allocations: 0.663 MB / 0.6891 GB, free: 3.258 MB / 0.5762 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0004084/1.844, allocations: 254.4 kB / 0.6893 GB, free: 3 MB / 0.5762 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.749e-06/1.844, allocations: 7.938 kB / 0.6893 GB, free: 2.992 MB / 0.5762 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.637e-06/1.844, allocations: 0 / 0.6893 GB, free: 2.992 MB / 0.5762 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001025/1.845, allocations: 0.8203 MB / 0.6901 GB, free: 2.113 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.394e-06/1.845, allocations: 4 kB / 0.6901 GB, free: 2.109 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 6.414e-05/1.845, allocations: 20.69 kB / 0.6901 GB, free: 2.09 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0004766/1.846, allocations: 132.7 kB / 0.6903 GB, free: 1.957 MB / 0.5762 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.252e-05/1.846, allocations: 11.92 kB / 0.6903 GB, free: 1.945 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0004532/1.846, allocations: 0.6311 MB / 0.6909 GB, free: 1.289 MB / 0.5762 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.213e-06/1.846, allocations: 3.938 kB / 0.6909 GB, free: 1.285 MB / 0.5762 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0004668/1.847, allocations: 400.8 kB / 0.6913 GB, free: 0.875 MB / 0.5762 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001157/1.847, allocations: 140.6 kB / 0.6914 GB, free: 0.7188 MB / 0.5762 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 3.862e-05/1.847, allocations: 4 kB / 0.6914 GB, free: 0.7148 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0001081/1.847, allocations: 7.906 kB / 0.6914 GB, free: 0.707 MB / 0.5762 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 4.187e-05/1.847, allocations: 15.11 kB / 0.6914 GB, free: 0.6953 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 9.878e-06/1.847, allocations: 11.98 kB / 0.6915 GB, free: 0.6836 MB / 0.5762 GB
Notification: Performance of sorting global known variables: time 0.0003204/1.847, allocations: 327.1 kB / 0.6918 GB, free: 372 kB / 0.5762 GB
Notification: Performance of sort global known variables: time 1.3e-07/1.847, allocations: 4 kB / 0.6918 GB, free: 368 kB / 0.5762 GB
Notification: Performance of remove unused functions: time 0.1525/2, allocations: 1.199 MB / 0.6929 GB, free: 228.4 MB / 0.5762 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * 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 (13):
 * Single equations (assignments): 12
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * 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
   {(1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.005062/2.005, allocations: 1.772 MB / 0.6947 GB, free: 228.2 MB / 0.5762 GB
Notification: Performance of simCode: created initialization part: time 0.0006436/2.005, allocations: 273.3 kB / 0.6949 GB, free: 228.2 MB / 0.5762 GB
Notification: Performance of simCode: created event and clocks part: time 3.787e-06/2.005, allocations: 2.312 kB / 0.6949 GB, free: 228.2 MB / 0.5762 GB
Notification: Performance of simCode: created simulation system equations: time 0.0002672/2.006, allocations: 121.1 kB / 0.6951 GB, free: 228.2 MB / 0.5762 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0007892/2.007, allocations: 121.3 kB / 0.6952 GB, free: 228.2 MB / 0.5762 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0009329/2.007, allocations: 0.8036 MB / 0.696 GB, free: 227.8 MB / 0.5762 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0002036/2.008, allocations: 0.8052 MB / 0.6967 GB, free: 227.1 MB / 0.5762 GB
Notification: Performance of simCode: alias equations: time 0.0001252/2.008, allocations: 30.7 kB / 0.6968 GB, free: 227.1 MB / 0.5762 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 5.228e-05/2.008, allocations: 23.56 kB / 0.6968 GB, free: 227.1 MB / 0.5762 GB
Notification: Performance of SimCode: time 2.2e-07/2.008, allocations: 1.938 kB / 0.6968 GB, free: 227.1 MB / 0.5762 GB
Notification: Performance of Templates: time 0.0434/2.051, allocations: 42.54 MB / 0.7383 GB, free: 205.8 MB / 0.5762 GB
make -j1 -f ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve.makefile
Environment - environmentSimulation:
(rm -f ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve.pipe >> ../files/ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve.sim & ./ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve  -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoSysPro_ThermoSysPro.Examples.Book.SimpleExamples.PressureLoss.TestControlValve.pipe 2>&1)
Environment - environmentSimulation: