Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings.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.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|bui.1..zon.TAir|bui.2..zon.TAir",fileNamePrefix="Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings")
translateModel(Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|bui.1..zon.TAir|bui.2..zon.TAir",fileNamePrefix="Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001411/0.001411, allocations: 109.1 kB / 16.42 MB, free: 6.461 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.001486/0.001486, allocations: 189.5 kB / 17.35 MB, free: 5.715 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.354/1.354, allocations: 222.9 MB / 241 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.511/2.511, allocations: 461.9 MB / 0.7355 GB, free: 11.03 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.00139/0.00139, allocations: 68.06 kB / 1.055 GB, free: 7.715 MB / 0.8262 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.8352/0.8366, allocations: 157.4 MB / 1.208 GB, free: 13.62 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings): time 0.1905/1.027, allocations: 180.4 MB / 1.385 GB, free: 8.566 MB / 1.107 GB
Notification: Performance of NFInst.instExpressions: time 0.02058/1.048, allocations: 15.09 MB / 1.399 GB, free: 9.434 MB / 1.123 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00223/1.05, allocations: 43.75 kB / 1.399 GB, free: 9.391 MB / 1.123 GB
Notification: Performance of NFTyping.typeComponents: time 0.00213/1.052, allocations: 0.6749 MB / 1.4 GB, free: 8.711 MB / 1.123 GB
Notification: Performance of NFTyping.typeBindings: time 0.005736/1.058, allocations: 1.994 MB / 1.402 GB, free: 6.711 MB / 1.123 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005097/1.063, allocations: 2.069 MB / 1.404 GB, free: 4.652 MB / 1.123 GB
Notification: Performance of NFFlatten.flatten: time 0.01066/1.074, allocations: 8.886 MB / 1.413 GB, free: 11.73 MB / 1.139 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.008716/1.083, allocations: 6.457 MB / 1.419 GB, free: 5.191 MB / 1.139 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007289/1.09, allocations: 3.575 MB / 1.422 GB, free: 1.629 MB / 1.139 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004726/1.095, allocations: 2.834 MB / 1.425 GB, free: 14.79 MB / 1.154 GB
Notification: Performance of NFPackage.collectConstants: time 0.001874/1.097, allocations: 0.6914 MB / 1.426 GB, free: 14.1 MB / 1.154 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005291/1.102, allocations: 2.301 MB / 1.428 GB, free: 11.8 MB / 1.154 GB
Notification: Performance of NFScalarize.scalarize: time 0.00248/1.104, allocations: 1.656 MB / 1.43 GB, free: 10.14 MB / 1.154 GB
Notification: Performance of NFVerifyModel.verify: time 0.00481/1.109, allocations: 2.825 MB / 1.432 GB, free: 7.301 MB / 1.154 GB
Notification: Performance of NFConvertDAE.convert: time 0.01298/1.122, allocations: 10.13 MB / 1.442 GB, free: 13.14 MB / 1.17 GB
Notification: Performance of FrontEnd - DAE generated: time 7.524e-06/1.122, allocations: 0 / 1.442 GB, free: 13.14 MB / 1.17 GB
Notification: Performance of FrontEnd: time 2.315e-06/1.122, allocations: 0 / 1.442 GB, free: 13.14 MB / 1.17 GB
Notification: Performance of Transformations before backend: time 0.0002298/1.122, allocations: 4 kB / 1.442 GB, free: 13.14 MB / 1.17 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 878
 * Number of variables: 878
Notification: Performance of Generate backend data structure: time 0.01319/1.136, allocations: 5.487 MB / 1.448 GB, free: 7.531 MB / 1.17 GB
Notification: Performance of prepare preOptimizeDAE: time 4.298e-05/1.136, allocations: 12.03 kB / 1.448 GB, free: 7.52 MB / 1.17 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006303/1.142, allocations: 1.06 MB / 1.449 GB, free: 6.453 MB / 1.17 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007956/1.15, allocations: 3.986 MB / 1.453 GB, free: 2.395 MB / 1.17 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000423/1.151, allocations: 334.8 kB / 1.453 GB, free: 2.055 MB / 1.17 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001229/1.152, allocations: 360 kB / 1.453 GB, free: 1.703 MB / 1.17 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01164/1.163, allocations: 5.766 MB / 1.459 GB, free: 11.82 MB / 1.186 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.661e-05/1.164, allocations: 11.91 kB / 1.459 GB, free: 11.81 MB / 1.186 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004883/1.164, allocations: 140 kB / 1.459 GB, free: 11.67 MB / 1.186 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.885e-05/1.164, allocations: 87.98 kB / 1.459 GB, free: 11.59 MB / 1.186 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01168/1.176, allocations: 6.437 MB / 1.465 GB, free: 5.133 MB / 1.186 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.02952/1.205, allocations: 18.65 MB / 1.484 GB, free: 1.789 MB / 1.201 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006968/1.212, allocations: 4.454 MB / 1.488 GB, free: 13.2 MB / 1.217 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003588/1.216, allocations: 2.104 MB / 1.49 GB, free: 11.09 MB / 1.217 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005741/1.217, allocations: 365.8 kB / 1.49 GB, free: 10.67 MB / 1.217 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004455/1.221, allocations: 2.661 MB / 1.493 GB, free: 7.945 MB / 1.217 GB
Notification: Performance of pre-optimization done (n=288): time 5.59e-06/1.221, allocations: 0 / 1.493 GB, free: 7.945 MB / 1.217 GB
Notification: Performance of matching and sorting (n=288): time 0.01331/1.234, allocations: 6.74 MB / 1.5 GB, free: 1.141 MB / 1.217 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002523/1.235, allocations: 0.5614 MB / 1.5 GB, free: 476 kB / 1.217 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004926/1.24, allocations: 3.406 MB / 1.504 GB, free: 13.04 MB / 1.232 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007194/1.24, allocations: 137.7 kB / 1.504 GB, free: 12.9 MB / 1.232 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001482/1.242, allocations: 1.476 MB / 1.505 GB, free: 11.41 MB / 1.232 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001191/1.243, allocations: 0.9363 MB / 1.506 GB, free: 10.46 MB / 1.232 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001157/1.244, allocations: 0.7178 MB / 1.507 GB, free: 9.73 MB / 1.232 GB
Notification: Performance of setup shared object (initialization): time 9.437e-05/1.244, allocations: 301.1 kB / 1.507 GB, free: 9.434 MB / 1.232 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003391/1.248, allocations: 2.059 MB / 1.509 GB, free: 7.371 MB / 1.232 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0039/1.252, allocations: 2.629 MB / 1.512 GB, free: 4.605 MB / 1.232 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006761/1.258, allocations: 4.51 MB / 1.516 GB, free: 15.97 MB / 1.248 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.311e-05/1.258, allocations: 7.875 kB / 1.516 GB, free: 15.96 MB / 1.248 GB
Notification: Performance of matching and sorting (n=416) (initialization): time 0.009058/1.267, allocations: 5.234 MB / 1.521 GB, free: 10.7 MB / 1.248 GB
Notification: Performance of prepare postOptimizeDAE: time 6.627e-05/1.268, allocations: 63.39 kB / 1.521 GB, free: 10.63 MB / 1.248 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.229e-05/1.268, allocations: 8 kB / 1.521 GB, free: 10.62 MB / 1.248 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002824/1.268, allocations: 133.1 kB / 1.521 GB, free: 10.47 MB / 1.248 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003191/1.271, allocations: 0.7098 MB / 1.522 GB, free: 9.762 MB / 1.248 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0008295/1.272, allocations: 1.237 MB / 1.523 GB, free: 8.461 MB / 1.248 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003872/1.276, allocations: 468.8 kB / 1.524 GB, free: 8.008 MB / 1.248 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005569/1.276, allocations: 151.9 kB / 1.524 GB, free: 7.859 MB / 1.248 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 30
 * Number of states: 0 ()
 * Number of discrete variables: 108 (bui[1].zon.fmuZon.EGaiRadLast,$PRE.bui[1].zon.fmuZon.EGaiRadLast,bui[1].zon.fmuZon.tLast,$PRE.bui[1].zon.fmuZon.tLast,bui[1].zon.fmuZon.dtLast,$PRE.bui[1].zon.fmuZon.dtLast,bui[2].zon.fmuZon.EGaiRadLast,$PRE.bui[2].zon.fmuZon.EGaiRadLast,bui[2].zon.fmuZon.tLast,$PRE.bui[2].zon.fmuZon.tLast,bui[2].zon.fmuZon.dtLast,$PRE.bui[2].zon.fmuZon.dtLast,bui[2].zon.vol.computeCSen,bui[2].zon.fmuZon.nObj,bui[2].building.weaDat.conTim.canRepeatWeatherFile,bui[2].building.weaDat.conTimMin.canRepeatWeatherFile,bui[2].zon.fmuZon.QConLast_flow,$PRE.bui[2].zon.fmuZon.QConLast_flow,bui[2].zon.fmuZon.QGaiRadAve_flow,$PRE.bui[2].zon.fmuZon.QGaiRadAve_flow,bui[2].zon.fmuZon.TRooLast,$PRE.bui[2].zon.fmuZon.TRooLast,bui[2].zon.fmuZon.TAveInlet,$PRE.bui[2].zon.fmuZon.TAveInlet,bui[2].zon.fmuZon.mInlet_flow,$PRE.bui[2].zon.fmuZon.mInlet_flow,bui[2].zon.fmuZon.tNext,$PRE.bui[2].zon.fmuZon.tNext,bui[2].zon.fmuZon.yEP[5],$PRE.bui[2].zon.fmuZon.yEP[5],bui[2].zon.fmuZon.yEP[4],$PRE.bui[2].zon.fmuZon.yEP[4],bui[2].zon.fmuZon.yEP[3],$PRE.bui[2].zon.fmuZon.yEP[3],bui[2].zon.fmuZon.yEP[2],$PRE.bui[2].zon.fmuZon.yEP[2],bui[2].zon.fmuZon.yEP[1],$PRE.bui[2].zon.fmuZon.yEP[1],bui[2].zon.fmuZon.QPeo_flow,$PRE.bui[2].zon.fmuZon.QPeo_flow,bui[2].zon.fmuZon.QLat_flow,$PRE.bui[2].zon.fmuZon.QLat_flow,bui[2].zon.fmuZon.TRad,$PRE.bui[2].zon.fmuZon.TRad,bui[2].building.weaDat.decAng.tNext,$PRE.bui[2].building.weaDat.decAng.tNext,bui[2].building.weaDat.eqnTim.tNext,$PRE.bui[2].building.weaDat.eqnTim.tNext,bui[2].building.weaDat.conTim.tNext,$PRE.bui[2].building.weaDat.conTim.tNext,bui[2].building.weaDat.conTimMin.tNext,$PRE.bui[2].building.weaDat.conTimMin.tNext,bui[2].building.weaDat.locTim.tNext,$PRE.bui[2].building.weaDat.locTim.tNext,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,bui[1].zon.vol.computeCSen,bui[1].zon.fmuZon.nObj,bui[1].building.weaDat.conTim.canRepeatWeatherFile,bui[1].building.weaDat.conTimMin.canRepeatWeatherFile,bui[1].zon.fmuZon.QConLast_flow,$PRE.bui[1].zon.fmuZon.QConLast_flow,bui[1].zon.fmuZon.QGaiRadAve_flow,$PRE.bui[1].zon.fmuZon.QGaiRadAve_flow,bui[1].zon.fmuZon.TRooLast,$PRE.bui[1].zon.fmuZon.TRooLast,bui[1].zon.fmuZon.TAveInlet,$PRE.bui[1].zon.fmuZon.TAveInlet,bui[1].zon.fmuZon.mInlet_flow,$PRE.bui[1].zon.fmuZon.mInlet_flow,bui[1].zon.fmuZon.tNext,$PRE.bui[1].zon.fmuZon.tNext,bui[1].zon.fmuZon.yEP[5],$PRE.bui[1].zon.fmuZon.yEP[5],bui[1].zon.fmuZon.yEP[4],$PRE.bui[1].zon.fmuZon.yEP[4],bui[1].zon.fmuZon.yEP[3],$PRE.bui[1].zon.fmuZon.yEP[3],bui[1].zon.fmuZon.yEP[2],$PRE.bui[1].zon.fmuZon.yEP[2],bui[1].zon.fmuZon.yEP[1],$PRE.bui[1].zon.fmuZon.yEP[1],bui[1].zon.fmuZon.QPeo_flow,$PRE.bui[1].zon.fmuZon.QPeo_flow,bui[1].zon.fmuZon.QLat_flow,$PRE.bui[1].zon.fmuZon.QLat_flow,bui[1].zon.fmuZon.TRad,$PRE.bui[1].zon.fmuZon.TRad,bui[1].building.weaDat.decAng.tNext,$PRE.bui[1].building.weaDat.decAng.tNext,bui[1].building.weaDat.eqnTim.tNext,$PRE.bui[1].building.weaDat.eqnTim.tNext,bui[1].building.weaDat.conTim.tNext,$PRE.bui[1].building.weaDat.conTim.tNext,bui[1].building.weaDat.conTimMin.tNext,$PRE.bui[1].building.weaDat.conTimMin.tNext,bui[1].building.weaDat.locTim.tNext,$PRE.bui[1].building.weaDat.locTim.tNext,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (400):
 * Single equations (assignments): 394
 * Array equations: 4
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,2), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.003608/1.28, allocations: 1.903 MB / 1.526 GB, free: 5.93 MB / 1.248 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001236/1.281, allocations: 332 kB / 1.526 GB, free: 5.602 MB / 1.248 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01003/1.291, allocations: 5.099 MB / 1.531 GB, free: 496 kB / 1.248 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.007754/1.299, allocations: 4.399 MB / 1.535 GB, free: 12.02 MB / 1.264 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.776e-05/1.299, allocations: 4 kB / 1.535 GB, free: 12.02 MB / 1.264 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002561/1.302, allocations: 1.129 MB / 1.536 GB, free: 10.86 MB / 1.264 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001037/1.303, allocations: 95.95 kB / 1.536 GB, free: 10.77 MB / 1.264 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003115/1.306, allocations: 275.6 kB / 1.537 GB, free: 10.5 MB / 1.264 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006094/1.307, allocations: 278.1 kB / 1.537 GB, free: 10.23 MB / 1.264 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01103/1.318, allocations: 5.696 MB / 1.543 GB, free: 4.477 MB / 1.264 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01311/1.331, allocations: 8.104 MB / 1.55 GB, free: 12.29 MB / 1.279 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003555/1.334, allocations: 2.202 MB / 1.553 GB, free: 10.08 MB / 1.279 GB
Notification: Performance of sorting global known variables: time 0.004388/1.339, allocations: 2.368 MB / 1.555 GB, free: 7.711 MB / 1.279 GB
Notification: Performance of Backend: time 8.62e-07/1.339, allocations: 4 kB / 1.555 GB, free: 7.707 MB / 1.279 GB
Notification: Performance of simCode: created initialization part: time 0.01206/1.351, allocations: 4.133 MB / 1.559 GB, free: 3.852 MB / 1.279 GB
Notification: Performance of SimCode: time 0.5829/1.934, allocations: 9.223 MB / 1.568 GB, free: 337.6 MB / 1.279 GB
Notification: Performance of Templates: time 0.1016/2.035, allocations: 82.1 MB / 1.648 GB, free: 274.1 MB / 1.279 GB
make -j1 -f Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings.makefile
(rm -f Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings.pipe ; mkfifo Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings.pipe ; head -c 1048576 < Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings.pipe >> ../files/Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings.sim & ./Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.ThermalZones.EnergyPlus_9_6_0.Validation.MultipleBuildings.TwoIdenticalOneZoneBuildings.pipe 2>&1)