Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF.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.Control.FeedForward.Check.TestBlockFF,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="CPUtime|EventCounter|PTarget.duration|PTarget.height|PTarget.offset|PTarget.startTime|PTarget.y|Time|const2.k|const2.y|const3.k|const3.y|feedForwardBlock_3508_1.CL_Valve_.1,1.|feedForwardBlock_3508_1.CL_Valve_.1,2.|feedForwardBlock_3508_1.CL_Valve_.2,1.|feedForwardBlock_3508_1.CL_Valve_.2,2.|feedForwardBlock_3508_1.FuelFeedForward.k|feedForwardBlock_3508_1.FuelFeedForward.u|feedForwardBlock_3508_1.FuelFeedForward.y|feedForwardBlock_3508_1.FuelOvershoot.T|der.feedForwardBlock_3508_1.FuelOvershoot.x.|feedForwardBlock_3508_1.FuelOvershoot.initType|feedForwardBlock_3508_1.FuelOvershoot.k|feedForwardBlock_3508_1.FuelOvershoot.u|feedForwardBlock_3508_1.FuelOvershoot.x|feedForwardBlock_3508_1.FuelOvershoot.x_start|feedForwardBlock_3508_1.FuelOvershoot.y|feedForwardBlock_3508_1.FuelOvershoot.y_start|feedForwardBlock_3508_1.P_G_set_|feedForwardBlock_3508_1.P_G_target_|feedForwardBlock_3508_1.P_max_|feedForwardBlock_3508_1.P_min_|feedForwardBlock_3508_1.QF_FF_|feedForwardBlock_3508_1.add.k1|feedForwardBlock_3508_1.add.k2|feedForwardBlock_3508_1.add.u1|feedForwardBlock_3508_1.add.u2|feedForwardBlock_3508_1.add.y|feedForwardBlock_3508_1.derP_StG_|feedForwardBlock_3508_1.derP_T_|feedForwardBlock_3508_1.derP_max_|feedForwardBlock_3508_1.eta_gen|feedForwardBlock_3508_1.gain.k|feedForwardBlock_3508_1.gain.u|feedForwardBlock_3508_1.gain.y|feedForwardBlock_3508_1.k_FuelOvershoot|feedForwardBlock_3508_1.min1.u1|feedForwardBlock_3508_1.min1.u2|feedForwardBlock_3508_1.min1.y|feedForwardBlock_3508_1.turbineValveOpeneing.columns.1.|feedForwardBlock_3508_1.turbineValveOpeneing.extrapolation|feedForwardBlock_3508_1.turbineValveOpeneing.n|feedForwardBlock_3508_1.turbineValveOpeneing.smoothness|feedForwardBlock_3508_1.turbineValveOpeneing.tableOnFile|feedForwardBlock_3508_1.turbineValveOpeneing.table.1,1.|feedForwardBlock_3508_1.turbineValveOpeneing.table.1,2.|feedForwardBlock_3508_1.turbineValveOpeneing.table.2,1.|feedForwardBlock_3508_1.turbineValveOpeneing.table.2,2.|feedForwardBlock_3508_1.turbineValveOpeneing.u.1.|feedForwardBlock_3508_1.turbineValveOpeneing.u_max|feedForwardBlock_3508_1.turbineValveOpeneing.u_min|feedForwardBlock_3508_1.turbineValveOpeneing.verboseExtrapolation|feedForwardBlock_3508_1.turbineValveOpeneing.verboseRead|feedForwardBlock_3508_1.turbineValveOpeneing.y.1.|feedForwardBlock_3508_1.variableGradientLimiter.Nd|feedForwardBlock_3508_1.variableGradientLimiter.constantLimits|feedForwardBlock_3508_1.variableGradientLimiter.maxGrad|feedForwardBlock_3508_1.variableGradientLimiter.maxGrad_const|feedForwardBlock_3508_1.variableGradientLimiter.minGrad|feedForwardBlock_3508_1.variableGradientLimiter.minGrad_const|feedForwardBlock_3508_1.variableGradientLimiter.thres|feedForwardBlock_3508_1.variableGradientLimiter.u|feedForwardBlock_3508_1.variableGradientLimiter.useThresh|feedForwardBlock_3508_1.variableGradientLimiter.y|feedForwardBlock_3508_1.variableLimiter.homotopyType|feedForwardBlock_3508_1.variableLimiter.limit1|feedForwardBlock_3508_1.variableLimiter.limit2|feedForwardBlock_3508_1.variableLimiter.strict|feedForwardBlock_3508_1.variableLimiter.u|feedForwardBlock_3508_1.variableLimiter.y|feedForwardBlock_3508_1.variableLimiter.ySimplified|feedForwardBlock_3508_1.y_Turbine_|ramp2.duration|ramp2.height|ramp2.offset|ramp2.startTime|ramp2.y",fileNamePrefix="ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF")
translateModel(ClaRa.Components.Control.FeedForward.Check.TestBlockFF,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="CPUtime|EventCounter|PTarget.duration|PTarget.height|PTarget.offset|PTarget.startTime|PTarget.y|Time|const2.k|const2.y|const3.k|const3.y|feedForwardBlock_3508_1.CL_Valve_.1,1.|feedForwardBlock_3508_1.CL_Valve_.1,2.|feedForwardBlock_3508_1.CL_Valve_.2,1.|feedForwardBlock_3508_1.CL_Valve_.2,2.|feedForwardBlock_3508_1.FuelFeedForward.k|feedForwardBlock_3508_1.FuelFeedForward.u|feedForwardBlock_3508_1.FuelFeedForward.y|feedForwardBlock_3508_1.FuelOvershoot.T|der.feedForwardBlock_3508_1.FuelOvershoot.x.|feedForwardBlock_3508_1.FuelOvershoot.initType|feedForwardBlock_3508_1.FuelOvershoot.k|feedForwardBlock_3508_1.FuelOvershoot.u|feedForwardBlock_3508_1.FuelOvershoot.x|feedForwardBlock_3508_1.FuelOvershoot.x_start|feedForwardBlock_3508_1.FuelOvershoot.y|feedForwardBlock_3508_1.FuelOvershoot.y_start|feedForwardBlock_3508_1.P_G_set_|feedForwardBlock_3508_1.P_G_target_|feedForwardBlock_3508_1.P_max_|feedForwardBlock_3508_1.P_min_|feedForwardBlock_3508_1.QF_FF_|feedForwardBlock_3508_1.add.k1|feedForwardBlock_3508_1.add.k2|feedForwardBlock_3508_1.add.u1|feedForwardBlock_3508_1.add.u2|feedForwardBlock_3508_1.add.y|feedForwardBlock_3508_1.derP_StG_|feedForwardBlock_3508_1.derP_T_|feedForwardBlock_3508_1.derP_max_|feedForwardBlock_3508_1.eta_gen|feedForwardBlock_3508_1.gain.k|feedForwardBlock_3508_1.gain.u|feedForwardBlock_3508_1.gain.y|feedForwardBlock_3508_1.k_FuelOvershoot|feedForwardBlock_3508_1.min1.u1|feedForwardBlock_3508_1.min1.u2|feedForwardBlock_3508_1.min1.y|feedForwardBlock_3508_1.turbineValveOpeneing.columns.1.|feedForwardBlock_3508_1.turbineValveOpeneing.extrapolation|feedForwardBlock_3508_1.turbineValveOpeneing.n|feedForwardBlock_3508_1.turbineValveOpeneing.smoothness|feedForwardBlock_3508_1.turbineValveOpeneing.tableOnFile|feedForwardBlock_3508_1.turbineValveOpeneing.table.1,1.|feedForwardBlock_3508_1.turbineValveOpeneing.table.1,2.|feedForwardBlock_3508_1.turbineValveOpeneing.table.2,1.|feedForwardBlock_3508_1.turbineValveOpeneing.table.2,2.|feedForwardBlock_3508_1.turbineValveOpeneing.u.1.|feedForwardBlock_3508_1.turbineValveOpeneing.u_max|feedForwardBlock_3508_1.turbineValveOpeneing.u_min|feedForwardBlock_3508_1.turbineValveOpeneing.verboseExtrapolation|feedForwardBlock_3508_1.turbineValveOpeneing.verboseRead|feedForwardBlock_3508_1.turbineValveOpeneing.y.1.|feedForwardBlock_3508_1.variableGradientLimiter.Nd|feedForwardBlock_3508_1.variableGradientLimiter.constantLimits|feedForwardBlock_3508_1.variableGradientLimiter.maxGrad|feedForwardBlock_3508_1.variableGradientLimiter.maxGrad_const|feedForwardBlock_3508_1.variableGradientLimiter.minGrad|feedForwardBlock_3508_1.variableGradientLimiter.minGrad_const|feedForwardBlock_3508_1.variableGradientLimiter.thres|feedForwardBlock_3508_1.variableGradientLimiter.u|feedForwardBlock_3508_1.variableGradientLimiter.useThresh|feedForwardBlock_3508_1.variableGradientLimiter.y|feedForwardBlock_3508_1.variableLimiter.homotopyType|feedForwardBlock_3508_1.variableLimiter.limit1|feedForwardBlock_3508_1.variableLimiter.limit2|feedForwardBlock_3508_1.variableLimiter.strict|feedForwardBlock_3508_1.variableLimiter.u|feedForwardBlock_3508_1.variableLimiter.y|feedForwardBlock_3508_1.variableLimiter.ySimplified|feedForwardBlock_3508_1.y_Turbine_|ramp2.duration|ramp2.height|ramp2.offset|ramp2.startTime|ramp2.y",fileNamePrefix="ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtIInt 0.2.2-main/package.mo): time 0.008307/0.008307, allocations: 1.439 MB / 17.75 MB, free: 5.32 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia 1.8.1-main/package.mo): time 0.1068/0.1068, allocations: 22.37 MB / 41.17 MB, free: 7.773 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.0009962/0.0009962, allocations: 108 kB / 48.67 MB, free: 252 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.001272/0.001272, allocations: 190.2 kB / 56.27 MB, free: 9.461 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.241/1.241, allocations: 222.9 MB / 286.6 MB, free: 14 MB / 222.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.8.2-main/package.mo): time 0.8017/0.8017, allocations: 127.8 MB / 471.3 MB, free: 0.5742 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.292e-05/2.294e-05, allocations: 2.281 kB / 0.6358 GB, free: 13.35 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(ClaRa.Components.Control.FeedForward.Check.TestBlockFF): time 0.003458/0.00349, allocations: 2.732 MB / 0.6385 GB, free: 10.6 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001816/0.005319, allocations: 1.185 MB / 0.6397 GB, free: 9.41 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001256/0.005457, allocations: 0 / 0.6397 GB, free: 9.41 MB / 478.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002343/0.005698, allocations: 59.56 kB / 0.6397 GB, free: 9.352 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0002693/0.005989, allocations: 79.5 kB / 0.6398 GB, free: 9.273 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0005558/0.006553, allocations: 284.3 kB / 0.6401 GB, free: 9 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0003607/0.006923, allocations: 307.9 kB / 0.6404 GB, free: 8.699 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002122/0.007145, allocations: 125 kB / 0.6405 GB, free: 8.578 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0001352/0.007287, allocations: 111.5 kB / 0.6406 GB, free: 8.469 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001495/0.007443, allocations: 119.4 kB / 0.6407 GB, free: 8.352 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 3.896e-05/0.007491, allocations: 28 kB / 0.6407 GB, free: 8.324 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 9.181e-05/0.007588, allocations: 47.98 kB / 0.6408 GB, free: 8.277 MB / 478.1 MB
Notification: Performance of combineBinaries: time 0.0003037/0.007897, allocations: 387.2 kB / 0.6411 GB, free: 7.895 MB / 478.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0001324/0.008035, allocations: 256 kB / 0.6414 GB, free: 7.641 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 4.133e-05/0.008082, allocations: 35.88 kB / 0.6414 GB, free: 7.605 MB / 478.1 MB
Notification: Performance of FrontEnd: time 4.283e-05/0.00813, allocations: 11.88 kB / 0.6414 GB, free: 7.594 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: 43 (43)
 * Number of variables: 43 (43)
Notification: Performance of Bindings: time 0.001073/0.009208, allocations: 1.213 MB / 0.6426 GB, free: 6.273 MB / 478.1 MB
Notification: Performance of FunctionAlias: time 7.186e-05/0.009286, allocations: 47.91 kB / 0.6427 GB, free: 6.227 MB / 478.1 MB
Notification: Performance of Early Inline: time 0.0005152/0.009809, allocations: 0.5384 MB / 0.6432 GB, free: 5.66 MB / 478.1 MB
Notification: Performance of simplify1: time 4.692e-05/0.009865, allocations: 43.95 kB / 0.6432 GB, free: 5.617 MB / 478.1 MB
Notification: Performance of Alias: time 0.001283/0.01115, allocations: 1.136 MB / 0.6443 GB, free: 4.355 MB / 478.1 MB
Notification: Performance of simplify2: time 3.467e-05/0.0112, allocations: 27.95 kB / 0.6444 GB, free: 4.328 MB / 478.1 MB
Notification: Performance of Detect States: time 0.0001499/0.01135, allocations: 128.9 kB / 0.6445 GB, free: 4.191 MB / 478.1 MB
Notification: Performance of Events: time 0.0001278/0.01149, allocations: 87.19 kB / 0.6446 GB, free: 4.109 MB / 478.1 MB
Notification: Performance of Partitioning: time 0.0001578/0.01166, allocations: 152.7 kB / 0.6447 GB, free: 3.945 MB / 478.1 MB
Notification: Performance of Causalize: time 0.0006227/0.01228, allocations: 0.5457 MB / 0.6453 GB, free: 3.395 MB / 478.1 MB
Notification: Performance of After Index Reduction Inline: time 0.000331/0.01262, allocations: 396.2 kB / 0.6456 GB, free: 2.98 MB / 478.1 MB
Notification: Performance of Inline: time 0.001729/0.01436, allocations: 0.7359 MB / 0.6464 GB, free: 2.238 MB / 478.1 MB
Notification: Performance of Partitioning: time 4.242e-05/0.01441, allocations: 46.38 kB / 0.6464 GB, free: 2.188 MB / 478.1 MB
Notification: Performance of Cleanup: time 7.211e-05/0.01449, allocations: 77.11 kB / 0.6465 GB, free: 2.105 MB / 478.1 MB
Notification: Performance of Causalize: time 0.002217/0.01671, allocations: 2.049 MB / 0.6485 GB, free: 52 kB / 478.1 MB
Notification: Performance of Tearing: time 1.088e-05/0.01673, allocations: 0 / 0.6485 GB, free: 52 kB / 478.1 MB
Notification: Performance of Initialization: time 3.51e-07/0.01674, allocations: 0 / 0.6485 GB, free: 52 kB / 478.1 MB
Notification: Performance of Tearing: time 2.104e-06/0.01675, allocations: 0 / 0.6485 GB, free: 52 kB / 478.1 MB
Notification: Performance of Categorize: time 8.587e-06/0.01676, allocations: 3.938 kB / 0.6485 GB, free: 48 kB / 478.1 MB
Notification: Performance of Solve: time 0.000542/0.01731, allocations: 481.3 kB / 0.6489 GB, free: 15.52 MB / 494.1 MB
Notification: Performance of Jacobian: time 0.0002926/0.01761, allocations: 375 kB / 0.6493 GB, free: 15.12 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: ............... 1
 * Number of algebraic event partitions: ......... 1
 * 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: ............................. 2 (2) {feedForwardBlock_3508_1.variableGradientLimiter.y_aux, feedForwardBlock_3508_1.FuelOvershoot.x}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {NOT YET AVAILABLE}
 * Number of discrete variables: ................. 7 (7) {$SEV_2, $SEV_1, $SEV_0, $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: ........... 22 (scalar:22, 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] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 35 (scalar:33, array:1, record:1)
 * 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: ... 1 (linear: 0, nonlinear:1)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 35 (scalar:33, array:1, record:1)
 * 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: ... 1 (linear: 0, nonlinear:1)
Notification: Performance of backend: time 6.643e-05/0.01769, allocations: 36.19 kB / 0.6493 GB, free: 15.09 MB / 494.1 MB
Notification: Performance of SimCode: time 0.001972/0.01966, allocations: 1.931 MB / 0.6512 GB, free: 13.29 MB / 494.1 MB
Notification: Performance of Templates: time 0.004973/0.02465, allocations: 2.269 MB / 0.6534 GB, free: 11.03 MB / 494.1 MB
make -j1 -f ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF.makefile
(rm -f ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF.pipe ; mkfifo ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF.pipe ; head -c 1048576 < ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF.pipe >> ../files/ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF.sim & ./ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF.pipe 2>&1)
diffSimulationResults("ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/ClaRa/ReferenceResults/ClaRa.Components.Control.FeedForward.Check.TestBlockFF.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ClaRa_dev_ClaRa.Components.Control.FeedForward.Check.TestBlockFF.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches