[Vorbis] Fwd: Vorbis Encoder Problem

pavan kumar pavanchikkala at yahoo.co.in
Thu Jan 5 02:04:31 PST 2006


Skipped content of type multipart/alternative-------------- next part --------------
PlatSecEnforcement ON
PlatSecDiagnostics ON
PlatSecProcessIsolation ON
PlatSecEnforceSysBin ON
PlatSecDisabledCaps NONE
     0.000	Thread 00bdd880 created @ 0xbdd880 - Win32 Thread ID 0x8cc
     0.000	Thread EKern.exe::Supervisor created @ 0xcd3400 - Win32 Thread ID 0x858
     0.000	Thread EKern.exe::DfcThread0 created @ 0xcd3ea8 - Win32 Thread ID 0x8c4
     0.000	Thread EKern.exe::DfcThread1 created @ 0xcd42bc - Win32 Thread ID 0x934
     0.000	Thread EKern.exe::TimerThread created @ 0xcd4b70 - Win32 Thread ID 0x7c8
     0.005	Thread EKern.exe::FlashThread created @ 0xcd5910 - Win32 Thread ID 0x5a4
     0.020	Thread EKern.exe::MultiMediaCard0 created @ 0xcd67e4 - Win32 Thread ID 0x69c
     0.020	Thread EKern.exe::NandThread created @ 0xcda360 - Win32 Thread ID 0x4b4
     0.025	Thread EFile.exe::Main created @ 0xcdb0f8 - Win32 Thread ID 0x884
     0.030	Thread EFile.exe::Local-00ce24e8 created @ 0xce27a0 - Win32 Thread ID 0x794
     0.030	Thread EFile.exe::LoaderThread created @ 0xce8f6c - Win32 Thread ID 0x894
     0.030	Thread EFile.exe::StartupThread created @ 0xce9468 - Win32 Thread ID 0x814
     0.060	Thread E32STRT.EXE::Main created @ 0xcf343c - Win32 Thread ID 0x944
     0.065	Thread EFile.exe::Local-00cf39f4 created @ 0xcf3cac - Win32 Thread ID 0x814
     0.080	Thread EFile.exe::Local-00cf5288 created @ 0xcf5540 - Win32 Thread ID 0x78c
     0.080	Thread EFile.exe::Local-00cf58f0 created @ 0xcf5ba8 - Win32 Thread ID 0x760
     0.085	Thread EFile.exe::Local-00cf6130 created @ 0xcf63e8 - Win32 Thread ID 0x8c8
     0.445	Thread EFile.exe::Local-00cf68a0 created @ 0xcf6b58 - Win32 Thread ID 0x840
     0.445	Thread EFile.exe::Local-00cf7018 created @ 0xcf72d0 - Win32 Thread ID 0x7f0
     0.450	Thread EFile.exe::ReclaimThread_49634464 created @ 0xcf7fa0 - Win32 Thread ID 0x86c
     1.075	Thread EFile.exe::InitCompleteThread created @ 0xcf8ccc - Win32 Thread ID 0x924
     1.110	Thread domainSrv.exe::Main created @ 0xcf94bc - Win32 Thread ID 0x924
     1.140	Thread SYSSTART.EXE::Main created @ 0xcfb0c0 - Win32 Thread ID 0x77c
     1.145	SysStart: using resource file Z:\private\10205C44\SSCForStartupMode0.rsc
     1.145	SysStart: Send state transition request (move to Critical Static) to domain manager
     1.145	SysStart: Result of state transition request is 0
     1.145	SysStart: starting Z:\sys\bin\SysAgt2Svr.exe 
     1.165	Thread SysAgt2Svr.exe::Main created @ 0xcfbb44 - Win32 Thread ID 0x870
     1.165	SysStart: waiting on process ...
     1.165	SysStart: done. [0]
     1.165	SysStart: starting Z:\sys\bin\fbserv.exe 
     1.190	Thread fbserv.exe::Main created @ 0xcfd07c - Win32 Thread ID 0x870
     1.190	SysStart: waiting on process ...
     1.220	Thread ecomserver.EXE::Main created @ 0xcfe39c - Win32 Thread ID 0x948
     1.635	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\EON14.GDR
     1.640	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\fnt.ttf
     1.640	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NCRBIU.TTF
     1.645	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NCRBRU.TTF
     1.650	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NCRRIU.TTF
     1.650	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NCRRRU.TTF
     1.655	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NTMBIU.TTF
     1.660	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NTMBRU.TTF
     1.665	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NTMRIU.TTF
     1.670	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NTMRRU.TTF
     1.675	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\SWABIU.TTF
     1.680	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\SWABRU.TTF
     1.685	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\SWARIU.TTF
     1.690	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\SWARRU.TTF
     1.695	SysStart: done. [0]
     1.695	SysStart: starting Z:\sys\bin\wserv.exe -NoShell
     1.795	Thread wserv.exe::Main created @ 0xd001dc - Win32 Thread ID 0x7ac
     1.795	SysStart: waiting on process ...
     1.835	Thread MMFAudioServer.exe::Main created @ 0xd01874 - Win32 Thread ID 0x90c
     1.835	Thread MMFAudioServer.exe::Local-00d009ec created @ 0xd00ca4 - Win32 Thread ID 0x918
     1.925	Thread MMFAudioServer.exe::Local-00d019a0 created @ 0xd01c58 - Win32 Thread ID 0x938
     1.935	Thread MMFAudioServer.exe::Local-00d02790 created @ 0xd02a48 - Win32 Thread ID 0x774
     2.260	SysStart: done. [0]
     2.260	SysStart: Start splash screen Z:\sys\bin\splash.exe
     2.285	Thread splash.exe::Main created @ 0xd38144 - Win32 Thread ID 0x7b0
     2.285	SysStart: starting Z:\sys\bin\eiksrvs.exe -OnlyStartDependentServers
     2.310	Thread eiksrvs.exe::Main created @ 0xd3bc40 - Win32 Thread ID 0x864
     2.310	SysStart: waiting on process ...
     2.400	Thread centralrepositorysrv.EXE::Main created @ 0xd3a688 - Win32 Thread ID 0x7b8
     2.510	Thread Fepswitch.exe::Main created @ 0xd3db34 - Win32 Thread ID 0x7a4
     2.535	Thread eiksrvs.exe::ViewServerThread created @ 0xd3bfb0 - Win32 Thread ID 0x910
     2.580	Thread FLOGSVR.EXE::Main created @ 0xd3d620 - Win32 Thread ID 0x904
     2.810	SysStart: done. [0]
     2.810	SysStart: starting Z:\sys\bin\sisregistryserver.exe 
     2.850	Thread sisregistryserver.exe::Main created @ 0xd40ac8 - Win32 Thread ID 0x308
     2.850	SysStart: waiting on process ...
     2.895	SysStart: done. [0]
     2.895	SysStart: starting Z:\sys\bin\tzserver.exe 
     2.920	Thread tzserver.exe::Main created @ 0xd41190 - Win32 Thread ID 0x8ec
     2.920	SysStart: waiting on process ...
     2.925	SysStart: done. [0]
     2.925	SysStart: Send state transition request (move to Critical Dynamic) to domain manager
     2.925	SysStart: Result of state transition request is 0
     2.925	SysStart: starting Z:\sys\bin\apsexe.exe 
     2.945	Thread apsexe.exe::Main created @ 0xd42c00 - Win32 Thread ID 0x928
     2.945	SysStart: waiting on process ...
     2.970	Thread baksrvs.EXE::Main created @ 0xd43464 - Win32 Thread ID 0x244
     3.140	SysStart: done. [0]
     3.140	SysStart: starting Z:\sys\bin\shell.exe 
     3.230	Thread shell.exe::Main created @ 0xd4b4c8 - Win32 Thread ID 0x490
     3.230	SysStart: checking status of deferred command shell
     3.390	Thread shutdownsrvs.EXE::Main created @ 0xd48f98 - Win32 Thread ID 0x8e4
     3.500	Thread System::SystemServerThread created @ 0xd4a040 - Win32 Thread ID 0x854
     3.560	SysStart: successful rendezvous of deferred command shell 
     3.560	SysStart: Kill splash screen
     3.600	SysStart: Send state transition request (move to Networking-Critical) to domain manager
     3.635	Thread RTAServer.EXE::Main created @ 0xd4bdf4 - Win32 Thread ID 0x7b0
     3.640	SysStart: Result of state transition request is 0
     3.640	SysStart: starting Z:\sys\bin\c32start.exe 
     3.665	Thread c32start.exe::Main created @ 0xd4c850 - Win32 Thread ID 0x630
     3.665	SysStart: waiting on process ...
     3.680	Thread COMSDBGSVR.EXE::Main created @ 0xd4d090 - Win32 Thread ID 0x6e0
     3.685	Thread COMSDBGSVR.EXE::Comsdbg2 created @ 0xd4d8f0 - Win32 Thread ID 0x624
     3.705	Thread c32exe.exe::Main created @ 0xd4f248 - Win32 Thread ID 0x764
     3.705	SysStart: done. [0]
     3.710	SysStart: starting Z:\sys\bin\msexe.exe 
     3.740	Thread msexe.exe::Main created @ 0xd5013c - Win32 Thread ID 0x71c
     3.740	SysStart: waiting on process ...
     3.835	SysStart: done. [0]
     3.835	SysStart: starting Z:\sys\bin\watcher.exe 
     3.840	Thread watcher.exe::Main created @ 0xd53ce4 - Win32 Thread ID 0x940
     3.840	SysStart: waiting on process ...
     3.840	Thread watcher.exe::WatcherMainThread created @ 0xd54150 - Win32 Thread ID 0x5b4
     3.850	Thread c32exe.exe::ESock_Main created @ 0xd55354 - Win32 Thread ID 0x120
     3.865	Thread c32exe.exe::CCommServer created @ 0xd564b0 - Win32 Thread ID 0x800
     3.870	Thread c32exe.exe::CTelServer created @ 0xd56a2c - Win32 Thread ID 0x7dc
     3.875	Thread c32exe.exe::ESock_SIP created @ 0xd55e38 - Win32 Thread ID 0x804
     3.915	Thread c32exe.exe::ESock_SmsWap created @ 0xd58eac - Win32 Thread ID 0x740
     4.030	SysStart: done. [0]
     4.030	SysStart: Send state transition request (move to Non-critical) to domain manager
     4.050	Thread c32exe.exe::SimTsyCPM created @ 0xd5c2c8 - Win32 Thread ID 0x810
     4.050	Thread c32exe.exe::ESock_IP created @ 0xd5a818 - Win32 Thread ID 0x810
     4.140	Thread c32exe.exe::ESock_Bt created @ 0xd5fea0 - Win32 Thread ID 0x908
     4.145	Thread c32exe.exe::ESock_Ir created @ 0xd605b8 - Win32 Thread ID 0x768
     4.365	Thread LogServ.EXE::Main created @ 0xd66e88 - Win32 Thread ID 0x930
     5.110	SysStart: Result of state transition request is 0
     5.110	SysStart: starting Z:\sys\bin\SystemAMS.exe -boot
     5.125	Thread SystemAMS.exe::Main created @ 0xd6d0c8 - Win32 Thread ID 0x308
     5.130	SysStart: starting Z:\sys\bin\swidaemon.exe 
     5.155	Thread swidaemon.exe::Main created @ 0xd6f59c - Win32 Thread ID 0xe8
     5.155	SysStart: waiting on process ...
     5.275	Thread SisRegistryServer.EXE::Main created @ 0xd7086c - Win32 Thread ID 0x920
     5.335	SysStart: done. [0]
     5.335	SysStart: starting Z:\sys\bin\cntsrv.exe -nontransient
     5.415	Thread cntsrv.exe::Main created @ 0xd7111c - Win32 Thread ID 0x348
     5.415	SysStart: starting Z:\sys\bin\agsvexe.exe -nontransient
     5.435	Thread agsvexe.exe::Main created @ 0xd71db8 - Win32 Thread ID 0x278
     5.445	Thread SystemAMS.exe::Security2.Thread created @ 0xd7181c - Win32 Thread ID 0x77c
     5.770	Thread SystemAMS.exe::!MIDP.SystemAMS.Connection.ServerThread created @ 0xd74870 - Win32 Thread ID 0x498
     5.770	Thread SystemAMS.exe::MIDP2.CHS.Thread created @ 0xd758d8 - Win32 Thread ID 0x8d0
     5.790	Thread EDBSRV.EXE::Main created @ 0xd762e4 - Win32 Thread ID 0x7a8
     6.540	Thread dnd.exe::Main created @ 0xd7acf4 - Win32 Thread ID 0x8bc
     6.785	Thread SystemAMS.exe::MIDP2.LifecycleV2.Thread created @ 0xd7a3f8 - Win32 Thread ID 0x7f8
     6.805	Thread SystemAMS.exe::MIDP2.CMS.Thread created @ 0xd7b904 - Win32 Thread ID 0x744
     6.805	Thread SystemAMS.exe::MIDP2.CID.Thread created @ 0xd7bfb8 - Win32 Thread ID 0x468
     6.810	Thread Audio.exe::Main created @ 0xd80930 - Win32 Thread ID 0x74c
    11.105	*PlatSec* ERROR - Capability check failed - A Message (function number=0x00000031) from Thread Sound Rec[001f4119]0001::Sound Rec, sent to Server !FileServer, was checked by Thread EFile.exe[100039e3]0001::Main and was found to be missing the capabilities: AllFiles .  Additional diagnostic message: \private\* Used to call: Dir Open
    11.105	*PlatSec* ERROR - Capability check failed - A Message (function number=0x00000031) from Thread Sound Rec[001f4119]0001::Sound Rec, sent to Server !FileServer, was checked by Thread EFile.exe[100039e3]0001::Main and was found to be missing the capabilities: AllFiles .  Additional diagnostic message: \sys\* Used to call: Dir Open
    17.930	Thread Sound Rec::MMFControllerProxyServer8150af81 created @ 0xd0406c - Win32 Thread ID 0x7a8
    17.940	COggRecordController::NewL
    17.950	Thread MMFAudioServer.exe::Local-00d047c0 created @ 0xd04a78 - Win32 Thread ID 0x920
    17.970	Thread Sound Rec::MMFControllerProxyServerebd775c6 created @ 0xd05a44 - Win32 Thread ID 0x7e4
    17.980	Thread MMFAudioServer.exe::Local-00d061cc created @ 0xd06484 - Win32 Thread ID 0x340
    20.610	CVorbisHwDeviceWrapper2::NewL
    20.610	CVorbisEncoderPlugIn::NewL
    20.610	CVorbisHwDeviceWrapper2::Codec
    20.920	COggRecordController::PlayL
    21.370	Called vorbis_analysis_buffer with int vals = 1024
    21.370	Called vorbis_analysis_wrote with vals = 1024
    21.495	Called vorbis_analysis_buffer with int vals = 1024
    21.495	Called vorbis_analysis_wrote with vals = 1024
    21.625	Called vorbis_analysis_buffer with int vals = 1024
    21.625	Called vorbis_analysis_wrote with vals = 1024
    21.635	called vorbis_analysis_blockout with return of 1
    21.635	called  packet vorbis_bitrate_flushpacket
    21.635	CVorbisEncoder::PacketOut packet of length 18 added to cache
    21.635	HeaderPageLength 58
    21.635	HeaderPageLength 4206
    21.635	HeaderPageLength 107
    21.635	called vorbis_analysis_blockout with return of 1
    21.640	called  packet vorbis_bitrate_flushpacket
    21.640	CVorbisEncoder::PacketOut packet of length 63 added to cache
    21.640	called vorbis_analysis_blockout with return of 1
    21.645	called  packet vorbis_bitrate_flushpacket
    21.645	CVorbisEncoder::PacketOut packet of length 86 added to cache
    21.645	called vorbis_analysis_blockout with return of 1
    21.650	called  packet vorbis_bitrate_flushpacket
    21.650	CVorbisEncoder::PacketOut packet of length 76 added to cache
    21.650	called vorbis_analysis_blockout with return of 1
    21.655	called  packet vorbis_bitrate_flushpacket
    21.655	CVorbisEncoder::PacketOut packet of length 56 added to cache
    21.655	called vorbis_analysis_blockout with return of 1
    21.655	called  packet vorbis_bitrate_flushpacket
    21.655	CVorbisEncoder::PacketOut packet of length 76 added to cache
    21.655	called vorbis_analysis_blockout with return of 1
    21.660	called  packet vorbis_bitrate_flushpacket
    21.660	CVorbisEncoder::PacketOut packet of length 54 added to cache
    21.660	called vorbis_analysis_blockout with return of 1
    21.665	called  packet vorbis_bitrate_flushpacket
    21.665	CVorbisEncoder::PacketOut packet of length 62 added to cache
    21.665	called vorbis_analysis_blockout with return of 1
    21.665	called  packet vorbis_bitrate_flushpacket
    21.665	CVorbisEncoder::PacketOut packet of length 63 added to cache
    21.665	called vorbis_analysis_blockout with return of 1
    21.670	called  packet vorbis_bitrate_flushpacket
    21.670	CVorbisEncoder::PacketOut packet of length 56 added to cache
    21.670	called vorbis_analysis_blockout with return of 1
    21.675	called  packet vorbis_bitrate_flushpacket
    21.675	CVorbisEncoder::PacketOut packet of length 71 added to cache
    21.675	called vorbis_analysis_blockout with return of 1
    21.680	called  packet vorbis_bitrate_flushpacket
    21.680	CVorbisEncoder::PacketOut packet of length 65 added to cache
    21.680	called vorbis_analysis_blockout with return of 1
    21.680	called  packet vorbis_bitrate_flushpacket
    21.680	CVorbisEncoder::PacketOut packet of length 62 added to cache
    21.680	called vorbis_analysis_blockout with return of 1
    21.685	called  packet vorbis_bitrate_flushpacket
    21.685	CVorbisEncoder::PacketOut packet of length 73 added to cache
    21.685	called vorbis_analysis_blockout with return of 1
    21.690	called  packet vorbis_bitrate_flushpacket
    21.690	CVorbisEncoder::PacketOut packet of length 63 added to cache
    21.690	called vorbis_analysis_blockout with return of 1
    21.695	called  packet vorbis_bitrate_flushpacket
    21.695	CVorbisEncoder::PacketOut packet of length 57 added to cache
    21.695	called vorbis_analysis_blockout with return of 1
    21.700	called  packet vorbis_bitrate_flushpacket
    21.700	CVorbisEncoder::PacketOut packet of length 68 added to cache
    21.700	called vorbis_analysis_blockout with return of 1
    21.705	called  packet vorbis_bitrate_flushpacket
    21.705	CVorbisEncoder::PacketOut packet of length 65 added to cache
    21.705	called vorbis_analysis_blockout with return of 1
    21.705	called  packet vorbis_bitrate_flushpacket
    21.705	CVorbisEncoder::PacketOut packet of length 69 added to cache
    21.705	called vorbis_analysis_blockout with return of 1
    21.710	called  packet vorbis_bitrate_flushpacket
    21.710	CVorbisEncoder::PacketOut packet of length 68 added to cache
    21.750	Called vorbis_analysis_buffer with int vals = 1024
    21.750	Called vorbis_analysis_wrote with vals = 1024
    21.880	Called vorbis_analysis_buffer with int vals = 1024
    21.880	Called vorbis_analysis_wrote with vals = 1024
    21.880	called vorbis_analysis_blockout with return of 1
    21.885	called  packet vorbis_bitrate_flushpacket
    21.885	CVorbisEncoder::PacketOut packet of length 61 added to cache
    22.010	Called vorbis_analysis_buffer with int vals = 1024
    22.010	Called vorbis_analysis_wrote with vals = 1024
    22.010	called vorbis_analysis_blockout with return of 1
    22.035	called  packet vorbis_bitrate_flushpacket
    22.035	CVorbisEncoder::PacketOut packet of length 267 added to cache
    22.135	Called vorbis_analysis_buffer with int vals = 1024
    22.135	Called vorbis_analysis_wrote with vals = 1024
    22.140	called vorbis_analysis_blockout with return of 1
    22.165	called  packet vorbis_bitrate_flushpacket
    22.165	CVorbisEncoder::PacketOut packet of length 262 added to cache
    22.165	called vorbis_analysis_blockout with return of 1
    22.190	called  packet vorbis_bitrate_flushpacket
    22.190	CVorbisEncoder::PacketOut packet of length 275 added to cache
    22.190	called vorbis_analysis_blockout with return of 1
    22.195	called  packet vorbis_bitrate_flushpacket
    22.195	CVorbisEncoder::PacketOut packet of length 70 added to cache
    22.195	called vorbis_analysis_blockout with return of 1
    22.200	called  packet vorbis_bitrate_flushpacket
    22.200	CVorbisEncoder::PacketOut packet of length 54 added to cache
    22.200	called vorbis_analysis_blockout with return of 1
    22.200	called  packet vorbis_bitrate_flushpacket
    22.200	CVorbisEncoder::PacketOut packet of length 66 added to cache
    22.200	called vorbis_analysis_blockout with return of 1
    22.205	called  packet vorbis_bitrate_flushpacket
    22.205	CVorbisEncoder::PacketOut packet of length 64 added to cache
    22.205	called vorbis_analysis_blockout with return of 1
    22.210	called  packet vorbis_bitrate_flushpacket
    22.210	CVorbisEncoder::PacketOut packet of length 66 added to cache
    22.210	called vorbis_analysis_blockout with return of 1
    22.215	called  packet vorbis_bitrate_flushpacket
    22.215	CVorbisEncoder::PacketOut packet of length 64 added to cache
    22.265	Called vorbis_analysis_buffer with int vals = 1024
    22.265	Called vorbis_analysis_wrote with vals = 1024
    22.265	called vorbis_analysis_blockout with return of 1
    22.270	called  packet vorbis_bitrate_flushpacket
    22.270	CVorbisEncoder::PacketOut packet of length 66 added to cache
    22.390	Called vorbis_analysis_buffer with int vals = 1024
    22.390	Called vorbis_analysis_wrote with vals = 1024
    22.395	called vorbis_analysis_blockout with return of 1
    22.420	called  packet vorbis_bitrate_flushpacket
    22.420	CVorbisEncoder::PacketOut packet of length 266 added to cache
    22.520	Called vorbis_analysis_buffer with int vals = 1024
    22.520	Called vorbis_analysis_wrote with vals = 1024
    22.525	called vorbis_analysis_blockout with return of 1
    22.550	called  packet vorbis_bitrate_flushpacket
    22.550	CVorbisEncoder::PacketOut packet of length 271 added to cache
    22.550	called vorbis_analysis_blockout with return of 1
    22.550	called  packet vorbis_bitrate_flushpacket
    22.550	CVorbisEncoder::PacketOut packet of length 59 added to cache
    22.550	called vorbis_analysis_blockout with return of 1
    22.555	called  packet vorbis_bitrate_flushpacket
    22.555	CVorbisEncoder::PacketOut packet of length 66 added to cache
    22.555	called vorbis_analysis_blockout with return of 1
    22.560	called  packet vorbis_bitrate_flushpacket
    22.560	CVorbisEncoder::PacketOut packet of length 60 added to cache
    22.560	called vorbis_analysis_blockout with return of 1
    22.565	called  packet vorbis_bitrate_flushpacket
    22.565	CVorbisEncoder::PacketOut packet of length 52 added to cache
    22.565	called vorbis_analysis_blockout with return of 1
    22.565	called  packet vorbis_bitrate_flushpacket
    22.565	CVorbisEncoder::PacketOut packet of length 69 added to cache
    22.565	called vorbis_analysis_blockout with return of 1
    22.570	called  packet vorbis_bitrate_flushpacket
    22.570	CVorbisEncoder::PacketOut packet of length 70 added to cache
    22.570	called vorbis_analysis_blockout with return of 1
    22.575	called  packet vorbis_bitrate_flushpacket
    22.575	CVorbisEncoder::PacketOut packet of length 57 added to cache
    22.575	called vorbis_analysis_blockout with return of 1
    22.580	called  packet vorbis_bitrate_flushpacket
    22.580	CVorbisEncoder::PacketOut packet of length 78 added to cache
    22.580	called vorbis_analysis_blockout with return of 1
    22.580	called  packet vorbis_bitrate_flushpacket
    22.580	CVorbisEncoder::PacketOut packet of length 63 added to cache
    22.650	Called vorbis_analysis_buffer with int vals = 1024
    22.650	Called vorbis_analysis_wrote with vals = 1024
    22.775	Called vorbis_analysis_buffer with int vals = 1024
    22.775	Called vorbis_analysis_wrote with vals = 1024
    22.780	called vorbis_analysis_blockout with return of 1
    22.785	called  packet vorbis_bitrate_flushpacket
    22.785	CVorbisEncoder::PacketOut packet of length 72 added to cache
    22.905	Called vorbis_analysis_buffer with int vals = 1024
    22.905	Called vorbis_analysis_wrote with vals = 1024
    22.905	called vorbis_analysis_blockout with return of 1
    22.935	called  packet vorbis_bitrate_flushpacket
    22.935	CVorbisEncoder::PacketOut packet of length 282 added to cache
    22.935	called vorbis_analysis_blockout with return of 1
    22.960	called  packet vorbis_bitrate_flushpacket
    22.960	CVorbisEncoder::PacketOut packet of length 268 added to cache
    22.960	PageLength 4365
    22.960	called vorbis_analysis_blockout with return of 1
    22.960	called  packet vorbis_bitrate_flushpacket
    22.960	CVorbisEncoder::PacketOut packet of length 52 added to cache
    22.960	called vorbis_analysis_blockout with return of 1
    22.965	called  packet vorbis_bitrate_flushpacket
    22.965	CVorbisEncoder::PacketOut packet of length 62 added to cache
    22.965	called vorbis_analysis_blockout with return of 1
    22.970	called  packet vorbis_bitrate_flushpacket
    22.970	CVorbisEncoder::PacketOut packet of length 63 added to cache
    22.970	called vorbis_analysis_blockout with return of 1
    22.975	called  packet vorbis_bitrate_flushpacket
    22.975	CVorbisEncoder::PacketOut packet of length 60 added to cache
    22.975	called vorbis_analysis_blockout with return of 1
    22.980	called  packet vorbis_bitrate_flushpacket
    22.980	CVorbisEncoder::PacketOut packet of length 68 added to cache
    22.980	called vorbis_analysis_blockout with return of 1
    22.980	called  packet vorbis_bitrate_flushpacket
    22.980	CVorbisEncoder::PacketOut packet of length 63 added to cache
    23.030	Called vorbis_analysis_buffer with int vals = 1024
    23.035	Called vorbis_analysis_wrote with vals = 1024
    23.160	Called vorbis_analysis_buffer with int vals = 1024
    23.160	Called vorbis_analysis_wrote with vals = 1024
    23.165	called vorbis_analysis_blockout with return of 1
    23.165	called  packet vorbis_bitrate_flushpacket
    23.165	CVorbisEncoder::PacketOut packet of length 62 added to cache
    23.290	Called vorbis_analysis_buffer with int vals = 1024
    23.290	Called vorbis_analysis_wrote with vals = 1024
    23.290	called vorbis_analysis_blockout with return of 1
    23.315	called  packet vorbis_bitrate_flushpacket
    23.315	CVorbisEncoder::PacketOut packet of length 266 added to cache
    23.315	called vorbis_analysis_blockout with return of 1
    23.340	called  packet vorbis_bitrate_flushpacket
    23.340	CVorbisEncoder::PacketOut packet of length 256 added to cache
    23.340	called vorbis_analysis_blockout with return of 1
    23.345	called  packet vorbis_bitrate_flushpacket
    23.345	CVorbisEncoder::PacketOut packet of length 59 added to cache
    23.345	called vorbis_analysis_blockout with return of 1
    23.350	called  packet vorbis_bitrate_flushpacket
    23.350	CVorbisEncoder::PacketOut packet of length 55 added to cache
    23.350	called vorbis_analysis_blockout with return of 1
    23.355	called  packet vorbis_bitrate_flushpacket
    23.355	CVorbisEncoder::PacketOut packet of length 69 added to cache
    23.355	called vorbis_analysis_blockout with return of 1
    23.355	called  packet vorbis_bitrate_flushpacket
    23.360	CVorbisEncoder::PacketOut packet of length 65 added to cache
    23.360	called vorbis_analysis_blockout with return of 1
    23.360	called  packet vorbis_bitrate_flushpacket
    23.360	CVorbisEncoder::PacketOut packet of length 72 added to cache
    23.415	Called vorbis_analysis_buffer with int vals = 1024
    23.415	Called vorbis_analysis_wrote with vals = 1024
    23.420	called vorbis_analysis_blockout with return of 1
    23.420	called  packet vorbis_bitrate_flushpacket
    23.420	CVorbisEncoder::PacketOut packet of length 69 added to cache
    23.420	called vorbis_analysis_blockout with return of 1
    23.425	called  packet vorbis_bitrate_flushpacket
    23.425	CVorbisEncoder::PacketOut packet of length 64 added to cache
    23.425	called vorbis_analysis_blockout with return of 1
    23.430	called  packet vorbis_bitrate_flushpacket
    23.430	CVorbisEncoder::PacketOut packet of length 70 added to cache
    23.430	called vorbis_analysis_blockout with return of 1
    23.435	called  packet vorbis_bitrate_flushpacket
    23.435	CVorbisEncoder::PacketOut packet of length 60 added to cache
    23.435	called vorbis_analysis_blockout with return of 1
    23.440	called  packet vorbis_bitrate_flushpacket
    23.440	CVorbisEncoder::PacketOut packet of length 67 added to cache
    23.440	called vorbis_analysis_blockout with return of 1
    23.440	called  packet vorbis_bitrate_flushpacket
    23.440	CVorbisEncoder::PacketOut packet of length 62 added to cache
    23.440	called vorbis_analysis_blockout with return of 1
    23.445	called  packet vorbis_bitrate_flushpacket
    23.445	CVorbisEncoder::PacketOut packet of length 65 added to cache
    23.445	called vorbis_analysis_blockout with return of 1
    23.450	called  packet vorbis_bitrate_flushpacket
    23.450	CVorbisEncoder::PacketOut packet of length 68 added to cache
    23.545	Called vorbis_analysis_buffer with int vals = 1024
    23.545	Called vorbis_analysis_wrote with vals = 1024
    23.545	called vorbis_analysis_blockout with return of 1
    23.550	called  packet vorbis_bitrate_flushpacket
    23.550	CVorbisEncoder::PacketOut packet of length 70 added to cache
    23.670	Called vorbis_analysis_buffer with int vals = 1024
    23.670	Called vorbis_analysis_wrote with vals = 1024
    23.675	called vorbis_analysis_blockout with return of 1
    23.700	called  packet vorbis_bitrate_flushpacket
    23.700	CVorbisEncoder::PacketOut packet of length 286 added to cache
    23.800	Called vorbis_analysis_buffer with int vals = 1024
    23.800	Called vorbis_analysis_wrote with vals = 1024
    23.805	called vorbis_analysis_blockout with return of 1
    23.830	called  packet vorbis_bitrate_flushpacket
    23.830	CVorbisEncoder::PacketOut packet of length 272 added to cache
    23.830	called vorbis_analysis_blockout with return of 1
    23.830	called  packet vorbis_bitrate_flushpacket
    23.830	CVorbisEncoder::PacketOut packet of length 66 added to cache
    23.830	called vorbis_analysis_blockout with return of 1
    23.835	called  packet vorbis_bitrate_flushpacket
    23.835	CVorbisEncoder::PacketOut packet of length 73 added to cache
    23.835	called vorbis_analysis_blockout with return of 1
    23.840	called  packet vorbis_bitrate_flushpacket
    23.840	CVorbisEncoder::PacketOut packet of length 69 added to cache
    23.840	called vorbis_analysis_blockout with return of 1
    23.845	called  packet vorbis_bitrate_flushpacket
    23.845	CVorbisEncoder::PacketOut packet of length 68 added to cache
    23.845	called vorbis_analysis_blockout with return of 1
    23.850	called  packet vorbis_bitrate_flushpacket
    23.850	CVorbisEncoder::PacketOut packet of length 68 added to cache
    23.930	Called vorbis_analysis_buffer with int vals = 1024
    23.930	Called vorbis_analysis_wrote with vals = 1024
    23.930	called vorbis_analysis_blockout with return of 1
    23.935	called  packet vorbis_bitrate_flushpacket
    23.935	CVorbisEncoder::PacketOut packet of length 57 added to cache
    24.055	Called vorbis_analysis_buffer with int vals = 1024
    24.055	Called vorbis_analysis_wrote with vals = 1024
    24.060	called vorbis_analysis_blockout with return of 1
    24.085	called  packet vorbis_bitrate_flushpacket
    24.085	CVorbisEncoder::PacketOut packet of length 267 added to cache
    24.085	called vorbis_analysis_blockout with return of 1
    24.090	called  packet vorbis_bitrate_flushpacket
    24.090	CVorbisEncoder::PacketOut packet of length 68 added to cache
    24.090	called vorbis_analysis_blockout with return of 1
    24.090	called  packet vorbis_bitrate_flushpacket
    24.090	CVorbisEncoder::PacketOut packet of length 72 added to cache
    24.090	called vorbis_analysis_blockout with return of 1
    24.095	called  packet vorbis_bitrate_flushpacket
    24.095	CVorbisEncoder::PacketOut packet of length 60 added to cache
    24.095	called vorbis_analysis_blockout with return of 1
    24.100	called  packet vorbis_bitrate_flushpacket
    24.100	CVorbisEncoder::PacketOut packet of length 65 added to cache
    24.100	called vorbis_analysis_blockout with return of 1
    24.105	called  packet vorbis_bitrate_flushpacket
    24.105	CVorbisEncoder::PacketOut packet of length 64 added to cache
    24.105	called vorbis_analysis_blockout with return of 1
    24.105	called  packet vorbis_bitrate_flushpacket
    24.105	CVorbisEncoder::PacketOut packet of length 62 added to cache
    24.105	called vorbis_analysis_blockout with return of 1
    24.110	called  packet vorbis_bitrate_flushpacket
    24.110	CVorbisEncoder::PacketOut packet of length 63 added to cache
    24.185	Called vorbis_analysis_buffer with int vals = 1024
    24.185	Called vorbis_analysis_wrote with vals = 1024
    24.185	called vorbis_analysis_blockout with return of 1
    24.190	called  packet vorbis_bitrate_flushpacket
    24.190	CVorbisEncoder::PacketOut packet of length 62 added to cache
    24.190	called vorbis_analysis_blockout with return of 1
    24.215	called  packet vorbis_bitrate_flushpacket
    24.215	CVorbisEncoder::PacketOut packet of length 269 added to cache
    24.215	called vorbis_analysis_blockout with return of 1
    24.220	called  packet vorbis_bitrate_flushpacket
    24.220	CVorbisEncoder::PacketOut packet of length 57 added to cache
    24.220	called vorbis_analysis_blockout with return of 1
    24.225	called  packet vorbis_bitrate_flushpacket
    24.225	CVorbisEncoder::PacketOut packet of length 68 added to cache
    24.225	called vorbis_analysis_blockout with return of 1
    24.225	called  packet vorbis_bitrate_flushpacket
    24.225	CVorbisEncoder::PacketOut packet of length 67 added to cache
    24.225	called vorbis_analysis_blockout with return of 1
    24.230	called  packet vorbis_bitrate_flushpacket
    24.230	CVorbisEncoder::PacketOut packet of length 66 added to cache
    24.230	PageLength 4228
    24.310	Called vorbis_analysis_buffer with int vals = 1024
    24.310	Called vorbis_analysis_wrote with vals = 1024
    24.440	Called vorbis_analysis_buffer with int vals = 1024
    24.440	Called vorbis_analysis_wrote with vals = 1024
    24.445	called vorbis_analysis_blockout with return of 1
    24.445	called  packet vorbis_bitrate_flushpacket
    24.445	CVorbisEncoder::PacketOut packet of length 69 added to cache
    24.445	called vorbis_analysis_blockout with return of 1
    24.470	called  packet vorbis_bitrate_flushpacket
    24.470	CVorbisEncoder::PacketOut packet of length 266 added to cache
    24.475	called vorbis_analysis_blockout with return of 1
    24.475	called  packet vorbis_bitrate_flushpacket
    24.475	CVorbisEncoder::PacketOut packet of length 59 added to cache
    24.475	called vorbis_analysis_blockout with return of 1
    24.480	called  packet vorbis_bitrate_flushpacket
    24.480	CVorbisEncoder::PacketOut packet of length 64 added to cache
    24.480	called vorbis_analysis_blockout with return of 1
    24.485	called  packet vorbis_bitrate_flushpacket
    24.485	CVorbisEncoder::PacketOut packet of length 67 added to cache
    24.485	called vorbis_analysis_blockout with return of 1
    24.490	called  packet vorbis_bitrate_flushpacket
    24.490	CVorbisEncoder::PacketOut packet of length 74 added to cache
    24.490	called vorbis_analysis_blockout with return of 1
    24.490	called  packet vorbis_bitrate_flushpacket
    24.490	CVorbisEncoder::PacketOut packet of length 67 added to cache
    24.490	called vorbis_analysis_blockout with return of 1
    24.495	called  packet vorbis_bitrate_flushpacket
    24.495	CVorbisEncoder::PacketOut packet of length 65 added to cache
    24.495	called vorbis_analysis_blockout with return of 1
    24.500	called  packet vorbis_bitrate_flushpacket
    24.500	CVorbisEncoder::PacketOut packet of length 58 added to cache
    24.570	Called vorbis_analysis_buffer with int vals = 1024
    24.570	Called vorbis_analysis_wrote with vals = 1024
    24.695	Called vorbis_analysis_buffer with int vals = 1024
    24.695	Called vorbis_analysis_wrote with vals = 1024
    24.700	called vorbis_analysis_blockout with return of 1
    24.705	called  packet vorbis_bitrate_flushpacket
    24.705	CVorbisEncoder::PacketOut packet of length 58 added to cache
    24.705	called vorbis_analysis_blockout with return of 1
    24.735	called  packet vorbis_bitrate_flushpacket
    24.735	CVorbisEncoder::PacketOut packet of length 261 added to cache
    24.735	called vorbis_analysis_blockout with return of 1
    24.735	called  packet vorbis_bitrate_flushpacket
    24.735	CVorbisEncoder::PacketOut packet of length 67 added to cache
    24.735	called vorbis_analysis_blockout with return of 1
    24.740	called  packet vorbis_bitrate_flushpacket
    24.740	CVorbisEncoder::PacketOut packet of length 65 added to cache
    24.740	called vorbis_analysis_blockout with return of 1
    24.745	called  packet vorbis_bitrate_flushpacket
    24.745	CVorbisEncoder::PacketOut packet of length 53 added to cache
    24.745	called vorbis_analysis_blockout with return of 1
    24.750	called  packet vorbis_bitrate_flushpacket
    24.750	CVorbisEncoder::PacketOut packet of length 63 added to cache
    24.750	called vorbis_analysis_blockout with return of 1
    24.750	called  packet vorbis_bitrate_flushpacket
    24.750	CVorbisEncoder::PacketOut packet of length 72 added to cache
    24.750	called vorbis_analysis_blockout with return of 1
    24.755	called  packet vorbis_bitrate_flushpacket
    24.755	CVorbisEncoder::PacketOut packet of length 65 added to cache
    24.825	Called vorbis_analysis_buffer with int vals = 1024
    24.825	Called vorbis_analysis_wrote with vals = 1024
    24.950	Called vorbis_analysis_buffer with int vals = 1024
    24.955	Called vorbis_analysis_wrote with vals = 1024
    24.955	called vorbis_analysis_blockout with return of 1
    24.960	called  packet vorbis_bitrate_flushpacket
    24.960	CVorbisEncoder::PacketOut packet of length 64 added to cache
    24.960	called vorbis_analysis_blockout with return of 1
    24.985	called  packet vorbis_bitrate_flushpacket
    24.985	CVorbisEncoder::PacketOut packet of length 280 added to cache
    24.985	called vorbis_analysis_blockout with return of 1
    24.990	called  packet vorbis_bitrate_flushpacket
    24.990	CVorbisEncoder::PacketOut packet of length 56 added to cache
    24.990	called vorbis_analysis_blockout with return of 1
    24.995	called  packet vorbis_bitrate_flushpacket
    24.995	CVorbisEncoder::PacketOut packet of length 62 added to cache
    25.080	Called vorbis_analysis_buffer with int vals = 1024
    25.080	Called vorbis_analysis_wrote with vals = 1024
    25.080	called vorbis_analysis_blockout with return of 1
    25.085	called  packet vorbis_bitrate_flushpacket
    25.085	CVorbisEncoder::PacketOut packet of length 63 added to cache
    25.210	Called vorbis_analysis_buffer with int vals = 1024
    25.210	Called vorbis_analysis_wrote with vals = 1024
    25.210	called vorbis_analysis_blockout with return of 1
    25.240	called  packet vorbis_bitrate_flushpacket
    25.240	CVorbisEncoder::PacketOut packet of length 280 added to cache
    25.335	Called vorbis_analysis_buffer with int vals = 1024
    25.335	Called vorbis_analysis_wrote with vals = 1024
    25.340	called vorbis_analysis_blockout with return of 1
    25.365	called  packet vorbis_bitrate_flushpacket
    25.365	CVorbisEncoder::PacketOut packet of length 291 added to cache
    25.365	called vorbis_analysis_blockout with return of 1
    25.370	called  packet vorbis_bitrate_flushpacket
    25.370	CVorbisEncoder::PacketOut packet of length 63 added to cache
    25.370	called vorbis_analysis_blockout with return of 1
    25.375	called  packet vorbis_bitrate_flushpacket
    25.375	CVorbisEncoder::PacketOut packet of length 55 added to cache
    25.375	called vorbis_analysis_blockout with return of 1
    25.375	called  packet vorbis_bitrate_flushpacket
    25.375	CVorbisEncoder::PacketOut packet of length 58 added to cache
    25.375	called vorbis_analysis_blockout with return of 1
    25.380	called  packet vorbis_bitrate_flushpacket
    25.380	CVorbisEncoder::PacketOut packet of length 71 added to cache
    25.380	called vorbis_analysis_blockout with return of 1
    25.385	called  packet vorbis_bitrate_flushpacket
    25.385	CVorbisEncoder::PacketOut packet of length 69 added to cache
    25.385	called vorbis_analysis_blockout with return of 1
    25.390	called  packet vorbis_bitrate_flushpacket
    25.390	CVorbisEncoder::PacketOut packet of length 74 added to cache
    25.390	called vorbis_analysis_blockout with return of 1
    25.390	called  packet vorbis_bitrate_flushpacket
    25.390	CVorbisEncoder::PacketOut packet of length 67 added to cache
    25.390	called vorbis_analysis_blockout with return of 1
    25.395	called  packet vorbis_bitrate_flushpacket
    25.395	CVorbisEncoder::PacketOut packet of length 65 added to cache
    25.395	called vorbis_analysis_blockout with return of 1
    25.400	called  packet vorbis_bitrate_flushpacket
    25.400	CVorbisEncoder::PacketOut packet of length 59 added to cache
    25.400	called vorbis_analysis_blockout with return of 1
    25.405	called  packet vorbis_bitrate_flushpacket
    25.405	CVorbisEncoder::PacketOut packet of length 64 added to cache
    25.465	Called vorbis_analysis_buffer with int vals = 1024
    25.465	Called vorbis_analysis_wrote with vals = 1024
    25.465	called vorbis_analysis_blockout with return of 1
    25.470	called  packet vorbis_bitrate_flushpacket
    25.470	CVorbisEncoder::PacketOut packet of length 61 added to cache
    25.470	called vorbis_analysis_blockout with return of 1
    25.495	called  packet vorbis_bitrate_flushpacket
    25.495	CVorbisEncoder::PacketOut packet of length 267 added to cache
    25.495	called vorbis_analysis_blockout with return of 1
    25.500	called  packet vorbis_bitrate_flushpacket
    25.500	CVorbisEncoder::PacketOut packet of length 53 added to cache
    25.500	called vorbis_analysis_blockout with return of 1
    25.505	called  packet vorbis_bitrate_flushpacket
    25.505	CVorbisEncoder::PacketOut packet of length 63 added to cache
    25.590	Called vorbis_analysis_buffer with int vals = 1024
    25.590	Called vorbis_analysis_wrote with vals = 1024
    25.595	called vorbis_analysis_blockout with return of 1
    25.600	called  packet vorbis_bitrate_flushpacket
    25.600	CVorbisEncoder::PacketOut packet of length 66 added to cache
    25.720	Called vorbis_analysis_buffer with int vals = 1024
    25.720	Called vorbis_analysis_wrote with vals = 1024
    25.725	called vorbis_analysis_blockout with return of 1
    25.725	called  packet vorbis_bitrate_flushpacket
    25.725	CVorbisEncoder::PacketOut packet of length 58 added to cache
    25.725	called vorbis_analysis_blockout with return of 1
    25.730	called  packet vorbis_bitrate_flushpacket
    25.730	CVorbisEncoder::PacketOut packet of length 66 added to cache
    25.730	called vorbis_analysis_blockout with return of 1
    25.735	called  packet vorbis_bitrate_flushpacket
    25.735	CVorbisEncoder::PacketOut packet of length 56 added to cache
    25.735	called vorbis_analysis_blockout with return of 1
    25.740	called  packet vorbis_bitrate_flushpacket
    25.740	CVorbisEncoder::PacketOut packet of length 57 added to cache
    25.740	called vorbis_analysis_blockout with return of 1
    25.740	called  packet vorbis_bitrate_flushpacket
    25.740	CVorbisEncoder::PacketOut packet of length 60 added to cache
    25.740	called vorbis_analysis_blockout with return of 1
    25.745	called  packet vorbis_bitrate_flushpacket
    25.745	CVorbisEncoder::PacketOut packet of length 67 added to cache
    25.745	PageLength 4186
    25.745	called vorbis_analysis_blockout with return of 1
    25.750	called  packet vorbis_bitrate_flushpacket
    25.750	CVorbisEncoder::PacketOut packet of length 50 added to cache
    25.750	called vorbis_analysis_blockout with return of 1
    25.755	called  packet vorbis_bitrate_flushpacket
    25.755	CVorbisEncoder::PacketOut packet of length 68 added to cache
    25.755	called vorbis_analysis_blockout with return of 1
    25.755	called  packet vorbis_bitrate_flushpacket
    25.755	CVorbisEncoder::PacketOut packet of length 67 added to cache
    25.850	Called vorbis_analysis_buffer with int vals = 1024
    25.850	Called vorbis_analysis_wrote with vals = 1024
    25.850	called vorbis_analysis_blockout with return of 1
    25.855	called  packet vorbis_bitrate_flushpacket
    25.855	CVorbisEncoder::PacketOut packet of length 69 added to cache
    25.855	called vorbis_analysis_blockout with return of 1
    25.860	called  packet vorbis_bitrate_flushpacket
    25.860	CVorbisEncoder::PacketOut packet of length 51 added to cache
    25.860	called vorbis_analysis_blockout with return of 1
    25.860	called  packet vorbis_bitrate_flushpacket
    25.860	CVorbisEncoder::PacketOut packet of length 57 added to cache
    25.860	called vorbis_analysis_blockout with return of 1
    25.865	called  packet vorbis_bitrate_flushpacket
    25.865	CVorbisEncoder::PacketOut packet of length 48 added to cache
    25.865	called vorbis_analysis_blockout with return of 1
    25.870	called  packet vorbis_bitrate_flushpacket
    25.870	CVorbisEncoder::PacketOut packet of length 55 added to cache
    25.870	called vorbis_analysis_blockout with return of 1
    25.875	called  packet vorbis_bitrate_flushpacket
    25.875	CVorbisEncoder::PacketOut packet of length 52 added to cache
    25.875	called vorbis_analysis_blockout with return of 1
    25.875	called  packet vorbis_bitrate_flushpacket
    25.875	CVorbisEncoder::PacketOut packet of length 46 added to cache
    25.875	called vorbis_analysis_blockout with return of 1
    25.880	called  packet vorbis_bitrate_flushpacket
    25.880	CVorbisEncoder::PacketOut packet of length 64 added to cache
    25.880	called vorbis_analysis_blockout with return of 1
    25.885	called  packet vorbis_bitrate_flushpacket
    25.885	CVorbisEncoder::PacketOut packet of length 85 added to cache
    25.975	Called vorbis_analysis_buffer with int vals = 1024
    25.975	Called vorbis_analysis_wrote with vals = 1024
    25.980	called vorbis_analysis_blockout with return of 1
    25.985	called  packet vorbis_bitrate_flushpacket
    25.985	CVorbisEncoder::PacketOut packet of length 69 added to cache
    25.985	called vorbis_analysis_blockout with return of 1
    26.010	called  packet vorbis_bitrate_flushpacket
    26.010	CVorbisEncoder::PacketOut packet of length 278 added to cache
    26.010	called vorbis_analysis_blockout with return of 1
    26.015	called  packet vorbis_bitrate_flushpacket
    26.015	CVorbisEncoder::PacketOut packet of length 56 added to cache
    26.015	called vorbis_analysis_blockout with return of 1
    26.020	called  packet vorbis_bitrate_flushpacket
    26.020	CVorbisEncoder::PacketOut packet of length 66 added to cache
    26.020	called vorbis_analysis_blockout with return of 1
    26.025	called  packet vorbis_bitrate_flushpacket
    26.025	CVorbisEncoder::PacketOut packet of length 64 added to cache
    26.105	Called vorbis_analysis_buffer with int vals = 1024
    26.105	Called vorbis_analysis_wrote with vals = 1024
    26.230	Called vorbis_analysis_buffer with int vals = 1024
    26.235	Called vorbis_analysis_wrote with vals = 1024
    26.235	called vorbis_analysis_blockout with return of 1
    26.240	called  packet vorbis_bitrate_flushpacket
    26.240	CVorbisEncoder::PacketOut packet of length 54 added to cache
    26.240	called vorbis_analysis_blockout with return of 1
    26.265	called  packet vorbis_bitrate_flushpacket
    26.265	CVorbisEncoder::PacketOut packet of length 261 added to cache
    26.265	called vorbis_analysis_blockout with return of 1
    26.270	called  packet vorbis_bitrate_flushpacket
    26.270	CVorbisEncoder::PacketOut packet of length 60 added to cache
    26.270	called vorbis_analysis_blockout with return of 1
    26.270	called  packet vorbis_bitrate_flushpacket
    26.270	CVorbisEncoder::PacketOut packet of length 45 added to cache
    26.270	called vorbis_analysis_blockout with return of 1
    26.275	called  packet vorbis_bitrate_flushpacket
    26.275	CVorbisEncoder::PacketOut packet of length 73 added to cache
    26.275	called vorbis_analysis_blockout with return of 1
    26.280	called  packet vorbis_bitrate_flushpacket
    26.280	CVorbisEncoder::PacketOut packet of length 59 added to cache
    26.280	called vorbis_analysis_blockout with return of 1
    26.285	called  packet vorbis_bitrate_flushpacket
    26.285	CVorbisEncoder::PacketOut packet of length 62 added to cache
    26.360	Called vorbis_analysis_buffer with int vals = 1024
    26.360	Called vorbis_analysis_wrote with vals = 1024
    26.365	called vorbis_analysis_blockout with return of 1
    26.365	called  packet vorbis_bitrate_flushpacket
    26.365	CVorbisEncoder::PacketOut packet of length 70 added to cache
    26.365	called vorbis_analysis_blockout with return of 1
    26.370	called  packet vorbis_bitrate_flushpacket
    26.370	CVorbisEncoder::PacketOut packet of length 68 added to cache
    26.370	called vorbis_analysis_blockout with return of 1
    26.375	called  packet vorbis_bitrate_flushpacket
    26.375	CVorbisEncoder::PacketOut packet of length 58 added to cache
    26.375	called vorbis_analysis_blockout with return of 1
    26.380	called  packet vorbis_bitrate_flushpacket
    26.380	CVorbisEncoder::PacketOut packet of length 51 added to cache
    26.380	called vorbis_analysis_blockout with return of 1
    26.380	called  packet vorbis_bitrate_flushpacket
    26.380	CVorbisEncoder::PacketOut packet of length 68 added to cache
    26.380	called vorbis_analysis_blockout with return of 1
    26.385	called  packet vorbis_bitrate_flushpacket
    26.385	CVorbisEncoder::PacketOut packet of length 64 added to cache
    26.385	called vorbis_analysis_blockout with return of 1
    26.390	called  packet vorbis_bitrate_flushpacket
    26.390	CVorbisEncoder::PacketOut packet of length 63 added to cache
    26.390	called vorbis_analysis_blockout with return of 1
    26.395	called  packet vorbis_bitrate_flushpacket
    26.395	CVorbisEncoder::PacketOut packet of length 71 added to cache
    26.395	called vorbis_analysis_blockout with return of 1
    26.400	called  packet vorbis_bitrate_flushpacket
    26.400	CVorbisEncoder::PacketOut packet of length 72 added to cache
    26.490	Called vorbis_analysis_buffer with int vals = 1024
    26.490	Called vorbis_analysis_wrote with vals = 1024
    26.490	called vorbis_analysis_blockout with return of 1
    26.495	called  packet vorbis_bitrate_flushpacket
    26.495	CVorbisEncoder::PacketOut packet of length 67 added to cache
    26.615	Called vorbis_analysis_buffer with int vals = 1024
    26.615	Called vorbis_analysis_wrote with vals = 1024
    26.620	called vorbis_analysis_blockout with return of 1
    26.645	called  packet vorbis_bitrate_flushpacket
    26.645	CVorbisEncoder::PacketOut packet of length 264 added to cache
    26.745	Called vorbis_analysis_buffer with int vals = 1024
    26.745	Called vorbis_analysis_wrote with vals = 1024
    26.745	called vorbis_analysis_blockout with return of 1
    26.775	called  packet vorbis_bitrate_flushpacket
    26.775	CVorbisEncoder::PacketOut packet of length 267 added to cache
    26.870	Called vorbis_analysis_buffer with int vals = 1024
    26.875	Called vorbis_analysis_wrote with vals = 1024
    26.875	called vorbis_analysis_blockout with return of 1
    26.900	called  packet vorbis_bitrate_flushpacket
    26.900	CVorbisEncoder::PacketOut packet of length 275 added to cache
    26.900	called vorbis_analysis_blockout with return of 1
    26.905	called  packet vorbis_bitrate_flushpacket
    26.905	CVorbisEncoder::PacketOut packet of length 56 added to cache
    26.905	called vorbis_analysis_blockout with return of 1
    26.910	called  packet vorbis_bitrate_flushpacket
    26.910	CVorbisEncoder::PacketOut packet of length 60 added to cache
    26.910	called vorbis_analysis_blockout with return of 1
    26.915	called  packet vorbis_bitrate_flushpacket
    26.915	CVorbisEncoder::PacketOut packet of length 60 added to cache
    26.915	called vorbis_analysis_blockout with return of 1
    26.915	called  packet vorbis_bitrate_flushpacket
    26.915	CVorbisEncoder::PacketOut packet of length 70 added to cache
    26.915	called vorbis_analysis_blockout with return of 1
    26.920	called  packet vorbis_bitrate_flushpacket
    26.920	CVorbisEncoder::PacketOut packet of length 58 added to cache
    27.000	Called vorbis_analysis_buffer with int vals = 1024
    27.000	Called vorbis_analysis_wrote with vals = 1024
    27.000	called vorbis_analysis_blockout with return of 1
    27.005	called  packet vorbis_bitrate_flushpacket
    27.005	CVorbisEncoder::PacketOut packet of length 65 added to cache
    27.005	called vorbis_analysis_blockout with return of 1
    27.035	called  packet vorbis_bitrate_flushpacket
    27.035	CVorbisEncoder::PacketOut packet of length 267 added to cache
    27.035	called vorbis_analysis_blockout with return of 1
    27.035	called  packet vorbis_bitrate_flushpacket
    27.035	CVorbisEncoder::PacketOut packet of length 68 added to cache
    27.035	called vorbis_analysis_blockout with return of 1
    27.040	called  packet vorbis_bitrate_flushpacket
    27.040	CVorbisEncoder::PacketOut packet of length 81 added to cache
    27.040	PageLength 4181
    27.040	called vorbis_analysis_blockout with return of 1
    27.045	called  packet vorbis_bitrate_flushpacket
    27.045	CVorbisEncoder::PacketOut packet of length 53 added to cache
    27.130	Called vorbis_analysis_buffer with int vals = 1024
    27.130	Called vorbis_analysis_wrote with vals = 1024
    27.130	called vorbis_analysis_blockout with return of 1
    27.135	called  packet vorbis_bitrate_flushpacket
    27.135	CVorbisEncoder::PacketOut packet of length 67 added to cache
    27.255	Called vorbis_analysis_buffer with int vals = 1024
    27.255	Called vorbis_analysis_wrote with vals = 1024
    27.260	called vorbis_analysis_blockout with return of 1
    27.265	called  packet vorbis_bitrate_flushpacket
    27.265	CVorbisEncoder::PacketOut packet of length 63 added to cache
    27.385	Called vorbis_analysis_buffer with int vals = 1024
    27.385	Called vorbis_analysis_wrote with vals = 1024
    27.385	called vorbis_analysis_blockout with return of 1
    27.415	called  packet vorbis_bitrate_flushpacket
    27.415	CVorbisEncoder::PacketOut packet of length 266 added to cache
    27.510	Called vorbis_analysis_buffer with int vals = 1024
    27.510	Called vorbis_analysis_wrote with vals = 1024
    27.515	called vorbis_analysis_blockout with return of 1
    27.540	called  packet vorbis_bitrate_flushpacket
    27.540	CVorbisEncoder::PacketOut packet of length 262 added to cache
    27.540	called vorbis_analysis_blockout with return of 1
    27.565	called  packet vorbis_bitrate_flushpacket
    27.565	CVorbisEncoder::PacketOut packet of length 275 added to cache
    27.565	called vorbis_analysis_blockout with return of 1
    27.570	called  packet vorbis_bitrate_flushpacket
    27.570	CVorbisEncoder::PacketOut packet of length 82 added to cache
    27.570	called vorbis_analysis_blockout with return of 1
    27.575	called  packet vorbis_bitrate_flushpacket
    27.575	CVorbisEncoder::PacketOut packet of length 59 added to cache
    27.640	Called vorbis_analysis_buffer with int vals = 1024
    27.640	Called vorbis_analysis_wrote with vals = 1024
    27.645	called vorbis_analysis_blockout with return of 1
    27.645	called  packet vorbis_bitrate_flushpacket
    27.645	CVorbisEncoder::PacketOut packet of length 63 added to cache
    27.645	called vorbis_analysis_blockout with return of 1
    27.675	called  packet vorbis_bitrate_flushpacket
    27.675	CVorbisEncoder::PacketOut packet of length 285 added to cache
    27.675	called vorbis_analysis_blockout with return of 1
    27.675	called  packet vorbis_bitrate_flushpacket
    27.675	CVorbisEncoder::PacketOut packet of length 60 added to cache
    27.675	called vorbis_analysis_blockout with return of 1
    27.680	called  packet vorbis_bitrate_flushpacket
    27.680	CVorbisEncoder::PacketOut packet of length 60 added to cache
    27.680	called vorbis_analysis_blockout with return of 1
    27.685	called  packet vorbis_bitrate_flushpacket
    27.685	CVorbisEncoder::PacketOut packet of length 66 added to cache
    27.770	Called vorbis_analysis_buffer with int vals = 1024
    27.770	Called vorbis_analysis_wrote with vals = 1024
    27.770	called vorbis_analysis_blockout with return of 1
    27.775	called  packet vorbis_bitrate_flushpacket
    27.775	CVorbisEncoder::PacketOut packet of length 64 added to cache
    27.775	called vorbis_analysis_blockout with return of 1
    27.780	called  packet vorbis_bitrate_flushpacket
    27.780	CVorbisEncoder::PacketOut packet of length 66 added to cache
    27.895	Called vorbis_analysis_buffer with int vals = 1024
    27.895	Called vorbis_analysis_wrote with vals = 1024
    27.900	called vorbis_analysis_blockout with return of 1
    27.905	called  packet vorbis_bitrate_flushpacket
    27.905	CVorbisEncoder::PacketOut packet of length 61 added to cache
    28.025	Called vorbis_analysis_buffer with int vals = 1024
    28.025	Called vorbis_analysis_wrote with vals = 1024
    28.025	called vorbis_analysis_blockout with return of 1
    28.050	called  packet vorbis_bitrate_flushpacket
    28.050	CVorbisEncoder::PacketOut packet of length 270 added to cache
    28.050	called vorbis_analysis_blockout with return of 1
    28.055	called  packet vorbis_bitrate_flushpacket
    28.055	CVorbisEncoder::PacketOut packet of length 61 added to cache
    28.055	called vorbis_analysis_blockout with return of 1
    28.060	called  packet vorbis_bitrate_flushpacket
    28.060	CVorbisEncoder::PacketOut packet of length 56 added to cache
    28.060	called vorbis_analysis_blockout with return of 1
    28.065	called  packet vorbis_bitrate_flushpacket
    28.065	CVorbisEncoder::PacketOut packet of length 61 added to cache
    28.065	called vorbis_analysis_blockout with return of 1
    28.065	called  packet vorbis_bitrate_flushpacket
    28.065	CVorbisEncoder::PacketOut packet of length 58 added to cache
    28.065	called vorbis_analysis_blockout with return of 1
    28.070	called  packet vorbis_bitrate_flushpacket
    28.070	CVorbisEncoder::PacketOut packet of length 64 added to cache
    28.070	called vorbis_analysis_blockout with return of 1
    28.075	called  packet vorbis_bitrate_flushpacket
    28.075	CVorbisEncoder::PacketOut packet of length 62 added to cache
    28.075	called vorbis_analysis_blockout with return of 1
    28.080	called  packet vorbis_bitrate_flushpacket
    28.080	CVorbisEncoder::PacketOut packet of length 51 added to cache
    28.080	called vorbis_analysis_blockout with return of 1
    28.080	called  packet vorbis_bitrate_flushpacket
    28.080	CVorbisEncoder::PacketOut packet of length 71 added to cache
    28.150	Called vorbis_analysis_buffer with int vals = 1024
    28.155	Called vorbis_analysis_wrote with vals = 1024
    28.155	called vorbis_analysis_blockout with return of 1
    28.160	called  packet vorbis_bitrate_flushpacket
    28.160	CVorbisEncoder::PacketOut packet of length 69 added to cache
    28.160	called vorbis_analysis_blockout with return of 1
    28.185	called  packet vorbis_bitrate_flushpacket
    28.185	CVorbisEncoder::PacketOut packet of length 269 added to cache
    28.185	called vorbis_analysis_blockout with return of 1
    28.190	called  packet vorbis_bitrate_flushpacket
    28.190	CVorbisEncoder::PacketOut packet of length 80 added to cache
    28.190	called vorbis_analysis_blockout with return of 1
    28.195	called  packet vorbis_bitrate_flushpacket
    28.195	CVorbisEncoder::PacketOut packet of length 56 added to cache
    28.280	Called vorbis_analysis_buffer with int vals = 1024
    28.280	Called vorbis_analysis_wrote with vals = 1024
    28.285	called vorbis_analysis_blockout with return of 1
    28.285	called  packet vorbis_bitrate_flushpacket
    28.285	CVorbisEncoder::PacketOut packet of length 52 added to cache
    28.410	Called vorbis_analysis_buffer with int vals = 1024
    28.410	Called vorbis_analysis_wrote with vals = 1024
    28.410	called vorbis_analysis_blockout with return of 1
    28.435	called  packet vorbis_bitrate_flushpacket
    28.435	CVorbisEncoder::PacketOut packet of length 267 added to cache
    28.435	called vorbis_analysis_blockout with return of 1
    28.440	called  packet vorbis_bitrate_flushpacket
    28.440	CVorbisEncoder::PacketOut packet of length 56 added to cache
    28.440	called vorbis_analysis_blockout with return of 1
    28.445	called  packet vorbis_bitrate_flushpacket
    28.445	CVorbisEncoder::PacketOut packet of length 63 added to cache
    28.445	called vorbis_analysis_blockout with return of 1
    28.450	called  packet vorbis_bitrate_flushpacket
    28.450	CVorbisEncoder::PacketOut packet of length 61 added to cache
    28.450	called vorbis_analysis_blockout with return of 1
    28.455	called  packet vorbis_bitrate_flushpacket
    28.455	CVorbisEncoder::PacketOut packet of length 59 added to cache
    28.455	called vorbis_analysis_blockout with return of 1
    28.455	called  packet vorbis_bitrate_flushpacket
    28.455	CVorbisEncoder::PacketOut packet of length 63 added to cache
    28.455	called vorbis_analysis_blockout with return of 1
    28.460	called  packet vorbis_bitrate_flushpacket
    28.460	CVorbisEncoder::PacketOut packet of length 66 added to cache
    28.460	called vorbis_analysis_blockout with return of 1
    28.465	called  packet vorbis_bitrate_flushpacket
    28.465	CVorbisEncoder::PacketOut packet of length 59 added to cache
    28.465	called vorbis_analysis_blockout with return of 1
    28.465	called  packet vorbis_bitrate_flushpacket
    28.465	CVorbisEncoder::PacketOut packet of length 61 added to cache
    28.465	called vorbis_analysis_blockout with return of 1
    28.470	called  packet vorbis_bitrate_flushpacket
    28.470	CVorbisEncoder::PacketOut packet of length 71 added to cache
    28.535	Called vorbis_analysis_buffer with int vals = 1024
    28.535	Called vorbis_analysis_wrote with vals = 1024
    28.540	called vorbis_analysis_blockout with return of 1
    28.540	called  packet vorbis_bitrate_flushpacket
    28.540	CVorbisEncoder::PacketOut packet of length 62 added to cache
    28.540	called vorbis_analysis_blockout with return of 1
    28.545	called  packet vorbis_bitrate_flushpacket
    28.545	CVorbisEncoder::PacketOut packet of length 61 added to cache
    28.545	called vorbis_analysis_blockout with return of 1
    28.550	called  packet vorbis_bitrate_flushpacket
    28.550	CVorbisEncoder::PacketOut packet of length 68 added to cache
    28.550	PageLength 4226
    28.550	called vorbis_analysis_blockout with return of 1
    28.555	called  packet vorbis_bitrate_flushpacket
    28.555	CVorbisEncoder::PacketOut packet of length 62 added to cache
    28.555	called vorbis_analysis_blockout with return of 1
    28.560	called  packet vorbis_bitrate_flushpacket
    28.560	CVorbisEncoder::PacketOut packet of length 64 added to cache
    28.560	called vorbis_analysis_blockout with return of 1
    28.560	called  packet vorbis_bitrate_flushpacket
    28.560	CVorbisEncoder::PacketOut packet of length 59 added to cache
    28.560	called vorbis_analysis_blockout with return of 1
    28.565	called  packet vorbis_bitrate_flushpacket
    28.565	CVorbisEncoder::PacketOut packet of length 67 added to cache
    28.565	called vorbis_analysis_blockout with return of 1
    28.570	called  packet vorbis_bitrate_flushpacket
    28.570	CVorbisEncoder::PacketOut packet of length 73 added to cache
    28.665	Called vorbis_analysis_buffer with int vals = 1024
    28.665	Called vorbis_analysis_wrote with vals = 1024
    28.790	Called vorbis_analysis_buffer with int vals = 1024
    28.790	Called vorbis_analysis_wrote with vals = 1024
    28.795	called vorbis_analysis_blockout with return of 1
    28.800	called  packet vorbis_bitrate_flushpacket
    28.800	CVorbisEncoder::PacketOut packet of length 62 added to cache
    28.800	called vorbis_analysis_blockout with return of 1
    28.825	called  packet vorbis_bitrate_flushpacket
    28.825	CVorbisEncoder::PacketOut packet of length 269 added to cache
    28.825	called vorbis_analysis_blockout with return of 1
    28.830	called  packet vorbis_bitrate_flushpacket
    28.830	CVorbisEncoder::PacketOut packet of length 65 added to cache
    28.830	called vorbis_analysis_blockout with return of 1
    28.830	called  packet vorbis_bitrate_flushpacket
    28.830	CVorbisEncoder::PacketOut packet of length 72 added to cache
    28.920	Called vorbis_analysis_buffer with int vals = 1024
    28.920	Called vorbis_analysis_wrote with vals = 1024
    28.920	called vorbis_analysis_blockout with return of 1
    28.925	called  packet vorbis_bitrate_flushpacket
    28.925	CVorbisEncoder::PacketOut packet of length 66 added to cache
    29.050	Called vorbis_analysis_buffer with int vals = 1024
    29.050	Called vorbis_analysis_wrote with vals = 1024
    29.050	called vorbis_analysis_blockout with return of 1
    29.080	called  packet vorbis_bitrate_flushpacket
    29.080	CVorbisEncoder::PacketOut packet of length 275 added to cache
    29.175	Called vorbis_analysis_buffer with int vals = 1024
    29.175	Called vorbis_analysis_wrote with vals = 1024
    29.180	called vorbis_analysis_blockout with return of 1
    29.205	called  packet vorbis_bitrate_flushpacket
    29.205	CVorbisEncoder::PacketOut packet of length 256 added to cache
    29.205	called vorbis_analysis_blockout with return of 1
    29.230	called  packet vorbis_bitrate_flushpacket
    29.230	CVorbisEncoder::PacketOut packet of length 273 added to cache
    29.230	called vorbis_analysis_blockout with return of 1
    29.235	called  packet vorbis_bitrate_flushpacket
    29.235	CVorbisEncoder::PacketOut packet of length 57 added to cache
    29.235	called vorbis_analysis_blockout with return of 1
    29.240	called  packet vorbis_bitrate_flushpacket
    29.240	CVorbisEncoder::PacketOut packet of length 69 added to cache
    29.240	called vorbis_analysis_blockout with return of 1
    29.245	called  packet vorbis_bitrate_flushpacket
    29.245	CVorbisEncoder::PacketOut packet of length 66 added to cache
    29.245	called vorbis_analysis_blockout with return of 1
    29.250	called  packet vorbis_bitrate_flushpacket
    29.250	CVorbisEncoder::PacketOut packet of length 68 added to cache
    29.305	Called vorbis_analysis_buffer with int vals = 1024
    29.305	Called vorbis_analysis_wrote with vals = 1024
    29.305	called vorbis_analysis_blockout with return of 1
    29.310	called  packet vorbis_bitrate_flushpacket
    29.310	CVorbisEncoder::PacketOut packet of length 64 added to cache
    29.430	Called vorbis_analysis_buffer with int vals = 1024
    29.430	Called vorbis_analysis_wrote with vals = 1024
    29.435	called vorbis_analysis_blockout with return of 1
    29.440	called  packet vorbis_bitrate_flushpacket
    29.440	CVorbisEncoder::PacketOut packet of length 64 added to cache
    29.440	called vorbis_analysis_blockout with return of 1
    29.465	called  packet vorbis_bitrate_flushpacket
    29.465	CVorbisEncoder::PacketOut packet of length 270 added to cache
    29.465	called vorbis_analysis_blockout with return of 1
    29.470	called  packet vorbis_bitrate_flushpacket
    29.470	CVorbisEncoder::PacketOut packet of length 67 added to cache
    29.470	called vorbis_analysis_blockout with return of 1
    29.470	called  packet vorbis_bitrate_flushpacket
    29.470	CVorbisEncoder::PacketOut packet of length 61 added to cache
    29.470	called vorbis_analysis_blockout with return of 1
    29.475	called  packet vorbis_bitrate_flushpacket
    29.475	CVorbisEncoder::PacketOut packet of length 66 added to cache
    29.475	called vorbis_analysis_blockout with return of 1
    29.480	called  packet vorbis_bitrate_flushpacket
    29.480	CVorbisEncoder::PacketOut packet of length 65 added to cache
    29.480	called vorbis_analysis_blockout with return of 1
    29.485	called  packet vorbis_bitrate_flushpacket
    29.485	CVorbisEncoder::PacketOut packet of length 67 added to cache
    29.560	Called vorbis_analysis_buffer with int vals = 1024
    29.560	Called vorbis_analysis_wrote with vals = 1024
    29.690	Called vorbis_analysis_buffer with int vals = 1024
    29.690	Called vorbis_analysis_wrote with vals = 1024
    29.690	called vorbis_analysis_blockout with return of 1
    29.695	called  packet vorbis_bitrate_flushpacket
    29.695	CVorbisEncoder::PacketOut packet of length 58 added to cache
    29.695	called vorbis_analysis_blockout with return of 1
    29.720	called  packet vorbis_bitrate_flushpacket
    29.720	CVorbisEncoder::PacketOut packet of length 269 added to cache
    29.720	called vorbis_analysis_blockout with return of 1
    29.725	called  packet vorbis_bitrate_flushpacket
    29.725	CVorbisEncoder::PacketOut packet of length 64 added to cache
    29.725	called vorbis_analysis_blockout with return of 1
    29.730	called  packet vorbis_bitrate_flushpacket
    29.730	CVorbisEncoder::PacketOut packet of length 69 added to cache
    29.730	called vorbis_analysis_blockout with return of 1
    29.730	called  packet vorbis_bitrate_flushpacket
    29.730	CVorbisEncoder::PacketOut packet of length 76 added to cache
    29.730	called vorbis_analysis_blockout with return of 1
    29.735	called  packet vorbis_bitrate_flushpacket
    29.735	CVorbisEncoder::PacketOut packet of length 61 added to cache
    29.735	called vorbis_analysis_blockout with return of 1
    29.740	called  packet vorbis_bitrate_flushpacket
    29.740	CVorbisEncoder::PacketOut packet of length 66 added to cache
    29.740	called vorbis_analysis_blockout with return of 1
    29.745	called  packet vorbis_bitrate_flushpacket
    29.745	CVorbisEncoder::PacketOut packet of length 60 added to cache
    29.815	Called vorbis_analysis_buffer with int vals = 1024
    29.815	Called vorbis_analysis_wrote with vals = 1024
    29.820	called vorbis_analysis_blockout with return of 1
    29.825	called  packet vorbis_bitrate_flushpacket
    29.825	CVorbisEncoder::PacketOut packet of length 60 added to cache
    29.945	Called vorbis_analysis_buffer with int vals = 1024
    29.945	Called vorbis_analysis_wrote with vals = 1024
    29.945	called vorbis_analysis_blockout with return of 1
    29.975	called  packet vorbis_bitrate_flushpacket
    29.975	CVorbisEncoder::PacketOut packet of length 271 added to cache
    29.975	called vorbis_analysis_blockout with return of 1
    29.975	called  packet vorbis_bitrate_flushpacket
    29.975	CVorbisEncoder::PacketOut packet of length 71 added to cache
    29.975	called vorbis_analysis_blockout with return of 1
    29.980	called  packet vorbis_bitrate_flushpacket
    29.980	CVorbisEncoder::PacketOut packet of length 57 added to cache
    29.980	called vorbis_analysis_blockout with return of 1
    29.985	called  packet vorbis_bitrate_flushpacket
    29.985	CVorbisEncoder::PacketOut packet of length 60 added to cache
    29.985	called vorbis_analysis_blockout with return of 1
    29.990	called  packet vorbis_bitrate_flushpacket
    29.990	CVorbisEncoder::PacketOut packet of length 60 added to cache
    29.990	called vorbis_analysis_blockout with return of 1
    29.990	called  packet vorbis_bitrate_flushpacket
    29.990	CVorbisEncoder::PacketOut packet of length 66 added to cache
    30.070	Called vorbis_analysis_buffer with int vals = 1024
    30.075	Called vorbis_analysis_wrote with vals = 1024
    30.075	called vorbis_analysis_blockout with return of 1
    30.080	called  packet vorbis_bitrate_flushpacket
    30.080	CVorbisEncoder::PacketOut packet of length 67 added to cache
    30.080	called vorbis_analysis_blockout with return of 1
    30.080	called  packet vorbis_bitrate_flushpacket
    30.080	CVorbisEncoder::PacketOut packet of length 66 added to cache
    30.080	PageLength 4224
    30.085	called vorbis_analysis_blockout with return of 1
    30.085	called  packet vorbis_bitrate_flushpacket
    30.085	CVorbisEncoder::PacketOut packet of length 59 added to cache
    30.085	called vorbis_analysis_blockout with return of 1
    30.090	called  packet vorbis_bitrate_flushpacket
    30.090	CVorbisEncoder::PacketOut packet of length 51 added to cache
    30.090	called vorbis_analysis_blockout with return of 1
    30.095	called  packet vorbis_bitrate_flushpacket
    30.095	CVorbisEncoder::PacketOut packet of length 69 added to cache
    30.095	called vorbis_analysis_blockout with return of 1
    30.100	called  packet vorbis_bitrate_flushpacket
    30.100	CVorbisEncoder::PacketOut packet of length 64 added to cache
    30.100	called vorbis_analysis_blockout with return of 1
    30.100	called  packet vorbis_bitrate_flushpacket
    30.100	CVorbisEncoder::PacketOut packet of length 60 added to cache
    30.200	Called vorbis_analysis_buffer with int vals = 1024
    30.200	Called vorbis_analysis_wrote with vals = 1024
    30.205	called vorbis_analysis_blockout with return of 1
    30.205	called  packet vorbis_bitrate_flushpacket
    30.205	CVorbisEncoder::PacketOut packet of length 61 added to cache
    30.205	called vorbis_analysis_blockout with return of 1
    30.235	called  packet vorbis_bitrate_flushpacket
    30.235	CVorbisEncoder::PacketOut packet of length 268 added to cache
    30.235	called vorbis_analysis_blockout with return of 1
    30.235	called  packet vorbis_bitrate_flushpacket
    30.235	CVorbisEncoder::PacketOut packet of length 63 added to cache
    30.235	called vorbis_analysis_blockout with return of 1
    30.240	called  packet vorbis_bitrate_flushpacket
    30.240	CVorbisEncoder::PacketOut packet of length 57 added to cache
    30.240	called vorbis_analysis_blockout with return of 1
    30.245	called  packet vorbis_bitrate_flushpacket
    30.245	CVorbisEncoder::PacketOut packet of length 70 added to cache
    30.330	Called vorbis_analysis_buffer with int vals = 1024
    30.330	Called vorbis_analysis_wrote with vals = 1024
    30.455	Called vorbis_analysis_buffer with int vals = 1024
    30.455	Called vorbis_analysis_wrote with vals = 1024
    30.460	called vorbis_analysis_blockout with return of 1
    30.465	called  packet vorbis_bitrate_flushpacket
    30.465	CVorbisEncoder::PacketOut packet of length 68 added to cache
    30.465	called vorbis_analysis_blockout with return of 1
    30.490	called  packet vorbis_bitrate_flushpacket
    30.490	CVorbisEncoder::PacketOut packet of length 268 added to cache
    30.490	called vorbis_analysis_blockout with return of 1
    30.495	called  packet vorbis_bitrate_flushpacket
    30.495	CVorbisEncoder::PacketOut packet of length 58 added to cache
    30.495	called vorbis_analysis_blockout with return of 1
    30.495	called  packet vorbis_bitrate_flushpacket
    30.495	CVorbisEncoder::PacketOut packet of length 69 added to cache
    30.495	called vorbis_analysis_blockout with return of 1
    30.500	called  packet vorbis_bitrate_flushpacket
    30.500	CVorbisEncoder::PacketOut packet of length 78 added to cache
    30.500	called vorbis_analysis_blockout with return of 1
    30.505	called  packet vorbis_bitrate_flushpacket
    30.505	CVorbisEncoder::PacketOut packet of length 65 added to cache
    30.505	called vorbis_analysis_blockout with return of 1
    30.505	called  packet vorbis_bitrate_flushpacket
    30.505	CVorbisEncoder::PacketOut packet of length 71 added to cache
    30.505	called vorbis_analysis_blockout with return of 1
    30.510	called  packet vorbis_bitrate_flushpacket
    30.510	CVorbisEncoder::PacketOut packet of length 68 added to cache
    30.510	called vorbis_analysis_blockout with return of 1
    30.515	called  packet vorbis_bitrate_flushpacket
    30.515	CVorbisEncoder::PacketOut packet of length 47 added to cache
    30.515	called vorbis_analysis_blockout with return of 1
    30.520	called  packet vorbis_bitrate_flushpacket
    30.520	CVorbisEncoder::PacketOut packet of length 68 added to cache
    30.585	Called vorbis_analysis_buffer with int vals = 1024
    30.585	Called vorbis_analysis_wrote with vals = 1024
    30.585	called vorbis_analysis_blockout with return of 1
    30.590	called  packet vorbis_bitrate_flushpacket
    30.590	CVorbisEncoder::PacketOut packet of length 64 added to cache
    30.710	Called vorbis_analysis_buffer with int vals = 1024
    30.710	Called vorbis_analysis_wrote with vals = 1024
    30.715	called vorbis_analysis_blockout with return of 1
    30.720	called  packet vorbis_bitrate_flushpacket
    30.720	CVorbisEncoder::PacketOut packet of length 66 added to cache
    30.840	Called vorbis_analysis_buffer with int vals = 1024
    30.840	Called vorbis_analysis_wrote with vals = 1024
    30.845	called vorbis_analysis_blockout with return of 1
    30.870	called  packet vorbis_bitrate_flushpacket
    30.870	CVorbisEncoder::PacketOut packet of length 278 added to cache
    30.870	called vorbis_analysis_blockout with return of 1
    30.895	called  packet vorbis_bitrate_flushpacket
    30.895	CVorbisEncoder::PacketOut packet of length 277 added to cache
    30.895	called vorbis_analysis_blockout with return of 1
    30.900	called  packet vorbis_bitrate_flushpacket
    30.900	CVorbisEncoder::PacketOut packet of length 60 added to cache
    30.900	called vorbis_analysis_blockout with return of 1
    30.905	called  packet vorbis_bitrate_flushpacket
    30.905	CVorbisEncoder::PacketOut packet of length 61 added to cache
    30.905	called vorbis_analysis_blockout with return of 1
    30.910	called  packet vorbis_bitrate_flushpacket
    30.910	CVorbisEncoder::PacketOut packet of length 50 added to cache
    30.910	called vorbis_analysis_blockout with return of 1
    30.915	called  packet vorbis_bitrate_flushpacket
    30.915	CVorbisEncoder::PacketOut packet of length 61 added to cache
    30.915	called vorbis_analysis_blockout with return of 1
    30.915	called  packet vorbis_bitrate_flushpacket
    30.915	CVorbisEncoder::PacketOut packet of length 68 added to cache
    30.970	Called vorbis_analysis_buffer with int vals = 1024
    30.970	Called vorbis_analysis_wrote with vals = 1024
    30.970	called vorbis_analysis_blockout with return of 1
    30.975	called  packet vorbis_bitrate_flushpacket
    30.975	CVorbisEncoder::PacketOut packet of length 67 added to cache
    30.975	called vorbis_analysis_blockout with return of 1
    30.980	called  packet vorbis_bitrate_flushpacket
    30.980	CVorbisEncoder::PacketOut packet of length 60 added to cache
    30.980	called vorbis_analysis_blockout with return of 1
    30.985	called  packet vorbis_bitrate_flushpacket
    30.985	CVorbisEncoder::PacketOut packet of length 65 added to cache
    30.985	called vorbis_analysis_blockout with return of 1
    30.985	called  packet vorbis_bitrate_flushpacket
    30.985	CVorbisEncoder::PacketOut packet of length 59 added to cache
    30.985	called vorbis_analysis_blockout with return of 1
    30.990	called  packet vorbis_bitrate_flushpacket
    30.990	CVorbisEncoder::PacketOut packet of length 47 added to cache
    30.990	called vorbis_analysis_blockout with return of 1
    30.995	called  packet vorbis_bitrate_flushpacket
    30.995	CVorbisEncoder::PacketOut packet of length 61 added to cache
    30.995	called vorbis_analysis_blockout with return of 1
    31.000	called  packet vorbis_bitrate_flushpacket
    31.000	CVorbisEncoder::PacketOut packet of length 61 added to cache
    31.000	called vorbis_analysis_blockout with return of 1
    31.000	called  packet vorbis_bitrate_flushpacket
    31.000	CVorbisEncoder::PacketOut packet of length 61 added to cache
    31.000	called vorbis_analysis_blockout with return of 1
    31.005	called  packet vorbis_bitrate_flushpacket
    31.005	CVorbisEncoder::PacketOut packet of length 67 added to cache
    31.095	Called vorbis_analysis_buffer with int vals = 1024
    31.095	Called vorbis_analysis_wrote with vals = 1024
    31.225	Called vorbis_analysis_buffer with int vals = 1024
    31.225	Called vorbis_analysis_wrote with vals = 1024
    31.225	called vorbis_analysis_blockout with return of 1
    31.230	called  packet vorbis_bitrate_flushpacket
    31.230	CVorbisEncoder::PacketOut packet of length 62 added to cache
    31.230	called vorbis_analysis_blockout with return of 1
    31.255	called  packet vorbis_bitrate_flushpacket
    31.255	CVorbisEncoder::PacketOut packet of length 260 added to cache
    31.255	called vorbis_analysis_blockout with return of 1
    31.260	called  packet vorbis_bitrate_flushpacket
    31.260	CVorbisEncoder::PacketOut packet of length 58 added to cache
    31.260	called vorbis_analysis_blockout with return of 1
    31.265	called  packet vorbis_bitrate_flushpacket
    31.265	CVorbisEncoder::PacketOut packet of length 61 added to cache
    31.265	called vorbis_analysis_blockout with return of 1
    31.270	called  packet vorbis_bitrate_flushpacket
    31.270	CVorbisEncoder::PacketOut packet of length 60 added to cache
    31.270	called vorbis_analysis_blockout with return of 1
    31.270	called  packet vorbis_bitrate_flushpacket
    31.270	CVorbisEncoder::PacketOut packet of length 67 added to cache
    31.270	called vorbis_analysis_blockout with return of 1
    31.275	called  packet vorbis_bitrate_flushpacket
    31.275	CVorbisEncoder::PacketOut packet of length 71 added to cache
    31.350	Called vorbis_analysis_buffer with int vals = 1024
    31.350	Called vorbis_analysis_wrote with vals = 1024
    31.355	called vorbis_analysis_blockout with return of 1
    31.360	called  packet vorbis_bitrate_flushpacket
    31.360	CVorbisEncoder::PacketOut packet of length 64 added to cache
    31.480	Called vorbis_analysis_buffer with int vals = 1024
    31.480	Called vorbis_analysis_wrote with vals = 1024
    31.485	called vorbis_analysis_blockout with return of 1
    31.510	called  packet vorbis_bitrate_flushpacket
    31.510	CVorbisEncoder::PacketOut packet of length 283 added to cache
    31.510	PageLength 4252
    31.510	called vorbis_analysis_blockout with return of 1
    31.515	called  packet vorbis_bitrate_flushpacket
    31.515	CVorbisEncoder::PacketOut packet of length 64 added to cache
    31.515	called vorbis_analysis_blockout with return of 1
    31.515	called  packet vorbis_bitrate_flushpacket
    31.515	CVorbisEncoder::PacketOut packet of length 60 added to cache
    31.515	called vorbis_analysis_blockout with return of 1
    31.520	called  packet vorbis_bitrate_flushpacket
    31.520	CVorbisEncoder::PacketOut packet of length 53 added to cache
    31.520	called vorbis_analysis_blockout with return of 1
    31.525	called  packet vorbis_bitrate_flushpacket
    31.525	CVorbisEncoder::PacketOut packet of length 50 added to cache
    31.525	called vorbis_analysis_blockout with return of 1
    31.530	called  packet vorbis_bitrate_flushpacket
    31.530	CVorbisEncoder::PacketOut packet of length 56 added to cache
    31.530	called vorbis_analysis_blockout with return of 1
    31.535	called  packet vorbis_bitrate_flushpacket
    31.535	CVorbisEncoder::PacketOut packet of length 67 added to cache
    31.535	called vorbis_analysis_blockout with return of 1
    31.535	called  packet vorbis_bitrate_flushpacket
    31.535	CVorbisEncoder::PacketOut packet of length 75 added to cache
    31.535	called vorbis_analysis_blockout with return of 1
    31.540	called  packet vorbis_bitrate_flushpacket
    31.540	CVorbisEncoder::PacketOut packet of length 70 added to cache
    31.610	Called vorbis_analysis_buffer with int vals = 1024
    31.610	Called vorbis_analysis_wrote with vals = 1024
    31.735	Called vorbis_analysis_buffer with int vals = 1024
    31.735	Called vorbis_analysis_wrote with vals = 1024
    31.740	called vorbis_analysis_blockout with return of 1
    31.745	called  packet vorbis_bitrate_flushpacket
    31.745	CVorbisEncoder::PacketOut packet of length 57 added to cache
    31.865	Called vorbis_analysis_buffer with int vals = 1024
    31.865	Called vorbis_analysis_wrote with vals = 1024
    31.865	called vorbis_analysis_blockout with return of 1
    31.895	called  packet vorbis_bitrate_flushpacket
    31.895	CVorbisEncoder::PacketOut packet of length 275 added to cache
    31.990	Called vorbis_analysis_buffer with int vals = 1024
    31.995	Called vorbis_analysis_wrote with vals = 1024
    31.995	called vorbis_analysis_blockout with return of 1
    32.020	called  packet vorbis_bitrate_flushpacket
    32.020	CVorbisEncoder::PacketOut packet of length 262 added to cache
    32.020	called vorbis_analysis_blockout with return of 1
    32.045	called  packet vorbis_bitrate_flushpacket
    32.045	CVorbisEncoder::PacketOut packet of length 263 added to cache
    32.045	called vorbis_analysis_blockout with return of 1
    32.050	called  packet vorbis_bitrate_flushpacket
    32.050	CVorbisEncoder::PacketOut packet of length 61 added to cache
    32.050	called vorbis_analysis_blockout with return of 1
    32.055	called  packet vorbis_bitrate_flushpacket
    32.055	CVorbisEncoder::PacketOut packet of length 57 added to cache
    32.055	called vorbis_analysis_blockout with return of 1
    32.060	called  packet vorbis_bitrate_flushpacket
    32.060	CVorbisEncoder::PacketOut packet of length 68 added to cache
    32.120	Called vorbis_analysis_buffer with int vals = 1024
    32.120	Called vorbis_analysis_wrote with vals = 1024
    32.125	called vorbis_analysis_blockout with return of 1
    32.125	called  packet vorbis_bitrate_flushpacket
    32.125	CVorbisEncoder::PacketOut packet of length 67 added to cache
    32.125	called vorbis_analysis_blockout with return of 1
    32.130	called  packet vorbis_bitrate_flushpacket
    32.130	CVorbisEncoder::PacketOut packet of length 70 added to cache
    32.130	called vorbis_analysis_blockout with return of 1
    32.135	called  packet vorbis_bitrate_flushpacket
    32.135	CVorbisEncoder::PacketOut packet of length 57 added to cache
    32.135	called vorbis_analysis_blockout with return of 1
    32.140	called  packet vorbis_bitrate_flushpacket
    32.140	CVorbisEncoder::PacketOut packet of length 64 added to cache
    32.140	called vorbis_analysis_blockout with return of 1
    32.140	called  packet vorbis_bitrate_flushpacket
    32.140	CVorbisEncoder::PacketOut packet of length 53 added to cache
    32.140	called vorbis_analysis_blockout with return of 1
    32.145	called  packet vorbis_bitrate_flushpacket
    32.145	CVorbisEncoder::PacketOut packet of length 56 added to cache
    32.145	called vorbis_analysis_blockout with return of 1
    32.150	called  packet vorbis_bitrate_flushpacket
    32.150	CVorbisEncoder::PacketOut packet of length 58 added to cache
    32.150	called vorbis_analysis_blockout with return of 1
    32.155	called  packet vorbis_bitrate_flushpacket
    32.155	CVorbisEncoder::PacketOut packet of length 66 added to cache
    32.155	called vorbis_analysis_blockout with return of 1
    32.160	called  packet vorbis_bitrate_flushpacket
    32.160	CVorbisEncoder::PacketOut packet of length 54 added to cache
    32.250	Called vorbis_analysis_buffer with int vals = 1024
    32.250	Called vorbis_analysis_wrote with vals = 1024
    32.250	called vorbis_analysis_blockout with return of 1
    32.255	called  packet vorbis_bitrate_flushpacket
    32.255	CVorbisEncoder::PacketOut packet of length 64 added to cache
    32.375	Called vorbis_analysis_buffer with int vals = 1024
    32.375	Called vorbis_analysis_wrote with vals = 1024
    32.380	called vorbis_analysis_blockout with return of 1
    32.405	called  packet vorbis_bitrate_flushpacket
    32.405	CVorbisEncoder::PacketOut packet of length 263 added to cache
    32.405	called vorbis_analysis_blockout with return of 1
    32.410	called  packet vorbis_bitrate_flushpacket
    32.410	CVorbisEncoder::PacketOut packet of length 71 added to cache
    32.410	called vorbis_analysis_blockout with return of 1
    32.415	called  packet vorbis_bitrate_flushpacket
    32.415	CVorbisEncoder::PacketOut packet of length 73 added to cache
    32.415	called vorbis_analysis_blockout with return of 1
    32.415	called  packet vorbis_bitrate_flushpacket
    32.415	CVorbisEncoder::PacketOut packet of length 51 added to cache
    32.415	called vorbis_analysis_blockout with return of 1
    32.420	called  packet vorbis_bitrate_flushpacket
    32.420	CVorbisEncoder::PacketOut packet of length 57 added to cache
    32.420	called vorbis_analysis_blockout with return of 1
    32.425	called  packet vorbis_bitrate_flushpacket
    32.425	CVorbisEncoder::PacketOut packet of length 62 added to cache
    32.425	called vorbis_analysis_blockout with return of 1
    32.430	called  packet vorbis_bitrate_flushpacket
    32.430	CVorbisEncoder::PacketOut packet of length 71 added to cache
    32.430	called vorbis_analysis_blockout with return of 1
    32.430	called  packet vorbis_bitrate_flushpacket
    32.430	CVorbisEncoder::PacketOut packet of length 78 added to cache
    32.430	called vorbis_analysis_blockout with return of 1
    32.435	called  packet vorbis_bitrate_flushpacket
    32.435	CVorbisEncoder::PacketOut packet of length 61 added to cache
    32.435	called vorbis_analysis_blockout with return of 1
    32.440	called  packet vorbis_bitrate_flushpacket
    32.440	CVorbisEncoder::PacketOut packet of length 64 added to cache
    32.440	called vorbis_analysis_blockout with return of 1
    32.445	called  packet vorbis_bitrate_flushpacket
    32.445	CVorbisEncoder::PacketOut packet of length 64 added to cache
    32.445	called vorbis_analysis_blockout with return of 1
    32.450	called  packet vorbis_bitrate_flushpacket
    32.450	CVorbisEncoder::PacketOut packet of length 75 added to cache
    32.505	Called vorbis_analysis_buffer with int vals = 1024
    32.505	Called vorbis_analysis_wrote with vals = 1024
    32.505	called vorbis_analysis_blockout with return of 1
    32.510	called  packet vorbis_bitrate_flushpacket
    32.510	CVorbisEncoder::PacketOut packet of length 66 added to cache
    32.630	Called vorbis_analysis_buffer with int vals = 1024
    32.630	Called vorbis_analysis_wrote with vals = 1024
    32.635	called vorbis_analysis_blockout with return of 1
    32.640	called  packet vorbis_bitrate_flushpacket
    32.640	CVorbisEncoder::PacketOut packet of length 63 added to cache
    32.760	Called vorbis_analysis_buffer with int vals = 1024
    32.760	Called vorbis_analysis_wrote with vals = 1024
    32.765	called vorbis_analysis_blockout with return of 1
    32.790	called  packet vorbis_bitrate_flushpacket
    32.790	CVorbisEncoder::PacketOut packet of length 267 added to cache
    32.790	called vorbis_analysis_blockout with return of 1
    32.815	called  packet vorbis_bitrate_flushpacket
    32.815	CVorbisEncoder::PacketOut packet of length 273 added to cache
    32.815	called vorbis_analysis_blockout with return of 1
    32.820	called  packet vorbis_bitrate_flushpacket
    32.820	CVorbisEncoder::PacketOut packet of length 51 added to cache
    32.820	called vorbis_analysis_blockout with return of 1
    32.825	called  packet vorbis_bitrate_flushpacket
    32.825	CVorbisEncoder::PacketOut packet of length 60 added to cache
    32.825	called vorbis_analysis_blockout with return of 1
    32.825	called  packet vorbis_bitrate_flushpacket
    32.825	CVorbisEncoder::PacketOut packet of length 66 added to cache
    32.825	called vorbis_analysis_blockout with return of 1
    32.830	called  packet vorbis_bitrate_flushpacket
    32.830	CVorbisEncoder::PacketOut packet of length 58 added to cache
    32.830	called vorbis_analysis_blockout with return of 1
    32.835	called  packet vorbis_bitrate_flushpacket
    32.835	CVorbisEncoder::PacketOut packet of length 65 added to cache
    32.835	PageLength 4214
    32.890	Called vorbis_analysis_buffer with int vals = 1024
    32.890	Called vorbis_analysis_wrote with vals = 1024
    33.015	Called vorbis_analysis_buffer with int vals = 1024
    33.015	Called vorbis_analysis_wrote with vals = 1024
    33.025	called vorbis_analysis_blockout with return of 1
    33.030	called  packet vorbis_bitrate_flushpacket
    33.030	CVorbisEncoder::PacketOut packet of length 63 added to cache
    33.030	called vorbis_analysis_blockout with return of 1
    33.055	called  packet vorbis_bitrate_flushpacket
    33.055	CVorbisEncoder::PacketOut packet of length 273 added to cache
    33.055	called vorbis_analysis_blockout with return of 1
    33.060	called  packet vorbis_bitrate_flushpacket
    33.060	CVorbisEncoder::PacketOut packet of length 60 added to cache
    33.060	called vorbis_analysis_blockout with return of 1
    33.060	called  packet vorbis_bitrate_flushpacket
    33.060	CVorbisEncoder::PacketOut packet of length 59 added to cache
    33.060	called vorbis_analysis_blockout with return of 1
    33.065	called  packet vorbis_bitrate_flushpacket
    33.065	CVorbisEncoder::PacketOut packet of length 59 added to cache
    33.065	called vorbis_analysis_blockout with return of 1
    33.070	called  packet vorbis_bitrate_flushpacket
    33.070	CVorbisEncoder::PacketOut packet of length 65 added to cache
    33.145	Called vorbis_analysis_buffer with int vals = 1024
    33.145	Called vorbis_analysis_wrote with vals = 1024
    33.145	called vorbis_analysis_blockout with return of 1
    33.150	called  packet vorbis_bitrate_flushpacket
    33.150	CVorbisEncoder::PacketOut packet of length 63 added to cache
    33.270	Called vorbis_analysis_buffer with int vals = 1024
    33.275	Called vorbis_analysis_wrote with vals = 1024
    33.275	called vorbis_analysis_blockout with return of 1
    33.300	called  packet vorbis_bitrate_flushpacket
    33.300	CVorbisEncoder::PacketOut packet of length 267 added to cache
    33.300	called vorbis_analysis_blockout with return of 1
    33.305	called  packet vorbis_bitrate_flushpacket
    33.305	CVorbisEncoder::PacketOut packet of length 64 added to cache
    33.305	called vorbis_analysis_blockout with return of 1
    33.310	called  packet vorbis_bitrate_flushpacket
    33.310	CVorbisEncoder::PacketOut packet of length 69 added to cache
    33.310	called vorbis_analysis_blockout with return of 1
    33.310	called  packet vorbis_bitrate_flushpacket
    33.310	CVorbisEncoder::PacketOut packet of length 67 added to cache
    33.310	called vorbis_analysis_blockout with return of 1
    33.315	called  packet vorbis_bitrate_flushpacket
    33.315	CVorbisEncoder::PacketOut packet of length 60 added to cache
    33.315	called vorbis_analysis_blockout with return of 1
    33.320	called  packet vorbis_bitrate_flushpacket
    33.320	CVorbisEncoder::PacketOut packet of length 69 added to cache
    33.320	called vorbis_analysis_blockout with return of 1
    33.325	called  packet vorbis_bitrate_flushpacket
    33.325	CVorbisEncoder::PacketOut packet of length 64 added to cache
    33.400	Called vorbis_analysis_buffer with int vals = 1024
    33.400	Called vorbis_analysis_wrote with vals = 1024
    33.405	called vorbis_analysis_blockout with return of 1
    33.405	called  packet vorbis_bitrate_flushpacket
    33.405	CVorbisEncoder::PacketOut packet of length 68 added to cache
    33.405	called vorbis_analysis_blockout with return of 1
    33.410	called  packet vorbis_bitrate_flushpacket
    33.410	CVorbisEncoder::PacketOut packet of length 56 added to cache
    33.410	called vorbis_analysis_blockout with return of 1
    33.415	called  packet vorbis_bitrate_flushpacket
    33.415	CVorbisEncoder::PacketOut packet of length 69 added to cache
    33.415	called vorbis_analysis_blockout with return of 1
    33.420	called  packet vorbis_bitrate_flushpacket
    33.420	CVorbisEncoder::PacketOut packet of length 57 added to cache
    33.420	called vorbis_analysis_blockout with return of 1
    33.420	called  packet vorbis_bitrate_flushpacket
    33.420	CVorbisEncoder::PacketOut packet of length 62 added to cache
    33.420	called vorbis_analysis_blockout with return of 1
    33.425	called  packet vorbis_bitrate_flushpacket
    33.425	CVorbisEncoder::PacketOut packet of length 58 added to cache
    33.425	called vorbis_analysis_blockout with return of 1
    33.430	called  packet vorbis_bitrate_flushpacket
    33.430	CVorbisEncoder::PacketOut packet of length 48 added to cache
    33.430	called vorbis_analysis_blockout with return of 1
    33.435	called  packet vorbis_bitrate_flushpacket
    33.435	CVorbisEncoder::PacketOut packet of length 58 added to cache
    33.435	called vorbis_analysis_blockout with return of 1
    33.435	called  packet vorbis_bitrate_flushpacket
    33.435	CVorbisEncoder::PacketOut packet of length 65 added to cache
    33.530	Called vorbis_analysis_buffer with int vals = 1024
    33.530	Called vorbis_analysis_wrote with vals = 1024
    33.530	called vorbis_analysis_blockout with return of 1
    33.535	called  packet vorbis_bitrate_flushpacket
    33.535	CVorbisEncoder::PacketOut packet of length 62 added to cache
    33.535	called vorbis_analysis_blockout with return of 1
    33.560	called  packet vorbis_bitrate_flushpacket
    33.560	CVorbisEncoder::PacketOut packet of length 275 added to cache
    33.560	called vorbis_analysis_blockout with return of 1
    33.565	called  packet vorbis_bitrate_flushpacket
    33.565	CVorbisEncoder::PacketOut packet of length 71 added to cache
    33.565	called vorbis_analysis_blockout with return of 1
    33.570	called  packet vorbis_bitrate_flushpacket
    33.570	CVorbisEncoder::PacketOut packet of length 65 added to cache
    33.655	Called vorbis_analysis_buffer with int vals = 1024
    33.655	Called vorbis_analysis_wrote with vals = 1024
    33.660	called vorbis_analysis_blockout with return of 1
    33.665	called  packet vorbis_bitrate_flushpacket
    33.665	CVorbisEncoder::PacketOut packet of length 64 added to cache
    33.665	called vorbis_analysis_blockout with return of 1
    33.665	called  packet vorbis_bitrate_flushpacket
    33.665	CVorbisEncoder::PacketOut packet of length 67 added to cache
    33.665	called vorbis_analysis_blockout with return of 1
    33.670	called  packet vorbis_bitrate_flushpacket
    33.670	CVorbisEncoder::PacketOut packet of length 52 added to cache
    33.670	called vorbis_analysis_blockout with return of 1
    33.675	called  packet vorbis_bitrate_flushpacket
    33.675	CVorbisEncoder::PacketOut packet of length 53 added to cache
    33.675	called vorbis_analysis_blockout with return of 1
    33.680	called  packet vorbis_bitrate_flushpacket
    33.680	CVorbisEncoder::PacketOut packet of length 66 added to cache
    33.785	Called vorbis_analysis_buffer with int vals = 1024
    33.785	Called vorbis_analysis_wrote with vals = 1024
    33.785	called vorbis_analysis_blockout with return of 1
    33.790	called  packet vorbis_bitrate_flushpacket
    33.790	CVorbisEncoder::PacketOut packet of length 66 added to cache
    33.790	called vorbis_analysis_blockout with return of 1
    33.795	called  packet vorbis_bitrate_flushpacket
    33.795	CVorbisEncoder::PacketOut packet of length 70 added to cache
    33.795	called vorbis_analysis_blockout with return of 1
    33.800	called  packet vorbis_bitrate_flushpacket
    33.800	CVorbisEncoder::PacketOut packet of length 66 added to cache
    33.800	called vorbis_analysis_blockout with return of 1
    33.800	called  packet vorbis_bitrate_flushpacket
    33.800	CVorbisEncoder::PacketOut packet of length 79 added to cache
    33.800	called vorbis_analysis_blockout with return of 1
    33.805	called  packet vorbis_bitrate_flushpacket
    33.805	CVorbisEncoder::PacketOut packet of length 54 added to cache
    33.805	called vorbis_analysis_blockout with return of 1
    33.810	called  packet vorbis_bitrate_flushpacket
    33.810	CVorbisEncoder::PacketOut packet of length 50 added to cache
    33.810	called vorbis_analysis_blockout with return of 1
    33.815	called  packet vorbis_bitrate_flushpacket
    33.815	CVorbisEncoder::PacketOut packet of length 57 added to cache
    33.815	called vorbis_analysis_blockout with return of 1
    33.820	called  packet vorbis_bitrate_flushpacket
    33.820	CVorbisEncoder::PacketOut packet of length 63 added to cache
    33.820	called vorbis_analysis_blockout with return of 1
    33.820	called  packet vorbis_bitrate_flushpacket
    33.820	CVorbisEncoder::PacketOut packet of length 63 added to cache
    33.910	Called vorbis_analysis_buffer with int vals = 1024
    33.915	Called vorbis_analysis_wrote with vals = 1024
    33.915	called vorbis_analysis_blockout with return of 1
    33.920	called  packet vorbis_bitrate_flushpacket
    33.920	CVorbisEncoder::PacketOut packet of length 69 added to cache
    34.040	Called vorbis_analysis_buffer with int vals = 1024
    34.040	Called vorbis_analysis_wrote with vals = 1024
    34.045	called vorbis_analysis_blockout with return of 1
    34.070	called  packet vorbis_bitrate_flushpacket
    34.070	CVorbisEncoder::PacketOut packet of length 268 added to cache
    34.070	called vorbis_analysis_blockout with return of 1
    34.095	called  packet vorbis_bitrate_flushpacket
    34.095	CVorbisEncoder::PacketOut packet of length 260 added to cache
    34.095	called vorbis_analysis_blockout with return of 1
    34.100	called  packet vorbis_bitrate_flushpacket
    34.100	CVorbisEncoder::PacketOut packet of length 70 added to cache
    34.100	called vorbis_analysis_blockout with return of 1
    34.105	called  packet vorbis_bitrate_flushpacket
    34.105	CVorbisEncoder::PacketOut packet of length 57 added to cache
    34.170	Called vorbis_analysis_buffer with int vals = 1024
    34.170	Called vorbis_analysis_wrote with vals = 1024
    34.170	called vorbis_analysis_blockout with return of 1
    34.175	called  packet vorbis_bitrate_flushpacket
    34.175	CVorbisEncoder::PacketOut packet of length 65 added to cache
    34.175	called vorbis_analysis_blockout with return of 1
    34.180	called  packet vorbis_bitrate_flushpacket
    34.180	CVorbisEncoder::PacketOut packet of length 50 added to cache
    34.180	called vorbis_analysis_blockout with return of 1
    34.185	called  packet vorbis_bitrate_flushpacket
    34.185	CVorbisEncoder::PacketOut packet of length 67 added to cache
    34.185	called vorbis_analysis_blockout with return of 1
    34.185	called  packet vorbis_bitrate_flushpacket
    34.185	CVorbisEncoder::PacketOut packet of length 54 added to cache
    34.185	PageLength 4228
    34.185	called vorbis_analysis_blockout with return of 1
    34.190	called  packet vorbis_bitrate_flushpacket
    34.190	CVorbisEncoder::PacketOut packet of length 61 added to cache
    34.190	called vorbis_analysis_blockout with return of 1
    34.195	called  packet vorbis_bitrate_flushpacket
    34.195	CVorbisEncoder::PacketOut packet of length 74 added to cache
    34.195	called vorbis_analysis_blockout with return of 1
    34.200	called  packet vorbis_bitrate_flushpacket
    34.200	CVorbisEncoder::PacketOut packet of length 65 added to cache
    34.295	Called vorbis_analysis_buffer with int vals = 1024
    34.295	Called vorbis_analysis_wrote with vals = 1024
    34.425	Called vorbis_analysis_buffer with int vals = 1024
    34.425	Called vorbis_analysis_wrote with vals = 1024
    34.425	called vorbis_analysis_blockout with return of 1
    34.430	called  packet vorbis_bitrate_flushpacket
    34.430	CVorbisEncoder::PacketOut packet of length 64 added to cache
    34.430	called vorbis_analysis_blockout with return of 1
    34.455	called  packet vorbis_bitrate_flushpacket
    34.455	CVorbisEncoder::PacketOut packet of length 276 added to cache
    34.455	called vorbis_analysis_blockout with return of 1
    34.460	called  packet vorbis_bitrate_flushpacket
    34.460	CVorbisEncoder::PacketOut packet of length 77 added to cache
    34.460	called vorbis_analysis_blockout with return of 1
    34.465	called  packet vorbis_bitrate_flushpacket
    34.465	CVorbisEncoder::PacketOut packet of length 69 added to cache
    34.465	called vorbis_analysis_blockout with return of 1
    34.470	called  packet vorbis_bitrate_flushpacket
    34.470	CVorbisEncoder::PacketOut packet of length 55 added to cache
    34.470	called vorbis_analysis_blockout with return of 1
    34.475	called  packet vorbis_bitrate_flushpacket
    34.475	CVorbisEncoder::PacketOut packet of length 63 added to cache
    34.550	Called vorbis_analysis_buffer with int vals = 1024
    34.550	Called vorbis_analysis_wrote with vals = 1024
    34.555	called vorbis_analysis_blockout with return of 1
    34.560	called  packet vorbis_bitrate_flushpacket
    34.560	CVorbisEncoder::PacketOut packet of length 61 added to cache
    34.560	called vorbis_analysis_blockout with return of 1
    34.565	called  packet vorbis_bitrate_flushpacket
    34.565	CVorbisEncoder::PacketOut packet of length 52 added to cache
    34.565	called vorbis_analysis_blockout with return of 1
    34.565	called  packet vorbis_bitrate_flushpacket
    34.565	CVorbisEncoder::PacketOut packet of length 69 added to cache
    34.565	called vorbis_analysis_blockout with return of 1
    34.570	called  packet vorbis_bitrate_flushpacket
    34.570	CVorbisEncoder::PacketOut packet of length 76 added to cache
    34.570	called vorbis_analysis_blockout with return of 1
    34.575	called  packet vorbis_bitrate_flushpacket
    34.575	CVorbisEncoder::PacketOut packet of length 73 added to cache
    34.575	called vorbis_analysis_blockout with return of 1
    34.580	called  packet vorbis_bitrate_flushpacket
    34.580	CVorbisEncoder::PacketOut packet of length 56 added to cache
    34.580	called vorbis_analysis_blockout with return of 1
    34.580	called  packet vorbis_bitrate_flushpacket
    34.580	CVorbisEncoder::PacketOut packet of length 57 added to cache
    34.580	called vorbis_analysis_blockout with return of 1
    34.585	called  packet vorbis_bitrate_flushpacket
    34.585	CVorbisEncoder::PacketOut packet of length 63 added to cache
    34.680	Called vorbis_analysis_buffer with int vals = 1024
    34.680	Called vorbis_analysis_wrote with vals = 1024
    34.685	called vorbis_analysis_blockout with return of 1
    34.685	called  packet vorbis_bitrate_flushpacket
    34.685	CVorbisEncoder::PacketOut packet of length 65 added to cache
    34.810	Called vorbis_analysis_buffer with int vals = 1024
    34.810	Called vorbis_analysis_wrote with vals = 1024
    34.810	called vorbis_analysis_blockout with return of 1
    34.835	called  packet vorbis_bitrate_flushpacket
    34.835	CVorbisEncoder::PacketOut packet of length 280 added to cache
    34.935	Called vorbis_analysis_buffer with int vals = 1024
    34.935	Called vorbis_analysis_wrote with vals = 1024
    34.940	called vorbis_analysis_blockout with return of 1
    34.965	called  packet vorbis_bitrate_flushpacket
    34.965	CVorbisEncoder::PacketOut packet of length 273 added to cache
    34.965	called vorbis_analysis_blockout with return of 1
    34.970	called  packet vorbis_bitrate_flushpacket
    34.970	CVorbisEncoder::PacketOut packet of length 62 added to cache
    34.970	called vorbis_analysis_blockout with return of 1
    34.975	called  packet vorbis_bitrate_flushpacket
    34.975	CVorbisEncoder::PacketOut packet of length 60 added to cache
    34.975	called vorbis_analysis_blockout with return of 1
    34.975	called  packet vorbis_bitrate_flushpacket
    34.975	CVorbisEncoder::PacketOut packet of length 52 added to cache
    34.975	called vorbis_analysis_blockout with return of 1
    34.980	called  packet vorbis_bitrate_flushpacket
    34.980	CVorbisEncoder::PacketOut packet of length 50 added to cache
    34.980	called vorbis_analysis_blockout with return of 1
    34.985	called  packet vorbis_bitrate_flushpacket
    34.985	CVorbisEncoder::PacketOut packet of length 69 added to cache
    35.065	Called vorbis_analysis_buffer with int vals = 1024
    35.065	Called vorbis_analysis_wrote with vals = 1024
    35.065	called vorbis_analysis_blockout with return of 1
    35.070	called  packet vorbis_bitrate_flushpacket
    35.070	CVorbisEncoder::PacketOut packet of length 58 added to cache
    35.190	Called vorbis_analysis_buffer with int vals = 1024
    35.195	Called vorbis_analysis_wrote with vals = 1024
    35.195	called vorbis_analysis_blockout with return of 1
    35.220	called  packet vorbis_bitrate_flushpacket
    35.220	CVorbisEncoder::PacketOut packet of length 264 added to cache
    35.320	Called vorbis_analysis_buffer with int vals = 1024
    35.320	Called vorbis_analysis_wrote with vals = 1024
    35.325	called vorbis_analysis_blockout with return of 1
    35.350	called  packet vorbis_bitrate_flushpacket
    35.350	CVorbisEncoder::PacketOut packet of length 270 added to cache
    35.350	called vorbis_analysis_blockout with return of 1
    35.375	called  packet vorbis_bitrate_flushpacket
    35.375	CVorbisEncoder::PacketOut packet of length 269 added to cache
    35.375	called vorbis_analysis_blockout with return of 1
    35.380	called  packet vorbis_bitrate_flushpacket
    35.380	CVorbisEncoder::PacketOut packet of length 77 added to cache
    35.380	called vorbis_analysis_blockout with return of 1
    35.385	called  packet vorbis_bitrate_flushpacket
    35.385	CVorbisEncoder::PacketOut packet of length 66 added to cache
    35.385	called vorbis_analysis_blockout with return of 1
    35.385	called  packet vorbis_bitrate_flushpacket
    35.385	CVorbisEncoder::PacketOut packet of length 77 added to cache
    35.385	called vorbis_analysis_blockout with return of 1
    35.390	called  packet vorbis_bitrate_flushpacket
    35.390	CVorbisEncoder::PacketOut packet of length 72 added to cache
    35.390	called vorbis_analysis_blockout with return of 1
    35.395	called  packet vorbis_bitrate_flushpacket
    35.395	CVorbisEncoder::PacketOut packet of length 69 added to cache
    35.450	Called vorbis_analysis_buffer with int vals = 1024
    35.450	Called vorbis_analysis_wrote with vals = 1024
    35.575	Called vorbis_analysis_buffer with int vals = 1024
    35.575	Called vorbis_analysis_wrote with vals = 1024
    35.580	called vorbis_analysis_blockout with return of 1
    35.585	called  packet vorbis_bitrate_flushpacket
    35.585	CVorbisEncoder::PacketOut packet of length 59 added to cache
    35.585	called vorbis_analysis_blockout with return of 1
    35.610	called  packet vorbis_bitrate_flushpacket
    35.610	CVorbisEncoder::PacketOut packet of length 272 added to cache
    35.610	called vorbis_analysis_blockout with return of 1
    35.615	called  packet vorbis_bitrate_flushpacket
    35.615	CVorbisEncoder::PacketOut packet of length 65 added to cache
    35.615	called vorbis_analysis_blockout with return of 1
    35.620	called  packet vorbis_bitrate_flushpacket
    35.620	CVorbisEncoder::PacketOut packet of length 70 added to cache
    35.620	called vorbis_analysis_blockout with return of 1
    35.620	called  packet vorbis_bitrate_flushpacket
    35.620	CVorbisEncoder::PacketOut packet of length 51 added to cache
    35.620	called vorbis_analysis_blockout with return of 1
    35.625	called  packet vorbis_bitrate_flushpacket
    35.625	CVorbisEncoder::PacketOut packet of length 60 added to cache
    35.625	called vorbis_analysis_blockout with return of 1
    35.630	called  packet vorbis_bitrate_flushpacket
    35.630	CVorbisEncoder::PacketOut packet of length 68 added to cache
    35.705	Called vorbis_analysis_buffer with int vals = 1024
    35.705	Called vorbis_analysis_wrote with vals = 1024
    35.705	called vorbis_analysis_blockout with return of 1
    35.710	called  packet vorbis_bitrate_flushpacket
    35.710	CVorbisEncoder::PacketOut packet of length 68 added to cache
    35.710	PageLength 4233
    35.835	Called vorbis_analysis_buffer with int vals = 1024
    35.835	Called vorbis_analysis_wrote with vals = 1024
    35.840	called vorbis_analysis_blockout with return of 1
    35.865	called  packet vorbis_bitrate_flushpacket
    35.865	CVorbisEncoder::PacketOut packet of length 281 added to cache
    35.960	Called vorbis_analysis_buffer with int vals = 1024
    35.960	Called vorbis_analysis_wrote with vals = 1024
    35.965	called vorbis_analysis_blockout with return of 1
    35.990	called  packet vorbis_bitrate_flushpacket
    35.990	CVorbisEncoder::PacketOut packet of length 263 added to cache
    36.090	Called vorbis_analysis_buffer with int vals = 1024
    36.090	Called vorbis_analysis_wrote with vals = 1024
    36.090	called vorbis_analysis_blockout with return of 1
    36.115	called  packet vorbis_bitrate_flushpacket
    36.115	CVorbisEncoder::PacketOut packet of length 264 added to cache
    36.120	called vorbis_analysis_blockout with return of 1
    36.120	called  packet vorbis_bitrate_flushpacket
    36.120	CVorbisEncoder::PacketOut packet of length 67 added to cache
    36.120	called vorbis_analysis_blockout with return of 1
    36.125	called  packet vorbis_bitrate_flushpacket
    36.125	CVorbisEncoder::PacketOut packet of length 52 added to cache
    36.125	called vorbis_analysis_blockout with return of 1
    36.130	called  packet vorbis_bitrate_flushpacket
    36.130	CVorbisEncoder::PacketOut packet of length 57 added to cache
    36.130	called vorbis_analysis_blockout with return of 1
    36.130	called  packet vorbis_bitrate_flushpacket
    36.130	CVorbisEncoder::PacketOut packet of length 63 added to cache
    36.130	called vorbis_analysis_blockout with return of 1
    36.135	called  packet vorbis_bitrate_flushpacket
    36.135	CVorbisEncoder::PacketOut packet of length 62 added to cache
    36.135	called vorbis_analysis_blockout with return of 1
    36.140	called  packet vorbis_bitrate_flushpacket
    36.140	CVorbisEncoder::PacketOut packet of length 61 added to cache
    36.140	called vorbis_analysis_blockout with return of 1
    36.145	called  packet vorbis_bitrate_flushpacket
    36.145	CVorbisEncoder::PacketOut packet of length 69 added to cache
    36.145	called vorbis_analysis_blockout with return of 1
    36.150	called  packet vorbis_bitrate_flushpacket
    36.150	CVorbisEncoder::PacketOut packet of length 67 added to cache
    36.215	Called vorbis_analysis_buffer with int vals = 1024
    36.215	Called vorbis_analysis_wrote with vals = 1024
    36.345	Called vorbis_analysis_buffer with int vals = 1024
    36.345	Called vorbis_analysis_wrote with vals = 1024
    36.345	called vorbis_analysis_blockout with return of 1
    36.350	called  packet vorbis_bitrate_flushpacket
    36.350	CVorbisEncoder::PacketOut packet of length 63 added to cache
    36.470	Called vorbis_analysis_buffer with int vals = 1024
    36.470	Called vorbis_analysis_wrote with vals = 1024
    36.475	called vorbis_analysis_blockout with return of 1
    36.500	called  packet vorbis_bitrate_flushpacket
    36.500	CVorbisEncoder::PacketOut packet of length 268 added to cache
    36.500	called vorbis_analysis_blockout with return of 1
    36.525	called  packet vorbis_bitrate_flushpacket
    36.525	CVorbisEncoder::PacketOut packet of length 276 added to cache
    36.530	called vorbis_analysis_blockout with return of 1
    36.530	called  packet vorbis_bitrate_flushpacket
    36.530	CVorbisEncoder::PacketOut packet of length 68 added to cache
    36.530	called vorbis_analysis_blockout with return of 1
    36.535	called  packet vorbis_bitrate_flushpacket
    36.535	CVorbisEncoder::PacketOut packet of length 64 added to cache
    36.535	called vorbis_analysis_blockout with return of 1
    36.540	called  packet vorbis_bitrate_flushpacket
    36.540	CVorbisEncoder::PacketOut packet of length 69 added to cache
    36.540	called vorbis_analysis_blockout with return of 1
    36.545	called  packet vorbis_bitrate_flushpacket
    36.545	CVorbisEncoder::PacketOut packet of length 61 added to cache
    36.545	called vorbis_analysis_blockout with return of 1
    36.545	called  packet vorbis_bitrate_flushpacket
    36.545	CVorbisEncoder::PacketOut packet of length 68 added to cache
    36.600	Called vorbis_analysis_buffer with int vals = 1024
    36.600	Called vorbis_analysis_wrote with vals = 1024
    36.605	called vorbis_analysis_blockout with return of 1
    36.605	called  packet vorbis_bitrate_flushpacket
    36.605	CVorbisEncoder::PacketOut packet of length 56 added to cache
    36.730	Called vorbis_analysis_buffer with int vals = 1024
    36.730	Called vorbis_analysis_wrote with vals = 1024
    36.730	called vorbis_analysis_blockout with return of 1
    36.755	called  packet vorbis_bitrate_flushpacket
    36.755	CVorbisEncoder::PacketOut packet of length 270 added to cache
    36.855	Called vorbis_analysis_buffer with int vals = 1024
    36.855	Called vorbis_analysis_wrote with vals = 1024
    36.860	called vorbis_analysis_blockout with return of 1
    36.885	called  packet vorbis_bitrate_flushpacket
    36.885	CVorbisEncoder::PacketOut packet of length 255 added to cache
    36.985	Called vorbis_analysis_buffer with int vals = 1024
    36.985	Called vorbis_analysis_wrote with vals = 1024
    36.985	called vorbis_analysis_blockout with return of 1
    37.015	called  packet vorbis_bitrate_flushpacket
    37.015	CVorbisEncoder::PacketOut packet of length 269 added to cache
    37.110	Called vorbis_analysis_buffer with int vals = 1024
    37.115	Called vorbis_analysis_wrote with vals = 1024
    37.115	called vorbis_analysis_blockout with return of 1
    37.140	called  packet vorbis_bitrate_flushpacket
    37.140	CVorbisEncoder::PacketOut packet of length 262 added to cache
    37.240	Called vorbis_analysis_buffer with int vals = 1024
    37.240	Called vorbis_analysis_wrote with vals = 1024
    37.245	called vorbis_analysis_blockout with return of 1
    37.270	called  packet vorbis_bitrate_flushpacket
    37.270	CVorbisEncoder::PacketOut packet of length 249 added to cache
    37.370	Called vorbis_analysis_buffer with int vals = 1024
    37.370	Called vorbis_analysis_wrote with vals = 1024
    37.370	called vorbis_analysis_blockout with return of 1
    37.400	called  packet vorbis_bitrate_flushpacket
    37.400	CVorbisEncoder::PacketOut packet of length 254 added to cache
    37.495	Called vorbis_analysis_buffer with int vals = 1024
    37.495	Called vorbis_analysis_wrote with vals = 1024
    37.500	called vorbis_analysis_blockout with return of 1
    37.525	called  packet vorbis_bitrate_flushpacket
    37.525	CVorbisEncoder::PacketOut packet of length 261 added to cache
    37.525	PageLength 4176
    37.525	called vorbis_analysis_blockout with return of 1
    37.530	called  packet vorbis_bitrate_flushpacket
    37.530	CVorbisEncoder::PacketOut packet of length 67 added to cache
    37.530	called vorbis_analysis_blockout with return of 1
    37.535	called  packet vorbis_bitrate_flushpacket
    37.535	CVorbisEncoder::PacketOut packet of length 64 added to cache
    37.535	called vorbis_analysis_blockout with return of 1
    37.535	called  packet vorbis_bitrate_flushpacket
    37.535	CVorbisEncoder::PacketOut packet of length 64 added to cache
    37.535	called vorbis_analysis_blockout with return of 1
    37.540	called  packet vorbis_bitrate_flushpacket
    37.540	CVorbisEncoder::PacketOut packet of length 56 added to cache
    37.540	called vorbis_analysis_blockout with return of 1
    37.545	called  packet vorbis_bitrate_flushpacket
    37.545	CVorbisEncoder::PacketOut packet of length 63 added to cache
    37.545	called vorbis_analysis_blockout with return of 1
    37.545	called  packet vorbis_bitrate_flushpacket
    37.545	CVorbisEncoder::PacketOut packet of length 61 added to cache
    37.545	called vorbis_analysis_blockout with return of 1
    37.550	called  packet vorbis_bitrate_flushpacket
    37.550	CVorbisEncoder::PacketOut packet of length 69 added to cache
    37.550	called vorbis_analysis_blockout with return of 1
    37.555	called  packet vorbis_bitrate_flushpacket
    37.555	CVorbisEncoder::PacketOut packet of length 75 added to cache
    37.555	called vorbis_analysis_blockout with return of 1
    37.560	called  packet vorbis_bitrate_flushpacket
    37.560	CVorbisEncoder::PacketOut packet of length 59 added to cache
    37.625	Called vorbis_analysis_buffer with int vals = 1024
    37.625	Called vorbis_analysis_wrote with vals = 1024
    37.750	Called vorbis_analysis_buffer with int vals = 1024
    37.750	Called vorbis_analysis_wrote with vals = 1024
    37.755	called vorbis_analysis_blockout with return of 1
    37.760	called  packet vorbis_bitrate_flushpacket
    37.760	CVorbisEncoder::PacketOut packet of length 63 added to cache
    37.880	Called vorbis_analysis_buffer with int vals = 1024
    37.880	Called vorbis_analysis_wrote with vals = 1024
    37.885	called vorbis_analysis_blockout with return of 1
    37.910	called  packet vorbis_bitrate_flushpacket
    37.910	CVorbisEncoder::PacketOut packet of length 277 added to cache
    37.910	called vorbis_analysis_blockout with return of 1
    37.935	called  packet vorbis_bitrate_flushpacket
    37.935	CVorbisEncoder::PacketOut packet of length 267 added to cache
    37.935	called vorbis_analysis_blockout with return of 1
    37.940	called  packet vorbis_bitrate_flushpacket
    37.940	CVorbisEncoder::PacketOut packet of length 49 added to cache
    37.940	called vorbis_analysis_blockout with return of 1
    37.945	called  packet vorbis_bitrate_flushpacket
    37.945	CVorbisEncoder::PacketOut packet of length 54 added to cache
    37.945	called vorbis_analysis_blockout with return of 1
    37.945	called  packet vorbis_bitrate_flushpacket
    37.945	CVorbisEncoder::PacketOut packet of length 57 added to cache
    37.945	called vorbis_analysis_blockout with return of 1
    37.950	called  packet vorbis_bitrate_flushpacket
    37.950	CVorbisEncoder::PacketOut packet of length 72 added to cache
    37.950	called vorbis_analysis_blockout with return of 1
    37.955	called  packet vorbis_bitrate_flushpacket
    37.955	CVorbisEncoder::PacketOut packet of length 60 added to cache
    37.955	called vorbis_analysis_blockout with return of 1
    37.960	called  packet vorbis_bitrate_flushpacket
    37.960	CVorbisEncoder::PacketOut packet of length 65 added to cache
    38.010	Called vorbis_analysis_buffer with int vals = 1024
    38.010	Called vorbis_analysis_wrote with vals = 1024
    38.010	called vorbis_analysis_blockout with return of 1
    38.015	called  packet vorbis_bitrate_flushpacket
    38.015	CVorbisEncoder::PacketOut packet of length 60 added to cache
    38.135	Called vorbis_analysis_buffer with int vals = 1024
    38.135	Called vorbis_analysis_wrote with vals = 1024
    38.140	called vorbis_analysis_blockout with return of 1
    38.165	called  packet vorbis_bitrate_flushpacket
    38.165	CVorbisEncoder::PacketOut packet of length 282 added to cache
    38.165	called vorbis_analysis_blockout with return of 1
    38.170	called  packet vorbis_bitrate_flushpacket
    38.170	CVorbisEncoder::PacketOut packet of length 76 added to cache
    38.170	called vorbis_analysis_blockout with return of 1
    38.175	called  packet vorbis_bitrate_flushpacket
    38.175	CVorbisEncoder::PacketOut packet of length 76 added to cache
    38.175	called vorbis_analysis_blockout with return of 1
    38.175	called  packet vorbis_bitrate_flushpacket
    38.175	CVorbisEncoder::PacketOut packet of length 64 added to cache
    38.265	Called vorbis_analysis_buffer with int vals = 1024
    38.265	Called vorbis_analysis_wrote with vals = 1024
    38.265	called vorbis_analysis_blockout with return of 1
    38.270	called  packet vorbis_bitrate_flushpacket
    38.270	CVorbisEncoder::PacketOut packet of length 65 added to cache
    38.270	called vorbis_analysis_blockout with return of 1
    38.295	called  packet vorbis_bitrate_flushpacket
    38.295	CVorbisEncoder::PacketOut packet of length 273 added to cache
    38.295	called vorbis_analysis_blockout with return of 1
    38.300	called  packet vorbis_bitrate_flushpacket
    38.300	CVorbisEncoder::PacketOut packet of length 65 added to cache
    38.300	called vorbis_analysis_blockout with return of 1
    38.305	called  packet vorbis_bitrate_flushpacket
    38.305	CVorbisEncoder::PacketOut packet of length 67 added to cache
    38.390	Called vorbis_analysis_buffer with int vals = 1024
    38.390	Called vorbis_analysis_wrote with vals = 1024
    38.395	called vorbis_analysis_blockout with return of 1
    38.400	called  packet vorbis_bitrate_flushpacket
    38.400	CVorbisEncoder::PacketOut packet of length 63 added to cache
    38.520	Called vorbis_analysis_buffer with int vals = 1024
    38.520	Called vorbis_analysis_wrote with vals = 1024
    38.525	called vorbis_analysis_blockout with return of 1
    38.550	called  packet vorbis_bitrate_flushpacket
    38.550	CVorbisEncoder::PacketOut packet of length 261 added to cache
    38.650	Called vorbis_analysis_buffer with int vals = 1024
    38.650	Called vorbis_analysis_wrote with vals = 1024
    38.650	called vorbis_analysis_blockout with return of 1
    38.675	called  packet vorbis_bitrate_flushpacket
    38.675	CVorbisEncoder::PacketOut packet of length 250 added to cache
    38.775	Called vorbis_analysis_buffer with int vals = 1024
    38.775	Called vorbis_analysis_wrote with vals = 1024
    38.780	called vorbis_analysis_blockout with return of 1
    38.805	called  packet vorbis_bitrate_flushpacket
    38.805	CVorbisEncoder::PacketOut packet of length 254 added to cache
    38.905	Called vorbis_analysis_buffer with int vals = 1024
    38.905	Called vorbis_analysis_wrote with vals = 1024
    38.905	called vorbis_analysis_blockout with return of 1
    38.935	called  packet vorbis_bitrate_flushpacket
    38.935	CVorbisEncoder::PacketOut packet of length 263 added to cache
    38.935	called vorbis_analysis_blockout with return of 1
    38.960	called  packet vorbis_bitrate_flushpacket
    38.960	CVorbisEncoder::PacketOut packet of length 279 added to cache
    38.960	called vorbis_analysis_blockout with return of 1
    38.965	called  packet vorbis_bitrate_flushpacket
    38.965	CVorbisEncoder::PacketOut packet of length 55 added to cache
    38.965	called vorbis_analysis_blockout with return of 1
    38.965	called  packet vorbis_bitrate_flushpacket
    38.965	CVorbisEncoder::PacketOut packet of length 60 added to cache
    39.030	Called vorbis_analysis_buffer with int vals = 1024
    39.035	Called vorbis_analysis_wrote with vals = 1024
    39.035	called vorbis_analysis_blockout with return of 1
    39.040	called  packet vorbis_bitrate_flushpacket
    39.040	CVorbisEncoder::PacketOut packet of length 70 added to cache
    39.040	PageLength 4202
    39.160	Called vorbis_analysis_buffer with int vals = 1024
    39.160	Called vorbis_analysis_wrote with vals = 1024
    39.165	called vorbis_analysis_blockout with return of 1
    39.165	called  packet vorbis_bitrate_flushpacket
    39.165	CVorbisEncoder::PacketOut packet of length 64 added to cache
    39.165	called vorbis_analysis_blockout with return of 1
    39.170	called  packet vorbis_bitrate_flushpacket
    39.170	CVorbisEncoder::PacketOut packet of length 69 added to cache
    39.170	called vorbis_analysis_blockout with return of 1
    39.175	called  packet vorbis_bitrate_flushpacket
    39.175	CVorbisEncoder::PacketOut packet of length 57 added to cache
    39.175	called vorbis_analysis_blockout with return of 1
    39.180	called  packet vorbis_bitrate_flushpacket
    39.180	CVorbisEncoder::PacketOut packet of length 56 added to cache
    39.180	called vorbis_analysis_blockout with return of 1
    39.185	called  packet vorbis_bitrate_flushpacket
    39.185	CVorbisEncoder::PacketOut packet of length 69 added to cache
    39.185	called vorbis_analysis_blockout with return of 1
    39.185	called  packet vorbis_bitrate_flushpacket
    39.185	CVorbisEncoder::PacketOut packet of length 61 added to cache
    39.185	called vorbis_analysis_blockout with return of 1
    39.190	called  packet vorbis_bitrate_flushpacket
    39.190	CVorbisEncoder::PacketOut packet of length 74 added to cache
    39.190	called vorbis_analysis_blockout with return of 1
    39.195	called  packet vorbis_bitrate_flushpacket
    39.195	CVorbisEncoder::PacketOut packet of length 53 added to cache
    39.195	called vorbis_analysis_blockout with return of 1
    39.200	called  packet vorbis_bitrate_flushpacket
    39.200	CVorbisEncoder::PacketOut packet of length 76 added to cache
    39.200	called vorbis_analysis_blockout with return of 1
    39.200	called  packet vorbis_bitrate_flushpacket
    39.200	CVorbisEncoder::PacketOut packet of length 62 added to cache
    39.290	Called vorbis_analysis_buffer with int vals = 1024
    39.290	Called vorbis_analysis_wrote with vals = 1024
    39.290	called vorbis_analysis_blockout with return of 1
    39.295	called  packet vorbis_bitrate_flushpacket
    39.295	CVorbisEncoder::PacketOut packet of length 66 added to cache
    39.295	called vorbis_analysis_blockout with return of 1
    39.300	called  packet vorbis_bitrate_flushpacket
    39.300	CVorbisEncoder::PacketOut packet of length 55 added to cache
    39.300	called vorbis_analysis_blockout with return of 1
    39.305	called  packet vorbis_bitrate_flushpacket
    39.305	CVorbisEncoder::PacketOut packet of length 66 added to cache
    39.305	called vorbis_analysis_blockout with return of 1
    39.305	called  packet vorbis_bitrate_flushpacket
    39.305	CVorbisEncoder::PacketOut packet of length 72 added to cache
    39.305	called vorbis_analysis_blockout with return of 1
    39.310	called  packet vorbis_bitrate_flushpacket
    39.310	CVorbisEncoder::PacketOut packet of length 52 added to cache
    39.310	called vorbis_analysis_blockout with return of 1
    39.315	called  packet vorbis_bitrate_flushpacket
    39.315	CVorbisEncoder::PacketOut packet of length 63 added to cache
    39.415	Called vorbis_analysis_buffer with int vals = 1024
    39.415	Called vorbis_analysis_wrote with vals = 1024
    39.420	called vorbis_analysis_blockout with return of 1
    39.425	called  packet vorbis_bitrate_flushpacket
    39.425	CVorbisEncoder::PacketOut packet of length 64 added to cache
    39.425	called vorbis_analysis_blockout with return of 1
    39.450	called  packet vorbis_bitrate_flushpacket
    39.450	CVorbisEncoder::PacketOut packet of length 260 added to cache
    39.450	called vorbis_analysis_blockout with return of 1
    39.455	called  packet vorbis_bitrate_flushpacket
    39.455	CVorbisEncoder::PacketOut packet of length 67 added to cache
    39.455	called vorbis_analysis_blockout with return of 1
    39.455	called  packet vorbis_bitrate_flushpacket
    39.455	CVorbisEncoder::PacketOut packet of length 66 added to cache
    39.545	Called vorbis_analysis_buffer with int vals = 1024
    39.545	Called vorbis_analysis_wrote with vals = 1024
    39.545	called vorbis_analysis_blockout with return of 1
    39.550	called  packet vorbis_bitrate_flushpacket
    39.550	CVorbisEncoder::PacketOut packet of length 62 added to cache
    39.550	called vorbis_analysis_blockout with return of 1
    39.555	called  packet vorbis_bitrate_flushpacket
    39.555	CVorbisEncoder::PacketOut packet of length 57 added to cache
    39.555	called vorbis_analysis_blockout with return of 1
    39.560	called  packet vorbis_bitrate_flushpacket
    39.560	CVorbisEncoder::PacketOut packet of length 65 added to cache
    39.560	called vorbis_analysis_blockout with return of 1
    39.565	called  packet vorbis_bitrate_flushpacket
    39.565	CVorbisEncoder::PacketOut packet of length 61 added to cache
    39.565	called vorbis_analysis_blockout with return of 1
    39.565	called  packet vorbis_bitrate_flushpacket
    39.565	CVorbisEncoder::PacketOut packet of length 61 added to cache
    39.565	called vorbis_analysis_blockout with return of 1
    39.570	called  packet vorbis_bitrate_flushpacket
    39.570	CVorbisEncoder::PacketOut packet of length 48 added to cache
    39.570	called vorbis_analysis_blockout with return of 1
    39.575	called  packet vorbis_bitrate_flushpacket
    39.575	CVorbisEncoder::PacketOut packet of length 58 added to cache
    39.575	called vorbis_analysis_blockout with return of 1
    39.580	called  packet vorbis_bitrate_flushpacket
    39.580	CVorbisEncoder::PacketOut packet of length 58 added to cache
    39.670	Called vorbis_analysis_buffer with int vals = 1024
    39.670	Called vorbis_analysis_wrote with vals = 1024
    39.675	called vorbis_analysis_blockout with return of 1
    39.680	called  packet vorbis_bitrate_flushpacket
    39.680	CVorbisEncoder::PacketOut packet of length 59 added to cache
    39.800	Called vorbis_analysis_buffer with int vals = 1024
    39.800	Called vorbis_analysis_wrote with vals = 1024
    39.805	called vorbis_analysis_blockout with return of 1
    39.830	called  packet vorbis_bitrate_flushpacket
    39.830	CVorbisEncoder::PacketOut packet of length 256 added to cache
    39.830	called vorbis_analysis_blockout with return of 1
    39.830	called  packet vorbis_bitrate_flushpacket
    39.830	CVorbisEncoder::PacketOut packet of length 60 added to cache
    39.835	called vorbis_analysis_blockout with return of 1
    39.835	called  packet vorbis_bitrate_flushpacket
    39.835	CVorbisEncoder::PacketOut packet of length 70 added to cache
    39.835	called vorbis_analysis_blockout with return of 1
    39.840	called  packet vorbis_bitrate_flushpacket
    39.840	CVorbisEncoder::PacketOut packet of length 81 added to cache
    39.840	called vorbis_analysis_blockout with return of 1
    39.845	called  packet vorbis_bitrate_flushpacket
    39.845	CVorbisEncoder::PacketOut packet of length 66 added to cache
    39.845	called vorbis_analysis_blockout with return of 1
    39.850	called  packet vorbis_bitrate_flushpacket
    39.850	CVorbisEncoder::PacketOut packet of length 69 added to cache
    39.930	Called vorbis_analysis_buffer with int vals = 1024
    39.930	Called vorbis_analysis_wrote with vals = 1024
    39.930	called vorbis_analysis_blockout with return of 1
    39.935	called  packet vorbis_bitrate_flushpacket
    39.935	CVorbisEncoder::PacketOut packet of length 61 added to cache
    39.935	called vorbis_analysis_blockout with return of 1
    39.940	called  packet vorbis_bitrate_flushpacket
    39.940	CVorbisEncoder::PacketOut packet of length 58 added to cache
    39.940	called vorbis_analysis_blockout with return of 1
    39.945	called  packet vorbis_bitrate_flushpacket
    39.945	CVorbisEncoder::PacketOut packet of length 68 added to cache
    39.945	called vorbis_analysis_blockout with return of 1
    39.945	called  packet vorbis_bitrate_flushpacket
    39.945	CVorbisEncoder::PacketOut packet of length 67 added to cache
    39.945	called vorbis_analysis_blockout with return of 1
    39.950	called  packet vorbis_bitrate_flushpacket
    39.950	CVorbisEncoder::PacketOut packet of length 63 added to cache
    39.950	called vorbis_analysis_blockout with return of 1
    39.955	called  packet vorbis_bitrate_flushpacket
    39.955	CVorbisEncoder::PacketOut packet of length 51 added to cache
    39.955	called vorbis_analysis_blockout with return of 1
    39.960	called  packet vorbis_bitrate_flushpacket
    39.960	CVorbisEncoder::PacketOut packet of length 56 added to cache
    39.960	called vorbis_analysis_blockout with return of 1
    39.960	called  packet vorbis_bitrate_flushpacket
    39.960	CVorbisEncoder::PacketOut packet of length 58 added to cache
    39.960	called vorbis_analysis_blockout with return of 1
    39.965	called  packet vorbis_bitrate_flushpacket
    39.965	CVorbisEncoder::PacketOut packet of length 66 added to cache
    39.965	called vorbis_analysis_blockout with return of 1
    39.970	called  packet vorbis_bitrate_flushpacket
    39.970	CVorbisEncoder::PacketOut packet of length 66 added to cache
    40.055	Called vorbis_analysis_buffer with int vals = 1024
    40.055	Called vorbis_analysis_wrote with vals = 1024
    40.060	called vorbis_analysis_blockout with return of 1
    40.065	called  packet vorbis_bitrate_flushpacket
    40.065	CVorbisEncoder::PacketOut packet of length 63 added to cache
    40.065	called vorbis_analysis_blockout with return of 1
    40.065	called  packet vorbis_bitrate_flushpacket
    40.065	CVorbisEncoder::PacketOut packet of length 51 added to cache
    40.065	called vorbis_analysis_blockout with return of 1
    40.070	called  packet vorbis_bitrate_flushpacket
    40.070	CVorbisEncoder::PacketOut packet of length 54 added to cache
    40.070	called vorbis_analysis_blockout with return of 1
    40.075	called  packet vorbis_bitrate_flushpacket
    40.075	CVorbisEncoder::PacketOut packet of length 56 added to cache
    40.075	called vorbis_analysis_blockout with return of 1
    40.080	called  packet vorbis_bitrate_flushpacket
    40.080	CVorbisEncoder::PacketOut packet of length 62 added to cache
    40.080	called vorbis_analysis_blockout with return of 1
    40.080	called  packet vorbis_bitrate_flushpacket
    40.080	CVorbisEncoder::PacketOut packet of length 58 added to cache
    40.080	called vorbis_analysis_blockout with return of 1
    40.085	called  packet vorbis_bitrate_flushpacket
    40.085	CVorbisEncoder::PacketOut packet of length 57 added to cache
    40.085	called vorbis_analysis_blockout with return of 1
    40.090	called  packet vorbis_bitrate_flushpacket
    40.090	CVorbisEncoder::PacketOut packet of length 68 added to cache
    40.090	called vorbis_analysis_blockout with return of 1
    40.095	called  packet vorbis_bitrate_flushpacket
    40.095	CVorbisEncoder::PacketOut packet of length 63 added to cache
    40.095	called vorbis_analysis_blockout with return of 1
    40.100	called  packet vorbis_bitrate_flushpacket
    40.100	CVorbisEncoder::PacketOut packet of length 63 added to cache
    40.100	called vorbis_analysis_blockout with return of 1
    40.100	called  packet vorbis_bitrate_flushpacket
    40.100	CVorbisEncoder::PacketOut packet of length 69 added to cache
    40.100	called vorbis_analysis_blockout with return of 1
    40.105	called  packet vorbis_bitrate_flushpacket
    40.105	CVorbisEncoder::PacketOut packet of length 59 added to cache
    40.185	Called vorbis_analysis_buffer with int vals = 1024
    40.185	Called vorbis_analysis_wrote with vals = 1024
    40.310	Called vorbis_analysis_buffer with int vals = 1024
    40.315	Called vorbis_analysis_wrote with vals = 1024
    40.315	called vorbis_analysis_blockout with return of 1
    40.320	called  packet vorbis_bitrate_flushpacket
    40.320	CVorbisEncoder::PacketOut packet of length 67 added to cache
    40.320	called vorbis_analysis_blockout with return of 1
    40.345	called  packet vorbis_bitrate_flushpacket
    40.345	CVorbisEncoder::PacketOut packet of length 254 added to cache
    40.345	PageLength 4349
    40.345	called vorbis_analysis_blockout with return of 1
    40.350	called  packet vorbis_bitrate_flushpacket
    40.350	CVorbisEncoder::PacketOut packet of length 54 added to cache
    40.350	called vorbis_analysis_blockout with return of 1
    40.355	called  packet vorbis_bitrate_flushpacket
    40.355	CVorbisEncoder::PacketOut packet of length 52 added to cache
    40.355	called vorbis_analysis_blockout with return of 1
    40.355	called  packet vorbis_bitrate_flushpacket
    40.355	CVorbisEncoder::PacketOut packet of length 54 added to cache
    40.355	called vorbis_analysis_blockout with return of 1
    40.360	called  packet vorbis_bitrate_flushpacket
    40.360	CVorbisEncoder::PacketOut packet of length 70 added to cache
    40.360	called vorbis_analysis_blockout with return of 1
    40.365	called  packet vorbis_bitrate_flushpacket
    40.365	CVorbisEncoder::PacketOut packet of length 64 added to cache
    40.440	Called vorbis_analysis_buffer with int vals = 1024
    40.440	Called vorbis_analysis_wrote with vals = 1024
    40.445	called vorbis_analysis_blockout with return of 1
    40.445	called  packet vorbis_bitrate_flushpacket
    40.445	CVorbisEncoder::PacketOut packet of length 58 added to cache
    40.570	Called vorbis_analysis_buffer with int vals = 1024
    40.570	Called vorbis_analysis_wrote with vals = 1024
    40.570	called vorbis_analysis_blockout with return of 1
    40.595	called  packet vorbis_bitrate_flushpacket
    40.595	CVorbisEncoder::PacketOut packet of length 263 added to cache
    40.695	Called vorbis_analysis_buffer with int vals = 1024
    40.695	Called vorbis_analysis_wrote with vals = 1024
    40.700	called vorbis_analysis_blockout with return of 1
    40.725	called  packet vorbis_bitrate_flushpacket
    40.725	CVorbisEncoder::PacketOut packet of length 262 added to cache
    40.725	called vorbis_analysis_blockout with return of 1
    40.730	called  packet vorbis_bitrate_flushpacket
    40.730	CVorbisEncoder::PacketOut packet of length 72 added to cache
    40.730	called vorbis_analysis_blockout with return of 1
    40.735	called  packet vorbis_bitrate_flushpacket
    40.735	CVorbisEncoder::PacketOut packet of length 73 added to cache
    40.735	called vorbis_analysis_blockout with return of 1
    40.740	called  packet vorbis_bitrate_flushpacket
    40.740	CVorbisEncoder::PacketOut packet of length 76 added to cache
    40.740	called vorbis_analysis_blockout with return of 1
    40.740	called  packet vorbis_bitrate_flushpacket
    40.740	CVorbisEncoder::PacketOut packet of length 62 added to cache
    40.740	called vorbis_analysis_blockout with return of 1
    40.745	called  packet vorbis_bitrate_flushpacket
    40.745	CVorbisEncoder::PacketOut packet of length 68 added to cache
    40.745	called vorbis_analysis_blockout with return of 1
    40.750	called  packet vorbis_bitrate_flushpacket
    40.750	CVorbisEncoder::PacketOut packet of length 65 added to cache
    40.825	Called vorbis_analysis_buffer with int vals = 1024
    40.825	Called vorbis_analysis_wrote with vals = 1024
    40.825	called vorbis_analysis_blockout with return of 1
    40.830	called  packet vorbis_bitrate_flushpacket
    40.830	CVorbisEncoder::PacketOut packet of length 62 added to cache
    40.955	Called vorbis_analysis_buffer with int vals = 1024
    40.955	Called vorbis_analysis_wrote with vals = 1024
    40.955	called vorbis_analysis_blockout with return of 1
    40.985	called  packet vorbis_bitrate_flushpacket
    40.985	CVorbisEncoder::PacketOut packet of length 266 added to cache
    40.985	called vorbis_analysis_blockout with return of 1
    41.010	called  packet vorbis_bitrate_flushpacket
    41.010	CVorbisEncoder::PacketOut packet of length 275 added to cache
    41.010	called vorbis_analysis_blockout with return of 1
    41.015	called  packet vorbis_bitrate_flushpacket
    41.015	CVorbisEncoder::PacketOut packet of length 70 added to cache
    41.015	called vorbis_analysis_blockout with return of 1
    41.020	called  packet vorbis_bitrate_flushpacket
    41.020	CVorbisEncoder::PacketOut packet of length 64 added to cache
    41.080	Called vorbis_analysis_buffer with int vals = 1024
    41.080	Called vorbis_analysis_wrote with vals = 1024
    41.205	Called vorbis_analysis_buffer with int vals = 512
    41.205	Called vorbis_analysis_wrote with vals = 512
    41.205	called vorbis_analysis_blockout with return of 1
    41.210	called  packet vorbis_bitrate_flushpacket
    41.210	CVorbisEncoder::PacketOut packet of length 72 added to cache
-------------- next part --------------
PlatSecEnforcement ON
PlatSecDiagnostics ON
PlatSecProcessIsolation ON
PlatSecEnforceSysBin ON
PlatSecDisabledCaps NONE
     0.000	Thread 00bdd880 created @ 0xbdd880 - Win32 Thread ID 0x900
     0.000	Thread EKern.exe::Supervisor created @ 0xcd3400 - Win32 Thread ID 0x244
     0.000	Thread EKern.exe::DfcThread0 created @ 0xcd3ea8 - Win32 Thread ID 0x7b8
     0.000	Thread EKern.exe::DfcThread1 created @ 0xcd42bc - Win32 Thread ID 0x7bc
     0.000	Thread EKern.exe::TimerThread created @ 0xcd4b70 - Win32 Thread ID 0x140
     0.015	Thread EKern.exe::FlashThread created @ 0xcd5910 - Win32 Thread ID 0x8d0
     0.030	Thread EKern.exe::MultiMediaCard0 created @ 0xcd67e4 - Win32 Thread ID 0x8c8
     0.110	Thread EKern.exe::NandThread created @ 0xcda360 - Win32 Thread ID 0x8cc
     0.115	Thread EFile.exe::Main created @ 0xcdb0f8 - Win32 Thread ID 0x8c4
     0.140	Thread EFile.exe::Local-00ce24e8 created @ 0xce27a0 - Win32 Thread ID 0xe8
     0.140	Thread EFile.exe::LoaderThread created @ 0xce8f6c - Win32 Thread ID 0x78c
     0.140	Thread EFile.exe::StartupThread created @ 0xce9468 - Win32 Thread ID 0x730
     0.540	Thread E32STRT.EXE::Main created @ 0xcf343c - Win32 Thread ID 0x410
     0.560	Thread EFile.exe::Local-00cf39f4 created @ 0xcf3cac - Win32 Thread ID 0x730
     0.580	Thread EFile.exe::Local-00cf5288 created @ 0xcf5540 - Win32 Thread ID 0x748
     0.580	Thread EFile.exe::Local-00cf58f0 created @ 0xcf5ba8 - Win32 Thread ID 0x894
     0.590	Thread EFile.exe::Local-00cf6130 created @ 0xcf63e8 - Win32 Thread ID 0x8c0
     1.010	Thread EFile.exe::Local-00cf68a0 created @ 0xcf6b58 - Win32 Thread ID 0x308
     1.015	Thread EFile.exe::Local-00cf7018 created @ 0xcf72d0 - Win32 Thread ID 0x7c8
     1.015	Thread EFile.exe::ReclaimThread_49634464 created @ 0xcf7fa0 - Win32 Thread ID 0x6bc
     1.635	Thread EFile.exe::InitCompleteThread created @ 0xcf8ccc - Win32 Thread ID 0x7e0
     1.675	Thread domainSrv.exe::Main created @ 0xcf94bc - Win32 Thread ID 0x7e0
     1.705	Thread SYSSTART.EXE::Main created @ 0xcfb0c0 - Win32 Thread ID 0x79c
     1.710	SysStart: using resource file Z:\private\10205C44\SSCForStartupMode0.rsc
     1.710	SysStart: Send state transition request (move to Critical Static) to domain manager
     1.710	SysStart: Result of state transition request is 0
     1.710	SysStart: starting Z:\sys\bin\SysAgt2Svr.exe 
     1.725	Thread SysAgt2Svr.exe::Main created @ 0xcfbb44 - Win32 Thread ID 0x7e4
     1.725	SysStart: waiting on process ...
     1.730	SysStart: done. [0]
     1.730	SysStart: starting Z:\sys\bin\fbserv.exe 
     1.755	Thread fbserv.exe::Main created @ 0xcfd07c - Win32 Thread ID 0x7e4
     1.755	SysStart: waiting on process ...
     1.785	Thread ecomserver.EXE::Main created @ 0xcfe39c - Win32 Thread ID 0x848
     2.195	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\EON14.GDR
     2.195	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\fnt.ttf
     2.200	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NCRBIU.TTF
     2.200	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NCRBRU.TTF
     2.205	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NCRRIU.TTF
     2.210	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NCRRRU.TTF
     2.215	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NTMBIU.TTF
     2.215	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NTMBRU.TTF
     2.220	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NTMRIU.TTF
     2.225	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\NTMRRU.TTF
     2.230	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\SWABIU.TTF
     2.235	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\SWABRU.TTF
     2.240	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\SWARIU.TTF
     2.245	FBServ::LoadFontsL loaded font filename: Z:\resource\fonts\SWARRU.TTF
     2.250	SysStart: done. [0]
     2.250	SysStart: starting Z:\sys\bin\wserv.exe -NoShell
     2.345	Thread wserv.exe::Main created @ 0xd001dc - Win32 Thread ID 0x854
     2.345	SysStart: waiting on process ...
     2.385	Thread MMFAudioServer.exe::Main created @ 0xd01874 - Win32 Thread ID 0x810
     2.385	Thread MMFAudioServer.exe::Local-00d009ec created @ 0xd00ca4 - Win32 Thread ID 0x69c
     2.475	Thread MMFAudioServer.exe::Local-00d019a0 created @ 0xd01c58 - Win32 Thread ID 0x750
     2.485	Thread MMFAudioServer.exe::Local-00d02790 created @ 0xd02a48 - Win32 Thread ID 0x724
     2.810	SysStart: done. [0]
     2.810	SysStart: Start splash screen Z:\sys\bin\splash.exe
     2.830	Thread splash.exe::Main created @ 0xd38144 - Win32 Thread ID 0x7fc
     2.830	SysStart: starting Z:\sys\bin\eiksrvs.exe -OnlyStartDependentServers
     2.855	Thread eiksrvs.exe::Main created @ 0xd3bc40 - Win32 Thread ID 0x6e0
     2.860	SysStart: waiting on process ...
     2.945	Thread centralrepositorysrv.EXE::Main created @ 0xd3a688 - Win32 Thread ID 0x2b4
     3.055	Thread Fepswitch.exe::Main created @ 0xd3db34 - Win32 Thread ID 0x89c
     3.085	Thread eiksrvs.exe::ViewServerThread created @ 0xd3bfb0 - Win32 Thread ID 0x790
     3.125	Thread FLOGSVR.EXE::Main created @ 0xd3d620 - Win32 Thread ID 0x740
     3.355	SysStart: done. [0]
     3.355	SysStart: starting Z:\sys\bin\sisregistryserver.exe 
     3.390	Thread sisregistryserver.exe::Main created @ 0xd40ac8 - Win32 Thread ID 0x77c
     3.390	SysStart: waiting on process ...
     3.420	SysStart: done. [0]
     3.420	SysStart: starting Z:\sys\bin\tzserver.exe 
     3.450	Thread tzserver.exe::Main created @ 0xd41190 - Win32 Thread ID 0x7a0
     3.450	SysStart: waiting on process ...
     3.450	SysStart: done. [0]
     3.455	SysStart: Send state transition request (move to Critical Dynamic) to domain manager
     3.455	SysStart: Result of state transition request is 0
     3.455	SysStart: starting Z:\sys\bin\apsexe.exe 
     3.470	Thread apsexe.exe::Main created @ 0xd42c00 - Win32 Thread ID 0x768
     3.470	SysStart: waiting on process ...
     3.495	Thread baksrvs.EXE::Main created @ 0xd43464 - Win32 Thread ID 0x8d8
     3.680	SysStart: done. [0]
     3.680	SysStart: starting Z:\sys\bin\shell.exe 
     3.770	Thread shell.exe::Main created @ 0xd4b4c8 - Win32 Thread ID 0x7b4
     3.770	SysStart: checking status of deferred command shell
     3.910	Thread shutdownsrvs.EXE::Main created @ 0xd48f98 - Win32 Thread ID 0x794
     4.020	Thread System::SystemServerThread created @ 0xd4a040 - Win32 Thread ID 0x884
     4.070	SysStart: successful rendezvous of deferred command shell 
     4.070	SysStart: Kill splash screen
     4.115	SysStart: Send state transition request (move to Networking-Critical) to domain manager
     4.150	Thread RTAServer.EXE::Main created @ 0xd4bdf4 - Win32 Thread ID 0x7fc
     4.155	SysStart: Result of state transition request is 0
     4.155	SysStart: starting Z:\sys\bin\c32start.exe 
     4.180	Thread c32start.exe::Main created @ 0xd4c850 - Win32 Thread ID 0x800
     4.180	SysStart: waiting on process ...
     4.205	Thread COMSDBGSVR.EXE::Main created @ 0xd4d090 - Win32 Thread ID 0x728
     4.215	Thread COMSDBGSVR.EXE::Comsdbg2 created @ 0xd4d8f0 - Win32 Thread ID 0x814
     4.230	Thread c32exe.exe::Main created @ 0xd4f248 - Win32 Thread ID 0x468
     4.230	SysStart: done. [0]
     4.230	SysStart: starting Z:\sys\bin\msexe.exe 
     4.250	Thread msexe.exe::Main created @ 0xd5013c - Win32 Thread ID 0x7d4
     4.250	SysStart: waiting on process ...
     4.355	SysStart: done. [0]
     4.355	SysStart: starting Z:\sys\bin\watcher.exe 
     4.355	Thread watcher.exe::Main created @ 0xd53ce4 - Win32 Thread ID 0x804
     4.360	SysStart: waiting on process ...
     4.365	Thread watcher.exe::WatcherMainThread created @ 0xd54150 - Win32 Thread ID 0x764
     4.375	Thread c32exe.exe::ESock_Main created @ 0xd55374 - Win32 Thread ID 0x7cc
     4.390	Thread c32exe.exe::CCommServer created @ 0xd55be8 - Win32 Thread ID 0x59c
     4.395	Thread c32exe.exe::CTelServer created @ 0xd566b0 - Win32 Thread ID 0x71c
     4.400	Thread c32exe.exe::ESock_SIP created @ 0xd56ecc - Win32 Thread ID 0x774
     4.440	Thread c32exe.exe::ESock_SmsWap created @ 0xd58e54 - Win32 Thread ID 0x5b4
     4.565	SysStart: done. [0]
     4.565	SysStart: Send state transition request (move to Non-critical) to domain manager
     4.585	Thread c32exe.exe::SimTsyCPM created @ 0xd5bdec - Win32 Thread ID 0x340
     4.585	Thread c32exe.exe::ESock_IP created @ 0xd5c474 - Win32 Thread ID 0x340
     4.675	Thread c32exe.exe::ESock_Bt created @ 0xd5fd70 - Win32 Thread ID 0x624
     4.680	Thread c32exe.exe::ESock_Ir created @ 0xd60488 - Win32 Thread ID 0x81c
     4.900	Thread LogServ.EXE::Main created @ 0xd66ecc - Win32 Thread ID 0x760
     5.645	SysStart: Result of state transition request is 0
     5.645	SysStart: starting Z:\sys\bin\SystemAMS.exe -boot
     5.660	Thread SystemAMS.exe::Main created @ 0xd6d10c - Win32 Thread ID 0x77c
     5.660	SysStart: starting Z:\sys\bin\swidaemon.exe 
     5.685	Thread swidaemon.exe::Main created @ 0xd6f534 - Win32 Thread ID 0x7ac
     5.685	SysStart: waiting on process ...
     5.760	Thread SisRegistryServer.EXE::Main created @ 0xd7087c - Win32 Thread ID 0x770
     5.795	SysStart: done. [0]
     5.795	SysStart: starting Z:\sys\bin\cntsrv.exe -nontransient
     5.835	Thread cntsrv.exe::Main created @ 0xd70e14 - Win32 Thread ID 0x604
     5.835	SysStart: starting Z:\sys\bin\agsvexe.exe -nontransient
     5.855	Thread agsvexe.exe::Main created @ 0xd71c04 - Win32 Thread ID 0x630
     5.915	Thread SystemAMS.exe::Security2.Thread created @ 0xcfb0c0 - Win32 Thread ID 0x79c
     6.210	Thread SystemAMS.exe::!MIDP.SystemAMS.Connection.ServerThread created @ 0xd74658 - Win32 Thread ID 0x278
     6.210	Thread SystemAMS.exe::MIDP2.CHS.Thread created @ 0xd75748 - Win32 Thread ID 0x858
     6.230	Thread EDBSRV.EXE::Main created @ 0xd76154 - Win32 Thread ID 0x7b0
     7.000	Thread dnd.exe::Main created @ 0xd7aee0 - Win32 Thread ID 0x7f4
     7.200	Thread SystemAMS.exe::MIDP2.LifecycleV2.Thread created @ 0xd7b848 - Win32 Thread ID 0x490
     7.215	Thread SystemAMS.exe::MIDP2.CMS.Thread created @ 0xd7bbb8 - Win32 Thread ID 0x784
     7.215	Thread SystemAMS.exe::MIDP2.CID.Thread created @ 0xd7c194 - Win32 Thread ID 0x73c
     7.225	Thread Audio.exe::Main created @ 0xd80a54 - Win32 Thread ID 0x1f8
    10.620	*PlatSec* ERROR - Capability check failed - A Message (function number=0x00000031) from Thread Sound Rec[001f4119]0001::Sound Rec, sent to Server !FileServer, was checked by Thread EFile.exe[100039e3]0001::Main and was found to be missing the capabilities: AllFiles .  Additional diagnostic message: \private\* Used to call: Dir Open
    10.620	*PlatSec* ERROR - Capability check failed - A Message (function number=0x00000031) from Thread Sound Rec[001f4119]0001::Sound Rec, sent to Server !FileServer, was checked by Thread EFile.exe[100039e3]0001::Main and was found to be missing the capabilities: AllFiles .  Additional diagnostic message: \sys\* Used to call: Dir Open
    16.235	Thread Sound Rec::MMFControllerProxyServer8261947e created @ 0xd048a4 - Win32 Thread ID 0x7b0
    16.240	COggRecordController::NewL
    16.250	Thread MMFAudioServer.exe::Local-00d04c24 created @ 0xd04edc - Win32 Thread ID 0x770
    16.270	Thread Sound Rec::MMFControllerProxyServer2cb5f5fd created @ 0xd05ed4 - Win32 Thread ID 0x778
    16.285	Thread MMFAudioServer.exe::Local-00d065b8 created @ 0xd06870 - Win32 Thread ID 0x864
    17.755	CVorbisHwDeviceWrapper2::NewL
    17.755	CVorbisEncoderPlugIn::NewL
    17.755	CVorbisHwDeviceWrapper2::Codec
    18.065	COggRecordController::PlayL
    18.780	HeaderPageLength 58
    18.780	HeaderPageLength 4206
    18.780	HeaderPageLength 90
    18.840	PageLength in controller 4354 bytes
    19.800	PageLength 4235
    19.855	PageLength in controller 4235 bytes
    21.105	PageLength 4414
    21.125	PageLength in controller 4414 bytes
    22.515	PageLength 4198
    22.520	PageLength in controller 4198 bytes
    24.025	PageLength 4222
    24.050	PageLength in controller 4222 bytes
    25.430	PageLength 4213
    25.430	PageLength in controller 4213 bytes
    26.735	PageLength 4215
    26.740	PageLength in controller 4215 bytes
    28.155	PageLength 4231
    28.170	PageLength in controller 4231 bytes
    29.935	PageLength 4353
    29.965	PageLength in controller 4353 bytes
    31.340	PageLength 4311
    31.370	PageLength in controller 4311 bytes
    32.910	PageLength 4227
    32.915	PageLength in controller 4227 bytes
    34.430	PageLength 4196
    34.435	PageLength in controller 4196 bytes
    35.820	PageLength 4205
    35.830	PageLength in controller 4205 bytes
    37.360	PageLength 4389
    37.375	PageLength in controller 4389 bytes
    38.490	PageLength 4203
    38.520	PageLength in controller 4203 bytes
    39.920	PageLength 4413
    39.955	PageLength in controller 4413 bytes
    41.305	PageLength 4231
    41.340	PageLength in controller 4231 bytes
    42.465	PageLength 4184
    42.490	PageLength in controller 4184 bytes
    47.895	Thread Sound Rec::MMFControllerProxyServer68d68455 created @ 0xd05e28 - Win32 Thread ID 0x864
    47.900	Thread MMFAudioServer.exe::Local-00d05ee0 created @ 0xd06198 - Win32 Thread ID 0x778
    47.940	PageSize while playing 58
    47.945	PageSize while playing 4206
    47.945	PageSize while playing 90
    47.955	PageSize while playing 4235
    47.970	PageSize while playing 4414
    48.185	PageSize while playing 4198
    48.465	PageSize while playing 4222
    48.745	PageSize while playing 4213
    49.025	PageSize while playing 4215
    49.305	PageSize while playing 4231
    49.485	PageSize while playing 4353
    49.765	PageSize while playing 4311
    50.045	PageSize while playing 4227
    50.325	PageSize while playing 4196
    50.605	PageSize while playing 4205
    50.875	PageSize while playing 4389
    51.155	PageSize while playing 4203
    51.350	PageSize while playing 4413
    51.625	PageSize while playing 4231


More information about the Vorbis mailing list