| Sunday, March 22nd, 2015, 00:21 UTC | ||
| [00:21:26] | erasmus (erasmus!~esb@unaffiliated/erasmus) has quit (Read error: Connection reset by peer) | |
| [01:06:41] | arescorpio (arescorpio!~arescorpi@190.16.242.8) has joined #mythtv | |
| [01:22:27] | mad_enz (mad_enz!~Enz@CPE00508b114c3e-CMbc1401360c70.cpe.net.cable.rogers.com) has quit (Quit: Leaving) | |
| [01:37:35] | tstorm (tstorm!~tstorm@67.169.143.241) has quit (Quit: tstorm) | |
| [01:51:46] | dmfrey (dmfrey!~dmfrey@65-78-98-83.c3-0.smt-ubr1.atw-smt.pa.cable.rcn.com) has joined #mythtv | |
| [03:25:51] | andreaz (andreaz!~andre_000@p579231F3.dip0.t-ipconnect.de) has quit (Read error: Connection reset by peer) | |
| [03:34:16] | peper03 (peper03!~peper03@mythtv/developer/peper03) has quit (Ping timeout: 265 seconds) | |
| [03:34:52] | peper03 (peper03!~peper03@mythtv/developer/peper03) has joined #mythtv | |
| [04:50:03] | arescorpio (arescorpio!~arescorpi@190.16.242.8) has quit (Excess Flood) | |
| [04:52:00] | fetzerch_ (fetzerch_!~quassel@unaffiliated/fetzerch) has joined #mythtv | |
| [04:53:40] | dmfrey (dmfrey!~dmfrey@65-78-98-83.c3-0.smt-ubr1.atw-smt.pa.cable.rcn.com) has quit (Quit: Ex-Chat) | |
| [04:55:59] | fetzerch (fetzerch!~quassel@unaffiliated/fetzerch) has quit (Ping timeout: 252 seconds) | |
| [06:20:06] | dblain (dblain!~dblain@mythtv/developer/dblain) has quit (Read error: Connection reset by peer) | |
| [06:20:29] | dblain (dblain!~dblain@c-73-186-115-133.hsd1.ma.comcast.net) has joined #mythtv | |
| [06:20:29] | dblain (dblain!~dblain@mythtv/developer/dblain) has joined #mythtv | |
| [06:20:29] | dblain (dblain!~dblain@c-73-186-115-133.hsd1.ma.comcast.net) has quit (Changing host) | |
| [06:20:58] | jheizer__ (jheizer__!~jheizer@2601:d:3a00:5422:7442:b3d7:1bcb:c0b8) has joined #mythtv | |
| [06:23:26] | kormoc (kormoc!~kormoc@mythtv/developer/kormoc) has quit (Ping timeout: 265 seconds) | |
| [06:24:24] | jheizer_ (jheizer_!~jheizer@2601:d:3a00:5422:7442:b3d7:1bcb:c0b8) has quit (Ping timeout: 265 seconds) | |
| [06:26:25] | kormoc (kormoc!~kormoc@mythtv/developer/kormoc) has joined #mythtv | |
| [07:59:23] | dekarl1 (dekarl1!~dekarl@mythtv/developer/dekarl) has quit (Read error: Connection reset by peer) | |
| [08:00:52] | dekarl (dekarl!~dekarl@mythtv/developer/dekarl) has joined #mythtv | |
| [09:21:25] | jpharvey (jpharvey!~jpharvey@81.134.82.82) has quit (Ping timeout: 264 seconds) | |
| [09:30:22] | peper03: | stuartm: I don't think so. I committed a change in master to reduce the audio buffer to try to improve live playback of DVB radio (i.e. low bit-rate) streams, but I reverted it again a few days later because it broke other stuff. |
| [09:30:40] | peper03: | That was back in November. |
| [09:33:38] | jpharvey (jpharvey!~jpharvey@host86-149-150-45.range86-149.btcentralplus.com) has joined #mythtv | |
| [09:47:19] | peper03: | Hydr0p0nX: Does the audio problem always occur? Have you tried playing back a LiveTV recording (i.e. from the LiveTV recording group)? |
| [09:58:10] | SteveGoodey (SteveGoodey!~steve@host86-151-178-79.range86-151.btcentralplus.com) has joined #mythtv | |
| [11:34:34] | peper03: | Does anyone understand all the different scenarios EITFixup::SetUKSubtitle is trying to handle? Found at least one instance where it's not only "finding" a subtitle that isn't one but also mangling the description. |
| [11:37:17] | peper03: | I can trace though it but there are no comments and it's not clear to me what good cases it's trying to determine. Doesn't give me any confidence that any changes I potentially make won't break something else. |
| [12:02:23] | joki (joki!~joki@p5B36E695.dip0.t-ipconnect.de) has quit (Ping timeout: 250 seconds) | |
| [12:08:42] | joki (joki!~joki@p5B36D2C5.dip0.t-ipconnect.de) has joined #mythtv | |
| [12:56:24] | yngves (yngves!~yngve.sve@88.95.34.222) has joined #mythtv | |
| [13:38:10] | stuartm: | peper03: most of the existing fixups for the UK were either written or committed by stuarta, so I'd ask him directly |
| [13:38:59] | amessina (amessina!~amessina@unaffiliated/amessina) has quit (Quit: Konversation terminated!) | |
| [13:58:54] | Hydr0p0nX: | the first 1–4 seconds of a recording don't play audio either, I'm watching one recorded overnight now, so I can say for sure shortly |
| [14:06:44] | amessina (amessina!~amessina@unaffiliated/amessina) has joined #mythtv | |
| [14:23:17] | Hydr0p0nX: | recording didn't show any problems |
| [14:30:17] | peper03: | Hydr0p0nX: What about a LiveTV segment that had the problem? If you then exit out of LiveTV (you might want to wait for a minute or two before exiting to ensure the recording doesn't get deleted immediately) and play that segment again via Watch Recordings, does the problem still occur? |
| [14:31:30] | peper03: | It's probably a good idea to enable audio logging. |
| [14:32:18] | yngves (yngves!~yngve.sve@88.95.34.222) has left #mythtv () | |
| [15:02:16] | Hydr0p0nX: | it's enabled for the backend ... |
| [15:02:46] | Hydr0p0nX: | I think it is for the frontend, but I'll have to check when I restart it |
| [15:03:10] | Hydr0p0nX: | actually, ps says it is enabled |
| [15:03:39] | Hydr0p0nX: | audio,gpuadio,gpuvideo,audio,playback,network,general |
| [15:51:50] | peper03: | Hydr0p0nX: Makes no difference on the backend. It's not trying to play any audio. Maybe start the frontend with -v playback,audio --loglevel=debug |
| [15:52:16] | peper03: | You said you have no audio for several *minutes* after a new show starts? |
| [15:57:09] | Hydr0p0nX: | it's in and out over the first few minutes |
| [15:57:23] | Hydr0p0nX: | more working than not, just drops out for a second or two |
| [15:58:05] | peper03: | And this is only on LiveTV? |
| [15:58:08] | Hydr0p0nX: | yes |
| [15:58:43] | peper03: | And if you play back a LiveTV segment afterwards, does the sound drop out at the same places? |
| [15:58:56] | Hydr0p0nX: | once recorded? no |
| [15:59:40] | peper03: | So it doesn't sound like it's a problem with recorded data. Purely playback. |
| [15:59:48] | peper03: | with the recorded data. |
| [16:00:44] | peper03: | And video playback stays smooth during the drop-outs? |
| [16:00:48] | Hydr0p0nX: | yep |
| [16:01:03] | Hydr0p0nX: | I thought it might be related to buffering a new stream ... I'm not exactly sure how it's handled but, it feels like a new buffer is created when a new show starts and it takes a few minutes for that buffer to completely fill |
| [16:02:17] | peper03: | It creates a new file and switches to playing back that file. There can be a bit of a drop-out at the transistion but that should affect video and audio. |
| [16:02:30] | peper03: | Any buffers should usually be filled within seconds. |
| [16:06:39] | Hydr0p0nX: | i'll be able to restart the frontend w/ the logging changes in about 30 minutes and can re-create it pretty quickly |
| [16:06:55] | Hydr0p0nX: | looks like I missed the = when setting log level |
| [16:07:47] | peper03: | I'm not sure off the top of my head whether it's necessary. |
| [16:09:27] | Hydr0p0nX: | doesn't appear to be necessary for the backend, but I get a lot less detail in the frontend log without the = |
| [16:10:48] | peper03: | Looking at the frontend logs you posted (and I'm not an expert on playback so I may be missing something) but I see complaints about the HW audio buffer being too small, having to wait for video buffers and one block of 'Audio xxx ms behind video' |
| [16:13:39] | peper03: | You say you've set the prealloc buffers to 32768. I don't know whether the driver accepts anything or ignores values that are too large. |
| [16:13:50] | peper03: | I have mine set to 192. |
| [16:14:00] | Hydr0p0nX: | that's the value listed in prealloc_max |
| [16:14:15] | peper03: | Sorry, 256. |
| [16:16:35] | peper03: | And yet the frontend still says the buffer is not big enough. I would be tempted to think that it's not because 32768 is too small. |
| [16:17:31] | peper03: | I don't know why that setting should only affect LiveTV though. If it's not right, I'd expect there to be problems with playback in general. |
| [16:17:55] | dekarl1 (dekarl1!~dekarl@mythtv/developer/dekarl) has joined #mythtv | |
| [16:18:05] | Hydr0p0nX: | yea, I've also ensured cpu throttling is disabled, AMD FX(tm)-6300 and each core reports current CPU frequency is 3.50 GHz. w/ cpufreq-info |
| [16:18:41] | peper03: | When the drop-outs occur, is there anything that appears in the logs at that time? |
| [16:19:50] | Hydr0p0nX: | Waited xxxms for video buffers AAAAfAAAALAALA usually 4 or 5 times |
| [16:19:53] | dekarl (dekarl!~dekarl@mythtv/developer/dekarl) has quit (Ping timeout: 246 seconds) | |
| [16:20:01] | stuartm: | peper03: I think it's codec/channel detection related, from the reports it only happens at the beginning of recordings |
| [16:21:04] | peper03: | stuartm: But why would it be intermittent for several minutes? |
| [16:21:39] | stuartm: | peper03: missed that detail ... |
| [16:22:38] | Hydr0p0nX: | this a combined fe/be w/ 8GB Ram mysql is on a 500GB boot disk, storage groups are allocated accross all 4 2tb drives |
| [16:22:45] | stuartm: | in that case it does sound more like a playback buffering issue |
| [16:23:03] | Hydr0p0nX: | smartctl says drives are good |
| [16:23:40] | stuartm: | odd though that it's affecting only a few users, on fast hardware ... |
| [16:26:21] | peper03: | The only big difference I'm aware of between 'LiveTV' and playing back a recording is the fact that LiveTV has to work with the data coming in in real-time, whereas playback of a recording has everything already there. It can read in more if it needs to. |
| [16:27:17] | peper03: | Hydr0p0nX: I'd be interested to know if the problem stays around if you pause playback for a few seconds. |
| [16:34:04] | Hydr0p0nX: | usually, no |
| [16:38:36] | Hydr0p0nX: | I'm going to try updating to the 331-updates driver, seems to be the same version so i don't expect any noticeable improvement, also looks like there are a few updates to myth i'll drop in |
| [16:43:54] | peper03: | If pausing playback fixes the issue, it really does sound like a buffering issue. It sounds then like it's starting playback before it really has enough data in the buffer. |
| [16:47:47] | peper03: | You say you have Infinitv and HDHomerun recorders. I've no direct experience with either but I've got some vague recollection of reading something about the ordering of the packets from one or other. |
| [16:48:10] | Hydr0p0nX: | K, I've updated everything to current and fixed the missing(?) = in the frontend startup command, rebooting now |
| [16:48:59] | Hydr0p0nX: | any ideas on what I can do to increase the buffers or which ones need to be increased? |
| [16:50:00] | peper03: | Other than looking at the prealloc buffers, I don't think there's anything you can tweak without compiling from source. |
| [16:50:48] | Hydr0p0nX: | k, looks like tv is running about 3seconds behind the recording right now |
| [16:51:19] | Hydr0p0nX: | audio started about 2–3 seconds after video, then dropped at about 15seconds, and again ~48seconds |
| [16:53:16] | Hydr0p0nX: | 3 minutes in, livetv is about 4seconds ahead, no more issues so far |
| [16:53:41] | peper03: | Can you post the frontend logs somewhere? |
| [16:54:02] | Hydr0p0nX: | yep, I'm going to let it go to about the 5minute mark |
| [16:59:44] | Hydr0p0nX: | http://www.instabrick.me/mythtv/mythfrontend.log |
| [17:00:09] | Hydr0p0nX: | gotta pull some old data out of the backend logs, but I can upload it in a few more minutes |
| [17:01:35] | peper03: | Ok, food's ready. Back later. |
| [17:19:12] | gary_buhrmaster (gary_buhrmaster!~gtb@2601:9:4980:1843:222:4dff:fe51:6728) has quit (Ping timeout: 256 seconds) | |
| [17:20:15] | gary_buhrmaster (gary_buhrmaster!~gtb@2601:9:4980:1843:222:4dff:fe51:6728) has joined #mythtv | |
| [17:48:04] | Hydr0p0nX: | backend log is uploaded also, all 155MB |
| [18:04:31] | erasmus (erasmus!~esb@unaffiliated/erasmus) has joined #mythtv | |
| [18:07:58] | peper03: | Hmm. Ok, I'm getting out of my depth now. Other than the 'Waited ...ms for video buffers', there's nothing there. My understanding is that that message indicates we want to decode another video frame but there's no free frame buffer to decode it to. |
| [18:08:24] | peper03: | I'm not sure why that would cause the audio to drop out. |
| [18:11:39] | peper03: | jya would probably have a better idea what's going on here since he spent a lot of time working on LiveTV playback but he doesn't have much time (if any) any more. |
| [18:12:08] | Hydr0p0nX: | yea, I haven't figured out what's causing it, everything else pretty much just works |
| [18:14:15] | peper03: | Looking at the code in general, running with -v playback,timestamp *might* show something. I think I'd leave off the '--loglevel=debug' to start with as it's already fairly verbose. |
| [18:47:28] | erasmus (erasmus!~esb@unaffiliated/erasmus) has left #mythtv ("Namaste ") | |
| [18:53:46] | Hydr0p0nX: | was able to confirm that rewinding and replaying it shows no issues |
| [19:29:06] | dekarl1 is now known as dekarl | |
| [19:52:27] | gary_buhrmaster (gary_buhrmaster!~gtb@2601:9:4980:1843:222:4dff:fe51:6728) has left #mythtv () | |
| [19:57:03] | andreaz (andreaz!~andre_000@p579231F3.dip0.t-ipconnect.de) has joined #mythtv | |
| [20:26:05] | lomion0815 (lomion0815!~markus@178-191-252-11.adsl.highway.telekom.at) has joined #mythtv | |
| [20:41:44] | knightr (knightr!~Nicolas@mythtv/developer/knightr) has quit (Quit: Leaving) | |
| [20:42:23] | knightr (knightr!~Nicolas@69-165-170-178.dsl.teksavvy.com) has joined #mythtv | |
| [20:42:24] | knightr (knightr!~Nicolas@69-165-170-178.dsl.teksavvy.com) has quit (Changing host) | |
| [20:42:24] | knightr (knightr!~Nicolas@mythtv/developer/knightr) has joined #mythtv | |
| [20:56:42] | amessina (amessina!~amessina@unaffiliated/amessina) has quit (Quit: Konversation terminated!) | |
| [20:59:08] | lomion0815 (lomion0815!~markus@178-191-252-11.adsl.highway.telekom.at) has quit (Remote host closed the connection) | |
| [22:02:26] | rich0 (rich0!~quassel@gentoo/developer/rich0) has quit (Ping timeout: 252 seconds) | |
| [22:11:48] | SteveGoodey (SteveGoodey!~steve@host86-151-178-79.range86-151.btcentralplus.com) has quit (Quit: Konversation terminated!) | |
| [22:19:35] | rich0 (rich0!~quassel@gentoo/developer/rich0) has joined #mythtv | |
| [22:21:38] | rich0_ (rich0_!~quassel@gentoo/developer/rich0) has joined #mythtv | |
| [22:24:04] | rich0 (rich0!~quassel@gentoo/developer/rich0) has quit (Ping timeout: 252 seconds) | |
| [23:00:18] | rich0_ (rich0_!~quassel@gentoo/developer/rich0) has quit (Ping timeout: 246 seconds) | |
| [23:07:11] | jya: | peper03: what is the issue ? |
| [23:07:42] | jya: | yeah, I got swamped with my new work, even when I think I can get back to do stuff on mythtv during the week-end, I run out of time :( |
| [23:08:18] | Hydr0p0nX: | jya, I'm having issues with audio dropping out on livetv, most frequently when a new show starts |
| [23:08:18] | jya: | peper03: after working on the media stack in firefox for a few months now ; it made me realise how poor ours is |
| [23:08:48] | Hydr0p0nX: | video runs fine, audio drops for a second or two then picks up like nothing happened |
| [23:09:21] | jya: | our code is super fragile to properly handle A/V sync, as decoding is all done on the same thread for both audio and video. And then it all get rendered in the main thread. Anything with a delay on the main thread (like downloading metadata) will cause A/V sync breakage, video pause etc |
| [23:09:32] | jya: | Hydr0p0nX: is this a new issue ? |
| [23:10:01] | jya: | you’re using hdmi ? |
| [23:10:11] | Hydr0p0nX: | yes, vdpau w/ nv 650 |
| [23:10:22] | jya: | got a new amp ? |
| [23:10:30] | Hydr0p0nX: | nope, plugged straight in to tv |
| [23:10:38] | Hydr0p0nX: | had weird issues w/ it going to the onkyo |
| [23:10:45] | jya: | with hdmi, there can be a delay on how long it takes for the device to get the sync |
| [23:10:56] | jya: | my hdmi amps takes over 3s to re-sync when audio format changes |
| [23:11:16] | jya: | so when I change channel, I get 3s+ of silence before it gets a lock again |
| [23:11:30] | Hydr0p0nX: | yea, I have HDMI to the tv -> optical to the receiver .. onkyo doesn't seem to play well with pc hdmi for some reason |
| [23:11:55] | Hydr0p0nX: | logs only show Waited 623ms for video buffers dDAAAAdALAAAAA |
| [23:11:56] | jya: | you could be having the same issue, and unfortuantely, there’s nothing you can do other than maybe try switching to analog audio |
| [23:12:12] | jya: | Hydr0p0nX: yeah but that would cause the video to stall, not audio |
| [23:12:22] | Hydr0p0nX: | when that happens 3 or 4 times, audio drops, video keeps going |
| [23:12:28] | jya: | and that’s how long it takes for myth to resupply data when changing channel |
| [23:13:10] | Hydr0p0nX: | if you get some time, and I understand how difficult that can be, I've posted a few sets of logs here: http://www.instabrick.me/mythtv/ |
| [23:13:53] | Hydr0p0nX: | you may see something I haven't, ruled out hardware as much as possible... I can try enabling audio through the tv speakers to see if it makes a difference though |
| [23:13:54] | jya: | have you changed anything in your setup lately? |
| [23:14:15] | jya: | can you try this? as soon as you have a channel change. Press pause, and wait 5s and unpause |
| [23:14:39] | jya: | do you hear the audio then, or does it still stay silent for the 3s |
| [23:14:40] | Hydr0p0nX: | just updates pushed with mythbuntu, changed the driver to nvidia-331-updates today |
| [23:15:09] | jya: | Feb 14 09:40:17 DVR mythfrontend.real: mythfrontend[2893]: I SendMessage mythcorecontext.cpp:426 (ConnectCommandSocket) MythCoreContext: Connecting to backend server: 192.168.1.3:6543 (try 1 of 1) |
| [23:15:09] | jya: | Feb 14 09:40:17 DVR mythfrontend.real: mythfrontend[2893]: E MythSocketThread(-1) mythsocket.cpp:721 (ConnectToHostReal) MythSocket(7fdde401da30:-1): Failed to connect to (127.0.0.1:6543) Connection refused |
| [23:15:10] | jya: | that’s no good |
| [23:15:21] | Hydr0p0nX: | If i pause it for a few seconds, the audio usually has no problem |
| [23:15:49] | jya: | i’m mainly interested to know if you hear the audio you would have otherwise missed |
| [23:15:50] | Hydr0p0nX: | I have myth backend setup to only listen on the physical address, 192.168.1.3 |
| [23:16:05] | Hydr0p0nX: | oh, I can backup after hte drop and it's fine |
| [23:16:11] | jya: | if that’s the case, then your problem is your TV not syncing quickly enough when audio format change |
| [23:16:38] | jya: | what I mean is : you change channel, as soon as you have a fix. Press pause |
| [23:16:41] | jya: | wiat 5s |
| [23:16:48] | jya: | press play: if you hear audio immediately |
| [23:16:51] | Hydr0p0nX: | yea, that will usually work |
| [23:16:57] | jya: | then the issue is your TV/amp |
| [23:17:11] | Hydr0p0nX: | if it's not immediate, it's within a few seconds then works fine |
| [23:17:25] | jya: | after the pause/play ? |
| [23:17:28] | Hydr0p0nX: | yes |
| [23:17:38] | jya: | have you just tried? |
| [23:17:46] | jpharvey (jpharvey!~jpharvey@host86-149-150-45.range86-149.btcentralplus.com) has quit (Ping timeout: 264 seconds) | |
| [23:18:05] | Hydr0p0nX: | no, but i've done that a few times and it work |
| [23:18:17] | Hydr0p0nX: | not a gf approved solution though :) |
| [23:18:47] | Hydr0p0nX: | I'm in the market for a new reciever though, so if you know of one that doesn't have that issue, i'll move it up on my list |
| [23:19:46] | jya: | i’ve never seen a TV with that problem before |
| [23:19:52] | jya: | my amp does |
| [23:20:03] | jya: | so obviously I’m not a good judge for this :) |
| [23:20:06] | Hydr0p0nX: | it could easily be due to optical out to the receiver |
| [23:20:39] | jya: | but then, I bought my pre-amp for the quality of it’s D/A, not how fast it took to sync the hdmi |
| [23:20:56] | jya: | I’ve never had the issue with plain SPDIF |
| [23:21:00] | jya: | only with hdmi |
| [23:21:08] | jya: | (I have a Primare SP32) |
| [23:21:15] | Hydr0p0nX: | onkyo was just flaky with detecting hdmi if things weren't started in the right order |
| [23:22:46] | jya: | you can tweak that with nvidia drivers quite easily |
| [23:22:58] | jya: | the issue is most likely with your PC |
| [23:23:07] | jya: | when it comes to having started in order. |
| [23:23:58] | Hydr0p0nX: | entirely believable, was just quicker to plug it in to the tv than spend hours debugging, and I already had optical from tv to receiver |
| [23:24:16] | stuartm: | Hydr0p0nX: if you want to be sure you can connect up a pair of speakers, or even headphones to the audio out jack and switch the audio device in mythfrontend, might be a bit fiddly but probably worth checking before spending money on new gear |
| [23:24:41] | Hydr0p0nX: | oh, i'm going to be buying new gear anyway |
| [23:24:46] | Hydr0p0nX: | out of HDMI ports =/ |
| [23:25:05] | stuartm: | the standard ALSA device won't behave exactly like the HDMI audio device, so it's not a solid indicator, but it will rule out most other issues |
| [23:27:08] | Hydr0p0nX: | I definitely think it's related to this pc/tv/receiver combo, just the errors in the frontend log when it happens that I couldn't rule out |
| [23:27:09] | knightr (knightr!~Nicolas@mythtv/developer/knightr) has quit (Read error: Connection reset by peer) | |
| [23:28:15] | Hydr0p0nX: | I have a remote frontend on windows, and a Pi2 running openelec that work almost perfectly |
| [23:29:06] | stuartm: | hmm, another option might be to use a fixed number of channels for the audio? |
| [23:30:04] | jpharvey (jpharvey!~jpharvey@host86-149-148-188.range86-149.btcentralplus.com) has joined #mythtv | |
| [23:31:07] | stuartm: | not too sure what our options are in that area, my TV has stereo speakers so there's no advantage in feeding it anything but that |
| [23:34:05] | rich0 (rich0!~quassel@gentoo/developer/rich0) has joined #mythtv | |
| [23:35:18] | Hydr0p0nX: | I think I remember seeing an optin to upconvert to 5.1 |
| [23:35:42] | Hydr0p0nX: | and force spdif 2 channel, not sure if that impacts hdmi though |
| [23:58:33] | gary_buhrmaster (gary_buhrmaster!~gtb@2601:9:4980:1843:222:4dff:fe51:6728) has joined #mythtv | |
IRC Logs collected by
BeirdoBot.
Please use the above link to report any bugs.