2011-07-22 10:32:43.768 mythfrontend version: [v0.24.1] www.mythtv.org 2011-07-22 10:32:43.769 Using runtime prefix = /usr 2011-07-22 10:32:43.769 Using configuration directory = /mnt/homes/mythtv---wz/.mythtv 2011-07-22 10:32:43.772 ThreadPool:HTTP: Initial 1, Max 25, Timeout 60000 2011-07-22 10:32:44.768 Using localhost value of wohnzimmer 2011-07-22 10:32:44.769 Testing network connectivity to 'server.home.xx' 2011-07-22 10:32:44.907 New DB connection, total: 1 2011-07-22 10:32:44.912 Connected to database 'mythconverg' at host: server.home.xx 2011-07-22 10:32:44.981 Closing DB connection named 'DBManager0' 2011-07-22 10:32:44.983 Connected to database 'mythconverg' at host: server.home.xx 2011-07-22 10:32:44.987 Current locale DE_DE 2011-07-22 10:32:44.988 Reading locale defaults from /usr/share/mythtv//locales/de_de.xml 2011-07-22 10:32:45.176 ScreenSaverX11Private: Gnome screen saver support enabled 2011-07-22 10:32:45.178 DPMS is disabled. 2011-07-22 10:32:45.215 Desktop video mode: 1280x720 60.073 Hz 2011-07-22 10:32:45.256 Enabled verbose msgs: important general audio timestamp 2011-07-22 10:32:45.263 Loading de translation for module mythfrontend 2011-07-22 10:32:45.287 LIRC: Successfully initialized '/dev/lircd' using '/mnt/homes/mythtv---wz/.lircrc' config 2011-07-22 10:32:45.288 JoystickMenuThread: Joystick disabled - Failed to read /mnt/homes/mythtv---wz/.mythtv/joystickmenurc 2011-07-22 10:32:45.356 Using Frameless Window 2011-07-22 10:32:45.798 Using the OpenGL painter 2011-07-22 10:32:45.957 OpenGL: OpenGL vendor : NVIDIA Corporation 2011-07-22 10:32:45.958 OpenGL: OpenGL renderer: GeForce4 Ti 4200/AGP/SSE/3DNOW! 2011-07-22 10:32:45.958 OpenGL: OpenGL version : 1.5.8 NVIDIA 96.43.18 2011-07-22 10:32:45.958 OpenGL: Max texture size: 4096 x 4096 2011-07-22 10:32:45.958 OpenGL: Max texture units: 4 2011-07-22 10:32:45.958 OpenGL: Direct rendering: Yes 2011-07-22 10:32:45.958 OpenGL: Initialised MythRenderOpenGL 2011-07-22 10:32:46.643 Current MythTV Schema Version (DBSchemaVer): 1264 2011-07-22 10:32:46.719 New DB connection, total: 2 2011-07-22 10:32:46.723 Connected to database 'mythconverg' at host: server.home.xx 2011-07-22 10:32:47.179 Pulse: PulseAudio not running 2011-07-22 10:32:47.196 AO: SRC quality = disabled 2011-07-22 10:32:47.200 AO: Sample rate 8000 is supported 2011-07-22 10:32:47.200 AO: Sample rate 11025 is supported 2011-07-22 10:32:47.200 AO: Sample rate 16000 is supported 2011-07-22 10:32:47.200 AO: Sample rate 22050 is supported 2011-07-22 10:32:47.200 AO: Sample rate 32000 is supported 2011-07-22 10:32:47.200 AO: Sample rate 44100 is supported 2011-07-22 10:32:47.200 AO: Sample rate 48000 is supported 2011-07-22 10:32:47.201 AO: Sample rate 64000 is supported 2011-07-22 10:32:47.201 AO: Sample rate 88200 is supported 2011-07-22 10:32:47.201 AO: Sample rate 96000 is supported 2011-07-22 10:32:47.201 AO: 1 channel(s) are supported 2011-07-22 10:32:47.201 AO: 2 channel(s) are supported 2011-07-22 10:32:47.201 AO: 3 channel(s) are supported 2011-07-22 10:32:47.201 AO: 4 channel(s) are supported 2011-07-22 10:32:47.201 AO: 5 channel(s) are supported 2011-07-22 10:32:47.201 AO: 6 channel(s) are supported 2011-07-22 10:32:47.201 AO: 7 channel(s) are supported 2011-07-22 10:32:47.201 AO: 8 channel(s) are supported 2011-07-22 10:32:47.232 AO: Killing AudioOutputDSP 2011-07-22 10:32:47.232 Found ALSA:iec958:CARD=EWX2496,DEV=0 (ALSA:iec958:CARD=EWX2496,DEV=0 Device supports up to 7.1 (digital output, AC3,DTS,multi-channels LPCM)) 2011-07-22 10:32:47.508 Registering Internal as a media playback plugin. 2011-07-22 10:32:47.640 MMUnix::AddDevice() Error: failed to stat /dev/bdi, eno: Datei oder Verzeichnis nicht gefunden (2) 2011-07-22 10:32:47.680 MMUnix::AddDevice() Error: failed to stat /dev/power, eno: Datei oder Verzeichnis nicht gefunden (2) 2011-07-22 10:32:47.731 MMUnix::AddDevice() Error: failed to stat /dev/trace, eno: Datei oder Verzeichnis nicht gefunden (2) 2011-07-22 10:32:47.770 MonitorRegisterExtensions(0x100, gif,jpg,png) 2011-07-22 10:32:47.771 Loading de translation for module mythgallery 2011-07-22 10:32:47.843 Current MythMusic Schema Version (MusicDBSchemaVer): 1017 2011-07-22 10:32:47.935 MonitorRegisterExtensions(0x40, mp3,mp2,ogg,oga,flac,wma,wav,ac3,oma,omg,atp,ra,dts,aac,m4a,aa3,tta,mka,aiff,swa,wv) 2011-07-22 10:32:47.950 Loading de translation for module mythmusic 2011-07-22 10:32:47.967 Current MythVideo Schema Version (mythvideo.DBSchemaVer): 1038 2011-07-22 10:32:48.010 Loading de translation for module mythvideo 2011-07-22 10:32:48.032 Starting update of BBC-Current-XML 2011-07-22 10:32:48.033 BBC-Current-XML recently updated, skipping. 2011-07-22 10:32:48.035 Starting update of BBC-3day-XML 2011-07-22 10:32:48.036 BBC-3day-XML recently updated, skipping. 2011-07-22 10:32:48.039 Loading de translation for module mythweather 2011-07-22 10:32:48.770 Found mainmenu.xml for theme 'MythCenter-wide---024' 2011-07-22 10:32:49.025 MythCoreContext: Connecting to backend server: 192.168.33.2:6543 (try 1 of 5) 2011-07-22 10:32:49.027 Using protocol version 63 2011-07-22 10:32:57.845 New DB connection, total: 3 2011-07-22 10:32:57.848 Connected to database 'mythconverg' at host: server.home.xx 2011-07-22 10:32:58.081 XMLParse: LoadTheme using '/usr/share/mythtv/themes/default-wide/music-ui.xml' 2011-07-22 10:33:09.202 Pulse: PulseAudio not running 2011-07-22 10:33:09.216 AO: SRC quality = disabled 2011-07-22 10:33:09.219 AO: Sample rate 8000 is supported 2011-07-22 10:33:09.219 AO: Sample rate 11025 is supported 2011-07-22 10:33:09.219 AO: Sample rate 16000 is supported 2011-07-22 10:33:09.219 AO: Sample rate 22050 is supported 2011-07-22 10:33:09.220 AO: Sample rate 32000 is supported 2011-07-22 10:33:09.220 AO: Sample rate 44100 is supported 2011-07-22 10:33:09.220 AO: Sample rate 48000 is supported 2011-07-22 10:33:09.220 AO: Sample rate 64000 is supported 2011-07-22 10:33:09.220 AO: Sample rate 88200 is supported 2011-07-22 10:33:09.220 AO: Sample rate 96000 is supported 2011-07-22 10:33:09.220 AO: 1 channel(s) are supported 2011-07-22 10:33:09.220 AO: 2 channel(s) are supported 2011-07-22 10:33:09.220 AO: 3 channel(s) are supported 2011-07-22 10:33:09.220 AO: 4 channel(s) are supported 2011-07-22 10:33:09.220 AO: 5 channel(s) are supported 2011-07-22 10:33:09.221 AO: 6 channel(s) are supported 2011-07-22 10:33:09.221 AO: 7 channel(s) are supported 2011-07-22 10:33:09.221 AO: 8 channel(s) are supported 2011-07-22 10:33:09.248 AO: Killing AudioOutputDSP 2011-07-22 10:33:09.249 AO: Original codec was NONE, signed 16 bit, 44 kHz, 2 channels 2011-07-22 10:33:09.249 AO: enc(0), passthru(0), canAC3(0), canDTS(0), canLPCM(0), configured_channels(2), 2 channels supported(1) 2011-07-22 10:33:09.250 AO: Opening audio device 'iec958:CARD=EWX2496,DEV=0' ch 2(2) sr 44100 sf signed 16 bit reenc 0 2011-07-22 10:33:09.252 ALSA: SetParameters(format=2, channels=2, rate=44100, buffer_time=500000, period_time=4) 2011-07-22 10:33:09.253 ALSA: Buffer size range from 2 to 6553 2011-07-22 10:33:09.253 ALSA: Period size range from 2 to 3276 2011-07-22 10:33:09.253 ALSA: Requested 500000us got 148594 buffer time 2011-07-22 10:33:09.253 ALSA: Hardware audio buffer cur: 256 need: 896 max allowed: 256 2011-07-22 10:33:09.253 ALSA, Error: Unable to sufficiently increase ALSA hardware buffer size - underruns are likely 2011-07-22 10:33:09.255 ALSA: SetParameters(format=2, channels=2, rate=44100, buffer_time=500000, period_time=4) 2011-07-22 10:33:09.256 ALSA: Buffer size range from 2 to 6553 2011-07-22 10:33:09.256 ALSA: Period size range from 2 to 3276 2011-07-22 10:33:09.256 ALSA: Buffer time = 148594 us 2011-07-22 10:33:09.256 ALSA: Period time = 4 periods 2011-07-22 10:33:09.261 ALSA: Buffer size = 6553 | Period size = 1311 2011-07-22 10:33:09.261 ALSA: Period size changed from 1311 to 1304 2011-07-22 10:33:09.262 AO: Audio fragment size: 2622 2011-07-22 10:33:09.262 AO: Audio Stretch Factor: 1 2011-07-22 10:33:09.262 AO: Ending Reconfigure() 2011-07-22 10:33:09.264 AO: kickoffOutputAudioLoop: pid = 2018 2011-07-22 10:33:09.264 AO: OutputAudioLoop: Play Event 2011-07-22 10:33:09.489 AO: Pause 1 2011-07-22 10:33:09.496 AO: OutputAudioLoop: audio paused 2011-07-22 10:33:09.497 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.497 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.497 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.497 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.497 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.497 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.497 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.498 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.499 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.500 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.500 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.500 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.500 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.500 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.500 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.500 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.500 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.500 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.527 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.528 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.528 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.528 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.528 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.528 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.528 WriteAudio: Preparing 704 bytes (176 frames) 2011-07-22 10:33:09.540 AO: Reconfigure(): No change -> exiting 2011-07-22 10:33:09.548 AO: AddFrames frames=882, bytes=3528, used=1, free=3071999, timecode=-1 needsupmix=0 2011-07-22 10:33:09.548 AO: SetAudiotime atc=0 tc=0 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.548 AO: AddFrames frames=882, bytes=3528, used=3529, free=3068471, timecode=-1 needsupmix=0 2011-07-22 10:33:09.548 AO: SetAudiotime atc=20 tc=20 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.548 AO: AddFrames frames=882, bytes=3528, used=7057, free=3064943, timecode=-1 needsupmix=0 2011-07-22 10:33:09.549 AO: SetAudiotime atc=40 tc=40 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.549 AO: AddFrames frames=882, bytes=3528, used=10585, free=3061415, timecode=-1 needsupmix=0 2011-07-22 10:33:09.549 AO: Pause 0 2011-07-22 10:33:09.549 AO: SetAudiotime atc=60 tc=60 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.549 AO: AddFrames frames=882, bytes=3528, used=14113, free=3057887, timecode=-1 needsupmix=0 2011-07-22 10:33:09.549 AO: SetAudiotime atc=80 tc=80 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.549 AO: AddFrames frames=882, bytes=3528, used=17641, free=3054359, timecode=-1 needsupmix=0 2011-07-22 10:33:09.549 AO: SetAudiotime atc=100 tc=100 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.549 AO: AddFrames frames=882, bytes=3528, used=21169, free=3050831, timecode=-1 needsupmix=0 2011-07-22 10:33:09.549 AO: SetAudiotime atc=120 tc=120 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.549 AO: AddFrames frames=882, bytes=3528, used=24697, free=3047303, timecode=-1 needsupmix=0 2011-07-22 10:33:09.550 AO: SetAudiotime atc=140 tc=140 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.550 AO: AddFrames frames=882, bytes=3528, used=28225, free=3043775, timecode=-1 needsupmix=0 2011-07-22 10:33:09.550 AO: SetAudiotime atc=160 tc=160 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.551 AO: AddFrames frames=882, bytes=3528, used=31753, free=3040247, timecode=-1 needsupmix=0 2011-07-22 10:33:09.551 AO: SetAudiotime atc=180 tc=180 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.551 AO: AddFrames frames=882, bytes=3528, used=35281, free=3036719, timecode=-1 needsupmix=0 2011-07-22 10:33:09.551 AO: SetAudiotime atc=200 tc=200 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.551 AO: AddFrames frames=882, bytes=3528, used=38809, free=3033191, timecode=-1 needsupmix=0 2011-07-22 10:33:09.552 AO: SetAudiotime atc=220 tc=220 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.552 AO: AddFrames frames=882, bytes=3528, used=42337, free=3029663, timecode=-1 needsupmix=0 2011-07-22 10:33:09.552 AO: SetAudiotime atc=240 tc=240 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.552 AO: AddFrames frames=882, bytes=3528, used=45865, free=3026135, timecode=-1 needsupmix=0 2011-07-22 10:33:09.552 AO: SetAudiotime atc=260 tc=260 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.552 AO: AddFrames frames=882, bytes=3528, used=49393, free=3022607, timecode=-1 needsupmix=0 2011-07-22 10:33:09.552 AO: SetAudiotime atc=280 tc=280 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.552 AO: AddFrames frames=882, bytes=3528, used=52921, free=3019079, timecode=-1 needsupmix=0 2011-07-22 10:33:09.552 AO: SetAudiotime atc=300 tc=300 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.552 AO: AddFrames frames=882, bytes=3528, used=56449, free=3015551, timecode=-1 needsupmix=0 2011-07-22 10:33:09.552 AO: SetAudiotime atc=320 tc=320 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.552 AO: AddFrames frames=882, bytes=3528, used=59977, free=3012023, timecode=-1 needsupmix=0 2011-07-22 10:33:09.553 AO: SetAudiotime atc=340 tc=340 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.554 AO: AddFrames frames=882, bytes=3528, used=63505, free=3008495, timecode=-1 needsupmix=0 2011-07-22 10:33:09.557 AO: OutputAudioLoop: Play Event 2011-07-22 10:33:09.557 AO: GetAudiotime audt=0 atc=340 mb=63504 sb=21112 tb=84616 sr=44100 obpf=4 bpf=4 sf=1 8461600000 479 2011-07-22 10:33:09.558 AO: GetAudiotime audt=0 atc=340 mb=63504 sb=21080 tb=84584 sr=44100 obpf=4 bpf=4 sf=1 8458400000 479 2011-07-22 10:33:09.558 ALSA, Error: ALSA: WriteAudio: data not aligned to alsa-frame size 2011-07-22 10:33:09.558 ALSA, Error: ALSA: size: 2622, size needed: 2616 2011-07-22 10:33:09.558 WriteAudio: Preparing 2622 bytes (655 frames) 2011-07-22 10:33:09.558 AO: GetAudiotime audt=0 atc=340 mb=60882 sb=23624 tb=84506 sr=44100 obpf=4 bpf=4 sf=1 8450600000 479 2011-07-22 10:33:09.558 ALSA, Error: ALSA: WriteAudio: data not aligned to alsa-frame size 2011-07-22 10:33:09.558 ALSA, Error: ALSA: size: 2622, size needed: 2616 2011-07-22 10:33:09.558 WriteAudio: Preparing 2622 bytes (655 frames) 2011-07-22 10:33:09.558 AO: GetAudiotime audt=0 atc=340 mb=58260 sb=26184 tb=84444 sr=44100 obpf=4 bpf=4 sf=1 8444400000 478 2011-07-22 10:33:09.559 ALSA, Error: ALSA: WriteAudio: data not aligned to alsa-frame size 2011-07-22 10:33:09.559 ALSA, Error: ALSA: size: 2622, size needed: 2616 2011-07-22 10:33:09.559 WriteAudio: Preparing 2622 bytes (655 frames) 2011-07-22 10:33:09.566 AO: SetAudiotime atc=360 tc=360 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.567 AO: AddFrames frames=882, bytes=3528, used=61789, free=3010211, timecode=-1 needsupmix=0 2011-07-22 10:33:09.567 AO: SetAudiotime atc=380 tc=380 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.567 AO: AddFrames frames=882, bytes=3528, used=65317, free=3006683, timecode=-1 needsupmix=0 2011-07-22 10:33:09.567 AO: SetAudiotime atc=400 tc=400 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.567 AO: AddFrames frames=882, bytes=3528, used=68845, free=3003155, timecode=-1 needsupmix=0 2011-07-22 10:33:09.567 AO: SetAudiotime atc=420 tc=420 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.567 AO: AddFrames frames=882, bytes=3528, used=72373, free=2999627, timecode=-1 needsupmix=0 2011-07-22 10:33:09.567 AO: SetAudiotime atc=440 tc=440 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.567 AO: AddFrames frames=882, bytes=3528, used=75901, free=2996099, timecode=-1 needsupmix=0 2011-07-22 10:33:09.567 AO: SetAudiotime atc=460 tc=460 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.567 AO: AddFrames frames=882, bytes=3528, used=79429, free=2992571, timecode=-1 needsupmix=0 2011-07-22 10:33:09.567 AO: SetAudiotime atc=480 tc=480 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.568 AO: AddFrames frames=882, bytes=3528, used=82957, free=2989043, timecode=-1 needsupmix=0 2011-07-22 10:33:09.568 AO: SetAudiotime atc=500 tc=500 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.568 AO: AddFrames frames=882, bytes=3528, used=86485, free=2985515, timecode=-1 needsupmix=0 2011-07-22 10:33:09.568 AO: SetAudiotime atc=520 tc=520 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.569 AO: AddFrames frames=882, bytes=3528, used=90013, free=2981987, timecode=-1 needsupmix=0 2011-07-22 10:33:09.569 AO: SetAudiotime atc=540 tc=540 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.569 AO: AddFrames frames=882, bytes=3528, used=93541, free=2978459, timecode=-1 needsupmix=0 2011-07-22 10:33:09.570 AO: SetAudiotime atc=560 tc=560 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.570 AO: AddFrames frames=882, bytes=3528, used=97069, free=2974931, timecode=-1 needsupmix=0 2011-07-22 10:33:09.570 AO: SetAudiotime atc=580 tc=580 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.570 AO: AddFrames frames=882, bytes=3528, used=100597, free=2971403, timecode=-1 needsupmix=0 2011-07-22 10:33:09.570 AO: SetAudiotime atc=600 tc=600 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.574 AO: AddFrames frames=882, bytes=3528, used=104125, free=2967875, timecode=-1 needsupmix=0 2011-07-22 10:33:09.574 AO: SetAudiotime atc=620 tc=620 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.574 AO: AddFrames frames=882, bytes=3528, used=107653, free=2964347, timecode=-1 needsupmix=0 2011-07-22 10:33:09.574 AO: SetAudiotime atc=640 tc=640 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.574 AO: AddFrames frames=882, bytes=3528, used=111181, free=2960819, timecode=-1 needsupmix=0 2011-07-22 10:33:09.574 AO: SetAudiotime atc=660 tc=660 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.574 AO: AddFrames frames=882, bytes=3528, used=114709, free=2957291, timecode=-1 needsupmix=0 2011-07-22 10:33:09.575 AO: SetAudiotime atc=680 tc=680 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.575 AO: AddFrames frames=882, bytes=3528, used=118237, free=2953763, timecode=-1 needsupmix=0 2011-07-22 10:33:09.575 AO: SetAudiotime atc=700 tc=700 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.575 AO: AddFrames frames=882, bytes=3528, used=121765, free=2950235, timecode=-1 needsupmix=0 2011-07-22 10:33:09.575 AO: SetAudiotime atc=720 tc=720 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.576 AO: AddFrames frames=882, bytes=3528, used=125293, free=2946707, timecode=-1 needsupmix=0 2011-07-22 10:33:09.576 AO: SetAudiotime atc=740 tc=740 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.576 AO: AddFrames frames=882, bytes=3528, used=128821, free=2943179, timecode=-1 needsupmix=0 2011-07-22 10:33:09.577 AO: SetAudiotime atc=760 tc=760 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.577 AO: AddFrames frames=882, bytes=3528, used=132349, free=2939651, timecode=-1 needsupmix=0 2011-07-22 10:33:09.577 AO: SetAudiotime atc=780 tc=780 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.577 AO: AddFrames frames=882, bytes=3528, used=135877, free=2936123, timecode=-1 needsupmix=0 2011-07-22 10:33:09.580 AO: SetAudiotime atc=800 tc=800 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.581 AO: AddFrames frames=882, bytes=3528, used=139405, free=2932595, timecode=-1 needsupmix=0 2011-07-22 10:33:09.581 AO: SetAudiotime atc=820 tc=820 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.581 AO: AddFrames frames=882, bytes=3528, used=142933, free=2929067, timecode=-1 needsupmix=0 2011-07-22 10:33:09.581 AO: SetAudiotime atc=840 tc=840 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.581 AO: AddFrames frames=882, bytes=3528, used=146461, free=2925539, timecode=-1 needsupmix=0 2011-07-22 10:33:09.581 AO: SetAudiotime atc=860 tc=860 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.581 AO: AddFrames frames=882, bytes=3528, used=149989, free=2922011, timecode=-1 needsupmix=0 2011-07-22 10:33:09.581 AO: SetAudiotime atc=880 tc=880 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.581 AO: AddFrames frames=882, bytes=3528, used=153517, free=2918483, timecode=-1 needsupmix=0 2011-07-22 10:33:09.581 AO: SetAudiotime atc=900 tc=900 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.587 AO: AddFrames frames=882, bytes=3528, used=157045, free=2914955, timecode=-1 needsupmix=0 2011-07-22 10:33:09.587 AO: SetAudiotime atc=920 tc=920 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.587 AO: AddFrames frames=882, bytes=3528, used=160573, free=2911427, timecode=-1 needsupmix=0 2011-07-22 10:33:09.587 AO: SetAudiotime atc=940 tc=940 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.588 AO: AddFrames frames=882, bytes=3528, used=164101, free=2907899, timecode=-1 needsupmix=0 2011-07-22 10:33:09.588 AO: SetAudiotime atc=960 tc=960 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.588 AO: AddFrames frames=882, bytes=3528, used=167629, free=2904371, timecode=-1 needsupmix=0 2011-07-22 10:33:09.588 AO: SetAudiotime atc=980 tc=980 f=882 pfu=0 pfs=0 2011-07-22 10:33:09.588 AO: GetAudiotime audt=0 atc=980 mb=171156 sb=20992 tb=192148 sr=44100 obpf=4 bpf=4 sf=1 19214800000 1089 2011-07-22 10:33:09.617 AO: GetAudiotime audt=0 atc=980 mb=168534 sb=18540 tb=187074 sr=44100 obpf=4 bpf=4 sf=1 18707400000 1060 2011-07-22 10:33:09.617 ALSA, Error: ALSA: WriteAudio: data not aligned to alsa-frame size 2011-07-22 10:33:09.617 ALSA, Error: ALSA: size: 2622, size needed: 2616 2011-07-22 10:33:09.617 WriteAudio: Preparing 2622 bytes (655 frames) 2011-07-22 10:33:09.617 AO: GetAudiotime audt=0 atc=980 mb=165912 sb=21060 tb=186972 sr=44100 obpf=4 bpf=4 sf=1 18697200000 1059 2011-07-22 10:33:09.617 ALSA, Error: ALSA: WriteAudio: data not aligned to alsa-frame size 2011-07-22 10:33:09.617 ALSA, Error: ALSA: size: 2622, size needed: 2616 2011-07-22 10:33:09.618 WriteAudio: Preparing 2622 bytes (655 frames) 2011-07-22 10:33:09.618 AO: GetAudiotime audt=0 atc=980 mb=163290 sb=23620 tb=186910 sr=44100 obpf=4 bpf=4 sf=1 18691000000 1059 2011-07-22 10:33:09.618 ALSA, Error: ALSA: WriteAudio: data not aligned to alsa-frame size 2011-07-22 10:33:09.618 ALSA, Error: ALSA: size: 2622, size needed: 2616 2011-07-22 10:33:09.618 WriteAudio: Preparing 2622 bytes (655 frames) 2011-07-22 10:33:09.618 AO: GetAudiotime audt=0 atc=980 mb=160668 sb=26168 tb=186836 sr=44100 obpf=4 bpf=4 sf=1 18683600000 1059