Opened 13 years ago
Closed 13 years ago
#9955 closed Bug Report - Hang/Deadlock (Invalid)
Waited 100ms for video buffers -- FE crash
| Reported by: | Owned by: | ||
|---|---|---|---|
| Priority: | minor | Milestone: | unknown |
| Component: | MythTV - General | Version: | 0.24-fixes |
| Severity: | medium | Keywords: | video buffer hang |
| Cc: | Ticket locked: | yes |
Description
Hi
Having similar problems as reported in other tickets e.g. http://code.mythtv.org/trac/ticket/9769.
Basically when playing videos in MythVideo? occasionally playback will freeze and the frontend just completely hangs and does not recover (have waited several minutes for it to recover, nothing happens - the mythfrontend process needs to be killed and restarted).
The difference from other tickets and posts I've seen is that this is for local video files on an external HDD in MythVideo? (not live or recorded TV).
This issue started occurring for me a week or so ago, when I changed all my MythVideo? files to use Storage Groups as opposed to using direct paths configured on the FE. Never had this problem before using Storage Groups for the playback of MythVideo? files. Haven't had any issues with TV, live or recorded, which were always using Storage Groups. The difference may be that I've only seen this issue with HD 720p content in MythVideo?; I only get standard definition TV.
FE and BE are on the same server, running latest version of 0.24-fixes from Mythbuntu PPA, 11.04. Pentium 4 @ 3.2GHz w/ 2GB RAM.
Error in mythfrontend.log when playback freezes below (slightly truncated to avoid large number of mostly identical lines).
2011-07-29 21:07:46.811 VDPAU: Added 2 output surfaces (total 4, max 4) 2011-07-29 21:07:48.805 Player(0): Waited 100ms for video buffers AAAAAAAAAAAAAuLLL <lots of similar messages> 2011-07-29 21:34:40.318 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:40.420 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 1.0 seconds for data 2011-07-29 21:34:40.421 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:41.342 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:41.420 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 2.0 seconds for data 2011-07-29 21:34:41.446 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:43.391 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:43.421 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 4.0 seconds for data 2011-07-29 21:34:43.495 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:47.349 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:47.427 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 8.0 seconds for data 2011-07-29 21:34:47.470 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:48.365 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:48.428 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 9.0 seconds for data 2011-07-29 21:34:48.484 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:48.637 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:48.678 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 9.2 seconds for data 2011-07-29 21:34:48.742 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:48.886 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:48.929 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 9.5 seconds for data 2011-07-29 21:34:48.998 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:49.151 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:49.179 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 9.8 seconds for data 2011-07-29 21:34:49.261 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:49.407 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:49.430 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 10.0 seconds for data 2011-07-29 21:34:49.509 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:49.660 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:49.680 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 10.2 seconds for data 2011-07-29 21:34:49.766 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:49.916 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:49.930 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 10.5 seconds for data 2011-07-29 21:34:50.029 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:50.167 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:50.180 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 10.8 seconds for data 2011-07-29 21:34:50.278 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:50.429 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:50.431 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 11.0 seconds for data 2011-07-29 21:34:50.542 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:50.676 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:50.681 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 11.2 seconds for data 2011-07-29 21:34:50.687 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:50.917 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:50.931 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 11.5 seconds for data 2011-07-29 21:34:50.935 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:51.181 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:51.182 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 11.8 seconds for data 2011-07-29 21:34:51.197 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:51.429 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:51.432 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 12.0 seconds for data 2011-07-29 21:34:51.446 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:51.584 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:51.682 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 12.2 seconds for data 2011-07-29 21:34:51.685 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:51.836 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:51.932 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 12.5 seconds for data 2011-07-29 21:34:51.942 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:52.095 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:52.183 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 12.8 seconds for data 2011-07-29 21:34:52.206 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:52.348 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:52.433 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 13.0 seconds for data 2011-07-29 21:34:52.453 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:52.605 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:52.683 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 13.2 seconds for data 2011-07-29 21:34:52.708 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:52.860 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:52.933 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 13.5 seconds for data 2011-07-29 21:34:52.964 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:53.116 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:53.184 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 13.8 seconds for data 2011-07-29 21:34:53.220 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:53.223 MythSocket(9a01140:73): readStringList: Error, timed out after 7000 ms. 2011-07-29 21:34:53.223 RemoteFile::Read(): No response from control socket. 2011-07-29 21:34:53.223 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv) Error: RingBuffer::safe_read(RemoteFile* ...): read failed 2011-07-29 21:34:53.230 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:53.372 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:53.434 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 14.0 seconds for data 2011-07-29 21:34:53.476 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:53.628 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:53.684 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 14.2 seconds for data 2011-07-29 21:34:53.733 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:53.885 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:53.934 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 14.5 seconds for data 2011-07-29 21:34:53.989 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:54.141 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:54.185 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 14.8 seconds for data 2011-07-29 21:34:54.245 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:54.397 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:54.435 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 15.0 seconds for data 2011-07-29 21:34:54.501 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:54.653 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:54.685 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 15.2 seconds for data 2011-07-29 21:34:54.757 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:54.902 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:54.935 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 15.5 seconds for data 2011-07-29 21:34:55.021 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:55.166 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:55.186 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 15.8 seconds for data 2011-07-29 21:34:55.270 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:55.421 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:55.436 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv): Waited 16.0 seconds for data 2011-07-29 21:34:55.436 RingBuf(myth://Videos@127.0.0.1:6543/TV/<tvshow>/Season 2/<tvshow>.S02E01.720p.HDTV.x264.mkv) Error: Waited 16 seconds for data, aborting. 2011-07-29 21:34:55.534 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA <lots of similar messages> 2011-07-29 21:34:59.903 Player(0): Waited 100ms for video buffers AALLAAAAfAAfAAfAA 2011-07-29 21:34:59.939 Player(0), Error: Waited too long for decoder to fill video buffers. Exiting.. 2011-07-29 21:35:00.034 TV: Attempting to change from WatchingVideo to None 2011-07-29 21:35:05.171 Player(0), Error: Failed to stop decoder loop. 2011-07-29 21:35:05.207 VDPAU Painter: Clearing VDPAU painter cache. 2011-07-29 21:35:05.216 MythPainter: 43 images not yet de-allocated.
Checked the mythbackend.log, nothing too exciting although it did seem fairly busy at the time (had started a commercial detection job and was rescheduling a recording just as the video buffer errors started on the frontend). Not sure if relevant.
Let me know if I can provide any other information which may help.
Thanks
Change History (3)
comment:1 Changed 13 years ago by
comment:2 follow-up: 3 Changed 13 years ago by
Hi
It's a PCIe 2.0 graphics card (9500GT) and the external HDD is connected via USB2. I've used this system as a combined BE/FE for several years and never had any issues with HD content before, including full fat 1080p h264, 5GB for 1 hour.
Not sure what encoding options were used I'm afraid, they were downloaded. They are 720p, approx 1.5GB for 1 hour.
This only started happening when I switched from using direct paths on the FE config to using a Videos storage group configured on the BE, and set up MythWeb about a week ago which is why I suspect it may be something to do with MythTV storage groups...
Thanks
Roger
Note: See
TracTickets for help on using
tickets.
Old hardware such as P4s and AthlonXPs often had both USB1.1 and USB2.0 ports. Are you sure that external hard drive is actually connected to port with sufficient bandwidth for HD video?
Older hardware also typically ran AGP rather than PCIe. If that's an AGP system, then you are running a PCI graphics card. Is there anything else connected that may be using a significant amount of the PCI bus and not allowing sufficient communication to the graphics card?
VDPAU is implemented in a custom ASIC, and as such is inherently limited. It only supports a small subset of what the h264 codec is capable of, and the x264 encoder offers many options that can break playback with VDPAU. What options did you use when encoding these videos?