Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent.conf.json
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/IBPSA 4.0.0-master/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/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 IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/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)
Running command: translateModel(IBPSA.Airflow.Multizone.Examples.TrickleVent,tolerance=1e-06,outputFormat="empty",numberOfIntervals=8640,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent")
translateModel(IBPSA.Airflow.Multizone.Examples.TrickleVent,tolerance=1e-06,outputFormat="empty",numberOfIntervals=8640,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001908/0.001908, allocations: 183.9 kB / 15.76 MB, free: 6.363 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6858/0.6858, allocations: 91.99 MB / 108.5 MB, free: 13.09 MB / 90.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.725/1.725, allocations: 223.2 MB / 354.3 MB, free: 12.28 MB / 282.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00144/0.00144, allocations: 91.16 kB / 427.4 MB, free: 3.977 MB / 346.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003968/0.0003967, allocations: 8 kB / 0.4982 GB, free: 42.35 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1845/0.1849, allocations: 72.31 MB / 0.5689 GB, free: 1.965 MB / 394.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 5.15/5.335, allocations: 1.912 GB / 2.481 GB, free: 158.3 MB / 0.6042 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0004125/5.335, allocations: 93.66 kB / 2.481 GB, free: 158.3 MB / 0.6042 GB
Notification: Performance of FrontEnd - DAE generated: time 2.045/7.38, allocations: 0.5769 GB / 3.058 GB, free: 40.33 MB / 0.6042 GB
Notification: Performance of FrontEnd: time 2.394e-06/7.38, allocations: 0 / 3.058 GB, free: 40.33 MB / 0.6042 GB
Notification: Performance of Transformations before backend: time 0.0003936/7.381, allocations: 52 kB / 3.058 GB, free: 40.28 MB / 0.6042 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 441
 * Number of variables: 441
Notification: Performance of Generate backend data structure: time 0.009029/7.39, allocations: 2.678 MB / 3.061 GB, free: 37.54 MB / 0.6042 GB
Notification: Performance of prepare preOptimizeDAE: time 5.09e-05/7.39, allocations: 12.03 kB / 3.061 GB, free: 37.52 MB / 0.6042 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00451/7.394, allocations: 0.5473 MB / 3.061 GB, free: 36.97 MB / 0.6042 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005618/7.4, allocations: 1.932 MB / 3.063 GB, free: 34.99 MB / 0.6042 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001678/7.4, allocations: 131.5 kB / 3.063 GB, free: 34.86 MB / 0.6042 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000742/7.401, allocations: 168 kB / 3.064 GB, free: 34.7 MB / 0.6042 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005496/7.407, allocations: 1.968 MB / 3.066 GB, free: 32.64 MB / 0.6042 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.432e-05/7.407, allocations: 7.906 kB / 3.066 GB, free: 32.64 MB / 0.6042 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003708/7.407, allocations: 76 kB / 3.066 GB, free: 32.56 MB / 0.6042 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.284e-05/7.407, allocations: 59.31 kB / 3.066 GB, free: 32.5 MB / 0.6042 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003981/7.411, allocations: 2.015 MB / 3.068 GB, free: 30.48 MB / 0.6042 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.01622/7.427, allocations: 7.715 MB / 3.075 GB, free: 22.44 MB / 0.6042 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002779/7.43, allocations: 1.605 MB / 3.077 GB, free: 20.79 MB / 0.6042 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007154/7.431, allocations: 0.6416 MB / 3.077 GB, free: 20.02 MB / 0.6042 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001762/7.433, allocations: 0.9153 MB / 3.078 GB, free: 19.09 MB / 0.6042 GB
Notification: Performance of pre-optimization done (n=142): time 6.773e-06/7.433, allocations: 0 / 3.078 GB, free: 19.09 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=142): time 0.006172/7.439, allocations: 2.571 MB / 3.081 GB, free: 16.45 MB / 0.6042 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001039/7.439, allocations: 270.3 kB / 3.081 GB, free: 16.12 MB / 0.6042 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003721/7.443, allocations: 1.948 MB / 3.083 GB, free: 14.16 MB / 0.6042 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002266/7.443, allocations: 57.7 kB / 3.083 GB, free: 14.1 MB / 0.6042 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008941/7.444, allocations: 0.8508 MB / 3.084 GB, free: 13.24 MB / 0.6042 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0005077/7.444, allocations: 488.9 kB / 3.084 GB, free: 12.75 MB / 0.6042 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 8.356e-05/7.445, allocations: 24 kB / 3.084 GB, free: 12.73 MB / 0.6042 GB
Notification: Performance of setup shared object (initialization): time 0.0001172/7.445, allocations: 353.9 kB / 3.085 GB, free: 12.38 MB / 0.6042 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001034/7.446, allocations: 0.5413 MB / 3.085 GB, free: 11.84 MB / 0.6042 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001111/7.447, allocations: 0.7271 MB / 3.086 GB, free: 11.06 MB / 0.6042 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001097/7.448, allocations: 0.6271 MB / 3.087 GB, free: 10.43 MB / 0.6042 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.073e-06/7.448, allocations: 4 kB / 3.087 GB, free: 10.43 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=155) (initialization): time 0.003659/7.452, allocations: 1.673 MB / 3.088 GB, free: 8.738 MB / 0.6042 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001905/7.452, allocations: 0.6471 MB / 3.089 GB, free: 8.039 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.375e-05/7.452, allocations: 3.984 kB / 3.089 GB, free: 8.035 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008441/7.453, allocations: 142.4 kB / 3.089 GB, free: 7.887 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001324/7.454, allocations: 295.6 kB / 3.089 GB, free: 7.598 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003362/7.457, allocations: 4.262 MB / 3.093 GB, free: 2.93 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002069/7.46, allocations: 186.8 kB / 3.094 GB, free: 2.746 MB / 0.6042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001877/7.46, allocations: 63.97 kB / 3.094 GB, free: 2.684 MB / 0.6042 GB
Notification: Performance of prepare postOptimizeDAE: time 1.197e-05/7.46, allocations: 8 kB / 3.094 GB, free: 2.676 MB / 0.6042 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.003019/7.463, allocations: 1.458 MB / 3.095 GB, free: 1.207 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.046e-05/7.463, allocations: 4 kB / 3.095 GB, free: 1.203 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007092/7.464, allocations: 142.6 kB / 3.095 GB, free: 1.055 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001311/7.465, allocations: 299.5 kB / 3.095 GB, free: 0.7617 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004172/7.469, allocations: 4.249 MB / 3.1 GB, free: 12.11 MB / 0.6198 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002263/7.471, allocations: 178.8 kB / 3.1 GB, free: 11.93 MB / 0.6198 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002424/7.472, allocations: 59.97 kB / 3.1 GB, free: 11.88 MB / 0.6198 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 7
 * Number of states: 0 ()
 * Number of discrete variables: 6 ($whenCondition2,$whenCondition1,$PRE.weaDat.conTimMin.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTim.tNext)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (149):
 * Single equations (assignments): 146
 * 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: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 2 {(1,100.0%) 2,(1,100.0%) 2}
 * Non-linear torn systems: 1 {1 2}
Notification: Performance of prepare postOptimizeDAE: time 0.001786/7.473, allocations: 0.5249 MB / 3.1 GB, free: 11.34 MB / 0.6198 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000869/7.474, allocations: 189.7 kB / 3.101 GB, free: 11.15 MB / 0.6198 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005223/7.479, allocations: 2.026 MB / 3.103 GB, free: 9.105 MB / 0.6198 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.186e-05/7.479, allocations: 19.95 kB / 3.103 GB, free: 9.086 MB / 0.6198 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.216e-05/7.48, allocations: 3.984 kB / 3.103 GB, free: 9.082 MB / 0.6198 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003267/7.483, allocations: 1.595 MB / 3.104 GB, free: 7.445 MB / 0.6198 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.009271/7.492, allocations: 4.057 MB / 3.108 GB, free: 3.316 MB / 0.6198 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.793e-06/7.492, allocations: 0 / 3.108 GB, free: 3.316 MB / 0.6198 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001529/7.494, allocations: 315.6 kB / 3.108 GB, free: 3.008 MB / 0.6198 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0007366/7.494, allocations: 150.3 kB / 3.108 GB, free: 2.852 MB / 0.6198 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001594/7.495, allocations: 39.97 kB / 3.109 GB, free: 2.812 MB / 0.6198 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.4596/7.954, allocations: 4.25 MB / 3.113 GB, free: 100.5 MB / 0.6198 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.176e-06/7.954, allocations: 8.219 kB / 3.113 GB, free: 100.5 MB / 0.6198 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008248/7.963, allocations: 2.696 MB / 3.115 GB, free: 100.3 MB / 0.6198 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002268/7.965, allocations: 0.6018 MB / 3.116 GB, free: 100.2 MB / 0.6198 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000406/7.965, allocations: 31.02 kB / 3.116 GB, free: 100.2 MB / 0.6198 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001615/7.967, allocations: 143.6 kB / 3.116 GB, free: 100.2 MB / 0.6198 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000381/7.967, allocations: 99.16 kB / 3.116 GB, free: 100.2 MB / 0.6198 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000251/7.968, allocations: 71.3 kB / 3.116 GB, free: 100.2 MB / 0.6198 GB
Notification: Performance of sorting global known variables: time 0.003539/7.971, allocations: 1.543 MB / 3.118 GB, free: 100.1 MB / 0.6198 GB
Notification: Performance of sort global known variables: time 1.4e-07/7.971, allocations: 1.812 kB / 3.118 GB, free: 100.1 MB / 0.6198 GB
Notification: Performance of remove unused functions: time 0.005841/7.977, allocations: 1.323 MB / 3.119 GB, free: 100 MB / 0.6198 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 5 (room.dynBal.medium.Xi[1],room.dynBal.U,room.dynBal.m,tabDat_m_flow.mExc,tabDat_V_flow.mExc)
 * Number of discrete variables: 4 ($whenCondition2,$whenCondition1,weaDat.conTimMin.tNext,weaDat.conTim.tNext)
 * Number of discrete states: 2 (weaDat.conTimMin.tNext,weaDat.conTim.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (149):
 * Single equations (assignments): 144
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 2 {(1,100.0%) 2,(1,100.0%) 2}
 * Non-linear torn systems: 1 {1 3}
Notification: Performance of Backend phase and start with SimCode phase: time 0.005112/7.982, allocations: 2.064 MB / 3.121 GB, free: 99.59 MB / 0.6198 GB
Notification: Performance of simCode: created initialization part: time 0.007072/7.989, allocations: 2.815 MB / 3.124 GB, free: 98.89 MB / 0.6198 GB
Notification: Performance of simCode: created event and clocks part: time 1.355e-05/7.989, allocations: 448 / 3.124 GB, free: 98.89 MB / 0.6198 GB
Notification: Performance of simCode: created simulation system equations: time 0.002224/7.992, allocations: 1.128 MB / 3.125 GB, free: 98.55 MB / 0.6198 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004466/7.996, allocations: 0.6679 MB / 3.126 GB, free: 98.54 MB / 0.6198 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.009262/8.005, allocations: 4.841 MB / 3.13 GB, free: 96.59 MB / 0.6198 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001623/8.007, allocations: 1.555 MB / 3.132 GB, free: 95.85 MB / 0.6198 GB
Notification: Performance of simCode: alias equations: time 0.003433/8.01, allocations: 0.7158 MB / 3.133 GB, free: 95.83 MB / 0.6198 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0008093/8.011, allocations: 207.5 kB / 3.133 GB, free: 95.82 MB / 0.6198 GB
Notification: Performance of SimCode: time 1.092e-06/8.011, allocations: 2.219 kB / 3.133 GB, free: 95.82 MB / 0.6198 GB
Notification: Performance of Templates: time 0.08721/8.098, allocations: 53.09 MB / 3.185 GB, free: 93.71 MB / 0.6198 GB
make -j1 -f IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent.makefile
(rm -f IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent.pipe ; mkfifo IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent.pipe >> ../files/IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent.sim & ./IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Airflow.Multizone.Examples.TrickleVent.pipe 2>&1)