Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger.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.Interfaces.Examples.FourPortHeatMassExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 4.758/4.758, allocations: 0.5623 GB / 0.5776 GB, free: 3.363 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.002464/0.002464, allocations: 358 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.087/4.087, allocations: 410.7 MB / 1.113 GB, free: 6.016 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.001844/0.001843, allocations: 184.4 kB / 1.226 GB, free: 6.172 MB / 0.7136 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004772/0.0004774, allocations: 12 kB / 1.349 GB, free: 8.309 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.687/0.6875, allocations: 115.3 MB / 1.461 GB, free: 284.4 MB / 0.8542 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger): time 0.0427/0.7303, allocations: 38.3 MB / 1.499 GB, free: 246.1 MB / 0.8542 GB
Notification: Performance of NFInst.instExpressions: time 0.01567/0.746, allocations: 9.5 MB / 1.508 GB, free: 236.6 MB / 0.8542 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001842/0.7479, allocations: 43.69 kB / 1.508 GB, free: 236.6 MB / 0.8542 GB
Notification: Performance of NFTyping.typeComponents: time 0.002311/0.7502, allocations: 0.5685 MB / 1.509 GB, free: 236 MB / 0.8542 GB
Notification: Performance of NFTyping.typeBindings: time 0.006766/0.757, allocations: 1.885 MB / 1.51 GB, free: 234.2 MB / 0.8542 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005294/0.7623, allocations: 1.353 MB / 1.512 GB, free: 232.9 MB / 0.8542 GB
Notification: Performance of NFFlatten.flatten: time 0.005232/0.7676, allocations: 3.849 MB / 1.516 GB, free: 229 MB / 0.8542 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001432/0.7691, allocations: 0.7388 MB / 1.516 GB, free: 228.3 MB / 0.8542 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00214/0.7712, allocations: 0.9592 MB / 1.517 GB, free: 227.3 MB / 0.8542 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001345/0.7726, allocations: 0.8065 MB / 1.518 GB, free: 226.5 MB / 0.8542 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001485/0.7728, allocations: 36 kB / 1.518 GB, free: 226.5 MB / 0.8542 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002007/0.7748, allocations: 494.6 kB / 1.518 GB, free: 226 MB / 0.8542 GB
Notification: Performance of NFScalarize.scalarize: time 0.000293/0.7751, allocations: 195.1 kB / 1.519 GB, free: 225.8 MB / 0.8542 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004143/0.7755, allocations: 267 kB / 1.519 GB, free: 225.6 MB / 0.8542 GB
Notification: Performance of NFConvertDAE.convert: time 0.002035/0.7776, allocations: 1.36 MB / 1.52 GB, free: 224.2 MB / 0.8542 GB
Notification: Performance of FrontEnd - DAE generated: time 5.751e-06/0.7776, allocations: 0 / 1.52 GB, free: 224.2 MB / 0.8542 GB
Notification: Performance of FrontEnd: time 2.144e-06/0.7776, allocations: 0 / 1.52 GB, free: 224.2 MB / 0.8542 GB
Notification: Performance of Transformations before backend: time 1.439e-05/0.7776, allocations: 0 / 1.52 GB, free: 224.2 MB / 0.8542 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 174
 * Number of variables: 174
Notification: Performance of Generate backend data structure: time 0.002748/0.7804, allocations: 1.32 MB / 1.522 GB, free: 222.8 MB / 0.8542 GB
Notification: Performance of prepare preOptimizeDAE: time 4.559e-05/0.7805, allocations: 13.78 kB / 1.522 GB, free: 222.8 MB / 0.8542 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004415/0.7809, allocations: 134.6 kB / 1.522 GB, free: 222.7 MB / 0.8542 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0023/0.7832, allocations: 1.024 MB / 1.523 GB, free: 221.6 MB / 0.8542 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.933e-05/0.7833, allocations: 51.03 kB / 1.523 GB, free: 221.6 MB / 0.8542 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000137/0.7835, allocations: 72 kB / 1.523 GB, free: 221.5 MB / 0.8542 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001875/0.7853, allocations: 0.795 MB / 1.524 GB, free: 220.7 MB / 0.8542 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.731e-05/0.7854, allocations: 12.41 kB / 1.524 GB, free: 220.7 MB / 0.8542 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.166e-05/0.7855, allocations: 29.25 kB / 1.524 GB, free: 220.6 MB / 0.8542 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.664e-05/0.7856, allocations: 20 kB / 1.524 GB, free: 220.6 MB / 0.8542 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001642/0.7872, allocations: 0.5838 MB / 1.524 GB, free: 220 MB / 0.8542 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.004798/0.792, allocations: 3.556 MB / 1.528 GB, free: 216.3 MB / 0.8542 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0007834/0.7928, allocations: 263.2 kB / 1.528 GB, free: 216 MB / 0.8542 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005327/0.7934, allocations: 187.6 kB / 1.528 GB, free: 215.8 MB / 0.8542 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005226/0.7939, allocations: 0.655 MB / 1.529 GB, free: 215 MB / 0.8542 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.141e-05/0.794, allocations: 46.98 kB / 1.529 GB, free: 215 MB / 0.8542 GB
Notification: Performance of pre-optimization done (n=31): time 3.006e-06/0.794, allocations: 0 / 1.529 GB, free: 215 MB / 0.8542 GB
Notification: Performance of matching and sorting (n=31): time 0.001715/0.7957, allocations: 0.5468 MB / 1.529 GB, free: 214.4 MB / 0.8542 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.06e-05/0.7957, allocations: 51.41 kB / 1.529 GB, free: 214.4 MB / 0.8542 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001376/0.7971, allocations: 0.9175 MB / 1.53 GB, free: 213.4 MB / 0.8542 GB
Notification: Performance of collectPreVariables (initialization): time 5.009e-05/0.7972, allocations: 37.7 kB / 1.53 GB, free: 213.4 MB / 0.8542 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000387/0.7976, allocations: 496.2 kB / 1.531 GB, free: 212.9 MB / 0.8542 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001099/0.7977, allocations: 118.4 kB / 1.531 GB, free: 212.8 MB / 0.8542 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.17e-05/0.7977, allocations: 12.53 kB / 1.531 GB, free: 212.8 MB / 0.8542 GB
Notification: Performance of setup shared object (initialization): time 6.904e-05/0.7978, allocations: 331.2 kB / 1.531 GB, free: 212.5 MB / 0.8542 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005455/0.7984, allocations: 171.6 kB / 1.531 GB, free: 212.3 MB / 0.8542 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000655/0.7991, allocations: 366.9 kB / 1.532 GB, free: 211.9 MB / 0.8542 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.000632/0.7997, allocations: 231.8 kB / 1.532 GB, free: 211.6 MB / 0.8542 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.22e-06/0.7997, allocations: 0 / 1.532 GB, free: 211.6 MB / 0.8542 GB
Notification: Performance of matching and sorting (n=65) (initialization): time 0.001566/0.8013, allocations: 0.63 MB / 1.533 GB, free: 211 MB / 0.8542 GB
Notification: Performance of prepare postOptimizeDAE: time 1.976e-05/0.8013, allocations: 8 kB / 1.533 GB, free: 211 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.093e-05/0.8014, allocations: 4 kB / 1.533 GB, free: 211 MB / 0.8542 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.629e-05/0.8014, allocations: 8.438 kB / 1.533 GB, free: 211 MB / 0.8542 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007821/0.8022, allocations: 131.8 kB / 1.533 GB, free: 210.8 MB / 0.8542 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.201e-05/0.8022, allocations: 15.92 kB / 1.533 GB, free: 210.8 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001146/0.8034, allocations: 111.2 kB / 1.533 GB, free: 210.7 MB / 0.8542 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.795e-05/0.8035, allocations: 31.94 kB / 1.533 GB, free: 210.7 MB / 0.8542 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 23
 * 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 (65):
 * Single equations (assignments): 65
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.000494/0.804, allocations: 269.6 kB / 1.533 GB, free: 210.4 MB / 0.8542 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001746/0.8041, allocations: 102.8 kB / 1.533 GB, free: 210.3 MB / 0.8542 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001475/0.8056, allocations: 0.4965 MB / 1.534 GB, free: 209.8 MB / 0.8542 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00106/0.8067, allocations: 483.6 kB / 1.534 GB, free: 209.3 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.07e-06/0.8067, allocations: 3.938 kB / 1.534 GB, free: 209.3 MB / 0.8542 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00048/0.8072, allocations: 235.7 kB / 1.534 GB, free: 209.1 MB / 0.8542 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001829/0.8074, allocations: 11.95 kB / 1.534 GB, free: 209.1 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001003/0.8084, allocations: 55.88 kB / 1.534 GB, free: 209 MB / 0.8542 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.573e-05/0.8085, allocations: 23.97 kB / 1.534 GB, free: 209 MB / 0.8542 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001614/0.8102, allocations: 0.516 MB / 1.535 GB, free: 208.5 MB / 0.8542 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.001885/0.8121, allocations: 0.8642 MB / 1.536 GB, free: 207.6 MB / 0.8542 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0005133/0.8126, allocations: 194.5 kB / 1.536 GB, free: 207.4 MB / 0.8542 GB
Notification: Performance of sorting global known variables: time 0.001093/0.8137, allocations: 0.6232 MB / 1.537 GB, free: 206.8 MB / 0.8542 GB
Notification: Performance of Backend: time 7.41e-07/0.8137, allocations: 0 / 1.537 GB, free: 206.8 MB / 0.8542 GB
Notification: Performance of simCode: created initialization part: time 0.002354/0.8161, allocations: 0.6768 MB / 1.537 GB, free: 206.1 MB / 0.8542 GB
Notification: Performance of SimCode: time 0.006549/0.8227, allocations: 2.811 MB / 1.54 GB, free: 203.3 MB / 0.8542 GB
Notification: Performance of Templates: time 0.04573/0.8684, allocations: 19.83 MB / 1.559 GB, free: 183.9 MB / 0.8542 GB