Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Movers.Validation.Pump_Nrpm_stratos.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.Movers.Validation.Pump_Nrpm_stratos,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Movers.Validation.Pump_Nrpm_stratos")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002705/0.002711, allocations: 354.7 kB / 16.58 MB, free: 5.578 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.253/1.253, allocations: 165.8 MB / 183.1 MB, free: 5.922 MB / 90.72 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.027/4.027, allocations: 410.7 MB / 0.6001 GB, free: 2.195 MB / 410.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001849/0.001848, allocations: 187.5 kB / 0.6668 GB, free: 14.05 MB / 490.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006087/0.0006089, allocations: 8 kB / 0.7429 GB, free: 52 kB / 0.5417 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4568/0.4574, allocations: 67.43 MB / 0.8087 GB, free: 245.3 MB / 0.5886 GB
Notification: Performance of FrontEnd - scodeFlatten: time 0.8101/1.268, allocations: 361.6 MB / 1.162 GB, free: 129.1 MB / 0.5886 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003006/1.268, allocations: 96.05 kB / 1.162 GB, free: 129 MB / 0.5886 GB
Notification: Performance of FrontEnd - DAE generated: time 14.87/16.14, allocations: 2.686 GB / 3.848 GB, free: 47.35 MB / 0.7292 GB
Notification: Performance of FrontEnd: time 2.274e-06/16.14, allocations: 0 / 3.848 GB, free: 47.35 MB / 0.7292 GB
Notification: Performance of Transformations before backend: time 0.002447/16.14, allocations: 274.9 kB / 3.848 GB, free: 47.31 MB / 0.7292 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1234
 * Number of variables: 1234
Notification: Performance of Generate backend data structure: time 0.07269/16.21, allocations: 15.18 MB / 3.863 GB, free: 42.14 MB / 0.7292 GB
Notification: Performance of prepare preOptimizeDAE: time 4.651e-05/16.21, allocations: 9.531 kB / 3.863 GB, free: 42.14 MB / 0.7292 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02889/16.24, allocations: 2.863 MB / 3.866 GB, free: 41.5 MB / 0.7292 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1995/16.44, allocations: 57.53 MB / 3.922 GB, free: 37.81 MB / 0.7292 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008191/16.44, allocations: 437.8 kB / 3.922 GB, free: 37.8 MB / 0.7292 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003302/16.45, allocations: 0.5763 MB / 3.923 GB, free: 37.79 MB / 0.7292 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02768/16.47, allocations: 6.835 MB / 3.93 GB, free: 36.65 MB / 0.7292 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002617/16.47, allocations: 7.344 kB / 3.93 GB, free: 36.65 MB / 0.7292 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00228/16.48, allocations: 211.9 kB / 3.93 GB, free: 36.65 MB / 0.7292 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001659/16.48, allocations: 119.7 kB / 3.93 GB, free: 36.65 MB / 0.7292 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02631/16.5, allocations: 4.89 MB / 3.935 GB, free: 36.57 MB / 0.7292 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.08759/16.59, allocations: 29.88 MB / 3.964 GB, free: 25.63 MB / 0.7292 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02221/16.61, allocations: 4.187 MB / 3.968 GB, free: 25.53 MB / 0.7292 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008504/16.62, allocations: 1.836 MB / 3.97 GB, free: 25.49 MB / 0.7292 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.03398/16.66, allocations: 11.05 MB / 3.981 GB, free: 21.73 MB / 0.7292 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.559e-05/16.66, allocations: 70.47 kB / 3.981 GB, free: 21.68 MB / 0.7292 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.00757/16.66, allocations: 0.6611 MB / 3.981 GB, free: 21.44 MB / 0.7292 GB
Notification: Performance of pre-optimization done (n=262): time 1.363e-05/16.66, allocations: 0 / 3.981 GB, free: 21.44 MB / 0.7292 GB
Notification: Performance of matching and sorting (n=262): time 0.05478/16.72, allocations: 8.215 MB / 3.989 GB, free: 20.14 MB / 0.7292 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002371/16.72, allocations: 0.7133 MB / 3.99 GB, free: 19.3 MB / 0.7292 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03722/16.76, allocations: 11.66 MB / 4.001 GB, free: 17.59 MB / 0.7292 GB
Notification: Performance of collectPreVariables (initialization): time 0.001991/16.76, allocations: 117.2 kB / 4.001 GB, free: 17.5 MB / 0.7292 GB
Notification: Performance of collectInitialEqns (initialization): time 0.009138/16.77, allocations: 4.971 MB / 4.006 GB, free: 13.61 MB / 0.7292 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002254/16.77, allocations: 0.908 MB / 4.007 GB, free: 12.9 MB / 0.7292 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001226/16.77, allocations: 95.5 kB / 4.007 GB, free: 12.83 MB / 0.7292 GB
Notification: Performance of setup shared object (initialization): time 0.0005129/16.77, allocations: 0.502 MB / 4.008 GB, free: 12.43 MB / 0.7292 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.009583/16.78, allocations: 2.177 MB / 4.01 GB, free: 11.7 MB / 0.7292 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01191/16.79, allocations: 4.533 MB / 4.014 GB, free: 7.914 MB / 0.7292 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01089/16.8, allocations: 2.66 MB / 4.017 GB, free: 6.828 MB / 0.7292 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.703e-05/16.8, allocations: 18.06 kB / 4.017 GB, free: 6.828 MB / 0.7292 GB
Notification: Performance of matching and sorting (n=667) (initialization): time 0.03375/16.84, allocations: 7.724 MB / 4.024 GB, free: 3.84 MB / 0.7292 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001422/16.84, allocations: 1.855 MB / 4.026 GB, free: 1.273 MB / 0.7292 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002424/16.84, allocations: 81.48 kB / 4.026 GB, free: 1.273 MB / 0.7292 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004891/16.84, allocations: 0.9731 MB / 4.027 GB, free: 1.035 MB / 0.7292 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00983/16.85, allocations: 1.189 MB / 4.028 GB, free: 0.918 MB / 0.7292 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008852/16.86, allocations: 4.058 MB / 4.032 GB, free: 13.74 MB / 0.7448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01316/16.88, allocations: 476.1 kB / 4.033 GB, free: 13.63 MB / 0.7448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002113/16.88, allocations: 454.6 kB / 4.033 GB, free: 13.58 MB / 0.7448 GB
Notification: Performance of prepare postOptimizeDAE: time 1.748e-05/16.88, allocations: 9.359 kB / 4.033 GB, free: 13.58 MB / 0.7448 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.02743/16.91, allocations: 6.923 MB / 4.04 GB, free: 10.96 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002692/16.91, allocations: 76.05 kB / 4.04 GB, free: 10.96 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0049/16.91, allocations: 0.9872 MB / 4.041 GB, free: 10.41 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008911/16.92, allocations: 1.105 MB / 4.042 GB, free: 9.469 MB / 0.7448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009258/16.93, allocations: 4.056 MB / 4.046 GB, free: 5.52 MB / 0.7448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01198/16.94, allocations: 450.4 kB / 4.047 GB, free: 5.164 MB / 0.7448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001954/16.94, allocations: 399.9 kB / 4.047 GB, free: 4.805 MB / 0.7448 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 266
 * 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 initialization (542):
 * Single equations (assignments): 507
 * Array equations: 20
 * Algorithm blocks: 0
 * Record equations: 10
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 5 {2 9,2 9,2 9,2 9,2 9}
Notification: Performance of prepare postOptimizeDAE: time 0.009383/16.95, allocations: 2.324 MB / 4.049 GB, free: 2.684 MB / 0.7448 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003561/16.96, allocations: 0.9408 MB / 4.05 GB, free: 1.73 MB / 0.7448 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04475/17, allocations: 7.018 MB / 4.057 GB, free: 13.53 MB / 0.7605 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001257/17, allocations: 42.14 kB / 4.057 GB, free: 13.5 MB / 0.7605 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.562e-05/17, allocations: 3.938 kB / 4.057 GB, free: 13.49 MB / 0.7605 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001094/17, allocations: 20.45 kB / 4.057 GB, free: 13.49 MB / 0.7605 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 postOpt removeSimpleEquations (simulation): time 0.05825/17.06, allocations: 13.64 MB / 4.07 GB, free: 2.887 MB / 0.7605 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.173e-05/17.06, allocations: 0 / 4.07 GB, free: 2.887 MB / 0.7605 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.006368/17.07, allocations: 0.5758 MB / 4.071 GB, free: 2.43 MB / 0.7605 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004536/17.07, allocations: 0.7605 MB / 4.072 GB, free: 1.809 MB / 0.7605 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.00101/17.07, allocations: 128.6 kB / 4.072 GB, free: 1.715 MB / 0.7605 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007015/17.08, allocations: 3.649 MB / 4.075 GB, free: 14.1 MB / 0.7761 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.406e-06/17.08, allocations: 4.031 kB / 4.075 GB, free: 14.09 MB / 0.7761 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04049/17.12, allocations: 8.163 MB / 4.083 GB, free: 6.906 MB / 0.7761 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.007651/17.13, allocations: 1.881 MB / 4.085 GB, free: 5.246 MB / 0.7761 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003684/17.13, allocations: 72.62 kB / 4.085 GB, free: 5.176 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01144/17.14, allocations: 430 kB / 4.086 GB, free: 4.863 MB / 0.7761 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0009797/17.14, allocations: 195.9 kB / 4.086 GB, free: 4.742 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0008124/17.14, allocations: 184.2 kB / 4.086 GB, free: 4.602 MB / 0.7761 GB
Notification: Performance of sorting global known variables: time 0.7525/17.9, allocations: 8.174 MB / 4.094 GB, free: 86.6 MB / 0.7761 GB
Notification: Performance of sort global known variables: time 8.61e-07/17.9, allocations: 0 / 4.094 GB, free: 86.6 MB / 0.7761 GB
Notification: Performance of remove unused functions: time 0.02436/17.92, allocations: 4.313 MB / 4.098 GB, free: 86.6 MB / 0.7761 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 20 (pump1.filter.x[1],pump1.filter.x[2],pump2.filter.x[1],pump2.filter.x[2],pump3.filter.x[1],pump3.filter.x[2],pump4.filter.x[1],pump4.filter.x[2],pump5.filter.x[1],pump5.filter.x[2],forcedPump1.filter.x[1],forcedPump1.filter.x[2],forcedPump2.filter.x[1],forcedPump2.filter.x[2],forcedPump3.filter.x[1],forcedPump3.filter.x[2],forcedPump4.filter.x[1],forcedPump4.filter.x[2],forcedPump5.filter.x[1],forcedPump5.filter.x[2])
 * 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 (274):
 * Single equations (assignments): 247
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 22
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 5 {2 8,2 8,2 8,2 8,2 8}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01016/17.93, allocations: 4.546 MB / 4.103 GB, free: 85.04 MB / 0.7761 GB
Notification: Performance of simCode: created initialization part: time 0.03785/17.97, allocations: 9.587 MB / 4.112 GB, free: 84.32 MB / 0.7761 GB
Notification: Performance of simCode: created event and clocks part: time 1.539e-05/17.97, allocations: 3.094 kB / 4.112 GB, free: 84.32 MB / 0.7761 GB
Notification: Performance of simCode: created simulation system equations: time 0.009807/17.98, allocations: 2.184 MB / 4.114 GB, free: 84.3 MB / 0.7761 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03699/18.02, allocations: 4.732 MB / 4.119 GB, free: 84.25 MB / 0.7761 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.04948/18.07, allocations: 19.49 MB / 4.138 GB, free: 76.28 MB / 0.7761 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01229/18.08, allocations: 5.251 MB / 4.143 GB, free: 75.38 MB / 0.7761 GB
Notification: Performance of simCode: alias equations: time 0.0239/18.1, allocations: 2.825 MB / 4.146 GB, free: 75.29 MB / 0.7761 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004953/18.11, allocations: 0.8162 MB / 4.147 GB, free: 75.29 MB / 0.7761 GB
Notification: Performance of SimCode: time 1.352e-06/18.11, allocations: 0 / 4.147 GB, free: 75.29 MB / 0.7761 GB
Notification: Performance of Templates: time 0.5987/18.71, allocations: 211.7 MB / 4.353 GB, free: 2.277 MB / 0.7917 GB