Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

sql/scheduledlogging: TestCaptureIndexUsageStats failed #102980

Closed
cockroach-teamcity opened this issue May 9, 2023 · 1 comment · Fixed by #105771
Closed

sql/scheduledlogging: TestCaptureIndexUsageStats failed #102980

cockroach-teamcity opened this issue May 9, 2023 · 1 comment · Fixed by #105771
Assignees
Labels
branch-master Failures and bugs on the master branch. C-test-failure Broken test (automatically or manually discovered). O-robot Originated from a bot.
Milestone

Comments

@cockroach-teamcity
Copy link
Member

cockroach-teamcity commented May 9, 2023

sql/scheduledlogging.TestCaptureIndexUsageStats failed with artifacts on master @ 7a8be52cc09dd6779b02a54bf7ce9a290cd135c8:

    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881908000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881907294,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":2,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.646766 +0000 UTC","SchemaName":"public"} n1 16 true TELEMETRY 326 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881882000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881881300,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":1,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.378305 +0000 UTC","SchemaName":"public"} n1 15 true TELEMETRY 334 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881864000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881862896,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":2,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.391717 +0000 UTC","SchemaName":"public"} n1 14 true TELEMETRY 323 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881845000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881845074,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":1,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.373061 +0000 UTC","SchemaName":"public"} n1 13 true TELEMETRY 331 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881829000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881828639,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":2,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"IdX✏","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.890136 +0000 UTC","SchemaName":"public"} n1 12 true TELEMETRY 329 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881801000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881800905,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":1,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"sPe-CiAl✔_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.382678 +0000 UTC","SchemaName":"public"} n1 11 true TELEMETRY 353 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881779000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881778251,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":2,"DatabaseName":"index","TableName":"index","IndexName":"index","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:16.096715 +0000 UTC","SchemaName":"public"} n1 10 true TELEMETRY 303 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881725000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881721946,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":1,"DatabaseName":"index","TableName":"index","IndexName":"index_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.387427 +0000 UTC","SchemaName":"public"} n1 9 true TELEMETRY 322 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491650000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491649881,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":2,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.646766 +0000 UTC","SchemaName":"public"} n1 8 true TELEMETRY 326 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491640000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491639756,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":1,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.378305 +0000 UTC","SchemaName":"public"} n1 7 true TELEMETRY 334 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491632000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491632231,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":2,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.391717 +0000 UTC","SchemaName":"public"} n1 6 true TELEMETRY 323 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491624000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491624125,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":1,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.373061 +0000 UTC","SchemaName":"public"} n1 5 true TELEMETRY 331 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491615000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491615074,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":2,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"IdX✏","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.890136 +0000 UTC","SchemaName":"public"} n1 4 true TELEMETRY 329 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491604000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491603308,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":1,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"sPe-CiAl✔_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.382678 +0000 UTC","SchemaName":"public"} n1 3 true TELEMETRY 353 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491578000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491573654,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":2,"DatabaseName":"index","TableName":"index","IndexName":"index","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:16.096715 +0000 UTC","SchemaName":"public"} n1 2 true TELEMETRY 303 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664700721386000 2701 util/log/event_log.go 32 {"Timestamp":1683664700721382728,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":1,"DatabaseName":"index","TableName":"index","IndexName":"index_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.387427 +0000 UTC","SchemaName":"public"} n1 1 true TELEMETRY 322 0 0 1}
    captured_index_usage_stats_test.go:324: found index counts: map[IdX✏:2 index:2 index_pkey:2 sPe-CiAl✔_pkey:2 test2_table_letter_idx:2 test2_table_pkey:2 test_table_letter_idx:2 test_table_pkey:2]
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664706561928000 2701 util/log/event_log.go 32 {"Timestamp":1683664706561927253,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":2,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.646766 +0000 UTC","SchemaName":"public"} n1 24 true TELEMETRY 326 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664706561899000 2701 util/log/event_log.go 32 {"Timestamp":1683664706561898248,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":1,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.378305 +0000 UTC","SchemaName":"public"} n1 23 true TELEMETRY 334 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664706561882000 2701 util/log/event_log.go 32 {"Timestamp":1683664706561881640,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":2,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.391717 +0000 UTC","SchemaName":"public"} n1 22 true TELEMETRY 323 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664706561864000 2701 util/log/event_log.go 32 {"Timestamp":1683664706561863523,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":1,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.373061 +0000 UTC","SchemaName":"public"} n1 21 true TELEMETRY 331 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664706561839000 2701 util/log/event_log.go 32 {"Timestamp":1683664706561838530,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":2,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"IdX✏","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.890136 +0000 UTC","SchemaName":"public"} n1 20 true TELEMETRY 329 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664706561815000 2701 util/log/event_log.go 32 {"Timestamp":1683664706561813882,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":1,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"sPe-CiAl✔_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.382678 +0000 UTC","SchemaName":"public"} n1 19 true TELEMETRY 353 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664706561791000 2701 util/log/event_log.go 32 {"Timestamp":1683664706561790357,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":2,"DatabaseName":"index","TableName":"index","IndexName":"index","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:16.096715 +0000 UTC","SchemaName":"public"} n1 18 true TELEMETRY 303 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664706561738000 2701 util/log/event_log.go 32 {"Timestamp":1683664706561734578,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":1,"DatabaseName":"index","TableName":"index","IndexName":"index_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.387427 +0000 UTC","SchemaName":"public"} n1 17 true TELEMETRY 322 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881908000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881907294,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":2,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.646766 +0000 UTC","SchemaName":"public"} n1 16 true TELEMETRY 326 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881882000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881881300,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":1,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.378305 +0000 UTC","SchemaName":"public"} n1 15 true TELEMETRY 334 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881864000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881862896,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":2,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.391717 +0000 UTC","SchemaName":"public"} n1 14 true TELEMETRY 323 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881845000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881845074,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":1,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.373061 +0000 UTC","SchemaName":"public"} n1 13 true TELEMETRY 331 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881829000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881828639,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":2,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"IdX✏","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.890136 +0000 UTC","SchemaName":"public"} n1 12 true TELEMETRY 329 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881801000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881800905,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":1,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"sPe-CiAl✔_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.382678 +0000 UTC","SchemaName":"public"} n1 11 true TELEMETRY 353 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881779000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881778251,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":2,"DatabaseName":"index","TableName":"index","IndexName":"index","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:16.096715 +0000 UTC","SchemaName":"public"} n1 10 true TELEMETRY 303 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664704881725000 2701 util/log/event_log.go 32 {"Timestamp":1683664704881721946,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":1,"DatabaseName":"index","TableName":"index","IndexName":"index_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.387427 +0000 UTC","SchemaName":"public"} n1 9 true TELEMETRY 322 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491650000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491649881,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":2,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.646766 +0000 UTC","SchemaName":"public"} n1 8 true TELEMETRY 326 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491640000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491639756,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":113,"IndexID":1,"DatabaseName":"test2","TableName":"test2_table","IndexName":"test2_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.378305 +0000 UTC","SchemaName":"public"} n1 7 true TELEMETRY 334 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491632000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491632231,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":2,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_letter_idx","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.391717 +0000 UTC","SchemaName":"public"} n1 6 true TELEMETRY 323 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491624000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491624125,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":112,"IndexID":1,"DatabaseName":"test","TableName":"test_table","IndexName":"test_table_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.373061 +0000 UTC","SchemaName":"public"} n1 5 true TELEMETRY 331 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491615000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491615074,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":2,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"IdX✏","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:14.890136 +0000 UTC","SchemaName":"public"} n1 4 true TELEMETRY 329 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491604000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491603308,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":114,"IndexID":1,"DatabaseName":"\"mIxEd-CaSe\"\"woo☃\"","TableName":"sPe-CiAl✔","IndexName":"sPe-CiAl✔_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.382678 +0000 UTC","SchemaName":"public"} n1 3 true TELEMETRY 353 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664702491578000 2701 util/log/event_log.go 32 {"Timestamp":1683664702491573654,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":2,"DatabaseName":"index","TableName":"index","IndexName":"index","IndexType":"secondary","CreatedAt":"2023-05-09 20:38:16.096715 +0000 UTC","SchemaName":"public"} n1 2 true TELEMETRY 303 0 0 1}
    captured_index_usage_stats_test.go:307: checking entry: {INFO 1683664700721386000 2701 util/log/event_log.go 32 {"Timestamp":1683664700721382728,"EventType":"captured_index_usage_stats","LastRead":"0001-01-01 00:00:00 +0000 UTC","TableID":115,"IndexID":1,"DatabaseName":"index","TableName":"index","IndexName":"index_pkey","IndexType":"primary","IsUnique":true,"CreatedAt":"2023-05-09 20:38:14.387427 +0000 UTC","SchemaName":"public"} n1 1 true TELEMETRY 322 0 0 1}
    captured_index_usage_stats_test.go:324: found index counts: map[IdX✏:3 index:3 index_pkey:3 sPe-CiAl✔_pkey:3 test2_table_letter_idx:3 test2_table_pkey:3 test_table_letter_idx:3 test_table_pkey:3]
    captured_index_usage_stats_test.go:267: 
        	Error Trace:	github.com/cockroachdb/cockroach/pkg/sql/scheduledlogging/captured_index_usage_stats_test.go:267
        	Error:      	"1s" is not greater than "1.160339s"
        	Test:       	TestCaptureIndexUsageStats
        	Messages:   	1s <= 4.160339s-3s
test logs left over in: /artifacts/tmp/_tmp/69cc8b5ff8b35dcd9569961cf48105ef/logTestCaptureIndexUsageStats2024413349
    panic.go:522: -- test log scope end --
--- FAIL: TestCaptureIndexUsageStats (17.69s)
Help

See also: How To Investigate a Go Test Failure (internal)

Same failure on other branches

/cc @cockroachdb/cluster-observability

This test on roachdash | Improve this report!

Jira issue: CRDB-27768

@cockroach-teamcity cockroach-teamcity added branch-master Failures and bugs on the master branch. C-test-failure Broken test (automatically or manually discovered). O-robot Originated from a bot. labels May 9, 2023
@cockroach-teamcity cockroach-teamcity added this to the 23.1 milestone May 9, 2023
@gtr
Copy link
Contributor

gtr commented Jun 15, 2023

Skipped by #103295.

@gtr gtr closed this as completed Jun 15, 2023
@maryliag maryliag reopened this Jun 15, 2023
gtr added a commit to gtr/cockroach that referenced this issue Jun 28, 2023
Previously, the `pkg/sql/scheduleslogging/TestCaptureIndexUsageStats`
test failed on CI, despire passing locally. This commit increases the
time buffer from 3s to 4s to give a larger tolerance for
non-determinism.

Fixes cockroachdb#102980
Release note: None
gtr added a commit to gtr/cockroach that referenced this issue Jun 29, 2023
Previously, the `pkg/sql/scheduleslogging/TestCaptureIndexUsageStats`
test failed on CI, despire passing locally. This commit increases the
time buffer from 3s to 4s to give a larger tolerance for
non-determinism.

Fixes cockroachdb#102980
Release note: None
craig bot pushed a commit that referenced this issue Jun 30, 2023
105771:  sql: increase time buffer for TestCaptureIndexUsageStats r=gtr a=gtr

Note to reviewers: this builds on top of #105755, please only consider the second commit.

Previously, the `pkg/sql/scheduleslogging/TestCaptureIndexUsageStats`
test failed on CI, despire passing locally. This commit increases the
time buffer from 3s to 4s to give a larger tolerance for
non-determinism.

Fixes #102980
Release note: None

105919: roachtest: Delete scbench randomload test r=rafiss a=rimadeodhar

This test has been skipped for a year and based
on the history of the test hasn't been providing
much value. We can delete it now. Random
schema change testing is covered by schemachange/randomload.

Epic: none
Fixes: #56230
Release note: None

Co-authored-by: gtr <[email protected]>
Co-authored-by: rimadeodhar <[email protected]>
@craig craig bot closed this as completed in dd30c5c Jun 30, 2023
blathers-crl bot pushed a commit that referenced this issue Jun 30, 2023
Previously, the `pkg/sql/scheduleslogging/TestCaptureIndexUsageStats`
test failed on CI, despire passing locally. This commit increases the
time buffer from 3s to 4s to give a larger tolerance for
non-determinism.

Fixes #102980
Release note: None
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
branch-master Failures and bugs on the master branch. C-test-failure Broken test (automatically or manually discovered). O-robot Originated from a bot.
Projects
None yet
Development

Successfully merging a pull request may close this issue.

3 participants