Open Radar

 
Boris Sotillos
29-Jan-2016 05:04 PM

Summary:
On a NSBundleResourceRequest, calling beginAccessingResourcesWithCompletionHandler takes one minute before it issues the actual HTTP GET request,

This has been introduced in tvOS 9.2 beta 2. In 9.1 it didn't happen.

Steps to Reproduce:
1) Clean ODR (reinstall application)
2) Run attached application in debug (ODR via Xcode simulation) or release (you may have to set up a webserver).
3) Inspect logs.

See how in between these two log traces there is a 1 minute period. There is no reason for that.
2016-01-29 16:54:25.738 odrup[568:150102] waiting for beginAccessingResourcesWithCompletionHandler completion
2016-01-29 16:55:26.032 odrup[568:150372] beginAccessingResourcesWithCompletionHandler downloaded=1


Expected Results:
I would expect that download of such smaller files was initiated instantaneously.
It seems as there as a 1' timeout somewhere.

Actual Results:
2016-01-29 16:54:24.733 odrup[568:150102] begin v1
2016-01-29 16:54:24.734 odrup[568:150102] DumpTagContents begin (d1)
2016-01-29 16:54:24.737 odrup[568:150102] waiting for conditionallyBeginAccessingResourcesWithCompletionHandler completion
2016-01-29 16:54:24.746 odrup[568:150136] conditionallyBeginAccessingResourcesWithCompletionHandler available=0 checked=1
2016-01-29 16:54:25.737 odrup[568:150102] conditionallyBeginAccessingResourcesWithCompletionHandler completed
2016-01-29 16:54:25.738 odrup[568:150102] waiting for beginAccessingResourcesWithCompletionHandler completion
2016-01-29 16:55:26.032 odrup[568:150372] beginAccessingResourcesWithCompletionHandler downloaded=1
2016-01-29 16:55:26.807 odrup[568:150102] beginAccessingResourcesWithCompletionHandler completed
2016-01-29 16:55:26.829 odrup[568:150102] contents='this is d1. same file in v1 & v2'
2016-01-29 16:55:26.829 odrup[568:150102] DumpTagContents end (d1)
2016-01-29 16:55:26.830 odrup[568:150102] DumpTagContents begin (d2)
2016-01-29 16:55:26.830 odrup[568:150102] waiting for conditionallyBeginAccessingResourcesWithCompletionHandler completion
2016-01-29 16:55:26.838 odrup[568:150372] conditionallyBeginAccessingResourcesWithCompletionHandler available=0 checked=1
2016-01-29 16:55:27.832 odrup[568:150102] conditionallyBeginAccessingResourcesWithCompletionHandler completed
2016-01-29 16:55:27.833 odrup[568:150102] waiting for beginAccessingResourcesWithCompletionHandler completion
2016-01-29 16:56:28.170 odrup[568:150524] beginAccessingResourcesWithCompletionHandler downloaded=1
2016-01-29 16:56:28.902 odrup[568:150102] beginAccessingResourcesWithCompletionHandler completed
2016-01-29 16:56:28.912 odrup[568:150102] contents='this is d2 from v1'
2016-01-29 16:56:28.912 odrup[568:150102] DumpTagContents end (d2)
2016-01-29 16:56:28.913 odrup[568:150102] DumpTagContents begin (d3)
2016-01-29 16:56:28.914 odrup[568:150102] waiting for conditionallyBeginAccessingResourcesWithCompletionHandler completion
2016-01-29 16:56:28.920 odrup[568:150524] conditionallyBeginAccessingResourcesWithCompletionHandler available=0 checked=1
2016-01-29 16:56:29.915 odrup[568:150102] conditionallyBeginAccessingResourcesWithCompletionHandler completed
2016-01-29 16:56:29.916 odrup[568:150102] waiting for beginAccessingResourcesWithCompletionHandler completion
2016-01-29 16:56:29.921 odrup[568:150524] beginAccessingResourcesWithCompletionHandler downloaded=0
2016-01-29 16:56:30.918 odrup[568:150102] beginAccessingResourcesWithCompletionHandler completed
2016-01-29 16:56:30.918 odrup[568:150102] DumpTagContents end (d3)
2016-01-29 16:56:30.919 odrup[568:150102] end



Version:
tvOS 9.2 (13Y5189e)

Notes:


Configuration:
apple TV over LAN

Attachments:
'odrup.rar' was successfully uploaded.