Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Recently uploaded videos do not play at 720p with mpeg-dash disabled #302

Closed
pitsi opened this issue May 5, 2022 · 9 comments
Closed

Recently uploaded videos do not play at 720p with mpeg-dash disabled #302

pitsi opened this issue May 5, 2022 · 9 comments
Labels
bug Something isn't working

Comments

@pitsi
Copy link

pitsi commented May 5, 2022

Context

Please provide any relevant information about your setup

  • Add-on Version: 6.8.18
  • Kodi Version: 18.9 and 19.4
  • Kodi GUI Language: Greek and english respectively
  • Operating System: Libreelec 9.2.6 and debian testing/unstable respectively, both x64
  • Operating System Language: English

Expected Behavior

Videos should play at 720p, which is the max resolution available when mpeg-dash is set to disabled.


Current Behavior

When a video is selected, the loading circle appears as usual but the video does not start and kodi instantly returns to the menu where all videos are listed. This happens only on recently uploaded videos, which play with no issue after 1-2 days.
Moreover, right clicking on a video, selecting "ask for resolution" and then "720p" has no effect. Selecting 360p (the second highest resolution with mpeg-dash disabled) makes the video play... but at 360p.


Steps to Reproduce

  1. Disable mpeg-dash from the settings.
  2. Set max resolution to 720p (optional).
  3. Find a video that was recently uploaded, eg on ltt.
  4. Try playing it.

Log

The following is from 2 days ago, from a video of jerryrig, which was uploaded 4 days ago (counting today). Today, the video plays as usual

2022-05-03 10:08:24.448 T:140573346842752  NOTICE: VideoPlayer::OpenFile: plugin://plugin.video.youtube/play/?video_id=e9KyEgw4PKQ
2022-05-03 10:08:24.455 T:140573171898112  NOTICE: Creating InputStream
2022-05-03 10:08:24.749 T:140573171898112  NOTICE: Creating Demuxer
2022-05-03 10:08:24.945 T:140571784312576   ERROR: CCurlFile::FillBuffer - Failed: Transferred a partial file(18)
2022-05-03 10:08:24.945 T:140571784312576 WARNING: CCurlFile::FillBuffer - Reconnect, (re)try 1
2022-05-03 10:08:25.144 T:140571784312576   ERROR: CCurlFile::FillBuffer - Failed: Transferred a partial file(18)
2022-05-03 10:08:25.144 T:140571784312576 WARNING: CCurlFile::FillBuffer - Reconnect, (re)try 2
2022-05-03 10:08:25.323 T:140571784312576   ERROR: CCurlFile::FillBuffer - Failed: Transferred a partial file(18)
2022-05-03 10:08:25.373 T:140573171898112   ERROR: Open - Error, could not open file https://rr1---sn-vuxbavcx-n3bs.googlevideo.com/videoplayback?expire=1651583304&ei=6NRwYujLCY_N1gK86ICwDw&ip=x.x.x.x&id=o-ACpua8vMtBVfJjQBiiyNNFA0pySn4gPdwEkyFecHfhOZ&itag=22&source=youtube&requiressl=yes&mh=yY&mm=31%2C29&mn=sn-vuxbavcx-n3bs%2Csn-4g5e6nz7&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=23&initcwndbps=773750&vprv=1&mime=video%2Fmp4&cnr=14&ratebypass=yes&dur=512.975&lmt=1651413615754063&mt=1651561279&fvip=3&fexp=24001373%2C24007246&c=ANDROID&txp=4432434&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cvprv%2Cmime%2Ccnr%2Cratebypass%2Cdur%2Clmt&sig=AOq0QJ8wRAIgYkswdpcPRLY8nbGoRvvkUCyerixGZSCfgkVq4ePbJW4CIHrSfXXukOIzxe2miFzxfbIV9rw9lvRaDAYRmat1QEZz&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AG3C_xAwRQIhAIfoML__m5kZmF9bC3aGr-maPmMlLbMLsGRvhBq4NVonAiBMhUMpDneMXdDNu7_gwta-SPCQtlGzIik7BJhu6MiGjg%3D%3D
2022-05-03 10:08:25.373 T:140573171898112   ERROR: OpenDemuxStream - Error creating demuxer
2022-05-03 10:08:25.373 T:140573171898112  NOTICE: CVideoPlayer::OnExit()
2022-05-03 10:08:25.394 T:140573346842752  NOTICE: CVideoPlayer::CloseFile()
2022-05-03 10:08:25.401 T:140573346842752  NOTICE: VideoPlayer: waiting for threads to exit
2022-05-03 10:08:25.401 T:140573346842752  NOTICE: VideoPlayer: finished waiting

Additional Information

Obviously, enabling mpeg-dash solves the forementioned issue, but I think it is some api bs from youtube's end.
The issue is also confirmed with a friend running 19.4 on w10.


@pitsi pitsi added the bug Something isn't working label May 5, 2022
@markusfoerster
Copy link

Same here. Kodi 19.4, Windows 10

@pitsi
Copy link
Author

pitsi commented Jun 22, 2022

So today I had the idea to replicate kodi's behavior on mpv, which, as you may all know, uses yt-dlp to resolve youtube's urls.
This is what yt-dlp reports about the resolutions of a video, so I picked a recent one with Linus from ltt that goes up to 4k.

$ yt-dlp -F https://www.youtube.com/watch?v=W3kggpE9W8A
[youtube] W3kggpE9W8A: Downloading webpage
[youtube] W3kggpE9W8A: Downloading android player API JSON
[info] Available formats for W3kggpE9W8A:
ID  EXT   RESOLUTION FPS │   FILESIZE    TBR PROTO │ VCODEC         VBR ACODEC      ABR     ASR MORE INFO
─────────────────────────────────────────────────────────────────────────────────────────────────────────────────
sb2 mhtml 48x27          │                   mhtml │ images                                     storyboard
sb1 mhtml 89x45          │                   mhtml │ images                                     storyboard
sb0 mhtml 179x90         │                   mhtml │ images                                     storyboard
139 m4a   audio only     │    3.80MiB    48k https │ audio only         mp4a.40.5   48k 22050Hz low, m4a_dash
249 webm  audio only     │    3.95MiB    50k https │ audio only         opus        50k 48000Hz low, webm_dash
250 webm  audio only     │    5.04MiB    64k https │ audio only         opus        64k 48000Hz low, webm_dash
140 m4a   audio only     │   10.09MiB   129k https │ audio only         mp4a.40.2  129k 44100Hz medium, m4a_dash
251 webm  audio only     │    9.49MiB   121k https │ audio only         opus       121k 48000Hz medium, webm_dash
17  3gp   176x144      7 │    6.43MiB    82k https │ mp4v.20.3      82k mp4a.40.2    0k 22050Hz 144p
160 mp4   256x128     30 │    3.35MiB    43k https │ avc1.4d400c    43k video only              144p, mp4_dash
278 webm  256x128     30 │    5.46MiB    70k https │ vp9            70k video only              144p, webm_dash
133 mp4   426x214     30 │    6.99MiB    89k https │ avc1.4d400d    89k video only              240p, mp4_dash
242 webm  426x214     30 │    8.49MiB   108k https │ vp9           108k video only              240p, webm_dash
134 mp4   640x320     30 │   12.10MiB   155k https │ avc1.4d401e   155k video only              360p, mp4_dash
18  mp4   640x320     30 │   33.05MiB   424k https │ avc1.42001E   424k mp4a.40.2    0k 44100Hz 360p
243 webm  640x320     30 │   18.72MiB   240k https │ vp9           240k video only              360p, webm_dash
135 mp4   854x428     30 │   20.36MiB   261k https │ avc1.4d401f   261k video only              480p, mp4_dash
244 webm  854x428     30 │   28.17MiB   361k https │ vp9           361k video only              480p, webm_dash
22  mp4   1280x640    30 │ ~ 44.29MiB   554k https │ avc1.64001F   554k mp4a.40.2    0k 44100Hz 720p
136 mp4   1280x640    30 │   34.58MiB   443k https │ avc1.4d401f   443k video only              720p, mp4_dash
247 webm  1280x640    30 │   51.42MiB   659k https │ vp9           659k video only              720p, webm_dash
137 mp4   1920x960    30 │   97.03MiB  1245k https │ avc1.640028  1245k video only              1080p, mp4_dash
248 webm  1920x960    30 │   90.39MiB  1159k https │ vp9          1159k video only              1080p, webm_dash
271 webm  2560x1280   30 │  259.12MiB  3324k https │ vp9          3324k video only              1440p, webm_dash
313 webm  3840x1920   30 │  831.19MiB 10664k https │ vp9         10664k video only              2160p, webm_dash

Notice the ids 22 and 18, which are respectively the 720p and 360p versions of the video, which in turn are the qualities used by the addon when mpeg-dash is disabled. So, playing id 22 with mpv resulted it this... mess and the video did not even start

$ mpv --ytdl-format=22 https://www.youtube.com/watch?v=W3kggpE9W8A
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 310755 in 0 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 310755 in 1 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 310755 in 3 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 310755 in 7 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: STSZ atom truncated
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 1, missing mandatory atoms, broken header
 (+) Video --vid=1 (*) (h264 1280x640 29.970fps)
 (+) Audio --aid=1 --alang=eng (*) (aac 2ch 44100Hz)
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x4f663: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x5509c: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x555b8: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x5567a: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x55ec7: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x56010: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x5612f: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x567ff: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x56980: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x56aef: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x5703d: partial file
[lavf] error reading packet: Invalid data found when processing input.
[lavf] ...treating it as fatal error.
AV: 00:00:00 / 00:10:53 (0%) A-V:  0.000 Cache: 0.0s

Exiting... (Errors when loading file)

Meanwhile, playing id 18 in the same way had zero issues

$ mpv --ytdl-format=18 https://www.youtube.com/watch?v=W3kggpE9W8A
 (+) Video --vid=1 (*) (h264 640x320 29.970fps)
 (+) Audio --aid=1 --alang=eng (*) (aac 2ch 44100Hz)
Using hardware decoding (vdpau).
AO: [alsa] 48000Hz stereo 2ch float
VO: [vdpau] 640x320 vdpau[yuv420p]
AV: 00:00:02 / 00:10:53 (0%) A-V:  0.000 Cache: 57s/5MB

As expected, the video does not play at 720p in kodi too, while it plays with no issues at 360p. This, imho, means that youtube's api is seriously messing things up for recent videos at 720p. So, this is definitely not an issue of the addon but a bs of the api. Thus, I let the devs decide if the issue can be closed and if the addon must make mpeg-dash mandatory.
I know it will affect users who are on kodi 17 or lower, because kodi lacks inputstream.adaptive for those versions.

p.s. Yt-dlp above is still on v2022.05.18. i.e. the previous version after today's latest v2022.06.22.
There are some changes about youtube in its changelog, but I doubt that have to do anything with the issue.

@pitsi
Copy link
Author

pitsi commented Jun 23, 2022

New test because I got the upgrade to yt-dlp v2022.06.22.1 earlier this morning.
This time it only played the first frame and it quitted!

$ mpv --ytdl-format=22 https://www.youtube.com/watch?v=TmCXxIEGXdE
 (+) Video --vid=1 (*) (h264 1280x640 29.970fps)
 (+) Audio --aid=1 --alang=eng (*) (aac 2ch 44100Hz)
Using hardware decoding (vdpau).
VO: [vdpau] 1280x640 vdpau[yuv420p]
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 434991 in 0 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 434991 in 1 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 434991 in 3 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 434991 in 7 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: Packet corrupt (stream = 0, dts = 3003).
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x6ac3e: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x6b243: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x6b7d0: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x6db27: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x6e18a: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x6e7d9: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x70ca2: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x71379: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x7196e: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 1, offset 0x73a14: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 1, offset 0x73b87: partial file
[lavf] error reading packet: Invalid data found when processing input.
[lavf] ...treating it as fatal error.
AV: 00:00:00 / 00:12:33 (0%) A-V:  0.000 Cache: 0.0s/7KB
[ffmpeg/video] h264: Invalid NAL unit size (9214 > 6895).
[ffmpeg/video] h264: Error splitting the input into NAL units.
Error while decoding frame (hardware decoding)!
AV: 00:00:00 / 00:12:33 (0%) A-V:  0.000 Cache: 0.0s

Exiting... (End of file)

@pitsi
Copy link
Author

pitsi commented Jun 25, 2022

And I just came across a video that fails to play even on 360p! Kodi's log, where it does not say it is on 360p

2022-06-25 09:21:44.103 T:140686615595136  NOTICE: VideoPlayer::OpenFile: plugin://plugin.video.youtube/play/?video_id=arGkQ2EsW6k
2022-06-25 09:21:44.103 T:140684922230528  NOTICE: Creating InputStream
2022-06-25 09:21:44.310 T:140684922230528  NOTICE: Creating Demuxer
2022-06-25 09:21:44.525 T:140684939015936   ERROR: CCurlFile::FillBuffer - Failed: Transferred a partial file(18)
2022-06-25 09:21:44.525 T:140684939015936 WARNING: CCurlFile::FillBuffer - Reconnect, (re)try 1
2022-06-25 09:21:44.716 T:140684939015936   ERROR: CCurlFile::FillBuffer - Failed: Transferred a partial file(18)
2022-06-25 09:21:44.716 T:140684939015936 WARNING: CCurlFile::FillBuffer - Reconnect, (re)try 2
2022-06-25 09:21:44.929 T:140684939015936   ERROR: CCurlFile::FillBuffer - Failed: Transferred a partial file(18)
2022-06-25 09:21:44.930 T:140684922230528   ERROR: Open - Error, could not open file https://rr1---sn-vuxbavcx-n3bl.googlevideo.com/videoplayback?expire=1656159702&ei=dqm2YrqHDY-D6dsPpKa-6Ac&ip=x.x.x.x&id=o-AOCMTH9w5pdlMQg3FmToj36-qi9nUzuecrNjWFA0bG10&itag=18&source=youtube&requiressl=yes&mh=_f&mm=31%2C29&mn=sn-vuxbavcx-n3bl%2Csn-4g5edn6y&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=25&initcwndbps=867500&vprv=1&mime=video%2Fmp4&cnr=14&ratebypass=yes&dur=518.617&lmt=1656095665149901&mt=1656137823&fvip=4&fexp=24001373%2C24007246&c=ANDROID&txp=4438434&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cvprv%2Cmime%2Ccnr%2Cratebypass%2Cdur%2Clmt&sig=AOq0QJ8wRgIhAJrI08jNY0_a8Sydepl8Vsg9f8nu5lwOsWh9KiTxpRUjAiEA9Una-tKrsD8xsCdWLssXOEd-RnZJpMx1FzNn56jQrgg%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AG3C_xAwRAIgf2Xa3nvU5gCFEoiFcKntjXiOVFKRySsNeo0qcntGHOACIDKNZYlygECLMlB9e63P6wkLzhLLw2BludbCHTu18fBC
2022-06-25 09:21:44.930 T:140684922230528   ERROR: OpenDemuxStream - Error creating demuxer

and mpv's log for id 18

$ mpv --ytdl-format=18 https://www.youtube.com/watch?v=arGkQ2EsW6k
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 214057 in 0 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 214057 in 1 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 214057 in 3 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg] https: Will reconnect at 214057 in 7 second(s), error=Input/output error.
[ffmpeg] tls: error:00000000:lib(0)::reason(0)
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: STSZ atom truncated
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 1, missing mandatory atoms, broken header
 (+) Video --vid=1 (*) (h264 640x360 25.000fps)
 (+) Audio --aid=1 --alang=eng (*) (aac 2ch 44100Hz)
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x3a1a9: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x3cae8: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x3d670: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x3d954: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x3dbfa: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x3e6cd: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x3e97a: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x3f66c: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x3f936: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x40502: partial file
[lavf] error reading packet: Invalid data found when processing input.
[ffmpeg/demuxer] mov,mp4,m4a,3gp,3g2,mj2: stream 0, offset 0x406b0: partial file
[lavf] error reading packet: Invalid data found when processing input.
[lavf] ...treating it as fatal error.

Exiting... (Errors when loading file)

Well, at least it plays on 144p... which is a 3gp file at 6fps, yes SIX fps. Sony ericsson k750 memories :D

In other news, a similar issue has been reported to yt-dlp, ~1 month before my issue here.
yt-dlp/yt-dlp#3372

@pitsi
Copy link
Author

pitsi commented Jan 16, 2023

Can anyone confirm that this issue still exists? Since then, I have set youtube to play at 720p with mpeg dash disabled and I have not seen the issue for at least 2 or 3 months (that is as far as I can recall).
If it does not, please close it.

@pitsi
Copy link
Author

pitsi commented Jan 19, 2023

Closing it, as I can no longer verify it in either kodi or mpv.

@pitsi pitsi closed this as completed Jan 19, 2023
@pitsi
Copy link
Author

pitsi commented Mar 5, 2023

It just happened on a random vid that was uploaded recently. Here is the log's output

2023-03-05 19:09:51.283 T:140166606903424  NOTICE: VideoPlayer::OpenFile: plugin://plugin.video.youtube/play/?video_id=aFze0XVhHZA
2023-03-05 19:09:51.283 T:140166442657536  NOTICE: Creating InputStream
2023-03-05 19:09:51.514 T:140166442657536  NOTICE: Creating Demuxer
2023-03-05 19:09:51.920 T:140165006092032   ERROR: CCurlFile::FillBuffer - Failed: Transferred a partial file(18)
2023-03-05 19:09:51.920 T:140165006092032 WARNING: CCurlFile::FillBuffer - Reconnect, (re)try 1
2023-03-05 19:09:52.085 T:140165006092032   ERROR: CCurlFile::FillBuffer - Failed: Transferred a partial file(18)
2023-03-05 19:09:52.085 T:140165006092032 WARNING: CCurlFile::FillBuffer - Reconnect, (re)try 2
2023-03-05 19:09:52.246 T:140165006092032   ERROR: CCurlFile::FillBuffer - Failed: Transferred a partial file(18)
2023-03-05 19:09:52.257 T:140166442657536  NOTICE: Opening stream: 0 source: 256
2023-03-05 19:09:52.257 T:140166442657536  NOTICE: Creating video codec with codec id: 27
2023-03-05 19:09:52.257 T:140166442657536  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
2023-03-05 19:09:52.257 T:140166442657536  NOTICE: Creating video thread
2023-03-05 19:09:52.259 T:140166442657536  NOTICE: Opening stream: 1 source: 256
2023-03-05 19:09:52.259 T:140166442657536  NOTICE: Finding audio codec for: 86018
2023-03-05 19:09:52.260 T:140166442657536  NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder aac
2023-03-05 19:09:52.260 T:140166442657536  NOTICE: Creating audio thread
2023-03-05 19:09:52.261 T:140165014484736  NOTICE: running thread: video_thread
2023-03-05 19:09:52.264 T:140165014484736  NOTICE: VAAPI::Close
2023-03-05 19:09:52.264 T:140165014484736  NOTICE: VAAPI::Close - closing decoder context
2023-03-05 19:09:52.267 T:140164978816768  NOTICE: running thread: CVideoPlayerAudio::Process()
2023-03-05 19:09:52.286 T:140165014484736  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
2023-03-05 19:09:52.320 T:140166606903424   ERROR: CShader::InsertSource - failed to open file gl_tonemap.glsl
2023-03-05 19:09:52.320 T:140166606903424  NOTICE: GL: Selecting YUV 2 RGB shader
2023-03-05 19:09:52.321 T:140166606903424  NOTICE: GL: NPOT texture support detected
2023-03-05 19:09:52.321 T:140166606903424  NOTICE: GL: Using GL_ARB_pixel_buffer_object
2023-03-05 19:09:52.321 T:140166606903424  NOTICE: Using GL_TEXTURE_2D
2023-03-05 19:10:27.155 T:140166442657536 WARNING: Seek - failed to get remaining data
2023-03-05 19:10:51.264 T:140165225826048 WARNING: Previous line repeats 240 times.
2023-03-05 19:10:51.264 T:140165225826048  NOTICE: ES: Client  from ::ffff:192.168.1.2 timed out
2023-03-05 19:10:51.316 T:140166442657536 WARNING: Seek - failed to get remaining data

The video does not start even after MINUTES of waiting and the issue does not occur when selecting 360p or any mpeg-dash option. Likewise, on mpv

$ mpv --ytdl-format=22 https://www.youtube.com/watch?v=aFze0XVhHZA
 (+) Video --vid=1 (*) (h264 1280x720 29.970fps)
 (+) Audio --aid=1 --alang=eng (*) (aac 2ch 44100Hz)
     Subs  --sid=1 --slang=en-US 'English (United States)' (webvtt) (external)
VO: [vdpau] 1280x720 yuv420p
[ffmpeg] tls: IO error: End of file
[ffmpeg] https: Stream ends prematurely at 453713, should be 109277362
[ffmpeg] https: Will reconnect at 453713 in 0 second(s), error=Input/output error.
[ffmpeg] https: HTTP error 404 Not Found
[ffmpeg] tls: IO error: End of file
[ffmpeg] https: Stream ends prematurely at 453713, should be 18446744073709551615
[ffmpeg] https: Will reconnect at 453713 in 1 second(s), error=Input/output error.
[ffmpeg] https: HTTP error 404 Not Found
[ffmpeg] tls: IO error: End of file
[ffmpeg] https: Stream ends prematurely at 453713, should be 18446744073709551615
[ffmpeg] https: Will reconnect at 453713 in 3 second(s), error=Input/output error.
[ffmpeg] https: HTTP error 404 Not Found
[ffmpeg] tls: IO error: End of file
[ffmpeg] https: Stream ends prematurely at 453713, should be 18446744073709551615
[ffmpeg] https: Will reconnect at 453713 in 7 second(s), error=Input/output error.

Exiting... (Quit)

I tried many other videos that were uploaded recently but all of them worked fine. I will not reopen the issue until I find a second one that does the same. I am fed up with those idiots at youtube and their lastest changes in the api :(

p.s. I noticed that a similar issue was opened, #426, was opened yesterday. However, since the contents of its log seem different than the one above, I am reporting my issue here.

@pitsi
Copy link
Author

pitsi commented Mar 21, 2023

2+ (almost 3) weeks after that video was uploaded and it finally plays as it should! Last time I had checked it was during the weekend and it was still throttling, so something has changed on their end those last couple of days.

Thank you youtube! /s

@almasalmasalmas
Copy link

No description provided.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
None yet
Development

No branches or pull requests

3 participants