Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Airflow.Multizone.Examples.NaturalVentilation.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 IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/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)
Running command: translateModel(IBPSA.Airflow.Multizone.Examples.NaturalVentilation,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Airflow.Multizone.Examples.NaturalVentilation")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002438/0.002442, allocations: 353.8 kB / 15.94 MB, free: 6.207 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.514/1.514, allocations: 165.8 MB / 182.5 MB, free: 5.391 MB / 138.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 3.701/3.701, allocations: 410.7 MB / 0.5995 GB, free: 15.14 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001705/0.001704, allocations: 191.6 kB / 0.6662 GB, free: 6.941 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0007174/0.0007178, allocations: 23.97 kB / 0.7423 GB, free: 8.977 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3394/0.3401, allocations: 67.44 MB / 0.8081 GB, free: 28.81 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Airflow.Multizone.Examples.NaturalVentilation): time 0.5843/0.9245, allocations: 181.1 MB / 0.985 GB, free: 356 kB / 474.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01284/0.9374, allocations: 7.798 MB / 0.9926 GB, free: 15.49 MB / 490.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001728/0.9392, allocations: 33.59 kB / 0.9926 GB, free: 15.48 MB / 490.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.002278/0.9415, allocations: 0.5598 MB / 0.9932 GB, free: 15.15 MB / 490.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.007987/0.9495, allocations: 2.194 MB / 0.9953 GB, free: 14.14 MB / 490.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003815/0.9533, allocations: 0.9895 MB / 0.9963 GB, free: 13.84 MB / 490.7 MB
Notification: Performance of NFFlatten.flatten: time 0.004987/0.9583, allocations: 3.465 MB / 0.9996 GB, free: 12.65 MB / 490.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001397/0.9598, allocations: 0.6801 MB / 1 GB, free: 12.38 MB / 490.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002234/0.962, allocations: 0.8934 MB / 1.001 GB, free: 12.05 MB / 490.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001814/0.9639, allocations: 0.9148 MB / 1.002 GB, free: 11.73 MB / 490.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002162/0.9641, allocations: 49.28 kB / 1.002 GB, free: 11.73 MB / 490.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002978/0.9671, allocations: 0.7865 MB / 1.003 GB, free: 11.51 MB / 490.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.000668/0.9678, allocations: 382 kB / 1.003 GB, free: 11.34 MB / 490.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0005187/0.9684, allocations: 260 kB / 1.004 GB, free: 11.28 MB / 490.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002756/0.9711, allocations: 1.484 MB / 1.005 GB, free: 10.54 MB / 490.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.912e-06/0.9712, allocations: 0 / 1.005 GB, free: 10.54 MB / 490.7 MB
Notification: Performance of FrontEnd: time 2.35e-06/0.9712, allocations: 0 / 1.005 GB, free: 10.54 MB / 490.7 MB
Notification: Performance of Transformations before backend: time 2.987e-05/0.9712, allocations: 2.844 kB / 1.005 GB, free: 10.54 MB / 490.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 214
 * Number of variables: 214
Notification: Performance of Generate backend data structure: time 0.003871/0.9751, allocations: 1.382 MB / 1.006 GB, free: 9.598 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.88e-05/0.9752, allocations: 8.688 kB / 1.006 GB, free: 9.598 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003443/0.9786, allocations: 376.9 kB / 1.007 GB, free: 9.453 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001892/0.9806, allocations: 0.7812 MB / 1.007 GB, free: 9.004 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.162e-05/0.9806, allocations: 63.52 kB / 1.007 GB, free: 9 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001647/0.9808, allocations: 87.06 kB / 1.008 GB, free: 9 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002204/0.983, allocations: 1.035 MB / 1.009 GB, free: 8.68 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.374e-05/0.9831, allocations: 0 / 1.009 GB, free: 8.68 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001076/0.9832, allocations: 33.41 kB / 1.009 GB, free: 8.68 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.55e-05/0.9833, allocations: 48.14 kB / 1.009 GB, free: 8.668 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002028/0.9853, allocations: 0.8741 MB / 1.01 GB, free: 8.523 MB / 490.7 MB
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.006796/0.9922, allocations: 4.286 MB / 1.014 GB, free: 5.414 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001392/0.9936, allocations: 0.7012 MB / 1.014 GB, free: 5.301 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000941/0.9945, allocations: 450.8 kB / 1.015 GB, free: 5.23 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0008224/0.9954, allocations: 0.6765 MB / 1.015 GB, free: 4.457 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.589e-05/0.9955, allocations: 46.69 kB / 1.016 GB, free: 4.414 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=70): time 4.121e-06/0.9955, allocations: 0 / 1.016 GB, free: 4.414 MB / 490.7 MB
Notification: Performance of matching and sorting (n=70): time 0.002509/0.998, allocations: 0.9924 MB / 1.016 GB, free: 4.223 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.442e-05/0.9981, allocations: 57.41 kB / 1.017 GB, free: 4.16 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0009801/0.9991, allocations: 0.6268 MB / 1.017 GB, free: 3.938 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 8.607e-05/0.9992, allocations: 38.67 kB / 1.017 GB, free: 3.906 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003656/0.9995, allocations: 425.7 kB / 1.018 GB, free: 3.676 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003081/0.9999, allocations: 251.3 kB / 1.018 GB, free: 3.496 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 4.722e-05/0.9999, allocations: 11 kB / 1.018 GB, free: 3.496 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002357/1, allocations: 392 kB / 1.018 GB, free: 3.156 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006167/1.001, allocations: 273 kB / 1.018 GB, free: 3.117 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007007/1.002, allocations: 364.9 kB / 1.019 GB, free: 2.996 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0006943/1.002, allocations: 326.6 kB / 1.019 GB, free: 2.961 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.683e-06/1.002, allocations: 0 / 1.019 GB, free: 2.961 MB / 490.7 MB
Notification: Performance of matching and sorting (n=82) (initialization): time 0.001922/1.004, allocations: 0.7964 MB / 1.02 GB, free: 2.418 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.145e-05/1.004, allocations: 4 kB / 1.02 GB, free: 2.414 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.118e-05/1.004, allocations: 4 kB / 1.02 GB, free: 2.41 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.212e-05/1.004, allocations: 4 kB / 1.02 GB, free: 2.406 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009546/1.005, allocations: 142.3 kB / 1.02 GB, free: 2.273 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.688e-05/1.005, allocations: 4 kB / 1.02 GB, free: 2.27 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001302/1.007, allocations: 112 kB / 1.02 GB, free: 2.168 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.628e-05/1.007, allocations: 26.17 kB / 1.02 GB, free: 2.148 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 7
 * 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 (82):
 * Single equations (assignments): 82
 * 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.0006289/1.007, allocations: 285.6 kB / 1.02 GB, free: 1.938 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002328/1.008, allocations: 82.97 kB / 1.021 GB, free: 1.855 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001946/1.01, allocations: 0.7899 MB / 1.021 GB, free: 1.336 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.276e-05/1.01, allocations: 8 kB / 1.021 GB, free: 1.328 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.555e-06/1.01, allocations: 3.984 kB / 1.021 GB, free: 1.324 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001562/1.011, allocations: 0.8097 MB / 1.022 GB, free: 0.6875 MB / 490.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004044/1.015, allocations: 1.844 MB / 1.024 GB, free: 15.37 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.284e-06/1.015, allocations: 1.859 kB / 1.024 GB, free: 15.37 MB / 0.4948 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001201/1.016, allocations: 173.1 kB / 1.024 GB, free: 15.2 MB / 0.4948 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.2e-05/1.017, allocations: 8 kB / 1.024 GB, free: 15.2 MB / 0.4948 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.776e-05/1.017, allocations: 13.5 kB / 1.024 GB, free: 15.19 MB / 0.4948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.6e-06/1.017, allocations: 4 kB / 1.024 GB, free: 15.19 MB / 0.4948 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.891e-06/1.017, allocations: 3.953 kB / 1.024 GB, free: 15.18 MB / 0.4948 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002736/1.019, allocations: 1.268 MB / 1.025 GB, free: 14.3 MB / 0.4948 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006357/1.02, allocations: 249.9 kB / 1.026 GB, free: 14.08 MB / 0.4948 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001493/1.02, allocations: 18.05 kB / 1.026 GB, free: 14.07 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00101/1.021, allocations: 69.86 kB / 1.026 GB, free: 14.02 MB / 0.4948 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000141/1.021, allocations: 44.23 kB / 1.026 GB, free: 13.98 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.691e-05/1.021, allocations: 26.7 kB / 1.026 GB, free: 13.96 MB / 0.4948 GB
Notification: Performance of sorting global known variables: time 0.0007672/1.022, allocations: 443.3 kB / 1.026 GB, free: 13.63 MB / 0.4948 GB
Notification: Performance of sort global known variables: time 8.55e-07/1.022, allocations: 4 kB / 1.026 GB, free: 13.63 MB / 0.4948 GB
Notification: Performance of remove unused functions: time 0.001229/1.024, allocations: 336.2 kB / 1.027 GB, free: 13.32 MB / 0.4948 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 8 (volA.dynBal.U,volA.dynBal.m,volA.dynBal.mXi[1],oriOutBot.mExc,oriOutTop.mExc,volOut.dynBal.U,volOut.dynBal.m,volOut.dynBal.mXi[1])
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (70):
 * Single equations (assignments): 70
 * 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 Backend phase and start with SimCode phase: time 0.0003963/1.024, allocations: 194.7 kB / 1.027 GB, free: 13.14 MB / 0.4948 GB
Notification: Performance of simCode: created initialization part: time 0.001616/1.026, allocations: 0.6803 MB / 1.027 GB, free: 12.68 MB / 0.4948 GB
Notification: Performance of simCode: created event and clocks part: time 4.106e-06/1.026, allocations: 0 / 1.027 GB, free: 12.68 MB / 0.4948 GB
Notification: Performance of simCode: created simulation system equations: time 0.0007755/1.026, allocations: 370.9 kB / 1.028 GB, free: 12.42 MB / 0.4948 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003278/1.03, allocations: 0.5215 MB / 1.028 GB, free: 12 MB / 0.4948 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005305/1.035, allocations: 2.649 MB / 1.031 GB, free: 9.52 MB / 0.4948 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001028/1.036, allocations: 1.107 MB / 1.032 GB, free: 8.41 MB / 0.4948 GB
Notification: Performance of simCode: alias equations: time 0.001459/1.038, allocations: 223.1 kB / 1.032 GB, free: 8.188 MB / 0.4948 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003151/1.038, allocations: 75.36 kB / 1.032 GB, free: 8.113 MB / 0.4948 GB
Notification: Performance of SimCode: time 2.209e-06/1.038, allocations: 0 / 1.032 GB, free: 8.113 MB / 0.4948 GB
Notification: Performance of Templates: time 0.0435/1.081, allocations: 16.87 MB / 1.049 GB, free: 7.465 MB / 0.5105 GB