Higher packet loss

Jeevan · March 9, 2023, 9:34am

Hello there,

I have a SBC based on iMX6S. Onto which I connected the Lucid Vision Tritron 5Mp color camera. I wanted to get the video from the sensor and then to output it to the LCD without any delay. So for this, I used Aravis gstreamer element. The pipeline worked with a lower resolution set on the camera, but not obtained any frames in the actual 5MP resolution (2448*2048). For debugging purposes, I have used the arv-camera-test-0.8 utility on my PC as well as on the target board.

In PC, I am getting the frames in the required resolution without much packet loss. But on the board, I was getting 0 frames with some error packets most of the time.

See the prints below come from my board,

Looking for the first available camera
vendor name            = Lucid Vision Labs
model name             = TRI051S-C
device serial number   = 221900076
image width            = 2448
image height           = 2048
horizontal binning     = 1
vertical binning       = 1
exposure               = 72436.8 µs
gain                   = 0 dB
payload                = 5013504 bytes
gv n_stream channels   = 1
gv current channel     = 0
gv packet delay        = 80 ns
gv packet size         = 1500 bytes
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s - 1 error
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s - 1 error
  0 frame/s  -       0 MiB/s - 1 error
  2 frames/s -    9.66 MiB/s - 2 errors
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s
  2 frames/s -    9.86 MiB/s - 1 error
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s - 1 error
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s - 1 error
  0 frame/s  -       0 MiB/s - 2 errors
  0 frame/s  -       0 MiB/s - 1 error
  0 frame/s  -       0 MiB/s - 2 errors
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s - 1 error
  0 frame/s  -       0 MiB/s
  1 frame/s  -     4.8 MiB/s - 1 error
  0 frame/s  -       0 MiB/s - 1 error
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s - 2 errors
  0 frame/s  -       0 MiB/s - 1 error
  2 frames/s -      10 MiB/s - 2 errors
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s
  1 frame/s  -    4.94 MiB/s
  1 frame/s  -    3.99 MiB/s - 1 error
  0 frame/s  -       0 MiB/s
  0 frame/s  -       0 MiB/s - 1 error
^C  0 frame/s  -       0 MiB/s - 2 errors
n_completed_buffers    = 9
n_failures             = 25
n_underruns            = 0
n_timeouts             = 25
n_aborted              = 0
n_missing_frames       = 0
n_size_mismatch_errors = 10
n_received_packets     = 105531
n_missing_packets      = 44001
n_error_packets        = 0
n_ignored_packets      = 459
n_resend_requests      = 1771597
n_resent_packets       = 60496
n_resend_ratio_reached = 10
n_resend_disabled      = 0
n_duplicated_packets   = 19710
n_transferred_bytes    = 154560146
n_ignored_bytes        = 675648

Logs with all the debugs enabled is as follows

Looking for the first available camera
[15:41:51.527] 🅸 interface> Found 0 USB3Vision device (among 1 USB device)
[15:41:51.528] 🅸 interface> [GvDiscoverSocket::new] Add interface 127.0.0.1 (127.0.0.1)
[15:41:51.529] 🅸 interface> [GvDiscoverSocket::new] Add interface 192.168.40.1 (192.168.40.255)
[15:41:51.529] 🅸 interface> [GvDiscoverSocket::new] Add interface 169.254.119.15 (169.254.255.255)
[15:41:51.535] 🅸 interface> [GvInterface::discovery] Device 'Lucid Vision Labs-TRI051S-C-221900076' found (interface 192.168.40.1) user_id '' - MAC '1c:0f:af:d4:66:  '
[15:41:51.536] 🅸 device> [GvDevice::new] Interface address = 192.168.40.1
[15:41:51.536] 🅸 device> [GvDevice::new] Device address = 192.168.40.10
[15:41:51.540] 🅸 device> [GvDevice::load_genicam] xml url = 'Local:Lucid_Vision_Labs_TRI051S-C_rev1_0_9077e250626e83edfb4a3e4c6896cbc7.zip;800dab20;f204' at 0x200
[15:41:51.541] 🅸 device> [GvDevice::load_genicam] Xml address = 0x800dab20 - size = 0xf204 - Lucid_Vision_Labs_TRI051S-C_rev1_0_9077e250626e83edfb4a3e4c6896cbc7.zip
[15:41:51.967] 🅸 device> [GvDevice::load_genicam] Zipped xml data
[15:41:51.986] 🅸 dom> [GcFeature::set_attribute] Unknown attribute 'xmlns:mstns'
[15:41:52.411] 🅸 genicam> [Gc::set_default_node_data] Add 'DeviceID'
[15:41:52.412] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevCurrentIPConfigurationLLA'
[15:41:52.413] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevCurrentIPConfigurationDHCP'
[15:41:52.414] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevCurrentIPConfigurationPersistentIP'
[15:41:52.414] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevCurrentIPAddress'
[15:41:52.415] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevCurrentSubnetMask'
[15:41:52.415] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevCurrentDefaultGateway'
[15:41:52.416] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevNumberOfNetworkInterfaces'
[15:41:52.416] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevPersistentIPAddress'
[15:41:52.416] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevPersistentSubnetMask'
[15:41:52.417] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevPersistentDefaultGateway'
[15:41:52.417] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevStreamChannelCount'
[15:41:52.418] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevStreamChannelSelector'
[15:41:52.418] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCPAddrCalc'
[15:41:52.418] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevTimestampTickFrequency'
[15:41:52.420] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCPHostPort'
[15:41:52.421] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCPSFireTestPacket'
[15:41:52.421] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCPSDoNotFragment'
[15:41:52.422] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCPSBigEndian'
[15:41:52.423] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCPSPacketSize'
[15:41:52.424] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCPD'
[15:41:52.425] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCDA'
[15:41:52.425] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCSP'
[15:41:52.426] 🅸 genicam> [Gc::set_default_node_data] Add 'ArvGevSCCFGMultipart'
[15:41:52.431] 🅸 device> [GvDevice::new] Device endianness = big
[15:41:52.432] 🅸 device> [GvDevice::new] Packet resend     = yes
[15:41:52.432] 🅸 device> [GvDevice::new] Write memory      = yes
[15:41:52.432] 🅸 device> [GvDevice::new] Legacy endianness handling = no
vendor name            = Lucid Vision Labs
model name             = TRI051S-C
device serial number   = 221900076
image width            = 2448
image height           = 2048
horizontal binning     = 1
vertical binning       = 1
exposure               = 93364.1 µs
gain                   = 0 dB
payload                = 5013504 bytes
gv n_stream channels   = 1
gv current channel     = 0
gv packet delay        = 80 ns
[15:41:52.492] 🅸 device> [GvDevice::create_stream] Number of stream channels = 1
[15:41:52.528] 🅸 device> [GvDevice::auto_packet_size] Current packet size check successfull (1500 bytes)
[15:41:52.538] 🅸 stream> [GvStream::stream_new] Stream channel = 0
[15:41:52.545] 🅸 stream> [GvStream::stream_new] Packet size = 1500 byte(s)
[15:41:52.552] 🅸 stream> [GvStream::stream_new] Destination stream port = 57600
[15:41:52.553] 🅸 stream> [GvStream::stream_new] Source stream port = 49154
[15:41:52.554] 🅸 stream> [GvStream::loop] Standard socket method
gv packet size         = 1500 bytes
[15:41:53.064] 🆆 device> [GvDevice::write_memory] Ack reception timeout
[15:41:53.064] 🆆 device> [GvDevice::write_memory] Ack reception timeout
[15:41:53.565] 🆆 device> [GvDevice::write_memory] Ack reception timeout
[15:41:53.565] 🆆 device> [GvDevice::write_memory] Ack reception timeout
[15:41:53.759] 🅸 device> [GvDevice::read_register] Unexpected answer (0x00)
[15:41:53.760] 🅸 device> [GvDevice::read_register] Unexpected answer (0x00)
[15:41:54.260] 🆆 device> [GvDevice::read_register] Ack reception timeout
[15:41:54.261] 🆆 device> [GvDevice::read_register] Ack reception timeout
  0 frame/s  -       0 MiB/s
[15:41:54.800] 🅸 stream-thread> [GvStream::missing_packet_check] Maximum number of requests reached at dt = 26884, n_packet_requests = 1301 (3427 packets/frame), fr  2
[15:41:55.277] 🅸 stream-thread> [GvStream::process_data_block] 696 unexpected bytes in packet 3425  for frame 1
[15:41:55.305] 🆆 stream-thread> [GvStream::check_frame_completion] Timeout for frame 2 at dt = 532566
  1 frame/s  -    5.01 MiB/s - 1 error
  0 frame/s  -       0 MiB/s
[15:41:56.816] 🅸 stream-thread> [GvStream::missing_packet_check] Maximum number of requests reached at dt = 49628, n_packet_requests = 1231 (3427 packets/frame), fr  4
[15:41:57.181] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        3 
                     packet_id    =     3426
                     data_size    =      768
[15:41:57.269] 🆆 stream-thread> [GvStream::check_frame_completion] Timeout for frame 4 at dt = 504077
[15:41:57.270] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 3 (last: 4)
[15:41:57.270] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        3 
                     packet_id    =     3083
                     data_size    =     1464
[15:41:57.270] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 3 (last: 4)
[15:41:57.271] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        3 
                     packet_id    =     3083
                     data_size    =     1464
[15:41:57.271] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 3 (last: 4)
[15:41:57.272] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        3 
                     packet_id    =     3083
                     data_size    =     1464
  1 frame/s  -    4.79 MiB/s - 1 error
  0 frame/s  -       0 MiB/s
[15:41:59.403] 🅸 stream-thread> [GvStream::process_data_block] 696 unexpected bytes in packet 3425  for frame 6
[15:41:59.404] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3426
                     data_size    =      768
[15:41:59.760] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        5 
                     packet_id    =     3426
                     data_size    =      768
  0 frame/s  -       0 MiB/s
[15:42:00.083] 🆆 stream-thread> [GvStream::check_frame_completion] Timeout for frame 5 at dt = 2317201
[15:42:00.133] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 5 (last: 7)
[15:42:00.133] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        5 
                     packet_id    =     3413
                     data_size    =     1464
  0 frame/s  -       0 MiB/s - 1 error
[15:42:00.870] 🆆 stream-thread> [GvStream::check_frame_completion] Timeout for frame 6 at dt = 2100180
[15:42:00.877] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.878] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3053
                     data_size    =     1464
[15:42:00.878] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.878] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3121
                     data_size    =     1464
[15:42:00.878] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.878] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3122
                     data_size    =     1464
[15:42:00.878] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.879] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3123
                     data_size    =     1464
[15:42:00.879] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.879] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3124
                     data_size    =     1464
[15:42:00.879] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.879] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3165
                     data_size    =     1464
[15:42:00.879] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.879] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3166
                     data_size    =     1464
[15:42:00.881] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.881] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3110
                     data_size    =     1464
[15:42:00.881] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.881] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3179
                     data_size    =     1464
[15:42:00.881] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.881] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3268
                     data_size    =     1464
[15:42:00.881] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:00.881] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3269
                     data_size    =     1464
[15:42:01.215] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:01.215] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3270
                     data_size    =     1464
[15:42:01.216] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:01.216] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3380
                     data_size    =     1464
[15:42:01.233] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:01.233] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     2172
                     data_size    =     1464
[15:42:01.233] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:01.233] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     2927
                     data_size    =     1464
[15:42:01.234] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:01.234] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3176
                     data_size    =     1464
[15:42:01.235] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:01.235] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     2172
                     data_size    =     1464
[15:42:01.235] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:01.235] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     2841
                     data_size    =     1464
[15:42:01.235] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:01.235] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3063
                     data_size    =     1464
[15:42:01.236] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 6 (last: 8)
[15:42:01.236] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        6 
                     packet_id    =     3203
                     data_size    =     1464
[15:42:01.317] 🆆 stream-thread> [GvStream::check_frame_completion] Timeout for frame 7 at dt = 1548633
[15:42:01.344] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.344] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      453
                     data_size    =     1464
[15:42:01.344] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.344] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      454
                     data_size    =     1464
[15:42:01.344] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.345] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      455
                     data_size    =     1464
[15:42:01.345] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.345] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      872
                     data_size    =     1464
[15:42:01.345] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.678] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     1173
                     data_size    =     1464
[15:42:01.678] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.678] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     1633
                     data_size    =     1464
[15:42:01.679] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.679] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     2087
                     data_size    =     1464
[15:42:01.679] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.680] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     2509
                     data_size    =     1464
[15:42:01.680] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.680] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     2650
                     data_size    =     1464
[15:42:01.680] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.681] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     2651
                     data_size    =     1464
[15:42:01.681] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.681] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     2876
                     data_size    =     1464
[15:42:01.682] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.682] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      300
                     data_size    =     1464
[15:42:01.682] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.683] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      329
                     data_size    =     1464
[15:42:01.683] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:01.683] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      444
                     data_size    =     1464
[15:42:01.683] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
  0 frame/s  -       0 MiB/s - 2 errors
[15:42:02.017] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      447
                     data_size    =     1464
[15:42:02.017] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.018] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      453
                     data_size    =     1464
[15:42:02.018] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.018] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      454
                     data_size    =     1464
[15:42:02.018] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.019] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      455
                     data_size    =     1464
[15:42:02.019] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.019] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      505
                     data_size    =     1464
[15:42:02.019] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.020] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      510
                     data_size    =     1464
[15:42:02.020] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.020] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      512
                     data_size    =     1464
[15:42:02.020] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.021] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      513
                     data_size    =     1464
[15:42:02.021] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.021] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      514
                     data_size    =     1464
[15:42:02.022] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.022] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      515
                     data_size    =     1464
[15:42:02.022] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.356] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      517
                     data_size    =     1464
[15:42:02.356] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.357] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      529
                     data_size    =     1464
[15:42:02.357] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.357] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      572
                     data_size    =     1464
[15:42:02.358] 🆆 stream-thread> [GvStream::check_frame_completion] Timeout for frame 8 at dt = 1586848
[15:42:02.358] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.358] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      589
                     data_size    =     1464
[15:42:02.359] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.359] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      591
                     data_size    =     1464
[15:42:02.359] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.359] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      592
                     data_size    =     1464
[15:42:02.360] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.360] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      593
                     data_size    =     1464
[15:42:02.360] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.360] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      594
                     data_size    =     1464
[15:42:02.361] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.361] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      595
                     data_size    =     1464
[15:42:02.361] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.361] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      596
                     data_size    =     1464
[15:42:02.695] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.695] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      597
                     data_size    =     1464
[15:42:02.696] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.696] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      598
                     data_size    =     1464
[15:42:02.696] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.696] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      601
                     data_size    =     1464
[15:42:02.697] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.697] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      602
                     data_size    =     1464
[15:42:02.697] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.697] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      603
                     data_size    =     1464
[15:42:02.698] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.698] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      605
                     data_size    =     1464
[15:42:02.698] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.698] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      606
                     data_size    =     1464
[15:42:02.699] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.699] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      608
                     data_size    =     1464
[15:42:02.699] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.700] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      610
                     data_size    =     1464
[15:42:02.700] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:02.700] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      611
                     data_size    =     1464
[15:42:02.700] 🅸 stream-thread>   0 frame/s  -       0 MiB/s - 1 error
[GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.034] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      615
                     data_size    =     1464
[15:42:03.035] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.035] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      617
                     data_size    =     1464
[15:42:03.035] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.035] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      618
                     data_size    =     1464
[15:42:03.036] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.036] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      619
                     data_size    =     1464
[15:42:03.036] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.036] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      621
                     data_size    =     1464
[15:42:03.037] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.037] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      622
                     data_size    =     1464
[15:42:03.037] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.037] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      623
                     data_size    =     1464
[15:42:03.038] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.038] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      625
                     data_size    =     1464
[15:42:03.038] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.038] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      626
                     data_size    =     1464
[15:42:03.039] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.039] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      628
                     data_size    =     1464
[15:42:03.370] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.371] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      629
                     data_size    =     1464
[15:42:03.371] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.371] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      631
                     data_size    =     1464
[15:42:03.371] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.372] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      632
                     data_size    =     1464
[15:42:03.372] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.372] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      633
                     data_size    =     1464
[15:42:03.373] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.373] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      635
                     data_size    =     1464
[15:42:03.374] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.374] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      636
                     data_size    =     1464
[15:42:03.374] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.374] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      638
                     data_size    =     1464
[15:42:03.375] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.375] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      639
                     data_size    =     1464
[15:42:03.375] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.375] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      640
                     data_size    =     1464
[15:42:03.376] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.376] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      643
                     data_size    =     1464
[15:42:03.376] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.710] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      645
                     data_size    =     1464
[15:42:03.710] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.710] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      646
                     data_size    =     1464
[15:42:03.710] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.711] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      649
                     data_size    =     1464
[15:42:03.711] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.711] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      650
                     data_size    =     1464
[15:42:03.711] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.712] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      651
                     data_size    =     1464
[15:42:03.712] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.712] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      652
                     data_size    =     1464
[15:42:03.713] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.713] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      654
                     data_size    =     1464
[15:42:03.713] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.713] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      656
                     data_size    =     1464
[15:42:03.714] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.714] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      657
                     data_size    =     1464
[15:42:03.714] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:03.714] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      658
                     data_size    =     1464
[15:42:03.715] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
  0 frame/s  -       0 MiB/s
[15:42:04.049] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      660
                     data_size    =     1464
[15:42:04.049] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.049] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      661
                     data_size    =     1464
[15:42:04.050] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.050] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      663
                     data_size    =     1464
[15:42:04.050] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.050] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      664
                     data_size    =     1464
[15:42:04.051] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.051] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      666
                     data_size    =     1464
[15:42:04.051] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.051] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      667
                     data_size    =     1464
[15:42:04.052] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.052] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      669
                     data_size    =     1464
[15:42:04.052] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.053] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      671
                     data_size    =     1464
[15:42:04.053] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.053] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      673
                     data_size    =     1464
[15:42:04.053] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.054] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      674
                     data_size    =     1464
[15:42:04.054] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.388] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      676
                     data_size    =     1464
[15:42:04.388] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.388] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      678
                     data_size    =     1464
[15:42:04.388] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.389] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      680
                     data_size    =     1464
[15:42:04.389] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.389] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      682
                     data_size    =     1464
[15:42:04.389] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.390] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      683
                     data_size    =     1464
[15:42:04.390] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.390] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      685
                     data_size    =     1464
[15:42:04.391] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.391] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =      687
                     data_size    =     1464
[15:42:04.391] 🅸 stream-thread> [GvStream::find_frame_^Crame 7 (last: 8)
[15:42:04.649] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     1271
                     data_size    =     1464
[15:42:04.649] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.649] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     2012
                     data_size    =     1464
[15:42:04.650] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.650] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     2013
                     data_size    =     1464
[15:42:04.650] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.650] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     2521
                     data_size    =     1464
[15:42:04.651] 🅸 stream-thread> [GvStream::find_frame_data] Discard late frame 7 (last: 8)
[15:42:04.651] 🅸 sp> packet_type  =       ok (0x0000)
                     content_type =  payload (0x0003)
                     frame_id     =        7 
                     packet_id    =     2522
                     data_size    =     1464
[15:42:04.681] 🅸 stream-thread> [GvStream::missing_packet_check] Maximum number of requests reached at dt = 27453, n_packet_requests = 3396 (3427 packets/frame), fr  1
[15:42:04.713] 🅸 stream-thread> [GvStream::missing_packet_check] Maximum number of requests reached at dt = 322325, n_packet_requests = 3363 (3427 packets/frame), f  0
  0 frame/s  -       0 MiB/s
n_completed_buffers    = 2
n_failures             = 6
n_underruns            = 0
n_timeouts             = 6
n_aborted              = 0
n_missing_frames       = 1
n_size_mismatch_errors = 2
n_received_packets     = 20531
n_missing_packets      = 14430
n_error_packets        = 0
n_ignored_packets      = 123
n_resend_requests      = 193886
n_resent_packets       = 11871
n_resend_ratio_reached = 4
n_resend_disabled      = 0
n_duplicated_packets   = 2650
n_transferred_bytes    = 30014850
n_ignored_bytes        = 181056
[15:42:04.789] 🆆 stream-thread> [GvStream::check_frame_completion] Timeout for frame 10 at dt = 397349
[15:42:04.794] 🆆 stream-thread> [GvStream::check_frame_completion] Timeout for frame 11 at dt = 140177
[15:42:04.921] 🅸 stream>     bins    ;frame_retent; packet_time;inter_packet
                                    0;           0;         341;       20368
                                 2000;           0;         306;         214
                                 4000;           0;         236;          51
                                 6000;           0;         220;          39
                                 8000;           0;         207;          26
                                10000;           0;         158;          20
                                12000;           0;         191;          11
                                14000;           0;         192;          10
                                16000;           0;         160;          14
                                18000;           0;         127;           9
                                20000;           0;         221;           8
                                22000;           0;         208;           5
                                24000;           0;         189;           4
                                26000;           0;         191;           1
                                28000;           0;         238;           1
                                30000;           0;         189;           3
                                32000;           0;         204;           3
                                34000;           0;         179;           5
                                36000;           0;         142;           1
                                38000;           0;         167;           3
                                40000;           1;          80;           2
                                42000;           0;          80;           0
                                44000;           0;          95;           1
                                46000;           0;         112;           1
                                48000;           0;          31;           1
                                50000;           0;          96;           1
                                52000;           0;         123;           1
                                54000;           0;          64;           0
                                56000;           0;          48;           0
                                58000;           0;          48;           0
                                60000;           0;          80;           0
                                62000;           0;          40;           1
                                64000;           0;          12;           0
                                66000;           0;          14;           0
                                68000;           0;          11;           0
                                70000;           0;          13;           1
                                72000;           0;          26;           0
                                74000;           0;           8;           2
                                76000;           0;           9;           1
                                78000;           0;          16;           0
                                80000;           0;          12;           0
                                82000;           0;          13;           0
                                84000;           0;          28;           0
                                86000;           0;          15;           0
                                88000;           0;          16;           1
                                90000;           0;          28;           0
                                92000;           0;          39;           0
                                94000;           0;          49;           0
                                96000;           0;          48;           0
                                98000;           0;          44;           0
                               100000;           0;          19;           0
                               102000;           0;          12;           0
                               104000;           0;          12;           0
                               106000;           0;          45;           0
                               108000;           0;          16;           0
                               110000;           0;          14;           0
                               112000;           0;          26;           0
                               114000;           0;          12;           0
                               116000;           0;          12;           0
                               118000;           0;          19;           0
                               120000;           0;          23;           0
                               122000;           0;          20;           0
                               124000;           0;          16;           0
                               126000;           0;          20;           0
                               128000;           0;          13;           0
                               130000;           0;          20;           0
                               132000;           0;          37;           0
                               134000;           0;          25;           0
                               136000;           0;          22;           0
                               138000;           0;          38;           0
                               140000;           1;          15;           0
                               142000;           0;          24;           0
                               144000;           0;          17;           0
                               146000;           0;          18;           0
                               148000;           0;          37;           0
                               150000;           0;          29;           0
                               152000;           0;          45;           0
                               154000;           0;          49;           0
                               156000;           0;           9;           0
                               158000;           0;           7;           0
                               160000;           0;           9;           0
                               162000;           0;          22;           0
                               164000;           0;          25;           0
                               166000;           0;           7;           0
                               168000;           0;          22;           0
                               170000;           0;          25;           0
                               172000;           0;          23;           0
                               174000;           0;           8;           0
                               176000;           0;          25;           0
                               178000;           0;           7;           0
                               180000;           0;          36;           0
                               182000;           0;           6;           0
                               184000;           0;          22;           0
                               186000;           0;           7;           0
                               188000;           0;           8;           0
                               190000;           0;          23;           0
                               192000;           0;           7;           0
                               194000;           0;           8;           0
                               196000;           0;           8;           0
                               198000;           0;          12;           0
                         -------------
                         >=    200000;           9;       14479;           4
                         <          0;           0;           0;           0
                         min         :       40334;           0;           0
                         max         :  2.3172e+06; 2.21329e+06;      349010
                         last max at :           4;       17082;       19887
                         counter     :          11:       20824:       20813
[15:42:05.589] 🅸 stream> [GvStream::finalize] n_completed_buffers    = 2
[15:42:05.589] 🅸 stream> [GvStream::finalize] n_failures             = 8
[15:42:05.590] 🅸 stream> [GvStream::finalize] n_underruns            = 0
[15:42:05.590] 🅸 stream> [GvStream::finalize] n_timeouts             = 8
[15:42:05.590] 🅸 stream> [GvStream::finalize] n_aborted              = 1
[15:42:05.590] 🅸 stream> [GvStream::finalize] n_missing_frames       = 1
[15:42:05.590] 🅸 stream> [GvStream::finalize] n_size_mismatch_errors = 2
[15:42:05.590] 🅸 stream> [GvStream::finalize] n_received_packets     = 20947
[15:42:05.591] 🅸 stream> [GvStream::finalize] n_missing_packets      = 21189
[15:42:05.591] 🅸 stream> [GvStream::finalize] n_error_packets        = 0
[15:42:05.591] 🅸 stream> [GvStream::finalize] n_ignored_packets      = 123
[15:42:05.591] 🅸 stream> [GvStream::finalize] n_resend_requests      = 196129
[15:42:05.591] 🅸 stream> [GvStream::finalize] n_resent_packets       = 11871
[15:42:05.592] 🅸 stream> [GvStream::finalize] n_resend_ratio_reached = 4
[15:42:05.592] 🅸 stream> [GvStream::finalize] n_resend_disabled      = 0
[15:42:05.592] 🅸 stream> [GvStream::finalize] n_duplicated_packets   = 2650
[15:42:05.592] 🅸 stream> [GvStream::finalize] n_transferred_bytes    = 30625774
[15:42:05.592] 🅸 stream> [GvStream::finalize] n_ignored_bytes        = 181056
[15:42:05.593] 🅸 stream> [Stream::finalize] Flush 49 buffer[s] in input queue
[15:42:05.593] 🅸 stream> [Stream::finalize] Flush 1 buffer[s] in output queue

I am new to this GigeV term, so any help/support in resolving this issue is appreciated.

Thanks in advance.
-Jeevan

Emmanuel · March 10, 2023, 8:06am

Hi Jeevan,

Please have a look there: Aravis – 0.8: Ethernet Devices

What is the CPU use when arv-camera-test run ?
Does your board have a gigabit interface ?

Emmanuel.

Jeevan · March 13, 2023, 6:47am

Hi @Emmanuel

Thanks for your reply.

Checked on the web link you gave, I tried in that way too (socket buff size set as AUTO, stream thread as real-time & high priority) still the behavior is same not any changes observed
When I checked, I am seeing, arv-camera-test is using 49% of CPU. Not any other applications running in the background which consumes CPU.
Yes, My board has got gigabit ethernet capabilities. (BTW, MTU is 1500B on my board. I guess this may not be an issue, because the MTU size was the same value on PC and there I was getting frames properly)

Emmanuel · March 13, 2023, 8:04am

Did you try packet socket ?

Running arv-camera-test as root should be enough.

Jeevan · March 13, 2023, 8:11am

@Emmanuel , Yes I tried packet socket as well as standard mode(For this I tried invoking the arv-camera-test with and without the argument “–no-packet-socket”). All the application runs with the root root privilege in my case.

Emmanuel · March 13, 2023, 8:25am

I have seen this in the log output:

If packet socket is used, this should read “Packet socket method”.

Jeevan · March 13, 2023, 8:27am

Sorry for the confusions, I missed to point out that the very first log file is the output with --no-packet-socket argument

Jeevan · March 13, 2023, 8:55am

Hi @Emmanuel ,

Just a quick update. I was checking the logs from PC as well as from board & also playing around some arguments.

When I configured the gv-packet-delay, detected a some frames.

arv-camera-test-0.8  --no-packet-socket -y 21000
Looking for the first available camera
vendor name            = Lucid Vision Labs
model name             = TRI051S-C
device serial number   = 221900076
image width            = 2448
image height           = 2048
horizontal binning     = 1
vertical binning       = 1
exposure               = 132746 �µs
gain                   = 0 dB
payload                = 5013504 bytes
gv n_stream channels   = 1
gv current channel     = 0
gv packet delay        = 21000 ns
gv packet size         = 1400 bytes
  7 frames/s -    35.1 MiB/s
  8 frames/s -    40.1 MiB/s
  7 frames/s -    35.1 MiB/s
  8 frames/s -    40.1 MiB/s
  7 frames/s -    35.1 MiB/s
  8 frames/s -    40.1 MiB/s
  7 frames/s -    35.1 MiB/s
  8 frames/s -    40.1 MiB/s
  7 frames/s -    35.1 MiB/s
  8 frames/s -    40.1 MiB/s
^C  7 frames/s -    35.1 MiB/s
n_completed_buffers    = 82
n_failures             = 0
n_underruns            = 0
n_timeouts             = 0
n_aborted              = 0
n_missing_frames       = 0
n_size_mismatch_errors = 0
n_received_packets     = 304332
n_missing_packets      = 0
n_error_packets        = 0
n_ignored_packets      = 0
n_resend_requests      = 138
n_resent_packets       = 138
n_resend_ratio_reached = 0
n_resend_disabled      = 0
n_duplicated_packets   = 0
n_transferred_bytes    = 417276332
n_ignored_bytes        = 0

Any hints from this information?

Tried reducing the delay to a small val, but no luck in that case.

Emmanuel · March 13, 2023, 9:17am

Running arv-camera-test without --no-packet-socket does not mean aravis is using packet socket, event if it is run as root. Did you check there is “Packet socket method” in the logs ?

Emmanuel · March 13, 2023, 9:19am

On the SBC ?

gv-packet-delay is a delay between each stream packets. It is normally only useful when you are receiveing a video stream from several cameras, in order to avoid any switch buffer overflow that may happen.

Jeevan · March 13, 2023, 9:22am

Yes,

The logs I have given in this post if from the board console.

Jeevan · March 15, 2023, 6:46am

Hello @Emmanuel ,

Here is an update: Even though my SBC’s ethernet is rated as 1G, the practical Bandwidth measured on the ethernet interface is around 48MB/s (I used the iperf for the testing and it reported 390Mb/s after the test). So I am just assuming this is the culprit. I am looking around for a different SBC (which really has the 1G ethernet ) to test out my camera.

I shall keep you posted about my findings.

Thank you for the comments , in fact one of your previous comment triggered me to measure the bandwidth of ethernet.