Network timeout on Android

Discuss any general programming issues here
User avatar
airsoftsoftwair
Posts: 2914
Joined: Fri Feb 12, 2010 2:33 pm
Location: Germany
Contact:

Re: Network timeout on Android

Post by airsoftsoftwair » Fri Sep 23, 2016 4:55 pm

Ok, now it's starting to get interesting. Please try the next build and post the log.

zylesea
Posts: 198
Joined: Tue Feb 16, 2010 12:50 am
Location: Westfalen/Germany
Contact:

Re: Network timeout on Android

Post by zylesea » Fri Sep 23, 2016 11:24 pm

Here's the interesting new stuff:

Code: Select all

I/LogTag  (15284): And Action!
I/LogTag  (15284):
I/LogTag  (15284): *** OPEN CONNECTION: www.airsoftsoftwair.de
I/LogTag  (15284): *** GOT0: 0
I/LogTag  (15284): *** SEND REQUEST: GET /images/products/hollywood/47_shot1.jpg HTTP/1.1
I/LogTag  (15284):
I/LogTag  (15284): *** APP_CMD_WINDOW_RESIZED
I/LogTag  (15284): *** GOT1: 0
I/LogTag  (15284): *** SEND REQUEST: TE: trailers
I/LogTag  (15284): Connection: close, TE
I/LogTag  (15284): Host: www.airsoftsoftwair.de
I/LogTag  (15284): User-Agent: Hollywood 6.1
I/LogTag  (15284):
I/LogTag  (15284):
I/LogTag  (15284): *** GOT2: 0
I/LogTag  (15284): *** GETTING STATUS
I/LogTag  (15284): *** BUFFER_GET
E/WifiStateMachine(  468): WifiStateMachine CMD_START_SCAN source -2 txSuccessRate=0,07 rxSuccessRate=0,29 targetRoamBSS
ID=c8:0e:14:fa:33:72 RSSI=-63
E/WifiStateMachine(  468): WifiStateMachine starting scan for "XXX"WPA_PSK with 2437
I/DownloadManagerWrapper(  914): onReceive() : Charging = true
E/WifiStateMachine(  468): WifiStateMachine CMD_START_SCAN source -2 txSuccessRate=0,07 rxSuccessRate=0,03 targetRoamBSS
ID=c8:0e:14:fa:33:72 RSSI=-67
D/ConnectivityService(  468): updateNetworkScore for NetworkAgentInfo [WIFI () - 105] to 56
D/ConnectivityService(  468): rematching NetworkAgentInfo [WIFI () - 105]
D/ConnectivityService(  468): Network NetworkAgentInfo [WIFI () - 105] was already satisfying request 1. No change.
D/ConnectivityService(  468): notifyType AVAILABLE for NetworkAgentInfo [WIFI () - 105]
D/ConnectivityManager.CallbackHandler(  700): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 1331): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 6009): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(13733): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(13804): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(14290): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 6243): CM callback handler got msg 524290
D/ConnectivityService(  468): updateNetworkScore for NetworkAgentInfo [WIFI () - 105] to 60
D/ConnectivityService(  468): rematching NetworkAgentInfo [WIFI () - 105]
D/ConnectivityService(  468): Network NetworkAgentInfo [WIFI () - 105] was already satisfying request 1. No change.
D/ConnectivityService(  468): notifyType AVAILABLE for NetworkAgentInfo [WIFI () - 105]
D/ConnectivityManager.CallbackHandler(  700): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 6009): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 6243): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 1331): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(13733): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(13804): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(14290): CM callback handler got msg 524290
E/WifiStateMachine(  468): WifiStateMachine CMD_START_SCAN source -2 txSuccessRate=0,06 rxSuccessRate=0,03 targetRoamBSS
ID=c8:0e:14:fa:33:72 RSSI=-70
E/WifiStateMachine(  468): WifiStateMachine starting scan for "XXX"WPA_PSK with 2437
D/ConnectivityService(  468): updateNetworkScore for NetworkAgentInfo [WIFI () - 105] to 56
D/ConnectivityService(  468): rematching NetworkAgentInfo [WIFI () - 105]
D/ConnectivityService(  468): Network NetworkAgentInfo [WIFI () - 105] was already satisfying request 1. No change.
D/ConnectivityService(  468): notifyType AVAILABLE for NetworkAgentInfo [WIFI () - 105]
D/ConnectivityManager.CallbackHandler( 1331): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(  700): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(13733): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 6243): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(14290): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 6009): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(13804): CM callback handler got msg 524290
D/ConnectivityService(  468): updateNetworkScore for NetworkAgentInfo [WIFI () - 105] to 60
D/ConnectivityService(  468): rematching NetworkAgentInfo [WIFI () - 105]
D/ConnectivityService(  468): Network NetworkAgentInfo [WIFI () - 105] was already satisfying request 1. No change.
D/ConnectivityService(  468): notifyType AVAILABLE for NetworkAgentInfo [WIFI () - 105]
D/ConnectivityManager.CallbackHandler(  700): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 6009): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 6243): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 1331): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(13733): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(13804): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(14290): CM callback handler got msg 524290
I/LogTag  (15284): *** TAKEN: 0
I/LogTag  (15284): *** ERRNO: 22
I/LogTag  (15284): *** RECV: -2 GOT: 0
I/LogTag  (15284): *** RETURN --> ERROR: -2 COUNT: 0
I/LogTag  (15284): *** GOT3: 1423 STATUS: -1
V/WindowManager(  468): not Base app: Adding window Window{378726b u0 com.airsoftsoftwair.hollywood/com.airsoftsoftwair.
hollywood.HollywoodActivity} at 7 of 13
I/LogTag  (15284): *** APP_CMD_LOST_FOCUS
E/WifiStateMachine(  468): WifiStateMachine CMD_START_SCAN source -2 txSuccessRate=0,31 rxSuccessRate=0,03 targetRoamBSS
ID=c8:0e:14:fa:33:72 RSSI=-63
E/WifiStateMachine(  468): WifiStateMachine starting scan for "XXX"WPA_PSK with 2437
I/LogTag  (15284): *** APP_CMD_GAINED_FOCUS
W/InputMethodManagerService(  468): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMeth
odClient$Stub$Proxy@2fd6f274 attribute=null, token = android.os.BinderProxy@15778380
W/ActivityManager(  468): Activity pause timeout for ActivityRecord{17b5e650 u0 com.airsoftsoftwair.hollywood/.Hollywood
Activity t42 f}
I/ActivityManager(  468): Killing 13177:com.google.android.apps.docs/u0a28 (adj 15): empty #17
I/LogTag  (15284): *** APP_CMD_LOST_FOCUS
I/LogTag  (15284): *** APP_CMD_PAUSE
W/OpenGLRenderer( 1041): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
W/OpenGLRenderer( 1041): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
W/ResourceType(  700): No package identifier when getting value for resource number 0x00000000
W/PackageManager(  700): Failure retrieving resources for com.airsoftsoftwair.hollywood: Resource ID #0x0
I/LogTag  (15284): *** APP_CMD_STOP
I/LogTag  (15284): *** APP_CMD_TERM_WINDOW
I/Process (15284): Sending signal. PID: 15284 SIG: 9
I/WindowState(  468): WIN DEATH: Window{2f42db9 u0 com.airsoftsoftwair.hollywood/com.airsoftsoftwair.hollywood.Hollywood
Activity}
I/ActivityManager(  468): Process com.airsoftsoftwair.hollywood (pid 15284) has died 
Takes quite some time until the final errort message box appears.

User avatar
airsoftsoftwair
Posts: 2914
Joined: Fri Feb 12, 2010 2:33 pm
Location: Germany
Contact:

Re: Network timeout on Android

Post by airsoftsoftwair » Sat Sep 24, 2016 1:06 pm

Thanks, build updated, next log please :)

zylesea
Posts: 198
Joined: Tue Feb 16, 2010 12:50 am
Location: Westfalen/Germany
Contact:

Re: Network timeout on Android

Post by zylesea » Sat Sep 24, 2016 11:51 pm

Home again late - the surprising work of an Asphaltfräse made my afternoon cycling tour a bit longer than intended: tyre broke but rim is okay, hands are dirty and the is shin a bit scratchy and bloody plus blisters on the feet due to quite a long walk in biking shoes... Nothing nasty, but a bit unpleasant. Anyway, here's the log:

Code: Select all

I/LogTag  (17754): And Action!
I/LogTag  (17754):
I/threaded_app(17754): NativeWindowResized: 0x60bf8950 -- 0x4004c010
I/LogTag  (17754): *** OPEN CONNECTION: www.airsoftsoftwair.de
I/LogTag  (17754): *** GETHOSTBYNAME FOR www.airsoftsoftwair.de
I/LogTag  (17754): *** INET_PTON: 1
I/LogTag  (17754): *** APP_CMD_WINDOW_RESIZED
I/LogTag  (17754): *** GOT0: 0
I/LogTag  (17754): *** SEND REQUEST: GET /images/products/hollywood/47_shot1.jpg HTTP/1.1
I/LogTag  (17754):
I/LogTag  (17754): *** GOT1: 0
I/LogTag  (17754): *** SEND REQUEST: TE: trailers
I/LogTag  (17754): Connection: close, TE
I/LogTag  (17754): Host: www.airsoftsoftwair.de
I/LogTag  (17754): User-Agent: Hollywood 6.1
I/LogTag  (17754):
I/LogTag  (17754):
I/LogTag  (17754): *** GOT2: 0
I/LogTag  (17754): *** GETTING STATUS
I/LogTag  (17754): *** BUFFER_GET
I/LogTag  (17754): *** TAKEN: -1
I/LogTag  (17754): *** ERRNO: 11
I/LogTag  (17754): *** NEW WAITFD --- BLOCK: 0 TOTAL: 0 START: 1474752553.0941
I/LogTag  (17754): *** NOW RUNNING SELECT WITH TIMEOUT: 10 0
E/WifiStateMachine(  469): WifiStateMachine CMD_START_SCAN source -2 txSuccessRate=2,15 rxSuccessRate=1,13 targetRoamBSS
ID=00:00:00:00:00:00 RSSI=-59
I/LogTag  (17754): *** RETURN FROM SELECT WITH: 0 11 ---- THIS TOOK: 10 1357
I/LogTag  (17754): *** EXIT: 0
I/LogTag  (17754): *** RECV: -1 GOT: 0
I/LogTag  (17754): *** RETURN --> ERROR: -1 COUNT: 0
I/LogTag  (17754): *** GOT IO_TIMEOUT
I/LogTag  (17754): *** NETWORK TIMEOUT THRESHOLD REACHED (10000) -- ERRORING
I/LogTag  (17754): *** GOT3: 1422 STATUS: -1
V/WindowManager(  469): not Base app: Adding window Window{13acf9a9 u0 com.airsoftsoftwair.hollywood/com.airsoftsoftwair
.hollywood.HollywoodActivity} at 6 of 12
I/LogTag  (17754): *** APP_CMD_LOST_FOCUS
I/LogTag  (17754): *** APP_CMD_GAINED_FOCUS
W/InputMethodManagerService(  469): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMeth
odClient$Stub$Proxy@a629c3a attribute=null, token = android.os.BinderProxy@125a6e94
W/ActivityManager(  469): Activity pause timeout for ActivityRecord{2eb32464 u0 com.airsoftsoftwair.hollywood/.Hollywood
Activity t19 f}
I/ActivityManager(  469): Killing 13429:com.android.packageinstaller/u0a66 (adj 15): empty #17
I/LogTag  (17754): *** APP_CMD_LOST_FOCUS
I/LogTag  (17754): *** APP_CMD_PAUSE
W/OpenGLRenderer( 1151): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
W/OpenGLRenderer( 1151): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
W/ResourceType(  722): No package identifier when getting value for resource number 0x00000000
W/PackageManager(  722): Failure retrieving resources for com.airsoftsoftwair.hollywood: Resource ID #0x0
I/LogTag  (17754): *** APP_CMD_STOP
I/LogTag  (17754): *** APP_CMD_TERM_WINDOW
I/Process (17754): Sending signal. PID: 17754 SIG: 9
I/WindowState(  469): WIN DEATH: Window{38aa5d3d u0 com.airsoftsoftwair.hollywood/com.airsoftsoftwair.hollywood.Hollywoo
dActivity}
I/ActivityManager(  469): Process com.airsoftsoftwair.hollywood (pid 17754) has died                          

User avatar
airsoftsoftwair
Posts: 2914
Joined: Fri Feb 12, 2010 2:33 pm
Location: Germany
Contact:

Re: Network timeout on Android

Post by airsoftsoftwair » Sun Sep 25, 2016 11:50 am

Ok, next log please :)

zylesea
Posts: 198
Joined: Tue Feb 16, 2010 12:50 am
Location: Westfalen/Germany
Contact:

Re: Network timeout on Android

Post by zylesea » Sun Sep 25, 2016 8:37 pm

Here we go, I guess it's intendedthat this release behaves a bit different? The Hollywood 4.7 updater gets shown...

Code: Select all

I/LogTag  ( 7540): *** TAKEN: 1440
I/LogTag  ( 7540): *** RECV: 0 GOT: 1440
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 1440
I/LogTag  ( 7540): *** RECV: 0 GOT: 1440
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 5760
I/LogTag  ( 7540): *** RECV: 0 GOT: 5760
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 5760
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 1440
I/LogTag  ( 7540): *** RECV: 0 GOT: 1440
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 1440
I/LogTag  ( 7540): *** RECV: 0 GOT: 1440
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 1440
I/LogTag  ( 7540): *** RECV: 0 GOT: 1440
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 1440
I/LogTag  ( 7540): *** RECV: 0 GOT: 1440
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 1440
I/LogTag  ( 7540): *** RECV: 0 GOT: 1440
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 4320
I/LogTag  ( 7540): *** RECV: 0 GOT: 4320
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 4320
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 4320
I/LogTag  ( 7540): *** RECV: 0 GOT: 4320
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 4320
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 5760
I/LogTag  ( 7540): *** RECV: 0 GOT: 5760
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 5760
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 4320
I/LogTag  ( 7540): *** RECV: 0 GOT: 4320
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 4320
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 7200
I/LogTag  ( 7540): *** RECV: 0 GOT: 7200
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 7200
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 5760
I/LogTag  ( 7540): *** RECV: 0 GOT: 5760
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 5760
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 7200
I/LogTag  ( 7540): *** RECV: 0 GOT: 7200
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 7200
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 4320
I/LogTag  ( 7540): *** RECV: 0 GOT: 4320
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 4320
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 2880
I/LogTag  ( 7540): *** RECV: 0 GOT: 2880
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 1440
I/LogTag  ( 7540): *** RECV: 0 GOT: 1440
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 8192
I/LogTag  ( 7540): *** RECV: 0 GOT: 8192
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 8192
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 6208
I/LogTag  ( 7540): *** RECV: 0 GOT: 6208
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 6208
I/LogTag  ( 7540): *** BUFFER_GET
I/LogTag  ( 7540): *** TAKEN: 1272
I/LogTag  ( 7540): *** RECV: 0 GOT: 1272
I/LogTag  ( 7540): *** RETURN --> ERROR: 0 COUNT: 1272
I/LogTag  ( 7540): *** GOT5: 0
I/LogTag  ( 7540): *** APP_CMD_WINDOW_RESIZED
I/threaded_app( 7540): New input event: type=2
I/threaded_app( 7540): New input event: type=2
I/threaded_app( 7540): New input event: type=2
W/ActivityManager(  469): Activity pause timeout for ActivityRecord{22e4af3f u0 com.airsoftsoftwair.hollywood/.Hollywood
Activity t22 f}
I/ActivityManager(  469): Killing 5972:com.android.keychain/1000 (adj 15): empty #17
I/LogTag  ( 7540): *** APP_CMD_LOST_FOCUS
I/LogTag  ( 7540): *** APP_CMD_PAUSE
W/OpenGLRenderer( 1151): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
W/OpenGLRenderer( 1151): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
W/ResourceType(  722): No package identifier when getting value for resource number 0x00000000
W/PackageManager(  722): Failure retrieving resources for com.airsoftsoftwair.hollywood: Resource ID #0x0
I/LogTag  ( 7540): *** APP_CMD_STOP
E/WifiStateMachine(  469): WifiStateMachine CMD_START_SCAN source -2 txSuccessRate=25,62 rxSuccessRate=25,56 targetRoamB
SSID=00:00:00:00:00:00 RSSI=-62
E/WifiStateMachine(  469): WifiStateMachine starting scan for "XXX"WPA_PSK with 2437
I/LogTag  ( 7540): *** APP_CMD_TERM_WINDOW
I/Process ( 7540): Sending signal. PID: 7540 SIG: 9
I/WindowState(  469): WIN DEATH: Window{c87843c u0 com.airsoftsoftwair.hollywood/com.airsoftsoftwair.hollywood.Hollywood
Activity}
I/ActivityManager(  469): Process com.airsoftsoftwair.hollywood (pid 7540) has died  


User avatar
airsoftsoftwair
Posts: 2914
Joined: Fri Feb 12, 2010 2:33 pm
Location: Germany
Contact:

Re: Network timeout on Android

Post by airsoftsoftwair » Mon Sep 26, 2016 4:01 pm

Ok, so now it's working correctly. But I have disabled some stuff that I need to enable again so I'll now enable things one by one to see which one of the changes caused the downloader to fail on your system. So please try the new build and post the log.

zylesea
Posts: 198
Joined: Tue Feb 16, 2010 12:50 am
Location: Westfalen/Germany
Contact:

Re: Network timeout on Android

Post by zylesea » Mon Sep 26, 2016 9:48 pm

Quite much debug output again, cut out the massive repetions. Et voilà:

Code: Select all

I/LogTag  (26587): And Action!
I/LogTag  (26587): *** NEW OPEN CONNECTION: www.airsoftsoftwair.de
I/LogTag  (26587): *** GETHOSTBYNAME FOR www.airsoftsoftwair.de
I/LogTag  (26587): *** INET_PTON: 1
I/LogTag  (26587): SIZEOF: 4 16 16
I/LogTag  (26587): *** TRYING TO CONNECT
I/LogTag  (26587): *** HOLDING THE LINE
I/LogTag  (26587): *** GOT0: 0
I/LogTag  (26587): *** SEND REQUEST: GET /images/products/hollywood/47_shot1.jpg HTTP/1.0
I/LogTag  (26587): Host: www.airsoftsoftwair.de
I/LogTag  (26587): User-Agent: Hollywood 6.1
I/LogTag  (26587): 
I/LogTag  (26587): 
I/LogTag  (26587): *** GOT1: 0
I/LogTag  (26587): *** GETTING STATUS
I/LogTag  (26587): *** BUFFER_GET
I/LogTag  (26587): *** TAKEN: -1
I/LogTag  (26587): *** ERRNO: 11
I/LogTag  (26587): *** TAKEN: -1
I/LogTag  (26587): *** ERRNO: 11
(... quite some repetitions ...)
I/LogTag  (26587): *** TAKEN: 2880
(...)
I/LogTag  (26587): *** RECV: 0 GOT: 1440
I/LogTag  (26587): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  (26587): *** BUFFER_GET
I/LogTag  (26587): *** TAKEN: 5760
I/LogTag  (26587): *** RECV: 0 GOT: 5760
I/LogTag  (26587): *** RETURN --> ERROR: 0 COUNT: 5760
I/LogTag  (26587): *** BUFFER_GET
I/LogTag  (26587): *** TAKEN: 4320
I/LogTag  (26587): *** RECV: 0 GOT: 4320
I/LogTag  (26587): *** RETURN --> ERROR: 0 COUNT: 4320
(...)
I/LogTag  (26587): *** TAKEN: 1440
I/LogTag  (26587): *** RECV: 0 GOT: 1440
I/LogTag  (26587): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  (26587): *** BUFFER_GET
I/LogTag  (26587): *** TAKEN: 2880
I/LogTag  (26587): *** RECV: 0 GOT: 2880
I/LogTag  (26587): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  (26587): *** BUFFER_GET
I/LogTag  (26587): *** TAKEN: 1440
I/LogTag  (26587): *** RECV: 0 GOT: 1440
I/LogTag  (26587): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  (26587): *** BUFFER_GET
I/LogTag  (26587): *** TAKEN: -1
I/LogTag  (26587): *** ERRNO: 11
(...)
I/LogTag  (26587): *** RECV: 0 GOT: 1440
I/LogTag  (26587): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  (26587): *** BUFFER_GET
I/LogTag  (26587): *** TAKEN: 2880
I/LogTag  (26587): *** RECV: 0 GOT: 2880
I/LogTag  (26587): *** RETURN --> ERROR: 0 COUNT: 2880
I/LogTag  (26587): *** BUFFER_GET
I/LogTag  (26587): *** TAKEN: -1
I/LogTag  (26587): *** ERRNO: 11
I/LogTag  (26587): *** ERRNO: 11
I/LogTag  (26587): *** TAKEN: -1
I/LogTag  (26587): *** TAKEN: -1
I/LogTag  (26587): *** TAKEN: -1
I/LogTag  (26587): *** ERRNO: 11
I/LogTag  (26587): *** APP_CMD_WINDOW_RESIZED
I/threaded_app(26587): New input event: type=2
I/threaded_app(26587): New input event: type=2
W/ActivityManager(  469): Activity pause timeout for ActivityRecord{175e2608 u0 com.airsoftsoftwair.hollywood/.HollywoodActivity t29 f}
I/ActivityManager(  469): Killing 24623:com.android.externalstorage/u0a7 (adj 15): empty #17
I/LogTag  (26587): *** APP_CMD_LOST_FOCUS
I/LogTag  (26587): *** APP_CMD_PAUSE
W/OpenGLRenderer( 1151): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
W/OpenGLRenderer( 1151): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
W/ResourceType(  722): No package identifier when getting value for resource number 0x00000000
W/PackageManager(  722): Failure retrieving resources for com.airsoftsoftwair.hollywood: Resource ID #0x0
I/LogTag  (26587): *** APP_CMD_STOP
I/LogTag  (26587): *** APP_CMD_TERM_WINDOW
I/Process (26587): Sending signal. PID: 26587 SIG: 9
I/WindowState(  469): WIN DEATH: Window{1a521495 u0 com.airsoftsoftwair.hollywood/com.airsoftsoftwair.hollywood.HollywoodActivity}
I/ActivityManager(  469): Process com.airsoftsoftwair.hollywood (pid 26587) has died      


User avatar
airsoftsoftwair
Posts: 2914
Joined: Fri Feb 12, 2010 2:33 pm
Location: Germany
Contact:

Re: Network timeout on Android

Post by airsoftsoftwair » Mon Sep 26, 2016 10:27 pm

Ok, thanks, next log please...

zylesea
Posts: 198
Joined: Tue Feb 16, 2010 12:50 am
Location: Westfalen/Germany
Contact:

Re: Network timeout on Android

Post by zylesea » Tue Sep 27, 2016 12:06 am

Again massive repeating debug output. Cut away about 4000 repeating lines, but I guess there's something useful in the remaining lines:

Code: Select all

I/LogTag  ( 1677): And Action!
I/threaded_app( 1677): NativeWindowResized: 0x41e07c58 -- 0x5ab8e728
D/ConnectivityService(  469): updateNetworkScore for NetworkAgentInfo [WIFI () - 101] to 60
D/ConnectivityService(  469): rematching NetworkAgentInfo [WIFI () - 101]
D/ConnectivityService(  469): Network NetworkAgentInfo [WIFI () - 101] was already satisfying request 1. No change.
D/ConnectivityService(  469): notifyType AVAILABLE for NetworkAgentInfo [WIFI () - 101]
D/ConnectivityManager.CallbackHandler(  722): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(29252): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 3192): CM callback handler got msg 524290
I/LogTag  ( 1677): *** NEW NEW OPEN CONNECTION: www.airsoftsoftwair.de
I/LogTag  ( 1677): *** GETHOSTBYNAME FOR www.airsoftsoftwair.de
I/LogTag  ( 1677): *** INET_PTON: 1
I/LogTag  ( 1677): SIZEOF: 4 16 16
I/LogTag  ( 1677): *** TRYING TO CONNECT
I/LogTag  ( 1677): *** HOLDING THE LINE
I/LogTag  ( 1677): *** APP_CMD_WINDOW_RESIZED
I/LogTag  ( 1677): *** GOT0: 0
I/LogTag  ( 1677): *** SEND REQUEST: GET /images/products/hollywood/47_shot1.jpg HTTP/1.0
I/LogTag  ( 1677): Host: www.airsoftsoftwair.de
I/LogTag  ( 1677): User-Agent: Hollywood 6.1
I/LogTag  ( 1677): *** GOT1: 0
I/LogTag  ( 1677): *** GETTING STATUS
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** TAKEN: -1
I/LogTag  ( 1677): *** ERRNO: 11
I/LogTag  ( 1677): *** TAKEN: -1
I/LogTag  ( 1677): *** ERRNO: 11
  (... a thousand or so repetitions ...)
I/LogTag  ( 1677): *** TAKEN: 1440
I/LogTag  ( 1677): *** RECV: 0 GOT: 1440
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 1677): *** GOT3: 0 STATUS: 200
I/LogTag  ( 1677): *** GETTING HTTP HEADERS
I/LogTag  ( 1677): *** GET NEXT LINE
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1423
I/LogTag  ( 1677): *** ERROR: 0 GOT LINE: Date: Mon, 26 Sep 2016 21:42:44 GMT
I/LogTag  ( 1677): *** GET NEXT LINE
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1386
I/LogTag  ( 1677): *** ERROR: 0 GOT LINE: Content-Type: image/jpeg
I/LogTag  ( 1677): *** GET NEXT LINE
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1360
I/LogTag  ( 1677): *** ERROR: 0 GOT LINE: Content-Length: 142147
I/LogTag  ( 1677): *** GET NEXT LINE
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1336
I/LogTag  ( 1677): *** ERROR: 0 GOT LINE: Connection: close
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** ERROR: 0 GOT LINE: Server: Apache
I/LogTag  ( 1677): *** GET NEXT LINE
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1301
I/LogTag  ( 1677): *** ERROR: 0 GOT LINE: Last-Modified: Fri, 23 Apr 2010 12:52:22 GMT
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1255
I/LogTag  ( 1677): *** GET NEXT LINE
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1219
I/LogTag  ( 1677): *** ERROR: 0 GOT LINE: Accept-Ranges: bytes
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1197
I/LogTag  ( 1677): *** GOT4: 0
I/LogTag  ( 1677): *** NOW DOWNLOADING 142147 BYTES
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1195
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** TAKEN: 1440
I/LogTag  ( 1677): *** RECV: 0 GOT: 1440
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1440
I/LogTag  ( 1677): *** BUFFER_GET
I/LogTag  ( 1677): *** TAKEN: -1
I/LogTag  ( 1677): *** TAKEN: 1440
I/LogTag  ( 1677): *** RECV: 0 GOT: 1440
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1440
  (... quite some repetitions of the above ...)
I/LogTag  ( 1677): *** ERRNO: 11
I/LogTag  ( 1677): *** ERRNO: 11
I/LogTag  ( 1677): *** TAKEN: 1272
I/LogTag  ( 1677): *** RETURN --> ERROR: 0 COUNT: 1272
I/LogTag  ( 1677): *** GOT5: 0
I/threaded_app( 1677): New input event: type=2
I/threaded_app( 1677): New input event: type=2
I/threaded_app( 1677): New input event: type=2
I/threaded_app( 1677): New input event: type=2
W/ActivityManager(  469): Activity pause timeout for ActivityRecord{eee7b0e u0 com.airsoftsoftwair.hollywood/.HollywoodActivity t31 f}
I/ActivityManager(  469): Killing 331:com.google.android.apps.plus/u0a47 (adj 15): empty #17
I/LogTag  ( 1677): *** APP_CMD_LOST_FOCUS
I/LogTag  ( 1677): *** APP_CMD_PAUSE
W/OpenGLRenderer( 1151): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
W/OpenGLRenderer( 1151): Incorrectly called buildLayer on View: ShortcutAndWidgetContainer, destroying layer...
I/DownloadManagerWrapper( 1001): onReceive() : Charging = true
D/ConnectivityService(  469): updateNetworkScore for NetworkAgentInfo [WIFI () - 101] to 56
D/ConnectivityService(  469): rematching NetworkAgentInfo [WIFI () - 101]
D/ConnectivityService(  469): Network NetworkAgentInfo [WIFI () - 101] was already satisfying request 1. No change.
D/ConnectivityService(  469): notifyType AVAILABLE for NetworkAgentInfo [WIFI () - 101]
D/ConnectivityManager.CallbackHandler(  722): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler( 3192): CM callback handler got msg 524290
D/ConnectivityManager.CallbackHandler(29252): CM callback handler got msg 524290
W/ResourceType(  722): No package identifier when getting value for resource number 0x00000000
W/PackageManager(  722): Failure retrieving resources for com.airsoftsoftwair.hollywood: Resource ID #0x0
I/LogTag  ( 1677): *** APP_CMD_STOP
I/LogTag  ( 1677): *** APP_CMD_TERM_WINDOW
I/Process ( 1677): Sending signal. PID: 1677 SIG: 9
I/WindowState(  469): WIN DEATH: Window{80826c3 u0 com.airsoftsoftwair.hollywood/com.airsoftsoftwair.hollywood.HollywoodActivity}
I/ActivityManager(  469): Process com.airsoftsoftwair.hollywood (pid 1677) has died                                   

Post Reply