Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_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 9.1.3-maint.9.1.x/package.mo", uses=false) Using package Buildings with version 9.1.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.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.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_9_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_9_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.001664/0.001664, allocations: 115.2 kB / 16.42 MB, free: 6.449 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.001588/0.001588, allocations: 183.9 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 1.29/1.29, 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 9.1.3-maint.9.1.x/package.mo): time 2.179/2.179, allocations: 390.3 MB / 0.6655 GB, free: 0.6367 MB / 0.5294 GB Notification: Performance of FrontEnd - loaded program: time 0.001181/0.001181, allocations: 59.91 kB / 0.9516 GB, free: 7.57 MB / 0.7325 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.6696/0.6708, allocations: 140.4 MB / 1.089 GB, free: 5.527 MB / 0.8575 GB Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF): time 0.2378/0.9086, allocations: 233.8 MB / 1.317 GB, free: 3.621 MB / 1.045 GB Notification: Performance of NFInst.instExpressions: time 0.06331/0.972, allocations: 43.86 MB / 1.36 GB, free: 7.637 MB / 1.092 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.01183/0.9839, allocations: 354.1 kB / 1.36 GB, free: 7.289 MB / 1.092 GB Notification: Performance of NFTyping.typeComponents: time 0.01766/1.002, allocations: 7.706 MB / 1.368 GB, free: 15.55 MB / 1.107 GB Notification: Performance of NFTyping.typeBindings: time 0.01849/1.02, allocations: 6.66 MB / 1.374 GB, free: 8.859 MB / 1.107 GB Notification: Performance of NFTyping.typeClassSections: time 0.01512/1.035, allocations: 6.232 MB / 1.38 GB, free: 2.637 MB / 1.107 GB Notification: Performance of NFFlatten.flatten: time 0.05449/1.09, allocations: 49.21 MB / 1.428 GB, free: 1.348 MB / 1.154 GB Notification: Performance of NFFlatten.resolveConnections: time 0.02954/1.119, allocations: 23.92 MB / 1.452 GB, free: 9.273 MB / 1.186 GB Notification: Performance of NFEvalConstants.evaluate: time 0.03058/1.15, allocations: 21.72 MB / 1.473 GB, free: 3.504 MB / 1.201 GB Notification: Performance of NFSimplifyModel.simplify: time 0.02538/1.175, allocations: 17.27 MB / 1.49 GB, free: 2.168 MB / 1.217 GB Notification: Performance of NFPackage.collectConstants: time 0.009786/1.185, allocations: 3.453 MB / 1.493 GB, free: 14.71 MB / 1.232 GB Notification: Performance of NFFlatten.collectFunctions: time 0.01939/1.205, allocations: 8.117 MB / 1.501 GB, free: 6.594 MB / 1.232 GB Notification: Performance of NFScalarize.scalarize: time 0.01485/1.219, allocations: 11.37 MB / 1.512 GB, free: 11.2 MB / 1.248 GB Notification: Performance of NFVerifyModel.verify: time 0.02723/1.247, allocations: 16.75 MB / 1.529 GB, free: 10.37 MB / 1.264 GB Notification: Performance of NFConvertDAE.convert: time 0.06589/1.313, allocations: 57.62 MB / 1.585 GB, free: 0.6016 MB / 1.311 GB Notification: Performance of FrontEnd - DAE generated: time 6.312e-06/1.313, allocations: 7.938 kB / 1.585 GB, free: 0.5938 MB / 1.311 GB Notification: Performance of FrontEnd: time 1.793e-06/1.313, allocations: 0 / 1.585 GB, free: 0.5938 MB / 1.311 GB Notification: Performance of Transformations before backend: time 0.001431/1.314, allocations: 4 kB / 1.585 GB, free: 0.5898 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: 2568 * Number of variables: 2568 Notification: Performance of Generate backend data structure: time 1.02/2.335, allocations: 37.35 MB / 1.621 GB, free: 393.8 MB / 1.311 GB Notification: Performance of prepare preOptimizeDAE: time 4.596e-05/2.335, allocations: 9.312 kB / 1.621 GB, free: 393.8 MB / 1.311 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06549/2.4, allocations: 12.24 MB / 1.633 GB, free: 392 MB / 1.311 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.08198/2.482, allocations: 40.18 MB / 1.673 GB, free: 369.4 MB / 1.311 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001421/2.484, allocations: 1.596 MB / 1.674 GB, free: 368.1 MB / 1.311 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.005957/2.49, allocations: 1.224 MB / 1.675 GB, free: 367.7 MB / 1.311 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.05117/2.541, allocations: 20.93 MB / 1.696 GB, free: 348.1 MB / 1.311 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0004704/2.541, allocations: 24.38 kB / 1.696 GB, free: 348.1 MB / 1.311 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003909/2.545, allocations: 418.8 kB / 1.696 GB, free: 347.6 MB / 1.311 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000252/2.545, allocations: 359 kB / 1.697 GB, free: 347.3 MB / 1.311 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05378/2.599, allocations: 23.11 MB / 1.719 GB, free: 324.2 MB / 1.311 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.1615/2.761, allocations: 97.58 MB / 1.814 GB, free: 224.3 MB / 1.311 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0289/2.79, allocations: 15.29 MB / 1.829 GB, free: 209 MB / 1.311 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.01898/2.809, allocations: 10.36 MB / 1.839 GB, free: 198.6 MB / 1.311 GB Notification: Performance of preOpt evalFunc (simulation): time 0.001355/2.81, allocations: 1.003 MB / 1.84 GB, free: 197.4 MB / 1.311 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01881/2.829, allocations: 9.861 MB / 1.85 GB, free: 187.5 MB / 1.311 GB Notification: Performance of pre-optimization done (n=746): time 1.014e-05/2.829, allocations: 0 / 1.85 GB, free: 187.5 MB / 1.311 GB Notification: Performance of matching and sorting (n=746): time 0.08039/2.909, allocations: 34.78 MB / 1.884 GB, free: 152.3 MB / 1.311 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001936/2.91, allocations: 361.6 kB / 1.884 GB, free: 151.9 MB / 1.311 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.08486/2.994, allocations: 53.24 MB / 1.936 GB, free: 98.87 MB / 1.311 GB Notification: Performance of collectPreVariables (initialization): time 0.003197/2.998, allocations: 269.7 kB / 1.937 GB, free: 98.6 MB / 1.311 GB Notification: Performance of collectInitialEqns (initialization): time 0.01518/3.013, allocations: 12.28 MB / 1.949 GB, free: 86.27 MB / 1.311 GB Notification: Performance of collectInitialBindings (initialization): time 0.004107/3.017, allocations: 2.561 MB / 1.951 GB, free: 83.67 MB / 1.311 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.009395/3.026, allocations: 5.628 MB / 1.957 GB, free: 78.02 MB / 1.311 GB Notification: Performance of setup shared object (initialization): time 3.712e-05/3.026, allocations: 301.1 kB / 1.957 GB, free: 77.72 MB / 1.311 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.03952/3.066, allocations: 34.37 MB / 1.99 GB, free: 43.32 MB / 1.311 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.04289/3.109, allocations: 38.64 MB / 2.028 GB, free: 3.164 MB / 1.311 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0754/3.184, allocations: 48.97 MB / 2.076 GB, free: 0.5898 MB / 1.358 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001473/3.185, allocations: 32 kB / 2.076 GB, free: 0.5586 MB / 1.358 GB Notification: Performance of matching and sorting (n=2356) (initialization): time 0.6739/3.858, allocations: 80.64 MB / 2.155 GB, free: 440.5 MB / 1.389 GB Notification: Performance of prepare postOptimizeDAE: time 0.0002869/3.859, allocations: 192.7 kB / 2.155 GB, free: 440.4 MB / 1.389 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.08384/3.943, allocations: 57.97 MB / 2.212 GB, free: 412.2 MB / 1.389 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.1075/4.05, allocations: 36.89 MB / 2.248 GB, free: 378.3 MB / 1.389 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02088/4.071, allocations: 4.183 MB / 2.252 GB, free: 374.1 MB / 1.389 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02265/4.094, allocations: 32.36 MB / 2.283 GB, free: 339.7 MB / 1.389 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02824/4.122, allocations: 3.664 MB / 2.287 GB, free: 336.7 MB / 1.389 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003611/4.126, allocations: 0.6283 MB / 2.287 GB, free: 336.1 MB / 1.389 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.05393/4.18, allocations: 47.41 MB / 2.334 GB, free: 288.7 MB / 1.389 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.04055/4.22, allocations: 38.59 MB / 2.371 GB, free: 248.6 MB / 1.389 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0581/4.278, allocations: 48.87 MB / 2.419 GB, free: 198.2 MB / 1.389 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001163/4.279, allocations: 32 kB / 2.419 GB, free: 198.1 MB / 1.389 GB Notification: Performance of matching and sorting (n=2356) (initialization_lambda0): time 0.1075/4.386, allocations: 79.62 MB / 2.497 GB, free: 119 MB / 1.389 GB Notification: Performance of prepare postOptimizeDAE: time 0.0002176/4.386, allocations: 195.7 kB / 2.497 GB, free: 118.8 MB / 1.389 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0753/4.462, allocations: 57.83 MB / 2.554 GB, free: 60.87 MB / 1.389 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.007919/4.47, allocations: 2.979 MB / 2.557 GB, free: 57.86 MB / 1.389 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0204/4.49, allocations: 4.126 MB / 2.561 GB, free: 53.72 MB / 1.389 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02608/4.516, allocations: 31.87 MB / 2.592 GB, free: 20.33 MB / 1.389 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02829/4.544, allocations: 3.328 MB / 2.595 GB, free: 17.18 MB / 1.389 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003735/4.548, allocations: 0.6349 MB / 2.596 GB, free: 16.55 MB / 1.389 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 477 * 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 (1571): * Single equations (assignments): 1516 * 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 {(12,45), (1,11)} Notification: Performance of prepare postOptimizeDAE: time 0.005336/4.554, allocations: 1.131 MB / 2.597 GB, free: 15.42 MB / 1.389 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.007666/4.561, allocations: 2.448 MB / 2.599 GB, free: 12.94 MB / 1.389 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05676/4.618, allocations: 24.43 MB / 2.623 GB, free: 4.398 MB / 1.404 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.049/4.667, allocations: 20.14 MB / 2.643 GB, free: 68 kB / 1.42 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.5656/5.233, allocations: 19.04 MB / 2.661 GB, free: 476 MB / 1.42 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0221/5.255, allocations: 7.03 MB / 2.668 GB, free: 473.6 MB / 1.42 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.009332/5.264, allocations: 229.7 kB / 2.668 GB, free: 473.5 MB / 1.42 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02237/5.286, allocations: 1.941 MB / 2.67 GB, free: 473.4 MB / 1.42 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001855/5.288, allocations: 0.4925 MB / 2.671 GB, free: 473.3 MB / 1.42 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.07091/5.359, allocations: 25.46 MB / 2.696 GB, free: 466.5 MB / 1.42 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.07201/5.431, allocations: 33.01 MB / 2.728 GB, free: 453.6 MB / 1.42 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01953/5.451, allocations: 10.01 MB / 2.738 GB, free: 448.2 MB / 1.42 GB Notification: Performance of sorting global known variables: time 0.05989/5.511, allocations: 36.87 MB / 2.774 GB, free: 414.2 MB / 1.42 GB Notification: Performance of Backend: time 1.202e-06/5.511, allocations: 3.062 kB / 2.774 GB, free: 414.2 MB / 1.42 GB Notification: Performance of simCode: created initialization part: time 0.1298/5.641, allocations: 89.64 MB / 2.861 GB, free: 325.4 MB / 1.42 GB Notification: Performance of SimCode: time 0.1164/5.757, allocations: 72.82 MB / 2.932 GB, free: 252.8 MB / 1.42 GB Notification: Performance of Templates: time 1.754/7.511, allocations: 0.5931 GB / 3.525 GB, free: 182.8 MB / 1.42 GB make -j1 -f Buildings_9_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.makefile (rm -f Buildings_9_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe ; mkfifo Buildings_9_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe ; head -c 1048576 < Buildings_9_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe >> ../files/Buildings_9_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.sim & ./Buildings_9_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Buildings_9_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe 2>&1)