Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_dev_ClaRa.Components.Utilities.Blocks.Check.test_1_LimPID.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtIInt 0.2.2-main/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.8.1-main/package.mo", uses=false)
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/ClaRa 1.8.2-main/package.mo", uses=false)
Using package ClaRa with version 1.8.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.8.2-main/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)
Using package TILMedia with version 1.8.1 ClaRa (/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.8.1-main/package.mo)
Using package SMArtIInt with version 0.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtIInt 0.2.2-main/package.mo)
Running command: translateModel(ClaRa.Components.Utilities.Blocks.Check.test_1_LimPID,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="CPUtime|EventCounter|PID.D_approx.Tau|der.PID.D_approx.x.|PID.D_approx.initOption|PID.D_approx.k|PID.D_approx.u|PID.D_approx.x|PID.D_approx.x_start|PID.D_approx.y|PID.D_approx.y_start|PID.I.Tau_i_const|der.PID.I.y.|PID.I.initOption|PID.I.startTime|PID.I.u|PID.I.variable_Tau_i|PID.I.y|PID.I.y_start|PID.I.y_startInputIsActive|PID.I.y_start_const|PID.I_activation.threshold|PID.I_activation.u|PID.I_activation.y|PID.I_off_zero.k|PID.I_off_zero.y|PID.Nd|PID.Ni|PID.P.k|PID.P.u|PID.P.y|PID.Tau_add|PID.Tau_d|PID.Tau_i|PID.Tau_in|PID.Tau_lag_I|PID.Tau_out|PID.activate_.y|PID.addI.k1|PID.addI.k2|PID.addI.u1|PID.addI.u2|PID.addI.y|PID.addPID.k1|PID.addPID.k2|PID.addPID.k3|PID.addPID.u1|PID.addPID.u2|PID.addPID.u3|PID.addPID.y|PID.addSat.u1|PID.addSat.u2|PID.addSat.y|PID.booleanPassThrough.u|PID.booleanPassThrough.y|PID.controlError|PID.controllerType|PID.feedback.u1|PID.feedback.u2|PID.feedback.y|PID.fromPU.k|PID.fromPU.u|PID.fromPU.y|PID.gainTrack.k|PID.gainTrack.u|PID.gainTrack.y|PID.initOption|PID.k|PID.limiter.homotopyType|PID.limiter.strict|PID.limiter.u|PID.limiter.uMax|PID.limiter.uMin|PID.limiter.y|PID.limitsAtInit|PID.perUnitConversion|PID.resetP.u1|PID.resetP.u2|PID.resetP.y|PID.resetPD.k1|PID.resetPD.k2|PID.resetPD.u1|PID.resetPD.u2|PID.resetPD.y|PID.sign|PID.smoothPIDInput.Tau|PID.smoothPIDInput.initOption|PID.smoothPIDInput.u|PID.smoothPIDInput.y|PID.smoothPIDInput.y_start|PID.smoothPIDOutput.Tau|PID.smoothPIDOutput.initOption|PID.smoothPIDOutput.u|PID.smoothPIDOutput.y|PID.smoothPIDOutput.y_start|PID.smoothPIDOutput1.Tau|PID.smoothPIDOutput1.initOption|PID.smoothPIDOutput1.u|PID.smoothPIDOutput1.y|PID.smoothPIDOutput1.y_start|PID.switch_OnOff.u1|PID.switch_OnOff.u2|PID.switch_OnOff.u3|PID.switch_OnOff.y|PID.switch_OnOff_I.u1|PID.switch_OnOff_I.u2|PID.switch_OnOff_I.u3|PID.switch_OnOff_I.y|PID.t_activation|PID.time_lag_I_activation.u|PID.time_lag_I_activation.y|PID.toPU.k|PID.toPU.u|PID.toPU.y|PID.u_m|PID.u_ref|PID.u_s|PID.use_activateInput|PID.xd_start|PID.xi_start|PID.y|PID.y_inactive|PID.y_max|PID.y_min|PID.y_ref|PID.y_start|PID.y_start_I.y|PID.y_unlocked.y|PID.y_unlocked1.y|PID.y_unlocked2.y|Time|add.k1|add.k2|add.u1|add.u2|add.y|booleanExpression.y|firstOrder.T|der.firstOrder.y.|firstOrder.initType|firstOrder.k|firstOrder.u|firstOrder.y|firstOrder.y_start|realExpression.y|sine.amplitude|sine.f|sine.offset|sine.phase|sine.startTime|sine.y",fileNamePrefix="ClaRa_dev_ClaRa.Components.Utilities.Blocks.Check.test_1_LimPID")
translateModel(ClaRa.Components.Utilities.Blocks.Check.test_1_LimPID,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="CPUtime|EventCounter|PID.D_approx.Tau|der.PID.D_approx.x.|PID.D_approx.initOption|PID.D_approx.k|PID.D_approx.u|PID.D_approx.x|PID.D_approx.x_start|PID.D_approx.y|PID.D_approx.y_start|PID.I.Tau_i_const|der.PID.I.y.|PID.I.initOption|PID.I.startTime|PID.I.u|PID.I.variable_Tau_i|PID.I.y|PID.I.y_start|PID.I.y_startInputIsActive|PID.I.y_start_const|PID.I_activation.threshold|PID.I_activation.u|PID.I_activation.y|PID.I_off_zero.k|PID.I_off_zero.y|PID.Nd|PID.Ni|PID.P.k|PID.P.u|PID.P.y|PID.Tau_add|PID.Tau_d|PID.Tau_i|PID.Tau_in|PID.Tau_lag_I|PID.Tau_out|PID.activate_.y|PID.addI.k1|PID.addI.k2|PID.addI.u1|PID.addI.u2|PID.addI.y|PID.addPID.k1|PID.addPID.k2|PID.addPID.k3|PID.addPID.u1|PID.addPID.u2|PID.addPID.u3|PID.addPID.y|PID.addSat.u1|PID.addSat.u2|PID.addSat.y|PID.booleanPassThrough.u|PID.booleanPassThrough.y|PID.controlError|PID.controllerType|PID.feedback.u1|PID.feedback.u2|PID.feedback.y|PID.fromPU.k|PID.fromPU.u|PID.fromPU.y|PID.gainTrack.k|PID.gainTrack.u|PID.gainTrack.y|PID.initOption|PID.k|PID.limiter.homotopyType|PID.limiter.strict|PID.limiter.u|PID.limiter.uMax|PID.limiter.uMin|PID.limiter.y|PID.limitsAtInit|PID.perUnitConversion|PID.resetP.u1|PID.resetP.u2|PID.resetP.y|PID.resetPD.k1|PID.resetPD.k2|PID.resetPD.u1|PID.resetPD.u2|PID.resetPD.y|PID.sign|PID.smoothPIDInput.Tau|PID.smoothPIDInput.initOption|PID.smoothPIDInput.u|PID.smoothPIDInput.y|PID.smoothPIDInput.y_start|PID.smoothPIDOutput.Tau|PID.smoothPIDOutput.initOption|PID.smoothPIDOutput.u|PID.smoothPIDOutput.y|PID.smoothPIDOutput.y_start|PID.smoothPIDOutput1.Tau|PID.smoothPIDOutput1.initOption|PID.smoothPIDOutput1.u|PID.smoothPIDOutput1.y|PID.smoothPIDOutput1.y_start|PID.switch_OnOff.u1|PID.switch_OnOff.u2|PID.switch_OnOff.u3|PID.switch_OnOff.y|PID.switch_OnOff_I.u1|PID.switch_OnOff_I.u2|PID.switch_OnOff_I.u3|PID.switch_OnOff_I.y|PID.t_activation|PID.time_lag_I_activation.u|PID.time_lag_I_activation.y|PID.toPU.k|PID.toPU.u|PID.toPU.y|PID.u_m|PID.u_ref|PID.u_s|PID.use_activateInput|PID.xd_start|PID.xi_start|PID.y|PID.y_inactive|PID.y_max|PID.y_min|PID.y_ref|PID.y_start|PID.y_start_I.y|PID.y_unlocked.y|PID.y_unlocked1.y|PID.y_unlocked2.y|Time|add.k1|add.k2|add.u1|add.u2|add.y|booleanExpression.y|firstOrder.T|der.firstOrder.y.|firstOrder.initType|firstOrder.k|firstOrder.u|firstOrder.y|firstOrder.y_start|realExpression.y|sine.amplitude|sine.f|sine.offset|sine.phase|sine.startTime|sine.y",fileNamePrefix="ClaRa_dev_ClaRa.Components.Utilities.Blocks.Check.test_1_LimPID")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtIInt 0.2.2-main/package.mo): time 0.008319/0.008319, allocations: 1.439 MB / 17.75 MB, free: 5.348 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.8.1-main/package.mo): time 0.1059/0.1059, allocations: 22.38 MB / 41.18 MB, free: 7.793 MB / 34.91 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001014/0.001014, allocations: 104 kB / 48.66 MB, free: 288 kB / 34.91 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001215/0.001215, allocations: 196.3 kB / 56.26 MB, free: 9.473 MB / 46.55 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.312/1.312, allocations: 222.9 MB / 286.6 MB, free: 13.97 MB / 222.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.8.2-main/package.mo): time 0.8214/0.8214, allocations: 127.8 MB / 471.3 MB, free: 0.5508 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.13e-05/2.129e-05, allocations: 2.281 kB / 0.6359 GB, free: 13.33 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(ClaRa.Components.Utilities.Blocks.Check.test_1_LimPID): time 0.004709/0.004739, allocations: 3.459 MB / 0.6392 GB, free: 9.852 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001981/0.006733, allocations: 0.9629 MB / 0.6402 GB, free: 8.883 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003681/0.007112, allocations: 11.94 kB / 0.6402 GB, free: 8.871 MB / 478.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002335/0.007355, allocations: 63.27 kB / 0.6403 GB, free: 8.809 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0004068/0.00779, allocations: 91.17 kB / 0.6403 GB, free: 8.719 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0006376/0.008435, allocations: 302.8 kB / 0.6406 GB, free: 8.426 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0007498/0.009194, allocations: 0.6014 MB / 0.6412 GB, free: 7.824 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003682/0.00957, allocations: 213.8 kB / 0.6414 GB, free: 7.602 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003472/0.009924, allocations: 203.1 kB / 0.6416 GB, free: 7.402 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000267/0.0102, allocations: 187 kB / 0.6418 GB, free: 7.219 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001148/0.01033, allocations: 44 kB / 0.6418 GB, free: 7.176 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 6.146e-05/0.0104, allocations: 44 kB / 0.6419 GB, free: 7.133 MB / 478.1 MB
Notification: Performance of combineBinaries: time 0.0004626/0.01087, allocations: 0.6985 MB / 0.6426 GB, free: 6.426 MB / 478.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0002619/0.01114, allocations: 464.9 kB / 0.643 GB, free: 5.965 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001007/0.01124, allocations: 67.75 kB / 0.6431 GB, free: 5.898 MB / 478.1 MB
Notification: Performance of FrontEnd: time 0.0001149/0.01136, allocations: 31.69 kB / 0.6431 GB, free: 5.867 MB / 478.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 83 (83)
 * Number of variables: 83 (83)
Notification: Performance of Bindings: time 0.001851/0.01322, allocations: 2.048 MB / 0.6451 GB, free: 3.703 MB / 478.1 MB
Notification: Performance of FunctionAlias: time 0.0001737/0.0134, allocations: 95.84 kB / 0.6452 GB, free: 3.609 MB / 478.1 MB
Notification: Performance of Early Inline: time 0.0008991/0.01431, allocations: 0.9287 MB / 0.6461 GB, free: 2.652 MB / 478.1 MB
Notification: Performance of simplify1: time 0.0001044/0.01442, allocations: 75.91 kB / 0.6462 GB, free: 2.578 MB / 478.1 MB
Notification: Performance of Alias: time 0.002345/0.01677, allocations: 2.014 MB / 0.6481 GB, free: 304 kB / 478.1 MB
Notification: Performance of simplify2: time 8.433e-05/0.01687, allocations: 51.94 kB / 0.6482 GB, free: 252 kB / 478.1 MB
Notification: Performance of Events: time 0.0001811/0.01706, allocations: 135.6 kB / 0.6483 GB, free: 116 kB / 478.1 MB
Notification: Performance of Detect States: time 0.0003768/0.01744, allocations: 298.7 kB / 0.6486 GB, free: 15.8 MB / 494.1 MB
Notification: Performance of Partitioning: time 0.0003141/0.01776, allocations: 287.9 kB / 0.6489 GB, free: 15.48 MB / 494.1 MB
Notification: Performance of Causalize: time 0.001274/0.01904, allocations: 0.9729 MB / 0.6498 GB, free: 14.47 MB / 494.1 MB
Notification: Performance of After Index Reduction Inline: time 0.0005842/0.01964, allocations: 0.6279 MB / 0.6504 GB, free: 13.82 MB / 494.1 MB
Notification: Performance of Inline: time 0.001134/0.02078, allocations: 1.106 MB / 0.6515 GB, free: 12.68 MB / 494.1 MB
Notification: Performance of Partitioning: time 8.063e-05/0.02087, allocations: 75.58 kB / 0.6516 GB, free: 12.59 MB / 494.1 MB
Notification: Performance of Cleanup: time 0.0001794/0.02106, allocations: 135.6 kB / 0.6517 GB, free: 12.46 MB / 494.1 MB
Notification: Performance of Causalize: time 0.003861/0.02492, allocations: 3.255 MB / 0.6549 GB, free: 9.184 MB / 494.1 MB
Notification: Performance of Tearing: time 1.206e-05/0.02495, allocations: 0 / 0.6549 GB, free: 9.184 MB / 494.1 MB
Notification: Performance of Initialization: time 2.134e-06/0.02496, allocations: 4 kB / 0.6549 GB, free: 9.18 MB / 494.1 MB
Notification: Performance of Tearing: time 5.19e-06/0.02497, allocations: 4 kB / 0.6549 GB, free: 9.176 MB / 494.1 MB
Notification: Performance of Categorize: time 1.162e-05/0.02498, allocations: 0 / 0.6549 GB, free: 9.176 MB / 494.1 MB
Notification: Performance of Solve: time 0.0003895/0.02537, allocations: 214.5 kB / 0.6551 GB, free: 8.965 MB / 494.1 MB
Notification: Performance of Jacobian: time 0.0006545/0.02604, allocations: 0.8517 MB / 0.6559 GB, free: 8.004 MB / 494.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: ............... 3
 * Number of algebraic event partitions: ......... 2
 * 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: ............................. 9 (9) {PID.I.y, PID.smoothPIDInput.y_aux, PID.smoothPIDOutput.y_aux, PID.smoothPIDOutput1.y_aux, PID.resetValueP, PID.resetValueID, PID.resetValueI, firstOrder.y, PID.D_approx.x}
 * Number of discrete states: .................... 1 (1) {PID.time_lag_I_activation.entryTime}
 * Number of clocked states: ..................... 0 (0) {NOT YET AVAILABLE}
 * Number of discrete variables: ................. 12 (12) {PID.activate_.y, PID.I_activation.y, booleanExpression.y, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $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: ........... 42 (scalar:42, array:0, record:0)
 * Number of multi strong components: ............ 1 (algorithm:0, when:1, 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: ........... 66 (scalar:66, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 66 (scalar:66, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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.0001367/0.02618, allocations: 53.58 kB / 0.656 GB, free: 7.961 MB / 494.1 MB
Error: Internal error NBEquation.WhenEquationBody.getBodyAttributes.getConditions failed for condition: change(PID.switch_OnOff.u2)