Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.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/Buildings 10.1.1-maint.10.0.x/package.mo", uses=false)
Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/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(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|TRooHou.y|staRes.minT.Min|staRes.minT.Mean|staRes.minT.Max|staRes.maxT.Min|staRes.maxT.Mean|staRes.maxT.Max|TRooAnn.y|staRes.meanT.Min|staRes.meanT.Mean|staRes.meanT.Max",fileNamePrefix="Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF")
translateModel(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|TRooHou.y|staRes.minT.Min|staRes.minT.Mean|staRes.minT.Max|staRes.maxT.Min|staRes.maxT.Mean|staRes.maxT.Max|TRooAnn.y|staRes.meanT.Min|staRes.meanT.Mean|staRes.meanT.Max",fileNamePrefix="Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001468/0.001468, allocations: 114.6 kB / 16.42 MB, free: 6.523 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.001533/0.001533, allocations: 186.7 kB / 17.35 MB, free: 5.734 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.422/1.422, allocations: 222.9 MB / 241.1 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.479/2.479, allocations: 437 MB / 0.7112 GB, free: 4.363 MB / 0.5762 GB
Notification: Performance of FrontEnd - loaded program: time 0.001324/0.001324, allocations: 72.11 kB / 1.019 GB, free: 9.375 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.6634/0.6647, allocations: 151.6 MB / 1.167 GB, free: 3.824 MB / 0.8887 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF): time 0.2322/0.8969, allocations: 237 MB / 1.399 GB, free: 5.926 MB / 1.123 GB
Notification: Performance of NFInst.instExpressions: time 0.05974/0.9567, allocations: 43.68 MB / 1.441 GB, free: 10.12 MB / 1.17 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01079/0.9675, allocations: 350.2 kB / 1.442 GB, free: 9.773 MB / 1.17 GB
Notification: Performance of NFTyping.typeComponents: time 0.01759/0.9852, allocations: 7.331 MB / 1.449 GB, free: 2.406 MB / 1.17 GB
Notification: Performance of NFTyping.typeBindings: time 0.01857/1.004, allocations: 6.849 MB / 1.456 GB, free: 11.52 MB / 1.186 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01514/1.019, allocations: 6.154 MB / 1.462 GB, free: 5.379 MB / 1.186 GB
Notification: Performance of NFFlatten.flatten: time 0.05403/1.073, allocations: 50.96 MB / 1.511 GB, free: 2.324 MB / 1.232 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03123/1.104, allocations: 23.95 MB / 1.535 GB, free: 10.21 MB / 1.264 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03147/1.136, allocations: 22.28 MB / 1.557 GB, free: 3.887 MB / 1.279 GB
Notification: Performance of NFSimplifyModel.simplify: time 1.131/2.267, allocations: 17.71 MB / 1.574 GB, free: 58.81 MB / 1.279 GB
Notification: Performance of NFPackage.collectConstants: time 0.01012/2.277, allocations: 3.525 MB / 1.577 GB, free: 58.81 MB / 1.279 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02093/2.298, allocations: 8.186 MB / 1.585 GB, free: 58.81 MB / 1.279 GB
Notification: Performance of NFScalarize.scalarize: time 0.01664/2.315, allocations: 11.67 MB / 1.597 GB, free: 58.81 MB / 1.279 GB
Notification: Performance of NFVerifyModel.verify: time 0.02753/2.342, allocations: 17.26 MB / 1.614 GB, free: 54.66 MB / 1.279 GB
Notification: Performance of NFConvertDAE.convert: time 0.06029/2.403, allocations: 59.36 MB / 1.671 GB, free: 47.07 MB / 1.279 GB
Notification: Performance of FrontEnd - DAE generated: time 5.891e-06/2.403, allocations: 4 kB / 1.671 GB, free: 47.07 MB / 1.279 GB
Notification: Performance of FrontEnd: time 1.793e-06/2.403, allocations: 0 / 1.671 GB, free: 47.07 MB / 1.279 GB
Notification: Performance of Transformations before backend: time 0.001411/2.404, allocations: 1.062 kB / 1.671 GB, free: 47.07 MB / 1.279 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2646
 * Number of variables: 2646
Notification: Performance of Generate backend data structure: time 0.09564/2.5, allocations: 39.03 MB / 1.71 GB, free: 25.41 MB / 1.279 GB
Notification: Performance of prepare preOptimizeDAE: time 4.171e-05/2.5, allocations: 12.06 kB / 1.71 GB, free: 25.4 MB / 1.279 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05906/2.559, allocations: 12.41 MB / 1.722 GB, free: 19.65 MB / 1.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.06964/2.629, allocations: 40.99 MB / 1.762 GB, free: 15.93 MB / 1.311 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001379/2.63, allocations: 1.618 MB / 1.763 GB, free: 14.16 MB / 1.311 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005287/2.635, allocations: 1.253 MB / 1.765 GB, free: 12.91 MB / 1.311 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0503/2.686, allocations: 21.65 MB / 1.786 GB, free: 6.887 MB / 1.326 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002154/2.686, allocations: 26.28 kB / 1.786 GB, free: 6.875 MB / 1.326 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001693/2.688, allocations: 431.4 kB / 1.786 GB, free: 6.457 MB / 1.326 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002907/2.688, allocations: 371.5 kB / 1.787 GB, free: 6.094 MB / 1.326 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05559/2.744, allocations: 23.61 MB / 1.81 GB, free: 14.55 MB / 1.358 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.208/2.952, allocations: 108.1 MB / 1.915 GB, free: 396 kB / 1.451 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03506/2.987, allocations: 15.77 MB / 1.931 GB, free: 0.5781 MB / 1.467 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02231/3.009, allocations: 10.54 MB / 1.941 GB, free: 6.023 MB / 1.483 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001793/3.011, allocations: 1.015 MB / 1.942 GB, free: 4.879 MB / 1.483 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02263/3.033, allocations: 10.06 MB / 1.952 GB, free: 10.78 MB / 1.498 GB
Notification: Performance of pre-optimization done (n=760): time 1.155e-05/3.033, allocations: 0 / 1.952 GB, free: 10.78 MB / 1.498 GB
Notification: Performance of matching and sorting (n=760): time 0.09378/3.127, allocations: 35.45 MB / 1.986 GB, free: 7 MB / 1.529 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003218/3.128, allocations: 368.5 kB / 1.987 GB, free: 6.602 MB / 1.529 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1094/3.237, allocations: 53.56 MB / 2.039 GB, free: 1.219 MB / 1.576 GB
Notification: Performance of collectPreVariables (initialization): time 0.003649/3.241, allocations: 277.7 kB / 2.039 GB, free: 0.9414 MB / 1.576 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01872/3.259, allocations: 12.47 MB / 2.051 GB, free: 4.496 MB / 1.592 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005741/3.265, allocations: 2.748 MB / 2.054 GB, free: 1.789 MB / 1.592 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.009175/3.274, allocations: 5.718 MB / 2.06 GB, free: 12.07 MB / 1.608 GB
Notification: Performance of setup shared object (initialization): time 8.458e-05/3.274, allocations: 301.1 kB / 2.06 GB, free: 11.77 MB / 1.608 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.04626/3.321, allocations: 34.67 MB / 2.094 GB, free: 9.086 MB / 1.639 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0538/3.375, allocations: 39.04 MB / 2.132 GB, free: 0.5469 MB / 1.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.6266/4.001, allocations: 49.64 MB / 2.18 GB, free: 0.671 GB / 1.701 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001037/4.001, allocations: 31.2 kB / 2.18 GB, free: 0.671 GB / 1.701 GB
Notification: Performance of matching and sorting (n=2381) (initialization): time 0.1148/4.116, allocations: 81.56 MB / 2.26 GB, free: 0.642 GB / 1.701 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000219/4.116, allocations: 194 kB / 2.26 GB, free: 0.6418 GB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.08268/4.199, allocations: 58.69 MB / 2.318 GB, free: 0.5908 GB / 1.701 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.1128/4.312, allocations: 37.16 MB / 2.354 GB, free: 0.5596 GB / 1.701 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02221/4.334, allocations: 4.253 MB / 2.358 GB, free: 0.5555 GB / 1.701 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02417/4.358, allocations: 32.88 MB / 2.39 GB, free: 0.5214 GB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02991/4.388, allocations: 4.122 MB / 2.394 GB, free: 0.5182 GB / 1.701 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004287/4.393, allocations: 0.6378 MB / 2.395 GB, free: 0.5176 GB / 1.701 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.05809/4.451, allocations: 47.9 MB / 2.442 GB, free: 482.1 MB / 1.701 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.04289/4.494, allocations: 38.97 MB / 2.48 GB, free: 441.8 MB / 1.701 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.06467/4.558, allocations: 49.54 MB / 2.528 GB, free: 390.9 MB / 1.701 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001151/4.559, allocations: 32 kB / 2.528 GB, free: 390.9 MB / 1.701 GB
Notification: Performance of matching and sorting (n=2381) (initialization_lambda0): time 0.1127/4.671, allocations: 80.59 MB / 2.607 GB, free: 310.9 MB / 1.701 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002348/4.672, allocations: 197 kB / 2.607 GB, free: 310.7 MB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.07919/4.751, allocations: 58.51 MB / 2.664 GB, free: 252 MB / 1.701 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008223/4.759, allocations: 3.274 MB / 2.667 GB, free: 248.7 MB / 1.701 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02019/4.779, allocations: 4.192 MB / 2.671 GB, free: 244.5 MB / 1.701 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0261/4.805, allocations: 32.35 MB / 2.703 GB, free: 210.7 MB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02977/4.835, allocations: 3.778 MB / 2.707 GB, free: 207.1 MB / 1.701 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004134/4.839, allocations: 0.6356 MB / 2.707 GB, free: 206.5 MB / 1.701 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 492
 * Number of states: 0 ()
 * Number of discrete variables: 64 (TRooAnn.mode,$PRE.TRooAnn.mode,$whenCondition1,TRooHou.mode,$PRE.TRooHou.mode,$whenCondition2,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,roo.solRadExc.is_flo[11],roo.solRadExc.is_flo[10],roo.solRadExc.is_flo[9],roo.solRadExc.is_flo[8],roo.solRadExc.is_flo[7],roo.solRadExc.is_flo[6],roo.solRadExc.is_flo[5],roo.solRadExc.is_flo[4],roo.solRadExc.is_flo[3],roo.solRadExc.is_flo[2],roo.solRadExc.is_flo[1],weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,roo.bouConExt.HDifTil[4].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,roo.bouConExt.HDifTil[3].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,roo.bouConExt.HDifTil[2].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,roo.bouConExt.HDifTil[1].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,roo.bouConExt.HDirTil[4].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,roo.bouConExt.HDirTil[3].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,roo.bouConExt.HDirTil[2].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,roo.bouConExt.HDirTil[1].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[1].incAng.decAng.tNext,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1584):
 * Single equations (assignments): 1529
 * Array equations: 36
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 12
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 6 systems
   {1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 10 systems
   {(1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(13,44), (1,23)}
Notification: Performance of prepare postOptimizeDAE: time 0.003967/4.843, allocations: 1.132 MB / 2.708 GB, free: 205.4 MB / 1.701 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.008579/4.852, allocations: 2.576 MB / 2.711 GB, free: 202.8 MB / 1.701 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05718/4.909, allocations: 25.41 MB / 2.736 GB, free: 177.3 MB / 1.701 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04162/4.951, allocations: 21.07 MB / 2.756 GB, free: 156.1 MB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.03959/4.99, allocations: 19.98 MB / 2.776 GB, free: 136 MB / 1.701 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01869/5.009, allocations: 7.401 MB / 2.783 GB, free: 128.6 MB / 1.701 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.009522/5.019, allocations: 231.8 kB / 2.783 GB, free: 128.4 MB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02272/5.041, allocations: 2.289 MB / 2.785 GB, free: 126.1 MB / 1.701 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002619/5.044, allocations: 0.5052 MB / 2.786 GB, free: 125.6 MB / 1.701 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.06344/5.107, allocations: 26.27 MB / 2.812 GB, free: 99.34 MB / 1.701 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.06157/5.169, allocations: 33.83 MB / 2.845 GB, free: 65.4 MB / 1.701 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01656/5.186, allocations: 10.23 MB / 2.855 GB, free: 55.14 MB / 1.701 GB
Notification: Performance of sorting global known variables: time 0.05394/5.24, allocations: 37.13 MB / 2.891 GB, free: 18.16 MB / 1.701 GB
Notification: Performance of Backend: time 1.142e-06/5.24, allocations: 0 / 2.891 GB, free: 18.16 MB / 1.701 GB
Notification: Performance of simCode: created initialization part: time 0.6632/5.903, allocations: 90.02 MB / 2.979 GB, free: 0.6619 GB / 1.701 GB
Notification: Performance of SimCode: time 0.123/6.026, allocations: 74.54 MB / 3.052 GB, free: 0.6083 GB / 1.701 GB
Notification: Performance of Templates: time 1.838/7.864, allocations: 0.6069 GB / 3.658 GB, free: 0.6569 GB / 1.701 GB
make -j1 -f Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.makefile
(rm -f Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.pipe ; mkfifo Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.pipe ; head -c 1048576 < Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.pipe >> ../files/Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.sim & ./Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_10_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.pipe 2>&1)