Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam")
translateModel(IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.006648/0.006648, allocations: 101.1 kB / 15.88 MB, free: 6.32 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001188/0.001188, allocations: 192.5 kB / 16.79 MB, free: 6.246 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.4/1.4, allocations: 222.9 MB / 240.5 MB, free: 4.543 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.7579/0.7579, allocations: 122.9 MB / 413.5 MB, free: 11.14 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001475/0.001475, allocations: 63.84 kB / 0.4904 GB, free: 14.36 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1952/0.1967, allocations: 77.94 MB / 0.5666 GB, free: 0.6367 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam): time 1.183/1.379, allocations: 282 MB / 0.842 GB, free: 1.418 MB / 0.6387 GB
Notification: Performance of NFInst.instExpressions: time 0.03172/1.411, allocations: 17.51 MB / 0.8591 GB, free: 1.23 MB / 0.6387 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005672/1.417, allocations: 63.78 kB / 0.8592 GB, free: 1.23 MB / 0.6387 GB
Notification: Performance of NFTyping.typeComponents: time 0.005774/1.423, allocations: 1.495 MB / 0.8606 GB, free: 1.199 MB / 0.6387 GB
Notification: Performance of NFTyping.typeBindings: time 0.01919/1.442, allocations: 5.558 MB / 0.866 GB, free: 0.9297 MB / 0.6387 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009892/1.452, allocations: 2.557 MB / 0.8685 GB, free: 0.8516 MB / 0.6387 GB
Notification: Performance of NFFlatten.flatten: time 0.01538/1.467, allocations: 9.646 MB / 0.878 GB, free: 0.8438 MB / 0.6387 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004958/1.472, allocations: 2.182 MB / 0.8801 GB, free: 16.51 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007526/1.48, allocations: 2.156 MB / 0.8822 GB, free: 16.51 MB / 0.6544 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.007176/1.487, allocations: 2.503 MB / 0.8846 GB, free: 16.49 MB / 0.6544 GB
Notification: Performance of NFPackage.collectConstants: time 0.001012/1.488, allocations: 179.4 kB / 0.8848 GB, free: 16.49 MB / 0.6544 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01739/1.505, allocations: 6.878 MB / 0.8915 GB, free: 16.43 MB / 0.6544 GB
Notification: Performance of NFScalarize.scalarize: time 0.003145/1.509, allocations: 1.189 MB / 0.8927 GB, free: 16.42 MB / 0.6544 GB
Notification: Performance of NFVerifyModel.verify: time 0.004022/1.513, allocations: 1.579 MB / 0.8942 GB, free: 15.99 MB / 0.6544 GB
Notification: Performance of NFConvertDAE.convert: time 0.01794/1.531, allocations: 6.698 MB / 0.9008 GB, free: 13.62 MB / 0.6544 GB
Notification: Performance of FrontEnd - DAE generated: time 7.855e-06/1.531, allocations: 0 / 0.9008 GB, free: 13.62 MB / 0.6544 GB
Notification: Performance of FrontEnd: time 1.884e-06/1.531, allocations: 2.531 kB / 0.9008 GB, free: 13.62 MB / 0.6544 GB
Notification: Performance of Transformations before backend: time 0.000121/1.531, allocations: 0 / 0.9008 GB, free: 13.62 MB / 0.6544 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 627
 * Number of variables: 627
Notification: Performance of Generate backend data structure: time 0.0117/1.542, allocations: 3.747 MB / 0.9044 GB, free: 11.57 MB / 0.6544 GB
Notification: Performance of prepare preOptimizeDAE: time 4.952e-05/1.542, allocations: 15.06 kB / 0.9044 GB, free: 11.56 MB / 0.6544 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005886/1.548, allocations: 0.8122 MB / 0.9052 GB, free: 11.23 MB / 0.6544 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003368/1.552, allocations: 1.632 MB / 0.9068 GB, free: 10.49 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001295/1.552, allocations: 185.1 kB / 0.907 GB, free: 10.48 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003673/1.552, allocations: 246.8 kB / 0.9072 GB, free: 10.48 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005338/1.558, allocations: 3.091 MB / 0.9103 GB, free: 9.594 MB / 0.6544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.644e-05/1.558, allocations: 13.41 kB / 0.9103 GB, free: 9.586 MB / 0.6544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002334/1.558, allocations: 103.4 kB / 0.9104 GB, free: 9.586 MB / 0.6544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001546/1.558, allocations: 129.1 kB / 0.9105 GB, free: 9.566 MB / 0.6544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004563/1.563, allocations: 2.839 MB / 0.9133 GB, free: 9.09 MB / 0.6544 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.01654/1.579, allocations: 12.06 MB / 0.9251 GB, free: 14.7 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003791/1.583, allocations: 2.272 MB / 0.9273 GB, free: 13.11 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002259/1.585, allocations: 1.244 MB / 0.9285 GB, free: 11.9 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001742/1.587, allocations: 1.366 MB / 0.9298 GB, free: 10.25 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.201e-05/1.587, allocations: 56.56 kB / 0.9299 GB, free: 10.18 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=197): time 5.42e-06/1.587, allocations: 4 kB / 0.9299 GB, free: 10.18 MB / 0.67 GB
Notification: Performance of matching and sorting (n=197): time 0.006322/1.594, allocations: 2.831 MB / 0.9326 GB, free: 7.348 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.179e-05/1.594, allocations: 77.34 kB / 0.9327 GB, free: 7.262 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002523/1.596, allocations: 1.308 MB / 0.934 GB, free: 5.945 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002071/1.596, allocations: 65.7 kB / 0.9341 GB, free: 5.875 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007731/1.597, allocations: 0.9477 MB / 0.935 GB, free: 4.914 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0008373/1.598, allocations: 0.6821 MB / 0.9356 GB, free: 4.238 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005309/1.599, allocations: 295.5 kB / 0.9359 GB, free: 3.941 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 0.00014/1.599, allocations: 309.1 kB / 0.9362 GB, free: 3.637 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00139/1.6, allocations: 0.7808 MB / 0.937 GB, free: 2.855 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001579/1.602, allocations: 0.9711 MB / 0.9379 GB, free: 1.855 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003229/1.605, allocations: 1.874 MB / 0.9398 GB, free: 15.96 MB / 0.6856 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.686e-06/1.605, allocations: 0 / 0.9398 GB, free: 15.96 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=219) (initialization): time 0.004346/1.609, allocations: 2.155 MB / 0.9419 GB, free: 13.81 MB / 0.6856 GB
Notification: Performance of prepare postOptimizeDAE: time 3.049e-05/1.609, allocations: 8.344 kB / 0.9419 GB, free: 13.8 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.44e-05/1.609, allocations: 4 kB / 0.9419 GB, free: 13.8 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.043e-05/1.609, allocations: 12 kB / 0.9419 GB, free: 13.79 MB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001684/1.611, allocations: 376.8 kB / 0.9423 GB, free: 13.44 MB / 0.6856 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.846e-05/1.611, allocations: 12 kB / 0.9423 GB, free: 13.43 MB / 0.6856 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003764/1.615, allocations: 328.8 kB / 0.9426 GB, free: 13.11 MB / 0.6856 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001674/1.615, allocations: 63.92 kB / 0.9426 GB, free: 13.05 MB / 0.6856 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 12
 * 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 (219):
 * Single equations (assignments): 219
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.001795/1.617, allocations: 0.5923 MB / 0.9432 GB, free: 12.46 MB / 0.6856 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008953/1.618, allocations: 201.7 kB / 0.9434 GB, free: 12.27 MB / 0.6856 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004544/1.622, allocations: 2.267 MB / 0.9456 GB, free: 9.988 MB / 0.6856 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.913e-05/1.622, allocations: 20 kB / 0.9456 GB, free: 9.969 MB / 0.6856 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.113e-05/1.622, allocations: 0 / 0.9456 GB, free: 9.969 MB / 0.6856 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003025/1.625, allocations: 1.874 MB / 0.9475 GB, free: 8.086 MB / 0.6856 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.009518/1.635, allocations: 5.1 MB / 0.9525 GB, free: 2.93 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.04e-05/1.635, allocations: 4 kB / 0.9525 GB, free: 2.926 MB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002032/1.637, allocations: 425.1 kB / 0.9529 GB, free: 2.531 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.502e-05/1.637, allocations: 12 kB / 0.9529 GB, free: 2.52 MB / 0.6856 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001343/1.637, allocations: 47.98 kB / 0.9529 GB, free: 2.473 MB / 0.6856 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.431e-05/1.637, allocations: 12 kB / 0.9529 GB, free: 2.461 MB / 0.6856 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.124e-06/1.637, allocations: 2.625 kB / 0.9529 GB, free: 2.461 MB / 0.6856 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005477/1.643, allocations: 3.409 MB / 0.9563 GB, free: 15.01 MB / 0.7012 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001466/1.644, allocations: 0.5022 MB / 0.9567 GB, free: 14.49 MB / 0.7012 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00031/1.645, allocations: 43.98 kB / 0.9568 GB, free: 14.45 MB / 0.7012 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001818/1.646, allocations: 203.6 kB / 0.957 GB, free: 14.25 MB / 0.7012 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00028/1.647, allocations: 132.4 kB / 0.9571 GB, free: 14.12 MB / 0.7012 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001394/1.647, allocations: 67.91 kB / 0.9572 GB, free: 14.05 MB / 0.7012 GB
Notification: Performance of sorting global known variables: time 0.001303/1.648, allocations: 0.9083 MB / 0.9581 GB, free: 13.14 MB / 0.7012 GB
Notification: Performance of sort global known variables: time 1.9e-07/1.648, allocations: 0 / 0.9581 GB, free: 13.14 MB / 0.7012 GB
Notification: Performance of remove unused functions: time 0.002113/1.65, allocations: 0.8532 MB / 0.9589 GB, free: 12.29 MB / 0.7012 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 11
 * Number of states: 16 (volEas.dynBal.medium.Xi[1],volEas.dynBal.U,volEas.dynBal.m,volEas.dynBal.mC[1],oriOutBot.mExc,oriOutTop.mExc,oriWesTop.mExc,volWes.dynBal.medium.Xi[1],volWes.dynBal.U,volWes.dynBal.m,volWes.dynBal.mC[1],oriEasTop.mExc,volTop.dynBal.medium.Xi[1],volTop.dynBal.U,volTop.dynBal.m,volTop.dynBal.mC[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 (201):
 * Single equations (assignments): 201
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0008024/1.651, allocations: 368.9 kB / 0.9592 GB, free: 11.97 MB / 0.7012 GB
Notification: Performance of simCode: created initialization part: time 0.003394/1.655, allocations: 1.967 MB / 0.9612 GB, free: 10.03 MB / 0.7012 GB
Notification: Performance of simCode: created event and clocks part: time 6.612e-06/1.655, allocations: 4 kB / 0.9612 GB, free: 10.03 MB / 0.7012 GB
Notification: Performance of simCode: created simulation system equations: time 0.001624/1.656, allocations: 1.083 MB / 0.9622 GB, free: 8.992 MB / 0.7012 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00569/1.662, allocations: 1.19 MB / 0.9634 GB, free: 7.816 MB / 0.7012 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01028/1.672, allocations: 6.386 MB / 0.9696 GB, free: 1.398 MB / 0.7012 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001558/1.674, allocations: 1.824 MB / 0.9714 GB, free: 15.54 MB / 0.7169 GB
Notification: Performance of simCode: alias equations: time 0.002966/1.677, allocations: 0.622 MB / 0.972 GB, free: 14.91 MB / 0.7169 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006405/1.677, allocations: 179.3 kB / 0.9722 GB, free: 14.73 MB / 0.7169 GB
Notification: Performance of SimCode: time 1.122e-06/1.677, allocations: 0 / 0.9722 GB, free: 14.73 MB / 0.7169 GB
Notification: Performance of Templates: time 0.07678/1.754, allocations: 42.72 MB / 1.014 GB, free: 4.637 MB / 0.7481 GB
make -j1 -f IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.makefile
(rm -f IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.pipe ; mkfifo IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.pipe >> ../files/IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.sim & ./IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.pipe 2>&1)