2025-10-26 20:03:37,750 - DEBUG - ya.test - __init__: Reading variables from env_file at /home/runner/.ya/build/build_root/70hy/0003ad/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse/test-results/py3test/env.json.txt
2025-10-26 20:03:37,751 - DEBUG - ya.test - __init__: Variables loaded: ['COMPOSE_PROJECT_NAME', 'DOCKER_COMPOSE_FILE']
2025-10-26 20:03:37,757 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/0003ad/library/recipes/docker_compose/bin/docker-compose', '-f', '/home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse/docker-compose.yml', 'ps', '-q']' in 'None' (waiting)
2025-10-26 20:03:37,759 - DEBUG - ya.test - execute: Command pid: 2004868
2025-10-26 20:03:38,454 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) rc: 0
2025-10-26 20:03:38,455 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) elapsed time (sec): 0.6943740844726562
2025-10-26 20:03:38,455 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) idrss: 0
2025-10-26 20:03:38,455 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) inblock: 0
2025-10-26 20:03:38,455 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) isrss: 0
2025-10-26 20:03:38,455 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) ixrss: 0
2025-10-26 20:03:38,455 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) majflt: 0
2025-10-26 20:03:38,455 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) maxrss: 148596
2025-10-26 20:03:38,456 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) minflt: 17580
2025-10-26 20:03:38,456 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) msgrcv: 0
2025-10-26 20:03:38,456 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) msgsnd: 0
2025-10-26 20:03:38,456 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) nivcsw: 19
2025-10-26 20:03:38,456 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) nsignals: 0
2025-10-26 20:03:38,456 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) nswap: 0
2025-10-26 20:03:38,456 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) nvcsw: 25
2025-10-26 20:03:38,456 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) oublock: 53464
2025-10-26 20:03:38,456 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) stime: 0.097296
2025-10-26 20:03:38,457 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) utime: 0.589178
2025-10-26 20:03:38,457 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) wtime: 0.696
2025-10-26 20:03:38,457 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) output:
09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e
944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c

2025-10-26 20:03:38,457 - DEBUG - ya.test - _save_outputs: Command (pid 2004868) errors:

2025-10-26 20:03:38,460 - DEBUG - ya.test - execute: Executing '['docker', 'inspect', '--format={{.Name}}', '09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e']' in 'None' (waiting)
2025-10-26 20:03:38,463 - DEBUG - ya.test - execute: Command pid: 2004873
2025-10-26 20:03:38,497 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) rc: 0
2025-10-26 20:03:38,498 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) elapsed time (sec): 0.03290081024169922
2025-10-26 20:03:38,498 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) idrss: 0
2025-10-26 20:03:38,498 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) inblock: 0
2025-10-26 20:03:38,498 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) isrss: 0
2025-10-26 20:03:38,498 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) ixrss: 0
2025-10-26 20:03:38,498 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) majflt: 0
2025-10-26 20:03:38,498 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) maxrss: 149460
2025-10-26 20:03:38,498 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) minflt: 3016
2025-10-26 20:03:38,498 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) msgrcv: 0
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) msgsnd: 0
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) nivcsw: 6
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) nsignals: 0
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) nswap: 0
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) nvcsw: 318
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) oublock: 8
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) stime: 0.020946
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) utime: 0.025136
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) wtime: 0.036
2025-10-26 20:03:38,499 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) output:
/fq-tests-ch-clickhouse

2025-10-26 20:03:38,500 - DEBUG - ya.test - _save_outputs: Command (pid 2004873) errors:

2025-10-26 20:03:38,502 - DEBUG - ya.test - execute: Executing '['docker', 'inspect', '--format={{.Name}}', '944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c']' in 'None' (waiting)
2025-10-26 20:03:38,505 - DEBUG - ya.test - execute: Command pid: 2004888
2025-10-26 20:03:38,537 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) rc: 0
2025-10-26 20:03:38,537 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) elapsed time (sec): 0.031082630157470703
2025-10-26 20:03:38,538 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) idrss: 0
2025-10-26 20:03:38,538 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) inblock: 0
2025-10-26 20:03:38,538 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) isrss: 0
2025-10-26 20:03:38,538 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) ixrss: 0
2025-10-26 20:03:38,538 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) majflt: 0
2025-10-26 20:03:38,538 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) maxrss: 150192
2025-10-26 20:03:38,539 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) minflt: 2783
2025-10-26 20:03:38,539 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) msgrcv: 0
2025-10-26 20:03:38,539 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) msgsnd: 0
2025-10-26 20:03:38,539 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) nivcsw: 3
2025-10-26 20:03:38,539 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) nsignals: 0
2025-10-26 20:03:38,539 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) nswap: 0
2025-10-26 20:03:38,539 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) nvcsw: 171
2025-10-26 20:03:38,539 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) oublock: 8
2025-10-26 20:03:38,539 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) stime: 0.015686
2025-10-26 20:03:38,540 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) utime: 0.02196
2025-10-26 20:03:38,540 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) wtime: 0.034
2025-10-26 20:03:38,540 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) output:
/fq-tests-ch-fq-connector-go

2025-10-26 20:03:38,540 - DEBUG - ya.test - _save_outputs: Command (pid 2004888) errors:

2025-10-26 20:03:38,542 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/0003ad/library/recipes/docker_compose/bin/docker-compose', '-f', '/home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse/docker-compose.yml', '--log-level', 'DEBUG', '--no-ansi', 'ps', '-q']' in '/home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse' (waiting)
2025-10-26 20:03:38,544 - DEBUG - ya.test - execute: Command pid: 2004898
2025-10-26 20:03:39,225 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) rc: 0
2025-10-26 20:03:39,225 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) elapsed time (sec): 0.6797988414764404
2025-10-26 20:03:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) idrss: 0
2025-10-26 20:03:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) inblock: 0
2025-10-26 20:03:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) isrss: 0
2025-10-26 20:03:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) ixrss: 0
2025-10-26 20:03:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) majflt: 0
2025-10-26 20:03:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) maxrss: 150940
2025-10-26 20:03:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) minflt: 17549
2025-10-26 20:03:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) msgrcv: 0
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) msgsnd: 0
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) nivcsw: 12
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) nsignals: 0
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) nswap: 0
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) nvcsw: 36
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) oublock: 53464
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) stime: 0.109039
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) utime: 0.564035
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) wtime: 0.682
2025-10-26 20:03:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) output:
09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e
944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c

2025-10-26 20:03:39,228 - DEBUG - ya.test - _save_outputs: Command (pid 2004898) errors:
Using configuration files: /home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse/docker-compose.yml
Trying paths: ['/home/runner/.docker/config.json', '/home/runner/.dockercfg']
No config file found
Trying paths: ['/home/runner/.docker/config.json', '/home/runner/.dockercfg']
No config file found
http://localhost:None "GET /v1.30/networks/clickhouse_default HTTP/1.1" 200 1103
http://localhost:None "GET /v1.30/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dclickhouse%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 None
http://localhost:None "GET /v1.30/containers/944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c/json HTTP/1.1" 200 None
http://localhost:None "GET /v1.30/containers/09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e/json HTTP/1.1" 200 None
http://localhost:None "GET /v1.30/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dclickhouse%22%2C+%22com.docker.compose.oneoff%3DTrue%22%5D%7D HTTP/1.1" 200 3
http://localhost:None "GET /v1.30/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dclickhouse%22%2C+%22com.docker.compose.oneoff%3DTrue%22%5D%7D HTTP/1.1" 200 3

2025-10-26 20:03:39,228 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-10-26 20:03:39,230 - DEBUG - ya.test - execute: Executing '['docker', 'ps', '-a', '--filter', 'id=09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e', '--format', '{{.Status}}\t{{.Names}}']' in '/home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse' (waiting)
2025-10-26 20:03:39,233 - DEBUG - ya.test - execute: Command pid: 2004903
2025-10-26 20:03:39,264 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) rc: 0
2025-10-26 20:03:39,265 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) elapsed time (sec): 0.030212879180908203
2025-10-26 20:03:39,265 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) idrss: 0
2025-10-26 20:03:39,265 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) inblock: 0
2025-10-26 20:03:39,265 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) isrss: 0
2025-10-26 20:03:39,266 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) ixrss: 0
2025-10-26 20:03:39,266 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) majflt: 0
2025-10-26 20:03:39,266 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) maxrss: 151684
2025-10-26 20:03:39,266 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) minflt: 2767
2025-10-26 20:03:39,267 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) msgrcv: 0
2025-10-26 20:03:39,267 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) msgsnd: 0
2025-10-26 20:03:39,267 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) nivcsw: 2
2025-10-26 20:03:39,267 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) nsignals: 0
2025-10-26 20:03:39,267 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) nswap: 0
2025-10-26 20:03:39,267 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) nvcsw: 163
2025-10-26 20:03:39,267 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) oublock: 8
2025-10-26 20:03:39,267 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) stime: 0.008796
2025-10-26 20:03:39,267 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) utime: 0.026389
2025-10-26 20:03:39,268 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) wtime: 0.033
2025-10-26 20:03:39,268 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) output:
Up 10 minutes	fq-tests-ch-clickhouse

2025-10-26 20:03:39,268 - DEBUG - ya.test - _save_outputs: Command (pid 2004903) errors:

2025-10-26 20:03:39,270 - DEBUG - ya.test - execute: Executing '['docker', 'ps', '-a', '--filter', 'id=944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c', '--format', '{{.Status}}\t{{.Names}}']' in '/home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse' (waiting)
2025-10-26 20:03:39,273 - DEBUG - ya.test - execute: Command pid: 2004914
2025-10-26 20:03:39,303 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) rc: 0
2025-10-26 20:03:39,303 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) elapsed time (sec): 0.029010534286499023
2025-10-26 20:03:39,304 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) idrss: 0
2025-10-26 20:03:39,304 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) inblock: 0
2025-10-26 20:03:39,304 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) isrss: 0
2025-10-26 20:03:39,304 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) ixrss: 0
2025-10-26 20:03:39,304 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) majflt: 0
2025-10-26 20:03:39,304 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) maxrss: 152292
2025-10-26 20:03:39,304 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) minflt: 2834
2025-10-26 20:03:39,305 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) msgrcv: 0
2025-10-26 20:03:39,305 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) msgsnd: 0
2025-10-26 20:03:39,305 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) nivcsw: 2
2025-10-26 20:03:39,305 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) nsignals: 0
2025-10-26 20:03:39,305 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) nswap: 0
2025-10-26 20:03:39,305 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) nvcsw: 187
2025-10-26 20:03:39,305 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) oublock: 8
2025-10-26 20:03:39,305 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) stime: 0.018465
2025-10-26 20:03:39,305 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) utime: 0.018460999999999998
2025-10-26 20:03:39,306 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) wtime: 0.032
2025-10-26 20:03:39,306 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) output:
Up 10 minutes	fq-tests-ch-fq-connector-go

2025-10-26 20:03:39,306 - DEBUG - ya.test - _save_outputs: Command (pid 2004914) errors:

2025-10-26 20:03:39,308 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/0003ad/library/recipes/docker_compose/bin/docker-compose', '-f', '/home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse/docker-compose.yml', '--log-level', 'DEBUG', '--no-ansi', 'stop']' in '/home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse' (waiting)
2025-10-26 20:03:39,311 - DEBUG - ya.test - execute: Command pid: 2004926
2025-10-26 20:03:41,851 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) rc: 0
2025-10-26 20:03:41,851 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) elapsed time (sec): 2.5384175777435303
2025-10-26 20:03:41,851 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) idrss: 0
2025-10-26 20:03:41,851 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) inblock: 0
2025-10-26 20:03:41,851 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) isrss: 0
2025-10-26 20:03:41,852 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) ixrss: 0
2025-10-26 20:03:41,852 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) majflt: 0
2025-10-26 20:03:41,852 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) maxrss: 152872
2025-10-26 20:03:41,852 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) minflt: 17577
2025-10-26 20:03:41,852 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) msgrcv: 0
2025-10-26 20:03:41,852 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) msgsnd: 0
2025-10-26 20:03:41,852 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) nivcsw: 17
2025-10-26 20:03:41,852 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) nsignals: 0
2025-10-26 20:03:41,852 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) nswap: 0
2025-10-26 20:03:41,853 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) nvcsw: 74
2025-10-26 20:03:41,853 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) oublock: 53480
2025-10-26 20:03:41,853 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) stime: 0.10974099999999999
2025-10-26 20:03:41,853 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) utime: 0.5822109999999999
2025-10-26 20:03:41,853 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) wtime: 2.542
2025-10-26 20:03:41,853 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) output:

2025-10-26 20:03:41,854 - DEBUG - ya.test - _save_outputs: Command (pid 2004926) errors:
Using configuration files: /home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse/docker-compose.yml
Trying paths: ['/home/runner/.docker/config.json', '/home/runner/.dockercfg']
No config file found
Trying paths: ['/home/runner/.docker/config.json', '/home/runner/.dockercfg']
No config file found
http://localhost:None "GET /v1.30/networks/clickhouse_default HTTP/1.1" 200 1103
http://localhost:None "GET /v1.30/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dclickhouse%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 None
http://localhost:None "GET /v1.30/containers/944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c/json HTTP/1.1" 200 None
http://localhost:None "GET /v1.30/containers/09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e/json HTTP/1.1" 200 None
Stopping fq-tests-ch-fq-connector-go ... 
Stopping fq-tests-ch-clickhouse      ... 
Pending: {<Container: fq-tests-ch-clickhouse (09900d)>, <Container: fq-tests-ch-fq-connector-go (944bfd)>}
Starting producer thread for <Container: fq-tests-ch-clickhouse (09900d)>
Starting producer thread for <Container: fq-tests-ch-fq-connector-go (944bfd)>
Pending: set()
Pending: set()
Pending: set()
Pending: set()
http://localhost:None "POST /v1.30/containers/944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c/stop?t=10 HTTP/1.1" 204 0
Finished processing: <Container: fq-tests-ch-fq-connector-go (944bfd)>
Stopping fq-tests-ch-fq-connector-go ... done
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
Pending: set()
http://localhost:None "POST /v1.30/containers/09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e/stop?t=10 HTTP/1.1" 204 0
Finished processing: <Container: fq-tests-ch-clickhouse (09900d)>
Stopping fq-tests-ch-clickhouse      ... done
Pending: set()

2025-10-26 20:03:41,854 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-10-26 20:03:41,857 - DEBUG - ya.test - execute: Executing '['docker', 'logs', '09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e']' in 'None' (waiting)
2025-10-26 20:03:41,860 - DEBUG - ya.test - execute: Command pid: 2005041
2025-10-26 20:03:41,893 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) rc: 0
2025-10-26 20:03:41,894 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) elapsed time (sec): 0.03266572952270508
2025-10-26 20:03:41,894 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) idrss: 0
2025-10-26 20:03:41,894 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) inblock: 0
2025-10-26 20:03:41,894 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) isrss: 0
2025-10-26 20:03:41,894 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) ixrss: 0
2025-10-26 20:03:41,894 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) majflt: 0
2025-10-26 20:03:41,894 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) maxrss: 153668
2025-10-26 20:03:41,894 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) minflt: 3113
2025-10-26 20:03:41,895 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) msgrcv: 0
2025-10-26 20:03:41,895 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) msgsnd: 0
2025-10-26 20:03:41,895 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) nivcsw: 8
2025-10-26 20:03:41,895 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) nsignals: 0
2025-10-26 20:03:41,895 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) nswap: 0
2025-10-26 20:03:41,895 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) nvcsw: 300
2025-10-26 20:03:41,895 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) oublock: 16
2025-10-26 20:03:41,895 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) stime: 0.008986
2025-10-26 20:03:41,895 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) utime: 0.035946
2025-10-26 20:03:41,896 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) wtime: 0.036
2025-10-26 20:03:41,896 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) output:
/entrypoint.sh: create new user 'user' instead 'default'
ClickHouse Database directory appears to contain a database; Skipping initialization

2025-10-26 20:03:41,896 - DEBUG - ya.test - _save_outputs: Command (pid 2005041) errors:
Processing configuration file '/etc/clickhouse-server/config.xml'.
Merging configuration file '/etc/clickhouse-server/config.d/docker_related_config.xml'.
Logging trace to /var/log/clickhouse-server/clickhouse-server.log
Logging errors to /var/log/clickhouse-server/clickhouse-server.err.log
Processing configuration file '/etc/clickhouse-server/config.xml'.
Merging configuration file '/etc/clickhouse-server/config.d/docker_related_config.xml'.
Saved preprocessed configuration to '/var/lib/clickhouse/preprocessed_configs/config.xml'.
Processing configuration file '/etc/clickhouse-server/users.xml'.
Merging configuration file '/etc/clickhouse-server/users.d/default-user.xml'.
Saved preprocessed configuration to '/var/lib/clickhouse/preprocessed_configs/users.xml'.

2025-10-26 20:03:41,896 - DEBUG - ya.test - verify_sanitize_errors: 'docker' doesn't belong to '/home/runner/.ya/build/build_root/70hy/0003ad' - no check for sanitize errors
2025-10-26 20:03:41,899 - DEBUG - ya.test - execute: Executing '['docker', 'logs', '09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e']' in 'None' (waiting)
2025-10-26 20:03:41,902 - DEBUG - ya.test - execute: Command pid: 2005056
2025-10-26 20:03:41,936 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) rc: 0
2025-10-26 20:03:41,938 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) elapsed time (sec): 0.0336458683013916
2025-10-26 20:03:41,938 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) idrss: 0
2025-10-26 20:03:41,938 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) inblock: 0
2025-10-26 20:03:41,939 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) isrss: 0
2025-10-26 20:03:41,939 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) ixrss: 0
2025-10-26 20:03:41,939 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) majflt: 0
2025-10-26 20:03:41,939 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) maxrss: 154484
2025-10-26 20:03:41,939 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) minflt: 2900
2025-10-26 20:03:41,939 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) msgrcv: 0
2025-10-26 20:03:41,939 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) msgsnd: 0
2025-10-26 20:03:41,939 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) nivcsw: 9
2025-10-26 20:03:41,940 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) nsignals: 0
2025-10-26 20:03:41,940 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) nswap: 0
2025-10-26 20:03:41,940 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) nvcsw: 273
2025-10-26 20:03:41,940 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) oublock: 16
2025-10-26 20:03:41,940 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) stime: 0.027384
2025-10-26 20:03:41,940 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) utime: 0.013692
2025-10-26 20:03:41,940 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) wtime: 0.037
2025-10-26 20:03:41,940 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) output:
/entrypoint.sh: create new user 'user' instead 'default'
ClickHouse Database directory appears to contain a database; Skipping initialization

2025-10-26 20:03:41,941 - DEBUG - ya.test - _save_outputs: Command (pid 2005056) errors:
Processing configuration file '/etc/clickhouse-server/config.xml'.
Merging configuration file '/etc/clickhouse-server/config.d/docker_related_config.xml'.
Logging trace to /var/log/clickhouse-server/clickhouse-server.log
Logging errors to /var/log/clickhouse-server/clickhouse-server.err.log
Processing configuration file '/etc/clickhouse-server/config.xml'.
Merging configuration file '/etc/clickhouse-server/config.d/docker_related_config.xml'.
Saved preprocessed configuration to '/var/lib/clickhouse/preprocessed_configs/config.xml'.
Processing configuration file '/etc/clickhouse-server/users.xml'.
Merging configuration file '/etc/clickhouse-server/users.d/default-user.xml'.
Saved preprocessed configuration to '/var/lib/clickhouse/preprocessed_configs/users.xml'.

2025-10-26 20:03:41,941 - DEBUG - ya.test - verify_sanitize_errors: 'docker' doesn't belong to '/home/runner/.ya/build/build_root/70hy/0003ad' - no check for sanitize errors
2025-10-26 20:03:41,944 - DEBUG - ya.test - execute: Executing '['docker', 'logs', '944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c']' in 'None' (waiting)
2025-10-26 20:03:41,946 - DEBUG - ya.test - execute: Command pid: 2005065
2025-10-26 20:03:41,989 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) rc: 0
2025-10-26 20:03:41,989 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) elapsed time (sec): 0.04047369956970215
2025-10-26 20:03:41,989 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) idrss: 0
2025-10-26 20:03:41,989 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) inblock: 0
2025-10-26 20:03:41,989 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) isrss: 0
2025-10-26 20:03:41,990 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) ixrss: 0
2025-10-26 20:03:41,990 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) majflt: 0
2025-10-26 20:03:41,990 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) maxrss: 155084
2025-10-26 20:03:41,990 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) minflt: 2767
2025-10-26 20:03:41,990 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) msgrcv: 0
2025-10-26 20:03:41,990 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) msgsnd: 0
2025-10-26 20:03:41,990 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) nivcsw: 7
2025-10-26 20:03:41,990 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) nsignals: 0
2025-10-26 20:03:41,991 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) nswap: 0
2025-10-26 20:03:41,991 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) nvcsw: 232
2025-10-26 20:03:41,991 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) oublock: 656
2025-10-26 20:03:41,991 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) stime: 0.026764
2025-10-26 20:03:41,991 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) utime: 0.016058
2025-10-26 20:03:41,991 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) wtime: 0.043
2025-10-26 20:03:41,992 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) output:

2025-10-26 20:03:41,992 - DEBUG - ya.test - _save_outputs: Command (pid 2005065) errors:
...type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:23.561Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:01:23.563Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:01:23.563Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:23.563Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "column_selection_A_b_C_d_E_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"t277375b9\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:23.564Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "column_selection_A_b_C_d_E_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col2\" FROM \"t277375b9\""}
2025-10-26T20:01:23.566Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "column_selection_A_b_C_d_E_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 296}
2025-10-26T20:01:23.566Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "column_selection_A_b_C_d_E_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 8, "total_rows": 2}
2025-10-26T20:01:23.566Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:33.500Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "table": "t48ab11b5"}
2025-10-26T20:01:33.500Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable"}
2025-10-26T20:01:33.504Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t48ab11b5","column_selection_A_b_C_d_E_HTTP"]}
2025-10-26T20:01:33.507Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "response": "schema:{columns:{name:\"COL1\"  type:{type_id:INT32}}  columns:{name:\"col2\"  type:{type_id:INT32}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:01:34.380Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:01:34.380Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:01:34.380Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:34.380Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:34.380Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:01:34.382Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:01:34.382Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:34.382Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:34.386Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col2\" FROM \"t48ab11b5\""}
2025-10-26T20:01:34.388Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 296}
2025-10-26T20:01:34.388Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 8, "total_rows": 2}
2025-10-26T20:01:34.388Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:45.608Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "table": "t48ab11b5"}
2025-10-26T20:01:45.608Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable"}
2025-10-26T20:01:45.613Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t48ab11b5","column_selection_A_b_C_d_E_HTTP"]}
2025-10-26T20:01:45.615Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "response": "schema:{columns:{name:\"COL1\"  type:{type_id:INT32}}  columns:{name:\"col2\"  type:{type_id:INT32}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:01:45.850Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:01:45.851Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:01:45.851Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:45.851Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:45.851Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:01:45.853Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:01:45.853Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:45.853Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:45.857Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col2\" FROM \"t48ab11b5\""}
2025-10-26T20:01:45.859Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 296}
2025-10-26T20:01:45.859Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 8, "total_rows": 2}
2025-10-26T20:01:45.859Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:59.994Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "te362f4dd"}
2025-10-26T20:01:59.994Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:01:59.995Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["te362f4dd","large_table_NATIVE"]}
2025-10-26T20:01:59.999Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "response": "schema:{columns:{name:\"col_01_int64\"  type:{type_id:INT32}}  columns:{name:\"col_02_utf8\"  type:{type_id:STRING}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:02:01.481Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:01.481Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:01.482Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:01.482Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:01.482Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:01.507Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:01.507Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:01.507Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:01.508Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col_01_int64\" FROM \"te362f4dd\""}
2025-10-26T20:02:01.616Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 2097448}
2025-10-26T20:02:01.617Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 2097152, "total_rows": 524288}
2025-10-26T20:02:01.617Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:02.497Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:02.497Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:02.497Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:02.497Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:02.497Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:02.500Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:02.500Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:02.500Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:02.502Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col_01_int64\", \"col_02_utf8\" FROM \"te362f4dd\""}
2025-10-26T20:02:02.667Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:02.729Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:02.801Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:02.879Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:02.912Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 2330656}
2025-10-26T20:02:02.913Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 18874368, "total_rows": 524288}
2025-10-26T20:02:02.913Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:17.784Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "te362f4dd"}
2025-10-26T20:02:17.784Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:02:17.785Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["te362f4dd","large_table_NATIVE"]}
2025-10-26T20:02:17.789Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "response": "schema:{columns:{name:\"col_01_int64\"  type:{type_id:INT32}}  columns:{name:\"col_02_utf8\"  type:{type_id:STRING}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:02:18.410Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:18.410Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:18.410Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:18.410Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:18.410Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:18.412Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:18.412Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:18.412Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:18.413Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col_01_int64\" FROM \"te362f4dd\""}
2025-10-26T20:02:18.514Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 2097448}
2025-10-26T20:02:18.516Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 2097152, "total_rows": 524288}
2025-10-26T20:02:18.516Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:18.975Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:18.975Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:18.975Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:18.975Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:18.975Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:18.977Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:18.977Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:18.977Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:18.978Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col_01_int64\", \"col_02_utf8\" FROM \"te362f4dd\""}
2025-10-26T20:02:19.136Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:19.203Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:19.269Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:19.339Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:19.373Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 2330656}
2025-10-26T20:02:19.374Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 18874368, "total_rows": 524288}
2025-10-26T20:02:19.374Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:33.837Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "table": "t9858dc2c"}
2025-10-26T20:02:33.837Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable"}
2025-10-26T20:02:33.842Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t9858dc2c","large_table_HTTP"]}
2025-10-26T20:02:33.846Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "response": "schema:{columns:{name:\"col_01_int64\"  type:{type_id:INT32}}  columns:{name:\"col_02_utf8\"  type:{type_id:STRING}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:02:35.379Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:35.379Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:35.379Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:35.379Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:35.379Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:35.381Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:35.381Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:35.381Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:35.386Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col_01_int64\" FROM \"t9858dc2c\""}
2025-10-26T20:02:35.724Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 2097448}
2025-10-26T20:02:35.726Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 2097152, "total_rows": 524288}
2025-10-26T20:02:35.726Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:36.599Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:36.600Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:36.600Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:36.600Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:36.600Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:36.601Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:36.601Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:36.601Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:36.607Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col_01_int64\", \"col_02_utf8\" FROM \"t9858dc2c\""}
2025-10-26T20:02:36.940Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:37.113Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:37.289Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:37.481Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:37.572Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 2330656}
2025-10-26T20:02:37.573Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 18874368, "total_rows": 524288}
2025-10-26T20:02:37.573Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:52.249Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "table": "t9858dc2c"}
2025-10-26T20:02:52.249Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable"}
2025-10-26T20:02:52.253Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t9858dc2c","large_table_HTTP"]}
2025-10-26T20:02:52.257Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "response": "schema:{columns:{name:\"col_01_int64\"  type:{type_id:INT32}}  columns:{name:\"col_02_utf8\"  type:{type_id:STRING}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:02:52.942Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:52.942Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:52.942Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:52.942Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:52.942Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:52.944Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:52.944Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:52.944Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:52.948Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col_01_int64\" FROM \"t9858dc2c\""}
2025-10-26T20:02:53.308Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 2097448}
2025-10-26T20:02:53.309Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 2097152, "total_rows": 524288}
2025-10-26T20:02:53.309Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:53.809Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:53.809Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:53.809Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:53.809Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:53.809Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:53.811Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:53.811Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:53.811Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:53.818Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col_01_int64\", \"col_02_utf8\" FROM \"t9858dc2c\""}
2025-10-26T20:02:54.176Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:54.352Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:54.534Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:54.705Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:54.786Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 2330656}
2025-10-26T20:02:54.787Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 18874368, "total_rows": 524288}
2025-10-26T20:02:54.787Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:03:04.131Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "t81defd9e"}
2025-10-26T20:03:04.131Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:03:04.132Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t81defd9e","missing_database_NATIVE"]}
2025-10-26T20:03:04.135Z	[31mERROR[0m	server/service_connector.go:56	request handling failed	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "error": "get schema: build schema: table does not exist"}
github.com/ydb-platform/fq-connector-go/app/server.(*serviceConnector).DescribeTable
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/service_connector.go:56
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler.func1
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:236
github.com/ydb-platform/fq-connector-go/app/server.makeGRPCOptions.UnaryServerMetadata.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metadata.go:53
google.golang.org/grpc.getChainUnaryHandler.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1203
github.com/ydb-platform/fq-connector-go/app/server.UnaryServerMetrics.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metrics.go:136
google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1194
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:238
google.golang.org/grpc.(*Server).processUnaryRPC
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1383
google.golang.org/grpc.(*Server).handleStream
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1794
google.golang.org/grpc.(*Server).serveStreams.func2.1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1027
2025-10-26T20:03:16.176Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "t81defd9e"}
2025-10-26T20:03:16.176Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:03:16.177Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t81defd9e","missing_database_NATIVE"]}
2025-10-26T20:03:16.180Z	[31mERROR[0m	server/service_connector.go:56	request handling failed	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "error": "get schema: build schema: table does not exist"}
github.com/ydb-platform/fq-connector-go/app/server.(*serviceConnector).DescribeTable
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/service_connector.go:56
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler.func1
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:236
github.com/ydb-platform/fq-connector-go/app/server.makeGRPCOptions.UnaryServerMetadata.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metadata.go:53
google.golang.org/grpc.getChainUnaryHandler.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1203
github.com/ydb-platform/fq-connector-go/app/server.UnaryServerMetrics.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metrics.go:136
google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1194
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:238
google.golang.org/grpc.(*Server).processUnaryRPC
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1383
google.golang.org/grpc.(*Server).handleStream
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1794
google.golang.org/grpc.(*Server).serveStreams.func2.1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1027
2025-10-26T20:03:24.797Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "t9b18c376"}
2025-10-26T20:03:24.797Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:03:24.798Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t9b18c376","missing_table_NATIVE"]}
2025-10-26T20:03:24.801Z	[31mERROR[0m	server/service_connector.go:56	request handling failed	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "error": "get schema: build schema: table does not exist"}
github.com/ydb-platform/fq-connector-go/app/server.(*serviceConnector).DescribeTable
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/service_connector.go:56
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler.func1
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:236
github.com/ydb-platform/fq-connector-go/app/server.makeGRPCOptions.UnaryServerMetadata.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metadata.go:53
google.golang.org/grpc.getChainUnaryHandler.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1203
github.com/ydb-platform/fq-connector-go/app/server.UnaryServerMetrics.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metrics.go:136
google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1194
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:238
google.golang.org/grpc.(*Server).processUnaryRPC
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1383
google.golang.org/grpc.(*Server).handleStream
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1794
google.golang.org/grpc.(*Server).serveStreams.func2.1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1027
2025-10-26T20:03:39.931Z	[34mINFO[0m	server/launcher.go:102	interrupting signal	{"value": "terminated"}
2025-10-26T20:03:39.931Z	[34mINFO[0m	server/launcher.go:42	stopping service	{"service": "metrics"}
2025-10-26T20:03:39.931Z	[34mINFO[0m	server/launcher.go:42	stopping service	{"service": "connector"}
2025-10-26T20:03:39.931Z	[34mINFO[0m	server/launcher.go:42	stopping service	{"service": "pprof"}

2025-10-26 20:03:41,993 - DEBUG - ya.test - verify_sanitize_errors: 'docker' doesn't belong to '/home/runner/.ya/build/build_root/70hy/0003ad' - no check for sanitize errors
2025-10-26 20:03:41,996 - DEBUG - ya.test - execute: Executing '['docker', 'logs', '944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c']' in 'None' (waiting)
2025-10-26 20:03:41,998 - DEBUG - ya.test - execute: Command pid: 2005076
2025-10-26 20:03:42,042 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) rc: 0
2025-10-26 20:03:42,042 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) elapsed time (sec): 0.04192161560058594
2025-10-26 20:03:42,042 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) idrss: 0
2025-10-26 20:03:42,043 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) inblock: 0
2025-10-26 20:03:42,043 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) isrss: 0
2025-10-26 20:03:42,043 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) ixrss: 0
2025-10-26 20:03:42,043 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) majflt: 0
2025-10-26 20:03:42,043 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) maxrss: 157428
2025-10-26 20:03:42,043 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) minflt: 2856
2025-10-26 20:03:42,043 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) msgrcv: 0
2025-10-26 20:03:42,043 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) msgsnd: 0
2025-10-26 20:03:42,044 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) nivcsw: 13
2025-10-26 20:03:42,044 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) nsignals: 0
2025-10-26 20:03:42,044 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) nswap: 0
2025-10-26 20:03:42,044 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) nvcsw: 234
2025-10-26 20:03:42,044 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) oublock: 656
2025-10-26 20:03:42,044 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) stime: 0.03191
2025-10-26 20:03:42,044 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) utime: 0.015955
2025-10-26 20:03:42,045 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) wtime: 0.045
2025-10-26 20:03:42,045 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) output:

2025-10-26 20:03:42,046 - DEBUG - ya.test - _save_outputs: Command (pid 2005076) errors:
...type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:23.561Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:01:23.563Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:01:23.563Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:23.563Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "column_selection_A_b_C_d_E_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"t277375b9\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:23.564Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "column_selection_A_b_C_d_E_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col2\" FROM \"t277375b9\""}
2025-10-26T20:01:23.566Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "column_selection_A_b_C_d_E_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 296}
2025-10-26T20:01:23.566Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "column_selection_A_b_C_d_E_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 8, "total_rows": 2}
2025-10-26T20:01:23.566Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:33.500Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "table": "t48ab11b5"}
2025-10-26T20:01:33.500Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable"}
2025-10-26T20:01:33.504Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t48ab11b5","column_selection_A_b_C_d_E_HTTP"]}
2025-10-26T20:01:33.507Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "response": "schema:{columns:{name:\"COL1\"  type:{type_id:INT32}}  columns:{name:\"col2\"  type:{type_id:INT32}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:01:34.380Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:01:34.380Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:01:34.380Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:34.380Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:34.380Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:01:34.382Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:01:34.382Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:34.382Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:34.386Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col2\" FROM \"t48ab11b5\""}
2025-10-26T20:01:34.388Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 296}
2025-10-26T20:01:34.388Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 8, "total_rows": 2}
2025-10-26T20:01:34.388Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:45.608Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "table": "t48ab11b5"}
2025-10-26T20:01:45.608Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable"}
2025-10-26T20:01:45.613Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t48ab11b5","column_selection_A_b_C_d_E_HTTP"]}
2025-10-26T20:01:45.615Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "response": "schema:{columns:{name:\"COL1\"  type:{type_id:INT32}}  columns:{name:\"col2\"  type:{type_id:INT32}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:01:45.850Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:01:45.851Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:01:45.851Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:45.851Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:45.851Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:01:45.853Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:01:45.853Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:45.853Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t48ab11b5\"", "what": "items:{column:{name:\"col2\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:01:45.857Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col2\" FROM \"t48ab11b5\""}
2025-10-26T20:01:45.859Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 296}
2025-10-26T20:01:45.859Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "column_selection_A_b_C_d_E_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 8, "total_rows": 2}
2025-10-26T20:01:45.859Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:01:59.994Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "te362f4dd"}
2025-10-26T20:01:59.994Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:01:59.995Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["te362f4dd","large_table_NATIVE"]}
2025-10-26T20:01:59.999Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "response": "schema:{columns:{name:\"col_01_int64\"  type:{type_id:INT32}}  columns:{name:\"col_02_utf8\"  type:{type_id:STRING}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:02:01.481Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:01.481Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:01.482Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:01.482Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:01.482Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:01.507Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:01.507Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:01.507Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:01.508Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col_01_int64\" FROM \"te362f4dd\""}
2025-10-26T20:02:01.616Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 2097448}
2025-10-26T20:02:01.617Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 2097152, "total_rows": 524288}
2025-10-26T20:02:01.617Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:02.497Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:02.497Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:02.497Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:02.497Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:02.497Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:02.500Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:02.500Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:02.500Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:02.502Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col_01_int64\", \"col_02_utf8\" FROM \"te362f4dd\""}
2025-10-26T20:02:02.667Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:02.729Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:02.801Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:02.879Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:02.912Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 2330656}
2025-10-26T20:02:02.913Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 18874368, "total_rows": 524288}
2025-10-26T20:02:02.913Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:17.784Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "te362f4dd"}
2025-10-26T20:02:17.784Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:02:17.785Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["te362f4dd","large_table_NATIVE"]}
2025-10-26T20:02:17.789Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "response": "schema:{columns:{name:\"col_01_int64\"  type:{type_id:INT32}}  columns:{name:\"col_02_utf8\"  type:{type_id:STRING}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:02:18.410Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:18.410Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:18.410Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:18.410Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:18.410Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:18.412Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:18.412Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:18.412Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:18.413Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col_01_int64\" FROM \"te362f4dd\""}
2025-10-26T20:02:18.514Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 2097448}
2025-10-26T20:02:18.516Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 2097152, "total_rows": 524288}
2025-10-26T20:02:18.516Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:18.975Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:18.975Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:18.975Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:18.975Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:18.975Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:18.977Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:18.977Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:18.977Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "from": "table:\"te362f4dd\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:18.978Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "query": "SELECT \"col_01_int64\", \"col_02_utf8\" FROM \"te362f4dd\""}
2025-10-26T20:02:19.136Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:19.203Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:19.269Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:19.339Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:19.373Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "arrow_blob_length": 2330656}
2025-10-26T20:02:19.374Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "large_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "split_id": 0, "total_bytes": 18874368, "total_rows": 524288}
2025-10-26T20:02:19.374Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:33.837Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "table": "t9858dc2c"}
2025-10-26T20:02:33.837Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable"}
2025-10-26T20:02:33.842Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t9858dc2c","large_table_HTTP"]}
2025-10-26T20:02:33.846Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "response": "schema:{columns:{name:\"col_01_int64\"  type:{type_id:INT32}}  columns:{name:\"col_02_utf8\"  type:{type_id:STRING}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:02:35.379Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:35.379Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:35.379Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:35.379Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:35.379Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:35.381Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:35.381Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:35.381Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:35.386Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col_01_int64\" FROM \"t9858dc2c\""}
2025-10-26T20:02:35.724Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 2097448}
2025-10-26T20:02:35.726Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 2097152, "total_rows": 524288}
2025-10-26T20:02:35.726Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:36.599Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:36.600Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:36.600Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:36.600Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:36.600Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:36.601Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:36.601Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:36.601Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:36.607Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col_01_int64\", \"col_02_utf8\" FROM \"t9858dc2c\""}
2025-10-26T20:02:36.940Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:37.113Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:37.289Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:37.481Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:37.572Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 2330656}
2025-10-26T20:02:37.573Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 18874368, "total_rows": 524288}
2025-10-26T20:02:37.573Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:52.249Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "table": "t9858dc2c"}
2025-10-26T20:02:52.249Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable"}
2025-10-26T20:02:52.253Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t9858dc2c","large_table_HTTP"]}
2025-10-26T20:02:52.257Z	[34mINFO[0m	server/service_connector.go:64	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "method": "DescribeTable", "response": "schema:{columns:{name:\"col_01_int64\"  type:{type_id:INT32}}  columns:{name:\"col_02_utf8\"  type:{type_id:STRING}}}  error:{status:SUCCESS  message:\"succeeded\"}"}
2025-10-26T20:02:52.942Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:52.942Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:52.942Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:52.942Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:52.942Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:52.944Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:52.944Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:52.944Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}", "where": "<nil>"}
2025-10-26T20:02:52.948Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col_01_int64\" FROM \"t9858dc2c\""}
2025-10-26T20:02:53.308Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 2097448}
2025-10-26T20:02:53.309Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 2097152, "total_rows": 524288}
2025-10-26T20:02:53.309Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:53.809Z	[34mINFO[0m	server/service_connector.go:71	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total selects": 1}
2025-10-26T20:02:53.809Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits"}
2025-10-26T20:02:53.809Z	[35mDEBUG[0m	server/service_connector.go:107	responding selects	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:53.809Z	[35mDEBUG[0m	server/service_connector.go:120	responding split	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:53.809Z	[34mINFO[0m	server/service_connector.go:89	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ListSplits", "total_splits": 1}
2025-10-26T20:02:53.811Z	[34mINFO[0m	server/service_connector.go:155	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "total_splits": 1}
2025-10-26T20:02:53.811Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:02:53.811Z	[35mDEBUG[0m	server/data_source_collection.go:91	split reading started	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "from": "table:\"t9858dc2c\"", "what": "items:{column:{name:\"col_01_int64\"  type:{type_id:INT32}}}  items:{column:{name:\"col_02_utf8\"  type:{type_id:STRING}}}", "where": "<nil>"}
2025-10-26T20:02:53.818Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "query": "SELECT \"col_01_int64\", \"col_02_utf8\" FROM \"t9858dc2c\""}
2025-10-26T20:02:54.176Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:54.352Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:54.534Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:54.705Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 4660736}
2025-10-26T20:02:54.786Z	[35mDEBUG[0m	streaming/streamer.go:84	response	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "arrow_blob_length": 2330656}
2025-10-26T20:02:54.787Z	[35mDEBUG[0m	server/data_source_collection.go:130	split reading finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 8123, "database": "large_table_HTTP", "use_tls": false, "protocol": "HTTP", "split_id": 0, "total_bytes": 18874368, "total_rows": 524288}
2025-10-26T20:02:54.787Z	[34mINFO[0m	server/service_connector.go:168	request handling finished	{"service": "connector", "user_id": "", "session_id": "", "method": "ReadSplits"}
2025-10-26T20:03:04.131Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "t81defd9e"}
2025-10-26T20:03:04.131Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:03:04.132Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t81defd9e","missing_database_NATIVE"]}
2025-10-26T20:03:04.135Z	[31mERROR[0m	server/service_connector.go:56	request handling failed	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "error": "get schema: build schema: table does not exist"}
github.com/ydb-platform/fq-connector-go/app/server.(*serviceConnector).DescribeTable
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/service_connector.go:56
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler.func1
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:236
github.com/ydb-platform/fq-connector-go/app/server.makeGRPCOptions.UnaryServerMetadata.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metadata.go:53
google.golang.org/grpc.getChainUnaryHandler.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1203
github.com/ydb-platform/fq-connector-go/app/server.UnaryServerMetrics.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metrics.go:136
google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1194
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:238
google.golang.org/grpc.(*Server).processUnaryRPC
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1383
google.golang.org/grpc.(*Server).handleStream
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1794
google.golang.org/grpc.(*Server).serveStreams.func2.1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1027
2025-10-26T20:03:16.176Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "t81defd9e"}
2025-10-26T20:03:16.176Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:03:16.177Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t81defd9e","missing_database_NATIVE"]}
2025-10-26T20:03:16.180Z	[31mERROR[0m	server/service_connector.go:56	request handling failed	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_database_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "error": "get schema: build schema: table does not exist"}
github.com/ydb-platform/fq-connector-go/app/server.(*serviceConnector).DescribeTable
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/service_connector.go:56
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler.func1
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:236
github.com/ydb-platform/fq-connector-go/app/server.makeGRPCOptions.UnaryServerMetadata.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metadata.go:53
google.golang.org/grpc.getChainUnaryHandler.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1203
github.com/ydb-platform/fq-connector-go/app/server.UnaryServerMetrics.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metrics.go:136
google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1194
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:238
google.golang.org/grpc.(*Server).processUnaryRPC
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1383
google.golang.org/grpc.(*Server).handleStream
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1794
google.golang.org/grpc.(*Server).serveStreams.func2.1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1027
2025-10-26T20:03:24.797Z	[34mINFO[0m	server/service_connector.go:44	request handling started	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "table": "t9b18c376"}
2025-10-26T20:03:24.797Z	[33mWARN[0m	server/validate.go:101	connector will use insecure connection to access data source	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable"}
2025-10-26T20:03:24.798Z	[35mDEBUG[0m	common/logger.go:130	execute SQL query	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "query": "SELECT name, type FROM system.columns WHERE table = ? and database = ?", "args": ["t9b18c376","missing_table_NATIVE"]}
2025-10-26T20:03:24.801Z	[31mERROR[0m	server/service_connector.go:56	request handling failed	{"service": "connector", "user_id": "", "session_id": "", "method": "DescribeTable", "data_source_kind": "CLICKHOUSE", "host": "172.18.0.2", "port": 9000, "database": "missing_table_NATIVE", "use_tls": false, "protocol": "NATIVE", "method": "DescribeTable", "error": "get schema: build schema: table does not exist"}
github.com/ydb-platform/fq-connector-go/app/server.(*serviceConnector).DescribeTable
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/service_connector.go:56
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler.func1
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:236
github.com/ydb-platform/fq-connector-go/app/server.makeGRPCOptions.UnaryServerMetadata.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metadata.go:53
google.golang.org/grpc.getChainUnaryHandler.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1203
github.com/ydb-platform/fq-connector-go/app/server.UnaryServerMetrics.func1
	/home/runner/work/fq-connector-go/fq-connector-go/app/server/grpc_metrics.go:136
google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1194
github.com/ydb-platform/fq-connector-go/api/service._Connector_DescribeTable_Handler
	/home/runner/work/fq-connector-go/fq-connector-go/api/service/connector_grpc.pb.go:238
google.golang.org/grpc.(*Server).processUnaryRPC
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1383
google.golang.org/grpc.(*Server).handleStream
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1794
google.golang.org/grpc.(*Server).serveStreams.func2.1
	/home/runner/go/pkg/mod/google.golang.org/grpc@v1.62.0/server.go:1027
2025-10-26T20:03:39.931Z	[34mINFO[0m	server/launcher.go:102	interrupting signal	{"value": "terminated"}
2025-10-26T20:03:39.931Z	[34mINFO[0m	server/launcher.go:42	stopping service	{"service": "metrics"}
2025-10-26T20:03:39.931Z	[34mINFO[0m	server/launcher.go:42	stopping service	{"service": "connector"}
2025-10-26T20:03:39.931Z	[34mINFO[0m	server/launcher.go:42	stopping service	{"service": "pprof"}

2025-10-26 20:03:42,046 - DEBUG - ya.test - verify_sanitize_errors: 'docker' doesn't belong to '/home/runner/.ya/build/build_root/70hy/0003ad' - no check for sanitize errors
2025-10-26 20:03:42,050 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/0003ad/library/recipes/docker_compose/bin/docker-compose', '-f', '/home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse/docker-compose.yml', '--log-level', 'DEBUG', '--no-ansi', 'down', '--rmi', 'local']' in '/home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse' (waiting)
2025-10-26 20:03:42,053 - DEBUG - ya.test - execute: Command pid: 2005088
2025-10-26 20:03:43,385 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) rc: 0
2025-10-26 20:03:43,386 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) elapsed time (sec): 1.3314924240112305
2025-10-26 20:03:43,386 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) idrss: 0
2025-10-26 20:03:43,386 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) inblock: 0
2025-10-26 20:03:43,386 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) isrss: 0
2025-10-26 20:03:43,386 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) ixrss: 0
2025-10-26 20:03:43,386 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) majflt: 0
2025-10-26 20:03:43,386 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) maxrss: 160616
2025-10-26 20:03:43,387 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) minflt: 17607
2025-10-26 20:03:43,387 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) msgrcv: 0
2025-10-26 20:03:43,387 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) msgsnd: 0
2025-10-26 20:03:43,387 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) nivcsw: 16
2025-10-26 20:03:43,387 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) nsignals: 0
2025-10-26 20:03:43,387 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) nswap: 0
2025-10-26 20:03:43,387 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) nvcsw: 57
2025-10-26 20:03:43,388 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) oublock: 53464
2025-10-26 20:03:43,388 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) stime: 0.132351
2025-10-26 20:03:43,388 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) utime: 0.595086
2025-10-26 20:03:43,388 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) wtime: 1.334
2025-10-26 20:03:43,388 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) output:

2025-10-26 20:03:43,388 - DEBUG - ya.test - _save_outputs: Command (pid 2005088) errors:
Using configuration files: /home/runner/.ya/build/build_root/70hy/0003ad/environment/arcadia/ydb/library/yql/providers/generic/connector/tests/datasource/clickhouse/docker-compose.yml
Trying paths: ['/home/runner/.docker/config.json', '/home/runner/.dockercfg']
No config file found
Trying paths: ['/home/runner/.docker/config.json', '/home/runner/.dockercfg']
No config file found
http://localhost:None "GET /v1.30/networks/clickhouse_default HTTP/1.1" 200 577
http://localhost:None "GET /v1.30/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dclickhouse%22%5D%7D HTTP/1.1" 200 3
http://localhost:None "GET /v1.30/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dclickhouse%22%5D%7D HTTP/1.1" 200 3
Pending: set()
http://localhost:None "GET /v1.30/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dclickhouse%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
http://localhost:None "GET /v1.30/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dclickhouse%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
http://localhost:None "GET /v1.30/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dclickhouse%22%5D%7D HTTP/1.1" 200 None
http://localhost:None "GET /v1.30/containers/944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c/json HTTP/1.1" 200 None
http://localhost:None "GET /v1.30/containers/09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e/json HTTP/1.1" 200 None
Removing fq-tests-ch-fq-connector-go ... 
Removing fq-tests-ch-clickhouse      ... 
Pending: {<Container: fq-tests-ch-fq-connector-go (944bfd)>, <Container: fq-tests-ch-clickhouse (09900d)>}
Starting producer thread for <Container: fq-tests-ch-fq-connector-go (944bfd)>
Starting producer thread for <Container: fq-tests-ch-clickhouse (09900d)>
http://localhost:None "DELETE /v1.30/containers/944bfdd769724082e90ff0c9e03d64d484d2fe563a0a3f9190edf6699772de4c?v=False&link=False&force=False HTTP/1.1" 204 0
Finished processing: <Container: fq-tests-ch-fq-connector-go (944bfd)>
Removing fq-tests-ch-fq-connector-go ... done
Pending: set()
http://localhost:None "DELETE /v1.30/containers/09900d9807bba67f1646245cf4c637603c46aac5b9272c70fa046f3fe2ade68e?v=False&link=False&force=False HTTP/1.1" 204 0
Finished processing: <Container: fq-tests-ch-clickhouse (09900d)>
Removing fq-tests-ch-clickhouse      ... done
Pending: set()
Removing network clickhouse_default
http://localhost:None "DELETE /v1.30/networks/clickhouse_default HTTP/1.1" 204 0

2025-10-26 20:03:43,388 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
