Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_dev_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP.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.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="CPUtime|EventCounter|NonlinearSystems.initialization.1..Calls|NonlinearSystems.initialization.1..Iterations|NonlinearSystems.initialization.1..Jacobians|NonlinearSystems.initialization.1..Residues|PI_1ph_in.Dzero.k|PI_1ph_in.Dzero.y|PI_1ph_in.I.Tau_i_const|der.PI_1ph_in.I.y.|PI_1ph_in.I.initOption|PI_1ph_in.I.startTime|PI_1ph_in.I.u|PI_1ph_in.I.variable_Tau_i|PI_1ph_in.I.y|PI_1ph_in.I.y_start|PI_1ph_in.I.y_startInputIsActive|PI_1ph_in.I.y_start_const|PI_1ph_in.I_activation.threshold|PI_1ph_in.I_activation.u|PI_1ph_in.I_activation.y|PI_1ph_in.I_off_zero.k|PI_1ph_in.I_off_zero.y|PI_1ph_in.Nd|PI_1ph_in.Ni|PI_1ph_in.P.k|PI_1ph_in.P.u|PI_1ph_in.P.y|PI_1ph_in.Tau_add|PI_1ph_in.Tau_d|PI_1ph_in.Tau_i|PI_1ph_in.Tau_in|PI_1ph_in.Tau_lag_I|PI_1ph_in.Tau_out|PI_1ph_in.activate_.y|PI_1ph_in.addI.k1|PI_1ph_in.addI.k2|PI_1ph_in.addI.u1|PI_1ph_in.addI.u2|PI_1ph_in.addI.y|PI_1ph_in.addPID.k1|PI_1ph_in.addPID.k2|PI_1ph_in.addPID.k3|PI_1ph_in.addPID.u1|PI_1ph_in.addPID.u2|PI_1ph_in.addPID.u3|PI_1ph_in.addPID.y|PI_1ph_in.addSat.u1|PI_1ph_in.addSat.u2|PI_1ph_in.addSat.y|PI_1ph_in.booleanPassThrough.u|PI_1ph_in.booleanPassThrough.y|PI_1ph_in.controlError|PI_1ph_in.controllerType|PI_1ph_in.feedback.u1|PI_1ph_in.feedback.u2|PI_1ph_in.feedback.y|PI_1ph_in.fromPU.k|PI_1ph_in.fromPU.u|PI_1ph_in.fromPU.y|PI_1ph_in.gainTrack.k|PI_1ph_in.gainTrack.u|PI_1ph_in.gainTrack.y|PI_1ph_in.initOption|PI_1ph_in.k|PI_1ph_in.limiter.homotopyType|PI_1ph_in.limiter.strict|PI_1ph_in.limiter.u|PI_1ph_in.limiter.uMax|PI_1ph_in.limiter.uMin|PI_1ph_in.limiter.y|PI_1ph_in.limitsAtInit|PI_1ph_in.perUnitConversion|PI_1ph_in.resetP.u1|PI_1ph_in.resetP.u2|PI_1ph_in.resetP.y|PI_1ph_in.resetPD.k1|PI_1ph_in.resetPD.k2|PI_1ph_in.resetPD.u1|PI_1ph_in.resetPD.u2|PI_1ph_in.resetPD.y|PI_1ph_in.sign|PI_1ph_in.smoothPIDInput.Tau|PI_1ph_in.smoothPIDInput.initOption|PI_1ph_in.smoothPIDInput.u|PI_1ph_in.smoothPIDInput.y|PI_1ph_in.smoothPIDInput.y_start|PI_1ph_in.smoothPIDOutput.Tau|PI_1ph_in.smoothPIDOutput.initOption|PI_1ph_in.smoothPIDOutput.u|PI_1ph_in.smoothPIDOutput.y|PI_1ph_in.smoothPIDOutput.y_start|PI_1ph_in.smoothPIDOutput1.Tau|PI_1ph_in.smoothPIDOutput1.initOption|PI_1ph_in.smoothPIDOutput1.u|PI_1ph_in.smoothPIDOutput1.y|PI_1ph_in.smoothPIDOutput1.y_start|PI_1ph_in.switch_OnOff.u1|PI_1ph_in.switch_OnOff.u2|PI_1ph_in.switch_OnOff.u3|PI_1ph_in.switch_OnOff.y|PI_1ph_in.switch_OnOff_I.u1|PI_1ph_in.switch_OnOff_I.u2|PI_1ph_in.switch_OnOff_I.u3|PI_1ph_in.switch_OnOff_I.y|PI_1ph_in.t_activation|PI_1ph_in.time_lag_I_activation.u|PI_1ph_in.time_lag_I_activation.y|PI_1ph_in.toPU.k|PI_1ph_in.toPU.u|PI_1ph_in.toPU.y|PI_1ph_in.u_m|PI_1ph_in.u_ref|PI_1ph_in.u_s|PI_1ph_in.use_activateInput|PI_1ph_in.xd_start|PI_1ph_in.xi_start|PI_1ph_in.y|PI_1ph_in.y_inactive|PI_1ph_in.y_max|PI_1ph_in.y_min|PI_1ph_in.y_ref|PI_1ph_in.y_start|PI_1ph_in.y_start_I.y|PI_1ph_in.y_unlocked.y|PI_1ph_in.y_unlocked1.y|PI_1ph_in.y_unlocked2.y|Time|const.k|const.y|control_y|step.offset|step.shiftTime|step.startTime|step.table.1,1.|step.table.1,2.|step.table.10,1.|step.table.10,2.|step.table.11,1.|step.table.11,2.|step.table.12,1.|step.table.12,2.|step.table.13,1.|step.table.13,2.|step.table.14,1.|step.table.14,2.|step.table.15,1.|step.table.15,2.|step.table.16,1.|step.table.16,2.|step.table.17,1.|step.table.17,2.|step.table.18,1.|step.table.18,2.|step.table.19,1.|step.table.19,2.|step.table.2,1.|step.table.2,2.|step.table.3,1.|step.table.3,2.|step.table.4,1.|step.table.4,2.|step.table.5,1.|step.table.5,2.|step.table.6,1.|step.table.6,2.|step.table.7,1.|step.table.7,2.|step.table.8,1.|step.table.8,2.|step.table.9,1.|step.table.9,2.|step.timeScale|step.y|stopablePI.K_p|stopablePI.N_i|stopablePI.Tau_i|stopablePI.initOption|stopablePI.u|stopablePI.y|stopablePI.y_max|stopablePI.y_min|stopablePI.y_start",fileNamePrefix="ClaRa_dev_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP")
translateModel(ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="CPUtime|EventCounter|NonlinearSystems.initialization.1..Calls|NonlinearSystems.initialization.1..Iterations|NonlinearSystems.initialization.1..Jacobians|NonlinearSystems.initialization.1..Residues|PI_1ph_in.Dzero.k|PI_1ph_in.Dzero.y|PI_1ph_in.I.Tau_i_const|der.PI_1ph_in.I.y.|PI_1ph_in.I.initOption|PI_1ph_in.I.startTime|PI_1ph_in.I.u|PI_1ph_in.I.variable_Tau_i|PI_1ph_in.I.y|PI_1ph_in.I.y_start|PI_1ph_in.I.y_startInputIsActive|PI_1ph_in.I.y_start_const|PI_1ph_in.I_activation.threshold|PI_1ph_in.I_activation.u|PI_1ph_in.I_activation.y|PI_1ph_in.I_off_zero.k|PI_1ph_in.I_off_zero.y|PI_1ph_in.Nd|PI_1ph_in.Ni|PI_1ph_in.P.k|PI_1ph_in.P.u|PI_1ph_in.P.y|PI_1ph_in.Tau_add|PI_1ph_in.Tau_d|PI_1ph_in.Tau_i|PI_1ph_in.Tau_in|PI_1ph_in.Tau_lag_I|PI_1ph_in.Tau_out|PI_1ph_in.activate_.y|PI_1ph_in.addI.k1|PI_1ph_in.addI.k2|PI_1ph_in.addI.u1|PI_1ph_in.addI.u2|PI_1ph_in.addI.y|PI_1ph_in.addPID.k1|PI_1ph_in.addPID.k2|PI_1ph_in.addPID.k3|PI_1ph_in.addPID.u1|PI_1ph_in.addPID.u2|PI_1ph_in.addPID.u3|PI_1ph_in.addPID.y|PI_1ph_in.addSat.u1|PI_1ph_in.addSat.u2|PI_1ph_in.addSat.y|PI_1ph_in.booleanPassThrough.u|PI_1ph_in.booleanPassThrough.y|PI_1ph_in.controlError|PI_1ph_in.controllerType|PI_1ph_in.feedback.u1|PI_1ph_in.feedback.u2|PI_1ph_in.feedback.y|PI_1ph_in.fromPU.k|PI_1ph_in.fromPU.u|PI_1ph_in.fromPU.y|PI_1ph_in.gainTrack.k|PI_1ph_in.gainTrack.u|PI_1ph_in.gainTrack.y|PI_1ph_in.initOption|PI_1ph_in.k|PI_1ph_in.limiter.homotopyType|PI_1ph_in.limiter.strict|PI_1ph_in.limiter.u|PI_1ph_in.limiter.uMax|PI_1ph_in.limiter.uMin|PI_1ph_in.limiter.y|PI_1ph_in.limitsAtInit|PI_1ph_in.perUnitConversion|PI_1ph_in.resetP.u1|PI_1ph_in.resetP.u2|PI_1ph_in.resetP.y|PI_1ph_in.resetPD.k1|PI_1ph_in.resetPD.k2|PI_1ph_in.resetPD.u1|PI_1ph_in.resetPD.u2|PI_1ph_in.resetPD.y|PI_1ph_in.sign|PI_1ph_in.smoothPIDInput.Tau|PI_1ph_in.smoothPIDInput.initOption|PI_1ph_in.smoothPIDInput.u|PI_1ph_in.smoothPIDInput.y|PI_1ph_in.smoothPIDInput.y_start|PI_1ph_in.smoothPIDOutput.Tau|PI_1ph_in.smoothPIDOutput.initOption|PI_1ph_in.smoothPIDOutput.u|PI_1ph_in.smoothPIDOutput.y|PI_1ph_in.smoothPIDOutput.y_start|PI_1ph_in.smoothPIDOutput1.Tau|PI_1ph_in.smoothPIDOutput1.initOption|PI_1ph_in.smoothPIDOutput1.u|PI_1ph_in.smoothPIDOutput1.y|PI_1ph_in.smoothPIDOutput1.y_start|PI_1ph_in.switch_OnOff.u1|PI_1ph_in.switch_OnOff.u2|PI_1ph_in.switch_OnOff.u3|PI_1ph_in.switch_OnOff.y|PI_1ph_in.switch_OnOff_I.u1|PI_1ph_in.switch_OnOff_I.u2|PI_1ph_in.switch_OnOff_I.u3|PI_1ph_in.switch_OnOff_I.y|PI_1ph_in.t_activation|PI_1ph_in.time_lag_I_activation.u|PI_1ph_in.time_lag_I_activation.y|PI_1ph_in.toPU.k|PI_1ph_in.toPU.u|PI_1ph_in.toPU.y|PI_1ph_in.u_m|PI_1ph_in.u_ref|PI_1ph_in.u_s|PI_1ph_in.use_activateInput|PI_1ph_in.xd_start|PI_1ph_in.xi_start|PI_1ph_in.y|PI_1ph_in.y_inactive|PI_1ph_in.y_max|PI_1ph_in.y_min|PI_1ph_in.y_ref|PI_1ph_in.y_start|PI_1ph_in.y_start_I.y|PI_1ph_in.y_unlocked.y|PI_1ph_in.y_unlocked1.y|PI_1ph_in.y_unlocked2.y|Time|const.k|const.y|control_y|step.offset|step.shiftTime|step.startTime|step.table.1,1.|step.table.1,2.|step.table.10,1.|step.table.10,2.|step.table.11,1.|step.table.11,2.|step.table.12,1.|step.table.12,2.|step.table.13,1.|step.table.13,2.|step.table.14,1.|step.table.14,2.|step.table.15,1.|step.table.15,2.|step.table.16,1.|step.table.16,2.|step.table.17,1.|step.table.17,2.|step.table.18,1.|step.table.18,2.|step.table.19,1.|step.table.19,2.|step.table.2,1.|step.table.2,2.|step.table.3,1.|step.table.3,2.|step.table.4,1.|step.table.4,2.|step.table.5,1.|step.table.5,2.|step.table.6,1.|step.table.6,2.|step.table.7,1.|step.table.7,2.|step.table.8,1.|step.table.8,2.|step.table.9,1.|step.table.9,2.|step.timeScale|step.y|stopablePI.K_p|stopablePI.N_i|stopablePI.Tau_i|stopablePI.initOption|stopablePI.u|stopablePI.y|stopablePI.y_max|stopablePI.y_min|stopablePI.y_start",fileNamePrefix="ClaRa_dev_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtIInt 0.2.2-main/package.mo): time 0.007065/0.007065, allocations: 1.43 MB / 17.75 MB, free: 5.328 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.8.1-main/package.mo): time 0.1023/0.1023, allocations: 22.37 MB / 41.17 MB, free: 7.762 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.001059/0.00106, allocations: 104 kB / 48.66 MB, free: 248 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.001506/0.001506, allocations: 197.7 kB / 56.26 MB, free: 9.457 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.345/1.345, allocations: 222.9 MB / 286.6 MB, free: 13.98 MB / 222.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.8.2-main/package.mo): time 0.838/0.838, allocations: 127.8 MB / 471.3 MB, free: 0.5508 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.379e-05/2.381e-05, allocations: 2.281 kB / 0.6359 GB, free: 13.3 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP): time 0.004727/0.004759, allocations: 3.467 MB / 0.6393 GB, free: 9.82 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.00225/0.007022, allocations: 1.084 MB / 0.6403 GB, free: 8.73 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003457/0.007381, allocations: 8 kB / 0.6403 GB, free: 8.723 MB / 478.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.000387/0.007775, allocations: 155.1 kB / 0.6405 GB, free: 8.57 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.000353/0.008136, allocations: 171.1 kB / 0.6406 GB, free: 8.402 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001008/0.009168, allocations: 360.6 kB / 0.641 GB, free: 8.055 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0008349/0.01001, allocations: 0.6521 MB / 0.6416 GB, free: 7.402 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003436/0.01037, allocations: 213.1 kB / 0.6418 GB, free: 7.188 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003345/0.01071, allocations: 223.1 kB / 0.642 GB, free: 6.969 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000321/0.01104, allocations: 238.9 kB / 0.6423 GB, free: 6.734 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 8.357e-05/0.01113, allocations: 44 kB / 0.6423 GB, free: 6.691 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001917/0.01133, allocations: 119.9 kB / 0.6424 GB, free: 6.574 MB / 478.1 MB
Notification: Performance of combineBinaries: time 0.0004765/0.01181, allocations: 0.7062 MB / 0.6431 GB, free: 5.859 MB / 478.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0002755/0.0121, allocations: 461 kB / 0.6435 GB, free: 5.402 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001085/0.01221, allocations: 71.75 kB / 0.6436 GB, free: 5.332 MB / 478.1 MB
Notification: Performance of FrontEnd: time 0.0001142/0.01233, allocations: 31.73 kB / 0.6436 GB, free: 5.301 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: 86 (82)
 * Number of variables: 86 (86)
Notification: Performance of Bindings: time 0.001972/0.01431, allocations: 2.056 MB / 0.6457 GB, free: 3.125 MB / 478.1 MB
Notification: Performance of FunctionAlias: time 0.0001069/0.01442, allocations: 79.83 kB / 0.6457 GB, free: 3.047 MB / 478.1 MB
Notification: Performance of Early Inline: time 0.0008941/0.01532, allocations: 0.9443 MB / 0.6467 GB, free: 2.078 MB / 478.1 MB
Notification: Performance of simplify1: time 0.0001005/0.01543, allocations: 63.92 kB / 0.6467 GB, free: 2.016 MB / 478.1 MB
Notification: Performance of Alias: time 0.002327/0.01776, allocations: 2.031 MB / 0.6487 GB, free: 15.73 MB / 494.1 MB
Notification: Performance of simplify2: time 7.785e-05/0.01785, allocations: 43.94 kB / 0.6487 GB, free: 15.69 MB / 494.1 MB
Notification: Performance of Events: time 0.0002392/0.0181, allocations: 144.8 kB / 0.6489 GB, free: 15.55 MB / 494.1 MB
Notification: Performance of Detect States: time 0.0004012/0.01851, allocations: 316.8 kB / 0.6492 GB, free: 15.22 MB / 494.1 MB
Notification: Performance of Partitioning: time 0.0003676/0.01889, allocations: 312.1 kB / 0.6495 GB, free: 14.86 MB / 494.1 MB
Notification: Performance of Causalize: time 0.001227/0.02012, allocations: 1.008 MB / 0.6505 GB, free: 13.8 MB / 494.1 MB
Notification: Performance of After Index Reduction Inline: time 0.0005904/0.02072, allocations: 0.6199 MB / 0.6511 GB, free: 13.15 MB / 494.1 MB
Notification: Performance of Inline: time 0.001334/0.02207, allocations: 1.205 MB / 0.6522 GB, free: 11.91 MB / 494.1 MB
Notification: Performance of Partitioning: time 9.353e-05/0.02217, allocations: 75.59 kB / 0.6523 GB, free: 11.82 MB / 494.1 MB
Notification: Performance of Cleanup: time 0.000213/0.02239, allocations: 147.6 kB / 0.6525 GB, free: 11.68 MB / 494.1 MB
Warning: NBResolveSingularities.balanceInitialization reports an overdetermined initialization!
Checking for consistency is not yet supported, following equations had to be removed:
        [SCAL] (1) step.nextEventScaled = $START.step.nextEventScaled ($RES_SRT_103)
         slice: {};
Notification: Performance of Causalize: time 0.006762/0.02916, allocations: 5.398 MB / 0.6577 GB, free: 6.195 MB / 494.1 MB
Notification: Performance of Tearing: time 2.004e-05/0.0292, allocations: 3.984 kB / 0.6577 GB, free: 6.191 MB / 494.1 MB
Notification: Performance of Initialization: time 9.72e-07/0.02921, allocations: 4 kB / 0.6577 GB, free: 6.188 MB / 494.1 MB
Notification: Performance of Tearing: time 9.729e-06/0.02922, allocations: 3.938 kB / 0.6577 GB, free: 6.184 MB / 494.1 MB
Notification: Performance of Categorize: time 1.722e-05/0.02925, allocations: 0 / 0.6577 GB, free: 6.184 MB / 494.1 MB
Error: Internal error NBDifferentiate.differentiateBuiltinCall2Arg failed for: max
Error: Internal error NBSolve.solveStrongComponent failed with status = Solve.UNSOLVABLE while trying to solve following strong component:
BLOCK: Single Strong Component (status = Solve.UNPROCESSED)
-------------------------------------------------------------
### Variable:
        protected Real stopablePI.outputI
### Equation:
        [SCAL] (1) control_y = max(stopablePI.y_min, min(stopablePI.y_max, stopablePI.outputI + stopablePI.outputP)) ($RES_SIM_45)