Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT2Nodes.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.MSLAIT2Nodes,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT2Nodes")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 5.018/5.018, allocations: 0.5623 GB / 0.5776 GB, free: 3.324 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.002423/0.002423, allocations: 356.3 kB / 0.6447 GB, free: 185.6 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.183/4.183, allocations: 410.7 MB / 1.113 GB, free: 147.7 MB / 0.5886 GB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0017/0.0017, allocations: 167.7 kB / 1.226 GB, free: 35.97 MB / 0.5886 GB
Notification: Performance of FrontEnd - loaded program: time 0.0005292/0.0005297, allocations: 12 kB / 1.349 GB, free: 121.7 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2179/0.2185, allocations: 115.3 MB / 1.461 GB, free: 6.594 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.FixedResistances.Validation.PlugFlowPipes.MSLAIT2Nodes): time 0.7902/1.009, allocations: 84.65 MB / 1.544 GB, free: 15.73 MB / 0.6667 GB
Notification: Performance of NFInst.instExpressions: time 0.06529/1.074, allocations: 30.45 MB / 1.574 GB, free: 11.49 MB / 0.6667 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007375/1.081, allocations: 177.7 kB / 1.574 GB, free: 11.41 MB / 0.6667 GB
Notification: Performance of NFTyping.typeComponents: time 0.007782/1.089, allocations: 1.423 MB / 1.575 GB, free: 10.79 MB / 0.6667 GB
Notification: Performance of NFTyping.typeBindings: time 0.02118/1.111, allocations: 4.828 MB / 1.58 GB, free: 9.043 MB / 0.6667 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03413/1.145, allocations: 8.038 MB / 1.588 GB, free: 6.168 MB / 0.6667 GB
Notification: Performance of NFFlatten.flatten: time 0.02741/1.172, allocations: 15.97 MB / 1.603 GB, free: 13.19 MB / 0.6823 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.008639/1.181, allocations: 3.263 MB / 1.607 GB, free: 11.19 MB / 0.6823 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01426/1.195, allocations: 4.503 MB / 1.611 GB, free: 9.109 MB / 0.6823 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01228/1.208, allocations: 4.661 MB / 1.616 GB, free: 6.973 MB / 0.6823 GB
Notification: Performance of NFPackage.collectConstants: time 0.00224/1.21, allocations: 243.3 kB / 1.616 GB, free: 6.973 MB / 0.6823 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01085/1.221, allocations: 1.908 MB / 1.618 GB, free: 6.168 MB / 0.6823 GB
Notification: Performance of NFScalarize.scalarize: time 0.004769/1.226, allocations: 1.856 MB / 1.619 GB, free: 4.996 MB / 0.6823 GB
Notification: Performance of NFVerifyModel.verify: time 0.003756/1.229, allocations: 0.9757 MB / 1.62 GB, free: 4.012 MB / 0.6823 GB
Notification: Performance of NFConvertDAE.convert: time 0.01503/1.244, allocations: 6.226 MB / 1.627 GB, free: 14.04 MB / 0.698 GB
Notification: Performance of FrontEnd - DAE generated: time 8.566e-06/1.244, allocations: 0 / 1.627 GB, free: 14.04 MB / 0.698 GB
Notification: Performance of FrontEnd: time 3.457e-06/1.244, allocations: 3.938 kB / 1.627 GB, free: 14.04 MB / 0.698 GB
Notification: Performance of Transformations before backend: time 0.0002949/1.245, allocations: 0 / 1.627 GB, free: 14.04 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: 1031
 * Number of variables: 1031
Notification: Performance of Generate backend data structure: time 0.02183/1.267, allocations: 5.028 MB / 1.631 GB, free: 8.992 MB / 0.698 GB
Notification: Performance of prepare preOptimizeDAE: time 5.347e-05/1.267, allocations: 8.031 kB / 1.631 GB, free: 8.984 MB / 0.698 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003582/1.27, allocations: 0.5834 MB / 1.632 GB, free: 8.395 MB / 0.698 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01224/1.283, allocations: 3.049 MB / 1.635 GB, free: 5.352 MB / 0.698 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000476/1.283, allocations: 290.4 kB / 1.635 GB, free: 5.086 MB / 0.698 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001828/1.285, allocations: 385.5 kB / 1.636 GB, free: 4.73 MB / 0.698 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01882/1.304, allocations: 5.995 MB / 1.641 GB, free: 14.57 MB / 0.7136 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001832/1.304, allocations: 7.938 kB / 1.642 GB, free: 14.56 MB / 0.7136 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008826/1.305, allocations: 166.3 kB / 1.642 GB, free: 14.42 MB / 0.7136 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001008/1.306, allocations: 459 kB / 1.642 GB, free: 13.97 MB / 0.7136 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02185/1.328, allocations: 5.318 MB / 1.647 GB, free: 8.645 MB / 0.7136 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.07374/1.402, allocations: 24.3 MB / 1.671 GB, free: 15.04 MB / 0.7448 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01348/1.415, allocations: 4.477 MB / 1.675 GB, free: 10.59 MB / 0.7448 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00681/1.422, allocations: 2.411 MB / 1.678 GB, free: 8.172 MB / 0.7448 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.03672/1.459, allocations: 12.43 MB / 1.69 GB, free: 10.86 MB / 0.7605 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.006573/1.465, allocations: 2.221 MB / 1.692 GB, free: 8.598 MB / 0.7605 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004791/1.47, allocations: 0.5585 MB / 1.693 GB, free: 8.039 MB / 0.7605 GB
Notification: Performance of pre-optimization done (n=310): time 1.527e-05/1.47, allocations: 0 / 1.693 GB, free: 8.039 MB / 0.7605 GB
Notification: Performance of matching and sorting (n=334): time 0.05518/1.526, allocations: 13.19 MB / 1.705 GB, free: 10.79 MB / 0.7761 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001051/1.526, allocations: 111.7 kB / 1.706 GB, free: 10.66 MB / 0.7761 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007106/1.533, allocations: 3.132 MB / 1.709 GB, free: 7.547 MB / 0.7761 GB
Notification: Performance of collectPreVariables (initialization): time 0.001022/1.534, allocations: 93.64 kB / 1.709 GB, free: 7.449 MB / 0.7761 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002662/1.537, allocations: 2.059 MB / 1.711 GB, free: 5.383 MB / 0.7761 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002135/1.539, allocations: 1.153 MB / 1.712 GB, free: 4.238 MB / 0.7761 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004338/1.539, allocations: 84 kB / 1.712 GB, free: 4.156 MB / 0.7761 GB
Notification: Performance of setup shared object (initialization): time 0.000359/1.54, allocations: 470.6 kB / 1.712 GB, free: 3.688 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005845/1.545, allocations: 1.928 MB / 1.714 GB, free: 1.75 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007589/1.553, allocations: 2.953 MB / 1.717 GB, free: 14.39 MB / 0.7917 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007384/1.561, allocations: 2.43 MB / 1.72 GB, free: 11.95 MB / 0.7917 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.576e-05/1.561, allocations: 8 kB / 1.72 GB, free: 11.94 MB / 0.7917 GB
Notification: Performance of matching and sorting (n=512) (initialization): time 0.01826/1.579, allocations: 5.547 MB / 1.725 GB, free: 6.359 MB / 0.7917 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0009136/1.58, allocations: 0.9226 MB / 1.726 GB, free: 5.047 MB / 0.7917 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.414e-05/1.58, allocations: 28 kB / 1.726 GB, free: 5.02 MB / 0.7917 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001032/1.58, allocations: 51.98 kB / 1.726 GB, free: 4.969 MB / 0.7917 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.06793/1.648, allocations: 4.152 MB / 1.73 GB, free: 0.8164 MB / 0.7917 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004598/1.653, allocations: 3.969 MB / 1.734 GB, free: 12.71 MB / 0.8073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008181/1.661, allocations: 379.6 kB / 1.734 GB, free: 12.34 MB / 0.8073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001405/1.662, allocations: 199.9 kB / 1.734 GB, free: 12.14 MB / 0.8073 GB
Notification: Performance of prepare postOptimizeDAE: time 1.566e-05/1.662, allocations: 4 kB / 1.734 GB, free: 12.14 MB / 0.8073 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01777/1.68, allocations: 5.038 MB / 1.739 GB, free: 7.078 MB / 0.8073 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.422e-05/1.68, allocations: 28 kB / 1.739 GB, free: 7.051 MB / 0.8073 GB
Notification: Performance of postOpt tearingSystem (initialization): time 8.415e-05/1.68, allocations: 55.98 kB / 1.739 GB, free: 6.996 MB / 0.8073 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0129/1.693, allocations: 1.354 MB / 1.741 GB, free: 5.641 MB / 0.8073 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001478/1.694, allocations: 67.78 kB / 1.741 GB, free: 5.574 MB / 0.8073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007652/1.701, allocations: 363.3 kB / 1.741 GB, free: 5.219 MB / 0.8073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001352/1.703, allocations: 191.9 kB / 1.741 GB, free: 5.031 MB / 0.8073 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 125
 * 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 (512):
 * Single equations (assignments): 506
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 6
 * 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: 6 {1,1,1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.004904/1.708, allocations: 1.251 MB / 1.743 GB, free: 3.77 MB / 0.8073 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001676/1.709, allocations: 403 kB / 1.743 GB, free: 3.371 MB / 0.8073 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02026/1.73, allocations: 5.372 MB / 1.748 GB, free: 14.03 MB / 0.823 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01404/1.744, allocations: 4.253 MB / 1.752 GB, free: 9.711 MB / 0.823 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.168e-05/1.744, allocations: 0 / 1.752 GB, free: 9.711 MB / 0.823 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004167/1.748, allocations: 0.9522 MB / 1.753 GB, free: 8.734 MB / 0.823 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001781/1.75, allocations: 75.98 kB / 1.753 GB, free: 8.66 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006427/1.756, allocations: 280.1 kB / 1.754 GB, free: 8.391 MB / 0.823 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001189/1.758, allocations: 222.7 kB / 1.754 GB, free: 8.172 MB / 0.823 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02373/1.781, allocations: 5.462 MB / 1.759 GB, free: 2.711 MB / 0.823 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.02357/1.805, allocations: 7.616 MB / 1.767 GB, free: 11.04 MB / 0.8386 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.006229/1.811, allocations: 2.245 MB / 1.769 GB, free: 8.785 MB / 0.8386 GB
Notification: Performance of sorting global known variables: time 0.005554/1.817, allocations: 2.053 MB / 1.771 GB, free: 6.75 MB / 0.8386 GB
Notification: Performance of Backend: time 2.885e-06/1.817, allocations: 4 kB / 1.771 GB, free: 6.746 MB / 0.8386 GB
Notification: Performance of simCode: created initialization part: time 0.1143/1.931, allocations: 11.1 MB / 1.782 GB, free: 11.95 MB / 0.8542 GB
Notification: Performance of SimCode: time 0.03331/1.965, allocations: 11.51 MB / 1.793 GB, free: 420 kB / 0.8542 GB
Notification: Performance of Templates: time 0.8925/2.857, allocations: 98.25 MB / 1.889 GB, free: 337.6 MB / 0.948 GB