[SuperSU] lzanoni:
Marshmallow - Can't install to SD (asec)

Hello,

On my Nvidia Shield tablet (OTA 4.4) running Marshmallow, before rooting with 2.79 stable, some apk were able to install to the external SD as .asec.

(I know, even if MM doesn't allow this, the app 'prefered' the external storage, and thus was directly installed there).

After rooting (systemless), I tried to install the same app, and this time, it failed. In logcat, I see an error saying that it was denied access when creating the secure container.

Any suggestion why "vold" was denied access ? I think it's related to accessing the external storage maybe ?

Any setting in SuperSu worth trying ?

For information, on the same tablet, if I put Lollipop with SuperSu 2.79 in systemmode, all works well.

here is the relevant part:

01-06 11:46:16.402 3100 3127 W PackageParser: Unknown element under <application>: enable-feature at /storage/60C2-1EF3/Download/com.fivebn.daf1.free.apk Binary XML file line #95
01-06 11:46:16.402 3100 3127 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_NETWORK_STATE in package: com.fivebn.daf1.free at: Binary XML file line #137
01-06 11:46:16.402 3100 3127 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.INTERNET in package: com.fivebn.daf1.free at: Binary XML file line #138
01-06 11:46:16.402 3100 3127 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.INTERNET in package: com.fivebn.daf1.free at: Binary XML file line #139
01-06 11:46:16.402 3100 3127 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_NETWORK_STATE in package: com.fivebn.daf1.free at: Binary XML file line #140
01-06 11:46:16.402 3100 3127 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_WIFI_STATE in package: com.fivebn.daf1.free at: Binary XML file line #141
01-06 11:46:16.402 3100 3127 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.WRITE_EXTERNAL_STORAGE in package: com.fivebn.daf1.free at: Binary XML file line #142
01-06 11:46:17.522 3100 3100 W PackageParser: Unknown element under <application>: enable-feature at /storage/60C2-1EF3/Download/com.fivebn.daf1.free.apk Binary XML file line #95
01-06 11:46:17.522 3100 3100 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_NETWORK_STATE in package: com.fivebn.daf1.free at: Binary XML file line #137
01-06 11:46:17.522 3100 3100 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.INTERNET in package: com.fivebn.daf1.free at: Binary XML file line #138
01-06 11:46:17.522 3100 3100 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.INTERNET in package: com.fivebn.daf1.free at: Binary XML file line #139
01-06 11:46:17.522 3100 3100 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_NETWORK_STATE in package: com.fivebn.daf1.free at: Binary XML file line #140
01-06 11:46:17.522 3100 3100 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_WIFI_STATE in package: com.fivebn.daf1.free at: Binary XML file line #141
01-06 11:46:17.522 3100 3100 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.WRITE_EXTERNAL_STORAGE in package: com.fivebn.daf1.free at: Binary XML file line #142
01-06 11:46:17.544 1264 1264 D RSMouse : mFeatureEnabled=true mPackageEnabled=true
01-06 11:46:20.712 324 808 E nvaudio_hw: nvaudio_out_set_parameters: Could not find the usecase (0) in the list
01-06 11:46:20.721 777 1321 I ActivityManager: START u0 {act=android.intent.action.VIEW dat=file:///storage/60C2-1EF3/Download/com.fivebn.daf1.free.apk typ=application/vnd.android.package-archive flg=0x10000000 cmp=com.google.android.packageinstaller/com.android.packageinstaller.PackageInstallerActivity} from uid 10027 on display 0
01-06 11:46:20.733 777 1321 W ActivityManager: Activity is launching as a new task, so cancelling activity result.
01-06 11:46:20.777 1264 1264 D RSMouse : mFeatureEnabled=true mPackageEnabled=true
01-06 11:46:20.781 1264 1264 D ShieldTech_Services: Starting service
01-06 11:46:20.797 777 926 I ActivityManager: Start proc 3136:com.google.android.packageinstaller/u0a11 for activity com.google.android.packageinstaller/com.android.packageinstaller.PackageInstallerActivity
01-06 11:46:20.870 3136 3136 W System : ClassLoader referenced unknown path: /system/priv-app/GooglePackageInstaller/lib/arm
01-06 11:46:20.899 3136 3136 W PackageParser: Unknown element under <application>: enable-feature at /storage/60C2-1EF3/Download/com.fivebn.daf1.free.apk Binary XML file line #95
01-06 11:46:20.899 3136 3136 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_NETWORK_STATE in package: com.fivebn.daf1.free at: Binary XML file line #137
01-06 11:46:20.899 3136 3136 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.INTERNET in package: com.fivebn.daf1.free at: Binary XML file line #138
01-06 11:46:20.899 3136 3136 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.INTERNET in package: com.fivebn.daf1.free at: Binary XML file line #139
01-06 11:46:20.899 3136 3136 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_NETWORK_STATE in package: com.fivebn.daf1.free at: Binary XML file line #140
01-06 11:46:20.899 3136 3136 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_WIFI_STATE in package: com.fivebn.daf1.free at: Binary XML file line #141
01-06 11:46:20.899 3136 3136 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.WRITE_EXTERNAL_STORAGE in package: com.fivebn.daf1.free at: Binary XML file line #142
01-06 11:46:21.027 3136 3136 I AppSecurityPermissions: Ignoring unknown permission:com.fivebn.daf1.free.permission.C2D_MESSAGE
01-06 11:46:21.028 3136 3136 I AppSecurityPermissions: Ignoring unknown permission:com.fivebn.daf1.free.permission.RECEIVE_ADM_MESSAGE
01-06 11:46:21.028 3136 3136 I AppSecurityPermissions: Ignoring unknown permission:com.amazon.device.messaging.permission.RECEIVE
01-06 11:46:21.040 3136 3149 D OpenGLRenderer: Use EGL_SWAP_BEHAVIOR_PRESERVED: true
01-06 11:46:21.060 1264 1264 D RSMouse : mFeatureEnabled=true mPackageEnabled=true
01-06 11:46:21.092 3136 3149 I OpenGLRenderer: Initialized EGL, version 1.4
01-06 11:46:21.187 777 795 I ActivityManager: Displayed com.google.android.packageinstaller/com.android.packageinstaller.PackageInstallerActivity: +404ms
01-06 11:46:22.307 777 1351 I ActivityManager: START u0 {dat=file:///storage/60C2-1EF3/Download/com.fivebn.daf1.free.apk cmp=com.google.android.packageinstaller/com.android.packageinstaller.InstallAppProgress (has extras)} from uid 10011 on display 0
01-06 11:46:22.316 1264 1264 D ShieldTech_Services: Starting service
01-06 11:46:22.346 777 801 I PackageManager: Trying to bind to DefaultContainerService
01-06 11:46:22.362 777 801 I ActivityManager: Start proc 3156:com.android.defcontainer/u0a5 for service com.android.defcontainer/.DefaultContainerService
01-06 11:46:22.370 1264 1264 D RSMouse : mFeatureEnabled=true mPackageEnabled=true
01-06 11:46:22.417 777 777 I PackageManager: onServiceConnected
01-06 11:46:22.432 777 795 I ActivityManager: Displayed com.google.android.packageinstaller/com.android.packageinstaller.InstallAppProgress: +114ms
01-06 11:46:22.450 3156 3168 D PackageHelper: fitsOnExternal: check secondary storage
01-06 11:46:22.452 777 801 I PackageManager: Checking for more work or unbind...
01-06 11:46:22.452 777 801 I PackageManager: Posting delayed MCS_UNBIND
01-06 11:46:22.459 3136 3149 D OpenGLRenderer: endAllStagingAnimators on 0xa8ab2200 (RippleDrawable) with handle 0xb46c6a30
01-06 11:46:22.542 2111 2111 I Finsky : [1] com.google.android.vending.verifier.PackageVerificationReceiver.onReceive(2093): Skipping verification because network inactive
01-06 11:46:22.577 2111 2111 I Finsky : [1] com.google.android.vending.verifier.PackageVerificationReceiver.onReceive(2093): Skipping verification because network inactive
01-06 11:46:22.585 777 801 D VoldConnector: SND -> {10 asec create smdl124512646.tmp 9 ext4 [scrubbed] 10005 1}
01-06 11:46:22.603 178 192 E Vold : Error creating imagefile (Permission denied)
01-06 11:46:22.603 178 192 E Vold : ASEC image file creation failed (Permission denied)
01-06 11:46:22.603 178 192 W Vold : Returning OperationFailed - no handler for errno 13
01-06 11:46:22.603 777 824 D VoldConnector: RCV <- {400 10 asec operation failed (Permission denied)}
01-06 11:46:22.604 3156 3167 E PackageHelper: Failed to create secure container smdl124512646.tmp
01-06 11:46:22.604 3156 3167 W DefContainer: Failed to copy package at /storage/60C2-1EF3/Download/com.fivebn.daf1.free.apk
01-06 11:46:22.604 3156 3167 W DefContainer: java.io.IOException: Failed to create container smdl124512646.tmp
01-06 11:46:22.604 3156 3167 W DefContainer:	at com.android.defcontainer.DefaultContainerService.copyPackageToContainerInner(DefaultContainerService.java:343)
01-06 11:46:22.604 3156 3167 W DefContainer:	at com.android.defcontainer.DefaultContainerService.-wrap1(DefaultContainerService.java)
01-06 11:46:22.604 3156 3167 W DefContainer:	at com.android.defcontainer.DefaultContainerService$1.copyPackageToContainer(DefaultContainerService.java:108)
01-06 11:46:22.604 3156 3167 W DefContainer:	at com.android.internal.app.IMediaContainerService$Stub.onTransact(IMediaContainerService.java:60)
01-06 11:46:22.604 3156 3167 W DefContainer:	at android.os.Binder.execTransact(Binder.java:453)
01-06 11:46:22.605 777 801 W PackageManager: Invalid verification token 0 received
01-06 11:46:22.611 777 801 I art : Starting a blocking GC Explicit
01-06 11:46:22.623 307 307 W SurfaceFlinger: couldn't log to binary event log: overflow.
01-06 11:46:22.649 777 801 I art : Explicit concurrent mark sweep GC freed 5150(297KB) AllocSpace objects, 1(40KB) LOS objects, 30% free, 9MB/13MB, paused 623us total 37.774ms
01-06 11:46:22.663 3136 3136 D InstallAppProgress: Installation error code: -18

Then I tried with SE permissive, and I can install the app, but it's not stored on the external sd as it should, instead it stays as 'asec' in the /mnt/secure/asec/....asec.

Quite useless as the purpose was to free space on the /data partition, not fill up the / ;)

01-06 12:03:42.980 777 1379 I ActivityManager: START u0 {dat=file:///storage/60C2-1EF3/Download/com.fivebn.daf1.free.apk cmp=com.google.android.packageinstaller/com.android.packageinstaller.InstallAppProgress (has extras)} from uid 10011 on display 0
01-06 12:03:42.981 324 808 E nvaudio_hw: nvaudio_out_set_parameters: Could not find the usecase (0) in the list
01-06 12:03:42.988 1264 1264 D ShieldTech_Services: Starting service
01-06 12:03:43.026 777 801 I PackageManager: Trying to bind to DefaultContainerService
01-06 12:03:43.031 777 777 I PackageManager: onServiceConnected
01-06 12:03:43.047 1264 1264 D RSMouse : mFeatureEnabled=true mPackageEnabled=true
01-06 12:03:43.053 3156 3167 D PackageHelper: fitsOnExternal: check secondary storage
01-06 12:03:43.053 777 801 I PackageManager: Checking for more work or unbind...
01-06 12:03:43.053 777 801 I PackageManager: Posting delayed MCS_UNBIND
01-06 12:03:43.055 2111 2111 I Finsky : [1] com.google.android.vending.verifier.PackageVerificationReceiver.onReceive(2093): Skipping verification because network inactive
01-06 12:03:43.067 2111 2111 I Finsky : [1] com.google.android.vending.verifier.PackageVerificationReceiver.onReceive(2093): Skipping verification because network inactive
01-06 12:03:43.083 777 801 D VoldConnector: SND -> {25 asec create smdl1944723308.tmp 9 ext4 [scrubbed] 10005 1}
01-06 12:03:43.085 178 188 D vold : Disk at 7:1 changed
01-06 12:03:43.091 178 192 V vold : /system/bin/make_ext4fs
01-06 12:03:43.091 178 192 V vold : -J
01-06 12:03:43.091 178 192 V vold : -a
01-06 12:03:43.091 178 192 V vold : /mnt/asec/smdl1944723308.tmp
01-06 12:03:43.091 178 192 V vold : -l
01-06 12:03:43.091 178 192 V vold : 10678272
01-06 12:03:43.091 178 192 V vold : -u
01-06 12:03:43.091 178 192 V vold : /dev/block/dm-0
01-06 12:03:43.091 178 188 D vold : Disk at 253:0 changed
01-06 12:03:43.097 777 795 I ActivityManager: Displayed com.google.android.packageinstaller/com.android.packageinstaller.InstallAppProgress: +106ms
01-06 12:03:43.111 178 192 I make_ext4fs: SELinux: Loaded file_contexts contexts from /file_contexts.
01-06 12:03:43.111 178 192 I make_ext4fs: Creating filesystem with parameters:
01-06 12:03:43.111 178 192 I make_ext4fs: Size: 10678272
01-06 12:03:43.111 178 192 I make_ext4fs: Block size: 4096
01-06 12:03:43.112 178 192 I make_ext4fs: Blocks per group: 32768
01-06 12:03:43.112 178 192 I make_ext4fs: Inodes per group: 656
01-06 12:03:43.112 178 192 I make_ext4fs: Inode size: 256
01-06 12:03:43.112 178 192 I make_ext4fs: Journal blocks: 0
01-06 12:03:43.112 178 192 I make_ext4fs: Label:
01-06 12:03:43.112 178 192 I make_ext4fs: Blocks: 2607
01-06 12:03:43.112 178 192 I make_ext4fs: Block groups: 1
01-06 12:03:43.112 3136 3149 D OpenGLRenderer: endAllStagingAnimators on 0xa8aa7400 (RippleDrawable) with handle 0xa13459b0
01-06 12:03:43.112 178 192 I make_ext4fs: Reserved block group size: 7
01-06 12:03:43.113 178 192 I make_ext4fs: Created filesystem with 11/656 inodes and 55/2607 blocks
01-06 12:03:43.131 777 824 D VoldConnector: RCV <- {200 25 asec operation succeeded}
01-06 12:03:43.132 777 801 D VoldConnector: SND -> {26 asec path smdl1944723308.tmp}
01-06 12:03:43.132 777 824 D VoldConnector: RCV <- {211 26 /mnt/asec/smdl1944723308.tmp}
01-06 12:03:43.133 3156 3168 D DefContainer: Copying /storage/60C2-1EF3/Download/com.fivebn.daf1.free.apk to /mnt/asec/smdl1944723308.tmp/base.apk
01-06 12:03:43.276 307 307 W SurfaceFlinger: couldn't log to binary event log: overflow.
01-06 12:03:43.330 777 801 D VoldConnector: SND -> {27 asec finalize smdl1944723308.tmp}
01-06 12:03:43.354 777 824 D VoldConnector: RCV <- {200 27 asec operation succeeded}
01-06 12:03:43.355 777 801 I art : Starting a blocking GC Explicit
01-06 12:03:43.394 777 801 I art : Explicit concurrent mark sweep GC freed 4311(270KB) AllocSpace objects, 1(20KB) LOS objects, 30% free, 9MB/13MB, paused 486us total 38.078ms
01-06 12:03:43.394 777 801 D VoldConnector: SND -> {28 asec unmount smdl1944723308.tmp force}
01-06 12:03:43.403 178 188 D vold : Disk at 7:1 changed
01-06 12:03:43.404 777 824 D VoldConnector: RCV <- {200 28 asec operation succeeded}
01-06 12:03:43.404 777 801 W PackageManager: Invalid verification token 2 received
01-06 12:03:43.405 777 801 D VoldConnector: SND -> {29 asec mount smdl1944723308.tmp [scrubbed] 1000 ro base}
01-06 12:03:43.405 178 192 E Vold : Found asec: specialAsecDir=(null), asecFileName=/mnt/secure/asec/smdl1944723308.tmp.asec
01-06 12:03:43.456 178 188 D vold : Disk at 7:1 changed
01-06 12:03:43.461 178 188 D vold : Disk at 253:0 changed
01-06 12:03:43.466 777 824 D VoldConnector: RCV <- {200 29 asec operation succeeded}
01-06 12:03:43.467 777 801 D VoldConnector: SND -> {30 asec path smdl1944723308.tmp}
01-06 12:03:43.468 777 824 D VoldConnector: RCV <- {211 30 /mnt/asec/smdl1944723308.tmp}
01-06 12:03:43.469 777 801 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcast:765 com.android.server.pm.PackageManagerService.sendSdtatusVerificationRequest:12628 com.android.server.pm.PackageManagerService.instal
com.android.server.pm.PackageManagerService.-wrap26:-1 com.android.server.pm.PackageManagerService$9.run:10516
01-06 12:03:43.479 777 801 W PackageParser: Unknown element under <application>: enable-feature at /mnt/asec/smdl1944723308.tmp/base.apk Binary XML file line #95
01-06 12:03:43.479 777 801 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_NETWORK_STATE in package: com.fivebn.daf1.free at: Binary XML file line #137
01-06 12:03:43.479 777 801 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.INTERNET in package: com.fivebn.daf1.free at: Binary XML file line #138
01-06 12:03:43.480 777 801 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.INTERNET in package: com.fivebn.daf1.free at: Binary XML file line #139
01-06 12:03:43.480 777 801 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_NETWORK_STATE in package: com.fivebn.daf1.free at: Binary XML file line #140
01-06 12:03:43.480 777 801 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.ACCESS_WIFI_STATE in package: com.fivebn.daf1.free at: Binary XML file line #141
01-06 12:03:43.480 777 801 W PackageParser: Ignoring duplicate uses-permissions/uses-permissions-sdk-m: android.permission.WRITE_EXTERNAL_STORAGE in package: com.fivebn.daf1.free at: Binary XML file line #142
01-06 12:03:43.767 777 801 D PackageManager: /// [installPackageLI] isExternalAsec: FORCEFULLY calling derivePackageAbi()
01-06 12:03:43.769 777 801 D PackageManager: primaryCpuAbi for external asec: armeabi
01-06 12:03:43.769 777 801 I art : Starting a blocking GC Explicit
01-06 12:03:43.803 777 801 I art : Explicit concurrent mark sweep GC freed 20068(1116KB) AllocSpace objects, 16(328KB) LOS objects, 30% free, 9MB/13MB, paused 502us total 33.944ms
01-06 12:03:43.803 777 801 D VoldConnector: SND -> {31 asec unmount smdl1944723308.tmp force}
01-06 12:03:43.814 178 188 D vold : Disk at 7:1 changed
01-06 12:03:43.815 777 824 D VoldConnector: RCV <- {200 31 asec operation succeeded}
01-06 12:03:43.815 777 801 D VoldConnector: SND -> {32 asec rename smdl1944723308.tmp com.fivebn.daf1.free-1}
01-06 12:03:43.816 777 824 D VoldConnector: RCV <- {200 32 asec operation succeeded}
01-06 12:03:43.817 777 801 W PackageManager: Mounting container com.fivebn.daf1.free-1
01-06 12:03:43.817 777 801 D VoldConnector: SND -> {33 asec mount com.fivebn.daf1.free-1 [scrubbed] 1000 ro base}
01-06 12:03:43.817 178 192 E Vold : Found asec: specialAsecDir=(null), asecFileName=/mnt/secure/asec/com.fivebn.daf1.free-1.asec
01-06 12:03:43.868 178 188 D vold : Disk at 7:1 changed
01-06 12:03:43.872 178 188 D vold : Disk at 253:0 changed
01-06 12:03:43.879 777 824 D VoldConnector: RCV <- {200 33 asec operation succeeded}
01-06 12:03:43.880 777 801 D VoldConnector: SND -> {34 asec path com.fivebn.daf1.free-1}
01-06 12:03:43.880 777 824 D VoldConnector: RCV <- {211 34 /mnt/asec/com.fivebn.daf1.free-1}
01-06 12:03:43.881 777 801 I PackageManager: Succesfully renamed smdl1944723308.tmp to com.fivebn.daf1.free-1 at new path: /mnt/asec/com.fivebn.daf1.free-1
01-06 12:03:43.901 777 801 I PackageManager.DexOptimizer: Running dexopt (dex2oat) on: /mnt/asec/com.fivebn.daf1.free-1/base.apk pkg=com.fivebn.daf1.free isa=arm vmSafeMode=false debuggable=false oatDir = null
01-06 12:03:43.929 3731 3731 I dex2oat : Starting dex2oat.
01-06 12:03:46.702 3731 3731 W dex2oat : Compilation of void com.amazonaws.com.google.gson.internal.$Gson$Types$ParameterizedTypeImpl.<init>(java.lang.reflect.Type, java.lang.reflect.Type, java.lang.reflect.Type[]) took 145.543ms
01-06 12:03:46.721 3731 3733 W dex2oat : Compilation of void com.amazonaws.com.google.gson.internal.$Gson$Types$WildcardTypeImpl.<init>(java.lang.reflect.Type[], java.lang.reflect.Type[]) took 162.942ms
01-06 12:03:46.759 3731 3735 W dex2oat : Compilation of java.lang.reflect.Type com.amazonaws.com.google.gson.internal.$Gson$Types.canonicalize(java.lang.reflect.Type) took 159.538ms
01-06 12:03:48.303 3731 3734 W dex2oat : No verified method for method calling String.<init>: java.lang.String java.io.ByteArrayOutputStream.toString()
01-06 12:03:49.355 777 1261 D NetworkTimeUpdateService: mLastNtpFetchTime:-1 refTime:2497892 event:2 getCacheAge:9223372036854775807 isNtpRefreshed:false mTryAgainCounter:17
01-06 12:03:49.926 3731 3734 W dex2oat : Compilation of boolean com.google.android.gms.games.internal.IGamesService$Stub.onTransact(int, android.os.Parcel, android.os.Parcel, int) took 128.640ms
01-06 12:03:50.307 3731 3735 W dex2oat : No verified method for method calling String.<init>: void org.json.JSONStringer.<init>(int)
01-06 12:03:52.066 1181 1181 D BlakeWifiIntentManager: SCAN_RESULTS_AVAILABLE_ACTION
01-06 12:03:52.215 342 342 D Raydium_ts_main: ## Report rate in 10 seconds =2411
01-06 12:03:52.832 3731 3731 I dex2oat : dex2oat took 8.903s (threads: 4) arena alloc=38MB java alloc=9MB native alloc=74MB free=9MB
01-06 12:03:53.304 777 801 W PackageManager: Not granting permission android.permission.SET_ORIENTATION to package com.fivebn.daf1.free (protectionLevel=2 flags=0x180cbc44)
01-06 12:03:53.304 777 801 W PackageManager: Unknown permission com.amazon.device.messaging.permission.RECEIVE in package com.fivebn.daf1.free
01-06 12:03:53.402 777 801 D VoldConnector: SND -> {35 asec fixperms com.fivebn.daf1.free-1 -1 null}
01-06 12:03:53.412 777 824 D VoldConnector: RCV <- {200 35 asec operation succeeded}
01-06 12:03:53.413 777 801 V BackupManagerService: restoreAtInstall pkg=com.fivebn.daf1.free token=3 restoreSet=0
01-06 12:03:53.413 777 801 V BackupManagerService: Finishing install immediately
01-06 12:03:53.415 777 801 W Settings: Setting install_non_market_apps has moved from android.provider.Settings.Global to android.provider.Settings.Secure, returning read-only value.
01-06 12:03:53.415 777 801 I art : Starting a blocking GC Explicit
01-06 12:03:53.483 777 801 I art : Explicit concurrent mark sweep GC freed 28833(1752KB) AllocSpace objects, 6(120KB) LOS objects, 30% free, 9MB/13MB, paused 981us total 66.954ms
01-06 12:03:53.488 1369 1369 D CarrierServiceBindHelper: Receive action: android.intent.action.PACKAGE_ADDED
01-06 12:03:53.489 1369 1369 D CarrierServiceBindHelper: mHandler: 3
01-06 12:03:53.496 1369 1369 D CarrierConfigLoader: mHandler: 9 phoneId: 0
01-06 12:03:53.496 777 822 I InputReader: Reconfiguring input devices. changes=0x00000010
01-06 12:03:53.529 777 788 I AccountManagerService: getTypesVisibleToCaller: isPermitted? true
01-06 12:03:53.529 1504 3740 D PkgBroadcastIntentOp: Received broadcast action=android.intent.action.PACKAGE_ADDED and uri=com.fivebn.daf1.free
01-06 12:03:53.534 1504 1504 D AsyncTaskServiceImpl: Submit a task: k
01-06 12:03:53.539 3592 3738 D Documents: Update found 8 roots in 33ms
01-06 12:03:53.542 1504 3740 D WearableController: Received broadcast action=android.intent.action.PACKAGE_ADDED and uri=com.fivebn.daf1.free
01-06 12:03:53.556 1504 3745 D k : Processing package: com.fivebn.daf1.free
01-06 12:03:53.562 1504 3745 D GassUtils: Found app info for package com.fivebn.daf1.free:1006. Hash: 6719b0159048aa93210770bba55f9e0902614b71a4813724d5d08a8aa52d4db2
01-06 12:03:53.562 1504 3745 D k : Found info for package com.fivebn.daf1.free in db.
01-06 12:03:53.564 777 889 I AccountManagerService: getTypesVisibleToCaller: isPermitted? true
01-06 12:03:53.565 1504 3743 I PeopleContactsSync: triggerPendingContactsCleanup: no accounts
01-06 12:03:53.642 2111 2111 I Finsky : [1] com.google.android.finsky.utils.PermissionPolicies$PermissionPolicyService.onStartCommand(117): post-install permissions check for com.fivebn.daf1.free