App Store not updating apps....

I installed Mojave beta on two computers. Works perfectly on both, but on one I can update apps, but the other throws this error "unable to download [app name]. Try again later." See attachment.


Anybody has seen this? I went through the log files, I can't find anything... See below (table from Excel for easier formatting)






default

18:38:31.430661 -0700

ReportCrash

Caught EXC_BAD_ACCESS at 0x10bb60873, valid page mapping, page query flags (0x381)\

default

18:38:31.431046 -0700

kernel

Failed to send exception EXC_CORPSE_NOTIFY. error code: -308 for pid 36538\

error

18:38:31.437784 -0700

ReportCrash

Failed to start process notifications for pid 36539 (16)\

default

18:38:31.600973 -0700

ReportCrash

Trying to extract VM information using cr2\

default

18:38:32.092693 -0700

ReportCrash

Saved crash report for <private> to <private>\

default

18:38:32.127878 -0700

ReportCrash

Removing excessive log: <private>\

default

18:38:32.360579 -0700

com.apple.geod

TIC TCP Conn Cancel [24:0x7fa1239095c0]\

default

18:38:32.360682 -0700

com.apple.geod

[C24 gsp64-ssl.ls.apple.com:443 tcp, url: https://gsp64-ssl.ls.apple.com/hvr/v3/use, tls] cancel\

default

18:38:32.360813 -0700

com.apple.geod

[C24 gsp64-ssl.ls.apple.com:443 tcp, url: https://gsp64-ssl.ls.apple.com/hvr/v3/use, tls] cancelled\

default

18:38:32.360855 -0700

com.apple.geod

0.000s [C24 DC008C5F-B2C3-4228-9110-693E738173E9 gsp64-ssl.ls.apple.com:443 resolver] path:start\

default

18:38:32.360882 -0700

com.apple.geod

0.000s [C24 DC008C5F-B2C3-4228-9110-693E738173E9 gsp64-ssl.ls.apple.com:443 resolver] path:satisfied\

default

18:38:32.360907 -0700

com.apple.geod

0.000s [C24 DC008C5F-B2C3-4228-9110-693E738173E9 gsp64-ssl.ls.apple.com:443 resolver] resolver:start_dns\

default

18:38:32.360932 -0700

com.apple.geod

0.132s [C24 DC008C5F-B2C3-4228-9110-693E738173E9 gsp64-ssl.ls.apple.com:443 resolver] resolver:receive_dns\

default

18:38:32.361002 -0700

com.apple.geod

0.132s [C24.1 57B7642E-0BDF-4BBF-A492-14938C1F358B 10.0.1.2:57992<->17.167.194.230:443 socket-flow] path:start\

default

18:38:32.361037 -0700

com.apple.geod

0.133s [C24.1 57B7642E-0BDF-4BBF-A492-14938C1F358B 10.0.1.2:57992<->17.167.194.230:443 socket-flow] path:satisfied\

default

18:38:32.361064 -0700

com.apple.geod

0.134s [C24.1 57B7642E-0BDF-4BBF-A492-14938C1F358B 10.0.1.2:57992<->17.167.194.230:443 socket-flow] flow:start_connect\

default

18:38:32.361090 -0700

com.apple.geod

0.220s [C24.1 57B7642E-0BDF-4BBF-A492-14938C1F358B 10.0.1.2:57992<->17.167.194.230:443 socket-flow] flow:finish_transport\

default

18:38:32.361116 -0700

com.apple.geod

0.220s [C24 DC008C5F-B2C3-4228-9110-693E738173E9 gsp64-ssl.ls.apple.com:443 resolver] flow:finish_transport\

default

18:38:32.361225 -0700

com.apple.geod

0.491s [C24.1 57B7642E-0BDF-4BBF-A492-14938C1F358B 10.0.1.2:57992<->17.167.194.230:443 socket-flow] flow:finish_connect\

default

18:38:32.361356 -0700

com.apple.geod

0.491s [C24 DC008C5F-B2C3-4228-9110-693E738173E9 gsp64-ssl.ls.apple.com:443 resolver] flow:finish_connect\

default

18:38:32.361514 -0700

com.apple.geod

0.491s [C24.1 57B7642E-0BDF-4BBF-A492-14938C1F358B 10.0.1.2:57992<->17.167.194.230:443 socket-flow] flow:changed_viability\

default

18:38:32.361609 -0700

com.apple.geod

0.491s [C24 DC008C5F-B2C3-4228-9110-693E738173E9 gsp64-ssl.ls.apple.com:443 resolver] flow:changed_viability\

default

18:38:32.361728 -0700

com.apple.geod

60.492s [C24] path:cancel\

default

18:38:32.362839 -0700

com.apple.geod

nw_endpoint_flow_protocol_disconnected [C24.1 17.167.194.230:443 cancelled socket-flow (null)] Output protocol disconnected\

default

18:38:32.990192 -0700

App Store

TIC TCP Conn Cancel [12:0x600003d70300]\

default

18:38:32.994446 -0700

App Store

CKDialogController: Connection to com.apple.storeuid was invalidated - removing connection from pool\

default

18:38:32.994544 -0700

accountsd

<private> (<private>) received\

default

18:38:32.997353 -0700

accountsd

<private> (<private>) received\

default

18:38:33.002833 -0700

accountsd

<private> (<private>) received\

default

18:38:33.004683 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:33.004780 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:33.009907 -0700

accountsd

<private> (<private>) received\

default

18:38:33.012614 -0700

accountsd

<private> (<private>) received\

default

18:38:33.016406 -0700

accountsd

<private> (<private>) received\

default

18:38:33.018876 -0700

accountsd

<private> (<private>) received\

default

18:38:33.020706 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:33.020714 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:33.206992 -0700

App Store

27366555: RECEIVED OUT-OF-SEQUENCE NOTIFICATION: 161 vs 224, 512, <private>\

default

18:38:33.207107 -0700

nsurlsessiond

27366555: RECEIVED OUT-OF-SEQUENCE NOTIFICATION: 104 vs 160, 512, <private>\

default

18:38:33.207328 -0700

contextstored

27366555: RECEIVED OUT-OF-SEQUENCE NOTIFICATION: 0 vs 161, 513, <private>\

default

18:38:33.211474 -0700

App Store

[AppStoreKitMac.UpdateStore]: updateAllWithOrder\

default

18:38:33.212066 -0700

appstoreagent

[UpdatesService]: [17186FFE] Update all requested\

default

18:38:33.212294 -0700

appstoreagent

[MacPowerAssertion]: Created power assertion: com.apple.appstored.interactive (id=36817)\

default

18:38:33.212449 -0700

appstoreagent

[TaskManager]: Adding task for bundleID: com.microsoft.OneDrive-mac storeItemID: 823766827 isBackground: 0\

default

18:38:33.212516 -0700

appstoreagent

[CommerceKitProgress]: Task for com.microsoft.OneDrive-mac has started, beginning progress\

default

18:38:33.212548 -0700

appstoreagent

[PreflightManager]: Downloading remote pre-flight from http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/b0/dd/7e/b0dd7ee3-4768-8e56-362c-c81b90614aef/signed.dcr.3661201972134244841.pfpkg\

default

18:38:33.212557 -0700

appstoreagent

[ProgressCache]: Beginning progress for bundleID: com.microsoft.OneDrive-mac storeItemID: 823766827\

default

18:38:33.212816 -0700

commerce

appstoreagent[13058] starting request http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/b0/dd/7e/b0dd7ee3-4768-8e56-362c-c81b90614aef/signed.dcr.3661201972134244841.pfpkg\

default

18:38:33.213326 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(823766827: <NSProgress: 0x6000039401e0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: -1 of 1000 )\

default

18:38:33.232678 -0700

commerce

<CKStoreRequest: 0x7f9c47f05b70> http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/b0/dd/7e/b0dd7ee3-4768-8e56-362c-c81b90614aef/signed.dcr.3661201972134244841.pfpkg\

default

18:38:33.234270 -0700

commerce

Task <A443A0D1-9385-4598-91A2-DD416B3198B4>.<639> now using Connection 24\

default

18:38:33.234516 -0700

commerce

Task <A443A0D1-9385-4598-91A2-DD416B3198B4>.<639> sent request, body N\

default

18:38:33.249164 -0700

commerce

Task <A443A0D1-9385-4598-91A2-DD416B3198B4>.<639> received response, status 304 content U\

default

18:38:33.249392 -0700

commerce

Task <A443A0D1-9385-4598-91A2-DD416B3198B4>.<639> done using Connection 24\

default

18:38:33.251506 -0700

appstoreagent

[PreflightManager]: Remote pre-flight downloaded to file:///var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/823766827/preflight.pfpkg\

default

18:38:33.251602 -0700

appstoreagent

[PreflightCheck]: [PreflightCheck]: Local pre-flight exists at <private>\

error

18:38:33.252334 -0700

appstoreagent

NSURLConnection finished with error - code -1100\

error

18:38:33.257491 -0700

appstoreagent

NSURLConnection finished with error - code -1100\

default

18:38:33.266590 -0700

appstoreagent

Trust evaluate failure: [leaf ExtendedKeyUsage] [ca1 IntermediateEKU]\

default

18:38:33.281244 -0700

appstoreagent

[PKDistributionController]: [PKDistributionController]: Performing disk space check with 28283490304 bytes available on disk, 0 bytes alreay downloaded and 429355008 required bytes (installSize=81665024 + fileSize=33117184 + paddingSize=314572800)\

default

18:38:33.281289 -0700

appstoreagent

[PreflightCheck]: [PreflightCheck]: verified preflight success=1, error=(null), distController=<private>\

default

18:38:33.285996 -0700

accountsd

<private> (<private>) received\

default

18:38:33.308868 -0700

commerce

<CKStoreRequest: 0x7f9c4a05c2e0> https://p24-buy.itunes.apple.com/WebObjects/MZDSService.woa/mac/appleID\

default

18:38:33.310003 -0700

commerce

Task <05E077FA-2F74-4CFF-ADC9-3FEBB7F2017F>.<642> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:33.310176 -0700

commerce

Task <05E077FA-2F74-4CFF-ADC9-3FEBB7F2017F>.<642> now using Connection 25\

default

18:38:33.310702 -0700

commerce

Task <05E077FA-2F74-4CFF-ADC9-3FEBB7F2017F>.<642> sent request, body S\

default

18:38:33.320521 -0700

suggestd

The connection to ACDAccountStore was invalidated.\

default

18:38:33.322471 -0700

suggestd

PPPortrait loaded 1 disabled bundleIds from CloudKit prefs.\

default

18:38:33.322575 -0700

suggestd

PPPortrait now rewriting sync state for 0 bundleIds with CloudKit access newly disabled.\

default

18:38:33.334315 -0700

locationd

\{"msg":"kCLConnectionMessageWatchdog", "event":"activity", "this":"0x7fe8f7421200", "registrationRequired":0, "registrationReceived":1\}\

default

18:38:33.370706 -0700

commerce

Task <05E077FA-2F74-4CFF-ADC9-3FEBB7F2017F>.<642> received response, status 200 content K\

default

18:38:33.370915 -0700

commerce

Task <05E077FA-2F74-4CFF-ADC9-3FEBB7F2017F>.<642> response ended\

default

18:38:33.370995 -0700

commerce

Task <05E077FA-2F74-4CFF-ADC9-3FEBB7F2017F>.<642> done using Connection 25\

default

18:38:33.372299 -0700

appstoreagent

[TaskManager]: Adding task for bundleID: com.pixelmatorteam.pixelmator storeItemID: 407963104 isBackground: 0\

default

18:38:33.372390 -0700

appstoreagent

[CommerceKitProgress]: Task for com.pixelmatorteam.pixelmator has started, beginning progress\

default

18:38:33.372417 -0700

appstoreagent

[PreflightManager]: Downloading remote pre-flight from http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/31/39/d1/3139d14c-6ea1-cfea-e066-c0824ab1d7b9/signed.dcr.8913057339033976497.pfpkg\

default

18:38:33.372438 -0700

appstoreagent

[ProgressCache]: Beginning progress for bundleID: com.pixelmatorteam.pixelmator storeItemID: 407963104\

default

18:38:33.372682 -0700

commerce

appstoreagent[13058] starting request http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/31/39/d1/3139d14c-6ea1-cfea-e066-c0824ab1d7b9/signed.dcr.8913057339033976497.pfpkg\

default

18:38:33.373143 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(407963104: <NSProgress: 0x6000039559a0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: -1 of 1000 )\

default

18:38:33.389926 -0700

commerce

<CKStoreRequest: 0x7f9c47e15dc0> http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/31/39/d1/3139d14c-6ea1-cfea-e066-c0824ab1d7b9/signed.dcr.8913057339033976497.pfpkg\

default

18:38:33.391634 -0700

commerce

Task <9AEAA369-00C3-4389-AE1E-F8CBA55B1BF9>.<647> now using Connection 24\

default

18:38:33.391846 -0700

commerce

Task <9AEAA369-00C3-4389-AE1E-F8CBA55B1BF9>.<647> sent request, body N\

default

18:38:33.406104 -0700

commerce

Task <9AEAA369-00C3-4389-AE1E-F8CBA55B1BF9>.<647> received response, status 304 content U\

default

18:38:33.406227 -0700

commerce

Task <9AEAA369-00C3-4389-AE1E-F8CBA55B1BF9>.<647> done using Connection 24\

default

18:38:33.408449 -0700

appstoreagent

[PreflightManager]: Remote pre-flight downloaded to file:///var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/407963104/preflight.pfpkg\

default

18:38:33.408546 -0700

appstoreagent

[PreflightCheck]: [PreflightCheck]: Local pre-flight exists at <private>\

error

18:38:33.409235 -0700

appstoreagent

NSURLConnection finished with error - code -1100\

error

18:38:33.413943 -0700

appstoreagent

NSURLConnection finished with error - code -1100\

default

18:38:33.423500 -0700

appstoreagent

Trust evaluate failure: [leaf ExtendedKeyUsage] [ca1 IntermediateEKU]\

default

18:38:33.434794 -0700

appstoreagent

[PKDistributionController]: [PKDistributionController]: Performing disk space check with 28283469824 bytes available on disk, 0 bytes alreay downloaded and 568133632 required bytes (installSize=175076352 + fileSize=78484480 + paddingSize=314572800)\

default

18:38:33.434839 -0700

appstoreagent

[PreflightCheck]: [PreflightCheck]: verified preflight success=1, error=(null), distController=<private>\

default

18:38:33.441995 -0700

commerce

appstoreagent[13058] starting request ds-appleid-lookup\

default

18:38:33.461297 -0700

commerce

<CKStoreRequest: 0x7f9c4a5470f0> https://p24-buy.itunes.apple.com/WebObjects/MZDSService.woa/mac/appleID\

default

18:38:33.462433 -0700

commerce

Task <958E0014-7CAA-41F2-9937-95B94B9DFFFF>.<650> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:33.462601 -0700

commerce

Task <958E0014-7CAA-41F2-9937-95B94B9DFFFF>.<650> now using Connection 25\

default

18:38:33.463021 -0700

commerce

Task <958E0014-7CAA-41F2-9937-95B94B9DFFFF>.<650> sent request, body S\

default

18:38:33.513756 -0700

commerce

Task <958E0014-7CAA-41F2-9937-95B94B9DFFFF>.<650> received response, status 200 content K\

default

18:38:33.514863 -0700

commerce

Task <958E0014-7CAA-41F2-9937-95B94B9DFFFF>.<650> response ended\

default

18:38:33.514938 -0700

commerce

Task <958E0014-7CAA-41F2-9937-95B94B9DFFFF>.<650> done using Connection 25\

default

18:38:33.516177 -0700

appstoreagent

[TaskManager]: Adding task for bundleID: com.bananaglue.mac.inet storeItemID: 403304796 isBackground: 0\

default

18:38:33.516276 -0700

appstoreagent

[CommerceKitProgress]: Task for com.bananaglue.mac.inet has started, beginning progress\

default

18:38:33.516290 -0700

appstoreagent

[PreflightManager]: Downloading remote pre-flight from http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/fc/b9/e9/fcb9e96e-f4d7-43db-1077-79257502f21d/signed.dcr.3564008701335736596.pfpkg\

default

18:38:33.516331 -0700

appstoreagent

[ProgressCache]: Beginning progress for bundleID: com.bananaglue.mac.inet storeItemID: 403304796\

default

18:38:33.516525 -0700

commerce

appstoreagent[13058] starting request http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/fc/b9/e9/fcb9e96e-f4d7-43db-1077-79257502f21d/signed.dcr.3564008701335736596.pfpkg\

default

18:38:33.517103 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(403304796: <NSProgress: 0x60000393cfa0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: -1 of 1000 )\

default

18:38:33.519038 -0700

Notes

ENCODE: Caching encoded userInfo to use until we are marked dirty again, returning encoded result <private> opts=\{ LSUserActivityContainsFileProviderURL = 0; LSUserActivityContainsUnsynchronizedCloudDocs = 0; UAUserActivityContainsCloudDocsKey = 0;\}\

default

18:38:33.533919 -0700

commerce

<CKStoreRequest: 0x7f9c4842c920> http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/fc/b9/e9/fcb9e96e-f4d7-43db-1077-79257502f21d/signed.dcr.3564008701335736596.pfpkg\

default

18:38:33.535593 -0700

commerce

Task <95C6DF7C-1F83-4F6B-974C-E5EFCCB983B3>.<655> now using Connection 24\

default

18:38:33.535778 -0700

commerce

Task <95C6DF7C-1F83-4F6B-974C-E5EFCCB983B3>.<655> sent request, body N\

default

18:38:33.550680 -0700

commerce

Task <95C6DF7C-1F83-4F6B-974C-E5EFCCB983B3>.<655> received response, status 304 content U\

default

18:38:33.550826 -0700

commerce

Task <95C6DF7C-1F83-4F6B-974C-E5EFCCB983B3>.<655> done using Connection 24\

default

18:38:33.552820 -0700

appstoreagent

[PreflightManager]: Remote pre-flight downloaded to file:///var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/403304796/preflight.pfpkg\

default

18:38:33.552918 -0700

appstoreagent

[PreflightCheck]: [PreflightCheck]: Local pre-flight exists at <private>\

error

18:38:33.553636 -0700

appstoreagent

NSURLConnection finished with error - code -1100\

error

18:38:33.558719 -0700

appstoreagent

NSURLConnection finished with error - code -1100\

default

18:38:33.568374 -0700

appstoreagent

Trust evaluate failure: [leaf ExtendedKeyUsage] [ca1 IntermediateEKU]\

default

18:38:33.578055 -0700

appstoreagent

[PKDistributionController]: [PKDistributionController]: Performing disk space check with 28279259136 bytes available on disk, 0 bytes alreay downloaded and 475231232 required bytes (installSize=88621056 + fileSize=72037376 + paddingSize=314572800)\

default

18:38:33.578098 -0700

appstoreagent

[PreflightCheck]: [PreflightCheck]: verified preflight success=1, error=(null), distController=<private>\

default

18:38:33.585307 -0700

commerce

appstoreagent[13058] starting request ds-appleid-lookup\

default

18:38:33.587336 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 9189941: err 2\

default

18:38:33.587349 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 772530 offset 0 len 4194304 - found missing pext!\

default

18:38:33.604485 -0700

commerce

<CKStoreRequest: 0x7f9c48005890> https://p24-buy.itunes.apple.com/WebObjects/MZDSService.woa/mac/appleID\

default

18:38:33.605649 -0700

commerce

Task <51195763-E8B5-4801-8351-38595EA4BEB7>.<658> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:33.605827 -0700

commerce

Task <51195763-E8B5-4801-8351-38595EA4BEB7>.<658> now using Connection 25\

default

18:38:33.606294 -0700

commerce

Task <51195763-E8B5-4801-8351-38595EA4BEB7>.<658> sent request, body S\

default

18:38:33.652508 -0700

commerce

Task <51195763-E8B5-4801-8351-38595EA4BEB7>.<658> received response, status 200 content K\

default

18:38:33.655920 -0700

commerce

Task <51195763-E8B5-4801-8351-38595EA4BEB7>.<658> response ended\

default

18:38:33.656024 -0700

commerce

Task <51195763-E8B5-4801-8351-38595EA4BEB7>.<658> done using Connection 25\

default

18:38:33.657191 -0700

appstoreagent

[MacUpdatesController]: Update All: Proceeding with 3 purchase(s)\

default

18:38:33.657309 -0700

appstoreagent

[CommerceKitPurchaseRequest]: Starting purchase of 3 items\

default

18:38:33.658246 -0700

commerce

Starting purchase transaction <Transaction id:F7CE24DF-6D1D-4E16-8380-66E903EDE69F gid:E8FAC07A-9AE2-402E-BBD0-0CE691F8C989> on queue com.apple.appstore.interactive\

default

18:38:33.688496 -0700

Notes

ENCODE: Caching encoded userInfo to use until we are marked dirty again, returning encoded result <private> opts=\{ LSUserActivityContainsFileProviderURL = 0; LSUserActivityContainsUnsynchronizedCloudDocs = 0; UAUserActivityContainsCloudDocsKey = 0;\}\

default

18:38:33.695252 -0700

Notes

ENCODE: Caching encoded userInfo to use until we are marked dirty again, returning encoded result <private> opts=\{ LSUserActivityContainsFileProviderURL = 0; LSUserActivityContainsUnsynchronizedCloudDocs = 0; UAUserActivityContainsCloudDocsKey = 0;\}\

default

18:38:33.718214 -0700

commerce

-[LAContext initWithExternalizedContext:] 0 on <private>\

default

18:38:33.718840 -0700

commerce

-[LAContext canEvaluatePolicy:error:]_block_invoke 1 on <private>\

default

18:38:33.718912 -0700

commerce

-[LAClient evaluatePolicy:options:uiDelegate:reply:] 1, \{\

default

18:38:33.719330 -0700

coreauthd

-[Daemon connectToExistingContext:callback:processId:userId:auditSessionId:auditToken:cApiOrigin:checkEntitlementBlock:invalidationBlock:connectionHash:reply:] 0, 2169, 501, 100008, 0, 42400220 on <private>\

default

18:38:33.719407 -0700

kernel

ACM: createCredentialSet: Credential set created, CS[126]/2/0/158.\

default

18:38:33.719960 -0700

coreauthd

-[ContextProxy evaluatePolicy:options:uiDelegate:originator:reply:]_block_invoke 1, \{\

default

18:38:33.720029 -0700

coreauthd

Created <ManagedACMParameter 0x7fd047a02b70: type: 4 data:<f5010000>>\

default

18:38:33.720084 -0700

kernel

ACM: verifyPolicy: Verifying policy DeviceOwnerAuthenticationWithBiometrics, checkKeybagUUID = No, CS[126].\

default

18:38:33.720097 -0700

kernel

ACM: verifyPolicy: Policy satisfied = No, preflight = Yes, CS[126].\

default

18:38:33.720318 -0700

coreauthd

-[MechanismManagerACM _mechanismForACMRequirement:acmContextRecord:policy:internalInfo:uiDelegate:originator:reply:] 0x7fd047a00ad0, 1, \{\

default

18:38:33.720406 -0700

coreauthd

-[MechanismManagerACM _nonUiMechanismForACMRequirement:acmContextRecord:policy:internalInfo:state:error:] type=3, flags=0, policy=1, state=1 -> Error Domain=com.apple.LocalAuthentication Code=-6 "Biometry is not available on this device." UserInfo=\{NSLoc

default

18:38:33.720442 -0700

coreauthd

nonUiMechanism: (null)\

default

18:38:33.720528 -0700

coreauthd

-[ContextProxy evaluatePolicy:options:uiDelegate:originator:reply:]_block_invoke -> (null), Error Domain=com.apple.LocalAuthentication Code=-6 "Biometry is not available on this device." UserInfo=\{BiometryType=0, NSLocalizedDescription=Biometry is not av

default

18:38:33.720594 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 14038351: err 2\

default

18:38:33.720604 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 795139 offset 0 len 823296 - found missing pext!\

default

18:38:33.720735 -0700

commerce

-[LAClient evaluatePolicy:options:uiDelegate:reply:]_block_invoke -> (null), Error Domain=com.apple.LocalAuthentication Code=-6 UserInfo=\{BiometryType=0, NSLocalizedDescription=<redacted>\} on <private>\

default

18:38:33.720827 -0700

commerce

-[LAContext canEvaluatePolicy:error:]_block_invoke -> Error Domain=com.apple.LocalAuthentication Code=-6 UserInfo=\{NSLocalizedDescription=<redacted>\} on <private>\

default

18:38:33.720878 -0700

commerce

-[LAContext dealloc] on <private>\

default

18:38:33.721042 -0700

coreauthd

Connection invalidated: <NSXPCConnection: 0x7fd042400220> connection from pid 2169 hash: 42400220\

default

18:38:33.721089 -0700

coreauthd

-[ContextProxy dealloc] on <private>\

default

18:38:33.721214 -0700

kernel

ACM: deleteCredentialSet: Deleting credential set, CS[126].\

default

18:38:33.742818 -0700

commerce

<CKStoreRequest: 0x7f9c4a62d1b0> https://p24-buy.itunes.apple.com/WebObjects/MZBuy.woa/wa/updateProduct\

default

18:38:33.744201 -0700

commerce

Task <3E9E25FF-8057-48C1-B319-113A46EF346B>.<661> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:33.744612 -0700

commerce

Task <3E9E25FF-8057-48C1-B319-113A46EF346B>.<661> now using Connection 25\

default

18:38:33.745099 -0700

commerce

Task <3E9E25FF-8057-48C1-B319-113A46EF346B>.<661> sent request, body S\

default

18:38:33.750994 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 21978838: err 2\

default

18:38:33.751007 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 795140 offset 0 len 823296 - found missing pext!\

default

18:38:33.754818 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(403304796: <NSProgress: 0x60000393cfa0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: -1 of 1000 )\

default

18:38:33.754971 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(407963104: <NSProgress: 0x6000039559a0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: -1 of 1000 )\

default

18:38:33.755078 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(823766827: <NSProgress: 0x6000039401e0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: -1 of 1000 )\

default

18:38:33.778160 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 16914225: err 2\

default

18:38:33.778173 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 23066245 offset 0 len 524288 - found missing pext!\

default

18:38:33.789901 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 14826510: err 2\

default

18:38:33.789914 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 23066246 offset 0 len 262144 - found missing pext!\

default

18:38:33.829721 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 14598962: err 2\

default

18:38:33.829733 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 23066251 offset 0 len 1048576 - found missing pext!\

default

18:38:33.869672 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 20508044: err 2\

default

18:38:33.869684 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 28999306 offset 0 len 20480 - found missing pext!\

default

18:38:33.873675 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 8273760: err 2\

default

18:38:33.873687 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 29004894 offset 0 len 65536 - found missing pext!\

default

18:38:33.888405 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 5127425: err 2\

default

18:38:33.888427 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 29004897 offset 0 len 487424 - found missing pext!\

default

18:38:33.943373 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 15362461: err 2\

default

18:38:33.943396 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 29008420 offset 0 len 1904640 - found missing pext!\

default

18:38:33.946282 -0700

commerce

Task <3E9E25FF-8057-48C1-B319-113A46EF346B>.<661> received response, status 200 content K\

default

18:38:33.946662 -0700

commerce

Task <3E9E25FF-8057-48C1-B319-113A46EF346B>.<661> response ended\

default

18:38:33.946749 -0700

commerce

Task <3E9E25FF-8057-48C1-B319-113A46EF346B>.<661> done using Connection 25\

default

18:38:33.948504 -0700

commerce

Purchase queue com.apple.appstore.interactive transaction <Transaction id:F7CE24DF-6D1D-4E16-8380-66E903EDE69F gid:E8FAC07A-9AE2-402E-BBD0-0CE691F8C989> finished\

default

18:38:33.949211 -0700

commerce

Starting purchase transaction <Transaction id:54566183-C9F3-4214-B568-AAE89AE1EA75 gid:E8FAC07A-9AE2-402E-BBD0-0CE691F8C989> on queue com.apple.appstore.interactive\

default

18:38:33.949525 -0700

appstoreagent

[CommerceKitPurchaseRequest]: Purchase complete for 823766827 resulting downloads are: (\

default

18:38:33.950373 -0700

appstoreagent

[CommerceKitDownloadManager]: Downloading icon from https://a5.mzstatic.com/us/r30/Purple125/v4/d8/cb/13/d8cb13f7-bb36-37aa-6274-aa6301cb2548/icon1024x1024.png\

default

18:38:33.950595 -0700

appstoreagent

[CommerceKitDownloadManager]: Starting CommerceKit download for 823766827\

default

18:38:33.950684 -0700

commerce

appstoreagent[13058] starting request https://a5.mzstatic.com/us/r30/Purple125/v4/d8/cb/13/d8cb13f7-bb36-37aa-6274-aa6301cb2548/icon1024x1024.png\

default

18:38:33.953198 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f81b450>: (com.microsoft.OneDrive-mac, 18.065.0329, 823766827:826917933 VPP:NO source:Spotlight /Applications/OneDrive.app) using SoftwareMap to upgrade to 18.091.0506\

default

18:38:33.953399 -0700

storedownloadd

Download: Download <Download: 0x7fe73c65bee0>: com.microsoft.OneDrive-mac 18.091.0506 (823766827) paused:0 failed:0 isInServerQueue:0 is known to be an update when metadata is set\

default

18:38:33.953556 -0700

storedownloadd

DownloadManifest: removePurgeablePath: /var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/823766827\

default

18:38:33.996903 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f81b450>: (com.microsoft.OneDrive-mac, 18.065.0329, 823766827:826917933 VPP:NO source:Spotlight /Applications/OneDrive.app) using SoftwareMap to upgrade to 18.091.0506\

default

18:38:33.997100 -0700

storedownloadd

Download: Download <Download: 0x7fe73e5ad410>: com.microsoft.OneDrive-mac 18.091.0506 (823766827) paused:0 failed:0 isInServerQueue:0 is known to be an update when metadata is set\

default

18:38:33.997775 -0700

appstoreagent

[CommerceKitProgress]: Added progress for com.microsoft.OneDrive-mac/823766827\

default

18:38:34.000471 -0700

storedownloadd

sending status (OneDrive): 0.000000% (0.000000)\

default

18:38:34.001021 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.microsoft.OneDrive-mac (0.00)\

default

18:38:34.001090 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f81b450>: (com.microsoft.OneDrive-mac, 18.065.0329, 823766827:826917933 VPP:NO source:Spotlight /Applications/OneDrive.app) using SoftwareMap to upgrade to 18.091.0506\

default

18:38:34.001369 -0700

storedownloadd

ProgressObserver: Locking app at /Applications/OneDrive.app\

default

18:38:34.009483 -0700

commerce

-[LAContext initWithExternalizedContext:] 0 on <private>\

default

18:38:34.010075 -0700

commerce

-[LAContext canEvaluatePolicy:error:]_block_invoke 1 on <private>\

default

18:38:34.010130 -0700

commerce

-[LAClient evaluatePolicy:options:uiDelegate:reply:] 1, \{\

default

18:38:34.010578 -0700

coreauthd

-[Daemon connectToExistingContext:callback:processId:userId:auditSessionId:auditToken:cApiOrigin:checkEntitlementBlock:invalidationBlock:connectionHash:reply:] 0, 2169, 501, 100008, 0, 447033b0 on <private>\

default

18:38:34.010657 -0700

kernel

ACM: createCredentialSet: Credential set created, CS[127]/2/0/158.\

default

18:38:34.011152 -0700

coreauthd

-[ContextProxy evaluatePolicy:options:uiDelegate:originator:reply:]_block_invoke 1, \{\

default

18:38:34.011226 -0700

coreauthd

Created <ManagedACMParameter 0x7fd047800600: type: 4 data:<f5010000>>\

default

18:38:34.011281 -0700

kernel

ACM: verifyPolicy: Verifying policy DeviceOwnerAuthenticationWithBiometrics, checkKeybagUUID = No, CS[127].\

default

18:38:34.011292 -0700

kernel

ACM: verifyPolicy: Policy satisfied = No, preflight = Yes, CS[127].\

default

18:38:34.011491 -0700

coreauthd

-[MechanismManagerACM _mechanismForACMRequirement:acmContextRecord:policy:internalInfo:uiDelegate:originator:reply:] 0x7fd047800830, 1, \{\

default

18:38:34.011577 -0700

coreauthd

-[MechanismManagerACM _nonUiMechanismForACMRequirement:acmContextRecord:policy:internalInfo:state:error:] type=3, flags=0, policy=1, state=1 -> Error Domain=com.apple.LocalAuthentication Code=-6 "Biometry is not available on this device." UserInfo=\{NSLoc

default

18:38:34.011619 -0700

coreauthd

nonUiMechanism: (null)\

default

18:38:34.011703 -0700

coreauthd

-[ContextProxy evaluatePolicy:options:uiDelegate:originator:reply:]_block_invoke -> (null), Error Domain=com.apple.LocalAuthentication Code=-6 "Biometry is not available on this device." UserInfo=\{BiometryType=0, NSLocalizedDescription=Biometry is not av

default

18:38:34.011907 -0700

commerce

-[LAClient evaluatePolicy:options:uiDelegate:reply:]_block_invoke -> (null), Error Domain=com.apple.LocalAuthentication Code=-6 UserInfo=\{BiometryType=0, NSLocalizedDescription=<redacted>\} on <private>\

default

18:38:34.012009 -0700

commerce

-[LAContext canEvaluatePolicy:error:]_block_invoke -> Error Domain=com.apple.LocalAuthentication Code=-6 UserInfo=\{NSLocalizedDescription=<redacted>\} on <private>\

default

18:38:34.012060 -0700

commerce

-[LAContext dealloc] on <private>\

default

18:38:34.012210 -0700

coreauthd

Connection invalidated: <NSXPCConnection: 0x7fd0447033b0> connection from pid 2169 hash: 447033b0\

default

18:38:34.012278 -0700

coreauthd

-[ContextProxy dealloc] on <private>\

default

18:38:34.012414 -0700

kernel

ACM: deleteCredentialSet: Deleting credential set, CS[127].\

default

18:38:34.036380 -0700

commerce

<CKStoreRequest: 0x7f9c4a054460> https://a5.mzstatic.com/us/r30/Purple125/v4/d8/cb/13/d8cb13f7-bb36-37aa-6274-aa6301cb2548/icon1024x1024.png\

default

18:38:34.037824 -0700

commerce

<CKStoreRequest: 0x7f9c4a632470> https://p24-buy.itunes.apple.com/WebObjects/MZBuy.woa/wa/updateProduct\

default

18:38:34.039676 -0700

commerce

Task <3FAAE419-110D-4000-AB08-272B57F27414>.<669> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:34.039843 -0700

commerce

Task <3FAAE419-110D-4000-AB08-272B57F27414>.<669> now using Connection 25\

default

18:38:34.040040 -0700

appstoreagent

[CommerceKitDownloadManager]: Icon downloaded to (null)\

default

18:38:34.040313 -0700

commerce

Task <3FAAE419-110D-4000-AB08-272B57F27414>.<669> sent request, body S\

default

18:38:34.057012 -0700

ReceiptInstaller

ReceiptDispatch: locked application at path /Applications/OneDrive.app\

default

18:38:34.059829 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 15366680: err 2\

default

18:38:34.059844 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 29008422 offset 0 len 4194304 - found missing pext!\

default

18:38:34.241599 -0700

commerce

Task <3FAAE419-110D-4000-AB08-272B57F27414>.<669> received response, status 200 content K\

default

18:38:34.242547 -0700

commerce

Task <3FAAE419-110D-4000-AB08-272B57F27414>.<669> response ended\

default

18:38:34.242630 -0700

commerce

Task <3FAAE419-110D-4000-AB08-272B57F27414>.<669> done using Connection 25\

default

18:38:34.244364 -0700

commerce

Purchase queue com.apple.appstore.interactive transaction <Transaction id:54566183-C9F3-4214-B568-AAE89AE1EA75 gid:E8FAC07A-9AE2-402E-BBD0-0CE691F8C989> finished\

default

18:38:34.245196 -0700

commerce

Starting purchase transaction <Transaction id:C1CEB66B-05A7-45F4-96CE-EDA5A95CDD73 gid:E8FAC07A-9AE2-402E-BBD0-0CE691F8C989> on queue com.apple.appstore.interactive\

default

18:38:34.245466 -0700

appstoreagent

[CommerceKitPurchaseRequest]: Purchase complete for 407963104 resulting downloads are: (\

default

18:38:34.246954 -0700

appstoreagent

[CommerceKitDownloadManager]: Downloading icon from https://a1.mzstatic.com/us/r30/Purple115/v4/aa/16/ef/aa16ef83-4ccf-a679-149d-a1f7dbf79d96/icon1024x1024.png\

default

18:38:34.247097 -0700

appstoreagent

[CommerceKitDownloadManager]: Starting CommerceKit download for 407963104\

default

18:38:34.247254 -0700

commerce

appstoreagent[13058] starting request https://a1.mzstatic.com/us/r30/Purple115/v4/aa/16/ef/aa16ef83-4ccf-a679-149d-a1f7dbf79d96/icon1024x1024.png\

default

18:38:34.249768 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f955e60>: (com.pixelmatorteam.pixelmator, 3.7, 407963104:819930459 VPP:NO source:Spotlight /Applications/Pixelmator.app) using SoftwareMap to upgrade to 3.7.3\

default

18:38:34.249972 -0700

storedownloadd

Download: Download <Download: 0x7fe73c622fb0>: com.pixelmatorteam.pixelmator 3.7.3 (407963104) paused:0 failed:0 isInServerQueue:0 is known to be an update when metadata is set\

default

18:38:34.250161 -0700

storedownloadd

DownloadManifest: removePurgeablePath: /var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/407963104\

default

18:38:34.282916 -0700

kernel

apfs_rr_should_defrag_phys_extents:1217: Failed to lookup physical extent starting at 5344959: err 2\

default

18:38:34.282931 -0700

kernel

apfs_reallocate_range:1695: Refusing to reallocate ino 29017737 offset 0 len 4194304 - found missing pext!\

default

18:38:34.301859 -0700

commerce

-[LAContext initWithExternalizedContext:] 0 on <private>\

default

18:38:34.302567 -0700

commerce

-[LAContext canEvaluatePolicy:error:]_block_invoke 1 on <private>\

default

18:38:34.302638 -0700

commerce

-[LAClient evaluatePolicy:options:uiDelegate:reply:] 1, \{\

default

18:38:34.302977 -0700

coreauthd

-[Daemon connectToExistingContext:callback:processId:userId:auditSessionId:auditToken:cApiOrigin:checkEntitlementBlock:invalidationBlock:connectionHash:reply:] 0, 2169, 501, 100008, 0, 43403660 on <private>\

default

18:38:34.303057 -0700

kernel

ACM: createCredentialSet: Credential set created, CS[128]/2/0/158.\

default

18:38:34.303525 -0700

coreauthd

-[ContextProxy evaluatePolicy:options:uiDelegate:originator:reply:]_block_invoke 1, \{\

default

18:38:34.303596 -0700

coreauthd

Created <ManagedACMParameter 0x7fd0447056a0: type: 4 data:<f5010000>>\

default

18:38:34.303651 -0700

kernel

ACM: verifyPolicy: Verifying policy DeviceOwnerAuthenticationWithBiometrics, checkKeybagUUID = No, CS[128].\

default

18:38:34.303663 -0700

kernel

ACM: verifyPolicy: Policy satisfied = No, preflight = Yes, CS[128].\

default

18:38:34.303886 -0700

coreauthd

-[MechanismManagerACM _mechanismForACMRequirement:acmContextRecord:policy:internalInfo:uiDelegate:originator:reply:] 0x7fd0447048d0, 1, \{\

default

18:38:34.303972 -0700

coreauthd

-[MechanismManagerACM _nonUiMechanismForACMRequirement:acmContextRecord:policy:internalInfo:state:error:] type=3, flags=0, policy=1, state=1 -> Error Domain=com.apple.LocalAuthentication Code=-6 "Biometry is not available on this device." UserInfo=\{NSLoc

default

18:38:34.304008 -0700

coreauthd

nonUiMechanism: (null)\

default

18:38:34.304083 -0700

coreauthd

-[ContextProxy evaluatePolicy:options:uiDelegate:originator:reply:]_block_invoke -> (null), Error Domain=com.apple.LocalAuthentication Code=-6 "Biometry is not available on this device." UserInfo=\{BiometryType=0, NSLocalizedDescription=Biometry is not av

default

18:38:34.304301 -0700

commerce

-[LAClient evaluatePolicy:options:uiDelegate:reply:]_block_invoke -> (null), Error Domain=com.apple.LocalAuthentication Code=-6 UserInfo=\{BiometryType=0, NSLocalizedDescription=<redacted>\} on <private>\

default

18:38:34.304402 -0700

commerce

-[LAContext canEvaluatePolicy:error:]_block_invoke -> Error Domain=com.apple.LocalAuthentication Code=-6 UserInfo=\{NSLocalizedDescription=<redacted>\} on <private>\

default

18:38:34.304447 -0700

commerce

-[LAContext dealloc] on <private>\

default

18:38:34.304580 -0700

coreauthd

Connection invalidated: <NSXPCConnection: 0x7fd043403660> connection from pid 2169 hash: 43403660\

default

18:38:34.304630 -0700

coreauthd

-[ContextProxy dealloc] on <private>\

default

18:38:34.304780 -0700

kernel

ACM: deleteCredentialSet: Deleting credential set, CS[128].\

default

18:38:34.329298 -0700

commerce

<CKStoreRequest: 0x7f9c4a0052f0> https://a1.mzstatic.com/us/r30/Purple115/v4/aa/16/ef/aa16ef83-4ccf-a679-149d-a1f7dbf79d96/icon1024x1024.png\

default

18:38:34.330459 -0700

commerce

<CKStoreRequest: 0x7f9c4a53ab00> https://p24-buy.itunes.apple.com/WebObjects/MZBuy.woa/wa/updateProduct\

default

18:38:34.332098 -0700

commerce

Task <582657E2-AD44-4DE5-88CF-ADCF09318280>.<677> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:34.332262 -0700

commerce

Task <582657E2-AD44-4DE5-88CF-ADCF09318280>.<677> now using Connection 25\

default

18:38:34.332757 -0700

commerce

Task <582657E2-AD44-4DE5-88CF-ADCF09318280>.<677> sent request, body S\

default

18:38:34.334844 -0700

appstoreagent

[CommerceKitDownloadManager]: Icon downloaded to (null)\

default

18:38:34.370257 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f955e60>: (com.pixelmatorteam.pixelmator, 3.7, 407963104:819930459 VPP:NO source:Spotlight /Applications/Pixelmator.app) using SoftwareMap to upgrade to 3.7.3\

default

18:38:34.370430 -0700

storedownloadd

Download: Download <Download: 0x7fe73ec6fb50>: com.pixelmatorteam.pixelmator 3.7.3 (407963104) paused:0 failed:0 isInServerQueue:0 is known to be an update when metadata is set\

default

18:38:34.371201 -0700

appstoreagent

[CommerceKitProgress]: Added progress for com.pixelmatorteam.pixelmator/407963104\

default

18:38:34.372019 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f955e60>: (com.pixelmatorteam.pixelmator, 3.7, 407963104:819930459 VPP:NO source:Spotlight /Applications/Pixelmator.app) using SoftwareMap to upgrade to 3.7.3\

default

18:38:34.372549 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f955e60>: (com.pixelmatorteam.pixelmator, 3.7, 407963104:819930459 VPP:NO source:Spotlight /Applications/Pixelmator.app) using SoftwareMap to upgrade to 3.7.3\

default

18:38:34.373471 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f955e60>: (com.pixelmatorteam.pixelmator, 3.7, 407963104:819930459 VPP:NO source:Spotlight /Applications/Pixelmator.app) using SoftwareMap to upgrade to 3.7.3\

default

18:38:34.373633 -0700

storedownloadd

ProgressObserver: Locking app at /Applications/Pixelmator.app\

default

18:38:34.373725 -0700

storedownloadd

sending status (Pixelmator): 0.000000% (0.000000)\

default

18:38:34.374213 -0700

ReceiptInstaller

ReceiptDispatch: locked application at path /Applications/Pixelmator.app\

default

18:38:34.374343 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.pixelmatorteam.pixelmator (0.00)\

default

18:38:34.381675 -0700

storedownloadd

SSDownloadAsset caching-server-locator-timeout 10\

default

18:38:34.382854 -0700

storedownloadd

#86553b12 ACSLocateCachingServer(assetURL=http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473284143.pkg, locateTimeout=10.000, options=(null), callbackQueue=0x0, callback=0x7000043d2238)\

default

18:38:34.385252 -0700

AssetCacheLocatorService

#86553b12 [AssetCacheLocatorService.queue] early hit: no caching servers\

default

18:38:34.385701 -0700

storedownloadd

#86553b12 ACSLocateCachingServer -> [new] newURL (null), advice (null), error (null), elapsed 0.003/10.000\

default

18:38:34.385881 -0700

storedownloadd

AssetDownloadOperation no modified URL for http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473284143.pkg\

default

18:38:34.386414 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe74b03dff0>: Initializing MD5 context\

default

18:38:34.386820 -0700

storedownloadd

ISStoreURLOperation: Starting URL operation with url=http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473284143.pkg / bagKey=(null)\

default

18:38:34.386889 -0700

storedownloadd

-[ISStoreURLOperation _runURLOperation]: _addStandardQueryParametersForURL: http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473284143.pkg\

default

18:38:34.416667 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe74b03dff0>: Opening file /var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/407963104/jlt211943315473284143.pkg returning file descriptor 10 (0 streamed)\

default

18:38:34.427296 -0700

storedownloadd

TIC TCP Conn Start [40:0x7fe74b040770]\

default

18:38:34.427651 -0700

storedownloadd

[C40 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473] start\

default

18:38:34.428528 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C40] reporting state preparing\

default

18:38:34.431555 -0700

storedownloadd

Task <D2859936-31C6-4E7D-9384-535DC16A2AF9>.<0> setting up Connection 40\

default

18:38:34.450893 -0700

storedownloadd

nw_socket_handle_socket_event [C40.1:2] Socket received CONNECTED event\

default

18:38:34.451198 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C40.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Transport protocol connected\

default

18:38:34.451681 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C40.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Output protocol connected\

default

18:38:34.452151 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C40] reporting state ready\

default

18:38:34.452585 -0700

storedownloadd

TIC TCP Conn Connected [40:0x7fe74b040770]: Err(16)\

default

18:38:34.452846 -0700

storedownloadd

TIC TCP Conn Event [40:0x7fe74b040770]: 1\

default

18:38:34.453741 -0700

storedownloadd

Task <D2859936-31C6-4E7D-9384-535DC16A2AF9>.<0> now using Connection 40\

default

18:38:34.453934 -0700

storedownloadd

Task <D2859936-31C6-4E7D-9384-535DC16A2AF9>.<0> sent request, body N\

default

18:38:34.474101 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f81b450>: (com.microsoft.OneDrive-mac, 18.065.0329, 823766827:826917933 VPP:NO source:Spotlight /Applications/OneDrive.app) using SoftwareMap to upgrade to 18.091.0506\

error

18:38:34.474782 -0700

storedownloadd

NSURLConnection finished with error - code -1100\

default

18:38:34.481421 -0700

storedownloadd

AssetDownloadOperation: Subtracted 0 already-downloaded bytes from required space (now requires 78494334 bytes)\

default

18:38:34.481702 -0700

storedownloadd

sending status (Pixelmator): 0.000000% (-1.000000)\

default

18:38:34.482475 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.pixelmatorteam.pixelmator (0.00)\

default

18:38:34.488370 -0700

storedownloadd

#e0fda299 ACSLocateCachingServer -> [new] newURL (null), advice (null), error (null), elapsed 0.002/10.000\

default

18:38:34.488457 -0700

storedownloadd

AssetDownloadOperation no modified URL for http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473284143.pkg\

default

18:38:34.488957 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73ec20390>: Initializing MD5 context\

default

18:38:34.489402 -0700

storedownloadd

ISStoreURLOperation: Starting URL operation with url=http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473284143.pkg / bagKey=(null)\

default

18:38:34.489545 -0700

storedownloadd

-[ISStoreURLOperation _runURLOperation]: _addStandardQueryParametersForURL: http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473284143.pkg\

default

18:38:34.518311 -0700

commerce

Task <582657E2-AD44-4DE5-88CF-ADCF09318280>.<677> received response, status 200 content K\

default

18:38:34.519735 -0700

commerce

Task <582657E2-AD44-4DE5-88CF-ADCF09318280>.<677> response ended\

default

18:38:34.519825 -0700

commerce

Task <582657E2-AD44-4DE5-88CF-ADCF09318280>.<677> done using Connection 25\

default

18:38:34.521426 -0700

commerce

Purchase queue com.apple.appstore.interactive transaction <Transaction id:C1CEB66B-05A7-45F4-96CE-EDA5A95CDD73 gid:E8FAC07A-9AE2-402E-BBD0-0CE691F8C989> finished\

default

18:38:34.522432 -0700

appstoreagent

[CommerceKitPurchaseRequest]: Purchase complete for 403304796 resulting downloads are: (\

default

18:38:34.525441 -0700

appstoreagent

[CommerceKitPurchaseRequest]: Completing 3 purchase(s) completed with 3 result(s)\

default

18:38:34.525511 -0700

appstoreagent

[MacUpdatesController]: Update All: Purchase result for bundleID com.microsoft.OneDrive-mac is: Success\

default

18:38:34.525567 -0700

appstoreagent

[MacUpdatesController]: Update All: Purchase result for bundleID com.pixelmatorteam.pixelmator is: Success\

default

18:38:34.525636 -0700

appstoreagent

[MacUpdatesController]: Update All: Purchase result for bundleID com.bananaglue.mac.inet is: Success\

default

18:38:34.525726 -0700

appstoreagent

[UpdatesService]: [17186FFE] Completed successfully\

error

18:38:34.526045 -0700

App Store

[AppStateMachine]: 403304796: Denied state change. waiting -> waiting, rule: WaitingRules\

default

18:38:34.526099 -0700

appstoreagent

[MacPowerAssertion]: Released power assertion (id=36817)\

error

18:38:34.526145 -0700

App Store

[AppStateMachine]: 823766827: Denied state change. waiting -> waiting, rule: WaitingRules\

error

18:38:34.526229 -0700

App Store

[AppStateMachine]: 407963104: Denied state change. waiting -> waiting, rule: WaitingRules\

default

18:38:34.526908 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(407963104: <NSProgress: 0x6000039559a0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: 0 of 1000 )\

default

18:38:34.526945 -0700

storedownloadd

TIC TCP Conn Start [41:0x7fe74b041090]\

default

18:38:34.527238 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(823766827: <NSProgress: 0x6000039401e0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: 0 of 1000 )\

default

18:38:34.527541 -0700

storedownloadd

[C41 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473] start\

default

18:38:34.527722 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945e735a70>: (com.bananaglue.mac.inet, 2.4.7, 403304796:827262553 VPP:NO source:Spotlight /Applications/iNet Network Scanner.app) using SoftwareMap to upgrade to 2.4.8\

default

18:38:34.527908 -0700

storedownloadd

Download: Download <Download: 0x7fe74b50c9c0>: com.bananaglue.mac.inet 2.4.8 (403304796) paused:0 failed:0 isInServerQueue:0 is known to be an update when metadata is set\

default

18:38:34.528102 -0700

storedownloadd

DownloadManifest: removePurgeablePath: /var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/403304796\

default

18:38:34.528557 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C41] reporting state preparing\

default

18:38:34.543561 -0700

commerce

<CKStoreRequest: 0x7f9c4a53ab00> https://a3.mzstatic.com/us/r30/Purple115/v4/41/16/7a/41167af1-972c-fdc7-56a3-099467e51f1f/icon1024x1024.png\

default

18:38:34.548418 -0700

appstoreagent

[CommerceKitDownloadManager]: Icon downloaded to (null)\

default

18:38:34.549500 -0700

storedownloadd

nw_socket_handle_socket_event [C41.1:2] Socket received CONNECTED event\

default

18:38:34.549749 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C41.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Transport protocol connected\

default

18:38:34.550251 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C41.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Output protocol connected\

default

18:38:34.550802 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C41] reporting state ready\

default

18:38:34.551283 -0700

storedownloadd

TIC TCP Conn Connected [41:0x7fe74b041090]: Err(16)\

default

18:38:34.551515 -0700

storedownloadd

TIC TCP Conn Event [41:0x7fe74b041090]: 1\

default

18:38:34.552430 -0700

storedownloadd

Task <0C3CE0DA-5117-40CA-8B8E-032E927C58E5>.<0> now using Connection 41\

default

18:38:34.552662 -0700

storedownloadd

Task <0C3CE0DA-5117-40CA-8B8E-032E927C58E5>.<0> sent request, body N\

default

18:38:34.568052 -0700

storedownloadd

Task <0C3CE0DA-5117-40CA-8B8E-032E927C58E5>.<0> received response, status 200 content K\

error

18:38:34.571836 -0700

storedownloadd

NSURLConnection finished with error - code -1100\

default

18:38:34.572615 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945e735a70>: (com.bananaglue.mac.inet, 2.4.7, 403304796:827262553 VPP:NO source:Spotlight /Applications/iNet Network Scanner.app) using SoftwareMap to upgrade to 2.4.8\

default

18:38:34.572791 -0700

storedownloadd

Download: Download <Download: 0x7fe73ec7ff60>: com.bananaglue.mac.inet 2.4.8 (403304796) paused:0 failed:0 isInServerQueue:0 is known to be an update when metadata is set\

default

18:38:34.578888 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.pixelmatorteam.pixelmator (0.00)\

default

18:38:34.579649 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945e735a70>: (com.bananaglue.mac.inet, 2.4.7, 403304796:827262553 VPP:NO source:Spotlight /Applications/iNet Network Scanner.app) using SoftwareMap to upgrade to 2.4.8\

default

18:38:34.581266 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945e735a70>: (com.bananaglue.mac.inet, 2.4.7, 403304796:827262553 VPP:NO source:Spotlight /Applications/iNet Network Scanner.app) using SoftwareMap to upgrade to 2.4.8\

default

18:38:34.581474 -0700

storedownloadd

ProgressObserver: Locking app at /Applications/iNet Network Scanner.app\

default

18:38:34.581670 -0700

storedownloadd

sending status (iNet Network Scanner): 0.000000% (0.000000)\

default

18:38:34.582203 -0700

ReceiptInstaller

ReceiptDispatch: locked application at path /Applications/iNet Network Scanner.app\

default

18:38:34.582439 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.bananaglue.mac.inet (0.00)\

default

18:38:34.582545 -0700

storedownloadd

HashedDownloadProvider: Failed to initialize decryption session with error -42076\

default

18:38:34.582775 -0700

storedownloadd

TIC TCP Conn Cancel [41:0x7fe74b041090]\

default

18:38:34.582783 -0700

storedownloadd

ISStoreURLOperation: Chose not to retry after error: Error Domain=ISErrorDomain Code=7 "Unknown Error." UserInfo=\{NSLocalizedDescription=Unknown Error.\}\

default

18:38:34.582858 -0700

storedownloadd

[C41 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473] cancel\

default

18:38:34.582910 -0700

storedownloadd

AssetDownloadOperation: Asset download cancelled/failed. Will do retry #2? 1\

default

18:38:34.583064 -0700

storedownloadd

[C41 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473] cancelled\

default

18:38:34.583130 -0700

storedownloadd

0.000s [C41 A55D9FF2-1837-4F6B-8B6E-80090AB743BA Hostname#1784b493:80 resolver] path:start\

default

18:38:34.614481 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73e596060>: Opening file /var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/407963104/jlt211943315473284143.pkg returning file descriptor 13 (0 streamed)\

default

18:38:34.625173 -0700

storedownloadd

TIC TCP Conn Start [42:0x7fe73e35c700]\

default

18:38:34.625439 -0700

storedownloadd

[C42 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple128/v4/b7/8e/c7/b78ec728-ef5b-c022-d481-33ef72d1b27d/jlt211943315473] start\

default

18:38:34.626167 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C42] reporting state preparing\

default

18:38:34.629688 -0700

storedownloadd

Task <10B9A8E1-424A-40E2-96C9-89483C8042BD>.<0> setting up Connection 42\

default

18:38:34.645533 -0700

storedownloadd

nw_socket_handle_socket_event [C42.1:2] Socket received CONNECTED event\

default

18:38:34.645758 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C42.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Transport protocol connected\

default

18:38:34.646205 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C42.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Output protocol connected\

default

18:38:34.668822 -0700

storedownloadd

Task <10B9A8E1-424A-40E2-96C9-89483C8042BD>.<0> received response, status 200 content K\

error

18:38:34.672316 -0700

storedownloadd

NSURLConnection finished with error - code -1100\

default

18:38:34.682281 -0700

storedownloadd

HashedDownloadProvider: Failed to initialize decryption session with error -42076\

default

18:38:34.682789 -0700

storedownloadd

TIC TCP Conn Cancel [42:0x7fe73e35c700]\

default

18:38:34.687256 -0700

rtcreportingd

listener: Accepting new XPC connection <private> as it has proper entitlement, 1(0) connections.\

default

18:38:34.687376 -0700

rtcreportingd

initWithSessionDelegate: ReportingdSession initWithSessionDelegate:<private>\

default

18:38:34.687525 -0700

rtcreportingd

initWithSessionDelegate: Initialized session with UUID <private>\

default

18:38:34.687565 -0700

rtcreportingd

createReportingSessionWithDelegate: retained XPC Transaction. Ref count is 2\

default

18:38:34.687822 -0700

rtcreportingd

setSessionInfo: Configuring session 1973075505\

default

18:38:34.687851 -0700

rtcreportingd

updateCorrelatedSessions: Session 1973075505 has no correlated sessions as it is a standalone session\

default

18:38:34.687895 -0700

rtcreportingd

requestSharedConnectivityHelperForReportingSession: Requesting shared connectivity helper for userInfoKey <private>\

default

18:38:34.687924 -0700

rtcreportingd

requestSharedConnectivityHelperForReportingSession: Creating shared connectivity helper for userInfoKey <private>\

default

18:38:34.687978 -0700

rtcreportingd

ReportingSessionConnectivityHelper created with delegate 0\

default

18:38:34.688014 -0700

rtcreportingd

requestSharedConnectivityHelperForReportingSession: Incrementing usage of shared connectivity helper for userInfoKey <private>\

default

18:38:34.688071 -0700

rtcreportingd

stopConnectivityHelperReleaseTimer: stopping connectivity helper release timer for NSURLSession with ID <inactive>\

default

18:38:34.688104 -0700

rtcreportingd

ownerIncrementUsageCount: connectivity helper incremented usage count for NSURLSession with ID <inactive>. _usageCount=1, _totalSessionsServedCount=0\

default

18:38:34.688120 -0700

rtcreportingd

startConfigWithCompletionHandler: Starting configuration for session 1973075505\

default

18:38:34.688154 -0700

rtcreportingd

storebagForSession: Retrieving storebag for session 1973075505 with client type 12\

default

18:38:34.688617 -0700

rtcreportingd

storebagForSession: Cached storebag found for client type 12\

default

18:38:34.688658 -0700

rtcreportingd

createBackendsWithStorebag: Creating backends for session 1973075505\

default

18:38:34.689508 -0700

rtcreportingd

reading _CRCopyDiagnosticMessagesHistoryValue key SeedAutoSubmit-#41 (stat 0: 238964)\

default

18:38:34.696354 -0700

rtcreportingd

SeedAutoSubmitPreference is 1 via AutoSubmitPreferenceKey\

default

18:38:34.696513 -0700

rtcreportingd

getPersistentIdentifierForDNU: The value for uuidRespectDNU: <private>\

default

18:38:34.696596 -0700

rtcreportingd

getPersistentIdentifierForDNU: The value for uuidOverrideDNU: <private>\

default

18:38:34.696754 -0700

rtcreportingd

resetBackendStateWithClient: event_threshold set to 50\

default

18:38:34.696784 -0700

rtcreportingd

setBackendStateWithClient: extras on internal is set to 0\

default

18:38:34.696812 -0700

rtcreportingd

HTTPSPostBackend(updateBackendState): <private>: client found <private>:<private>, state=2, samplingFactor=0.045500\

default

18:38:34.696840 -0700

rtcreportingd

HTTPSPostBackend(updatePostLink): Storebag '<private>' for postURL\

default

18:38:34.696866 -0700

rtcreportingd

HTTPSPostBackend(updatePostLink): realtimePostURL defaults to postURL '<private>'\

default

18:38:34.696905 -0700

rtcreportingd

activate: activating connectivity helper for NSURLSession with ID <inactive>\

default

18:38:34.697019 -0700

rtcreportingd

NSURLSession created and activated with ID <<private>>, delegate 1673639712\

default

18:38:34.697434 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): realtime is 0\

default

18:38:34.697471 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Batching 2, 1, 1\

default

18:38:34.697524 -0700

rtcreportingd

internalSendMessage: Sent internal message (method:0 respCode:0)\

default

18:38:34.697664 -0700

rtcreportingd

fetchDisplayURL: Fetching display URL for session 1973075505\

default

18:38:34.697709 -0700

storedownloadd

Message Sent Delegate reads 0:\

default

18:38:34.697711 -0700

storedownloadd

Cached 1 enabled backends, ((null), (null)) listed events\

default

18:38:34.698011 -0700

rtcreportingd

sendMessageWithDictionary: Sending message for session 1973075505\

default

18:38:34.698086 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): realtime is 0\

default

18:38:34.698115 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Batching 2, 1, 1\

default

18:38:34.698238 -0700

storedownloadd

sendMessageWithDictionary: (null)\

default

18:38:34.698394 -0700

storedownloadd

aboutToDealloc: RTCReporting client session 0x7fe73e12ac40 is about to dealloc\

default

18:38:34.698566 -0700

rtcreportingd

finishSessionGracefully: Session 1973075505 has been finished gracefully\

default

18:38:34.698579 -0700

storedownloadd

initWithSessionInfo: XPC connection invalidated\

default

18:38:34.698658 -0700

rtcreportingd

listener: XPC connection to <private> was invalidated\

default

18:38:34.698691 -0700

rtcreportingd

invalidateReportingSession: ReportingdSession <private> was invalidated\

default

18:38:34.698757 -0700

rtcreportingd

dealloc: ReportingdSession dealloc: 1973075505\

default

18:38:34.699018 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Adding dnu type and sampling threshold to SESSION_TYPE_STOP message dictionary\

default

18:38:34.699084 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): realtime is 0\

default

18:38:34.699110 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Batching 2, 1, 1\

default

18:38:34.699149 -0700

rtcreportingd

internalSendMessage: Sent internal message (method:0 respCode:1)\

default

18:38:34.699173 -0700

rtcreportingd

flushMessagesWithCompletion: Flushing messages for session 1973075505\

default

18:38:34.699195 -0700

rtcreportingd

HTTPSPostBackend(flushMessagesWithCompletion): called\

default

18:38:34.699353 -0700

rtcreportingd

userDefaultsEnvironment: Environment type 3\

default

18:38:34.706046 -0700

rtcreportingd

Task <450FCB84-9DA7-4BFF-811A-B53EAB6CAAFC>.<1> setting up Connection 12\

default

18:38:34.729669 -0700

storeuid

Memory usage info dump at MainFrameLoadStarted:\

default

18:38:34.729705 -0700

storeuid

compressed: 0\

default

18:38:34.729735 -0700

storeuid

internal: 23691264\

default

18:38:34.729768 -0700

storeuid

pagecache_page_count: 0\

default

18:38:34.729798 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:34.729828 -0700

storeuid

virtual_size: 4751044608\

default

18:38:34.729860 -0700

storeuid

phys_footprint: 24686592\

default

18:38:34.729941 -0700

storeuid

resident_size: 46780416\

default

18:38:34.729992 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:34.730040 -0700

storeuid

document_count: 1\

default

18:38:34.730290 -0700

storeuid

0x7f9778906e90 - FrameLoader::prepareForLoadStart: Starting frame load (frame = 0x10ba72d68, main = 1)\

default

18:38:34.730390 -0700

storeuid

0x10baeb000 - DocumentLoader::startLoadingMainResource: Starting load (frame = 0x10ba72d68, main = 1)\

default

18:38:34.730426 -0700

storeuid

0x10baeb000 - DocumentLoader::startLoadingMainResource: Returning substitute data (frame = 0x10ba72d68, main = 1)\

default

18:38:34.745686 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:34.745731 -0700

storeuid

compressed: 0\

default

18:38:34.745763 -0700

storeuid

internal: 23724032\

default

18:38:34.745794 -0700

storeuid

pagecache_page_count: 0\

default

18:38:34.745824 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:34.745854 -0700

storeuid

virtual_size: 4752093184\

default

18:38:34.745884 -0700

storeuid

phys_footprint: 24719360\

default

18:38:34.745914 -0700

storeuid

resident_size: 46792704\

default

18:38:34.745943 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:34.745974 -0700

storeuid

document_count: 2\

default

18:38:34.746021 -0700

storeuid

0x7f9778906e90 - FrameLoader::checkLoadCompleteForThisFrame: Finished frame load (frame = 0x10ba72d68, main = 1)\

default

18:38:34.772921 -0700

storeuid

internal: 23724032\

default

18:38:34.772951 -0700

storeuid

pagecache_page_count: 0\

default

18:38:34.772980 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:34.773010 -0700

storeuid

virtual_size: 4752093184\

default

18:38:34.773039 -0700

storeuid

phys_footprint: 24719360\

default

18:38:34.773068 -0700

storeuid

resident_size: 46792704\

default

18:38:34.773097 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:34.773125 -0700

storeuid

document_count: 3\

default

18:38:34.773347 -0700

storeuid

0x7f9777f64100 - FrameLoader::prepareForLoadStart: Starting frame load (frame = 0x10ba72108, main = 1)\

default

18:38:34.773423 -0700

storeuid

0x10ba9f000 - DocumentLoader::startLoadingMainResource: Starting load (frame = 0x10ba72108, main = 1)\

default

18:38:34.773458 -0700

storeuid

0x10ba9f000 - DocumentLoader::startLoadingMainResource: Returning substitute data (frame = 0x10ba72108, main = 1)\

default

18:38:34.775228 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:34.775269 -0700

storeuid

compressed: 0\

default

18:38:34.775302 -0700

storeuid

internal: 23732224\

default

18:38:34.775332 -0700

storeuid

pagecache_page_count: 0\

default

18:38:34.775362 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:34.775392 -0700

storeuid

virtual_size: 4752093184\

default

18:38:34.775421 -0700

storeuid

phys_footprint: 24727552\

default

18:38:34.775451 -0700

storeuid

resident_size: 46792704\

default

18:38:34.775489 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:34.775519 -0700

storeuid

document_count: 4\

default

18:38:34.775565 -0700

storeuid

0x7f9777f64100 - FrameLoader::checkLoadCompleteForThisFrame: Finished frame load (frame = 0x10ba72108, main = 1)\

default

18:38:34.789204 -0700

contextstored

27366555: RECEIVED OUT-OF-SEQUENCE NOTIFICATION: 0 vs 110, 513, <private>\

default

18:38:34.797903 -0700

rtcreportingd

nw_socket_handle_socket_event [C12.1:3] Socket received CONNECTED event\

default

18:38:34.798023 -0700

rtcreportingd

nw_endpoint_flow_protocol_connected [C12.1 IPv4#56d683fc:443 in_progress socket-flow (satisfied)] Transport protocol connected\

default

18:38:34.903666 -0700

rtcreportingd

TIC TLS Trust Result [12:0x7fd963d18810]: 0\

default

18:38:34.998899 -0700

rtcreportingd

nw_endpoint_flow_protocol_connected [C12.1 IPv4#56d683fc:443 in_progress socket-flow (satisfied)] Output protocol connected\

default

18:38:34.999113 -0700

rtcreportingd

nw_connection_report_state_with_handler_locked [C12] reporting state ready\

default

18:38:34.999308 -0700

rtcreportingd

TIC TLS Event [12:0x7fd963d18810]: 20, Pending(0)\

default

18:38:34.999348 -0700

rtcreportingd

TIC TCP Conn Connected [12:0x7fd963d18810]: Err(16)\

default

18:38:34.999572 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f81b450>: (com.microsoft.OneDrive-mac, 18.065.0329, 823766827:826917933 VPP:NO source:Spotlight /Applications/OneDrive.app) using SoftwareMap to upgrade to 18.091.0506\

default

18:38:34.999929 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f81b450>: (com.microsoft.OneDrive-mac, 18.065.0329, 823766827:826917933 VPP:NO source:Spotlight /Applications/OneDrive.app) using SoftwareMap to upgrade to 18.091.0506\

default

18:38:35.000012 -0700

rtcreportingd

Task <450FCB84-9DA7-4BFF-811A-B53EAB6CAAFC>.<1> now using Connection 12\

default

18:38:35.000196 -0700

rtcreportingd

nw_endpoint_flow_protocol_connected [C12.1 IPv4#56d683fc:443 ready socket-flow (satisfied)] Output protocol connected\

default

18:38:35.000673 -0700

rtcreportingd

Task <450FCB84-9DA7-4BFF-811A-B53EAB6CAAFC>.<1> sent request, body S\

default

18:38:35.000849 -0700

rtcreportingd

didSendBodyData: for <session>:<task> <<private>>:<<private>>: Sent 922 out of 922\

default

18:38:35.097067 -0700

rtcreportingd

Task <450FCB84-9DA7-4BFF-811A-B53EAB6CAAFC>.<1> received response, status 200 content K\

default

18:38:35.097239 -0700

rtcreportingd

Task <450FCB84-9DA7-4BFF-811A-B53EAB6CAAFC>.<1> response ended\

default

18:38:35.097326 -0700

rtcreportingd

Task <450FCB84-9DA7-4BFF-811A-B53EAB6CAAFC>.<1> done using Connection 12\

default

18:38:35.097379 -0700

rtcreportingd

didReceiveResponse: for <session>:<task> <<private>>:<<private>>\

default

18:38:35.097529 -0700

rtcreportingd

didReceiveData: received 2 bytes for <session>:<task> <<private>>:<<private>>\

default

18:38:35.097933 -0700

rtcreportingd

didCompleteWithError: for <session>:<task> <<private>>:<<private>> with response <private>, error (null)\

default

18:38:35.097970 -0700

rtcreportingd

internalFlushMessagesWithCompletion: <private>\

default

18:38:35.098567 -0700

rtcreportingd

writeToLogFile: Saved log message to <private>\

default

18:38:35.098611 -0700

rtcreportingd

ConnectivityHelperTask with ID <<private>> dealloced\

default

18:38:35.127316 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(407963104: <NSProgress: 0x6000039559a0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: 0 of 1000 )\

default

18:38:35.127473 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(403304796: <NSProgress: 0x60000393cfa0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: 0 of 1000 )\

default

18:38:35.212927 -0700

dasd

COMPLETED 0:com.apple.mds.Health check (2).0:B14EAA <private>!\

default

18:38:35.213040 -0700

dasd

NO LONGER RUNNING 0:com.apple.mds.Health check (2).0:B14EAA ...Tasks running in group [com.apple.dasd.default] are 4!\

default

18:38:35.213915 -0700

dasd

501:com.apple.mediaanalysisd.fullanalysis:537F8D:[\

default

18:38:35.214603 -0700

dasd

0:com.apple.coreduetd.people:2650D0:[\

default

18:38:35.215341 -0700

dasd

0:com.apple.apsd.apprefresh:4FB60E:[\

default

18:38:35.334193 -0700

accountsd

<private> (<private>) received\

default

18:38:35.336901 -0700

accountsd

<private> (<private>) received\

default

18:38:35.338400 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:35.338506 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:35.341889 -0700

accountsd

<private> (<private>) received\

default

18:38:35.342820 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73e599120>: Initializing MD5 context\

default

18:38:35.342914 -0700

storedownloadd

AssetDownloadOperation: Using delta package.\

default

18:38:35.343234 -0700

storedownloadd

ISStoreURLOperation: Starting URL operation with url=http://osxapps.itunes.apple.com/itunes-assets/Purple115/v4/e0/6a/81/e06a819d-7eb0-3ca6-630a-32d666dd4397/mzps7861077000939446461.pkg / bagKey=(null)\

default

18:38:35.343285 -0700

storedownloadd

-[ISStoreURLOperation _runURLOperation]: _addStandardQueryParametersForURL: http://osxapps.itunes.apple.com/itunes-assets/Purple115/v4/e0/6a/81/e06a819d-7eb0-3ca6-630a-32d666dd4397/mzps7861077000939446461.pkg\

default

18:38:35.344273 -0700

accountsd

<private> (<private>) received\

default

18:38:35.345697 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:35.345727 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:35.347886 -0700

accountsd

<private> (<private>) received\

default

18:38:35.350053 -0700

commerce

Task <ADFD77C2-72D4-4D47-8CEE-F7B15C90D952>.<702> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:35.350218 -0700

commerce

Task <ADFD77C2-72D4-4D47-8CEE-F7B15C90D952>.<702> now using Connection 23\

default

18:38:35.350351 -0700

accountsd

<private> (<private>) received\

default

18:38:35.350414 -0700

commerce

Task <ADFD77C2-72D4-4D47-8CEE-F7B15C90D952>.<702> sent request, body N\

default

18:38:35.351781 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:35.351811 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:35.359402 -0700

App Store

AMSMetrics: [D96AABC5] Flushing events for container: MacAppStore\

default

18:38:35.364337 -0700

App Store

AMSMetrics: Posting...\

default

18:38:35.367982 -0700

accountsd

<private> (<private>) received\

default

18:38:35.370449 -0700

accountsd

<private> (<private>) received\

default

18:38:35.371928 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:35.371972 -0700

commerce

The connection to ACDAccountStore was invalidated.\

default

18:38:35.372646 -0700

App Store

AMSURLRequestEncoder: [D96AABC5] Encoding request for Account = <ACAccount: 0x600003478e00 Local Account | storefront = 143441-1,13>> URL = https://xp.apple.com/report/2/xp_amp_appstore\

error

18:38:35.375229 -0700

App Store

AMSURLRequest: Failed to fetch GUID schemes from bag\

default

18:38:35.375346 -0700

App Store

AMSURLSession: [D96AABC5] Preparing task with request: AMSURLRequest <private>\

default

18:38:35.375844 -0700

App Store

Task <407418B4-2E69-429B-B457-0BA70736466C>.<4> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:35.376166 -0700

App Store

TIC Enabling TLS [13:0x600003d2dd40]\

default

18:38:35.376231 -0700

App Store

TIC TCP Conn Start [13:0x600003d2dd40]\

default

18:38:35.376399 -0700

App Store

[C13 Hostname#c98e3914:443 tcp, url: https://xp.apple.com/report/2/xp_amp_appstore, traffic class: 200, tls] start\

default

18:38:35.376876 -0700

App Store

nw_connection_report_state_with_handler_locked [C13] reporting state preparing\

default

18:38:35.380081 -0700

App Store

Task <407418B4-2E69-429B-B457-0BA70736466C>.<4> setting up Connection 13\

default

18:38:35.441435 -0700

commerce

Task <ADFD77C2-72D4-4D47-8CEE-F7B15C90D952>.<702> received response, status 200 content K\

default

18:38:35.441612 -0700

commerce

Task <ADFD77C2-72D4-4D47-8CEE-F7B15C90D952>.<702> response ended\

default

18:38:35.441673 -0700

commerce

Task <ADFD77C2-72D4-4D47-8CEE-F7B15C90D952>.<702> done using Connection 23\

default

18:38:35.461623 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73e599120>: Opening file /var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/823766827/syz7246331111982550578.pkg returning file descriptor 11 (0 streamed)\

default

18:38:35.471726 -0700

App Store

nw_socket_handle_socket_event [C13.1:3] Socket received CONNECTED event\

default

18:38:35.471854 -0700

App Store

nw_endpoint_flow_protocol_connected [C13.1 IPv4#9d8cd9c2:443 in_progress socket-flow (satisfied)] Transport protocol connected\

default

18:38:35.472222 -0700

storedownloadd

TIC TCP Conn Start [43:0x7fe73e92dd50]\

default

18:38:35.472382 -0700

storedownloadd

[C43 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple115/v4/e0/6a/81/e06a819d-7eb0-3ca6-630a-32d666dd4397/mzps78610770009] start\

default

18:38:35.472793 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C43] reporting state preparing\

default

18:38:35.474251 -0700

App Store

TIC TLS Event [13:0x600003d2dd40]: 1, Pending(0)\

default

18:38:35.474428 -0700

App Store

TIC TLS Event [13:0x600003d2dd40]: 2, Pending(0)\

default

18:38:35.476037 -0700

storedownloadd

Task <743077BA-877A-420C-9DD9-B0CB782355AB>.<0> setting up Connection 43\

default

18:38:35.493737 -0700

storedownloadd

nw_socket_handle_socket_event [C43.1:2] Socket received CONNECTED event\

default

18:38:35.493827 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C43.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Transport protocol connected\

default

18:38:35.494045 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C43.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Output protocol connected\

default

18:38:35.494369 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C43] reporting state ready\

default

18:38:35.494910 -0700

storedownloadd

TIC TCP Conn Connected [43:0x7fe73e92dd50]: Err(16)\

default

18:38:35.495169 -0700

storedownloadd

TIC TCP Conn Event [43:0x7fe73e92dd50]: 1\

default

18:38:35.496192 -0700

storedownloadd

Task <743077BA-877A-420C-9DD9-B0CB782355AB>.<0> now using Connection 43\

default

18:38:35.496348 -0700

storedownloadd

Task <743077BA-877A-420C-9DD9-B0CB782355AB>.<0> sent request, body N\

default

18:38:35.522822 -0700

storedownloadd

Task <743077BA-877A-420C-9DD9-B0CB782355AB>.<0> received response, status 200 content K\

default

18:38:35.523828 -0700

storedownloadd

sending status (OneDrive): 0.000000% (0.000000)\

default

18:38:35.524457 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.microsoft.OneDrive-mac (0.00)\

default

18:38:35.524663 -0700

storedownloadd

AssetDownloadOperation: Subtracted 0 already-downloaded bytes from required space (now requires 10680964 bytes)\

default

18:38:35.524828 -0700

storedownloadd

sending status (OneDrive): 0.000000% (-1.000000)\

default

18:38:35.525347 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.microsoft.OneDrive-mac (0.00)\

default

18:38:35.527866 -0700

storedownloadd

HashedDownloadProvider: Failed to initialize decryption session with error -42076\

default

18:38:35.528133 -0700

storedownloadd

TIC TCP Conn Cancel [43:0x7fe73e92dd50]\

default

18:38:35.528146 -0700

storedownloadd

ISStoreURLOperation: Chose not to retry after error: Error Domain=ISErrorDomain Code=7 "Unknown Error." UserInfo=\{NSLocalizedDescription=Unknown Error.\}\

default

18:38:35.528229 -0700

storedownloadd

[C43 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple115/v4/e0/6a/81/e06a819d-7eb0-3ca6-630a-32d666dd4397/mzps78610770009] cancel\

default

18:38:35.528276 -0700

storedownloadd

AssetDownloadOperation: Delta package download failed, falling back to full package\

default

18:38:35.528321 -0700

storedownloadd

AssetDownloadOperation: Asset download cancelled/failed. Will do retry #1? 1\

default

18:38:35.528361 -0700

storedownloadd

[C43 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple115/v4/e0/6a/81/e06a819d-7eb0-3ca6-630a-32d666dd4397/mzps78610770009] cancelled\

default

18:38:35.528385 -0700

storedownloadd

#53e786f9 ACSLocateCachingServer(assetURL=http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/14/41/a5/1441a5a4-bc80-6ea8-b9c9-a4c0d6cd7d69/syz7246331111982550578.pkg, locateTimeout=10.000, options=(null), callbackQueue=0x0, callback=0x700004249238)\

default

18:38:35.528399 -0700

storedownloadd

0.000s [C43 26CFBBBC-9B31-428F-9EF6-EF645576A0DF Hostname#1784b493:80 resolver] path:start\

default

18:38:35.528427 -0700

storedownloadd

0.000s [C43 26CFBBBC-9B31-428F-9EF6-EF645576A0DF Hostname#1784b493:80 resolver] path:satisfied\

default

18:38:35.528453 -0700

storedownloadd

0.000s [C43 26CFBBBC-9B31-428F-9EF6-EF645576A0DF Hostname#1784b493:80 resolver] resolver:start_dns\

default

18:38:35.528478 -0700

storedownloadd

0.004s [C43 26CFBBBC-9B31-428F-9EF6-EF645576A0DF Hostname#1784b493:80 resolver] resolver:receive_dns\

default

18:38:35.528506 -0700

storedownloadd

0.004s [C43.1 B56C23DC-84C5-4B62-8400-656BAD13046F 10.0.1.2:58042<->IPv4#cbadfac4:80 socket-flow] path:start\

default

18:38:35.528532 -0700

storedownloadd

0.005s [C43.1 B56C23DC-84C5-4B62-8400-656BAD13046F 10.0.1.2:58042<->IPv4#cbadfac4:80 socket-flow] path:satisfied\

default

18:38:35.528560 -0700

storedownloadd

0.005s [C43.1 B56C23DC-84C5-4B62-8400-656BAD13046F 10.0.1.2:58042<->IPv4#cbadfac4:80 socket-flow] flow:start_connect\

default

18:38:35.528599 -0700

storedownloadd

0.021s [C43.1 B56C23DC-84C5-4B62-8400-656BAD13046F 10.0.1.2:58042<->IPv4#cbadfac4:80 socket-flow] flow:finish_transport\

default

18:38:35.528655 -0700

storedownloadd

0.021s [C43 26CFBBBC-9B31-428F-9EF6-EF645576A0DF Hostname#1784b493:80 resolver] flow:finish_transport\

default

18:38:35.528687 -0700

storedownloadd

0.021s [C43.1 B56C23DC-84C5-4B62-8400-656BAD13046F 10.0.1.2:58042<->IPv4#cbadfac4:80 socket-flow] flow:finish_connect\

default

18:38:35.528761 -0700

storedownloadd

0.022s [C43 26CFBBBC-9B31-428F-9EF6-EF645576A0DF Hostname#1784b493:80 resolver] flow:finish_connect\

default

18:38:35.528823 -0700

storedownloadd

0.022s [C43.1 B56C23DC-84C5-4B62-8400-656BAD13046F 10.0.1.2:58042<->IPv4#cbadfac4:80 socket-flow] flow:changed_viability\

default

18:38:35.528879 -0700

storedownloadd

0.022s [C43 26CFBBBC-9B31-428F-9EF6-EF645576A0DF Hostname#1784b493:80 resolver] flow:changed_viability\

default

18:38:35.528924 -0700

storedownloadd

0.055s [C43] path:cancel\

default

18:38:35.529239 -0700

storedownloadd

nw_endpoint_flow_protocol_disconnected [C43.1 IPv4#cbadfac4:80 cancelled socket-flow (null)] Output protocol disconnected\

default

18:38:35.529454 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C43] reporting state cancelled\

default

18:38:35.529548 -0700

storedownloadd

Task <743077BA-877A-420C-9DD9-B0CB782355AB>.<0> done using Connection 43\

default

18:38:35.529606 -0700

storedownloadd

TIC TCP Conn Destroyed [43:0x7fe73e92dd50]\

error

18:38:35.529690 -0700

storedownloadd

TIC Read Status [43:0x0]: 1:57\

default

18:38:35.529917 -0700

AssetCacheLocatorService

#53e786f9 [AssetCacheLocatorService.queue] early hit: no caching servers\

default

18:38:35.530221 -0700

storedownloadd

#53e786f9 ACSLocateCachingServer -> [new] newURL (null), advice (null), error (null), elapsed 0.002/10.000\

default

18:38:35.530344 -0700

storedownloadd

AssetDownloadOperation no modified URL for http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/14/41/a5/1441a5a4-bc80-6ea8-b9c9-a4c0d6cd7d69/syz7246331111982550578.pkg\

default

18:38:35.530688 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73e35d5c0>: Initializing MD5 context\

default

18:38:35.530818 -0700

storedownloadd

delta update failed, trying full package\

default

18:38:35.531126 -0700

storedownloadd

ISStoreURLOperation: Starting URL operation with url=http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/14/41/a5/1441a5a4-bc80-6ea8-b9c9-a4c0d6cd7d69/syz7246331111982550578.pkg / bagKey=(null)\

default

18:38:35.531176 -0700

storedownloadd

-[ISStoreURLOperation _runURLOperation]: _addStandardQueryParametersForURL: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/14/41/a5/1441a5a4-bc80-6ea8-b9c9-a4c0d6cd7d69/syz7246331111982550578.pkg\

default

18:38:35.557482 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73e35d5c0>: Opening file /var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/823766827/syz7246331111982550578.pkg returning file descriptor 14 (0 streamed)\

default

18:38:35.567463 -0700

storedownloadd

TIC TCP Conn Start [44:0x7fe73e369ef0]\

default

18:38:35.567608 -0700

storedownloadd

[C44 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/14/41/a5/1441a5a4-bc80-6ea8-b9c9-a4c0d6cd7d69/syz724633111198] start\

default

18:38:35.567995 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C44] reporting state preparing\

default

18:38:35.570623 -0700

App Store

TIC TLS Event [13:0x600003d2dd40]: 2, Pending(0)\

default

18:38:35.571248 -0700

storedownloadd

Task <84A2603B-6709-4F5D-B743-998E9D116EB8>.<0> setting up Connection 44\

default

18:38:35.573313 -0700

App Store

nw_endpoint_flow_protocol_connected [C13.1 IPv4#9d8cd9c2:443 in_progress socket-flow (satisfied)] Output protocol connected\

default

18:38:35.573498 -0700

App Store

nw_connection_report_state_with_handler_locked [C13] reporting state ready\

default

18:38:35.573930 -0700

App Store

TIC TLS Event [13:0x600003d2dd40]: 20, Pending(0)\

default

18:38:35.574249 -0700

App Store

TIC TCP Conn Connected [13:0x600003d2dd40]: Err(16)\

default

18:38:35.574428 -0700

App Store

TIC TCP Conn Event [13:0x600003d2dd40]: 1\

default

18:38:35.574449 -0700

App Store

TIC TCP Conn Event [13:0x600003d2dd40]: 8\

default

18:38:35.574532 -0700

App Store

TIC TLS Handshake Complete [13:0x600003d2dd40]\

default

18:38:35.574751 -0700

App Store

Task <407418B4-2E69-429B-B457-0BA70736466C>.<4> now using Connection 13\

default

18:38:35.575129 -0700

App Store

nw_endpoint_flow_protocol_connected [C13.1 IPv4#9d8cd9c2:443 ready socket-flow (satisfied)] Output protocol connected\

default

18:38:35.575682 -0700

App Store

Task <407418B4-2E69-429B-B457-0BA70736466C>.<4> sent request, body S\

default

18:38:35.598383 -0700

storedownloadd

nw_socket_handle_socket_event [C44.1:2] Socket received CONNECTED event\

default

18:38:35.598472 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C44.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Transport protocol connected\

default

18:38:35.598624 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C44.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Output protocol connected\

default

18:38:35.598787 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C44] reporting state ready\

default

18:38:35.598956 -0700

storedownloadd

TIC TCP Conn Connected [44:0x7fe73e369ef0]: Err(16)\

default

18:38:35.599055 -0700

storedownloadd

TIC TCP Conn Event [44:0x7fe73e369ef0]: 1\

default

18:38:35.599795 -0700

storedownloadd

Task <84A2603B-6709-4F5D-B743-998E9D116EB8>.<0> now using Connection 44\

default

18:38:35.599932 -0700

storedownloadd

Task <84A2603B-6709-4F5D-B743-998E9D116EB8>.<0> sent request, body N\

default

18:38:35.618139 -0700

storedownloadd

Task <84A2603B-6709-4F5D-B743-998E9D116EB8>.<0> received response, status 200 content K\

default

18:38:35.618943 -0700

storedownloadd

sending status (OneDrive): 0.000000% (-1.000000)\

default

18:38:35.619577 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.microsoft.OneDrive-mac (0.00)\

default

18:38:35.619769 -0700

storedownloadd

AssetDownloadOperation: Subtracted 0 already-downloaded bytes from required space (now requires 33127033 bytes)\

default

18:38:35.619927 -0700

storedownloadd

sending status (OneDrive): 0.000000% (-1.000000)\

default

18:38:35.620499 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.microsoft.OneDrive-mac (0.00)\

default

18:38:35.622800 -0700

storedownloadd

HashedDownloadProvider: Failed to initialize decryption session with error -42076\

default

18:38:35.623029 -0700

storedownloadd

TIC TCP Conn Cancel [44:0x7fe73e369ef0]\

default

18:38:35.623045 -0700

storedownloadd

ISStoreURLOperation: Chose not to retry after error: Error Domain=ISErrorDomain Code=7 "Unknown Error." UserInfo=\{NSLocalizedDescription=Unknown Error.\}\

default

18:38:35.623120 -0700

storedownloadd

[C44 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/14/41/a5/1441a5a4-bc80-6ea8-b9c9-a4c0d6cd7d69/syz724633111198] cancel\

default

18:38:35.623166 -0700

storedownloadd

AssetDownloadOperation: Asset download cancelled/failed. Will do retry #2? 0\

default

18:38:35.623249 -0700

storedownloadd

[C44 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/14/41/a5/1441a5a4-bc80-6ea8-b9c9-a4c0d6cd7d69/syz724633111198] cancelled\

default

18:38:35.623296 -0700

storedownloadd

ProgressObserver: Unlocking app at /Applications/OneDrive.app\

default

18:38:35.623309 -0700

storedownloadd

0.000s [C44 40B0EEE2-27CE-4E08-A2A0-73E83EB39922 Hostname#1784b493:80 resolver] path:start\

default

18:38:35.623350 -0700

storedownloadd

0.000s [C44 40B0EEE2-27CE-4E08-A2A0-73E83EB39922 Hostname#1784b493:80 resolver] path:satisfied\

default

18:38:35.623378 -0700

storedownloadd

0.000s [C44 40B0EEE2-27CE-4E08-A2A0-73E83EB39922 Hostname#1784b493:80 resolver] resolver:start_dns\

default

18:38:35.623404 -0700

storedownloadd

0.004s [C44 40B0EEE2-27CE-4E08-A2A0-73E83EB39922 Hostname#1784b493:80 resolver] resolver:receive_dns\

default

18:38:35.623428 -0700

storedownloadd

DownloadOperation: Download failed with error: Error Domain=ISErrorDomain Code=7 "Unknown Error." UserInfo=\{NSLocalizedDescription=Unknown Error.\}\

default

18:38:35.623435 -0700

storedownloadd

0.004s [C44.1 2F6D6254-BB6A-48BE-9122-B37DDCFCDE6E 10.0.1.2:58043<->IPv4#cbadfac4:80 socket-flow] path:start\

default

18:38:35.623464 -0700

storedownloadd

0.005s [C44.1 2F6D6254-BB6A-48BE-9122-B37DDCFCDE6E 10.0.1.2:58043<->IPv4#cbadfac4:80 socket-flow] path:satisfied\

default

18:38:35.623491 -0700

storedownloadd

0.005s [C44.1 2F6D6254-BB6A-48BE-9122-B37DDCFCDE6E 10.0.1.2:58043<->IPv4#cbadfac4:80 socket-flow] flow:start_connect\

default

18:38:35.623516 -0700

storedownloadd

0.030s [C44.1 2F6D6254-BB6A-48BE-9122-B37DDCFCDE6E 10.0.1.2:58043<->IPv4#cbadfac4:80 socket-flow] flow:finish_transport\

default

18:38:35.623543 -0700

storedownloadd

0.030s [C44 40B0EEE2-27CE-4E08-A2A0-73E83EB39922 Hostname#1784b493:80 resolver] flow:finish_transport\

default

18:38:35.623571 -0700

storedownloadd

0.031s [C44.1 2F6D6254-BB6A-48BE-9122-B37DDCFCDE6E 10.0.1.2:58043<->IPv4#cbadfac4:80 socket-flow] flow:finish_connect\

default

18:38:35.623621 -0700

storedownloadd

0.031s [C44 40B0EEE2-27CE-4E08-A2A0-73E83EB39922 Hostname#1784b493:80 resolver] flow:finish_connect\

default

18:38:35.623671 -0700

storedownloadd

0.031s [C44.1 2F6D6254-BB6A-48BE-9122-B37DDCFCDE6E 10.0.1.2:58043<->IPv4#cbadfac4:80 socket-flow] flow:changed_viability\

default

18:38:35.623716 -0700

storedownloadd

0.031s [C44 40B0EEE2-27CE-4E08-A2A0-73E83EB39922 Hostname#1784b493:80 resolver] flow:changed_viability\

default

18:38:35.623762 -0700

ReceiptInstaller

ReceiptDispatch: unlocked application at path /Applications/OneDrive.app\

default

18:38:35.623765 -0700

storedownloadd

0.055s [C44] path:cancel\

default

18:38:35.624056 -0700

storedownloadd

nw_endpoint_flow_protocol_disconnected [C44.1 IPv4#cbadfac4:80 cancelled socket-flow (null)] Output protocol disconnected\

default

18:38:35.624248 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C44] reporting state cancelled\

default

18:38:35.624295 -0700

storedownloadd

Task <84A2603B-6709-4F5D-B743-998E9D116EB8>.<0> done using Connection 44\

default

18:38:35.624369 -0700

storedownloadd

TIC TCP Conn Destroyed [44:0x7fe73e369ef0]\

error

18:38:35.624466 -0700

storedownloadd

TIC Read Status [44:0x0]: 1:57\

default

18:38:35.624742 -0700

storedownloadd

startLogging: Client starts logging...\

default

18:38:35.625405 -0700

rtcreportingd

listener: Accepting new XPC connection <private> as it has proper entitlement, 1(0) connections.\

default

18:38:35.625525 -0700

rtcreportingd

initWithSessionDelegate: ReportingdSession initWithSessionDelegate:<private>\

default

18:38:35.625658 -0700

rtcreportingd

initWithSessionDelegate: Initialized session with UUID <private>\

default

18:38:35.625694 -0700

rtcreportingd

createReportingSessionWithDelegate: retained XPC Transaction. Ref count is 3\

default

18:38:35.625879 -0700

rtcreportingd

setSessionInfo: Configuring session 1348128665\

default

18:38:35.625908 -0700

rtcreportingd

updateCorrelatedSessions: Session 1348128665 has no correlated sessions as it is a standalone session\

default

18:38:35.625946 -0700

rtcreportingd

requestSharedConnectivityHelperForReportingSession: Requesting shared connectivity helper for userInfoKey <private>\

default

18:38:35.625974 -0700

rtcreportingd

requestSharedConnectivityHelperForReportingSession: Found existing shared connectivity helper for userInfoKey <private>\

default

18:38:35.625997 -0700

rtcreportingd

requestSharedConnectivityHelperForReportingSession: Incrementing usage of shared connectivity helper for userInfoKey <private>\

default

18:38:35.626047 -0700

rtcreportingd

stopConnectivityHelperReleaseTimer: stopping connectivity helper release timer for NSURLSession with ID <<private>>\

default

18:38:35.626069 -0700

rtcreportingd

startConfigWithCompletionHandler: Starting configuration for session 1348128665\

default

18:38:35.626084 -0700

rtcreportingd

ownerIncrementUsageCount: connectivity helper incremented usage count for NSURLSession with ID <<private>>. _usageCount=1, _totalSessionsServedCount=1\

default

18:38:35.626099 -0700

rtcreportingd

storebagForSession: Retrieving storebag for session 1348128665 with client type 12\

default

18:38:35.626520 -0700

rtcreportingd

storebagForSession: Cached storebag found for client type 12\

default

18:38:35.626557 -0700

rtcreportingd

createBackendsWithStorebag: Creating backends for session 1348128665\

default

18:38:35.627399 -0700

rtcreportingd

reading _CRCopyDiagnosticMessagesHistoryValue key SeedAutoSubmit-#43 (stat 0: 238964)\

default

18:38:35.630794 -0700

rtcreportingd

reading _CRCopyDiagnosticMessagesHistoryValue key AutoSubmit-#44 (stat 0: 238964)\

default

18:38:35.633815 -0700

rtcreportingd

SeedAutoSubmitPreference is 1 via AutoSubmitPreferenceKey\

default

18:38:35.633955 -0700

rtcreportingd

getPersistentIdentifierForDNU: The value for uuidRespectDNU: <private>\

default

18:38:35.634038 -0700

rtcreportingd

getPersistentIdentifierForDNU: The value for uuidOverrideDNU: <private>\

default

18:38:35.634191 -0700

rtcreportingd

resetBackendStateWithClient: event_threshold set to 50\

default

18:38:35.634221 -0700

rtcreportingd

setBackendStateWithClient: extras on internal is set to 0\

default

18:38:35.634251 -0700

rtcreportingd

HTTPSPostBackend(updateBackendState): <private>: client found <private>:<private>, state=2, samplingFactor=0.715800\

default

18:38:35.634279 -0700

rtcreportingd

HTTPSPostBackend(updatePostLink): Storebag '<private>' for postURL\

default

18:38:35.634306 -0700

rtcreportingd

HTTPSPostBackend(updatePostLink): realtimePostURL defaults to postURL '<private>'\

default

18:38:35.634344 -0700

rtcreportingd

activate: activating connectivity helper for NSURLSession with ID <<private>>\

default

18:38:35.634392 -0700

rtcreportingd

activate: connectivity helper is already active for NSURLSession with ID <<private>>\

default

18:38:35.634809 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): realtime is 0\

default

18:38:35.634846 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Batching 2, 1, 1\

default

18:38:35.634886 -0700

rtcreportingd

internalSendMessage: Sent internal message (method:0 respCode:0)\

default

18:38:35.635013 -0700

rtcreportingd

fetchDisplayURL: Fetching display URL for session 1348128665\

default

18:38:35.635091 -0700

storedownloadd

Message Sent Delegate reads 0:\

default

18:38:35.635094 -0700

storedownloadd

Cached 1 enabled backends, ((null), (null)) listed events\

default

18:38:35.635346 -0700

rtcreportingd

sendMessageWithDictionary: Sending message for session 1348128665\

default

18:38:35.635417 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): realtime is 0\

default

18:38:35.635447 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Batching 2, 1, 1\

default

18:38:35.635562 -0700

storedownloadd

sendMessageWithDictionary: (null)\

default

18:38:35.635604 -0700

storedownloadd

aboutToDealloc: RTCReporting client session 0x7fe73e595ab0 is about to dealloc\

default

18:38:35.635700 -0700

rtcreportingd

finishSessionGracefully: Session 1348128665 has been finished gracefully\

default

18:38:35.635705 -0700

storedownloadd

initWithSessionInfo: XPC connection invalidated\

default

18:38:35.635788 -0700

rtcreportingd

listener: XPC connection to <private> was invalidated\

default

18:38:35.635826 -0700

rtcreportingd

invalidateReportingSession: ReportingdSession <private> was invalidated\

default

18:38:35.635885 -0700

rtcreportingd

dealloc: ReportingdSession dealloc: 1348128665\

default

18:38:35.636094 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Adding dnu type and sampling threshold to SESSION_TYPE_STOP message dictionary\

default

18:38:35.636157 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): realtime is 0\

default

18:38:35.636182 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Batching 2, 1, 1\

default

18:38:35.636217 -0700

rtcreportingd

internalSendMessage: Sent internal message (method:0 respCode:1)\

default

18:38:35.636238 -0700

rtcreportingd

flushMessagesWithCompletion: Flushing messages for session 1348128665\

default

18:38:35.636259 -0700

rtcreportingd

HTTPSPostBackend(flushMessagesWithCompletion): called\

default

18:38:35.636416 -0700

rtcreportingd

userDefaultsEnvironment: Environment type 3\

default

18:38:35.636602 -0700

rtcreportingd

compressDataWithZlibOrGzip: Compressed file from 2408 to 925\

default

18:38:35.636708 -0700

rtcreportingd

shutdownSessionAggregation: Disable aggregation module for session 1348128665\

default

18:38:35.636737 -0700

rtcreportingd

ReportingdSession dealloc: incrementing total sessions count for session 1348128665\

default

18:38:35.636759 -0700

rtcreportingd

Total Sessions Served Count is incremented for NSURLSession with ID <<private>>\

default

18:38:35.636781 -0700

rtcreportingd

ConnectivityHelperTask with ID <<private>> created\

default

18:38:35.636809 -0700

rtcreportingd

createHelperForTask: created helperTask for task <<private>>\

default

18:38:35.636817 -0700

rtcreportingd

releaseSharedConnectivityHelperForReportingSession: Releasing shared connectivity helper for userInfoKey <private>\

default

18:38:35.636844 -0700

rtcreportingd

releaseSharedConnectivityHelperForReportingSession: Decrementing usage count of shared connectivity helper for userInfoKey <private>\

default

18:38:35.636871 -0700

rtcreportingd

ownerDecrementUsageCountWithBlock: connectivity helper decremented usage count for NSURLSession with ID <<private>>. _usageCount=0, _totalSessionsServedCount=2\

default

18:38:35.636895 -0700

rtcreportingd

ownerDecrementUsageCountWithBlock: Usage count for NSURLSession with ID <<private>> is equal to 0. Starting connectivity helper release timer\

default

18:38:35.636930 -0700

rtcreportingd

startConnectivityHelperReleaseTimerWithBlock: started connectivity helper release timer for NSURLSession with ID <<private>>\

default

18:38:35.637301 -0700

rtcreportingd

Task <65AA7EEC-D910-4C6A-8901-0E7B3EDB0F27>.<2> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:35.637434 -0700

rtcreportingd

Task <65AA7EEC-D910-4C6A-8901-0E7B3EDB0F27>.<2> now using Connection 12\

default

18:38:35.637951 -0700

rtcreportingd

Task <65AA7EEC-D910-4C6A-8901-0E7B3EDB0F27>.<2> sent request, body S\

default

18:38:35.637953 -0700

rtcreportingd

didSendBodyData: for <session>:<task> <<private>>:<<private>>: Sent 925 out of 925\

default

18:38:35.666555 -0700

App Store

Task <407418B4-2E69-429B-B457-0BA70736466C>.<4> received response, status 200 content K\

default

18:38:35.666805 -0700

App Store

Task <407418B4-2E69-429B-B457-0BA70736466C>.<4> response ended\

default

18:38:35.666887 -0700

App Store

Task <407418B4-2E69-429B-B457-0BA70736466C>.<4> done using Connection 13\

default

18:38:35.666901 -0700

App Store

AMSURLSession: [D96AABC5] Task received response\

default

18:38:35.667006 -0700

App Store

AMSURLProtocolHandler: [D96AABC5] StatusCode: 200; 2BV73IXX4V5KSBHP5SFUJWY6WE; Environment: ST\

default

18:38:35.667713 -0700

App Store

AMSURLSession: [D96AABC5] Task finished loading\

default

18:38:35.667976 -0700

App Store

AMSURLSession: [D96AABC5] Task completed successfully\

default

18:38:35.668242 -0700

App Store

AMSURLProtocolHandler: [D96AABC5] Recording LoadURL Metrics\

default

18:38:35.668974 -0700

App Store

AMSMetrics: [D96AABC5] Successfully flushed 2 events\

default

18:38:35.731236 -0700

rtcreportingd

Task <65AA7EEC-D910-4C6A-8901-0E7B3EDB0F27>.<2> received response, status 200 content K\

default

18:38:35.731397 -0700

rtcreportingd

Task <65AA7EEC-D910-4C6A-8901-0E7B3EDB0F27>.<2> response ended\

default

18:38:35.731485 -0700

rtcreportingd

didReceiveResponse: for <session>:<task> <<private>>:<<private>>\

default

18:38:35.731499 -0700

rtcreportingd

Task <65AA7EEC-D910-4C6A-8901-0E7B3EDB0F27>.<2> done using Connection 12\

default

18:38:35.731626 -0700

rtcreportingd

didReceiveData: received 2 bytes for <session>:<task> <<private>>:<<private>>\

default

18:38:35.731945 -0700

rtcreportingd

didCompleteWithError: for <session>:<task> <<private>>:<<private>> with response <private>, error (null)\

default

18:38:35.731985 -0700

rtcreportingd

internalFlushMessagesWithCompletion: <private>\

default

18:38:35.732478 -0700

rtcreportingd

writeToLogFile: Saved log message to <private>\

default

18:38:35.732517 -0700

rtcreportingd

ConnectivityHelperTask with ID <<private>> dealloced\

default

18:38:35.999598 -0700

rtcreportingd

TIC TCP Conn Event [12:0x7fd963d18810]: 1\

default

18:38:35.999670 -0700

rtcreportingd

TIC TCP Conn Event [12:0x7fd963d18810]: 8\

default

18:38:35.999728 -0700

rtcreportingd

TIC TLS Handshake Complete [12:0x7fd963d18810]\

default

18:38:36.037019 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(823766827: <NSProgress: 0x6000039401e0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: 0 of 1000 )\

default

18:38:36.253408 -0700

storedownloadd

sending status (Pixelmator): 0.000000% (-1.000000)\

default

18:38:36.254483 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.pixelmatorteam.pixelmator (0.00)\

default

18:38:36.254574 -0700

storedownloadd

sending status (Pixelmator): 0.000000% (-1.000000)\

default

18:38:36.255237 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.pixelmatorteam.pixelmator (0.00)\

default

18:38:36.257389 -0700

storedownloadd

ISStoreURLOperation: Starting URL operation with url=https://p24-buy.itunes.apple.com/WebObjects/MZFastFinance.woa/wa/songDownloadDone?download-id=J24N_C_240047016856128&cancel=1 / bagKey=(null)\

default

18:38:36.259405 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f955e60>: (com.pixelmatorteam.pixelmator, 3.7, 407963104:819930459 VPP:NO source:Spotlight /Applications/Pixelmator.app) using SoftwareMap to upgrade to 3.7.3\

default

18:38:36.259592 -0700

storedownloadd

Download: Download <Download: 0x7fe73e344f30>: com.pixelmatorteam.pixelmator 3.7.3 (407963104) paused:0 failed:0 isInServerQueue:0 is known to be an update when metadata is set\

default

18:38:36.260371 -0700

appstoreagent

[CommerceKitProgress]: Cancelled progress for com.pixelmatorteam.pixelmator\

default

18:38:36.260426 -0700

appstoreagent

[TaskManager]: Removing task for bundleID: com.pixelmatorteam.pixelmator storeItemID: 407963104 isBackground: 0 with result: 100\

error

18:38:36.260508 -0700

appstoreagent

[CommerceKitProgress]: Task for com.pixelmatorteam.pixelmator has failed with reason: 100\

default

18:38:36.260579 -0700

appstoreagent

[ProgressCache]: Canceling progress for bundleID: com.pixelmatorteam.pixelmator\

default

18:38:36.261751 -0700

appstoreagent

[LibraryService]: [755A982D] Starting query for com.apple.AppStore: bundleID IN \{"com.pixelmatorteam.pixelmator"\} AND isStoreApp == 1\

default

18:38:36.261844 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945e735a70>: (com.bananaglue.mac.inet, 2.4.7, 403304796:827262553 VPP:NO source:Spotlight /Applications/iNet Network Scanner.app) using SoftwareMap to upgrade to 2.4.8\

default

18:38:36.262269 -0700

appstoreagent

[LibraryService]: [755A982D] Completed with 1 result: <ASDApp: 0x7fc320400240>: \{bundleID = com.pixelmatorteam.pixelmator; storeItemID = 407963104; storeExternalVersionID = 819930459; installed = 1\}\

default

18:38:36.262561 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(407963104: <BundleID=com.pixelmatorteam.pixelmator, Installed=true, LaunchProhibited=false>)\

default

18:38:36.266187 -0700

storedownloadd

-[ISStoreURLOperation _runURLOperation]: _addStandardQueryParametersForURL: https://p24-buy.itunes.apple.com/WebObjects/MZFastFinance.woa/wa/songDownloadDone?download-id=J24N_C_240047016856128&cancel=1\

default

18:38:36.266588 -0700

storedownloadd

sending status (Pixelmator): 0.000000% (-1.000000)\

default

18:38:36.267349 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.pixelmatorteam.pixelmator (0.00)\

error

18:38:36.267427 -0700

appstoreagent

[ProgressCache]: Failed to set fraction completed: 0.00 for: com.pixelmatorteam.pixelmator\

default

18:38:36.268483 -0700

storedownloadd

ProgressObserver: Using existing app path /Applications/Pixelmator.app to represent download progress\

default

18:38:36.268934 -0700

storedownloadd

ProgressObserver: Finder acknowledged download for com.pixelmatorteam.pixelmator\

default

18:38:36.268996 -0700

storeuid

0x10ba73000 - DocumentLoader::startLoadingMainResource: Returning empty document (frame = 0x10ba72420, main = 1)\

default

18:38:36.269074 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:36.269329 -0700

storeuid

compressed: 0\

default

18:38:36.269702 -0700

storeuid

internal: 23855104\

default

18:38:36.270051 -0700

storeuid

pagecache_page_count: 0\

default

18:38:36.270309 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:36.270508 -0700

storeuid

virtual_size: 4753166336\

default

18:38:36.270701 -0700

storeuid

phys_footprint: 24850432\

default

18:38:36.270895 -0700

storeuid

resident_size: 46964736\

default

18:38:36.270986 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:36.271145 -0700

storeuid

document_count: 1\

default

18:38:36.271352 -0700

storeuid

0x7f9777c09410 - PerformanceMonitor::measureCPUUsageInActivityState: Process is using 39.9% CPU in state: VisibleNonActive\

default

18:38:36.309369 -0700

storeuid

Memory usage info dump at MainFrameLoadStarted:\

default

18:38:36.309402 -0700

storeuid

compressed: 0\

default

18:38:36.309433 -0700

storeuid

internal: 23855104\

default

18:38:36.309462 -0700

storeuid

pagecache_page_count: 0\

default

18:38:36.309490 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:36.309520 -0700

storeuid

virtual_size: 4753166336\

default

18:38:36.309549 -0700

storeuid

phys_footprint: 24850432\

default

18:38:36.309577 -0700

storeuid

resident_size: 46964736\

default

18:38:36.309624 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:36.309668 -0700

storeuid

document_count: 1\

default

18:38:36.309892 -0700

storeuid

0x7f9777c11160 - FrameLoader::prepareForLoadStart: Starting frame load (frame = 0x10ba72420, main = 1)\

default

18:38:36.309974 -0700

storeuid

0x10babf000 - DocumentLoader::startLoadingMainResource: Starting load (frame = 0x10ba72420, main = 1)\

default

18:38:36.310009 -0700

storeuid

0x10babf000 - DocumentLoader::startLoadingMainResource: Returning substitute data (frame = 0x10ba72420, main = 1)\

default

18:38:36.321469 -0700

storedownloadd

Task <91BAE85F-E534-4D66-9A9A-D4DCEF419FF4>.<0> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:36.322083 -0700

storedownloadd

Task <91BAE85F-E534-4D66-9A9A-D4DCEF419FF4>.<0> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:36.322211 -0700

storedownloadd

Task <91BAE85F-E534-4D66-9A9A-D4DCEF419FF4>.<0> now using Connection 37\

default

18:38:36.322422 -0700

storedownloadd

Task <91BAE85F-E534-4D66-9A9A-D4DCEF419FF4>.<0> sent request, body N\

default

18:38:36.324910 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:36.324953 -0700

storeuid

compressed: 0\

default

18:38:36.324985 -0700

storeuid

internal: 23875584\

default

18:38:36.325015 -0700

storeuid

pagecache_page_count: 0\

default

18:38:36.325045 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:36.325074 -0700

storeuid

virtual_size: 4753166336\

default

18:38:36.325104 -0700

storeuid

phys_footprint: 24870912\

default

18:38:36.325133 -0700

storeuid

resident_size: 46964736\

default

18:38:36.325163 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:36.325192 -0700

storeuid

document_count: 2\

default

18:38:36.325239 -0700

storeuid

0x7f9777c11160 - FrameLoader::checkLoadCompleteForThisFrame: Finished frame load (frame = 0x10ba72420, main = 1)\

default

18:38:36.327166 -0700

storeuid

0x10ba70000 - DocumentLoader::startLoadingMainResource: Returning empty document (frame = 0x10ba72738, main = 1)\

default

18:38:36.327235 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:36.327269 -0700

storeuid

compressed: 0\

default

18:38:36.327300 -0700

storeuid

internal: 23875584\

default

18:38:36.327331 -0700

storeuid

pagecache_page_count: 0\

default

18:38:36.327364 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:36.327394 -0700

storeuid

virtual_size: 4753166336\

default

18:38:36.327424 -0700

storeuid

phys_footprint: 24870912\

default

18:38:36.327452 -0700

storeuid

resident_size: 46964736\

default

18:38:36.327482 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:36.327512 -0700

storeuid

document_count: 3\

default

18:38:36.327593 -0700

storeuid

0x7f9778e30950 - PerformanceMonitor::measureCPUUsageInActivityState: Process is using 100.3% CPU in state: VisibleNonActive\

default

18:38:36.340206 -0700

storedownloadd

Task <91BAE85F-E534-4D66-9A9A-D4DCEF419FF4>.<0> received response, status 200 content K\

default

18:38:36.340422 -0700

storedownloadd

Task <91BAE85F-E534-4D66-9A9A-D4DCEF419FF4>.<0> response ended\

default

18:38:36.340550 -0700

storedownloadd

Task <91BAE85F-E534-4D66-9A9A-D4DCEF419FF4>.<0> done using Connection 37\

default

18:38:36.354082 -0700

storeuid

Memory usage info dump at MainFrameLoadStarted:\

default

18:38:36.354120 -0700

storeuid

compressed: 0\

default

18:38:36.354151 -0700

storeuid

internal: 23879680\

default

18:38:36.354181 -0700

storeuid

pagecache_page_count: 0\

default

18:38:36.354212 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:36.354242 -0700

storeuid

virtual_size: 4753166336\

default

18:38:36.354272 -0700

storeuid

phys_footprint: 24875008\

default

18:38:36.354302 -0700

storeuid

resident_size: 46968832\

default

18:38:36.354333 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:36.354363 -0700

storeuid

document_count: 3\

default

18:38:36.354625 -0700

storeuid

0x7f9778e30780 - FrameLoader::prepareForLoadStart: Starting frame load (frame = 0x10ba72738, main = 1)\

default

18:38:36.354696 -0700

storeuid

0x10baa4000 - DocumentLoader::startLoadingMainResource: Starting load (frame = 0x10ba72738, main = 1)\

default

18:38:36.354732 -0700

storeuid

0x10baa4000 - DocumentLoader::startLoadingMainResource: Returning substitute data (frame = 0x10ba72738, main = 1)\

default

18:38:36.356385 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:36.356434 -0700

storeuid

compressed: 0\

default

18:38:36.356467 -0700

storeuid

internal: 23879680\

default

18:38:36.356499 -0700

storeuid

pagecache_page_count: 0\

default

18:38:36.356531 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:36.356569 -0700

storeuid

virtual_size: 4753166336\

default

18:38:36.356606 -0700

storeuid

phys_footprint: 24875008\

default

18:38:36.356636 -0700

storeuid

resident_size: 46968832\

default

18:38:36.356678 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:36.356709 -0700

storeuid

document_count: 4\

default

18:38:36.356797 -0700

storeuid

0x7f9778e30780 - FrameLoader::checkLoadCompleteForThisFrame: Finished frame load (frame = 0x10ba72738, main = 1)\

default

18:38:37.186685 -0700

storedownloadd

sending status (OneDrive): 0.000000% (-1.000000)\

default

18:38:37.187493 -0700

storedownloadd

sending status (OneDrive): 0.000000% (-1.000000)\

default

18:38:37.187517 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.microsoft.OneDrive-mac (0.00)\

default

18:38:37.188559 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.microsoft.OneDrive-mac (0.00)\

default

18:38:37.190647 -0700

storedownloadd

ISStoreURLOperation: Starting URL operation with url=https://p24-buy.itunes.apple.com/WebObjects/MZFastFinance.woa/wa/songDownloadDone?download-id=J24N_C_240047016856042&cancel=1 / bagKey=(null)\

default

18:38:37.192721 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945f81b450>: (com.microsoft.OneDrive-mac, 18.065.0329, 823766827:826917933 VPP:NO source:Spotlight /Applications/OneDrive.app) using SoftwareMap to upgrade to 18.091.0506\

default

18:38:37.192907 -0700

storedownloadd

Download: Download <Download: 0x7fe73eb91f60>: com.microsoft.OneDrive-mac 18.091.0506 (823766827) paused:0 failed:0 isInServerQueue:0 is known to be an update when metadata is set\

default

18:38:37.193876 -0700

appstoreagent

[CommerceKitProgress]: Cancelled progress for com.microsoft.OneDrive-mac\

default

18:38:37.193965 -0700

appstoreagent

[TaskManager]: Removing task for bundleID: com.microsoft.OneDrive-mac storeItemID: 823766827 isBackground: 0 with result: 100\

error

18:38:37.194056 -0700

appstoreagent

[CommerceKitProgress]: Task for com.microsoft.OneDrive-mac has failed with reason: 100\

default

18:38:37.194151 -0700

appstoreagent

[ProgressCache]: Canceling progress for bundleID: com.microsoft.OneDrive-mac\

default

18:38:37.195372 -0700

appstoreagent

[LibraryService]: [52DFDB82] Starting query for com.apple.AppStore: bundleID IN \{"com.microsoft.OneDrive-mac"\} AND isStoreApp == 1\

default

18:38:37.195847 -0700

appstoreagent

[LibraryService]: [52DFDB82] Completed with 1 result: <ASDApp: 0x7fc31dd64270>: \{bundleID = com.microsoft.OneDrive-mac; storeItemID = 823766827; storeExternalVersionID = 826917933; installed = 1\}\

default

18:38:37.196144 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(823766827: <BundleID=com.microsoft.OneDrive-mac, Installed=true, LaunchProhibited=false>)\

default

18:38:37.199338 -0700

storedownloadd

-[ISStoreURLOperation _runURLOperation]: _addStandardQueryParametersForURL: https://p24-buy.itunes.apple.com/WebObjects/MZFastFinance.woa/wa/songDownloadDone?download-id=J24N_C_240047016856042&cancel=1\

default

18:38:37.200385 -0700

storedownloadd

sending status (OneDrive): 0.000000% (-1.000000)\

default

18:38:37.201131 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.microsoft.OneDrive-mac (0.00)\

error

18:38:37.201272 -0700

appstoreagent

[ProgressCache]: Failed to set fraction completed: 0.00 for: com.microsoft.OneDrive-mac\

default

18:38:37.202379 -0700

storedownloadd

ProgressObserver: Using existing app path /Applications/OneDrive.app to represent download progress\

default

18:38:37.202807 -0700

storedownloadd

ProgressObserver: Finder acknowledged download for com.microsoft.OneDrive-mac\

default

18:38:37.251653 -0700

storedownloadd

Task <58679CC4-6DED-479C-AF7A-F836DD2A71AA>.<0> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:37.252402 -0700

storedownloadd

Task <58679CC4-6DED-479C-AF7A-F836DD2A71AA>.<0> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:37.252559 -0700

storedownloadd

Task <58679CC4-6DED-479C-AF7A-F836DD2A71AA>.<0> now using Connection 37\

default

18:38:37.252785 -0700

storedownloadd

Task <58679CC4-6DED-479C-AF7A-F836DD2A71AA>.<0> sent request, body N\

default

18:38:37.274999 -0700

storedownloadd

Task <58679CC4-6DED-479C-AF7A-F836DD2A71AA>.<0> received response, status 200 content K\

default

18:38:37.275140 -0700

storedownloadd

Task <58679CC4-6DED-479C-AF7A-F836DD2A71AA>.<0> response ended\

default

18:38:37.275257 -0700

storedownloadd

Task <58679CC4-6DED-479C-AF7A-F836DD2A71AA>.<0> done using Connection 37\

default

18:38:37.978070 -0700

storedownloadd

SSDownloadAsset caching-server-locator-timeout 10\

default

18:38:37.979546 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73e2de6f0>: Initializing MD5 context\

default

18:38:37.979638 -0700

storedownloadd

AssetDownloadOperation: Using delta package.\

default

18:38:37.979981 -0700

storedownloadd

ISStoreURLOperation: Starting URL operation with url=http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ef/8b/fc/ef8bfcb7-3a66-9731-e987-e14bd9baa353/mzps6634698879297104887.pkg / bagKey=(null)\

default

18:38:37.980030 -0700

storedownloadd

-[ISStoreURLOperation _runURLOperation]: _addStandardQueryParametersForURL: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ef/8b/fc/ef8bfcb7-3a66-9731-e987-e14bd9baa353/mzps6634698879297104887.pkg\

default

18:38:38.006157 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73e2de6f0>: Opening file /var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/403304796/czs2797760201626123230.pkg returning file descriptor 10 (0 streamed)\

default

18:38:38.016241 -0700

storedownloadd

TIC TCP Conn Start [45:0x7fe74b801590]\

default

18:38:38.016391 -0700

storedownloadd

[C45 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ef/8b/fc/ef8bfcb7-3a66-9731-e987-e14bd9baa353/mzps66346988792] start\

default

18:38:38.016781 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C45] reporting state preparing\

default

18:38:38.019963 -0700

storedownloadd

Task <573621E5-8D9C-4D22-A461-708EB0233655>.<0> setting up Connection 45\

default

18:38:38.035397 -0700

storedownloadd

nw_socket_handle_socket_event [C45.1:2] Socket received CONNECTED event\

default

18:38:38.035499 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C45.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Transport protocol connected\

default

18:38:38.035654 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C45.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Output protocol connected\

default

18:38:38.035829 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C45] reporting state ready\

default

18:38:38.036019 -0700

storedownloadd

TIC TCP Conn Connected [45:0x7fe74b801590]: Err(16)\

default

18:38:38.036128 -0700

storedownloadd

TIC TCP Conn Event [45:0x7fe74b801590]: 1\

default

18:38:38.036878 -0700

storedownloadd

Task <573621E5-8D9C-4D22-A461-708EB0233655>.<0> now using Connection 45\

default

18:38:38.037039 -0700

storedownloadd

Task <573621E5-8D9C-4D22-A461-708EB0233655>.<0> sent request, body N\

default

18:38:38.061577 -0700

storedownloadd

Task <573621E5-8D9C-4D22-A461-708EB0233655>.<0> received response, status 200 content K\

default

18:38:38.062606 -0700

storedownloadd

sending status (iNet Network Scanner): 0.000000% (0.000000)\

default

18:38:38.063215 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.bananaglue.mac.inet (0.00)\

default

18:38:38.063540 -0700

storedownloadd

AssetDownloadOperation: Subtracted 0 already-downloaded bytes from required space (now requires 2051144 bytes)\

default

18:38:38.063723 -0700

storedownloadd

sending status (iNet Network Scanner): 0.000000% (-1.000000)\

default

18:38:38.064291 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.bananaglue.mac.inet (0.00)\

default

18:38:38.066770 -0700

storedownloadd

HashedDownloadProvider: Failed to initialize decryption session with error -42076\

default

18:38:38.067006 -0700

storedownloadd

TIC TCP Conn Cancel [45:0x7fe74b801590]\

default

18:38:38.067020 -0700

storedownloadd

ISStoreURLOperation: Chose not to retry after error: Error Domain=ISErrorDomain Code=7 "Unknown Error." UserInfo=\{NSLocalizedDescription=Unknown Error.\}\

default

18:38:38.067114 -0700

storedownloadd

[C45 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ef/8b/fc/ef8bfcb7-3a66-9731-e987-e14bd9baa353/mzps66346988792] cancel\

default

18:38:38.067157 -0700

storedownloadd

AssetDownloadOperation: Delta package download failed, falling back to full package\

default

18:38:38.067197 -0700

storedownloadd

AssetDownloadOperation: Asset download cancelled/failed. Will do retry #1? 1\

default

18:38:38.067248 -0700

storedownloadd

[C45 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ef/8b/fc/ef8bfcb7-3a66-9731-e987-e14bd9baa353/mzps66346988792] cancelled\

default

18:38:38.067264 -0700

storedownloadd

#57090b76 ACSLocateCachingServer(assetURL=http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ff/07/7c/ff077c1d-9d48-29b0-2d5a-46e4d3242d75/czs2797760201626123230.pkg, locateTimeout=10.000, options=(null), callbackQueue=0x0, callback=0x70000455b238)\

default

18:38:38.067285 -0700

storedownloadd

0.000s [C45 FC92B539-1A46-41F7-A908-9F386EA69B43 Hostname#1784b493:80 resolver] path:start\

default

18:38:38.067327 -0700

storedownloadd

0.000s [C45 FC92B539-1A46-41F7-A908-9F386EA69B43 Hostname#1784b493:80 resolver] path:satisfied\

default

18:38:38.067354 -0700

storedownloadd

0.000s [C45 FC92B539-1A46-41F7-A908-9F386EA69B43 Hostname#1784b493:80 resolver] resolver:start_dns\

default

18:38:38.067381 -0700

storedownloadd

0.004s [C45 FC92B539-1A46-41F7-A908-9F386EA69B43 Hostname#1784b493:80 resolver] resolver:receive_dns\

default

18:38:38.067409 -0700

storedownloadd

0.004s [C45.1 DBF266FF-9695-4B7C-9746-5E30C93F42F9 10.0.1.2:58044<->IPv4#cbadfac4:80 socket-flow] path:start\

default

18:38:38.067436 -0700

storedownloadd

0.004s [C45.1 DBF266FF-9695-4B7C-9746-5E30C93F42F9 10.0.1.2:58044<->IPv4#cbadfac4:80 socket-flow] path:satisfied\

default

18:38:38.067462 -0700

storedownloadd

0.005s [C45.1 DBF266FF-9695-4B7C-9746-5E30C93F42F9 10.0.1.2:58044<->IPv4#cbadfac4:80 socket-flow] flow:start_connect\

default

18:38:38.067486 -0700

storedownloadd

0.019s [C45.1 DBF266FF-9695-4B7C-9746-5E30C93F42F9 10.0.1.2:58044<->IPv4#cbadfac4:80 socket-flow] flow:finish_transport\

default

18:38:38.067511 -0700

storedownloadd

0.019s [C45 FC92B539-1A46-41F7-A908-9F386EA69B43 Hostname#1784b493:80 resolver] flow:finish_transport\

default

18:38:38.067537 -0700

storedownloadd

0.019s [C45.1 DBF266FF-9695-4B7C-9746-5E30C93F42F9 10.0.1.2:58044<->IPv4#cbadfac4:80 socket-flow] flow:finish_connect\

default

18:38:38.067562 -0700

storedownloadd

0.019s [C45 FC92B539-1A46-41F7-A908-9F386EA69B43 Hostname#1784b493:80 resolver] flow:finish_connect\

default

18:38:38.067636 -0700

storedownloadd

0.019s [C45.1 DBF266FF-9695-4B7C-9746-5E30C93F42F9 10.0.1.2:58044<->IPv4#cbadfac4:80 socket-flow] flow:changed_viability\

default

18:38:38.067701 -0700

storedownloadd

0.019s [C45 FC92B539-1A46-41F7-A908-9F386EA69B43 Hostname#1784b493:80 resolver] flow:changed_viability\

default

18:38:38.067792 -0700

storedownloadd

0.050s [C45] path:cancel\

default

18:38:38.068132 -0700

storedownloadd

nw_endpoint_flow_protocol_disconnected [C45.1 IPv4#cbadfac4:80 cancelled socket-flow (null)] Output protocol disconnected\

default

18:38:38.068351 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C45] reporting state cancelled\

default

18:38:38.068399 -0700

storedownloadd

Task <573621E5-8D9C-4D22-A461-708EB0233655>.<0> done using Connection 45\

default

18:38:38.068499 -0700

storedownloadd

TIC TCP Conn Destroyed [45:0x7fe74b801590]\

error

18:38:38.068585 -0700

storedownloadd

TIC Read Status [45:0x0]: 1:57\

default

18:38:38.068780 -0700

AssetCacheLocatorService

#57090b76 [AssetCacheLocatorService.queue] early hit: no caching servers\

default

18:38:38.069109 -0700

storedownloadd

#57090b76 ACSLocateCachingServer -> [new] newURL (null), advice (null), error (null), elapsed 0.002/10.000\

default

18:38:38.069204 -0700

storedownloadd

AssetDownloadOperation no modified URL for http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ff/07/7c/ff077c1d-9d48-29b0-2d5a-46e4d3242d75/czs2797760201626123230.pkg\

default

18:38:38.069489 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73ec20390>: Initializing MD5 context\

default

18:38:38.069588 -0700

storedownloadd

delta update failed, trying full package\

default

18:38:38.069897 -0700

storedownloadd

ISStoreURLOperation: Starting URL operation with url=http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ff/07/7c/ff077c1d-9d48-29b0-2d5a-46e4d3242d75/czs2797760201626123230.pkg / bagKey=(null)\

default

18:38:38.069947 -0700

storedownloadd

-[ISStoreURLOperation _runURLOperation]: _addStandardQueryParametersForURL: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ff/07/7c/ff077c1d-9d48-29b0-2d5a-46e4d3242d75/czs2797760201626123230.pkg\

default

18:38:38.096103 -0700

storedownloadd

<HashedDownloadProvider: 0x7fe73ec20390>: Opening file /var/folders/6z/lf1xkdhs6nzclqlp3g9675lm0000gn/C/com.apple.appstore/403304796/czs2797760201626123230.pkg returning file descriptor 11 (0 streamed)\

default

18:38:38.106192 -0700

storedownloadd

TIC TCP Conn Start [46:0x7fe73ebc4050]\

default

18:38:38.106340 -0700

storedownloadd

[C46 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ff/07/7c/ff077c1d-9d48-29b0-2d5a-46e4d3242d75/czs279776020162] start\

default

18:38:38.106753 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C46] reporting state preparing\

default

18:38:38.109812 -0700

storedownloadd

Task <36346175-1FC6-4456-B01A-73B1B6C4D1D9>.<0> setting up Connection 46\

default

18:38:38.125830 -0700

storedownloadd

nw_socket_handle_socket_event [C46.1:2] Socket received CONNECTED event\

default

18:38:38.125946 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C46.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Transport protocol connected\

default

18:38:38.126127 -0700

storedownloadd

nw_endpoint_flow_protocol_connected [C46.1 IPv4#cbadfac4:80 in_progress socket-flow (satisfied)] Output protocol connected\

default

18:38:38.126350 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C46] reporting state ready\

default

18:38:38.126683 -0700

storedownloadd

TIC TCP Conn Connected [46:0x7fe73ebc4050]: Err(16)\

default

18:38:38.126829 -0700

storedownloadd

TIC TCP Conn Event [46:0x7fe73ebc4050]: 1\

default

18:38:38.127680 -0700

storedownloadd

Task <36346175-1FC6-4456-B01A-73B1B6C4D1D9>.<0> now using Connection 46\

default

18:38:38.127839 -0700

storedownloadd

Task <36346175-1FC6-4456-B01A-73B1B6C4D1D9>.<0> sent request, body N\

default

18:38:38.160410 -0700

storedownloadd

Task <36346175-1FC6-4456-B01A-73B1B6C4D1D9>.<0> received response, status 200 content K\

default

18:38:38.161455 -0700

storedownloadd

sending status (iNet Network Scanner): 0.000000% (-1.000000)\

default

18:38:38.162112 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.bananaglue.mac.inet (0.00)\

default

18:38:38.162257 -0700

storedownloadd

AssetDownloadOperation: Subtracted 0 already-downloaded bytes from required space (now requires 72047670 bytes)\

default

18:38:38.162415 -0700

storedownloadd

sending status (iNet Network Scanner): 0.000000% (-1.000000)\

default

18:38:38.162994 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.bananaglue.mac.inet (0.00)\

default

18:38:38.165798 -0700

storedownloadd

HashedDownloadProvider: Failed to initialize decryption session with error -42076\

default

18:38:38.166043 -0700

storedownloadd

ISStoreURLOperation: Chose not to retry after error: Error Domain=ISErrorDomain Code=7 "Unknown Error." UserInfo=\{NSLocalizedDescription=Unknown Error.\}\

default

18:38:38.166047 -0700

storedownloadd

TIC TCP Conn Cancel [46:0x7fe73ebc4050]\

default

18:38:38.166144 -0700

storedownloadd

[C46 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ff/07/7c/ff077c1d-9d48-29b0-2d5a-46e4d3242d75/czs279776020162] cancel\

default

18:38:38.166166 -0700

storedownloadd

AssetDownloadOperation: Asset download cancelled/failed. Will do retry #2? 0\

default

18:38:38.166277 -0700

storedownloadd

ProgressObserver: Unlocking app at /Applications/iNet Network Scanner.app\

default

18:38:38.166281 -0700

storedownloadd

[C46 Hostname#1784b493:80 tcp, url: http://osxapps.itunes.apple.com/itunes-assets/Purple125/v4/ff/07/7c/ff077c1d-9d48-29b0-2d5a-46e4d3242d75/czs279776020162] cancelled\

default

18:38:38.166321 -0700

storedownloadd

0.000s [C46 D556CD18-79BC-4FE8-BCE0-898B36433079 Hostname#1784b493:80 resolver] path:start\

default

18:38:38.166348 -0700

storedownloadd

0.000s [C46 D556CD18-79BC-4FE8-BCE0-898B36433079 Hostname#1784b493:80 resolver] path:satisfied\

default

18:38:38.166374 -0700

storedownloadd

0.000s [C46 D556CD18-79BC-4FE8-BCE0-898B36433079 Hostname#1784b493:80 resolver] resolver:start_dns\

default

18:38:38.166393 -0700

storedownloadd

DownloadOperation: Download failed with error: Error Domain=ISErrorDomain Code=7 "Unknown Error." UserInfo=\{NSLocalizedDescription=Unknown Error.\}\

default

18:38:38.166400 -0700

storedownloadd

0.004s [C46 D556CD18-79BC-4FE8-BCE0-898B36433079 Hostname#1784b493:80 resolver] resolver:receive_dns\

default

18:38:38.166435 -0700

storedownloadd

0.004s [C46.1 10BEF4A6-5739-4DDF-B71E-0577DB8C07E2 10.0.1.2:58045<->IPv4#cbadfac4:80 socket-flow] path:start\

default

18:38:38.166462 -0700

storedownloadd

0.004s [C46.1 10BEF4A6-5739-4DDF-B71E-0577DB8C07E2 10.0.1.2:58045<->IPv4#cbadfac4:80 socket-flow] path:satisfied\

default

18:38:38.166506 -0700

storedownloadd

0.005s [C46.1 10BEF4A6-5739-4DDF-B71E-0577DB8C07E2 10.0.1.2:58045<->IPv4#cbadfac4:80 socket-flow] flow:start_connect\

default

18:38:38.166535 -0700

storedownloadd

0.019s [C46.1 10BEF4A6-5739-4DDF-B71E-0577DB8C07E2 10.0.1.2:58045<->IPv4#cbadfac4:80 socket-flow] flow:finish_transport\

default

18:38:38.166560 -0700

storedownloadd

0.019s [C46 D556CD18-79BC-4FE8-BCE0-898B36433079 Hostname#1784b493:80 resolver] flow:finish_transport\

default

18:38:38.166586 -0700

storedownloadd

0.019s [C46.1 10BEF4A6-5739-4DDF-B71E-0577DB8C07E2 10.0.1.2:58045<->IPv4#cbadfac4:80 socket-flow] flow:finish_connect\

default

18:38:38.166637 -0700

storedownloadd

0.020s [C46 D556CD18-79BC-4FE8-BCE0-898B36433079 Hostname#1784b493:80 resolver] flow:finish_connect\

default

18:38:38.166649 -0700

ReceiptInstaller

ReceiptDispatch: unlocked application at path /Applications/iNet Network Scanner.app\

default

18:38:38.166686 -0700

storedownloadd

0.020s [C46.1 10BEF4A6-5739-4DDF-B71E-0577DB8C07E2 10.0.1.2:58045<->IPv4#cbadfac4:80 socket-flow] flow:changed_viability\

default

18:38:38.166732 -0700

storedownloadd

0.020s [C46 D556CD18-79BC-4FE8-BCE0-898B36433079 Hostname#1784b493:80 resolver] flow:changed_viability\

default

18:38:38.166778 -0700

storedownloadd

0.059s [C46] path:cancel\

default

18:38:38.167196 -0700

storedownloadd

nw_endpoint_flow_protocol_disconnected [C46.1 IPv4#cbadfac4:80 cancelled socket-flow (null)] Output protocol disconnected\

default

18:38:38.167369 -0700

storedownloadd

nw_connection_report_state_with_handler_locked [C46] reporting state cancelled\

default

18:38:38.167419 -0700

storedownloadd

Task <36346175-1FC6-4456-B01A-73B1B6C4D1D9>.<0> done using Connection 46\

default

18:38:38.167525 -0700

storedownloadd

TIC TCP Conn Destroyed [46:0x7fe73ebc4050]\

error

18:38:38.167650 -0700

storedownloadd

TIC Read Status [46:0x0]: 1:57\

default

18:38:38.167859 -0700

storedownloadd

startLogging: Client starts logging...\

default

18:38:38.168621 -0700

rtcreportingd

listener: Accepting new XPC connection <private> as it has proper entitlement, 1(0) connections.\

default

18:38:38.168746 -0700

rtcreportingd

initWithSessionDelegate: ReportingdSession initWithSessionDelegate:<private>\

default

18:38:38.168889 -0700

rtcreportingd

initWithSessionDelegate: Initialized session with UUID <private>\

default

18:38:38.168920 -0700

rtcreportingd

createReportingSessionWithDelegate: retained XPC Transaction. Ref count is 4\

default

18:38:38.169123 -0700

rtcreportingd

setSessionInfo: Configuring session 1264437288\

default

18:38:38.169149 -0700

rtcreportingd

updateCorrelatedSessions: Session 1264437288 has no correlated sessions as it is a standalone session\

default

18:38:38.169186 -0700

rtcreportingd

requestSharedConnectivityHelperForReportingSession: Requesting shared connectivity helper for userInfoKey <private>\

default

18:38:38.169215 -0700

rtcreportingd

requestSharedConnectivityHelperForReportingSession: Found existing shared connectivity helper for userInfoKey <private>\

default

18:38:38.169240 -0700

rtcreportingd

requestSharedConnectivityHelperForReportingSession: Incrementing usage of shared connectivity helper for userInfoKey <private>\

default

18:38:38.169307 -0700

rtcreportingd

stopConnectivityHelperReleaseTimer: stopping connectivity helper release timer for NSURLSession with ID <<private>>\

default

18:38:38.169330 -0700

rtcreportingd

startConfigWithCompletionHandler: Starting configuration for session 1264437288\

default

18:38:38.169347 -0700

rtcreportingd

ownerIncrementUsageCount: connectivity helper incremented usage count for NSURLSession with ID <<private>>. _usageCount=1, _totalSessionsServedCount=2\

default

18:38:38.169384 -0700

rtcreportingd

storebagForSession: Retrieving storebag for session 1264437288 with client type 12\

default

18:38:38.169920 -0700

rtcreportingd

storebagForSession: Cached storebag found for client type 12\

default

18:38:38.169955 -0700

rtcreportingd

createBackendsWithStorebag: Creating backends for session 1264437288\

default

18:38:38.170834 -0700

rtcreportingd

reading _CRCopyDiagnosticMessagesHistoryValue key SeedAutoSubmit-#45 (stat 0: 238964)\

default

18:38:38.174693 -0700

rtcreportingd

reading _CRCopyDiagnosticMessagesHistoryValue key AutoSubmit-#46 (stat 0: 238964)\

default

18:38:38.178479 -0700

rtcreportingd

SeedAutoSubmitPreference is 1 via AutoSubmitPreferenceKey\

default

18:38:38.178617 -0700

rtcreportingd

getPersistentIdentifierForDNU: The value for uuidRespectDNU: <private>\

default

18:38:38.178697 -0700

rtcreportingd

getPersistentIdentifierForDNU: The value for uuidOverrideDNU: <private>\

default

18:38:38.178851 -0700

rtcreportingd

resetBackendStateWithClient: event_threshold set to 50\

default

18:38:38.178879 -0700

rtcreportingd

setBackendStateWithClient: extras on internal is set to 0\

default

18:38:38.178907 -0700

rtcreportingd

HTTPSPostBackend(updateBackendState): <private>: client found <private>:<private>, state=2, samplingFactor=0.113900\

default

18:38:38.178934 -0700

rtcreportingd

HTTPSPostBackend(updatePostLink): Storebag '<private>' for postURL\

default

18:38:38.178960 -0700

rtcreportingd

HTTPSPostBackend(updatePostLink): realtimePostURL defaults to postURL '<private>'\

default

18:38:38.179065 -0700

rtcreportingd

activate: activating connectivity helper for NSURLSession with ID <<private>>\

default

18:38:38.179217 -0700

rtcreportingd

activate: connectivity helper is already active for NSURLSession with ID <<private>>\

default

18:38:38.179648 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): realtime is 0\

default

18:38:38.179680 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Batching 2, 1, 1\

default

18:38:38.179721 -0700

rtcreportingd

internalSendMessage: Sent internal message (method:0 respCode:0)\

default

18:38:38.179892 -0700

rtcreportingd

fetchDisplayURL: Fetching display URL for session 1264437288\

default

18:38:38.179974 -0700

storedownloadd

Cached 1 enabled backends, ((null), (null)) listed events\

default

18:38:38.180030 -0700

storedownloadd

Message Sent Delegate reads 0:\

default

18:38:38.180324 -0700

rtcreportingd

sendMessageWithDictionary: Sending message for session 1264437288\

default

18:38:38.180401 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): realtime is 0\

default

18:38:38.180430 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Batching 2, 1, 1\

default

18:38:38.180596 -0700

storedownloadd

sendMessageWithDictionary: (null)\

default

18:38:38.180636 -0700

storedownloadd

aboutToDealloc: RTCReporting client session 0x7fe73e12c130 is about to dealloc\

default

18:38:38.180742 -0700

storedownloadd

initWithSessionInfo: XPC connection invalidated\

default

18:38:38.180747 -0700

rtcreportingd

finishSessionGracefully: Session 1264437288 has been finished gracefully\

default

18:38:38.180857 -0700

rtcreportingd

listener: XPC connection to <private> was invalidated\

default

18:38:38.180892 -0700

rtcreportingd

invalidateReportingSession: ReportingdSession <private> was invalidated\

default

18:38:38.181237 -0700

rtcreportingd

dealloc: ReportingdSession dealloc: 1264437288\

default

18:38:38.181609 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Adding dnu type and sampling threshold to SESSION_TYPE_STOP message dictionary\

default

18:38:38.181662 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): realtime is 0\

default

18:38:38.181759 -0700

rtcreportingd

HTTPSPostBackend(sendMessage): Batching 2, 1, 1\

default

18:38:38.181960 -0700

rtcreportingd

internalSendMessage: Sent internal message (method:0 respCode:1)\

default

18:38:38.182100 -0700

rtcreportingd

flushMessagesWithCompletion: Flushing messages for session 1264437288\

default

18:38:38.182278 -0700

rtcreportingd

HTTPSPostBackend(flushMessagesWithCompletion): called\

default

18:38:38.182557 -0700

rtcreportingd

userDefaultsEnvironment: Environment type 3\

default

18:38:38.182901 -0700

rtcreportingd

compressDataWithZlibOrGzip: Compressed file from 2409 to 927\

default

18:38:38.183018 -0700

rtcreportingd

shutdownSessionAggregation: Disable aggregation module for session 1264437288\

default

18:38:38.183048 -0700

rtcreportingd

ReportingdSession dealloc: incrementing total sessions count for session 1264437288\

default

18:38:38.183116 -0700

rtcreportingd

Total Sessions Served Count is incremented for NSURLSession with ID <<private>>\

default

18:38:38.183124 -0700

rtcreportingd

ConnectivityHelperTask with ID <<private>> created\

default

18:38:38.183300 -0700

rtcreportingd

releaseSharedConnectivityHelperForReportingSession: Releasing shared connectivity helper for userInfoKey <private>\

default

18:38:38.183391 -0700

rtcreportingd

createHelperForTask: created helperTask for task <<private>>\

default

18:38:38.183565 -0700

rtcreportingd

releaseSharedConnectivityHelperForReportingSession: Decrementing usage count of shared connectivity helper for userInfoKey <private>\

default

18:38:38.183943 -0700

rtcreportingd

ownerDecrementUsageCountWithBlock: connectivity helper decremented usage count for NSURLSession with ID <<private>>. _usageCount=0, _totalSessionsServedCount=3\

default

18:38:38.184094 -0700

rtcreportingd

ownerDecrementUsageCountWithBlock: Usage count for NSURLSession with ID <<private>> is equal to 0. Starting connectivity helper release timer\

default

18:38:38.184281 -0700

rtcreportingd

startConnectivityHelperReleaseTimerWithBlock: started connectivity helper release timer for NSURLSession with ID <<private>>\

default

18:38:38.184368 -0700

rtcreportingd

Task <A4C9B65C-B48C-46AA-8BA4-D5152E1F7A2D>.<3> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:38.184719 -0700

rtcreportingd

Task <A4C9B65C-B48C-46AA-8BA4-D5152E1F7A2D>.<3> now using Connection 12\

default

18:38:38.185183 -0700

rtcreportingd

Task <A4C9B65C-B48C-46AA-8BA4-D5152E1F7A2D>.<3> sent request, body S\

default

18:38:38.185198 -0700

rtcreportingd

didSendBodyData: for <session>:<task> <<private>>:<<private>>: Sent 927 out of 927\

default

18:38:38.186163 -0700

storeuid

0x10ba67000 - DocumentLoader::startLoadingMainResource: Returning empty document (frame = 0x10ba72a50, main = 1)\

default

18:38:38.186238 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:38.186274 -0700

storeuid

compressed: 0\

default

18:38:38.186305 -0700

storeuid

internal: 23887872\

default

18:38:38.186336 -0700

storeuid

pagecache_page_count: 0\

default

18:38:38.186366 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:38.186397 -0700

storeuid

virtual_size: 4754214912\

default

18:38:38.186427 -0700

storeuid

phys_footprint: 24883200\

default

18:38:38.186457 -0700

storeuid

resident_size: 47005696\

default

18:38:38.186486 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:38.186593 -0700

storeuid

document_count: 1\

default

18:38:38.186836 -0700

storeuid

0x7f9778d1faa0 - PerformanceMonitor::measureCPUUsageInActivityState: Process is using 88.4% CPU in state: VisibleNonActive\

default

18:38:38.217874 -0700

storeuid

Memory usage info dump at MainFrameLoadStarted:\

default

18:38:38.217911 -0700

storeuid

compressed: 0\

default

18:38:38.217941 -0700

storeuid

internal: 23887872\

default

18:38:38.217983 -0700

storeuid

pagecache_page_count: 0\

default

18:38:38.218016 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:38.218046 -0700

storeuid

virtual_size: 4754214912\

default

18:38:38.218076 -0700

storeuid

phys_footprint: 24883200\

default

18:38:38.218107 -0700

storeuid

resident_size: 47005696\

default

18:38:38.218137 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:38.218168 -0700

storeuid

document_count: 1\

default

18:38:38.218401 -0700

storeuid

0x7f9778d02030 - FrameLoader::prepareForLoadStart: Starting frame load (frame = 0x10ba72a50, main = 1)\

default

18:38:38.218491 -0700

storeuid

0x10baeb000 - DocumentLoader::startLoadingMainResource: Starting load (frame = 0x10ba72a50, main = 1)\

default

18:38:38.218535 -0700

storeuid

0x10baeb000 - DocumentLoader::startLoadingMainResource: Returning substitute data (frame = 0x10ba72a50, main = 1)\

default

18:38:38.232637 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:38.232683 -0700

storeuid

compressed: 0\

default

18:38:38.232717 -0700

storeuid

internal: 23908352\

default

18:38:38.232747 -0700

storeuid

pagecache_page_count: 0\

default

18:38:38.232780 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:38.232811 -0700

storeuid

virtual_size: 4754214912\

default

18:38:38.232841 -0700

storeuid

phys_footprint: 24903680\

default

18:38:38.232872 -0700

storeuid

resident_size: 47005696\

default

18:38:38.232903 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:38.232933 -0700

storeuid

document_count: 2\

default

18:38:38.232980 -0700

storeuid

0x7f9778d02030 - FrameLoader::checkLoadCompleteForThisFrame: Finished frame load (frame = 0x10ba72a50, main = 1)\

default

18:38:38.234941 -0700

storeuid

0x10baeb000 - DocumentLoader::startLoadingMainResource: Returning empty document (frame = 0x10ba72d68, main = 1)\

default

18:38:38.235009 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:38.235045 -0700

storeuid

compressed: 0\

default

18:38:38.235076 -0700

storeuid

internal: 23908352\

default

18:38:38.235108 -0700

storeuid

pagecache_page_count: 0\

default

18:38:38.235139 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:38.235169 -0700

storeuid

virtual_size: 4754214912\

default

18:38:38.235200 -0700

storeuid

phys_footprint: 24903680\

default

18:38:38.235231 -0700

storeuid

resident_size: 47005696\

default

18:38:38.235262 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:38.235293 -0700

storeuid

document_count: 3\

default

18:38:38.235375 -0700

storeuid

0x7f9777f5d8a0 - PerformanceMonitor::measureCPUUsageInActivityState: Process is using 100.3% CPU in state: VisibleNonActive\

default

18:38:38.258026 -0700

storeuid

Memory usage info dump at MainFrameLoadStarted:\

default

18:38:38.258064 -0700

storeuid

compressed: 0\

default

18:38:38.258096 -0700

storeuid

internal: 23908352\

default

18:38:38.258137 -0700

storeuid

pagecache_page_count: 0\

default

18:38:38.258176 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:38.258208 -0700

storeuid

virtual_size: 4754214912\

default

18:38:38.258239 -0700

storeuid

phys_footprint: 24903680\

default

18:38:38.258270 -0700

storeuid

resident_size: 47005696\

default

18:38:38.258301 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:38.258331 -0700

storeuid

document_count: 3\

default

18:38:38.258494 -0700

storeuid

0x7f9777f5d6d0 - FrameLoader::prepareForLoadStart: Starting frame load (frame = 0x10ba72d68, main = 1)\

default

18:38:38.258559 -0700

storeuid

0x10ba79000 - DocumentLoader::startLoadingMainResource: Starting load (frame = 0x10ba72d68, main = 1)\

default

18:38:38.258594 -0700

storeuid

0x10ba79000 - DocumentLoader::startLoadingMainResource: Returning substitute data (frame = 0x10ba72d68, main = 1)\

default

18:38:38.260010 -0700

storeuid

Memory usage info dump at MainFrameLoadCompleted:\

default

18:38:38.260051 -0700

storeuid

compressed: 0\

default

18:38:38.260083 -0700

storeuid

internal: 23912448\

default

18:38:38.260116 -0700

storeuid

pagecache_page_count: 0\

default

18:38:38.260147 -0700

storeuid

javascript_gc_heap_extra_memory_size: 0\

default

18:38:38.260179 -0700

storeuid

virtual_size: 4754214912\

default

18:38:38.260210 -0700

storeuid

phys_footprint: 24907776\

default

18:38:38.260239 -0700

storeuid

resident_size: 47005696\

default

18:38:38.260270 -0700

storeuid

javascript_gc_heap_capacity: 65536\

default

18:38:38.260300 -0700

storeuid

document_count: 4\

default

18:38:38.260348 -0700

storeuid

0x7f9777f5d6d0 - FrameLoader::checkLoadCompleteForThisFrame: Finished frame load (frame = 0x10ba72d68, main = 1)\

default

18:38:38.272721 -0700

rtcreportingd

Task <A4C9B65C-B48C-46AA-8BA4-D5152E1F7A2D>.<3> received response, status 200 content K\

default

18:38:38.272891 -0700

rtcreportingd

Task <A4C9B65C-B48C-46AA-8BA4-D5152E1F7A2D>.<3> response ended\

default

18:38:38.272979 -0700

rtcreportingd

Task <A4C9B65C-B48C-46AA-8BA4-D5152E1F7A2D>.<3> done using Connection 12\

default

18:38:38.273039 -0700

rtcreportingd

didReceiveResponse: for <session>:<task> <<private>>:<<private>>\

default

18:38:38.273164 -0700

rtcreportingd

didReceiveData: received 2 bytes for <session>:<task> <<private>>:<<private>>\

default

18:38:38.273501 -0700

rtcreportingd

didCompleteWithError: for <session>:<task> <<private>>:<<private>> with response <private>, error (null)\

default

18:38:38.273540 -0700

rtcreportingd

internalFlushMessagesWithCompletion: <private>\

default

18:38:38.274021 -0700

rtcreportingd

writeToLogFile: Saved log message to <private>\

default

18:38:38.274059 -0700

rtcreportingd

ConnectivityHelperTask with ID <<private>> dealloced\

default

18:38:38.322253 -0700

kernel

CODE SIGNING: cs_invalid_page(0x10bcab000): p=36573[Box Autoupdater] final status 0x22000000, allowing (remove VALID) page\

default

18:38:38.603892 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(403304796: <NSProgress: 0x60000393cfa0> : Parent: 0x0 / Fraction completed: 0.0000 / Completed: 0 of 1000 )\

default

18:38:39.245214 -0700

storedownloadd

sending status (iNet Network Scanner): 0.000000% (-1.000000)\

default

18:38:39.245848 -0700

storedownloadd

sending status (iNet Network Scanner): 0.000000% (-1.000000)\

default

18:38:39.245892 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.bananaglue.mac.inet (0.00)\

default

18:38:39.246504 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.bananaglue.mac.inet (0.00)\

default

18:38:39.248492 -0700

storedownloadd

ISStoreURLOperation: Starting URL operation with url=https://p24-buy.itunes.apple.com/WebObjects/MZFastFinance.woa/wa/songDownloadDone?download-id=J24N_C_240047016856194&cancel=1 / bagKey=(null)\

default

18:38:39.250312 -0700

storeassetd

SoftwareMap: Found app at <CKSoftwareProduct: 0x7f945e735a70>: (com.bananaglue.mac.inet, 2.4.7, 403304796:827262553 VPP:NO source:Spotlight /Applications/iNet Network Scanner.app) using SoftwareMap to upgrade to 2.4.8\

default

18:38:39.250499 -0700

storedownloadd

Download: Download <Download: 0x7fe73c62f3e0>: com.bananaglue.mac.inet 2.4.8 (403304796) paused:0 failed:0 isInServerQueue:0 is known to be an update when metadata is set\

default

18:38:39.251126 -0700

appstoreagent

[CommerceKitProgress]: Cancelled progress for com.bananaglue.mac.inet\

default

18:38:39.251177 -0700

appstoreagent

[TaskManager]: Removing task for bundleID: com.bananaglue.mac.inet storeItemID: 403304796 isBackground: 0 with result: 100\

error

18:38:39.251245 -0700

appstoreagent

[CommerceKitProgress]: Task for com.bananaglue.mac.inet has failed with reason: 100\

default

18:38:39.251319 -0700

appstoreagent

[ProgressCache]: Canceling progress for bundleID: com.bananaglue.mac.inet\

default

18:38:39.252372 -0700

appstoreagent

[LibraryService]: [706D234C] Starting query for com.apple.AppStore: bundleID IN \{"com.bananaglue.mac.inet"\} AND isStoreApp == 1\

default

18:38:39.252805 -0700

appstoreagent

[LibraryService]: [706D234C] Completed with 1 result: <ASDApp: 0x7fc31de3dbf0>: \{bundleID = com.bananaglue.mac.inet; storeItemID = 403304796; storeExternalVersionID = 827262553; installed = 1\}\

default

18:38:39.253170 -0700

App Store

[DeviceAppStateDataSource] ASDAppQuery.resultsDidChange(403304796: <BundleID=com.bananaglue.mac.inet, Installed=true, LaunchProhibited=false>)\

default

18:38:39.254706 -0700

storedownloadd

sending status (iNet Network Scanner): 0.000000% (-1.000000)\

default

18:38:39.255340 -0700

appstoreagent

[CommerceKitProgress]: Updated progress for com.bananaglue.mac.inet (0.00)\

error

18:38:39.255419 -0700

appstoreagent

[ProgressCache]: Failed to set fraction completed: 0.00 for: com.bananaglue.mac.inet\

default

18:38:39.256259 -0700

storedownloadd

-[ISStoreURLOperation _runURLOperation]: _addStandardQueryParametersForURL: https://p24-buy.itunes.apple.com/WebObjects/MZFastFinance.woa/wa/songDownloadDone?download-id=J24N_C_240047016856194&cancel=1\

default

18:38:39.256604 -0700

storedownloadd

ProgressObserver: Using existing app path /Applications/iNet Network Scanner.app to represent download progress\

default

18:38:39.257010 -0700

storedownloadd

ProgressObserver: Finder acknowledged download for com.bananaglue.mac.inet\

default

18:38:39.308859 -0700

storedownloadd

Task <E355D927-DC7A-48E5-B180-9A30B791F3B9>.<0> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:39.309362 -0700

storedownloadd

Task <E355D927-DC7A-48E5-B180-9A30B791F3B9>.<0> \{strength 0, tls 4, ct 0, sub 0, sig 1, ciphers 0, bundle 1, builtin 0\}\

default

18:38:39.309462 -0700

storedownloadd

Task <E355D927-DC7A-48E5-B180-9A30B791F3B9>.<0> now using Connection 37\

default

18:38:39.309637 -0700

storedownloadd

Task <E355D927-DC7A-48E5-B180-9A30B791F3B9>.<0> sent request, body N\

default

18:38:39.329561 -0700

storedownloadd

Task <E355D927-DC7A-48E5-B180-9A30B791F3B9>.<0> received response, status 200 content K\

default

18:38:39.329675 -0700

storedownloadd

Task <E355D927-DC7A-48E5-B180-9A30B791F3B9>.<0> response ended\

default

18:38:39.329737 -0700

storedownloadd

Task <E355D927-DC7A-48E5-B180-9A30B791F3B9>.<0> done using Connection 37\

default

18:38:39.545027 -0700

locationd

\{"msg":"kCLConnectionMessageWatchdog", "event":"activity", "this":"0x7fe8f9b28a80", "registrationRequired":0, "registrationReceived":1\}\

default

18:38:40.317975 -0700

Console

27366555: RECEIVED OUT-OF-SEQUENCE NOTIFICATION: 164 vs 232, 512, <private>\

default

18:38:40.317993 -0700

Dock

27366555: RECEIVED OUT-OF-SEQUENCE NOTIFICATION: 108 vs 163, 512, <private>\

default

18:38:40.318348 -0700

storeuid

27366555: RECEIVED OUT-OF-SEQUENCE NOTIFICATION: 0 vs 162, 513, <private>\

default

18:38:40.318360 -0700

contextstored

27366555: RECEIVED OUT-OF-SEQUENCE NOTIFICATION: 111 vs 163, 513, <private>\

Replies

4 days later, 113 views, and no reply. Guess that means others are having the same problem, but nobody knows what's happening when it's happening. App Stores work fine on one computer, but not on the other. And no clear indication what could be wrong in the logs. Really bizarre...

I haven't had this issue. I'm assuming in 4 days you've restarted, but I'll still say that I've found that with Mojave I've had to be sure to restart after each Beta update and it fixes a few weird glitches that existed after each update.