Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.PlantRequests.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/Buildings 9.1.3-maint.9.1.x/package.mo", uses=false)
Using package Buildings with version 9.1.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/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.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.PlantRequests,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|plaReq.TAirSup|plaReq.TSupHeaEco|plaReq.uCooCoi_actual|plaReq.uHeaCoi_actual|plaReq.yHotWatResReq|plaReq.yHotWatPlaReq|plaReq1.TAirSup|plaReq1.TSupCoo|plaReq1.uCooCoi_actual|plaReq1.yChiWatResReq|plaReq1.yChiPlaReq",fileNamePrefix="Buildings_9_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.PlantRequests")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.PlantRequests,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|plaReq.TAirSup|plaReq.TSupHeaEco|plaReq.uCooCoi_actual|plaReq.uHeaCoi_actual|plaReq.yHotWatResReq|plaReq.yHotWatPlaReq|plaReq1.TAirSup|plaReq1.TSupCoo|plaReq1.uCooCoi_actual|plaReq1.yChiWatResReq|plaReq1.yChiPlaReq",fileNamePrefix="Buildings_9_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.PlantRequests")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001083/0.001083, allocations: 110.8 kB / 16.42 MB, free: 6.461 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.001072/0.001072, allocations: 190 kB / 17.36 MB, free: 5.699 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.213/1.213, allocations: 222.9 MB / 241 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/package.mo): time 1.952/1.952, allocations: 390.2 MB / 0.6655 GB, free: 0.6328 MB / 0.5294 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.337e-05/1.339e-05, allocations: 2.281 kB / 0.9515 GB, free: 7.648 MB / 0.7325 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.PlantRequests): time 0.003793/0.003815, allocations: 3.581 MB / 0.955 GB, free: 4.051 MB / 0.7325 GB
Notification: Performance of NFInst.instExpressions: time 0.002538/0.006364, allocations: 2.226 MB / 0.9572 GB, free: 1.809 MB / 0.7325 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003031/0.006677, allocations: 43.75 kB / 0.9572 GB, free: 1.766 MB / 0.7325 GB
Notification: Performance of NFTyping.typeComponents: time 0.0003347/0.007018, allocations: 182.1 kB / 0.9574 GB, free: 1.586 MB / 0.7325 GB
Notification: Performance of NFTyping.typeBindings: time 0.0002375/0.007264, allocations: 138.7 kB / 0.9575 GB, free: 1.449 MB / 0.7325 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0007081/0.007979, allocations: 0.5578 MB / 0.9581 GB, free: 0.8906 MB / 0.7325 GB
Notification: Performance of NFFlatten.flatten: time 0.001148/0.009135, allocations: 1.668 MB / 0.9597 GB, free: 15.22 MB / 0.7481 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006786/0.009828, allocations: 0.6229 MB / 0.9603 GB, free: 14.57 MB / 0.7481 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0004047/0.01024, allocations: 0.5451 MB / 0.9609 GB, free: 14.03 MB / 0.7481 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003988/0.01065, allocations: 0.5601 MB / 0.9614 GB, free: 13.46 MB / 0.7481 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001672/0.01082, allocations: 164 kB / 0.9616 GB, free: 13.3 MB / 0.7481 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001382/0.01096, allocations: 164 kB / 0.9617 GB, free: 13.14 MB / 0.7481 GB
Notification: Performance of combineBinaries: time 0.000882/0.01185, allocations: 1.684 MB / 0.9634 GB, free: 11.44 MB / 0.7481 GB
Notification: Performance of replaceArrayConstructors: time 0.0004104/0.01227, allocations: 0.9808 MB / 0.9643 GB, free: 10.45 MB / 0.7481 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001494/0.01242, allocations: 183.4 kB / 0.9645 GB, free: 10.27 MB / 0.7481 GB
Notification: Performance of FrontEnd: time 9.508e-05/0.01252, allocations: 59.44 kB / 0.9645 GB, free: 10.21 MB / 0.7481 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 183 (183)
 * Number of variables: 183 (183)
Notification: Performance of Bindings: time 0.003582/0.01611, allocations: 4.718 MB / 0.9692 GB, free: 5.328 MB / 0.7481 GB
Notification: Performance of FunctionAlias: time 0.0001759/0.01629, allocations: 219.7 kB / 0.9694 GB, free: 5.113 MB / 0.7481 GB
Notification: Performance of Early Inline: time 0.002967/0.01927, allocations: 3.343 MB / 0.9726 GB, free: 1.734 MB / 0.7481 GB
Notification: Performance of simplify1: time 0.0002007/0.01947, allocations: 219.6 kB / 0.9728 GB, free: 1.52 MB / 0.7481 GB
Notification: Performance of Alias: time 0.005025/0.02451, allocations: 5.338 MB / 0.978 GB, free: 11.7 MB / 0.7637 GB
Notification: Performance of simplify2: time 0.0001282/0.02464, allocations: 163.7 kB / 0.9782 GB, free: 11.54 MB / 0.7637 GB
Notification: Performance of Detect States: time 0.0007637/0.02542, allocations: 1.03 MB / 0.9792 GB, free: 10.48 MB / 0.7637 GB
Notification: Performance of Events: time 0.001077/0.0265, allocations: 1.008 MB / 0.9802 GB, free: 9.449 MB / 0.7637 GB
Notification: Performance of Partitioning: time 0.0007679/0.02728, allocations: 0.8669 MB / 0.981 GB, free: 8.57 MB / 0.7637 GB
Notification: Performance of Causalize: time 0.002956/0.03024, allocations: 2.99 MB / 0.984 GB, free: 5.555 MB / 0.7637 GB
Notification: Performance of After Index Reduction Inline: time 0.002443/0.03269, allocations: 3.153 MB / 0.987 GB, free: 2.363 MB / 0.7637 GB
Notification: Performance of Inline: time 0.003853/0.03656, allocations: 4.653 MB / 0.9916 GB, free: 13.64 MB / 0.7794 GB
Notification: Performance of Partitioning: time 0.0002163/0.03678, allocations: 219.6 kB / 0.9918 GB, free: 13.41 MB / 0.7794 GB
Notification: Performance of Cleanup: time 0.0001751/0.03696, allocations: 259.6 kB / 0.992 GB, free: 13.15 MB / 0.7794 GB
Warning: NBResolveSingularities.balanceInitialization reports an overdetermined initialization!
Checking for consistency is not yet supported, following equations had to be removed:
        [SCAL] (1) $TEV_1 = false ($RES_SIM_5)
         slice: {};
        [SCAL] (1) $TEV_10 = false ($RES_SIM_22)
         slice: {};
        [SCAL] (1) $TEV_19 = false ($RES_SIM_39)
         slice: {};
        [SCAL] (1) plaReq1.lesThr1.lesHys.pre_y_start = plaReq1.lesThr1.pre_y_start ($RES_BND_343)
         slice: {};
        [SCAL] (1) plaReq1.lesThr.lesHys.pre_y_start = plaReq1.lesThr.pre_y_start ($RES_BND_341)
         slice: {};
        [SCAL] (1) plaReq1.greThr2.greHys.pre_y_start = plaReq1.greThr2.pre_y_start ($RES_BND_339)
         slice: {};
        [SCAL] (1) plaReq1.greThr1.greHys.pre_y_start = plaReq1.greThr1.pre_y_start ($RES_BND_337)
         slice: {};
        [SCAL] (1) plaReq1.greThr.greHys.pre_y_start = plaReq1.greThr.pre_y_start ($RES_BND_335)
         slice: {};
        [SCAL] (1) plaReq.lesThr3.lesHys.pre_y_start = plaReq.lesThr3.pre_y_start ($RES_BND_333)
         slice: {};
        [SCAL] (1) plaReq.greThr5.greHys.pre_y_start = plaReq.greThr5.pre_y_start ($RES_BND_331)
         slice: {};
        [SCAL] (1) plaReq.lesThr2.lesHys.pre_y_start = plaReq.lesThr2.pre_y_start ($RES_BND_329)
         slice: {};
        [SCAL] (1) plaReq.greThr4.greHys.pre_y_start = plaReq.greThr4.pre_y_start ($RES_BND_327)
         slice: {};
        [SCAL] (1) plaReq.greThr3.greHys.pre_y_start = plaReq.greThr3.pre_y_start ($RES_BND_325)
         slice: {};
        [SCAL] (1) plaReq.lesThr1.lesHys.pre_y_start = plaReq.lesThr1.pre_y_start ($RES_BND_323)
         slice: {};
        [SCAL] (1) plaReq.lesThr.lesHys.pre_y_start = plaReq.lesThr.pre_y_start ($RES_BND_321)
         slice: {};
        [SCAL] (1) plaReq.greThr2.greHys.pre_y_start = plaReq.greThr2.pre_y_start ($RES_BND_319)
         slice: {};
        [SCAL] (1) plaReq.greThr1.greHys.pre_y_start = plaReq.greThr1.pre_y_start ($RES_BND_317)
         slice: {};
        [SCAL] (1) plaReq.greThr.greHys.pre_y_start = plaReq.greThr.pre_y_start ($RES_BND_315)
         slice: {};
Notification: Performance of Causalize: time 0.008699/0.04567, allocations: 8.642 MB / 1 GB, free: 4.352 MB / 0.7794 GB
Notification: Performance of Tearing: time 1.895e-05/0.0457, allocations: 0 / 1 GB, free: 4.352 MB / 0.7794 GB
Notification: Performance of Initialization: time 6.71e-07/0.04571, allocations: 0 / 1 GB, free: 4.352 MB / 0.7794 GB
Notification: Performance of Tearing: time 8.196e-06/0.04572, allocations: 0 / 1 GB, free: 4.352 MB / 0.7794 GB
Notification: Performance of Categorize: time 1.655e-05/0.04574, allocations: 4 kB / 1 GB, free: 4.348 MB / 0.7794 GB
Notification: Performance of Solve: time 0.0007643/0.04651, allocations: 0.5982 MB / 1.001 GB, free: 3.734 MB / 0.7794 GB
Notification: Performance of Jacobian: time 2.795e-06/0.04652, allocations: 0 / 1.001 GB, free: 3.734 MB / 0.7794 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: ......... 2
 * 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: .................... 18 (18) {plaReq1.lat1.y, plaReq1.lat.y, plaReq1.truDel1.t_next, plaReq1.truDel1.y, plaReq1.truDel.y, plaReq1.truDel.t_next, plaReq.lat3.y, plaReq.lat2.y, plaReq.truDel3.t_next, plaReq.truDel3.y, plaReq.truDel2.t_next, plaReq.truDel2.y, plaReq.lat1.y, plaReq.lat.y, plaReq.truDel1.y, plaReq.truDel1.t_next, plaReq.truDel.t_next, plaReq.truDel.y}
 * Number of clocked states: ..................... 0 (0) {NOT YET AVAILABLE}
 * Number of discrete variables: ................. 107 (107) {plaReq.truDel.u, plaReq.truDel1.u, plaReq.chiWatRes3.y, plaReq.chiWatRes2.y, plaReq.lat.u, plaReq.lat.clr, plaReq.chiWatRes1.y, plaReq.lat1.clr, plaReq.intSwi3.y, plaReq.truDel2.u, plaReq.truDel3.u, plaReq.hotWatRes3.y, plaReq.hotWatRes2.y, plaReq.lat2.u, plaReq.lat2.clr, plaReq.hotWatRes1.y, plaReq.lat3.clr, plaReq.intSwi1.y, plaReq1.truDel.u, plaReq1.truDel1.u, plaReq1.chiWatRes3.y, plaReq1.chiWatRes2.y, plaReq1.lat.u, plaReq1.lat.clr, plaReq1.chiWatRes1.y, plaReq1.lat1.clr, plaReq1.intSwi3.y, $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_40, $TEV_39, $TEV_38, $TEV_37, $TEV_36, $TEV_35, $TEV_34, $TEV_33, $TEV_32, $TEV_31, $TEV_30, $TEV_29, $TEV_28, $TEV_27, $TEV_26, $TEV_25, $TEV_24, $TEV_23, $TEV_22, $TEV_21, $TEV_20, $TEV_19, $TEV_18, $TEV_17, $TEV_16, $TEV_15, $TEV_14, $TEV_13, $TEV_12, $TEV_11, $TEV_10, $TEV_9, $TEV_8, $TEV_7, $TEV_6, $TEV_5, $TEV_4, $TEV_3, $TEV_2, $TEV_1, $TEV_0}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 117 (scalar:117, array:0, record:0)
 * Number of multi strong components: ............ 18 (algorithm:0, when:18, if:0, tuple:0)
 * Number of for-loop strong components: ......... 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: ........... 220 (scalar:220, array:0, record:0)
 * Number of multi strong components: ............ 18 (algorithm:18, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 7.997e-05/0.0466, allocations: 94.56 kB / 1.001 GB, free: 3.652 MB / 0.7794 GB
Error: Internal error NBEquation.WhenEquationBody.getBodyAttributes.getConditions failed for condition: not plaReq.truDel3.u