diff options
| author | Julie Qiu <julie@golang.org> | 2020-10-05 14:56:42 -0400 |
|---|---|---|
| committer | Julie Qiu <julie@golang.org> | 2020-10-05 19:43:10 +0000 |
| commit | bd29f00845aece2e284c0a4307288c4b9ba12f1d (patch) | |
| tree | d37388a66cd28181f7dcf3eab583d6d493036e18 /internal/database/database.go | |
| parent | 96718d5258f97eb1e201273c41fcd5c08d47232a (diff) | |
| download | go-x-pkgsite-bd29f00845aece2e284c0a4307288c4b9ba12f1d.tar.xz | |
internal/database: log additional info for QueryRow errors
We're seeing several 500s from queries that should be cheap, such as
db.IsExcluded, db.GetUnitMeta, and getPathID in db.GetUnit. These
queries all call QueryRow. Additional logging is added to debug this
issue.
Change-Id: I286b5b2115d757ef6bcc2a3f4d8530d04037bbae
Reviewed-on: https://go-review.googlesource.com/c/pkgsite/+/259619
Trust: Julie Qiu <julie@golang.org>
Run-TryBot: Julie Qiu <julie@golang.org>
Reviewed-by: Jonathan Amsterdam <jba@google.com>
TryBot-Result: kokoro <noreply+kokoro@google.com>
Diffstat (limited to 'internal/database/database.go')
| -rw-r--r-- | internal/database/database.go | 13 |
1 files changed, 12 insertions, 1 deletions
diff --git a/internal/database/database.go b/internal/database/database.go index bff5b08c..fc82059c 100644 --- a/internal/database/database.go +++ b/internal/database/database.go @@ -15,6 +15,7 @@ import ( "regexp" "strings" "sync" + "time" "github.com/lib/pq" "golang.org/x/pkgsite/internal/derrors" @@ -107,7 +108,17 @@ func (db *DB) Query(ctx context.Context, query string, args ...interface{}) (_ * // QueryRow runs the query and returns a single row. func (db *DB) QueryRow(ctx context.Context, query string, args ...interface{}) *sql.Row { - defer logQuery(ctx, query, args, db.instanceID)(nil) + start := time.Now() + defer func() { + d, _ := ctx.Deadline() + msg := fmt.Sprintf("args=%v; elapsed=%q, start=%q, deadline=%q", args, time.Since(start), start, d) + if ctx.Err() != nil { + log.Errorf(ctx, "QueryRow context error: %v "+msg, ctx.Err()) + } else { + log.Debugf(ctx, "QueryRow: "+msg) + } + logQuery(ctx, query, args, db.instanceID)(nil) + }() if db.tx != nil { return db.tx.QueryRowContext(ctx, query, args...) } |