Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo)
Using package Modelica with version 3.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo)
Using package Complex with version 3.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo)
Using package Annex60 with version 1.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo)
Running command: translateModel(Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier")
translateModel(Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo): time 0.4353/0.4353, allocations: 55.01 MB / 69.95 MB, free: 8.648 MB / 58.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.001716/0.001716, allocations: 187.3 kB / 83.98 MB, free: 10.85 MB / 74.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo): time 1.698/1.698, allocations: 194.4 MB / 292.3 MB, free: 3.594 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo): time 0.001783/0.001783, allocations: 116.6 kB / 350.7 MB, free: 9.102 MB / 282.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000489/0.0004889, allocations: 16 kB / 418.9 MB, free: 37.02 MB / 298.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1281/0.1286, allocations: 57.65 MB / 476.5 MB, free: 11.3 MB / 330.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 5.239/5.368, allocations: 2.14 GB / 2.605 GB, free: 41.35 MB / 0.4948 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002413/5.368, allocations: 97.03 kB / 2.605 GB, free: 41.25 MB / 0.4948 GB
Notification: Performance of FrontEnd - DAE generated: time 5.373/10.74, allocations: 1.252 GB / 3.857 GB, free: 55.34 MB / 0.5573 GB
Notification: Performance of FrontEnd: time 4.869e-06/10.74, allocations: 0 / 3.857 GB, free: 55.34 MB / 0.5573 GB
Notification: Performance of Transformations before backend: time 0.0003561/10.74, allocations: 50.86 kB / 3.857 GB, free: 55.34 MB / 0.5573 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 351
 * Number of variables: 351
Notification: Performance of Generate backend data structure: time 0.01301/10.75, allocations: 2.538 MB / 3.86 GB, free: 54.47 MB / 0.5573 GB
Notification: Performance of prepare preOptimizeDAE: time 7.426e-05/10.75, allocations: 8.688 kB / 3.86 GB, free: 54.47 MB / 0.5573 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006198/10.76, allocations: 0.4958 MB / 3.86 GB, free: 54.37 MB / 0.5573 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006501/10.77, allocations: 1.558 MB / 3.862 GB, free: 54.04 MB / 0.5573 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002468/10.77, allocations: 108.8 kB / 3.862 GB, free: 54.04 MB / 0.5573 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005804/10.77, allocations: 149.2 kB / 3.862 GB, free: 54.04 MB / 0.5573 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005671/10.77, allocations: 1.832 MB / 3.864 GB, free: 53.84 MB / 0.5573 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.761e-05/10.77, allocations: 6.844 kB / 3.864 GB, free: 53.84 MB / 0.5573 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001951/10.77, allocations: 56.53 kB / 3.864 GB, free: 53.84 MB / 0.5573 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.801e-05/10.77, allocations: 51.56 kB / 3.864 GB, free: 53.83 MB / 0.5573 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003704/10.78, allocations: 1.527 MB / 3.865 GB, free: 53.82 MB / 0.5573 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.0137/10.79, allocations: 7.667 MB / 3.873 GB, free: 49.68 MB / 0.5573 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002846/10.79, allocations: 0.9129 MB / 3.874 GB, free: 49.65 MB / 0.5573 GB
Notification: Performance of preOpt evalFunc (simulation): time 8.119e-05/10.79, allocations: 24.47 kB / 3.874 GB, free: 49.64 MB / 0.5573 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.148e-05/10.8, allocations: 44.25 kB / 3.874 GB, free: 49.61 MB / 0.5573 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001733/10.8, allocations: 164.2 kB / 3.874 GB, free: 49.59 MB / 0.5573 GB
Notification: Performance of pre-optimization done (n=66): time 3.987e-06/10.8, allocations: 2 kB / 3.874 GB, free: 49.59 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=66): time 0.004986/10.8, allocations: 1.347 MB / 3.875 GB, free: 49.48 MB / 0.5573 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.487e-05/10.8, allocations: 87.7 kB / 3.875 GB, free: 49.38 MB / 0.5573 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002699/10.8, allocations: 1.111 MB / 3.876 GB, free: 49.23 MB / 0.5573 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002465/10.8, allocations: 44.39 kB / 3.876 GB, free: 49.2 MB / 0.5573 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008975/10.81, allocations: 0.8583 MB / 3.877 GB, free: 48.91 MB / 0.5573 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003338/10.81, allocations: 244.7 kB / 3.878 GB, free: 48.8 MB / 0.5573 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 7.569e-05/10.81, allocations: 22.94 kB / 3.878 GB, free: 48.8 MB / 0.5573 GB
Notification: Performance of setup shared object (initialization): time 0.0001695/10.81, allocations: 345.8 kB / 3.878 GB, free: 48.49 MB / 0.5573 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001252/10.81, allocations: 424.8 kB / 3.878 GB, free: 48.49 MB / 0.5573 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001504/10.81, allocations: 0.839 MB / 3.879 GB, free: 47.98 MB / 0.5573 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001531/10.81, allocations: 0.6501 MB / 3.88 GB, free: 47.84 MB / 0.5573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.967e-05/10.81, allocations: 4.188 kB / 3.88 GB, free: 47.84 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=134) (initialization): time 0.004047/10.81, allocations: 1.508 MB / 3.881 GB, free: 47.61 MB / 0.5573 GB
Notification: Performance of prepare postOptimizeDAE: time 0.002219/10.82, allocations: 4.813 MB / 3.886 GB, free: 42.68 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.411e-05/10.82, allocations: 11.09 kB / 3.886 GB, free: 42.68 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 9.828e-05/10.82, allocations: 19.31 kB / 3.886 GB, free: 42.68 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001358/10.82, allocations: 269.2 kB / 3.886 GB, free: 42.68 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 5.723e-05/10.82, allocations: 27.36 kB / 3.886 GB, free: 42.68 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002765/10.82, allocations: 153.7 kB / 3.886 GB, free: 42.67 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001607/10.82, allocations: 55.52 kB / 3.886 GB, free: 42.67 MB / 0.5573 GB
Notification: Performance of prepare postOptimizeDAE: time 4.629e-05/10.82, allocations: 2.469 kB / 3.886 GB, free: 42.67 MB / 0.5573 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002394/10.82, allocations: 1.25 MB / 3.888 GB, free: 42.53 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.895e-05/10.82, allocations: 13.06 kB / 3.888 GB, free: 42.53 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.118e-05/10.82, allocations: 20.44 kB / 3.888 GB, free: 42.53 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009662/10.83, allocations: 238.2 kB / 3.888 GB, free: 42.53 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.075e-05/10.83, allocations: 25.61 kB / 3.888 GB, free: 42.52 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002531/10.83, allocations: 131.4 kB / 3.888 GB, free: 42.52 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001562/10.83, allocations: 57.78 kB / 3.888 GB, free: 42.52 MB / 0.5573 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 53
 * Number of states: 0 ()
 * Number of discrete variables: 4 (humBac.vol.i_w,humFor.vol.i_w,senMas1.i_x,senMas2.i_x)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (134):
 * Single equations (assignments): 130
 * Array equations: 0
 * Algorithm blocks: 4
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.001655/10.83, allocations: 0.5162 MB / 3.889 GB, free: 42.33 MB / 0.5573 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007177/10.83, allocations: 146.4 kB / 3.889 GB, free: 42.25 MB / 0.5573 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002549/10.83, allocations: 0.9537 MB / 3.89 GB, free: 42.18 MB / 0.5573 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.443e-05/10.83, allocations: 6.5 kB / 3.89 GB, free: 42.18 MB / 0.5573 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.302e-05/10.83, allocations: 3.953 kB / 3.89 GB, free: 42.18 MB / 0.5573 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001691/10.83, allocations: 0.9182 MB / 3.891 GB, free: 41.91 MB / 0.5573 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00711/10.84, allocations: 2.426 MB / 3.893 GB, free: 41.57 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.097e-06/10.84, allocations: 8.094 kB / 3.893 GB, free: 41.57 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00117/10.84, allocations: 190.9 kB / 3.893 GB, free: 41.57 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (simulation): time 2.485e-05/10.84, allocations: 8.578 kB / 3.893 GB, free: 41.56 MB / 0.5573 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.956e-05/10.84, allocations: 23.72 kB / 3.893 GB, free: 41.56 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.224e-05/10.84, allocations: 4 kB / 3.893 GB, free: 41.56 MB / 0.5573 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.911e-06/10.84, allocations: 0.9062 kB / 3.893 GB, free: 41.56 MB / 0.5573 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003523/10.85, allocations: 1.545 MB / 3.895 GB, free: 41.25 MB / 0.5573 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001765/10.85, allocations: 325.4 kB / 3.895 GB, free: 41.08 MB / 0.5573 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0008467/10.85, allocations: 21.19 kB / 3.895 GB, free: 41.08 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002345/10.85, allocations: 118.1 kB / 3.895 GB, free: 41.07 MB / 0.5573 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001662/10.85, allocations: 43.61 kB / 3.895 GB, free: 41.07 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001786/10.85, allocations: 34.41 kB / 3.895 GB, free: 41.07 MB / 0.5573 GB
Notification: Performance of sorting global known variables: time 0.002738/10.85, allocations: 0.854 MB / 3.896 GB, free: 40.96 MB / 0.5573 GB
Notification: Performance of sort global known variables: time 2.81e-07/10.85, allocations: 0 / 3.896 GB, free: 40.96 MB / 0.5573 GB
Notification: Performance of remove unused functions: time 0.007568/10.86, allocations: 1.173 MB / 3.897 GB, free: 40.86 MB / 0.5573 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 6 (humBac.vol.dynBal.U,humBac.vol.dynBal.m,humBac.vol.dynBal.mXi[1],humFor.vol.dynBal.U,humFor.vol.dynBal.m,humFor.vol.dynBal.mXi[1])
 * 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 (70):
 * Single equations (assignments): 70
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.007033/10.87, allocations: 3.142 MB / 3.9 GB, free: 39.51 MB / 0.5573 GB
Notification: Performance of simCode: created initialization part: time 0.004768/10.87, allocations: 1.985 MB / 3.902 GB, free: 39 MB / 0.5573 GB
Notification: Performance of simCode: created event and clocks part: time 1.221e-05/10.87, allocations: 448 / 3.902 GB, free: 39 MB / 0.5573 GB
Notification: Performance of simCode: created simulation system equations: time 0.0009941/10.88, allocations: 414.5 kB / 3.903 GB, free: 39 MB / 0.5573 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005379/10.88, allocations: 0.8207 MB / 3.903 GB, free: 38.97 MB / 0.5573 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008549/10.89, allocations: 3.659 MB / 3.907 GB, free: 37.41 MB / 0.5573 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001777/10.89, allocations: 1.403 MB / 3.908 GB, free: 36.7 MB / 0.5573 GB
Notification: Performance of simCode: alias equations: time 0.003703/10.89, allocations: 443.6 kB / 3.909 GB, free: 36.68 MB / 0.5573 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007793/10.9, allocations: 115.9 kB / 3.909 GB, free: 36.67 MB / 0.5573 GB
Notification: Performance of SimCode: time 2.274e-06/10.9, allocations: 0 / 3.909 GB, free: 36.67 MB / 0.5573 GB
Notification: Performance of Templates: time 0.104/11, allocations: 61.57 MB / 3.969 GB, free: 33.41 MB / 0.5573 GB
make -j1 -f Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier.makefile
(rm -f Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe ; mkfifo Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe ; head -c 1048576 < Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe >> ../files/Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier.sim & ./Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Annex60_1.0.0_Annex60.Fluid.Interfaces.Examples.ReverseFlowHumidifier.pipe 2>&1)