Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.OperationMode.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.001398/0.001398, allocations: 100.4 kB / 19.72 MB, free: 2.121 MB / 14.72 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.001559/0.001559, allocations: 209.5 kB / 23.01 MB, free: 4.93 MB / 14.72 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 1.298/1.298, allocations: 230.6 MB / 256.8 MB, free: 7.805 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.814/2.814, allocations: 0.49 GB / 0.7958 GB, free: 35.43 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.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: translateModel(Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.OperationMode,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|opeModSel.yOpeMod|opeModSel.u1Occ|opeModSel.u1HigOccCoo|opeModSel.u1OccHeaHig|opeModSel.tNexOcc|opeModSel.maxCooDowTim|opeModSel.maxWarUpTim|TZonHeaSetUno.y|TZonCooSetUno.y|TZonHeaSetOcc.y|TZonCooSetOcc.y|opeModSel.TZonMin",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.OperationMode")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.OperationMode,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|opeModSel.yOpeMod|opeModSel.u1Occ|opeModSel.u1HigOccCoo|opeModSel.u1OccHeaHig|opeModSel.tNexOcc|opeModSel.maxCooDowTim|opeModSel.maxWarUpTim|TZonHeaSetUno.y|TZonCooSetUno.y|TZonHeaSetOcc.y|TZonCooSetOcc.y|opeModSel.TZonMin",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.OperationMode") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.497e-05/1.497e-05, allocations: 2.281 kB / 1.155 GB, free: 25.25 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.ZoneGroups.Validation.OperationMode): time 0.003832/0.003847, allocations: 3.483 MB / 1.158 GB, free: 22.88 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.002228/0.006075, allocations: 1.567 MB / 1.16 GB, free: 21.76 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002634/0.006339, allocations: 24.5 kB / 1.16 GB, free: 21.75 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.0002742/0.006613, allocations: 133.7 kB / 1.16 GB, free: 21.65 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 0.0002115/0.006824, allocations: 100.2 kB / 1.16 GB, free: 21.56 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0009377/0.007762, allocations: 0.5948 MB / 1.161 GB, free: 21.21 MB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 0.000899/0.008661, allocations: 1.339 MB / 1.162 GB, free: 20.54 MB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006326/0.009294, allocations: 0.5371 MB / 1.163 GB, free: 20.18 MB / 0.9044 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003895/0.009683, allocations: 497.2 kB / 1.163 GB, free: 19.9 MB / 0.9044 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003424/0.01003, allocations: 0.5309 MB / 1.164 GB, free: 19.58 MB / 0.9044 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001782/0.0102, allocations: 143.4 kB / 1.164 GB, free: 19.58 MB / 0.9044 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0002938/0.0105, allocations: 242.7 kB / 1.164 GB, free: 19.55 MB / 0.9044 GB
Notification: Performance of combineBinaries: time 0.000928/0.01143, allocations: 2.128 MB / 1.166 GB, free: 17.99 MB / 0.9044 GB
Notification: Performance of replaceArrayConstructors: time 0.0004211/0.01185, allocations: 1.291 MB / 1.167 GB, free: 17.06 MB / 0.9044 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001163/0.01196, allocations: 72.19 kB / 1.167 GB, free: 17.06 MB / 0.9044 GB
Notification: Performance of FrontEnd: time 0.0001244/0.01209, allocations: 75.03 kB / 1.167 GB, free: 17.01 MB / 0.9044 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 282 (279)
 * Number of variables: 282 (282)
Notification: Performance of [SIM] Bindings: time 0.003274/0.01536, allocations: 4.82 MB / 1.172 GB, free: 13.65 MB / 0.9044 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0006238/0.01598, allocations: 0.7802 MB / 1.173 GB, free: 13.15 MB / 0.9044 GB
Notification: Performance of [SIM] Early Inline: time 0.002784/0.01877, allocations: 3.884 MB / 1.177 GB, free: 10.72 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 1: time 0.0008201/0.01959, allocations: 0.6162 MB / 1.177 GB, free: 10.34 MB / 0.9044 GB
Notification: Performance of [SIM] Alias: time 0.006578/0.02617, allocations: 6.676 MB / 1.184 GB, free: 6.371 MB / 0.9044 GB
Notification: Performance of [SIM] Simplify 2: time 0.0004646/0.02663, allocations: 405.4 kB / 1.184 GB, free: 6.133 MB / 0.9044 GB
Notification: Performance of [SIM] Remove Stream: time 0.0002445/0.02688, allocations: 301.7 kB / 1.185 GB, free: 5.926 MB / 0.9044 GB
Notification: Performance of [SIM] Detect States: time 0.0008134/0.02769, allocations: 0.8983 MB / 1.185 GB, free: 5.301 MB / 0.9044 GB
Notification: Performance of [SIM] Events: time 0.0005899/0.02828, allocations: 0.5399 MB / 1.186 GB, free: 4.98 MB / 0.9044 GB
Notification: Performance of [SIM] Partitioning: time 0.001081/0.02936, allocations: 1.099 MB / 1.187 GB, free: 4.469 MB / 0.9044 GB
Notification: Performance of [SIM] Causalize: time 0.00283/0.03219, allocations: 2.448 MB / 1.189 GB, free: 3.883 MB / 0.9044 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001931/0.03412, allocations: 2.592 MB / 1.192 GB, free: 2.43 MB / 0.9044 GB
Notification: Performance of [INI] Simplify: time 0.001702/0.03582, allocations: 1.3 MB / 1.193 GB, free: 1.664 MB / 0.9044 GB
Notification: Performance of [INI] Inline: time 0.002931/0.03876, allocations: 3.771 MB / 1.197 GB, free: 15.44 MB / 0.92 GB
Notification: Performance of [INI] Partitioning: time 0.0001688/0.03892, allocations: 75.42 kB / 1.197 GB, free: 15.39 MB / 0.92 GB
Notification: Performance of [INI] Cleanup: time 0.0005733/0.0395, allocations: 0.5717 MB / 1.197 GB, free: 15.04 MB / 0.92 GB
Notification: Performance of [INI] Causalize: time 0.007306/0.0468, allocations: 5.464 MB / 1.203 GB, free: 13.71 MB / 0.92 GB
Notification: Performance of [INI] Tearing: time 8.284e-05/0.04689, allocations: 124.2 kB / 1.203 GB, free: 13.62 MB / 0.92 GB
Notification: Performance of [SIM] Initialization: time 1.353e-06/0.04689, allocations: 0 / 1.203 GB, free: 13.62 MB / 0.92 GB
Notification: Performance of [SIM] Remove Dummies: time 3.064e-05/0.04692, allocations: 6 kB / 1.203 GB, free: 13.62 MB / 0.92 GB
Notification: Performance of [SIM] Tearing: time 5.51e-05/0.04697, allocations: 86.06 kB / 1.203 GB, free: 13.56 MB / 0.92 GB
Notification: Performance of [SIM] Categorize: time 3.059e-05/0.047, allocations: 9.812 kB / 1.203 GB, free: 13.55 MB / 0.92 GB
Notification: Performance of [SIM] Solve: time 0.001635/0.04864, allocations: 1.123 MB / 1.204 GB, free: 13.07 MB / 0.92 GB
Notification: Performance of [SIM] Jacobian: time 1.185e-05/0.04865, allocations: 4 kB / 1.204 GB, free: 13.06 MB / 0.92 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 1
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 0 (0) {}
 * Number of discrete states: .................... 9 (9) {opeModSel.truFalHol1.entryTimeFalse, opeModSel.truFalHol1.entryTimeTrue, opeModSel.truFalHol1.y, opeModSel.truFalHol.entryTimeFalse, opeModSel.truFalHol.entryTimeTrue, opeModSel.truFalHol.y, opeModSel.booToRea6.u, opeModSel.booToRea4.u, opeModSel.booToRea3.u}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 124 (124) {opeModSel.u1HigOccCoo, opeModSel.u1OccHeaHig, opeModSel.yOpeMod, opeModSel.intGreThr.y, opeModSel.hys2.y, opeModSel.hys3.y, opeModSel.hys4.y, opeModSel.hys5.y, opeModSel.hys9.y, opeModSel.hys10.y, opeModSel.intGreThr2.y, opeModSel.addInt.y, opeModSel.addInt1.y, opeModSel.addInt2.y, opeModSel.addInt3.y, opeModSel.addInt4.y, opeModSel.occMod.y, opeModSel.setBacMod.y, opeModSel.freProSetBacMod.y, opeModSel.setUpMod.y, opeModSel.edg.u, opeModSel.truFalHol.u, opeModSel.truFalHol.not_u, opeModSel.truFalHol.not_y, opeModSel.edg1.u, opeModSel.truFalHol1.u, opeModSel.truFalHol1.not_u, opeModSel.truFalHol1.not_y, opeModSel.booToRea1.u, opeModSel.booToRea.u, opeModSel.booToInt3.y, opeModSel.and2.u1, opeModSel.and2.y, opeModSel.or1.y, opeModSel.or9.y, opeModSel.or4.y, opeModSel.or5.y, opeModSel.or6.u2, opeModSel.or6.y, opeModSel.notOcc.y, opeModSel.and3.y, opeModSel.setBacMod1.y, opeModSel.setBacMod2.y, opeModSel.and5.u1, opeModSel.and5.y, opeModSel.allCol.y, opeModSel.allHot.y, opeModSel.or2.y, opeModSel.or7.y, opeModSel.endSetBac.u, opeModSel.endSetBac.y, opeModSel.endSetUp.u, opeModSel.endSetUp.y, opeModSel.intGreThr1.y, opeModSel.addInt6.y, opeModSel.addInt7.y, opeModSel.or10.y, booToInt.u, booToInt.y, booToInt1.u, booToInt1.y, occSch.occupied, occSch.tOcc, occSch.tNext, hys3.y, hys1.y, $SEV_55, $SEV_54, $SEV_53, $SEV_52, $SEV_51, $SEV_50, $SEV_49, $SEV_48, $SEV_47, $SEV_46, $SEV_45, $SEV_44, $SEV_43, $SEV_42, $SEV_41, $SEV_40, $SEV_39, $SEV_38, $SEV_37, $SEV_36, $SEV_35, $SEV_34, $SEV_33, $SEV_32, $SEV_31, $SEV_30, $SEV_29, $SEV_28, $SEV_27, $SEV_26, $SEV_25, $SEV_24, $SEV_23, $SEV_22, $SEV_21, $SEV_20, $SEV_19, $SEV_18, $SEV_17, $SEV_16, $SEV_15, $SEV_14, $SEV_13, $SEV_12, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_1, $TEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 157 (scalar:157, array:0, record:0)
 * Number of multi strong components: ............ 10 (algorithm:0, when:10, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 235 (scalar:235, array:0, record:0)
 * Number of multi strong components: ............ 9 (algorithm:9, when:0, if:0, tuple:1)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 0.0001265/0.04878, allocations: 117.8 kB / 1.204 GB, free: 12.96 MB / 0.92 GB
Notification: Performance of SimCode: time 0.004498/0.05328, allocations: 3.643 MB / 1.208 GB, free: 11.35 MB / 0.92 GB
[CodegenCFunctions.tpl:3323:11-3323:11:writable] Error: Template error: tupleReturnVariableUpdates: Unhandled expression. -((-occSch.tNexNonOcc) - time).
"
[Timeout remaining time 300]
[Calling sys.exit(0), Time elapsed: 5.659356255084276]
Failed to read output from testmodel.py, exit status != 0:
0.07786402432247996 0.09080542800000001 0.07612036500000001
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff7b95b2f20>