2012-06-24 07:58:51.7500 [(20)] INFO: Encoding: starting output named pipe \\.\pipe\49995d14-6678-4f6f-ae38-4effbb336798 2012-06-24 07:58:51.7500 [(20)] INFO: Encoder: Transcoder configuration dump 2012-06-24 07:58:51.7500 [(20)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-24 07:58:51.7500 [(20)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-24 07:58:51.7500 [(20)] INFO: Encoder: arguments -y -i "\\.\pipe\dc33928e-3121-4f49-aecb-db8501a50470" -s 600x336 -aspect 600:336 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\49995d14-6678-4f6f-ae38-4effbb336798" 2012-06-24 07:58:51.7656 [(20)] DEBUG: Setup data unit 5 2012-06-24 07:58:51.7656 [(20)] DEBUG: Setup log unit 6 2012-06-24 07:58:51.7656 [(20)] INFO: Pipeline assembled 2012-06-24 07:58:51.7656 [(20)] INFO: Starting data unit 1 2012-06-24 07:58:51.7656 [(20)] INFO: Starting data unit 5 2012-06-24 07:58:51.9843 [(20)] INFO: Encoding: Copy stream of type MPExtended.Services.StreamingService.Code.TsBuffer into transcoder input stream of type MPExtended.Services.StreamingService.Code.NamedPipe 2012-06-24 07:58:51.9843 [(20)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-24 07:58:58.2187 [(20)] INFO: All data units started! 2012-06-24 07:58:58.2187 [(20)] INFO: Started stream with identifier aMPdroid.-1224136936.ts 2012-06-24 08:10:21.0468 [(15)] INFO: TsBuffer: Files added 1, removed 0 2012-06-24 08:12:17.8281 [(17)] DEBUG: Called FinishStream with ident=aMPdroid.-1224136936.ts 2012-06-24 08:12:17.8281 [(17)] DEBUG: Stopping stream with identifier aMPdroid.-1224136936.ts 2012-06-24 08:12:17.8281 [(17)] INFO: Stopping data unit 1 2012-06-24 08:12:17.8437 [(17)] INFO: Stopping data unit 5 2012-06-24 08:12:17.8437 [(17)] DEBUG: Encoding: Killing transcoder 2012-06-24 08:12:17.8437 [(17)] DEBUG: Pipeline stopped 2012-06-24 08:12:17.8437 [(17)] DEBUG: Killed stream with identifier aMPdroid.-1224136936.ts 2012-06-24 08:12:17.8437 [(17)] INFO: Cancel timeshifting with identifier aMPdroid.-1224136936.ts 2012-06-24 08:12:17.8437 [(18)] DEBUG: IOException in NamedPipe.Write, is usually no problem System.IO.IOException: Pipe is broken. at System.IO.Pipes.PipeStream.WinIOError(Int32 errorCode) at System.IO.Pipes.PipeStream.EndWrite(IAsyncResult asyncResult) at System.IO.Pipes.PipeStream.WriteCore(Byte[] buffer, Int32 offset, Int32 count) at System.IO.Pipes.PipeStream.Write(Byte[] buffer, Int32 offset, Int32 count) at MPExtended.Services.StreamingService.Code.NamedPipe.Write(Byte[] buffer, Int32 offset, Int32 count) 2012-06-24 08:12:17.8437 [(18)] INFO: StreamCopy transinput: IOException in inner stream copy, is usually ok: Pipe is broken. 2012-06-24 20:16:45.7187 [(19)] DEBUG: Adding schedule on channel 439 for The Wiz - Das Zauberhafte Land, 24.6.2012 21:40:00 till 24.6.2012 23:50:00, type Once 2012-06-25 12:12:38.0156 [(17)] INFO: Called InitStream with type=TVEpisode; provider=6; itemId=55656; clientDescription=aMPdroid; identifier=aMPdroid.2097885912.ts; idleTimeout= 2012-06-25 12:12:38.1562 [(24)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.2097885912.ts; profile=Android FFmpeg medium; start=0; audioId=-1; subtitleId=-2 2012-06-25 12:12:38.1562 [(24)] DEBUG: StartStream with identifier aMPdroid.2097885912.ts for file mediatype=TVEpisode provider=6 id=55656 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E01 Ein.jeder.kriegt.sein.Fett.avi 2012-06-25 12:12:38.1562 [(24)] DEBUG: Using 532x400 as output size for stream aMPdroid.2097885912.ts 2012-06-25 12:12:38.1562 [(24)] DEBUG: WatchSharing: synchronizing start watching event to service 2012-06-25 12:12:38.2031 [(24)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 12:12:38.2031 [(24)] INFO: Assembling following pipeline: 2012-06-25 12:12:38.2031 [(24)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 12:12:38.2031 [(24)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 12:12:38.2031 [(24)] INFO: logconn 5 -> 6 2012-06-25 12:12:38.2031 [(24)] INFO: Encoding: starting output named pipe \\.\pipe\a6f19091-a213-4dfb-9363-f414541390b2 2012-06-25 12:12:38.2031 [(24)] INFO: Encoder: Transcoder configuration dump 2012-06-25 12:12:38.2031 [(24)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 12:12:38.2031 [(24)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 12:12:38.2031 [(24)] INFO: Encoder: arguments -y -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E01 Ein.jeder.kriegt.sein.Fett.avi" -s 532x400 -aspect 532:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\a6f19091-a213-4dfb-9363-f414541390b2" 2012-06-25 12:12:38.2031 [(24)] DEBUG: Setup data unit 5 2012-06-25 12:12:38.2031 [(24)] DEBUG: Setup log unit 6 2012-06-25 12:12:38.2031 [(24)] INFO: Pipeline assembled 2012-06-25 12:12:38.2031 [(24)] INFO: Starting data unit 5 2012-06-25 12:12:38.2187 [(24)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 12:12:38.3281 [(24)] INFO: All data units started! 2012-06-25 12:12:38.3281 [(24)] INFO: Started stream with identifier aMPdroid.2097885912.ts 2012-06-25 12:13:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:13:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 77000ms, runtime 1306000ms, progress 6% 2012-06-25 12:14:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:14:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 138000ms, runtime 1306000ms, progress 11% 2012-06-25 12:15:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:15:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 199000ms, runtime 1306000ms, progress 15% 2012-06-25 12:16:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:16:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 257000ms, runtime 1306000ms, progress 20% 2012-06-25 12:17:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:17:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 318000ms, runtime 1306000ms, progress 24% 2012-06-25 12:18:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:18:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 378000ms, runtime 1306000ms, progress 29% 2012-06-25 12:19:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:19:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 438000ms, runtime 1306000ms, progress 34% 2012-06-25 12:20:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:20:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 498000ms, runtime 1306000ms, progress 38% 2012-06-25 12:21:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:21:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 557000ms, runtime 1306000ms, progress 43% 2012-06-25 12:22:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:22:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 618000ms, runtime 1306000ms, progress 47% 2012-06-25 12:23:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:23:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 679000ms, runtime 1306000ms, progress 52% 2012-06-25 12:24:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:24:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 738000ms, runtime 1306000ms, progress 57% 2012-06-25 12:25:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:25:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 797000ms, runtime 1306000ms, progress 61% 2012-06-25 12:26:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:26:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 859000ms, runtime 1306000ms, progress 66% 2012-06-25 12:27:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:27:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 917000ms, runtime 1306000ms, progress 70% 2012-06-25 12:28:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:28:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 978000ms, runtime 1306000ms, progress 75% 2012-06-25 12:29:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:29:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 1037000ms, runtime 1306000ms, progress 79% 2012-06-25 12:30:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:30:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 1099000ms, runtime 1306000ms, progress 84% 2012-06-25 12:31:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:31:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 1159000ms, runtime 1306000ms, progress 89% 2012-06-25 12:32:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 12:32:39.0625 [WatchWorker(29)] DEBUG: WatchSharing: watch position 1218000ms, runtime 1306000ms, progress 93% 2012-06-25 17:33:32.5156 [StreamTimeout(13)] INFO: Stream aMPdroid.2097885912.ts has been idle for 18034953 milliseconds with last activity at 25.6.2012 12:12:38, so cancel it 2012-06-25 17:33:32.5156 [StreamTimeout(13)] DEBUG: Called FinishStream with ident=aMPdroid.2097885912.ts 2012-06-25 17:33:32.5156 [StreamTimeout(13)] DEBUG: Stopping stream with identifier aMPdroid.2097885912.ts 2012-06-25 17:33:32.5156 [StreamTimeout(13)] DEBUG: WatchSharing: watch position 1241000ms, runtime 1306000ms, progress 95% 2012-06-25 17:33:32.5156 [StreamTimeout(13)] DEBUG: WatchSharing: seeing 95% as finished for TVEpisode_55656 2012-06-25 17:33:32.5156 [StreamTimeout(13)] INFO: Stopping data unit 5 2012-06-25 17:33:32.5156 [StreamTimeout(13)] DEBUG: Encoding: Killing transcoder 2012-06-25 17:33:32.5156 [StreamTimeout(13)] DEBUG: Pipeline stopped 2012-06-25 17:33:32.5156 [StreamTimeout(13)] DEBUG: Killed stream with identifier aMPdroid.2097885912.ts 2012-06-25 17:33:33.2500 [WatchWorker(29)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 17:33:33.2500 [WatchWorker(29)] DEBUG: WatchSharing: watch position 1241000ms, runtime 1306000ms, progress 95% 2012-06-25 17:33:35.7187 [FinishWatching(35)] WARN: Failed to call Follwit API (FollwitAPI.UpdateEpisodeState => FollwitAPI.CallAPI => Log.Warn) System.Net.WebException: The remote name could not be resolved: 'follw.it' at System.Net.WebClient.UploadDataInternal(Uri address, String method, Byte[] data, WebRequest& request) at System.Net.WebClient.UploadString(Uri address, String method, String data) at System.Net.WebClient.UploadString(String address, String data) at MPExtended.Libraries.Social.Follwit.FollwitAPI.CallAPI(String address, String data) 2012-06-25 17:33:36.0468 [FinishWatching(35)] WARN: Follwit: failed to update episode watch status (FollwitSharingProvider.FinishEpisode => FollwitSharingProvider.CallFollwitEpisode => Log.Warn) System.NullReferenceException: Object reference not set to an instance of an object. at MPExtended.Libraries.Social.FollwitSharingProvider.CallFollwitEpisode(WebTVEpisodeDetailed episode, FollwitWatchStatus state) 2012-06-25 17:33:36.0937 [FinishWatching(35)] DEBUG: WatchSharing: finished handling TVEpisode_55656 2012-06-25 17:56:12.8437 [(17)] INFO: Called InitStream with type=TVEpisode; provider=6; itemId=55656; clientDescription=aMPdroid; identifier=aMPdroid.218939581.ts; idleTimeout= 2012-06-25 17:56:12.9062 [(19)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.218939581.ts; profile=Android FFmpeg medium; start=0; audioId=-1; subtitleId=-2 2012-06-25 17:56:12.9062 [(19)] DEBUG: StartStream with identifier aMPdroid.218939581.ts for file mediatype=TVEpisode provider=6 id=55656 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E01 Ein.jeder.kriegt.sein.Fett.avi 2012-06-25 17:56:12.9062 [(19)] DEBUG: Using 532x400 as output size for stream aMPdroid.218939581.ts 2012-06-25 17:56:12.9062 [(19)] DEBUG: WatchSharing: synchronizing start watching event to service 2012-06-25 17:56:12.9531 [(19)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 17:56:12.9531 [(19)] INFO: Assembling following pipeline: 2012-06-25 17:56:12.9531 [(19)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 17:56:12.9531 [(19)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 17:56:12.9531 [(19)] INFO: logconn 5 -> 6 2012-06-25 17:56:12.9531 [(19)] INFO: Encoding: starting output named pipe \\.\pipe\2cbc4bcd-de55-42d7-9782-54e823b7583d 2012-06-25 17:56:12.9531 [(19)] INFO: Encoder: Transcoder configuration dump 2012-06-25 17:56:12.9531 [(19)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 17:56:12.9531 [(19)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 17:56:12.9531 [(19)] INFO: Encoder: arguments -y -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E01 Ein.jeder.kriegt.sein.Fett.avi" -s 532x400 -aspect 532:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\2cbc4bcd-de55-42d7-9782-54e823b7583d" 2012-06-25 17:56:13.0156 [(19)] DEBUG: Setup data unit 5 2012-06-25 17:56:13.0468 [(19)] DEBUG: Setup log unit 6 2012-06-25 17:56:13.0468 [(19)] INFO: Pipeline assembled 2012-06-25 17:56:13.0468 [(19)] INFO: Starting data unit 5 2012-06-25 17:56:13.0468 [(19)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 17:56:13.5937 [(19)] INFO: All data units started! 2012-06-25 17:56:13.5937 [(19)] INFO: Started stream with identifier aMPdroid.218939581.ts 2012-06-25 17:57:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 17:57:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: watch position 77000ms, runtime 1306000ms, progress 6% 2012-06-25 17:58:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 17:58:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: watch position 137000ms, runtime 1306000ms, progress 10% 2012-06-25 17:59:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: syncing status for TVEpisode_55656 2012-06-25 17:59:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: watch position 198000ms, runtime 1306000ms, progress 15% 2012-06-25 18:00:00.8281 [(17)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.218939581.ts; profile=Android FFmpeg medium; start=235; audioId=-1; subtitleId=-2 2012-06-25 18:00:00.8281 [(17)] DEBUG: Stopping stream with identifier aMPdroid.218939581.ts 2012-06-25 18:00:00.8281 [(17)] DEBUG: WatchSharing: watch position -922ms, runtime 1306000ms, progress 0% 2012-06-25 18:00:00.8281 [(17)] DEBUG: WatchSharing: canceling stream TVEpisode_55656 2012-06-25 18:00:00.8281 [(17)] INFO: Stopping data unit 5 2012-06-25 18:00:00.8281 [(17)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:00:00.8281 [(17)] DEBUG: Pipeline stopped 2012-06-25 18:00:00.8281 [(17)] DEBUG: StartStream with identifier aMPdroid.218939581.ts for file mediatype=TVEpisode provider=6 id=55656 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E01 Ein.jeder.kriegt.sein.Fett.avi 2012-06-25 18:00:00.8281 [(17)] DEBUG: Using 532x400 as output size for stream aMPdroid.218939581.ts 2012-06-25 18:00:00.8281 [(17)] INFO: WatchSharing: Picking up old stream 2012-06-25 18:00:00.8281 [(17)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 18:00:00.8281 [(17)] INFO: Assembling following pipeline: 2012-06-25 18:00:00.8281 [(17)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:00:00.8281 [(17)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:00:00.8281 [(17)] INFO: logconn 5 -> 6 2012-06-25 18:00:00.8281 [(17)] INFO: Encoding: starting output named pipe \\.\pipe\fbe08663-bdfa-4bb3-ab1c-c73935988cd9 2012-06-25 18:00:00.8281 [(17)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:00:00.8281 [(17)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:00:00.8281 [(17)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:00:00.8281 [(17)] INFO: Encoder: arguments -y -ss 235 -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E01 Ein.jeder.kriegt.sein.Fett.avi" -s 532x400 -aspect 532:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\fbe08663-bdfa-4bb3-ab1c-c73935988cd9" 2012-06-25 18:00:00.8281 [(17)] DEBUG: Setup data unit 5 2012-06-25 18:00:00.8593 [(17)] DEBUG: Setup log unit 6 2012-06-25 18:00:00.8593 [(17)] INFO: Pipeline assembled 2012-06-25 18:00:00.8593 [(17)] INFO: Starting data unit 5 2012-06-25 18:00:00.8593 [(17)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:00:00.9687 [(17)] INFO: All data units started! 2012-06-25 18:00:00.9687 [(17)] INFO: Started stream with identifier aMPdroid.218939581.ts 2012-06-25 18:00:01.3281 [(19)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.218939581.ts; profile=Android FFmpeg medium; start=235; audioId=-1; subtitleId=-2 2012-06-25 18:00:01.3281 [(19)] DEBUG: Stopping stream with identifier aMPdroid.218939581.ts 2012-06-25 18:00:01.3281 [(19)] DEBUG: WatchSharing: watch position 235031ms, runtime 1306000ms, progress 18% 2012-06-25 18:00:01.3281 [(19)] DEBUG: WatchSharing: canceling stream TVEpisode_55656 2012-06-25 18:00:01.3281 [(19)] INFO: Stopping data unit 5 2012-06-25 18:00:01.3281 [(19)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:00:01.3281 [(19)] DEBUG: Pipeline stopped 2012-06-25 18:00:01.3281 [(19)] DEBUG: StartStream with identifier aMPdroid.218939581.ts for file mediatype=TVEpisode provider=6 id=55656 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E01 Ein.jeder.kriegt.sein.Fett.avi 2012-06-25 18:00:01.3281 [(19)] DEBUG: Using 532x400 as output size for stream aMPdroid.218939581.ts 2012-06-25 18:00:01.3281 [(19)] INFO: WatchSharing: Picking up old stream 2012-06-25 18:00:01.3281 [(19)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 18:00:01.3281 [(19)] INFO: Assembling following pipeline: 2012-06-25 18:00:01.3281 [(19)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:00:01.3281 [(19)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:00:01.3281 [(19)] INFO: logconn 5 -> 6 2012-06-25 18:00:01.3281 [(19)] INFO: Encoding: starting output named pipe \\.\pipe\e74a81c7-798c-4365-a5e2-863fe3720c30 2012-06-25 18:00:01.3281 [(19)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:00:01.3437 [(19)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:00:01.3437 [(19)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:00:01.3437 [(19)] INFO: Encoder: arguments -y -ss 235 -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E01 Ein.jeder.kriegt.sein.Fett.avi" -s 532x400 -aspect 532:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\e74a81c7-798c-4365-a5e2-863fe3720c30" 2012-06-25 18:00:01.3437 [(19)] DEBUG: Setup data unit 5 2012-06-25 18:00:01.3437 [(19)] DEBUG: Setup log unit 6 2012-06-25 18:00:01.3437 [(19)] INFO: Pipeline assembled 2012-06-25 18:00:01.3437 [(19)] INFO: Starting data unit 5 2012-06-25 18:00:01.3437 [(19)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:00:01.4531 [(19)] INFO: All data units started! 2012-06-25 18:00:01.4531 [(19)] INFO: Started stream with identifier aMPdroid.218939581.ts 2012-06-25 18:00:03.6250 [(20)] DEBUG: Called FinishStream with ident=aMPdroid.218939581.ts 2012-06-25 18:00:03.6250 [(20)] DEBUG: Stopping stream with identifier aMPdroid.218939581.ts 2012-06-25 18:00:03.6250 [(20)] DEBUG: WatchSharing: watch position 237328ms, runtime 1306000ms, progress 18% 2012-06-25 18:00:03.6250 [(20)] DEBUG: WatchSharing: canceling stream TVEpisode_55656 2012-06-25 18:00:03.6250 [(20)] INFO: Stopping data unit 5 2012-06-25 18:00:03.6250 [(20)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:00:03.6250 [(20)] DEBUG: Pipeline stopped 2012-06-25 18:00:03.6250 [(20)] DEBUG: Killed stream with identifier aMPdroid.218939581.ts 2012-06-25 18:00:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: stream TVEpisode_55656 is canceled 2012-06-25 18:00:17.3437 [(17)] INFO: Called InitStream with type=TVEpisode; provider=6; itemId=55665; clientDescription=aMPdroid; identifier=aMPdroid.1752439186.ts; idleTimeout= 2012-06-25 18:00:17.4062 [(24)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.1752439186.ts; profile=Android FFmpeg medium; start=0; audioId=-1; subtitleId=-2 2012-06-25 18:00:17.4062 [(24)] DEBUG: StartStream with identifier aMPdroid.1752439186.ts for file mediatype=TVEpisode provider=6 id=55665 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E10 Wir fahrn nach Vegas - DVD-RiP.avi 2012-06-25 18:00:17.4062 [(24)] DEBUG: Using 552x400 as output size for stream aMPdroid.1752439186.ts 2012-06-25 18:00:17.4062 [(24)] DEBUG: WatchSharing: synchronizing start watching event to service 2012-06-25 18:00:17.4375 [(24)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 18:00:17.4375 [(24)] INFO: Assembling following pipeline: 2012-06-25 18:00:17.4375 [(24)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:00:17.4375 [(24)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:00:17.4375 [(24)] INFO: logconn 5 -> 6 2012-06-25 18:00:17.4375 [(24)] INFO: Encoding: starting output named pipe \\.\pipe\0563c349-6b5a-4d96-9db8-9628594ea754 2012-06-25 18:00:17.4375 [(24)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:00:17.4375 [(24)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:00:17.4375 [(24)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:00:17.4375 [(24)] INFO: Encoder: arguments -y -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E10 Wir fahrn nach Vegas - DVD-RiP.avi" -s 552x400 -aspect 552:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\0563c349-6b5a-4d96-9db8-9628594ea754" 2012-06-25 18:00:17.4375 [(24)] DEBUG: Setup data unit 5 2012-06-25 18:00:17.4375 [(24)] DEBUG: Setup log unit 6 2012-06-25 18:00:17.4375 [(24)] INFO: Pipeline assembled 2012-06-25 18:00:17.4375 [(24)] INFO: Starting data unit 5 2012-06-25 18:00:17.4375 [(24)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:00:17.5468 [(24)] INFO: All data units started! 2012-06-25 18:00:17.5468 [(24)] INFO: Started stream with identifier aMPdroid.1752439186.ts 2012-06-25 18:01:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: stream TVEpisode_55656 is canceled 2012-06-25 18:01:18.2812 [WatchWorker(37)] DEBUG: WatchSharing: syncing status for TVEpisode_55665 2012-06-25 18:01:18.2812 [WatchWorker(37)] DEBUG: WatchSharing: watch position 80000ms, runtime 1314600ms, progress 6% 2012-06-25 18:01:20.6406 [(20)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.1752439186.ts; profile=Android FFmpeg medium; start=71; audioId=-1; subtitleId=-2 2012-06-25 18:01:20.6406 [(20)] DEBUG: Stopping stream with identifier aMPdroid.1752439186.ts 2012-06-25 18:01:20.6406 [(20)] DEBUG: WatchSharing: watch position -938ms, runtime 1314600ms, progress 0% 2012-06-25 18:01:20.6406 [(20)] DEBUG: WatchSharing: canceling stream TVEpisode_55665 2012-06-25 18:01:20.6406 [(20)] INFO: Stopping data unit 5 2012-06-25 18:01:20.6406 [(20)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:01:20.6406 [(20)] DEBUG: Pipeline stopped 2012-06-25 18:01:20.6406 [(20)] DEBUG: StartStream with identifier aMPdroid.1752439186.ts for file mediatype=TVEpisode provider=6 id=55665 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E10 Wir fahrn nach Vegas - DVD-RiP.avi 2012-06-25 18:01:20.6406 [(20)] DEBUG: Using 552x400 as output size for stream aMPdroid.1752439186.ts 2012-06-25 18:01:20.6406 [(20)] INFO: WatchSharing: Picking up old stream 2012-06-25 18:01:20.6406 [(20)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 18:01:20.6406 [(20)] INFO: Assembling following pipeline: 2012-06-25 18:01:20.6406 [(20)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:01:20.6406 [(20)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:01:20.6406 [(20)] INFO: logconn 5 -> 6 2012-06-25 18:01:20.6406 [(20)] INFO: Encoding: starting output named pipe \\.\pipe\53264354-a671-417d-b8e5-8cbb6068b074 2012-06-25 18:01:20.6406 [(20)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:01:20.6406 [(20)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:01:20.6406 [(20)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:01:20.6406 [(20)] INFO: Encoder: arguments -y -ss 71 -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E10 Wir fahrn nach Vegas - DVD-RiP.avi" -s 552x400 -aspect 552:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\53264354-a671-417d-b8e5-8cbb6068b074" 2012-06-25 18:01:20.6406 [(20)] DEBUG: Setup data unit 5 2012-06-25 18:01:20.6562 [(20)] DEBUG: Setup log unit 6 2012-06-25 18:01:20.6562 [(20)] INFO: Pipeline assembled 2012-06-25 18:01:20.6562 [(20)] INFO: Starting data unit 5 2012-06-25 18:01:20.6562 [(20)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:01:20.7656 [(20)] INFO: All data units started! 2012-06-25 18:01:20.7656 [(20)] INFO: Started stream with identifier aMPdroid.1752439186.ts 2012-06-25 18:01:21.1250 [(20)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.1752439186.ts; profile=Android FFmpeg medium; start=71; audioId=-1; subtitleId=-2 2012-06-25 18:01:21.1250 [(20)] DEBUG: Stopping stream with identifier aMPdroid.1752439186.ts 2012-06-25 18:01:21.1250 [(20)] DEBUG: WatchSharing: watch position -454ms, runtime 1314600ms, progress 0% 2012-06-25 18:01:21.1250 [(20)] DEBUG: WatchSharing: canceling stream TVEpisode_55665 2012-06-25 18:01:21.1250 [(20)] INFO: Stopping data unit 5 2012-06-25 18:01:21.1250 [(20)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:01:21.1250 [(20)] DEBUG: Pipeline stopped 2012-06-25 18:01:21.1406 [(20)] DEBUG: StartStream with identifier aMPdroid.1752439186.ts for file mediatype=TVEpisode provider=6 id=55665 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E10 Wir fahrn nach Vegas - DVD-RiP.avi 2012-06-25 18:01:21.1406 [(20)] DEBUG: Using 552x400 as output size for stream aMPdroid.1752439186.ts 2012-06-25 18:01:21.1406 [(20)] INFO: WatchSharing: Picking up old stream 2012-06-25 18:01:21.1406 [(20)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 18:01:21.1406 [(20)] INFO: Assembling following pipeline: 2012-06-25 18:01:21.1406 [(20)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:01:21.1406 [(20)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:01:21.1406 [(20)] INFO: logconn 5 -> 6 2012-06-25 18:01:21.1406 [(20)] INFO: Encoding: starting output named pipe \\.\pipe\d5bb1ed1-f205-41d9-86ec-aad15f8f7724 2012-06-25 18:01:21.1406 [(20)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:01:21.1406 [(20)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:01:21.1406 [(20)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:01:21.1406 [(20)] INFO: Encoder: arguments -y -ss 71 -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E10 Wir fahrn nach Vegas - DVD-RiP.avi" -s 552x400 -aspect 552:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\d5bb1ed1-f205-41d9-86ec-aad15f8f7724" 2012-06-25 18:01:21.1406 [(20)] DEBUG: Setup data unit 5 2012-06-25 18:01:21.1406 [(20)] DEBUG: Setup log unit 6 2012-06-25 18:01:21.1406 [(20)] INFO: Pipeline assembled 2012-06-25 18:01:21.1406 [(20)] INFO: Starting data unit 5 2012-06-25 18:01:21.1406 [(20)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:01:21.2500 [(20)] INFO: All data units started! 2012-06-25 18:01:21.2500 [(20)] INFO: Started stream with identifier aMPdroid.1752439186.ts 2012-06-25 18:01:22.4062 [(24)] DEBUG: Called FinishStream with ident=aMPdroid.1752439186.ts 2012-06-25 18:01:22.4062 [(24)] DEBUG: Stopping stream with identifier aMPdroid.1752439186.ts 2012-06-25 18:01:22.4062 [(24)] DEBUG: WatchSharing: watch position 72265ms, runtime 1314600ms, progress 5% 2012-06-25 18:01:22.4062 [(24)] DEBUG: WatchSharing: canceling stream TVEpisode_55665 2012-06-25 18:01:22.4062 [(24)] INFO: Stopping data unit 5 2012-06-25 18:01:22.4062 [(24)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:01:22.4062 [(24)] DEBUG: Pipeline stopped 2012-06-25 18:01:22.4062 [(24)] DEBUG: Killed stream with identifier aMPdroid.1752439186.ts 2012-06-25 18:01:42.4218 [(20)] INFO: Called InitStream with type=Movie; provider=3; itemId=185; clientDescription=aMPdroid; identifier=aMPdroid.266185357.ts; idleTimeout= 2012-06-25 18:01:42.4843 [(17)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.266185357.ts; profile=Android FFmpeg medium; start=0; audioId=-1; subtitleId=-2 2012-06-25 18:01:42.4843 [(17)] DEBUG: StartStream with identifier aMPdroid.266185357.ts for file mediatype=Movie provider=3 id=185 filetype=Content offset=0 path=G:\Filme\Movies\Alice im Wunderland\Alice im Wunderland-2012-05-17.ts 2012-06-25 18:01:42.4843 [(17)] DEBUG: Using 600x336 as output size for stream aMPdroid.266185357.ts 2012-06-25 18:01:42.4843 [(17)] DEBUG: WatchSharing: synchronizing start watching event to service 2012-06-25 18:01:42.5000 [(17)] DEBUG: Final stream selection: audioId=64, subtitleId= 2012-06-25 18:01:42.5000 [(17)] INFO: Assembling following pipeline: 2012-06-25 18:01:42.5000 [(17)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:01:42.5000 [(17)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:01:42.5000 [(17)] INFO: logconn 5 -> 6 2012-06-25 18:01:42.5000 [(17)] INFO: Encoding: starting output named pipe \\.\pipe\e80a063d-69e9-4721-adc4-40cbb0d16406 2012-06-25 18:01:42.5000 [(17)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:01:42.5000 [(17)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:01:42.5000 [(17)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:01:42.5000 [(17)] INFO: Encoder: arguments -y -i "G:\Filme\Movies\Alice im Wunderland\Alice im Wunderland-2012-05-17.ts" -s 600x336 -aspect 600:336 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\e80a063d-69e9-4721-adc4-40cbb0d16406" 2012-06-25 18:01:42.5000 [(17)] DEBUG: Setup data unit 5 2012-06-25 18:01:42.5000 [(17)] DEBUG: Setup log unit 6 2012-06-25 18:01:42.5000 [(17)] INFO: Pipeline assembled 2012-06-25 18:01:42.5000 [(17)] INFO: Starting data unit 5 2012-06-25 18:01:42.5000 [(17)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:01:42.6093 [(17)] INFO: All data units started! 2012-06-25 18:01:42.6093 [(17)] INFO: Started stream with identifier aMPdroid.266185357.ts 2012-06-25 18:02:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: stream TVEpisode_55656 is canceled 2012-06-25 18:02:18.2812 [WatchWorker(37)] DEBUG: WatchSharing: stream TVEpisode_55665 is canceled 2012-06-25 18:02:18.7656 [(17)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.266185357.ts; profile=Android FFmpeg medium; start=45; audioId=-1; subtitleId=-2 2012-06-25 18:02:18.7656 [(17)] DEBUG: Stopping stream with identifier aMPdroid.266185357.ts 2012-06-25 18:02:18.7656 [(17)] DEBUG: WatchSharing: watch position -938ms, runtime 6349344ms, progress 0% 2012-06-25 18:02:18.7656 [(17)] DEBUG: WatchSharing: canceling stream Movie_185 2012-06-25 18:02:18.7656 [(17)] INFO: Stopping data unit 5 2012-06-25 18:02:18.7656 [(17)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:02:18.7656 [(17)] DEBUG: Pipeline stopped 2012-06-25 18:02:18.7656 [(17)] DEBUG: StartStream with identifier aMPdroid.266185357.ts for file mediatype=Movie provider=3 id=185 filetype=Content offset=0 path=G:\Filme\Movies\Alice im Wunderland\Alice im Wunderland-2012-05-17.ts 2012-06-25 18:02:18.7656 [(17)] DEBUG: Using 600x336 as output size for stream aMPdroid.266185357.ts 2012-06-25 18:02:18.7656 [(17)] INFO: WatchSharing: Picking up old stream 2012-06-25 18:02:18.7656 [(17)] DEBUG: Final stream selection: audioId=64, subtitleId= 2012-06-25 18:02:18.7656 [(17)] INFO: Assembling following pipeline: 2012-06-25 18:02:18.7656 [(17)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:02:18.7656 [(17)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:02:18.7656 [(17)] INFO: logconn 5 -> 6 2012-06-25 18:02:18.7656 [(17)] INFO: Encoding: starting output named pipe \\.\pipe\90766769-66ed-40f7-b314-e13f240ede2d 2012-06-25 18:02:18.7656 [(17)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:02:18.7656 [(17)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:02:18.7656 [(17)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:02:18.7656 [(17)] INFO: Encoder: arguments -y -ss 45 -i "G:\Filme\Movies\Alice im Wunderland\Alice im Wunderland-2012-05-17.ts" -s 600x336 -aspect 600:336 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\90766769-66ed-40f7-b314-e13f240ede2d" 2012-06-25 18:02:18.7812 [(17)] DEBUG: Setup data unit 5 2012-06-25 18:02:18.7812 [(17)] DEBUG: Setup log unit 6 2012-06-25 18:02:18.7812 [(17)] INFO: Pipeline assembled 2012-06-25 18:02:18.7812 [(17)] INFO: Starting data unit 5 2012-06-25 18:02:18.7812 [(17)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:02:18.7968 [(24)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.266185357.ts; profile=Android FFmpeg medium; start=45; audioId=-1; subtitleId=-2 2012-06-25 18:02:19.2187 [(17)] INFO: All data units started! 2012-06-25 18:02:19.2187 [(17)] INFO: Started stream with identifier aMPdroid.266185357.ts 2012-06-25 18:02:19.2187 [(24)] DEBUG: Stopping stream with identifier aMPdroid.266185357.ts 2012-06-25 18:02:19.2187 [(24)] DEBUG: WatchSharing: watch position -485ms, runtime 6349344ms, progress 0% 2012-06-25 18:02:19.2187 [(24)] DEBUG: WatchSharing: canceling stream Movie_185 2012-06-25 18:02:19.2187 [(24)] INFO: Stopping data unit 5 2012-06-25 18:02:19.2187 [(24)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:02:19.2187 [(24)] DEBUG: Pipeline stopped 2012-06-25 18:02:19.2187 [(24)] DEBUG: StartStream with identifier aMPdroid.266185357.ts for file mediatype=Movie provider=3 id=185 filetype=Content offset=0 path=G:\Filme\Movies\Alice im Wunderland\Alice im Wunderland-2012-05-17.ts 2012-06-25 18:02:19.2187 [(24)] DEBUG: Using 600x336 as output size for stream aMPdroid.266185357.ts 2012-06-25 18:02:19.2187 [(24)] INFO: WatchSharing: Picking up old stream 2012-06-25 18:02:19.2187 [(24)] DEBUG: Final stream selection: audioId=64, subtitleId= 2012-06-25 18:02:19.2187 [(24)] INFO: Assembling following pipeline: 2012-06-25 18:02:19.2187 [(24)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:02:19.2187 [(24)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:02:19.2187 [(24)] INFO: logconn 5 -> 6 2012-06-25 18:02:19.2187 [(24)] INFO: Encoding: starting output named pipe \\.\pipe\d51a9488-77da-4eb0-a735-c5470f52f380 2012-06-25 18:02:19.2187 [(24)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:02:19.2187 [(24)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:02:19.2187 [(24)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:02:19.2187 [(24)] INFO: Encoder: arguments -y -ss 45 -i "G:\Filme\Movies\Alice im Wunderland\Alice im Wunderland-2012-05-17.ts" -s 600x336 -aspect 600:336 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\d51a9488-77da-4eb0-a735-c5470f52f380" 2012-06-25 18:02:19.2187 [(24)] DEBUG: Setup data unit 5 2012-06-25 18:02:19.2187 [(24)] DEBUG: Setup log unit 6 2012-06-25 18:02:19.2187 [(24)] INFO: Pipeline assembled 2012-06-25 18:02:19.2187 [(24)] INFO: Starting data unit 5 2012-06-25 18:02:19.2187 [(24)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:02:19.3281 [(24)] INFO: All data units started! 2012-06-25 18:02:19.3281 [(24)] INFO: Started stream with identifier aMPdroid.266185357.ts 2012-06-25 18:02:19.9375 [(24)] DEBUG: Called FinishStream with ident=aMPdroid.266185357.ts 2012-06-25 18:02:19.9375 [(24)] DEBUG: Stopping stream with identifier aMPdroid.266185357.ts 2012-06-25 18:02:19.9375 [(24)] DEBUG: WatchSharing: watch position 45562ms, runtime 6349344ms, progress 1% 2012-06-25 18:02:19.9375 [(24)] DEBUG: WatchSharing: canceling stream Movie_185 2012-06-25 18:02:19.9375 [(24)] INFO: Stopping data unit 5 2012-06-25 18:02:19.9375 [(24)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:02:19.9375 [(24)] DEBUG: Pipeline stopped 2012-06-25 18:02:19.9375 [(24)] DEBUG: Killed stream with identifier aMPdroid.266185357.ts 2012-06-25 18:02:24.4531 [(24)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:02:29.5312 [(20)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:02:34.6093 [(24)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:02:36.4218 [(24)] INFO: Starting timeshifting on channel 1223 for client aMPdroid with identifier aMPdroid.-545449811.ts 2012-06-25 18:02:36.4218 [(20)] DEBUG: Starting timeshifting with username webstreamingservice-aMPdroid.-545449811.ts on channel id 1223 2012-06-25 18:02:36.4218 [(20)] DEBUG: Starting timeshifting 2012-06-25 18:02:39.3906 [(20)] DEBUG: Timeshifting succeeded 2012-06-25 18:02:39.5000 [(24)] DEBUG: Timeshifting started! 2012-06-25 18:02:39.5000 [(24)] INFO: Called InitStream with type=TV; provider=100; itemId=Z:\\live5-0.ts.tsbuffer; clientDescription=aMPdroid; identifier=aMPdroid.-545449811.ts; idleTimeout= 2012-06-25 18:02:39.6093 [(24)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.-545449811.ts; profile=Android FFmpeg medium; start=0; audioId=-1; subtitleId=-2 2012-06-25 18:02:39.6093 [(24)] DEBUG: StartStream with identifier aMPdroid.-545449811.ts for file mediatype=TV provider=100 id=Z:\\live5-0.ts.tsbuffer filetype=Content offset=0 path=Z:\\live5-0.ts.tsbuffer 2012-06-25 18:02:39.6093 [(24)] INFO: TsBuffer: Files added 1, removed 0 2012-06-25 18:02:39.6093 [(24)] DEBUG: Using path Z:\\live5-0.ts.tsbuffer1.ts from TS buffer Z:\\live5-0.ts.tsbuffer as source for mediatype=TV provider=100 id=Z:\\live5-0.ts.tsbuffer filetype=Content offset=0 path=Z:\\live5-0.ts.tsbuffer 2012-06-25 18:02:39.7812 [(24)] DEBUG: Using 600x336 as output size for stream aMPdroid.-545449811.ts 2012-06-25 18:02:39.7812 [(24)] DEBUG: Final stream selection: audioId=64, subtitleId= 2012-06-25 18:02:39.7812 [(24)] INFO: Assembling following pipeline: 2012-06-25 18:02:39.7812 [(24)] INFO: data 1: MPExtended.Services.StreamingService.Units.InputUnit (input False, data True, log False) 2012-06-25 18:02:39.7812 [(24)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input True, data True, log True) 2012-06-25 18:02:39.7812 [(24)] INFO: dataconn 1 -> 5 2012-06-25 18:02:39.7812 [(24)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:02:39.7812 [(24)] INFO: logconn 5 -> 6 2012-06-25 18:02:39.7812 [(24)] INFO: Using TsBuffer to read input 2012-06-25 18:02:39.7812 [(24)] INFO: TsBuffer: Files added 1, removed 0 2012-06-25 18:02:39.7812 [(24)] DEBUG: Setup data unit 1 2012-06-25 18:02:39.7812 [(24)] INFO: Encoding: starting input named pipe \\.\pipe\93d05c19-883c-4279-b239-54c2ad5517f4 2012-06-25 18:02:39.7812 [(24)] INFO: Encoding: starting output named pipe \\.\pipe\64108914-db7b-4253-abee-9141164b9191 2012-06-25 18:02:39.7812 [(24)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:02:39.7812 [(24)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:02:39.7812 [(24)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:02:39.7812 [(24)] INFO: Encoder: arguments -y -i "\\.\pipe\93d05c19-883c-4279-b239-54c2ad5517f4" -s 600x336 -aspect 600:336 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\64108914-db7b-4253-abee-9141164b9191" 2012-06-25 18:02:39.7812 [(24)] DEBUG: Setup data unit 5 2012-06-25 18:02:39.7812 [(24)] DEBUG: Setup log unit 6 2012-06-25 18:02:39.7812 [(24)] INFO: Pipeline assembled 2012-06-25 18:02:39.7812 [(24)] INFO: Starting data unit 1 2012-06-25 18:02:39.7812 [(24)] INFO: Starting data unit 5 2012-06-25 18:02:39.8906 [(24)] INFO: Encoding: Copy stream of type MPExtended.Services.StreamingService.Code.TsBuffer into transcoder input stream of type MPExtended.Services.StreamingService.Code.NamedPipe 2012-06-25 18:02:39.8906 [(24)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:02:39.7343 [(20)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:02:43.0000 [WatchWorker(45)] DEBUG: WatchSharing: stream Movie_185 is canceled 2012-06-25 18:02:44.8125 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:02:45.5781 [(24)] INFO: All data units started! 2012-06-25 18:02:45.5781 [(24)] INFO: Started stream with identifier aMPdroid.-545449811.ts 2012-06-25 18:02:49.8906 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:02:54.9375 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:00.0312 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:05.0937 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:10.1406 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:13.5937 [WatchWorker(46)] DEBUG: WatchSharing: stream TVEpisode_55656 is canceled 2012-06-25 18:03:15.2343 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:18.2812 [WatchWorker(37)] DEBUG: WatchSharing: stream TVEpisode_55665 is canceled 2012-06-25 18:03:20.2812 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:25.3593 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:30.4687 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:01.9687 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:07.0468 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:09.4062 [WatchWorker(45)] DEBUG: WatchSharing: stream Movie_185 is canceled 2012-06-25 18:03:12.0937 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:17.1718 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:22.2187 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:27.2812 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:32.3593 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:37.4531 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:40.0000 [WatchWorker(46)] DEBUG: WatchSharing: stream TVEpisode_55656 is canceled 2012-06-25 18:03:42.5468 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:44.6875 [WatchWorker(37)] DEBUG: WatchSharing: stream TVEpisode_55665 is canceled 2012-06-25 18:03:47.5937 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:49.9375 [(17)] DEBUG: Called FinishStream with ident=aMPdroid.-545449811.ts 2012-06-25 18:03:49.9375 [(17)] DEBUG: Stopping stream with identifier aMPdroid.-545449811.ts 2012-06-25 18:03:49.9375 [(17)] INFO: Stopping data unit 1 2012-06-25 18:03:49.9375 [(17)] INFO: Stopping data unit 5 2012-06-25 18:03:49.9375 [(17)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:03:49.9375 [(17)] DEBUG: Pipeline stopped 2012-06-25 18:03:49.9375 [(17)] DEBUG: Killed stream with identifier aMPdroid.-545449811.ts 2012-06-25 18:03:49.9375 [(17)] INFO: Cancel timeshifting with identifier aMPdroid.-545449811.ts 2012-06-25 18:03:49.9375 [(39)] DEBUG: IOException in NamedPipe.Write, is usually no problem System.IO.IOException: Pipe is broken. at System.IO.Pipes.PipeStream.WinIOError(Int32 errorCode) at System.IO.Pipes.PipeStream.EndWrite(IAsyncResult asyncResult) at System.IO.Pipes.PipeStream.WriteCore(Byte[] buffer, Int32 offset, Int32 count) at System.IO.Pipes.PipeStream.Write(Byte[] buffer, Int32 offset, Int32 count) at MPExtended.Services.StreamingService.Code.NamedPipe.Write(Byte[] buffer, Int32 offset, Int32 count) 2012-06-25 18:03:49.9375 [(39)] INFO: StreamCopy transinput: IOException in inner stream copy, is usually ok: Pipe is broken. 2012-06-25 18:03:52.6562 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:03:57.7343 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:04:02.8437 [(19)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:04:07.9687 [(17)] ERROR: Unhandled exception in service (JSON interface) (ErrorBehavior.ProvideMessageFaultCore => ErrorBehavior.ProvideFault => WebExceptionHandling.ProvideFault) System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at MPExtended.Services.StreamingService.Code.Streaming.GetEncodingInfo(String identifier) at MPExtended.Services.StreamingService.StreamingService.GetTranscodingInfo(String identifier, Nullable`1 playerPosition) at SyncInvokeGetTranscodingInfo(Object , Object[] , Object[] ) at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs) at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc) at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc) at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet) 2012-06-25 18:04:09.4062 [WatchWorker(45)] DEBUG: WatchSharing: stream Movie_185 is canceled 2012-06-25 18:04:31.9531 [(17)] INFO: Called InitStream with type=TVEpisode; provider=6; itemId=55661; clientDescription=aMPdroid; identifier=aMPdroid.-484197591.ts; idleTimeout= 2012-06-25 18:04:32.0625 [(24)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.-484197591.ts; profile=Android FFmpeg medium; start=0; audioId=-1; subtitleId=-2 2012-06-25 18:04:32.0625 [(24)] DEBUG: StartStream with identifier aMPdroid.-484197591.ts for file mediatype=TVEpisode provider=6 id=55661 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E06 Homer.ist.ein.toller.Hippie.avi 2012-06-25 18:04:32.0625 [(24)] DEBUG: Using 532x400 as output size for stream aMPdroid.-484197591.ts 2012-06-25 18:04:32.0625 [(24)] DEBUG: WatchSharing: synchronizing start watching event to service 2012-06-25 18:04:32.0937 [(24)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 18:04:32.0937 [(24)] INFO: Assembling following pipeline: 2012-06-25 18:04:32.0937 [(24)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:04:32.0937 [(24)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:04:32.0937 [(24)] INFO: logconn 5 -> 6 2012-06-25 18:04:32.0937 [(24)] INFO: Encoding: starting output named pipe \\.\pipe\8174f331-ba52-46a8-b76e-03b394618a3f 2012-06-25 18:04:32.0937 [(24)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:04:32.0937 [(24)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:04:32.0937 [(24)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:04:32.0937 [(24)] INFO: Encoder: arguments -y -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E06 Homer.ist.ein.toller.Hippie.avi" -s 532x400 -aspect 532:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\8174f331-ba52-46a8-b76e-03b394618a3f" 2012-06-25 18:04:32.1093 [(24)] DEBUG: Setup data unit 5 2012-06-25 18:04:32.1093 [(24)] DEBUG: Setup log unit 6 2012-06-25 18:04:32.1093 [(24)] INFO: Pipeline assembled 2012-06-25 18:04:32.1093 [(24)] INFO: Starting data unit 5 2012-06-25 18:04:32.1093 [(24)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:04:32.2187 [(24)] INFO: All data units started! 2012-06-25 18:04:32.2187 [(24)] INFO: Started stream with identifier aMPdroid.-484197591.ts 2012-06-25 18:04:40.0000 [WatchWorker(46)] DEBUG: WatchSharing: stream TVEpisode_55656 is canceled 2012-06-25 18:04:40.0000 [WatchWorker(46)] DEBUG: WatchSharing: definitely killing stream TVEpisode_55656 with cancelwatching event 2012-06-25 18:04:44.6875 [WatchWorker(37)] DEBUG: WatchSharing: stream TVEpisode_55665 is canceled 2012-06-25 18:05:09.4062 [WatchWorker(45)] DEBUG: WatchSharing: stream Movie_185 is canceled 2012-06-25 18:05:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:05:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 85000ms, runtime 1352680ms, progress 6% 2012-06-25 18:05:44.6875 [WatchWorker(37)] DEBUG: WatchSharing: stream TVEpisode_55665 is canceled 2012-06-25 18:06:09.4062 [WatchWorker(45)] DEBUG: WatchSharing: stream Movie_185 is canceled 2012-06-25 18:06:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:06:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 145000ms, runtime 1352680ms, progress 11% 2012-06-25 18:06:44.6875 [WatchWorker(37)] DEBUG: WatchSharing: stream TVEpisode_55665 is canceled 2012-06-25 18:06:44.6875 [WatchWorker(37)] DEBUG: WatchSharing: definitely killing stream TVEpisode_55665 with cancelwatching event 2012-06-25 18:07:09.4062 [WatchWorker(45)] DEBUG: WatchSharing: stream Movie_185 is canceled 2012-06-25 18:07:09.4062 [WatchWorker(45)] DEBUG: WatchSharing: definitely killing stream Movie_185 with cancelwatching event 2012-06-25 18:07:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:07:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 205000ms, runtime 1352680ms, progress 15% 2012-06-25 18:08:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:08:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 263000ms, runtime 1352680ms, progress 19% 2012-06-25 18:09:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:09:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 324000ms, runtime 1352680ms, progress 24% 2012-06-25 18:10:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:10:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 385000ms, runtime 1352680ms, progress 28% 2012-06-25 18:11:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:11:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 444000ms, runtime 1352680ms, progress 33% 2012-06-25 18:12:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:12:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 505000ms, runtime 1352680ms, progress 37% 2012-06-25 18:13:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:13:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 565000ms, runtime 1352680ms, progress 42% 2012-06-25 18:14:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:14:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 625000ms, runtime 1352680ms, progress 46% 2012-06-25 18:15:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:15:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 685000ms, runtime 1352680ms, progress 51% 2012-06-25 18:16:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:16:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 745000ms, runtime 1352680ms, progress 55% 2012-06-25 18:17:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:17:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 805000ms, runtime 1352680ms, progress 60% 2012-06-25 18:18:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:18:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 865000ms, runtime 1352680ms, progress 64% 2012-06-25 18:19:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:19:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 925000ms, runtime 1352680ms, progress 68% 2012-06-25 18:20:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:20:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 985000ms, runtime 1352680ms, progress 73% 2012-06-25 18:21:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:21:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1044000ms, runtime 1352680ms, progress 77% 2012-06-25 18:22:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:22:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1105000ms, runtime 1352680ms, progress 82% 2012-06-25 18:23:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:23:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1165000ms, runtime 1352680ms, progress 86% 2012-06-25 18:24:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:24:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1225000ms, runtime 1352680ms, progress 91% 2012-06-25 18:25:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:25:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1285000ms, runtime 1352680ms, progress 95% 2012-06-25 18:26:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:26:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1344000ms, runtime 1352680ms, progress 99% 2012-06-25 18:27:07.5156 [(19)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.-484197591.ts; profile=Android FFmpeg medium; start=1342; audioId=-1; subtitleId=-2 2012-06-25 18:27:07.5156 [(19)] DEBUG: Stopping stream with identifier aMPdroid.-484197591.ts 2012-06-25 18:27:07.5156 [(19)] DEBUG: WatchSharing: watch position -922ms, runtime 1352680ms, progress 0% 2012-06-25 18:27:07.5156 [(19)] DEBUG: WatchSharing: canceling stream TVEpisode_55661 2012-06-25 18:27:07.5156 [(19)] INFO: Stopping data unit 5 2012-06-25 18:27:07.5156 [(19)] DEBUG: Pipeline stopped 2012-06-25 18:27:07.5156 [(19)] DEBUG: StartStream with identifier aMPdroid.-484197591.ts for file mediatype=TVEpisode provider=6 id=55661 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E06 Homer.ist.ein.toller.Hippie.avi 2012-06-25 18:27:07.5156 [(19)] DEBUG: Using 532x400 as output size for stream aMPdroid.-484197591.ts 2012-06-25 18:27:07.5156 [(19)] INFO: WatchSharing: Picking up old stream 2012-06-25 18:27:07.5156 [(19)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 18:27:07.5156 [(19)] INFO: Assembling following pipeline: 2012-06-25 18:27:07.5156 [(19)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:27:07.5156 [(19)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:27:07.5156 [(19)] INFO: logconn 5 -> 6 2012-06-25 18:27:07.5156 [(19)] INFO: Encoding: starting output named pipe \\.\pipe\2dfdfaaa-14e6-455d-ae4f-7213ad1c6e59 2012-06-25 18:27:07.5156 [(19)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:27:07.5156 [(19)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:27:07.5156 [(19)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:27:07.5156 [(19)] INFO: Encoder: arguments -y -ss 1342 -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E06 Homer.ist.ein.toller.Hippie.avi" -s 532x400 -aspect 532:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\2dfdfaaa-14e6-455d-ae4f-7213ad1c6e59" 2012-06-25 18:27:07.5156 [(19)] DEBUG: Setup data unit 5 2012-06-25 18:27:07.5312 [(19)] DEBUG: Setup log unit 6 2012-06-25 18:27:07.5312 [(19)] INFO: Pipeline assembled 2012-06-25 18:27:07.5312 [(19)] INFO: Starting data unit 5 2012-06-25 18:27:07.5312 [(19)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:27:07.5625 [(20)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.-484197591.ts; profile=Android FFmpeg medium; start=1342; audioId=-1; subtitleId=-2 2012-06-25 18:27:07.7656 [(19)] INFO: All data units started! 2012-06-25 18:27:07.7656 [(19)] INFO: Started stream with identifier aMPdroid.-484197591.ts 2012-06-25 18:27:07.7656 [(20)] DEBUG: Stopping stream with identifier aMPdroid.-484197591.ts 2012-06-25 18:27:07.7656 [(20)] DEBUG: WatchSharing: watch position -672ms, runtime 1352680ms, progress 0% 2012-06-25 18:27:07.7656 [(20)] DEBUG: WatchSharing: canceling stream TVEpisode_55661 2012-06-25 18:27:07.7656 [(20)] INFO: Stopping data unit 5 2012-06-25 18:27:07.7656 [(20)] DEBUG: Encoding: Killing transcoder 2012-06-25 18:27:07.7656 [(20)] DEBUG: Pipeline stopped 2012-06-25 18:27:07.7656 [(20)] DEBUG: StartStream with identifier aMPdroid.-484197591.ts for file mediatype=TVEpisode provider=6 id=55661 filetype=Content offset=0 path=G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E06 Homer.ist.ein.toller.Hippie.avi 2012-06-25 18:27:07.7656 [(20)] DEBUG: Using 532x400 as output size for stream aMPdroid.-484197591.ts 2012-06-25 18:27:07.7656 [(20)] INFO: WatchSharing: Picking up old stream 2012-06-25 18:27:07.7656 [(20)] DEBUG: Final stream selection: audioId=1, subtitleId= 2012-06-25 18:27:07.7656 [(20)] INFO: Assembling following pipeline: 2012-06-25 18:27:07.7656 [(20)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input False, data True, log True) 2012-06-25 18:27:07.7656 [(20)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 18:27:07.7656 [(20)] INFO: logconn 5 -> 6 2012-06-25 18:27:07.7656 [(20)] INFO: Encoding: starting output named pipe \\.\pipe\cb16f627-8b06-4acd-92e8-7a34c978d2a9 2012-06-25 18:27:07.7656 [(20)] INFO: Encoder: Transcoder configuration dump 2012-06-25 18:27:07.7656 [(20)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 18:27:07.7656 [(20)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 18:27:07.7656 [(20)] INFO: Encoder: arguments -y -ss 1342 -i "G:\Filme\Serien\Die Simpsons\Season 10\Die Simpsons S10E06 Homer.ist.ein.toller.Hippie.avi" -s 532x400 -aspect 532:400 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\cb16f627-8b06-4acd-92e8-7a34c978d2a9" 2012-06-25 18:27:07.7656 [(20)] DEBUG: Setup data unit 5 2012-06-25 18:27:07.7812 [(20)] DEBUG: Setup log unit 6 2012-06-25 18:27:07.7812 [(20)] INFO: Pipeline assembled 2012-06-25 18:27:07.7812 [(20)] INFO: Starting data unit 5 2012-06-25 18:27:07.7812 [(20)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 18:27:07.8906 [(20)] INFO: All data units started! 2012-06-25 18:27:07.8906 [(20)] INFO: Started stream with identifier aMPdroid.-484197591.ts 2012-06-25 18:27:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:27:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1343187ms, runtime 1352680ms, progress 99% 2012-06-25 18:28:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:28:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1342218ms, runtime 1352680ms, progress 99% 2012-06-25 18:29:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:29:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1346281ms, runtime 1352680ms, progress 100% 2012-06-25 18:30:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:30:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1345375ms, runtime 1352680ms, progress 99% 2012-06-25 18:31:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:31:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1344375ms, runtime 1352680ms, progress 99% 2012-06-25 18:32:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:32:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1373890ms, runtime 1352680ms, progress 102% 2012-06-25 18:33:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:33:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1433890ms, runtime 1352680ms, progress 106% 2012-06-25 18:34:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:34:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1370109ms, runtime 1352680ms, progress 101% 2012-06-25 18:35:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:35:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1369906ms, runtime 1352680ms, progress 101% 2012-06-25 18:36:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:36:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 1429906ms, runtime 1352680ms, progress 106% 2012-06-25 18:37:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:37:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 0ms, runtime 1352680ms, progress 0% 2012-06-25 18:38:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: syncing status for TVEpisode_55661 2012-06-25 18:38:39.5000 [WatchWorker(30)] DEBUG: WatchSharing: watch position 0ms, runtime 1352680ms, progress 0% 2012-06-25 20:43:11.5000 [StreamTimeout(13)] INFO: Stream aMPdroid.-484197591.ts has been idle for 8166939 milliseconds with last activity at 25.6.2012 18:35:11, so cancel it 2012-06-25 20:43:11.5000 [StreamTimeout(13)] DEBUG: Called FinishStream with ident=aMPdroid.-484197591.ts 2012-06-25 20:43:11.5000 [StreamTimeout(13)] DEBUG: Stopping stream with identifier aMPdroid.-484197591.ts 2012-06-25 20:43:11.5000 [StreamTimeout(13)] DEBUG: WatchSharing: watch position 0ms, runtime 1352680ms, progress 0% 2012-06-25 20:43:11.5000 [StreamTimeout(13)] DEBUG: WatchSharing: canceling stream TVEpisode_55661 2012-06-25 20:43:11.5000 [StreamTimeout(13)] INFO: Stopping data unit 5 2012-06-25 20:43:11.5000 [StreamTimeout(13)] DEBUG: Encoding: Killing transcoder 2012-06-25 20:43:12.1093 [StreamTimeout(13)] DEBUG: Pipeline stopped 2012-06-25 20:43:12.1093 [StreamTimeout(13)] DEBUG: Killed stream with identifier aMPdroid.-484197591.ts 2012-06-25 20:43:12.1093 [WatchWorker(30)] DEBUG: WatchSharing: stream TVEpisode_55661 is canceled 2012-06-25 20:45:03.7543 [WatchWorker(30)] DEBUG: WatchSharing: stream TVEpisode_55661 is canceled 2012-06-25 20:45:28.0512 [(19)] INFO: Starting timeshifting on channel 470 for client aMPdroid with identifier aMPdroid.1134571847.ts 2012-06-25 20:45:28.0512 [(24)] DEBUG: Starting timeshifting with username webstreamingservice-aMPdroid.1134571847.ts on channel id 470 2012-06-25 20:45:28.0512 [(24)] DEBUG: Starting timeshifting 2012-06-25 20:45:29.8949 [(24)] DEBUG: Timeshifting succeeded 2012-06-25 20:45:30.0043 [(19)] DEBUG: Timeshifting started! 2012-06-25 20:45:30.0043 [(19)] INFO: Called InitStream with type=TV; provider=100; itemId=Z:\\live5-0.ts.tsbuffer; clientDescription=aMPdroid; identifier=aMPdroid.1134571847.ts; idleTimeout= 2012-06-25 20:45:30.2074 [(20)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.1134571847.ts; profile=Android FFmpeg medium; start=0; audioId=-1; subtitleId=-2 2012-06-25 20:45:30.2074 [(20)] DEBUG: StartStream with identifier aMPdroid.1134571847.ts for file mediatype=TV provider=100 id=Z:\\live5-0.ts.tsbuffer filetype=Content offset=0 path=Z:\\live5-0.ts.tsbuffer 2012-06-25 20:45:30.2074 [(20)] INFO: TsBuffer: Files added 1, removed 0 2012-06-25 20:45:30.2074 [(20)] DEBUG: Using path Z:\\live5-0.ts.tsbuffer1.ts from TS buffer Z:\\live5-0.ts.tsbuffer as source for mediatype=TV provider=100 id=Z:\\live5-0.ts.tsbuffer filetype=Content offset=0 path=Z:\\live5-0.ts.tsbuffer 2012-06-25 20:45:30.3480 [(20)] DEBUG: Using 600x336 as output size for stream aMPdroid.1134571847.ts 2012-06-25 20:45:30.3480 [(20)] DEBUG: Final stream selection: audioId=64, subtitleId= 2012-06-25 20:45:30.3480 [(20)] INFO: Assembling following pipeline: 2012-06-25 20:45:30.3480 [(20)] INFO: data 1: MPExtended.Services.StreamingService.Units.InputUnit (input False, data True, log False) 2012-06-25 20:45:30.3480 [(20)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input True, data True, log True) 2012-06-25 20:45:30.3480 [(20)] INFO: dataconn 1 -> 5 2012-06-25 20:45:30.3480 [(20)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 20:45:30.3480 [(20)] INFO: logconn 5 -> 6 2012-06-25 20:45:30.3480 [(20)] INFO: Using TsBuffer to read input 2012-06-25 20:45:30.3480 [(20)] INFO: TsBuffer: Files added 1, removed 0 2012-06-25 20:45:30.3480 [(20)] DEBUG: Setup data unit 1 2012-06-25 20:45:30.3480 [(20)] INFO: Encoding: starting input named pipe \\.\pipe\f89fb6fe-eb4b-424f-872d-b45813457dbc 2012-06-25 20:45:30.3480 [(20)] INFO: Encoding: starting output named pipe \\.\pipe\433ff40d-5f7c-4e00-b825-b3b7dc3c1fa5 2012-06-25 20:45:30.3480 [(20)] INFO: Encoder: Transcoder configuration dump 2012-06-25 20:45:30.3480 [(20)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 20:45:30.3480 [(20)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 20:45:30.3480 [(20)] INFO: Encoder: arguments -y -i "\\.\pipe\f89fb6fe-eb4b-424f-872d-b45813457dbc" -s 600x336 -aspect 600:336 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\433ff40d-5f7c-4e00-b825-b3b7dc3c1fa5" 2012-06-25 20:45:30.3480 [(20)] DEBUG: Setup data unit 5 2012-06-25 20:45:30.3480 [(20)] DEBUG: Setup log unit 6 2012-06-25 20:45:30.3480 [(20)] INFO: Pipeline assembled 2012-06-25 20:45:30.3480 [(20)] INFO: Starting data unit 1 2012-06-25 20:45:30.3480 [(20)] INFO: Starting data unit 5 2012-06-25 20:45:30.4574 [(20)] INFO: Encoding: Copy stream of type MPExtended.Services.StreamingService.Code.TsBuffer into transcoder input stream of type MPExtended.Services.StreamingService.Code.NamedPipe 2012-06-25 20:45:30.4574 [(20)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 20:45:36.3637 [(20)] INFO: All data units started! 2012-06-25 20:45:36.3637 [(20)] INFO: Started stream with identifier aMPdroid.1134571847.ts 2012-06-25 20:46:03.7543 [WatchWorker(30)] DEBUG: WatchSharing: stream TVEpisode_55661 is canceled 2012-06-25 20:47:03.7543 [WatchWorker(30)] DEBUG: WatchSharing: stream TVEpisode_55661 is canceled 2012-06-25 20:48:03.7543 [WatchWorker(30)] DEBUG: WatchSharing: stream TVEpisode_55661 is canceled 2012-06-25 20:49:03.7543 [WatchWorker(30)] DEBUG: WatchSharing: stream TVEpisode_55661 is canceled 2012-06-25 20:49:03.7543 [WatchWorker(30)] DEBUG: WatchSharing: definitely killing stream TVEpisode_55661 with cancelwatching event 2012-06-25 20:51:25.1293 [(20)] DEBUG: Called FinishStream with ident=aMPdroid.1134571847.ts 2012-06-25 20:51:25.1293 [(20)] DEBUG: Stopping stream with identifier aMPdroid.1134571847.ts 2012-06-25 20:51:25.1293 [(20)] INFO: Stopping data unit 1 2012-06-25 20:51:25.1449 [(20)] INFO: Stopping data unit 5 2012-06-25 20:51:25.1449 [(20)] DEBUG: Encoding: Killing transcoder 2012-06-25 20:51:25.1449 [(20)] DEBUG: Pipeline stopped 2012-06-25 20:51:25.1449 [(20)] DEBUG: Killed stream with identifier aMPdroid.1134571847.ts 2012-06-25 20:51:25.1449 [(20)] INFO: Cancel timeshifting with identifier aMPdroid.1134571847.ts 2012-06-25 20:51:25.1449 [(38)] DEBUG: IOException in NamedPipe.Write, is usually no problem System.IO.IOException: Pipe is broken. at System.IO.Pipes.PipeStream.WinIOError(Int32 errorCode) at System.IO.Pipes.PipeStream.EndWrite(IAsyncResult asyncResult) at System.IO.Pipes.PipeStream.WriteCore(Byte[] buffer, Int32 offset, Int32 count) at System.IO.Pipes.PipeStream.Write(Byte[] buffer, Int32 offset, Int32 count) at MPExtended.Services.StreamingService.Code.NamedPipe.Write(Byte[] buffer, Int32 offset, Int32 count) 2012-06-25 20:51:25.1449 [(38)] INFO: StreamCopy transinput: IOException in inner stream copy, is usually ok: Pipe is broken. 2012-06-25 20:56:20.7699 [(20)] INFO: Starting timeshifting on channel 470 for client aMPdroid with identifier aMPdroid.1663258922.ts 2012-06-25 20:56:20.7699 [(24)] DEBUG: Starting timeshifting with username webstreamingservice-aMPdroid.1663258922.ts on channel id 470 2012-06-25 20:56:20.7699 [(24)] DEBUG: Starting timeshifting 2012-06-25 20:56:22.3012 [(24)] DEBUG: Timeshifting succeeded 2012-06-25 20:56:22.4262 [(20)] DEBUG: Timeshifting started! 2012-06-25 20:56:22.4262 [(20)] INFO: Called InitStream with type=TV; provider=100; itemId=Z:\\live5-0.ts.tsbuffer; clientDescription=aMPdroid; identifier=aMPdroid.1663258922.ts; idleTimeout= 2012-06-25 20:56:22.7230 [(20)] DEBUG: Called StartStreamWithStreamSelection with ident=aMPdroid.1663258922.ts; profile=Android FFmpeg medium; start=0; audioId=-1; subtitleId=-2 2012-06-25 20:56:22.7230 [(20)] DEBUG: StartStream with identifier aMPdroid.1663258922.ts for file mediatype=TV provider=100 id=Z:\\live5-0.ts.tsbuffer filetype=Content offset=0 path=Z:\\live5-0.ts.tsbuffer 2012-06-25 20:56:22.7230 [(20)] INFO: TsBuffer: Files added 1, removed 0 2012-06-25 20:56:22.7230 [(20)] DEBUG: Using path Z:\\live5-0.ts.tsbuffer1.ts from TS buffer Z:\\live5-0.ts.tsbuffer as source for mediatype=TV provider=100 id=Z:\\live5-0.ts.tsbuffer filetype=Content offset=0 path=Z:\\live5-0.ts.tsbuffer 2012-06-25 20:56:22.8480 [(20)] DEBUG: Using 600x336 as output size for stream aMPdroid.1663258922.ts 2012-06-25 20:56:22.8480 [(20)] DEBUG: Final stream selection: audioId=64, subtitleId= 2012-06-25 20:56:22.8480 [(20)] INFO: Assembling following pipeline: 2012-06-25 20:56:22.8480 [(20)] INFO: data 1: MPExtended.Services.StreamingService.Units.InputUnit (input False, data True, log False) 2012-06-25 20:56:22.8480 [(20)] INFO: data 5: MPExtended.Services.StreamingService.Units.EncoderUnit (input True, data True, log True) 2012-06-25 20:56:22.8480 [(20)] INFO: dataconn 1 -> 5 2012-06-25 20:56:22.8480 [(20)] INFO: log 6: MPExtended.Services.StreamingService.Units.FFMpegLogParsingUnit 2012-06-25 20:56:22.8480 [(20)] INFO: logconn 5 -> 6 2012-06-25 20:56:22.8480 [(20)] INFO: Using TsBuffer to read input 2012-06-25 20:56:22.8480 [(20)] INFO: TsBuffer: Files added 1, removed 0 2012-06-25 20:56:22.8480 [(20)] DEBUG: Setup data unit 1 2012-06-25 20:56:22.8480 [(20)] INFO: Encoding: starting input named pipe \\.\pipe\1a47b628-df09-47ea-acf1-a2928aafbde3 2012-06-25 20:56:22.8480 [(20)] INFO: Encoding: starting output named pipe \\.\pipe\40bd5aa1-bf27-4dde-ac99-7853ace42f5d 2012-06-25 20:56:22.8480 [(20)] INFO: Encoder: Transcoder configuration dump 2012-06-25 20:56:22.8480 [(20)] INFO: Encoder: hasStdin False, hasStdout False, hasStderr True 2012-06-25 20:56:22.8480 [(20)] INFO: Encoder: path Streaming\ffmpeg.exe 2012-06-25 20:56:22.8480 [(20)] INFO: Encoder: arguments -y -i "\\.\pipe\1a47b628-df09-47ea-acf1-a2928aafbde3" -s 600x336 -aspect 600:336 -map v:0 -map a:0 -codec:v libx264 -b:v 512k -profile:v baseline -preset:v fast -coder rle -codec:a aac -b:a 128k -ac 2 -strict experimental -async 1 -sn -f mpegts "\\.\pipe\40bd5aa1-bf27-4dde-ac99-7853ace42f5d" 2012-06-25 20:56:22.8480 [(20)] DEBUG: Setup data unit 5 2012-06-25 20:56:22.8480 [(20)] DEBUG: Setup log unit 6 2012-06-25 20:56:22.8480 [(20)] INFO: Pipeline assembled 2012-06-25 20:56:22.8480 [(20)] INFO: Starting data unit 1 2012-06-25 20:56:22.8480 [(20)] INFO: Starting data unit 5 2012-06-25 20:56:22.9574 [(20)] INFO: Encoding: Copy stream of type MPExtended.Services.StreamingService.Code.TsBuffer into transcoder input stream of type MPExtended.Services.StreamingService.Code.NamedPipe 2012-06-25 20:56:22.9574 [(20)] INFO: Encoding: Waiting till output named pipe is ready 2012-06-25 20:56:28.3168 [(20)] INFO: All data units started! 2012-06-25 20:56:28.3168 [(20)] INFO: Started stream with identifier aMPdroid.1663258922.ts 2012-06-25 21:05:53.8168 [(15)] INFO: TsBuffer: Files added 1, removed 0 2012-06-25 21:14:27.0980 [(11)] INFO: TsBuffer: Files added 1, removed 0 2012-06-25 21:20:11.4262 [(20)] DEBUG: Called FinishStream with ident=aMPdroid.1663258922.ts 2012-06-25 21:20:11.4262 [(20)] DEBUG: Stopping stream with identifier aMPdroid.1663258922.ts 2012-06-25 21:20:11.4262 [(20)] INFO: Stopping data unit 1 2012-06-25 21:20:11.4418 [(20)] INFO: Stopping data unit 5 2012-06-25 21:20:11.4574 [(20)] DEBUG: Encoding: Killing transcoder 2012-06-25 21:20:11.4574 [(20)] DEBUG: Pipeline stopped 2012-06-25 21:20:11.4574 [(20)] DEBUG: Killed stream with identifier aMPdroid.1663258922.ts 2012-06-25 21:20:11.4574 [(20)] INFO: Cancel timeshifting with identifier aMPdroid.1663258922.ts 2012-06-25 21:20:11.4574 [(22)] DEBUG: IOException in NamedPipe.Write, is usually no problem System.IO.IOException: Pipe is broken. at System.IO.Pipes.PipeStream.WinIOError(Int32 errorCode) at System.IO.Pipes.PipeStream.EndWrite(IAsyncResult asyncResult) at System.IO.Pipes.PipeStream.WriteCore(Byte[] buffer, Int32 offset, Int32 count) at System.IO.Pipes.PipeStream.Write(Byte[] buffer, Int32 offset, Int32 count) at MPExtended.Services.StreamingService.Code.NamedPipe.Write(Byte[] buffer, Int32 offset, Int32 count) 2012-06-25 21:20:11.4574 [(22)] INFO: StreamCopy transinput: IOException in inner stream copy, is usually ok: Pipe is broken.