Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.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.MultiZone.VAV.SetPoints.Validation.PlantRequests,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|plaReq.TAirSup|plaReq.TAirSupSet|plaReq.uCooCoi_actual|plaReq.uHeaCoi_actual|plaReq.yHotWatResReq|plaReq.yHotWatPlaReq|plaReq1.TAirSup|plaReq1.TAirSupSet|plaReq1.uCooCoi_actual|plaReq1.yChiWatResReq|plaReq1.yChiPlaReq",fileNamePrefix="Buildings_9_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.PlantRequests")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.PlantRequests,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|plaReq.TAirSup|plaReq.TAirSupSet|plaReq.uCooCoi_actual|plaReq.uHeaCoi_actual|plaReq.yHotWatResReq|plaReq.yHotWatPlaReq|plaReq1.TAirSup|plaReq1.TAirSupSet|plaReq1.uCooCoi_actual|plaReq1.yChiWatResReq|plaReq1.yChiPlaReq",fileNamePrefix="Buildings_9_Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.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.001128/0.001128, allocations: 114.8 kB / 16.43 MB, free: 6.508 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.001128/0.001128, allocations: 187.2 kB / 17.36 MB, free: 5.715 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.224/1.224, 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 2.022/2.022, allocations: 390.2 MB / 0.6655 GB, free: 0.625 MB / 0.5294 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.264e-05/2.285e-05, allocations: 4.672 kB / 0.9515 GB, free: 7.629 MB / 0.7325 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.AHUs.MultiZone.VAV.SetPoints.Validation.PlantRequests): time 0.0044/0.004435, allocations: 3.527 MB / 0.955 GB, free: 4.082 MB / 0.7325 GB
Notification: Performance of NFInst.instExpressions: time 0.00337/0.00782, allocations: 2.203 MB / 0.9571 GB, free: 1.863 MB / 0.7325 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008336/0.008665, allocations: 43.75 kB / 0.9572 GB, free: 1.82 MB / 0.7325 GB
Notification: Performance of NFTyping.typeComponents: time 0.0005239/0.009198, allocations: 182.1 kB / 0.9573 GB, free: 1.641 MB / 0.7325 GB
Notification: Performance of NFTyping.typeBindings: time 0.0005178/0.009723, allocations: 134.7 kB / 0.9575 GB, free: 1.508 MB / 0.7325 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001146/0.0109, allocations: 0.5538 MB / 0.958 GB, free: 0.9531 MB / 0.7325 GB
Notification: Performance of NFFlatten.flatten: time 0.001705/0.01262, allocations: 1.633 MB / 0.9596 GB, free: 15.32 MB / 0.7481 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009515/0.01358, allocations: 0.6267 MB / 0.9602 GB, free: 14.67 MB / 0.7481 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0007316/0.01432, allocations: 0.5296 MB / 0.9607 GB, free: 14.14 MB / 0.7481 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0006448/0.01497, allocations: 0.5484 MB / 0.9613 GB, free: 13.59 MB / 0.7481 GB
Notification: Performance of NFPackage.collectConstants: time 0.000271/0.01525, allocations: 168 kB / 0.9614 GB, free: 13.42 MB / 0.7481 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001618/0.01542, allocations: 160 kB / 0.9616 GB, free: 13.27 MB / 0.7481 GB
Notification: Performance of combineBinaries: time 0.001012/0.01644, allocations: 1.665 MB / 0.9632 GB, free: 11.58 MB / 0.7481 GB
Notification: Performance of replaceArrayConstructors: time 0.0004789/0.01692, allocations: 0.9617 MB / 0.9641 GB, free: 10.61 MB / 0.7481 GB
Notification: Performance of NFVerifyModel.verify: time 0.000187/0.01711, allocations: 175.4 kB / 0.9643 GB, free: 10.43 MB / 0.7481 GB
Notification: Performance of FrontEnd: time 0.0001558/0.01727, allocations: 63.38 kB / 0.9644 GB, free: 10.37 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: 181 (181)
 * Number of variables: 181 (181)
Notification: Performance of Bindings: time 0.003851/0.02113, allocations: 4.663 MB / 0.9689 GB, free: 5.547 MB / 0.7481 GB
Notification: Performance of FunctionAlias: time 0.000157/0.02129, allocations: 199.8 kB / 0.9691 GB, free: 5.352 MB / 0.7481 GB
Notification: Performance of Early Inline: time 0.002732/0.02403, allocations: 3.3 MB / 0.9723 GB, free: 2.016 MB / 0.7481 GB
Notification: Performance of simplify1: time 0.0001991/0.02424, allocations: 219.6 kB / 0.9725 GB, free: 1.801 MB / 0.7481 GB
Notification: Performance of Alias: time 0.005277/0.02952, allocations: 5.295 MB / 0.9777 GB, free: 12.03 MB / 0.7637 GB
Notification: Performance of simplify2: time 0.0001463/0.02968, allocations: 151.7 kB / 0.9779 GB, free: 11.88 MB / 0.7637 GB
Notification: Performance of Detect States: time 0.0008407/0.03053, allocations: 1.03 MB / 0.9789 GB, free: 10.83 MB / 0.7637 GB
Notification: Performance of Events: time 0.001177/0.03171, allocations: 0.9798 MB / 0.9798 GB, free: 9.82 MB / 0.7637 GB
Notification: Performance of Partitioning: time 0.000867/0.03259, allocations: 0.8513 MB / 0.9807 GB, free: 8.957 MB / 0.7637 GB
Notification: Performance of Causalize: time 0.003144/0.03574, allocations: 2.954 MB / 0.9835 GB, free: 5.977 MB / 0.7637 GB
Notification: Performance of After Index Reduction Inline: time 0.002713/0.03847, allocations: 3.106 MB / 0.9866 GB, free: 2.832 MB / 0.7637 GB
Notification: Performance of Inline: time 0.00408/0.04256, allocations: 4.579 MB / 0.991 GB, free: 14.18 MB / 0.7794 GB
Notification: Performance of Partitioning: time 0.0002365/0.0428, allocations: 219.6 kB / 0.9913 GB, free: 13.95 MB / 0.7794 GB
Notification: Performance of Cleanup: time 0.0001894/0.043, allocations: 255.6 kB / 0.9915 GB, free: 13.7 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_339)
         slice: {};
        [SCAL] (1) plaReq1.lesThr.lesHys.pre_y_start = plaReq1.lesThr.pre_y_start ($RES_BND_337)
         slice: {};
        [SCAL] (1) plaReq1.greThr2.greHys.pre_y_start = plaReq1.greThr2.pre_y_start ($RES_BND_335)
         slice: {};
        [SCAL] (1) plaReq1.greThr1.greHys.pre_y_start = plaReq1.greThr1.pre_y_start ($RES_BND_333)
         slice: {};
        [SCAL] (1) plaReq1.greThr.greHys.pre_y_start = plaReq1.greThr.pre_y_start ($RES_BND_331)
         slice: {};
        [SCAL] (1) plaReq.lesThr3.lesHys.pre_y_start = plaReq.lesThr3.pre_y_start ($RES_BND_329)
         slice: {};
        [SCAL] (1) plaReq.greThr5.greHys.pre_y_start = plaReq.greThr5.pre_y_start ($RES_BND_327)
         slice: {};
        [SCAL] (1) plaReq.lesThr2.lesHys.pre_y_start = plaReq.lesThr2.pre_y_start ($RES_BND_325)
         slice: {};
        [SCAL] (1) plaReq.greThr4.greHys.pre_y_start = plaReq.greThr4.pre_y_start ($RES_BND_323)
         slice: {};
        [SCAL] (1) plaReq.greThr3.greHys.pre_y_start = plaReq.greThr3.pre_y_start ($RES_BND_321)
         slice: {};
        [SCAL] (1) plaReq.lesThr1.lesHys.pre_y_start = plaReq.lesThr1.pre_y_start ($RES_BND_319)
         slice: {};
        [SCAL] (1) plaReq.lesThr.lesHys.pre_y_start = plaReq.lesThr.pre_y_start ($RES_BND_317)
         slice: {};
        [SCAL] (1) plaReq.greThr2.greHys.pre_y_start = plaReq.greThr2.pre_y_start ($RES_BND_315)
         slice: {};
        [SCAL] (1) plaReq.greThr1.greHys.pre_y_start = plaReq.greThr1.pre_y_start ($RES_BND_313)
         slice: {};
        [SCAL] (1) plaReq.greThr.greHys.pre_y_start = plaReq.greThr.pre_y_start ($RES_BND_311)
         slice: {};
Notification: Performance of Causalize: time 0.009634/0.05264, allocations: 8.563 MB / 0.9999 GB, free: 4.977 MB / 0.7794 GB
Notification: Performance of Tearing: time 1.925e-05/0.05268, allocations: 4 kB / 0.9999 GB, free: 4.973 MB / 0.7794 GB
Notification: Performance of Initialization: time 8.62e-07/0.05268, allocations: 4 kB / 0.9999 GB, free: 4.969 MB / 0.7794 GB
Notification: Performance of Tearing: time 8.375e-06/0.0527, allocations: 0 / 0.9999 GB, free: 4.969 MB / 0.7794 GB
Notification: Performance of Categorize: time 2.328e-05/0.05273, allocations: 4 kB / 0.9999 GB, free: 4.965 MB / 0.7794 GB
Notification: Performance of Solve: time 0.0008205/0.05355, allocations: 0.5943 MB / 1 GB, free: 4.355 MB / 0.7794 GB
Notification: Performance of Jacobian: time 3.357e-06/0.05356, allocations: 3.938 kB / 1 GB, free: 4.352 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: ................. 105 (105) {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_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: ........... 114 (scalar:114, 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: ........... 217 (scalar:217, 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 8.898e-05/0.05365, allocations: 84.73 kB / 1.001 GB, free: 4.281 MB / 0.7794 GB
Error: Internal error NBEquation.WhenEquationBody.getBodyAttributes.getConditions failed for condition: not plaReq.truDel3.u