Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001283/0.001283, allocations: 80.45 kB / 19.95 MB, free: 4.602 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001376/0.001376, allocations: 169.2 kB / 23.24 MB, free: 1.316 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.8926/0.8926, allocations: 177.1 MB / 203.5 MB, free: 5.742 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 1.754/1.754, allocations: 389.6 MB / 0.6343 GB, free: 12.6 MB / 0.6042 GB
"
[Timeout remaining time 178]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960,fileNamePrefix="Buildings_13_Buildings_ThermalZones_Detailed_Validation_BESTEST_Cases9xx_Case960",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960,fileNamePrefix="Buildings_13_Buildings_ThermalZones_Detailed_Validation_BESTEST_Cases9xx_Case960",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.172e-06/1.172e-06, allocations: 0 / 1.001 GB, free: 13.39 MB / 0.9636 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.522e-05/1.639e-05, allocations: 2.281 kB / 1.001 GB, free: 13.38 MB / 0.9636 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960): time 0.6909/0.6909, allocations: 279.4 MB / 1.274 GB, free: 4.441 MB / 1.104 GB
Notification: Performance of NFInst.instExpressions: time 0.08543/0.7763, allocations: 60.2 MB / 1.332 GB, free: 8.086 MB / 1.167 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02415/0.8005, allocations: 0.9197 MB / 1.333 GB, free: 7.16 MB / 1.167 GB
Notification: Performance of NFTyping.typeComponents: time 0.02052/0.821, allocations: 10.78 MB / 1.344 GB, free: 12.33 MB / 1.182 GB
Notification: Performance of NFTyping.typeBindings: time 0.02543/0.8464, allocations: 11.85 MB / 1.355 GB, free: 432 kB / 1.182 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01764/0.8641, allocations: 9.693 MB / 1.365 GB, free: 6.734 MB / 1.198 GB
Notification: Performance of NFFlatten.flatten: time 0.0733/0.9374, allocations: 84.8 MB / 1.448 GB, free: 1.793 MB / 1.276 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0343/0.9717, allocations: 28.63 MB / 1.476 GB, free: 4.984 MB / 1.307 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.06715/1.039, allocations: 48.63 MB / 1.523 GB, free: 4.277 MB / 1.354 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.04002/1.079, allocations: 29.44 MB / 1.552 GB, free: 6.793 MB / 1.385 GB
Notification: Performance of NFPackage.collectConstants: time 0.0149/1.094, allocations: 5.754 MB / 1.558 GB, free: 1.039 MB / 1.385 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02549/1.119, allocations: 11.43 MB / 1.569 GB, free: 5.594 MB / 1.401 GB
Notification: Performance of NFScalarize.scalarize: time 1.052/2.172, allocations: 19.56 MB / 1.588 GB, free: 129.7 MB / 1.401 GB
Notification: Performance of NFVerifyModel.verify: time 0.04653/2.218, allocations: 19.64 MB / 1.607 GB, free: 129.7 MB / 1.401 GB
Notification: Performance of NFConvertDAE.convert: time 0.1147/2.333, allocations: 105.4 MB / 1.71 GB, free: 120.7 MB / 1.401 GB
Notification: Performance of FrontEnd - DAE generated: time 5.771e-06/2.333, allocations: 0 / 1.71 GB, free: 120.7 MB / 1.401 GB
Notification: Performance of FrontEnd: time 1.523e-06/2.333, allocations: 2.062 kB / 1.71 GB, free: 120.7 MB / 1.401 GB
Notification: Performance of Transformations before backend: time 0.003086/2.336, allocations: 3.984 kB / 1.71 GB, free: 120.7 MB / 1.401 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4416
 * Number of variables: 4416
Notification: Performance of Generate backend data structure: time 0.1876/2.524, allocations: 75.62 MB / 1.784 GB, free: 84.53 MB / 1.401 GB
Notification: Performance of prepare preOptimizeDAE: time 5.094e-05/2.524, allocations: 8.5 kB / 1.784 GB, free: 84.53 MB / 1.401 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0107/2.534, allocations: 2.337 MB / 1.786 GB, free: 82.89 MB / 1.401 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1182/2.653, allocations: 41 MB / 1.826 GB, free: 56.11 MB / 1.401 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.2739/2.926, allocations: 339.9 MB / 2.158 GB, free: 5.652 MB / 1.682 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001858/2.928, allocations: 3.094 MB / 2.161 GB, free: 2.203 MB / 1.682 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00884/2.937, allocations: 2.11 MB / 2.163 GB, free: 100 kB / 1.682 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.6641/3.601, allocations: 47.65 MB / 2.21 GB, free: 0.6285 GB / 1.714 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002585/3.601, allocations: 39.69 kB / 2.21 GB, free: 0.6284 GB / 1.714 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002127/3.604, allocations: 0.7026 MB / 2.21 GB, free: 0.6284 GB / 1.714 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003069/3.604, allocations: 0.6122 MB / 2.211 GB, free: 0.6284 GB / 1.714 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1134/3.717, allocations: 60.76 MB / 2.27 GB, free: 0.6215 GB / 1.714 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.3132/4.03, allocations: 251 MB / 2.515 GB, free: 440.3 MB / 1.714 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.04789/4.078, allocations: 32.99 MB / 2.548 GB, free: 407.2 MB / 1.714 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.03757/4.116, allocations: 24.38 MB / 2.571 GB, free: 382.8 MB / 1.714 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001008/4.117, allocations: 301.7 kB / 2.572 GB, free: 382.5 MB / 1.714 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.03951/4.156, allocations: 25.78 MB / 2.597 GB, free: 356.5 MB / 1.714 GB
Notification: Performance of pre-optimization done (n=1318): time 1.542e-05/4.156, allocations: 2.328 kB / 2.597 GB, free: 356.5 MB / 1.714 GB
Notification: Performance of matching and sorting (n=1318): time 0.1424/4.299, allocations: 75.73 MB / 2.671 GB, free: 281.5 MB / 1.714 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002351/4.299, allocations: 0.5569 MB / 2.671 GB, free: 280.9 MB / 1.714 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.9431/5.242, allocations: 419.6 MB / 3.081 GB, free: 0.5843 GB / 1.714 GB
Notification: Performance of collectPreVariables (initialization): time 0.00631/5.249, allocations: 485.3 kB / 3.082 GB, free: 0.5839 GB / 1.714 GB
Notification: Performance of collectInitialEqns (initialization): time 0.03301/5.282, allocations: 22.86 MB / 3.104 GB, free: 0.5661 GB / 1.714 GB
Notification: Performance of collectInitialBindings (initialization): time 0.009268/5.291, allocations: 4.722 MB / 3.109 GB, free: 0.562 GB / 1.714 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01106/5.302, allocations: 5.324 MB / 3.114 GB, free: 0.5574 GB / 1.714 GB
Notification: Performance of setup shared object (initialization): time 3.137e-05/5.302, allocations: 302.6 kB / 3.114 GB, free: 0.5571 GB / 1.714 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0426/5.344, allocations: 30.13 MB / 3.144 GB, free: 0.5345 GB / 1.714 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.05146/5.396, allocations: 38.31 MB / 3.181 GB, free: 0.5012 GB / 1.714 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0816/5.478, allocations: 56.53 MB / 3.236 GB, free: 462.5 MB / 1.714 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002004/5.478, allocations: 58.72 kB / 3.236 GB, free: 462.5 MB / 1.714 GB
Notification: Performance of matching and sorting (n=2784) (initialization): time 0.1357/5.613, allocations: 71.89 MB / 3.306 GB, free: 390.5 MB / 1.714 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003287/5.614, allocations: 209.6 kB / 3.307 GB, free: 390.2 MB / 1.714 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.1004/5.714, allocations: 58.35 MB / 3.364 GB, free: 331.7 MB / 1.714 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009996/5.724, allocations: 4.77 MB / 3.368 GB, free: 326.9 MB / 1.714 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04066/5.765, allocations: 10.15 MB / 3.378 GB, free: 316.8 MB / 1.714 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02137/5.786, allocations: 44.76 MB / 3.422 GB, free: 269.4 MB / 1.714 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04927/5.836, allocations: 10.95 MB / 3.433 GB, free: 258.4 MB / 1.714 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007532/5.843, allocations: 1.037 MB / 3.434 GB, free: 257.4 MB / 1.714 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0792/5.922, allocations: 52.42 MB / 3.485 GB, free: 204.9 MB / 1.714 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.05029/5.973, allocations: 38.23 MB / 3.522 GB, free: 163.6 MB / 1.714 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.08156/6.054, allocations: 56.39 MB / 3.577 GB, free: 104.4 MB / 1.714 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001843/6.054, allocations: 52 kB / 3.577 GB, free: 104.3 MB / 1.714 GB
Notification: Performance of matching and sorting (n=2784) (initialization_lambda0): time 0.1269/6.181, allocations: 72.29 MB / 3.648 GB, free: 31.88 MB / 1.714 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002016/6.181, allocations: 216.1 kB / 3.648 GB, free: 31.67 MB / 1.714 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.6892/6.871, allocations: 58.4 MB / 3.705 GB, free: 0.572 GB / 1.714 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0119/6.882, allocations: 4.671 MB / 3.71 GB, free: 0.5718 GB / 1.714 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.03637/6.919, allocations: 9.887 MB / 3.719 GB, free: 0.5718 GB / 1.714 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03491/6.954, allocations: 46.26 MB / 3.764 GB, free: 0.5492 GB / 1.714 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.05617/7.01, allocations: 10.41 MB / 3.775 GB, free: 0.5491 GB / 1.714 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.008965/7.019, allocations: 1.036 MB / 3.776 GB, free: 0.5491 GB / 1.714 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 878
 * Number of states: 0 ()
 * Number of discrete variables: 156 ($PRE.TSetHea.tab.nextTimeEvent,$whenCondition16,$PRE.TSetCoo.tab.nextTimeEvent,$whenCondition15,TSunSpaAnn.mode,$PRE.TSunSpaAnn.mode,$whenCondition1,TSunSpaHou.mode,$PRE.TSunSpaHou.mode,$whenCondition2,TSkyTemAnn.mode,$PRE.TSkyTemAnn.mode,$whenCondition11,TSkyTemHou.mode,$PRE.TSkyTemHou.mode,$whenCondition12,PCoo.mode,$PRE.PCoo.mode,$whenCondition13,PHea.mode,$PRE.PHea.mode,$whenCondition14,TRooAnn.mode,$PRE.TRooAnn.mode,$whenCondition17,TRooHou.mode,$PRE.TRooHou.mode,$whenCondition18,conCoo.con1.y,conHea.con1.y,sunSpa.solRadExc.is_flo[10],sunSpa.solRadExc.is_flo[9],sunSpa.solRadExc.is_flo[8],sunSpa.solRadExc.is_flo[7],sunSpa.solRadExc.is_flo[6],sunSpa.solRadExc.is_flo[5],sunSpa.solRadExc.is_flo[4],sunSpa.solRadExc.is_flo[3],sunSpa.solRadExc.is_flo[2],sunSpa.solRadExc.is_flo[1],sunSpa.bouConExtWin.HDifTil[1].incAng.decAng.k,$PRE.sunSpa.bouConExtWin.HDifTil[1].incAng.decAng.k,sunSpa.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.sunSpa.bouConExtWin.HDifTil[1].incAng.decAng.tNext,sunSpa.bouConExtWin.HDirTil[1].incAng.decAng.k,$PRE.sunSpa.bouConExtWin.HDirTil[1].incAng.decAng.k,sunSpa.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.sunSpa.bouConExtWin.HDirTil[1].incAng.decAng.tNext,sunSpa.bouConExt.HDifTil[3].incAng.decAng.k,$PRE.sunSpa.bouConExt.HDifTil[3].incAng.decAng.k,sunSpa.bouConExt.HDifTil[3].incAng.decAng.tNext,$PRE.sunSpa.bouConExt.HDifTil[3].incAng.decAng.tNext,sunSpa.bouConExt.HDifTil[2].incAng.decAng.k,$PRE.sunSpa.bouConExt.HDifTil[2].incAng.decAng.k,sunSpa.bouConExt.HDifTil[2].incAng.decAng.tNext,$PRE.sunSpa.bouConExt.HDifTil[2].incAng.decAng.tNext,sunSpa.bouConExt.HDifTil[1].incAng.decAng.k,$PRE.sunSpa.bouConExt.HDifTil[1].incAng.decAng.k,sunSpa.bouConExt.HDifTil[1].incAng.decAng.tNext,$PRE.sunSpa.bouConExt.HDifTil[1].incAng.decAng.tNext,sunSpa.bouConExt.HDirTil[3].incAng.decAng.k,$PRE.sunSpa.bouConExt.HDirTil[3].incAng.decAng.k,sunSpa.bouConExt.HDirTil[3].incAng.decAng.tNext,$PRE.sunSpa.bouConExt.HDirTil[3].incAng.decAng.tNext,sunSpa.bouConExt.HDirTil[2].incAng.decAng.k,$PRE.sunSpa.bouConExt.HDirTil[2].incAng.decAng.k,sunSpa.bouConExt.HDirTil[2].incAng.decAng.tNext,$PRE.sunSpa.bouConExt.HDirTil[2].incAng.decAng.tNext,sunSpa.bouConExt.HDirTil[1].incAng.decAng.k,$PRE.sunSpa.bouConExt.HDirTil[1].incAng.decAng.k,sunSpa.bouConExt.HDirTil[1].incAng.decAng.tNext,$PRE.sunSpa.bouConExt.HDirTil[1].incAng.decAng.tNext,TSetCoo.tab.nextTimeEventScaled,$PRE.TSetCoo.tab.nextTimeEventScaled,TSetCoo.tab.nextTimeEvent,TSetHea.tab.nextTimeEventScaled,$PRE.TSetHea.tab.nextTimeEventScaled,TSetHea.tab.nextTimeEvent,weaDat.decAng.k,$PRE.weaDat.decAng.k,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.k,$PRE.weaDat.eqnTim.k,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.k,$PRE.weaDat.conTim.k,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.k,$PRE.weaDat.conTimMin.k,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.k,$PRE.weaDat.locTim.k,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,roo.bouConExt.HDifTil[4].incAng.decAng.k,$PRE.roo.bouConExt.HDifTil[4].incAng.decAng.k,roo.bouConExt.HDifTil[4].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,roo.bouConExt.HDifTil[3].incAng.decAng.k,$PRE.roo.bouConExt.HDifTil[3].incAng.decAng.k,roo.bouConExt.HDifTil[3].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,roo.bouConExt.HDifTil[2].incAng.decAng.k,$PRE.roo.bouConExt.HDifTil[2].incAng.decAng.k,roo.bouConExt.HDifTil[2].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,roo.bouConExt.HDifTil[1].incAng.decAng.k,$PRE.roo.bouConExt.HDifTil[1].incAng.decAng.k,roo.bouConExt.HDifTil[1].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,roo.bouConExt.HDirTil[4].incAng.decAng.k,$PRE.roo.bouConExt.HDirTil[4].incAng.decAng.k,roo.bouConExt.HDirTil[4].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,roo.bouConExt.HDirTil[3].incAng.decAng.k,$PRE.roo.bouConExt.HDirTil[3].incAng.decAng.k,roo.bouConExt.HDirTil[3].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,roo.bouConExt.HDirTil[2].incAng.decAng.k,$PRE.roo.bouConExt.HDirTil[2].incAng.decAng.k,roo.bouConExt.HDirTil[2].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,roo.bouConExt.HDirTil[1].incAng.decAng.k,$PRE.roo.bouConExt.HDirTil[1].incAng.decAng.k,roo.bouConExt.HDirTil[1].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[1].incAng.decAng.tNext,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24,$whenCondition25,$whenCondition26,$whenCondition27,$whenCondition28,$whenCondition29,$whenCondition30,$whenCondition31,traSol.local_reset,gloSou.local_reset,gloHor.local_reset,ECoo.local_reset,EHea.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2642):
 * Single equations (assignments): 2615
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 20
 * 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): 17 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%), (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): 3 systems
   {(1,23), (11,44), (1,23)}
Notification: Performance of prepare postOptimizeDAE: time 0.008134/7.027, allocations: 1.729 MB / 3.777 GB, free: 0.5486 GB / 1.714 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01918/7.046, allocations: 4.665 MB / 3.782 GB, free: 0.548 GB / 1.714 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1079/7.154, allocations: 54.22 MB / 3.835 GB, free: 0.5388 GB / 1.714 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.101e-05/7.154, allocations: 127.8 kB / 3.835 GB, free: 0.5388 GB / 1.714 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.765e-05/7.154, allocations: 11.88 kB / 3.835 GB, free: 0.5388 GB / 1.714 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.07872/7.233, allocations: 45.91 MB / 3.88 GB, free: 0.5245 GB / 1.714 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1969/7.43, allocations: 107.9 MB / 3.985 GB, free: 426.9 MB / 1.714 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.625e-05/7.43, allocations: 5.094 kB / 3.985 GB, free: 426.9 MB / 1.714 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.02088/7.451, allocations: 7.229 MB / 3.992 GB, free: 419.7 MB / 1.714 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.007853/7.459, allocations: 4.025 MB / 3.996 GB, free: 415.6 MB / 1.714 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.003487/7.462, allocations: 0.5268 MB / 3.997 GB, free: 415 MB / 1.714 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02569/7.488, allocations: 53.81 MB / 4.049 GB, free: 358.4 MB / 1.714 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.226e-06/7.488, allocations: 4.094 kB / 4.049 GB, free: 358.4 MB / 1.714 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1384/7.626, allocations: 80.49 MB / 4.128 GB, free: 277.7 MB / 1.714 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.04396/7.67, allocations: 15.35 MB / 4.143 GB, free: 262.4 MB / 1.714 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01918/7.689, allocations: 0.5786 MB / 4.143 GB, free: 261.8 MB / 1.714 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.04141/7.731, allocations: 7.643 MB / 4.151 GB, free: 254.2 MB / 1.714 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.004186/7.735, allocations: 0.9247 MB / 4.152 GB, free: 253.2 MB / 1.714 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002436/7.737, allocations: 483.6 kB / 4.152 GB, free: 252.8 MB / 1.714 GB
Notification: Performance of sorting global known variables: time 0.9019/8.639, allocations: 326.5 MB / 4.471 GB, free: 0.5449 GB / 1.714 GB
Notification: Performance of sort global known variables: time 2.51e-07/8.639, allocations: 1.125 kB / 4.471 GB, free: 0.5449 GB / 1.714 GB
Notification: Performance of remove unused functions: time 0.09711/8.736, allocations: 23.65 MB / 4.494 GB, free: 0.5436 GB / 1.714 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 9
 * Number of states: 108 (gloSou.y,traSol.y,roo.conExt[1].opa.lay[1].T[1],roo.conExt[1].opa.lay[1].T[2],roo.conExt[1].opa.lay[2].T[1],roo.conExt[1].opa.lay[2].T[2],roo.conExt[1].opa.lay[2].T[3],roo.conExt[1].opa.lay[2].T[4],roo.conExt[1].opa.lay[3].T[1],roo.conExt[1].opa.lay[3].T[2],roo.conExt[2].opa.lay[1].T[1],roo.conExt[2].opa.lay[1].T[2],roo.conExt[2].opa.lay[2].T[1],roo.conExt[2].opa.lay[2].T[2],roo.conExt[2].opa.lay[3].T[1],roo.conExt[2].opa.lay[3].T[2],roo.conExt[3].opa.lay[1].T[1],roo.conExt[3].opa.lay[1].T[2],roo.conExt[3].opa.lay[2].T[1],roo.conExt[3].opa.lay[2].T[2],roo.conExt[3].opa.lay[3].T[1],roo.conExt[3].opa.lay[3].T[2],roo.conExt[4].opa.lay[1].T[1],roo.conExt[4].opa.lay[1].T[2],roo.conExt[4].opa.lay[2].T[1],roo.conExt[4].opa.lay[2].T[2],roo.conExt[4].opa.lay[3].T[1],roo.conExt[4].opa.lay[3].T[2],roo.conBou[1].opa.lay[2].T[1],roo.conBou[1].opa.lay[2].T[2],roo.conBou[1].opa.lay[2].T[3],roo.conBou[1].opa.lay[2].T[4],roo.air.vol.dynBal.medium.Xi[1],roo.air.vol.dynBal.U,roo.air.vol.dynBal.m,TRooHou.mu,TRooAnn.mu,conHea.I.y,conCoo.I.y,EHea.y,ECoo.y,PHea.mu,PCoo.mu,gloHor.y,TSkyTemHou.mu,TSkyTemAnn.mu,parWal.lay[1].T[1],parWal.lay[1].T[2],parWal.lay[1].T[3],sunSpa.conExt[1].opa.lay[1].T[1],sunSpa.conExt[1].opa.lay[1].T[2],sunSpa.conExt[1].opa.lay[2].T[1],sunSpa.conExt[1].opa.lay[2].T[2],sunSpa.conExt[1].opa.lay[2].T[3],sunSpa.conExt[1].opa.lay[2].T[4],sunSpa.conExt[1].opa.lay[3].T[1],sunSpa.conExt[1].opa.lay[3].T[2],sunSpa.conExt[2].opa.lay[1].T[1],sunSpa.conExt[2].opa.lay[1].T[2],sunSpa.conExt[2].opa.lay[2].T[1],sunSpa.conExt[2].opa.lay[2].T[2],sunSpa.conExt[2].opa.lay[3].T[1],sunSpa.conExt[2].opa.lay[3].T[2],sunSpa.conExt[2].opa.lay[3].T[3],sunSpa.conExt[2].opa.lay[3].T[4],sunSpa.conExt[2].opa.lay[3].T[5],sunSpa.conExt[2].opa.lay[3].T[6],sunSpa.conExt[2].opa.lay[3].T[7],sunSpa.conExt[2].opa.lay[3].T[8],sunSpa.conExt[2].opa.lay[3].T[9],sunSpa.conExt[3].opa.lay[1].T[1],sunSpa.conExt[3].opa.lay[1].T[2],sunSpa.conExt[3].opa.lay[2].T[1],sunSpa.conExt[3].opa.lay[2].T[2],sunSpa.conExt[3].opa.lay[3].T[1],sunSpa.conExt[3].opa.lay[3].T[2],sunSpa.conExt[3].opa.lay[3].T[3],sunSpa.conExt[3].opa.lay[3].T[4],sunSpa.conExt[3].opa.lay[3].T[5],sunSpa.conExt[3].opa.lay[3].T[6],sunSpa.conExt[3].opa.lay[3].T[7],sunSpa.conExt[3].opa.lay[3].T[8],sunSpa.conExt[3].opa.lay[3].T[9],sunSpa.conExtWin[1].opa.lay[1].T[1],sunSpa.conExtWin[1].opa.lay[1].T[2],sunSpa.conExtWin[1].opa.lay[2].T[1],sunSpa.conExtWin[1].opa.lay[2].T[2],sunSpa.conExtWin[1].opa.lay[3].T[1],sunSpa.conExtWin[1].opa.lay[3].T[2],sunSpa.conExtWin[1].opa.lay[3].T[3],sunSpa.conExtWin[1].opa.lay[3].T[4],sunSpa.conExtWin[1].opa.lay[3].T[5],sunSpa.conExtWin[1].opa.lay[3].T[6],sunSpa.conExtWin[1].opa.lay[3].T[7],sunSpa.conExtWin[1].opa.lay[3].T[8],sunSpa.conExtWin[1].opa.lay[3].T[9],sunSpa.conExtWin[1].win.capGla.TUns,sunSpa.conExtWin[1].win.capFra.T,sunSpa.conBou[1].opa.lay[2].T[1],sunSpa.conBou[1].opa.lay[2].T[2],sunSpa.conBou[1].opa.lay[2].T[3],sunSpa.conBou[1].opa.lay[2].T[4],sunSpa.conBou[1].opa.lay[2].T[5],sunSpa.air.vol.dynBal.medium.Xi[1],sunSpa.air.vol.dynBal.U,sunSpa.air.vol.dynBal.m,TSunSpaHou.mu,TSunSpaAnn.mu)
 * Number of discrete variables: 85 ($whenCondition31,$whenCondition30,$whenCondition29,$whenCondition28,$whenCondition27,$whenCondition26,$whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,roo.bouConExt.HDirTil[1].incAng.decAng.tNext,roo.bouConExt.HDirTil[1].incAng.decAng.k,roo.bouConExt.HDirTil[2].incAng.decAng.tNext,roo.bouConExt.HDirTil[2].incAng.decAng.k,roo.bouConExt.HDirTil[3].incAng.decAng.tNext,roo.bouConExt.HDirTil[3].incAng.decAng.k,roo.bouConExt.HDirTil[4].incAng.decAng.tNext,roo.bouConExt.HDirTil[4].incAng.decAng.k,roo.bouConExt.HDifTil[1].incAng.decAng.tNext,roo.bouConExt.HDifTil[1].incAng.decAng.k,roo.bouConExt.HDifTil[2].incAng.decAng.tNext,roo.bouConExt.HDifTil[2].incAng.decAng.k,roo.bouConExt.HDifTil[3].incAng.decAng.tNext,roo.bouConExt.HDifTil[3].incAng.decAng.k,roo.bouConExt.HDifTil[4].incAng.decAng.tNext,roo.bouConExt.HDifTil[4].incAng.decAng.k,weaDat.locTim.tNext,weaDat.locTim.k,weaDat.conTimMin.tNext,weaDat.conTimMin.k,weaDat.conTim.tNext,weaDat.conTim.k,weaDat.eqnTim.tNext,weaDat.eqnTim.k,weaDat.decAng.tNext,weaDat.decAng.k,TRooHou.mode,TRooAnn.mode,TSetHea.tab.nextTimeEvent,TSetHea.tab.nextTimeEventScaled,TSetCoo.tab.nextTimeEvent,TSetCoo.tab.nextTimeEventScaled,PHea.mode,PCoo.mode,TSkyTemHou.mode,TSkyTemAnn.mode,sunSpa.bouConExt.HDirTil[1].incAng.decAng.tNext,sunSpa.bouConExt.HDirTil[1].incAng.decAng.k,sunSpa.bouConExt.HDirTil[2].incAng.decAng.tNext,sunSpa.bouConExt.HDirTil[2].incAng.decAng.k,sunSpa.bouConExt.HDirTil[3].incAng.decAng.tNext,sunSpa.bouConExt.HDirTil[3].incAng.decAng.k,sunSpa.bouConExt.HDifTil[1].incAng.decAng.tNext,sunSpa.bouConExt.HDifTil[1].incAng.decAng.k,sunSpa.bouConExt.HDifTil[2].incAng.decAng.tNext,sunSpa.bouConExt.HDifTil[2].incAng.decAng.k,sunSpa.bouConExt.HDifTil[3].incAng.decAng.tNext,sunSpa.bouConExt.HDifTil[3].incAng.decAng.k,sunSpa.bouConExtWin.HDirTil[1].incAng.decAng.tNext,sunSpa.bouConExtWin.HDirTil[1].incAng.decAng.k,sunSpa.bouConExtWin.HDifTil[1].incAng.decAng.tNext,sunSpa.bouConExtWin.HDifTil[1].incAng.decAng.k,TSunSpaHou.mode,TSunSpaAnn.mode)
 * Number of discrete states: 46 (TSetHea.tab.nextTimeEvent,TSetCoo.tab.nextTimeEvent,TSetCoo.tab.nextTimeEventScaled,TSetHea.tab.nextTimeEventScaled,weaDat.conTimMin.tNext,weaDat.conTimMin.k,sunSpa.bouConExtWin.HDirTil[1].incAng.decAng.tNext,sunSpa.bouConExtWin.HDirTil[1].incAng.decAng.k,roo.bouConExt.HDirTil[1].incAng.decAng.tNext,roo.bouConExt.HDirTil[1].incAng.decAng.k,roo.bouConExt.HDifTil[1].incAng.decAng.tNext,roo.bouConExt.HDifTil[1].incAng.decAng.k,roo.bouConExt.HDirTil[2].incAng.decAng.tNext,roo.bouConExt.HDirTil[2].incAng.decAng.k,roo.bouConExt.HDifTil[2].incAng.decAng.tNext,roo.bouConExt.HDifTil[2].incAng.decAng.k,roo.bouConExt.HDirTil[3].incAng.decAng.tNext,roo.bouConExt.HDirTil[3].incAng.decAng.k,roo.bouConExt.HDifTil[3].incAng.decAng.tNext,roo.bouConExt.HDifTil[3].incAng.decAng.k,roo.bouConExt.HDirTil[4].incAng.decAng.tNext,roo.bouConExt.HDirTil[4].incAng.decAng.k,roo.bouConExt.HDifTil[4].incAng.decAng.tNext,roo.bouConExt.HDifTil[4].incAng.decAng.k,weaDat.locTim.tNext,weaDat.locTim.k,weaDat.conTim.tNext,weaDat.conTim.k,weaDat.eqnTim.tNext,weaDat.eqnTim.k,weaDat.decAng.tNext,weaDat.decAng.k,sunSpa.bouConExt.HDirTil[1].incAng.decAng.tNext,sunSpa.bouConExt.HDirTil[1].incAng.decAng.k,sunSpa.bouConExt.HDifTil[1].incAng.decAng.tNext,sunSpa.bouConExt.HDifTil[1].incAng.decAng.k,sunSpa.bouConExt.HDirTil[2].incAng.decAng.tNext,sunSpa.bouConExt.HDirTil[2].incAng.decAng.k,sunSpa.bouConExt.HDifTil[2].incAng.decAng.tNext,sunSpa.bouConExt.HDifTil[2].incAng.decAng.k,sunSpa.bouConExt.HDirTil[3].incAng.decAng.tNext,sunSpa.bouConExt.HDirTil[3].incAng.decAng.k,sunSpa.bouConExt.HDifTil[3].incAng.decAng.tNext,sunSpa.bouConExt.HDifTil[3].incAng.decAng.k,sunSpa.bouConExtWin.HDifTil[1].incAng.decAng.tNext,sunSpa.bouConExtWin.HDifTil[1].incAng.decAng.k)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1237):
 * Single equations (assignments): 1155
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 54
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 21
 * 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): 19 systems
   {(9,26,85.2%), (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,5,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%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,23), (1,23)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.1477/8.884, allocations: 83.55 MB / 4.576 GB, free: 0.5192 GB / 1.714 GB
Notification: Performance of simCode: created initialization part: time 0.152/9.036, allocations: 95.86 MB / 4.669 GB, free: 453.8 MB / 1.714 GB
Notification: Performance of simCode: created event and clocks part: time 1.111e-05/9.036, allocations: 0.5 kB / 4.669 GB, free: 453.8 MB / 1.714 GB
Notification: Performance of simCode: created simulation system equations: time 0.04167/9.078, allocations: 26.85 MB / 4.696 GB, free: 426.7 MB / 1.714 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.06888/9.147, allocations: 15.33 MB / 4.711 GB, free: 411.8 MB / 1.714 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 6.358/15.5, allocations: 1.961 GB / 6.671 GB, free: 410.7 MB / 1.714 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0462/15.55, allocations: 31.71 MB / 6.702 GB, free: 387.2 MB / 1.714 GB
Notification: Performance of simCode: alias equations: time 0.05919/15.61, allocations: 26.77 MB / 6.728 GB, free: 370.7 MB / 1.714 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.05042/15.66, allocations: 22.71 MB / 6.75 GB, free: 349.5 MB / 1.714 GB
Notification: Performance of SimCode: time 1.403e-06/15.66, allocations: 0 / 6.75 GB, free: 349.5 MB / 1.714 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 2.569/18.23, allocations: 1.486 GB / 8.236 GB, free: 143.8 MB / 1.714 GB
Notification: Performance of buildModelFMU: Generate platform static: time 114.3/132.5, allocations: 7.938 kB / 8.236 GB, free: 143.7 MB / 1.714 GB
"
[Timeout remaining time 167]
(rm -f Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.pipe ; mkfifo Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.pipe ; head -c 1048576 < Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.pipe >> ../files/Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.sim & (cd run_OMSimulator && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --stripRoot --tempDir=temp_Buildings_13_Buildings_ThermalZones_Detailed_Validation_BESTEST_Cases9xx_Case960_fmu --startTime=0 --stopTime=3.1536e+07 --stepSize=3600 --timeout=50 --tolerance=1e-06 ../Buildings_13_Buildings_ThermalZones_Detailed_Validation_BESTEST_Cases9xx_Case960.fmu) > Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960.pipe 2>&1) [Timeout 52.5]
(rm -f Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960_fmpy.pipe ; mkfifo Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960_fmpy.pipe ; head -c 1048576 < Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960_fmpy.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960_fmpy.sim & (cd run_fmpy && python3 -m fmpy simulate --output-file ../Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960_fmpy_res.csv --start-time 0 --stop-time 3.1536e+07 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 3600 ../Buildings_13_Buildings_ThermalZones_Detailed_Validation_BESTEST_Cases9xx_Case960.fmu) > Buildings_13_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case960_fmpy.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 227.30755123402923]