Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag.conf.json
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 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo", uses=false)
Using package PowerGrids with version 1.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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)
Running command: translateModel(PowerGrids.Controls.Test.TestDerivativeLag,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="derivativeLag.T1|derivativeLag.Td|derivativeLag.feedback.y|derivativeLag.gain.k|derivativeLag.gain.u|derivativeLag.gain.y|derivativeLag.initType|derivativeLag.integrator.initType|derivativeLag.integrator.k|derivativeLag.integrator.u|derivativeLag.integrator.y|derivativeLag.integrator.y_start|derivativeLag.noDynamics|derivativeLag.u|derivativeLag.y|derivativeLag.yStart|derivativeLagAnalyticSolution.y|derivativeLagNoDynamics.T1|derivativeLagNoDynamics.Td|derivativeLagNoDynamics.feedback.y|derivativeLagNoDynamics.gain.k|derivativeLagNoDynamics.gain.u|derivativeLagNoDynamics.gain.y|derivativeLagNoDynamics.initType|derivativeLagNoDynamics.noDynamics|derivativeLagNoDynamics.u|derivativeLagNoDynamics.y|derivativeLagNoDynamics.yStart|derivativeLagNoDynamics.zero.y|derivativeLagNoDynamicsAnalyticSolution.y|step.height|step.offset|step.startTime|step.y|time",fileNamePrefix="PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag")
translateModel(PowerGrids.Controls.Test.TestDerivativeLag,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="derivativeLag.T1|derivativeLag.Td|derivativeLag.feedback.y|derivativeLag.gain.k|derivativeLag.gain.u|derivativeLag.gain.y|derivativeLag.initType|derivativeLag.integrator.initType|derivativeLag.integrator.k|derivativeLag.integrator.u|derivativeLag.integrator.y|derivativeLag.integrator.y_start|derivativeLag.noDynamics|derivativeLag.u|derivativeLag.y|derivativeLag.yStart|derivativeLagAnalyticSolution.y|derivativeLagNoDynamics.T1|derivativeLagNoDynamics.Td|derivativeLagNoDynamics.feedback.y|derivativeLagNoDynamics.gain.k|derivativeLagNoDynamics.gain.u|derivativeLagNoDynamics.gain.y|derivativeLagNoDynamics.initType|derivativeLagNoDynamics.noDynamics|derivativeLagNoDynamics.u|derivativeLagNoDynamics.y|derivativeLagNoDynamics.yStart|derivativeLagNoDynamics.zero.y|derivativeLagNoDynamicsAnalyticSolution.y|step.height|step.offset|step.startTime|step.y|time",fileNamePrefix="PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001459/0.001459, allocations: 105.1 kB / 16.42 MB, free: 6.465 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00133/0.00133, allocations: 192.2 kB / 17.36 MB, free: 5.73 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.647/1.647, allocations: 205.1 MB / 223.2 MB, free: 12.24 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.06056/0.06056, allocations: 14.18 MB / 284.8 MB, free: 13.86 MB / 238.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.913e-05/2.914e-05, allocations: 2.281 kB / 399.2 MB, free: 42.75 MB / 318.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Controls.Test.TestDerivativeLag): time 0.003092/0.00313, allocations: 1.826 MB / 401 MB, free: 41.47 MB / 318.1 MB
Notification: Performance of NFInst.instExpressions: time 0.0004692/0.003614, allocations: 171.9 kB / 401.2 MB, free: 41.35 MB / 318.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001255/0.003752, allocations: 3.344 kB / 401.2 MB, free: 41.35 MB / 318.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.000169/0.003927, allocations: 25.5 kB / 401.2 MB, free: 41.33 MB / 318.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0001843/0.004136, allocations: 27.62 kB / 401.2 MB, free: 41.31 MB / 318.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0001137/0.004258, allocations: 37.41 kB / 401.3 MB, free: 41.29 MB / 318.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0002276/0.004492, allocations: 145 kB / 401.4 MB, free: 41.21 MB / 318.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.000178/0.004678, allocations: 53.67 kB / 401.5 MB, free: 41.19 MB / 318.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 7.733e-05/0.004761, allocations: 51.41 kB / 401.5 MB, free: 41.16 MB / 318.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001069/0.004874, allocations: 44.7 kB / 401.6 MB, free: 41.14 MB / 318.1 MB
Notification: Performance of NFPackage.collectConstants: time 2.997e-05/0.004909, allocations: 7.75 kB / 401.6 MB, free: 41.14 MB / 318.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 2.07e-05/0.004936, allocations: 13.84 kB / 401.6 MB, free: 41.13 MB / 318.1 MB
Notification: Performance of combineBinaries: time 0.0001451/0.005085, allocations: 186.2 kB / 401.8 MB, free: 40.99 MB / 318.1 MB
Notification: Performance of replaceArrayConstructors: time 6.484e-05/0.005156, allocations: 126.9 kB / 401.9 MB, free: 40.9 MB / 318.1 MB
Notification: Performance of NFVerifyModel.verify: time 2.923e-05/0.005191, allocations: 22.78 kB / 401.9 MB, free: 40.88 MB / 318.1 MB
Notification: Performance of FrontEnd: time 3.972e-05/0.005235, allocations: 7.906 kB / 401.9 MB, free: 40.88 MB / 318.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 22 (22)
 * Number of variables: 22 (22)
Notification: Performance of Bindings: time 0.0006516/0.005891, allocations: 0.6167 MB / 402.5 MB, free: 40.31 MB / 318.1 MB
Notification: Performance of FunctionAlias: time 9.046e-05/0.005988, allocations: 28.05 kB / 402.6 MB, free: 40.29 MB / 318.1 MB
Notification: Performance of Early Inline: time 0.0002259/0.006223, allocations: 246 kB / 402.8 MB, free: 40.07 MB / 318.1 MB
Notification: Performance of simplify1: time 2.337e-05/0.006252, allocations: 19.27 kB / 402.8 MB, free: 40.06 MB / 318.1 MB
Notification: Performance of Alias: time 0.000875/0.007133, allocations: 0.573 MB / 403.4 MB, free: 39.59 MB / 318.1 MB
Notification: Performance of simplify2: time 2.003e-05/0.007165, allocations: 15.62 kB / 403.4 MB, free: 39.58 MB / 318.1 MB
Notification: Performance of Events: time 9.598e-05/0.007267, allocations: 39.14 kB / 403.5 MB, free: 39.55 MB / 318.1 MB
Notification: Performance of Detect States: time 0.0003525/0.007626, allocations: 79.22 kB / 403.5 MB, free: 39.47 MB / 318.1 MB
Notification: Performance of Partitioning: time 0.0001196/0.007755, allocations: 89.72 kB / 403.6 MB, free: 39.39 MB / 318.1 MB
Notification: Performance of Causalize: time 0.0003849/0.008147, allocations: 261.8 kB / 403.9 MB, free: 39.24 MB / 318.1 MB
Notification: Performance of After Index Reduction Inline: time 0.0001413/0.008297, allocations: 161.8 kB / 404 MB, free: 39.09 MB / 318.1 MB
Notification: Performance of Inline: time 0.0002743/0.008577, allocations: 260.4 kB / 404.3 MB, free: 38.87 MB / 318.1 MB
Notification: Performance of Partitioning: time 3.027e-05/0.008616, allocations: 22.94 kB / 404.3 MB, free: 38.85 MB / 318.1 MB
Notification: Performance of Cleanup: time 1.496e-05/0.008636, allocations: 5.031 kB / 404.3 MB, free: 38.84 MB / 318.1 MB
Notification: Performance of Causalize: time 0.0004312/0.009072, allocations: 327.2 kB / 404.6 MB, free: 38.69 MB / 318.1 MB
Notification: Performance of Tearing: time 7.444e-06/0.009089, allocations: 5 kB / 404.6 MB, free: 38.68 MB / 318.1 MB
Notification: Performance of Initialization: time 2.8e-07/0.009094, allocations: 0 / 404.6 MB, free: 38.68 MB / 318.1 MB
Notification: Performance of Tearing: time 2.264e-06/0.009103, allocations: 1.156 kB / 404.6 MB, free: 38.68 MB / 318.1 MB
Notification: Performance of Categorize: time 1.28e-05/0.009121, allocations: 12.86 kB / 404.7 MB, free: 38.67 MB / 318.1 MB
Notification: Performance of Solve: time 0.0001207/0.009247, allocations: 50.2 kB / 404.7 MB, free: 38.65 MB / 318.1 MB
Notification: Performance of Jacobian: time 0.000154/0.009408, allocations: 224.2 kB / 404.9 MB, free: 38.42 MB / 318.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: ......... 2
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 1 (1) {derivativeLag.integrator.y}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {NOT YET AVAILABLE}
 * Number of discrete variables: ................. 3 (3) {$SEV_0, $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: ........... 12 (scalar:12, 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: ........... 15 (scalar:15, 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 3.831e-05/0.009455, allocations: 19.41 kB / 404.9 MB, free: 38.41 MB / 318.1 MB
Notification: Performance of SimCode: time 0.0006331/0.01009, allocations: 1.022 MB / 406 MB, free: 37.47 MB / 318.1 MB
Notification: Performance of Templates: time 0.002876/0.01298, allocations: 0.697 MB / 406.7 MB, free: 37.12 MB / 318.1 MB
make -j1 -f PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag.makefile
(rm -f PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag.pipe ; mkfifo PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag.pipe ; head -c 1048576 < PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag.pipe >> ../files/PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag.sim & ./PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag  -lv=LOG_STATS -s=dassl -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag.pipe 2>&1)
diffSimulationResults("PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/PowerGrids/PowerGrids.Controls.Test.TestDerivativeLag_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/PowerGrids_PowerGrids.Controls.Test.TestDerivativeLag.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
""

Variables in the reference:derivativeLag.T1,derivativeLag.Td,derivativeLag.feedback.y,derivativeLag.gain.k,derivativeLag.gain.u,derivativeLag.gain.y,derivativeLag.initType,derivativeLag.integrator.initType,derivativeLag.integrator.k,derivativeLag.integrator.u,derivativeLag.integrator.y,derivativeLag.integrator.y_start,derivativeLag.noDynamics,derivativeLag.u,derivativeLag.y,derivativeLag.yStart,derivativeLagAnalyticSolution.y,derivativeLagNoDynamics.T1,derivativeLagNoDynamics.Td,derivativeLagNoDynamics.feedback.y,derivativeLagNoDynamics.gain.k,derivativeLagNoDynamics.gain.u,derivativeLagNoDynamics.gain.y,derivativeLagNoDynamics.initType,derivativeLagNoDynamics.noDynamics,derivativeLagNoDynamics.u,derivativeLagNoDynamics.y,derivativeLagNoDynamics.yStart,derivativeLagNoDynamics.zero.y,derivativeLagNoDynamicsAnalyticSolution.y,step.height,step.offset,step.startTime,step.y,time

Variables in the result:derivativeLag.T1,derivativeLag.Td,derivativeLag.feedback.y,derivativeLag.gain.k,derivativeLag.gain.u,derivativeLag.gain.y,derivativeLag.initType,derivativeLag.integrator.initType,derivativeLag.integrator.k,derivativeLag.integrator.u,derivativeLag.integrator.y,derivativeLag.integrator.y_start,derivativeLag.noDynamics,derivativeLag.u,derivativeLag.y,derivativeLag.yStart,derivativeLagAnalyticSolution.y,derivativeLagNoDynamics.T1,derivativeLagNoDynamics.Td,derivativeLagNoDynamics.feedback.u2,derivativeLagNoDynamics.feedback.y,derivativeLagNoDynamics.gain.k,derivativeLagNoDynamics.gain.u,derivativeLagNoDynamics.gain.y,derivativeLagNoDynamics.initType,derivativeLagNoDynamics.noDynamics,derivativeLagNoDynamics.u,derivativeLagNoDynamics.y,derivativeLagNoDynamics.yStart,derivativeLagNoDynamics.zero.y,derivativeLagNoDynamicsAnalyticSolution.y,step.height,step.offset,step.startTime,step.y,time