Skip to content

Instantly share code, notes, and snippets.

@ganadist
Last active December 11, 2018 01:17
Show Gist options
  • Save ganadist/ba90d1af0b539540bb9dd86ec3e10b06 to your computer and use it in GitHub Desktop.
Save ganadist/ba90d1af0b539540bb9dd86ec3e10b06 to your computer and use it in GitHub Desktop.
[user@host trebuchet]$ ./scripts/run-startup.sh com.kakao.talk .activity.SplashActivity
+ PACKAGE=com.kakao.talk
+ ACTIVITY=.activity.SplashActivity
+ ADB=adb
+ adb root
adbd cannot run as root in production builds
+ adb shell 'am force-stop com.kakao.talk'
+ adb shell 'pm compile -m speed com.kakao.talk'
Success
+ adb shell 'echo 3 > /proc/sys/vm/drop_caches'
/system/bin/sh: can't create /proc/sys/vm/drop_caches: Permission denied
+ adb shell 'atrace -a com.kakao.talk -b 32768 --async_start input dalvik view am wm sched freq idle sync binder_driver hal freq'
capturing trace...+ adb shell 'am start -W -n com.kakao.talk/.activity.SplashActivity'
Starting: Intent { cmp=com.kakao.talk/.activity.SplashActivity }
Status: ok
Activity: com.kakao.talk/.activity.SplashActivity
ThisTime: 1515
TotalTime: 1515
WaitTime: 1573
Complete
+ sleep 10
+ adb shell 'atrace --async_stop -o /sdcard/atrace.trace'
done
+ adb pull /sdcard/atrace.trace
/sdcard/atrace.trace: 1 file pulled. 40.4 MB/s (49084428 bytes in 1.159s)
++ pwd
+ ./gradlew :trebuchet:startup-analyzer:run --args=/home/ganadist/src/build/aosp/android/tools/trebuchet/atrace.trace
> Task :trebuchet:startup-analyzer:run
Opening `/home/ganadist/src/build/aosp/android/tools/trebuchet/atrace.trace`
Progress: 100.00%
Parsing atrace.trace took 674ms
App Startup summary for com.kakao.talk (9820):
Start offset: 183.944 ms
Startup period end point: activityResume
Time to first slice: 93.391 ms
Startup duration: 1388.754 ms
Unallocated time: 7.379 ms
Top-level slice information:
activityResume
Event count: 1
Total duration: 78.958 ms
activityStart
Event count: 1
Total duration: 112.382 ms
ActivityThreadMain
Event count: 1
Total duration: 32.600 ms
bindApplication
Event count: 1
Total duration: 1041.421 ms
PostFork
Event count: 1
Total duration: 3.038 ms
setCoreSettings
Event count: 1
Total duration: 0.039 ms
ZygoteInit
Event count: 1
Total duration: 19.546 ms
All slice information:
activityResume
Event count: 1
Total duration: 78.958 ms
Total duration (self): 78.958 ms
activityStart
Event count: 1
Total duration: 112.382 ms
Total duration (self): 66.110 ms
ActivityThreadMain
Event count: 1
Total duration: 32.600 ms
Total duration (self): 32.600 ms
bindApplication
Event count: 1
Total duration: 1041.421 ms
Total duration (self): 924.146 ms
createClassloaderNamespace
Event count: 2
Total duration: 20.840 ms
Total duration (self): 20.840 ms
FrameLayout
Event count: 2
Total duration: 0.144 ms
Total duration (self): 0.144 ms
FullSuspendCheck
Event count: 2
Total duration: 4.403 ms
Total duration (self): 4.381 ms
inflate
Event count: 3
Total duration: 46.176 ms
Total duration (self): 33.903 ms
initializeJavaContextClassLoader
Event count: 1
Total duration: 1.537 ms
Total duration (self): 1.537 ms
LinearLayout
Event count: 1
Total duration: 0.186 ms
Total duration (self): 0.186 ms
Load Dex files from classpath
Event count: 2
Total duration: 71.796 ms
Total duration (self): 6.872 ms
Lock contention
Event count: 17
Total duration: 0.354 ms
Total duration (self): 0.354 ms
makeApplication
Event count: 1
Total duration: 37.577 ms
Total duration (self): 36.040 ms
NetworkSecurityConfigProvider.install
Event count: 1
Total duration: 0.166 ms
Total duration (self): 0.166 ms
Open dex file
Event count: 7
Total duration: 3.051 ms
Total duration (self): 3.051 ms
Event details:
/system/framework/org.apache.http.legacy.boot.jar @ 0.035 ms
/system/framework/com.google.android.maps.jar @ 0.031 ms
/data/app/com.kakao.talk @ 0.808 ms
/data/app/com.kakao.talk @ 0.621 ms
/data/app/com.kakao.talk @ 0.624 ms
/data/app/com.kakao.talk @ 0.895 ms
/data/app/com.android.chrome @ 0.037 ms
Open dex file function invocation
Event count: 7
Total duration: 3.078 ms
Total duration (self): 0.027 ms
Open oat file
Event count: 8
Total duration: 14.427 ms
Total duration (self): 14.427 ms
Event details:
/data/dalvik-cache/arm/system@framework@org.apache.http.legacy.boot.jar@classes.dex @ 0.024 ms
/system/framework/oat/arm/org.apache.http.legacy.boot.odex @ 3.766 ms
/data/dalvik-cache/arm/system@framework@com.google.android.maps.jar@classes.dex @ 0.028 ms
/system/framework/oat/arm/com.google.android.maps.odex @ 1.808 ms
/data/dalvik-cache/arm/data@app@com.kakao.talk-M5719UNkgzi7zqMKYFCbcg==@base.apk@classes.dex @ 0.031 ms
/data/app/com.kakao.talk-M5719UNkgzi7zqMKYFCbcg==/oat/arm/base.odex @ 6.240 ms
/data/dalvik-cache/arm/data@app@com.android.chrome-ifdOEErF8hBTmrQIi9peFg==@base.apk@classes.dex @ 0.824 ms
/data/app/com.android.chrome-ifdOEErF8hBTmrQIi9peFg==/oat/arm/base.odex @ 1.706 ms
OpenDexFilesFromOat
Event count: 4
Total duration: 44.084 ms
Total duration (self): 24.007 ms
OpenImageFile
Event count: 4
Total duration: 2.572 ms
Total duration (self): 2.572 ms
PostFork
Event count: 1
Total duration: 3.038 ms
Total duration (self): 3.038 ms
setCoreSettings
Event count: 1
Total duration: 0.039 ms
Total duration (self): 0.039 ms
setLayerPaths
Event count: 2
Total duration: 0.028 ms
Total duration (self): 0.028 ms
Setup proxies
Event count: 1
Total duration: 0.199 ms
Total duration (self): 0.199 ms
setupGraphicsSupport
Event count: 1
Total duration: 2.680 ms
Total duration (self): 2.680 ms
Unknown Slice
Event count: 19
Total duration: 10.973 ms
Total duration (self): 10.973 ms
Event details:
Run checkpoint function @ 0.018 ms
Run checkpoint function @ 0.014 ms
Run checkpoint function @ 0.012 ms
Run checkpoint function @ 0.014 ms
Run checkpoint function @ 0.010 ms
Run checkpoint function @ 0.015 ms
Run checkpoint function @ 0.017 ms
Run checkpoint function @ 0.016 ms
Run checkpoint function @ 0.013 ms
Run checkpoint function @ 0.023 ms
Run checkpoint function @ 0.016 ms
Run checkpoint function @ 0.011 ms
Run checkpoint function @ 0.010 ms
Run checkpoint function @ 0.001 ms
android.support.v7.widget.FitWindowsLinearLayout @ 0.961 ms
android.support.v7.widget.ViewStubCompat @ 0.318 ms
android.support.v7.widget.ContentFrameLayout @ 0.448 ms
com.kakao.talk.widget.theme.ThemeImageView @ 8.832 ms
com.kakao.talk.widget.theme.ThemeImageView @ 0.224 ms
ViewStub
Event count: 4
Total duration: 1.160 ms
Total duration (self): 1.160 ms
ZygoteInit
Event count: 1
Total duration: 19.546 ms
Total duration (self): 19.546 ms
BUILD SUCCESSFUL in 1s
11 actionable tasks: 1 executed, 10 up-to-date
[user@host trebuchet]$ ./scripts/run-startup.sh jp.naver.line.android .activity.SplashActivity
+ PACKAGE=jp.naver.line.android
+ ACTIVITY=.activity.SplashActivity
+ ADB=adb
+ adb root
adbd cannot run as root in production builds
+ adb shell 'am force-stop jp.naver.line.android'
+ adb shell 'pm compile -m speed jp.naver.line.android'
Success
+ adb shell 'echo 3 > /proc/sys/vm/drop_caches'
/system/bin/sh: can't create /proc/sys/vm/drop_caches: Permission denied
+ adb shell 'atrace -a jp.naver.line.android -b 32768 --async_start input dalvik view am wm sched freq idle sync binder_driver hal freq'
capturing trace...+ adb shell 'am start -W -n jp.naver.line.android/.activity.SplashActivity'
Starting: Intent { cmp=jp.naver.line.android/.activity.SplashActivity }
Status: ok
Activity: jp.naver.line.android/.activity.SplashActivity
ThisTime: 978
TotalTime: 978
WaitTime: 1035
Complete
+ sleep 10
+ adb shell 'atrace --async_stop -o /sdcard/atrace.trace'
done
+ adb pull /sdcard/atrace.trace
/sdcard/atrace.trace: 1 file pulled. 40.3 MB/s (56201168 bytes in 1.332s)
++ pwd
+ ./gradlew :trebuchet:startup-analyzer:run --args=/home/ganadist/src/build/aosp/android/tools/trebuchet/atrace.trace
> Task :trebuchet:startup-analyzer:run
Opening `/home/ganadist/src/build/aosp/android/tools/trebuchet/atrace.trace`
Progress: 100.00%
Parsing atrace.trace took 1220ms
App Startup summary for jp.naver.line.android (7750):
Start offset: 126.896 ms
Startup period end point: activityResume
Time to first slice: 26.485 ms
Startup duration: 784.173 ms
Unallocated time: 12.950 ms
Top-level slice information:
activityResume
Event count: 1
Total duration: 82.465 ms
activityStart
Event count: 1
Total duration: 345.090 ms
ActivityThreadMain
Event count: 1
Total duration: 16.137 ms
bindApplication
Event count: 1
Total duration: 297.556 ms
Lock contention
Event count: 3
Total duration: 0.013 ms
PostFork
Event count: 1
Total duration: 0.497 ms
setCoreSettings
Event count: 1
Total duration: 0.036 ms
ZygoteInit
Event count: 1
Total duration: 2.944 ms
All slice information:
activityResume
Event count: 1
Total duration: 82.465 ms
Total duration (self): 80.808 ms
activityStart
Event count: 1
Total duration: 345.090 ms
Total duration (self): 325.095 ms
ActivityThreadMain
Event count: 1
Total duration: 16.137 ms
Total duration (self): 16.137 ms
bindApplication
Event count: 1
Total duration: 297.556 ms
Total duration (self): 212.201 ms
createClassloaderNamespace
Event count: 1
Total duration: 2.147 ms
Total duration (self): 2.147 ms
FrameLayout
Event count: 1
Total duration: 0.070 ms
Total duration (self): 0.070 ms
FullSuspendCheck
Event count: 1
Total duration: 0.356 ms
Total duration (self): 0.356 ms
ImageView
Event count: 2
Total duration: 0.201 ms
Total duration (self): 0.201 ms
inflate
Event count: 2
Total duration: 19.407 ms
Total duration (self): 0.760 ms
initializeJavaContextClassLoader
Event count: 1
Total duration: 0.473 ms
Total duration (self): 0.473 ms
LinearLayout
Event count: 3
Total duration: 0.286 ms
Total duration (self): 0.286 ms
Load Dex files from classpath
Event count: 1
Total duration: 35.076 ms
Total duration (self): 2.301 ms
Lock contention
Event count: 36
Total duration: 1.963 ms
Total duration (self): 1.963 ms
makeApplication
Event count: 1
Total duration: 46.354 ms
Total duration (self): 45.881 ms
NetworkSecurityConfigProvider.install
Event count: 1
Total duration: 0.182 ms
Total duration (self): 0.182 ms
Open dex file
Event count: 9
Total duration: 5.886 ms
Total duration (self): 5.886 ms
Event details:
/system/framework/org.apache.http.legacy.boot.jar @ 0.030 ms
/system/framework/com.google.android.maps.jar @ 0.559 ms
/data/app/jp.naver.line.android @ 1.163 ms
/data/app/jp.naver.line.android @ 0.562 ms
/data/app/jp.naver.line.android @ 0.617 ms
/data/app/jp.naver.line.android @ 0.628 ms
/data/app/jp.naver.line.android @ 1.010 ms
/data/app/jp.naver.line.android @ 0.749 ms
/data/app/jp.naver.line.android @ 0.568 ms
Open dex file function invocation
Event count: 9
Total duration: 5.928 ms
Total duration (self): 0.042 ms
Open oat file
Event count: 6
Total duration: 19.168 ms
Total duration (self): 19.168 ms
Event details:
/data/dalvik-cache/arm/system@framework@org.apache.http.legacy.boot.jar@classes.dex @ 1.402 ms
/system/framework/oat/arm/org.apache.http.legacy.boot.odex @ 1.089 ms
/data/dalvik-cache/arm/system@framework@com.google.android.maps.jar@classes.dex @ 0.026 ms
/system/framework/oat/arm/com.google.android.maps.odex @ 2.713 ms
/data/dalvik-cache/arm/data@app@jp.naver.line.android-SzAu8DF0bsY1YYaNo_rBjA==@base.apk@classes.dex @ 0.017 ms
/data/app/jp.naver.line.android-SzAu8DF0bsY1YYaNo_rBjA==/oat/arm/base.odex @ 13.921 ms
OpenDexFilesFromOat
Event count: 3
Total duration: 30.628 ms
Total duration (self): 5.453 ms
OpenImageFile
Event count: 3
Total duration: 0.079 ms
Total duration (self): 0.079 ms
PostFork
Event count: 1
Total duration: 0.497 ms
Total duration (self): 0.497 ms
RelativeLayout
Event count: 1
Total duration: 13.604 ms
Total duration (self): 13.604 ms
setCoreSettings
Event count: 1
Total duration: 0.036 ms
Total duration (self): 0.036 ms
setLayerPaths
Event count: 1
Total duration: 0.015 ms
Total duration (self): 0.015 ms
Setup proxies
Event count: 1
Total duration: 0.948 ms
Total duration (self): 0.948 ms
setupGraphicsSupport
Event count: 1
Total duration: 2.681 ms
Total duration (self): 2.681 ms
Unknown Slice
Event count: 8
Total duration: 2.934 ms
Total duration (self): 2.924 ms
Event details:
Run checkpoint function @ 0.005 ms
Run checkpoint function @ 0.021 ms
Run checkpoint function @ 0.004 ms
Run checkpoint function @ 0.015 ms
Run checkpoint function @ 0.003 ms
jp.naver.line.android.activity.SplashLogoView @ 2.854 ms
jp.naver.line.android.activity.SplashLogoView @ 0.028 ms
Run checkpoint function @ 0.004 ms
View
Event count: 5
Total duration: 0.458 ms
Total duration (self): 0.454 ms
ViewStub
Event count: 4
Total duration: 1.146 ms
Total duration (self): 1.146 ms
ZygoteInit
Event count: 1
Total duration: 2.944 ms
Total duration (self): 2.944 ms
BUILD SUCCESSFUL in 2s
11 actionable tasks: 1 executed, 10 up-to-date
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment