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.008185/0.008185, allocations: 1.438 MB / 17.75 MB, free: 5.344 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.8.1-main/package.mo): time 0.102/0.102, allocations: 22.37 MB / 41.17 MB, free: 7.781 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.0009625/0.0009626, allocations: 108 kB / 48.66 MB, free: 268 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.001084/0.001084, allocations: 188.5 kB / 56.26 MB, free: 9.48 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.204/1.204, allocations: 222.9 MB / 286.6 MB, free: 13.96 MB / 222.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.8.2-main/package.mo): time 0.7778/0.7778, allocations: 127.8 MB / 471.3 MB, free: 0.5859 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.554e-05/1.555e-05, allocations: 2.281 kB / 0.6359 GB, free: 13.34 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(ClaRa.Components.Utilities.Blocks.Check.test_1_LimPID): time 0.004003/0.004028, allocations: 3.455 MB / 0.6392 GB, free: 9.863 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001725/0.005765, allocations: 0.9706 MB / 0.6402 GB, free: 8.887 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002861/0.006067, allocations: 8 kB / 0.6402 GB, free: 8.879 MB / 478.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002125/0.006286, allocations: 59.27 kB / 0.6402 GB, free: 8.82 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0003413/0.006641, allocations: 105.8 kB / 0.6403 GB, free: 8.719 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0005873/0.007235, allocations: 300 kB / 0.6406 GB, free: 8.43 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0006369/0.007881, allocations: 0.6131 MB / 0.6412 GB, free: 7.816 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003044/0.008193, allocations: 205.9 kB / 0.6414 GB, free: 7.602 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0002735/0.008473, allocations: 207.2 kB / 0.6416 GB, free: 7.398 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001817/0.008664, allocations: 187 kB / 0.6418 GB, free: 7.215 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 6.592e-05/0.008736, allocations: 44 kB / 0.6418 GB, free: 7.172 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 5.505e-05/0.008796, allocations: 44 kB / 0.6419 GB, free: 7.129 MB / 478.1 MB
Notification: Performance of combineBinaries: time 0.0004144/0.009216, allocations: 0.6985 MB / 0.6426 GB, free: 6.422 MB / 478.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0002237/0.009446, allocations: 457 kB / 0.643 GB, free: 5.969 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 7.307e-05/0.009524, allocations: 63.75 kB / 0.6431 GB, free: 5.906 MB / 478.1 MB
Notification: Performance of FrontEnd: time 9.374e-05/0.009623, allocations: 35.73 kB / 0.6431 GB, free: 5.871 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.001611/0.01124, allocations: 2.044 MB / 0.6451 GB, free: 3.711 MB / 478.1 MB
Notification: Performance of FunctionAlias: time 0.0001207/0.01137, allocations: 99.78 kB / 0.6452 GB, free: 3.613 MB / 478.1 MB
Notification: Performance of Early Inline: time 0.0007995/0.01217, allocations: 0.9249 MB / 0.6461 GB, free: 2.66 MB / 478.1 MB
Notification: Performance of simplify1: time 7.632e-05/0.01226, allocations: 75.89 kB / 0.6462 GB, free: 2.586 MB / 478.1 MB
Notification: Performance of Alias: time 0.002014/0.01428, allocations: 2.018 MB / 0.6481 GB, free: 308 kB / 478.1 MB
Notification: Performance of simplify2: time 6.695e-05/0.01435, allocations: 51.94 kB / 0.6482 GB, free: 256 kB / 478.1 MB
Notification: Performance of Detect States: time 0.0002992/0.01466, allocations: 282.6 kB / 0.6485 GB, free: 15.96 MB / 494.1 MB
Notification: Performance of Events: time 0.0001616/0.01483, allocations: 127.7 kB / 0.6486 GB, free: 15.83 MB / 494.1 MB
Notification: Performance of Partitioning: time 0.0002732/0.01511, allocations: 283.9 kB / 0.6488 GB, free: 15.52 MB / 494.1 MB
Notification: Performance of Causalize: time 0.001032/0.01615, allocations: 0.9774 MB / 0.6498 GB, free: 14.5 MB / 494.1 MB
Notification: Performance of After Index Reduction Inline: time 0.0005284/0.01669, allocations: 0.6234 MB / 0.6504 GB, free: 13.85 MB / 494.1 MB
Notification: Performance of Inline: time 0.001108/0.0178, allocations: 1.121 MB / 0.6515 GB, free: 12.7 MB / 494.1 MB
Notification: Performance of Partitioning: time 8.324e-05/0.0179, allocations: 71.61 kB / 0.6516 GB, free: 12.61 MB / 494.1 MB
Notification: Performance of Cleanup: time 0.0001549/0.01806, allocations: 131.6 kB / 0.6517 GB, free: 12.48 MB / 494.1 MB
Notification: Performance of Causalize: time 0.003537/0.0216, allocations: 3.256 MB / 0.6549 GB, free: 9.207 MB / 494.1 MB
Notification: Performance of Tearing: time 1.292e-05/0.02162, allocations: 0 / 0.6549 GB, free: 9.207 MB / 494.1 MB
Notification: Performance of Initialization: time 2.094e-06/0.02163, allocations: 4 kB / 0.6549 GB, free: 9.203 MB / 494.1 MB
Notification: Performance of Tearing: time 3.947e-06/0.02164, allocations: 0 / 0.6549 GB, free: 9.203 MB / 494.1 MB
Notification: Performance of Categorize: time 1.178e-05/0.02165, allocations: 3.984 kB / 0.6549 GB, free: 9.199 MB / 494.1 MB
Notification: Performance of Solve: time 0.0003466/0.022, allocations: 214.5 kB / 0.6551 GB, free: 8.988 MB / 494.1 MB
Notification: Performance of Jacobian: time 0.0005691/0.02258, allocations: 0.8439 MB / 0.6559 GB, free: 8.035 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 5.328e-05/0.02264, allocations: 53.7 kB / 0.656 GB, free: 7.992 MB / 494.1 MB
Error: Internal error NBEquation.WhenEquationBody.getBodyAttributes.getConditions failed for condition: change(PID.switch_OnOff.u2)