Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.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 11.0.1-master/package.mo", uses=false) Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-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(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF,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_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF") translateModel(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF,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_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001364/0.001364, allocations: 110.9 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.001202/0.001202, allocations: 186.6 kB / 17.35 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.337/1.337, allocations: 222.9 MB / 241 MB, free: 15.15 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.638/2.638, allocations: 469.4 MB / 0.7428 GB, free: 3.582 MB / 0.6075 GB Notification: Performance of FrontEnd - loaded program: time 0.001352/0.001352, allocations: 71.89 kB / 1.066 GB, free: 13.71 MB / 0.8419 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.7222/0.7236, allocations: 159.1 MB / 1.221 GB, free: 2.504 MB / 0.9356 GB Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF): time 0.2383/0.9619, allocations: 237.7 MB / 1.453 GB, free: 3.848 MB / 1.17 GB Notification: Performance of NFInst.instExpressions: time 0.06991/1.032, allocations: 44.58 MB / 1.497 GB, free: 7.125 MB / 1.217 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.01167/1.044, allocations: 354.1 kB / 1.497 GB, free: 6.777 MB / 1.217 GB Notification: Performance of NFTyping.typeComponents: time 0.01945/1.063, allocations: 7.822 MB / 1.505 GB, free: 14.91 MB / 1.232 GB Notification: Performance of NFTyping.typeBindings: time 0.01949/1.083, allocations: 6.954 MB / 1.511 GB, free: 7.938 MB / 1.232 GB Notification: Performance of NFTyping.typeClassSections: time 0.01575/1.098, allocations: 6.274 MB / 1.518 GB, free: 1.672 MB / 1.232 GB Notification: Performance of NFFlatten.flatten: time 1.317/2.415, allocations: 53.64 MB / 1.57 GB, free: 20.53 MB / 1.279 GB Notification: Performance of NFFlatten.resolveConnections: time 0.03233/2.448, allocations: 24.71 MB / 1.594 GB, free: 17.22 MB / 1.279 GB Notification: Performance of NFEvalConstants.evaluate: time 0.03222/2.48, allocations: 23.43 MB / 1.617 GB, free: 15.86 MB / 1.279 GB Notification: Performance of NFSimplifyModel.simplify: time 0.02751/2.508, allocations: 18.83 MB / 1.635 GB, free: 12.88 MB / 1.279 GB Notification: Performance of NFPackage.collectConstants: time 0.01233/2.52, allocations: 3.76 MB / 1.639 GB, free: 12.88 MB / 1.279 GB Notification: Performance of NFFlatten.collectFunctions: time 0.02372/2.544, allocations: 8.479 MB / 1.647 GB, free: 12.88 MB / 1.279 GB Notification: Performance of NFScalarize.scalarize: time 0.0181/2.562, allocations: 12.6 MB / 1.66 GB, free: 11.69 MB / 1.279 GB Notification: Performance of NFVerifyModel.verify: time 0.03088/2.593, allocations: 18.36 MB / 1.678 GB, free: 7.008 MB / 1.279 GB Notification: Performance of NFConvertDAE.convert: time 0.06896/2.662, allocations: 63.28 MB / 1.739 GB, free: 3.758 MB / 1.311 GB Notification: Performance of FrontEnd - DAE generated: time 4.709e-06/2.662, allocations: 3.75 kB / 1.739 GB, free: 3.758 MB / 1.311 GB Notification: Performance of FrontEnd: time 3.536e-06/2.662, allocations: 4 kB / 1.739 GB, free: 3.754 MB / 1.311 GB Notification: Performance of Transformations before backend: time 0.001591/2.663, allocations: 0 / 1.739 GB, free: 3.754 MB / 1.311 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 2797 * Number of variables: 2797 Notification: Performance of Generate backend data structure: time 0.121/2.784, allocations: 40.71 MB / 1.779 GB, free: 11.1 MB / 1.358 GB Notification: Performance of prepare preOptimizeDAE: time 5.296e-05/2.784, allocations: 8.625 kB / 1.779 GB, free: 11.09 MB / 1.358 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06595/2.85, allocations: 12.4 MB / 1.791 GB, free: 14.64 MB / 1.373 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0897/2.94, allocations: 42.57 MB / 1.833 GB, free: 4.844 MB / 1.404 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001572/2.942, allocations: 1.68 MB / 1.834 GB, free: 3.012 MB / 1.404 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.005837/2.948, allocations: 1.328 MB / 1.836 GB, free: 1.684 MB / 1.404 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.05832/3.006, allocations: 23.19 MB / 1.858 GB, free: 10.05 MB / 1.436 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0003989/3.006, allocations: 20.56 kB / 1.858 GB, free: 10.04 MB / 1.436 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004008/3.01, allocations: 458.7 kB / 1.859 GB, free: 9.598 MB / 1.436 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003592/3.011, allocations: 392.4 kB / 1.859 GB, free: 9.211 MB / 1.436 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05999/3.071, allocations: 24.67 MB / 1.883 GB, free: 0.625 MB / 1.451 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.2456/3.316, allocations: 123.8 MB / 2.004 GB, free: 2.199 MB / 1.576 GB Notification: Performance of preOpt comSubExp (simulation): time 0.03913/3.356, allocations: 17.47 MB / 2.021 GB, free: 0.6836 MB / 1.592 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.02564/3.381, allocations: 11.2 MB / 2.032 GB, free: 5.469 MB / 1.608 GB Notification: Performance of preOpt evalFunc (simulation): time 0.002111/3.383, allocations: 1.009 MB / 2.033 GB, free: 4.328 MB / 1.608 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02698/3.41, allocations: 10.83 MB / 2.044 GB, free: 9.457 MB / 1.623 GB Notification: Performance of pre-optimization done (n=824): time 1.533e-05/3.41, allocations: 4 kB / 2.044 GB, free: 9.453 MB / 1.623 GB Notification: Performance of matching and sorting (n=824): time 0.1038/3.514, allocations: 36.89 MB / 2.08 GB, free: 4.227 MB / 1.654 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003014/3.515, allocations: 366.2 kB / 2.08 GB, free: 3.824 MB / 1.654 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1153/3.63, allocations: 55.79 MB / 2.135 GB, free: 12.2 MB / 1.717 GB Notification: Performance of collectPreVariables (initialization): time 0.003817/3.634, allocations: 289.7 kB / 2.135 GB, free: 11.91 MB / 1.717 GB Notification: Performance of collectInitialEqns (initialization): time 0.02313/3.657, allocations: 12.92 MB / 2.148 GB, free: 15.01 MB / 1.733 GB Notification: Performance of collectInitialBindings (initialization): time 0.007022/3.664, allocations: 2.893 MB / 2.15 GB, free: 12.15 MB / 1.733 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.01796/3.682, allocations: 5.899 MB / 2.156 GB, free: 6.246 MB / 1.733 GB Notification: Performance of setup shared object (initialization): time 9.798e-05/3.682, allocations: 309.1 kB / 2.156 GB, free: 5.941 MB / 1.733 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.05204/3.734, allocations: 36.49 MB / 2.192 GB, free: 1.426 MB / 1.764 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.696/4.43, allocations: 41.11 MB / 2.232 GB, free: 0.6952 GB / 1.764 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.06964/4.5, allocations: 52.6 MB / 2.284 GB, free: 0.6703 GB / 1.764 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002092/4.5, allocations: 32 kB / 2.284 GB, free: 0.6702 GB / 1.764 GB Notification: Performance of matching and sorting (n=2512) (initialization): time 0.121/4.621, allocations: 85.54 MB / 2.367 GB, free: 0.597 GB / 1.764 GB Notification: Performance of prepare postOptimizeDAE: time 0.0002769/4.621, allocations: 189.2 kB / 2.367 GB, free: 0.5968 GB / 1.764 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.1269/4.748, allocations: 68.35 MB / 2.434 GB, free: 0.5311 GB / 1.764 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.1265/4.875, allocations: 37.18 MB / 2.47 GB, free: 0.4948 GB / 1.764 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02501/4.9, allocations: 4.754 MB / 2.475 GB, free: 0.4901 GB / 1.764 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02601/4.926, allocations: 32.88 MB / 2.507 GB, free: 466.9 MB / 1.764 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03801/4.964, allocations: 5.195 MB / 2.512 GB, free: 462.5 MB / 1.764 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004769/4.969, allocations: 0.6733 MB / 2.513 GB, free: 461.8 MB / 1.764 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.06271/5.032, allocations: 50.34 MB / 2.562 GB, free: 411.4 MB / 1.764 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.04675/5.078, allocations: 41.05 MB / 2.602 GB, free: 368.7 MB / 1.764 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.06886/5.147, allocations: 52.49 MB / 2.653 GB, free: 314.6 MB / 1.764 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001262/5.147, allocations: 36 kB / 2.653 GB, free: 314.5 MB / 1.764 GB Notification: Performance of matching and sorting (n=2512) (initialization_lambda0): time 0.1196/5.267, allocations: 84.53 MB / 2.736 GB, free: 230.5 MB / 1.764 GB Notification: Performance of prepare postOptimizeDAE: time 0.0002781/5.267, allocations: 193.6 kB / 2.736 GB, free: 230.3 MB / 1.764 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0879/5.355, allocations: 62.16 MB / 2.797 GB, free: 168.1 MB / 1.764 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.008472/5.364, allocations: 3.276 MB / 2.8 GB, free: 164.8 MB / 1.764 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02286/5.387, allocations: 4.699 MB / 2.805 GB, free: 160.1 MB / 1.764 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02689/5.414, allocations: 32.34 MB / 2.836 GB, free: 126.2 MB / 1.764 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0358/5.449, allocations: 4.848 MB / 2.841 GB, free: 121.5 MB / 1.764 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004299/5.454, allocations: 0.6753 MB / 2.842 GB, free: 120.8 MB / 1.764 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 522 * Number of states: 0 () * Number of discrete variables: 69 ($PRE.vent.tab.nextTimeEvent,$whenCondition1,TRooAnn.mode,$PRE.TRooAnn.mode,$whenCondition2,TRooHou.mode,$PRE.TRooHou.mode,$whenCondition3,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],vent.tab.nextTimeEventScaled,$PRE.vent.tab.nextTimeEventScaled,vent.tab.nextTimeEvent,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,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (1715): * Single equations (assignments): 1660 * 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.006426/5.46, allocations: 1.183 MB / 2.843 GB, free: 119.6 MB / 1.764 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.009559/5.47, allocations: 2.566 MB / 2.845 GB, free: 117 MB / 1.764 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0569/5.527, allocations: 26.52 MB / 2.871 GB, free: 90.42 MB / 1.764 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04329/5.57, allocations: 21.96 MB / 2.893 GB, free: 68.3 MB / 1.764 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.04352/5.614, allocations: 20.95 MB / 2.913 GB, free: 47.26 MB / 1.764 GB Notification: Performance of postOpt removeConstants (simulation): time 0.02148/5.635, allocations: 7.889 MB / 2.921 GB, free: 39.31 MB / 1.764 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01122/5.646, allocations: 291.8 kB / 2.921 GB, free: 39.03 MB / 1.764 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02836/5.675, allocations: 2.839 MB / 2.924 GB, free: 36.18 MB / 1.764 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002574/5.677, allocations: 0.5408 MB / 2.924 GB, free: 35.64 MB / 1.764 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.06866/5.746, allocations: 28.73 MB / 2.952 GB, free: 6.934 MB / 1.764 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.7736/6.52, allocations: 36.59 MB / 2.988 GB, free: 0.6751 GB / 1.764 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01981/6.54, allocations: 11.18 MB / 2.999 GB, free: 0.6714 GB / 1.764 GB Notification: Performance of sorting global known variables: time 0.06517/6.605, allocations: 38.64 MB / 3.037 GB, free: 0.6594 GB / 1.764 GB Notification: Performance of Backend: time 1.253e-06/6.605, allocations: 3.516 kB / 3.037 GB, free: 0.6594 GB / 1.764 GB Notification: Performance of simCode: created initialization part: time 0.1417/6.746, allocations: 94.45 MB / 3.129 GB, free: 0.5907 GB / 1.764 GB Notification: Performance of SimCode: time 0.1473/6.894, allocations: 78.46 MB / 3.206 GB, free: 0.5151 GB / 1.764 GB Notification: Performance of Templates: time 2.086/8.98, allocations: 0.6601 GB / 3.866 GB, free: 0.578 GB / 1.764 GB make -j1 -f Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.makefile (rm -f Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe ; mkfifo Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe ; head -c 1048576 < Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe >> ../files/Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.sim & ./Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe 2>&1)