EmmanuelP
commented
3 years ago Please retry with --debug=all.
Closed Shorlaks closed 3 years ago
EmmanuelP
commented
3 years ago Please retry with --debug=all.
Shorlaks
commented
3 years ago Hi EmmanuelP. Thank you for the quick response. Iv'e ran it for a few seconds and pressed Ctrl+C
pi@raspberrypi:~/Downloads/aravis-0.8.6/build/tests $ ./arv-camera-test --debug=all
Looking for the first available camera
Found 0 USB3Vision device (among 6 USB devices)
[GvDiscoverSocket::new] Add interface 127.0.0.1
[GvDiscoverSocket::new] Add interface 10.53.148.116
[GvDiscoverSocket::new] Add interface 169.254.94.131
[GvInterface::discovery] Device 'GigaLinx-GigE_Connect-10001' found (interface 169.254.94.131) user_id '' - MAC '00:50:c2:8c:f0:87'
[GvDevice::new] Interface address = 169.254.94.131
[GvDevice::new] Device address = 169.254.0.8
[GvDevice::load_genicam] xml url = 'Local:Rafael_Flir_GEV_v5_my.xml;C00F8000;617E' at 0x200
[GvDevice::load_genicam] Xml address = 0xc00f8000 - size = 0x617e - Rafael_Flir_GEV_v5_my.xml
[GcFeature::set_attribute] Unknown attribute 'StandardNameSpace'
[GcFeature::set_attribute] Unknown attribute 'ToolTip'
[GcFeature::set_attribute] Unknown attribute 'ProductGuid'
[GcFeature::set_attribute] Unknown attribute 'VersionGuid'
[GcFeature::set_attribute] Unknown attribute 'xmlns'
[GcFeature::set_attribute] Unknown attribute 'xmlns:xsi'
[GcFeature::set_attribute] Unknown attribute 'xsi:schemaLocation'
[Gc::set_default_node_data] Add 'DeviceVendorName'
[Gc::set_default_node_data] Add 'DeviceModelName'
[Gc::set_default_node_data] Add 'DeviceVersion'
[Gc::set_default_node_data] Add 'DeviceManufacturerInfo'
[Gc::set_default_node_data] Add 'DeviceID'
[Gc::set_default_node_data] Add 'GevStreamChannelCount'
[Gc::set_default_node_data] Add 'GevTimestampTickFrequency'
[Gc::set_default_node_data] Add 'GevSCPHostPort'
[Gc::set_default_node_data] Add 'GevSCPSDoNotFragment'
[Gc::set_default_node_data] Add 'GevSCPSBigEndian'
[Gc::set_default_node_data] Add 'GevSCDA'
[Gc::set_default_node_data] Add 'GevSCSP'
[Gc::set_default_node_data] Add 'GevSCPAddrCalc'
[GvDevice::new] Packet resend = yes
[GvDevice::new] Write memory = yes
[GvDevice::new] Legacy endianness handling = yes
vendor name = GigaLinx
model name = GigE_Connect
device id = 10001
image width = 480
image height = 385
horizontal binning = 0
vertical binning = -1231105060
payload = 369600 bytes
exposure = 0 µs
gain = 0 dB
[GvDevice::create_stream] Number of stream channels = 1
[GvDevice::auto_packet_size] No GevSCPSFireTestPacket feature found
[GvStream::stream_new] Packet size = 8036 byte(s)
[GvStream::stream_new] Destination stream port = 42443
[GvStream::stream_new] Source stream port = 0
[GvStream::stream_thread] Packet timeout = 40 ms
[GvStream::stream_thread] Frame retention = 200 ms
[GvStream::loop] Standard socket method
gv n_stream channels = 1
gv current channel = 0
gv packet delay = 384 ns
gv packet size = 8036 bytes
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3333, n_packet_requests = 47 (49 packets/frame), frame_id = 2392
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3384, n_packet_requests = 47 (49 packets/frame), frame_id = 2393
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3416, n_packet_requests = 47 (49 packets/frame), frame_id = 2394
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3425, n_packet_requests = 47 (49 packets/frame), frame_id = 2395
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3486, n_packet_requests = 47 (49 packets/frame), frame_id = 2396
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3325, n_packet_requests = 47 (49 packets/frame), frame_id = 2397
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3432, n_packet_requests = 47 (49 packets/frame), frame_id = 2398
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3384, n_packet_requests = 47 (49 packets/frame), frame_id = 2399
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3478, n_packet_requests = 47 (49 packets/frame), frame_id = 2400
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3395, n_packet_requests = 47 (49 packets/frame), frame_id = 2401
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3472, n_packet_requests = 47 (49 packets/frame), frame_id = 2402
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3372, n_packet_requests = 47 (49 packets/frame), frame_id = 2403
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3438, n_packet_requests = 47 (49 packets/frame), frame_id = 2404
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3479, n_packet_requests = 47 (49 packets/frame), frame_id = 2405
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3411, n_packet_requests = 47 (49 packets/frame), frame_id = 2406
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3437, n_packet_requests = 47 (49 packets/frame), frame_id = 2407
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3430, n_packet_requests = 47 (49 packets/frame), frame_id = 2408
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3523, n_packet_requests = 47 (49 packets/frame), frame_id = 2409
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3416, n_packet_requests = 47 (49 packets/frame), frame_id = 2410
..
..
..
[GvStream::check_frame_completion] Timeout for frame 2631 at dt = 105401
[GvStream::check_frame_completion] Timeout for frame 2632 at dt = 103727
bins ;Buffer r
0; 1
2000; 0
4000; 1
6000; 0
8000; 1
10000; 0
12000; 1
14000; 0
16000; 1
18000; 0
20000; 1
22000; 0
24000; 1
26000; 0
28000; 1
30000; 0
32000; 1
34000; 1
36000; 0
38000; 1
40000; 0
42000; 1
44000; 0
46000; 1
48000; 0
50000; 1
52000; 0
54000; 1
56000; 0
58000; 1
60000; 0
62000; 1
64000; 0
66000; 1
68000; 1
70000; 0
72000; 1
74000; 0
76000; 1
78000; 0
80000; 1
82000; 0
84000; 1
86000; 0
88000; 1
90000; 0
92000; 1
94000; 0
96000; 1
98000; 1
100000; 0
102000; 1
104000; 234
-------------
>=106000; 0
< 0; 0
min ; 1972
max ; 105715
last max
at: ; 2601
Counter = 2659
[GvStream::finalize] n_completed_buffers = 0
[GvStream::finalize] n_failures = 241
[GvStream::finalize] n_timeouts = 241
[GvStream::finalize] n_aborteds = 27
[GvStream::finalize] n_underruns = 0
[GvStream::finalize] n_missing_frames = 0
[GvStream::finalize] n_size_mismatch_errors = 0
[GvStream::finalize] n_received_packets = 535
[GvStream::finalize] n_missing_packets = 11568
[GvStream::finalize] n_error_packets = 0
[GvStream::finalize] n_ignored_packets = 0
[GvStream::finalize] n_resend_requests = 0
[GvStream::finalize] n_resent_packets = 0
[GvStream::finalize] n_resend_ratio_reached = 267
[GvStream::finalize] n_duplicated_packets = 0
[Stream::finalize] Flush 22 buffer[s] in input queue
[Stream::finalize] Flush 28 buffer[s] in output queueThanks you, Shorlaks
EmmanuelP
commented
3 years ago The packet size is probably to big, aravis only receives leader and trailer packets.
Try to set the packet size to 1500 (-i 1500)
Shorlaks
commented
3 years ago Is that how i set the packet size?
Thanks, Shorlaks
EmmanuelP
commented
3 years ago Yes. What gives the debug output ?
Shorlaks
commented
3 years ago pi@raspberrypi:~/Downloads/aravis-0.8.6/build/tests $ ./arv-camera-test -i 1500 --debug=all
Looking for the first available camera
Found 0 USB3Vision device (among 6 USB devices)
[GvDiscoverSocket::new] Add interface 127.0.0.1
[GvDiscoverSocket::new] Add interface 169.254.94.131
[GvInterface::discovery] Device 'GigaLinx-GigE_Connect-10001' found (interface 169.254.94.131) user_id '' - MAC '00:50:c2:8c:f0:87'
[GvDevice::new] Interface address = 169.254.94.131
[GvDevice::new] Device address = 169.254.0.8
[GvDevice::load_genicam] xml url = 'Local:Rafael_Flir_GEV_v5_my.xml;C00F8000;617E' at 0x200
[GvDevice::load_genicam] Xml address = 0xc00f8000 - size = 0x617e - Rafael_Flir_GEV_v5_my.xml
[GcFeature::set_attribute] Unknown attribute 'StandardNameSpace'
[GcFeature::set_attribute] Unknown attribute 'ToolTip'
[GcFeature::set_attribute] Unknown attribute 'ProductGuid'
[GcFeature::set_attribute] Unknown attribute 'VersionGuid'
[GcFeature::set_attribute] Unknown attribute 'xmlns'
[GcFeature::set_attribute] Unknown attribute 'xmlns:xsi'
[GcFeature::set_attribute] Unknown attribute 'xsi:schemaLocation'
[Gc::set_default_node_data] Add 'DeviceVendorName'
[Gc::set_default_node_data] Add 'DeviceModelName'
[Gc::set_default_node_data] Add 'DeviceVersion'
[Gc::set_default_node_data] Add 'DeviceManufacturerInfo'
[Gc::set_default_node_data] Add 'DeviceID'
[Gc::set_default_node_data] Add 'GevStreamChannelCount'
[Gc::set_default_node_data] Add 'GevTimestampTickFrequency'
[Gc::set_default_node_data] Add 'GevSCPHostPort'
[Gc::set_default_node_data] Add 'GevSCPSDoNotFragment'
[Gc::set_default_node_data] Add 'GevSCPSBigEndian'
[Gc::set_default_node_data] Add 'GevSCDA'
[Gc::set_default_node_data] Add 'GevSCSP'
[Gc::set_default_node_data] Add 'GevSCPAddrCalc'
[GvDevice::new] Packet resend = yes
[GvDevice::new] Write memory = yes
[GvDevice::new] Legacy endianness handling = yes
vendor name = GigaLinx
model name = GigE_Connect
device id = 10001
image width = 480
image height = 385
horizontal binning = 0
vertical binning = -1230703652
payload = 369600 bytes
exposure = 0 µs
gain = 0 dB
[GvDevice::create_stream] Number of stream channels = 1
[GvDevice::auto_packet_size] No GevSCPSFireTestPacket feature found
[GvStream::stream_new] Packet size = 1500 byte(s)
[GvStream::stream_new] Destination stream port = 35048
[GvStream::stream_new] Source stream port = 0
[GvStream::stream_thread] Packet timeout = 40 ms
[GvStream::stream_thread] Frame retention = 200 ms
[GvStream::loop] Standard socket method
gv n_stream channels = 1
gv current channel = 0
gv packet delay = 384 ns
gv packet size = 1500 bytes
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 205 (255 packets/frame), frame_id = 17326
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 30909, n_packet_requests = 198 (255 packets/frame), frame_id = 17324
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 4660, n_packet_requests = 66 (255 packets/frame), frame_id = 17333
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3378, n_packet_requests = 64 (255 packets/frame), frame_id = 17335
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 456, n_packet_requests = 82 (255 packets/frame), frame_id = 17336
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 141 (255 packets/frame), frame_id = 17338
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3241, n_packet_requests = 178 (255 packets/frame), frame_id = 17339
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2923, n_packet_requests = 76 (255 packets/frame), frame_id = 17340
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 247, n_packet_requests = 95 (255 packets/frame), frame_id = 17341
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 24259, n_packet_requests = 159 (255 packets/frame), frame_id = 17337
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 4354, n_packet_requests = 70 (255 packets/frame), frame_id = 17343
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 4630, n_packet_requests = 69 (255 packets/frame), frame_id = 17344
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 6077, n_packet_requests = 71 (255 packets/frame), frame_id = 17345
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 134 (255 packets/frame), frame_id = 17347
[GvStream::check_frame_completion] Timeout for frame 17324 at dt = 110895
[GvStream::check_frame_completion] Timeout for frame 17326 at dt = 101848
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 102 (255 packets/frame), frame_id = 17352
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 24580, n_packet_requests = 145 (255 packets/frame), frame_id = 17346
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 4920, n_packet_requests = 110 (255 packets/frame), frame_id = 17353
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 76, n_packet_requests = 83 (255 packets/frame), frame_id = 17354
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 24881, n_packet_requests = 88 (255 packets/frame), frame_id = 17348
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 143 (255 packets/frame), frame_id = 17355
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 64 (255 packets/frame), frame_id = 17357
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 94, n_packet_requests = 102 (255 packets/frame), frame_id = 17358
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1892, n_packet_requests = 79 (255 packets/frame), frame_id = 17359
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2613, n_packet_requests = 127 (255 packets/frame), frame_id = 17360
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 24490, n_packet_requests = 84 (255 packets/frame), frame_id = 17350
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 112 (255 packets/frame), frame_id = 17362
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 108 (255 packets/frame), frame_id = 17363
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 926, n_packet_requests = 65 (255 packets/frame), frame_id = 17364
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3045, n_packet_requests = 66 (255 packets/frame), frame_id = 17368
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 23507, n_packet_requests = 96 (255 packets/frame), frame_id = 17361
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2715, n_packet_requests = 78 (255 packets/frame), frame_id = 17369
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 4002, n_packet_requests = 77 (255 packets/frame), frame_id = 17370
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 4231, n_packet_requests = 135 (255 packets/frame), frame_id = 17376
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 24122, n_packet_requests = 208 (255 packets/frame), frame_id = 17379
[GvStream::check_frame_completion] Timeout for frame 17327 at dt = 224135
[GvStream::check_frame_completion] Timeout for frame 17328 at dt = 218267
[GvStream::check_frame_completion] Timeout for frame 17329 at dt = 210742
[GvStream::check_frame_completion] Timeout for frame 17330 at dt = 205697
[GvStream::check_frame_completion] Timeout for frame 17331 at dt = 201723
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1473, n_packet_requests = 141 (255 packets/frame), frame_id = 17388
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2046, n_packet_requests = 102 (255 packets/frame), frame_id = 17390
[GvStream::check_frame_completion] Timeout for frame 17332 at dt = 208687
[GvStream::check_frame_completion] Timeout for frame 17333 at dt = 205142
[GvStream::check_frame_completion] Timeout for frame 17334 at dt = 200359
[GvStream::check_frame_completion] Timeout for frame 17335 at dt = 195933
[GvStream::check_frame_completion] Timeout for frame 17336 at dt = 190122
[GvStream::check_frame_completion] Timeout for frame 17337 at dt = 186432
[GvStream::check_frame_completion] Timeout for frame 17338 at dt = 182161
[GvStream::check_frame_completion] Timeout for frame 17339 at dt = 181583
[GvStream::check_frame_completion] Timeout for frame 17340 at dt = 177225
[GvStream::check_frame_completion] Timeout for frame 17341 at dt = 170933
[GvStream::check_frame_completion] Timeout for frame 17343 at dt = 165881
[GvStream::check_frame_completion] Timeout for frame 17344 at dt = 161380
[GvStream::check_frame_completion] Timeout for frame 17345 at dt = 156310
[GvStream::check_frame_completion] Timeout for frame 17346 at dt = 150058
[GvStream::check_frame_completion] Timeout for frame 17347 at dt = 145476
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 5063, n_packet_requests = 96 (255 packets/frame), frame_id = 17391
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 71 (255 packets/frame), frame_id = 17392
[GvStream::check_frame_completion] Timeout for frame 17348 at dt = 147709
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 5747, n_packet_requests = 148 (255 packets/frame), frame_id = 17393
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 119 (255 packets/frame), frame_id = 17394
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1466, n_packet_requests = 84 (255 packets/frame), frame_id = 17396
[GvStream::check_frame_completion] Timeout for frame 17349 at dt = 171594
[GvStream::check_frame_completion] Timeout for frame 17350 at dt = 164249
[GvStream::check_frame_completion] Timeout for frame 17352 at dt = 159806
[GvStream::check_frame_completion] Timeout for frame 17353 at dt = 159033
[GvStream::check_frame_completion] Timeout for frame 17354 at dt = 154042
[GvStream::check_frame_completion] Timeout for frame 17355 at dt = 151432
[GvStream::check_frame_completion] Timeout for frame 17357 at dt = 150356
[GvStream::check_frame_completion] Timeout for frame 17358 at dt = 147569
[GvStream::check_frame_completion] Timeout for frame 17359 at dt = 146671
[GvStream::check_frame_completion] Timeout for frame 17360 at dt = 144494
[GvStream::check_frame_completion] Timeout for frame 17361 at dt = 141782
[GvStream::check_frame_completion] Timeout for frame 17362 at dt = 138211
[GvStream::check_frame_completion] Timeout for frame 17363 at dt = 135948
[GvStream::check_frame_completion] Timeout for frame 17364 at dt = 133526
[GvStream::check_frame_completion] Timeout for frame 17365 at dt = 132517
[GvStream::check_frame_completion] Timeout for frame 17366 at dt = 129456
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1519, n_packet_requests = 137 (255 packets/frame), frame_id = 17402
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 5007, n_packet_requests = 167 (255 packets/frame), frame_id = 17403
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 70 (255 packets/frame), frame_id = 17404
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2507, n_packet_requests = 120 (255 packets/frame), frame_id = 17405
[GvStream::check_frame_completion] Timeout for frame 17367 at dt = 147268
[GvStream::check_frame_completion] Timeout for frame 17368 at dt = 143618
[GvStream::check_frame_completion] Timeout for frame 17369 at dt = 139901
[GvStream::check_frame_completion] Timeout for frame 17370 at dt = 136048
[GvStream::check_frame_completion] Timeout for frame 17371 at dt = 131849
[GvStream::check_frame_completion] Timeout for frame 17372 at dt = 128117
[GvStream::check_frame_completion] Timeout for frame 17373 at dt = 124457
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2397, n_packet_requests = 100 (255 packets/frame), frame_id = 17406
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2855, n_packet_requests = 81 (255 packets/frame), frame_id = 17407
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 101 (255 packets/frame), frame_id = 17408
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 5042, n_packet_requests = 119 (255 packets/frame), frame_id = 17410
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 90 (255 packets/frame), frame_id = 17411
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 121, n_packet_requests = 75 (255 packets/frame), frame_id = 17413
[GvStream::check_frame_completion] Timeout for frame 17374 at dt = 165253
[GvStream::check_frame_completion] Timeout for frame 17375 at dt = 161543
[GvStream::check_frame_completion] Timeout for frame 17376 at dt = 157909
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 25219, n_packet_requests = 169 (255 packets/frame), frame_id = 17412
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 4329, n_packet_requests = 111 (255 packets/frame), frame_id = 17419
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 5254, n_packet_requests = 182 (255 packets/frame), frame_id = 17421
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 101 (255 packets/frame), frame_id = 17422
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 746, n_packet_requests = 68 (255 packets/frame), frame_id = 17432
[GvStream::check_frame_completion] Timeout for frame 17377 at dt = 220869
[GvStream::check_frame_completion] Timeout for frame 17378 at dt = 217545
[GvStream::check_frame_completion] Timeout for frame 17379 at dt = 211828
[GvStream::check_frame_completion] Timeout for frame 17388 at dt = 178272
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 94 (255 packets/frame), frame_id = 17435
[GvStream::check_frame_completion] Timeout for frame 17389 at dt = 206764
[GvStream::check_frame_completion] Timeout for frame 17390 at dt = 202518
[GvStream::check_frame_completion] Timeout for frame 17391 at dt = 200170
[GvStream::check_frame_completion] Timeout for frame 17392 at dt = 195021
[GvStream::check_frame_completion] Timeout for frame 17393 at dt = 192670
[GvStream::check_frame_completion] Timeout for frame 17394 at dt = 186750
[GvStream::check_frame_completion] Timeout for frame 17395 at dt = 184292
[GvStream::check_frame_completion] Timeout for frame 17396 at dt = 181125
[GvStream::check_frame_completion] Timeout for frame 17397 at dt = 177010
[GvStream::check_frame_completion] Timeout for frame 17398 at dt = 173020
[GvStream::check_frame_completion] Timeout for frame 17399 at dt = 169321
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 184 (255 packets/frame), frame_id = 17443
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 268, n_packet_requests = 78 (255 packets/frame), frame_id = 17444
[GvStream::check_frame_completion] Timeout for frame 17400 at dt = 169803
[GvStream::check_frame_completion] Timeout for frame 17401 at dt = 165634
[GvStream::check_frame_completion] Timeout for frame 17402 at dt = 161311
[GvStream::check_frame_completion] Timeout for frame 17403 at dt = 158790
[GvStream::check_frame_completion] Timeout for frame 17404 at dt = 153662
[GvStream::check_frame_completion] Timeout for frame 17405 at dt = 150770
[GvStream::check_frame_completion] Timeout for frame 17406 at dt = 146796
[GvStream::check_frame_completion] Timeout for frame 17407 at dt = 143198
[GvStream::check_frame_completion] Timeout for frame 17408 at dt = 135987
[GvStream::check_frame_completion] Timeout for frame 17409 at dt = 135823
[GvStream::check_frame_completion] Timeout for frame 17410 at dt = 132172
[GvStream::check_frame_completion] Timeout for frame 17411 at dt = 126931
[GvStream::check_frame_completion] Timeout for frame 17412 at dt = 161847
[GvStream::check_frame_completion] Timeout for frame 17413 at dt = 156537
[GvStream::check_frame_completion] Timeout for frame 17414 at dt = 154337
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2740, n_packet_requests = 68 (255 packets/frame), frame_id = 17454
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3079, n_packet_requests = 67 (255 packets/frame), frame_id = 17458
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1689, n_packet_requests = 85 (255 packets/frame), frame_id = 17465
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2796, n_packet_requests = 68 (255 packets/frame), frame_id = 17467
^C[GvStream::check_frame_completion] Timeout for frame 17415 at dt = 211641
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2856, n_packet_requests = 67 (255 packets/frame), frame_id = 17471
[GvStream::check_frame_completion] Timeout for frame 17416 at dt = 218794
[GvStream::check_frame_completion] Timeout for frame 17417 at dt = 215375
[GvStream::check_frame_completion] Timeout for frame 17418 at dt = 212329
[GvStream::check_frame_completion] Timeout for frame 17419 at dt = 208690
[GvStream::check_frame_completion] Timeout for frame 17420 at dt = 204193
[GvStream::check_frame_completion] Timeout for frame 17421 at dt = 201146
[GvStream::check_frame_completion] Timeout for frame 17422 at dt = 195717
[GvStream::check_frame_completion] Timeout for frame 17423 at dt = 193194
[GvStream::check_frame_completion] Timeout for frame 17424 at dt = 189309
[GvStream::check_frame_completion] Timeout for frame 17425 at dt = 185300
[GvStream::check_frame_completion] Timeout for frame 17426 at dt = 181358
[GvStream::check_frame_completion] Timeout for frame 17427 at dt = 177851
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1615, n_packet_requests = 86 (255 packets/frame), frame_id = 17478
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1512, n_packet_requests = 87 (255 packets/frame), frame_id = 17482
[GvStream::check_frame_completion] Timeout for frame 17428 at dt = 211582
[GvStream::check_frame_completion] Timeout for frame 17429 at dt = 207836
[GvStream::check_frame_completion] Timeout for frame 17430 at dt = 204011
[GvStream::check_frame_completion] Timeout for frame 17431 at dt = 200002
[GvStream::check_frame_completion] Timeout for frame 17432 at dt = 196149
[GvStream::check_frame_completion] Timeout for frame 17433 at dt = 193520
[GvStream::check_frame_completion] Timeout for frame 17434 at dt = 188765
[GvStream::check_frame_completion] Timeout for frame 17435 at dt = 183177
[GvStream::check_frame_completion] Timeout for frame 17436 at dt = 181630
[GvStream::check_frame_completion] Timeout for frame 17437 at dt = 177951
[GvStream::check_frame_completion] Timeout for frame 17438 at dt = 174018
[GvStream::check_frame_completion] Timeout for frame 17443 at dt = 151563
[GvStream::check_frame_completion] Timeout for frame 17444 at dt = 150749
[GvStream::check_frame_completion] Timeout for frame 17445 at dt = 147455
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 680, n_packet_requests = 69 (255 packets/frame), frame_id = 17493
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2078, n_packet_requests = 64 (255 packets/frame), frame_id = 17496
[GvStream::check_frame_completion] Timeout for frame 17446 at dt = 195574
[GvStream::check_frame_completion] Timeout for frame 17447 at dt = 191904
[GvStream::check_frame_completion] Timeout for frame 17448 at dt = 188345
[GvStream::check_frame_completion] Timeout for frame 17449 at dt = 184775
[GvStream::check_frame_completion] Timeout for frame 17450 at dt = 180181
[GvStream::check_frame_completion] Timeout for frame 17451 at dt = 176987
[GvStream::check_frame_completion] Timeout for frame 17452 at dt = 173216
[GvStream::check_frame_completion] Timeout for frame 17453 at dt = 168631
[GvStream::check_frame_completion] Timeout for frame 17454 at dt = 164811
[GvStream::check_frame_completion] Timeout for frame 17455 at dt = 160857
[GvStream::check_frame_completion] Timeout for frame 17456 at dt = 157932
[GvStream::check_frame_completion] Timeout for frame 17457 at dt = 153589
[GvStream::check_frame_completion] Timeout for frame 17458 at dt = 150293
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2643, n_packet_requests = 69 (255 packets/frame), frame_id = 17497
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 67 (255 packets/frame), frame_id = 17498
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3679, n_packet_requests = 78 (255 packets/frame), frame_id = 17507
[GvStream::check_frame_completion] Timeout for frame 17459 at dt = 191792
[GvStream::check_frame_completion] Timeout for frame 17460 at dt = 186944
[GvStream::check_frame_completion] Timeout for frame 17461 at dt = 184007
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2780, n_packet_requests = 73 (255 packets/frame), frame_id = 17510
[GvStream::check_frame_completion] Timeout for frame 17462 at dt = 220471
[GvStream::check_frame_completion] Timeout for frame 17463 at dt = 218399
[GvStream::check_frame_completion] Timeout for frame 17464 at dt = 213570
[GvStream::check_frame_completion] Timeout for frame 17465 at dt = 208382
[GvStream::check_frame_completion] Timeout for frame 17466 at dt = 205603
[GvStream::check_frame_completion] Timeout for frame 17467 at dt = 202208
[GvStream::check_frame_completion] Timeout for frame 17468 at dt = 198416
[GvStream::check_frame_completion] Timeout for frame 17471 at dt = 187224
[GvStream::check_frame_completion] Timeout for frame 17474 at dt = 175548
[GvStream::check_frame_completion] Timeout for frame 17475 at dt = 172612
[GvStream::check_frame_completion] Timeout for frame 17476 at dt = 168531
[GvStream::check_frame_completion] Timeout for frame 17477 at dt = 164708
[GvStream::check_frame_completion] Timeout for frame 17478 at dt = 160735
[GvStream::check_frame_completion] Timeout for frame 17479 at dt = 157104
[GvStream::check_frame_completion] Timeout for frame 17480 at dt = 152986
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 177 (255 packets/frame), frame_id = 17520
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3138, n_packet_requests = 83 (255 packets/frame), frame_id = 17530
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3394, n_packet_requests = 91 (255 packets/frame), frame_id = 17534
[GvStream::check_frame_completion] Timeout for frame 17481 at dt = 210606
[GvStream::check_frame_completion] Timeout for frame 17482 at dt = 206932
[GvStream::check_frame_completion] Timeout for frame 17483 at dt = 203469
[GvStream::check_frame_completion] Timeout for frame 17484 at dt = 199463
[GvStream::check_frame_completion] Timeout for frame 17485 at dt = 197166
[GvStream::check_frame_completion] Timeout for frame 17486 at dt = 193331
[GvStream::check_frame_completion] Timeout for frame 17487 at dt = 189092
[GvStream::check_frame_completion] Timeout for frame 17488 at dt = 185548
[GvStream::check_frame_completion] Timeout for frame 17489 at dt = 182007
[GvStream::check_frame_completion] Timeout for frame 17490 at dt = 178035
[GvStream::check_frame_completion] Timeout for frame 17491 at dt = 173862
[GvStream::check_frame_completion] Timeout for frame 17492 at dt = 169627
[GvStream::check_frame_completion] Timeout for frame 17493 at dt = 165176
[GvStream::check_frame_completion] Timeout for frame 17494 at dt = 162517
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2924, n_packet_requests = 64 (255 packets/frame), frame_id = 17544
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 23927, n_packet_requests = 95 (255 packets/frame), frame_id = 17543
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2737, n_packet_requests = 85 (255 packets/frame), frame_id = 17549
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1126, n_packet_requests = 75 (255 packets/frame), frame_id = 17550
[GvStream::check_frame_completion] Timeout for frame 17495 at dt = 212126
[GvStream::check_frame_completion] Timeout for frame 17496 at dt = 207922
[GvStream::check_frame_completion] Timeout for frame 17497 at dt = 204184
[GvStream::check_frame_completion] Timeout for frame 17498 at dt = 200631
[GvStream::check_frame_completion] Timeout for frame 17499 at dt = 197730
[GvStream::check_frame_completion] Timeout for frame 17500 at dt = 193607
[GvStream::check_frame_completion] Timeout for frame 17501 at dt = 190160
[GvStream::check_frame_completion] Timeout for frame 17502 at dt = 185542
[GvStream::check_frame_completion] Timeout for frame 17503 at dt = 181702
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 68 (255 packets/frame), frame_id = 17551
[GvStream::check_frame_completion] Timeout for frame 17504 at dt = 194815
[GvStream::check_frame_completion] Timeout for frame 17505 at dt = 191336
[GvStream::check_frame_completion] Timeout for frame 17506 at dt = 187034
[GvStream::check_frame_completion] Timeout for frame 17507 at dt = 182773
[GvStream::check_frame_completion] Timeout for frame 17508 at dt = 178664
[GvStream::check_frame_completion] Timeout for frame 17509 at dt = 175960
[GvStream::check_frame_completion] Timeout for frame 17510 at dt = 172363
[GvStream::check_frame_completion] Timeout for frame 17511 at dt = 168435
[GvStream::check_frame_completion] Timeout for frame 17512 at dt = 163550
[GvStream::check_frame_completion] Timeout for frame 17513 at dt = 160103
[GvStream::check_frame_completion] Timeout for frame 17514 at dt = 157054
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3548, n_packet_requests = 67 (255 packets/frame), frame_id = 17564
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1810, n_packet_requests = 69 (255 packets/frame), frame_id = 17565
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3129, n_packet_requests = 64 (255 packets/frame), frame_id = 17566
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3508, n_packet_requests = 89 (255 packets/frame), frame_id = 17569
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1610, n_packet_requests = 85 (255 packets/frame), frame_id = 17570
[GvStream::check_frame_completion] Timeout for frame 17515 at dt = 224078
[GvStream::check_frame_completion] Timeout for frame 17520 at dt = 201811
[GvStream::check_frame_completion] Timeout for frame 17521 at dt = 200611
[GvStream::check_frame_completion] Timeout for frame 17522 at dt = 196308
[GvStream::check_frame_completion] Timeout for frame 17523 at dt = 193416
[GvStream::check_frame_completion] Timeout for frame 17524 at dt = 189850
[GvStream::check_frame_completion] Timeout for frame 17525 at dt = 186048
[GvStream::check_frame_completion] Timeout for frame 17526 at dt = 182750
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 111 (255 packets/frame), frame_id = 17574
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2578, n_packet_requests = 64 (255 packets/frame), frame_id = 17580
[GvStream::check_frame_completion] Timeout for frame 17527 at dt = 203903
[GvStream::check_frame_completion] Timeout for frame 17528 at dt = 223148
[GvStream::check_frame_completion] Timeout for frame 17529 at dt = 218571
[GvStream::check_frame_completion] Timeout for frame 17530 at dt = 214983
[GvStream::check_frame_completion] Timeout for frame 17531 at dt = 211459
[GvStream::check_frame_completion] Timeout for frame 17532 at dt = 208130
[GvStream::check_frame_completion] Timeout for frame 17533 at dt = 203578
[GvStream::check_frame_completion] Timeout for frame 17534 at dt = 199083
[GvStream::check_frame_completion] Timeout for frame 17537 at dt = 188131
[GvStream::check_frame_completion] Timeout for frame 17538 at dt = 185534
[GvStream::check_frame_completion] Timeout for frame 17539 at dt = 181485
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 238 (255 packets/frame), frame_id = 17586
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 657, n_packet_requests = 82 (255 packets/frame), frame_id = 17587
0 frame/s - 0 MiB/s - 190 errors
Completed buffers = 0
Failures = 190
Underruns = 544
[GvStream::check_frame_completion] Timeout for frame 17540 at dt = 201681
[GvStream::check_frame_completion] Timeout for frame 17541 at dt = 197820
[GvStream::check_frame_completion] Timeout for frame 17542 at dt = 194224
[GvStream::check_frame_completion] Timeout for frame 17543 at dt = 190546
[GvStream::check_frame_completion] Timeout for frame 17544 at dt = 186677
[GvStream::check_frame_completion] Timeout for frame 17545 at dt = 182945
[GvStream::check_frame_completion] Timeout for frame 17546 at dt = 178460
[GvStream::check_frame_completion] Timeout for frame 17547 at dt = 175312
[GvStream::check_frame_completion] Timeout for frame 17548 at dt = 171606
[GvStream::check_frame_completion] Timeout for frame 17549 at dt = 166619
[GvStream::check_frame_completion] Timeout for frame 17550 at dt = 163463
[GvStream::check_frame_completion] Timeout for frame 17551 at dt = 158526
[GvStream::check_frame_completion] Timeout for frame 17552 at dt = 156655
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 23018, n_packet_requests = 66 (255 packets/frame), frame_id = 17589
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 6115, n_packet_requests = 186 (255 packets/frame), frame_id = 17594
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 156 (255 packets/frame), frame_id = 17595
[GvStream::check_frame_completion] Timeout for frame 17553 at dt = 207280
[GvStream::check_frame_completion] Timeout for frame 17554 at dt = 203535
[GvStream::check_frame_completion] Timeout for frame 17555 at dt = 200035
[GvStream::check_frame_completion] Timeout for frame 17556 at dt = 197193
[GvStream::check_frame_completion] Timeout for frame 17557 at dt = 193442
[GvStream::check_frame_completion] Timeout for frame 17558 at dt = 189594
[GvStream::check_frame_completion] Timeout for frame 17559 at dt = 185329
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2173, n_packet_requests = 68 (255 packets/frame), frame_id = 17608
[GvStream::check_frame_completion] Timeout for frame 17560 at dt = 198173
[GvStream::check_frame_completion] Timeout for frame 17561 at dt = 195057
[GvStream::check_frame_completion] Timeout for frame 17562 at dt = 191671
[GvStream::check_frame_completion] Timeout for frame 17563 at dt = 187898
[GvStream::check_frame_completion] Timeout for frame 17564 at dt = 183375
[GvStream::check_frame_completion] Timeout for frame 17565 at dt = 179081
[GvStream::check_frame_completion] Timeout for frame 17566 at dt = 175404
[GvStream::check_frame_completion] Timeout for frame 17567 at dt = 209249
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 22053, n_packet_requests = 77 (255 packets/frame), frame_id = 17619
[GvStream::check_frame_completion] Timeout for frame 17568 at dt = 222872
[GvStream::check_frame_completion] Timeout for frame 17569 at dt = 218753
[GvStream::check_frame_completion] Timeout for frame 17570 at dt = 213930
[GvStream::check_frame_completion] Timeout for frame 17574 at dt = 198415
[GvStream::check_frame_completion] Timeout for frame 17575 at dt = 196733
[GvStream::check_frame_completion] Timeout for frame 17576 at dt = 191905
[GvStream::check_frame_completion] Timeout for frame 17577 at dt = 188683
[GvStream::check_frame_completion] Timeout for frame 17578 at dt = 184862
[GvStream::check_frame_completion] Timeout for frame 17579 at dt = 181308
[GvStream::check_frame_completion] Timeout for frame 17580 at dt = 177323
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1505, n_packet_requests = 114 (255 packets/frame), frame_id = 17631
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 891, n_packet_requests = 76 (255 packets/frame), frame_id = 17633
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1100, n_packet_requests = 67 (255 packets/frame), frame_id = 17635
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 4344, n_packet_requests = 82 (255 packets/frame), frame_id = 17636
[GvStream::check_frame_completion] Timeout for frame 17581 at dt = 222039
[GvStream::check_frame_completion] Timeout for frame 17582 at dt = 217601
[GvStream::check_frame_completion] Timeout for frame 17586 at dt = 199057
[GvStream::check_frame_completion] Timeout for frame 17587 at dt = 198697
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 230 (255 packets/frame), frame_id = 17639
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 67 (255 packets/frame), frame_id = 17642
[GvStream::check_frame_completion] Timeout for frame 17588 at dt = 221938
[GvStream::check_frame_completion] Timeout for frame 17589 at dt = 218400
[GvStream::check_frame_completion] Timeout for frame 17590 at dt = 215236
[GvStream::check_frame_completion] Timeout for frame 17591 at dt = 210974
[GvStream::check_frame_completion] Timeout for frame 17592 at dt = 207502
[GvStream::check_frame_completion] Timeout for frame 17593 at dt = 203547
[GvStream::check_frame_completion] Timeout for frame 17594 at dt = 200466
[GvStream::check_frame_completion] Timeout for frame 17595 at dt = 194096
[GvStream::check_frame_completion] Timeout for frame 17596 at dt = 192460
[GvStream::check_frame_completion] Timeout for frame 17597 at dt = 187915
[GvStream::check_frame_completion] Timeout for frame 17598 at dt = 184283
[GvStream::check_frame_completion] Timeout for frame 17599 at dt = 180561
[GvStream::check_frame_completion] Timeout for frame 17600 at dt = 176933
[GvStream::check_frame_completion] Timeout for frame 17601 at dt = 173391
[GvStream::check_frame_completion] Timeout for frame 17602 at dt = 169221
[GvStream::check_frame_completion] Timeout for frame 17603 at dt = 165450
[GvStream::check_frame_completion] Timeout for frame 17604 at dt = 171849
[GvStream::check_frame_completion] Timeout for frame 17605 at dt = 167839
[GvStream::check_frame_completion] Timeout for frame 17606 at dt = 204760
[GvStream::check_frame_completion] Timeout for frame 17607 at dt = 200669
[GvStream::check_frame_completion] Timeout for frame 17608 at dt = 197166
[GvStream::check_frame_completion] Timeout for frame 17609 at dt = 193468
[GvStream::check_frame_completion] Timeout for frame 17610 at dt = 189447
[GvStream::check_frame_completion] Timeout for frame 17611 at dt = 186099
[GvStream::check_frame_completion] Timeout for frame 17612 at dt = 182635
[GvStream::check_frame_completion] Timeout for frame 17613 at dt = 202861
[GvStream::check_frame_completion] Timeout for frame 17614 at dt = 199622
[GvStream::check_frame_completion] Timeout for frame 17615 at dt = 194373
[GvStream::check_frame_completion] Timeout for frame 17616 at dt = 191462
[GvStream::check_frame_completion] Timeout for frame 17617 at dt = 187895
[GvStream::check_frame_completion] Timeout for frame 17618 at dt = 183332
[GvStream::check_frame_completion] Timeout for frame 17619 at dt = 178714
[GvStream::check_frame_completion] Timeout for frame 17620 at dt = 174804
[GvStream::check_frame_completion] Timeout for frame 17621 at dt = 171872
[GvStream::check_frame_completion] Timeout for frame 17622 at dt = 168608
[GvStream::check_frame_completion] Timeout for frame 17623 at dt = 165187
[GvStream::check_frame_completion] Timeout for frame 17627 at dt = 149722
[GvStream::check_frame_completion] Timeout for frame 17628 at dt = 145800
[GvStream::check_frame_completion] Timeout for frame 17629 at dt = 142175
[GvStream::check_frame_completion] Timeout for frame 17630 at dt = 138464
[GvStream::check_frame_completion] Timeout for frame 17631 at dt = 134008
[GvStream::check_frame_completion] Timeout for frame 17632 at dt = 130771
[GvStream::check_frame_completion] Timeout for frame 17633 at dt = 127055
[GvStream::check_frame_completion] Timeout for frame 17634 at dt = 122778
[GvStream::check_frame_completion] Timeout for frame 17635 at dt = 118461
[GvStream::check_frame_completion] Timeout for frame 17636 at dt = 116330
[GvStream::check_frame_completion] Timeout for frame 17639 at dt = 100950
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 436, n_packet_requests = 66 (255 packets/frame), frame_id = 17667
[GvStream::check_frame_completion] Timeout for frame 17640 at dt = 103031
[GvStream::check_frame_completion] Timeout for frame 17641 at dt = 104622
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2393, n_packet_requests = 146 (255 packets/frame), frame_id = 17669
[GvStream::check_frame_completion] Timeout for frame 17642 at dt = 102656
[GvDevice::read_register] Ack reception timeout
[GvDevice::read_register] Ack reception timeout
[GvStream::check_frame_completion] Timeout for frame 17647 at dt = 102926
[GvStream::check_frame_completion] Timeout for frame 17648 at dt = 103832
[GvStream::find_frame_data] Discard late frame 17648 (last: 17679)
packet_type = ok (0x0000)
content_type = data-block (0x0003)
frame_id = 17648
packet_id = 28
data_size = 1464
[GvStream::find_frame_data] Discard late frame 17648 (last: 17679)
packet_type = ok (0x0000)
content_type = data-block (0x0003)
frame_id = 17648
packet_id = 29
data_size = 1464
[GvStream::find_frame_data] Discard late frame 17648 (last: 17679)
packet_type = ok (0x0000)
content_type = data-block (0x0003)
frame_id = 17648
packet_id = 52
data_size = 1464
[GvStream::find_frame_data] Discard late frame 17648 (last: 17679)
packet_type = ok (0x0000)
content_type = data-block (0x0003)
frame_id = 17648
packet_id = 53
data_size = 1464
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3763, n_packet_requests = 73 (255 packets/frame), frame_id = 17679
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2797, n_packet_requests = 64 (255 packets/frame), frame_id = 17685
[GvStream::check_frame_completion] Timeout for frame 17649 at dt = 142245
[GvStream::check_frame_completion] Timeout for frame 17650 at dt = 138462
[GvStream::check_frame_completion] Timeout for frame 17651 at dt = 135072
[GvStream::check_frame_completion] Timeout for frame 17652 at dt = 131180
[GvStream::check_frame_completion] Timeout for frame 17653 at dt = 127096
[GvStream::check_frame_completion] Timeout for frame 17654 at dt = 123681
[GvStream::check_frame_completion] Timeout for frame 17655 at dt = 119492
[GvStream::check_frame_completion] Timeout for frame 17656 at dt = 115902
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 152 (255 packets/frame), frame_id = 17695
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 2999, n_packet_requests = 67 (255 packets/frame), frame_id = 17698
[GvStream::check_frame_completion] Timeout for frame 17657 at dt = 164040
[GvStream::check_frame_completion] Timeout for frame 17658 at dt = 160505
[GvStream::check_frame_completion] Timeout for frame 17659 at dt = 156274
[GvStream::check_frame_completion] Timeout for frame 17660 at dt = 151804
[GvStream::check_frame_completion] Timeout for frame 17661 at dt = 148851
[GvStream::check_frame_completion] Timeout for frame 17662 at dt = 144875
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 24821, n_packet_requests = 140 (255 packets/frame), frame_id = 17694
[GvStream::check_frame_completion] Timeout for frame 17663 at dt = 144990
[GvStream::check_frame_completion] Timeout for frame 17664 at dt = 140356
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3154, n_packet_requests = 69 (255 packets/frame), frame_id = 17703
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1731, n_packet_requests = 69 (255 packets/frame), frame_id = 17712
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1166, n_packet_requests = 82 (255 packets/frame), frame_id = 17713
[GvStream::check_frame_completion] Timeout for frame 17665 at dt = 188103
[GvStream::check_frame_completion] Timeout for frame 17666 at dt = 213330
[GvStream::check_frame_completion] Timeout for frame 17667 at dt = 209036
[GvStream::check_frame_completion] Timeout for frame 17668 at dt = 206373
[GvStream::check_frame_completion] Timeout for frame 17669 at dt = 202710
[GvStream::check_frame_completion] Timeout for frame 17670 at dt = 198917
[GvStream::check_frame_completion] Timeout for frame 17671 at dt = 194591
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 86 (255 packets/frame), frame_id = 17722
^CThe log is missing the last part, just after you pressed ctrl+c.
EmmanuelP
commented
3 years ago Also, did you try to run aravis from a standard machine ?
Shorlaks
commented
3 years ago Oh, I accidentally pressed ctrl+c twice and missed the log. I didn't try running aravis from a standard machine because it has to run on a raspberryPi. Ill try running it on ubuntu instead of raspbian, maybe their drivers are better or abit different.
bins ;Buffer r
0; 1
2000; 0
4000; 1
6000; 0
8000; 1
10000; 0
12000; 1
14000; 0
16000; 1
18000; 0
20000; 1
22000; 0
24000; 1
26000; 1
28000; 0
30000; 1
32000; 0
34000; 1
36000; 0
38000; 1
40000; 0
42000; 1
44000; 0
46000; 1
48000; 1
50000; 0
52000; 0
54000; 1
56000; 0
58000; 1
60000; 0
62000; 1
64000; 1
66000; 0
68000; 1
70000; 0
72000; 1
74000; 0
76000; 1
78000; 0
80000; 1
82000; 0
84000; 1
86000; 0
88000; 1
90000; 1
92000; 0
94000; 1
96000; 0
98000; 1
100000; 2
102000; 10
104000; 4
106000; 5
108000; 4
110000; 4
112000; 3
114000; 5
116000; 1
118000; 8
120000; 7
122000; 6
124000; 4
126000; 8
128000; 4
130000; 12
132000; 9
134000; 7
136000; 10
138000; 11
140000; 13
142000; 13
144000; 14
146000; 18
148000; 16
150000; 13
152000; 24
154000; 18
156000; 24
158000; 19
160000; 26
162000; 20
164000; 29
166000; 39
168000; 32
170000; 34
172000; 29
174000; 32
176000; 26
178000; 29
180000; 36
182000; 39
184000; 29
186000; 35
188000; 38
190000; 33
192000; 35
194000; 32
196000; 33
198000; 27
-------------
>=200000; 209
< 0; 0
min ; 1980
max ; 224599
last max
at: ; 415
Counter = 1289
[GvStream::finalize] n_completed_buffers = 0
[GvStream::finalize] n_failures = 1137
[GvStream::finalize] n_timeouts = 1137
[GvStream::finalize] n_aborteds = 34
[GvStream::finalize] n_underruns = 1690
[GvStream::finalize] n_missing_frames = 40
[GvStream::finalize] n_size_mismatch_errors = 0
[GvStream::finalize] n_received_packets = 25274
[GvStream::finalize] n_missing_packets = 286898
[GvStream::finalize] n_error_packets = 0
[GvStream::finalize] n_ignored_packets = 1695
[GvStream::finalize] n_resend_requests = 1737861
[GvStream::finalize] n_resent_packets = 1982
[GvStream::finalize] n_resend_ratio_reached = 331
[GvStream::finalize] n_duplicated_packets = 18
[Stream::finalize] Flush 16 buffer[s] in input queue
[Stream::finalize] Flush 34 buffer[s] in output queue
[GvDevice::read_register] Ack reception timeout
[GvDevice::read_register] Ack reception timeout
What is the load on your raspberry ?
There a lot of underruns, which should indicate a system overload.
Also, a lot of missing packets.
You may try to decrease the frame rate (-f), enable auto socket buffer size (-a), enable realtime (--realtime) or high priority (--high-priority), or try the packet socket running arv-camera-test as root.
Shorlaks
commented
3 years ago OK, I've done some tests: To your question, the rPi CPU load is 5%, memory load is 0.1%. I tried running it on Ubuntu, I'm getting the same results (MTU is capped at 1500); Tried setting auto socket buffer, enabling real-time and setting high priority, non of them did anything.
I lowered the camera's frequency from within the camera from 265 to 100, and it helped, I'm getting full frames now. Only problem is I need 265 fps, not 100.
I guess the low MTU creates a bottleneck. Do you have any ideas what should I try? Thank you, Shorlaks
EmmanuelP
commented
3 years ago A question I did not ask, how is your camera connected to your machine ? Direct wired connection, through an ethernet switch, wireless ?
You can try to increase the MTU of your internet adapter and then change the packet size. If you have a switch in between, you also have to configure the switch.
Shorlaks
commented
3 years ago Direct wired connection. The raspberry's NIC MTU is capped at 1500, cant go any higher.
When I run 'arv-camera-test' I can limit the pocket size. (-i). How can I limit the pocket size from within the arv-viewer?
EmmanuelP
commented
3 years ago The packet size setting is not available in arv-viewer. As a workaround, you can set it using arv-tool or arv-camera-test before launching the viewer. If your camera supports it, you can save a default packet size on the camera. Please refer to your camera documentation.
I fear I have exhausted my list of tweaks related to performance issue, and what I'm able to do remotely.
Shorlaks
commented
3 years ago Ok, Thank you very much, I appreciate it. I'll keep tinkering with it, and ill post here my findings.
Shorlaks
commented
3 years ago Hello EmmanuelP, I got some news. The raspberry's internal network adapter supports up to 16k MTU, but the driver only supports up to 1.5k MTU. A solution to this is patching some files and recompiling the kernel, a guide to this can be found here.
Although the MTU now is 9k, I still experience some weird behavior. The default packet size from the camera side is 8036
pi@raspberrypi:~/aravis-0.8.6/build/tests $ ./arv-camera-test
Looking for the first available camera
vendor name = GigaLinx
model name = GigE_Connect
device id = 10001
image width = 480
image height = 385
horizontal binning = 0
vertical binning = 1460294008
payload = 369600 bytes
exposure = 0 µs
gain = 0 dB
gv n_stream channels = 1
gv current channel = 0
gv packet delay = 384 ns
gv packet size = 8036 bytes
0 frame/s - 0 MiB/s - 238 errors
0 frame/s - 0 MiB/s - 265 errors
0 frame/s - 0 MiB/s - 266 errors
0 frame/s - 0 MiB/s - 265 errors
0 frame/s - 0 MiB/s - 265 errors
0 frame/s - 0 MiB/s - 266 errors
0 frame/s - 0 MiB/s - 265 errors
0 frame/s - 0 MiB/s - 265 errors
0 frame/s - 0 MiB/s - 266 errors
^C 0 frame/s - 0 MiB/s - 265 errors
Completed buffers = 0
Failures = 2626
Underruns = 0If I change it to 4088, I'm getting full frames but after a while it brakes.
pi@raspberrypi:~/aravis-0.8.6/build/tests $ ./arv-camera-test -i 4088
Looking for the first available camera
vendor name = GigaLinx
model name = GigE_Connect
device id = 10001
image width = 480
image height = 385
horizontal binning = 0
vertical binning = 2027508088
payload = 369600 bytes
exposure = 0 µs
gain = 0 dB
gv n_stream channels = 1
gv current channel = 0
gv packet delay = 384 ns
gv packet size = 4088 bytes
263 frames/s - 97.2 MiB/s - 2 errors
265 frames/s - 97.9 MiB/s
266 frames/s - 98.3 MiB/s
265 frames/s - 97.9 MiB/s
264 frames/s - 97.6 MiB/s - 1 error
266 frames/s - 98.3 MiB/s
265 frames/s - 97.9 MiB/s
265 frames/s - 97.9 MiB/s
265 frames/s - 97.9 MiB/s
266 frames/s - 98.3 MiB/s
264 frames/s - 97.6 MiB/s - 1 error
265 frames/s - 97.9 MiB/s
265 frames/s - 97.9 MiB/s - 1 error
264 frames/s - 97.6 MiB/s - 1 error
264 frames/s - 97.6 MiB/s - 1 error
265 frames/s - 97.9 MiB/s
266 frames/s - 98.3 MiB/s
265 frames/s - 97.9 MiB/s
265 frames/s - 97.9 MiB/s
265 frames/s - 97.9 MiB/s
266 frames/s - 98.3 MiB/s
265 frames/s - 97.9 MiB/s
265 frames/s - 97.9 MiB/s
266 frames/s - 98.3 MiB/s
264 frames/s - 97.6 MiB/s - 1 error
264 frames/s - 97.6 MiB/s - 1 error
264 frames/s - 97.6 MiB/s - 1 error
265 frames/s - 97.9 MiB/s - 1 error
43 frames/s - 15.9 MiB/s - 144 errors
2 frames/s - 0.739 MiB/s - 193 errors
2 frames/s - 0.739 MiB/s - 212 errors
0 frame/s - 0 MiB/s - 203 errors
2 frames/s - 0.739 MiB/s - 224 errors
0 frame/s - 0 MiB/s - 202 errors
2 frames/s - 0.739 MiB/s - 200 errors
0 frame/s - 0 MiB/s - 215 errors
6 frames/s - 2.22 MiB/s - 208 errors
2 frames/s - 0.739 MiB/s - 214 errors
4 frames/s - 1.48 MiB/s - 202 errors
0 frame/s - 0 MiB/s - 226 errors
0 frame/s - 0 MiB/s - 193 errors
Control lost
^C 0 frame/s - 0 MiB/s - 217 errors
Completed buffers = 7480
Failures = 2864
Underruns = 18865With debug
pi@raspberrypi:~/aravis-0.8.6/build/tests $ ./arv-camera-test -i 4088 --debug=all
Looking for the first available camera
Found 0 USB3Vision device (among 6 USB devices)
[GvDiscoverSocket::new] Add interface 127.0.0.1
[GvDiscoverSocket::new] Add interface 10.53.148.116
[GvDiscoverSocket::new] Add interface 169.254.94.131
[GvInterface::discovery] Device 'GigaLinx-GigE_Connect-10001' found (interface 169.254.94.131) user_id '' - MAC '00:50:c2:8c:f0:87'
[GvDevice::new] Interface address = 169.254.94.131
[GvDevice::new] Device address = 169.254.0.8
[GvDevice::load_genicam] xml url = 'Local:Rafael_Flir_GEV_v5_my.xml;C00F8000;617E' at 0x200
[GvDevice::load_genicam] Xml address = 0xc00f8000 - size = 0x617e - Rafael_Flir_GEV_v5_my.xml
[GcFeature::set_attribute] Unknown attribute 'StandardNameSpace'
[GcFeature::set_attribute] Unknown attribute 'ToolTip'
[GcFeature::set_attribute] Unknown attribute 'ProductGuid'
[GcFeature::set_attribute] Unknown attribute 'VersionGuid'
[GcFeature::set_attribute] Unknown attribute 'xmlns'
[GcFeature::set_attribute] Unknown attribute 'xmlns:xsi'
[GcFeature::set_attribute] Unknown attribute 'xsi:schemaLocation'
[Gc::set_default_node_data] Add 'DeviceVendorName'
[Gc::set_default_node_data] Add 'DeviceModelName'
[Gc::set_default_node_data] Add 'DeviceVersion'
[Gc::set_default_node_data] Add 'DeviceManufacturerInfo'
[Gc::set_default_node_data] Add 'DeviceID'
[Gc::set_default_node_data] Add 'GevStreamChannelCount'
[Gc::set_default_node_data] Add 'GevTimestampTickFrequency'
[Gc::set_default_node_data] Add 'GevSCPHostPort'
[Gc::set_default_node_data] Add 'GevSCPSDoNotFragment'
[Gc::set_default_node_data] Add 'GevSCPSBigEndian'
[Gc::set_default_node_data] Add 'GevSCDA'
[Gc::set_default_node_data] Add 'GevSCSP'
[Gc::set_default_node_data] Add 'GevSCPAddrCalc'
[GvDevice::new] Packet resend = yes
[GvDevice::new] Write memory = yes
[GvDevice::new] Legacy endianness handling = yes
vendor name = GigaLinx
model name = GigE_Connect
device id = 10001
image width = 480
image height = 385
horizontal binning = 0
vertical binning = 1756451192
payload = 369600 bytes
exposure = 0 µs
gain = 0 dB
[GvDevice::create_stream] Number of stream channels = 1
[GvDevice::auto_packet_size] No GevSCPSFireTestPacket feature found
[GvStream::stream_new] Packet size = 4088 byte(s)
[GvStream::stream_new] Destination stream port = 58931
[GvStream::stream_new] Source stream port = 0
[GvStream::stream_thread] Packet timeout = 40 ms
[GvStream::stream_thread] Frame retention = 200 ms
[GvStream::loop] Standard socket method
gv n_stream channels = 1
gv current channel = 0
gv packet delay = 384 ns
gv packet size = 4088 bytes
264 frames/s - 97.6 MiB/s
266 frames/s - 98.3 MiB/s
265 frames/s - 97.9 MiB/s
265 frames/s - 97.9 MiB/s
266 frames/s - 98.3 MiB/s
265 frames/s - 97.9 MiB/s
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3993, n_packet_requests = 31 (94 packets/frame), frame_id = 1687
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 3032, n_packet_requests = 29 (94 packets/frame), frame_id = 1688
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 385, n_packet_requests = 52 (94 packets/frame), frame_id = 1690
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 30 (94 packets/frame), frame_id = 1693
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 25397, n_packet_requests = 52 (94 packets/frame), frame_id = 1692
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 7243, n_packet_requests = 30 (94 packets/frame), frame_id = 1702
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 1285, n_packet_requests = 24 (94 packets/frame), frame_id = 1703
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 951, n_packet_requests = 27 (94 packets/frame), frame_id = 1705
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 0, n_packet_requests = 27 (94 packets/frame), frame_id = 1706
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 693, n_packet_requests = 32 (94 packets/frame), frame_id = 1707
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 396, n_packet_requests = 24 (94 packets/frame), frame_id = 1709
[GvStream::missing_packet_check] Maximum number of requests reached at dt = 574, n_packet_requests = 35 (94 packets/frame), frame_id = 1710
[GvStream::check_frame_completion] Timeout for frame 1687 at dt = 104661
[GvStream::check_frame_completion] Timeout for frame 1688 at dt = 109956
[GvStream::check_frame_completion] Timeout for frame 1690 at dt = 113635
[GvStream::check_frame_completion] Timeout for frame 1692 at dt = 108978
[GvStream::check_frame_completion] Timeout for frame 1693 at dt = 103602
[GvStream::find_frame_data] Discard late frame 1700 (last: 1724)
packet_type = ok (0x0000)
content_type = data-block (0x0003)
frame_id = 1700
packet_id = 90
data_size = 4052
[GvStream::find_frame_data] Discard late frame 1700 (last: 1724)
packet_type = ok (0x0000)
content_type = data-block (0x0003)
frame_id = 1700
packet_id = 91
data_size = 4052
[GvStream::find_frame_data] Discard late frame 1700 (last: 1724)
packet_type = ok (0x0000)
content_type = data-block (0x0003)
frame_id = 1700
packet_id = 92
data_size = 868
[GvStream::find_frame_data] Discard late frame 1700 (last: 1724)
packet_type = ok (0x0000)
content_type = data-trailer (0x0002)
frame_id = 1700
packet_id = 93
data_size = 8
[GvStream::check_frame_completion] Timeout for frame 1702 at dt = 107244
[GvStream::check_frame_completion] Timeout for frame 1703 at dt = 102060
[GvStream::check_frame_completion] Timeout for frame 1705 at dt = 101558
[GvStream::check_frame_completion] Timeout for frame 1706 at dt = 108006
[GvStream::check_frame_completion] Timeout for frame 1707 at dt = 101194
[GvStream::check_frame_completion] Timeout for frame 1709 at dt = 120898
[GvStream::check_frame_completion] Timeout for frame 1710 at dt = 122152
c253 frames/s - 93.5 MiB/s - 12 errors
^C265 frames/s - 97.9 MiB/s
Completed buffers = 2109
Failures = 12
Underruns = 0
bins ;Buffer r
0; 0
2000; 1990
4000; 11
6000; 10
8000; 2
10000; 5
12000; 2
14000; 5
16000; 2
18000; 5
20000; 2
22000; 6
24000; 3
26000; 5
28000; 3
30000; 2
32000; 4
34000; 2
36000; 3
38000; 2
40000; 2
42000; 1
44000; 2
46000; 1
48000; 3
50000; 1
52000; 1
54000; 0
56000; 1
58000; 0
60000; 1
62000; 0
64000; 1
66000; 0
68000; 1
70000; 1
72000; 0
74000; 2
76000; 0
78000; 2
80000; 0
82000; 2
84000; 0
86000; 2
88000; 0
90000; 2
92000; 0
94000; 2
96000; 1
98000; 2
100000; 5
102000; 2
104000; 2
106000; 2
108000; 3
110000; 1
112000; 3
114000; 0
116000; 1
118000; 0
120000; 3
122000; 1
-------------
>=124000; 0
< 0; 0
min ; 3169
max ; 122210
last max
at: ; 1710
Counter = 2124
[GvStream::finalize] n_completed_buffers = 2112
[GvStream::finalize] n_failures = 12
[GvStream::finalize] n_timeouts = 12
[GvStream::finalize] n_aborteds = 0
[GvStream::finalize] n_underruns = 0
[GvStream::finalize] n_missing_frames = 0
[GvStream::finalize] n_size_mismatch_errors = 0
[GvStream::finalize] n_received_packets = 199174
[GvStream::finalize] n_missing_packets = 786
[GvStream::finalize] n_error_packets = 0
[GvStream::finalize] n_ignored_packets = 4
[GvStream::finalize] n_resend_requests = 1036
[GvStream::finalize] n_resent_packets = 812
[GvStream::finalize] n_resend_ratio_reached = 12
[GvStream::finalize] n_duplicated_packets = 68
[Stream::finalize] Flush 50 buffer[s] in input queue
[Stream::finalize] Flush 0 buffer[s] in output queueWhat is happening here?
EmmanuelP
commented
3 years ago Hi,
The default packet size from the camera side is 8036
To understand what is going wrong in this case, a capture of the network traffic may help.
If I change it to 4088, I'm getting full frames but after a while it brakes.
Some devices don't like to be asked too much for packet resend, and stop emitting resent packets. May be that is what is happening here.
You may try to decrease the packet request ratio threshold
Also, a network capture with this packet size would help.
https://www.wireshark.org/docs/wsug_html_chunked/ChCustCommandLine.html
Shorlaks
commented
3 years ago Hi EmmanuelP, I was in the middle of logging the errors and taking screenshots from wire-shark and I stumbled upon a solution. If you follow the guide i mentioned before for recompiling the kernel and you set the packet size to 6130 (-i 6130) everything works fine and there's no lost frames at all. I've tested several cameras, their frame rates ranges from 30 to 265 with different pixel formats (all streams were around 100Mb/s) and I experience zero problems. Thank you very much for Aravis and your help.
Describe the bug I am able to connect to the camera, but I don't get any frames. Iv'e ran
arv-camera-testand this is the result:The camera works at 265 Hz, so basically every pocket I receive is broken.
To Reproduce I followed the setup steps on a clean raspbian distro. Also tried changing MTU from 1500 to 4088 (max), didn't do anything.
Camera description: I tried 3 different cameras, same problem occurs on all 3 of them.
Platform description:
Thank you very much.