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.008509/0.008509, allocations: 1.437 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.1227/0.1227, allocations: 22.39 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.0009894/0.0009894, allocations: 100.1 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.001229/0.001229, allocations: 190.9 kB / 56.26 MB, free: 9.484 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.94 MB / 222.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.8.2-main/package.mo): time 0.8332/0.8332, allocations: 127.8 MB / 471.3 MB, free: 0.5703 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.854e-05/1.854e-05, allocations: 2.281 kB / 0.6358 GB, free: 13.33 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(ClaRa.Components.Control.FeedForward.Check.TestBlockFF): time 0.004224/0.004251, allocations: 2.739 MB / 0.6385 GB, free: 10.57 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.00227/0.006534, allocations: 1.181 MB / 0.6397 GB, free: 9.391 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000175/0.006721, allocations: 4 kB / 0.6397 GB, free: 9.387 MB / 478.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003013/0.007027, allocations: 59.56 kB / 0.6397 GB, free: 9.328 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0003414/0.007377, allocations: 85.98 kB / 0.6398 GB, free: 9.246 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.000743/0.008141, allocations: 275.3 kB / 0.6401 GB, free: 8.977 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0005804/0.00873, allocations: 307.8 kB / 0.6404 GB, free: 8.676 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002562/0.008994, allocations: 129.1 kB / 0.6405 GB, free: 8.551 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0001476/0.009148, allocations: 107.5 kB / 0.6406 GB, free: 8.445 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001498/0.009305, allocations: 115.4 kB / 0.6407 GB, free: 8.332 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 3.606e-05/0.009347, allocations: 20 kB / 0.6407 GB, free: 8.312 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001053/0.00946, allocations: 52 kB / 0.6408 GB, free: 8.262 MB / 478.1 MB
Notification: Performance of combineBinaries: time 0.0002553/0.009723, allocations: 391.2 kB / 0.6411 GB, free: 7.875 MB / 478.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0001203/0.00985, allocations: 256.1 kB / 0.6414 GB, free: 7.621 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 3.975e-05/0.009895, allocations: 39.81 kB / 0.6414 GB, free: 7.582 MB / 478.1 MB
Notification: Performance of FrontEnd: time 5.147e-05/0.009951, allocations: 7.938 kB / 0.6414 GB, free: 7.574 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.001099/0.01106, allocations: 1.205 MB / 0.6426 GB, free: 6.262 MB / 478.1 MB
Notification: Performance of FunctionAlias: time 8.173e-05/0.01114, allocations: 60.95 kB / 0.6427 GB, free: 6.203 MB / 478.1 MB
Notification: Performance of Early Inline: time 0.0004902/0.01164, allocations: 0.5306 MB / 0.6432 GB, free: 5.645 MB / 478.1 MB
Notification: Performance of simplify1: time 5.349e-05/0.0117, allocations: 51.92 kB / 0.6432 GB, free: 5.594 MB / 478.1 MB
Notification: Performance of Alias: time 0.001442/0.01315, allocations: 1.134 MB / 0.6443 GB, free: 4.332 MB / 478.1 MB
Notification: Performance of simplify2: time 2.596e-05/0.01318, allocations: 19.97 kB / 0.6444 GB, free: 4.312 MB / 478.1 MB
Notification: Performance of Events: time 0.0001385/0.01333, allocations: 102.4 kB / 0.6445 GB, free: 4.211 MB / 478.1 MB
Notification: Performance of Detect States: time 0.0001998/0.01353, allocations: 136.1 kB / 0.6446 GB, free: 4.062 MB / 478.1 MB
Notification: Performance of Partitioning: time 0.0001715/0.01371, allocations: 152.2 kB / 0.6447 GB, free: 3.898 MB / 478.1 MB
Notification: Performance of Causalize: time 0.000608/0.01433, allocations: 0.5443 MB / 0.6453 GB, free: 3.348 MB / 478.1 MB
Notification: Performance of After Index Reduction Inline: time 0.0003426/0.01468, allocations: 400 kB / 0.6456 GB, free: 2.93 MB / 478.1 MB
Notification: Performance of Inline: time 0.0007492/0.01544, allocations: 0.6843 MB / 0.6463 GB, free: 2.211 MB / 478.1 MB
Notification: Performance of Partitioning: time 4.319e-05/0.01549, allocations: 46.36 kB / 0.6464 GB, free: 2.16 MB / 478.1 MB
Notification: Performance of Cleanup: time 7.276e-05/0.01557, allocations: 73.12 kB / 0.6464 GB, free: 2.082 MB / 478.1 MB
Notification: Performance of Causalize: time 0.002268/0.01784, allocations: 2.042 MB / 0.6484 GB, free: 36 kB / 478.1 MB
Notification: Performance of Tearing: time 1.189e-05/0.01786, allocations: 3.984 kB / 0.6484 GB, free: 32 kB / 478.1 MB
Notification: Performance of Initialization: time 4.41e-07/0.01787, allocations: 0 / 0.6484 GB, free: 32 kB / 478.1 MB
Notification: Performance of Tearing: time 2.264e-06/0.01788, allocations: 0 / 0.6484 GB, free: 32 kB / 478.1 MB
Notification: Performance of Categorize: time 1.206e-05/0.01789, allocations: 7.938 kB / 0.6484 GB, free: 24 kB / 478.1 MB
Notification: Performance of Solve: time 0.0005647/0.01846, allocations: 0.5925 MB / 0.649 GB, free: 15.38 MB / 494.1 MB
Notification: Performance of Jacobian: time 0.0003476/0.01882, allocations: 363.1 kB / 0.6494 GB, free: 14.98 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.264e-05/0.01889, allocations: 39.02 kB / 0.6494 GB, free: 14.95 MB / 494.1 MB
Notification: Performance of SimCode: time 0.002292/0.02119, allocations: 1.92 MB / 0.6513 GB, free: 13.16 MB / 494.1 MB
Notification: Performance of Templates: time 0.005485/0.02669, allocations: 2.265 MB / 0.6535 GB, free: 10.91 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