Opened 10 years ago

Closed 10 years ago

#6193 closed defect (invalid)

Screensaver seems to be completely broken now

Reported by: mythtv@… Owned by: Isaac Richards
Priority: minor Milestone: 0.22
Component: MythTV - General Version: head
Severity: medium Keywords:
Cc: Ticket locked: no

Description

With all the work on screensaver triggering, something has now completely broken it.

On startup, the frontend logs that DPMS is deactivated, and that is the only screensaver related message which is logged. Nothing seems to re-enable it.

Running revision 19868.

Attachments (3)

mythfrontend.log (31.8 KB) - added by mythtv@… 10 years ago.
mythfrontend -v playback log
mythfrontend2.log (31.4 KB) - added by mythtv@… 10 years ago.
playback log with DPMS initially active
initial_DPMS_fix.diff (852 bytes) - added by mythtv@… 10 years ago.
Patch to fix initial DPMS state if disabled

Download all attachments as: .zip

Change History (9)

comment:1 Changed 10 years ago by Dibblah

Status: newinfoneeded_new

Logs please - mythfrontend -v playback

comment:2 Changed 10 years ago by sascha.zielinski@…

I discovered another problem which maybe has something to do with it. Everytime i watch something video hangs for about 3 minutes. This happens randomly, I think. Below there is the log with "-v most,important,general,record,playback,audio". I am using revision 19862.

2009-01-29 11:05:45.456 VideoOutputXv: ClearAfterSeek()
2009-01-29 11:05:45.456 VideoOutputXv: DiscardFrames(0)
2009-01-29 11:05:45.456 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2009-01-29 11:05:45.457 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2009-01-29 11:05:45.457 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2009-01-29 11:05:45.457 NVP(0): LoadFilters(''..) -> 0x0
2009-01-29 11:05:45.457 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2009-01-29 11:05:45.477 AO: Pause 0
2009-01-29 11:05:45.477 TV: DoNVPSeek() -- begin
2009-01-29 11:05:45.477 not changing sound mute state 1
2009-01-29 11:05:45.477 TV: DoNVPSeek() -- ff
2009-01-29 11:05:45.477 TV: DoNVPSeek() -- end
2009-01-29 11:05:45.477 UpdateOSDSeekMessage(Vorwärts, 1)
2009-01-29 11:05:45.536 VideoOutputXv: UpdatePauseFrame() UAAAUAAUAAUAAUUUAUUAuUALUAAAAAA
2009-01-29 11:05:45.537 AFD: DoFastForward(5586 (4849), do discard frames)
2009-01-29 11:05:45.537 Dec: DoFastForward(5586 (4849), do discard frames)
2009-01-29 11:05:45.537 Dec: FindPostion(5586, search not adjusted) --> [465(84463512),466(84706220)]
2009-01-29 11:05:45.537 AFD: SeekReset(5592, 0, do flush, do discard)
2009-01-29 11:05:45.537 AFD: SeekReset() flushing
2009-01-29 11:05:45.537 VideoOutputXv: DiscardFrames(1)
2009-01-29 11:05:45.537 VideoBuffers::DiscardFrames(1): UAAAUAAUAAUAAUUUAUUAUUAAUAAAAAA
2009-01-29 11:05:45.538 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2009-01-29 11:05:45.538 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2009-01-29 11:05:45.538 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2009-01-29 11:05:45.538 NVP(0): ClearAfterSeek(0)
2009-01-29 11:05:45.538 AO: Pause 1
2009-01-29 11:05:45.538 AO: OutputAudioLoop: audio paused
2009-01-29 11:05:45.538 WriteAudio: buffer underrun
2009-01-29 11:05:45.539 NVP(0): Waiting for prebuffer..  0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2009-01-29 11:05:45.573 AO: Pause 0
2009-01-29 11:05:45.575 AO: OutputAudioLoop: Play Event
2009-01-29 11:05:45.578 Setting PCM volume to 45
2009-01-29 11:05:45.578 Volume range is 0 to 255, mult=0.392157
2009-01-29 11:05:45.578 channel 0 vol set to 115
2009-01-29 11:05:45.578 Setting PCM volume to 45
2009-01-29 11:05:45.578 Volume range is 0 to 255, mult=0.392157
2009-01-29 11:05:45.578 channel 1 vol set to 115
2009-01-29 11:05:45.578 unmuting sound 0
2009-01-29 11:05:45.578 NVP(0): ClearAfterSeek(0)
2009-01-29 11:05:45.578 AO: Pause 1
2009-01-29 11:05:45.579 AO: OutputAudioLoop: audio paused
2009-01-29 11:05:45.595 AO: Pause 0
2009-01-29 11:05:45.596 AO: OutputAudioLoop: Play Event
2009-01-29 11:05:45.599 TV: DoNVPSeek() -- begin
2009-01-29 11:05:45.599 Setting PCM volume to 0
2009-01-29 11:05:45.599 Volume range is 0 to 255, mult=0.392157
2009-01-29 11:05:45.599 channel 0 vol set to 0
2009-01-29 11:05:45.599 Setting PCM volume to 0
2009-01-29 11:05:45.600 Volume range is 0 to 255, mult=0.392157
2009-01-29 11:05:45.600 channel 1 vol set to 0
2009-01-29 11:05:45.600 muting sound 1
2009-01-29 11:05:45.600 NVP(0): ClearAfterSeek(0)
2009-01-29 11:05:45.600 AO: Pause 1
2009-01-29 11:05:45.600 TV: DoNVPSeek() -- ff
2009-01-29 11:05:45.600 TV: DoNVPSeek() -- end
2009-01-29 11:05:45.600 UpdateOSDSeekMessage(Vorwärts, 1)
2009-01-29 11:05:45.604 AO: OutputAudioLoop: audio paused
2009-01-29 11:05:45.674 VideoOutputXv: UpdatePauseFrame() UUUUUUUUUUUUUAUUUUUUAuUULUAAUUU
2009-01-29 11:05:45.674 AFD: DoFastForward(6343 (5620), do discard frames)
2009-01-29 11:05:45.674 Dec: DoFastForward(6343 (5620), do discard frames)
2009-01-29 11:05:45.674 Dec: FindPostion(6343, search not adjusted) --> [528(100191216),529(100452536)]
2009-01-29 11:05:45.674 AFD: SeekReset(6348, 0, do flush, do discard)
2009-01-29 11:05:45.674 AFD: SeekReset() flushing
2009-01-29 11:05:45.674 VideoOutputXv: DiscardFrames(1)
2009-01-29 11:05:45.674 VideoBuffers::DiscardFrames(1): UUUUUUUUUUUUUAUUUUUUAUUUAUAAUUU
2009-01-29 11:05:45.674 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2009-01-29 11:05:45.675 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2009-01-29 11:05:45.675 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2009-01-29 11:05:45.675 NVP(0): ClearAfterSeek(0)
2009-01-29 11:05:45.675 AO: Pause 1
2009-01-29 11:05:45.676 NVP(0): Waiting for prebuffer..  0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2009-01-29 11:05:45.676 AO: OutputAudioLoop: audio paused
2009-01-29 11:05:45.731 AO: Pause 0
2009-01-29 11:05:45.733 AO: OutputAudioLoop: Play Event
2009-01-29 11:05:46.425 Setting PCM volume to 45
2009-01-29 11:05:46.425 Volume range is 0 to 255, mult=0.392157
2009-01-29 11:05:46.425 channel 0 vol set to 115
2009-01-29 11:05:46.426 Setting PCM volume to 45
2009-01-29 11:05:46.426 Volume range is 0 to 255, mult=0.392157
2009-01-29 11:05:46.426 channel 1 vol set to 115
2009-01-29 11:05:46.426 unmuting sound 0
2009-01-29 11:05:46.426 NVP(0): ClearAfterSeek(0)
2009-01-29 11:05:46.426 AO: Pause 1
2009-01-29 11:05:46.427 AO: OutputAudioLoop: audio paused
2009-01-29 11:05:46.427 WriteAudio: buffer underrun
2009-01-29 11:05:46.431 NVP(0): Waiting for prebuffer..  0
2009-01-29 11:05:46.434 AO: Pause 0
2009-01-29 11:05:46.434 AO: OutputAudioLoop: Play Event
2009-01-29 11:05:46.459 NVP(0): Video is 7.5125 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.460 NVP(0): Video is 12.8969 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.460 NVP(0): Video is 16.6914 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.461 NVP(0): Video is 19.2873 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.461 NVP(0): Video is 20.9905 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.463 NVP(0): Video is 22.0241 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.464 NVP(0): Video is 22.5556 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.465 NVP(0): Video is 22.7104 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.466 NVP(0): Video is 22.5828 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.466 NVP(0): Video is 22.2433 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.467 NVP(0): Video is 21.745 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.467 NVP(0): Video is 21.1275 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.468 NVP(0): Video is 20.4144 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.468 NVP(0): Video is 19.6295 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.469 NVP(0): Video is 18.7971 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.469 NVP(0): Video is 17.9228 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.470 NVP(0): Video is 17.0233 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.470 NVP(0): Video is 16.0987 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.471 NVP(0): Video is 15.1553 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.471 NVP(0): Video is 14.204 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.472 NVP(0): Video is 13.2405 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.472 NVP(0): Video is 12.2803 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.473 NVP(0): Video is 11.3103 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.473 NVP(0): Video is 10.3327 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.474 NVP(0): Video is 9.35575 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.474 NVP(0): Video is 8.37305 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.475 NVP(0): Video is 7.39227 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.475 NVP(0): Video is 6.4067 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.476 NVP(0): Video is 5.41752 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.476 NVP(0): Video is 4.43188 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:05:46.477 NVP(0): Video is 3.44265 frames behind audio (too slow), dropping frame to catch up.
'video_output' mean = '34980.74', std. dev. = '39580.94', fps = '28.59'
'video_output' mean = '40006.96', std. dev. = '1934.54', fps = '25.00'
'video_output' mean = '40000.54', std. dev. = '704.79', fps = '25.00'
'video_output' mean = '39995.73', std. dev. = '639.80', fps = '25.00'
2009-01-29 11:06:00.241 NVP(0): 400 interlaced frames seen.
'video_output' mean = '40006.18', std. dev. = '864.94', fps = '25.00'
'video_output' mean = '39998.86', std. dev. = '510.75', fps = '25.00'
'video_output' mean = '39988.66', std. dev. = '611.73', fps = '25.01'
'video_output' mean = '39997.97', std. dev. = '868.23', fps = '25.00'
2009-01-29 11:06:16.242 NVP(0): 800 interlaced frames seen.
'video_output' mean = '40008.30', std. dev. = '1905.65', fps = '24.99'
'video_output' mean = '39998.06', std. dev. = '989.97', fps = '25.00'
'video_output' mean = '39997.47', std. dev. = '697.12', fps = '25.00'
'video_output' mean = '39998.03', std. dev. = '1114.09', fps = '25.00'
2009-01-29 11:06:32.241 NVP(0): 1200 interlaced frames seen.
'video_output' mean = '39999.52', std. dev. = '860.52', fps = '25.00'
'video_output' mean = '39997.80', std. dev. = '911.75', fps = '25.00'
'video_output' mean = '39997.31', std. dev. = '1069.06', fps = '25.00'
'video_output' mean = '40135.25', std. dev. = '2783.18', fps = '24.92'
2009-01-29 11:06:48.251 NVP(0): 1600 interlaced frames seen.
'video_output' mean = '39869.87', std. dev. = '2981.18', fps = '25.08'
'video_output' mean = '39999.43', std. dev. = '479.65', fps = '25.00'
'video_output' mean = '39996.66', std. dev. = '854.64', fps = '25.00'
'video_output' mean = '39998.08', std. dev. = '1745.91', fps = '25.00'
2009-01-29 11:07:04.242 NVP(0): 2000 interlaced frames seen.
'video_output' mean = '39997.88', std. dev. = '422.02', fps = '25.00'
'video_output' mean = '39999.56', std. dev. = '618.88', fps = '25.00'
'video_output' mean = '40006.44', std. dev. = '886.40', fps = '25.00'
'video_output' mean = '39998.04', std. dev. = '2123.76', fps = '25.00'
2009-01-29 11:07:20.241 NVP(0): 2400 interlaced frames seen.
'video_output' mean = '39999.82', std. dev. = '557.84', fps = '25.00'
'video_output' mean = '39997.41', std. dev. = '354.99', fps = '25.00'
'video_output' mean = '39996.75', std. dev. = '566.13', fps = '25.00'
'video_output' mean = '39997.94', std. dev. = '377.92', fps = '25.00'
2009-01-29 11:07:36.242 NVP(0): 2800 interlaced frames seen.
'video_output' mean = '39996.54', std. dev. = '1024.87', fps = '25.00'
'video_output' mean = '40009.60', std. dev. = '798.44', fps = '24.99'
'video_output' mean = '40000.74', std. dev. = '804.43', fps = '25.00'
'video_output' mean = '39994.79', std. dev. = '2282.94', fps = '25.00'
2009-01-29 11:07:52.241 NVP(0): 3200 interlaced frames seen.
'video_output' mean = '39999.36', std. dev. = '380.43', fps = '25.00'
'video_output' mean = '39998.20', std. dev. = '655.21', fps = '25.00'
'video_output' mean = '39996.61', std. dev. = '692.95', fps = '25.00'
'video_output' mean = '39999.27', std. dev. = '329.67', fps = '25.00'
2009-01-29 11:08:08.242 NVP(0): 3600 interlaced frames seen.
'video_output' mean = '40006.60', std. dev. = '825.32', fps = '25.00'
'video_output' mean = '39998.09', std. dev. = '680.19', fps = '25.00'
'video_output' mean = '39998.99', std. dev. = '1004.71', fps = '25.00'
'video_output' mean = '39996.98', std. dev. = '605.69', fps = '25.00'
2009-01-29 11:08:24.241 NVP(0): 4000 interlaced frames seen.
'video_output' mean = '39997.77', std. dev. = '634.73', fps = '25.00'
'video_output' mean = '39997.93', std. dev. = '680.79', fps = '25.00'
'video_output' mean = '39998.08', std. dev. = '687.54', fps = '25.00'
'video_output' mean = '40007.68', std. dev. = '671.88', fps = '25.00'
2009-01-29 11:08:40.241 NVP(0): 4400 interlaced frames seen.
'video_output' mean = '39998.06', std. dev. = '483.21', fps = '25.00'
'video_output' mean = '40054.35', std. dev. = '738.02', fps = '24.97'
'video_output' mean = '39941.56', std. dev. = '2282.16', fps = '25.04'
'video_output' mean = '39999.69', std. dev. = '655.81', fps = '25.00'
2009-01-29 11:08:56.242 NVP(0): 4800 interlaced frames seen.
'video_output' mean = '39997.10', std. dev. = '1423.29', fps = '25.00'
'video_output' mean = '39997.72', std. dev. = '754.71', fps = '25.00'
'video_output' mean = '40012.59', std. dev. = '596.61', fps = '24.99'
'video_output' mean = '39995.26', std. dev. = '1604.67', fps = '25.00'
2009-01-29 11:09:12.241 NVP(0): 5200 interlaced frames seen.
'video_output' mean = '39995.60', std. dev. = '985.98', fps = '25.00'
'video_output' mean = '39997.70', std. dev. = '1139.19', fps = '25.00'
'video_output' mean = '40012.43', std. dev. = '635.89', fps = '24.99'
'video_output' mean = '39983.10', std. dev. = '373.44', fps = '25.01'
2009-01-29 11:09:28.242 NVP(0): 5600 interlaced frames seen.
'video_output' mean = '39998.03', std. dev. = '556.92', fps = '25.00'
'video_output' mean = '40009.21', std. dev. = '599.85', fps = '24.99'
'video_output' mean = '39996.22', std. dev. = '375.29', fps = '25.00'
2009-01-29 11:09:42.340 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:09:44.356 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:09:46.371 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:09:48.426 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:09:50.464 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:09:52.487 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:09:54.529 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:09:56.558 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:09:58.586 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:00.601 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:02.618 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:04.659 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:06.691 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:08.711 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:10.728 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:12.747 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:14.773 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:16.794 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:18.822 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:20.839 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:22.861 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:24.877 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:26.900 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:28.926 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:30.944 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:32.962 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:34.979 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:37.012 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:39.029 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:41.053 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:43.069 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:45.104 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:47.118 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:49.177 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:51.194 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:53.225 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:55.256 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:57.280 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:10:59.309 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:01.337 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:03.371 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:05.403 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:07.428 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:09.459 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:11.477 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:13.517 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:15.554 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:17.580 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:19.605 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:21.631 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:23.662 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:25.702 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:27.747 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:29.820 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:31.843 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:33.900 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:35.921 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:37.937 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:39.959 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:41.975 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:43.991 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:46.008 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:48.050 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:50.116 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:52.154 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:54.181 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:56.234 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:11:58.259 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:00.288 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:02.305 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:04.330 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:06.359 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:08.383 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:10.413 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:12.443 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:14.476 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:16.501 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:18.547 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:20.576 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:22.621 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:24.663 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:26.677 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:28.721 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:30.763 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:32.789 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:34.813 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:36.832 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:38.875 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:40.907 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:42.937 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:44.984 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:47.019 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:49.055 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:51.114 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:53.132 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:55.156 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:57.171 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:12:59.192 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:01.217 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:03.250 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:05.272 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:07.290 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:09.320 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:11.340 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:13.356 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:15.388 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:17.410 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:19.438 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:21.452 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:23.516 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:25.554 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:27.587 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:29.629 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:31.655 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:33.679 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:35.706 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:37.728 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:39.760 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:41.782 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:43.809 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:45.839 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:47.863 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:49.893 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:51.913 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:53.943 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:55.963 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:13:57.981 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:00.006 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:02.023 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:04.043 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:06.059 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:08.076 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:10.104 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:12.118 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:14.141 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:16.157 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:18.181 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:20.215 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:22.229 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:24.246 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:26.260 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:28.275 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:30.296 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:32.310 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:34.327 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:36.340 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:38.357 NVP(0): Timed out waiting for free video buffers.
2009-01-29 11:14:40.314 NVP(0): Video is 7.74843 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.314 NVP(0): Video is 13.3926 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.315 NVP(0): Video is 17.3757 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.315 NVP(0): Video is 20.1005 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.315 NVP(0): Video is 21.8941 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.316 NVP(0): Video is 22.9893 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.316 NVP(0): Video is 23.567 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.317 NVP(0): Video is 23.7502 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.317 NVP(0): Video is 23.6376 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.317 NVP(0): Video is 23.297 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.318 NVP(0): Video is 22.7915 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.318 NVP(0): Video is 22.1686 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.319 NVP(0): Video is 21.4515 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.319 NVP(0): Video is 20.6636 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.319 NVP(0): Video is 19.8164 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.320 NVP(0): Video is 18.931 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.320 NVP(0): Video is 18.0233 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.321 NVP(0): Video is 17.0924 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.321 NVP(0): Video is 16.1443 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.322 NVP(0): Video is 15.177 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.322 NVP(0): Video is 14.2015 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.322 NVP(0): Video is 13.2261 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.323 NVP(0): Video is 12.2446 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.323 NVP(0): Video is 11.2584 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.324 NVP(0): Video is 10.2626 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.324 NVP(0): Video is 9.26565 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.324 NVP(0): Video is 8.27423 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.325 NVP(0): Video is 7.28065 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.325 NVP(0): prebuffering pause
2009-01-29 11:14:40.325 AO: Pause 1
2009-01-29 11:14:40.325 NVP(0): Waiting for prebuffer..  0 AAAAAAAAuAALAAAAAAAAAAAAAAAAAAA
2009-01-29 11:14:40.325 AO: OutputAudioLoop: audio paused
2009-01-29 11:14:40.325 WriteAudio: buffer underrun
2009-01-29 11:14:40.367 AO: Pause 0
2009-01-29 11:14:40.367 NVP(0): Video is 6.28547 frames behind audio (too slow), dropping frame to catch up.
2009-01-29 11:14:40.369 AO: OutputAudioLoop: Play Event
'video_output' mean = '3028354.26', std. dev. = '29996366.07', fps = '0.33'
2009-01-29 11:14:43.078 NVP(0): 6000 interlaced frames seen.
'video_output' mean = '39997.45', std. dev. = '655.50', fps = '25.00'

Changed 10 years ago by mythtv@…

Attachment: mythfrontend.log added

mythfrontend -v playback log

comment:3 Changed 10 years ago by mythtv@…

Log file attached. Log contains the start of mythfrontend (noting that DPMS is disabled), then a live TV playback which is paused, then released and finally exited.

Apart from the initial DPMS disabled message, there are no screensaver log entries that I can find.

Changed 10 years ago by mythtv@…

Attachment: mythfrontend2.log added

playback log with DPMS initially active

comment:4 Changed 10 years ago by mythtv@…

The initial state of DPMS got me thinking, so I restarted the X server and tested again. This time DPMS was active at start time, and the second playback log shows that the screensaver is now working correctly. Obviously the initial state of DPMS disabled is causing some problems.

comment:5 Changed 10 years ago by mythtv@…

Ah... found it!

In screensaver-x11.cpp the initial state of DPMS is stored in m_dpmsenabled, which is referred to by IsDPMSEnabled(). DisableDPMS() correctly uses IsDPMSEnabled() to determine whether the screen saver is disabled or not and then sets the global m_dpmsdeactivated (but only if it wasn't already disabled). However, RestoreDPMS() only uses the global m_dpmsdeactivated to determine the current state, which is never set in the case where DPMS was inactive at startup.

Presumably all of this is to cater for cases where DPMS is not actually supported on the display, so changing the tests in DisableDPMS() or RestoreDPMS() may cause problems. Attached is a patch which simply re-enables DPMS if it is found to be disabled at startup.

Changed 10 years ago by mythtv@…

Attachment: initial_DPMS_fix.diff added

Patch to fix initial DPMS state if disabled

comment:6 Changed 10 years ago by danielk

Resolution: invalid
Status: infoneeded_newclosed

DPMS should not be turned on if it wasn't on initially. You can use xset in one of your login scripts if you want DPMS to be enabled, or specify it in the xorg.conf.

Note: See TracTickets for help on using tickets.