Posts

Post not yet marked as solved
3 Replies
2.0k Views
Hi,We have a large number of users complaining about unable to use iCloud assets.We were able to reproduce it once in-house with a specific asset (movie file , 21 sec, 60fps). this asset can be playback in our app and in Photos app,but trying to download it into the device with PHImageManager:requestAVAssetForVideo (setting networkAccessAllowed==true) returns AVAsset==nil.the info dictionary is :{ PHImageResultDeliveredImageFormatKey = 0; PHImageResultIsInCloudKey = 1; PHImageResultWantedImageFormatKey = 20001;}The console looks like containing viable messages, but crypto to us, regarding cloudd.Should I open a bug?here are the log details:default 12:51:52.272271 +0200 Mxxxxxx ***************** requestAVAssetForVideo START *****************default 12:51:52.274638 +0200 Mxxxxxx -[iCloudDownloadQueue downloadNextItem] itemIdentifier:871E0D6B-2158-4AD4-8814-16C33D94B988/L0/001default 12:51:52.275218 +0200 Mxxxxxx ANALYTICS WRAPPER (BK tracker): log category:"UPLOAD_MANAGER MANUAL" event:"ICLOUD DOWNLOAD REQUIRED" label:"video asset"default 12:51:52.311707 +0200 Mxxxxxx -[iCloudDownloadItem download:progress:]_block_invoke video, progress:0.0000 err:(null)default 12:51:52.312093 +0200 Mxxxxxx -[iCloudDownloadItem download:progress:]_block_invoke video, progress:0.0000 err:(null)default 12:51:52.320335 +0200 cloudd [Operation 0x16121d6a0] Initialized with context 0x1613711b0. Background: 0, cellular: 1, QOS: 0x19default 12:51:52.321506 +0200 cloudd [Operation 0x16121d6a0] Starting operationdefault 12:51:52.328117 +0200 cloudd [Operation 0x16121d6a0] Operation transitioning from state 1 (cancelled=0, stop=0, error=0)default 12:51:52.362853 +0200 cloudd [Operation 0x16121d6a0] Request 0x15fdf1c50 set on operationdefault 12:51:52.367461 +0200 cloudd [Request 0x15fdf1c50] Performingdefault 12:51:52.371042 +0200 cloudd [Request 0x15fdf1c50] Getting URL for the user partitiondefault 12:51:52.372302 +0200 cloudd [Request 0x15fdf1c50] Getting configurationdefault 12:51:52.373937 +0200 cloudd [Operation 0x16121d6a0] Operation is now in state 2default 12:51:52.375090 +0200 cloudd [Request 0x15fdf1c50] Fetching container scoped user IDdefault 12:51:52.376734 +0200 cloudd [Request 0x15fdf1c50] Getting device IDdefault 12:51:52.378053 +0200 cloudd [Request 0x15fdf1c50] Getting zone gatesdefault 12:51:52.410040 +0200 accountsd "SecItemCopyMatching result: -25300 - keychain item com.apple.appleaccount.cloudkit.token - username <private>"default 12:51:52.415710 +0200 cloudd [Request 0x15fdf1c50] Getting push tokendefault 12:51:52.416443 +0200 cloudd Creating a new client context 0x15fe96df0default 12:51:52.416795 +0200 cloudd [Request 0x15fdf1c50] Performing request. Background=0, cellular=1default 12:51:52.467271 +0200 cloudd TIC TCP Conn Start [149:0x15ff72350]default 12:51:52.775902 +0200 itunesstored TIC TCP Conn Cancel [310:0x10b1d29c0]default 12:51:52.776946 +0200 itunesstored __nw_socket_service_writes_block_invoke sendmsg(fd 33, 31 bytes): socket has been closeddefault 12:51:52.777926 +0200 itunesstored TIC TCP Conn Destroyed [310:0x10b1d29c0]default 12:51:52.974226 +0200 CommCenter QMI: Svc=0xe2(BSP) Req MsgId=0xe002 Bin=[<private>]default 12:51:53.033032 +0200 CommCenter QMI: Svc=0xe2(BSP) Resp MsgId=0xe002 Bin=[<private>]default 12:51:53.043204 +0200 cloudd TIC TCP Conn Event [149:0x15ff72350]: 1 Err(0)default 12:51:53.043426 +0200 cloudd TIC TCP Conn Connected [149:0x15ff72350]: Err(0)default 12:51:53.044073 +0200 cloudd TIC Enabling TLS [149:0x15ff72350]default 12:51:53.077903 +0200 Mxxxxxx TIC TCP Conn Cancel [11:0x174388c90]default 12:51:53.080234 +0200 Mxxxxxx __nw_socket_service_writes_block_invoke sendmsg(fd 26, 31 bytes): socket has been closeddefault 12:51:53.477593 +0200 cloudd TIC TLS Event [149:0x15ff72350]: 2, Pending(0)default 12:51:53.486101 +0200 cloudd TIC TLS Event [149:0x15ff72350]: 11, Pending(0)default 12:51:53.528421 +0200 cloudd TIC TLS Event [149:0x15ff72350]: 22, Pending(0)default 12:51:53.555062 +0200 cloudd TIC TLS Event [149:0x15ff72350]: 12, Pending(0)default 12:51:53.556589 +0200 cloudd TIC TLS Event [149:0x15ff72350]: 14, Pending(0)default 12:51:53.591366 +0200 securityd ocsp responder: (null) did not include status of requested certdefault 12:51:53.601973 +0200 cloudd TIC TLS Trust Result [149:0x15ff72350]: 0default 12:51:53.775506 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/Frameworks/CoreTelephony.framework'default 12:51:53.864027 +0200 cloudd TIC TLS Event [149:0x15ff72350]: 20, Pending(0)default 12:51:53.871118 +0200 cloudd TIC TCP Conn Event [149:0x15ff72350]: 8 Err(0)default 12:51:53.872066 +0200 cloudd TIC TLS Handshake Complete [149:0x15ff72350]default 12:51:53.876045 +0200 cloudd [Request 0x15fdf1c50] requestForEstablishedConnectiondefault 12:51:54.207342 +0200 locationd Incrementing METs -- mets:<private> metsFromGrade:<private>default 12:51:54.232051 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client 'com.apple.HealthKit'default 12:51:54.297083 +0200 cloudd [Request 0x15fdf1c50] URLSession:dataTask:didReceiveResponse:completionHandler:default 12:51:54.312535 +0200 cloudd [Request 0x15fdf1c50] URLSession:dataTask:didReceiveData:default 12:51:54.317248 +0200 cloudd [Request 0x15fdf1c50] URLSession:task:didCompleteWithError:default 12:51:54.328169 +0200 cloudd [Operation 0x161014440] Initialized with context 0x1613711b0. Background: 0, cellular: 1, QOS: 0x19default 12:51:54.331329 +0200 cloudd [Request 0x15fdf1c50] Finishing request with no errordefault 12:51:54.333169 +0200 cloudd [Operation 0x161014440] Starting operationdefault 12:51:54.337481 +0200 cloudd [Operation 0x16121d6a0] Request 0x0 set on operationdefault 12:51:54.369610 +0200 cloudd [Operation 0x16121d6a0] Operation transitioning from state 2 (cancelled=0, stop=0, error=0)default 12:51:54.370391 +0200 cloudd [Operation 0x161052bb0] Initialized with context 0x1613711b0. Background: 0, cellular: 1, QOS: 0x19default 12:51:54.370958 +0200 cloudd [Operation 0x16121d6a0] Operation is now in state 3default 12:51:54.371536 +0200 cloudd [Operation 0x161052bb0] Starting operationdefault 12:51:54.380152 +0200 cloudd [Operation 0x161052bb0] Operation transitioning from state 1 (cancelled=0, stop=0, error=0)default 12:51:54.383422 +0200 cloudd [Operation 0x161052bb0] Operation is now in state 2default 12:51:54.384803 +0200 cloudd [Operation 0x161052bb0] Operation transitioning from state 2 (cancelled=0, stop=0, error=0)default 12:51:54.387218 +0200 cloudd [Operation 0x161052bb0] Operation is now in state 3default 12:51:54.422954 +0200 cloudd #fc63cded ACSMightCurrentNetworkHaveCachingServer(options={ capabilities = { import = 1; namespaces = 1; personalCaching = 1; }; quickMiss = 1; "x-apple-persistent-identifier" = 2e04;}, callbackQueue=0x0, callback=0x16e8297e8)default 12:51:54.433351 +0200 cloudd #fc63cded ACSMightCurrentNetworkHaveCachingServer -> [new] mightHave 0, error (null), elapsed 0.013default 12:51:54.435790 +0200 cloudd HttpSession <MMCSHTTPSession: 0x15ff51c40><uuid:C8B3A3A4-DCB9-4483-A9A6-55AE9831A51B session:default, z:foreground, adaptiveReadTimeout:3, adaptiveWriteTimeout:3>default 12:51:54.436896 +0200 cloudd HttpURL (https://p59-content.icloud.com:443/11593352801/authorizeGet)default 12:51:54.440445 +0200 cloudd RequestHeader (x-apple-request-uuid:D13C9DDD-B7C9-4C8E-A93B-B4276DA4E544)default 12:51:54.443866 +0200 coreduetd Metering Update disabled because of App Refresh disableddefault 12:51:54.447605 +0200 cloudd TIC TCP Conn Start [150:0x15ff0fa20]default 12:51:54.660681 +0200 locationd #warning no watchdog event from com.apple.springboard, deletingdefault 12:51:54.661113 +0200 locationd Client com.apple.springboard disconnecteddefault 12:51:54.666115 +0200 locationd #warning no watchdog event from com.apple.locationd, deletingdefault 12:51:54.666549 +0200 locationd Client com.apple.locationd disconnecteddefault 12:51:54.670615 +0200 locationd Client com.apple.springboard connecteddefault 12:51:54.671141 +0200 locationd getClientEffectiveRegistrationResult, /System/Library/CoreServices/SpringBoard.app/SpringBoard, com.apple.springboard, , CLClientRegistrationResult, kCLClientRegistrationResultFailedUnavailable, CLCommonLocationServicesEnabled, 1default 12:51:54.671556 +0200 locationd message 'kCLConnectionMessageMotionActivityUpdate' received from client 'com.apple.springboard'default 12:51:54.672229 +0200 locationd Client com.apple.springboard (0x11e0d8400) is subscribing to notification kCLConnectionMessageMotionActivityUpdatedefault 12:51:54.673828 +0200 locationd Client com.apple.locationd connecteddefault 12:51:54.674129 +0200 locationd allowing internal executable com.apple.locationddefault 12:51:54.674317 +0200 locationd getClientEffectiveRegistrationResult, /usr/libexec/routined, com.apple.locationd, , CLClientRegistrationResult, kCLClientRegistrationResultAllowedAlways, CLCommonLocationServicesEnabled, 1default 12:51:54.674997 +0200 locationd allowing internal executable com.apple.locationddefault 12:51:54.675138 +0200 locationd getClientEffectiveRegistrationResult, /usr/libexec/routined, com.apple.locationd, , CLClientRegistrationResult, kCLClientRegistrationResultAllowedAlways, CLCommonLocationServicesEnabled, 1default 12:51:54.676080 +0200 locationd message 'kCLConnectionMessageMotionActivityUpdate' received from client 'com.apple.locationd'default 12:51:54.676542 +0200 locationd Client com.apple.locationd (0x11e80a800) is subscribing to notification kCLConnectionMessageMotionActivityUpdatedefault 12:51:54.956769 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/WifiCalling.bundle'default 12:51:54.986037 +0200 CommCenter QMI: Svc=0xe2(BSP) Req MsgId=0xe002 Bin=[<private>]default 12:51:55.045163 +0200 CommCenter QMI: Svc=0xe2(BSP) Resp MsgId=0xe002 Bin=[<private>]default 12:51:55.047037 +0200 CommCenter #watchdog #I Callback Watchdog: checkin 3504default 12:51:55.047358 +0200 CommCenter #watchdog #I Server Watchdog: checkin 3504default 12:51:56.147853 +0200 cloudd TIC TCP Conn Event [150:0x15ff0fa20]: 1 Err(0)default 12:51:56.148646 +0200 cloudd TIC TCP Conn Connected [150:0x15ff0fa20]: Err(0)default 12:51:56.149769 +0200 cloudd TIC Enabling TLS [150:0x15ff0fa20]default 12:51:56.386797 +0200 cloudd TIC TLS Event [150:0x15ff0fa20]: 2, Pending(0)default 12:51:56.411914 +0200 locationd {"msg":"client getting effective client name", "clientName":"/usr/sbin/wifid", "bundleId":"", "bundlePath":"/System/Library/PrivateFrameworks/MobileWiFi.framework"}default 12:51:56.423591 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/PrivateFrameworks/MobileWiFi.framework'default 12:51:56.430322 +0200 cloudd TIC TLS Event [150:0x15ff0fa20]: 11, Pending(0)default 12:51:56.432162 +0200 cloudd TIC TLS Event [150:0x15ff0fa20]: 22, Pending(0)default 12:51:56.434473 +0200 cloudd TIC TLS Event [150:0x15ff0fa20]: 12, Pending(0)default 12:51:56.435296 +0200 cloudd TIC TLS Event [150:0x15ff0fa20]: 14, Pending(0)default 12:51:56.447459 +0200 cloudd could not disable pinning: not an internal releasedefault 12:51:56.447935 +0200 cloudd could not enable test cert: not an internal releasedefault 12:51:56.471377 +0200 securityd ocsp responder: (null) did not include status of requested certdefault 12:51:56.483129 +0200 cloudd TIC TLS Trust Result [150:0x15ff0fa20]: 0default 12:51:56.761230 +0200 identityservicesd calling continuityDidDiscoverType:Activity withData:<private> fromPeer:<private>error 12:51:56.774248 +0200 sharingd SecItemCopyMatching baseDict failed with error -25300default 12:51:56.775158 +0200 sharingd No current key to decrypt advertisement from E4531DE6-C9AE-41C0-859D-278FD491CFB2 with rawAdvertisementData <086b17ecc5f41159d467e374772a>. Requesting keyerror 12:51:56.780430 +0200 sharingd SecItemCopyMatching baseDict failed with error -25300default 12:51:56.780548 +0200 sharingd SDActivityPayloadManager: BUDGET BLOCK: Only 2m21s since we last requested a key from E4531DE6-C9AE-41C0-859D-278FD491CFB2. Must wait another 38sdefault 12:51:56.781236 +0200 cloudd TIC TLS Event [150:0x15ff0fa20]: 20, Pending(0)default 12:51:56.786948 +0200 cloudd TIC TCP Conn Event [150:0x15ff0fa20]: 8 Err(0)default 12:51:56.787166 +0200 cloudd TIC TLS Handshake Complete [150:0x15ff0fa20]default 12:51:56.978995 +0200 CommCenter QMI: Svc=0xe2(BSP) Req MsgId=0xe002 Bin=[<private>]default 12:51:57.045584 +0200 CommCenter QMI: Svc=0xe2(BSP) Resp MsgId=0xe002 Bin=[<private>]default 12:51:57.057400 +0200 Mxxxxxx TIC TCP Conn Cancel [10:0x174387290]default 12:51:57.058334 +0200 Mxxxxxx __nw_socket_service_writes_block_invoke sendmsg(fd 32, 31 bytes): socket has been closeddefault 12:51:57.100680 +0200 cloudd HttpStatus (HTTP/1.1 200 no error)default 12:51:57.101404 +0200 cloudd ResponseHeader (X-Apple-Request-UUID:D13C9DDD-B7C9-4C8E-A93B-B4276DA4E544)default 12:51:57.101865 +0200 cloudd ResponseHeader (Via:xrail:st13p00ic-zteu25283501:8301:17E107:grp62, icloudedge:se03p01ic-zteu011122:7401:18RC19:Seattle)default 12:51:57.102570 +0200 cloudd ResponseHeader (Server:AppleHttpServer/2f080fc0)default 12:51:57.104121 +0200 cloudd ResponseHeader (X-Responding-Instance:content.15900504.st42p59ic-tyfb03210801:8004.1804B55)default 12:51:57.108148 +0200 cloudd Observed 0.0029 Mbps over 2.6728 seconds for 974 bytes. 0.0111 seconds in queue.default 12:51:57.112015 +0200 cloudd PutComplete at Edge Protocol : falsedefault 12:51:57.119832 +0200 Mxxxxxx -[iCloudDownloadItem download:progress:]_block_invoke video, progress:0.0000 err:(null)error 12:51:57.196662 +0200 cloudd Unregistering item without an asset handle for itemID=1847default 12:51:57.199506 +0200 cloudd getItemReaderWriterForItemCallback did not succeeddefault 12:51:57.281101 +0200 Mxxxxxx -[iCloudDownloadItem download:progress:]_block_invoke video, progress:0.9901 err:(null)default 12:51:57.317777 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/TimeZone.bundle'default 12:51:57.319322 +0200 cloudd itemId:1849 local fulfillment took 0.1316 seconds for 9106292 bytes. Validated for Resume (0 bytes), Resumed (0 bytes), Fullfilled Locally (9106292 bytes)default 12:51:57.320072 +0200 cloudd Renaming <private> to <private> for item 1849default 12:51:57.321417 +0200 cloudd itemId 1849 completeddefault 12:51:57.348572 +0200 Mxxxxxx -[iCloudDownloadItem download:progress:]_block_invoke video, progress:0.9901 err:(null)default 12:51:57.357961 +0200 cloudd [Operation 0x161052bb0] Operation transitioning from state 3 (cancelled=0, stop=0, error=0)default 12:51:57.360100 +0200 cloudd [Operation 0x161052bb0] Operation is now in state 4294967295default 12:51:57.367038 +0200 Mxxxxxx -[iCloudDownloadItem download:progress:]_block_invoke video, progress:1.0000 err:(null)default 12:51:57.380958 +0200 cloudd [Operation 0x16121d6a0] Operation transitioning from state 3 (cancelled=0, stop=0, error=0)default 12:51:57.384058 +0200 cloudd [Operation 0x16121d6a0] Operation is now in state 4294967295default 12:51:57.449212 +0200 Mxxxxxx TIC TCP Conn Cancel [7:0x17419ee00]default 12:51:57.451957 +0200 Mxxxxxx __nw_socket_service_writes_block_invoke sendmsg(fd 27, 31 bytes): socket has been closeddefault 12:51:57.517534 +0200 assetsd New connection 0x103d0ab70 (pid = 1091)default 12:51:57.519937 +0200 kernel SandboxViolation: Mxxxxxx(1091) deny(1) file-read-metadata /private/var/mobile/Media/PhotoData/Photos.sqlitedefault 12:51:57.522500 +0200 kernel SandboxViolation: Mxxxxxx(1091) deny(1) file-read-metadata /private/var/mobile/Media/PhotoData/Photos.sqlitedefault 12:51:57.579140 +0200 kernel SandboxViolation: Mxxxxxx(1091) deny(1) file-read-metadata /private/var/mobile/Media/PhotoData/Photos.sqlitedefault 12:51:57.586547 +0200 Mxxxxxx Load database will create database: database is missingdefault 12:51:57.586731 +0200 Mxxxxxx Issuing request for updated photo library databasedefault 12:51:57.587649 +0200 Mxxxxxx Load database will create database: database is missingdefault 12:51:57.587885 +0200 Mxxxxxx Issuing request for updated photo library databasedefault 12:51:57.591578 +0200 Mxxxxxx Load database will create database: database is missingdefault 12:51:57.591727 +0200 Mxxxxxx Issuing request for updated photo library databasedefault 12:51:57.592048 +0200 Mxxxxxx -[iCloudDownloadItem download:progress:]_block_invoke video, progress:1.0000 err:(null)default 12:51:58.027421 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/Traffic.bundle'default 12:51:58.030548 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/MotionCalibration.bundle'default 12:51:58.033573 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/CompassCalibration.bundle'default 12:51:58.035448 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/TimeZone.bundle'default 12:51:58.037759 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/MotionCalibration.bundle'default 12:51:58.039987 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/MotionCalibration.bundle'default 12:51:58.041228 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/Routine.bundle'default 12:51:58.043617 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/AppSuggestions.bundle'default 12:51:58.045080 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/AppGenius.bundle'default 12:51:59.154020 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/Traffic.bundle'default 12:51:59.156626 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/Routine.bundle'default 12:51:59.157906 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client 'com.apple.AppStore'default 12:51:59.158721 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/AppGenius.bundle'default 12:51:59.159629 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/MotionCalibration.bundle'default 12:51:59.164205 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/Traffic.bundle'default 12:51:59.165151 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/Routine.bundle'default 12:51:59.173527 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/Traffic.bundle'default 12:51:59.175865 +0200 CommCenter QMI: Svc=0xe2(BSP) Req MsgId=0xe002 Bin=[<private>]default 12:51:59.185416 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/LocationBundles/AppGenius.bundle'default 12:51:59.248206 +0200 CommCenter QMI: Svc=0xe2(BSP) Resp MsgId=0xe002 Bin=[<private>]default 12:51:59.261731 +0200 locationd Incrementing METs -- mets:<private> metsFromGrade:<private>default 12:51:59.642522 +0200 CommCenter QMI: Svc=0xe7(ELQM) Ind MsgId=0x0002 Bin=[<private>]default 12:51:59.650329 +0200 symptomsd eLQM: Posting RRC change notification with label = kNotificationCellLinkStateChange, state = 0, bitmask = 2, info = { Detail = 0; State = 0;}default 12:51:59.651530 +0200 symptomsd eLQM: Updated cell states (payload = <01020000 00>): (LQM = 100, RRC = 0, INTF = 1)default 12:51:59.671434 +0200 symptomsd RRC State changedefault 12:51:59.672046 +0200 symptomsd 0x131e560e0 foreground: 1 primary: 0 for noi: NOI: v:0 type:Cell, isAny:yes, isBuiltin:no, loi:-1, flags:0default 12:51:59.674568 +0200 symptomsd 0x131e59ba0 observed discretionaryTrafficInvited of object NOI: v:0 type:Cell, isAny:yes, isBuiltin:no, loi:-1, flags:0, partial update to pid: 57default 12:51:59.675107 +0200 symptomsd 0x131e4cea0 observed discretionaryTrafficInvited of object NOI: v:0 type:Cell, isAny:yes, isBuiltin:no, loi:-1, flags:0, partial update to pid: 85default 12:51:59.675907 +0200 symptomsd 0x131e63f40 observed discretionaryTrafficInvited of object NOI: v:0 type:Cell, isAny:yes, isBuiltin:no, loi:-1, flags:0, partial update to pid: 92default 12:51:59.676516 +0200 locationd message 'kCLConnectionMessageOnBodyDetection' received from client '/System/Library/Frameworks/CoreTelephony.framework/Support/CommCenter'default 12:51:59.676955 +0200 CommCenter QMI: Svc=0xe2(BSP) Ind MsgId=0xe006 Bin=[<private>]default 12:51:59.677398 +0200 symptomsd RRC Update to OFF. mach time: 1261983243547 <0x131e560e0> (NOI: v:0 type:Cell, isAny:yes, isBuiltin:no, loi:-1, flags:0)default 12:51:59.678709 +0200 symptomsd _lastDisconnectTimestamp: 1261983243547default 12:51:59.679293 +0200 locationd Client /System/Library/Frameworks/CoreTelephony.framework/Support/CommCenter (0x11e0b1400) is unsubscribing to notification kCLConnectionMessageOnBodyDetectiondefault 12:51:59.684420 +0200 symptomsd 0x131e560e0 foreground: 1 primary: 0 for noi: NOI: v:0 type:Cell, isAny:yes, isBuiltin:no, loi:-1, flags:0default 12:51:59.685249 +0200 symptomsd AWD RRC Metric: noi.isAny with no foregroundActivity flag became OFF (plugged in)default 12:51:59.686212 +0200 symptomsd 0x131e58100 foreground: 1 primary: 0 for noi: NOI: v:0 type:Cell, isAny:yes, isBuiltin:no, loi:-1, flags:1default 12:51:59.686370 +0200 locationd Client /System/Library/Frameworks/CoreTelephony.framework/Support/CommCenter disconnecteddefault 12:51:59.686870 +0200 symptomsd 0x131e59380 foreground: 1 primary: 0 for noi: NOI: v:0 type:Cell, isAny:no, isBuiltin:yes, loi:0, flags:0default 12:51:59.690317 +0200 DuetHeuristic-BM Trigger: <private> is now [0]default 12:51:59.694449 +0200 CommCenter QMI: Svc=0x01(WDS) Ind MsgId=0x0001 Bin=['01 10 00 80 01 0B 04 4D 0A 01 00 04 00 18 01 00 01']default 12:51:59.695704 +0200 CommCenter #I dor.QMIDormancyCommandDriver: ___ZN8dormancy24QMIDormancyCommandDriver20handleEventReportIndERKN3wds11EventReport10IndicationE_block_invoke: EventReportInd, dormancy status: kDormantdefault 12:51:59.696101 +0200 CommCenter #I DormancyStatus event, success:true, status:kDormantdefault 12:51:59.696376 +0200 CommCenter QMI: Svc=0x01(WDS) Ind MsgId=0x0001 Bin=['01 10 00 80 01 01 04 79 0C 01 00 04 00 18 01 00 01']default 12:51:59.696551 +0200 CommCenter #I DATA.QMIDriver:CMD: handleWdsEventReportInd_sync: Received WDS Set Event Report Indicationsdefault 12:51:59.696768 +0200 CommCenter #I DATA.QMIDriver:CMD: processWdsTlvDormancyStatus: Dormancy status: kDormancyStatusDormantdefault 12:51:59.697071 +0200 CommCenter #I DATA.BBDriver: setDormancy: from false to truedefault 12:51:59.697165 +0200 CommCenter #I DATA.QMIDriver:CMD: sendWdsGetCurrentDataBearerTechReq_sync: Getting current data bearer technologydefault 12:51:59.697342 +0200 CommCenter QMI: Svc=0x01(WDS) Req MsgId=0x0044 Bin=[<private>]default 12:51:59.698331 +0200 CommCenter QMI: Svc=0x01(WDS) Resp MsgId=0x0044 Bin=[<private>]default 12:51:59.698475 +0200 CommCenter #I DATA.QMIDriver:CMD: ___ZN20QMIDataCommandDriver39sendWdsGetCurrentDataBearerTechReq_syncEv_block_invoke: Response to GetCurrentDataBearerTech receiveddefault 12:51:59.698677 +0200 CommCenter #I DATA.QMIDriver:CMD: ___ZN20QMIDataCommandDriver39sendWdsGetCurrentDataBearerTechReq_syncEv_block_invoke: Data Bearer Technology status: current network (2) rat mask (1) service option mask (0)default 12:51:59.698873 +0200 CommCenter #I DATA.BBDriver: notifyDataBearer: kDataWirelessTechnologyUMTS: fDormancy true sending kRadioTransmitDCH(TxOff)default 12:51:59.698998 +0200 CommCenter #I DATA.Connection:WirelessModemAuthentication: handleDCHState: restEvent: dch=0default 12:51:59.699185 +0200 CommCenter #I DATA.Connection:WirelessModemTraffic: handleDCHState: restEvent: dch=0default 12:51:59.699346 +0200 CommCenter #I DATA.Connection:AppleWirelessDiagnostics: handleDCHState: restEvent: dch=0default 12:51:59.699664 +0200 CommCenter #I DATA.Connection:DataTest: handleDCHState: restEvent: dch=0default 12:51:59.699811 +0200 CommCenter #I DATA.Connection:OTAActivation: handleDCHState: restEvent: dch=0default 12:51:59.699899 +0200 CommCenter #I DATA.Connection:OTAInternet: handleDCHState: restEvent: dch=0default 12:51:59.700104 +0200 CommCenter #I DATA.Connection:ZeroRated: handleDCHState: restEvent: dch=0default 12:51:59.700443 +0200 CommCenter #I DATA.Connection:Provisioning: handleDCHState: restEvent: dch=0default 12:51:59.700659 +0200 CommCenter #I DATA.Connection:EmLoc: handleDCHState: restEvent: dch=0default 12:51:59.700892 +0200 CommCenter #I DATA.Connection:3GFaceTimeAuthentication: handleDCHState: restEvent: dch=0default 12:51:59.701019 +0200 CommCenter #I DATA.Connection:BootstrapRoamingInternetBypass: handleDCHState: restEvent: dch=0default 12:51:59.701176 +0200 CommCenter #I DATA.Connection:UT: handleDCHState: restEvent: dch=0default 12:51:59.701325 +0200 CommCenter #I DATA.Connection:Internet: handleDCHState: restEvent: dch=0default 12:51:59.701452 +0200 CommCenter #I DATA.Connection:VVM: handleDCHState: restEvent: dch=0default 12:51:59.701709 +0200 CommCenter #I DATA.Connection:Em: handleDCHState: restEvent: dch=0default 12:51:59.701914 +0200 CommCenter #I DATA.Connection:Bootstrap: handleDCHState: restEvent: dch=0default 12:51:59.702042 +0200 CommCenter #I DATA.Connection:3GFaceTimeTraffic: handleDCHState: restEvent: dch=0default 12:51:59.702231 +0200 CommCenter #I DATA.Connection:OMADM: handleDCHState: restEvent: dch=0default 12:51:59.702395 +0200 CommCenter #I DATA.Connection:iw5: handleDCHState: restEvent: dch=0default 12:51:59.702591 +0200 CommCenter #I DATA.Connection:InternalDataProbe: handleDCHState: restEvent: dch=0default 12:51:59.702765 +0200 CommCenter #I DATA.Connection:PushEmail: handleDCHState: restEvent: dch=0default 12:51:59.702940 +0200 CommCenter #I DATA.Connection:MMS: handleDCHState: restEvent: dch=0default 12:51:59.703120 +0200 CommCenter #I DATA.Connection:EntitlementTraffic: handleDCHState: restEvent: dch=0default 12:51:59.703883 +0200 calaccessd 2018-03-19 12:51:59 +0200 calaccessd[127]: Interface manager: WWAN radio power level notification; DCH status changed to inactivedefault 12:51:59.704073 +0200 imagent 2018-03-19 12:51:59 +0200 imagent[65]: Interface manager: WWAN radio power level notification; DCH status changed to inactivedefault 12:51:59.704246 +0200 DuetHeuristic-BM 2018-03-19 12:51:59 +0200 DuetHeuristic-BM[105]: Interface manager: WWAN radio power level notification; DCH status changed to inactivedefault 12:51:59.704422 +0200 DuetHeuristic-BM 2018-03-19 12:51:59 +0200 DuetHeuristic-BM[105]: <PCInterfaceUsabilityMonitor: 0x1002396c0> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.704597 +0200 DuetHeuristic-BM 2018-03-19 12:51:59 +0200 DuetHeuristic-BM[105] com.apple.Duet.DuetActivityScheduler.ActivityEvaluationTimer: <PCPersistentTimer: 0x1002780c0> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.704732 +0200 DuetHeuristic-BM 2018-03-19 12:51:59 +0200 DuetHeuristic-BM[105] com.apple.Duet.DuetActivityScheduler.ActivityEvaluationTimer: Last system wake date (2018-03-19 12:19:02 +0200) was longer than half of the timer duration, so setting minimum fire date to fire date.default 12:51:59.704884 +0200 DuetHeuristic-BM 2018-03-19 12:51:59 +0200 DuetHeuristic-BM[105] com.apple.Duet.DuetActivityScheduler.ActivityEvaluationTimer: <PCPersistentTimer: 0x1002780c0> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.705010 +0200 DuetHeuristic-BM 2018-03-19 12:51:59 +0200 DuetHeuristic-BM[105] com.apple.Duet.DuetActivityScheduler.ActivityEvaluationTimer: <PCPersistentTimer: 0x1002780c0> Calculated minimum fire date [2018-03-19 12:59:34 +0200] (100%) with fire date [2018-03-19 12:59:34 +0200], start date [2018-03-19 12:49:09 +0200], minimum early fire proportion 0.807479, power state detection supported: yes, in high power state: nodefault 12:51:59.705227 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63]: Interface manager: WWAN radio power level notification; DCH status changed to inactivedefault 12:51:59.705456 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63]: <PCInterfaceUsabilityMonitor: 0x11f201d60> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.705586 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] HarvestUploadTimer: <PCPersistentTimer: 0x11f2b2140> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.705737 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] HarvestUploadTimer: <PCPersistentTimer: 0x11f2b2140> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.705863 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] HarvestUploadTimer: <PCPersistentTimer: 0x11f2b2140> Calculated minimum fire date [2018-03-19 19:58:11 +0200] (90%) with fire date [2018-03-19 21:09:42 +0200], start date [2018-03-19 09:14:30 +0200], minimum early fire proportion 0.9, power state detection supported: yes, in high power state: nodefault 12:51:59.706030 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63]: <PCInterfaceUsabilityMonitor: 0x11f201d60> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.706300 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] FenceDownloadTimer: <PCPersistentTimer: 0x11dffb920> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.707057 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] FenceDownloadTimer: <PCPersistentTimer: 0x11dffb920> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.707138 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] FenceDownloadTimer: <PCPersistentTimer: 0x11dffb920> Calculated minimum fire date [2018-03-19 21:40:42 +0200] (90%) with fire date [2018-03-19 22:52:42 +0200], start date [2018-03-19 10:52:42 +0200], minimum early fire proportion 0.9, power state detection supported: yes, in high power state: nodefault 12:51:59.707342 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63]: <PCInterfaceUsabilityMonitor: 0x11f201d60> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.707422 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] CellLocDelayedCellLocationPropagationTimer: <PCPersistentTimer: 0x11dff8210> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.707615 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] CellLocDelayedCellLocationPropagationTimer: Last system wake date (2018-03-19 12:19:02 +0200) was longer than half of the timer duration, so setting minimum fire date to fire date.default 12:51:59.707804 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] CellLocDelayedCellLocationPropagationTimer: <PCPersistentTimer: 0x11dff8210> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.707966 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] CellLocDelayedCellLocationPropagationTimer: <PCPersistentTimer: 0x11dff8210> Calculated minimum fire date [2018-03-19 12:52:29 +0200] (100%) with fire date [2018-03-19 12:52:29 +0200], start date [2018-03-19 12:47:29 +0200], minimum early fire proportion 0.9, power state detection supported: yes, in high power state: nodefault 12:51:59.708092 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63]: <PCInterfaceUsabilityMonitor: 0x11f201d60> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.708326 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] WifiAWDTimer: <PCPersistentTimer: 0x11f24ef70> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.708458 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] WifiAWDTimer: <PCPersistentTimer: 0x11f24ef70> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.708822 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] WifiAWDTimer: <PCPersistentTimer: 0x11f24ef70> Calculated minimum fire date [2018-03-19 19:51:17 +0200] (90%) with fire date [2018-03-19 22:15:17 +0200], start date [2018-03-18 22:15:17 +0200], minimum early fire proportion 0.9, power state detection supported: yes, in high power state: nodefault 12:51:59.709056 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63]: <PCInterfaceUsabilityMonitor: 0x11f201d60> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.709217 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] HarvestPruneTimer: <PCPersistentTimer: 0x11f055070> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.709410 +0200 nanoregistryd 2018-03-19 12:51:59 +0200 nanoregistryd[95]: Interface manager: WWAN radio power level notification; DCH status changed to inactivedefault 12:51:59.709583 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] HarvestPruneTimer: <PCPersistentTimer: 0x11f055070> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.709810 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] HarvestPruneTimer: <PCPersistentTimer: 0x11f055070> Calculated minimum fire date [2018-03-19 19:19:34 +0200] (90%) with fire date [2018-03-19 21:07:34 +0200], start date [2018-03-19 03:07:34 +0200], minimum early fire proportion 0.9, power state detection supported: yes, in high power state: nodefault 12:51:59.709970 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63]: <PCInterfaceUsabilityMonitor: 0x11f201d60> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.710098 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] TimeZoneManager.ActiveModeTimer: <PCPersistentTimer: 0x11f0b6f70> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.710264 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] TimeZoneManager.ActiveModeTimer: Last system wake date (2018-03-19 12:19:02 +0200) was longer than half of the timer duration, so setting minimum fire date to fire date.default 12:51:59.710543 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] TimeZoneManager.ActiveModeTimer: <PCPersistentTimer: 0x11f0b6f70> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.710731 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] TimeZoneManager.ActiveModeTimer: <PCPersistentTimer: 0x11f0b6f70> Calculated minimum fire date [2018-03-19 13:27:29 +0200] (75%) with fire date [2018-03-19 13:42:29 +0200], start date [2018-03-19 12:42:29 +0200], minimum early fire proportion 0.75, power state detection supported: yes, in high power state: nodefault 12:51:59.710985 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63]: <PCInterfaceUsabilityMonitor: 0x11f201d60> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.711115 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] CompassDatabaseDaemonClearBiasTimer: <PCPersistentTimer: 0x11dfa2880> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.711289 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] CompassDatabaseDaemonClearBiasTimer: <PCPersistentTimer: 0x11dfa2880> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.711417 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] CompassDatabaseDaemonClearBiasTimer: <PCPersistentTimer: 0x11dfa2880> Calculated minimum fire date [2018-03-20 14:13:06 +0200] (90%) with fire date [2018-03-21 02:13:06 +0200], start date [2018-03-16 02:13:06 +0200], minimum early fire proportion 0.9, power state detection supported: yes, in high power state: nodefault 12:51:59.711499 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63]: <PCInterfaceUsabilityMonitor: 0x11f201d60> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.711689 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] NetworkLocationPurgeTimer: <PCPersistentTimer: 0x11f15db10> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.711872 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] NetworkLocationPurgeTimer: <PCPersistentTimer: 0x11f15db10> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.712070 +0200 locationd 2018-03-19 12:51:59 +0200 locationd[63] NetworkLocationPurgeTimer: <PCPersistentTimer: 0x11f15db10> Calculated minimum fire date [2018-03-19 13:14:16 +0200] (90%) with fire date [2018-03-19 13:44:16 +0200], start date [2018-03-19 08:44:16 +0200], minimum early fire proportion 0.9, power state detection supported: yes, in high power state: nodefault 12:51:59.712271 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25]: Interface manager: WWAN radio power level notification; DCH status changed to inactivedefault 12:51:59.712474 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85]: Interface manager: WWAN radio power level notification; DCH status changed to inactivedefault 12:51:59.712763 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85]: <PCInterfaceUsabilityMonitor: 0x1003927e0> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.712966 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25]: <PCInterfaceUsabilityMonitor: 0x107ebdb00> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.713139 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25] BTA-PeriodicConditionMonitor: <PCPersistentTimer: 0x107eb6e30> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.713402 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25] BTA-PeriodicConditionMonitor: Last system wake date (2018-03-19 12:19:02 +0200) was longer than half of the timer duration, so setting minimum fire date to fire date.default 12:51:59.713602 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25] BTA-PeriodicConditionMonitor: <PCPersistentTimer: 0x107eb6e30> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.713762 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25] BTA-PeriodicConditionMonitor: <PCPersistentTimer: 0x107eb6e30> Calculated minimum fire date [2018-03-19 13:18:09 +0200] (45%) with fire date [2018-03-19 13:51:09 +0200], start date [2018-03-19 12:51:09 +0200], minimum early fire proportion 0.45, power state detection supported: yes, in high power state: nodefault 12:51:59.713893 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25]: <PCInterfaceUsabilityMonitor: 0x107ebdb00> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.714049 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25] MobileBackupRegularWake: <PCPersistentTimer: 0x107dbf2e0> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.714337 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25] MobileBackupRegularWake: <PCPersistentTimer: 0x107dbf2e0> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.714557 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25] MobileBackupRegularWake: Forcing timer alignment to fire date [2018-03-19 13:06:45 +0200]default 12:51:59.714706 +0200 UserEventAgent 2018-03-19 12:51:59 +0200 UserEventAgent[25] MobileBackupRegularWake: <PCPersistentTimer: 0x107dbf2e0> Calculated minimum fire date [2018-03-19 13:06:45 +0200] (16.1394%) with fire date [2018-03-20 09:14:20 +0200], start date [2018-03-19 09:14:20 +0200], minimum early fire proportion 0, power state detection supported: yes, in high power state: nodefault 12:51:59.714857 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(sandbox.push.apple.com)-WWAN: <PCPersistentTimer: 0x100376cf0> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.715014 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85]: <APSCourier: 0x10040cf00> <PCInterfaceMonitor: 0x100411560> interface radio hotness changed to NOdefault 12:51:59.715118 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85]: <APSTopicManager: 0x10031a3f0> isPowerEfficientToSendFilter changed to NOdefault 12:51:59.715347 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85]: <APSCourier: 0x1004b1f60> <PCInterfaceMonitor: 0x100411560> interface radio hotness changed to NOdefault 12:51:59.715530 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85]: <APSTopicManager: 0x1003a7800> isPowerEfficientToSendFilter changed to NOdefault 12:51:59.715636 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(sandbox.push.apple.com)-WWAN: Last system wake date (2018-03-19 12:19:02 +0200) was longer than half of the timer duration, so setting minimum fire date to fire date.default 12:51:59.715865 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(sandbox.push.apple.com)-WWAN: <PCPersistentTimer: 0x100376cf0> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.716038 +0200 SpringBoard 2018-03-19 12:51:59 +0200 SpringBoard[57]: Interface manager: WWAN radio power level notification; DCH status changed to inactivedefault 12:51:59.716257 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(sandbox.push.apple.com)-WWAN: Forcing timer alignment to fire date [2018-03-19 13:06:45 +0200]default 12:51:59.716754 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(sandbox.push.apple.com)-WWAN: <PCPersistentTimer: 0x100376cf0> Calculated minimum fire date [2018-03-19 13:06:45 +0200] (53.1272%) with fire date [2018-03-19 13:19:59 +0200], start date [2018-03-19 12:51:43 +0200], minimum early fire proportion 0, power state detection supported: yes, in high power state: nodefault 12:51:59.717146 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85]: <PCInterfaceUsabilityMonitor: 0x1003927e0> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.717643 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(push.apple.com)-NonCellular: <PCPersistentTimer: 0x10036df50> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.718089 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(push.apple.com)-NonCellular: Last system wake date (2018-03-19 12:19:02 +0200) was longer than half of the timer duration, so setting minimum fire date to fire date.default 12:51:59.718383 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(push.apple.com)-NonCellular: <PCPersistentTimer: 0x10036df50> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.718516 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(push.apple.com)-NonCellular: <PCPersistentTimer: 0x10036df50> Calculated minimum fire date [2018-03-19 13:03:17 +0200] (100%) with fire date [2018-03-19 13:03:17 +0200], start date [2018-03-19 12:42:57 +0200], minimum early fire proportion 0, power state detection supported: yes, in high power state: nodefault 12:51:59.718685 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85]: <PCInterfaceUsabilityMonitor: 0x1003927e0> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.718894 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(push.apple.com)-WWAN: <PCPersistentTimer: 0x1004ace50> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.719224 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(push.apple.com)-WWAN: Last system wake date (2018-03-19 12:19:02 +0200) was longer than half of the timer duration, so setting minimum fire date to fire date.default 12:51:59.719733 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(push.apple.com)-WWAN: <PCPersistentTimer: 0x1004ace50> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.719987 +0200 apsd 2018-03-19 12:51:59 +0200 apsd[85] com.apple.apsd(push.apple.com)-WWAN: <PCPersistentTimer: 0x1004ace50> Calculated minimum fire date [2018-03-19 12:56:08 +0200] (100%) with fire date [2018-03-19 12:56:08 +0200], start date [2018-03-19 12:27:57 +0200], minimum early fire proportion 0, power state detection supported: yes, in high power state: nodefault 12:51:59.720287 +0200 identityservicesd 2018-03-19 12:51:59 +0200 identityservicesd[51]: Interface manager: WWAN radio power level notification; DCH status changed to inactivedefault 12:51:59.720442 +0200 identityservicesd 2018-03-19 12:51:59 +0200 identityservicesd[51]: <PCInterfaceUsabilityMonitor: 0x1008b18f0> [WWAN](pdp_ip0): isInterfaceUsable? YES reachable YES linkQuality 100 isNetworkCaptive? NOdefault 12:51:59.720603 +0200 identityservicesd 2018-03-19 12:51:59 +0200 identityservicesd[51] com.apple.identityservices.registration-hbi: <PCPersistentTimer: 0x1008f5320> calculating _earlyFireDate. powerStateDetectionSupported = YES = (detectionSupported(YES) && (wwanIsUp(YES) || ! internetReachable(YES)))default 12:51:59.720776 +0200 identityservicesd 2018-03-19 12:51:59 +0200 identityservicesd[51] com.apple.identityservices.registration-hbi: <PCPersistentTimer: 0x1008f5320> Device is plugged in, overriding earlyFireProportion to be 1.0default 12:51:59.720908 +0200 identityservicesd 2018-03-19 12:51:59 +0200 identityservicesd[51] com.apple.identityservices.registration-hbi: <PCPersistentTimer: 0x1008f5320> Calculated minimum fire date [2018-04-21 19:33:47 +0300] (100%) with fire date [2018-04-21 19:33:47 +0300], start date [2018-03-19 11:30:53 +0200], minimum early fire proportion 1, power state detection supported: yes, in high power state: nodefault 12:51:59.723670 +0200 symptomsd New RRC 0 when previous 1 from pdp_ip0, epoch interface pdp_ip0error 12:51:59.726315 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 848)error 12:51:59.726518 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.726672 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 890)error 12:51:59.726814 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.726984 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 720)error 12:51:59.727090 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.727274 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 722)error 12:51:59.727499 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.727670 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 734)error 12:51:59.727752 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.727988 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 858)error 12:51:59.728264 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.728492 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 732)error 12:51:59.728624 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.728835 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 10369)error 12:51:59.729064 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.729223 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 2117)error 12:51:59.729452 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.729585 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 860)error 12:51:59.729741 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.729874 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 853)error 12:51:59.730028 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.730255 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 10406)error 12:51:59.730504 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.730658 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 10376)error 12:51:59.730997 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.731392 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 860)error 12:51:59.731929 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.735709 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 714)error 12:51:59.735960 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.736363 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 968)error 12:51:59.736798 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.737249 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 837)error 12:51:59.737716 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.738051 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 726)error 12:51:59.738397 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.738950 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 849)error 12:51:59.739177 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.739637 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 720)error 12:51:59.739991 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.740413 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 716)error 12:51:59.740616 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.741041 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 722)error 12:51:59.741386 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.741930 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 848)error 12:51:59.742117 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.742612 +0200 coreduetd Data for key <private> does not fit in 693 bytes (it is 10360)error 12:51:59.743053 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.743577 +0200 coreduetd Data for key <private> does not fit in 172 bytes (it is 728)error 12:51:59.743814 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.744443 +0200 coreduetd Data for key <private> does not fit in 172 bytes (it is 714)error 12:51:59.744733 +0200 coreduetd Serialized size exceeds shared memory capacityerror 12:51:59.745382 +0200 coreduetd Data for key <private> does not fit in 172 bytes (it is 739)error 12:51:59.745627 +0200 coreduetd Serialized size exceeds shared memory capacitydefault 12:51:59.846651 +0200 locationd message 'kCLConnectionMessageWatchdog' received from client '/System/Library/PrivateFrameworks/CoreParsec.framework'default 12:52:00.241527 +0200 Mxxxxxx ***************** requestAVAssetForVideo END *****************
Posted
by shobi.
Last updated
.
Post not yet marked as solved
0 Replies
257 Views
Hi,Does the new search features in Photos exposed via Photos Kit?Does the new search feature exists also in iCloud? will we have API for that?thanks.
Posted
by shobi.
Last updated
.
Post not yet marked as solved
5 Replies
2.3k Views
Hi,It seems that nsurlsessiond crash due to memory issue, here is the device log:[iPhone 6s, iOS11.0)Nov 12 16:08:42 iPhone-6s kernel[0] <Notice>: EXC_RESOURCE -> nsurlsessiond[23521] exceeded mem limit: ActiveSoft 48 MB (non-fatal)and later...Nov 12 16:08:42 iPhone-6s ReportCrash[23522] <Notice>: Formulating report for corpse[23521] nsurlsessiondMy session is not big - ~60 (upload) tasks, 2MB each. app was in foreground.How can I debug this? or find a workaround.thanksamir.Update:I've receiving errors from NSURLSession didCompleteWithError :Domain=NSURLErrorDomain Code=-997 "Lost connection to background transfer service" UserInfo={NSErrorFailingURLStringKey=<private>/upload/chunk, NSLocalizedDescription=Lost connection to background transfer service})
Posted
by shobi.
Last updated
.
Post not yet marked as solved
0 Replies
922 Views
I am getting the following error while testing in app purchase with a valid user account(not Sandbox user)."You are not authorized to make purchases of this InApp in Sandbox at this time"My App is in "Pending for Developer Release". Downloaded via TestFlight.the iTunes account used for the purchase test is NOT a Sandbox user nor a tester.happened on iOS11 and iOS10. Is it because the app was downloaded via TestFlight? or the app current state?
Posted
by shobi.
Last updated
.
Post not yet marked as solved
0 Replies
709 Views
When using TestFlight:"All in-app purchases are free during the testing period." (https://developer.apple.com/testflight/testers/)So, How can I test a real purchase on production before App is in AppStore?just to clarify..My App is already in the app store available to download with the In-App available to purchase.I'm trying to upload a new app version and trying to perform a real purchase sanity test on the new version.
Posted
by shobi.
Last updated
.