Skip to content

Test timeout: TestChunkerPrefetching / TestUniqueOnNonUniqueData #837

@morgo

Description

@morgo
2026-05-11T18:22:56.9065865Z test-1           | panic: test timed out after 10m0s
2026-05-11T18:22:56.9065942Z test-1           | 	running tests:
2026-05-11T18:22:56.9066031Z test-1           | 		TestChunkerPrefetching (2m55s)
2026-05-11T18:22:56.9066102Z test-1           | 		TestDropColumn (9s)
2026-05-11T18:22:56.9066171Z test-1           | 		TestOnline (23s)
2026-05-11T18:22:56.9066272Z test-1           | 		TestUniqueOnNonUniqueData (5m43s)
2026-05-11T18:22:56.9066332Z test-1           | 
2026-05-11T18:22:56.9066411Z test-1           | goroutine 105452 [running]:
2026-05-11T18:22:56.9066502Z test-1           | testing.(*M).startAlarm.func1()
2026-05-11T18:22:56.9066657Z test-1           | 	/usr/local/go/src/testing/testing.go:2802 +0x605
2026-05-11T18:22:56.9066731Z test-1           | created by time.goFunc
2026-05-11T18:22:56.9066833Z test-1           | 	/usr/local/go/src/time/sleep.go:215 +0x45
2026-05-11T18:22:56.9066893Z test-1           | 
2026-05-11T18:22:56.9066985Z test-1           | goroutine 1 [chan receive, 8 minutes]:
2026-05-11T18:22:56.9067061Z test-1           | testing.tRunner.func1()
2026-05-11T18:22:56.9067172Z test-1           | 	/usr/local/go/src/testing/testing.go:1993 +0x9ad
2026-05-11T18:22:56.9067273Z test-1           | testing.tRunner(0xc0000f2b48, 0xc0003c5990)
2026-05-11T18:22:56.9067374Z test-1           | 	/usr/local/go/src/testing/testing.go:2042 +0x256
2026-05-11T18:22:56.9067797Z test-1           | testing.runTests({0x11a6305, 0x17}, {0x11b79a5, 0x25}, 0xc000016540, {0x217de60, 0xa1, 0xa1}, {0xc278a57d1bd614fb, 0x8bb34287ec, ...})
2026-05-11T18:22:56.9067903Z test-1           | 	/usr/local/go/src/testing/testing.go:2583 +0x9ea
2026-05-11T18:22:56.9067985Z test-1           | testing.(*M).Run(0xc0000afcc0)
2026-05-11T18:22:56.9068085Z test-1           | 	/usr/local/go/src/testing/testing.go:2443 +0xf4c
2026-05-11T18:22:56.9068265Z test-1           | go.uber.org/goleak.VerifyTestMain({0x1205920, 0xc0000afcc0}, {0x0, 0x0, 0x0})
2026-05-11T18:22:56.9068400Z test-1           | 	/go/pkg/mod/go.uber.org/goleak@v1.3.0/testmain.go:53 +0x65
2026-05-11T18:22:56.9068540Z test-1           | github.com/block/spirit/pkg/migration.TestMain(0xc0000afcc0)
2026-05-11T18:22:56.9068656Z test-1           | 	/app/pkg/migration/migration_test.go:30 +0x8e
2026-05-11T18:22:56.9068722Z test-1           | main.main()
2026-05-11T18:22:56.9068797Z test-1           | 	_testmain.go:368 +0x172
2026-05-11T18:22:56.9068910Z test-1           | 
2026-05-11T18:22:56.9069009Z test-1           | goroutine 150 [chan receive, 8 minutes]:
2026-05-11T18:22:56.9069196Z test-1           | testing.(*testState).waitParallel(0xc00003a7d0)
2026-05-11T18:22:56.9069310Z test-1           | 	/usr/local/go/src/testing/testing.go:2220 +0x125
2026-05-11T18:22:56.9069401Z test-1           | testing.(*T).Parallel(0xc0000f2fc8)
2026-05-11T18:22:56.9069500Z test-1           | 	/usr/local/go/src/testing/testing.go:1804 +0x533
2026-05-11T18:22:56.9069757Z test-1           | github.com/block/spirit/pkg/migration.TestE2EBinlogSubscribingCompositeKeyVarchar(0xc0000f2fc8)
2026-05-11T18:22:56.9069863Z test-1           | 	/app/pkg/migration/binlog_test.go:227 +0x3f
2026-05-11T18:22:56.9069955Z test-1           | testing.tRunner(0xc0000f2fc8, 0x11fad10)
2026-05-11T18:22:56.9070051Z test-1           | 	/usr/local/go/src/testing/testing.go:2036 +0x21d
2026-05-11T18:22:56.9070156Z test-1           | created by testing.(*T).Run in goroutine 1
2026-05-11T18:22:56.9070261Z test-1           | 	/usr/local/go/src/testing/testing.go:2101 +0xb13
2026-05-11T18:22:56.9070316Z test-1           | 
2026-05-11T18:22:56.9070415Z test-1           | goroutine 284 [chan receive, 8 minutes]:
2026-05-11T18:22:56.9070519Z test-1           | testing.(*testState).waitParallel(0xc00003a7d0)
2026-05-11T18:22:56.9070617Z test-1           | 	/usr/local/go/src/testing/testing.go:2220 +0x125
2026-05-11T18:22:56.9070698Z test-1           | testing.(*T).Parallel(0xc000579b08)
2026-05-11T18:22:56.9070803Z test-1           | 	/usr/local/go/src/testing/testing.go:1804 +0x533
2026-05-11T18:22:56.9071010Z test-1           | github.com/block/spirit/pkg/migration.TestDeferCutOverE2EBinlogAdvance(0xc000579b08)
2026-05-11T18:22:56.9071112Z test-1           | 	/app/pkg/migration/cutover_test.go:736 +0x3f
2026-05-11T18:22:56.9071205Z test-1           | testing.tRunner(0xc000579b08, 0x11facd8)
2026-05-11T18:22:56.9071301Z test-1           | 	/usr/local/go/src/testing/testing.go:2036 +0x21d
2026-05-11T18:22:56.9071400Z test-1           | created by testing.(*T).Run in goroutine 1
2026-05-11T18:22:56.9071507Z test-1           | 	/usr/local/go/src/testing/testing.go:2101 +0xb13
2026-05-11T18:22:56.9071565Z test-1           | 
2026-05-11T18:22:56.9071638Z test-1           | goroutine 45386 [select]:
2026-05-11T18:22:56.9071971Z test-1           | github.com/block/spirit/pkg/copier.(*Unbuffered).estimateRowsPerSecondLoop(0xc0002462d0, {0x120c210, 0xc0006cf8b0})
2026-05-11T18:22:56.9072074Z test-1           | 	/app/pkg/copier/unbuffered.go:193 +0x1d0
2026-05-11T18:22:56.9072255Z test-1           | created by github.com/block/spirit/pkg/copier.(*Unbuffered).Run in goroutine 340
2026-05-11T18:22:56.9072345Z test-1           | 	/app/pkg/copier/unbuffered.go:99 +0x165
2026-05-11T18:22:56.9072406Z test-1           | 
2026-05-11T18:22:56.9072492Z test-1           | goroutine 285 [chan receive, 8 minutes]:
2026-05-11T18:22:56.9072596Z test-1           | testing.(*testState).waitParallel(0xc00003a7d0)
2026-05-11T18:22:56.9072749Z test-1           | 	/usr/local/go/src/testing/testing.go:2220 +0x125
2026-05-11T18:22:56.9072832Z test-1           | testing.(*T).Parallel(0xc000579d48)
2026-05-11T18:22:56.9072934Z test-1           | 	/usr/local/go/src/testing/testing.go:1804 +0x533
2026-05-11T18:22:56.9073123Z test-1           | github.com/block/spirit/pkg/migration.TestChangeDatatypeNoData(0xc000579d48)
2026-05-11T18:22:56.9073223Z test-1           | 	/app/pkg/migration/datatype_test.go:19 +0x2f
2026-05-11T18:22:56.9073310Z test-1           | testing.tRunner(0xc000579d48, 0x11fac10)
2026-05-11T18:22:56.9073409Z test-1           | 	/usr/local/go/src/testing/testing.go:2036 +0x21d
2026-05-11T18:22:56.9073505Z test-1           | created by testing.(*T).Run in goroutine 1
2026-05-11T18:22:56.9073602Z test-1           | 	/usr/local/go/src/testing/testing.go:2101 +0xb13
2026-05-11T18:22:56.9073658Z test-1           | 

Full log @ https://productionresultssa3.blob.core.windows.net/actions-results/b97268be-3043-4d1c-a47c-03ad1431d933/workflow-job-run-7cf55951-9e78-55f1-aa57-94131508b93d/logs/job/job-logs.txt?rsct=text%2Fplain&se=2026-05-11T18%3A33%3A39Z&sig=7o3XdRczhGqJrAQ8LFC374%2FFy3lyCCa1Z2SKDXbBdR4%3D&ske=2026-05-11T19%3A52%3A20Z&skoid=ca7593d4-ee42-46cd-af88-8b886a2f84eb&sks=b&skt=2026-05-11T15%3A52%3A20Z&sktid=398a6654-997b-47e9-b12b-9515b896b4de&skv=2025-11-05&sp=r&spr=https&sr=b&st=2026-05-11T18%3A23%3A34Z&sv=2025-11-05

Metadata

Metadata

Assignees

No one assigned

    Labels

    No labels
    No labels

    Type

    Projects

    No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions