teamcity: failed test: TestImportControlJob

[cockroach-teamcity]

The following tests appear to have failed on master (test): TestImportControlJob, TestImportControlJob/cancel

You may want to check for open issues.

#1439112:

TestImportControlJob/cancel
--- FAIL: test/TestImportControlJob: TestImportControlJob/cancel (0.140s)

------- Stdout: -------
I190814 17:11:59.408104 478957 sql/event_log.go:130  [n1,client=127.0.0.1:35672,user=root] Event: "create_database", target: 53, info: {DatabaseName:cancelimport Statement:CREATE DATABASE cancelimport User:root}
I190814 17:11:59.453689 478786 ccl/importccl/read_import_proc.go:79  [n1,import-distsql-ingest] could not fetch file size; falling back to per-file progress: bad ContentLength: -1
I190814 17:11:59.457940 478787 storage/replica_command.go:283  [n1,s1,r20/1:/{Table/24-Max}] initiating a split of this range at key /Table/54/1 [r21] (manual)
W190814 17:11:59.527077 478787 storage/engine/rocksdb.go:116  [rocksdb] [db/version_set.cc:3086] More existing levels in DB than needed. max_bytes_for_level_multiplier may not be guaranteed.
I190814 17:11:59.532711 479429 storage/replica_command.go:283  [n1,split,s1,r20/1:/Table/{24-54/1}] initiating a split of this range at key /Table/54 [r22] (zone config)
W190814 17:11:59.535882 478452 storage/engine/rocksdb.go:116  [rocksdb] [db/version_set.cc:3086] More existing levels in DB than needed. max_bytes_for_level_multiplier may not be guaranteed.
        import_stmt_test.go:2085: expected 'job canceled' error, but got <nil>



TestImportControlJob
...d:"tcp" address_field:"127.0.0.1:34597" > 
I190814 17:11:59.178395 477792 server/node.go:422  [n1] initialized store [n1,s1]: disk (capacity=512 MiB, available=512 MiB, used=0 B, logicalBytes=8.7 KiB), ranges=20, leases=0, queries=0.00, writes=0.00, bytesPerReplica={p10=0.00 p25=0.00 p50=0.00 p75=0.00 p90=929.00 pMax=7803.00}, writesPerReplica={p10=0.00 p25=0.00 p50=0.00 p75=0.00 p90=0.00 pMax=0.00}
I190814 17:11:59.181077 477792 storage/stores.go:240  [n1] read 0 node addresses from persistent storage
I190814 17:11:59.181232 477792 server/node.go:636  [n1] connecting to gossip network to verify cluster ID...
W190814 17:11:59.184208 478507 storage/store.go:1535  [n1,s1,r6/1:/Table/{SystemCon…-11}] could not gossip system config: [NotLeaseHolderError] r6: replica (n1,s1):1 not lease holder; lease holder unknown
I190814 17:11:59.184320 477792 server/node.go:656  [n1] node connected via gossip and verified as part of cluster "086c48be-b6b3-43fe-9bb3-a36b70ff0047"
I190814 17:11:59.184449 477792 server/node.go:503  [n1] node=1: started with [<no-attributes>=<in-mem>] engine(s) and attributes []
I190814 17:11:59.184605 477792 server/server.go:1977  [n1] Could not start goroutine dumper worker due to: directory to store dumps could not be determined
I190814 17:11:59.184712 477792 server/server.go:1474  [n1] starting https server at 127.0.0.1:42239 (use: 127.0.0.1:42239)
I190814 17:11:59.191766 477792 server/server.go:1479  [n1] starting postgres server at 127.0.0.1:34597 (use: 127.0.0.1:34597)
I190814 17:11:59.191855 477792 server/server.go:1481  [n1] starting grpc server at 127.0.0.1:39541
I190814 17:11:59.191885 477792 server/server.go:1482  [n1] advertising CockroachDB node at 127.0.0.1:39541
I190814 17:11:59.272043 478593 sql/event_log.go:130  [n1,intExec=optInToDiagnosticsStatReporting] Event: "set_cluster_setting", target: 0, info: {SettingName:diagnostics.reporting.enabled Value:true User:root}
I190814 17:11:59.285035 477746 sql/event_log.go:130  [n1,intExec=set-setting] Event: "set_cluster_setting", target: 0, info: {SettingName:version Value:19.1-8 User:root}
I190814 17:11:59.308601 478235 sql/event_log.go:130  [n1,intExec=disableNetTrace] Event: "set_cluster_setting", target: 0, info: {SettingName:trace.debug.enable Value:false User:root}
I190814 17:11:59.328253 478875 sql/event_log.go:130  [n1,intExec=initializeClusterSecret] Event: "set_cluster_setting", target: 0, info: {SettingName:cluster.secret Value:dee1541d-9734-428c-8636-c02d1af254cb User:root}
I190814 17:11:59.336799 478859 sql/event_log.go:130  [n1,intExec=create-default-db] Event: "create_database", target: 50, info: {DatabaseName:defaultdb Statement:CREATE DATABASE IF NOT EXISTS defaultdb User:root}
I190814 17:11:59.340663 478864 sql/event_log.go:130  [n1,intExec=create-default-db] Event: "create_database", target: 51, info: {DatabaseName:postgres Statement:CREATE DATABASE IF NOT EXISTS postgres User:root}
I190814 17:11:59.351002 477792 server/server.go:1550  [n1] done ensuring all necessary migrations have run
I190814 17:11:59.351129 477792 server/server.go:1788  [n1] serving sql connections
I190814 17:11:59.352028 477792 testutils/testcluster/testcluster.go:655  WaitForFullReplication took: 1µs
I190814 17:11:59.354006 479018 server/server_update.go:68  [n1] no need to upgrade, cluster already at the newest version
I190814 17:11:59.355767 479020 sql/event_log.go:130  [n1] Event: "node_join", target: 1, info: {Descriptor:{NodeID:1 Address:127.0.0.1:39541 Attrs: Locality:region=test,dc=dc1 ServerVersion:19.1-8 BuildTag:v19.2.0-alpha.20190606-1512-ge445511 StartedAt:1565802719174286930 LocalityAddress:[] ClusterName: SQLAddress:127.0.0.1:34597} ClusterID:086c48be-b6b3-43fe-9bb3-a36b70ff0047 StartedAt:1565802719174286930 LastUp:1565802719174286930}
I190814 17:11:59.403341 478957 sql/event_log.go:130  [n1,client=127.0.0.1:35672,user=root] Event: "create_database", target: 52, info: {DatabaseName:data Statement:CREATE DATABASE data User:root}

Please assign, take a look and update the issue accordingly.

[nvanbenschoten]

Assigning @dt for triage.