google / ExoPlayer

This project is deprecated and stale. The latest ExoPlayer code is available in https://github.com/androidx/media
https://developer.android.com/media/media3/exoplayer
Apache License 2.0
21.71k stars 6.02k forks source link

Player blocked after empty preroll #4622

Closed andrewger157 closed 6 years ago

andrewger157 commented 6 years ago

Before filing an issue:

I Have searched existing issues, including issues that are closed but no luck.

When reporting a bug:

The bug occurs using the "extension-ima" library in case the call to the preroll returns an empty xml or goes into error

Issue description

Using the extension-ima library for managing the dfp advertising, if the call to the preroll returns an empty xml (or the call goes into error) all the advertisements after them (which are midroll or postroll) are not reproduced and the player remains locked at them.

Reproduction steps

to reproduce the bug with the ExoPlayer demo app it is sufficient to use an "ad_tag_url" which returns an empty preroll. If the xml also contains a midroll, the player will stop at the minute when the midroll should have started, if instead the xml contains only the postroll the player will hang on the last frame of the video content

Version of ExoPlayer being used

exoplayer:2.8.2 extension-ima:2.8.2 (also tested with version 2.7.3)

Device(s) and version(s) of Android being used

Samsung A5 Android 8.0 Samsung Galaxy s3 Neo Android 4.4.2 Huawei P8 Lite Android 7.0 Huawei P20 Android 8.1

A full bug report captured from the device

In the test I checked the traffic through Charles, and I noticed that after the call to the preroll (empty) no more calls are made for the mid / post-roll. Below is the log taken by charles https://drive.google.com/open?id=1bvobYfx3e8PC8O6baJVLjKZNBDpUYvxx

From the device, turning on the debug mode of the extensions-ima library, I have captured only the following Logs:

08-07 10:52:34.179 30320-30320 W/IMASDK: Invalid internal message, ignoring. Please make sure the Google IMA SDK library is up to date. Message: gmsg://afma.google.com/activityMonitor?type=getPageSignals&sid=60443a9a-1ec8-4a0c-abc9-586d33488ec1&dt=1533631954167 08-07 10:52:34.189 30320-30320 D/IMASDK: AdsManager.init -> Setting contentStartTime 3.0 08-07 10:52:35.199 30320-30320 I/ImaAdsLoader: AdEvent: {errorMessage=The response does not contain any valid ads., errorCode=1009, type=adLoadError}

andrewlewis commented 6 years ago

Please could you set DEBUG to true in ImaAdsLoader then reproduce the issue and send over the logcat output? We should be handling an empty preroll, though there's a bug where we don't handle two empty ad breaks in a row (#4030).

andrewger157 commented 6 years ago

I set the debug to true in ImaAdsLoader and I have attached the Logs that I report here again

08-07 10:52:34.179 30320-30320 W/IMASDK: Invalid internal message, ignoring. Please make sure the Google IMA SDK library is up to date. Message: gmsg://afma.google.com/activityMonitor?type=getPageSignals&sid=60443a9a-1ec8-4a0c-abc9-586d33488ec1&dt=1533631954167 08-07 10:52:34.189 30320-30320 D/IMASDK: AdsManager.init -> Setting contentStartTime 3.0 08-07 10:52:35.199 30320-30320 I/ImaAdsLoader: AdEvent: {errorMessage=The response does not contain any valid ads., errorCode=1009, type=adLoadError}****

andrewlewis commented 6 years ago

Please could you provide the full logcat, not just a snippet?

andrewger157 commented 6 years ago

These are the logs taken using an empty preroll and a midroll at 15 seconds

Logcat ```08-08 17:28:32.100 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:32.115 17279-17279/it.rainet I/ExoPlayerImpl: Init bfbef59 [ExoPlayerLib/2.8.2] [a5y17lte, SM-A520F, samsung, 26] 08-08 17:28:32.134 17279-17279/it.rainet D/EventLogger: positionDiscontinuity 08-08 17:28:32.138 17279-17279/it.rainet D/EventLogger: state [0.09, true, I] 08-08 17:28:32.205 17279-17279/it.rainet I/WebViewFactory: Loading com.android.chrome version 68.0.3440.91 (code 344009152) 08-08 17:28:32.211 17279-17279/it.rainet I/zygote: no shared libraies, dex_files: 1 08-08 17:28:32.262 17279-17279/it.rainet I/cr_LibraryLoader: Time to load native libraries: 5 ms (timestamps 5344-5349) 08-08 17:28:32.289 17279-17279/it.rainet I/chromium: [INFO:library_loader_hooks.cc(36)] Chromium logging enabled: level = 0, default verbosity = 0 08-08 17:28:32.290 17279-17279/it.rainet I/cr_LibraryLoader: Expected native library version number "68.0.3440.91", actual native library version number "68.0.3440.91" 08-08 17:28:32.301 17279-18327/it.rainet W/cr_ChildProcLH: Create a new ChildConnectionAllocator with package name = com.android.chrome, sandboxed = true 08-08 17:28:32.312 17279-17279/it.rainet I/cr_BrowserStartup: Initializing chromium process, singleProcess=false 08-08 17:28:32.314 17279-17279/it.rainet I/cr_base: Android Locale: it requires .pak files: [it] 08-08 17:28:32.319 17279-17279/it.rainet W/ResourceType: For resource 0x7f1204a3, entry index(1187) is beyond type entryCount(575) Failure getting entry for 0x7f1204a3 (t=17 e=1187) (error -75) 08-08 17:28:32.351 17279-17279/it.rainet I/chromium: [INFO:aw_field_trial_creator.cc(52)] First-WebView-Experiment found, group=Control 08-08 17:28:32.400 17279-17279/it.rainet I/zygote: Rejecting re-init on previously-failed class java.lang.Class
    : java.lang.NoClassDefFoundError: Failed resolution of: Landroid/webkit/SafeBrowsingResponse; at xf com.android.webview.chromium.WebViewChromiumFactoryProvider.a(android.webkit.WebView, android.content.Context) (SourceFile:209) at void com.android.webview.chromium.WebViewChromium.init(java.util.Map, boolean) (SourceFile:63) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int, java.util.Map, boolean) (WebView.java:651) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int) (WebView.java:581) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int) (WebView.java:564) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet) (WebView.java:551) at void android.webkit.WebView.(android.content.Context) (WebView.java:541) at void com.google.obf.je.(android.content.Context, com.google.obf.je$a) (IMASDK:1) at void com.google.obf.jd.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:30) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:4) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:1) at com.google.ads.interactivemedia.v3.api.AdsLoader com.google.ads.interactivemedia.v3.api.ImaSdkFactory.createAdsLoader(android.content.Context, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:10) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, java.lang.String, int, int, com.google.ads.interactivemedia.v3.api.AdEvent$AdEventListener) (ImaAdsLoader.java:390) 08-08 17:28:32.401 17279-17279/it.rainet I/zygote: at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri) (ImaAdsLoader.java:333) at void it.rainet.demo.PlayerActivity.initializePlayer() (PlayerActivity.java:652) at void it.rainet.demo.PlayerActivity.preparePlayer(boolean) (PlayerActivity.java:440) at void it.rainet.demo.PlayerActivity.replaceVideo(java.lang.String, java.lang.String, int, long, java.lang.String) (PlayerActivity.java:1137) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.goToNextVideo(it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:186) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.access$200(com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist, it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:39) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(it.rainet.media.model.Playlist) (PlayerFragmentWithPlaylist.java:171) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(java.lang.Object) (PlayerFragmentWithPlaylist.java:157) at void it.rainet.connectivity.request.BaseRequest.deliverResponse(java.lang.Object) (BaseRequest.java:39) at void it.rainet.connectivity.request.GetMediapolisPlaylistRequest.deliverError(com.android.volley.VolleyError) (GetMediapolisPlaylistRequest.java:60) at void com.android.volley.ExecutorDelivery$ResponseDeliveryRunnable.run() (ExecutorDelivery.java:101) at void android.os.Handler.handleCallback(android.os.Message) (Handler.java:789) at void android.os.Handler.dispatchMessage(android.os.Message) (Handler.java:98) at void android.os.Looper.loop() (Looper.java:164) at void android.app.ActivityThread.main(java.lang.String[]) (ActivityThread.java:6944) at java.lang.Object java.lang.reflect.Method.invoke(java.lang.Object, java.lang.Object[]) (Method.java:-2) at void com.android.internal.os.Zygote$MethodAndArgsCaller.run() (Zygote.java:327) at void com.android.internal.os.ZygoteInit.main(java.lang.String[]) (ZygoteInit.java:1374) Caused by: java.lang.ClassNotFoundException: Didn't find class "android.webkit.SafeBrowsingResponse" on path: DexPathList[[zip file "/data/app/com.android.chrome-o-xjES0s91pm6YVXGvDkig==/base.apk"],nativeLibraryDirectories=[/data/app/com.android.chrome-o-xjES0s91pm6YVXGvDkig==/lib/arm, /data/app/com.android.chrome-o-xjES0s91pm6YVXGvDkig==/base.apk!/lib/armeabi-v7a, /system/lib, /system/vendor/lib]] at java.lang.Class dalvik.system.BaseDexClassLoader.findClass(java.lang.String) (BaseDexClassLoader.java:93) at java.lang.Class java.lang.ClassLoader.loadClass(java.lang.String, boolean) (ClassLoader.java:379) at java.lang.Class java.lang.ClassLoader.loadClass(java.lang.String) (ClassLoader.java:312) at xf com.android.webview.chromium.WebViewChromiumFactoryProvider.a(android.webkit.WebView, android.content.Context) (SourceFile:209) at void com.android.webview.chromium.WebViewChromium.init(java.util.Map, boolean) (SourceFile:63) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int, java.util.Map, boolean) (WebView.java:651) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int) (WebView.java:581) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int) (WebView.java:564) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet) (WebView.java:551) at void android.webkit.WebView.(android.content.Context) (WebView.java:541) at void com.google.obf.je.(android.content.Context, com.google.obf.je$a) (IMASDK:1) at void com.google.obf.jd.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:30) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:4) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:1) at com.google.ads.interactivemedia.v3.api.AdsLoader com.google.ads.interactivemedia.v3.api.ImaSdkFactory.createAdsLoader(android.content.Context, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:10) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, java.lang.String, int, int, com.google.ads.interactivemedia.v3.api.AdEvent$AdEventListener) (ImaAdsLoader.java:390) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri) (ImaAdsLoader.java:333) at void it.rainet.demo.PlayerActivity.initializePlayer() (PlayerActivity.java:652) at void it.rainet.demo.PlayerActivity.preparePlayer(boolean) (PlayerActivity.java:440) at void it.rainet.demo.PlayerActivity.replaceVideo(java.lang.String, java.lang.String, int, long, java.lang.String) (PlayerActivity.java:1137) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.goToNextVideo(it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:186) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.access$200(com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist, it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:39) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(it.rainet.media.model.Playlist) (PlayerFragmentWithPlaylist.java:171) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(java.lang.Object) (PlayerFragmentWithPlaylist.java:157) at void it.rainet.connectivity.request.BaseRequest.deliverResponse(java.lang.Object) (BaseRequest.java:39) at void it.rainet.connectivity.request.GetMediapolisPlaylistRequest.deliverError(com.android.volley.VolleyError) (GetMediapolisPlaylistRequest.java:60) at void com.android.volley.ExecutorDelivery$ResponseDeliveryRunnable.run() (ExecutorDelivery.java:101) at void android.os.Handler.handleCallback(android.os.Message) (Handler.java:789) at void android.os.Handler.dispatchMessage(android.os.Message) (Handler.java:98) at void android.os.Looper.loop() (Looper.java:164) at void android.app.ActivityThread.main(java.lang.String[]) (ActivityThread.java:6944) at java.lang.Object java.lang.reflect.Method.invoke(java.lang.Object, java.lang.Object[]) (Method.java:-2) at void com.android.internal.os.Zygote$MethodAndArgsCaller.run() (Zygote.java:327) at void com.android.internal.os.ZygoteInit.main(java.lang.String[]) (ZygoteInit.java:1374) 08-08 17:28:32.402 17279-17279/it.rainet I/zygote: Rejecting re-init on previously-failed class java.lang.Class
      : java.lang.NoClassDefFoundError: Failed resolution of: Landroid/webkit/SafeBrowsingResponse; at xf com.android.webview.chromium.WebViewChromiumFactoryProvider.a(android.webkit.WebView, android.content.Context) (SourceFile:209) at void com.android.webview.chromium.WebViewChromium.init(java.util.Map, boolean) (SourceFile:63) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int, java.util.Map, boolean) (WebView.java:651) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int) (WebView.java:581) 08-08 17:28:32.403 17279-17279/it.rainet I/zygote: at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int) (WebView.java:564) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet) (WebView.java:551) at void android.webkit.WebView.(android.content.Context) (WebView.java:541) at void com.google.obf.je.(android.content.Context, com.google.obf.je$a) (IMASDK:1) at void com.google.obf.jd.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:30) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:4) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:1) at com.google.ads.interactivemedia.v3.api.AdsLoader com.google.ads.interactivemedia.v3.api.ImaSdkFactory.createAdsLoader(android.content.Context, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:10) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, java.lang.String, int, int, com.google.ads.interactivemedia.v3.api.AdEvent$AdEventListener) (ImaAdsLoader.java:390) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri) (ImaAdsLoader.java:333) at void it.rainet.demo.PlayerActivity.initializePlayer() (PlayerActivity.java:652) at void it.rainet.demo.PlayerActivity.preparePlayer(boolean) (PlayerActivity.java:440) at void it.rainet.demo.PlayerActivity.replaceVideo(java.lang.String, java.lang.String, int, long, java.lang.String) (PlayerActivity.java:1137) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.goToNextVideo(it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:186) 08-08 17:28:32.403 17279-17279/it.rainet I/zygote: at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.access$200(com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist, it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:39) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(it.rainet.media.model.Playlist) (PlayerFragmentWithPlaylist.java:171) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(java.lang.Object) (PlayerFragmentWithPlaylist.java:157) at void it.rainet.connectivity.request.BaseRequest.deliverResponse(java.lang.Object) (BaseRequest.java:39) at void it.rainet.connectivity.request.GetMediapolisPlaylistRequest.deliverError(com.android.volley.VolleyError) (GetMediapolisPlaylistRequest.java:60) at void com.android.volley.ExecutorDelivery$ResponseDeliveryRunnable.run() (ExecutorDelivery.java:101) at void android.os.Handler.handleCallback(android.os.Message) (Handler.java:789) at void android.os.Handler.dispatchMessage(android.os.Message) (Handler.java:98) at void android.os.Looper.loop() (Looper.java:164) at void android.app.ActivityThread.main(java.lang.String[]) (ActivityThread.java:6944) at java.lang.Object java.lang.reflect.Method.invoke(java.lang.Object, java.lang.Object[]) (Method.java:-2) at void com.android.internal.os.Zygote$MethodAndArgsCaller.run() (Zygote.java:327) at void com.android.internal.os.ZygoteInit.main(java.lang.String[]) (ZygoteInit.java:1374) Caused by: java.lang.ClassNotFoundException: Didn't find class "android.webkit.SafeBrowsingResponse" on path: DexPathList[[zip file "/data/app/com.android.chrome-o-xjES0s91pm6YVXGvDkig==/base.apk"],nativeLibraryDirectories=[/data/app/com.android.chrome-o-xjES0s91pm6YVXGvDkig==/lib/arm, /data/app/com.android.chrome-o-xjES0s91pm6YVXGvDkig==/base.apk!/lib/armeabi-v7a, /system/lib, /system/vendor/lib]] at java.lang.Class dalvik.system.BaseDexClassLoader.findClass(java.lang.String) (BaseDexClassLoader.java:93) at java.lang.Class java.lang.ClassLoader.loadClass(java.lang.String, boolean) (ClassLoader.java:379) at java.lang.Class java.lang.ClassLoader.loadClass(java.lang.String) (ClassLoader.java:312) at xf com.android.webview.chromium.WebViewChromiumFactoryProvider.a(android.webkit.WebView, android.content.Context) (SourceFile:209) at void com.android.webview.chromium.WebViewChromium.init(java.util.Map, boolean) (SourceFile:63) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int, java.util.Map, boolean) (WebView.java:651) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int) (WebView.java:581) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int) (WebView.java:564) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet) (WebView.java:551) at void android.webkit.WebView.(android.content.Context) (WebView.java:541) at void com.google.obf.je.(android.content.Context, com.google.obf.je$a) (IMASDK:1) at void com.google.obf.jd.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:30) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:4) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:1) at com.google.ads.interactivemedia.v3.api.AdsLoader com.google.ads.interactivemedia.v3.api.ImaSdkFactory.createAdsLoader(android.content.Context, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:10) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, java.lang.String, int, int, com.google.ads.interactivemedia.v3.api.AdEvent$AdEventListener) (ImaAdsLoader.java:390) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri) (ImaAdsLoader.java:333) at void it.rainet.demo.PlayerActivity.initializePlayer() (PlayerActivity.java:652) at void it.rainet.demo.PlayerActivity.preparePlayer(boolean) (PlayerActivity.java:440) at void it.rainet.demo.PlayerActivity.replaceVideo(java.lang.String, java.lang.String, int, long, java.lang.String) (PlayerActivity.java:1137) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.goToNextVideo(it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:186) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.access$200(com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist, it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:39) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(it.rainet.media.model.Playlist) (PlayerFragmentWithPlaylist.java:171) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(java.lang.Object) (PlayerFragmentWithPlaylist.java:157) 08-08 17:28:32.404 17279-17279/it.rainet I/zygote: at void it.rainet.connectivity.request.BaseRequest.deliverResponse(java.lang.Object) (BaseRequest.java:39) at void it.rainet.connectivity.request.GetMediapolisPlaylistRequest.deliverError(com.android.volley.VolleyError) (GetMediapolisPlaylistRequest.java:60) at void com.android.volley.ExecutorDelivery$ResponseDeliveryRunnable.run() (ExecutorDelivery.java:101) at void android.os.Handler.handleCallback(android.os.Message) (Handler.java:789) at void android.os.Handler.dispatchMessage(android.os.Message) (Handler.java:98) at void android.os.Looper.loop() (Looper.java:164) at void android.app.ActivityThread.main(java.lang.String[]) (ActivityThread.java:6944) at java.lang.Object java.lang.reflect.Method.invoke(java.lang.Object, java.lang.Object[]) (Method.java:-2) at void com.android.internal.os.Zygote$MethodAndArgsCaller.run() (Zygote.java:327) at void com.android.internal.os.ZygoteInit.main(java.lang.String[]) (ZygoteInit.java:1374) 08-08 17:28:32.405 17279-17279/it.rainet I/zygote: Rejecting re-init on previously-failed class java.lang.Class
        : java.lang.NoClassDefFoundError: Failed resolution of: Landroid/webkit/SafeBrowsingResponse; at xf com.android.webview.chromium.WebViewChromiumFactoryProvider.a(android.webkit.WebView, android.content.Context) (SourceFile:209) at void com.android.webview.chromium.WebViewChromium.init(java.util.Map, boolean) (SourceFile:63) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int, java.util.Map, boolean) (WebView.java:651) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int) (WebView.java:581) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int) (WebView.java:564) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet) (WebView.java:551) at void android.webkit.WebView.(android.content.Context) (WebView.java:541) at void com.google.obf.je.(android.content.Context, com.google.obf.je$a) (IMASDK:1) at void com.google.obf.jd.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:30) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:4) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:1) at com.google.ads.interactivemedia.v3.api.AdsLoader com.google.ads.interactivemedia.v3.api.ImaSdkFactory.createAdsLoader(android.content.Context, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:10) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, java.lang.String, int, int, com.google.ads.interactivemedia.v3.api.AdEvent$AdEventListener) (ImaAdsLoader.java:390) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri) (ImaAdsLoader.java:333) at void it.rainet.demo.PlayerActivity.initializePlayer() (PlayerActivity.java:652) at void it.rainet.demo.PlayerActivity.preparePlayer(boolean) (PlayerActivity.java:440) at void it.rainet.demo.PlayerActivity.replaceVideo(java.lang.String, java.lang.String, int, long, java.lang.String) (PlayerActivity.java:1137) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.goToNextVideo(it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:186) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.access$200(com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist, it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:39) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(it.rainet.media.model.Playlist) (PlayerFragmentWithPlaylist.java:171) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(java.lang.Object) (PlayerFragmentWithPlaylist.java:157) at void it.rainet.connectivity.request.BaseRequest.deliverResponse(java.lang.Object) (BaseRequest.java:39) at void it.rainet.connectivity.request.GetMediapolisPlaylistRequest.deliverError(com.android.volley.VolleyError) (GetMediapolisPlaylistRequest.java:60) at void com.android.volley.ExecutorDelivery$ResponseDeliveryRunnable.run() (ExecutorDelivery.java:101) at void android.os.Handler.handleCallback(android.os.Message) (Handler.java:789) at void android.os.Handler.dispatchMessage(android.os.Message) (Handler.java:98) at void android.os.Looper.loop() (Looper.java:164) at void android.app.ActivityThread.main(java.lang.String[]) (ActivityThread.java:6944) at java.lang.Object java.lang.reflect.Method.invoke(java.lang.Object, java.lang.Object[]) (Method.java:-2) at void com.android.internal.os.Zygote$MethodAndArgsCaller.run() (Zygote.java:327) at void com.android.internal.os.ZygoteInit.main(java.lang.String[]) (ZygoteInit.java:1374) Caused by: java.lang.ClassNotFoundException: Didn't find class "android.webkit.SafeBrowsingResponse" on path: DexPathList[[zip file "/data/app/com.android.chrome-o-xjES0s91pm6YVXGvDkig==/base.apk"],nativeLibraryDirectories=[/data/app/com.android.chrome-o-xjES0s91pm6YVXGvDkig==/lib/arm, /data/app/com.android.chrome-o-xjES0s91pm6YVXGvDkig==/base.apk!/lib/armeabi-v7a, /system/lib, /system/vendor/lib]] at java.lang.Class dalvik.system.BaseDexClassLoader.findClass(java.lang.String) (BaseDexClassLoader.java:93) at java.lang.Class java.lang.ClassLoader.loadClass(java.lang.String, boolean) (ClassLoader.java:379) at java.lang.Class java.lang.ClassLoader.loadClass(java.lang.String) (ClassLoader.java:312) at xf com.android.webview.chromium.WebViewChromiumFactoryProvider.a(android.webkit.WebView, android.content.Context) (SourceFile:209) at void com.android.webview.chromium.WebViewChromium.init(java.util.Map, boolean) (SourceFile:63) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int, java.util.Map, boolean) (WebView.java:651) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int, int) (WebView.java:581) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet, int) (WebView.java:564) at void android.webkit.WebView.(android.content.Context, android.util.AttributeSet) (WebView.java:551) at void android.webkit.WebView.(android.content.Context) (WebView.java:541) at void com.google.obf.je.(android.content.Context, com.google.obf.je$a) (IMASDK:1) at void com.google.obf.jd.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:30) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, com.google.ads.interactivemedia.v3.impl.data.TestingConfiguration) (IMASDK:4) at void com.google.obf.ii.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:1) at com.google.ads.interactivemedia.v3.api.AdsLoader com.google.ads.interactivemedia.v3.api.ImaSdkFactory.createAdsLoader(android.content.Context, com.google.ads.interactivemedia.v3.api.ImaSdkSettings) (IMASDK:10) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri, com.google.ads.interactivemedia.v3.api.ImaSdkSettings, java.lang.String, int, int, com.google.ads.interactivemedia.v3.api.AdEvent$AdEventListener) (ImaAdsLoader.java:390) at void com.google.android.exoplayer2.ext.ima.ImaAdsLoader.(android.content.Context, android.net.Uri) (ImaAdsLoader.java:333) at void it.rainet.demo.PlayerActivity.initializePlayer() (PlayerActivity.java:652) at void it.rainet.demo.PlayerActivity.preparePlayer(boolean) (PlayerActivity.java:440) at void it.rainet.demo.PlayerActivity.replaceVideo(java.lang.String, java.lang.String, int, long, java.lang.String) (PlayerActivity.java:1137) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.goToNextVideo(it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:186) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist.access$200(com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist, it.rainet.media.model.PlaylistItem, java.lang.String, int, long) (PlayerFragmentWithPlaylist.java:39) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(it.rainet.media.model.Playlist) (PlayerFragmentWithPlaylist.java:171) at void com.rai.android.exoplayer.demo.PlayerFragmentWithPlaylist$3.onResponse(java.lang.Object) (PlayerFragmentWithPlaylist.java:157) at void it.rainet.connectivity.request.BaseRequest.deliverResponse(java.lang.Object) (BaseRequest.java:39) at void it.rainet.connectivity.request.GetMediapolisPlaylistRequest.deliverError(com.android.volley.VolleyError) (GetMediapolisPlaylistRequest.java:60) at void com.android.volley.ExecutorDelivery$ResponseDeliveryRunnable.run() (ExecutorDelivery.java:101) at void android.os.Handler.handleCallback(android.os.Message) (Handler.java:789) at void android.os.Handler.dispatchMessage(android.os.Message) (Handler.java:98) at void android.os.Looper.loop() (Looper.java:164) at void android.app.ActivityThread.main(java.lang.String[]) (ActivityThread.java:6944) at java.lang.Object java.lang.reflect.Method.invoke(java.lang.Object, java.lang.Object[]) (Method.java:-2) at void com.android.internal.os.Zygote$MethodAndArgsCaller.run() (Zygote.java:327) at void com.android.internal.os.ZygoteInit.main(java.lang.String[]) (ZygoteInit.java:1374) 08-08 17:28:32.435 17279-17279/it.rainet D/ConnectivityManager: requestNetwork; CallingUid : 11527, CallingPid : 17279 08-08 17:28:32.453 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:32.501 17279-18352/it.rainet W/cr_media: Requires BLUETOOTH permission 08-08 17:28:32.518 17279-17279/it.rainet D/EventLogger: state [0.47, true, B] 08-08 17:28:32.519 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (542 ms) [ ] https://2uscreativem3rw-vh.akamaihd.net/i/podcastcdn/raitre_2/Geo/Geo_EP_Puntate/6744740_,800,1800,.mp4.csmil/master.m3u8?auth=daEcKb0ddcWb4bzcub.a6cEdKdIdzaUb4cX-bBAWWG-c0-GktxuGv&aifp=V001 0xc5015915 NORMAL 23 [2] MarkerLog.finish: (+0 ) [ 2] add-to-queue 08-08 17:28:32.520 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+0 ) [1731] network-queue-take [2] MarkerLog.finish: (+44 ) [1731] redirect-timeout-giveup [timeout=2500] [2] MarkerLog.finish: (+0 ) [1731] post-error 08-08 17:28:32.521 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+498 ) [ 2] done 08-08 17:28:32.526 17279-18364/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:32.527 17279-18364/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:32.547 17279-18360/it.rainet W/AudioCapabilities: Unsupported mime audio/mpeg-L1 08-08 17:28:32.548 17279-18360/it.rainet W/AudioCapabilities: Unsupported mime audio/mpeg-L2 08-08 17:28:32.550 17279-17279/it.rainet D/ConnectivityManager: requestNetwork; CallingUid : 11527, CallingPid : 17279 08-08 17:28:32.553 17279-18360/it.rainet W/AudioCapabilities: Unsupported mime audio/x-ms-wma 08-08 17:28:32.554 17279-18360/it.rainet W/AudioCapabilities: Unsupported mime audio/x-ima 08-08 17:28:32.561 17279-17279/it.rainet D/EventLogger: onLoadStarted 08-08 17:28:32.564 17279-18360/it.rainet W/VideoCapabilities: Unrecognized profile 2130706433 for video/avc Unrecognized profile 2130706434 for video/avc 08-08 17:28:32.570 17279-18360/it.rainet W/VideoCapabilities: Unrecognized profile 2130706433 for video/avc Unrecognized profile 2130706434 for video/avc 08-08 17:28:32.607 17279-18360/it.rainet W/VideoCapabilities: Unsupported mime video/wvc1 08-08 17:28:32.611 17279-18360/it.rainet W/VideoCapabilities: Unsupported mime video/x-ms-wmv 08-08 17:28:32.615 17279-18360/it.rainet W/VideoCapabilities: Unrecognized profile 2130706433 for video/avc Unrecognized profile 2130706434 for video/avc 08-08 17:28:32.670 17279-18360/it.rainet I/VideoCapabilities: Unsupported profile 4 for video/mp4v-es 08-08 17:28:32.685 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:32.686 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:32.715 17279-18360/it.rainet W/VideoCapabilities: Unrecognized profile/level 1/32 for video/mp4v-es Unrecognized profile/level 32768/2 for video/mp4v-es Unrecognized profile/level 32768/64 for video/mp4v-es 08-08 17:28:32.719 17279-18360/it.rainet W/VideoCapabilities: Unsupported mime video/wvc1 08-08 17:28:32.722 17279-18360/it.rainet W/VideoCapabilities: Unsupported mime video/x-ms-wmv 08-08 17:28:32.725 17279-18360/it.rainet W/VideoCapabilities: Unsupported mime video/x-ms-wmv7 08-08 17:28:32.728 17279-18360/it.rainet W/VideoCapabilities: Unsupported mime video/x-ms-wmv8 08-08 17:28:32.730 17279-18360/it.rainet W/VideoCapabilities: Unsupported mime video/mp43 08-08 17:28:32.777 17279-18360/it.rainet D/libGLESv2: STS_GLApi : DTS, ODTC are not allowed for Package : it.rainet 08-08 17:28:32.780 17279-17279/it.rainet D/CWISE: playerPosition: 22 08-08 17:28:32.783 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 817 08-08 17:28:32.794 17279-17279/it.rainet D/WebtrekkSDK: adding url: http://rai-italia01.wt-eu02.net/602039762736393/wt?p=401,app%3A%2F%2Fwww.raiplay.it%2Fvideo%2Fhttp%3A%2F%2Fmediapolisvod.rai.it%2Frelinker%2FrelinkerServlet.htm%3Fcont%3DEmNpPpPlusspsLWleoeeqqEEqual,0,1080x1920,32,0,1533742112784,0,0,0&eid=6153374174318945680&fns=0&one=0&tz=1&la=&mi=app+-+raiplay+-+vod+-+geo+-+marettimo+-+14%2F03%2F2017+-+contentitem-76fa3530-df88-438a-8c74-04d05e3ff9b1&mk=pos&mt1=0&mt2=-9223372036854775&ps=0&X-WT-UA=Tracking+Library+4.0.1%28Android%3B8.0.0%3Bsamsung+SM-A520F%3Bit%29&mg1=app&mg10=scienza+%26+natura&mg11=mondo+animale&mg12=programmi+tv&mg13=raiplay&mg2=rai+scuola&mg4=geo&mg5=vod&mg7=marettimo+-+14%2F03%2F2017&mg8=2018&eor=1 08-08 17:28:32.831 17279-17279/it.rainet D/EventLogger: onLoadStarted onLoadCompleted 08-08 17:28:32.834 17279-18382/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:32.918 17279-17279/it.rainet D/EventLogger: onLoadCompleted 08-08 17:28:32.992 17279-17658/it.rainet W/zygote: Skipping duplicate class check due to unrecognized classloader 08-08 17:28:33.079 17279-17901/it.rainet D/RaiVolley: [1730] OverrideCache.put: Override expiration date for Request for cacheKey=0:http://www.raiplay.it/playrai/profile/getSeeAfter to Thu Jan 01 01:00:00 GMT+01:00 1970 08-08 17:28:33.089 17279-17279/it.rainet V/RaiVolley: [2] RequestQueue.finish: Releasing 1 waiting requests for cacheKey=0:http://www.raiplay.it/playrai/profile/getSeeAfter. 08-08 17:28:33.090 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (1748 ms) [ ] https://www.raiplay.it/playrai/profile/getSeeAfter 0xa63e8582 NORMAL 19 [2] MarkerLog.finish: (+0 ) [ 2] add-to-queue [2] MarkerLog.finish: (+1 ) [1728] cache-queue-take 08-08 17:28:33.091 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+1 ) [1728] cache-hit-expired [2] MarkerLog.finish: (+1 ) [1730] network-queue-take 08-08 17:28:33.092 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+41 ) [1730] redirect-retry [timeout=60000] [2] MarkerLog.finish: (+1684) [1730] network-http-complete 08-08 17:28:33.093 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+8 ) [1730] network-parse-complete 08-08 17:28:33.094 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+5 ) [1730] network-cache-written [2] MarkerLog.finish: (+0 ) [1730] post-response 08-08 17:28:33.095 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+7 ) [ 2] done 08-08 17:28:33.097 17279-17903/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.146 17279-17903/it.rainet E/RaiVolley: [1732] BasicNetwork.performRequest: Request at http://www.raiplay.it/playrai/profile/getSeeAfter has been redirected to https://www.raiplay.it/playrai/profile/getSeeAfter 08-08 17:28:33.150 17279-17903/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.159 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.160 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.277 17279-17658/it.rainet W/cr_CrashFileManager: /data/user/0/it.rainet/cache/WebView/Crash Reports does not exist or is not a directory 08-08 17:28:33.421 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.422 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.627 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (1887 ms) [ ] https://www.raiplay.it/playrai/profile/lastSeen/ContentItem-76fa3530-df88-438a-8c74-04d05e3ff9b1 0xa63e8582 NORMAL 20 08-08 17:28:33.628 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+0 ) [ 2] add-to-queue [2] MarkerLog.finish: (+3 ) [1729] network-queue-take [2] MarkerLog.finish: (+137 ) [1729] redirect-retry [timeout=10000] 08-08 17:28:33.629 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+1741) [1729] network-http-complete [2] MarkerLog.finish: (+6 ) [1729] network-parse-complete 08-08 17:28:33.630 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+0 ) [1729] post-response [2] MarkerLog.finish: (+0 ) [ 2] done 08-08 17:28:33.671 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.672 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.714 17279-17279/it.rainet W/IMASDK: Invalid internal message, ignoring. Please make sure the Google IMA SDK library is up to date. Message: gmsg://afma.google.com/activityMonitor?type=getPageSignals&sid=d2cc601d-66bd-4d8e-bd8c-40cf35c0c66b&dt=1533742113701 08-08 17:28:33.714 17279-17667/it.rainet D/com.facebook.FacebookSdk: getGraphApiVersion: v3.0 08-08 17:28:33.768 17279-17279/it.rainet D/IMASDK: AdsManager.init -> Setting contentStartTime 0.02199999988079071 08-08 17:28:33.783 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 1817 08-08 17:28:33.784 17279-17279/it.rainet D/EventLogger: sourceInfo [periodCount=1, windowCount=1 08-08 17:28:33.785 17279-17279/it.rainet D/EventLogger: period [1273.00] window [1273.00, true, false] ] 08-08 17:28:33.916 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.918 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:33.948 17279-17279/it.rainet I/ImaAdsLoader: AdEvent: {errorMessage=The response does not contain any valid ads., errorCode=1009, type=adLoadError} 08-08 17:28:33.965 17279-17279/it.rainet I/ImaAdsLoader: AdEvent: {errorMessage=The response does not contain any valid ads., errorCode=1009, type=adLoadError} 08-08 17:28:33.982 17279-17279/it.rainet D/EventLogger: sourceInfo [periodCount=1, windowCount=1 08-08 17:28:33.983 17279-17279/it.rainet D/EventLogger: period [1273.00] 08-08 17:28:33.984 17279-17279/it.rainet D/EventLogger: window [1273.00, true, false] ] 08-08 17:28:33.987 17279-17279/it.rainet D/EventLogger: onMediaPeriodCreated 08-08 17:28:34.038 17279-17279/it.rainet D/EventLogger: onLoadStarted 08-08 17:28:34.040 17279-17279/it.rainet D/EventLogger: loading [true] 08-08 17:28:34.041 17279-17279/it.rainet D/EventLogger: sourceInfo [periodCount=1, windowCount=1 08-08 17:28:34.042 17279-17279/it.rainet D/EventLogger: period [1273.00] 08-08 17:28:34.043 17279-17279/it.rainet D/EventLogger: window [1273.00, true, false] ] 08-08 17:28:34.044 17279-18394/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.081 17279-17297/it.rainet I/zygote: Background concurrent copying GC freed 121792(6MB) AllocSpace objects, 70(4MB) LOS objects, 50% free, 10MB/20MB, paused 3.174ms total 155.365ms 08-08 17:28:34.156 17279-17675/it.rainet W/OkHttpClient: A connection to http://rai-italia01.wt-eu02.net/ was leaked. Did you forget to close a response body? 08-08 17:28:34.158 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.159 17279-18323/it.rainet W/VideoCapabilities: Unrecognized profile 2130706433 for video/avc Unrecognized profile 2130706434 for video/avc 08-08 17:28:34.176 17279-17279/it.rainet D/EventLogger: videoEnabled [2.13] 08-08 17:28:34.178 17279-17279/it.rainet D/EventLogger: audioEnabled [2.13] 08-08 17:28:34.183 17279-17279/it.rainet D/EventLogger: Tracks [ Renderer:0 [ Group:0, adaptive_supported=YES [ [X] Track:0, id=0, mimeType=video/avc, bitrate=851000, res=512x288, supported=YES [X] Track:1, id=1, mimeType=video/avc, bitrate=1890000, res=928x522, supported=YES ] ] 08-08 17:28:34.184 17279-17279/it.rainet D/EventLogger: Renderer:1 [ Group:0, adaptive_supported=N/A [ 08-08 17:28:34.185 17279-17279/it.rainet D/EventLogger: [X] Track:0, id=1/15, mimeType=audio/mp4a-latm, channels=2, sample_rate=44100, supported=YES ] ] Renderer:3 [ Group:0, adaptive_supported=N/A [ [X] Track:0, id=1/21, mimeType=application/id3, supported=YES ] ] ] 08-08 17:28:34.185 17279-18323/it.rainet I/ACodec: [] Now uninitialized 08-08 17:28:34.186 17279-17279/it.rainet D/EventLogger: onReadingStarted 08-08 17:28:34.187 17279-18396/it.rainet I/ACodec: [] onAllocateComponent 08-08 17:28:34.187 17279-17279/it.rainet D/EventLogger: onDownstreamFormatChanged 08-08 17:28:34.189 17279-18396/it.rainet I/OMXClient: Treble IOmx obtained 08-08 17:28:34.200 17279-18396/it.rainet I/ACodec: [OMX.Exynos.avc.dec] Now Loaded 08-08 17:28:34.204 17279-18323/it.rainet V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0 08-08 17:28:34.204 17279-18395/it.rainet D/SurfaceUtils: connecting to surface 0xcb9ac008, reason connectToSurface 08-08 17:28:34.205 17279-18395/it.rainet I/MediaCodec: [OMX.Exynos.avc.dec] setting surface generation to 17693697 08-08 17:28:34.205 17279-18395/it.rainet D/SurfaceUtils: disconnecting from surface 0xcb9ac008, reason connectToSurface(reconnect) connecting to surface 0xcb9ac008, reason connectToSurface(reconnect) 08-08 17:28:34.206 17279-18396/it.rainet I/ACodec: can't find wfdsink-exynos-enable 08-08 17:28:34.207 17279-18396/it.rainet I/ACodec: codec does not support config priority (err -1010) 08-08 17:28:34.209 17279-18396/it.rainet I/ACodec: [OMX.Exynos.avc.dec] Now Loaded->Idle 08-08 17:28:34.219 17279-18396/it.rainet D/SurfaceUtils: set up nativeWindow 0xcb9ac008 for 512x288, color 0x121, rotation 0, usage 0x2900 08-08 17:28:34.219 17279-18396/it.rainet I/ACodec: [OMX.Exynos.avc.dec] configureOutputBuffersFromNativeWindow setBufferCount : 8, minUndequeuedBuffers : 4 08-08 17:28:34.221 17279-18396/it.rainet I/ACodec: [OMX.Exynos.avc.dec] Now Idle->Executing [OMX.Exynos.avc.dec] Now Executing 08-08 17:28:34.225 17279-17279/it.rainet D/EventLogger: videoDecoderInitialized [2.18, OMX.Exynos.avc.dec] 08-08 17:28:34.227 17279-17279/it.rainet D/EventLogger: videoFormatChanged [2.18, id=1/27, mimeType=video/avc, res=512x288] 08-08 17:28:34.228 17279-18323/it.rainet I/ACodec: [] Now uninitialized 08-08 17:28:34.229 17279-18406/it.rainet I/ACodec: [] onAllocateComponent 08-08 17:28:34.229 17279-18396/it.rainet I/ACodec: [OMX.Exynos.avc.dec] Now handling output port settings change 08-08 17:28:34.230 17279-18406/it.rainet I/OMXClient: Treble IOmx obtained 08-08 17:28:34.234 17279-18406/it.rainet I/ACodec: [OMX.google.aac.decoder] Now Loaded 08-08 17:28:34.236 17279-18406/it.rainet I/ACodec: codec does not support config priority (err -2147483648) 08-08 17:28:34.236 17279-18406/it.rainet I/ACodec: [OMX.google.aac.decoder] Now Loaded->Idle 08-08 17:28:34.239 17279-18396/it.rainet D/SurfaceUtils: set up nativeWindow 0xcb9ac008 for 512x288, color 0x121, rotation 0, usage 0x2900 08-08 17:28:34.239 17279-18396/it.rainet I/ACodec: [OMX.Exynos.avc.dec] configureOutputBuffersFromNativeWindow setBufferCount : 15, minUndequeuedBuffers : 4 08-08 17:28:34.243 17279-18396/it.rainet I/ACodec: [OMX.Exynos.avc.dec] Now Executing 08-08 17:28:34.246 17279-18406/it.rainet I/ACodec: [OMX.google.aac.decoder] Now Idle->Executing 08-08 17:28:34.248 17279-17279/it.rainet D/EventLogger: audioDecoderInitialized [2.20, OMX.google.aac.decoder] 08-08 17:28:34.249 17279-17279/it.rainet D/EventLogger: audioFormatChanged [2.20, id=1/15, mimeType=audio/mp4a-latm, channels=2, sample_rate=44100] 08-08 17:28:34.250 17279-18406/it.rainet I/ACodec: [OMX.google.aac.decoder] Now Executing 08-08 17:28:34.255 17279-17279/it.rainet D/EventLogger: videoSizeChanged [512, 288] 08-08 17:28:34.256 17279-17279/it.rainet D/EventLogger: renderedFirstFrame [Surface(name=null)/@0x6add046] 08-08 17:28:34.259 17279-18406/it.rainet I/ACodec: [OMX.google.aac.decoder] Now handling output port settings change 08-08 17:28:34.265 17279-18406/it.rainet I/ACodec: [OMX.google.aac.decoder] Now Executing 08-08 17:28:34.282 17279-18323/it.rainet D/AudioTrack: Client defaulted notificationFrames to 7077 for frameCount 21232 08-08 17:28:34.285 17279-17279/it.rainet D/SurfaceView: BG show() Surface(name=Background for - SurfaceView - it.rainet/it.rainet.playrai.activity.OnlineHomeActivity@4ebeb35@0) android.view.SurfaceView{4ebeb35 V.E...... ......ID 0,0-1080,607} 08-08 17:28:34.296 17279-17279/it.rainet D/SurfaceView: surfaceChanged (1080,607) 1 #5 android.view.SurfaceView{4ebeb35 V.E...... ......ID 0,0-1080,607} 08-08 17:28:34.314 17279-17279/it.rainet D/EventLogger: audioSessionId [3825] 08-08 17:28:34.324 17279-18323/it.rainet I/AudioTrack: updateAudioTranstionLength FadeIn[0] FadeOut[0] FadeInRing[0] 08-08 17:28:34.337 17279-17279/it.rainet D/ViewRootImpl@6aad678[OnlineHomeActivity]: Relayout returned: old=[0,0][1080,1920] new=[0,0][1080,1920] result=0x1 surface={valid=true 3477243904} changed=false 08-08 17:28:34.339 17279-17279/it.rainet D/Rai: Position onVideoStarted:22 08-08 17:28:34.340 17279-17279/it.rainet D/Rai: VideoZeroDate: Wed Aug 08 17:28:33 GMT+02:00 2018 08-08 17:28:34.348 17279-17279/it.rainet E/[COMSCORE]: {"ns_st_ct":"vc12","ns_st_cu":"http:\/\/mediapolisvod.rai.it\/relinker\/relinkerServlet.htm?cont=EmNpPpPlusspsLWleoeeqqEEqual","ns_st_cdm":"to","cs_proid":"kwp-it","fp_offset":"*null","ns_st_tm":"05:28","ns_st_dtt":"05:28","ns_st_ti":"*null","ns_st_st":"Rai Scuola","ns_st_ami":"*null","ns_st_ad":"*null","oce_bpf":"RaiPlay","ns_st_ge":"scienza & natura","ns_st_cl":"1273000","ns_st_en":"*null","ns_st_tpr":"ContentItem-5ab15733-ef59-4f5c-a24a-b15c8311281e","ns_st_ep":"Marettimo - 14\/03\/2017","ns_st_ddt":"*null","ns_st_ci":"ContentItem-76fa3530-df88-438a-8c74-04d05e3ff9b1","ns_st_ia":"0","ns_st_sn":"*null","ns_st_tdt":"2018-08-08","ns_st_cmt":"*null","oce_odt":"VOD","c3":"raiplay","ns_st_tep":"ContentItem-76fa3530-df88-438a-8c74-04d05e3ff9b1","c4":"catalogo_vod","c6":"*null","ns_st_pr":"Geo","c7":"http:\/\/www.raiplay.it\/raiplay\/video\/2017\/03\/Marettimo---Geo-del-14032017-76fa3530-df88-438a-8c74-04d05e3ff9b1.html?json","ns_st_li":"0","ns_st_tp":"1","c8":"Geo - Marettimo - 14\/03\/2017 - video - raiplay","ns_st_stc":"ContentItem-b6b85a88-e2e4-494a-810e-739eed8b9636","c9":"*null","ns_st_pn":"1","ns_st_pu":"raiplay","ns_st_ty":"*null","cs_ucfr":"0"} 08-08 17:28:34.350 17279-17279/it.rainet E/[COMSCORE]: play - position= 22 08-08 17:28:34.351 17279-17279/it.rainet E/[COMSCORE]: play - isLive=false; adv=no; position=22 08-08 17:28:34.362 17279-17279/it.rainet D/WebtrekkSDK: adding url: http://rai-italia01.wt-eu02.net/602039762736393/wt?p=401,app%3A%2F%2Fwww.raiplay.it%2Fvideo%2Fhttp%3A%2F%2Fmediapolisvod.rai.it%2Frelinker%2FrelinkerServlet.htm%3Fcont%3DEmNpPpPlusspsLWleoeeqqEEqual,0,1080x1920,32,0,1533742114352,0,0,0&eid=6153374174318945680&fns=0&one=0&tz=1&la=&mi=app+-+raiplay+-+vod+-+geo+-+marettimo+-+14%2F03%2F2017+-+contentitem-76fa3530-df88-438a-8c74-04d05e3ff9b1&mk=start+content&mt2=1260&ps=0&X-WT-UA=Tracking+Library+4.0.1%28Android%3B8.0.0%3Bsamsung+SM-A520F%3Bit%29&mg1=app&mg10=scienza+%26+natura&mg11=mondo+animale&mg12=programmi+tv&mg13=raiplay&mg2=rai+scuola&mg4=geo&mg5=vod&mg7=marettimo+-+14%2F03%2F2017&mg8=2018&eor=1 08-08 17:28:34.380 17279-17279/it.rainet D/WebtrekkSDK: adding url: http://rai-italia01.wt-eu02.net/602039762736393/wt?p=401,app%3A%2F%2Fwww.raiplay.it%2Fvideo%2Fhttp%3A%2F%2Fmediapolisvod.rai.it%2Frelinker%2FrelinkerServlet.htm%3Fcont%3DEmNpPpPlusspsLWleoeeqqEEqual,0,1080x1920,32,0,1533742114369,0,0,0&eid=6153374174318945680&fns=0&one=0&tz=1&la=&mi=app+-+raiplay+-+vod+-+geo+-+marettimo+-+14%2F03%2F2017+-+contentitem-76fa3530-df88-438a-8c74-04d05e3ff9b1&mk=play&mt2=1260&ps=0&X-WT-UA=Tracking+Library+4.0.1%28Android%3B8.0.0%3Bsamsung+SM-A520F%3Bit%29&mg1=app&mg10=scienza+%26+natura&mg11=mondo+animale&mg12=programmi+tv&mg13=raiplay&mg2=rai+scuola&mg4=geo&mg5=vod&mg7=marettimo+-+14%2F03%2F2017&mg8=2018&eor=1 08-08 17:28:34.387 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.402 17279-17279/it.rainet D/EventLogger: state [2.35, true, R] 08-08 17:28:34.411 17279-18427/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.413 17279-18425/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.414 17279-18425/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.528 17279-17279/it.rainet D/EventLogger: onLoadCompleted 08-08 17:28:34.530 17279-17279/it.rainet D/EventLogger: onLoadStarted 08-08 17:28:34.534 17279-18394/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.634 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.764 17279-17903/it.rainet D/RaiVolley: [1732] OverrideCache.put: Override expiration date for Request for cacheKey=0:http://www.raiplay.it/playrai/profile/getSeeAfter to Thu Jan 01 01:00:00 GMT+01:00 1970 08-08 17:28:34.775 17279-17279/it.rainet W/Rai: Concurrent duplicate response inflight! 08-08 17:28:34.783 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (3011 ms) [ ] https://www.raiplay.it/playrai/profile/getSeeAfter 0xa63e8582 NORMAL 21 [2] MarkerLog.finish: (+0 ) [ 2] add-to-queue 08-08 17:28:34.784 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+1323) [1728] cache-queue-take [2] MarkerLog.finish: (+2 ) [1728] cache-hit-expired 08-08 17:28:34.785 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+0 ) [1732] network-queue-take [2] MarkerLog.finish: (+55 ) [1732] redirect-retry [timeout=60000] 08-08 17:28:34.786 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+1596) [1732] network-http-complete 08-08 17:28:34.787 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+19 ) [1732] network-parse-complete [2] MarkerLog.finish: (+13 ) [1732] network-cache-written 08-08 17:28:34.788 17279-17279/it.rainet D/RaiVolley: [2] MarkerLog.finish: (+0 ) [1732] post-response [2] MarkerLog.finish: (+3 ) [ 2] done 08-08 17:28:34.795 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 2830 08-08 17:28:34.880 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.881 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.918 17279-17279/it.rainet D/EventLogger: loading [false] 08-08 17:28:34.956 17279-17872/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:34.957 17279-17872/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:35.180 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:35.181 17279-17279/it.rainet D/EventLogger: onLoadCompleted 08-08 17:28:35.181 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:35.497 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:35.752 17279-17766/it.rainet I/chatty: uid=11527(u0_a1527) ADEum-Agent-IO identical 2 lines 08-08 17:28:35.754 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:35.787 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 3821 08-08 17:28:35.989 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:36.400 17279-17766/it.rainet I/chatty: uid=11527(u0_a1527) ADEum-Agent-IO identical 2 lines 08-08 17:28:36.401 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:36.665 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:36.666 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:36.786 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 4821 08-08 17:28:37.020 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:37.743 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:37.790 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 5824 08-08 17:28:38.251 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:38.783 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 6818 08-08 17:28:38.859 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.331 17279-17896/it.rainet D/WebtrekkSDK: onSendIntervalOver: activity count: 4 request urls: 4 08-08 17:28:39.343 17279-18289/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.346 17279-18289/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.442 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.443 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.460 17279-18289/it.rainet D/WebtrekkSDK: completed request. Status code:200 08-08 17:28:39.465 17279-18289/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.467 17279-18289/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.562 17279-18289/it.rainet D/WebtrekkSDK: completed request. Status code:200 08-08 17:28:39.574 17279-18289/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.576 17279-18289/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.671 17279-18289/it.rainet D/WebtrekkSDK: completed request. Status code:200 08-08 17:28:39.682 17279-18289/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.684 17279-18289/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.744 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:39.762 17279-18289/it.rainet D/WebtrekkSDK: completed request. Status code:200 08-08 17:28:39.780 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 7815 08-08 17:28:40.201 17279-17675/it.rainet W/OkHttpClient: A connection to http://rai-italia01.wt-eu02.net/ was leaked. Did you forget to close a response body? 08-08 17:28:40.202 17279-17675/it.rainet I/chatty: uid=11527(u0_a1527) OkHttp Connecti identical 2 lines 08-08 17:28:40.202 17279-17675/it.rainet W/OkHttpClient: A connection to http://rai-italia01.wt-eu02.net/ was leaked. Did you forget to close a response body? 08-08 17:28:40.211 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:40.704 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:40.705 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:40.782 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 8816 08-08 17:28:41.016 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:41.629 17279-17766/it.rainet I/chatty: uid=11527(u0_a1527) ADEum-Agent-IO identical 4 lines 08-08 17:28:41.630 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:41.785 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 9820 08-08 17:28:42.240 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:42.241 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:42.785 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 10819 08-08 17:28:42.853 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:43.780 17279-17766/it.rainet I/chatty: uid=11527(u0_a1527) ADEum-Agent-IO identical 4 lines 08-08 17:28:43.781 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:43.784 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 11819 08-08 17:28:44.042 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:44.783 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 12818 08-08 17:28:44.942 17279-17872/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:44.943 17279-17872/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:45.010 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:45.011 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:45.787 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 13822 08-08 17:28:46.774 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:46.775 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:46.780 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 14814 08-08 17:28:47.785 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 15820 08-08 17:28:48.790 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 16824 08-08 17:28:49.309 17279-17279/it.rainet D/EventLogger: state [17.26, true, B] 08-08 17:28:49.785 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 17819 08-08 17:28:50.333 17279-17896/it.rainet D/WebtrekkSDK: onSendIntervalOver: activity count: 4 request urls: 0 08-08 17:28:50.410 17279-17872/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:50.412 17279-17872/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:50.507 17279-17766/it.rainet I/System.out: (HTTPLog)-Static: isSBSettingEnabled false 08-08 17:28:50.783 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 18818 08-08 17:28:51.104 17279-17291/it.rainet I/zygote: Do full code cache collection, code=1011KB, data=810KB 08-08 17:28:51.114 17279-17291/it.rainet I/zygote: After code cache collection, code=999KB, data=691KB 08-08 17:28:51.784 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 19818 08-08 17:28:52.785 17279-17279/it.rainet E/TRACK_VOD: PositionActionEvent update: SystemClock.uptimeMillis() - lastUpdate= 20820 ```
andrewlewis commented 6 years ago

I have a possible fix in review for #4030 and #4280 which will likely address this. If you provide your ad tag I can verify, or feel free to wait for an update on those issues. Marking as a duplicate for now.

andrewger157 commented 6 years ago

you can try this ad tag

https://pubads.g.doubleclick.net/gampad/ads?sz=640x480&iu=/21690435817/rplym/test/test/video&cust_params=test%3D24&optout=false&programma=La prova del cuoco&genere=lifestyle&tipologia=Programmi Tv&impl=s&gdfp_req=1&env=vp&output=vmap&unviewed_position_start=1&url=[referrer_url]&description_url=[description_url]&correlator=1533033741271&vid_d=300&allcues=15000

let me know thanks

andrewlewis commented 6 years ago

That ad tag plays correctly with the fix I have in review, so please look for an update on #4030 when this gets pushed to the development branch.

andrewger157 commented 6 years ago

Hi, I have tested version 2.8.4 and now the player does not stop at the midroll if the preroll is empty. This is ok but the midroll is not played, if the preroll is empty / malformed none of the advs following the preroll are played. Will this behavior be fixed in the next versions?

andrewlewis commented 6 years ago

@andrewger157 I think the fix in e9e1c08 was too aggressive and caused a later ad break to be discarded. The provided ad tag plays correctly for me if I revert all of that change except the assignment pendingContentPositionMs = C.TIME_UNSET on line 1111, which is needed to ensure that the player position is reported to IMA. I've made a fix for this and it will be pushed to the dev branch soon. Thanks for following up.