Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Airflow.Multizone.Examples.ClosedDoors.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.Airflow.Multizone.Examples.ClosedDoors,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Airflow.Multizone.Examples.ClosedDoors")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 4.829/4.829, allocations: 0.5623 GB / 0.5776 GB, free: 3.348 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.0025/0.0025, allocations: 361.1 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.381/4.381, allocations: 410.7 MB / 1.113 GB, free: 5.836 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.001796/0.001796, allocations: 186.5 kB / 1.226 GB, free: 6.043 MB / 0.7136 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004713/0.0004716, allocations: 12 kB / 1.349 GB, free: 8.188 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.6905/0.691, allocations: 115.3 MB / 1.461 GB, free: 284.3 MB / 0.8542 GB
Notification: Performance of NFInst.instantiate(Buildings.Airflow.Multizone.Examples.ClosedDoors): time 0.2287/0.9198, allocations: 194.6 MB / 1.651 GB, free: 89.61 MB / 0.8542 GB
Notification: Performance of NFInst.instExpressions: time 0.03139/0.9512, allocations: 19.63 MB / 1.671 GB, free: 69.95 MB / 0.8542 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002881/0.9541, allocations: 47.69 kB / 1.671 GB, free: 69.9 MB / 0.8542 GB
Notification: Performance of NFTyping.typeComponents: time 0.004241/0.9584, allocations: 0.9823 MB / 1.672 GB, free: 68.91 MB / 0.8542 GB
Notification: Performance of NFTyping.typeBindings: time 0.01274/0.9712, allocations: 3.696 MB / 1.675 GB, free: 65.2 MB / 0.8542 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005909/0.9771, allocations: 1.44 MB / 1.677 GB, free: 63.79 MB / 0.8542 GB
Notification: Performance of NFFlatten.flatten: time 0.01004/0.9872, allocations: 7.98 MB / 1.684 GB, free: 55.79 MB / 0.8542 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003403/0.9906, allocations: 1.723 MB / 1.686 GB, free: 54.05 MB / 0.8542 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004919/0.9956, allocations: 2.02 MB / 1.688 GB, free: 52.02 MB / 0.8542 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004971/1.001, allocations: 2.403 MB / 1.69 GB, free: 49.61 MB / 0.8542 GB
Notification: Performance of NFPackage.collectConstants: time 0.0009908/1.002, allocations: 160 kB / 1.691 GB, free: 49.46 MB / 0.8542 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006301/1.008, allocations: 1.481 MB / 1.692 GB, free: 47.97 MB / 0.8542 GB
Notification: Performance of NFScalarize.scalarize: time 0.002301/1.01, allocations: 1.266 MB / 1.693 GB, free: 46.7 MB / 0.8542 GB
Notification: Performance of NFVerifyModel.verify: time 0.001591/1.012, allocations: 0.6252 MB / 1.694 GB, free: 46.07 MB / 0.8542 GB
Notification: Performance of NFConvertDAE.convert: time 0.00652/1.019, allocations: 3.85 MB / 1.698 GB, free: 42.21 MB / 0.8542 GB
Notification: Performance of FrontEnd - DAE generated: time 7.023e-06/1.019, allocations: 7.938 kB / 1.698 GB, free: 42.2 MB / 0.8542 GB
Notification: Performance of FrontEnd: time 2.495e-06/1.019, allocations: 0 / 1.698 GB, free: 42.2 MB / 0.8542 GB
Notification: Performance of Transformations before backend: time 0.0001504/1.019, allocations: 0 / 1.698 GB, free: 42.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: 697
 * Number of variables: 697
Notification: Performance of Generate backend data structure: time 0.01326/1.032, allocations: 3.434 MB / 1.701 GB, free: 38.71 MB / 0.8542 GB
Notification: Performance of prepare preOptimizeDAE: time 4.911e-05/1.032, allocations: 11.62 kB / 1.701 GB, free: 38.7 MB / 0.8542 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007402/1.039, allocations: 0.8353 MB / 1.702 GB, free: 37.86 MB / 0.8542 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005286/1.045, allocations: 1.813 MB / 1.704 GB, free: 35.99 MB / 0.8542 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002051/1.045, allocations: 201.4 kB / 1.704 GB, free: 35.79 MB / 0.8542 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000891/1.046, allocations: 275.9 kB / 1.704 GB, free: 35.52 MB / 0.8542 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.009402/1.055, allocations: 3.259 MB / 1.707 GB, free: 32.22 MB / 0.8542 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001143/1.056, allocations: 7.953 kB / 1.707 GB, free: 32.21 MB / 0.8542 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000463/1.056, allocations: 112 kB / 1.707 GB, free: 32.1 MB / 0.8542 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001629/1.056, allocations: 121.4 kB / 1.707 GB, free: 31.98 MB / 0.8542 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01221/1.068, allocations: 4.592 MB / 1.712 GB, free: 27.38 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.02385/1.092, allocations: 10.86 MB / 1.723 GB, free: 15.84 MB / 0.8542 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.009125/1.101, allocations: 4.831 MB / 1.727 GB, free: 10.97 MB / 0.8542 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00599/1.108, allocations: 2.516 MB / 1.73 GB, free: 8.445 MB / 0.8542 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001553/1.109, allocations: 0.8682 MB / 1.731 GB, free: 7.41 MB / 0.8542 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.671e-05/1.109, allocations: 85.69 kB / 1.731 GB, free: 7.316 MB / 0.8542 GB
Notification: Performance of pre-optimization done (n=399): time 6.983e-06/1.109, allocations: 0 / 1.731 GB, free: 7.316 MB / 0.8542 GB
Notification: Performance of matching and sorting (n=399): time 0.01637/1.126, allocations: 5.991 MB / 1.736 GB, free: 1.238 MB / 0.8542 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.771e-05/1.126, allocations: 94.53 kB / 1.737 GB, free: 1.133 MB / 0.8542 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.6183/1.744, allocations: 1.199 MB / 1.738 GB, free: 270.9 MB / 0.8542 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007041/1.745, allocations: 97.2 kB / 1.738 GB, free: 270.9 MB / 0.8542 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0009214/1.746, allocations: 0.8076 MB / 1.739 GB, free: 270.8 MB / 0.8542 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001742/1.747, allocations: 1.331 MB / 1.74 GB, free: 269.9 MB / 0.8542 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002746/1.748, allocations: 75.53 kB / 1.74 GB, free: 269.9 MB / 0.8542 GB
Notification: Performance of setup shared object (initialization): time 0.0002379/1.748, allocations: 441 kB / 1.74 GB, free: 269.6 MB / 0.8542 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004403/1.752, allocations: 1.586 MB / 1.742 GB, free: 269.1 MB / 0.8542 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005249/1.758, allocations: 1.911 MB / 1.744 GB, free: 268.3 MB / 0.8542 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005598/1.763, allocations: 1.884 MB / 1.746 GB, free: 267.5 MB / 0.8542 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.626e-05/1.763, allocations: 1.094 kB / 1.746 GB, free: 267.5 MB / 0.8542 GB
Notification: Performance of matching and sorting (n=430) (initialization): time 0.01294/1.776, allocations: 4.162 MB / 1.75 GB, free: 265.9 MB / 0.8542 GB
Notification: Performance of prepare postOptimizeDAE: time 4.105e-05/1.776, allocations: 6.25 kB / 1.75 GB, free: 265.9 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.603e-05/1.777, allocations: 3.406 kB / 1.75 GB, free: 265.9 MB / 0.8542 GB
Notification: Performance of postOpt tearingSystem (initialization): time 5.06e-05/1.777, allocations: 17.91 kB / 1.75 GB, free: 265.9 MB / 0.8542 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006411/1.783, allocations: 0.6895 MB / 1.75 GB, free: 265.8 MB / 0.8542 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001141/1.783, allocations: 15.78 kB / 1.75 GB, free: 265.8 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005291/1.788, allocations: 365.9 kB / 1.751 GB, free: 265.7 MB / 0.8542 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0006526/1.789, allocations: 118.2 kB / 1.751 GB, free: 265.6 MB / 0.8542 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 14
 * 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 (430):
 * Single equations (assignments): 430
 * 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.001959/1.791, allocations: 0.7282 MB / 1.752 GB, free: 265.2 MB / 0.8542 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007432/1.792, allocations: 238.7 kB / 1.752 GB, free: 265.1 MB / 0.8542 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01126/1.803, allocations: 4.616 MB / 1.756 GB, free: 263.2 MB / 0.8542 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01175/1.815, allocations: 3.936 MB / 1.76 GB, free: 261.6 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.704e-05/1.815, allocations: 0.5938 kB / 1.76 GB, free: 261.6 MB / 0.8542 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004718/1.82, allocations: 0.7539 MB / 1.761 GB, free: 261.1 MB / 0.8542 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001407/1.821, allocations: 66.94 kB / 1.761 GB, free: 261.1 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007057/1.828, allocations: 224.4 kB / 1.761 GB, free: 260.9 MB / 0.8542 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001017/1.829, allocations: 222.8 kB / 1.761 GB, free: 260.7 MB / 0.8542 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02121/1.851, allocations: 4.573 MB / 1.766 GB, free: 256.2 MB / 0.8542 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.02141/1.872, allocations: 7.095 MB / 1.773 GB, free: 249 MB / 0.8542 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.00457/1.877, allocations: 2.133 MB / 1.775 GB, free: 246.9 MB / 0.8542 GB
Notification: Performance of sorting global known variables: time 0.001695/1.878, allocations: 0.8447 MB / 1.776 GB, free: 246.1 MB / 0.8542 GB
Notification: Performance of Backend: time 6.22e-07/1.878, allocations: 1.156 kB / 1.776 GB, free: 246.1 MB / 0.8542 GB
Notification: Performance of simCode: created initialization part: time 0.009302/1.888, allocations: 3.038 MB / 1.779 GB, free: 243.2 MB / 0.8542 GB
Notification: Performance of SimCode: time 0.01569/1.904, allocations: 7.218 MB / 1.786 GB, free: 236.4 MB / 0.8542 GB
Notification: Performance of Templates: time 0.1202/2.024, allocations: 52.95 MB / 1.837 GB, free: 184.1 MB / 0.8542 GB