search

Tencent / tinker

Tinker is a hot-fix solution library for Android, it supports dex, library and resources update without reinstall apk.
Other
17.1k stars 3.33k forks source link

最新版本补丁合成很慢（50s），不管 dex2oat 是否成功都会循环 N 次 #1670

Open waruqi opened 1 year ago

waruqi commented 1 year ago

Issue/提问须知

最新版本在 android 12 pixel4 上会一直循环 dex2oat 失败，不停的循环 20次 后才成功，花了近 50s 时间，但是测试 demo app 就是一个 hello world ，之前 14.18 的版本，800ms 就合成完了。

异常类型：app运行时异常（补丁合成失败）

手机型号：Pixel4

手机系统版本：:Android 12.0 

tinker版本：1.9.14.24

gradle版本：6.5

是否使用热更新SDK：否

系统：Mac

堆栈/日志：
08-16 17:19:17.240 28643 28643 W Tinker.TinkerLoader: tryLoadPatchFiles: we don't load patch with :patch process itself, just return
08-16 17:19:17.241 28643 28643 D Tinker.DefaultAppLike: onBaseContextAttached:
08-16 17:19:17.242 28643 28643 I MultiDex: VM with version 2.1.0 has multidex support
08-16 17:19:17.242 28643 28643 I MultiDex: Installing application
08-16 17:19:17.242 28643 28643 I MultiDex: VM has multidex support, MultiDex support library is disabled.
08-16 17:19:17.244 28643 28643 V Tinker.SamplePatchListener: application maxMemory:256
08-16 17:19:17.245 28643 28643 W Tinker.Tinker: tinker patch directory: /data/user/0/tinker.sample.android/tinker
08-16 17:19:17.247 28643 28643 I Tinker.Tinker: try to install tinker, isEnable: true, version: 1.9.14.24.b
08-16 17:19:17.247 28643 28643 I Tinker.TinkerLoadResult: parseTinkerResult loadCode:-1, process name:tinker.sample.android:patch, main process:false, systemOTA:false, fingerPrint:Android/aosp_flame
/flame:12/SP1A.210812.016.A1/eng.ruki.20220721.145045:userdebug/test-keys, oatDir:null, useInterpretMode:false
08-16 17:19:17.247 28643 28643 W Tinker.TinkerLoadResult: tinker is disable, just return
08-16 17:19:17.248 28643 28643 I Tinker.DefaultLoadReporter: patch loadReporter onLoadResult: patch load result, path:/data/user/0/tinker.sample.android/tinker, code: -1, cost: 2ms
08-16 17:19:17.248 28643 28643 W Tinker.Tinker: tinker load fail!
08-16 17:19:17.248 28643 28643 D Tinker.DefaultAppLike: onCreate
08-16 17:19:17.257 28643 28661 I Tinker.TinkerPatchService: for system version >= Android O, we just ignore increasingPriority job to avoid crash or toasts.
08-16 17:19:17.258 28643 28661 I Tinker.DefaultPatchReporter: patchReporter onPatchServiceStart: patch service start
08-16 17:19:17.259 28643 28661 W Tinker.UpgradePatchRetry: try copy file: /storage/emulated/0/Android/data/tinker.sample.android/files/patch/patch_signed_7zip.apk to /data/user/0/tinker.sample.andro
id/tinker_temp/temp.apk
08-16 17:19:17.265 28643 28643 D Tinker.TinkerLoader: [PendingLog @ 2022-08-16 17:19:17.239] tryLoad test test
08-16 17:19:17.266 28643 28643 W Tinker.TinkerLoader: [PendingLog @ 2022-08-16 17:19:17.240] tryLoadPatchFiles: we don't load patch with :patch process itself, just return
08-16 17:19:17.266 28643 28643 D Tinker.DefaultAppLike: [PendingLog @ 2022-08-16 17:19:17.241] onBaseContextAttached:
08-16 17:19:17.266 28643 28643 W Tinker.UpgradePatchRetry: onPatchRetryLoad retry is not main process, just return
08-16 17:19:17.293 28643 28661 I Tinker.UpgradePatch: UpgradePatch tryPatch:patchMd5:3a16826853a00bcd823ff1dadc7ce2b2
08-16 17:19:17.295 28643 28661 W Tinker.PatchInfo: read property failed, e:java.io.FileNotFoundException: /data/user/0/tinker.sample.android/tinker/patch.info: open failed: ENOENT (No such file or d
irectory)
08-16 17:19:17.295 28643 28661 W Tinker.PatchInfo: read property failed, e:java.io.FileNotFoundException: /data/user/0/tinker.sample.android/tinker/patch.info: open failed: ENOENT (No such file or d
irectory)
08-16 17:19:17.295 28643 28661 I Tinker.UpgradePatch: UpgradePatch tryPatch:patchVersionDirectory:/data/user/0/tinker.sample.android/tinker/patch-3a168268
08-16 17:19:17.296 28643 28661 W Tinker.UpgradePatch: UpgradePatch copy patch file, src file: /storage/emulated/0/Android/data/tinker.sample.android/files/patch/patch_signed_7zip.apk size: 23662, de
st file: /data/user/0/tinker.sample.android/tinker/patch-3a168268/patch-3a168268.apk size:23662
08-16 17:19:17.902 28643 28661 W Tinker.DexDiffPatchInternal: success recover dex file: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/classes2.dex.jar, size: 933381, use time: 602
08-16 17:19:17.998 28643 28661 W Tinker.DexDiffPatchInternal: success recover dex file: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/classes.dex.jar, size: 153956, use time: 96
08-16 17:19:17.998 28643 28661 I Tinker.DexDiffPatchInternal: try Extracting /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/test.dex.jar
08-16 17:19:18.000 28643 28661 I Tinker.DexDiffPatchInternal: isExtractionSuccessful: true
08-16 17:19:18.039 28643 28661 I Tinker.PatchFileUtil: safeDeleteFile, try to delete path: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/classes.dex.jar
08-16 17:19:18.039 28643 28661 I Tinker.PatchFileUtil: safeDeleteFile, try to delete path: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/test.dex.jar
08-16 17:19:18.039 28643 28661 I Tinker.PatchFileUtil: safeDeleteFile, try to delete path: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/classes2.dex.jar
08-16 17:19:18.040 28643 28661 I Tinker.DexDiffPatchInternal: merge classN dex file /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk, result: true, size: 2612339, use:
40ms
08-16 17:19:18.040 28643 28661 I Tinker.DexDiffPatchInternal: legal files to do dexopt: [/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk]
08-16 17:19:18.041 28643 28661 W e.android:patc: Accessing hidden method Ldalvik/system/VMRuntime;->getCurrentInstructionSet()Ljava/lang/String; (unsupported,core-platform-api, reflection, allowed)
08-16 17:19:18.041 28643 28661 D Tinker.TinkerInternals: getCurrentInstructionSet:arm64
08-16 17:19:18.041 28643 28661 I Tinker.DexDiffPatchInternal: patch recover, try to optimize dex file count:1, optimizeDexDirectory:/data/user/0/tinker.sample.android/tinker/patch-3a168268/odex/
08-16 17:19:18.043 28643 28661 I Tinker.DexDiffPatchInternal: start to parallel optimize dex /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk, size: 2612339
08-16 17:19:18.043 28643 28661 I Tinker.TinkerInternals: class not found exception
08-16 17:19:18.043 28643 28661 I Tinker.ParallelDex: Creating fake odex path structure.
08-16 17:19:18.044 28643 28661 W e.android:patc: Accessing hidden field Ldalvik/system/BaseDexClassLoader;->pathList:Ldalvik/system/DexPathList; (unsupported, reflection, allowed)
08-16 17:19:18.044 28643 28661 W e.android:patc: Accessing hidden field Ldalvik/system/DexPathList;->nativeLibraryDirectories:Ljava/util/List; (unsupported, reflection, allowed)
08-16 17:19:18.044 28643 28661 W System  : ClassLoader referenced unknown path:
08-16 17:19:18.045 28643 28661 W e.android:patc: Unsupported class loader
08-16 17:19:18.045 28643 28661 W e.android:patc: Accessing hidden method Ldalvik/system/DexPathList;->makePathElements(Ljava/util/List;Ljava/io/File;Ljava/util/List;)[Ldalvik/system/DexPathList$Elem
ent; (unsupported, reflection, allowed)
08-16 17:19:18.046 28643 28661 W e.android:patc: Opening an oat file without a class loader. Are you using the deprecated DexFile APIs?
08-16 17:19:18.056 28643 28661 W e.android:patc: Accessing hidden field Ldalvik/system/DexPathList;->dexElements:[Ldalvik/system/DexPathList$Element; (unsupported, reflection, allowed)
08-16 17:19:18.056 28643 28661 I Tinker.ParallelDex: [+] Hit target device, do dexopt logic now.
08-16 17:19:18.057 28643 28661 W e.android:patc: Accessing hidden method Landroid/os/ServiceManager;->getService(Ljava/lang/String;)Landroid/os/IBinder; (unsupported, reflection, allowed)
08-16 17:19:18.057 28643 28661 W e.android:patc: Accessing hidden method Landroid/content/pm/IPackageManager$Stub;->asInterface(Landroid/os/IBinder;)Landroid/content/pm/IPackageManager; (unsupported
, reflection, allowed)
08-16 17:19:18.058 28643 28661 W e.android:patc: Accessing hidden method Landroid/app/ApplicationPackageManager;-><init>(Landroid/app/ContextImpl;Landroid/content/pm/IPackageManager;)V (unsupported,
 reflection, allowed)
08-16 17:19:18.059  2441 12362 D PackageDexOptimizer: Running dexopt on: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk pkg=tinker.sample.android isa=[arm64] reason=i
nstall dexoptFlags=debuggable,public,secondary,storage_ce,enable_hidden_api_checks target-filter=verify class-loader-context=null
08-16 17:19:18.059  1256 13652 D installd: Processing secondary dex path /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk
08-16 17:19:18.060 28664 28664 D installd: Mismatched cache GID/mode at /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat: found 10150/448 but expected 10150/505
08-16 17:19:18.060 28664 28664 I installd: installd cannot open vdex file during dexopt/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.vdex: No such file or dire
ctory
08-16 17:19:18.072 28664 28664 E dexoptanalyzer: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art!/system/etc/boot-image.prof
'. Attempting to fall back to imageless running. Error was:
08-16 17:19:18.301 28664 28664 W dexoptanalyzer: Current thread not detached in Runtime shutdown
08-16 17:19:18.307  1256 13652 D installd: Processed secondary dex file /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk result=1
08-16 17:19:18.308  1256 13652 V installd: DexInv: --- BEGIN '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' ---
08-16 17:19:18.308  1256 13652 V installd: Running /apex/com.android.art/bin/dex2oat64 in=tinker_classN.apk out=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.o
dex
08-16 17:19:18.321 28665 28665 W dex2oat64: Mismatch between dex2oat instruction set features to use (ISA: Arm64 Feature string: -a53,crc,lse,fp16,dotprod,-sve) and those from CPP defines (ISA: Arm6
4 Feature string: -a53,-crc,-lse,-fp16,-dotprod,-sve) for the command line:
08-16 17:19:18.321 28665 28665 W dex2oat64: /apex/com.android.art/bin/dex2oat64 --zip-fd=8 --zip-location=tinker_classN.apk --oat-fd=9 --oat-location=/data/user/0/tinker.sample.android/tinker/patch-
3a168268/dex/oat/arm64/tinker_classN.odex --input-vdex-fd=-1 --output-vdex-fd=10 --swap-fd=11 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --compact-dex-level=none --
instruction-set=arm64 --instruction-set-features=default --instruction-set-variant=cortex-a76 --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-co
nst-strings=true --debuggable --generate-mini-debug-info --runtime-arg -Xtarget-sdk-version:30 --runtime-arg -Xhidden-api-policy:enabled --runtime-arg -Xms64m --runtime-arg -Xmx512m
08-16 17:19:18.321 28665 28665 I dex2oat64: /apex/com.android.art/bin/dex2oat64 --input-vdex-fd=-1 --output-vdex-fd=10 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --
compact-dex-level=none --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-const-strings=true --debuggable --generate-mini-debug-info
08-16 17:19:18.339 28665 28665 E dex2oat64: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art'. Attempting to fall back to ima
geless running. Error was:
08-16 17:19:16.058     0     0 I         : c0  28305 google_charger: usbchg=USB_PD typec=PD usbv=4847 usbc=903 usbMv=5000 usbMc=3000
08-16 17:19:16.058     0     0 I         : c0  28305 sm8150_bms: MSC_PCS chg_state=5dc113a04010009 [0x9:4:1:4410:1500] chg=u
08-16 17:19:16.058     0     0 I         : c0  28305 google_battery: MSC_DIN chg_state=5dc113a04010009 f=0x9 chg_s=Charging chg_t=Taper vchg=4410 icl=1500
08-16 17:19:16.061     0     0 I         : c0  28305 google_battery: MSC_LAST vbatt=4403593 ibatt=-222812 fv_uv=4400000
08-16 17:19:16.062     0     0 I         : c0  28305 google_battery: MSC_LOGIC cv_cnt=3 ov_cnt=0 temp_idx:2->2, vbatt_idx:2->2, fv=4400000->4400000, cc_max=1400000
08-16 17:19:16.062     0     0 I         : c0  28305 google_battery: MSC_VOTE fv_uv=4400000 cc_max=1400000 update_interval=30000
08-16 17:19:16.062     0     0 I         : c0  28305 google_charger: MSC_CHG fv_uv=4400000, cc_max=1400000, rerun in 30000 ms (0)
08-16 17:19:18.584 28665 28665 E dex2oat64: Missing primary boot image for app compilation.
08-16 17:19:18.603 28665 28665 I dex2oat64: dex2oat took 283.171ms (262.180ms cpu) (threads: 8)
08-16 17:19:18.610  1256 13652 V installd: DexInv: --- END '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' --- status=0x 100, process failed
08-16 17:19:18.611  1256 13652 E installd: Dex2oat invocation for /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (256)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer: Failed to dexopt
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer: com.android.server.pm.Installer$InstallerException: android.os.ServiceSpecificException: Dex2oat invocation for /data/user/0/tinker.sample.andro
id/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (code 256)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.Installer.dexopt(Installer.java:506)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPathLI(PackageDexOptimizer.java:526)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPath(PackageDexOptimizer.java:437)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.dex.DexManager.registerDexModule(DexManager.java:787)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.registerDexModule(PackageManagerService.java:12759)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer:   at android.content.pm.IPackageManager$Stub.onTransact(IPackageManager.java:3596)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.onTransact(PackageManagerService.java:8506)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransactInternal(Binder.java:1179)
08-16 17:19:18.613  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransact(Binder.java:1143)
08-16 17:19:18.614 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, verify, tinker.sample.android]
08-16 17:19:18.616 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:19.617 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:19:19.620 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:20.489   969 28668 D resolv  : GetAddrInfoHandler::run: {107 262251 107 983147 10110 0}
08-16 17:19:20.489   969 28668 D resolv  : resolv_getaddrinfo: explore_fqdn(): ai_family=0 ai_socktype=1 ai_protocol=6
08-16 17:19:20.490   969 28669 D resolv  : doQuery: (1, 1)
08-16 17:19:20.490   969 28669 D resolv  : res_nmkquery: (QUERY, IN, A)
08-16 17:19:20.490   969 28669 D resolv  : res_nsend
08-16 17:19:20.490   969 28669 I resolv  : resolv_cache_lookup: lookup
08-16 17:19:20.490   969 28669 I resolv  : resolv_cache_lookup: FOUND IN CACHE entry=0xb4000079996fa2b0
08-16 17:19:20.490   969 28669 D resolv  : doQuery: rcode=0, ancount=2
08-16 17:19:20.490   969 28668 I ResolverController: No valid NAT64 prefix (107, <unspecified>/0)
08-16 17:19:20.623 28643 28661 W e.android:patc: Accessing hidden field Landroid/content/pm/IPackageManager$Stub;->TRANSACTION_performDexOptSecondary:I (max-target-o, reflection, denied)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex: [-] Error.  java.lang.IllegalStateException: Cannot query transaction code of performDexOptSecondary.
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:347)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.triggerPMDexOptOnDemand(TinkerDexOptimizer.java:275)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.access$200(TinkerDexOptimizer.java:67)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer$OptimizeWorker.run(TinkerDexOptimizer.java:166)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:108)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:83)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.dexOptimizeDexFiles(DexDiffPatchInternal.java:381)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.patchDexExtractViaDexDiff(DexDiffPatchInternal.java:196)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.tryRecoverDexFiles(DexDiffPatchInternal.java:87)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.UpgradePatch.tryPatch(UpgradePatch.java:170)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.doApplyPatch(TinkerPatchService.java:223)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.onHandleIntent(TinkerPatchService.java:101)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at android.app.IntentService$ServiceHandler.handleMessage(IntentService.java:78)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at android.os.Handler.dispatchMessage(Handler.java:106)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loopOnce(Looper.java:201)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loop(Looper.java:288)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at android.os.HandlerThread.run(HandlerThread.java:67)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.reflect.InvocationTargetException
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at java.lang.reflect.Method.invoke(Native Method)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:340)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    ... 16 more
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.NoSuchFieldException: No field TRANSACTION_performDexOptSecondary in class Landroid/content/pm/IPackageManager$Stub; (declar
ation of 'android.content.pm.IPackageManager$Stub' appears in /system/framework/framework.jar)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    at java.lang.Class.getDeclaredField(Native Method)
08-16 17:19:20.629 28643 28661 E Tinker.ParallelDex:    ... 18 more
08-16 17:19:21.634  2441 12362 D PackageDexOptimizer: Running dexopt on: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk pkg=tinker.sample.android isa=[arm64] reason=i
nstall dexoptFlags=debuggable,public,secondary,storage_ce,enable_hidden_api_checks target-filter=verify class-loader-context=null
08-16 17:19:21.635  1256 13652 D installd: Processing secondary dex path /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk
08-16 17:19:21.639 28671 28671 I installd: installd cannot open oat file during dexopt/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.odex: No such file or direc
tory
08-16 17:19:21.639 28671 28671 I installd: installd cannot open vdex file during dexopt/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.vdex: No such file or dire
ctory
08-16 17:19:21.653 28671 28671 E dexoptanalyzer: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art!/system/etc/boot-image.prof
'. Attempting to fall back to imageless running. Error was:
08-16 17:19:21.862 28671 28671 W dexoptanalyzer: Current thread not detached in Runtime shutdown
08-16 17:19:21.867  1256 13652 D installd: Processed secondary dex file /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk result=1
08-16 17:19:21.868  1256 13652 V installd: DexInv: --- BEGIN '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' ---
08-16 17:19:21.868  1256 13652 V installd: Running /apex/com.android.art/bin/dex2oat64 in=tinker_classN.apk out=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.o
dex
08-16 17:19:21.882 28672 28672 W dex2oat64: Mismatch between dex2oat instruction set features to use (ISA: Arm64 Feature string: -a53,crc,lse,fp16,dotprod,-sve) and those from CPP defines (ISA: Arm6
4 Feature string: -a53,-crc,-lse,-fp16,-dotprod,-sve) for the command line:
08-16 17:19:21.882 28672 28672 W dex2oat64: /apex/com.android.art/bin/dex2oat64 --zip-fd=8 --zip-location=tinker_classN.apk --oat-fd=9 --oat-location=/data/user/0/tinker.sample.android/tinker/patch-
3a168268/dex/oat/arm64/tinker_classN.odex --input-vdex-fd=-1 --output-vdex-fd=10 --swap-fd=11 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --compact-dex-level=none --
instruction-set=arm64 --instruction-set-features=default --instruction-set-variant=cortex-a76 --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-co
nst-strings=true --debuggable --generate-mini-debug-info --runtime-arg -Xtarget-sdk-version:30 --runtime-arg -Xhidden-api-policy:enabled --runtime-arg -Xms64m --runtime-arg -Xmx512m
08-16 17:19:21.882 28672 28672 I dex2oat64: /apex/com.android.art/bin/dex2oat64 --input-vdex-fd=-1 --output-vdex-fd=10 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --
compact-dex-level=none --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-const-strings=true --debuggable --generate-mini-debug-info
08-16 17:19:21.900 28672 28672 E dex2oat64: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art'. Attempting to fall back to ima
geless running. Error was:
08-16 17:19:22.153 28672 28672 E dex2oat64: Missing primary boot image for app compilation.
08-16 17:19:22.167 28672 28672 I dex2oat64: dex2oat took 285.762ms (269.670ms cpu) (threads: 8)
08-16 17:19:22.170  1256 13652 V installd: DexInv: --- END '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' --- status=0x 100, process failed
08-16 17:19:22.171  1256 13652 E installd: Dex2oat invocation for /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (256)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer: Failed to dexopt
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer: com.android.server.pm.Installer$InstallerException: android.os.ServiceSpecificException: Dex2oat invocation for /data/user/0/tinker.sample.andro
id/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (code 256)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.Installer.dexopt(Installer.java:506)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPathLI(PackageDexOptimizer.java:526)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPath(PackageDexOptimizer.java:437)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.dex.DexManager.registerDexModule(DexManager.java:787)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.registerDexModule(PackageManagerService.java:12759)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer:   at android.content.pm.IPackageManager$Stub.onTransact(IPackageManager.java:3596)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.onTransact(PackageManagerService.java:8506)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransactInternal(Binder.java:1179)
08-16 17:19:22.171  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransact(Binder.java:1143)
08-16 17:19:22.173 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, verify, tinker.sample.android]
08-16 17:19:22.175 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:23.179 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:19:23.184 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:24.186 28643 28661 W e.android:patc: Accessing hidden field Landroid/content/pm/IPackageManager$Stub;->TRANSACTION_performDexOptSecondary:I (max-target-o, reflection, denied)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex: [-] Error.  java.lang.IllegalStateException: Cannot query transaction code of performDexOptSecondary.
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:347)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.triggerPMDexOptOnDemand(TinkerDexOptimizer.java:275)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.access$200(TinkerDexOptimizer.java:67)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer$OptimizeWorker.run(TinkerDexOptimizer.java:166)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:108)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:83)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.dexOptimizeDexFiles(DexDiffPatchInternal.java:381)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.patchDexExtractViaDexDiff(DexDiffPatchInternal.java:196)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.tryRecoverDexFiles(DexDiffPatchInternal.java:87)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.UpgradePatch.tryPatch(UpgradePatch.java:170)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.doApplyPatch(TinkerPatchService.java:223)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.onHandleIntent(TinkerPatchService.java:101)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at android.app.IntentService$ServiceHandler.handleMessage(IntentService.java:78)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at android.os.Handler.dispatchMessage(Handler.java:106)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loopOnce(Looper.java:201)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loop(Looper.java:288)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at android.os.HandlerThread.run(HandlerThread.java:67)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.reflect.InvocationTargetException
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at java.lang.reflect.Method.invoke(Native Method)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:340)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    ... 16 more
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.NoSuchFieldException: No field TRANSACTION_performDexOptSecondary in class Landroid/content/pm/IPackageManager$Stub; (declar
ation of 'android.content.pm.IPackageManager$Stub' appears in /system/framework/framework.jar)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    at java.lang.Class.getDeclaredField(Native Method)
08-16 17:19:24.196 28643 28661 E Tinker.ParallelDex:    ... 18 more
08-16 17:19:25.202  2441 12362 D PackageDexOptimizer: Running dexopt on: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk pkg=tinker.sample.android isa=[arm64] reason=i
nstall dexoptFlags=debuggable,public,secondary,storage_ce,enable_hidden_api_checks target-filter=verify class-loader-context=null
08-16 17:19:25.203  1256 13652 D installd: Processing secondary dex path /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk
08-16 17:19:25.206 28674 28674 I installd: installd cannot open oat file during dexopt/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.odex: No such file or direc
tory
08-16 17:19:25.206 28674 28674 I installd: installd cannot open vdex file during dexopt/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.vdex: No such file or dire
ctory
08-16 17:19:25.224 28674 28674 E dexoptanalyzer: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art!/system/etc/boot-image.prof
'. Attempting to fall back to imageless running. Error was:
08-16 17:19:25.438 28674 28674 W dexoptanalyzer: Current thread not detached in Runtime shutdown
08-16 17:19:25.443  1256 13652 D installd: Processed secondary dex file /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk result=1
08-16 17:19:25.444  1256 13652 V installd: DexInv: --- BEGIN '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' ---
08-16 17:19:25.444  1256 13652 V installd: Running /apex/com.android.art/bin/dex2oat64 in=tinker_classN.apk out=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.o
dex
08-16 17:19:25.458 28675 28675 W dex2oat64: Mismatch between dex2oat instruction set features to use (ISA: Arm64 Feature string: -a53,crc,lse,fp16,dotprod,-sve) and those from CPP defines (ISA: Arm6
4 Feature string: -a53,-crc,-lse,-fp16,-dotprod,-sve) for the command line:
08-16 17:19:25.458 28675 28675 W dex2oat64: /apex/com.android.art/bin/dex2oat64 --zip-fd=8 --zip-location=tinker_classN.apk --oat-fd=9 --oat-location=/data/user/0/tinker.sample.android/tinker/patch-
3a168268/dex/oat/arm64/tinker_classN.odex --input-vdex-fd=-1 --output-vdex-fd=10 --swap-fd=11 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --compact-dex-level=none --
instruction-set=arm64 --instruction-set-features=default --instruction-set-variant=cortex-a76 --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-co
nst-strings=true --debuggable --generate-mini-debug-info --runtime-arg -Xtarget-sdk-version:30 --runtime-arg -Xhidden-api-policy:enabled --runtime-arg -Xms64m --runtime-arg -Xmx512m
08-16 17:19:25.459 28675 28675 I dex2oat64: /apex/com.android.art/bin/dex2oat64 --input-vdex-fd=-1 --output-vdex-fd=10 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --
compact-dex-level=none --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-const-strings=true --debuggable --generate-mini-debug-info
08-16 17:19:25.477 28675 28675 E dex2oat64: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art'. Attempting to fall back to ima
geless running. Error was:
08-16 17:19:25.633   969   969 I netd    : setProcSysNet(4, 2, wlan0, retrans_time_ms, 750) <0.10ms>
08-16 17:19:25.634   969   969 I netd    : setProcSysNet(4, 2, wlan0, ucast_solicit, 10) <0.04ms>
08-16 17:19:25.634   969   969 I netd    : setProcSysNet(6, 2, wlan0, retrans_time_ms, 750) <0.04ms>
08-16 17:19:25.634   969   969 I netd    : setProcSysNet(6, 2, wlan0, ucast_solicit, 10) <0.02ms>
08-16 17:19:25.726 28675 28675 E dex2oat64: Missing primary boot image for app compilation.
08-16 17:19:25.741 28675 28675 I dex2oat64: dex2oat took 283.298ms (267.085ms cpu) (threads: 8)
08-16 17:19:25.745  1256 13652 V installd: DexInv: --- END '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' --- status=0x 100, process failed
08-16 17:19:25.745  1256 13652 E installd: Dex2oat invocation for /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (256)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer: Failed to dexopt
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer: com.android.server.pm.Installer$InstallerException: android.os.ServiceSpecificException: Dex2oat invocation for /data/user/0/tinker.sample.andro
id/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (code 256)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.Installer.dexopt(Installer.java:506)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPathLI(PackageDexOptimizer.java:526)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPath(PackageDexOptimizer.java:437)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.dex.DexManager.registerDexModule(DexManager.java:787)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.registerDexModule(PackageManagerService.java:12759)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer:   at android.content.pm.IPackageManager$Stub.onTransact(IPackageManager.java:3596)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.onTransact(PackageManagerService.java:8506)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransactInternal(Binder.java:1179)
08-16 17:19:25.746  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransact(Binder.java:1143)
08-16 17:19:25.747 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, verify, tinker.sample.android]
08-16 17:19:25.750 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:26.753 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:19:26.759 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:27.761 28643 28661 W e.android:patc: Accessing hidden field Landroid/content/pm/IPackageManager$Stub;->TRANSACTION_performDexOptSecondary:I (max-target-o, reflection, denied)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex: [-] Error.  java.lang.IllegalStateException: Cannot query transaction code of performDexOptSecondary.
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:347)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.triggerPMDexOptOnDemand(TinkerDexOptimizer.java:275)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.access$200(TinkerDexOptimizer.java:67)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer$OptimizeWorker.run(TinkerDexOptimizer.java:166)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:108)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:83)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.dexOptimizeDexFiles(DexDiffPatchInternal.java:381)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.patchDexExtractViaDexDiff(DexDiffPatchInternal.java:196)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.tryRecoverDexFiles(DexDiffPatchInternal.java:87)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.UpgradePatch.tryPatch(UpgradePatch.java:170)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.doApplyPatch(TinkerPatchService.java:223)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.onHandleIntent(TinkerPatchService.java:101)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at android.app.IntentService$ServiceHandler.handleMessage(IntentService.java:78)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at android.os.Handler.dispatchMessage(Handler.java:106)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loopOnce(Looper.java:201)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loop(Looper.java:288)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at android.os.HandlerThread.run(HandlerThread.java:67)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.reflect.InvocationTargetException
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at java.lang.reflect.Method.invoke(Native Method)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:340)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    ... 16 more
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.NoSuchFieldException: No field TRANSACTION_performDexOptSecondary in class Landroid/content/pm/IPackageManager$Stub; (declar
ation of 'android.content.pm.IPackageManager$Stub' appears in /system/framework/framework.jar)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    at java.lang.Class.getDeclaredField(Native Method)
08-16 17:19:27.771 28643 28661 E Tinker.ParallelDex:    ... 18 more
08-16 17:19:28.776  2441 12362 D PackageDexOptimizer: Running dexopt on: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk pkg=tinker.sample.android isa=[arm64] reason=i
nstall dexoptFlags=debuggable,public,secondary,storage_ce,enable_hidden_api_checks target-filter=verify class-loader-context=null
08-16 17:19:28.777  1256 13652 D installd: Processing secondary dex path /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk
08-16 17:19:28.782 28677 28677 I installd: installd cannot open oat file during dexopt/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.odex: No such file or direc
tory
08-16 17:19:28.782 28677 28677 I installd: installd cannot open vdex file during dexopt/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.vdex: No such file or dire
ctory
08-16 17:19:28.799 28677 28677 E dexoptanalyzer: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art!/system/etc/boot-image.prof
'. Attempting to fall back to imageless running. Error was:
08-16 17:19:29.014 28677 28677 W dexoptanalyzer: Current thread not detached in Runtime shutdown
08-16 17:19:29.020  1256 13652 D installd: Processed secondary dex file /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk result=1
08-16 17:19:29.021  1256 13652 V installd: DexInv: --- BEGIN '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' ---
08-16 17:19:29.021  1256 13652 V installd: Running /apex/com.android.art/bin/dex2oat64 in=tinker_classN.apk out=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.o
dex
08-16 17:19:29.035 28678 28678 W dex2oat64: Mismatch between dex2oat instruction set features to use (ISA: Arm64 Feature string: -a53,crc,lse,fp16,dotprod,-sve) and those from CPP defines (ISA: Arm6
4 Feature string: -a53,-crc,-lse,-fp16,-dotprod,-sve) for the command line:
08-16 17:19:29.035 28678 28678 W dex2oat64: /apex/com.android.art/bin/dex2oat64 --zip-fd=8 --zip-location=tinker_classN.apk --oat-fd=9 --oat-location=/data/user/0/tinker.sample.android/tinker/patch-
3a168268/dex/oat/arm64/tinker_classN.odex --input-vdex-fd=-1 --output-vdex-fd=10 --swap-fd=11 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --compact-dex-level=none --
instruction-set=arm64 --instruction-set-features=default --instruction-set-variant=cortex-a76 --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-co
nst-strings=true --debuggable --generate-mini-debug-info --runtime-arg -Xtarget-sdk-version:30 --runtime-arg -Xhidden-api-policy:enabled --runtime-arg -Xms64m --runtime-arg -Xmx512m
08-16 17:19:29.035 28678 28678 I dex2oat64: /apex/com.android.art/bin/dex2oat64 --input-vdex-fd=-1 --output-vdex-fd=10 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --
compact-dex-level=none --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-const-strings=true --debuggable --generate-mini-debug-info
08-16 17:19:29.052 28678 28678 E dex2oat64: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art'. Attempting to fall back to ima
geless running. Error was:
08-16 17:19:29.304 28678 28678 E dex2oat64: Missing primary boot image for app compilation.
08-16 17:19:29.312 28678 28678 I dex2oat64: dex2oat took 278.108ms (268.253ms cpu) (threads: 8)
08-16 17:19:29.318  1256 13652 V installd: DexInv: --- END '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' --- status=0x 100, process failed
08-16 17:19:29.318  1256 13652 E installd: Dex2oat invocation for /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (256)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer: Failed to dexopt
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer: com.android.server.pm.Installer$InstallerException: android.os.ServiceSpecificException: Dex2oat invocation for /data/user/0/tinker.sample.andro
id/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (code 256)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.Installer.dexopt(Installer.java:506)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPathLI(PackageDexOptimizer.java:526)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPath(PackageDexOptimizer.java:437)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.dex.DexManager.registerDexModule(DexManager.java:787)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.registerDexModule(PackageManagerService.java:12759)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer:   at android.content.pm.IPackageManager$Stub.onTransact(IPackageManager.java:3596)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.onTransact(PackageManagerService.java:8506)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransactInternal(Binder.java:1179)
08-16 17:19:29.319  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransact(Binder.java:1143)
08-16 17:19:29.319 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, verify, tinker.sample.android]
08-16 17:19:29.321 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:30.324 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:19:30.331 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:31.333 28643 28661 W e.android:patc: Accessing hidden field Landroid/content/pm/IPackageManager$Stub;->TRANSACTION_performDexOptSecondary:I (max-target-o, reflection, denied)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex: [-] Error.  java.lang.IllegalStateException: Cannot query transaction code of performDexOptSecondary.
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:347)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.triggerPMDexOptOnDemand(TinkerDexOptimizer.java:275)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.access$200(TinkerDexOptimizer.java:67)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer$OptimizeWorker.run(TinkerDexOptimizer.java:166)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:108)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:83)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.dexOptimizeDexFiles(DexDiffPatchInternal.java:381)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.patchDexExtractViaDexDiff(DexDiffPatchInternal.java:196)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.tryRecoverDexFiles(DexDiffPatchInternal.java:87)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.UpgradePatch.tryPatch(UpgradePatch.java:170)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.doApplyPatch(TinkerPatchService.java:223)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.onHandleIntent(TinkerPatchService.java:101)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at android.app.IntentService$ServiceHandler.handleMessage(IntentService.java:78)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at android.os.Handler.dispatchMessage(Handler.java:106)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loopOnce(Looper.java:201)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loop(Looper.java:288)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at android.os.HandlerThread.run(HandlerThread.java:67)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.reflect.InvocationTargetException
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at java.lang.reflect.Method.invoke(Native Method)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:340)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    ... 16 more
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.NoSuchFieldException: No field TRANSACTION_performDexOptSecondary in class Landroid/content/pm/IPackageManager$Stub; (declar
ation of 'android.content.pm.IPackageManager$Stub' appears in /system/framework/framework.jar)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    at java.lang.Class.getDeclaredField(Native Method)
08-16 17:19:31.345 28643 28661 E Tinker.ParallelDex:    ... 18 more
08-16 17:19:32.350  2441 12362 D PackageDexOptimizer: Running dexopt on: /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk pkg=tinker.sample.android isa=[arm64] reason=i
nstall dexoptFlags=debuggable,public,secondary,storage_ce,enable_hidden_api_checks target-filter=verify class-loader-context=null
08-16 17:19:32.351  1256 13652 D installd: Processing secondary dex path /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk
08-16 17:19:32.356 28680 28680 I installd: installd cannot open oat file during dexopt/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.odex: No such file or direc
tory
08-16 17:19:32.356 28680 28680 I installd: installd cannot open vdex file during dexopt/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.vdex: No such file or dire
ctory
08-16 17:19:32.372 28680 28680 E dexoptanalyzer: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art!/system/etc/boot-image.prof
'. Attempting to fall back to imageless running. Error was:
08-16 17:19:32.574 28680 28680 W dexoptanalyzer: Current thread not detached in Runtime shutdown
08-16 17:19:32.580  1256 13652 D installd: Processed secondary dex file /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk result=1
08-16 17:19:32.581  1256 13652 V installd: DexInv: --- BEGIN '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' ---
08-16 17:19:32.581  1256 13652 V installd: Running /apex/com.android.art/bin/dex2oat64 in=tinker_classN.apk out=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/oat/arm64/tinker_classN.o
dex
08-16 17:19:32.595 28681 28681 W dex2oat64: Mismatch between dex2oat instruction set features to use (ISA: Arm64 Feature string: -a53,crc,lse,fp16,dotprod,-sve) and those from CPP defines (ISA: Arm6
4 Feature string: -a53,-crc,-lse,-fp16,-dotprod,-sve) for the command line:
08-16 17:19:32.595 28681 28681 W dex2oat64: /apex/com.android.art/bin/dex2oat64 --zip-fd=8 --zip-location=tinker_classN.apk --oat-fd=9 --oat-location=/data/user/0/tinker.sample.android/tinker/patch-
3a168268/dex/oat/arm64/tinker_classN.odex --input-vdex-fd=-1 --output-vdex-fd=10 --swap-fd=11 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --compact-dex-level=none --
instruction-set=arm64 --instruction-set-features=default --instruction-set-variant=cortex-a76 --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-co
nst-strings=true --debuggable --generate-mini-debug-info --runtime-arg -Xtarget-sdk-version:30 --runtime-arg -Xhidden-api-policy:enabled --runtime-arg -Xms64m --runtime-arg -Xmx512m
08-16 17:19:32.596 28681 28681 I dex2oat64: /apex/com.android.art/bin/dex2oat64 --input-vdex-fd=-1 --output-vdex-fd=10 --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex --
compact-dex-level=none --compiler-filter=verify --compilation-reason=install --max-image-block-size=524288 --resolve-startup-const-strings=true --debuggable --generate-mini-debug-info
08-16 17:19:32.614 28681 28681 E dex2oat64: Could not create image space with image file '/apex/com.android.art/javalib/boot.art:/system/framework/boot-framework.art'. Attempting to fall back to ima
geless running. Error was:
08-16 17:19:32.863 28681 28681 E dex2oat64: Missing primary boot image for app compilation.
08-16 17:19:32.883 28681 28681 I dex2oat64: dex2oat took 288.944ms (266.496ms cpu) (threads: 8)
08-16 17:19:32.890  1256 13652 V installd: DexInv: --- END '/data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk' --- status=0x 100, process failed
08-16 17:19:32.890  1256 13652 E installd: Dex2oat invocation for /data/user/0/tinker.sample.android/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (256)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer: Failed to dexopt
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer: com.android.server.pm.Installer$InstallerException: android.os.ServiceSpecificException: Dex2oat invocation for /data/user/0/tinker.sample.andro
id/tinker/patch-3a168268/dex/tinker_classN.apk failed: dex2oat error (code 256)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.Installer.dexopt(Installer.java:506)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPathLI(PackageDexOptimizer.java:526)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageDexOptimizer.dexOptSecondaryDexPath(PackageDexOptimizer.java:437)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.dex.DexManager.registerDexModule(DexManager.java:787)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.registerDexModule(PackageManagerService.java:12759)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer:   at android.content.pm.IPackageManager$Stub.onTransact(IPackageManager.java:3596)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer:   at com.android.server.pm.PackageManagerService.onTransact(PackageManagerService.java:8506)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransactInternal(Binder.java:1179)
08-16 17:19:32.891  2441 12362 W PackageDexOptimizer:   at android.os.Binder.execTransact(Binder.java:1143)
08-16 17:19:32.891 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, verify, tinker.sample.android]
08-16 17:19:32.893 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:33.897 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:19:33.903 28643 28661 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:19:34.255  2837  3458 D QCNEJ/WlanStaInfoRelay: Received action: android.net.wifi.RSSI_CHANGED
08-16 17:19:34.905 28643 28661 W e.android:patc: Accessing hidden field Landroid/content/pm/IPackageManager$Stub;->TRANSACTION_performDexOptSecondary:I (max-target-o, reflection, denied)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex: [-] Error.  java.lang.IllegalStateException: Cannot query transaction code of performDexOptSecondary.
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:347)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.triggerPMDexOptOnDemand(TinkerDexOptimizer.java:275)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.access$200(TinkerDexOptimizer.java:67)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer$OptimizeWorker.run(TinkerDexOptimizer.java:166)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:108)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.optimizeAll(TinkerDexOptimizer.java:83)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.dexOptimizeDexFiles(DexDiffPatchInternal.java:381)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.patchDexExtractViaDexDiff(DexDiffPatchInternal.java:196)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.DexDiffPatchInternal.tryRecoverDexFiles(DexDiffPatchInternal.java:87)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.patch.UpgradePatch.tryPatch(UpgradePatch.java:170)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.doApplyPatch(TinkerPatchService.java:223)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.lib.service.TinkerPatchService.onHandleIntent(TinkerPatchService.java:101)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at android.app.IntentService$ServiceHandler.handleMessage(IntentService.java:78)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at android.os.Handler.dispatchMessage(Handler.java:106)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loopOnce(Looper.java:201)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at android.os.Looper.loop(Looper.java:288)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at android.os.HandlerThread.run(HandlerThread.java:67)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.reflect.InvocationTargetException
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at java.lang.reflect.Method.invoke(Native Method)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at com.tencent.tinker.loader.TinkerDexOptimizer.performDexOptSecondaryByTransactionCode(TinkerDexOptimizer.java:340)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    ... 16 more
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex: Caused by: java.lang.NoSuchFieldException: No field TRANSACTION_performDexOptSecondary in class Landroid/content/pm/IPackageManager$Stub; (declar
ation of 'android.content.pm.IPackageManager$Stub' appears in /system/framework/framework.jar)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    at java.lang.Class.getDeclaredField(Native Method)
08-16 17:19:34.916 28643 28661 E Tinker.ParallelDex:    ... 18 more
waruqi commented 1 year ago

logs error 太多，看错嘞，我看代码里会循环 20 次，不停地尝试各种 dex2oat ，有些不支持的也把 error 栈打出来了而已。。最后也确实会成功。。

但是现在的问题是，之前我们用的去年9月份的版本，在 demo app 上合成是非常快的，基本1、2秒搞定了，现在必须跑完接近20次，才合成完，慢了半分钟左右。

另外一台荣耀 v20 的 android 10 上，error 栈错误没了，但是也要等跑完所有的 20 次才能成功，之前也是一下子就好了。

这是那台荣耀的，dex2oat 成功了，但是跑了近1分钟才成功。。在一个很小的 demo app 上。

08-16 17:34:06.023 20780 20780 W Tinker.Tinker: tinker load fail!
08-16 17:34:06.023 20780 20780 D Tinker.DefaultAppLike: onCreate
08-16 17:34:06.025 20780 20800 I AwareBitmapCacher: init processName:tinker.sample.android:patch pid=20780 uid=10913
08-16 17:34:06.029 20780 20806 I Tinker.TinkerPatchService: for system version >= Android O, we just ignore increasingPriority job to avoid crash or toasts.
08-16 17:34:06.030 20780 20806 I Tinker.DefaultPatchReporter: patchReporter onPatchServiceStart: patch service start
08-16 17:34:06.031 20780 20780 D Tinker.TinkerLoader: [PendingLog @ 2022-08-16 17:34:06.012] tryLoad test test
08-16 17:34:06.031 20780 20780 W Tinker.TinkerLoader: [PendingLog @ 2022-08-16 17:34:06.014] tryLoadPatchFiles: we don't load patch with :patch process itself, just return
08-16 17:34:06.031 20780 20780 D Tinker.DefaultAppLike: [PendingLog @ 2022-08-16 17:34:06.015] onBaseContextAttached:
08-16 17:34:06.032 20780 20780 W Tinker.UpgradePatchRetry: onPatchRetryLoad retry is not main process, just return
08-16 17:34:06.033 20780 20806 W Tinker.UpgradePatchRetry: try copy file: /storage/emulated/0/Android/data/tinker.sample.android/files/patch/patch_signed_7zip.apk to /data/user/0/tinker.sample.andro
id/tinker_temp/temp.apk
08-16 17:34:06.077 20780 20806 I Tinker.UpgradePatch: UpgradePatch tryPatch:patchMd5:c84f053bf481f8408d8d266932de6833
08-16 17:34:06.078 20780 20806 W Tinker.PatchInfo: read property failed, e:java.io.FileNotFoundException: /data/user/0/tinker.sample.android/tinker/patch.info: open failed: ENOENT (No such file or d
irectory)
08-16 17:34:06.078 20780 20806 W Tinker.PatchInfo: read property failed, e:java.io.FileNotFoundException: /data/user/0/tinker.sample.android/tinker/patch.info: open failed: ENOENT (No such file or d
irectory)
08-16 17:34:06.079 20780 20806 I Tinker.UpgradePatch: UpgradePatch tryPatch:patchVersionDirectory:/data/user/0/tinker.sample.android/tinker/patch-c84f053b
08-16 17:34:06.080 20780 20806 W Tinker.UpgradePatch: UpgradePatch copy patch file, src file: /storage/emulated/0/Android/data/tinker.sample.android/files/patch/patch_signed_7zip.apk size: 23662, de
st file: /data/user/0/tinker.sample.android/tinker/patch-c84f053b/patch-c84f053b.apk size:23662
08-16 17:34:06.581 20780 20806 W Tinker.DexDiffPatchInternal: success recover dex file: /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/classes2.dex.jar, size: 933395, use time: 498
08-16 17:34:06.657 20780 20806 W Tinker.DexDiffPatchInternal: success recover dex file: /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/classes.dex.jar, size: 154014, use time: 76
08-16 17:34:06.657 20780 20806 I Tinker.DexDiffPatchInternal: try Extracting /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/test.dex.jar
08-16 17:34:06.659 20780 20806 I Tinker.DexDiffPatchInternal: isExtractionSuccessful: true
08-16 17:34:06.693 20780 20806 I Tinker.PatchFileUtil: safeDeleteFile, try to delete path: /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/classes.dex.jar
08-16 17:34:06.693 20780 20806 I Tinker.PatchFileUtil: safeDeleteFile, try to delete path: /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/test.dex.jar
08-16 17:34:06.694 20780 20806 I Tinker.PatchFileUtil: safeDeleteFile, try to delete path: /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/classes2.dex.jar
08-16 17:34:06.694 20780 20806 I Tinker.DexDiffPatchInternal: merge classN dex file /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk, result: true, size: 2612339, use:
35ms
08-16 17:34:06.694 20780 20806 I Tinker.DexDiffPatchInternal: legal files to do dexopt: [/data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk]
08-16 17:34:06.695 20780 20806 D Tinker.TinkerInternals: getCurrentInstructionSet:arm64
08-16 17:34:06.695 20780 20806 I Tinker.DexDiffPatchInternal: patch recover, try to optimize dex file count:1, optimizeDexDirectory:/data/user/0/tinker.sample.android/tinker/patch-c84f053b/odex/
08-16 17:34:06.697 20780 20806 I Tinker.DexDiffPatchInternal: start to parallel optimize dex /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk, size: 2612339
08-16 17:34:06.698 20780 20806 I Tinker.ParallelDex: Creating fake odex path structure.
08-16 17:34:06.726 20780 20806 W e.android:patc: Failed execv(/system/bin/dex2oat --debuggable --instruction-set=arm64 --instruction-set-features=runtime --runtime-arg -Xhidden-api-policy:enabled --
runtime-arg -Xrelocate --boot-image=/system/framework/boot.art --runtime-arg -Xms64m --runtime-arg -Xmx512m -j4 --instruction-set-variant=generic --instruction-set-features=default --generate-mini-d
ebug-info --debuggable --generate-mini-debug-info --dex-file=/data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk --output-vdex-fd=85 --oat-fd=84 --oat-location=/data/user/
0/tinker.sample.android/tinker/patch-c84f053b/dex/oat/arm64/tinker_classN.odex --compiler-filter=verify --class-loader-context=& --compilation-reason=dynamic-load) because non-0 exit status
08-16 17:34:06.743 20780 20806 I Tinker.ParallelDex: [+] Hit target device, do dexopt logic now.
08-16 17:34:06.744 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:06.746 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:07.747 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:07.749 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:08.752 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:09.754 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:09.755 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:10.554  1039  1098 D AwareLog: iawared: WorkingsetProcessCommand subCmd = 352, userId=10913, pid=20686, tinker.sample.android
08-16 17:34:10.554  1039  1098 D AwareLog: iawared: WorkingsetStop tinker.sample.android
08-16 17:34:10.757 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:10.759 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:11.761 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:12.764 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:12.767 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:13.769 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:13.772 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:14.775 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:15.777 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:15.780 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:16.782 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:16.785 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:17.787 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:18.790 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:18.792 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:19.794 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:19.798 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:20.800 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:21.802 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:21.805 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:22.807 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:22.810 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:23.812 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:24.815 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:24.818 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:25.821 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:25.824 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:26.826 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:27.829 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:27.831 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:28.834 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:28.837 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:29.839 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:30.842 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:30.845 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:31.847 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:31.850 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:32.852 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:33.855 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:33.858 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:34.859 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:34.864 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:35.866 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:36.868 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:36.871 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:37.872 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:37.876 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:38.878 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:39.881 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:39.884 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:40.886 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:40.889 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:41.891 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:42.894 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:42.896 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:43.898 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:43.902 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:44.904 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:45.907 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:45.910 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:46.912 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:46.915 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:47.917 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:48.920 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:48.923 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:49.924 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:49.927 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:50.929 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:51.931 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:51.934 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:52.936 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:52.941 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:53.943 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:54.946 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:54.949 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:55.954 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:55.957 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:56.958 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:34:57.961 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:34:57.964 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:58.966 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:34:58.970 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:34:59.972 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:35:00.975 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:35:00.978 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:35:01.980 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:35:01.983 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:35:02.985 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:35:03.988 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [compile, -f, --secondary-dex, -m, speed-profile, tinker.sample.android]
08-16 17:35:03.990 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:35:04.991 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd, args: [bg-dexopt-job, tinker.sample.android]
08-16 17:35:04.995 20780 20806 I Tinker.ParallelDex: [+] Execute shell cmd done.
08-16 17:35:05.997 20780 20806 I Tinker.ParallelDex: [+] performDexOptSecondaryByTransactionCode, code: 120
08-16 17:35:07.010  1587  2700 D PackageManager.DexOptimizer: Running dexopt on: /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk pkg=tinker.sample.android isa=[arm64]
reason=install dexoptFlags=debuggable,public,secondary,storage_ce,enable_hidden_api_checks target-filter=extract class-loader-context=null
08-16 17:35:07.011  1022  1022 D installd: Processing secondary dex path /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk
08-16 17:35:07.013 20897 20897 D installd: Mismatched cache GID/mode at /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/oat: found 10913/448 but expected 10913/505
08-16 17:35:07.013 20897 20897 I installd: installd cannot open oat file during dexopt/data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/oat/arm64/tinker_classN.odex: No such file or direc
tory
08-16 17:35:07.013 20897 20897 I installd: installd cannot open vdex file during dexopt/data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/oat/arm64/tinker_classN.vdex: No such file or dire
ctory
08-16 17:35:07.089  1022  1022 D installd: Processed secondary dex file /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk result=1
08-16 17:35:07.090  1022  1022 V installd: DexInv: --- BEGIN '/data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk' ---
08-16 17:35:07.091  1022  1022 D installd: forkNotifyToRMS parcel pid=20898, ppid=1022, pkg=tinker.sample.android, status=0, num=0, time=0
08-16 17:35:07.142 20898 20898 I dex2oat : /apex/com.android.runtime/bin/dex2oat --input-vdex-fd=-1 --output-vdex-fd=10 --resolve-startup-const-strings=true --max-image-block-size=1048576 --compiler
-filter=extract -j4 --debuggable --classpath-dir=/data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex --generate-mini-debug-info --compact-dex-level=none --compilation-reason=install
08-16 17:35:07.174 20898 20898 W dex2oat : type=1400 audit(0.0:321731): avc: denied { getattr } for pid=20898 path="/data/data/tinker.sample.android" dev="sdd71" ino=1496166 scontext=u:r:dex2oat:s0
tcontext=u:object_r:app_data_file:s0:c145,c259,c512,c768 tclass=dir permissive=0
08-16 17:35:07.224  1022  1022 V installd: DexInv: --- END '/data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk' (success) ---
08-16 17:35:07.224  1587  2700 E DexManager: Failed to optimize dex module /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk
08-16 17:35:07.225 20780 20806 I Tinker.ParallelDex: [+] File /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/oat/arm64/tinker_classN.vdex was found.
08-16 17:35:07.225 20780 20806 I Tinker.DexDiffPatchInternal: success to parallel optimize dex /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/tinker_classN.apk, opt file:/data/user/0/t
inker.sample.android/tinker/patch-c84f053b/dex/oat/arm64/tinker_classN.odex, opt file size: 50016, use time 60528
08-16 17:35:07.226 20780 20806 I Tinker.DexDiffPatchInternal: recover dex result:true, cost:61144
08-16 17:35:07.226 20780 20806 W Tinker.BsDiffPatchInternal: patch recover, library is not contained
08-16 17:35:07.228 20780 20806 W Tinker.ResDiffPatchInternal: patch recover, resource is not contained
08-16 17:35:07.228 20780 20806 I Tinker.DexDiffPatchInternal: raw dex count: 3, dex opt dex count: 1, final wait times: 90
08-16 17:35:07.231 20780 20806 I Tinker.DexDiffPatchInternal: check dex optimizer file exist: /data/user/0/tinker.sample.android/tinker/patch-c84f053b/dex/oat/arm64/tinker_classN.odex, size 50016
08-16 17:35:07.232 20780 20806 I Tinker.DexDiffPatchInternal: check dex optimizer file format: tinker_classN.odex, size 50016
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo: rewritePatchInfoFile file path:/data/user/0/tinker.sample.android/tinker/patch.info , oldVer:, newVer:c84f053bf481f8408d8d266932de6833, isProtected
App:0, versionToRemove:, fingerprint:HONOR/PCT-AL10/HWPCT:10/HUAWEIPCT-AL10/10.1.0.162C00:user/release-keys, oatDir:odex, isRemoveInterpretOATDir:0, stack: java.lang.Throwable
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo:      at com.tencent.tinker.loader.shareutil.SharePatchInfo.rewritePatchInfoFile(SharePatchInfo.java:184)
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo:      at com.tencent.tinker.loader.shareutil.SharePatchInfo.rewritePatchInfoFileWithLock(SharePatchInfo.java:104)
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo:      at com.tencent.tinker.lib.patch.UpgradePatch.tryPatch(UpgradePatch.java:196)
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo:      at com.tencent.tinker.lib.service.TinkerPatchService.doApplyPatch(TinkerPatchService.java:223)
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo:      at com.tencent.tinker.lib.service.TinkerPatchService.onHandleIntent(TinkerPatchService.java:101)
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo:      at android.app.IntentService$ServiceHandler.handleMessage(IntentService.java:78)
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo:      at android.os.Handler.dispatchMessage(Handler.java:110)
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo:      at android.os.Looper.loop(Looper.java:219)
08-16 17:35:07.235 20780 20806 I Tinker.PatchInfo:      at android.os.HandlerThread.run(HandlerThread.java:67)
08-16 17:35:07.236 20780 20806 I Tinker.UpgradePatchRetry: onPatchResetMaxCheck, reset max check to 1
08-16 17:35:07.236 20780 20806 W Tinker.UpgradePatch: UpgradePatch tryPatch: done, it is ok
08-16 17:35:07.237 20780 20806 I Tinker.DefaultPatchReporter: patchReporter onPatchResult: patch all result path: /storage/emulated/0/Android/data/tinker.sample.android/files/patch/patch_signed_7zip
.apk, success: true, cost: 61194
08-16 17:35:07.237 20780 20806 I Tinker.PatchFileUtil: safeDeleteFile, try to delete path: /data/user/0/tinker.sample.android/tinker_temp/temp.apk
08-16 17:35:07.250 20686 20904 V Tinker.SampleResultService: SampleResultService receive result:
08-16 17:35:07.250 20686 20904 V Tinker.SampleResultService: PatchResult:
08-16 17:35:07.250 20686 20904 V Tinker.SampleResultService: isSuccess:true
08-16 17:35:07.250 20686 20904 V Tinker.SampleResultService: rawPatchFilePath:/storage/emulated/0/Android/data/tinker.sample.android/files/patch/patch_signed_7zip.apk
08-16 17:35:07.250 20686 20904 V Tinker.SampleResultService: costTime:61194
08-16 17:35:07.250 20686 20904 V Tinker.SampleResultService: dexoptTriggerTime:1660642446695
08-16 17:35:07.250 20686 20904 V Tinker.SampleResultService: isOatGenerated:true
08-16 17:35:07.250 20686 20904 V Tinker.SampleResultService: patchVersion:c84f053bf481f8408d8d266932de6833
08-16 17:35:07.251 20686 20904 W Tinker.DefaultTinkerResultService: deleteRawPatchFile rawFile path: /storage/emulated/0/Android/data/tinker.sample.android/files/patch/patch_signed_7zip.apk
08-16 17:35:07.251 20686 20904 I Tinker.PatchFileUtil: safeDeleteFile, try to delete path: /storage/emulated/0/Android/data/tinker.sample.android/files/patch/patch_signed_7zip.apk
08-16 17:35:07.252 20686 20904 V Tinker.SampleResultService: tinker wait screen to restart process
08-16 17:35:07.267  2792  3849 I PG_ash  : tinker.sample.android  has toast view ,pid :20686
08-16 17:35:07.268  1587 12441 I HwPCUtils#HwRioViewManager: check if rio enable, displayId = 0， packageName = tinker.sample.android
08-16 17:35:07.269  1587  6253 I ActivityManager: Process tinker.sample.android:patch (pid 20780) has died: vis BTOP
08-16 17:35:07.270  1587  6253 D ActivityManager: cleanUpApplicationRecord app: 20780:tinker.sample.android:patch/u0a913, bad: false, restarting: false, allowRestart: true
08-16 17:35:07.274  1587  6253 W ActivityManager: Scheduling restart of crashed service tinker.sample.android/com.tencent.tinker.lib.service.TinkerPatchForeService in 1000ms
artharyoung commented 1 year ago

+1 小米手机 Android 12 同样问题

guozhongrui000 commented 1 year ago

也遇到同样的问题

qianqianyixia commented 1 year ago

同样的问题 而且补丁包安装重启生效运行时会报tinker load exception 然后自动清除补丁，导致 补丁只在首次重启后有效

liangdong9676 commented 1 year ago

+1 小米手机 Android 12 同样问题

华为系的手机 合成挺快的

wojiaosuxiaobai commented 1 year ago

我也是同样的问题，请问老哥解决了吗 一加8T Android11

hxw-haha commented 10 months ago

+1 小米手机 Android 12 同样问题

华为系的手机 合成挺快的

版本：1.9.14.25.3 最新版 合成都很慢，大概40秒。 请问下老哥用的哪个版本？

bensonX commented 7 months ago

也是很慢，90秒左右，最新版 1.9.14.26