Bug #2324

Subtitles not show up sometimes

Added by Rural Hunter over 6 years ago. Updated over 6 years ago.

Status:FixedStart date:11/03/2014
Priority:NormalDue date:
Assignee:-% Done:

100%

Category:-
Target version:4.8
Found in version:4.7.443, 4.7.474 Platform:PS3

Description

This seems a regression as I didn't see it in version 4.6. It usually doesn't happen when playing a video at the first time and happens when I restart to play a video from the beginning. I see this problem on both linux and PS3 versions. I tested a file with several retries and these are the logs on the console(linux version):

1. First time playing, subtitles shows up:
navigator [INFO]: Opening file:///home/ruralhunter/tmp/moovee-aldi.mkv
Media [INFO]: Selecting subtitle track libav:2
Media [INFO]: Selecting subtitle track file:///home/ruralhunter/tmp/moovee-aldi.srt
Subtitles [INFO]: file:///home/ruralhunter/tmp/moovee-aldi.srt is not valid UTF-8. Decoded as BIG5 (specified by user)

2. Quit the movie and restart playing, subtitles shows up too:
navigator [INFO]: Opening file:///home/ruralhunter/tmp/moovee-aldi.mkv
Media [INFO]: Selecting subtitle track libav:3
Media [INFO]: Selecting subtitle track libav:2
Media [INFO]: Selecting subtitle track file:///home/ruralhunter/tmp/moovee-aldi.srt
Subtitles [INFO]: file:///home/ruralhunter/tmp/moovee-aldi.srt is not valid UTF-8. Decoded as BIG5 (specified by user)

3. Quit the movie and resume playing, subtitles shows up too:
navigator [INFO]: Opening file:///home/ruralhunter/tmp/moovee-aldi.mkv
Media [INFO]: Selecting subtitle track libav:2
Media [INFO]: Selecting subtitle track file:///home/ruralhunter/tmp/moovee-aldi.srt
Subtitles [INFO]: file:///home/ruralhunter/tmp/moovee-aldi.srt is not valid UTF-8. Decoded as BIG5 (specified by user)

4. Quit the movie and restart playing, subtitles don't show up:
navigator [INFO]: Opening file:///home/ruralhunter/tmp/moovee-aldi.mkv
Media [INFO]: Selecting subtitle track libav:2
Media [INFO]: Selecting subtitle track file:///home/ruralhunter/tmp/moovee-aldi.srt

5. Quit the movie and restart playing, subtitles don't show up still:
navigator [INFO]: Opening file:///home/ruralhunter/tmp/moovee-aldi.mkv
Media [INFO]: Selecting subtitle track libav:2
Media [INFO]: Selecting subtitle track file:///home/ruralhunter/tmp/moovee-aldi.srt

6. Quit the movie and resume playing, subtitles don't show up still:
navigator [INFO]: Opening file:///home/ruralhunter/tmp/moovee-aldi.mkv
Media [INFO]: Selecting subtitle track libav:2
Media [INFO]: Selecting subtitle track file:///home/ruralhunter/tmp/moovee-aldi.srt

I noticed there is no this log when subtitles don't show up:
Subtitles [INFO]: file:///home/ruralhunter/tmp/moovee-aldi.srt is not valid UTF-8. Decoded as BIG5 (specified by user).

I can make the subitles show up with swithing off and then swithing on the subtitles in menu when playing it. When I do that, the "Subtitles [INFO]" also shows up.

Associated revisions

Revision 260cf41f
Added by Andreas Smas over 6 years ago

video playback: Fix race condition causing embedded subtitles not be autoselected

Fixes #2324

Change included in version 4.7.512

History

#1 Updated by Ema Nymton over 6 years ago

I can confirm that here too, except that external subtitles NEVER show up the first time. I need to manually select them even though they're already checked and supposed to start automatically. Definitely a regression

#2 Updated by Andreas Smas over 6 years ago

Please never write 'latest code' in version field.

#3 Updated by Rural Hunter over 6 years ago

4.7.443

#4 Updated by Rural Hunter over 6 years ago

tested also with 4.7.474.g75868, same result.

#5 Updated by Andreas Smas over 6 years ago

  • Target version set to 4.8

#6 Updated by Leonid Protasov over 6 years ago

  • Found in version changed from latest code to 4.7.443, 4.7.474

I second that. Seen that too. The bug lives in restart/resume events on playing the same file.

#7 Updated by Ema Nymton over 6 years ago

Leonid, not necessarily. It sometimes works for me while resuming movies or starting a new movie.
Below is a resume event.

00:02:55.998: navigator [INFO ]:Opening smb://192.168.1.103/Vidéos/Films/oblivion.2013.1080p.bluray.x264-sparks.mkv
00:02:56.091: vp [DEBUG]:Waiting for event
00:02:56.092: vp [DEBUG]:Playing 'smb://192.168.1.103/Vidéos/Films/oblivion.2013.1080p.bluray.x264-sparks.mkv', primary, attempt-resume
00:02:56.093: media [DEBUG]:Settings initialized for URL smb://192.168.1.103/Vidéos/Films/oblivion.2013.1080p.bluray.x264-sparks.mkv in folder: Films [<unset>]
00:02:56.106: SVSYNC [DEBUG]:Set to 0s
00:02:56.208: AVSYNC [DEBUG]:Set to 0 ms
00:02:56.276: probe [DEBUG]:smb://192.168.1.103/Vidéos/Films/oblivion.2013.1080p.bluray.x264-sparks.mkv: Probed as matroska,webm
00:02:56.430: Video [DEBUG]:Starting playback of smb://192.168.1.103/Vidéos/Films/oblivion.2013.1080p.bluray.x264-sparks.mkv (matroska,webm)
00:02:56.431: Probe [DEBUG]: Stream #0: Video: h264 (High), yuv420p, 1920x808
00:02:56.431: Probe [DEBUG]: Stream #1: Audio: dca (DTS), 48000 Hz, 5.1, fltp, 1536 kb/s
00:02:56.431: Probe [DEBUG]: Stream #2: Subtitle: [0][0][0][0] / 0x0000
00:02:56.432: media [DEBUG]:Selecting track libav:1, best score 312
00:02:56.432: Media [DEBUG]:Selecting audio track libav:1
00:02:56.433: media [DEBUG]:Selecting track libav:2, best score 6305
00:02:56.434: Media [INFO ]:Selecting subtitle track libav:2
00:02:56.438: Subscanner [DEBUG]:Starting subtitle scan for Oblivion (imdbid:tt1483013) year:0 season:-1 episode:-1 duration:7482 opensubhash:798ba4e527133001
00:02:56.471: Video [DEBUG]:Scanning for subs in smb://192.168.1.103/Vidéos/Films/ for oblivion.2013.1080p.bluray.x264-sparks
00:02:56.484: Video [DEBUG]: Stream #0: Video: h264 (High), yuv420p, 1920x808
00:02:56.484: extradata [DEBUG]:0x000000: 01 64 00 29 ff e1 00 18 67 64 00 29 ac d9 80 78 .d.)....gd.)...x
00:02:56.485: extradata [DEBUG]:0x000010: 06 7f 96 10 00 19 74 f0 04 c4 b4 08 f1 83 19 a0 ......t.........
00:02:56.485: extradata [DEBUG]:0x000020: 01 00 06 68 e9 78 23 2c 8b ...h.x#,.
00:02:56.485: VDEC [DEBUG]:Dumping SPS
00:02:56.485: VDEC [DEBUG]:SPS[0]: 1920 x 816 profile:100 level:4.1 ref-frames:5
00:02:56.486: VDEC [DEBUG]: crop: left:0 right:0 top:0 bottom:8
00:02:56.516: VDEC [DEBUG]:Opening codec h264 level 42 using 54157309 bytes of RAM
00:02:56.519: VDEC [DEBUG]:Cell accelerated codec created using 54157309 bytes of RAM
00:02:56.521: Video [DEBUG]: Stream #0: Codec created
00:02:56.521: Video [DEBUG]: Stream #1: Audio: dca (DTS), 48000 Hz, 5.1, fltp, 1536 kb/s
00:02:56.522: Video [DEBUG]: Stream #1: Codec created
00:02:56.522: Video [DEBUG]: Stream #2: Subtitle: [0][0][0][0] / 0x0000
00:02:56.526: Video [DEBUG]:20 chapters
00:02:58.066: VIDEO [DEBUG]:Attempting to resume from 2374.21 seconds
00:02:58.067: Video [DEBUG]:seek restart position to 2374.21 (2374209000 - 0)
00:02:58.068: Subtitles [DEBUG]:smb://192.168.1.103/Vidéos/Films//Borat.PROPER.DVDRip.XviD-DoNE.sub is not a recognized subtitle format
00:02:59.035: Subtitles [DEBUG]:smb://192.168.1.103/Vidéos/Films//Pariah[2011]BRRip XviD-ETRG.sub is not a recognized subtitle format
00:02:59.047: opensubtitles [DEBUG]:Attempting to login as anonymous user
00:02:59.229: audio [DEBUG]:Codec changed to dca (0x15004)
00:02:59.319: AUDIO [DEBUG]:The state is 1
00:02:59.320: AUDIO [DEBUG]:PS3 audio port 0 opened (2 channels)
00:02:59.321: Audio [DEBUG]:Converting from [5.1 48000Hz fltp] to [stereo 48000Hz flt]
00:02:59.702: opensubtitles [DEBUG]:Login OK
00:03:02.365: opensubtitles [DEBUG]:Added 30 subtitles
00:06:58.955: Media [DEBUG]:Seeking by dropping 1431 audio packets and 295+61 video packets from queue
00:06:58.987: VDEC [DEBUG]:Waiting for end sequence
00:06:58.993: VDEC [DEBUG]:Waiting for end sequence -> done
00:07:28.346: Media [DEBUG]:Seeking by dropping 1432 audio packets and 309+45 video packets from queue
00:07:28.347: VDEC [DEBUG]:Waiting for end sequence
00:07:28.353: VDEC [DEBUG]:Waiting for end sequence -> done
00:07:30.546: Video [DEBUG]:seek direct to 2688.55 (2688550000 - 0)
00:07:30.623: VDEC [DEBUG]:Waiting for end sequence
00:07:30.628: VDEC [DEBUG]:Waiting for end sequence -> done
00:07:42.572: audio [DEBUG]:Master volume set to 11.000000 dB
00:07:42.959: audio [DEBUG]:Master volume set to 12.000000 dB
00:08:11.052: Media [INFO ]:Selecting subtitle track libav:2

#8 Updated by Ema Nymton over 6 years ago

With further tests, it seems to happen when resuming or opening files with embedded subtitles

#9 Updated by Rural Hunter over 6 years ago

It seems so

#10 Updated by Andreas Smas over 6 years ago

  • Status changed from New to Fixed
  • % Done changed from 0 to 100

Also available in: Atom PDF