[Bug] Problem with streaming of recordings (1 Viewer)

[megahorst]

I have a problem with streaming of tv recordings.

In most cases I get a message "Stream Fehler", stream error, Are there any logs, that are helpfull for debugging?

 

[DieBagger]

Yes please post the MPExtended logs...

 

[megahorst]

I have captured the logs.

I think, that this could be the interesting entry:

2012-12-04 20:52:20.32273 [(8)] INFO: Called InitStream with type=Recording; provider=0; itemId=0; offset=0; clientDescription=Slider; identifier=aMPdroid.-198091228.ts; idleTimeout=
2012-12-04 20:52:20.32373 [(22)] WARN: Tried to convert a null Recording to WebRecordingBasic
2012-12-04 20:52:20.32373 [(22)] WARN: Failed to load fileinfo for recording
System.NullReferenceException: Der Objektverweis wurde nicht auf eine Objektinstanz festgelegt.
  bei MPExtended.Services.TVAccessService.TVAccessService.GetRecordingFileInfo(Int32 id) in C:\Users\Oxan\Documents\Projects\MPExtended\Services\MPExtended.Services.TVAccessService\TVAccessService.cs:Zeile 811.
2012-12-04 20:52:20.32473 [(8)] ERROR: Unhandled exception in service (JSON interface)
System.NullReferenceException: Der Objektverweis wurde nicht auf eine Objektinstanz festgelegt.
  bei MPExtended.Libraries.Service.Util.PathUtil.StripFileProtocolPrefix(String path) in C:\Users\Oxan\Documents\Projects\MPExtended\Libraries\MPExtended.Libraries.Service\Util\PathUtil.cs:Zeile 63.
  bei MPExtended.Services.StreamingService.Code.MediaSource.GetFileInfo() in C:\Users\Oxan\Documents\Projects\MPExtended\Services\MPExtended.Services.StreamingService\Code\MediaSource.cs:Zeile 131.
  bei MPExtended.Services.StreamingService.Code.MediaSource.get_Exists() in C:\Users\Oxan\Documents\Projects\MPExtended\Services\MPExtended.Services.StreamingService\Code\MediaSource.cs:Zeile 48.
  bei MPExtended.Services.StreamingService.Code.Streaming.InitStream(String identifier, String clientDescription, MediaSource source, Int32 timeout) in C:\Users\Oxan\Documents\Projects\MPExtended\Services\MPExtended.Services.StreamingService\Code\Streaming.cs:Zeile 148.
  bei MPExtended.Services.StreamingService.StreamingService.InitStream(WebMediaType type, Nullable`1 provider, String itemId, Nullable`1 offset, String clientDescription, String identifier, Nullable`1 idleTimeout) in C:\Users\Oxan\Documents\Projects\MPExtended\Services\MPExtended.Services.StreamingService\StreamingService.cs:Zeile 220.
  bei SyncInvokeInitStream(Object , Object[] , Object[] )
  bei System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs)
  bei System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc)
  bei System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc)
  bei System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage41(MessageRpc& rpc)
  bei System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage4(MessageRpc& rpc)
  bei System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage31(MessageRpc& rpc)
  bei System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage3(MessageRpc& rpc)
  bei System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage2(MessageRpc& rpc)
  bei System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc)
  bei System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage1(MessageRpc& rpc)
  bei System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet)

I have attached the full logs to.

 

[DieBagger]

Can you open this link in a webbrowser and post the result (or send it to me) -> http://[ip-of-server]:4322/MPExtended/TvAccessService/json/GetRecordings

Also log files from android would help too...

 

[megahorst]

the output was generated at a pc within my local network. I send it as a PM.
Ok, I don't know how to send PMs with files in. I will attach the output.

I was asked for username and password before.

Where do I find the logfiles on my tablet? I don't have root acess.

 

[megahorst]

This issue does still exist. Any suggestions for a workaround or a final solution?

 

[DieBagger]

This issue does still exist. Any suggestions for a workaround or a final solution?

Workung on it, can you post the log files of your phone please?

 

[megahorst]

This issue does still exist. Any suggestions for a workaround or a final solution?

Workung on it, can you post the log files of your phone please?

Of course, but where do I find the logs?

 

[DieBagger]

This issue does still exist. Any suggestions for a workaround or a final solution?

Workung on it, can you post the log files of your phone please?

Of course, but where do I find the logs?

http://wiki.team-mediaportal.com/1_.../aMPdroid/Troubleshooting/How_to_report_a_Bug

 

[megahorst]

I have managed to get some loginfo from my tablet.

build.board: EeePad
build.bootloader: unknown
build.brand: asus
build.cpu_abi: armeabi-v7a
build.cpu_abi2: armeabi
build.device: SL101
build.display: IML74K.WW_epad-9.2.1.27-20120615
build.fingerprint: asus/WW_epad/SL101:4.0.3/IML74K/WW_epad-9.2.1.27-20120615:user/release-keys
build.hardware: ventana
build.host: Mars
build.id: IML74K
build.manufacturer: asus
build.model: Slider SL101
build.product: WW_epad
build.radio: unknown
build.serial: 043c7081423f94d7
build.tags: release-keys
build.time: 1339761901000
build.type: user
build.user: unknown
version.codename: REL
version.incremental: WW_epad-9.2.1.27-20120615
version.release: 4.0.3
version.sdk_int: 15
 
12-11 20:57:34.382 I/System  (7765): Failed to destroy process 7952
12-11 20:57:34.382 I/System  (7765): libcore.io.ErrnoException: kill failed: ESRCH (No such process)
12-11 20:57:34.382 I/System  (7765):    at libcore.io.Posix.kill(Native Method)
12-11 20:57:34.382 I/System  (7765):    at libcore.io.ForwardingOs.kill(ForwardingOs.java:77)
12-11 20:57:34.382 I/System  (7765):    at java.lang.ProcessManager$ProcessImpl.destroy(ProcessManager.java:257)
12-11 20:57:34.382 I/System  (7765):    at com.nolanlawson.logcat.b.i.a(Unknown Source)
12-11 20:57:34.382 I/System  (7765):    at com.nolanlawson.logcat.b.f.b(Unknown Source)
12-11 20:57:34.382 I/System  (7765):    at com.nolanlawson.logcat.reader.LogcatReaderLoader.<init>(Unknown Source)
12-11 20:57:34.382 I/System  (7765):    at com.nolanlawson.logcat.reader.LogcatReaderLoader.a(Unknown Source)
12-11 20:57:34.382 I/System  (7765):    at com.nolanlawson.logcat.b.l.a(Unknown Source)
12-11 20:57:34.382 I/System  (7765):    at com.nolanlawson.logcat.b.c.doInBackground(Unknown Source)
12-11 20:57:34.382 I/System  (7765):    at android.os.AsyncTask$2.call(AsyncTask.java:264)
12-11 20:57:34.382 I/System  (7765):    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:305)
12-11 20:57:34.382 I/System  (7765):    at java.util.concurrent.FutureTask.run(FutureTask.java:137)
12-11 20:57:34.382 I/System  (7765):    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1076)
12-11 20:57:34.382 I/System  (7765):    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:569)
12-11 20:57:34.382 I/System  (7765):    at java.lang.Thread.run(Thread.java:856)
12-11 20:57:34.452 D/dalvikvm(7765): GC_CONCURRENT freed 975K, 34% free 9543K/14407K, paused 2ms+4ms
12-11 20:57:34.592 D/WindowManager(164): readLidState, sw:1
12-11 20:57:34.592 D/WindowManager(164): adjustConfigurationLw, config:{1.0 0mcc0mnc (no locale) layoutdir=0 sw800dp w1280dp h752dp xlrg land ?uimode ?night finger qwerty/v/v -nav/v} mLidOpen:1 mHasDockFeature:false mHasHallSensorFeature:true config.hardKeyboardHidden:1
12-11 20:57:34.592 I/dalvikvm(7765): Jit: resizing JitTable from 4096 to 8192
12-11 20:57:34.592 V/TabletStatusBar(270): setLightsOn(true)
12-11 20:57:34.712 I/TextType(429): TextType = 0x0
12-11 20:57:34.992 D/dalvikvm(7765): GC_CONCURRENT freed 954K, 34% free 9598K/14407K, paused 2ms+5ms
12-11 20:57:37.692 D/PowerManagerService(164): @PowerManagement: 'KEEP_SCREEN_ON_FLAG' releaseWakeLock when screen locked
12-11 20:57:37.792 D/dalvikvm(7765): GC_CONCURRENT freed 1031K, 35% free 9482K/14407K, paused 2ms+4ms
12-11 20:57:39.982 D/dalvikvm(270): GC_CONCURRENT freed 2273K, 53% free 9872K/20743K, paused 2ms+4ms
12-11 20:57:40.462 D/dalvikvm(270): GC_CONCURRENT freed 125K, 48% free 10790K/20743K, paused 2ms+3ms
12-11 20:57:41.582 D/dalvikvm(164): GC_FOR_ALLOC freed 1793K, 22% free 17753K/22535K, paused 67ms
12-11 20:57:41.592 D/WindowManager(164): readLidState, sw:1
12-11 20:57:41.592 D/WindowManager(164): adjustConfigurationLw, config:{1.0 0mcc0mnc (no locale) layoutdir=0 sw800dp w1280dp h752dp xlrg land ?uimode ?night finger qwerty/v/v -nav/v} mLidOpen:1 mHasDockFeature:false mHasHallSensorFeature:true config.hardKeyboardHidden:1
12-11 20:57:41.672 D/aMPdroid(7830): Add new listener class com.mediaportal.ampdroid.activities.mediaplayback.ActivityStreamingDetails
12-11 20:57:41.672 D/aMPdroid(7830): Number of listeners: 2
12-11 20:57:41.862 D/OpenGLRenderer(270): Flushing caches (mode 0)
12-11 20:57:42.082 I/aMPdroid(7830): getting playback session state from db
12-11 20:57:42.232 I/TextType(429): TextType = 0x0
12-11 20:57:42.252 D/dalvikvm(7830): GC_CONCURRENT freed 1991K, 13% free 23786K/27335K, paused 2ms+14ms
12-11 20:57:42.312 D/skia    (7830): --- SkImageDecoder::Factory returned null
12-11 20:57:42.322 W/InputManagerService(164): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@418ac960 (uid=10128 pid=7765)
12-11 20:57:43.192 D/dalvikvm(456): GC_EXPLICIT freed 3215K, 43% free 13012K/22535K, paused 8ms+4ms
12-11 20:57:43.282 D/dalvikvm(164): GC_EXPLICIT freed 304K, 22% free 17624K/22535K, paused 3ms+7ms
12-11 20:57:44.602 D/WindowManager(164): readLidState, sw:1
12-11 20:57:44.602 D/WindowManager(164): adjustConfigurationLw, config:{1.0 0mcc0mnc (no locale) layoutdir=0 sw800dp w1280dp h752dp xlrg land ?uimode ?night finger qwerty/v/v -nav/v} mLidOpen:1 mHasDockFeature:false mHasHallSensorFeature:true config.hardKeyboardHidden:1
12-11 20:57:45.142 D/aMPdroid(7830): Add new listener class com.mediaportal.ampdroid.activities.tv.ActivityTvServerFeatures
12-11 20:57:45.142 D/aMPdroid(7830): Number of listeners: 3
12-11 20:57:45.222 I/TextType(429): TextType = 0x0
12-11 20:57:45.252 D/OpenGLRenderer(7830): Flushing caches (mode 0)
12-11 20:57:45.472 D/aMPdroid(7830): Remove listener class com.mediaportal.ampdroid.activities.mediaplayback.ActivityStreamingDetails
12-11 20:57:45.472 D/aMPdroid(7830): Number of listeners: 2
12-11 20:57:46.742 I/ActivityManager(164): START {cmp=com.mediaportal.ampdroid/.activities.mediaplayback.ActivityStreamingDetails (has extras)} from pid 7830
12-11 20:57:46.782 D/WindowManager(164): readLidState, sw:1
12-11 20:57:46.782 D/WindowManager(164): adjustConfigurationLw, config:{1.0 0mcc0mnc (no locale) layoutdir=0 sw800dp w1280dp h752dp xlrg land ?uimode ?night finger qwerty/v/v -nav/v} mLidOpen:1 mHasDockFeature:false mHasHallSensorFeature:true config.hardKeyboardHidden:1
12-11 20:57:46.852 I/aMPdroid(7830): onActivityCreated
12-11 20:57:46.852 I/aMPdroid(7830): getting playback session state from db
12-11 20:57:46.882 D/skia    (7830): --- SkImageDecoder::Factory returned null
12-11 20:57:47.512 D/aMPdroid(7830): Add new listener class com.mediaportal.ampdroid.activities.mediaplayback.ActivityStreamingDetails
12-11 20:57:47.512 D/aMPdroid(7830): Number of listeners: 3
12-11 20:57:47.612 I/aMPdroid(7830): getting playback session state from db
12-11 20:57:47.642 D/skia    (7830): --- SkImageDecoder::Factory returned null
12-11 20:57:47.672 I/ActivityManager(164): Displayed com.mediaportal.ampdroid/.activities.mediaplayback.ActivityStreamingDetails: +888ms
12-11 20:57:47.682 I/TextType(429): TextType = 0x0
12-11 20:57:47.712 D/OpenGLRenderer(7830): Flushing caches (mode 0)
12-11 20:57:47.722 D/dalvikvm(429): GC_CONCURRENT freed 433K, 53% free 7079K/14983K, paused 3ms+3ms
12-11 20:57:47.782 V/        (164): void cb_onMotion(uint16_t)
12-11 20:57:47.902 D/aMPdroid(7830): Remove listener class com.mediaportal.ampdroid.activities.tv.ActivityTvServerFeatures
12-11 20:57:47.902 D/aMPdroid(7830): Number of listeners: 2
12-11 20:57:49.932 I/ActivityManager(164): START {cmp=com.mediaportal.ampdroid/.activities.mediaplayback.ActivityVideoPlayer (has extras)} from pid 7830
12-11 20:57:49.972 D/WindowManager(164): readLidState, sw:1
12-11 20:57:49.972 D/WindowManager(164): adjustConfigurationLw, config:{1.0 0mcc0mnc (no locale) layoutdir=0 sw800dp w1280dp h752dp xlrg land ?uimode ?night finger qwerty/v/v -nav/v} mLidOpen:1 mHasDockFeature:false mHasHallSensorFeature:true config.hardKeyboardHidden:1
12-11 20:57:49.992 D/aMPdroid(7830): Current screen width: 1280x752
12-11 20:57:49.992 D/aMPdroid(7830): Starting UI Handler
12-11 20:57:50.202 D/aMPdroid(7830): Add new listener class com.mediaportal.ampdroid.activities.mediaplayback.ActivityVideoPlayer
12-11 20:57:50.212 D/aMPdroid(7830): Number of listeners: 3
12-11 20:57:50.302 D/aMPdroid(7830): MediaPlayer onResume
12-11 20:57:50.302 D/aMPdroid(7830): MediaPlayer onStart, screen on -> start playback
12-11 20:57:50.302 I/aMPdroid(7830): Start streaming task
12-11 20:57:50.302 I/aMPdroid(7830): Downloading overlay for position 0
12-11 20:57:50.332 D/skia    (7830): --- SkImageDecoder::Factory returned null
12-11 20:57:50.342 D/aMPdroid_VIDEO(7830): surfaceCreated called
12-11 20:57:50.342 D/aMPdroid_VIDEO(7830): surfaceChanged called: 4, 1280x752
12-11 20:57:50.392 I/ActivityManager(164): Displayed com.mediaportal.ampdroid/.activities.mediaplayback.ActivityVideoPlayer: +419ms
12-11 20:57:50.392 I/TextType(429): TextType = 0x0
12-11 20:57:50.412 D/OpenGLRenderer(7830): Flushing caches (mode 0)
12-11 20:57:50.502 I/aMPdroid(7830): Initialising Media Stream (type:Recording, id: 0)
12-11 20:57:50.592 E/aMPdroid(7830): Server exception: com.mediaportal.ampdroid.api.mpext.WebServiceException: Der Objektverweis wurde nicht auf eine Objektinstanz festgelegt.
12-11 20:57:50.602 E/aMPdroid(7830): Server exception:
12-11 20:57:50.602 E/aMPdroid(7830): com.mediaportal.ampdroid.api.mpext.WebServiceException: Der Objektverweis wurde nicht auf eine Objektinstanz festgelegt.
12-11 20:57:50.602 E/aMPdroid(7830):    at java.lang.reflect.Constructor.constructNative(Native Method)
12-11 20:57:50.602 E/aMPdroid(7830):    at java.lang.reflect.Constructor.newInstance(Constructor.java:417)
12-11 20:57:50.602 E/aMPdroid(7830):    at org.codehaus.jackson.map.introspect.AnnotatedConstructor.call1(AnnotatedConstructor.java:109)
12-11 20:57:50.602 E/aMPdroid(7830):    at org.codehaus.jackson.map.deser.std.StdValueInstantiator.createFromString(StdValueInstantiator.java:263)
12-11 20:57:50.602 E/aMPdroid(7830):    at org.codehaus.jackson.map.deser.std.ThrowableDeserializer.deserializeFromObject(ThrowableDeserializer.java:150)
12-11 20:57:50.602 E/aMPdroid(7830):    at org.codehaus.jackson.map.deser.BeanDeserializer.deserialize(BeanDeserializer.java:580)
12-11 20:57:50.602 E/aMPdroid(7830):    at org.codehaus.jackson.map.ObjectMapper._readMapAndClose(ObjectMapper.java:2732)
12-11 20:57:50.602 E/aMPdroid(7830):    at org.codehaus.jackson.map.ObjectMapper.readValue(ObjectMapper.java:1863)
12-11 20:57:50.602 E/aMPdroid(7830):    at com.mediaportal.ampdroid.api.mpext.BaseJsonWebservice.getObjectsFromJsonWithExceptions(BaseJsonWebservice.java:44)
12-11 20:57:50.602 E/aMPdroid(7830):    at com.mediaportal.ampdroid.api.mpext.StreamingJsonWebserviceApi.initStreaming(StreamingJsonWebserviceApi.java:73)
12-11 20:57:50.602 E/aMPdroid(7830):    at com.mediaportal.ampdroid.api.DataHandler.initStreaming(DataHandler.java:1115)
12-11 20:57:50.602 E/aMPdroid(7830):    at com.mediaportal.ampdroid.activities.mediaplayback.FragmentVideoPlayer$StartStreamingTask.doInBackground(FragmentVideoPlayer.java:90)
12-11 20:57:50.602 E/aMPdroid(7830):    at com.mediaportal.ampdroid.activities.mediaplayback.FragmentVideoPlayer$StartStreamingTask.doInBackground(FragmentVideoPlayer.java:1)
12-11 20:57:50.602 E/aMPdroid(7830):    at android.os.AsyncTask$2.call(AsyncTask.java:264)
12-11 20:57:50.602 E/aMPdroid(7830):    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:305)
12-11 20:57:50.602 E/aMPdroid(7830):    at java.util.concurrent.FutureTask.run(FutureTask.java:137)
12-11 20:57:50.602 E/aMPdroid(7830):    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1076)
12-11 20:57:50.602 E/aMPdroid(7830):    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:569)
12-11 20:57:50.602 E/aMPdroid(7830):    at java.lang.Thread.run(Thread.java:856)
12-11 20:57:50.602 I/aMPdroid(7830): Finish StartStream AsyncTask
12-11 20:57:50.622 D/aMPdroid(7830): Remove listener class com.mediaportal.ampdroid.activities.mediaplayback.ActivityStreamingDetails
12-11 20:57:50.622 D/aMPdroid(7830): Number of listeners: 2
12-11 20:57:55.472 V/        (164): void cb_onMotion(uint16_t)
12-11 20:57:55.762 D/dalvikvm(270): GC_CONCURRENT freed 2211K, 53% free 9930K/20743K, paused 2ms+4ms
12-11 20:57:56.462 D/dalvikvm(270): GC_CONCURRENT freed 119K, 48% free 10904K/20743K, paused 8ms+5ms
12-11 20:57:58.382 I/aMPdroid(7830): Saving playback session state to db
12-11 20:57:58.462 D/WindowManager(164): readLidState, sw:1
12-11 20:57:58.462 D/WindowManager(164): adjustConfigurationLw, config:{1.0 0mcc0mnc (no locale) layoutdir=0 sw800dp w1280dp h752dp xlrg land ?uimode ?night finger qwerty/v/v -nav/v} mLidOpen:1 mHasDockFeature:false mHasHallSensorFeature:true config.hardKeyboardHidden:1
12-11 20:57:58.642 D/dalvikvm(7765): GC_CONCURRENT freed 763K, 34% free 9600K/14407K, paused 2ms+6ms
12-11 20:57:58.652 D/OpenGLRenderer(270): Flushing caches (mode 0)
12-11 20:57:58.772 D/aMPdroid_VIDEO(7830): surfaceDestroyed called
12-11 20:57:58.772 D/OpenGLRenderer(7830): Flushing caches (mode 0)
12-11 20:57:58.782 V/TabletStatusBar(270): setLightsOn(true)
12-11 20:57:58.872 I/TextType(429): TextType = 0x0
12-11 20:57:59.042 D/OpenGLRenderer(7830): Flushing caches (mode 1)
12-11 20:57:59.312 D/PowerManagerService(164): @PowerManagement: 'KEEP_SCREEN_ON_FLAG' releaseWakeLock when screen locked
12-11 20:57:59.362 D/aMPdroid(7830): Remove listener class com.mediaportal.ampdroid.activities.mediaplayback.ActivityVideoPlayer
12-11 20:57:59.362 D/aMPdroid(7830): Number of listeners: 1
12-11 20:58:00.712 D/dalvikvm(28462): GC_FOR_ALLOC freed 376K, 9% free 7416K/8135K, paused 16ms
12-11 20:58:03.662 D/QuickSettingsView(270): onFinishInflate(): check if slider should be shown
12-11 20:58:03.662 V/StatusBar.StereoSepElement(270): HDMI Display NOT connected
12-11 20:58:03.662 D/QuickSettingsView(270): onFinishInflate(): set visibility on entire slider element to GONE
12-11 20:58:03.662 W/ActivityManager(164): Unable to start service Intent { cmp=com.nvidia.NvCPLSvc/.NvCPLService (has extras) }: not found