Deciphering a Couple errors

#1

While testing out the new Smart Commercial Detection, I made 5 recordings from random Pluto channels.
After the recordings finished I noticed 2 things.

  1. Two of the recordings show log entries of [ERR] Generating video index for file-# failed: No Keyframes were found in the stream
    Not sure why the error. Recordings play fine.
2021/12/24 12:29:34.882406 [DVR] Starting job 1640377770-ch9062 Martha Bakes on ch=[9062]
2021/12/24 12:29:37.842192 [M3U] stream timestamps: people-tv: start_at=2021-12-24T12:29:36-08:00 current_at=2021-12-24T12:29:46-08:00 end_at=2021-12-24T12:29:56-08:00
2021/12/24 12:29:37.843992 [TNR] Opened connection to M3U-Pluto for ch9062 PeopleTV
2021/12/24 12:29:37.844910 [DVR] Recording for job 1640377770-ch9062 from M3U-Pluto ch9062 into "TV/Martha Bakes/Martha Bakes 2021122412 2021-12-24-1229.mpg" for 33m25.117497834s
2021/12/24 12:29:38.133965 [IDX] Generating video index for job 1640377770-ch9062
2021/12/24 13:03:00.033933 [TNR] Closed connection to M3U-Pluto for ch9062 PeopleTV
2021/12/24 13:03:00.446073 [MTS] Statistics for "TV/Martha Bakes/Martha Bakes 2021122412 2021-12-24-1229.mpg": skipped=0 unhandled_packets=0 discontinuity_detected=13 transport_errors=0 invalid_pts=0 invalid_dts=0 saw_pcr=true saw_pmt=true highest_pts=2018.650567
2021/12/24 13:03:00.448341 [DVR] Finished job 1640377770-ch9062 Martha Bakes
2021/12/24 13:03:00.546726 [DVR] Processing partially recorded expired job 1640377770-ch9062 Martha Bakes
2021/12/24 13:03:04.073268 [DVR] Processing file-570: TV/Martha Bakes/Martha Bakes 2021122412 2021-12-24-1229.mpg
2021/12/24 13:03:04.702371 [IDX] Generating video index for file-570: Martha Bakes 2021122412 2021-12-24-1229.mpg
2021/12/24 13:03:04.731348 [ERR] Generating video index for file-570 failed: No Keyframes were found in the stream

2021/12/24 12:29:38.140223 [DVR] Starting job 1640377770-ch9326 The Andy Griffith Show on ch=[9326]
2021/12/24 12:29:43.566180 [M3U] stream timestamps: the-andy-griffith-show: start_at=2021-12-24T12:29:41-08:00 current_at=2021-12-24T12:29:52-08:00 end_at=2021-12-24T12:30:02-08:00
2021/12/24 12:29:43.568486 [TNR] Opened connection to M3U-Pluto for ch9326 The Andy Griffith Show
2021/12/24 12:29:43.569320 [DVR] Recording for job 1640377770-ch9326 from M3U-Pluto ch9326 into "TV/The Andy Griffith Show/The Andy Griffith Show S03E10 1961-12-03 Opies Rival 2021-12-24-1229.mpg" for 33m21.859694704s
2021/12/24 12:29:43.880202 [IDX] Generating video index for job 1640377770-ch9326
2021/12/24 13:03:00.039832 [TNR] Closed connection to M3U-Pluto for ch9326 The Andy Griffith Show
2021/12/24 13:03:00.237596 [MTS] Statistics for "TV/The Andy Griffith Show/The Andy Griffith Show S03E10 1961-12-03 Opies Rival 2021-12-24-1229.mpg": skipped=0 unhandled_packets=0 discontinuity_detected=23 transport_errors=0 invalid_pts=0 invalid_dts=0 saw_pcr=true saw_pmt=true highest_pts=2011.437333
2021/12/24 13:03:00.239509 [DVR] Finished job 1640377770-ch9326 The Andy Griffith Show
2021/12/24 13:03:00.541122 [DVR] Processing file-572: TV/The Andy Griffith Show/The Andy Griffith Show S03E10 1961-12-03 Opies Rival 2021-12-24-1229.mpg
2021/12/24 13:03:02.597305 [IDX] Generating video index for file-572: The Andy Griffith Show S03E10 1961-12-03 Opies Rival 2021-12-24-1229.mpg
2021/12/24 13:03:02.682702 [ERR] Generating video index for file-572 failed: No Keyframes were found in the stream
  1. Two of the recordings show as Interrupted, but there are no log entries for the interruption
2021/12/24 12:29:34.882406 [DVR] Starting job 1640377770-ch9062 Martha Bakes on ch=[9062]
2021/12/24 12:29:37.842192 [M3U] stream timestamps: people-tv: start_at=2021-12-24T12:29:36-08:00 current_at=2021-12-24T12:29:46-08:00 end_at=2021-12-24T12:29:56-08:00
2021/12/24 12:29:37.843992 [TNR] Opened connection to M3U-Pluto for ch9062 PeopleTV
2021/12/24 12:29:37.844910 [DVR] Recording for job 1640377770-ch9062 from M3U-Pluto ch9062 into "TV/Martha Bakes/Martha Bakes 2021122412 2021-12-24-1229.mpg" for 33m25.117497834s
2021/12/24 12:29:38.133965 [IDX] Generating video index for job 1640377770-ch9062
2021/12/24 13:03:00.033933 [TNR] Closed connection to M3U-Pluto for ch9062 PeopleTV
2021/12/24 13:03:00.446073 [MTS] Statistics for "TV/Martha Bakes/Martha Bakes 2021122412 2021-12-24-1229.mpg": skipped=0 unhandled_packets=0 discontinuity_detected=13 transport_errors=0 invalid_pts=0 invalid_dts=0 saw_pcr=true saw_pmt=true highest_pts=2018.650567
2021/12/24 13:03:00.448341 [DVR] Finished job 1640377770-ch9062 Martha Bakes
2021/12/24 13:03:00.546726 [DVR] Processing partially recorded expired job 1640377770-ch9062 Martha Bakes
2021/12/24 13:03:04.073268 [DVR] Processing file-570: TV/Martha Bakes/Martha Bakes 2021122412 2021-12-24-1229.mpg
2021/12/24 13:03:04.702371 [IDX] Generating video index for file-570: Martha Bakes 2021122412 2021-12-24-1229.mpg
2021/12/24 13:03:04.731348 [ERR] Generating video index for file-570 failed: No Keyframes were found in the stream

2021/12/24 12:29:37.845459 [DVR] Starting job 1640377770-ch9155 Baking With Julia on ch=[9155]
2021/12/24 12:29:38.137282 [M3U] stream timestamps: julia-child: start_at=2021-12-24T12:29:33-08:00 current_at=2021-12-24T12:29:43-08:00 end_at=2021-12-24T12:29:53-08:00
2021/12/24 12:29:38.139813 [TNR] Opened connection to M3U-Pluto for ch9155 Julia Child
2021/12/24 12:29:38.140705 [DVR] Recording for job 1640377770-ch9155 from M3U-Pluto ch9155 into "TV/Baking With Julia/Baking With Julia S02E03 1997-01-18 Pita Bread and Lamb with Jeffrey Alford and Naomi Duguid 2021-12-24-1229.mpg" for 33m22.154382788s
2021/12/24 12:29:38.384154 [IDX] Generating video index for job 1640377770-ch9155
2021/12/24 13:03:00.041708 [TNR] Closed connection to M3U-Pluto for ch9155 Julia Child
2021/12/24 13:03:00.446052 [MTS] Statistics for "TV/Baking With Julia/Baking With Julia S02E03 1997-01-18 Pita Bread and Lamb with Jeffrey Alford and Naomi Duguid 2021-12-24-1229.mpg": skipped=0 unhandled_packets=0 discontinuity_detected=20 transport_errors=0 invalid_pts=0 invalid_dts=0 saw_pcr=true saw_pmt=true highest_pts=2025.558667
2021/12/24 13:03:00.454596 [ADS] Detected 8 commercial markers in file-571: TV/Baking With Julia/Baking With Julia S02E03 1997-01-18 Pita Bread and Lamb with Jeffrey Alford and Naomi Duguid 2021-12-24-1229.mpg
2021/12/24 13:03:00.687330 [DVR] Finished job 1640377770-ch9155 Baking With Julia
2021/12/24 13:03:00.795616 [DVR] Processing partially recorded expired job 1640377770-ch9155 Baking With Julia
2021/12/24 13:03:02.766820 [DVR] Processing file-571: TV/Baking With Julia/Baking With Julia S02E03 1997-01-18 Pita Bread and Lamb with Jeffrey Alford and Naomi Duguid 2021-12-24-1229.mpg
#2

I have seen the keyframe error also. There is a bug somewhere.

2 Likes
#3

Fix uploading in v2021.12.27.2031

1 Like
#4

Thanks.
Are the interruptions no longer logged?

#5

There was no interruption. The failed indexing caused it to think otherwise.

#6

OK. Manage Recordings showed them as Interrupted.

#7

Yea that was part of the bug.

Fixed in v2021.12.27.2214

2 Likes
#8

Got another Pluto recording showing as Interrupted in Manage Recordings. but nothing in the log.
Could it be because I was recording 6 channels at the same time?

Channels Manage Recordings America's Test Kitchen
Channels Manage Recordings America's Test Kitchen871×237 36 KB 

2021/12/27 15:30:01.915481 [DVR] Starting job 1640647800-ch9166 America's Test Kitchen on ch=[9166]
2021/12/27 15:30:02.473235 [M3U] stream timestamps: americas-test-kitchen: start_at=2021-12-27T15:29:58-08:00 current_at=2021-12-27T15:30:08-08:00 end_at=2021-12-27T15:30:18-08:00
2021/12/27 15:30:02.475100 [TNR] Opened connection to M3U-Pluto for ch9166 America's Test Kitchen
2021/12/27 15:30:02.475850 [DVR] Recording for job 1640647800-ch9166 from M3U-Pluto ch9166 into "TV/America's Test Kitchen/America's Test Kitchen S06E04 2006-01-01 Cooking with Squash 2021-12-27-1530.mpg" for 29m58.084342829s
2021/12/27 15:30:03.166079 [IDX] Generating video index for job 1640647800-ch9166
2021/12/27 16:00:00.038697 [TNR] Closed connection to M3U-Pluto for ch9166 America's Test Kitchen
2021/12/27 16:00:00.483034 [MTS] Statistics for "TV/America's Test Kitchen/America's Test Kitchen S06E04 2006-01-01 Cooking with Squash 2021-12-27-1530.mpg": skipped=0 unhandled_packets=0 discontinuity_detected=39 transport_errors=0 invalid_pts=0 invalid_dts=0 saw_pcr=true saw_pmt=true highest_pts=1818.084000
2021/12/27 16:00:00.494438 [ADS] Detected 8 commercial markers in file-580: TV/America's Test Kitchen/America's Test Kitchen S06E04 2006-01-01 Cooking with Squash 2021-12-27-1530.mpg
2021/12/27 16:00:00.639110 [DVR] Finished job 1640647800-ch9166 America's Test Kitchen
2021/12/27 16:00:00.681184 [DVR] Processing partially recorded expired job 1640647800-ch9166 America's Test Kitchen
2021/12/27 16:00:08.180007 [DVR] Processing file-580: TV/America's Test Kitchen/America's Test Kitchen S06E04 2006-01-01 Cooking with Squash 2021-12-27-1530.mpg
#9

Looks like a possible race condition when a lot of recordings are happening.

#10

Hopefully fixed in v2021.12.28.0159

2 Likes
#11

I'll consider it fixed.
Just made 6 more simultaneous 30 minute Pluto recordings with no Interruption tags in Manage Recordings.

2 Likes