Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartNoHeatingNoCooling.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.001428/0.001428, 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.001255/0.001255, 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.282/1.282, allocations: 225.6 MB / 250.1 MB, free: 3.195 MB / 190.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.54/2.54, allocations: 496.2 MB / 0.7826 GB, free: 12.32 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.OBC.Utilities.Validation.OptimalStartNoHeatingNoCooling,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|optSta.tOpt|optSta.optOn|TSetHea.y|TSetCoo.y|optSta.TZon",fileNamePrefix="Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartNoHeatingNoCooling")
translateModel(Buildings.Controls.OBC.Utilities.Validation.OptimalStartNoHeatingNoCooling,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|optSta.tOpt|optSta.optOn|TSetHea.y|TSetCoo.y|optSta.TZon",fileNamePrefix="Buildings_latest_Buildings.Controls.OBC.Utilities.Validation.OptimalStartNoHeatingNoCooling") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.779e-05/1.779e-05, allocations: 2.281 kB / 1.136 GB, free: 12.58 MB / 0.92 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.Utilities.Validation.OptimalStartNoHeatingNoCooling): time 0.006636/0.006654, allocations: 5.445 MB / 1.142 GB, free: 7.109 MB / 0.92 GB
Notification: Performance of NFInst.instExpressions: time 0.004283/0.01094, allocations: 2.508 MB / 1.144 GB, free: 4.59 MB / 0.92 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005639/0.0115, allocations: 39.81 kB / 1.144 GB, free: 4.551 MB / 0.92 GB
Notification: Performance of NFTyping.typeComponents: time 0.0003196/0.01182, allocations: 122.6 kB / 1.144 GB, free: 4.43 MB / 0.92 GB
Notification: Performance of NFTyping.typeBindings: time 0.0002876/0.01211, allocations: 110.9 kB / 1.145 GB, free: 4.32 MB / 0.92 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001059/0.01317, allocations: 0.502 MB / 1.145 GB, free: 3.82 MB / 0.92 GB
Notification: Performance of NFFlatten.flatten: time 0.0008976/0.01406, allocations: 0.9776 MB / 1.146 GB, free: 2.844 MB / 0.92 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004416/0.01451, allocations: 299.3 kB / 1.146 GB, free: 2.527 MB / 0.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003417/0.01485, allocations: 330.7 kB / 1.147 GB, free: 2.203 MB / 0.92 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003195/0.01517, allocations: 342.2 kB / 1.147 GB, free: 1.867 MB / 0.92 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001058/0.01527, allocations: 88 kB / 1.147 GB, free: 1.781 MB / 0.92 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0002441/0.01552, allocations: 183.8 kB / 1.147 GB, free: 1.602 MB / 0.92 GB
Notification: Performance of combineBinaries: time 0.0008592/0.01638, allocations: 1.298 MB / 1.148 GB, free: 296 kB / 0.92 GB
Notification: Performance of replaceArrayConstructors: time 0.0004548/0.01683, allocations: 0.7889 MB / 1.149 GB, free: 15.49 MB / 0.9356 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001208/0.01695, allocations: 115.6 kB / 1.149 GB, free: 15.38 MB / 0.9356 GB
Notification: Performance of FrontEnd: time 0.0001306/0.01708, allocations: 59.48 kB / 1.149 GB, free: 15.32 MB / 0.9356 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 154 (151)
 * Number of variables: 154 (152)
Notification: Performance of Bindings: time 0.002439/0.01952, allocations: 2.721 MB / 1.152 GB, free: 12.42 MB / 0.9356 GB
Notification: Performance of FunctionAlias: time 0.000245/0.01977, allocations: 266.5 kB / 1.152 GB, free: 12.16 MB / 0.9356 GB
Notification: Performance of Early Inline: time 0.00144/0.02121, allocations: 1.483 MB / 1.154 GB, free: 10.64 MB / 0.9356 GB
Notification: Performance of Simplify 1: time 0.0003643/0.02157, allocations: 307.4 kB / 1.154 GB, free: 10.3 MB / 0.9356 GB
Notification: Performance of Alias: time 0.004023/0.02559, allocations: 3.332 MB / 1.157 GB, free: 6.477 MB / 0.9356 GB
Notification: Performance of Simplify 2: time 0.0002527/0.02585, allocations: 238 kB / 1.157 GB, free: 6.219 MB / 0.9356 GB
Notification: Performance of Remove Stream: time 0.0002171/0.02606, allocations: 210.3 kB / 1.158 GB, free: 5.984 MB / 0.9356 GB
Notification: Performance of Detect States: time 0.0004998/0.02656, allocations: 404.3 kB / 1.158 GB, free: 5.551 MB / 0.9356 GB
Notification: Performance of Events: time 0.0002219/0.02678, allocations: 169 kB / 1.158 GB, free: 5.391 MB / 0.9356 GB
Notification: Performance of Partitioning: time 0.0003847/0.02717, allocations: 362.9 kB / 1.159 GB, free: 5.02 MB / 0.9356 GB
Notification: Performance of Causalize: time 0.001522/0.02869, allocations: 1.227 MB / 1.16 GB, free: 3.773 MB / 0.9356 GB
Notification: Performance of After Index Reduction Inline: time 0.0006821/0.02937, allocations: 0.6869 MB / 1.16 GB, free: 3.086 MB / 0.9356 GB
Notification: Performance of Simplify: time 0.001101/0.03048, allocations: 0.8718 MB / 1.161 GB, free: 2.152 MB / 0.9356 GB
Notification: Performance of Inline: time 0.001159/0.03163, allocations: 1.241 MB / 1.163 GB, free: 0.9062 MB / 0.9356 GB
Notification: Performance of Partitioning: time 6.698e-05/0.0317, allocations: 39.62 kB / 1.163 GB, free: 0.8594 MB / 0.9356 GB
Notification: Performance of Cleanup: time 0.0003456/0.03205, allocations: 427.4 kB / 1.163 GB, free: 448 kB / 0.9356 GB
Warning: NBResolveSingularities.balanceInitialization reports an overdetermined initialization!
Checking for consistency is not yet supported, following equations had to be removed:
	[SCAL] (1) optSta.hysSta.greHys.pre_y_start = optSta.hysSta.pre_y_start ($RES_BND_193);
Notification: Performance of Causalize: time 0.008737/0.04078, allocations: 7.031 MB / 1.17 GB, free: 9.293 MB / 0.9513 GB
Notification: Performance of Tearing: time 2.252e-05/0.04081, allocations: 3.938 kB / 1.17 GB, free: 9.289 MB / 0.9513 GB
Notification: Performance of Initialization: time 1.172e-06/0.04081, allocations: 0 / 1.17 GB, free: 9.289 MB / 0.9513 GB
Notification: Performance of Remove Dummies: time 1.155e-05/0.04082, allocations: 4.562 kB / 1.17 GB, free: 9.285 MB / 0.9513 GB
Notification: Performance of Tearing: time 4.458e-06/0.04082, allocations: 3.938 kB / 1.17 GB, free: 9.281 MB / 0.9513 GB
Notification: Performance of Categorize: time 1.547e-05/0.04084, allocations: 4 kB / 1.17 GB, free: 9.277 MB / 0.9513 GB
Notification: Performance of Solve: time 0.000543/0.04138, allocations: 259.9 kB / 1.17 GB, free: 9.02 MB / 0.9513 GB
Notification: Performance of Jacobian: time 0.0005251/0.04191, allocations: 0.5025 MB / 1.171 GB, free: 8.48 MB / 0.9513 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 1
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 0
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 3 (3) {optSta.TZon, conPID1.addPID.u2, conPID.addPID.u2}
 * Number of discrete states: .................... 1 (1) {pul.booPul.y}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 18 (18) {optSta.falEdg.y, optSta.falEdg.not_u, booToRea1.u, occSch.tOcc, occSch.tNext, TSetCoo.u, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_2, $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: ........... 61 (scalar:61, array:0, record:0)
 * Number of multi strong components: ............ 2 (algorithm:0, when:2, 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: ........... 118 (scalar:118, array:0, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, 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: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 118 (scalar:118, array:0, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, 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.0001318/0.04204, allocations: 66.75 kB / 1.171 GB, free: 8.418 MB / 0.9513 GB
Notification: Performance of SimCode: time 0.002892/0.04493, allocations: 3.017 MB / 1.174 GB, free: 5.324 MB / 0.9513 GB
[CodegenCFunctions.tpl:3323:11-3323:11:writable] Error: Template error: tupleReturnVariableUpdates: Unhandled expression. -(0.0 - (occSch.tNexNonOcc + time)).
"
[Timeout remaining time 300]
[Calling sys.exit(0), Time elapsed: 5.342755634337664]