VILLASframework / node

Connecting real-time power grid simulation equipment
https://fein-aachen.org/projects/villas-node/
Apache License 2.0
10 stars 7 forks source link

One-way delay path statistics not valid even with hook function "ts" #19

Closed stv0g closed 1 year ago

stv0g commented 8 years ago

In GitLab by @ghost on Oct 11, 2015, 22:06

Created by: mstevic

I did some tests between rtds and polito opal. I included hook function "ts". But one-way delay is still not valid

[root@acs server]# ./server etc/acs-s2ss-test3.conf
     0.000       ├ This is Simulator2Simulator Server (S2SS)
     0.000       ├   Version: v0.5-059e993 (built on Oct 11 2015, 13:43:22)
     0.000       ├ Initialize real-time system
     0.000 Warn  │ ├ We recommend to use an PREEMPT_RT patched kernel!
     0.000 Warn  │ ├ Use setting 'priority' to enable real-time scheduling!
     0.000 Warn  │ ├ Use setting 'affinity' to pin process to isolated CPU cores!
     0.000       ├ Initialize signals
     0.000       ├ Parsing configuration
     0.000       ├ Initialize node types
     0.000       │ ├ Initializing 'socket' node type
     0.001 Warn  │ │ ├ Did not found any interrupts for interface 'p5p1'
     0.001 Warn  │ │ ├ Did not found any interrupts for interface 's2ss-turin'
     0.001       │ │ ├ Starting interface 'p5p1' which is used by 1 sockets
     0.001       │ │ ├ Starting interface 's2ss-turin' which is used by 1 sockets
     0.001       ├ Starting nodes
     0.001       ├ Starting paths
     0.001       │ ├ Starting path: acs-gtfpga2 => polito-s2ss (poolsize = 32, msgsize = 64, #hooks = 4)
     0.001       │ ├ Starting path: polito-s2ss => acs-gtfpga2 (poolsize = 32, msgsize = 64, #hooks = 5)
     0.001       ├ Source => Destination   :   #Sent    #Recv    #Drop    #Skip    #Invalid #Overuns
     0.001       ├──────────────────────────────────────────────────────────────────────────
     2.001       ├ acs-gtfpga2 => polito-s2ss :   4001     4001     0        0        0        0
     4.001       ├ polito-s2ss => acs-gtfpga2 :   8002     8002     0        0        0        0
     6.001       ├ acs-gtfpga2 => polito-s2ss :   12001    12001    0        0        0        0
     8.001       ├ polito-s2ss => acs-gtfpga2 :   16004    16004    0        0        0        0
     8.645       ├ Stopping paths
     8.645       │ ├ Stopping path: acs-gtfpga2 => polito-s2ss
     8.645       │ ├ One-way delay (received):
     8.645       │ │ ├ Total: 17289 values
     8.645       │ │ ├ Highest value: 0.000000
     8.645       │ │ ├ Lowest  value: -1444593567.021648
     8.645       │ │ ├ Mean: -1444593562.699969
     8.645       │ │ ├ Variance: 6.226760
     8.645       │ │ ├ Standard derivation: 2.495348
     8.645 Warn  │ │ ├ Missed:  17289 values below 0.000000
     8.645       │ ├ Message gap time:
     8.645       │ │ ├ Total: 17289 values
     8.645       │ │ ├ Highest value: 0.000000
     8.645       │ │ ├ Lowest  value: 0.000000
     8.645       │ │ ├ Mean: 0.000000
     8.646       │ │ ├ Variance: 0.000000
     8.646       │ │ ├ Standard derivation: 0.000000
     8.646       │ │ ├   # |     Value | Occur | Plot
     8.646       │ │ ├──────────────────────────────────────────────────────────────────────────
     8.646       │ │ ├   0 | +0.00e+00 | 17289 | ###################
     8.646       │ │ ├   1 | +1.00e-03 |     0 |
     8.646       │ │ ├   2 | +2.00e-03 |     0 |
     8.646       │ │ ├   3 | +3.00e-03 |     0 |
     8.646       │ │ ├   4 | +4.00e-03 |     0 |
     8.646       │ │ ├   5 | +5.00e-03 |     0 |
     8.646       │ │ ├   6 | +6.00e-03 |     0 |
     8.646       │ │ ├   7 | +7.00e-03 |     0 |
     8.646       │ │ ├   8 | +8.00e-03 |     0 |
     8.646       │ │ ├   9 | +9.00e-03 |     0 |
     8.646       │ │ ├  10 | +1.00e-02 |     0 |
     8.646       │ │ ├  11 | +1.10e-02 |     0 |
     8.646       │ │ ├  12 | +1.20e-02 |     0 |
     8.646       │ │ ├  13 | +1.30e-02 |     0 |
     8.646       │ │ ├  14 | +1.40e-02 |     0 |
     8.646       │ │ ├  15 | +1.50e-02 |     0 |
     8.646       │ │ ├  16 | +1.60e-02 |     0 |
     8.646       │ │ ├  17 | +1.70e-02 |     0 |
     8.646       │ │ ├  18 | +1.80e-02 |     0 |
     8.646       │ │ ├  19 | +1.90e-02 |     0 |
     8.646       │ │ ├  20 | +2.00e-02 |     0 |
     8.646       │ │ ├  21 | +2.10e-02 |     0 |
     8.646       │ │ ├  22 | +2.20e-02 |     0 |
     8.646       │ │ ├  23 | +2.30e-02 |     0 |
     8.646       │ │ ├  24 | +2.40e-02 |     0 |
     8.646       │ │ ├  25 | +2.50e-02 |     0 |
     8.646       │ │ ├  26 | +2.60e-02 |     0 |
     8.646       │ │ ├  27 | +2.70e-02 |     0 |
     8.646       │ │ ├  28 | +2.80e-02 |     0 |
     8.646       │ │ ├  29 | +2.90e-02 |     0 |
     8.646       │ │ ├  30 | +3.00e-02 |     0 |
     8.646       │ │ ├  31 | +3.10e-02 |     0 |
     8.646       │ │ ├  32 | +3.20e-02 |     0 |
     8.646       │ │ ├  33 | +3.30e-02 |     0 |
     8.646       │ │ ├  34 | +3.40e-02 |     0 |
     8.646       │ │ ├  35 | +3.50e-02 |     0 |
     8.646       │ │ ├  36 | +3.60e-02 |     0 |
     8.646       │ │ ├  37 | +3.70e-02 |     0 |
     8.646       │ │ ├  38 | +3.80e-02 |     0 |
     8.646       │ │ ├  39 | +3.90e-02 |     0 |
     8.646       │ │ ├ Matlab: [ 17289 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]
     8.646       │ ├ Sequence number gaps:
     8.646       │ │ ├ Total: 17289 values
     8.646       │ │ ├ Highest value: 1.000000
     8.646       │ │ ├ Lowest  value: 0.000000
     8.646       │ │ ├ Mean: 0.999942
     8.646       │ │ ├ Variance: 0.000058
     8.646       │ │ ├ Standard derivation: 0.007605
     8.646       │ │ ├   # |     Value | Occur | Plot
     8.646       │ │ ├──────────────────────────────────────────────────────────────────────────
     8.646       │ │ ├   0 | -1.70e+01 |     0 |
     8.646       │ │ ├   1 | -1.60e+01 |     0 |
     8.646       │ │ ├   2 | -1.50e+01 |     0 |
     8.646       │ │ ├   3 | -1.40e+01 |     0 |
     8.646       │ │ ├   4 | -1.30e+01 |     0 |
     8.646       │ │ ├   5 | -1.20e+01 |     0 |
     8.646       │ │ ├   6 | -1.10e+01 |     0 |
     8.646       │ │ ├   7 | -1.00e+01 |     0 |
     8.646       │ │ ├   8 | -9.00e+00 |     0 |
     8.646       │ │ ├   9 | -8.00e+00 |     0 |
     8.646       │ │ ├  10 | -7.00e+00 |     0 |
     8.646       │ │ ├  11 | -6.00e+00 |     0 |
     8.646       │ │ ├  12 | -5.00e+00 |     0 |
     8.646       │ │ ├  13 | -4.00e+00 |     0 |
     8.646       │ │ ├  14 | -3.00e+00 |     0 |
     8.646       │ │ ├  15 | -2.00e+00 |     0 |
     8.646       │ │ ├  16 | -1.00e+00 |     0 |
     8.646       │ │ ├  17 | +0.00e+00 |     1 |
     8.646       │ │ ├  18 | +1.00e+00 | 17288 | ###################
     8.646       │ │ ├  19 | +2.00e+00 |     0 |
     8.646       │ │ ├  20 | +3.00e+00 |     0 |
     8.646       │ │ ├  21 | +4.00e+00 |     0 |
     8.646       │ │ ├  22 | +5.00e+00 |     0 |
     8.646       │ │ ├  23 | +6.00e+00 |     0 |
     8.646       │ │ ├  24 | +7.00e+00 |     0 |
     8.646       │ │ ├  25 | +8.00e+00 |     0 |
     8.646       │ │ ├  26 | +9.00e+00 |     0 |
     8.646       │ │ ├  27 | +1.00e+01 |     0 |
     8.646       │ │ ├  28 | +1.10e+01 |     0 |
     8.646       │ │ ├  29 | +1.20e+01 |     0 |
     8.646       │ │ ├  30 | +1.30e+01 |     0 |
     8.646       │ │ ├  31 | +1.40e+01 |     0 |
     8.646       │ │ ├  32 | +1.50e+01 |     0 |
     8.646       │ │ ├  33 | +1.60e+01 |     0 |
     8.646       │ │ ├ Matlab: [ 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 17288 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]
     8.646       │ ├ Stopping path: polito-s2ss => acs-gtfpga2
     8.646       │ ├ One-way delay (received):
     8.646       │ │ ├ Total: 17294 values
     8.646       │ │ ├ Highest value: 0.000000
     8.646       │ │ ├ Lowest  value: -0.015344
     8.646       │ │ ├ Mean: -0.012740
     8.646       │ │ ├ Variance: 0.000000
     8.646       │ │ ├ Standard derivation: 0.000117
     8.646       │ │ ├   # |     Value | Occur | Plot
     8.646       │ │ ├──────────────────────────────────────────────────────────────────────────
     8.646       │ │ ├   0 | +0.00e+00 | 17294 | ###################
     8.646       │ │ ├   1 | +1.00e-01 |     0 |
     8.646       │ │ ├   2 | +2.00e-01 |     0 |
     8.646       │ │ ├   3 | +3.00e-01 |     0 |
     8.646       │ │ ├   4 | +4.00e-01 |     0 |
     8.646       │ │ ├   5 | +5.00e-01 |     0 |
     8.646       │ │ ├   6 | +6.00e-01 |     0 |
     8.646       │ │ ├   7 | +7.00e-01 |     0 |
     8.646       │ │ ├   8 | +8.00e-01 |     0 |
     8.646       │ │ ├   9 | +9.00e-01 |     0 |
     8.646       │ │ ├  10 | +1.00e+00 |     0 |
     8.646       │ │ ├  11 | +1.10e+00 |     0 |
     8.646       │ │ ├  12 | +1.20e+00 |     0 |
     8.646       │ │ ├  13 | +1.30e+00 |     0 |
     8.646       │ │ ├  14 | +1.40e+00 |     0 |
     8.646       │ │ ├  15 | +1.50e+00 |     0 |
     8.646       │ │ ├  16 | +1.60e+00 |     0 |
     8.646       │ │ ├  17 | +1.70e+00 |     0 |
     8.646       │ │ ├  18 | +1.80e+00 |     0 |
     8.646       │ │ ├  19 | +1.90e+00 |     0 |
     8.646       │ │ ├ Matlab: [ 17294 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]
     8.646       │ ├ Message gap time:
     8.646       │ │ ├ Total: 17294 values
     8.646       │ │ ├ Highest value: 0.000000
     8.646       │ │ ├ Lowest  value: -0.014755
     8.646       │ │ ├ Mean: -0.012239
     8.646       │ │ ├ Variance: 0.000000
     8.646       │ │ ├ Standard derivation: 0.000157
     8.646 Warn  │ │ ├ Missed:  17293 values below 0.000000
     8.646       │ │ ├   # |     Value | Occur | Plot
     8.646       │ │ ├──────────────────────────────────────────────────────────────────────────
     8.646       │ │ ├   0 | +0.00e+00 |     1 | ###################
     8.646       │ │ ├   1 | +1.00e-03 |     0 |
     8.646       │ │ ├   2 | +2.00e-03 |     0 |
     8.646       │ │ ├   3 | +3.00e-03 |     0 |
     8.646       │ │ ├   4 | +4.00e-03 |     0 |
     8.646       │ │ ├   5 | +5.00e-03 |     0 |
     8.646       │ │ ├   6 | +6.00e-03 |     0 |
     8.646       │ │ ├   7 | +7.00e-03 |     0 |
     8.646       │ │ ├   8 | +8.00e-03 |     0 |
     8.646       │ │ ├   9 | +9.00e-03 |     0 |
     8.646       │ │ ├  10 | +1.00e-02 |     0 |
     8.646       │ │ ├  11 | +1.10e-02 |     0 |
     8.646       │ │ ├  12 | +1.20e-02 |     0 |
     8.646       │ │ ├  13 | +1.30e-02 |     0 |
     8.646       │ │ ├  14 | +1.40e-02 |     0 |
     8.646       │ │ ├  15 | +1.50e-02 |     0 |
     8.646       │ │ ├  16 | +1.60e-02 |     0 |
     8.646       │ │ ├  17 | +1.70e-02 |     0 |
     8.646       │ │ ├  18 | +1.80e-02 |     0 |
     8.646       │ │ ├  19 | +1.90e-02 |     0 |
     8.646       │ │ ├  20 | +2.00e-02 |     0 |
     8.646       │ │ ├  21 | +2.10e-02 |     0 |
     8.646       │ │ ├  22 | +2.20e-02 |     0 |
     8.646       │ │ ├  23 | +2.30e-02 |     0 |
     8.646       │ │ ├  24 | +2.40e-02 |     0 |
     8.647       │ │ ├  25 | +2.50e-02 |     0 |
     8.647       │ │ ├  26 | +2.60e-02 |     0 |
     8.647       │ │ ├  27 | +2.70e-02 |     0 |
     8.647       │ │ ├  28 | +2.80e-02 |     0 |
     8.647       │ │ ├  29 | +2.90e-02 |     0 |
     8.647       │ │ ├  30 | +3.00e-02 |     0 |
     8.647       │ │ ├  31 | +3.10e-02 |     0 |
     8.647       │ │ ├  32 | +3.20e-02 |     0 |
     8.647       │ │ ├  33 | +3.30e-02 |     0 |
     8.647       │ │ ├  34 | +3.40e-02 |     0 |
     8.647       │ │ ├  35 | +3.50e-02 |     0 |
     8.647       │ │ ├  36 | +3.60e-02 |     0 |
     8.647       │ │ ├  37 | +3.70e-02 |     0 |
     8.647       │ │ ├  38 | +3.80e-02 |     0 |
     8.647       │ │ ├  39 | +3.90e-02 |     0 |
     8.647       │ │ ├ Matlab: [ 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]
     8.647       │ ├ Sequence number gaps:
     8.647       │ │ ├ Total: 17294 values
     8.647       │ │ ├ Highest value: 1.000000
     8.647       │ │ ├ Lowest  value: 0.000000
     8.647       │ │ ├ Mean: 0.999942
     8.647       │ │ ├ Variance: 0.000058
     8.647       │ │ ├ Standard derivation: 0.007604
     8.647       │ │ ├   # |     Value | Occur | Plot
     8.647       │ │ ├──────────────────────────────────────────────────────────────────────────
     8.647       │ │ ├   0 | -1.70e+01 |     0 |
     8.647       │ │ ├   1 | -1.60e+01 |     0 |
     8.647       │ │ ├   2 | -1.50e+01 |     0 |
     8.647       │ │ ├   3 | -1.40e+01 |     0 |
     8.647       │ │ ├   4 | -1.30e+01 |     0 |
     8.647       │ │ ├   5 | -1.20e+01 |     0 |
     8.647       │ │ ├   6 | -1.10e+01 |     0 |
     8.647       │ │ ├   7 | -1.00e+01 |     0 |
     8.647       │ │ ├   8 | -9.00e+00 |     0 |
     8.647       │ │ ├   9 | -8.00e+00 |     0 |
     8.647       │ │ ├  10 | -7.00e+00 |     0 |
     8.647       │ │ ├  11 | -6.00e+00 |     0 |
     8.647       │ │ ├  12 | -5.00e+00 |     0 |
     8.647       │ │ ├  13 | -4.00e+00 |     0 |
     8.647       │ │ ├  14 | -3.00e+00 |     0 |
     8.647       │ │ ├  15 | -2.00e+00 |     0 |
     8.647       │ │ ├  16 | -1.00e+00 |     0 |
     8.647       │ │ ├  17 | +0.00e+00 |     1 |
     8.647       │ │ ├  18 | +1.00e+00 | 17293 | ###################
     8.647       │ │ ├  19 | +2.00e+00 |     0 |
     8.647       │ │ ├  20 | +3.00e+00 |     0 |
     8.647       │ │ ├  21 | +4.00e+00 |     0 |
     8.647       │ │ ├  22 | +5.00e+00 |     0 |
     8.647       │ │ ├  23 | +6.00e+00 |     0 |
     8.647       │ │ ├  24 | +7.00e+00 |     0 |
     8.647       │ │ ├  25 | +8.00e+00 |     0 |
     8.647       │ │ ├  26 | +9.00e+00 |     0 |
     8.647       │ │ ├  27 | +1.00e+01 |     0 |
     8.647       │ │ ├  28 | +1.10e+01 |     0 |
     8.647       │ │ ├  29 | +1.20e+01 |     0 |
     8.647       │ │ ├  30 | +1.30e+01 |     0 |
     8.647       │ │ ├  31 | +1.40e+01 |     0 |
     8.647       │ │ ├  32 | +1.50e+01 |     0 |
     8.647       │ │ ├  33 | +1.60e+01 |     0 |
     8.647       │ │ ├ Matlab: [ 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 17293 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]
     8.647       ├ Stopping nodes
     8.647       │ ├ Stopping node 'acs-gtfpga2'
     8.647       │ ├ Stopping node 'polito-s2ss'
     8.647       ├ De-initializing node types
     8.647       │ ├ De-initializing 'socket' node type
     8.647       │ │ ├ Stopping interface 'p5p1'
     8.647       │ │ ├ Stopping interface 's2ss-turin'
     8.647       ├ Goodbye!
[root@acs server]#
stv0g commented 8 years ago

Created by: stv0g

The incredible high OWD for acs-gtfpga -> polito-s2ss is because OWD statistics are collected before we apply the ts hook.

This will be fixed by adding a new (implicit) hook which will replace invalid timestamps before statistics are collected.

stv0g commented 8 years ago

Created by: stv0g

This implicit hook function ("fix_ts") has been added by commit 0200f5608e619d58e507a5c86d8b6c58f364b37e.

This is an internal function which means that it will be added to every path implicitly. It will check the value of the timestamp. If it is invalid (0 or -1) we will add the current time.