Skip to content

Comments

Get user simple by id solve recursive#10

Open
plainbanana wants to merge 4 commits intomasterfrom
getUserSimpleByID-solverecursive
Open

Get user simple by id solve recursive#10
plainbanana wants to merge 4 commits intomasterfrom
getUserSimpleByID-solverecursive

Conversation

@plainbanana
Copy link
Collaborator

@plainbanana plainbanana commented Aug 8, 2020

No description provided.

@plainbanana
Copy link
Collaborator Author

plainbanana commented Aug 8, 2020 •
edited
Loading

{"pass":true,"score":2010,"campaign":0,"language":"Go","messages":[]}

./bin/benchmarker 
2020/08/08 12:13:33 main.go:104: === initialize ===
2020/08/08 12:13:43 main.go:123: === verify ===
2020/08/08 12:13:47 main.go:146: === validation ===
2020/08/08 12:13:47 scenario.go:54: - Start Load worker 1
2020/08/08 12:13:47 scenario.go:62: - Start Load worker 2
2020/08/08 12:14:47 fails.go:72: [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:802
    message("GET /new_items/20.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items/20.json?created_at=1565624550&item_id=49346: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:800
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:564
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadNewCategoryItemsAndItems] /home/isucon/isucari/bench/scenario/load.go:520
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:102
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:802
    message("GET /new_items/20.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items/20.json?created_at=1565623995&item_id=48789: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:800
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:564
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadNewCategoryItemsAndItems] /home/isucon/isucari/bench/scenario/load.go:520
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:102
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).NewItems] /home/isucon/isucari/bench/session/webapp.go:710
    message("GET /new_items.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewItems] /home/isucon/isucari/bench/session/webapp.go:708
    [scenario.loadIsRecommendNewItems] /home/isucon/isucari/bench/scenario/load.go:423
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:77
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).NewItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:742
    message("GET /new_items.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items.json?created_at=1565624235&item_id=49033: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:740
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:475
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadNewItemsAndItems] /home/isucon/isucari/bench/scenario/load.go:448
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:382
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:367
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 2008)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:275
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 285)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565604772&item_id=29568: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:180
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1025)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Check.func4] /home/isucon/isucari/bench/scenario/check.go:236
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Check.func4] /home/isucon/isucari/bench/scenario/check.go:192
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1599)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:121
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1011)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565616930&item_id=41724: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:180
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Buy] /home/isucon/isucari/bench/session/webapp.go:379
    message("POST /buy: リクエストに失敗しました (item_id: 50032)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/buy: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Buy] /home/isucon/isucari/bench/session/webapp.go:377
    [scenario.irregularSellAndBuy] /home/isucon/isucari/bench/scenario/wrong.go:105
    [scenario.Check.func2] /home/isucon/isucari/bench/scenario/check.go:104
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3766)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565621710&item_id=46504: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 317)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565621776&item_id=46568: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 2236)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:117
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:388
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 2315)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3265)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:121
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:275
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:346
    message("POST /sell: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/sell: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:344
    [scenario.sellParentCategory] /home/isucon/isucari/bench/scenario/action.go:83
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:189
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:346
    message("POST /sell: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/sell: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:344
    [scenario.sellParentCategory] /home/isucon/isucari/bench/scenario/action.go:83
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:376
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:48 main.go:180: === final check ===
2020/08/08 12:14:48 main.go:212: 2010 0
{"pass":true,"score":2010,"campaign":0,"language":"Go","messages":[]}

@plainbanana
Copy link
Collaborator Author

plainbanana commented Aug 8, 2020

{"pass":true,"score":2310,"campaign":0,"language":"Go","messages":[]}

./bin/benchmarker 
2020/08/08 12:13:33 main.go:104: === initialize ===
2020/08/08 12:13:43 main.go:123: === verify ===
2020/08/08 12:13:47 main.go:146: === validation ===
2020/08/08 12:13:47 scenario.go:54: - Start Load worker 1
2020/08/08 12:13:47 scenario.go:62: - Start Load worker 2
2020/08/08 12:14:47 fails.go:72: [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:802
    message("GET /new_items/20.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items/20.json?created_at=1565624550&item_id=49346: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:800
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:564
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadNewCategoryItemsAndItems] /home/isucon/isucari/bench/scenario/load.go:520
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:102
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:802
    message("GET /new_items/20.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items/20.json?created_at=1565623995&item_id=48789: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:800
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:564
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadNewCategoryItemsAndItems] /home/isucon/isucari/bench/scenario/load.go:520
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:102
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).NewItems] /home/isucon/isucari/bench/session/webapp.go:710
    message("GET /new_items.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewItems] /home/isucon/isucari/bench/session/webapp.go:708
    [scenario.loadIsRecommendNewItems] /home/isucon/isucari/bench/scenario/load.go:423
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:77
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).NewItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:742
    message("GET /new_items.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items.json?created_at=1565624235&item_id=49033: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:740
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:475
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadItemIDsFromNewItems] /home/isucon/isucari/bench/scenario/load.go:506
    [scenario.loadNewItemsAndItems] /home/isucon/isucari/bench/scenario/load.go:448
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:382
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:367
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 2008)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:275
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 285)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565604772&item_id=29568: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:180
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1025)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Check.func4] /home/isucon/isucari/bench/scenario/check.go:236
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Check.func4] /home/isucon/isucari/bench/scenario/check.go:192
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1599)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:121
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1011)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565616930&item_id=41724: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:180
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Buy] /home/isucon/isucari/bench/session/webapp.go:379
    message("POST /buy: リクエストに失敗しました (item_id: 50032)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/buy: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Buy] /home/isucon/isucari/bench/session/webapp.go:377
    [scenario.irregularSellAndBuy] /home/isucon/isucari/bench/scenario/wrong.go:105
    [scenario.Check.func2] /home/isucon/isucari/bench/scenario/check.go:104
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3766)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565621710&item_id=46504: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 317)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565621776&item_id=46568: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 2236)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:117
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:388
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 2315)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3265)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:121
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:275
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:346
    message("POST /sell: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/sell: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:344
    [scenario.sellParentCategory] /home/isucon/isucari/bench/scenario/action.go:83
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:189
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:47 fails.go:72: [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:346
    message("POST /sell: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/sell: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:344
    [scenario.sellParentCategory] /home/isucon/isucari/bench/scenario/action.go:83
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:376
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:14:48 main.go:180: === final check ===
2020/08/08 12:14:48 main.go:212: 2010 0
{"pass":true,"score":2010,"campaign":0,"language":"Go","messages":[]}
isucon@instance-2:/home/isucon/isucari$ ./bin/benchmarker
2020/08/08 12:17:18 main.go:104: === initialize ===
2020/08/08 12:17:28 main.go:123: === verify ===
2020/08/08 12:17:31 main.go:146: === validation ===
2020/08/08 12:17:31 scenario.go:54: - Start Load worker 1
2020/08/08 12:17:32 scenario.go:62: - Start Load worker 2
2020/08/08 12:18:31 fails.go:72: [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:802
    message("GET /new_items/30.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items/30.json?created_at=1565623166&item_id=47959: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:800
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:564
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadNewCategoryItemsAndItems] /home/isucon/isucari/bench/scenario/load.go:520
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:102
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:802
    message("GET /new_items/30.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items/30.json?created_at=1565624851&item_id=49648: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:800
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:564
    [scenario.loadItemIDsFromCategory] /home/isucon/isucari/bench/scenario/load.go:603
    [scenario.loadNewCategoryItemsAndItems] /home/isucon/isucari/bench/scenario/load.go:520
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:102
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:802
    message("GET /new_items/40.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items/40.json?created_at=1565622899&item_id=47690: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewCategoryItemsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:800
    [scenario.checkItemIDsFromCategory] /home/isucon/isucari/bench/scenario/check.go:338
    [scenario.checkItemIDsFromCategory] /home/isucon/isucari/bench/scenario/check.go:391
    [scenario.checkItemIDsFromCategory] /home/isucon/isucari/bench/scenario/check.go:391
    [scenario.checkItemIDsFromCategory] /home/isucon/isucari/bench/scenario/check.go:391
    [scenario.checkItemIDsFromCategory] /home/isucon/isucari/bench/scenario/check.go:391
    [scenario.checkItemIDsFromCategory] /home/isucon/isucari/bench/scenario/check.go:391
    [scenario.checkItemIDsFromCategory] /home/isucon/isucari/bench/scenario/check.go:391
    [scenario.checkItemIDsFromCategory] /home/isucon/isucari/bench/scenario/check.go:391
    [scenario.checkNewCategoryItemsAndItems] /home/isucon/isucari/bench/scenario/check.go:311
    [scenario.Check.func2] /home/isucon/isucari/bench/scenario/check.go:76
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).Ship] /home/isucon/isucari/bench/session/webapp.go:463
    message("POST /ship: リクエストに失敗しました (item_id: 50030)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/ship: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Ship] /home/isucon/isucari/bench/session/webapp.go:461
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:160
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:388
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1245)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565612932&item_id=37726: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 2532)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:173
    [scenario.Check.func4] /home/isucon/isucari/bench/scenario/check.go:236
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1652)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565613417&item_id=38212: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:180
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1737)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565621927&item_id=46719: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3575)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:173
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3167)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565612701&item_id=37497: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 725)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:173
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:31 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3474)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:32 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3798)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:117
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:388
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:32 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 2455)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:32 fails.go:72: [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:346
    message("POST /sell: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/sell: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Sell] /home/isucon/isucari/bench/session/webapp.go:344
    [scenario.sellParentCategory] /home/isucon/isucari/bench/scenario/action.go:83
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:189
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:32 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:275
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:32 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:275
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:32 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:367
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:18:32 main.go:180: === final check ===
2020/08/08 12:18:32 main.go:212: 2310 0
{"pass":true,"score":2310,"campaign":0,"language":"Go","messages":[]}

@plainbanana
Copy link
Collaborator Author

plainbanana commented Aug 8, 2020

{"pass":true,"score":2210,"campaign":0,"language":"Go","messages":[]}

bench 
isucon@instance-2:/home/isucon/isucari$ ./bin/benchmarker
2020/08/08 12:25:24 main.go:104: === initialize ===
2020/08/08 12:25:34 main.go:123: === verify ===
2020/08/08 12:25:37 main.go:146: === validation ===
2020/08/08 12:25:37 scenario.go:54: - Start Load worker 1
2020/08/08 12:25:37 scenario.go:62: - Start Load worker 2
2020/08/08 12:26:37 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 20)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:117
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:388
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).ShipDone] /home/isucon/isucari/bench/session/webapp.go:503
    message("POST /ship_done: リクエストに失敗しました (item_id: 50034)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/ship_done: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).ShipDone] /home/isucon/isucari/bench/session/webapp.go:501
    [scenario.shipDone] /home/isucon/isucari/bench/scenario/action.go:357
    [scenario.buyComplete] /home/isucon/isucari/bench/scenario/action.go:330
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:110
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).NewItems] /home/isucon/isucari/bench/session/webapp.go:710
    message("GET /new_items.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewItems] /home/isucon/isucari/bench/session/webapp.go:708
    [scenario.loadIsRecommendNewItems] /home/isucon/isucari/bench/scenario/load.go:423
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:77
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).ShipDone] /home/isucon/isucari/bench/session/webapp.go:503
    message("POST /ship_done: リクエストに失敗しました (item_id: 50032)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/ship_done: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).ShipDone] /home/isucon/isucari/bench/session/webapp.go:501
    [scenario.shipDone] /home/isucon/isucari/bench/scenario/action.go:357
    [scenario.buyComplete] /home/isucon/isucari/bench/scenario/action.go:330
    [scenario.Load.func1] /home/isucon/isucari/bench/scenario/load.go:110
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).Ship] /home/isucon/isucari/bench/session/webapp.go:463
    message("POST /ship: リクエストに失敗しました (item_id: 50030)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/ship: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Ship] /home/isucon/isucari/bench/session/webapp.go:461
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:160
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).Complete] /home/isucon/isucari/bench/session/webapp.go:534
    message("POST /complete: リクエストに失敗しました (item_id: 50035)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/complete: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Complete] /home/isucon/isucari/bench/session/webapp.go:532
    [scenario.complete] /home/isucon/isucari/bench/scenario/action.go:367
    [scenario.irregularSellAndBuy] /home/isucon/isucari/bench/scenario/wrong.go:189
    [scenario.Check.func2] /home/isucon/isucari/bench/scenario/check.go:104
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).NewCategoryItems] /home/isucon/isucari/bench/session/webapp.go:770
    message("GET /new_items/20.json: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/new_items/20.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).NewCategoryItems] /home/isucon/isucari/bench/session/webapp.go:768
    [scenario.checkItemIDsFromCategory] /home/isucon/isucari/bench/scenario/check.go:340
    [scenario.checkNewCategoryItemsAndItems] /home/isucon/isucari/bench/scenario/check.go:311
    [scenario.Check.func2] /home/isucon/isucari/bench/scenario/check.go:76
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1766)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565604496&item_id=29291: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:180
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 378)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565609253&item_id=34044: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:180
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3906)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565609194&item_id=33984: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3248)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:121
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:388
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:862
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3473)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json?created_at=1565599776&item_id=24575: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactionsWithItemIDAndCreatedAt] /home/isucon/isucari/bench/session/webapp.go:860
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:713
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadItemIDsTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:749
    [scenario.loadTransactionEvidence] /home/isucon/isucari/bench/scenario/load.go:672
    [scenario.Load.func2] /home/isucon/isucari/bench/scenario/load.go:224
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1383)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 3725)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:169
    [scenario.Check.func4] /home/isucon/isucari/bench/scenario/check.go:236
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:830
    message("GET /users/transactions.json リクエストに失敗しました (user_id: 1124)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Get http://127.0.0.1:8000/users/transactions.json: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).UsersTransactions] /home/isucon/isucari/bench/session/webapp.go:828
    [scenario.findItemFromUsersTransactionsAll] /home/isucon/isucari/bench/scenario/normal.go:192
    [scenario.findItemFromUsersTransactions] /home/isucon/isucari/bench/scenario/normal.go:182
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:117
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func4] /home/isucon/isucari/bench/scenario/load.go:367
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:275
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:249
    message("POST /login: リクエストに失敗しました")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/login: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Login] /home/isucon/isucari/bench/session/webapp.go:247
    [scenario.loginedSession] /home/isucon/isucari/bench/scenario/action.go:48
    [scenario.buyerSession] /home/isucon/isucari/bench/scenario/action.go:39
    [scenario.Check.func4] /home/isucon/isucari/bench/scenario/check.go:192
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:37 fails.go:72: [session.(*Session).Ship] /home/isucon/isucari/bench/session/webapp.go:463
    message("POST /ship: リクエストに失敗しました (item_id: 50029)")
[session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    code(error timeout)
    *url.Error("Post http://127.0.0.1:8000/ship: context deadline exceeded")
[CallStack]
    [session.(*Session).Do] /home/isucon/isucari/bench/session/session.go:186
    [session.(*Session).Ship] /home/isucon/isucari/bench/session/webapp.go:461
    [scenario.buyCompleteWithVerify] /home/isucon/isucari/bench/scenario/action.go:160
    [scenario.Load.func3] /home/isucon/isucari/bench/scenario/load.go:322
    [runtime.goexit] /home/isucon/local/go/src/runtime/asm_amd64.s:1357
2020/08/08 12:26:38 main.go:180: === final check ===
2020/08/08 12:26:38 main.go:212: 2210 0
{"pass":true,"score":2210,"campaign":0,"language":"Go","messages":[]}

@plainbanana
Copy link
Collaborator Author

plainbanana commented Aug 8, 2020

getUserSimpleByIDからgetUserSimpleByItemsへと変更することができる箇所はまだまだある

rg "getUserSimpleByID" main.go                
409:func getUserSimpleByID(q sqlx.Queryer, userID int64) (userSimple UserSimple, err error) {
794:    userSimple, err := getUserSimpleByID(dbx, userID)
1005:                   buyer, err := getUserSimpleByID(tx, item.BuyerID)
1106:   seller, err := getUserSimpleByID(dbx, item.SellerID)
1132:           buyer, err := getUserSimpleByID(dbx, **item.BuyerID)**

CPU的には61%以上の処理がbcryptに食われている状況

image

FlameGraphをみてもpostLoginが支配的になりつつあることが分かる

image

既存のgetUserSimpleByIDは放置でも良さそう

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment

Reviewers

No reviews

Assignees

No one assigned

Labels

None yet

Projects

None yet

Milestone

No milestone

Development

Successfully merging this pull request may close these issues.

1 participant

@plainbanana