Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Airflow.Multizone.Validation.OpenDoorTemperature.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.Validation.OpenDoorTemperature,tolerance=1e-06,outputFormat="empty",numberOfIntervals=96,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Airflow.Multizone.Validation.OpenDoorTemperature")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002462/0.002466, allocations: 356.6 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.457/1.457, allocations: 165.8 MB / 182.5 MB, free: 5.414 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.648/3.648, allocations: 410.8 MB / 0.5995 GB, free: 15.18 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.001741/0.001741, allocations: 197.1 kB / 0.6662 GB, free: 6.934 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004621/0.0004624, allocations: 12 kB / 0.7423 GB, free: 8.973 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3376/0.3381, allocations: 67.43 MB / 0.8081 GB, free: 28.81 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Airflow.Multizone.Validation.OpenDoorTemperature): time 0.5874/0.9256, allocations: 165.9 MB / 0.9702 GB, free: 1.211 MB / 474.7 MB
Notification: Performance of NFInst.instExpressions: time 0.007987/0.9336, allocations: 5.168 MB / 0.9752 GB, free: 0.9414 MB / 474.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0009894/0.9347, allocations: 13.34 kB / 0.9752 GB, free: 0.9375 MB / 474.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001322/0.936, allocations: 466.7 kB / 0.9757 GB, free: 0.8359 MB / 474.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.004008/0.9401, allocations: 1.282 MB / 0.9769 GB, free: 0.5859 MB / 474.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003316/0.9434, allocations: 0.5764 MB / 0.9775 GB, free: 0.5391 MB / 474.7 MB
Notification: Performance of NFFlatten.flatten: time 0.004822/0.9483, allocations: 2.495 MB / 0.9799 GB, free: 232 kB / 474.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.00165/0.95, allocations: 0.5747 MB / 0.9805 GB, free: 60 kB / 474.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005791/0.9558, allocations: 1.085 MB / 0.9815 GB, free: 15.91 MB / 490.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002484/0.9583, allocations: 0.8171 MB / 0.9823 GB, free: 15.64 MB / 490.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003436/0.9587, allocations: 52.03 kB / 0.9824 GB, free: 15.64 MB / 490.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004475/0.9632, allocations: 0.7986 MB / 0.9832 GB, free: 15.41 MB / 490.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001103/0.9644, allocations: 437.4 kB / 0.9836 GB, free: 15.23 MB / 490.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0007312/0.9652, allocations: 228.5 kB / 0.9838 GB, free: 15.16 MB / 490.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.003916/0.9691, allocations: 1.231 MB / 0.985 GB, free: 14.59 MB / 490.7 MB
Notification: Performance of FrontEnd - DAE generated: time 7.88e-06/0.9692, allocations: 0 / 0.985 GB, free: 14.59 MB / 490.7 MB
Notification: Performance of FrontEnd: time 4.29e-06/0.9692, allocations: 0 / 0.985 GB, free: 14.59 MB / 490.7 MB
Notification: Performance of Transformations before backend: time 4.028e-05/0.9693, allocations: 3.938 kB / 0.985 GB, free: 14.59 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: 230
 * Number of variables: 230
Notification: Performance of Generate backend data structure: time 0.008158/0.9774, allocations: 1.468 MB / 0.9864 GB, free: 13.62 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.736e-05/0.9775, allocations: 8.031 kB / 0.9864 GB, free: 13.62 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0008447/0.9784, allocations: 154.8 kB / 0.9866 GB, free: 13.55 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00125/0.9796, allocations: 0.6098 MB / 0.9872 GB, free: 13.17 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.183e-05/0.9797, allocations: 72.98 kB / 0.9873 GB, free: 13.16 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001615/0.9799, allocations: 89.2 kB / 0.9873 GB, free: 13.16 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002217/0.9821, allocations: 1.181 MB / 0.9885 GB, free: 12.84 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.427e-05/0.9822, allocations: 6.875 kB / 0.9885 GB, free: 12.84 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001058/0.9823, allocations: 30.16 kB / 0.9885 GB, free: 12.84 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.853e-05/0.9824, allocations: 47.14 kB / 0.9886 GB, free: 12.83 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002918/0.9853, allocations: 1.504 MB / 0.99 GB, free: 12.52 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.006516/0.9918, allocations: 3.55 MB / 0.9935 GB, free: 10.48 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002557/0.9944, allocations: 1.435 MB / 0.9949 GB, free: 10.22 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001387/0.9959, allocations: 0.6922 MB / 0.9956 GB, free: 10.11 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.001282/0.9972, allocations: 0.9622 MB / 0.9965 GB, free: 9.047 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001484/0.9987, allocations: 0.6973 MB / 0.9972 GB, free: 8.805 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=123): time 5.735e-06/0.9987, allocations: 0 / 0.9972 GB, free: 8.805 MB / 490.7 MB
Notification: Performance of matching and sorting (n=123): time 0.003821/1.003, allocations: 1.835 MB / 0.999 GB, free: 8.43 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.845e-05/1.003, allocations: 99.22 kB / 0.9991 GB, free: 8.332 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00132/1.004, allocations: 0.8313 MB / 0.9999 GB, free: 8.074 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001415/1.004, allocations: 46.36 kB / 1 GB, free: 8.043 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003514/1.005, allocations: 366.1 kB / 1 GB, free: 7.859 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004558/1.005, allocations: 410 kB / 1.001 GB, free: 7.566 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 7.314e-05/1.005, allocations: 20.56 kB / 1.001 GB, free: 7.566 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001879/1.005, allocations: 349.7 kB / 1.001 GB, free: 7.25 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000997/1.006, allocations: 0.5091 MB / 1.002 GB, free: 7.16 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00115/1.007, allocations: 0.6359 MB / 1.002 GB, free: 6.973 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001206/1.009, allocations: 0.6294 MB / 1.003 GB, free: 6.852 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.697e-06/1.009, allocations: 0 / 1.003 GB, free: 6.852 MB / 490.7 MB
Notification: Performance of matching and sorting (n=143) (initialization): time 0.002917/1.012, allocations: 1.48 MB / 1.004 GB, free: 6.535 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 5.73e-05/1.012, allocations: 41.72 kB / 1.004 GB, free: 6.496 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.195e-05/1.012, allocations: 2.688 kB / 1.004 GB, free: 6.496 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.429e-05/1.012, allocations: 6.062 kB / 1.004 GB, free: 6.496 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001275/1.013, allocations: 224.9 kB / 1.004 GB, free: 6.461 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.165e-05/1.013, allocations: 11.88 kB / 1.004 GB, free: 6.457 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001074/1.014, allocations: 134.6 kB / 1.005 GB, free: 6.379 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001322/1.014, allocations: 43.7 kB / 1.005 GB, free: 6.375 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 10
 * Number of states: 0 ()
 * Number of discrete variables: 7 ($whenCondition1,bouTem.a,bouTem.b,bouTem.last,$PRE.bouTem.nextEvent,bouTem.nextEvent,bouTem.nextEventScaled)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (138):
 * Single equations (assignments): 137
 * Array equations: 0
 * Algorithm blocks: 1
 * 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.000666/1.015, allocations: 369.8 kB / 1.005 GB, free: 6.18 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002607/1.015, allocations: 106.9 kB / 1.005 GB, free: 6.125 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003216/1.019, allocations: 1.59 MB / 1.007 GB, free: 5.59 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.971e-05/1.019, allocations: 12 kB / 1.007 GB, free: 5.578 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.828e-06/1.019, allocations: 0 / 1.007 GB, free: 5.578 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.866e-05/1.019, allocations: 8.016 kB / 1.007 GB, free: 5.57 MB / 490.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.007168/1.026, allocations: 3.296 MB / 1.01 GB, free: 2.922 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.785e-05/1.026, allocations: 4 kB / 1.01 GB, free: 2.918 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00124/1.027, allocations: 210.5 kB / 1.01 GB, free: 2.719 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 2.346e-05/1.027, allocations: 12 kB / 1.01 GB, free: 2.707 MB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001287/1.027, allocations: 33.75 kB / 1.01 GB, free: 2.691 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.072e-05/1.027, allocations: 11.98 kB / 1.01 GB, free: 2.68 MB / 490.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.026e-05/1.027, allocations: 11.94 kB / 1.01 GB, free: 2.668 MB / 490.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00471/1.032, allocations: 2.48 MB / 1.013 GB, free: 0.7539 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008781/1.033, allocations: 328.3 kB / 1.013 GB, free: 472 kB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000219/1.033, allocations: 30.23 kB / 1.013 GB, free: 460 kB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009041/1.034, allocations: 50.78 kB / 1.013 GB, free: 424 kB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00022/1.034, allocations: 86.3 kB / 1.013 GB, free: 344 kB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001236/1.035, allocations: 44.23 kB / 1.013 GB, free: 308 kB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.001022/1.036, allocations: 0.5949 MB / 1.014 GB, free: 15.86 MB / 0.4949 GB
Notification: Performance of sort global known variables: time 9.24e-07/1.036, allocations: 0 / 1.014 GB, free: 15.86 MB / 0.4949 GB
Notification: Performance of remove unused functions: time 0.001408/1.037, allocations: 363.9 kB / 1.014 GB, free: 15.54 MB / 0.4949 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 25
 * Number of states: 2 (dooDis.mExcAB,dooDis.mExcBA)
 * Number of discrete variables: 6 ($whenCondition1,bouTem.a,bouTem.b,bouTem.last,bouTem.nextEvent,bouTem.nextEventScaled)
 * Number of discrete states: 6 (bouTem.nextEvent,bouTem.last,bouTem.nextEventScaled,bouTem.b,bouTem.a,$whenCondition1)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (122):
 * Single equations (assignments): 121
 * Array equations: 0
 * Algorithm blocks: 1
 * 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.0007302/1.038, allocations: 291.2 kB / 1.014 GB, free: 15.28 MB / 0.4949 GB
Notification: Performance of simCode: created initialization part: time 0.002728/1.041, allocations: 1.337 MB / 1.016 GB, free: 14.27 MB / 0.4949 GB
Notification: Performance of simCode: created event and clocks part: time 7.556e-06/1.041, allocations: 1.859 kB / 1.016 GB, free: 14.27 MB / 0.4949 GB
Notification: Performance of simCode: created simulation system equations: time 0.001438/1.042, allocations: 0.7328 MB / 1.016 GB, free: 13.7 MB / 0.4949 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003024/1.045, allocations: 443.9 kB / 1.017 GB, free: 13.36 MB / 0.4949 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005221/1.05, allocations: 2.654 MB / 1.019 GB, free: 10.88 MB / 0.4949 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001065/1.051, allocations: 1.127 MB / 1.02 GB, free: 9.758 MB / 0.4949 GB
Notification: Performance of simCode: alias equations: time 0.001994/1.053, allocations: 432.2 kB / 1.021 GB, free: 9.332 MB / 0.4949 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004085/1.054, allocations: 96.89 kB / 1.021 GB, free: 9.242 MB / 0.4949 GB
Notification: Performance of SimCode: time 1.844e-06/1.054, allocations: 0 / 1.021 GB, free: 9.242 MB / 0.4949 GB
Notification: Performance of Templates: time 0.04819/1.102, allocations: 17.37 MB / 1.038 GB, free: 8.074 MB / 0.5105 GB