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.

Sign up for GitHub

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

Jump to bottom

teamcity: failed test: TestInitialPartitioning #41843

Closed
cockroach-teamcity opened this issue Oct 23, 2019 · 0 comments · Fixed by #41880
Closed

teamcity: failed test: TestInitialPartitioning #41843

cockroach-teamcity opened this issue Oct 23, 2019 · 0 comments · Fixed by #41880
Labels
C-test-failure Broken test (automatically or manually discovered). O-robot Originated from a bot.
Milestone
19.2

Comments

@cockroach-teamcity
Copy link
Member

The following tests appear to have failed on master (testrace): TestInitialPartitioning/interval_table, TestInitialPartitioning/list-range_partitioning, TestInitialPartitioning/oid_table, TestInitialPartitioning/timestamptz_table, TestInitialPartitioning/timestamp_table, TestInitialPartitioning/bool_table, TestInitialPartitioning/list-list_partitioning, TestInitialPartitioning/bytes_table, TestInitialPartitioning/uuid_table, TestInitialPartitioning/collatedstring{da}table, TestInitialPartitioning/time_table, TestInitialPartitioning/scans, TestInitialPartitioning, TestInitialPartitioning/varbit_table, TestInitialPartitioning/inet_table, TestInitialPartitioning/secondary_index-_NULL, TestInitialPartitioning/string_table

You may want to check for open issues.

#1554235:

TestInitialPartitioning/timestamptz_table
...izer plan
              [n1,client=127.0.0.1:36070,user=root] added table 'data.public.timestamptz_table' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/86/1/0001-01-01T00:00:00Z
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 3.867ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/86/1/0001-01-01T00:00:00Z{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=33ab8a1f] querying next range at /Table/86/1/0001-01-01T00:00:00Z
              [n1,client=127.0.0.1:36070,user=root,txn=33ab8a1f] r233: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=33ab8a1f] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r233/1:/{Table/86-Max}] read-only path
              [n1,s1,r233/1:/{Table/86-Max}] read has no clock uncertainty
              [n1,s1,r233/1:/{Table/86-Max}] acquire latches
              [n1,s1,r233/1:/{Table/86-Max}] waited 96.419µs to acquire latches
              [n1,s1,r233/1:/{Table/86-Max}] waiting for read lock
              [n1,s1,r233/1:/{Table/86-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 528µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:17423] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 986051 [running]:
            runtime/debug.Stack(0xc005e38ed0, 0x6722520, 0xc0054ca140)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc000f06e00, 0xc005e38ed0)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc000f06e00)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc000f06e00, 0xc0053bcff0)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/bytes_table
...ent=127.0.0.1:36070,user=root] generating optimizer plan
              [n1,client=127.0.0.1:36070,user=root] added table 'data.public.bytes_table' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/85/1/"\x8e"
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 35.549ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/85/1/"\x8e"{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=c0d36333] querying next range at /Table/85/1/"\x8e"
              [n1,client=127.0.0.1:36070,user=root,txn=c0d36333] r228: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=c0d36333] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r228/1:/{Table/85-Max}] read-only path
              [n1,s1,r228/1:/{Table/85-Max}] read has no clock uncertainty
              [n1,s1,r228/1:/{Table/85-Max}] acquire latches
              [n1,s1,r228/1:/{Table/85-Max}] waited 89.183µs to acquire latches
              [n1,s1,r228/1:/{Table/85-Max}] waiting for read lock
              [n1,s1,r228/1:/{Table/85-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 453µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:16710] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 939749 [running]:
            runtime/debug.Stack(0xc006cae090, 0x6722520, 0xc0053f2b20)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc004953100, 0xc006cae090)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc004953100)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc004953100, 0xc0056c0780)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/list-range_partitioning
...27.0.0.1:36070,user=root,txn=5488aaf5] evicting range descriptor on *roachpb.SendError and backoff for re-lookup: r156:/Table/72/1/5{-/6} [(n1,s1):1, next=2, gen=135]
              [n1,client=127.0.0.1:36070,user=root,txn=5488aaf5] evicting cached range descriptor
               === SPAN START: range lookup ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=5488aaf5,range-lookup=/Table/72/1/5] querying next range at /Meta2/Table/72/1/5/NULL
              [n1,client=127.0.0.1:36070,user=root,txn=5488aaf5,range-lookup=/Table/72/1/5] r1: sending batch 1 Scan to (n3,s3):3
              [n1,client=127.0.0.1:36070,user=root,txn=5488aaf5,range-lookup=/Table/72/1/5] sending request to 127.0.0.1:40589
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n3] 1 Scan
              [n3,s3] executing 1 requests
              [n3,s3,r1/3:/{Min-System/NodeL…}] read-only path
               === SPAN START: request range lease ===
               === SPAN START: [async] storage.pendingLeaseRequest: requesting lease ===
              [n3,s3,r1/3:/{Min-System/NodeL…}] acquire latches
              [n3,s3,r1/3:/{Min-System/NodeL…}] operation accepts inconsistent results
              [n3,s3,r1/3:/{Min-System/NodeL…}] waiting for read lock
              [n3,s3,r1/3:/{Min-System/NodeL…}] read completed
              [n1,client=127.0.0.1:36070,user=root,txn=5488aaf5] looked up range descriptor: r156:/Table/72/1/5{-/6} [(n1,s1):1, (n2,s2):2, next=3, gen=137]
              [n1,client=127.0.0.1:36070,user=root,txn=5488aaf5] r156: sending batch 1 Scan to (n2,s2):2
              [n1,client=127.0.0.1:36070,user=root,txn=5488aaf5] sending request to 127.0.0.1:39171
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n2] 1 Scan
              [n2,s2] executing 1 requests
              [n2,s2,r156/2:/Table/72/1/5{-/6}] read-only path
              [n2,s2,r156/2:/Table/72/1/5{-/6}] acquire latches
              [n2,s2,r156/2:/Table/72/1/5{-/6}] waited 94.91µs to acquire latches
              [n2,s2,r156/2:/Table/72/1/5{-/6}] waiting for read lock
              [n2,s2,r156/2:/Table/72/1/5{-/6}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 2.983ms
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:8564] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 435260 [running]:
            runtime/debug.Stack(0xc003ebbd40, 0x6722520, 0xc001019000)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc005159e00, 0xc003ebbd40)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc005159e00)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc005159e00, 0xc0062629f0)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/inet_table
...tion
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/89/1/"\x01p\xbeg\x96\xdf\x1e\x9a\x95X!h\xe5\xafG\x00\xc2\xcc"
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 19.101ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/89/1/"\x01p\xbeg\x96\xdf\x1e\x9a\x95X!h\xe5\xafG\x00\xc2\xcc"{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=4dbe5979] querying next range at /Table/89/1/"\x01p\xbeg\x96\xdf\x1e\x9a\x95X!h\xe5\xafG\x00\xc2\xcc"
              [n1,client=127.0.0.1:36070,user=root,txn=4dbe5979] r247: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=4dbe5979] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r247/1:/{Table/88/2-Max}] read-only path
              [n1,s1,r247/1:/{Table/88/2-Max}] read has no clock uncertainty
              [n1,s1,r247/1:/{Table/88/2-Max}] acquire latches
              [n1,s1,r247/1:/{Table/88/2-Max}] waited 78.184µs to acquire latches
              [n1,s1,r247/1:/{Table/88/2-Max}] waiting for read lock
              [n1,s1,r247/1:/{Table/88/2-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 404µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:19634] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 1132996 [running]:
            runtime/debug.Stack(0xc005376cf0, 0x6722520, 0xc00153e2e0)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc000e76f00, 0xc005376cf0)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc000e76f00)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc000e76f00, 0xc0064e6ae0)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/scans
... [n1,client=127.0.0.1:36070,user=root] generating optimizer plan
              [n1,client=127.0.0.1:36070,user=root] added table 'data.public.scans' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/76/1/5
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 23.174ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/76/1/5{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=526c5e1d] querying next range at /Table/76/1/5
              [n1,client=127.0.0.1:36070,user=root,txn=526c5e1d] r185: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=526c5e1d] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r185/1:/Table/76/1/{5-6}] read-only path
              [n1,s1,r185/1:/Table/76/1/{5-6}] read has no clock uncertainty
              [n1,s1,r185/1:/Table/76/1/{5-6}] acquire latches
              [n1,s1,r185/1:/Table/76/1/{5-6}] waited 111.276µs to acquire latches
              [n1,s1,r185/1:/Table/76/1/{5-6}] waiting for read lock
              [n1,s1,r185/1:/Table/76/1/{5-6}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 401µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:10821] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 575598 [running]:
            runtime/debug.Stack(0xc0030cdc80, 0x6722520, 0xc0046f6000)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc0016b9000, 0xc0030cdc80)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc0016b9000)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc0016b9000, 0xc00149cba0)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/time_table
...timizer plan
              [n1,client=127.0.0.1:36070,user=root] added table 'data.public.time_table' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/90/1/19632909060
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 2.281ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/90/1/19632909060{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=0c3c45a7] querying next range at /Table/90/1/19632909060
              [n1,client=127.0.0.1:36070,user=root,txn=0c3c45a7] r250: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=0c3c45a7] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r250/1:/{Table/89/1/"…-Max}] read-only path
              [n1,s1,r250/1:/{Table/89/1/"…-Max}] read has no clock uncertainty
              [n1,s1,r250/1:/{Table/89/1/"…-Max}] acquire latches
              [n1,s1,r250/1:/{Table/89/1/"…-Max}] waited 73.974µs to acquire latches
              [n1,s1,r250/1:/{Table/89/1/"…-Max}] waiting for read lock
              [n1,s1,r250/1:/{Table/89/1/"…-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 318µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:20347] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 1178844 [running]:
            runtime/debug.Stack(0xc0062a50b0, 0x6722520, 0xc0053fefa0)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc005fd6d00, 0xc0062a50b0)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc005fd6d00)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc005fd6d00, 0xc005d42f60)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/secondary_index_-_NULL
....0.1:36070,user=root] generating optimizer plan
              [n1,client=127.0.0.1:36070,user=root] added table 'data.public."secondary index - NULL"' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/75/2/3
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 9.677ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches true
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/75/2/{3-4}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=f1de58e1] querying next range at /Table/75/2/3
              [n1,client=127.0.0.1:36070,user=root,txn=f1de58e1] r178: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=f1de58e1] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r178/1:/Table/75/2/{3-4}] read-only path
              [n1,s1,r178/1:/Table/75/2/{3-4}] read has no clock uncertainty
              [n1,s1,r178/1:/Table/75/2/{3-4}] acquire latches
              [n1,s1,r178/1:/Table/75/2/{3-4}] waited 61.231µs to acquire latches
              [n1,s1,r178/1:/Table/75/2/{3-4}] waiting for read lock
              [n1,s1,r178/1:/Table/75/2/{3-4}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 8.888ms
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:10232] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 534188 [running]:
            runtime/debug.Stack(0xc0035b6ed0, 0x6722520, 0xc0002f9be0)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc000f06c00, 0xc0035b6ed0)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc000f06c00)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc000f06c00, 0xc006263710)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/interval_table
...able' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/83/1/-49 years -7 mons -246 days -16:15:32.44699
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 39.505ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/83/1/-49 years -7 mons -246 days -16:15:32.44699{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=9de5fe53] querying next range at /Table/83/1/-49 years -7 mons -246 days -16:15:32.44699
              [n1,client=127.0.0.1:36070,user=root,txn=9de5fe53] r220: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=9de5fe53] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r220/1:/{Table/83/1/-…-Max}] read-only path
              [n1,s1,r220/1:/{Table/83/1/-…-Max}] read has no clock uncertainty
              [n1,s1,r220/1:/{Table/83/1/-…-Max}] acquire latches
              [n1,s1,r220/1:/{Table/83/1/-…-Max}] waited 104.219µs to acquire latches
              [n1,s1,r220/1:/{Table/83/1/-…-Max}] waiting for read lock
              [n1,s1,r220/1:/{Table/83/1/-…-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 412µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:15296] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 847047 [running]:
            runtime/debug.Stack(0xc0040de000, 0x6722520, 0xc0039db680)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc005fd6900, 0xc0040de000)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc005fd6900)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc005fd6900, 0xc003aa45a0)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/collatedstring{da}_table
...        [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/92/1/"\x8c\x91\xa3\x8c\xfc\xb4\x88P\x18\x91\x86\n\x03\x8d\x88B\x9f\x00\x00\x00 \x00 \x00 \x00 \x00 \x00 \x00\x00\x02\x02\x02\x02\x02\x02"
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 14.277ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/92/1/"\x8c\x91\xa3\x8c\xfc\xb4\x88P\x18\x91\x86\n\x03\x8d\x88B\x9f\x00\x00\x00 \x00 \x00 \x00 \x00 \x00 \x00\x00\x02\x02\x02\x02\x02\x02"{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=71acc224] querying next range at /Table/92/1/"\x8c\x91\xa3\x8c\xfc\xb4\x88P\x18\x91\x86\n\x03\x8d\x88B\x9f\x00\x00\x00 \x00 \x00 \x00 \x00 \x00 \x00\x00\x02\x02\x02\x02\x02\x02"
              [n1,client=127.0.0.1:36070,user=root,txn=71acc224] r257: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=71acc224] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r257/1:/{Table/90/2-Max}] read-only path
              [n1,s1,r257/1:/{Table/90/2-Max}] read has no clock uncertainty
              [n1,s1,r257/1:/{Table/90/2-Max}] acquire latches
              [n1,s1,r257/1:/{Table/90/2-Max}] waited 91.81µs to acquire latches
              [n1,s1,r257/1:/{Table/90/2-Max}] waiting for read lock
              [n1,s1,r257/1:/{Table/90/2-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 526µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:21701] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 1270747 [running]:
            runtime/debug.Stack(0xc0038391d0, 0x6722520, 0xc005792a60)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc0046f8500, 0xc0038391d0)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc0046f8500)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc0046f8500, 0xc005be78c0)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/string_table
...mizer plan
              [n1,client=127.0.0.1:36070,user=root] added table 'data.public.string_table' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/84/1/"3'\x04w,8"
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 7.262ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/84/1/"3'\x04w,8"{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=668c5f85] querying next range at /Table/84/1/"3'\x04w,8"
              [n1,client=127.0.0.1:36070,user=root,txn=668c5f85] r225: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=668c5f85] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r225/1:/{Table/84/1/"…-Max}] read-only path
              [n1,s1,r225/1:/{Table/84/1/"…-Max}] read has no clock uncertainty
              [n1,s1,r225/1:/{Table/84/1/"…-Max}] acquire latches
              [n1,s1,r225/1:/{Table/84/1/"…-Max}] waited 121.033µs to acquire latches
              [n1,s1,r225/1:/{Table/84/1/"…-Max}] waiting for read lock
              [n1,s1,r225/1:/{Table/84/1/"…-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 505µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:16009] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 889764 [running]:
            runtime/debug.Stack(0xc0062ff830, 0x6722520, 0xc006fb6740)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc00566d900, 0xc0062ff830)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc00566d900)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc00566d900, 0xc0023bcb40)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning
...23 04:11:40.102155 30648 storage/raft_snapshot_queue.go:125  [n1,raftsnapshot,s1,r14/1:/Table/1{8-9}] skipping snapshot; replica is likely a learner in the process of being added: (n2,s2):2LEARNER
I191023 04:11:40.134903 3202 storage/store_snapshot.go:978  [n1,replicate,s1,r14/1:/Table/1{8-9}] sending LEARNER snapshot 84420742 at applied index 19
I191023 04:11:40.136488 3202 storage/store_snapshot.go:1021  [n1,replicate,s1,r14/1:/Table/1{8-9}] streamed snapshot to (n2,s2):2LEARNER: kv pairs: 7, log entries: 0, rate-limit: 8.0 MiB/sec, 0.04s
I191023 04:11:40.145603 30647 storage/replica_raftstorage.go:794  [n2,s2,r14/2:{-}] applying LEARNER snapshot [id=84420742 index=19]
I191023 04:11:40.195232 30647 storage/replica_raftstorage.go:815  [n2,s2,r14/2:/Table/1{8-9}] applied LEARNER snapshot [total=49ms ingestion=4@21ms id=84420742 index=19]
I191023 04:11:40.239722 3202 storage/replica_command.go:1586  [n1,replicate,s1,r14/1:/Table/1{8-9}] change replicas (add [(n2,s2):2] remove []): existing descriptor r14:/Table/1{8-9} [(n1,s1):1, (n2,s2):2LEARNER, next=3, gen=1]
I191023 04:11:40.334164 3202 storage/replica_raft.go:291  [n1,s1,r14/1:/Table/1{8-9}] proposing ADD_REPLICA[(n2,s2):2]: after=[(n1,s1):1 (n2,s2):2] next=3
I191023 04:11:40.374950 3202 storage/replica_command.go:1586  [n1,replicate,s1,r14/1:/Table/1{8-9}] change replicas (add [(n3,s3):3LEARNER] remove []): existing descriptor r14:/Table/1{8-9} [(n1,s1):1, (n2,s2):2, next=3, gen=2]
I191023 04:11:40.562482 3202 storage/replica_raft.go:291  [n1,s1,r14/1:/Table/1{8-9}] proposing ADD_REPLICA[(n3,s3):3LEARNER]: after=[(n1,s1):1 (n2,s2):2 (n3,s3):3LEARNER] next=4
I191023 04:11:40.648843 31282 storage/raft_snapshot_queue.go:125  [n1,raftsnapshot,s1,r14/1:/Table/1{8-9}] skipping snapshot; replica is likely a learner in the process of being added: (n3,s3):3LEARNER
I191023 04:11:40.650184 3202 storage/store_snapshot.go:978  [n1,replicate,s1,r14/1:/Table/1{8-9}] sending LEARNER snapshot 7d3ecd33 at applied index 24
I191023 04:11:40.651367 3202 storage/store_snapshot.go:1021  [n1,replicate,s1,r14/1:/Table/1{8-9}] streamed snapshot to (n3,s3):3LEARNER: kv pairs: 11, log entries: 0, rate-limit: 8.0 MiB/sec, 0.03s
I191023 04:11:40.654508 31212 storage/replica_raftstorage.go:794  [n3,s3,r14/3:{-}] applying LEARNER snapshot [id=7d3ecd33 index=24]
I191023 04:11:40.675548 31212 storage/replica_raftstorage.go:815  [n3,s3,r14/3:/Table/1{8-9}] applied LEARNER snapshot [total=21ms ingestion=4@18ms id=7d3ecd33 index=24]
I191023 04:11:40.692832 3202 storage/replica_command.go:1586  [n1,replicate,s1,r14/1:/Table/1{8-9}] change replicas (add [(n3,s3):3] remove []): existing descriptor r14:/Table/1{8-9} [(n1,s1):1, (n2,s2):2, (n3,s3):3LEARNER, next=4, gen=3]
I191023 04:11:40.880224 3202 storage/replica_raft.go:291  [n1,s1,r14/1:/Table/1{8-9}] proposing ADD_REPLICA[(n3,s3):3]: after=[(n1,s1):1 (n2,s2):2 (n3,s3):3] next=4
I191023 04:11:40.991169 3202 storage/queue.go:1134  [n1,replicate] purgatory is now empty
I191023 04:11:41.063394 2726 testutils/testcluster/testcluster.go:747  WaitForFullReplication took: 18.234876651s
I191023 04:11:41.328973 4547 sql/event_log.go:132  [n1,client=127.0.0.1:36070,user=root] Event: "create_database", target: 52, info: {DatabaseName:data Statement:CREATE DATABASE data User:root}
I191023 04:11:41.513933 7593 server/status/runtime.go:498  [n3] runtime stats: 680 MiB RSS, 769 goroutines, 59 MiB/54 MiB/136 MiB GO alloc/idle/total, 91 MiB/136 MiB CGO alloc/total, 2268.8 CGO/sec, 188.1/18.8 %(u/s)time, 1.3 %gc (9x), 3.0 MiB/3.0 MiB (r/w)net
I191023 04:11:41.561824 4547 sql/event_log.go:132  [n1,client=127.0.0.1:36070,user=root] Event: "set_cluster_setting", target: 0, info: {SettingName:server.declined_reservation_timeout Value:00:00:00 User:root}
I191023 04:11:41.848057 4547 sql/event_log.go:132  [n1,client=127.0.0.1:36070,user=root] Event: "set_cluster_setting", target: 0, info: {SettingName:server.failed_reservation_timeout Value:00:00:00 User:root}



TestInitialPartitioning/oid_table
...0.1:36070,user=root] generating optimizer plan
              [n1,client=127.0.0.1:36070,user=root] added table 'data.public.oid_table' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/87/1/3751096672
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 3.755ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/87/1/3751096672{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=3b72a348] querying next range at /Table/87/1/3751096672
              [n1,client=127.0.0.1:36070,user=root,txn=3b72a348] r238: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=3b72a348] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r238/1:/{Table/87-Max}] read-only path
              [n1,s1,r238/1:/{Table/87-Max}] read has no clock uncertainty
              [n1,s1,r238/1:/{Table/87-Max}] acquire latches
              [n1,s1,r238/1:/{Table/87-Max}] waited 80.427µs to acquire latches
              [n1,s1,r238/1:/{Table/87-Max}] waiting for read lock
              [n1,s1,r238/1:/{Table/87-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 385µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:18160] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 1033747 [running]:
            runtime/debug.Stack(0xc004dd08d0, 0x6722520, 0xc0064f4f20)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc0016b8200, 0xc004dd08d0)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc0016b8200)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc0016b8200, 0xc004c55560)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/timestamp_table
...
              [n1,client=127.0.0.1:36070,user=root] added table 'data.public.timestamp_table' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/82/1/3000-01-01T00:00:00Z
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 2.533ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/82/1/3000-01-01T00:00:00Z{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=10b6b8b9] querying next range at /Table/82/1/3000-01-01T00:00:00Z
              [n1,client=127.0.0.1:36070,user=root,txn=10b6b8b9] r214: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=10b6b8b9] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r214/1:/{Table/82/1-Max}] read-only path
              [n1,s1,r214/1:/{Table/82/1-Max}] read has no clock uncertainty
              [n1,s1,r214/1:/{Table/82/1-Max}] acquire latches
              [n1,s1,r214/1:/{Table/82/1-Max}] waited 76.736µs to acquire latches
              [n1,s1,r214/1:/{Table/82/1-Max}] waiting for read lock
              [n1,s1,r214/1:/{Table/82/1-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 337µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:14661] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 801989 [running]:
            runtime/debug.Stack(0xc005e38ed0, 0x6722520, 0xc005777420)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc00409d200, 0xc005e38ed0)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc00409d200)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc00409d200, 0xc00481d500)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/varbit_table
...lanning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/91/1/B00100101110101111011010110000000001001011011111100010110000100110000111010010100110110111101000110
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 3.018ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/91/1/B00100101110101111011010110000000001001011011111100010110000100110000111010010100110110111101000110{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=c68581f3] querying next range at /Table/91/1/B00100101110101111011010110000000001001011011111100010110000100110000111010010100110110111101000110
              [n1,client=127.0.0.1:36070,user=root,txn=c68581f3] r254: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=c68581f3] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r254/1:/{Table/90/1-Max}] read-only path
              [n1,s1,r254/1:/{Table/90/1-Max}] read has no clock uncertainty
              [n1,s1,r254/1:/{Table/90/1-Max}] acquire latches
              [n1,s1,r254/1:/{Table/90/1-Max}] waited 174.25µs to acquire latches
              [n1,s1,r254/1:/{Table/90/1-Max}] waiting for read lock
              [n1,s1,r254/1:/{Table/90/1-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 373µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:21006] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 1225557 [running]:
            runtime/debug.Stack(0xc00122bb00, 0x6722520, 0xc002d5c340)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc002640100, 0xc00122bb00)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc002640100)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc002640100, 0xc006e72450)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/list-list_partitioning
...tion
              [n1,client=127.0.0.1:36070,user=root] found table in table collection for table 'data.public."list-list partitioning"'
              [n1,client=127.0.0.1:36070,user=root] query cache hit but needed update
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/71/1/5/7
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 41.19ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches true
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/71/1/{5/7-6}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=fef9fc22] querying next range at /Table/71/1/5/7
              [n1,client=127.0.0.1:36070,user=root,txn=fef9fc22] r148: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=fef9fc22] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r148/1:/Table/71/1/{5/7-6}] read-only path
              [n1,s1,r148/1:/Table/71/1/{5/7-6}] read has no clock uncertainty
              [n1,s1,r148/1:/Table/71/1/{5/7-6}] acquire latches
              [n1,s1,r148/1:/Table/71/1/{5/7-6}] waited 107.63µs to acquire latches
              [n1,s1,r148/1:/Table/71/1/{5/7-6}] waiting for read lock
              [n1,s1,r148/1:/Table/71/1/{5/7-6}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 475µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:7816] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 389026 [running]:
            runtime/debug.Stack(0xc003c4e7b0, 0x6722520, 0xc0003d78a0)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc004952c00, 0xc003c4e7b0)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc004952c00)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc004952c00, 0xc0025149c0)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/uuid_table
...le 'data.public.uuid_table' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/88/1/"\x11j(\x82\x02\"FT\x93uN9\xff\xeaϭ"
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 8.151ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/88/1/"\x11j(\x82\x02\"FT\x93uN9\xff\xeaϭ"{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=64fb6f62] querying next range at /Table/88/1/"\x11j(\x82\x02\"FT\x93uN9\xff\xeaϭ"
              [n1,client=127.0.0.1:36070,user=root,txn=64fb6f62] r240: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=64fb6f62] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r240/1:/{Table/87/1/3…-Max}] read-only path
              [n1,s1,r240/1:/{Table/87/1/3…-Max}] read has no clock uncertainty
              [n1,s1,r240/1:/{Table/87/1/3…-Max}] acquire latches
              [n1,s1,r240/1:/{Table/87/1/3…-Max}] waited 98.856µs to acquire latches
              [n1,s1,r240/1:/{Table/87/1/3…-Max}] waiting for read lock
              [n1,s1,r240/1:/{Table/87/1/3…-Max}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 380µs
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:18885] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 1083323 [running]:
            runtime/debug.Stack(0xc00621be00, 0x6722520, 0xc002ed50e0)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc005475b00, 0xc00621be00)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc005475b00)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc005475b00, 0xc003f4b890)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b



TestInitialPartitioning/bool_table
...client=127.0.0.1:36070,user=root] generating optimizer plan
              [n1,client=127.0.0.1:36070,user=root] added table 'data.public.bool_table' to table collection
              [n1,client=127.0.0.1:36070,user=root] query cache hit
              [n1,client=127.0.0.1:36070,user=root] planning ends
              [n1,client=127.0.0.1:36070,user=root] checking distributability
              [n1,client=127.0.0.1:36070,user=root] will distribute plan: true
              [n1,client=127.0.0.1:36070,user=root] execution starts: distributed engine
               === SPAN START: consuming rows ===
              [n1,client=127.0.0.1:36070,user=root] creating DistSQL plan with isLocal=false
              [n1,client=127.0.0.1:36070,user=root] querying next range at /Table/77/1/1
              [n1,client=127.0.0.1:36070,user=root] running DistSQL plan
               === SPAN START: flow ===
              [n1,client=127.0.0.1:36070,user=root] starting (0 processors, 0 startables)
               === SPAN START: table reader ===
            cockroach.processorid: 0
            cockroach.stat.tablereader.bytes.read: 0 B
            cockroach.stat.tablereader.input.rows: 0
            cockroach.stat.tablereader.stalltime: 3.65ms
              [n1,client=127.0.0.1:36070,user=root] starting scan with limitBatches false
              [n1,client=127.0.0.1:36070,user=root] Scan /Table/77/1/1{-/#}
               === SPAN START: txn coordinator send ===
               === SPAN START: dist sender send ===
              [n1,client=127.0.0.1:36070,user=root,txn=0a5d33ad] querying next range at /Table/77/1/1
              [n1,client=127.0.0.1:36070,user=root,txn=0a5d33ad] r190: sending batch 1 Scan to (n1,s1):1
              [n1,client=127.0.0.1:36070,user=root,txn=0a5d33ad] sending request to local client
               === SPAN START: /cockroach.roachpb.Internal/Batch ===
              [n1] 1 Scan
              [n1,s1] executing 1 requests
              [n1,s1,r190/1:/Table/77/1/{1-2}] read-only path
              [n1,s1,r190/1:/Table/77/1/{1-2}] read has no clock uncertainty
              [n1,s1,r190/1:/Table/77/1/{1-2}] acquire latches
              [n1,s1,r190/1:/Table/77/1/{1-2}] waited 140.164µs to acquire latches
              [n1,s1,r190/1:/Table/77/1/{1-2}] waiting for read lock
              [n1,s1,r190/1:/Table/77/1/{1-2}] read completed
               === SPAN START: count rows ===
            cockroach.processorid: 1
            cockroach.stat.aggregator.input.rows: 0
            cockroach.stat.aggregator.mem.max: 0 B
            cockroach.stat.aggregator.stalltime: 1.358ms
              [n1,client=127.0.0.1:36070,user=root] execution ends
              [n1,client=127.0.0.1:36070,user=root] rows affected: 1
              [n1,client=127.0.0.1:36070,user=root] AutoCommit. err: <nil>
              [n1,client=127.0.0.1:36070,user=root] releasing 1 tables
               === SPAN START: exec stmt ===
              [n1,client=127.0.0.1:36070,user=root] [NoTxn pos:11534] executing ExecStmt: SET TRACING = off
              [n1,client=127.0.0.1:36070,user=root] executing: SET TRACING = off in state: NoTxn
            goroutine 622529 [running]:
            runtime/debug.Stack(0xc0017a50b0, 0x6722520, 0xc004ee0a40)
            	/usr/local/go/src/runtime/debug/stack.go:24 +0xab
            github.com/cockroachdb/cockroach/pkg/testutils.SucceedsSoon(0x6816820, 0xc001453600, 0xc0017a50b0)
            	/go/src/github.com/cockroachdb/cockroach/pkg/testutils/soon.go:37 +0x87
            github.com/cockroachdb/cockroach/pkg/ccl/partitionccl.TestInitialPartitioning.func1(0xc001453600)
            	/go/src/github.com/cockroachdb/cockroach/pkg/ccl/partitionccl/partition_test.go:1196 +0x23a
            testing.tRunner(0xc001453600, 0xc003766ab0)
            	/usr/local/go/src/testing/testing.go:865 +0x164
            created by testing.(*T).Run
            	/usr/local/go/src/testing/testing.go:916 +0x65b

Please assign, take a look and update the issue accordingly.
@cockroach-teamcity cockroach-teamcity added C-test-failure Broken test (automatically or manually discovered). O-robot Originated from a bot. labels Oct 23, 2019
@cockroach-teamcity cockroach-teamcity added this to the 19.2 milestone Oct 23, 2019
andreimatei added a commit to andreimatei/cockroach that referenced this issue Oct 23, 2019
@andreimatei
all: Revert cockroachdb#39722
0cf7360 
This reverts commit 0b0c71f, reversing
changes made to 9b36103.

Reverting "config,sqlbase: move computation of splits for SQL tables to
sqlbase". It seems to have caused TestInitialPartitioning and
TestRepartitioning to timeout often when run under testrace on TC (only
when the build runs on the master branch and these tests are run in
conjunction with all the other packages). I don't know what's wrong yet.

Fixes cockroachdb#41812
Fixes cockroachdb#41821
Fixes cockroachdb#41825
Fixes cockroachdb#41831
Fixes cockroachdb#41835
Fixes cockroachdb#41843
Fixes cockroachdb#41846
Fixes cockroachdb#41850
Fixes cockroachdb#41862
Fixes cockroachdb#41874
Fixes cockroachdb#41879

Fixes cockroachdb#41652
Fixes cockroachdb#41813
Fixes cockroachdb#41822
Fixes cockroachdb#41826
Fixes cockroachdb#41832
Fixes cockroachdb#41836
Fixes cockroachdb#41844
Fixes cockroachdb#41847
Fixes cockroachdb#41851
Fixes cockroachdb#41868
Fixes cockroachdb#41875

Release note: None
@andreimatei andreimatei mentioned this issue Oct 23, 2019
Merged
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
C-test-failure Broken test (automatically or manually discovered). O-robot Originated from a bot.
Projects
None yet
Milestone
19.2
Development

Successfully merging a pull request may close this issue.

all: Revert #39722 andreimatei/cockroach
1 participant
@cockroach-teamcity