Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_8_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 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/package.mo", uses=false)
Using package Buildings with version 8.1.4 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF")
translateModel(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_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.0011/0.0011, allocations: 106.3 kB / 16.36 MB, free: 6.309 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.00102/0.00102, allocations: 192.9 kB / 17.3 MB, free: 5.871 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.083/1.083, allocations: 205.1 MB / 223.2 MB, free: 12.22 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/package.mo): time 1.541/1.541, allocations: 292.3 MB / 0.5496 GB, free: 17.45 MB / 462.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001281/0.001281, allocations: 59.91 kB / 0.6729 GB, free: 5.816 MB / 0.545 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1625/0.1638, allocations: 114.6 MB / 0.7848 GB, free: 3.145 MB / 0.6544 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF): time 0.4493/0.6131, allocations: 226.6 MB / 1.006 GB, free: 7.23 MB / 0.795 GB
Notification: Performance of NFInst.instExpressions: time 0.04975/0.6629, allocations: 41.69 MB / 1.047 GB, free: 13.44 MB / 0.8419 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.008066/0.671, allocations: 314.2 kB / 1.047 GB, free: 13.13 MB / 0.8419 GB
Notification: Performance of NFTyping.typeComponents: time 0.01381/0.6848, allocations: 7.118 MB / 1.054 GB, free: 5.977 MB / 0.8419 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Utilities/Strings.mo:216:3-259:11:writable] Warning: Pure function 'Modelica.Utilities.Strings.find' contains a call to impure function 'Modelica.Utilities.Strings.length'.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/BoundaryConditions/WeatherData/BaseClasses/getHeaderElementTMY3.mo:2:1-105:25:writable] Warning: Pure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3' contains a call to impure function 'Modelica.Utilities.Streams.readLine'.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/BoundaryConditions/WeatherData/BaseClasses/getLongitudeTMY3.mo:2:1-48:21:writable] Warning: Pure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getLongitudeTMY3' contains a call to impure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3'.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/BoundaryConditions/WeatherData/BaseClasses/getLatitudeTMY3.mo:2:1-48:20:writable] Warning: Pure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getLatitudeTMY3' contains a call to impure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3'.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/BoundaryConditions/WeatherData/BaseClasses/getTimeZoneTMY3.mo:2:1-47:20:writable] Warning: Pure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getTimeZoneTMY3' contains a call to impure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3'.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Utilities/Strings.mo:139:3-175:14:writable] Warning: Pure function 'Modelica.Utilities.Strings.isEmpty' contains a call to impure function 'Modelica.Utilities.Strings.Advanced.skipWhiteSpace'.
Notification: Performance of NFTyping.typeBindings: time 0.01376/0.6986, allocations: 6.209 MB / 1.06 GB, free: 15.74 MB / 0.8575 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01107/0.7097, allocations: 5.835 MB / 1.066 GB, free: 9.926 MB / 0.8575 GB
Notification: Performance of NFFlatten.flatten: time 0.0417/0.7514, allocations: 47.99 MB / 1.113 GB, free: 9.895 MB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02275/0.7742, allocations: 23.17 MB / 1.135 GB, free: 2.637 MB / 0.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.6709/1.445, allocations: 20.4 MB / 1.155 GB, free: 38.34 MB / 0.92 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02453/1.47, allocations: 16.76 MB / 1.172 GB, free: 35.45 MB / 0.92 GB
Notification: Performance of NFPackage.collectConstants: time 0.009632/1.479, allocations: 3.316 MB / 1.175 GB, free: 35.45 MB / 0.92 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01562/1.495, allocations: 7.341 MB / 1.182 GB, free: 35.45 MB / 0.92 GB
Notification: Performance of NFScalarize.scalarize: time 0.01161/1.507, allocations: 11.36 MB / 1.193 GB, free: 34.34 MB / 0.92 GB
Notification: Performance of NFVerifyModel.verify: time 0.01994/1.527, allocations: 16.43 MB / 1.209 GB, free: 29.93 MB / 0.92 GB
Notification: Performance of NFConvertDAE.convert: time 0.03873/1.565, allocations: 54.18 MB / 1.262 GB, free: 16.1 MB / 0.92 GB
Notification: Performance of FrontEnd - DAE generated: time 4.778e-06/1.565, allocations: 4.625 kB / 1.262 GB, free: 16.1 MB / 0.92 GB
Notification: Performance of FrontEnd: time 1.252e-06/1.565, allocations: 0 / 1.262 GB, free: 16.1 MB / 0.92 GB
Notification: Performance of Transformations before backend: time 0.0008929/1.566, allocations: 0 / 1.262 GB, free: 16.1 MB / 0.92 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2472
 * Number of variables: 2472
Notification: Performance of Generate backend data structure: time 0.06951/1.636, allocations: 35.72 MB / 1.297 GB, free: 2.023 MB / 0.9357 GB
Notification: Performance of prepare preOptimizeDAE: time 3.888e-05/1.636, allocations: 12.03 kB / 1.297 GB, free: 2.012 MB / 0.9357 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0435/1.679, allocations: 10.19 MB / 1.307 GB, free: 7.914 MB / 0.9513 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.05746/1.737, allocations: 39.5 MB / 1.345 GB, free: 1.176 MB / 0.9825 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001036/1.738, allocations: 1.583 MB / 1.347 GB, free: 15.44 MB / 0.9982 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002352/1.74, allocations: 1.196 MB / 1.348 GB, free: 14.25 MB / 0.9982 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03131/1.772, allocations: 18.71 MB / 1.366 GB, free: 11.21 MB / 1.014 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000137/1.772, allocations: 17.28 kB / 1.366 GB, free: 11.2 MB / 1.014 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001037/1.773, allocations: 405.4 kB / 1.367 GB, free: 10.8 MB / 1.014 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002246/1.773, allocations: 347.8 kB / 1.367 GB, free: 10.46 MB / 1.014 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03836/1.811, allocations: 20.69 MB / 1.387 GB, free: 5.84 MB / 1.029 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.1364/1.948, allocations: 91.33 MB / 1.477 GB, free: 9.719 MB / 1.123 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02535/1.973, allocations: 13.75 MB / 1.49 GB, free: 11.95 MB / 1.139 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01433/1.987, allocations: 8.581 MB / 1.498 GB, free: 3.34 MB / 1.139 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001255/1.989, allocations: 0.9509 MB / 1.499 GB, free: 2.258 MB / 1.139 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0139/2.003, allocations: 8.076 MB / 1.507 GB, free: 10.12 MB / 1.154 GB
Notification: Performance of pre-optimization done (n=706): time 8.586e-06/2.003, allocations: 0 / 1.507 GB, free: 10.12 MB / 1.154 GB
Notification: Performance of matching and sorting (n=706): time 0.05902/2.062, allocations: 28.1 MB / 1.535 GB, free: 13.7 MB / 1.186 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001949/2.062, allocations: 387 kB / 1.535 GB, free: 13.27 MB / 1.186 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.3992/2.461, allocations: 53.09 MB / 1.587 GB, free: 476.3 MB / 1.186 GB
Notification: Performance of collectPreVariables (initialization): time 0.002788/2.464, allocations: 255.3 kB / 1.587 GB, free: 476.1 MB / 1.186 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01495/2.479, allocations: 12.14 MB / 1.599 GB, free: 468.2 MB / 1.186 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003785/2.483, allocations: 2.485 MB / 1.601 GB, free: 467.1 MB / 1.186 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.007849/2.491, allocations: 5.563 MB / 1.607 GB, free: 464.8 MB / 1.186 GB
Notification: Performance of setup shared object (initialization): time 3.346e-05/2.491, allocations: 305.8 kB / 1.607 GB, free: 464.5 MB / 1.186 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.03223/2.523, allocations: 32.66 MB / 1.639 GB, free: 453.4 MB / 1.186 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03479/2.558, allocations: 37.12 MB / 1.675 GB, free: 434.7 MB / 1.186 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04691/2.605, allocations: 46.36 MB / 1.721 GB, free: 391.6 MB / 1.186 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.955e-05/2.605, allocations: 39.31 kB / 1.721 GB, free: 391.5 MB / 1.186 GB
Notification: Performance of matching and sorting (n=2348) (initialization): time 0.08064/2.685, allocations: 76.5 MB / 1.795 GB, free: 319 MB / 1.186 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001561/2.685, allocations: 193.6 kB / 1.795 GB, free: 318.8 MB / 1.186 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.05425/2.74, allocations: 54.54 MB / 1.849 GB, free: 264.2 MB / 1.186 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008704/2.748, allocations: 3.642 MB / 1.852 GB, free: 260.6 MB / 1.186 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01374/2.762, allocations: 3.56 MB / 1.856 GB, free: 257.1 MB / 1.186 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01869/2.781, allocations: 28.79 MB / 1.884 GB, free: 226.8 MB / 1.186 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02292/2.804, allocations: 3.225 MB / 1.887 GB, free: 223.6 MB / 1.186 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001711/2.806, allocations: 0.616 MB / 1.888 GB, free: 223 MB / 1.186 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04393/2.85, allocations: 45.55 MB / 1.932 GB, free: 177.5 MB / 1.186 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.03136/2.881, allocations: 37.1 MB / 1.968 GB, free: 138.9 MB / 1.186 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04451/2.925, allocations: 46.33 MB / 2.014 GB, free: 90.96 MB / 1.186 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.379e-05/2.925, allocations: 32 kB / 2.014 GB, free: 90.93 MB / 1.186 GB
Notification: Performance of matching and sorting (n=2348) (initialization_lambda0): time 0.07956/3.005, allocations: 76.97 MB / 2.089 GB, free: 13.85 MB / 1.186 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001523/3.005, allocations: 194.6 kB / 2.089 GB, free: 13.65 MB / 1.186 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.3904/3.396, allocations: 54.94 MB / 2.143 GB, free: 452.2 MB / 1.186 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009513/3.405, allocations: 3.551 MB / 2.146 GB, free: 451.6 MB / 1.186 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0158/3.421, allocations: 3.565 MB / 2.15 GB, free: 451.5 MB / 1.186 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03122/3.452, allocations: 39.21 MB / 2.188 GB, free: 426.9 MB / 1.186 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02429/3.477, allocations: 2.886 MB / 2.191 GB, free: 426.7 MB / 1.186 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002627/3.479, allocations: 0.6237 MB / 2.191 GB, free: 426.6 MB / 1.186 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 513
 * Number of states: 0 ()
 * Number of discrete variables: 25 (TRooAnn.mode,$PRE.TRooAnn.mode,$whenCondition1,TRooHou.mode,$PRE.TRooHou.mode,$whenCondition2,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,roo.solRadExc.isFlo[11],roo.solRadExc.isFlo[10],roo.solRadExc.isFlo[9],roo.solRadExc.isFlo[8],roo.solRadExc.isFlo[7],roo.solRadExc.isFlo[6],roo.solRadExc.isFlo[5],roo.solRadExc.isFlo[4],roo.solRadExc.isFlo[3],roo.solRadExc.isFlo[2],roo.solRadExc.isFlo[1],weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,$whenCondition3,$whenCondition4)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1534):
 * Single equations (assignments): 1485
 * Array equations: 36
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 12
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 11 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%), (18,25,16.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(11,44)}
Notification: Performance of prepare postOptimizeDAE: time 0.004002/3.483, allocations: 1.078 MB / 2.192 GB, free: 426 MB / 1.186 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006755/3.49, allocations: 2.424 MB / 2.195 GB, free: 426 MB / 1.186 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03732/3.527, allocations: 20.11 MB / 2.214 GB, free: 419.4 MB / 1.186 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02566/3.553, allocations: 16.2 MB / 2.23 GB, free: 413.8 MB / 1.186 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.425e-05/3.553, allocations: 1.125 kB / 2.23 GB, free: 413.8 MB / 1.186 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01358/3.567, allocations: 6.725 MB / 2.237 GB, free: 410.4 MB / 1.186 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005665/3.572, allocations: 197.9 kB / 2.237 GB, free: 410.3 MB / 1.186 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01216/3.584, allocations: 1.456 MB / 2.238 GB, free: 410.2 MB / 1.186 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008348/3.585, allocations: 473.3 kB / 2.239 GB, free: 410.2 MB / 1.186 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0348/3.62, allocations: 19.5 MB / 2.258 GB, free: 395.2 MB / 1.186 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.03982/3.66, allocations: 27.5 MB / 2.285 GB, free: 367.7 MB / 1.186 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01036/3.67, allocations: 8.06 MB / 2.293 GB, free: 359.6 MB / 1.186 GB
Notification: Performance of sorting global known variables: time 0.04551/3.716, allocations: 36.78 MB / 2.328 GB, free: 323 MB / 1.186 GB
Notification: Performance of Backend: time 3.81e-07/3.716, allocations: 4 kB / 2.328 GB, free: 323 MB / 1.186 GB
Notification: Performance of simCode: created initialization part: time 0.0915/3.807, allocations: 86.47 MB / 2.413 GB, free: 237 MB / 1.186 GB
Notification: Performance of SimCode: time 0.09992/3.907, allocations: 72.57 MB / 2.484 GB, free: 164.8 MB / 1.186 GB
Notification: Performance of Templates: time 1.207/5.114, allocations: 0.5514 GB / 3.035 GB, free: 147.8 MB / 1.186 GB
make -j1 -f Buildings_8_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.makefile
(rm -f Buildings_8_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.pipe ; mkfifo Buildings_8_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.pipe ; head -c 1048576 < Buildings_8_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.pipe >> ../files/Buildings_8_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.sim & ./Buildings_8_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases6xx.Case600FF.pipe 2>&1)