Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Controls.SetPoints.Validation.OccupancySchedulePositiveStartTime.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/IDEAS 3.0.0-master/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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(IDEAS.Controls.SetPoints.Validation.OccupancySchedulePositiveStartTime,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Controls.SetPoints.Validation.OccupancySchedulePositiveStartTime")
translateModel(IDEAS.Controls.SetPoints.Validation.OccupancySchedulePositiveStartTime,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Controls.SetPoints.Validation.OccupancySchedulePositiveStartTime")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0009005/0.0009004, allocations: 111 kB / 16.42 MB, free: 6.527 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.0008613/0.0008613, allocations: 185.5 kB / 17.35 MB, free: 5.75 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.116/1.116, allocations: 222.9 MB / 241.1 MB, free: 15.15 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.6837/0.6837, allocations: 135.2 MB / 426.4 MB, free: 4.125 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 9.047e-06/9.057e-06, allocations: 2.281 kB / 0.5862 GB, free: 21.73 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Controls.SetPoints.Validation.OccupancySchedulePositiveStartTime): time 0.001519/0.001536, allocations: 1.475 MB / 0.5877 GB, free: 20.58 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.0007428/0.00229, allocations: 0.6947 MB / 0.5884 GB, free: 20.04 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 2.855e-05/0.002328, allocations: 1.469 kB / 0.5884 GB, free: 20.04 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 6.263e-05/0.002396, allocations: 9.609 kB / 0.5884 GB, free: 20.03 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 4.754e-05/0.002449, allocations: 14.19 kB / 0.5884 GB, free: 20.02 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.000652/0.00311, allocations: 340.8 kB / 0.5887 GB, free: 19.8 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0001348/0.003252, allocations: 164 kB / 0.5889 GB, free: 19.71 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 3.705e-05/0.003295, allocations: 3.75 kB / 0.5889 GB, free: 19.71 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 7.766e-05/0.003378, allocations: 71.55 kB / 0.5889 GB, free: 19.68 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 7.013e-05/0.003453, allocations: 57.09 kB / 0.589 GB, free: 19.64 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 2.795e-05/0.003487, allocations: 14.06 kB / 0.589 GB, free: 19.64 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0002364/0.003728, allocations: 254.3 kB / 0.5893 GB, free: 19.5 MB / 446.1 MB
Notification: Performance of combineBinaries: time 9.538e-05/0.003831, allocations: 159.1 kB / 0.5894 GB, free: 19.39 MB / 446.1 MB
Notification: Performance of replaceArrayConstructors: time 2.729e-05/0.003863, allocations: 85.5 kB / 0.5895 GB, free: 19.32 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 3.052e-05/0.003898, allocations: 15.69 kB / 0.5895 GB, free: 19.32 MB / 446.1 MB
Notification: Performance of FrontEnd: time 1.072e-05/0.003913, allocations: 1.438 kB / 0.5895 GB, free: 19.32 MB / 446.1 MB
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.0004202/0.004338, allocations: 0.5298 MB / 0.59 GB, free: 18.79 MB / 446.1 MB
Notification: Performance of FunctionAlias: time 5.967e-05/0.004403, allocations: 63.64 kB / 0.5901 GB, free: 18.74 MB / 446.1 MB
Notification: Performance of Early Inline: time 0.0001728/0.004582, allocations: 288.4 kB / 0.5904 GB, free: 18.43 MB / 446.1 MB
Notification: Performance of simplify1: time 3.997e-05/0.004629, allocations: 71.94 kB / 0.5904 GB, free: 18.34 MB / 446.1 MB
Notification: Performance of Alias: time 0.0003285/0.004963, allocations: 342.8 kB / 0.5908 GB, free: 17.93 MB / 446.1 MB
Notification: Performance of simplify2: time 3.266e-05/0.005004, allocations: 61.31 kB / 0.5908 GB, free: 17.84 MB / 446.1 MB
Notification: Performance of Detect States: time 9.843e-05/0.005108, allocations: 142.9 kB / 0.5909 GB, free: 17.69 MB / 446.1 MB
Notification: Performance of Events: time 0.0001225/0.005237, allocations: 124.3 kB / 0.5911 GB, free: 17.57 MB / 446.1 MB
Notification: Performance of Partitioning: time 9.048e-05/0.005335, allocations: 188.8 kB / 0.5912 GB, free: 17.3 MB / 446.1 MB
Notification: Performance of Causalize: time 0.000301/0.005642, allocations: 428.6 kB / 0.5917 GB, free: 16.8 MB / 446.1 MB
Notification: Performance of After Index Reduction Inline: time 0.0002026/0.005854, allocations: 347.8 kB / 0.592 GB, free: 16.44 MB / 446.1 MB
Notification: Performance of Inline: time 0.0002021/0.006062, allocations: 320.1 kB / 0.5923 GB, free: 16.09 MB / 446.1 MB
Notification: Performance of Partitioning: time 1.727e-05/0.006085, allocations: 33.14 kB / 0.5923 GB, free: 16.05 MB / 446.1 MB
Notification: Performance of Cleanup: time 3.581e-05/0.006126, allocations: 69.45 kB / 0.5924 GB, free: 15.99 MB / 446.1 MB
Notification: Performance of Causalize: time 0.0006527/0.006783, allocations: 0.717 MB / 0.5931 GB, free: 15.27 MB / 446.1 MB
Notification: Performance of Tearing: time 7.875e-06/0.0068, allocations: 4 kB / 0.5931 GB, free: 15.26 MB / 446.1 MB
Notification: Performance of Initialization: time 3.01e-07/0.006806, allocations: 4 kB / 0.5931 GB, free: 15.26 MB / 446.1 MB
Notification: Performance of Tearing: time 2.565e-06/0.006812, allocations: 3.938 kB / 0.5931 GB, free: 15.25 MB / 446.1 MB
Notification: Performance of Categorize: time 7.093e-06/0.006823, allocations: 4 kB / 0.5931 GB, free: 15.25 MB / 446.1 MB
Notification: Performance of Solve: time 0.0001041/0.006931, allocations: 93.45 kB / 0.5932 GB, free: 15.16 MB / 446.1 MB
Notification: Performance of Jacobian: time 1.924e-06/0.00694, allocations: 0 / 0.5932 GB, free: 15.16 MB / 446.1 MB
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: ......... 12
 * 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) {NOT YET AVAILABLE}
 * Number of discrete variables: ................. 20 (18) {occSchDay.occupied, occSchDay.tNext, occSchDay1.occupied, occSchDay1.tNext, occSchDay2.occupied, occSchDay2.tNext, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6[$i1], $SEV_5, $SEV_4, $SEV_3[$i1], $SEV_2, $SEV_1, $SEV_0[$i1]}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 11 (scalar:11, array:0, record:0)
 * Number of multi strong components: ............ 3 (algorithm:0, when:3, if:0, tuple:0)
 * Number of for-loop strong components: ......... 1 (generic: 1, 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: ........... 26 (scalar:26, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:3)
 * Number of for-loop strong components: ......... 1 (generic: 1, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 4.007e-05/0.006985, allocations: 35.92 kB / 0.5932 GB, free: 15.13 MB / 446.1 MB
Notification: Performance of SimCode: time 0.0007443/0.007734, allocations: 1.419 MB / 0.5946 GB, free: 13.69 MB / 446.1 MB
[CodegenCFunctions.tpl:3313:11-3313:11:writable] Error: Template error: tupleReturnVariableUpdates: Unhandled expression. -(0.0 - (occSchDay2.tNexNonOcc + time)).
[CodegenCFunctions.tpl:3120:11-3120:11:writable] Error: Template error: algStmtAssignWithRhsExpStr: Unhandled lhs expression. -(0.0 - (occSchDay2.tNexOcc + time)).
[CodegenCFunctions.tpl:3313:11-3313:11:writable] Error: Template error: tupleReturnVariableUpdates: Unhandled expression. -(0.0 - (occSchDay1.tNexNonOcc + time)).
[CodegenCFunctions.tpl:3120:11-3120:11:writable] Error: Template error: algStmtAssignWithRhsExpStr: Unhandled lhs expression. -(0.0 - (occSchDay1.tNexOcc + time)).
[CodegenCFunctions.tpl:3313:11-3313:11:writable] Error: Template error: tupleReturnVariableUpdates: Unhandled expression. -(0.0 - (occSchDay.tNexNonOcc + time)).
[CodegenCFunctions.tpl:3120:11-3120:11:writable] Error: Template error: algStmtAssignWithRhsExpStr: Unhandled lhs expression. -(0.0 - (occSchDay.tNexOcc + time)).