Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT.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.FixedResistances.Validation.PlugFlowPipes.MSLAIT,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002645/0.002645, allocations: 359 kB / 16.59 MB, free: 5.562 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.695/1.695, allocations: 165.8 MB / 183.1 MB, free: 5.473 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 4.33/4.33, allocations: 410.8 MB / 0.6001 GB, free: 15.19 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.001833/0.001832, allocations: 189.5 kB / 0.6668 GB, free: 6.941 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006503/0.0006506, allocations: 12 kB / 0.7429 GB, free: 8.969 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4972/0.4979, allocations: 67.44 MB / 0.8087 GB, free: 28.8 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT): time 0.1341/0.6321, allocations: 84.64 MB / 0.8914 GB, free: 7.941 MB / 442.7 MB
Notification: Performance of NFInst.instExpressions: time 0.07082/0.7029, allocations: 30.46 MB / 0.9211 GB, free: 9.414 MB / 474.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005975/0.709, allocations: 178.6 kB / 0.9213 GB, free: 9.238 MB / 474.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.007209/0.7162, allocations: 1.425 MB / 0.9227 GB, free: 7.805 MB / 474.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01953/0.7358, allocations: 4.874 MB / 0.9275 GB, free: 2.906 MB / 474.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.5686/1.304, allocations: 8.297 MB / 0.9356 GB, free: 10.73 MB / 474.7 MB
Notification: Performance of NFFlatten.flatten: time 0.1465/1.451, allocations: 105.3 MB / 1.038 GB, free: 9.488 MB / 0.5105 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.09824/1.549, allocations: 36.7 MB / 1.074 GB, free: 5.449 MB / 0.5417 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.09839/1.648, allocations: 33.77 MB / 1.107 GB, free: 4.434 MB / 0.573 GB
Notification: Performance of NFSimplifyModel.simplify: time 1.241/2.889, allocations: 65.6 MB / 1.171 GB, free: 53.88 MB / 0.6199 GB
Notification: Performance of NFPackage.collectConstants: time 0.03644/2.926, allocations: 3.055 MB / 1.174 GB, free: 53.88 MB / 0.6199 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04937/2.975, allocations: 4.734 MB / 1.179 GB, free: 53.87 MB / 0.6199 GB
Notification: Performance of NFScalarize.scalarize: time 0.05587/3.031, allocations: 31.89 MB / 1.21 GB, free: 53.86 MB / 0.6199 GB
Notification: Performance of NFVerifyModel.verify: time 0.04635/3.077, allocations: 15.16 MB / 1.225 GB, free: 53.83 MB / 0.6199 GB
Notification: Performance of NFConvertDAE.convert: time 0.1385/3.216, allocations: 94.27 MB / 1.317 GB, free: 9.441 MB / 0.6199 GB
Notification: Performance of FrontEnd - DAE generated: time 1.042e-05/3.216, allocations: 0 / 1.317 GB, free: 9.441 MB / 0.6199 GB
Notification: Performance of FrontEnd: time 3.226e-06/3.216, allocations: 2.719 kB / 1.317 GB, free: 9.441 MB / 0.6199 GB
Notification: Performance of Transformations before backend: time 0.00507/3.221, allocations: 0 / 1.317 GB, free: 9.441 MB / 0.6199 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 22767
 * Number of variables: 22767
Notification: Performance of Generate backend data structure: time 40.75/43.97, allocations: 2.441 GB / 3.757 GB, free: 252.9 MB / 0.7614 GB
Notification: Performance of prepare preOptimizeDAE: time 7.656e-05/43.97, allocations: 8.875 kB / 3.757 GB, free: 252.9 MB / 0.7614 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.07475/44.04, allocations: 8.734 MB / 3.766 GB, free: 248.8 MB / 0.7614 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1586/44.2, allocations: 37.46 MB / 3.803 GB, free: 234.3 MB / 0.7614 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.009507/44.21, allocations: 4.561 MB / 3.807 GB, free: 232.2 MB / 0.7614 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.04182/44.25, allocations: 6.239 MB / 3.813 GB, free: 226.7 MB / 0.7614 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.4517/44.71, allocations: 146.8 MB / 3.956 GB, free: 82.36 MB / 0.7614 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.004184/44.71, allocations: 289.4 kB / 3.957 GB, free: 82.07 MB / 0.7614 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.03718/44.75, allocations: 2.631 MB / 3.959 GB, free: 79.51 MB / 0.7614 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.014/44.76, allocations: 12.02 MB / 3.971 GB, free: 67.51 MB / 0.7614 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 1.304/46.07, allocations: 141.4 MB / 4.109 GB, free: 195.3 MB / 0.7614 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 2.921/48.99, allocations: 0.5576 GB / 4.667 GB, free: 190.6 MB / 0.7926 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.4586/49.45, allocations: 134.7 MB / 4.798 GB, free: 143.2 MB / 0.7926 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.1757/49.62, allocations: 61.81 MB / 4.859 GB, free: 81.37 MB / 0.7926 GB
Notification: Performance of preOpt evalFunc (simulation): time 1.646/51.27, allocations: 242.2 MB / 5.095 GB, free: 170.3 MB / 0.8083 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.1684/51.44, allocations: 53.09 MB / 5.147 GB, free: 122.7 MB / 0.8083 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.07983/51.52, allocations: 8.276 MB / 5.155 GB, free: 115.8 MB / 0.8083 GB
Notification: Performance of pre-optimization done (n=6322): time 0.0001702/51.52, allocations: 0 / 5.155 GB, free: 115.8 MB / 0.8083 GB
Notification: Performance of matching and sorting (n=6918): time 11.22/62.74, allocations: 1.052 GB / 6.207 GB, free: 177.1 MB / 0.8083 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0006439/62.74, allocations: 0.7626 MB / 6.208 GB, free: 177 MB / 0.8083 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1158/62.85, allocations: 41.67 MB / 6.249 GB, free: 163.1 MB / 0.8083 GB
Notification: Performance of collectPreVariables (initialization): time 0.02568/62.88, allocations: 1.354 MB / 6.25 GB, free: 162.1 MB / 0.8083 GB
Notification: Performance of collectInitialEqns (initialization): time 0.04/62.92, allocations: 34.48 MB / 6.284 GB, free: 135.7 MB / 0.8083 GB
Notification: Performance of collectInitialBindings (initialization): time 0.05221/62.97, allocations: 24.33 MB / 6.307 GB, free: 116.9 MB / 0.8083 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.02835/63, allocations: 1.736 MB / 6.309 GB, free: 115.6 MB / 0.8083 GB
Notification: Performance of setup shared object (initialization): time 0.01343/63.01, allocations: 3.985 MB / 6.313 GB, free: 113.7 MB / 0.8083 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1498/63.16, allocations: 47.98 MB / 6.36 GB, free: 89.18 MB / 0.8083 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.8795/64.04, allocations: 73.34 MB / 6.431 GB, free: 191.1 MB / 0.8083 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1824/64.22, allocations: 60.61 MB / 6.491 GB, free: 174.2 MB / 0.8083 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.001375/64.22, allocations: 206.8 kB / 6.491 GB, free: 174.2 MB / 0.8083 GB
Notification: Performance of matching and sorting (n=11374) (initialization): time 0.4429/64.67, allocations: 130.6 MB / 6.618 GB, free: 105.2 MB / 0.8083 GB
Notification: Performance of prepare postOptimizeDAE: time 0.01725/64.69, allocations: 21.63 MB / 6.639 GB, free: 73.59 MB / 0.8083 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.002635/64.69, allocations: 0.6992 MB / 6.64 GB, free: 72.89 MB / 0.8083 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002108/64.69, allocations: 1.242 MB / 6.641 GB, free: 71.65 MB / 0.8083 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 4.1/68.79, allocations: 188.6 MB / 6.825 GB, free: 177.4 MB / 0.8395 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.2463/69.04, allocations: 192.1 MB / 7.013 GB, free: 64.16 MB / 0.902 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.2572/69.29, allocations: 9.165 MB / 7.022 GB, free: 60.33 MB / 0.902 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0439/69.34, allocations: 4.22 MB / 7.026 GB, free: 56.9 MB / 0.902 GB
Notification: Performance of prepare postOptimizeDAE: time 2.556e-05/69.34, allocations: 4 kB / 7.026 GB, free: 56.9 MB / 0.902 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 1.279/70.62, allocations: 119.6 MB / 7.143 GB, free: 214.9 MB / 0.902 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.002899/70.62, allocations: 0.6964 MB / 7.144 GB, free: 214.9 MB / 0.902 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003341/70.62, allocations: 1.245 MB / 7.145 GB, free: 214.9 MB / 0.902 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.3931/71.02, allocations: 41.2 MB / 7.185 GB, free: 212.1 MB / 0.902 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003703/71.02, allocations: 1.591 MB / 7.187 GB, free: 211.8 MB / 0.902 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1565/71.18, allocations: 8.755 MB / 7.195 GB, free: 210.1 MB / 0.902 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02983/71.21, allocations: 4.06 MB / 7.199 GB, free: 209.3 MB / 0.902 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 3259
 * Number of states: 0 ()
 * Number of discrete variables: 6 ($whenCondition1,$PRE.DataReader.nextTimeEvent,DataReader.nextTimeEvent,$PRE.DataReader.nextTimeEventScaled,DataReader.nextTimeEventScaled,lessThreshold.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (11374):
 * Single equations (assignments): 11082
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 292
 * 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: 292 {1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.1677/71.37, allocations: 23.89 MB / 7.222 GB, free: 199.1 MB / 0.902 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.03304/71.41, allocations: 5.36 MB / 7.228 GB, free: 199.1 MB / 0.902 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.5378/71.95, allocations: 116.7 MB / 7.342 GB, free: 93.86 MB / 0.902 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.078/73.02, allocations: 93.88 MB / 7.433 GB, free: 221.9 MB / 0.902 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0006248/73.02, allocations: 3.562 kB / 7.433 GB, free: 221.9 MB / 0.902 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.07366/73.1, allocations: 17.39 MB / 7.45 GB, free: 218.1 MB / 0.902 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.03427/73.13, allocations: 1.475 MB / 7.452 GB, free: 217 MB / 0.902 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.1461/73.28, allocations: 6.328 MB / 7.458 GB, free: 215.7 MB / 0.902 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.02571/73.3, allocations: 4.465 MB / 7.462 GB, free: 215.1 MB / 0.902 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.7577/74.06, allocations: 135.2 MB / 7.594 GB, free: 166.7 MB / 0.902 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 1.347/75.41, allocations: 173.3 MB / 7.764 GB, free: 230.1 MB / 0.902 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.1589/75.57, allocations: 52.46 MB / 7.815 GB, free: 210.5 MB / 0.902 GB
Notification: Performance of sorting global known variables: time 0.08117/75.65, allocations: 27.29 MB / 7.841 GB, free: 201.8 MB / 0.902 GB
Notification: Performance of Backend: time 1.596e-05/75.65, allocations: 1.031 kB / 7.841 GB, free: 201.8 MB / 0.902 GB
Notification: Performance of simCode: created initialization part: time 5.669/81.32, allocations: 351.4 MB / 8.185 GB, free: 233.8 MB / 0.902 GB
Notification: Performance of SimCode: time 1.351/82.67, allocations: 194.2 MB / 8.374 GB, free: 195.9 MB / 0.902 GB
Notification: Performance of Templates: time 8.574/91.24, allocations: 1.57 GB / 9.944 GB, free: 170.4 MB / 1.028 GB