Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent.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/IDEAS 3.0.0-master/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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(IDEAS.Airflow.Multizone.Examples.TrickleVent,tolerance=1e-06,outputFormat="empty",numberOfIntervals=8640,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent")
translateModel(IDEAS.Airflow.Multizone.Examples.TrickleVent,tolerance=1e-06,outputFormat="empty",numberOfIntervals=8640,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0007919/0.0007919, allocations: 97.64 kB / 15.36 MB, free: 0.7344 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.006879/0.006879, allocations: 170.1 kB / 16.27 MB, free: 6.652 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.357/1.357, allocations: 223.3 MB / 240.3 MB, free: 5.332 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9655/0.9655, allocations: 135.3 MB / 426.7 MB, free: 14.32 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0005148/0.000515, allocations: 9.625 kB / 0.5076 GB, free: 4.734 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1971/0.1976, allocations: 82.31 MB / 0.588 GB, free: 2.598 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Airflow.Multizone.Examples.TrickleVent): time 0.4585/0.6562, allocations: 182.3 MB / 0.766 GB, free: 6.188 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.02218/0.6784, allocations: 16.16 MB / 0.7818 GB, free: 5.984 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002201/0.6806, allocations: 43.75 kB / 0.7818 GB, free: 5.941 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.002386/0.683, allocations: 0.6137 MB / 0.7824 GB, free: 5.324 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.006688/0.6898, allocations: 2.122 MB / 0.7845 GB, free: 3.199 MB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004591/0.6944, allocations: 1.741 MB / 0.7862 GB, free: 1.48 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.004909/0.6993, allocations: 4.337 MB / 0.7904 GB, free: 13.12 MB / 0.6075 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002695/0.702, allocations: 1.76 MB / 0.7921 GB, free: 11.32 MB / 0.6075 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003897/0.7059, allocations: 1.197 MB / 0.7933 GB, free: 10.14 MB / 0.6075 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001967/0.7079, allocations: 1.087 MB / 0.7944 GB, free: 9.047 MB / 0.6075 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003197/0.7082, allocations: 60 kB / 0.7944 GB, free: 8.988 MB / 0.6075 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00424/0.7125, allocations: 2.23 MB / 0.7966 GB, free: 6.754 MB / 0.6075 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006044/0.7131, allocations: 0.5564 MB / 0.7971 GB, free: 6.195 MB / 0.6075 GB
Notification: Performance of NFVerifyModel.verify: time 0.001234/0.7143, allocations: 1.004 MB / 0.7981 GB, free: 5.18 MB / 0.6075 GB
Notification: Performance of NFConvertDAE.convert: time 0.004501/0.7188, allocations: 3.683 MB / 0.8017 GB, free: 1.484 MB / 0.6075 GB
Notification: Performance of FrontEnd - DAE generated: time 3.617e-06/0.7188, allocations: 4 kB / 0.8017 GB, free: 1.48 MB / 0.6075 GB
Notification: Performance of FrontEnd: time 1.433e-06/0.7188, allocations: 0 / 0.8017 GB, free: 1.48 MB / 0.6075 GB
Notification: Performance of Transformations before backend: time 2.277e-05/0.7189, allocations: 0 / 0.8017 GB, free: 1.48 MB / 0.6075 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.003744/0.7226, allocations: 2.289 MB / 0.804 GB, free: 15.12 MB / 0.6231 GB
Notification: Performance of prepare preOptimizeDAE: time 4.016e-05/0.7227, allocations: 8.031 kB / 0.804 GB, free: 15.12 MB / 0.6231 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003328/0.726, allocations: 0.559 MB / 0.8045 GB, free: 14.55 MB / 0.6231 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002046/0.7281, allocations: 1.477 MB / 0.8059 GB, free: 13.02 MB / 0.6231 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.911e-05/0.7282, allocations: 127.5 kB / 0.8061 GB, free: 12.9 MB / 0.6231 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002351/0.7284, allocations: 176 kB / 0.8062 GB, free: 12.73 MB / 0.6231 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003237/0.7317, allocations: 1.986 MB / 0.8082 GB, free: 10.66 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.649e-05/0.7317, allocations: 4 kB / 0.8082 GB, free: 10.66 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001645/0.7319, allocations: 72 kB / 0.8082 GB, free: 10.59 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.618e-05/0.732, allocations: 71.31 kB / 0.8083 GB, free: 10.52 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003336/0.7353, allocations: 2.058 MB / 0.8103 GB, free: 8.457 MB / 0.6231 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.01002/0.7453, allocations: 7.256 MB / 0.8174 GB, free: 0.8242 MB / 0.6231 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002571/0.7479, allocations: 1.608 MB / 0.819 GB, free: 15.18 MB / 0.6387 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001221/0.7492, allocations: 0.7307 MB / 0.8197 GB, free: 14.45 MB / 0.6387 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007892/0.75, allocations: 0.6533 MB / 0.8203 GB, free: 13.67 MB / 0.6387 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001559/0.7515, allocations: 0.9114 MB / 0.8212 GB, free: 12.74 MB / 0.6387 GB
Notification: Performance of pre-optimization done (n=142): time 4.308e-06/0.7515, allocations: 0 / 0.8212 GB, free: 12.74 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=142): time 0.005636/0.7572, allocations: 2.552 MB / 0.8237 GB, free: 10.12 MB / 0.6387 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001117/0.7573, allocations: 226.9 kB / 0.8239 GB, free: 9.848 MB / 0.6387 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001858/0.7592, allocations: 1.479 MB / 0.8254 GB, free: 8.355 MB / 0.6387 GB
Notification: Performance of collectPreVariables (initialization): time 0.000121/0.7593, allocations: 61.64 kB / 0.8254 GB, free: 8.289 MB / 0.6387 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006624/0.76, allocations: 0.8112 MB / 0.8262 GB, free: 7.465 MB / 0.6387 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004038/0.7604, allocations: 492.9 kB / 0.8267 GB, free: 6.977 MB / 0.6387 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001573/0.7606, allocations: 105.7 kB / 0.8268 GB, free: 6.867 MB / 0.6387 GB
Notification: Performance of setup shared object (initialization): time 0.0001326/0.7607, allocations: 357.9 kB / 0.8271 GB, free: 6.512 MB / 0.6387 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001022/0.7617, allocations: 0.5609 MB / 0.8277 GB, free: 5.949 MB / 0.6387 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00117/0.7629, allocations: 0.7433 MB / 0.8284 GB, free: 5.168 MB / 0.6387 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002212/0.7651, allocations: 1.317 MB / 0.8297 GB, free: 3.824 MB / 0.6387 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.797e-06/0.7651, allocations: 0 / 0.8297 GB, free: 3.824 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=164) (initialization): time 0.003451/0.7686, allocations: 1.723 MB / 0.8314 GB, free: 2.082 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 9.182e-05/0.7687, allocations: 153.1 kB / 0.8315 GB, free: 1.91 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.103e-05/0.7687, allocations: 4 kB / 0.8315 GB, free: 1.906 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007866/0.7695, allocations: 142.4 kB / 0.8317 GB, free: 1.758 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001385/0.7709, allocations: 315.6 kB / 0.832 GB, free: 1.449 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003795/0.7747, allocations: 4.219 MB / 0.8361 GB, free: 12.83 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001623/0.7764, allocations: 190.7 kB / 0.8363 GB, free: 12.64 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001101/0.7765, allocations: 55.95 kB / 0.8363 GB, free: 12.59 MB / 0.6544 GB
Notification: Performance of prepare postOptimizeDAE: time 7.564e-06/0.7765, allocations: 4 kB / 0.8363 GB, free: 12.58 MB / 0.6544 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.00309/0.7796, allocations: 1.517 MB / 0.8378 GB, free: 11.05 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.77e-06/0.7796, allocations: 0 / 0.8378 GB, free: 11.05 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007361/0.7803, allocations: 150.5 kB / 0.838 GB, free: 10.9 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001293/0.7817, allocations: 303.6 kB / 0.8382 GB, free: 10.6 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003906/0.7856, allocations: 4.236 MB / 0.8424 GB, free: 5.961 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001742/0.7873, allocations: 169.6 kB / 0.8425 GB, free: 5.797 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001069/0.7874, allocations: 63.95 kB / 0.8426 GB, free: 5.734 MB / 0.6544 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 8
 * Number of states: 0 ()
 * Number of discrete variables: 8 (weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,$whenCondition1,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (158):
 * Single equations (assignments): 155
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.001076/0.7885, allocations: 0.5256 MB / 0.8431 GB, free: 5.199 MB / 0.6544 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002873/0.7888, allocations: 177.8 kB / 0.8433 GB, free: 5.023 MB / 0.6544 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004008/0.7928, allocations: 1.936 MB / 0.8452 GB, free: 3.062 MB / 0.6544 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.322e-05/0.7929, allocations: 16 kB / 0.8452 GB, free: 3.047 MB / 0.6544 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.36e-06/0.7929, allocations: 0 / 0.8452 GB, free: 3.047 MB / 0.6544 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003027/0.7959, allocations: 1.607 MB / 0.8468 GB, free: 1.402 MB / 0.6544 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006324/0.8022, allocations: 3.699 MB / 0.8504 GB, free: 13.63 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.13e-06/0.8023, allocations: 0 / 0.8504 GB, free: 13.63 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001383/0.8037, allocations: 315.6 kB / 0.8507 GB, free: 13.32 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0007038/0.8044, allocations: 146.5 kB / 0.8508 GB, free: 13.17 MB / 0.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 9.298e-05/0.8045, allocations: 39.97 kB / 0.8509 GB, free: 13.13 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003792/0.8083, allocations: 4.234 MB / 0.855 GB, free: 8.496 MB / 0.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.904e-06/0.8083, allocations: 0 / 0.855 GB, free: 8.496 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004962/0.8133, allocations: 2.703 MB / 0.8576 GB, free: 5.766 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009604/0.8142, allocations: 466.3 kB / 0.8581 GB, free: 5.289 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002043/0.8144, allocations: 32 kB / 0.8581 GB, free: 5.258 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001328/0.8158, allocations: 137.8 kB / 0.8582 GB, free: 5.125 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002411/0.816, allocations: 97.17 kB / 0.8583 GB, free: 5.027 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001246/0.8162, allocations: 63.95 kB / 0.8584 GB, free: 4.965 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.001521/0.8177, allocations: 1.035 MB / 0.8594 GB, free: 3.934 MB / 0.67 GB
Notification: Performance of sort global known variables: time 2.7e-07/0.8177, allocations: 0 / 0.8594 GB, free: 3.934 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.00267/0.8204, allocations: 1.075 MB / 0.8604 GB, free: 2.855 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 5 (room.dynBal.U,room.dynBal.m,room.dynBal.mXi[1],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 (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002047/0.8224, allocations: 0.7935 MB / 0.8612 GB, free: 2.258 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.2871/1.11, allocations: 2.902 MB / 0.8641 GB, free: 213.1 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 8.516e-06/1.11, allocations: 3.844 kB / 0.8641 GB, free: 213.1 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.001658/1.111, allocations: 1.142 MB / 0.8652 GB, free: 212.7 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003269/1.115, allocations: 0.6769 MB / 0.8658 GB, free: 212.7 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006502/1.121, allocations: 4.988 MB / 0.8707 GB, free: 210.6 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008499/1.122, allocations: 1.516 MB / 0.8722 GB, free: 209.9 MB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.002213/1.124, allocations: 0.5887 MB / 0.8728 GB, free: 209.8 MB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004177/1.125, allocations: 165.6 kB / 0.8729 GB, free: 209.7 MB / 0.67 GB
Notification: Performance of SimCode: time 9.52e-07/1.125, allocations: 0 / 0.8729 GB, free: 209.7 MB / 0.67 GB
Notification: Performance of Templates: time 0.05765/1.182, allocations: 32.97 MB / 0.9051 GB, free: 204.7 MB / 0.67 GB
make -j1 -f IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent.makefile
(rm -f IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent.pipe ; mkfifo IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent.pipe >> ../files/IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent.sim & ./IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Airflow.Multizone.Examples.TrickleVent.pipe 2>&1)