查看日志 按照耗时倒序排列

sort

使用命令

rm -rf /data/access_sort.log
cat /data/log/jiemo-api/access.log.2016-05-10|awk -F "|"  '{print  "| "$10" |"$2"|"$4"|"$1"|" }'|sort -rn -k 2 > /data/access_sort.log

log放在grape和lemon /data/access_sort.log 下

分析

lemon 共计请求 2144603 大于10s请求 122条 占比 00.56%
grpae 共计请求 1860623 大于10s请求 129条 占比 00.69%

分析数据如下 其中 grape前两条数据是翻一翻数据，而且是在4点时候 耗时25s，这个奇怪，压力不大耗时非常长，
其前后的请求都正常，只有他不正常

其前后2条数据如下

2016-05-10 04:26:04.856|64100|GET|http://api.jiemoapp.com/api/school/more?appver=1.2.1&channel=5&platform=android&cursor=AAAAPA|Jimeoapp 1.2.1.5 (Android (22/5.1.1; 640dpi; 1440x2560; Xiaomi; MI NOTE Pro; leo; qcom))|111.164.181.66|Android|1.2.1|5|12
2016-05-10 04:26:08.477|68632|GET|http://api.jiemoapp.com/api/post/images/list?appver=1.2.2&channel=0&count=20&platform=ios&user=kaIEtsynNkgrk_tbnqe1gg&v=jiemo|Jiemo/1.2.2 (iPhone; iOS 9.3.1; Scale/3.00)|117.136.5.51|iOS|1.2.2|0|18
2016-05-10 04:26:14.465|27113|GET|http://api.jiemoapp.com/api/matchFriend/list?appver=1.2.1&channel=13&platform=android|Jimeoapp 1.2.1.13 (Android (21/5.0.2; 480dpi; 1080x1920; Xiaomi; Redmi Note 3; hennessy; mt6795))|111.200.66.126|Android|1.2.1|13|254562
2016-05-10 04:26:15.041|64100|GET|http://api.jiemoapp.com/api/explore?appver=1.2.1&channel=5&platform=android&school=PSBJv6Z_2mgKJ3vfqYbDzw&count=20|Jimeoapp 1.2.1.5 (Android (22/5.1.1; 640dpi; 1440x2560; Xiaomi; MI NOTE Pro; leo; qcom))|111.164.181.66|Android|1.2.1|5|71
2016-05-10 04:26:31.341|64100|GET|http://api.jiemoapp.com/api/user/info/profile?appver=1.2.1&channel=5&platform=android&user=CTg4hPiqOfork_tbnqe1gg|Jimeoapp 1.2.1.5 (Android (22/5.1.1; 640dpi; 1440x2560; Xiaomi; MI NOTE Pro; leo; qcom))|111.164.181.66|Android|1.2.1|5|50


分析matchFriend搜索时间 发现很快搜索时间正常，怀疑是连接长时间没用 通道关闭了，恢复消耗所致，这个还可以继续观察

需要解决的api

分析日志得悉，目前需要优化的api是
http://api.jiemoapp.com/api/user/info/profile?appver

因为上传和文件相关，耗时长是可以理解，也可看看
api.jiemoapp.com/api/upload/image

10s以上请求的数据