Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Controls.SetPoints.Validation.OccupancyScheduleNegativeStartTime.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001283/0.001283, allocations: 112.7 kB / 18.34 MB, free: 3.961 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001365/0.001365, allocations: 190 kB / 21.52 MB, free: 0.7969 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.272/1.272, allocations: 225.6 MB / 250.1 MB, free: 13.51 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.823/2.823, allocations: 496.1 MB / 0.7826 GB, free: 33.46 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-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.Controls.SetPoints.Validation.OccupancyScheduleNegativeStartTime,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|occSchDay.occupied|occSchDay1.occupied|occSchDay2.occupied|occSchDay.tNexNonOcc|occSchDay.tNexOcc|occSchDay1.tNexNonOcc|occSchDay1.tNexOcc|occSchDay2.tNexNonOcc|occSchDay2.tNexOcc",fileNamePrefix="Buildings_latest_Buildings.Controls.SetPoints.Validation.OccupancyScheduleNegativeStartTime")
translateModel(Buildings.Controls.SetPoints.Validation.OccupancyScheduleNegativeStartTime,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|occSchDay.occupied|occSchDay1.occupied|occSchDay2.occupied|occSchDay.tNexNonOcc|occSchDay.tNexOcc|occSchDay1.tNexNonOcc|occSchDay1.tNexOcc|occSchDay2.tNexNonOcc|occSchDay2.tNexOcc",fileNamePrefix="Buildings_latest_Buildings.Controls.SetPoints.Validation.OccupancyScheduleNegativeStartTime") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.415e-05/1.415e-05, allocations: 6.938 kB / 1.136 GB, free: 33.64 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.SetPoints.Validation.OccupancyScheduleNegativeStartTime): time 0.001713/0.001727, allocations: 1.504 MB / 1.138 GB, free: 32.6 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.0007937/0.002521, allocations: 0.691 MB / 1.139 GB, free: 32.14 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 2.967e-05/0.002551, allocations: 1.375 kB / 1.139 GB, free: 32.14 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 6.362e-05/0.002614, allocations: 10.05 kB / 1.139 GB, free: 32.13 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 5.074e-05/0.002665, allocations: 17.94 kB / 1.139 GB, free: 32.12 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0007021/0.003367, allocations: 349.7 kB / 1.139 GB, free: 31.97 MB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 0.0001367/0.003504, allocations: 165.6 kB / 1.139 GB, free: 31.9 MB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 4.063e-05/0.003545, allocations: 6.453 kB / 1.139 GB, free: 31.9 MB / 0.9044 GB
Notification: Performance of NFEvalConstants.evaluate: time 7.665e-05/0.003621, allocations: 73.86 kB / 1.139 GB, free: 31.88 MB / 0.9044 GB
Notification: Performance of NFSimplifyModel.simplify: time 6.931e-05/0.003691, allocations: 54.94 kB / 1.139 GB, free: 31.86 MB / 0.9044 GB
Notification: Performance of NFPackage.collectConstants: time 2.509e-05/0.003716, allocations: 13.5 kB / 1.139 GB, free: 31.86 MB / 0.9044 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0002397/0.003955, allocations: 259.4 kB / 1.14 GB, free: 31.77 MB / 0.9044 GB
Notification: Performance of combineBinaries: time 0.0001013/0.004057, allocations: 185.1 kB / 1.14 GB, free: 31.66 MB / 0.9044 GB
Notification: Performance of replaceArrayConstructors: time 2.373e-05/0.00408, allocations: 86.16 kB / 1.14 GB, free: 31.6 MB / 0.9044 GB
Notification: Performance of NFVerifyModel.verify: time 3.028e-05/0.004111, allocations: 16.06 kB / 1.14 GB, free: 31.59 MB / 0.9044 GB
Notification: Performance of FrontEnd: time 1.234e-05/0.004123, allocations: 3.344 kB / 1.14 GB, free: 31.59 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: 18 (9)
 * Number of variables: 18 (18)
Notification: Performance of Bindings: time 0.0004533/0.004576, allocations: 0.5551 MB / 1.14 GB, free: 31.12 MB / 0.9044 GB
Notification: Performance of FunctionAlias: time 7.517e-05/0.004652, allocations: 59.72 kB / 1.14 GB, free: 31.09 MB / 0.9044 GB
Notification: Performance of Early Inline: time 0.0002043/0.004856, allocations: 319.9 kB / 1.141 GB, free: 30.88 MB / 0.9044 GB
Notification: Performance of Simplify 1: time 7.636e-05/0.004932, allocations: 95.5 kB / 1.141 GB, free: 30.8 MB / 0.9044 GB
Notification: Performance of Alias: time 0.0004568/0.005389, allocations: 448 kB / 1.141 GB, free: 30.48 MB / 0.9044 GB
Notification: Performance of Simplify 2: time 5.706e-05/0.005446, allocations: 96.17 kB / 1.141 GB, free: 30.4 MB / 0.9044 GB
Notification: Performance of Remove Stream: time 4.693e-05/0.005493, allocations: 81.69 kB / 1.141 GB, free: 30.33 MB / 0.9044 GB
Notification: Performance of Detect States: time 0.0001861/0.005679, allocations: 198.9 kB / 1.142 GB, free: 30.17 MB / 0.9044 GB
Notification: Performance of Events: time 4.091e-05/0.00572, allocations: 24.59 kB / 1.142 GB, free: 30.16 MB / 0.9044 GB
Notification: Performance of Partitioning: time 7.272e-05/0.005793, allocations: 89.23 kB / 1.142 GB, free: 30.09 MB / 0.9044 GB
Notification: Performance of Causalize: time 0.0002104/0.006003, allocations: 227.1 kB / 1.142 GB, free: 29.98 MB / 0.9044 GB
Notification: Performance of After Index Reduction Inline: time 0.0001454/0.006149, allocations: 213 kB / 1.142 GB, free: 29.88 MB / 0.9044 GB
Notification: Performance of Simplify: time 0.0001166/0.006265, allocations: 127.6 kB / 1.142 GB, free: 29.75 MB / 0.9044 GB
Notification: Performance of Inline: time 9.686e-05/0.006362, allocations: 163.6 kB / 1.142 GB, free: 29.67 MB / 0.9044 GB
Notification: Performance of Partitioning: time 1.499e-05/0.006377, allocations: 20.52 kB / 1.142 GB, free: 29.65 MB / 0.9044 GB
Notification: Performance of Cleanup: time 2.53e-05/0.006402, allocations: 41.14 kB / 1.142 GB, free: 29.63 MB / 0.9044 GB
Notification: Performance of Causalize: time 0.0006614/0.007064, allocations: 0.6453 MB / 1.143 GB, free: 29.39 MB / 0.9044 GB
Notification: Performance of Tearing: time 9.688e-06/0.007073, allocations: 4.75 kB / 1.143 GB, free: 29.39 MB / 0.9044 GB
Notification: Performance of Initialization: time 3.91e-07/0.007074, allocations: 1.906 kB / 1.143 GB, free: 29.39 MB / 0.9044 GB
Notification: Performance of Remove Dummies: time 3.296e-06/0.007077, allocations: 0 / 1.143 GB, free: 29.39 MB / 0.9044 GB
Notification: Performance of Tearing: time 2.134e-06/0.007079, allocations: 7.281 kB / 1.143 GB, free: 29.39 MB / 0.9044 GB
Notification: Performance of Categorize: time 6.362e-06/0.007086, allocations: 0 / 1.143 GB, free: 29.39 MB / 0.9044 GB
Notification: Performance of Solve: time 9.004e-05/0.007176, allocations: 60.11 kB / 1.143 GB, free: 29.37 MB / 0.9044 GB
Notification: Performance of Jacobian: time 3.266e-06/0.007179, allocations: 4 kB / 1.143 GB, free: 29.37 MB / 0.9044 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: ......... 3
 * 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: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 9 (9) {occSchDay.occupied, occSchDay.tNext, occSchDay1.occupied, occSchDay1.tNext, occSchDay2.occupied, occSchDay2.tNext, $SEV_2, $SEV_1, $SEV_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: ........... 3 (scalar:3, array:0, record:0)
 * Number of multi strong components: ............ 3 (algorithm:0, when:3, 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: ........... 18 (scalar:18, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:3)
 * 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 4.699e-05/0.007226, allocations: 14.86 kB / 1.143 GB, free: 29.36 MB / 0.9044 GB
Notification: Performance of SimCode: time 0.0008556/0.008081, allocations: 1.297 MB / 1.144 GB, free: 28.41 MB / 0.9044 GB
[CodegenCFunctions.tpl:3323:11-3323:11:writable] Error: Template error: tupleReturnVariableUpdates: Unhandled expression. -(0.0 - (occSchDay2.tNexNonOcc + time)).
[CodegenCFunctions.tpl:3130:11-3130:11:writable] Error: Template error: algStmtAssignWithRhsExpStr: Unhandled lhs expression. -(0.0 - (occSchDay2.tNexOcc + time)).
[CodegenCFunctions.tpl:3323:11-3323:11:writable] Error: Template error: tupleReturnVariableUpdates: Unhandled expression. -(0.0 - (occSchDay1.tNexNonOcc + time)).
[CodegenCFunctions.tpl:3130:11-3130:11:writable] Error: Template error: algStmtAssignWithRhsExpStr: Unhandled lhs expression. -(0.0 - (occSchDay1.tNexOcc + time)).
[CodegenCFunctions.tpl:3323:11-3323:11:writable] Error: Template error: tupleReturnVariableUpdates: Unhandled expression. -(0.0 - (occSchDay.tNexNonOcc + time)).
[CodegenCFunctions.tpl:3130:11-3130:11:writable] Error: Template error: algStmtAssignWithRhsExpStr: Unhandled lhs expression. -(0.0 - (occSchDay.tNexOcc + time)).
"
[Timeout remaining time 300]
[Calling sys.exit(0), Time elapsed: 5.61028569471091]