Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Movers.Validation.SpeedControlled_y.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.SpeedControlled_y,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Movers.Validation.SpeedControlled_y")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.00357/0.00357, allocations: 361.7 kB / 16.59 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.515/1.515, allocations: 165.8 MB / 183.1 MB, free: 5.387 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.669/3.669, allocations: 410.8 MB / 0.6001 GB, free: 15.17 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.002529/0.002529, allocations: 187.9 kB / 0.6668 GB, free: 6.938 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004974/0.0004976, allocations: 12 kB / 0.7429 GB, free: 8.984 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3926/0.3932, allocations: 67.46 MB / 0.8087 GB, free: 28.8 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Movers.Validation.SpeedControlled_y): time 0.8157/1.209, allocations: 287.2 MB / 1.089 GB, free: 9.496 MB / 0.5417 GB
Notification: Performance of NFInst.instExpressions: time 0.04623/1.255, allocations: 22.32 MB / 1.111 GB, free: 3.129 MB / 0.5573 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003535/1.259, allocations: 75.5 kB / 1.111 GB, free: 3.055 MB / 0.5573 GB
Notification: Performance of NFTyping.typeComponents: time 0.00545/1.264, allocations: 1.11 MB / 1.112 GB, free: 1.938 MB / 0.5573 GB
Notification: Performance of NFTyping.typeBindings: time 0.01644/1.281, allocations: 4.041 MB / 1.116 GB, free: 13.88 MB / 0.573 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01354/1.294, allocations: 3.17 MB / 1.119 GB, free: 10.74 MB / 0.573 GB
Notification: Performance of NFFlatten.flatten: time 0.01231/1.307, allocations: 6.625 MB / 1.126 GB, free: 4.098 MB / 0.573 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004105/1.311, allocations: 1.614 MB / 1.127 GB, free: 2.453 MB / 0.573 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007717/1.319, allocations: 2.341 MB / 1.13 GB, free: 104 kB / 0.573 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004604/1.323, allocations: 1.72 MB / 1.131 GB, free: 14.37 MB / 0.5886 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007154/1.324, allocations: 96 kB / 1.131 GB, free: 14.28 MB / 0.5886 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00703/1.331, allocations: 1.804 MB / 1.133 GB, free: 12.47 MB / 0.5886 GB
Notification: Performance of NFScalarize.scalarize: time 0.001914/1.333, allocations: 0.7826 MB / 1.134 GB, free: 11.69 MB / 0.5886 GB
Notification: Performance of NFVerifyModel.verify: time 0.001578/1.335, allocations: 0.5238 MB / 1.134 GB, free: 11.16 MB / 0.5886 GB
Notification: Performance of NFConvertDAE.convert: time 0.007582/1.342, allocations: 3.363 MB / 1.138 GB, free: 7.785 MB / 0.5886 GB
Notification: Performance of FrontEnd - DAE generated: time 8.846e-06/1.342, allocations: 0 / 1.138 GB, free: 7.785 MB / 0.5886 GB
Notification: Performance of FrontEnd: time 2.655e-06/1.342, allocations: 3.938 kB / 1.138 GB, free: 7.781 MB / 0.5886 GB
Notification: Performance of Transformations before backend: time 0.000117/1.342, allocations: 0 / 1.138 GB, free: 7.781 MB / 0.5886 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 349
 * Number of variables: 349
Notification: Performance of Generate backend data structure: time 0.008179/1.351, allocations: 2.618 MB / 1.14 GB, free: 5.102 MB / 0.5886 GB
Notification: Performance of prepare preOptimizeDAE: time 5.933e-05/1.351, allocations: 8.031 kB / 1.14 GB, free: 5.094 MB / 0.5886 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009471/1.36, allocations: 0.8943 MB / 1.141 GB, free: 4.195 MB / 0.5886 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007673/1.368, allocations: 2.005 MB / 1.143 GB, free: 2.117 MB / 0.5886 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002197/1.368, allocations: 115.1 kB / 1.143 GB, free: 2.004 MB / 0.5886 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006123/1.369, allocations: 152 kB / 1.143 GB, free: 1.855 MB / 0.5886 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005796/1.375, allocations: 1.714 MB / 1.145 GB, free: 88 kB / 0.5886 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.401e-05/1.375, allocations: 0 / 1.145 GB, free: 88 kB / 0.5886 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002347/1.375, allocations: 56 kB / 1.145 GB, free: 32 kB / 0.5886 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001056/1.375, allocations: 50.72 kB / 1.145 GB, free: 15.98 MB / 0.6042 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005721/1.381, allocations: 1.349 MB / 1.146 GB, free: 14.62 MB / 0.6042 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.01706/1.398, allocations: 7.702 MB / 1.154 GB, free: 6.328 MB / 0.6042 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004808/1.403, allocations: 0.9902 MB / 1.155 GB, free: 5.332 MB / 0.6042 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002317/1.405, allocations: 0.553 MB / 1.155 GB, free: 4.773 MB / 0.6042 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003054/1.406, allocations: 113.7 kB / 1.156 GB, free: 4.645 MB / 0.6042 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.778e-05/1.406, allocations: 47.16 kB / 1.156 GB, free: 4.586 MB / 0.6042 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001377/1.407, allocations: 139.1 kB / 1.156 GB, free: 4.449 MB / 0.6042 GB
Notification: Performance of pre-optimization done (n=81): time 4.418e-06/1.407, allocations: 0 / 1.156 GB, free: 4.449 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=81): time 0.009507/1.417, allocations: 1.842 MB / 1.158 GB, free: 2.559 MB / 0.6042 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.141e-05/1.417, allocations: 60.06 kB / 1.158 GB, free: 2.488 MB / 0.6042 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003738/1.42, allocations: 1.819 MB / 1.159 GB, free: 0.6367 MB / 0.6042 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002888/1.421, allocations: 49.7 kB / 1.159 GB, free: 0.582 MB / 0.6042 GB
Notification: Performance of collectInitialEqns (initialization): time 0.3617/1.782, allocations: 1 MB / 1.16 GB, free: 256.1 MB / 0.6042 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0005296/1.783, allocations: 283.9 kB / 1.161 GB, free: 256 MB / 0.6042 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001185/1.783, allocations: 24.44 kB / 1.161 GB, free: 256 MB / 0.6042 GB
Notification: Performance of setup shared object (initialization): time 0.0001314/1.783, allocations: 347.2 kB / 1.161 GB, free: 255.7 MB / 0.6042 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001841/1.785, allocations: 449 kB / 1.161 GB, free: 255.7 MB / 0.6042 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002109/1.787, allocations: 0.8529 MB / 1.162 GB, free: 255.3 MB / 0.6042 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002128/1.789, allocations: 0.5412 MB / 1.163 GB, free: 255.2 MB / 0.6042 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.033e-05/1.79, allocations: 2.688 kB / 1.163 GB, free: 255.2 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=135) (initialization): time 0.006141/1.796, allocations: 1.521 MB / 1.164 GB, free: 254.6 MB / 0.6042 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002335/1.796, allocations: 381.8 kB / 1.165 GB, free: 254.1 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.555e-05/1.796, allocations: 9.438 kB / 1.165 GB, free: 254.1 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001333/1.797, allocations: 192.5 kB / 1.165 GB, free: 254.1 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002242/1.8, allocations: 256.5 kB / 1.165 GB, free: 254 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001572/1.801, allocations: 1.868 MB / 1.167 GB, free: 252.3 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002786/1.804, allocations: 138 kB / 1.167 GB, free: 252.3 MB / 0.6042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002074/1.804, allocations: 68.92 kB / 1.167 GB, free: 252.3 MB / 0.6042 GB
Notification: Performance of prepare postOptimizeDAE: time 1.234e-05/1.804, allocations: 4.281 kB / 1.167 GB, free: 252.3 MB / 0.6042 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.005236/1.809, allocations: 1.451 MB / 1.169 GB, free: 251.7 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.424e-05/1.81, allocations: 12.56 kB / 1.169 GB, free: 251.7 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00199/1.812, allocations: 311.6 kB / 1.169 GB, free: 251.7 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001993/1.814, allocations: 235.1 kB / 1.169 GB, free: 251.7 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007324/1.821, allocations: 3.468 MB / 1.172 GB, free: 249 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002617/1.824, allocations: 134 kB / 1.173 GB, free: 249 MB / 0.6042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002173/1.824, allocations: 59.11 kB / 1.173 GB, free: 249 MB / 0.6042 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 43
 * 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 (120):
 * Single equations (assignments): 115
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 7,1 4}
Notification: Performance of prepare postOptimizeDAE: time 0.001569/1.825, allocations: 0.6101 MB / 1.173 GB, free: 248.6 MB / 0.6042 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000493/1.826, allocations: 200.8 kB / 1.173 GB, free: 248.5 MB / 0.6042 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006553/1.832, allocations: 1.328 MB / 1.175 GB, free: 248 MB / 0.6042 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00657/1.839, allocations: 1.127 MB / 1.176 GB, free: 247.5 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.212e-05/1.839, allocations: 4 kB / 1.176 GB, free: 247.5 MB / 0.6042 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001632/1.841, allocations: 369.9 kB / 1.176 GB, free: 247.2 MB / 0.6042 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0007198/1.842, allocations: 16.88 kB / 1.176 GB, free: 247.2 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003484/1.845, allocations: 107.8 kB / 1.176 GB, free: 247.2 MB / 0.6042 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003083/1.845, allocations: 67.88 kB / 1.176 GB, free: 247.2 MB / 0.6042 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.008198/1.854, allocations: 1.217 MB / 1.178 GB, free: 246.7 MB / 0.6042 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.008223/1.862, allocations: 1.748 MB / 1.179 GB, free: 245.9 MB / 0.6042 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002283/1.864, allocations: 421.2 kB / 1.18 GB, free: 245.8 MB / 0.6042 GB
Notification: Performance of sorting global known variables: time 0.003767/1.868, allocations: 1.229 MB / 1.181 GB, free: 245.3 MB / 0.6042 GB
Notification: Performance of Backend: time 2.013e-06/1.868, allocations: 2.188 kB / 1.181 GB, free: 245.3 MB / 0.6042 GB
Notification: Performance of simCode: created initialization part: time 0.01363/1.882, allocations: 2.342 MB / 1.183 GB, free: 244.3 MB / 0.6042 GB
Notification: Performance of SimCode: time 0.0212/1.903, allocations: 5.63 MB / 1.189 GB, free: 238.8 MB / 0.6042 GB
Notification: Performance of Templates: time 0.1425/2.046, allocations: 49.89 MB / 1.237 GB, free: 189.2 MB / 0.6042 GB