Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Obsolete.Examples.VAVReheat.Validation.VAVBranch.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.Obsolete.Examples.VAVReheat.Validation.VAVBranch,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Obsolete.Examples.VAVReheat.Validation.VAVBranch")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 4.778/4.778, allocations: 0.5623 GB / 0.5769 GB, free: 3.297 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.002456/0.002456, allocations: 360.2 kB / 0.6441 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.156/4.156, allocations: 410.7 MB / 1.112 GB, free: 5.906 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.001798/0.001798, allocations: 175.9 kB / 1.225 GB, free: 6.141 MB / 0.7136 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004798/0.00048, allocations: 12 kB / 1.348 GB, free: 8.27 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.6122/0.6127, allocations: 115.3 MB / 1.461 GB, free: 284.3 MB / 0.8542 GB
Notification: Performance of NFInst.instantiate(Buildings.Obsolete.Examples.VAVReheat.Validation.VAVBranch): time 0.19/0.8027, allocations: 194.5 MB / 1.651 GB, free: 89.72 MB / 0.8542 GB
Notification: Performance of NFInst.instExpressions: time 0.0218/0.8246, allocations: 14.63 MB / 1.665 GB, free: 75.07 MB / 0.8542 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002067/0.8267, allocations: 47.62 kB / 1.665 GB, free: 75.03 MB / 0.8542 GB
Notification: Performance of NFTyping.typeComponents: time 0.002058/0.8288, allocations: 0.6987 MB / 1.666 GB, free: 74.32 MB / 0.8542 GB
Notification: Performance of NFTyping.typeBindings: time 0.00702/0.8358, allocations: 2.321 MB / 1.668 GB, free: 71.99 MB / 0.8542 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009223/0.845, allocations: 2.98 MB / 1.671 GB, free: 69.07 MB / 0.8542 GB
Notification: Performance of NFFlatten.flatten: time 0.005023/0.8501, allocations: 4.288 MB / 1.675 GB, free: 64.77 MB / 0.8542 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00171/0.8518, allocations: 1.067 MB / 1.676 GB, free: 63.67 MB / 0.8542 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00349/0.8553, allocations: 1.661 MB / 1.678 GB, free: 62 MB / 0.8542 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001615/0.857, allocations: 1.128 MB / 1.679 GB, free: 60.87 MB / 0.8542 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002399/0.8572, allocations: 68 kB / 1.679 GB, free: 60.8 MB / 0.8542 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004634/0.8619, allocations: 2.347 MB / 1.681 GB, free: 58.45 MB / 0.8542 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005507/0.8625, allocations: 490.2 kB / 1.682 GB, free: 57.97 MB / 0.8542 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005207/0.863, allocations: 408.6 kB / 1.682 GB, free: 57.56 MB / 0.8542 GB
Notification: Performance of NFConvertDAE.convert: time 0.003709/0.8667, allocations: 3.258 MB / 1.685 GB, free: 54.3 MB / 0.8542 GB
Notification: Performance of FrontEnd - DAE generated: time 5.219e-06/0.8668, allocations: 0 / 1.685 GB, free: 54.3 MB / 0.8542 GB
Notification: Performance of FrontEnd: time 2.209e-06/0.8668, allocations: 0 / 1.685 GB, free: 54.3 MB / 0.8542 GB
Notification: Performance of Transformations before backend: time 2.145e-05/0.8668, allocations: 0 / 1.685 GB, free: 54.3 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: 251
 * Number of variables: 251
Notification: Performance of Generate backend data structure: time 0.005848/0.8727, allocations: 2.3 MB / 1.687 GB, free: 51.94 MB / 0.8542 GB
Notification: Performance of prepare preOptimizeDAE: time 3.753e-05/0.8727, allocations: 12.16 kB / 1.688 GB, free: 51.93 MB / 0.8542 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003203/0.8759, allocations: 0.5752 MB / 1.688 GB, free: 51.36 MB / 0.8542 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003535/0.8795, allocations: 1.789 MB / 1.69 GB, free: 49.52 MB / 0.8542 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007088/0.8802, allocations: 222.4 kB / 1.69 GB, free: 49.3 MB / 0.8542 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002343/0.8805, allocations: 120 kB / 1.69 GB, free: 49.18 MB / 0.8542 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003649/0.8841, allocations: 1.619 MB / 1.692 GB, free: 47.5 MB / 0.8542 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.166e-05/0.8842, allocations: 4 kB / 1.692 GB, free: 47.5 MB / 0.8542 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001439/0.8843, allocations: 43.95 kB / 1.692 GB, free: 47.45 MB / 0.8542 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.255e-05/0.8844, allocations: 42 kB / 1.692 GB, free: 47.41 MB / 0.8542 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004654/0.8891, allocations: 1.78 MB / 1.694 GB, free: 45.63 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.01083/0.8999, allocations: 6.97 MB / 1.7 GB, free: 38.32 MB / 0.8542 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004536/0.9045, allocations: 1.431 MB / 1.702 GB, free: 36.86 MB / 0.8542 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003509/0.9081, allocations: 0.7108 MB / 1.702 GB, free: 36.14 MB / 0.8542 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001086/0.9092, allocations: 0.7318 MB / 1.703 GB, free: 35.26 MB / 0.8542 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.887e-05/0.9092, allocations: 43.12 kB / 1.703 GB, free: 35.21 MB / 0.8542 GB
Notification: Performance of pre-optimization done (n=71): time 4.738e-06/0.9093, allocations: 0 / 1.703 GB, free: 35.21 MB / 0.8542 GB
Notification: Performance of matching and sorting (n=71): time 0.006223/0.9155, allocations: 2.137 MB / 1.705 GB, free: 33.07 MB / 0.8542 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.752e-05/0.9156, allocations: 196.5 kB / 1.705 GB, free: 32.83 MB / 0.8542 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003421/0.919, allocations: 2.098 MB / 1.708 GB, free: 30.69 MB / 0.8542 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002315/0.9193, allocations: 45.7 kB / 1.708 GB, free: 30.64 MB / 0.8542 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006157/0.9199, allocations: 0.7211 MB / 1.708 GB, free: 29.91 MB / 0.8542 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002339/0.9202, allocations: 240.5 kB / 1.709 GB, free: 29.67 MB / 0.8542 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 9.335e-05/0.9203, allocations: 24 kB / 1.709 GB, free: 29.64 MB / 0.8542 GB
Notification: Performance of setup shared object (initialization): time 9.946e-05/0.9204, allocations: 361.9 kB / 1.709 GB, free: 29.29 MB / 0.8542 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002525/0.9229, allocations: 1.253 MB / 1.71 GB, free: 28.04 MB / 0.8542 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004379/0.9273, allocations: 1.644 MB / 1.712 GB, free: 26.25 MB / 0.8542 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004703/0.9321, allocations: 1.345 MB / 1.713 GB, free: 24.91 MB / 0.8542 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.166e-05/0.9322, allocations: 4 kB / 1.713 GB, free: 24.91 MB / 0.8542 GB
Notification: Performance of matching and sorting (n=177) (initialization): time 0.01132/0.9435, allocations: 3.026 MB / 1.716 GB, free: 21.86 MB / 0.8542 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002101/0.9438, allocations: 292.7 kB / 1.716 GB, free: 21.49 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.076e-05/0.9438, allocations: 8 kB / 1.716 GB, free: 21.48 MB / 0.8542 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.279e-05/0.9439, allocations: 16 kB / 1.716 GB, free: 21.46 MB / 0.8542 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003685/0.9476, allocations: 339.5 kB / 1.717 GB, free: 21.13 MB / 0.8542 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.922e-05/0.9477, allocations: 27.81 kB / 1.717 GB, free: 21.11 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004393/0.9521, allocations: 322.9 kB / 1.717 GB, free: 20.79 MB / 0.8542 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002856/0.9524, allocations: 59.97 kB / 1.717 GB, free: 20.73 MB / 0.8542 GB
Notification: Performance of prepare postOptimizeDAE: time 1.563e-05/0.9524, allocations: 4 kB / 1.717 GB, free: 20.73 MB / 0.8542 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01885/0.9713, allocations: 2.851 MB / 1.72 GB, free: 17.88 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.379e-05/0.9714, allocations: 8 kB / 1.72 GB, free: 17.87 MB / 0.8542 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.055e-05/0.9714, allocations: 12 kB / 1.72 GB, free: 17.86 MB / 0.8542 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003573/0.975, allocations: 339.9 kB / 1.72 GB, free: 17.52 MB / 0.8542 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.045e-05/0.9751, allocations: 12 kB / 1.72 GB, free: 17.51 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004053/0.9792, allocations: 284.6 kB / 1.72 GB, free: 17.23 MB / 0.8542 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002764/0.9795, allocations: 55.97 kB / 1.72 GB, free: 17.18 MB / 0.8542 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 30
 * Number of states: 0 ()
 * Number of discrete variables: 15 (vavBra.terHea.flowRegime,vavBra.vav.idx_sorted[1],vavBra.vav.idx_sorted[2],vavBra.vav.idx_sorted[3],vavBra.vav.idx_sorted[4],vavBra.vav.idx_sorted[5],vavBra.vav.idx_sorted[6],vavBra.vav.idx_sorted[7],vavBra.vav.idx_sorted[8],vavBra.vav.idx_sorted[9],vavBra.vav.idx_sorted[10],vavBra.vav.idx_sorted[11],vavBra.vav.idx_sorted[12],vavBra.vav.idx_sorted[13],vavBra.terHea.flowRegime_nominal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (138):
 * Single equations (assignments): 134
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 2
 * 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.001671/0.9812, allocations: 0.5336 MB / 1.721 GB, free: 16.64 MB / 0.8542 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01296/0.9942, allocations: 165.8 kB / 1.721 GB, free: 16.47 MB / 0.8542 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01694/1.011, allocations: 1.654 MB / 1.723 GB, free: 14.82 MB / 0.8542 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.605e-05/1.011, allocations: 11.94 kB / 1.723 GB, free: 14.81 MB / 0.8542 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.197e-05/1.011, allocations: 4 kB / 1.723 GB, free: 14.8 MB / 0.8542 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.334e-05/1.011, allocations: 7.984 kB / 1.723 GB, free: 14.8 MB / 0.8542 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01371/1.025, allocations: 3.595 MB / 1.726 GB, free: 11.11 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.448e-05/1.025, allocations: 0 / 1.726 GB, free: 11.11 MB / 0.8542 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002664/1.028, allocations: 228 kB / 1.726 GB, free: 10.88 MB / 0.8542 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.97e-05/1.028, allocations: 7.953 kB / 1.727 GB, free: 10.88 MB / 0.8542 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001571/1.028, allocations: 31.97 kB / 1.727 GB, free: 10.84 MB / 0.8542 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.574e-05/1.028, allocations: 4 kB / 1.727 GB, free: 10.84 MB / 0.8542 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.876e-06/1.028, allocations: 4 kB / 1.727 GB, free: 10.84 MB / 0.8542 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01166/1.04, allocations: 2.635 MB / 1.729 GB, free: 8.16 MB / 0.8542 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001786/1.042, allocations: 446.5 kB / 1.73 GB, free: 7.703 MB / 0.8542 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005821/1.042, allocations: 19.94 kB / 1.73 GB, free: 7.684 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002325/1.045, allocations: 159.8 kB / 1.73 GB, free: 7.527 MB / 0.8542 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000173/1.045, allocations: 56.42 kB / 1.73 GB, free: 7.473 MB / 0.8542 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001227/1.045, allocations: 39.91 kB / 1.73 GB, free: 7.434 MB / 0.8542 GB
Notification: Performance of sorting global known variables: time 0.002807/1.048, allocations: 1.448 MB / 1.731 GB, free: 5.961 MB / 0.8542 GB
Notification: Performance of sort global known variables: time 1.009e-06/1.048, allocations: 0 / 1.731 GB, free: 5.961 MB / 0.8542 GB
Notification: Performance of remove unused functions: time 0.003178/1.051, allocations: 0.9871 MB / 1.732 GB, free: 4.973 MB / 0.8542 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 10
 * Number of states: 2 (vavBra.vav.filter.x[1],vavBra.vav.filter.x[2])
 * Number of discrete variables: 1 (vavBra.terHea.flowRegime)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (79):
 * Single equations (assignments): 77
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 2
 * 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 Backend phase and start with SimCode phase: time 0.001566/1.053, allocations: 0.5973 MB / 1.733 GB, free: 4.375 MB / 0.8542 GB
Notification: Performance of simCode: created initialization part: time 0.008025/1.061, allocations: 3.907 MB / 1.737 GB, free: 464 kB / 0.8542 GB
Notification: Performance of simCode: created event and clocks part: time 9.117e-06/1.061, allocations: 0 / 1.737 GB, free: 464 kB / 0.8542 GB
Notification: Performance of simCode: created simulation system equations: time 0.5041/1.565, allocations: 0.7587 MB / 1.737 GB, free: 272.3 MB / 0.8542 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004676/1.569, allocations: 0.6772 MB / 1.738 GB, free: 272.3 MB / 0.8542 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01218/1.582, allocations: 3.53 MB / 1.741 GB, free: 270.8 MB / 0.8542 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002063/1.584, allocations: 1.353 MB / 1.743 GB, free: 270.1 MB / 0.8542 GB
Notification: Performance of simCode: alias equations: time 0.003501/1.587, allocations: 464.4 kB / 1.743 GB, free: 270.1 MB / 0.8542 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007386/1.588, allocations: 137.4 kB / 1.743 GB, free: 270.1 MB / 0.8542 GB
Notification: Performance of SimCode: time 1.87e-06/1.588, allocations: 1.656 kB / 1.743 GB, free: 270.1 MB / 0.8542 GB
Notification: Performance of Templates: time 0.09216/1.68, allocations: 34.73 MB / 1.777 GB, free: 246.2 MB / 0.8542 GB