Log file created at: 2023/05/02 20:32:39 Running on machine: 1b57a349e8a0 Binary: Built with gc go1.20.1 for linux/amd64 Log line format: [IWEF]mmdd hh:mm:ss.uuuuuu threadid file:line] msg I0502 20:32:39.752567 6391 servenv.go:133] Version: 17.0.0-SNAPSHOT (Git revision 4ab581ceab76e869e62e3028dae06f53293d2eff branch 'duo-poc') built on Tue May 2 20:26:58 UTC 2023 by vitess@buildkitsandbox using go1.20.1 linux/amd64 I0502 20:32:39.763075 6391 healthcheck.go:312] loading tablets for cells: zone1 I0502 20:32:39.763083 6391 healthcheck.go:333] Setting up healthcheck for cell: zone1 I0502 20:32:39.763195 6391 flags.go:205] vtgate buffer not enabled. I0502 20:32:39.763783 6391 keyspace_events.go:84] started watching keyspace events in "zone1" I0502 20:32:39.763864 6391 tabletgateway.go:186] Gateway waiting for serving tablets of types [PRIMARY REPLICA] ... I0502 20:32:39.763935 6391 tabletgateway.go:194] Waiting for tablets completed I0502 20:32:39.763960 6391 vtgate.go:161] Transaction mode: 'MULTI' I0502 20:32:39.764539 6391 vtgate.go:363] No keyspace to load I0502 20:32:39.771995 6391 keyspace_events.go:385] created dedicated watcher for keyspace zone1/duo I0502 20:32:39.773926 6391 vschema_manager.go:103] Received vschema update I0502 20:32:39.774097 6391 keyspace_events.go:385] created dedicated watcher for keyspace zone1/duo_unsharded I0502 20:32:39.774168 6391 vschema_manager.go:103] Received vschema update I0502 20:32:39.774546 6391 streamlog.go:208] Streaming logs from VTGate at /debug/querylog. I0502 20:32:39.774213 6391 healthcheck.go:375] Adding tablet to healthcheck: alias:{cell:"zone1" uid:100} hostname:"1b57a349e8a0" port_map:{key:"grpc" value:16100} port_map:{key:"vt" value:15100} keyspace:"duo" shard:"-80" key_range:{end:"\x80"} type:PRIMARY mysql_hostname:"1b57a349e8a0" mysql_port:17100 primary_term_start_time:{seconds:1683059509 nanoseconds:385187246} db_server_version:"8.0.30" default_conn_collation:255 I0502 20:32:39.774823 6391 healthcheck.go:375] Adding tablet to healthcheck: alias:{cell:"zone1" uid:102} hostname:"1b57a349e8a0" port_map:{key:"grpc" value:16102} port_map:{key:"vt" value:15102} keyspace:"duo" shard:"-80" key_range:{end:"\x80"} type:RDONLY mysql_hostname:"1b57a349e8a0" mysql_port:17102 db_server_version:"8.0.30" default_conn_collation:255 I0502 20:32:39.774944 6391 healthcheck.go:375] Adding tablet to healthcheck: alias:{cell:"zone1" uid:202} hostname:"1b57a349e8a0" port_map:{key:"grpc" value:16202} port_map:{key:"vt" value:15202} keyspace:"duo" shard:"80-" key_range:{start:"\x80"} type:RDONLY mysql_hostname:"1b57a349e8a0" mysql_port:17202 db_server_version:"8.0.30" default_conn_collation:255 I0502 20:32:39.774983 6391 healthcheck.go:375] Adding tablet to healthcheck: alias:{cell:"zone1" uid:201} hostname:"1b57a349e8a0" port_map:{key:"grpc" value:16201} port_map:{key:"vt" value:15201} keyspace:"duo" shard:"80-" key_range:{start:"\x80"} type:PRIMARY mysql_hostname:"1b57a349e8a0" mysql_port:17201 primary_term_start_time:{seconds:1683059509 nanoseconds:435910144} db_server_version:"8.0.30" default_conn_collation:255 I0502 20:32:39.775015 6391 healthcheck.go:375] Adding tablet to healthcheck: alias:{cell:"zone1" uid:301} hostname:"1b57a349e8a0" port_map:{key:"grpc" value:16301} port_map:{key:"vt" value:15301} keyspace:"duo_unsharded" shard:"0" type:PRIMARY mysql_hostname:"1b57a349e8a0" mysql_port:17301 primary_term_start_time:{seconds:1683059554 nanoseconds:319762991} db_server_version:"8.0.30" default_conn_collation:255 I0502 20:32:39.775055 6391 healthcheck.go:375] Adding tablet to healthcheck: alias:{cell:"zone1" uid:101} hostname:"1b57a349e8a0" port_map:{key:"grpc" value:16101} port_map:{key:"vt" value:15101} keyspace:"duo" shard:"-80" key_range:{end:"\x80"} type:REPLICA mysql_hostname:"1b57a349e8a0" mysql_port:17101 db_server_version:"8.0.30" default_conn_collation:255 I0502 20:32:39.775087 6391 healthcheck.go:375] Adding tablet to healthcheck: alias:{cell:"zone1" uid:200} hostname:"1b57a349e8a0" port_map:{key:"grpc" value:16200} port_map:{key:"vt" value:15200} keyspace:"duo" shard:"80-" key_range:{start:"\x80"} type:REPLICA mysql_hostname:"1b57a349e8a0" mysql_port:17200 db_server_version:"8.0.30" default_conn_collation:255 I0502 20:32:39.775137 6391 healthcheck.go:375] Adding tablet to healthcheck: alias:{cell:"zone1" uid:302} hostname:"1b57a349e8a0" port_map:{key:"grpc" value:16302} port_map:{key:"vt" value:15302} keyspace:"duo_unsharded" shard:"0" type:RDONLY mysql_hostname:"1b57a349e8a0" mysql_port:17302 db_server_version:"8.0.30" default_conn_collation:255 I0502 20:32:39.775218 6391 vschema_manager.go:103] Received vschema update I0502 20:32:39.775226 6391 healthcheck.go:375] Adding tablet to healthcheck: alias:{cell:"zone1" uid:300} hostname:"1b57a349e8a0" port_map:{key:"grpc" value:16300} port_map:{key:"vt" value:15300} keyspace:"duo_unsharded" shard:"0" type:REPLICA mysql_hostname:"1b57a349e8a0" mysql_port:17300 db_server_version:"8.0.30" default_conn_collation:255 I0502 20:32:39.776971 6391 grpc_server.go:209] Setting grpc max message size to 16777216 I0502 20:32:39.776990 6391 grpc_server.go:384] Building interceptors with 0 unary interceptors and 0 stream interceptors I0502 20:32:39.779300 6391 tablet_health_check.go:110] HealthCheckUpdate(Serving State): tablet: zone1-302 (1b57a349e8a0) serving false => true for duo_unsharded/0 (RDONLY) reason: healthCheck update I0502 20:32:39.779469 6391 tablet_health_check.go:110] HealthCheckUpdate(Serving State): tablet: zone1-100 (1b57a349e8a0) serving false => true for duo/-80 (PRIMARY) reason: healthCheck update I0502 20:32:39.780382 6391 tablet_health_check.go:110] HealthCheckUpdate(Serving State): tablet: zone1-301 (1b57a349e8a0) serving false => true for duo_unsharded/0 (PRIMARY) reason: healthCheck update I0502 20:32:39.780456 6391 keyspace_events.go:272] keyspace event resolved: duo_unsharded/duo_unsharded is now consistent (serving: true) I0502 20:32:39.780485 6391 shard_buffer.go:483] disruption in shard duo_unsharded/0 resolved (serving: true) I0502 20:32:39.780549 6391 tablet_health_check.go:110] HealthCheckUpdate(Serving State): tablet: zone1-101 (1b57a349e8a0) serving false => true for duo/-80 (REPLICA) reason: healthCheck update I0502 20:32:39.780591 6391 tablet_health_check.go:110] HealthCheckUpdate(Serving State): tablet: zone1-300 (1b57a349e8a0) serving false => true for duo_unsharded/0 (REPLICA) reason: healthCheck update I0502 20:32:39.781165 6391 tablet_health_check.go:110] HealthCheckUpdate(Serving State): tablet: zone1-200 (1b57a349e8a0) serving false => true for duo/80- (REPLICA) reason: healthCheck update I0502 20:32:39.781253 6391 tablet_health_check.go:110] HealthCheckUpdate(Serving State): tablet: zone1-102 (1b57a349e8a0) serving false => true for duo/-80 (RDONLY) reason: healthCheck update I0502 20:32:39.781409 6391 auth_server_clientcert.go:46] Not configuring AuthServerClientCert because mysql_server_ssl_ca is empty I0502 20:32:39.781431 6391 auth_server_ldap.go:68] Not configuring AuthServerLdap because mysql_ldap_auth_config_file and mysql_ldap_auth_config_string are empty I0502 20:32:39.781434 6391 auth_server_static.go:99] Not configuring AuthServerStatic, as mysql_auth_server_static_file and mysql_auth_server_static_string are empty I0502 20:32:39.781442 6391 auth_server_vault.go:84] Not configuring AuthServerVault, as --mysql_auth_vault_addr is empty. I0502 20:32:39.781889 6391 tablet_health_check.go:110] HealthCheckUpdate(Serving State): tablet: zone1-202 (1b57a349e8a0) serving false => true for duo/80- (RDONLY) reason: healthCheck update I0502 20:32:39.782486 6391 tablet_health_check.go:110] HealthCheckUpdate(Serving State): tablet: zone1-201 (1b57a349e8a0) serving false => true for duo/80- (PRIMARY) reason: healthCheck update I0502 20:32:39.782503 6391 keyspace_events.go:272] keyspace event resolved: duo/duo is now consistent (serving: true) I0502 20:32:39.782505 6391 keyspace_events.go:272] keyspace event resolved: duo/duo is now consistent (serving: true) I0502 20:32:39.782530 6391 shard_buffer.go:483] disruption in shard duo/-80 resolved (serving: true) I0502 20:32:39.782547 6391 shard_buffer.go:483] disruption in shard duo/80- resolved (serving: true) I0502 20:32:39.782725 6391 statsd.go:81] statsdAddress is empty I0502 20:32:39.782756 6391 service_map.go:66] Registering vtgateservice for grpc, disable it with -grpc-vtgateservice service_map parameter I0502 20:32:39.782879 6391 tracker.go:159] Starting schema tracking I0502 20:32:39.785309 6391 grpc_server.go:286] Listening for gRPC calls on port 15991 I0502 20:32:39.785375 6391 unix_socket.go:37] Not listening on socket file I0502 20:32:40.905240 6391 tracker.go:126] finished loading schema for keyspace duo. Found 23 columns in total across the tables I0502 20:32:40.905298 6391 vschema_manager.go:165] Received schema update I0502 20:32:40.906316 6391 vschema_manager.go:178] Sent vschema to subscriber I0502 20:32:43.724820 6391 tracker.go:126] finished loading schema for keyspace duo_unsharded. Found 6 columns in total across the tables I0502 20:32:43.724851 6391 vschema_manager.go:165] Received schema update I0502 20:32:43.727205 6391 vschema_manager.go:178] Sent vschema to subscriber E0502 20:40:22.503332 6391 server.go:348] mysql_server caught panic: this switch should be exhaustive vitess.io/vitess/go/vt/vtgate/planbuilder/operators/sharded_routing.go:330 (0x1036325) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route.go:176 (0x102f5e1) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/helpers.go:136 (0x10223c6) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:48 (0x1019f46) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:121 (0x101a351) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:131 (0x101a3ed) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:73 (0x1019ede) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:47 (0x1019ebe) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/helpers.go:134 (0x102234c) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:382 (0x103310f) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:327 (0x1032876) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:246 (0x10321db) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:129 (0x10315b3) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:56 (0x103120f) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:110 (0x101a298) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:96 (0x101a1d8) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:61 (0x1019fc7) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:53 (0x1031118) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/operator.go:64 (0x102a064) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:209 (0x105a4ad) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:91 (0x1059c92) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:94 (0x10596c1) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:36 (0x10593b5) vitess.io/vitess/go/vt/vtgate/planbuilder/builder.go:202 (0x1047939) vitess.io/vitess/go/vt/vtgate/planbuilder/builder.go:212 (0x1047a8c) vitess.io/vitess/go/vt/vtgate/planbuilder/builder.go:113 (0x1047284) vitess.io/vitess/go/vt/vtgate/executor.go:1034 (0x10b858b) vitess.io/vitess/go/vt/vtgate/executor.go:1017 (0x10b81af) vitess.io/vitess/go/vt/vtgate/plan_execute.go:64 (0x10bc43c) vitess.io/vitess/go/vt/vtgate/executor.go:384 (0x10b1c68) vitess.io/vitess/go/vt/vtgate/executor.go:198 (0x10b0164) vitess.io/vitess/go/vt/vtgate/vtgate.go:437 (0x10e8c64) vitess.io/vitess/go/vt/vtgate/plugin_mysql_server.go:243 (0x10befad) vitess.io/vitess/go/mysql/conn.go:1359 (0xda9995) vitess.io/vitess/go/mysql/conn.go:1344 (0xda960c) vitess.io/vitess/go/mysql/conn.go:910 (0xda58a7) vitess.io/vitess/go/mysql/server.go:527 (0xdc7716) vitess.io/vitess/go/mysql/server.go:331 (0xdc629e) runtime/asm_amd64.s:1598 (0x470020) E0502 20:40:22.507259 6391 server.go:348] mysql_server caught panic: this switch should be exhaustive vitess.io/vitess/go/vt/vtgate/planbuilder/operators/sharded_routing.go:330 (0x1036325) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route.go:176 (0x102f5e1) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/helpers.go:136 (0x10223c6) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:48 (0x1019f46) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:121 (0x101a351) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:131 (0x101a3ed) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:73 (0x1019ede) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:47 (0x1019ebe) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/helpers.go:134 (0x102234c) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:382 (0x103310f) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:327 (0x1032876) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:246 (0x10321db) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:129 (0x10315b3) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:56 (0x103120f) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:110 (0x101a298) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:96 (0x101a1d8) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:61 (0x1019fc7) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:53 (0x1031118) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/operator.go:64 (0x102a064) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:209 (0x105a4ad) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:91 (0x1059c92) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:94 (0x10596c1) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:36 (0x10593b5) vitess.io/vitess/go/vt/vtgate/planbuilder/builder.go:202 (0x1047939) vitess.io/vitess/go/vt/vtgate/planbuilder/builder.go:212 (0x1047a8c) vitess.io/vitess/go/vt/vtgate/planbuilder/builder.go:113 (0x1047284) vitess.io/vitess/go/vt/vtgate/executor.go:1034 (0x10b858b) vitess.io/vitess/go/vt/vtgate/executor.go:1017 (0x10b81af) vitess.io/vitess/go/vt/vtgate/plan_execute.go:64 (0x10bc43c) vitess.io/vitess/go/vt/vtgate/executor.go:384 (0x10b1c68) vitess.io/vitess/go/vt/vtgate/executor.go:198 (0x10b0164) vitess.io/vitess/go/vt/vtgate/vtgate.go:437 (0x10e8c64) vitess.io/vitess/go/vt/vtgate/plugin_mysql_server.go:243 (0x10befad) vitess.io/vitess/go/mysql/conn.go:1359 (0xda9995) vitess.io/vitess/go/mysql/conn.go:1344 (0xda960c) vitess.io/vitess/go/mysql/conn.go:910 (0xda58a7) vitess.io/vitess/go/mysql/server.go:527 (0xdc7716) vitess.io/vitess/go/mysql/server.go:331 (0xdc629e) runtime/asm_amd64.s:1598 (0x470020) E0502 20:40:22.513442 6391 server.go:348] mysql_server caught panic: this switch should be exhaustive vitess.io/vitess/go/vt/vtgate/planbuilder/operators/sharded_routing.go:330 (0x1036325) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route.go:176 (0x102f5e1) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/helpers.go:136 (0x10223c6) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:48 (0x1019f46) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:121 (0x101a351) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:131 (0x101a3ed) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:73 (0x1019ede) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:47 (0x1019ebe) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/helpers.go:134 (0x102234c) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:382 (0x103310f) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:327 (0x1032876) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:246 (0x10321db) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:129 (0x10315b3) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:56 (0x103120f) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:110 (0x101a298) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:96 (0x101a1d8) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/rewrite/rewriters.go:61 (0x1019fc7) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/route_planning.go:53 (0x1031118) vitess.io/vitess/go/vt/vtgate/planbuilder/operators/operator.go:64 (0x102a064) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:209 (0x105a4ad) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:91 (0x1059c92) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:94 (0x10596c1) vitess.io/vitess/go/vt/vtgate/planbuilder/gen4_planner.go:36 (0x10593b5) vitess.io/vitess/go/vt/vtgate/planbuilder/builder.go:202 (0x1047939) vitess.io/vitess/go/vt/vtgate/planbuilder/builder.go:212 (0x1047a8c) vitess.io/vitess/go/vt/vtgate/planbuilder/builder.go:113 (0x1047284) vitess.io/vitess/go/vt/vtgate/executor.go:1034 (0x10b858b) vitess.io/vitess/go/vt/vtgate/executor.go:1017 (0x10b81af) vitess.io/vitess/go/vt/vtgate/plan_execute.go:64 (0x10bc43c) vitess.io/vitess/go/vt/vtgate/executor.go:384 (0x10b1c68) vitess.io/vitess/go/vt/vtgate/executor.go:198 (0x10b0164) vitess.io/vitess/go/vt/vtgate/vtgate.go:437 (0x10e8c64) vitess.io/vitess/go/vt/vtgate/plugin_mysql_server.go:243 (0x10befad) vitess.io/vitess/go/mysql/conn.go:1359 (0xda9995) vitess.io/vitess/go/mysql/conn.go:1344 (0xda960c) vitess.io/vitess/go/mysql/conn.go:910 (0xda58a7) vitess.io/vitess/go/mysql/server.go:527 (0xdc7716) vitess.io/vitess/go/mysql/server.go:331 (0xdc629e) runtime/asm_amd64.s:1598 (0x470020)