Unxpected Duration errors

I have a bunch of entries in the log that say unexpected duration. They all seem from remote playback.

2021/01/13 18:46:15.661400 [ENC] Segment 460 has unexpected duration: inputs=998-999 expected=1 actual=1.12 expected_pts=459.984000-460.944000 actual_pts=460.005333-461.105333
2021/01/13 18:46:20.248654 [ENC] Segment 465 has unexpected duration: inputs=1008-1009 expected=1 actual=1.12 expected_pts=464.424000-465.384000 actual_pts=464.445333-465.545333
2021/01/13 18:46:29.147719 [ENC] Segment 474 has unexpected duration: inputs=1028-1029 expected=1 actual=1.12 expected_pts=473.424000-474.384000 actual_pts=473.445333-474.545333
2021/01/13 18:46:32.147596 [ENC] Segment 477 has unexpected duration: inputs=1034-1035 expected=1.08 actual=1.16 expected_pts=476.424000-477.464000 actual_pts=476.485333-477.625333
2021/01/13 18:46:33.730159 [HLS] Stopping transcoder session ch6160-dANY-8d8900a2a99b (out: 35.921944s, finished: false)
2021/01/13 18:46:33.730398 [HLS] ffmpeg: ch6160-dANY-8d8900a2a99b-remux: [mpegts @ 0x7facd4808200] Dropped corrupted packet (stream = 0)
2021/01/13 18:46:33.765061 [TNR] Closed connection to TVE-DTV for ch6160 OLYMPICS
2021/01/13 18:46:35.348563 [ENC] Segment 480 has unexpected duration: inputs=1040-1041 expected=1 actual=1.12 expected_pts=479.624000-480.584000 actual_pts=479.645333-480.745333
2021/01/13 18:46:45.298640 [TVE] stream timestamps: tennis: start_at=2021-01-13T18:46:19+11:00 current_at=2021-01-13T18:46:23+11:00 end_at=2021-01-13T18:46:31+11:00
2021/01/13 18:46:45.298711 [TNR] Opened connection to TVE-DTV for ch6155 TENNIS
2021/01/13 18:46:45.311237 [HLS] Starting transcoder for channel 6155 from 121.218.34.39 (encoder=remux, resolution=, deinterlacer=, bitrate=2969)
2021/01/13 18:46:46.727897 [HLS] Probed live stream in 1.415489525s: h264 1280x720 progressive 2826239bps
2021/01/13 18:46:46.770379 [HLS] Session ch6155-dANY-8d8900a2a99b started in 6.25810811s
2021/01/13 18:46:52.249952 [ENC] Segment 497 has unexpected duration: inputs=1077-1078 expected=1 actual=1.12 expected_pts=496.544000-497.504000 actual_pts=496.565333-497.665333
2021/01/13 18:47:03.165522 [ENC] Segment 508 has unexpected duration: inputs=1099-1100 expected=1 actual=1.12 expected_pts=507.504000-508.464000 actual_pts=507.525333-508.625333
2021/01/13 18:47:09.055628 [ENC] Segment 514 has unexpected duration: inputs=1111-1112 expected=1 actual=1.12 expected_pts=513.304000-514.264000 actual_pts=513.325333-514.425333
2021/01/13 18:47:13.251543 [ENC] Segment 518 has unexpected duration: inputs=1119-1120 expected=1 actual=1.12 expected_pts=517.504000-518.464000 actual_pts=517.525333-518.625333
2021/01/13 18:47:19.165075 [HLS] Stopping transcoder session ch6155-dANY-8d8900a2a99b (out: 40.874667s, finished: false)
2021/01/13 18:47:19.165408 [HLS] ffmpeg: ch6155-dANY-8d8900a2a99b-remux: [mpegts @ 0x7f8c13011c00] Dropped corrupted packet (stream = 0)
2021/01/13 18:47:19.185136 [TNR] Closed connection to TVE-DTV for ch6155 TENNIS
2021/01/13 18:47:20.381989 [ENC] Segment 525 has unexpected duration: inputs=1135-1136 expected=1 actual=1.12 expected_pts=525.064000-526.024000 actual_pts=525.085333-526.185333
2021/01/13 18:47:22.251836 [ENC] Segment 527 has unexpected duration: inputs=1139-1140 expected=1.08 actual=1.2 expected_pts=526.544000-527.584000 actual_pts=526.565333-527.745333
2021/01/13 18:47:38.249647 [ENC] Segment 543 has unexpected duration: inputs=1171-1172 expected=1.08 actual=1.2 expected_pts=542.544000-543.584000 actual_pts=542.565333-543.745333
2021/01/13 18:47:40.245825 [ENC] Segment 545 has unexpected duration: inputs=1175-1176 expected=1 actual=1.12 expected_pts=544.544000-545.504000 actual_pts=544.565333-545.665333
2021/01/13 18:47:47.446619 [ENC] Segment 552 has unexpected duration: inputs=1189-1191 expected=1 actual=1.06 expected_pts=551.784000-552.744000 actual_pts=551.745333-552.785333
2021/01/13 18:47:48.447750 [ENC] Segment 553 has unexpected duration: inputs=1192-1193 expected=1 actual=1.12 expected_pts=552.784000-553.744000 actual_pts=552.805333-553.905333
2021/01/13 18:47:51.449710 [ENC] Segment 556 has unexpected duration: inputs=1198-1199 expected=1 actual=1.12 expected_pts=555.784000-556.744000 actual_pts=555.805333-556.905333
2021/01/13 18:48:08.674474 [ENC] Segment 573 has unexpected duration: inputs=1234-1235 expected=1 actual=1.12 expected_pts=573.024000-573.984000 actual_pts=573.045333-574.145333
2021/01/13 18:48:19.744411 [ENC] Segment 585 has unexpected duration: inputs=1258-1259 expected=1 actual=1.12 expected_pts=584.024000-584.984000 actual_pts=584.045333-585.145333
2021/01/13 18:48:33.949652 [ENC] Segment 599 has unexpected duration: inputs=1288-1289 expected=1.12 actual=1.22 expected_pts=598.144000-599.224000 actual_pts=598.165333-599.365333
2021/01/13 18:48:40.044910 [ENC] Segment 605 has unexpected duration: inputs=1301-1302 expected=1 actual=1.12 expected_pts=604.344000-605.304000 actual_pts=604.365333-605.465333
2021/01/13 18:48:48.355521 [ENC] Segment 613 has unexpected duration: inputs=1317-1318 expected=1 actual=1.12 expected_pts=612.544000-613.504000 actual_pts=612.565333-613.665333
2021/01/13 18:48:51.950371 [ENC] Segment 617 has unexpected duration: inputs=1325-1326 expected=1 actual=1.12 expected_pts=616.624000-617.584000 actual_pts=616.645333-617.745333
2021/01/13 18:48:54.055173 [ENC] Segment 619 has unexpected duration: inputs=1329-1330 expected=1 actual=1.12 expected_pts=618.344000-619.304000 actual_pts=618.365333-619.465333
2021/01/13 18:49:03.656738 [ENC] Segment 628 has unexpected duration: inputs=1349-1350 expected=1 actual=1.12 expected_pts=627.384000-628.344000 actual_pts=627.405333-628.505333
2021/01/13 18:49:07.743958 [ENC] Segment 632 has unexpected duration: inputs=1359-1360 expected=1.08 actual=1.16 expected_pts=631.944000-632.984000 actual_pts=632.005333-633.145333
2021/01/13 18:49:13.461298 [ENC] Segment 638 has unexpected duration: inputs=1371-1372 expected=1 actual=1.12 expected_pts=637.824000-638.784000 actual_pts=637.845333-638.945333
2021/01/13 18:49:24.141223 [ENC] Segment 649 has unexpected duration: inputs=1393-1394 expected=1 actual=1.12 expected_pts=648.744000-649.704000 actual_pts=648.765333-649.865333
2021/01/13 18:49:27.168130 [ENC] Segment 652 has unexpected duration: inputs=1399-1400 expected=1 actual=1.12 expected_pts=651.304000-652.264000 actual_pts=651.325333-652.425333
2021/01/13 18:49:32.344936 [ENC] Segment 657 has unexpected duration: inputs=1409-1410 expected=1 actual=1.12 expected_pts=656.624000-657.584000 actual_pts=656.645333-657.745333
2021/01/13 18:49:39.546197 [ENC] Segment 664 has unexpected duration: inputs=1423-1424 expected=1 actual=1.12 expected_pts=663.664000-664.624000 actual_pts=663.685333-664.785333
2021/01/13 18:49:52.445576 [ENC] Segment 677 has unexpected duration: inputs=1449-1450 expected=1 actual=1.12 expected_pts=676.784000-677.744000 actual_pts=676.805333-677.905333
2021/01/13 18:49:55.645549 [ENC] Segment 680 has unexpected duration: inputs=1455-1456 expected=1 actual=1.12 expected_pts=679.824000-680.784000 actual_pts=679.845333-680.945333
2021/01/13 18:50:07.150793 [ENC] Segment 692 has unexpected duration: inputs=1479-1480 expected=1.08 actual=1.16 expected_pts=691.304000-692.344000 actual_pts=691.325333-692.465333
2021/01/13 18:50:17.552387 [ENC] Segment 702 has unexpected duration: inputs=1499-1501 expected=1.08 actual=1.22 expected_pts=701.664000-702.704000 actual_pts=701.665333-702.865333
2021/01/13 18:50:20.141976 [ENC] Segment 705 has unexpected duration: inputs=1506-1507 expected=1.12 actual=1.22 expected_pts=704.224000-705.304000 actual_pts=704.245333-705.445333
2021/01/13 18:50:27.742989 [ENC] Segment 712 has unexpected duration: inputs=1521-1522 expected=1.08 actual=1.2 expected_pts=711.864000-712.904000 actual_pts=711.885333-713.065333
2021/01/13 18:50:34.943243 [ENC] Segment 720 has unexpected duration: inputs=1537-1538 expected=1 actual=1.08 expected_pts=719.504000-720.464000 actual_pts=719.525333-720.585333
2021/01/13 18:50:36.949931 [ENC] Segment 722 has unexpected duration: inputs=1541-1542 expected=1 actual=1.08 expected_pts=721.264000-722.224000 actual_pts=721.285333-722.345333
2021/01/13 18:50:40.455205 [ENC] Segment 725 has unexpected duration: inputs=1547-1548 expected=1.04 actual=1.12 expected_pts=724.304000-725.304000 actual_pts=724.365333-725.465333
2021/01/13 18:50:43.741539 [ENC] Segment 728 has unexpected duration: inputs=1555-1556 expected=1.08 actual=1.16 expected_pts=727.864000-728.904000 actual_pts=727.885333-729.025333
2021/01/13 18:50:50.343143 [ENC] Segment 735 has unexpected duration: inputs=1569-1570 expected=1 actual=1.12 expected_pts=734.624000-735.584000 actual_pts=734.645333-735.745333
2021/01/13 18:50:54.672714 [ENC] Segment 739 has unexpected duration: inputs=1577-1578 expected=1.08 actual=1.2 expected_pts=738.184000-739.224000 actual_pts=738.205333-739.385333
2021/01/13 18:50:57.749323 [ENC] Segment 742 has unexpected duration: inputs=1585-1586 expected=1 actual=1.12 expected_pts=741.944000-742.904000 actual_pts=741.965333-743.065333
2021/01/13 18:51:07.744936 [ENC] Segment 753 has unexpected duration: inputs=1607-1608 expected=1 actual=1.12 expected_pts=752.184000-753.144000 actual_pts=752.205333-753.305333
2021/01/13 18:51:21.242732 [ENC] Segment 766 has unexpected duration: inputs=1635-1636 expected=1 actual=1.12 expected_pts=765.704000-766.664000 actual_pts=765.725333-766.825333
2021/01/13 18:51:34.946185 [ENC] Segment 780 has unexpected duration: inputs=1666-1667 expected=1 actual=1.12 expected_pts=779.184000-780.144000 actual_pts=779.205333-780.305333
2021/01/13 18:51:41.350042 [ENC] Segment 786 has unexpected duration: inputs=1680-1682 expected=1 actual=1.18 expected_pts=786.024000-786.984000 actual_pts=785.985333-787.145333
2021/01/13 18:51:42.839280 [ENC] Segment 788 has unexpected duration: inputs=1685-1686 expected=1 actual=1.12 expected_pts=787.584000-788.544000 actual_pts=787.605333-788.705333
2021/01/13 18:51:45.561669 [ENC] Segment 790 has unexpected duration: inputs=1689-1690 expected=1.12 actual=1.22 expected_pts=789.224000-790.304000 actual_pts=789.245333-790.445333
2021/01/13 18:51:48.337316 [ENC] Segment 793 has unexpected duration: inputs=1699-1700 expected=1.08 actual=1.2 expected_pts=793.104000-794.144000 actual_pts=793.125333-794.305333
2021/01/13 18:51:50.141321 [ENC] Segment 795 has unexpected duration: inputs=1703-1704 expected=1 actual=1.12 expected_pts=794.664000-795.624000 actual_pts=794.685333-795.785333
2021/01/13 18:51:59.044071 [ENC] Segment 804 has unexpected duration: inputs=1721-1722 expected=1 actual=1.12 expected_pts=803.504000-804.464000 actual_pts=803.525333-804.625333
2021/01/13 18:52:01.051099 [ENC] Segment 806 has unexpected duration: inputs=1725-1726 expected=1 actual=1.12 expected_pts=805.344000-806.304000 actual_pts=805.365333-806.465333
2021/01/13 18:52:09.540097 [ENC] Segment 814 has unexpected duration: inputs=1743-1744 expected=1 actual=1.08 expected_pts=813.824000-814.784000 actual_pts=813.845333-814.905333
2021/01/13 18:52:16.741910 [ENC] Segment 821 has unexpected duration: inputs=1757-1758 expected=1.04 actual=1.12 expected_pts=820.944000-821.944000 actual_pts=821.005333-822.105333
2021/01/13 18:52:20.171227 [ENC] Segment 824 has unexpected duration: inputs=1763-1764 expected=1 actual=1.12 expected_pts=824.144000-825.104000 actual_pts=824.165333-825.265333
2021/01/13 18:52:21.340358 [ENC] Segment 826 has unexpected duration: inputs=1767-1768 expected=1 actual=1.12 expected_pts=825.504000-826.464000 actual_pts=825.525333-826.625333
2021/01/13 18:52:23.237416 [ENC] Segment 828 has unexpected duration: inputs=1771-1772 expected=1 actual=1.12 expected_pts=827.624000-828.584000 actual_pts=827.645333-828.745333
2021/01/13 18:52:28.441085 [ENC] Segment 833 has unexpected duration: inputs=1781-1782 expected=1 actual=1.12 expected_pts=832.064000-833.024000 actual_pts=832.085333-833.185333
2021/01/13 18:52:33.341091 [ENC] Segment 838 has unexpected duration: inputs=1793-1794 expected=1 actual=1.12 expected_pts=837.184000-838.144000 actual_pts=837.205333-838.305333
2021/01/13 18:52:43.837925 [ENC] Segment 848 has unexpected duration: inputs=1815-1816 expected=1 actual=1.12 expected_pts=848.104000-849.064000 actual_pts=848.125333-849.225333
2021/01/13 18:52:47.762116 [ENC] Segment 852 has unexpected duration: inputs=1823-1824 expected=1 actual=1.08 expected_pts=851.984000-852.944000 actual_pts=852.005333-853.065333
2021/01/13 18:52:55.040081 [ENC] Segment 860 has unexpected duration: inputs=1839-1840 expected=1.12 actual=1.22 expected_pts=859.224000-860.304000 actual_pts=859.245333-860.445333
2021/01/13 18:53:14.337637 [ENC] Segment 879 has unexpected duration: inputs=1880-1881 expected=0.96 actual=1.04 expected_pts=878.664000-879.584000 actual_pts=878.725333-879.745333
2021/01/13 18:53:19.434904 [ENC] Segment 884 has unexpected duration: inputs=1890-1891 expected=1 actual=1.12 expected_pts=883.664000-884.624000 actual_pts=883.685333-884.785333
2021/01/13 18:53:24.063802 [ENC] Segment 889 has unexpected duration: inputs=1900-1901 expected=1.08 actual=1.2 expected_pts=888.304000-889.344000 actual_pts=888.325333-889.505333
2021/01/13 18:53:37.485045 http: TLS handshake error from IP (hidden) : EOF
2021/01/13 18:53:37.738894 [ENC] Segment 902 has unexpected duration: inputs=1928-1929 expected=1 actual=1.12 expected_pts=901.584000-902.544000 actual_pts=901.605333-902.705333
2021/01/13 18:53:41.685878 [HLS] Stopping transcoder session ch33-dANY-7808913a504c (out: 15m8.024011s, finished: false)
2021/01/13 18:53:41.737582 [ENC] Stopped encoder for ch33 in /Volumes/VideoLibrary/DVR/Streaming/ch33-dANY-7808913a504c-309292862/encoder-1-487582207 after encoding 1 to 906
2021/01/13 18:53:41.738120 [TNR] Closed connection to 1252EEF9/0 for ch33 SBS Food

I am still getting these unexpected duration entries in the log every time a remote stream is started. Is this an issue.

Those errors usually indicate an issue with the source stream, and not something that Channels has control over. If the final stream/recording doesn't exhibit issues, then you can ignore them.

(If you have issues, can you supply some details about the original source/recording ... you haven't provided anything of real consequence yet.)

Okidoki thanks. Interestingly I those errors dont show up when I play the same stream locally. I'll do some more testing thanks

By default, when played locally, the stream is sent unchanged. This means that if there were errors in the stream, they'd only show in the logs on the client, not the DVR server.

You still haven't specified any details about the source of the issues.