Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Controls.OBC.ASHRAE.G36_PR1.TerminalUnits.Reheat.Validation.SystemRequests.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_PR1.TerminalUnits.Reheat.Validation.SystemRequests,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|sysReq_RehBox.TZonCooSet|sysReq_RehBox.TZon|sysReq_RehBox.uCoo|sysReq_RehBox.yZonTemResReq|sysReq_RehBox.VDisSet_flow|sysReq_RehBox.VDis_flow|sysReq_RehBox.yDam_actual|sysReq_RehBox.yZonPreResReq|sysReq_RehBox.TDisHeaSet|sysReq_RehBox.TDis|sysReq_RehBox.uHeaVal|sysReq_RehBox.yHeaValResReq|sysReq_RehBox.yHeaPlaReq",fileNamePrefix="Buildings_9_Buildings.Controls.OBC.ASHRAE.G36_PR1.TerminalUnits.Reheat.Validation.SystemRequests")
translateModel(Buildings.Controls.OBC.ASHRAE.G36_PR1.TerminalUnits.Reheat.Validation.SystemRequests,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|sysReq_RehBox.TZonCooSet|sysReq_RehBox.TZon|sysReq_RehBox.uCoo|sysReq_RehBox.yZonTemResReq|sysReq_RehBox.VDisSet_flow|sysReq_RehBox.VDis_flow|sysReq_RehBox.yDam_actual|sysReq_RehBox.yZonPreResReq|sysReq_RehBox.TDisHeaSet|sysReq_RehBox.TDis|sysReq_RehBox.uHeaVal|sysReq_RehBox.yHeaValResReq|sysReq_RehBox.yHeaPlaReq",fileNamePrefix="Buildings_9_Buildings.Controls.OBC.ASHRAE.G36_PR1.TerminalUnits.Reheat.Validation.SystemRequests")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001138/0.001139, allocations: 112.2 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.001105/0.001105, allocations: 183.2 kB / 17.35 MB, free: 5.754 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.175/1.175, allocations: 222.9 MB / 241.1 MB, free: 15.2 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.962/1.962, allocations: 390.2 MB / 0.6654 GB, free: 0.6562 MB / 0.5294 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.298e-05/1.3e-05, allocations: 2.281 kB / 0.9515 GB, free: 7.719 MB / 0.7325 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36_PR1.TerminalUnits.Reheat.Validation.SystemRequests): time 0.004775/0.004798, allocations: 4.492 MB / 0.9558 GB, free: 3.199 MB / 0.7325 GB
Notification: Performance of NFInst.instExpressions: time 0.002467/0.007275, allocations: 1.805 MB / 0.9576 GB, free: 1.387 MB / 0.7325 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003048/0.00759, allocations: 23.94 kB / 0.9576 GB, free: 1.363 MB / 0.7325 GB
Notification: Performance of NFTyping.typeComponents: time 0.0003482/0.007945, allocations: 177.9 kB / 0.9578 GB, free: 1.188 MB / 0.7325 GB
Notification: Performance of NFTyping.typeBindings: time 0.000306/0.008258, allocations: 178.1 kB / 0.958 GB, free: 1.012 MB / 0.7325 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001036/0.009312, allocations: 0.7373 MB / 0.9587 GB, free: 280 kB / 0.7325 GB
Notification: Performance of NFFlatten.flatten: time 0.00137/0.01069, allocations: 1.979 MB / 0.9606 GB, free: 14.29 MB / 0.7481 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001287/0.01199, allocations: 1.451 MB / 0.962 GB, free: 12.8 MB / 0.7481 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005348/0.01253, allocations: 0.7049 MB / 0.9627 GB, free: 12.09 MB / 0.7481 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005388/0.01308, allocations: 0.7624 MB / 0.9635 GB, free: 11.32 MB / 0.7481 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002058/0.01329, allocations: 220 kB / 0.9637 GB, free: 11.11 MB / 0.7481 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0002412/0.01354, allocations: 236 kB / 0.9639 GB, free: 10.88 MB / 0.7481 GB
Notification: Performance of combineBinaries: time 0.001152/0.0147, allocations: 2.264 MB / 0.9661 GB, free: 8.582 MB / 0.7481 GB
Notification: Performance of replaceArrayConstructors: time 0.0005537/0.01526, allocations: 1.316 MB / 0.9674 GB, free: 7.246 MB / 0.7481 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001982/0.01546, allocations: 251.2 kB / 0.9676 GB, free: 7 MB / 0.7481 GB
Notification: Performance of FrontEnd: time 0.0002012/0.01567, allocations: 119 kB / 0.9678 GB, free: 6.883 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: 308 (308)
 * Number of variables: 304 (304)
Notification: Performance of Bindings: time 0.004932/0.0206, allocations: 6.826 MB / 0.9744 GB, free: 15.84 MB / 0.7637 GB
Notification: Performance of FunctionAlias: time 0.0006719/0.02128, allocations: 0.8777 MB / 0.9753 GB, free: 14.95 MB / 0.7637 GB
Notification: Performance of Early Inline: time 0.004327/0.02562, allocations: 5.728 MB / 0.9809 GB, free: 9.16 MB / 0.7637 GB
Notification: Performance of simplify1: time 0.0002871/0.02592, allocations: 367.4 kB / 0.9812 GB, free: 8.801 MB / 0.7637 GB
Notification: Performance of Alias: time 0.007725/0.03365, allocations: 8.157 MB / 0.9892 GB, free: 15.78 MB / 0.7794 GB
Notification: Performance of simplify2: time 0.0002226/0.03389, allocations: 283.5 kB / 0.9895 GB, free: 15.51 MB / 0.7794 GB
Notification: Performance of Detect States: time 0.001339/0.03523, allocations: 1.872 MB / 0.9913 GB, free: 13.59 MB / 0.7794 GB
Notification: Performance of Events: time 0.001368/0.03661, allocations: 1.371 MB / 0.9926 GB, free: 12.2 MB / 0.7794 GB
Notification: Performance of Partitioning: time 0.00142/0.03804, allocations: 1.653 MB / 0.9942 GB, free: 10.35 MB / 0.7794 GB
Notification: Performance of Causalize: time 0.005662/0.04371, allocations: 5.876 MB / 1 GB, free: 4.238 MB / 0.7794 GB
Notification: Performance of After Index Reduction Inline: time 0.003579/0.0473, allocations: 4.429 MB / 1.004 GB, free: 15.76 MB / 0.795 GB
Notification: Performance of Inline: time 0.006107/0.05341, allocations: 7.413 MB / 1.012 GB, free: 8.246 MB / 0.795 GB
Notification: Performance of Partitioning: time 0.0003545/0.05378, allocations: 359.2 kB / 1.012 GB, free: 7.863 MB / 0.795 GB
Notification: Performance of Cleanup: time 0.0002913/0.05408, allocations: 363.4 kB / 1.012 GB, free: 7.508 MB / 0.795 GB
Warning: NBResolveSingularities.balanceInitialization reports an overdetermined initialization!
Checking for consistency is not yet supported, following equations had to be removed:
        [SCAL] (1) $TEV_15 = false ($RES_SIM_43)
         slice: {};
        [SCAL] (1) $TEV_21 = false ($RES_SIM_44)
         slice: {};
        [SCAL] (1) $TEV_27 = sysReq_RehBox.edg.pre_u_start ($RES_SIM_46)
         slice: {};
        [SCAL] (1) $TEV_1 = sysReq_RehBox.hys9.pre_y_start ($RES_SIM_55)
         slice: {};
        [SCAL] (1) $TEV_3 = sysReq_RehBox.hys8.pre_y_start ($RES_SIM_57)
         slice: {};
        [SCAL] (1) $TEV_5 = sysReq_RehBox.hys7.pre_y_start ($RES_SIM_59)
         slice: {};
        [SCAL] (1) $TEV_7 = sysReq_RehBox.hys3.pre_y_start ($RES_SIM_65)
         slice: {};
        [SCAL] (1) $TEV_9 = sysReq_RehBox.hys.pre_y_start ($RES_SIM_67)
         slice: {};
        [SCAL] (1) sysReq_RehBox.truHol.outputTrue.outerStatePort.localActive = $TEV_16 ($RES_SIM_129)
         slice: {};
        [SCAL] (1) sysReq_RehBox.truHol.toInitial.outPort.set = sysReq_RehBox.truHol.initialStep.inPort[1].set ($RES_SIM_355)
         slice: {};
        [SCAL] (1) sysReq_RehBox.truHol.initialStep.outPort[1].reset = sysReq_RehBox.truHol.toOutputTrue.outPort.set ($RES_SIM_360)
         slice: {};
        [SCAL] (1) $SEV_28 = (sysReq_RehBox.truHol.toOutputTrue.localCondition and sysReq_RehBox.truHol.toOutputTrue.inPort.available) and not sysReq_RehBox.truHol.toOutputTrue.outPort.occupied ($RES_EVT_481)
         slice: {};
        [SCAL] (1) $SEV_27 = (sysReq_RehBox.truHol.toInitial.localCondition and sysReq_RehBox.truHol.toInitial.inPort.available) and not sysReq_RehBox.truHol.toInitial.outPort.occupied ($RES_EVT_480)
         slice: {};
Notification: Performance of Causalize: time 0.01491/0.06899, allocations: 14.34 MB / 1.026 GB, free: 8.844 MB / 0.8106 GB
Notification: Performance of Tearing: time 2.549e-05/0.06903, allocations: 0 / 1.026 GB, free: 8.844 MB / 0.8106 GB
Notification: Performance of Initialization: time 8.91e-07/0.06904, allocations: 0 / 1.026 GB, free: 8.844 MB / 0.8106 GB
Notification: Performance of Tearing: time 3.017e-05/0.06907, allocations: 7.938 kB / 1.026 GB, free: 8.836 MB / 0.8106 GB
Notification: Performance of Categorize: time 5.186e-05/0.06913, allocations: 11.94 kB / 1.026 GB, free: 8.824 MB / 0.8106 GB
Notification: Performance of Solve: time 0.001413/0.07055, allocations: 0.9546 MB / 1.027 GB, free: 7.844 MB / 0.8106 GB
Notification: Performance of Jacobian: time 2.655e-06/0.07056, allocations: 0 / 1.027 GB, free: 7.844 MB / 0.8106 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: ......... 24
 * 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: .................... 34 (34) {TDisHeaSet.y, TZonCooSet.y, sysReq_RehBox.sampler4.y, sysReq_RehBox.sampler4.firstTrigger, sysReq_RehBox.sampler2.y, sysReq_RehBox.sampler2.firstTrigger, sysReq_RehBox.greVDis50.u2, sysReq_RehBox.sampler1.firstTrigger, sysReq_RehBox.gai1.u, sysReq_RehBox.sampler.firstTrigger, sysReq_RehBox.tim5.y, sysReq_RehBox.tim5.t_next, sysReq_RehBox.tim4.y, sysReq_RehBox.tim4.t_next, sysReq_RehBox.tim3.t_next, sysReq_RehBox.and3.u1, sysReq_RehBox.tim2.y, sysReq_RehBox.tim2.t_next, sysReq_RehBox.tim1.y, sysReq_RehBox.tim1.t_next, sysReq_RehBox.truHol.toInitial.t_start, sysReq_RehBox.truHol.toOutputTrue.t_start, sysReq_RehBox.truHol.outputTrue.oldActive, sysReq_RehBox.truHol.initialStep.oldActive, sysReq_RehBox.truHol.onDelay.t_next, sysReq_RehBox.truHol.toInitial.localCondition, sysReq_RehBox.tim.entryTime, sysReq_RehBox.tim.passed, sysReq_RehBox.lat1.y, sysReq_RehBox.tim.u, sysReq_RehBox.triSam.y, sysReq_RehBox.uniDel.y, sysReq_RehBox.uniDel.u, sysReq_RehBox.samTZonCooSet.firstTrigger}
 * Number of clocked states: ..................... 0 (0) {NOT YET AVAILABLE}
 * Number of discrete variables: ................. 167 (167) {sysReq_RehBox.hys.y, sysReq_RehBox.hys3.y, sysReq_RehBox.hys4.y, sysReq_RehBox.hys5.y, sysReq_RehBox.hys7.y, sysReq_RehBox.hys8.y, sysReq_RehBox.hys9.y, sysReq_RehBox.hys10.y, sysReq_RehBox.hys11.y, sysReq_RehBox.samTZonCooSet.sampleTrigger, sysReq_RehBox.uniDel.sampleTrigger, sysReq_RehBox.triSam.trigger, sysReq_RehBox.hys2.y, sysReq_RehBox.reaToInt.y, sysReq_RehBox.reaToInt1.y, sysReq_RehBox.reaToInt2.y, sysReq_RehBox.reaToInt3.y, sysReq_RehBox.and1.y, sysReq_RehBox.and2.u1, sysReq_RehBox.and2.y, sysReq_RehBox.and3.u2, sysReq_RehBox.and3.y, sysReq_RehBox.and4.u2, sysReq_RehBox.and4.y, sysReq_RehBox.swi.u2, sysReq_RehBox.truHol.stateGraphRoot.activeSteps, sysReq_RehBox.truHol.initialStep.inPort.set, sysReq_RehBox.truHol.initialStep.inPort.occupied, sysReq_RehBox.truHol.initialStep.outPort.reset, sysReq_RehBox.truHol.initialStep.outPort.available, sysReq_RehBox.truHol.initialStep.outerStatePort.localActive, sysReq_RehBox.truHol.initialStep.newActive, sysReq_RehBox.truHol.outputTrue.inPort.set, sysReq_RehBox.truHol.outputTrue.inPort.occupied, sysReq_RehBox.truHol.outputTrue.outPort.reset, sysReq_RehBox.truHol.outputTrue.outPort.available, sysReq_RehBox.truHol.outputTrue.outerStatePort.localActive, sysReq_RehBox.truHol.outputTrue.newActive, sysReq_RehBox.truHol.toOutputTrue.localCondition, sysReq_RehBox.truHol.toOutputTrue.inPort.available, sysReq_RehBox.truHol.toOutputTrue.outPort.occupied, sysReq_RehBox.truHol.toOutputTrue.outPort.set, sysReq_RehBox.truHol.toInitial.inPort.available, sysReq_RehBox.truHol.toInitial.outPort.occupied, sysReq_RehBox.truHol.toInitial.outPort.set, sysReq_RehBox.sampler.sampleTrigger, sysReq_RehBox.sampler1.sampleTrigger, sysReq_RehBox.sampler2.sampleTrigger, sysReq_RehBox.sampler4.sampleTrigger, TZonCooSet.sampleTrigger, TDisHeaSet.sampleTrigger, $FUN_10, $FUN_11, $FUN_12, $FUN_13, $SEV_56, $SEV_55, $SEV_54, $SEV_53, $SEV_52, $SEV_51, $SEV_50, $SEV_49, $SEV_48, $SEV_47, $SEV_46, $SEV_45, $SEV_44, $SEV_43, $SEV_42, $SEV_41, $SEV_40, $SEV_39, $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_54, $TEV_53, $TEV_52, $TEV_51, $TEV_50, $TEV_49, $TEV_48, $TEV_47, $TEV_46, $TEV_45, $TEV_44, $TEV_43, $TEV_42, $TEV_41, $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: ........... 213 (scalar:213, array:0, record:0)
 * Number of multi strong components: ............ 34 (algorithm:0, when:34, 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: ........... 353 (scalar:353, array:0, record:0)
 * Number of multi strong components: ............ 19 (algorithm:19, 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 0.0001364/0.0707, allocations: 159.7 kB / 1.027 GB, free: 7.668 MB / 0.8106 GB
Error: Internal error NBEquation.WhenEquationBody.getBodyAttributes.getConditions failed for condition: not sysReq_RehBox.tim.u