Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+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/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/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 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 7.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo)
Running command: translateModel(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF")
translateModel(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo): time 1.205/1.205, allocations: 251.5 MB / 267.4 MB, free: 11.08 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.0008953/0.0008955, allocations: 174.6 kB / 326.5 MB, free: 2.727 MB / 250.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.259/1.259, allocations: 205 MB / 0.5766 GB, free: 21.02 MB / 426.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0006916/0.0006917, allocations: 91.92 kB / 0.6804 GB, free: 14.75 MB / 0.5105 GB
Notification: Performance of FrontEnd - loaded program: time 0.000258/0.000258, allocations: 9.406 kB / 0.7938 GB, free: 136.6 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1355/0.1358, allocations: 105.4 MB / 0.8967 GB, free: 68.24 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF): time 0.4799/0.6157, allocations: 224.2 MB / 1.116 GB, free: 1.578 MB / 0.698 GB
Notification: Performance of NFInst.instExpressions: time 0.04979/0.6655, allocations: 42.63 MB / 1.157 GB, free: 14.84 MB / 0.7136 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01216/0.6777, allocations: 260.3 kB / 1.158 GB, free: 14.84 MB / 0.7136 GB
Notification: Performance of NFTyping.typeComponents: time 0.01768/0.6954, allocations: 7.125 MB / 1.165 GB, free: 12.56 MB / 0.7136 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.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 7.0.3-maint.7.0.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 7.0.3-maint.7.0.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 7.0.3-maint.7.0.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‘.
Notification: Performance of NFTyping.typeBindings: time 0.01763/0.7131, allocations: 5.827 MB / 1.17 GB, free: 9.449 MB / 0.7136 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01346/0.7265, allocations: 5.367 MB / 1.175 GB, free: 5.578 MB / 0.7136 GB
Notification: Performance of NFFlatten.flatten: time 0.05185/0.7784, allocations: 55.34 MB / 1.23 GB, free: 5.516 MB / 0.7605 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02118/0.7996, allocations: 18.98 MB / 1.248 GB, free: 2.621 MB / 0.7761 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02959/0.8292, allocations: 20.42 MB / 1.268 GB, free: 14.43 MB / 0.8073 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02051/0.8498, allocations: 15.22 MB / 1.283 GB, free: 15.59 MB / 0.823 GB
Notification: Performance of NFPackage.collectConstants: time 0.006258/0.856, allocations: 1.273 MB / 1.284 GB, free: 14.32 MB / 0.823 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01547/0.8715, allocations: 5.389 MB / 1.289 GB, free: 9.137 MB / 0.823 GB
Notification: Performance of NFScalarize.scalarize: time 0.01192/0.8835, allocations: 8.943 MB / 1.298 GB, free: 232 kB / 0.823 GB
Notification: Performance of NFVerifyModel.verify: time 0.02132/0.9048, allocations: 13.94 MB / 1.312 GB, free: 2.262 MB / 0.8386 GB
Notification: Performance of NFConvertDAE.convert: time 0.0512/0.956, allocations: 52.23 MB / 1.363 GB, free: 14.99 MB / 0.9011 GB
Notification: Performance of FrontEnd - DAE generated: time 3.737e-06/0.956, allocations: 0 / 1.363 GB, free: 14.99 MB / 0.9011 GB
Notification: Performance of FrontEnd: time 1.844e-06/0.9561, allocations: 0 / 1.363 GB, free: 14.99 MB / 0.9011 GB
Notification: Performance of Transformations before backend: time 0.001173/0.9572, allocations: 0 / 1.363 GB, free: 14.99 MB / 0.9011 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2510
 * Number of variables: 2510
Notification: Performance of Generate backend data structure: time 0.06145/1.019, allocations: 31.28 MB / 1.393 GB, free: 15.71 MB / 0.9323 GB
Notification: Performance of prepare preOptimizeDAE: time 3.798e-05/1.019, allocations: 12.03 kB / 1.393 GB, free: 15.7 MB / 0.9323 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04418/1.063, allocations: 10.45 MB / 1.403 GB, free: 5.207 MB / 0.9323 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.6231/1.686, allocations: 38.81 MB / 1.441 GB, free: 315.9 MB / 0.9324 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001068/1.687, allocations: 1.597 MB / 1.443 GB, free: 314.7 MB / 0.9324 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004288/1.691, allocations: 1.219 MB / 1.444 GB, free: 314.3 MB / 0.9324 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03226/1.724, allocations: 19.15 MB / 1.463 GB, free: 305.1 MB / 0.9324 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001633/1.724, allocations: 19.09 kB / 1.463 GB, free: 305.1 MB / 0.9324 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0009689/1.725, allocations: 412.9 kB / 1.463 GB, free: 304.8 MB / 0.9324 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001687/1.725, allocations: 350.2 kB / 1.464 GB, free: 304.7 MB / 0.9324 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03581/1.761, allocations: 21.15 MB / 1.484 GB, free: 287.6 MB / 0.9324 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.1249/1.886, allocations: 95.95 MB / 1.578 GB, free: 190.5 MB / 0.9324 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02202/1.908, allocations: 14 MB / 1.592 GB, free: 176.5 MB / 0.9324 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01268/1.921, allocations: 8.932 MB / 1.6 GB, free: 167.6 MB / 0.9324 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001093/1.922, allocations: 0.9424 MB / 1.601 GB, free: 166.5 MB / 0.9324 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.012/1.934, allocations: 8.27 MB / 1.609 GB, free: 158.2 MB / 0.9324 GB
Notification: Performance of pre-optimization done (n=721): time 7.684e-06/1.934, allocations: 0 / 1.609 GB, free: 158.2 MB / 0.9324 GB
Notification: Performance of matching and sorting (n=721): time 0.05013/1.984, allocations: 28.6 MB / 1.637 GB, free: 129.2 MB / 0.9324 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001441/1.984, allocations: 391.1 kB / 1.638 GB, free: 128.7 MB / 0.9324 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0772/2.061, allocations: 54.9 MB / 1.691 GB, free: 74.02 MB / 0.9324 GB
Notification: Performance of collectPreVariables (initialization): time 0.002571/2.064, allocations: 261.7 kB / 1.691 GB, free: 73.76 MB / 0.9324 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01277/2.077, allocations: 12.42 MB / 1.704 GB, free: 61.36 MB / 0.9324 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003467/2.08, allocations: 2.542 MB / 1.706 GB, free: 58.85 MB / 0.9324 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00407/2.084, allocations: 3.714 MB / 1.71 GB, free: 55.12 MB / 0.9324 GB
Notification: Performance of setup shared object (initialization): time 3.375e-05/2.084, allocations: 313.1 kB / 1.71 GB, free: 54.81 MB / 0.9324 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.03117/2.115, allocations: 32.83 MB / 1.742 GB, free: 21.96 MB / 0.9324 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.612/2.727, allocations: 37.43 MB / 1.779 GB, free: 297.7 MB / 0.9325 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04985/2.777, allocations: 46.84 MB / 1.824 GB, free: 277.3 MB / 0.9325 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.000149/2.778, allocations: 30.66 kB / 1.824 GB, free: 277.3 MB / 0.9325 GB
Notification: Performance of matching and sorting (n=2379) (initialization): time 0.08345/2.861, allocations: 77.12 MB / 1.9 GB, free: 213.7 MB / 0.9325 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001418/2.862, allocations: 3.755 MB / 1.903 GB, free: 208.4 MB / 0.9325 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.05758/2.92, allocations: 55.01 MB / 1.957 GB, free: 153.5 MB / 0.9325 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00834/2.928, allocations: 3.638 MB / 1.961 GB, free: 149.8 MB / 0.9325 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01434/2.943, allocations: 3.662 MB / 1.964 GB, free: 146.1 MB / 0.9325 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01797/2.961, allocations: 27.17 MB / 1.991 GB, free: 117.7 MB / 0.9325 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0231/2.984, allocations: 3.533 MB / 1.994 GB, free: 114.8 MB / 0.9325 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002664/2.987, allocations: 0.6239 MB / 1.995 GB, free: 114.2 MB / 0.9325 GB
Notification: Performance of prepare postOptimizeDAE: time 8.235e-06/2.987, allocations: 6.5 kB / 1.995 GB, free: 114.2 MB / 0.9325 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0752/3.062, allocations: 75.43 MB / 2.068 GB, free: 38.69 MB / 0.9325 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.3886/3.45, allocations: 55.49 MB / 2.123 GB, free: 292.3 MB / 0.9482 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008708/3.459, allocations: 3.396 MB / 2.126 GB, free: 292.2 MB / 0.9482 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0157/3.475, allocations: 3.653 MB / 2.13 GB, free: 292.2 MB / 0.9482 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02895/3.504, allocations: 36.66 MB / 2.165 GB, free: 271.9 MB / 0.9482 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02289/3.527, allocations: 3.236 MB / 2.169 GB, free: 271.5 MB / 0.9482 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002699/3.53, allocations: 0.6241 MB / 2.169 GB, free: 271.3 MB / 0.9482 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 518
 * Number of states: 0 ()
 * Number of discrete variables: 30 ($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.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],vent.tab.nextTimeEventScaled,$PRE.vent.tab.nextTimeEventScaled,vent.tab.nextTimeEvent,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,$whenCondition4,$whenCondition5)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1565):
 * Single equations (assignments): 1516
 * 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.01663/3.546, allocations: 13.92 MB / 2.183 GB, free: 266 MB / 0.9482 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006285/3.552, allocations: 2.481 MB / 2.185 GB, free: 266 MB / 0.9482 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03489/3.587, allocations: 20.55 MB / 2.205 GB, free: 257.1 MB / 0.9482 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02514/3.613, allocations: 16.49 MB / 2.221 GB, free: 247.3 MB / 0.9482 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.408e-05/3.613, allocations: 0 / 2.221 GB, free: 247.3 MB / 0.9482 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01398/3.627, allocations: 7.038 MB / 2.228 GB, free: 241.1 MB / 0.9482 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006358/3.633, allocations: 203.8 kB / 2.228 GB, free: 240.9 MB / 0.9482 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01419/3.647, allocations: 1.688 MB / 2.23 GB, free: 239.3 MB / 0.9482 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0009766/3.648, allocations: 485.6 kB / 2.231 GB, free: 238.8 MB / 0.9482 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0341/3.682, allocations: 20.11 MB / 2.25 GB, free: 218.8 MB / 0.9482 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.03914/3.721, allocations: 28.13 MB / 2.278 GB, free: 190.5 MB / 0.9482 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01024/3.732, allocations: 8.257 MB / 2.286 GB, free: 182.2 MB / 0.9482 GB
Notification: Performance of sorting global known variables: time 0.04491/3.777, allocations: 37.95 MB / 2.323 GB, free: 144.4 MB / 0.9482 GB
Notification: Performance of Backend: time 9.02e-07/3.777, allocations: 4 kB / 2.323 GB, free: 144.4 MB / 0.9482 GB
Notification: Performance of simCode: created initialization part: time 0.09413/3.871, allocations: 87.38 MB / 2.408 GB, free: 57.38 MB / 0.9482 GB
Notification: Performance of SimCode: time 0.4248/4.296, allocations: 82.08 MB / 2.488 GB, free: 284.7 MB / 0.9638 GB
Notification: Performance of Templates: time 0.8977/5.193, allocations: 0.5376 GB / 3.026 GB, free: 182.6 MB / 0.9794 GB
make -j1 -f Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.makefile
(rm -f Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe ; mkfifo Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe ; head -c 1048576 < Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe >> ../files/Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.sim & ./Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case950FF.pipe 2>&1)