Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.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/BuildSysPro 3.6.0/package.mo", uses=false)
Using package BuildSysPro with version 3.5.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/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(BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw")
translateModel(BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00129/0.00129, allocations: 108 kB / 15.6 MB, free: 132 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001275/0.001275, allocations: 194.9 kB / 16.53 MB, free: 6.391 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.269/1.269, allocations: 222.9 MB / 240.2 MB, free: 4.43 MB / 190.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/package.mo): time 0.9321/0.9321, allocations: 143 MB / 433.4 MB, free: 11.5 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001239/0.001239, allocations: 59.91 kB / 0.5142 GB, free: 11.67 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1391/0.1403, allocations: 82.04 MB / 0.5943 GB, free: 9.598 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw): time 0.3906/0.531, allocations: 192.7 MB / 0.7825 GB, free: 12.47 MB / 0.6075 GB
Notification: Performance of NFInst.instExpressions: time 0.005819/0.5368, allocations: 4.029 MB / 0.7864 GB, free: 8.43 MB / 0.6075 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0007011/0.5375, allocations: 19.94 kB / 0.7864 GB, free: 8.41 MB / 0.6075 GB
Notification: Performance of NFTyping.typeComponents: time 0.001163/0.5387, allocations: 473 kB / 0.7869 GB, free: 7.945 MB / 0.6075 GB
Notification: Performance of NFTyping.typeBindings: time 0.003123/0.5419, allocations: 1.532 MB / 0.7884 GB, free: 6.406 MB / 0.6075 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002839/0.5447, allocations: 1.341 MB / 0.7897 GB, free: 5.066 MB / 0.6075 GB
Notification: Performance of NFFlatten.flatten: time 0.001712/0.5465, allocations: 1.632 MB / 0.7913 GB, free: 3.43 MB / 0.6075 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001035/0.5475, allocations: 0.947 MB / 0.7922 GB, free: 2.473 MB / 0.6075 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001115/0.5486, allocations: 0.9189 MB / 0.7931 GB, free: 1.551 MB / 0.6075 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0009027/0.5495, allocations: 0.8565 MB / 0.7939 GB, free: 0.6914 MB / 0.6075 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001477/0.5497, allocations: 96 kB / 0.794 GB, free: 0.5977 MB / 0.6075 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00208/0.5518, allocations: 1.305 MB / 0.7953 GB, free: 15.29 MB / 0.6231 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003118/0.5521, allocations: 350.9 kB / 0.7956 GB, free: 14.95 MB / 0.6231 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004649/0.5526, allocations: 0.5134 MB / 0.7961 GB, free: 14.43 MB / 0.6231 GB
Notification: Performance of NFConvertDAE.convert: time 0.001843/0.5544, allocations: 1.659 MB / 0.7978 GB, free: 12.77 MB / 0.6231 GB
Notification: Performance of FrontEnd - DAE generated: time 3.697e-06/0.5544, allocations: 3.938 kB / 0.7978 GB, free: 12.76 MB / 0.6231 GB
Notification: Performance of FrontEnd: time 1.192e-06/0.5545, allocations: 0 / 0.7978 GB, free: 12.76 MB / 0.6231 GB
Notification: Performance of Transformations before backend: time 1.076e-05/0.5545, allocations: 0 / 0.7978 GB, free: 12.76 MB / 0.6231 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 127
 * Number of variables: 127
Notification: Performance of Generate backend data structure: time 0.002857/0.5573, allocations: 1.46 MB / 0.7992 GB, free: 11.25 MB / 0.6231 GB
Notification: Performance of prepare preOptimizeDAE: time 3.213e-05/0.5574, allocations: 8.031 kB / 0.7992 GB, free: 11.25 MB / 0.6231 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001486/0.5589, allocations: 242.7 kB / 0.7994 GB, free: 11.01 MB / 0.6231 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0008109/0.5597, allocations: 0.5876 MB / 0.8 GB, free: 10.38 MB / 0.6231 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.497e-05/0.5597, allocations: 37 kB / 0.8 GB, free: 10.34 MB / 0.6231 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001075/0.5598, allocations: 55.94 kB / 0.8001 GB, free: 10.29 MB / 0.6231 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001373/0.5612, allocations: 0.9609 MB / 0.801 GB, free: 9.254 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.936e-05/0.5613, allocations: 8 kB / 0.801 GB, free: 9.246 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.678e-05/0.5613, allocations: 16 kB / 0.8011 GB, free: 9.23 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.878e-05/0.5614, allocations: 31.98 kB / 0.8011 GB, free: 9.199 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001471/0.5629, allocations: 0.9367 MB / 0.802 GB, free: 8.266 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.005118/0.568, allocations: 4.268 MB / 0.8062 GB, free: 3.824 MB / 0.6231 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009377/0.5689, allocations: 0.6029 MB / 0.8068 GB, free: 3.211 MB / 0.6231 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007197/0.5697, allocations: 0.5097 MB / 0.8073 GB, free: 2.699 MB / 0.6231 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0009598/0.5706, allocations: 0.8783 MB / 0.8081 GB, free: 1.637 MB / 0.6231 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.55e-05/0.5707, allocations: 35 kB / 0.8082 GB, free: 1.594 MB / 0.6231 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001441/0.5721, allocations: 431.1 kB / 0.8086 GB, free: 1.172 MB / 0.6231 GB
Notification: Performance of pre-optimization done (n=50): time 3.056e-06/0.5721, allocations: 0 / 0.8086 GB, free: 1.172 MB / 0.6231 GB
Notification: Performance of matching and sorting (n=50): time 0.01755/0.5897, allocations: 3.833 MB / 0.8123 GB, free: 13.28 MB / 0.6387 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.439e-05/0.5898, allocations: 59.84 kB / 0.8124 GB, free: 13.21 MB / 0.6387 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0008575/0.5906, allocations: 0.7154 MB / 0.8131 GB, free: 12.49 MB / 0.6387 GB
Notification: Performance of collectPreVariables (initialization): time 7.926e-05/0.5907, allocations: 33.7 kB / 0.8131 GB, free: 12.45 MB / 0.6387 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002508/0.591, allocations: 316.6 kB / 0.8134 GB, free: 12.14 MB / 0.6387 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001703/0.5911, allocations: 177.5 kB / 0.8136 GB, free: 11.96 MB / 0.6387 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002479/0.5914, allocations: 150 kB / 0.8137 GB, free: 11.81 MB / 0.6387 GB
Notification: Performance of setup shared object (initialization): time 9.774e-05/0.5915, allocations: 326 kB / 0.814 GB, free: 11.48 MB / 0.6387 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006411/0.5922, allocations: 397.6 kB / 0.8144 GB, free: 11.1 MB / 0.6387 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007057/0.5929, allocations: 493.5 kB / 0.8149 GB, free: 10.59 MB / 0.6387 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00142/0.5943, allocations: 0.9141 MB / 0.8158 GB, free: 9.648 MB / 0.6387 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.578e-06/0.5943, allocations: 4 kB / 0.8158 GB, free: 9.645 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=60) (initialization): time 0.01153/0.6058, allocations: 2.56 MB / 0.8183 GB, free: 7.066 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 1.77e-05/0.6059, allocations: 8.109 kB / 0.8183 GB, free: 7.059 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.897e-06/0.6059, allocations: 8 kB / 0.8183 GB, free: 7.051 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009855/0.6158, allocations: 1.729 MB / 0.82 GB, free: 5.316 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004742/0.6162, allocations: 91.86 kB / 0.8201 GB, free: 5.227 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01287/0.6291, allocations: 7.148 MB / 0.827 GB, free: 13.8 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008687/0.63, allocations: 23.98 kB / 0.8271 GB, free: 13.77 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000138/0.6302, allocations: 51.92 kB / 0.8271 GB, free: 13.72 MB / 0.6544 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 9
 * 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 (46):
 * Single equations (assignments): 44
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(5,3,92.0%), (5,3,92.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.000399/0.6306, allocations: 212.9 kB / 0.8273 GB, free: 13.51 MB / 0.6544 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002515/0.6308, allocations: 82.97 kB / 0.8274 GB, free: 13.43 MB / 0.6544 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00527/0.6361, allocations: 1.73 MB / 0.8291 GB, free: 11.69 MB / 0.6544 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.998e-06/0.6361, allocations: 11.94 kB / 0.8291 GB, free: 11.68 MB / 0.6544 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.134e-05/0.6362, allocations: 4 kB / 0.8291 GB, free: 11.67 MB / 0.6544 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.067e-06/0.6362, allocations: 7.922 kB / 0.8291 GB, free: 11.66 MB / 0.6544 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006048/0.6422, allocations: 2.552 MB / 0.8316 GB, free: 9.027 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.202e-06/0.6423, allocations: 1 kB / 0.8316 GB, free: 9.027 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004397/0.6427, allocations: 87.89 kB / 0.8317 GB, free: 8.941 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003535/0.6462, allocations: 0.8142 MB / 0.8325 GB, free: 8.121 MB / 0.6544 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.193e-05/0.6463, allocations: 12 kB / 0.8325 GB, free: 8.109 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.006994/0.6533, allocations: 4.86 MB / 0.8372 GB, free: 2.977 MB / 0.6544 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.475e-06/0.6534, allocations: 0 / 0.8372 GB, free: 2.977 MB / 0.6544 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005366/0.6587, allocations: 2.155 MB / 0.8393 GB, free: 0.7773 MB / 0.6544 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004879/0.6592, allocations: 236 kB / 0.8396 GB, free: 0.5273 MB / 0.6544 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001702/0.6594, allocations: 12 kB / 0.8396 GB, free: 0.5156 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006319/0.6601, allocations: 23.98 kB / 0.8396 GB, free: 0.4922 MB / 0.6544 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001846/0.6602, allocations: 52.42 kB / 0.8396 GB, free: 452 kB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.853e-05/0.6603, allocations: 20 kB / 0.8397 GB, free: 432 kB / 0.6544 GB
Notification: Performance of sorting global known variables: time 0.0006638/0.661, allocations: 0.4951 MB / 0.8401 GB, free: 15.93 MB / 0.67 GB
Notification: Performance of sort global known variables: time 3.81e-07/0.661, allocations: 0 / 0.8401 GB, free: 15.93 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.0009541/0.6619, allocations: 291.8 kB / 0.8404 GB, free: 15.64 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * Number of states: 4 (pow_m_flow.mExc,pow_V_flow.mExc,pow_1dat.mExc,pow_2dat.mExc)
 * 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 (49):
 * Single equations (assignments): 47
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(5,3,92.0%), (4,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.0004732/0.6624, allocations: 216.4 kB / 0.8406 GB, free: 15.43 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.00373/0.6662, allocations: 1.514 MB / 0.8421 GB, free: 13.89 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 3.657e-06/0.6662, allocations: 0 / 0.8421 GB, free: 13.89 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.001817/0.668, allocations: 0.9108 MB / 0.843 GB, free: 12.95 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002062/0.6701, allocations: 474.3 kB / 0.8435 GB, free: 12.52 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002698/0.6728, allocations: 1.732 MB / 0.8451 GB, free: 10.76 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005295/0.6733, allocations: 0.9789 MB / 0.8461 GB, free: 9.754 MB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.0006081/0.674, allocations: 162.6 kB / 0.8463 GB, free: 9.59 MB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001916/0.6741, allocations: 75.34 kB / 0.8463 GB, free: 9.516 MB / 0.67 GB
Notification: Performance of SimCode: time 4.51e-07/0.6742, allocations: 0 / 0.8463 GB, free: 9.516 MB / 0.67 GB
Notification: Performance of Templates: time 0.2679/0.9421, allocations: 22.67 MB / 0.8685 GB, free: 210.9 MB / 0.67 GB
make -j1 -f BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.makefile
(rm -f BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.sim & ./BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.pipe 2>&1)