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.001569/0.001569, allocations: 116.3 kB / 16.42 MB, free: 6.504 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.00172/0.00172, allocations: 183.9 kB / 17.34 MB, free: 5.758 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.396/1.396, allocations: 222.9 MB / 241.1 MB, free: 15.21 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.396/2.396, allocations: 437 MB / 0.7112 GB, free: 4.402 MB / 0.5762 GB
Notification: Performance of FrontEnd - loaded program: time 0.002216/0.002216, allocations: 59.91 kB / 1.019 GB, free: 9.406 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7543/0.7566, allocations: 151.6 MB / 1.167 GB, free: 3.891 MB / 0.8887 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF): time 0.2296/0.9862, allocations: 237 MB / 1.399 GB, free: 6.004 MB / 1.123 GB
Notification: Performance of NFInst.instExpressions: time 0.06096/1.047, allocations: 43.7 MB / 1.441 GB, free: 10.18 MB / 1.17 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01168/1.059, allocations: 350.1 kB / 1.442 GB, free: 9.84 MB / 1.17 GB
Notification: Performance of NFTyping.typeComponents: time 0.01726/1.076, allocations: 7.331 MB / 1.449 GB, free: 2.473 MB / 1.17 GB
Notification: Performance of NFTyping.typeBindings: time 0.01798/1.094, allocations: 6.846 MB / 1.456 GB, free: 11.59 MB / 1.186 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0141/1.108, allocations: 6.149 MB / 1.462 GB, free: 5.453 MB / 1.186 GB
Notification: Performance of NFFlatten.flatten: time 0.05058/1.159, allocations: 50.97 MB / 1.511 GB, free: 2.395 MB / 1.232 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02758/1.187, allocations: 23.95 MB / 1.535 GB, free: 10.28 MB / 1.264 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02992/1.217, allocations: 22.26 MB / 1.557 GB, free: 3.969 MB / 1.279 GB
Notification: Performance of NFSimplifyModel.simplify: time 1.116/2.333, allocations: 17.72 MB / 1.574 GB, free: 58.65 MB / 1.279 GB
Notification: Performance of NFPackage.collectConstants: time 0.01026/2.343, allocations: 3.521 MB / 1.577 GB, free: 58.65 MB / 1.279 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02184/2.365, allocations: 8.187 MB / 1.585 GB, free: 58.65 MB / 1.279 GB
Notification: Performance of NFScalarize.scalarize: time 0.01555/2.38, allocations: 11.67 MB / 1.597 GB, free: 58.65 MB / 1.279 GB
Notification: Performance of NFVerifyModel.verify: time 0.02674/2.407, allocations: 17.26 MB / 1.614 GB, free: 54.51 MB / 1.279 GB
Notification: Performance of NFConvertDAE.convert: time 0.05649/2.464, allocations: 59.36 MB / 1.671 GB, free: 46.98 MB / 1.279 GB
Notification: Performance of FrontEnd - DAE generated: time 6.903e-06/2.464, allocations: 3.984 kB / 1.671 GB, free: 46.97 MB / 1.279 GB
Notification: Performance of FrontEnd: time 2.114e-06/2.464, allocations: 1.125 kB / 1.671 GB, free: 46.97 MB / 1.279 GB
Notification: Performance of Transformations before backend: time 0.001377/2.465, allocations: 0 / 1.671 GB, free: 46.97 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.09417/2.559, allocations: 39.02 MB / 1.71 GB, free: 25.37 MB / 1.279 GB
Notification: Performance of prepare preOptimizeDAE: time 4.26e-05/2.559, allocations: 10.78 kB / 1.71 GB, free: 25.37 MB / 1.279 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06022/2.619, allocations: 12.42 MB / 1.722 GB, free: 19.61 MB / 1.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.07142/2.691, allocations: 40.99 MB / 1.762 GB, free: 32 kB / 1.295 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001508/2.692, allocations: 1.616 MB / 1.763 GB, free: 14.26 MB / 1.311 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.006004/2.698, allocations: 1.256 MB / 1.765 GB, free: 13 MB / 1.311 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05366/2.752, allocations: 21.66 MB / 1.786 GB, free: 6.977 MB / 1.326 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001938/2.752, allocations: 16.94 kB / 1.786 GB, free: 6.973 MB / 1.326 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001946/2.754, allocations: 431.2 kB / 1.786 GB, free: 6.555 MB / 1.326 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000291/2.755, allocations: 376.3 kB / 1.787 GB, free: 6.188 MB / 1.326 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.058/2.813, allocations: 23.61 MB / 1.81 GB, free: 14.64 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.2049/3.018, allocations: 108.1 MB / 1.915 GB, free: 500 kB / 1.451 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03694/3.055, allocations: 15.76 MB / 1.931 GB, free: 0.6875 MB / 1.467 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0243/3.079, allocations: 10.55 MB / 1.941 GB, free: 6.117 MB / 1.483 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001864/3.081, allocations: 1.003 MB / 1.942 GB, free: 4.984 MB / 1.483 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02388/3.105, allocations: 10.06 MB / 1.952 GB, free: 10.88 MB / 1.498 GB
Notification: Performance of pre-optimization done (n=760): time 1.274e-05/3.105, allocations: 4 kB / 1.952 GB, free: 10.88 MB / 1.498 GB
Notification: Performance of matching and sorting (n=760): time 0.09671/3.201, allocations: 35.44 MB / 1.986 GB, free: 7.105 MB / 1.529 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003013/3.202, allocations: 365.4 kB / 1.987 GB, free: 6.707 MB / 1.529 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1071/3.309, allocations: 53.57 MB / 2.039 GB, free: 1.316 MB / 1.576 GB
Notification: Performance of collectPreVariables (initialization): time 0.003634/3.313, allocations: 277.7 kB / 2.039 GB, free: 1.039 MB / 1.576 GB
Notification: Performance of collectInitialEqns (initialization): time 0.02108/3.334, allocations: 12.47 MB / 2.051 GB, free: 4.598 MB / 1.592 GB
Notification: Performance of collectInitialBindings (initialization): time 0.006232/3.34, allocations: 2.746 MB / 2.054 GB, free: 1.891 MB / 1.592 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01577/3.356, allocations: 5.715 MB / 2.06 GB, free: 12.18 MB / 1.608 GB
Notification: Performance of setup shared object (initialization): time 0.0001025/3.356, allocations: 313.1 kB / 2.06 GB, free: 11.87 MB / 1.608 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.05031/3.406, allocations: 34.66 MB / 2.094 GB, free: 9.18 MB / 1.639 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0551/3.461, allocations: 39.04 MB / 2.132 GB, free: 0.6797 MB / 1.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.6383/4.1, allocations: 49.64 MB / 2.18 GB, free: 0.6711 GB / 1.701 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001077/4.1, allocations: 33.25 kB / 2.18 GB, free: 0.6711 GB / 1.701 GB
Notification: Performance of matching and sorting (n=2381) (initialization): time 0.1117/4.211, allocations: 81.56 MB / 2.26 GB, free: 0.6421 GB / 1.701 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002089/4.212, allocations: 188.3 kB / 2.26 GB, free: 0.6419 GB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0777/4.289, allocations: 58.69 MB / 2.318 GB, free: 0.5909 GB / 1.701 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.1096/4.399, allocations: 37.16 MB / 2.354 GB, free: 0.5597 GB / 1.701 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02178/4.421, allocations: 4.245 MB / 2.358 GB, free: 0.5556 GB / 1.701 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02342/4.444, allocations: 32.88 MB / 2.39 GB, free: 0.5216 GB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03046/4.475, allocations: 4.125 MB / 2.394 GB, free: 0.5183 GB / 1.701 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003904/4.479, allocations: 0.6393 MB / 2.395 GB, free: 0.5177 GB / 1.701 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.05481/4.534, allocations: 47.9 MB / 2.442 GB, free: 482.3 MB / 1.701 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.04139/4.575, allocations: 38.98 MB / 2.48 GB, free: 441.9 MB / 1.701 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.06112/4.636, allocations: 49.53 MB / 2.528 GB, free: 391.1 MB / 1.701 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001062/4.636, allocations: 28 kB / 2.528 GB, free: 391.1 MB / 1.701 GB
Notification: Performance of matching and sorting (n=2381) (initialization_lambda0): time 0.1089/4.745, allocations: 80.59 MB / 2.607 GB, free: 311 MB / 1.701 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002074/4.745, allocations: 201.2 kB / 2.607 GB, free: 310.8 MB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.07912/4.825, allocations: 58.5 MB / 2.664 GB, free: 252.2 MB / 1.701 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008691/4.833, allocations: 3.282 MB / 2.667 GB, free: 248.9 MB / 1.701 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02136/4.855, allocations: 4.196 MB / 2.671 GB, free: 244.7 MB / 1.701 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02589/4.881, allocations: 32.33 MB / 2.703 GB, free: 210.8 MB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03026/4.911, allocations: 3.786 MB / 2.707 GB, free: 207.2 MB / 1.701 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003989/4.915, allocations: 0.6315 MB / 2.707 GB, free: 206.6 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.004031/4.919, allocations: 1.141 MB / 2.708 GB, free: 205.5 MB / 1.701 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.007803/4.927, allocations: 2.571 MB / 2.711 GB, free: 203 MB / 1.701 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05481/4.982, allocations: 25.4 MB / 2.736 GB, free: 177.5 MB / 1.701 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04265/5.024, allocations: 21.07 MB / 2.756 GB, free: 156.2 MB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.04602/5.07, allocations: 19.97 MB / 2.776 GB, free: 136.1 MB / 1.701 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01914/5.089, allocations: 7.405 MB / 2.783 GB, free: 128.8 MB / 1.701 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.008627/5.098, allocations: 239.8 kB / 2.783 GB, free: 128.6 MB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0216/5.12, allocations: 2.283 MB / 2.785 GB, free: 126.3 MB / 1.701 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001625/5.121, allocations: 0.5091 MB / 2.786 GB, free: 125.8 MB / 1.701 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.06623/5.188, allocations: 26.26 MB / 2.812 GB, free: 99.5 MB / 1.701 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.06362/5.251, allocations: 33.83 MB / 2.845 GB, free: 65.55 MB / 1.701 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01743/5.269, allocations: 10.24 MB / 2.855 GB, free: 55.3 MB / 1.701 GB
Notification: Performance of sorting global known variables: time 0.05484/5.324, allocations: 37.13 MB / 2.891 GB, free: 18.31 MB / 1.701 GB
Notification: Performance of Backend: time 1.403e-06/5.324, allocations: 0 / 2.891 GB, free: 18.31 MB / 1.701 GB
Notification: Performance of simCode: created initialization part: time 0.6635/5.987, allocations: 90.03 MB / 2.979 GB, free: 0.6624 GB / 1.701 GB
Notification: Performance of SimCode: time 0.1225/6.11, allocations: 74.53 MB / 3.052 GB, free: 0.6087 GB / 1.701 GB
Notification: Performance of Templates: time 1.802/7.912, allocations: 0.6069 GB / 3.658 GB, free: 0.6572 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)