Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.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 Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 9.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo)
Running command: translateModel(Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 5.116/5.116, allocations: 0.5623 GB / 0.5776 GB, free: 3.391 MB / 474.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002509/0.002508, allocations: 361.9 kB / 0.6447 GB, free: 185.7 MB / 474.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.27/4.27, allocations: 410.7 MB / 1.113 GB, free: 5.926 MB / 0.6042 GB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.002445/0.002445, allocations: 174.6 kB / 1.226 GB, free: 6.176 MB / 0.7136 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004897/0.0004899, allocations: 12 kB / 1.349 GB, free: 8.297 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7322/0.7327, allocations: 115.3 MB / 1.461 GB, free: 284.4 MB / 0.8542 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT): time 0.1216/0.8543, allocations: 84.66 MB / 1.544 GB, free: 199.7 MB / 0.8542 GB
Notification: Performance of NFInst.instExpressions: time 0.05392/0.9083, allocations: 30.45 MB / 1.574 GB, free: 169.3 MB / 0.8542 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005604/0.914, allocations: 178.6 kB / 1.574 GB, free: 169.1 MB / 0.8542 GB
Notification: Performance of NFTyping.typeComponents: time 0.006575/0.9206, allocations: 1.417 MB / 1.575 GB, free: 167.7 MB / 0.8542 GB
Notification: Performance of NFTyping.typeBindings: time 0.01672/0.9374, allocations: 4.866 MB / 1.58 GB, free: 162.8 MB / 0.8542 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02843/0.9658, allocations: 8.328 MB / 1.588 GB, free: 154.6 MB / 0.8542 GB
Notification: Performance of NFFlatten.flatten: time 0.1055/1.071, allocations: 105.3 MB / 1.691 GB, free: 49.02 MB / 0.8542 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.07301/1.144, allocations: 36.71 MB / 1.727 GB, free: 12.23 MB / 0.8542 GB
Notification: Performance of NFEvalConstants.evaluate: time 1.56/2.704, allocations: 33.77 MB / 1.76 GB, free: 26.84 MB / 0.8543 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1431/2.848, allocations: 65.6 MB / 1.824 GB, free: 26.79 MB / 0.8543 GB
Notification: Performance of NFPackage.collectConstants: time 0.02593/2.874, allocations: 3.054 MB / 1.827 GB, free: 26.79 MB / 0.8543 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04766/2.921, allocations: 4.727 MB / 1.832 GB, free: 26.79 MB / 0.8543 GB
Notification: Performance of NFScalarize.scalarize: time 0.05284/2.974, allocations: 31.89 MB / 1.863 GB, free: 22.56 MB / 0.8543 GB
Notification: Performance of NFVerifyModel.verify: time 0.04331/3.018, allocations: 15.15 MB / 1.877 GB, free: 20.95 MB / 0.8543 GB
Notification: Performance of NFConvertDAE.convert: time 0.1496/3.167, allocations: 94.26 MB / 1.97 GB, free: 1.613 MB / 0.9168 GB
Notification: Performance of FrontEnd - DAE generated: time 7.294e-06/3.167, allocations: 0 / 1.97 GB, free: 1.613 MB / 0.9168 GB
Notification: Performance of FrontEnd: time 3.317e-06/3.167, allocations: 4 kB / 1.97 GB, free: 1.609 MB / 0.9168 GB
Notification: Performance of Transformations before backend: time 0.00414/3.171, allocations: 0 / 1.97 GB, free: 1.609 MB / 0.9168 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 38.61/41.78, allocations: 2.441 GB / 4.41 GB, free: 209.1 MB / 1.23 GB
Notification: Performance of prepare preOptimizeDAE: time 5.674e-05/41.78, allocations: 12.16 kB / 4.41 GB, free: 209.1 MB / 1.23 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0618/41.84, allocations: 8.737 MB / 4.419 GB, free: 200.3 MB / 1.23 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1201/41.96, allocations: 37.45 MB / 4.455 GB, free: 163.2 MB / 1.23 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.006775/41.97, allocations: 4.557 MB / 4.46 GB, free: 158.7 MB / 1.23 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.03388/42, allocations: 6.242 MB / 4.466 GB, free: 152.5 MB / 1.23 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.4101/42.41, allocations: 146.8 MB / 4.609 GB, free: 2.926 MB / 1.23 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.003736/42.42, allocations: 293.4 kB / 4.609 GB, free: 2.637 MB / 1.23 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.02941/42.45, allocations: 2.629 MB / 4.612 GB, free: 76 kB / 1.23 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.8371/43.28, allocations: 12.02 MB / 4.624 GB, free: 496.7 MB / 1.23 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.4286/43.71, allocations: 141.4 MB / 4.762 GB, free: 388 MB / 1.23 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.18/45.89, allocations: 0.5576 GB / 5.319 GB, free: 254.9 MB / 1.23 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.4035/46.3, allocations: 134.7 MB / 5.451 GB, free: 179.8 MB / 1.23 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.1734/46.47, allocations: 61.81 MB / 5.511 GB, free: 118 MB / 1.23 GB
Notification: Performance of preOpt evalFunc (simulation): time 1.729/48.2, allocations: 242.2 MB / 5.748 GB, free: 354 MB / 1.23 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.1609/48.36, allocations: 53.1 MB / 5.8 GB, free: 309.4 MB / 1.23 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.07688/48.44, allocations: 8.268 MB / 5.808 GB, free: 303.2 MB / 1.23 GB
Notification: Performance of pre-optimization done (n=6322): time 0.0001708/48.44, allocations: 0 / 5.808 GB, free: 303.2 MB / 1.23 GB
Notification: Performance of matching and sorting (n=6918): time 10.03/58.47, allocations: 1.052 GB / 6.86 GB, free: 138.7 MB / 1.23 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0005555/58.47, allocations: 0.7648 MB / 6.86 GB, free: 137.9 MB / 1.23 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.9427/59.41, allocations: 41.66 MB / 6.901 GB, free: 409.9 MB / 1.23 GB
Notification: Performance of collectPreVariables (initialization): time 0.02347/59.44, allocations: 1.349 MB / 6.902 GB, free: 409.9 MB / 1.23 GB
Notification: Performance of collectInitialEqns (initialization): time 0.04139/59.48, allocations: 34.5 MB / 6.936 GB, free: 392.7 MB / 1.23 GB
Notification: Performance of collectInitialBindings (initialization): time 0.04572/59.52, allocations: 24.32 MB / 6.96 GB, free: 374 MB / 1.23 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.02326/59.55, allocations: 1.732 MB / 6.962 GB, free: 372.6 MB / 1.23 GB
Notification: Performance of setup shared object (initialization): time 0.009209/59.56, allocations: 3.985 MB / 6.965 GB, free: 370.7 MB / 1.23 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1611/59.72, allocations: 47.98 MB / 7.012 GB, free: 353.6 MB / 1.23 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.1986/59.92, allocations: 73.35 MB / 7.084 GB, free: 307.4 MB / 1.23 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1846/60.1, allocations: 60.61 MB / 7.143 GB, free: 271.1 MB / 1.23 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.001107/60.1, allocations: 204 kB / 7.143 GB, free: 270.9 MB / 1.23 GB
Notification: Performance of matching and sorting (n=11374) (initialization): time 0.4164/60.52, allocations: 130.6 MB / 7.271 GB, free: 140.2 MB / 1.23 GB
Notification: Performance of prepare postOptimizeDAE: time 0.01551/60.53, allocations: 21.63 MB / 7.292 GB, free: 108.6 MB / 1.23 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.002172/60.54, allocations: 0.6992 MB / 7.293 GB, free: 107.9 MB / 1.23 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001773/60.54, allocations: 1.242 MB / 7.294 GB, free: 106.6 MB / 1.23 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 4.059/64.6, allocations: 188.6 MB / 7.478 GB, free: 305.8 MB / 1.23 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.1601/64.76, allocations: 192.1 MB / 7.666 GB, free: 114.8 MB / 1.23 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.2459/65, allocations: 9.168 MB / 7.675 GB, free: 106 MB / 1.23 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02798/65.03, allocations: 4.214 MB / 7.679 GB, free: 101.8 MB / 1.23 GB
Notification: Performance of prepare postOptimizeDAE: time 1.625e-05/65.03, allocations: 4 kB / 7.679 GB, free: 101.8 MB / 1.23 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 1.286/66.32, allocations: 119.6 MB / 7.796 GB, free: 306 MB / 1.246 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.002335/66.32, allocations: 0.6934 MB / 7.796 GB, free: 306 MB / 1.246 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001673/66.32, allocations: 1.245 MB / 7.797 GB, free: 306 MB / 1.246 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.4059/66.73, allocations: 41.2 MB / 7.838 GB, free: 306 MB / 1.246 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003263/66.73, allocations: 1.587 MB / 7.839 GB, free: 306 MB / 1.246 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1535/66.89, allocations: 8.759 MB / 7.848 GB, free: 305.8 MB / 1.246 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02717/66.91, allocations: 4.059 MB / 7.852 GB, free: 305.8 MB / 1.246 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.1036/67.02, allocations: 23.89 MB / 7.875 GB, free: 304.8 MB / 1.246 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.03653/67.05, allocations: 5.355 MB / 7.88 GB, free: 304.8 MB / 1.246 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.4235/67.48, allocations: 116.7 MB / 7.994 GB, free: 260.7 MB / 1.246 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.3099/67.79, allocations: 93.87 MB / 8.086 GB, free: 173.2 MB / 1.246 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0004996/67.79, allocations: 7.781 kB / 8.086 GB, free: 173.2 MB / 1.246 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.06889/67.86, allocations: 17.4 MB / 8.103 GB, free: 157.8 MB / 1.246 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.03155/67.89, allocations: 1.472 MB / 8.104 GB, free: 156.4 MB / 1.246 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.1239/68.01, allocations: 6.338 MB / 8.111 GB, free: 150.6 MB / 1.246 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.02349/68.03, allocations: 4.466 MB / 8.115 GB, free: 146.1 MB / 1.246 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.6534/68.69, allocations: 135.2 MB / 8.247 GB, free: 11.2 MB / 1.246 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 1.471/70.16, allocations: 173.3 MB / 8.416 GB, free: 265.5 MB / 1.246 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.142/70.3, allocations: 52.46 MB / 8.467 GB, free: 245.9 MB / 1.246 GB
Notification: Performance of sorting global known variables: time 0.07106/70.37, allocations: 27.29 MB / 8.494 GB, free: 224 MB / 1.246 GB
Notification: Performance of Backend: time 1.112e-06/70.37, allocations: 3.469 kB / 8.494 GB, free: 224 MB / 1.246 GB
Notification: Performance of simCode: created initialization part: time 5.814/76.19, allocations: 351.4 MB / 8.837 GB, free: 309.6 MB / 1.246 GB
Notification: Performance of SimCode: time 0.5663/76.75, allocations: 194.2 MB / 9.027 GB, free: 171.8 MB / 1.246 GB
Notification: Performance of Templates: time 7.095/83.85, allocations: 1.559 GB / 10.59 GB, free: 110.6 MB / 1.371 GB