Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF.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.Cases6xx.Case650FF,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.Cases6xx.Case650FF") translateModel(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF,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.Cases6xx.Case650FF") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001782/0.001782, allocations: 107.4 kB / 16.41 MB, free: 6.453 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.001981/0.001981, allocations: 192.3 kB / 17.35 MB, free: 5.738 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 2.496/2.496, allocations: 222.9 MB / 241.1 MB, free: 15.18 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 4.591/4.591, allocations: 461.9 MB / 0.7355 GB, free: 11.09 MB / 0.6075 GB Notification: Performance of FrontEnd - loaded program: time 0.002235/0.002235, allocations: 59.91 kB / 1.055 GB, free: 7.66 MB / 0.8262 GB Notification: Performance of FrontEnd - Absyn->SCode: time 1.547/1.549, allocations: 157.4 MB / 1.208 GB, free: 13.78 MB / 0.9356 GB Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF): time 0.4735/2.023, allocations: 237.3 MB / 1.44 GB, free: 15.55 MB / 1.17 GB Notification: Performance of NFInst.instExpressions: time 0.1785/2.201, allocations: 44.1 MB / 1.483 GB, free: 3.312 MB / 1.201 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.02771/2.229, allocations: 318.2 kB / 1.484 GB, free: 3 MB / 1.201 GB Notification: Performance of NFTyping.typeComponents: time 0.05354/2.283, allocations: 7.374 MB / 1.491 GB, free: 11.59 MB / 1.217 GB Notification: Performance of NFTyping.typeBindings: time 0.04688/2.33, allocations: 6.736 MB / 1.497 GB, free: 4.824 MB / 1.217 GB Notification: Performance of NFTyping.typeClassSections: time 0.04378/2.374, allocations: 6.272 MB / 1.504 GB, free: 14.56 MB / 1.232 GB Notification: Performance of NFFlatten.flatten: time 0.1368/2.51, allocations: 51.07 MB / 1.553 GB, free: 11.4 MB / 1.279 GB Notification: Performance of NFFlatten.resolveConnections: time 3.38/5.891, allocations: 24.01 MB / 1.577 GB, free: 23.51 MB / 1.279 GB Notification: Performance of NFEvalConstants.evaluate: time 0.0671/5.958, allocations: 22.33 MB / 1.599 GB, free: 22.35 MB / 1.279 GB Notification: Performance of NFSimplifyModel.simplify: time 0.05668/6.015, allocations: 17.8 MB / 1.616 GB, free: 19.41 MB / 1.279 GB Notification: Performance of NFPackage.collectConstants: time 0.02695/6.042, allocations: 3.53 MB / 1.619 GB, free: 19.41 MB / 1.279 GB Notification: Performance of NFFlatten.collectFunctions: time 0.05219/6.094, allocations: 8.242 MB / 1.628 GB, free: 19.41 MB / 1.279 GB Notification: Performance of NFScalarize.scalarize: time 0.03751/6.132, allocations: 11.73 MB / 1.639 GB, free: 18.26 MB / 1.279 GB Notification: Performance of NFVerifyModel.verify: time 0.06987/6.201, allocations: 17.31 MB / 1.656 GB, free: 13.75 MB / 1.279 GB Notification: Performance of NFConvertDAE.convert: time 0.1275/6.329, allocations: 59.43 MB / 1.714 GB, free: 11.35 MB / 1.295 GB Notification: Performance of FrontEnd - DAE generated: time 1.018e-05/6.329, allocations: 3.75 kB / 1.714 GB, free: 11.35 MB / 1.295 GB Notification: Performance of FrontEnd: time 3.557e-06/6.329, allocations: 0 / 1.714 GB, free: 11.35 MB / 1.295 GB Notification: Performance of Transformations before backend: time 0.001947/6.331, allocations: 0 / 1.714 GB, free: 11.35 MB / 1.295 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 2652 * Number of variables: 2652 Notification: Performance of Generate backend data structure: time 0.2597/6.591, allocations: 38.22 MB / 1.751 GB, free: 12.62 MB / 1.326 GB Notification: Performance of prepare preOptimizeDAE: time 6.949e-05/6.591, allocations: 8.031 kB / 1.751 GB, free: 12.61 MB / 1.326 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1341/6.725, allocations: 12.27 MB / 1.763 GB, free: 292 kB / 1.326 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.1739/6.899, allocations: 40.86 MB / 1.803 GB, free: 8.145 MB / 1.373 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.003114/6.902, allocations: 1.629 MB / 1.805 GB, free: 6.359 MB / 1.373 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.009786/6.912, allocations: 1.248 MB / 1.806 GB, free: 5.113 MB / 1.373 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.1145/7.027, allocations: 21.69 MB / 1.827 GB, free: 15.06 MB / 1.404 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0004617/7.027, allocations: 20.56 kB / 1.827 GB, free: 15.05 MB / 1.404 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.007064/7.034, allocations: 435 kB / 1.828 GB, free: 14.63 MB / 1.404 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0005727/7.035, allocations: 371.5 kB / 1.828 GB, free: 14.27 MB / 1.404 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1415/7.176, allocations: 23.64 MB / 1.851 GB, free: 6.695 MB / 1.42 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.4536/7.63, allocations: 108.1 MB / 1.957 GB, free: 8.422 MB / 1.529 GB Notification: Performance of preOpt comSubExp (simulation): time 0.08948/7.72, allocations: 15.83 MB / 1.972 GB, free: 8.547 MB / 1.545 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.04817/7.768, allocations: 10.58 MB / 1.982 GB, free: 13.95 MB / 1.561 GB Notification: Performance of preOpt evalFunc (simulation): time 0.003017/7.771, allocations: 1.006 MB / 1.983 GB, free: 12.81 MB / 1.561 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.04021/7.811, allocations: 10.1 MB / 1.993 GB, free: 2.672 MB / 1.561 GB Notification: Performance of pre-optimization done (n=766): time 2.278e-05/7.811, allocations: 0 / 1.993 GB, free: 2.672 MB / 1.561 GB Notification: Performance of matching and sorting (n=766): time 0.1575/7.969, allocations: 35.13 MB / 2.028 GB, free: 15.2 MB / 1.608 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0004792/7.969, allocations: 369.7 kB / 2.028 GB, free: 14.79 MB / 1.608 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1989/8.168, allocations: 53.78 MB / 2.08 GB, free: 9.203 MB / 1.654 GB Notification: Performance of collectPreVariables (initialization): time 0.005622/8.174, allocations: 277.7 kB / 2.081 GB, free: 8.926 MB / 1.654 GB Notification: Performance of collectInitialEqns (initialization): time 0.0377/8.212, allocations: 12.44 MB / 2.093 GB, free: 12.52 MB / 1.67 GB Notification: Performance of collectInitialBindings (initialization): time 0.009728/8.221, allocations: 2.641 MB / 2.095 GB, free: 9.91 MB / 1.67 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.02759/8.249, allocations: 5.685 MB / 2.101 GB, free: 4.219 MB / 1.67 GB Notification: Performance of setup shared object (initialization): time 0.0001403/8.249, allocations: 301.1 kB / 2.101 GB, free: 3.922 MB / 1.67 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.09323/8.342, allocations: 34.72 MB / 2.135 GB, free: 1.18 MB / 1.701 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.1178/8.46, allocations: 39.1 MB / 2.173 GB, free: 8.586 MB / 1.748 GB Notification: Performance of analyzeInitialSystem (initialization): time 1.362/9.823, allocations: 49.72 MB / 2.222 GB, free: 0.7 GB / 1.764 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001565/9.823, allocations: 34.91 kB / 2.222 GB, free: 0.7 GB / 1.764 GB Notification: Performance of matching and sorting (n=2396) (initialization): time 0.2495/10.07, allocations: 81.57 MB / 2.302 GB, free: 0.6684 GB / 1.764 GB Notification: Performance of prepare postOptimizeDAE: time 0.000414/10.07, allocations: 196.3 kB / 2.302 GB, free: 0.6682 GB / 1.764 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.1866/10.26, allocations: 58.85 MB / 2.359 GB, free: 0.617 GB / 1.764 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.2351/10.49, allocations: 37.17 MB / 2.396 GB, free: 0.583 GB / 1.764 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04241/10.54, allocations: 4.27 MB / 2.4 GB, free: 0.5788 GB / 1.764 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04915/10.59, allocations: 32.85 MB / 2.432 GB, free: 0.5447 GB / 1.764 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.06685/10.65, allocations: 4.097 MB / 2.436 GB, free: 0.5414 GB / 1.764 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0105/10.66, allocations: 0.6476 MB / 2.436 GB, free: 0.5408 GB / 1.764 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1191/10.78, allocations: 47.98 MB / 2.483 GB, free: 0.4939 GB / 1.764 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.09382/10.88, allocations: 39.04 MB / 2.521 GB, free: 465.1 MB / 1.764 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.1223/11, allocations: 49.61 MB / 2.57 GB, free: 414 MB / 1.764 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001852/11, allocations: 32 kB / 2.57 GB, free: 413.9 MB / 1.764 GB Notification: Performance of matching and sorting (n=2396) (initialization_lambda0): time 0.2144/11.21, allocations: 80.6 MB / 2.649 GB, free: 333.8 MB / 1.764 GB Notification: Performance of prepare postOptimizeDAE: time 0.0005039/11.21, allocations: 191.3 kB / 2.649 GB, free: 333.6 MB / 1.764 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.168/11.38, allocations: 58.63 MB / 2.706 GB, free: 274.8 MB / 1.764 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.01847/11.4, allocations: 3.26 MB / 2.709 GB, free: 271.6 MB / 1.764 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04112/11.44, allocations: 4.216 MB / 2.713 GB, free: 267.3 MB / 1.764 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.1215/11.56, allocations: 32.31 MB / 2.745 GB, free: 233.5 MB / 1.764 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.07714/11.64, allocations: 3.763 MB / 2.749 GB, free: 229.9 MB / 1.764 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00659/11.65, allocations: 0.6427 MB / 2.749 GB, free: 229.3 MB / 1.764 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 493 * 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 (1599): * Single equations (assignments): 1544 * 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.01107/11.66, allocations: 1.14 MB / 2.75 GB, free: 228.1 MB / 1.764 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01637/11.67, allocations: 2.452 MB / 2.753 GB, free: 225.6 MB / 1.764 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1394/11.81, allocations: 25.3 MB / 2.777 GB, free: 200.2 MB / 1.764 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1045/11.92, allocations: 20.95 MB / 2.798 GB, free: 179.1 MB / 1.764 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.1911/12.11, allocations: 26.6 MB / 2.824 GB, free: 152.4 MB / 1.764 GB Notification: Performance of postOpt removeConstants (simulation): time 0.03386/12.14, allocations: 7.296 MB / 2.831 GB, free: 145.1 MB / 1.764 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01907/12.16, allocations: 235.8 kB / 2.831 GB, free: 144.8 MB / 1.764 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.04135/12.2, allocations: 2.294 MB / 2.833 GB, free: 142.5 MB / 1.764 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003704/12.21, allocations: 0.5068 MB / 2.834 GB, free: 142 MB / 1.764 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.1313/12.34, allocations: 26.32 MB / 2.86 GB, free: 115.7 MB / 1.764 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.1379/12.48, allocations: 33.79 MB / 2.893 GB, free: 81.81 MB / 1.764 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.04349/12.52, allocations: 10.27 MB / 2.903 GB, free: 71.52 MB / 1.764 GB Notification: Performance of sorting global known variables: time 0.1215/12.64, allocations: 37.25 MB / 2.939 GB, free: 34.41 MB / 1.764 GB Notification: Performance of Backend: time 1.863e-06/12.64, allocations: 3.844 kB / 2.939 GB, free: 34.41 MB / 1.764 GB Notification: Performance of simCode: created initialization part: time 1.484/14.13, allocations: 90.49 MB / 3.027 GB, free: 0.6938 GB / 1.764 GB Notification: Performance of SimCode: time 0.2799/14.41, allocations: 73.96 MB / 3.1 GB, free: 0.6537 GB / 1.764 GB Notification: Performance of Templates: time 1.685/16.09, allocations: 0.6197 GB / 3.719 GB, free: 44.8 MB / 1.764 GB make -j1 -f Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF.makefile (rm -f Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF.pipe ; mkfifo Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF.pipe ; head -c 1048576 < Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF.pipe >> ../files/Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF.sim & ./Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case650FF.pipe 2>&1)