roc-streaming / roc-toolkit

Real-time audio streaming over the network.
https://roc-streaming.org
Mozilla Public License 2.0
1.02k stars 203 forks source link

Depacketizer packet drops #136

Open gavv opened 6 years ago

gavv commented 6 years ago

Depacketizer sometimes drops some packets without any obvious reason. FEC decoder didn't report any losses. Interleaver was disabled.

gavv commented 6 years ago
D: [alsa-sink-USB Audio] roc_audio: latency monitor: latency=8576 target=8640 fe=1.00006 trim_fe=1.00006 adj_fe=1.00006
D: [alsa-sink-USB Audio] roc_audio: depacketizer: ts=1687038435 loss_ratio=0.00010
D: [alsa-sink-USB Audio] roc_audio: latency monitor: latency=8832 target=8640 fe=0.99992 trim_fe=0.99992 adj_fe=0.99992
D: [alsa-sink-USB Audio] roc_audio: latency monitor: latency=9024 target=8640 fe=0.99999 trim_fe=0.99999 adj_fe=0.99999
D: [alsa-sink-USB Audio] roc_audio: latency monitor: latency=8960 target=8640 fe=0.99997 trim_fe=0.99997 adj_fe=0.99997
D: [alsa-sink-USB Audio] roc_audio: latency monitor: latency=8384 target=8640 fe=1.00008 trim_fe=1.00008 adj_fe=1.00008
D: [alsa-sink-USB Audio] roc_fec: fec reader: repair queue: fetched=3 added=0 dropped=3
D: [alsa-sink-USB Audio] roc_fec: fec reader: repair queue: fetched=17 added=10 dropped=7
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687778915
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687779235
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687779555
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687779875
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687780195
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687780515
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687780835
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687781155
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687781475
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687781795
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687782115
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687782435
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687782755
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687783075
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687783395
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687783715
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687784035
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687784355
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687784675
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687784995
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687785315
D: [alsa-sink-USB Audio] roc_audio: depacketizer: dropping late packet: ts=1687786211 pkt_ts=1687785635
D: [alsa-sink-USB Audio] roc_audio: depacketizer: fetched=1 dropped=22
D: [alsa-sink-USB Audio] roc_audio: depacketizer: ts=1687919971 loss_ratio=0.00030
D: [alsa-sink-USB Audio] roc_audio: latency monitor: latency=8448 target=8640 fe=1.00020 trim_fe=1.00020 adj_fe=1.00020
D: [alsa-sink-USB Audio] roc_audio: latency monitor: latency=8960 target=8640 fe=0.99858 trim_fe=0.99858 adj_fe=0.99858
D: [alsa-sink-USB Audio] roc_audio: latency monitor: latency=8768 target=8640 fe=1.00003 trim_fe=1.00003 adj_fe=1.00003
D: [alsa-sink-USB Audio] roc_audio: latency monitor: latency=9152 target=8640 fe=1.00006 trim_fe=1.00006 adj_fe=1.00006
gavv commented 6 years ago
[debug] roc_audio: depacketizer: ts=1327130041 loss_ratio=0.00049
[debug] roc_audio: latency monitor: latency=8064 target=8640 fe=1.00018 trim_fe=1.00018 adj_fe=0.91891
[debug] roc_audio: latency monitor: latency=9344 target=8640 fe=1.00014 trim_fe=1.00014 adj_fe=0.91888
[debug] roc_audio: latency monitor: latency=8704 target=8640 fe=1.00063 trim_fe=1.00063 adj_fe=0.91933
[debug] roc_audio: latency monitor: latency=8576 target=8640 fe=1.00029 trim_fe=1.00029 adj_fe=0.91902
[debug] roc_audio: depacketizer: ts=1328011961 loss_ratio=0.00048
[debug] roc_audio: latency monitor: latency=8576 target=8640 fe=0.99999 trim_fe=0.99999 adj_fe=0.91874
[debug] roc_audio: latency monitor: latency=8896 target=8640 fe=0.99978 trim_fe=0.99978 adj_fe=0.91855
[debug] roc_audio: latency monitor: latency=8704 target=8640 fe=0.99977 trim_fe=0.99977 adj_fe=0.91854
[debug] roc_audio: latency monitor: latency=8512 target=8640 fe=0.99981 trim_fe=0.99981 adj_fe=0.91858
[debug] roc_audio: depacketizer: ts=1328894265 loss_ratio=0.00048
[debug] roc_audio: latency monitor: latency=8192 target=8640 fe=0.99957 trim_fe=0.99957 adj_fe=0.91835
[debug] roc_audio: latency monitor: latency=9472 target=8640 fe=0.99999 trim_fe=0.99999 adj_fe=0.91874
[debug] roc_fec: fec reader: repair queue: fetched=6 added=0 dropped=6
[debug] roc_fec: fec reader: repair queue: fetched=11 added=10 dropped=1
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329264505
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329264825
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329265145
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329265465
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329265785
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329266105
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329266425
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329266745
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329267065
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329267385
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329267705
[debug] roc_audio: depacketizer: dropping late packet: ts=1329268537 pkt_ts=1329268025
[debug] roc_audio: depacketizer: fetched=1 dropped=12
[debug] roc_audio: latency monitor: latency=8192 target=8640 fe=1.00006 trim_fe=1.00006 adj_fe=0.91880
[debug] roc_audio: latency monitor: latency=8640 target=8640 fe=0.99918 trim_fe=0.99918 adj_fe=0.91800
[debug] roc_audio: depacketizer: ts=1329775673 loss_ratio=0.00050
[debug] roc_audio: latency monitor: latency=8768 target=8640 fe=1.00005 trim_fe=1.00005 adj_fe=0.91879
[debug] roc_audio: latency monitor: latency=8640 target=8640 fe=1.00019 trim_fe=1.00019 adj_fe=0.91892
[debug] roc_audio: latency monitor: latency=7808 target=8640 fe=0.99982 trim_fe=0.99982 adj_fe=0.91858
[debug] roc_audio: latency monitor: latency=8768 target=8640 fe=1.00028 trim_fe=1.00028 adj_fe=0.91901