Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.Interfaces.Examples.ReverseFlowMassExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Interfaces.Examples.ReverseFlowMassExchanger")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.003644/0.00365, allocations: 355.6 kB / 16.58 MB, free: 5.566 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.403/1.403, allocations: 165.8 MB / 183.1 MB, free: 5.395 MB / 138.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 3.555/3.555, allocations: 410.8 MB / 0.6001 GB, free: 15.09 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001752/0.001751, allocations: 190.9 kB / 0.6668 GB, free: 6.918 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004541/0.0004544, allocations: 15.94 kB / 0.7429 GB, free: 8.957 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3901/0.3906, allocations: 67.44 MB / 0.8087 GB, free: 28.79 MB / 378.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 5.759/6.15, allocations: 2.056 GB / 2.865 GB, free: 38.59 MB / 0.573 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003335/6.15, allocations: 102.2 kB / 2.865 GB, free: 38.53 MB / 0.573 GB
Notification: Performance of FrontEnd - DAE generated: time 15.1/21.25, allocations: 2.809 GB / 5.674 GB, free: 45.51 MB / 0.698 GB
Notification: Performance of FrontEnd: time 2.916e-06/21.25, allocations: 3.938 kB / 5.674 GB, free: 45.51 MB / 0.698 GB
Notification: Performance of Transformations before backend: time 0.0003781/21.26, allocations: 66.03 kB / 5.674 GB, free: 45.5 MB / 0.698 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 536
 * Number of variables: 536
Notification: Performance of Generate backend data structure: time 0.01708/21.27, allocations: 3.912 MB / 5.677 GB, free: 43.45 MB / 0.698 GB
Notification: Performance of prepare preOptimizeDAE: time 4.441e-05/21.27, allocations: 9.812 kB / 5.677 GB, free: 43.45 MB / 0.698 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01724/21.29, allocations: 1.2 MB / 5.679 GB, free: 43.29 MB / 0.698 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.009582/21.3, allocations: 2.36 MB / 5.681 GB, free: 42.7 MB / 0.698 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002478/21.3, allocations: 438.3 kB / 5.681 GB, free: 42.69 MB / 0.698 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001133/21.3, allocations: 227.7 kB / 5.682 GB, free: 42.68 MB / 0.698 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01103/21.31, allocations: 3.139 MB / 5.685 GB, free: 42.26 MB / 0.698 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.791e-05/21.31, allocations: 7.188 kB / 5.685 GB, free: 42.26 MB / 0.698 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004831/21.31, allocations: 90.19 kB / 5.685 GB, free: 42.26 MB / 0.698 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001236/21.31, allocations: 92.78 kB / 5.685 GB, free: 42.25 MB / 0.698 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0133/21.33, allocations: 3.228 MB / 5.688 GB, free: 42.2 MB / 0.698 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.0402/21.37, allocations: 14.08 MB / 5.702 GB, free: 34.5 MB / 0.698 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006998/21.38, allocations: 1.706 MB / 5.703 GB, free: 34.41 MB / 0.698 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003062/21.38, allocations: 0.7861 MB / 5.704 GB, free: 34.39 MB / 0.698 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000794/21.38, allocations: 327 kB / 5.704 GB, free: 34.11 MB / 0.698 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.926e-05/21.38, allocations: 49.19 kB / 5.704 GB, free: 34.07 MB / 0.698 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002516/21.38, allocations: 214.4 kB / 5.705 GB, free: 33.98 MB / 0.698 GB
Notification: Performance of pre-optimization done (n=110): time 5.841e-06/21.38, allocations: 0 / 5.705 GB, free: 33.98 MB / 0.698 GB
Notification: Performance of matching and sorting (n=110): time 0.01014/21.39, allocations: 2.393 MB / 5.707 GB, free: 33.75 MB / 0.698 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.135e-05/21.39, allocations: 68.56 kB / 5.707 GB, free: 33.68 MB / 0.698 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006171/21.4, allocations: 2.538 MB / 5.71 GB, free: 33.41 MB / 0.698 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005067/21.4, allocations: 60.11 kB / 5.71 GB, free: 33.38 MB / 0.698 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001181/21.4, allocations: 1.269 MB / 5.711 GB, free: 32.92 MB / 0.698 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0005076/21.4, allocations: 392.2 kB / 5.711 GB, free: 32.68 MB / 0.698 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002333/21.4, allocations: 35.03 kB / 5.711 GB, free: 32.68 MB / 0.698 GB
Notification: Performance of setup shared object (initialization): time 0.0001195/21.4, allocations: 371.8 kB / 5.712 GB, free: 32.37 MB / 0.698 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00451/21.41, allocations: 0.9928 MB / 5.713 GB, free: 32.34 MB / 0.698 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005172/21.41, allocations: 1.67 MB / 5.714 GB, free: 31.49 MB / 0.698 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00504/21.42, allocations: 1.213 MB / 5.715 GB, free: 31 MB / 0.698 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.39e-05/21.42, allocations: 3.625 kB / 5.715 GB, free: 31 MB / 0.698 GB
Notification: Performance of matching and sorting (n=216) (initialization): time 0.01214/21.43, allocations: 2.883 MB / 5.718 GB, free: 29.98 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000356/21.43, allocations: 0.5546 MB / 5.719 GB, free: 29.27 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.315e-05/21.43, allocations: 10.41 kB / 5.719 GB, free: 29.27 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.369e-05/21.43, allocations: 27.58 kB / 5.719 GB, free: 29.26 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005954/21.43, allocations: 0.5875 MB / 5.719 GB, free: 29.21 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001247/21.44, allocations: 2.395 MB / 5.722 GB, free: 26.82 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007148/21.44, allocations: 467.2 kB / 5.722 GB, free: 26.73 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000584/21.44, allocations: 99.61 kB / 5.722 GB, free: 26.71 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 1.303e-05/21.44, allocations: 3.906 kB / 5.722 GB, free: 26.71 MB / 0.698 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01097/21.45, allocations: 2.648 MB / 5.725 GB, free: 25.81 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.399e-05/21.45, allocations: 16.94 kB / 5.725 GB, free: 25.8 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.264e-05/21.45, allocations: 23.72 kB / 5.725 GB, free: 25.8 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004981/21.46, allocations: 0.5327 MB / 5.725 GB, free: 25.75 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.75e-05/21.46, allocations: 34.73 kB / 5.725 GB, free: 25.75 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006163/21.47, allocations: 396.7 kB / 5.726 GB, free: 25.66 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005357/21.47, allocations: 94.98 kB / 5.726 GB, free: 25.64 MB / 0.698 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 61
 * Number of states: 0 ()
 * Number of discrete variables: 4 (masExcFor.i1_w,masExcFor.i2_w,masExcRev.i1_w,masExcRev.i2_w)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (214):
 * Single equations (assignments): 208
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 4
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 4 {1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.00199/21.47, allocations: 0.6341 MB / 5.727 GB, free: 25.21 MB / 0.698 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007798/21.47, allocations: 264.8 kB / 5.727 GB, free: 24.96 MB / 0.698 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007236/21.48, allocations: 1.876 MB / 5.729 GB, free: 23.4 MB / 0.698 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.589e-05/21.48, allocations: 12 kB / 5.729 GB, free: 23.39 MB / 0.698 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.024e-05/21.48, allocations: 3.953 kB / 5.729 GB, free: 23.38 MB / 0.698 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.544e-05/21.48, allocations: 7.5 kB / 5.729 GB, free: 23.38 MB / 0.698 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01373/21.49, allocations: 4.488 MB / 5.733 GB, free: 19.73 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.249e-05/21.49, allocations: 7.938 kB / 5.733 GB, free: 19.73 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00323/21.49, allocations: 315.5 kB / 5.733 GB, free: 19.48 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.969e-05/21.49, allocations: 12 kB / 5.733 GB, free: 19.46 MB / 0.698 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001727/21.49, allocations: 31.55 kB / 5.733 GB, free: 19.44 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0009502/21.5, allocations: 2.366 MB / 5.736 GB, free: 17 MB / 0.698 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.356e-06/21.5, allocations: 11.94 kB / 5.736 GB, free: 16.99 MB / 0.698 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006806/21.5, allocations: 1.999 MB / 5.738 GB, free: 15.11 MB / 0.698 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002002/21.5, allocations: 0.5398 MB / 5.738 GB, free: 14.63 MB / 0.698 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000678/21.5, allocations: 31.12 kB / 5.738 GB, free: 14.61 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004993/21.51, allocations: 287.9 kB / 5.738 GB, free: 14.39 MB / 0.698 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002754/21.51, allocations: 87.66 kB / 5.739 GB, free: 14.32 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000267/21.51, allocations: 62.5 kB / 5.739 GB, free: 14.27 MB / 0.698 GB
Notification: Performance of sorting global known variables: time 0.004851/21.52, allocations: 1.748 MB / 5.74 GB, free: 12.81 MB / 0.698 GB
Notification: Performance of sort global known variables: time 5.41e-07/21.52, allocations: 0 / 5.74 GB, free: 12.81 MB / 0.698 GB
Notification: Performance of remove unused functions: time 0.008651/21.52, allocations: 1.929 MB / 5.742 GB, free: 10.92 MB / 0.698 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 25
 * 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 (110):
 * Single equations (assignments): 106
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 4
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 4 {1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.01301/21.54, allocations: 7.627 MB / 5.75 GB, free: 3.828 MB / 0.698 GB
Notification: Performance of simCode: created initialization part: time 0.01579/21.55, allocations: 3.706 MB / 5.753 GB, free: 0.6055 MB / 0.698 GB
Notification: Performance of simCode: created event and clocks part: time 1.397e-05/21.55, allocations: 0 / 5.753 GB, free: 0.6055 MB / 0.698 GB
Notification: Performance of simCode: created simulation system equations: time 0.003694/21.56, allocations: 0.8266 MB / 5.754 GB, free: 15.9 MB / 0.7136 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01287/21.57, allocations: 1.211 MB / 5.755 GB, free: 15.02 MB / 0.7136 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01434/21.58, allocations: 5.009 MB / 5.76 GB, free: 10.3 MB / 0.7136 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001978/21.59, allocations: 1.744 MB / 5.762 GB, free: 8.906 MB / 0.7136 GB
Notification: Performance of simCode: alias equations: time 0.006581/21.59, allocations: 0.7909 MB / 5.763 GB, free: 8.324 MB / 0.7136 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001258/21.59, allocations: 194.8 kB / 5.763 GB, free: 8.148 MB / 0.7136 GB
Notification: Performance of SimCode: time 1.423e-06/21.59, allocations: 0 / 5.763 GB, free: 8.148 MB / 0.7136 GB
Notification: Performance of Templates: time 0.903/22.5, allocations: 110.8 MB / 5.871 GB, free: 61.29 MB / 0.7136 GB