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.Case960.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.Case960,tolerance=1e-06,outputFormat="empty",numberOfIntervals=17520,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960")
translateModel(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960,tolerance=1e-06,outputFormat="empty",numberOfIntervals=17520,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo): time 1.2/1.2, allocations: 251.5 MB / 267.4 MB, free: 10.87 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.0008663/0.0008663, allocations: 163.5 kB / 326.5 MB, free: 2.656 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.231/1.231, allocations: 205 MB / 0.5767 GB, free: 20.91 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.0006525/0.0006525, allocations: 90.64 kB / 0.6804 GB, free: 14.69 MB / 0.5105 GB
Notification: Performance of FrontEnd - loaded program: time 0.0002486/0.0002486, allocations: 8.812 kB / 0.7938 GB, free: 136.5 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1312/0.1314, allocations: 105.4 MB / 0.8968 GB, free: 68.13 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960): time 0.5218/0.6532, allocations: 302.4 MB / 1.192 GB, free: 2.633 MB / 0.7136 GB
Notification: Performance of NFInst.instExpressions: time 0.08154/0.7348, allocations: 61.81 MB / 1.252 GB, free: 11.07 MB / 0.7761 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02146/0.7563, allocations: 0.497 MB / 1.253 GB, free: 10.57 MB / 0.7761 GB
Notification: Performance of NFTyping.typeComponents: time 0.02246/0.7788, allocations: 9.679 MB / 1.262 GB, free: 0.8555 MB / 0.7761 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.02666/0.8055, allocations: 9.563 MB / 1.272 GB, free: 7.258 MB / 0.7917 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01884/0.8243, allocations: 8.188 MB / 1.28 GB, free: 15.08 MB / 0.8073 GB
Notification: Performance of NFFlatten.flatten: time 0.08105/0.9054, allocations: 87.7 MB / 1.365 GB, free: 7.246 MB / 0.8855 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03329/0.9387, allocations: 28.52 MB / 1.393 GB, free: 10.53 MB / 0.9167 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.7662/1.705, allocations: 31.99 MB / 1.424 GB, free: 44.52 MB / 0.9168 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03212/1.737, allocations: 24.37 MB / 1.448 GB, free: 39.79 MB / 0.9168 GB
Notification: Performance of NFPackage.collectConstants: time 0.01184/1.749, allocations: 2.032 MB / 1.45 GB, free: 39.79 MB / 0.9168 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02249/1.771, allocations: 7.517 MB / 1.458 GB, free: 39.79 MB / 0.9168 GB
Notification: Performance of NFScalarize.scalarize: time 0.01764/1.789, allocations: 13.15 MB / 1.47 GB, free: 37.96 MB / 0.9168 GB
Notification: Performance of NFVerifyModel.verify: time 0.03221/1.821, allocations: 22.33 MB / 1.492 GB, free: 30.76 MB / 0.9168 GB
Notification: Performance of NFConvertDAE.convert: time 0.07973/1.901, allocations: 83.18 MB / 1.573 GB, free: 15.96 MB / 0.9324 GB
Notification: Performance of FrontEnd - DAE generated: time 4.719e-06/1.901, allocations: 0 / 1.573 GB, free: 15.96 MB / 0.9324 GB
Notification: Performance of FrontEnd: time 2.324e-06/1.901, allocations: 0 / 1.573 GB, free: 15.96 MB / 0.9324 GB
Notification: Performance of Transformations before backend: time 0.002005/1.903, allocations: 0 / 1.573 GB, free: 15.96 MB / 0.9324 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3994
 * Number of variables: 3994
Notification: Performance of Generate backend data structure: time 0.1018/2.005, allocations: 49.42 MB / 1.622 GB, free: 5.723 MB / 0.9637 GB
Notification: Performance of prepare preOptimizeDAE: time 3.946e-05/2.005, allocations: 11.69 kB / 1.622 GB, free: 5.715 MB / 0.9637 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06725/2.072, allocations: 15.85 MB / 1.637 GB, free: 5.863 MB / 0.9793 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.09655/2.169, allocations: 58.45 MB / 1.694 GB, free: 15.5 MB / 1.042 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001651/2.171, allocations: 2.129 MB / 1.696 GB, free: 13.22 MB / 1.042 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.007228/2.178, allocations: 1.929 MB / 1.698 GB, free: 11.3 MB / 1.042 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06242/2.24, allocations: 29.97 MB / 1.728 GB, free: 12.77 MB / 1.073 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003284/2.241, allocations: 32.69 kB / 1.728 GB, free: 12.75 MB / 1.073 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003131/2.244, allocations: 0.6326 MB / 1.728 GB, free: 12.12 MB / 1.073 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003721/2.244, allocations: 0.5478 MB / 1.729 GB, free: 11.57 MB / 1.073 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06842/2.313, allocations: 32.64 MB / 1.761 GB, free: 11.06 MB / 1.104 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.8451/3.158, allocations: 148.3 MB / 1.905 GB, free: 403 MB / 1.136 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03512/3.193, allocations: 21.54 MB / 1.926 GB, free: 391.6 MB / 1.136 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0212/3.214, allocations: 13.89 MB / 1.94 GB, free: 384.4 MB / 1.136 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00159/3.216, allocations: 1.127 MB / 1.941 GB, free: 383.4 MB / 1.136 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02071/3.236, allocations: 12.73 MB / 1.953 GB, free: 375.1 MB / 1.136 GB
Notification: Performance of pre-optimization done (n=1152): time 1.333e-05/3.236, allocations: 0 / 1.953 GB, free: 375.1 MB / 1.136 GB
Notification: Performance of matching and sorting (n=1153): time 0.1408/3.377, allocations: 72.5 MB / 2.024 GB, free: 304.5 MB / 1.136 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001851/3.378, allocations: 487.2 kB / 2.025 GB, free: 303.9 MB / 1.136 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1178/3.495, allocations: 81.39 MB / 2.104 GB, free: 222.9 MB / 1.136 GB
Notification: Performance of collectPreVariables (initialization): time 0.004336/3.5, allocations: 389.7 kB / 2.105 GB, free: 222.5 MB / 1.136 GB
Notification: Performance of collectInitialEqns (initialization): time 0.02243/3.522, allocations: 20.45 MB / 2.125 GB, free: 202.1 MB / 1.136 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005942/3.528, allocations: 4.073 MB / 2.129 GB, free: 198 MB / 1.136 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.006211/3.534, allocations: 4.474 MB / 2.133 GB, free: 193.5 MB / 1.136 GB
Notification: Performance of setup shared object (initialization): time 3.319e-05/3.534, allocations: 305.1 kB / 2.133 GB, free: 193.2 MB / 1.136 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.03872/3.573, allocations: 38.1 MB / 2.17 GB, free: 155.1 MB / 1.136 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.04505/3.618, allocations: 45.3 MB / 2.215 GB, free: 107.2 MB / 1.136 GB
Notification: Performance of analyzeInitialSystem (initialization): time 1.737/5.356, allocations: 357.9 MB / 2.564 GB, free: 257.8 MB / 1.136 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001331/5.356, allocations: 56 kB / 2.564 GB, free: 257.7 MB / 1.136 GB
Notification: Performance of matching and sorting (n=3316) (initialization): time 0.1177/5.473, allocations: 92.78 MB / 2.655 GB, free: 167 MB / 1.136 GB
Notification: Performance of prepare postOptimizeDAE: time 0.002176/5.476, allocations: 6.045 MB / 2.661 GB, free: 158.3 MB / 1.136 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.08161/5.557, allocations: 66.05 MB / 2.725 GB, free: 92.13 MB / 1.136 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01239/5.57, allocations: 5.379 MB / 2.73 GB, free: 86.69 MB / 1.136 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02247/5.592, allocations: 5.647 MB / 2.736 GB, free: 81.04 MB / 1.136 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03363/5.626, allocations: 48.19 MB / 2.783 GB, free: 30.68 MB / 1.136 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03725/5.663, allocations: 4.176 MB / 2.787 GB, free: 26.56 MB / 1.136 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005157/5.668, allocations: 0.9768 MB / 2.788 GB, free: 25.59 MB / 1.136 GB
Notification: Performance of prepare postOptimizeDAE: time 9.698e-06/5.668, allocations: 10.44 kB / 2.788 GB, free: 25.58 MB / 1.136 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.4862/6.155, allocations: 89.6 MB / 2.876 GB, free: 390 MB / 1.136 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.08296/6.238, allocations: 66.4 MB / 2.94 GB, free: 353.6 MB / 1.136 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01118/6.249, allocations: 5.112 MB / 2.945 GB, free: 349.8 MB / 1.136 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02234/6.271, allocations: 5.633 MB / 2.951 GB, free: 345.4 MB / 1.136 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04187/6.313, allocations: 57.66 MB / 3.007 GB, free: 289.4 MB / 1.136 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03669/6.35, allocations: 4.152 MB / 3.011 GB, free: 285.3 MB / 1.136 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005179/6.355, allocations: 0.9678 MB / 3.012 GB, free: 284.4 MB / 1.136 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization sytem:
         $DER.soiSunSpa.T[1] = 0.0.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 857
 * Number of states: 0 ()
 * Number of discrete variables: 44 ($PRE.TSetHea.tab.nextTimeEvent,$whenCondition4,$PRE.TSetCoo.tab.nextTimeEvent,$whenCondition3,PCoo.mode,$PRE.PCoo.mode,$whenCondition1,PHea.mode,$PRE.PHea.mode,$whenCondition2,TRooAnn.mode,$PRE.TRooAnn.mode,$whenCondition5,TRooHou.mode,$PRE.TRooHou.mode,$whenCondition6,sunSpa.solRadExc.isFlo[10],sunSpa.solRadExc.isFlo[9],sunSpa.solRadExc.isFlo[8],sunSpa.solRadExc.isFlo[7],sunSpa.solRadExc.isFlo[6],sunSpa.solRadExc.isFlo[5],sunSpa.solRadExc.isFlo[4],sunSpa.solRadExc.isFlo[3],sunSpa.solRadExc.isFlo[2],sunSpa.solRadExc.isFlo[1],weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,TSetCoo.tab.nextTimeEventScaled,$PRE.TSetCoo.tab.nextTimeEventScaled,TSetCoo.tab.nextTimeEvent,TSetHea.tab.nextTimeEventScaled,$PRE.TSetHea.tab.nextTimeEventScaled,TSetHea.tab.nextTimeEvent,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,$whenCondition7,$whenCondition8,ECoo.local_reset,EHea.local_reset,conCoo.I.trigger_internal,conHea.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2445):
 * Single equations (assignments): 2388
 * Array equations: 36
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 20
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 19 systems
   {(1,1,100.0%), (1,1,100.0%), (5,7,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%), (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%), (17,24,17.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(11,44)}
Notification: Performance of prepare postOptimizeDAE: time 0.02996/6.385, allocations: 21.47 MB / 3.033 GB, free: 262.9 MB / 1.136 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01086/6.396, allocations: 3.99 MB / 3.037 GB, free: 261.1 MB / 1.136 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05726/6.453, allocations: 31.29 MB / 3.068 GB, free: 230 MB / 1.136 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0406/6.494, allocations: 24.64 MB / 3.092 GB, free: 205.2 MB / 1.136 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.164e-05/6.494, allocations: 7.844 kB / 3.092 GB, free: 205.2 MB / 1.136 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02434/6.518, allocations: 10.99 MB / 3.102 GB, free: 196.3 MB / 1.136 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01207/6.53, allocations: 324.6 kB / 3.103 GB, free: 196 MB / 1.136 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02677/6.557, allocations: 2.692 MB / 3.105 GB, free: 193.3 MB / 1.136 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002711/6.56, allocations: 0.7469 MB / 3.106 GB, free: 192.6 MB / 1.136 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.05782/6.618, allocations: 30.62 MB / 3.136 GB, free: 162.1 MB / 1.136 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.06896/6.687, allocations: 43.2 MB / 3.178 GB, free: 118.9 MB / 1.136 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01762/6.704, allocations: 12.54 MB / 3.19 GB, free: 106.3 MB / 1.136 GB
Notification: Performance of sorting global known variables: time 0.08159/6.786, allocations: 56.8 MB / 3.246 GB, free: 49.75 MB / 1.136 GB
Notification: Performance of Backend: time 1.112e-06/6.786, allocations: 0 / 3.246 GB, free: 49.75 MB / 1.136 GB
Notification: Performance of simCode: created initialization part: time 0.506/7.292, allocations: 105 MB / 3.349 GB, free: 396.3 MB / 1.136 GB
Notification: Performance of SimCode: time 0.1805/7.472, allocations: 127.3 MB / 3.473 GB, free: 322.7 MB / 1.136 GB
Notification: Performance of Templates: time 1.681/9.153, allocations: 0.8196 GB / 4.292 GB, free: 334.3 MB / 1.136 GB
make -j1 -f Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.makefile
(rm -f Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.pipe ; mkfifo Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.pipe ; head -c 1048576 < Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.pipe >> ../files/Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.sim & ./Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960 -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_maint.7.0.x_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.pipe 2>&1)