FreeTDS Development Group

[Hegedűs Gábor <ghegedus0 AT freemail.hu>]

On Wed, 2010-03-17 at 18:36 -0400, James K. Lowden wrote:

> Use "servername = mssql_tds" instead of "server" in odbc.ini.  
> 
> HTH.  
> 
> --jkl

Hi James,

Your proposition solved the problem of not ASCI characters. The “Program
type out of range” remained. Here is the corresponding part of
freetds.log. As I see the query "sp_databases" went to MS SQL, the
answer returned correctly, but after final “rows_affected = 6” came
“logic error: cannot change query state from IDLE to PENDING” and the
“Program type out of range” was its consequence. How to avoid this
error?

Thank you and best regards
Gábor


06:45:04.162580 2955 (util.c:162):Changed query state from IDLE to
QUERYING
06:45:04.162600 2955 (write.c:136):tds_put_string converting 12 bytes of
"sp_databases"
06:45:04.162626 2955 (write.c:164):tds_put_string wrote 24 bytes
06:45:04.162646 2955 (util.c:162):Changed query state from QUERYING to
PENDING
06:45:04.162666 2955 (net.c:779):Sending packet
0000 01 01 00 20 00 00 01 00-73 00 70 00 5f 00 64 00 |... .... s.p._.d.|
0010 61 00 74 00 61 00 62 00-61 00 73 00 65 00 73 00 |a.t.a.b. a.s.e.s.|

06:45:04.162779 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb70, 0x32fb6c, 0x6914)
06:45:04.162807 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.371898 2955 (net.c:592):Received header
0000 04 01 01 49 00 33 01 00-                        |...I.3..|

06:45:07.371999 2955 (net.c:671):Received packet
0000 ff 01 00 c1 00 01 00 00-00 ff 01 00 c1 00 01 00 |........ ........|
0010 00 00 ff 01 00 c1 00 01-00 00 00 ff 01 00 c1 00 |........ ........|
0020 01 00 00 00 ff 01 00 c1-00 01 00 00 00 ff 01 00 |........ ........|
0030 c1 00 01 00 00 00 ff 01-00 c1 00 00 00 00 00 81 |........ ........|
0040 03 00 00 00 01 00 e7 00-01 0e 04 d0 00 00 0d 44 |........ .......D|
0050 00 41 00 54 00 41 00 42-00 41 00 53 00 45 00 5f |.A.T.A.B .A.S.E._|
0060 00 4e 00 41 00 4d 00 45-00 00 00 01 00 26 04 0d |.N.A.M.E .....&..|
0070 44 00 41 00 54 00 41 00-42 00 41 00 53 00 45 00 |D.A.T.A. B.A.S.E.|
0080 5f 00 53 00 49 00 5a 00-45 00 00 00 01 00 a7 fe |_.S.I.Z. E.......|
0090 00 0e 04 d0 00 00 07 52-00 45 00 4d 00 41 00 52 |.......R .E.M.A.R|
00a0 00 4b 00 53 00 a9 02 00-01 00 d1 0c 00 6d 00 61 |.K.S.... .....m.a|
00b0 00 73 00 74 00 65 00 72-00 04 c0 4c 00 00 ff ff |.s.t.e.r ...L....|
00c0 d1 0a 00 6d 00 6f 00 64-00 65 00 6c 00 04 80 07 |...m.o.d .e.l....|
00d0 00 00 ff ff d1 08 00 6d-00 73 00 64 00 62 00 04 |.......m .s.d.b..|
00e0 00 38 00 00 ff ff d1 12-00 4e 00 6f 00 72 00 74 |.8...... .N.o.r.t|
00f0 00 68 00 77 00 69 00 6e-00 64 00 04 00 11 00 00 |.h.w.i.n .d......|
0100 ff ff d1 08 00 70 00 75-00 62 00 73 00 04 00 0a |.....p.u .b.s....|
0110 00 00 ff ff d1 0c 00 74-00 65 00 6d 00 70 00 64 |.......t .e.m.p.d|
0120 00 62 00 04 00 23 00 00-ff ff ff 01 00 c1 00 06 |.b...#.. ........|
0130 00 00 00 79 00 00 00 00-fe 00 00 e0 00 06 00 00 |...y.... ........|
0140 00                     -                        |.|

06:45:07.372405 2955 (token.c:510):processing result tokens.  marker is
ff(DONEINPROC)
06:45:07.372430 2955 (token.c:2201):tds_process_end: more_results = 1
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.372452 2955 (token.c:2232):                rows_affected = 1
06:45:07.372471 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.372491 2955 (odbc.c:3269):odbc_process_tokens:
tds_process_tokens returned 1
06:45:07.372510 2955 (odbc.c:3270):    result_type=4054,
TDS_DONE_COUNT=0, TDS_DONE_ERROR=0
06:45:07.372530 2955 (odbc.c:3334):odbc_process_tokens: processed
TDS_DONEINPROC_RESULT
06:45:07.372548 2955 (odbc.c:3119):_SQLExecute: odbc_process_tokens
returned result_type 4054
06:45:07.372566 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb70, 0x32fb6c, 0x6914)
06:45:07.372587 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.372606 2955 (token.c:510):processing result tokens.  marker is
ff(DONEINPROC)
06:45:07.372626 2955 (token.c:2201):tds_process_end: more_results = 1
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.372645 2955 (token.c:2232):                rows_affected = 1
06:45:07.372664 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.372683 2955 (odbc.c:3269):odbc_process_tokens:
tds_process_tokens returned 1
06:45:07.372701 2955 (odbc.c:3270):    result_type=4054,
TDS_DONE_COUNT=0, TDS_DONE_ERROR=0
06:45:07.372720 2955 (odbc.c:3334):odbc_process_tokens: processed
TDS_DONEINPROC_RESULT
06:45:07.372737 2955 (odbc.c:3119):_SQLExecute: odbc_process_tokens
returned result_type 4054
06:45:07.372755 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb70, 0x32fb6c, 0x6914)
06:45:07.372774 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.372793 2955 (token.c:510):processing result tokens.  marker is
ff(DONEINPROC)
06:45:07.372812 2955 (token.c:2201):tds_process_end: more_results = 1
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.372831 2955 (token.c:2232):                rows_affected = 1
06:45:07.372850 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.372868 2955 (odbc.c:3269):odbc_process_tokens:
tds_process_tokens returned 1
06:45:07.372886 2955 (odbc.c:3270):    result_type=4054,
TDS_DONE_COUNT=0, TDS_DONE_ERROR=0
06:45:07.372905 2955 (odbc.c:3334):odbc_process_tokens: processed
TDS_DONEINPROC_RESULT
06:45:07.372922 2955 (odbc.c:3119):_SQLExecute: odbc_process_tokens
returned result_type 4054
06:45:07.372940 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb70, 0x32fb6c, 0x6914)
06:45:07.372960 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.372978 2955 (token.c:510):processing result tokens.  marker is
ff(DONEINPROC)
06:45:07.372997 2955 (token.c:2201):tds_process_end: more_results = 1
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.373016 2955 (token.c:2232):                rows_affected = 1
06:45:07.373034 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.373053 2955 (odbc.c:3269):odbc_process_tokens:
tds_process_tokens returned 1
06:45:07.373071 2955 (odbc.c:3270):    result_type=4054,
TDS_DONE_COUNT=0, TDS_DONE_ERROR=0
06:45:07.373090 2955 (odbc.c:3334):odbc_process_tokens: processed
TDS_DONEINPROC_RESULT
06:45:07.373107 2955 (odbc.c:3119):_SQLExecute: odbc_process_tokens
returned result_type 4054
06:45:07.373125 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb70, 0x32fb6c, 0x6914)
06:45:07.373145 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.373163 2955 (token.c:510):processing result tokens.  marker is
ff(DONEINPROC)
06:45:07.373206 2955 (token.c:2201):tds_process_end: more_results = 1
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.373228 2955 (token.c:2232):                rows_affected = 1
06:45:07.373246 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.373265 2955 (odbc.c:3269):odbc_process_tokens:
tds_process_tokens returned 1
06:45:07.373283 2955 (odbc.c:3270):    result_type=4054,
TDS_DONE_COUNT=0, TDS_DONE_ERROR=0
06:45:07.373302 2955 (odbc.c:3334):odbc_process_tokens: processed
TDS_DONEINPROC_RESULT
06:45:07.373319 2955 (odbc.c:3119):_SQLExecute: odbc_process_tokens
returned result_type 4054
06:45:07.373337 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb70, 0x32fb6c, 0x6914)
06:45:07.373357 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.373375 2955 (token.c:510):processing result tokens.  marker is
ff(DONEINPROC)
06:45:07.373394 2955 (token.c:2201):tds_process_end: more_results = 1
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.373413 2955 (token.c:2232):                rows_affected = 1
06:45:07.373431 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.373450 2955 (odbc.c:3269):odbc_process_tokens:
tds_process_tokens returned 1
06:45:07.373468 2955 (odbc.c:3270):    result_type=4054,
TDS_DONE_COUNT=0, TDS_DONE_ERROR=0
06:45:07.373487 2955 (odbc.c:3334):odbc_process_tokens: processed
TDS_DONEINPROC_RESULT
06:45:07.373504 2955 (odbc.c:3119):_SQLExecute: odbc_process_tokens
returned result_type 4054
06:45:07.373522 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb70, 0x32fb6c, 0x6914)
06:45:07.373541 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.373560 2955 (token.c:510):processing result tokens.  marker is
ff(DONEINPROC)
06:45:07.373579 2955 (token.c:2201):tds_process_end: more_results = 1
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.373598 2955 (token.c:2232):                rows_affected = 0
06:45:07.373617 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.373635 2955 (odbc.c:3269):odbc_process_tokens:
tds_process_tokens returned 1
06:45:07.373653 2955 (odbc.c:3270):    result_type=4054,
TDS_DONE_COUNT=0, TDS_DONE_ERROR=0
06:45:07.373671 2955 (odbc.c:3334):odbc_process_tokens: processed
TDS_DONEINPROC_RESULT
06:45:07.373689 2955 (odbc.c:3119):_SQLExecute: odbc_process_tokens
returned result_type 4054
06:45:07.373707 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb70, 0x32fb6c, 0x6914)
06:45:07.373726 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.373745 2955 (token.c:510):processing result tokens.  marker is
81(TDS7_RESULT)
06:45:07.373764 2955 (token.c:1520):processing TDS7 result metadata.
06:45:07.373782 2955 (mem.c:563):tds_free_all_results()
06:45:07.373808 2955 (token.c:1544):set current_results (3 columns) to
tds->res_info
06:45:07.373828 2955 (token.c:1555):setting up column 0
06:45:07.373850 2955 (token.c:3294):adjust_character_column_size:
        Server charset: UCS-2LE
        Server column_size: 256
        Client charset: UTF-8
        Client column_size: 512
06:45:07.373877 2955 (token.c:1490):tds7_get_data_info: 
        colname = DATABASE_NAME (13 bytes)
        type = 39 (varchar)
        server's type = 231 (x UCS-2 varchar)
        column_varint_size = 2
        column_size = 512 (256 on server)
06:45:07.373901 2955 (token.c:1555):setting up column 1
06:45:07.373923 2955 (token.c:1490):tds7_get_data_info: 
        colname = DATABASE_SIZE (13 bytes)
        type = 38 (integer-null)
        server's type = 38 (integer-null)
        column_varint_size = 1
        column_size = 4 (4 on server)
06:45:07.373946 2955 (token.c:1555):setting up column 2
06:45:07.373965 2955 (token.c:3294):adjust_character_column_size:
        Server charset: CP1250
        Server column_size: 254
        Client charset: UTF-8
        Client column_size: 1016
06:45:07.373987 2955 (token.c:1490):tds7_get_data_info: 
        colname = REMARKS (7 bytes)
        type = 39 (varchar)
        server's type = 167 (xvarchar)
        column_varint_size = 2
        column_size = 1016 (254 on server)
06:45:07.374012 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.374055 2955 (odbc.c:3269):odbc_process_tokens:
tds_process_tokens returned 1
06:45:07.374075 2955 (odbc.c:3270):    result_type=4049,
TDS_DONE_COUNT=0, TDS_DONE_ERROR=0
06:45:07.374094 2955 (odbc.c:3340):odbc_process_tokens: returning
result_type 4049
06:45:07.374112 2955 (odbc.c:3119):_SQLExecute: odbc_process_tokens
returned result_type 4049
06:45:07.374131 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb70, 0x32fb6c, 0x6914)
06:45:07.374150 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.374169 2955 (token.c:510):processing result tokens.  marker is
a9(ORDERBY)
06:45:07.374188 2955 (token.c:108):tds_process_default_tokens() marker
is a9(ORDERBY)
06:45:07.374207 2955 (token.c:223):Eating ORDERBY token
06:45:07.374226 2955 (token.c:510):processing result tokens.  marker is
d1(ROW)
06:45:07.374245 2955 (token.c:621):tds_process_tokens::SET_RETURN
stopping on current token
06:45:07.374263 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.374281 2955 (odbc.c:3269):odbc_process_tokens:
tds_process_tokens returned 1
06:45:07.374299 2955 (odbc.c:3270):    result_type=4040,
TDS_DONE_COUNT=0, TDS_DONE_ERROR=0
06:45:07.374318 2955 (odbc.c:3340):odbc_process_tokens: returning
result_type 4040
06:45:07.374336 2955 (odbc.c:3119):_SQLExecute: odbc_process_tokens
returned result_type 4040
06:45:07.374558 2955 (odbc.c:4100):SQLNumResultCols(0x7d0e2af8,
0x10107776)
06:45:07.374716 2955 (odbc.c:1702):SQLDescribeCol(0x7d0e2af8, 1,
0x7d0e5b50, 120, 0x10107720, 0x10107b98, 0x1000730c, 0x10147fb0,
0x10007310)
06:45:07.374983 2955 (odbc.c:1519):SQLBindCol(0x7d0e2af8, 1, -8,
0x10007720, 552, 0x10107ba4)
06:45:07.375084 2955 (error.c:609):SQLGetDiagRec(3, 0x7d0e2af8, 1,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.375113 2955 (error.c:510):_SQLGetDiagRec(3, 0x7d0e2af8, 1,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.375215 2955 (error.c:609):SQLGetDiagRec(3, 0x7d0e2af8, 2,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.375242 2955 (error.c:510):_SQLGetDiagRec(3, 0x7d0e2af8, 2,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.375332 2955 (odbc.c:1702):SQLDescribeCol(0x7d0e2af8, 2,
0x7d0e5c38, 120, 0x10107720, 0x10107b98, 0x1000730c, 0x10147fb0,
0x10007310)
06:45:07.375493 2955 (odbc.c:1519):SQLBindCol(0x7d0e2af8, 2, -8,
0x10007b80, 50, 0x10107ba8)
06:45:07.375586 2955 (error.c:609):SQLGetDiagRec(3, 0x7d0e2af8, 1,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.375613 2955 (error.c:510):_SQLGetDiagRec(3, 0x7d0e2af8, 1,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.375698 2955 (error.c:609):SQLGetDiagRec(3, 0x7d0e2af8, 2,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.375724 2955 (error.c:510):_SQLGetDiagRec(3, 0x7d0e2af8, 2,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.375812 2955 (odbc.c:1702):SQLDescribeCol(0x7d0e2af8, 3,
0x7d0e5b50, 120, 0x10107720, 0x10107b98, 0x1000730c, 0x10147fb0,
0x10007310)
06:45:07.375972 2955 (odbc.c:1519):SQLBindCol(0x7d0e2af8, 3, -8,
0x10007bf4, 1056, 0x10107bac)
06:45:07.376062 2955 (error.c:609):SQLGetDiagRec(3, 0x7d0e2af8, 1,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.376089 2955 (error.c:510):_SQLGetDiagRec(3, 0x7d0e2af8, 1,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.376174 2955 (error.c:609):SQLGetDiagRec(3, 0x7d0e2af8, 2,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.376200 2955 (error.c:510):_SQLGetDiagRec(3, 0x7d0e2af8, 2,
0x32f76e, 0x32f77c, 0x32f9a0, 512, 0x32f778)
06:45:07.395177 2955 (odbc.c:4388):SQLEndTran(2, 0x7d0e0ae0, 1)
06:45:07.395203 2955 (odbc.c:4366):_SQLTransact((nil), 0x7d0e0ae0, 1)
06:45:07.395217 2955 (odbc.c:4327):change_transaction(0x0x7d0e0ae0,0)
06:45:07.395228 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb68, 0x32fb64, 0x100)
06:45:07.395240 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.395251 2955 (token.c:510):processing result tokens.  marker is
d1(ROW)
06:45:07.395263 2955 (token.c:2166):tds_process_row(): reading column 0 
06:45:07.395278 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395311 2955 (token.c:1975):tds_get_data(): wire column size is
12 
06:45:07.395327 2955 (token.c:2166):tds_process_row(): reading column 1 
06:45:07.395337 2955 (token.c:1915):tds_get_data: type 38, varint size 1
06:45:07.395347 2955 (token.c:1975):tds_get_data(): wire column size is
4 
06:45:07.395357 2955 (token.c:2166):tds_process_row(): reading column 2 
06:45:07.395367 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395377 2955 (token.c:1975):tds_get_data(): wire column size is
-1 
06:45:07.395387 2955 (token.c:510):processing result tokens.  marker is
d1(ROW)
06:45:07.395397 2955 (token.c:2166):tds_process_row(): reading column 0 
06:45:07.395407 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395417 2955 (token.c:1975):tds_get_data(): wire column size is
10 
06:45:07.395427 2955 (token.c:2166):tds_process_row(): reading column 1 
06:45:07.395437 2955 (token.c:1915):tds_get_data: type 38, varint size 1
06:45:07.395447 2955 (token.c:1975):tds_get_data(): wire column size is
4 
06:45:07.395457 2955 (token.c:2166):tds_process_row(): reading column 2 
06:45:07.395466 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395476 2955 (token.c:1975):tds_get_data(): wire column size is
-1 
06:45:07.395486 2955 (token.c:510):processing result tokens.  marker is
d1(ROW)
06:45:07.395496 2955 (token.c:2166):tds_process_row(): reading column 0 
06:45:07.395505 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395515 2955 (token.c:1975):tds_get_data(): wire column size is
8 
06:45:07.395526 2955 (token.c:2166):tds_process_row(): reading column 1 
06:45:07.395536 2955 (token.c:1915):tds_get_data: type 38, varint size 1
06:45:07.395546 2955 (token.c:1975):tds_get_data(): wire column size is
4 
06:45:07.395555 2955 (token.c:2166):tds_process_row(): reading column 2 
06:45:07.395565 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395575 2955 (token.c:1975):tds_get_data(): wire column size is
-1 
06:45:07.395584 2955 (token.c:510):processing result tokens.  marker is
d1(ROW)
06:45:07.395594 2955 (token.c:2166):tds_process_row(): reading column 0 
06:45:07.395604 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395613 2955 (token.c:1975):tds_get_data(): wire column size is
18 
06:45:07.395624 2955 (token.c:2166):tds_process_row(): reading column 1 
06:45:07.395634 2955 (token.c:1915):tds_get_data: type 38, varint size 1
06:45:07.395644 2955 (token.c:1975):tds_get_data(): wire column size is
4 
06:45:07.395654 2955 (token.c:2166):tds_process_row(): reading column 2 
06:45:07.395663 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395673 2955 (token.c:1975):tds_get_data(): wire column size is
-1 
06:45:07.395683 2955 (token.c:510):processing result tokens.  marker is
d1(ROW)
06:45:07.395693 2955 (token.c:2166):tds_process_row(): reading column 0 
06:45:07.395702 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395712 2955 (token.c:1975):tds_get_data(): wire column size is
8 
06:45:07.395722 2955 (token.c:2166):tds_process_row(): reading column 1 
06:45:07.395732 2955 (token.c:1915):tds_get_data: type 38, varint size 1
06:45:07.395742 2955 (token.c:1975):tds_get_data(): wire column size is
4 
06:45:07.395752 2955 (token.c:2166):tds_process_row(): reading column 2 
06:45:07.395761 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395771 2955 (token.c:1975):tds_get_data(): wire column size is
-1 
06:45:07.395781 2955 (token.c:510):processing result tokens.  marker is
d1(ROW)
06:45:07.395791 2955 (token.c:2166):tds_process_row(): reading column 0 
06:45:07.395800 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395810 2955 (token.c:1975):tds_get_data(): wire column size is
12 
06:45:07.395821 2955 (token.c:2166):tds_process_row(): reading column 1 
06:45:07.395831 2955 (token.c:1915):tds_get_data: type 38, varint size 1
06:45:07.395841 2955 (token.c:1975):tds_get_data(): wire column size is
4 
06:45:07.395850 2955 (token.c:2166):tds_process_row(): reading column 2 
06:45:07.395873 2955 (token.c:1915):tds_get_data: type 39, varint size 2
06:45:07.395884 2955 (token.c:1975):tds_get_data(): wire column size is
-1 
06:45:07.395894 2955 (token.c:510):processing result tokens.  marker is
ff(DONEINPROC)
06:45:07.395905 2955 (token.c:2201):tds_process_end: more_results = 1
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.395915 2955 (token.c:2232):                rows_affected = 6
06:45:07.395925 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.395935 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb68, 0x32fb64, 0x100)
06:45:07.395945 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.395955 2955 (token.c:510):processing result tokens.  marker is
79(RETURNSTATUS)
06:45:07.395966 2955 (token.c:645):tds_process_tokens: return status is
0
06:45:07.395975 2955 (token.c:510):processing result tokens.  marker is
fe(DONEPROC)
06:45:07.395985 2955 (token.c:2201):tds_process_end: more_results = 0
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.395996 2955 (token.c:2217):tds_process_end() state set to
TDS_IDLE
06:45:07.396005 2955 (util.c:162):Changed query state from READING to
IDLE
06:45:07.396015 2955 (token.c:2232):                rows_affected = 6
06:45:07.396025 2955 (util.c:110):logic error: cannot change query state
from IDLE to PENDING
06:45:07.396035 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb68, 0x32fb64, 0x100)
06:45:07.396045 2955 (token.c:498):tds_process_tokens() state is
COMPLETED
06:45:07.396055 2955 (mem.c:563):tds_free_all_results()
06:45:07.396067 2955 (util.c:162):Changed query state from IDLE to
QUERYING
06:45:07.396078 2955 (write.c:136):tds_put_string converting 27 bytes of
"IF @@TRANCOUNT > 0 ROLLBACK"
06:45:07.396092 2955 (write.c:164):tds_put_string wrote 54 bytes
06:45:07.396102 2955 (util.c:162):Changed query state from QUERYING to
PENDING
06:45:07.396112 2955 (net.c:779):Sending packet
0000 01 01 00 3e 00 00 01 00-49 00 46 00 20 00 40 00 |...>.... I.F. .@.|
0010 40 00 54 00 52 00 41 00-4e 00 43 00 4f 00 55 00 |@.T.R.A. N.C.O.U.|
0020 4e 00 54 00 20 00 3e 00-20 00 30 00 20 00 52 00 |N.T. .>.  .0. .R.|
0030 4f 00 4c 00 4c 00 42 00-41 00 43 00 4b 00       |O.L.L.B. A.C.K.|

06:45:07.396199 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb68, 0x32fb64, 0x100)
06:45:07.396213 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.412986 2955 (net.c:592):Received header
0000 04 01 00 1a 00 33 01 00-                        |.....3..|

06:45:07.413041 2955 (net.c:671):Received packet
0000 fd 01 00 c0 00 00 00 00-00 fd 00 00 ca 00 00 00 |........ ........|
0010 00 00                  -                        |..|

06:45:07.413090 2955 (token.c:510):processing result tokens.  marker is
fd(DONE)
06:45:07.413112 2955 (token.c:2201):tds_process_end: more_results = 1
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.413132 2955 (token.c:2232):                rows_affected = 0
06:45:07.413151 2955 (util.c:162):Changed query state from READING to
PENDING
06:45:07.413170 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb68, 0x32fb64, 0x100)
06:45:07.413190 2955 (util.c:162):Changed query state from PENDING to
READING
06:45:07.413209 2955 (token.c:510):processing result tokens.  marker is
fd(DONE)
06:45:07.413228 2955 (token.c:2201):tds_process_end: more_results = 0
                was_cancelled = 0
                error = 0
                done_count_valid = 0
06:45:07.413247 2955 (token.c:2217):tds_process_end() state set to
TDS_IDLE
06:45:07.413265 2955 (util.c:162):Changed query state from READING to
IDLE
06:45:07.413283 2955 (token.c:2232):                rows_affected = 0
06:45:07.413301 2955 (util.c:110):logic error: cannot change query state
from IDLE to PENDING
06:45:07.413320 2955 (token.c:495):tds_process_tokens(0x7d0e0038,
0x32fb68, 0x32fb64, 0x100)
06:45:07.413339 2955 (token.c:498):tds_process_tokens() state is
COMPLETED
06:45:07.413462 2955 (odbc.c:5587):SQLGetInfo(0x7d0e0ae0, 24, 0x32fc32,
8, 0x32fc30)
06:45:07.413490 2955 (odbc.c:4841):_SQLGetInfo(0x7d0e0ae0, 24, 0x32fc32,
8, 0x32fc30
06:45:07.413821 2955 (error.c:609):SQLGetDiagRec(2, 0x7d0e0ae0, 1,
0x32f756, 0x32f764, 0x32f988, 512, 0x32f760)
06:45:07.413853 2955 (error.c:510):_SQLGetDiagRec(2, 0x7d0e0ae0, 1,
0x32f756, 0x32f764, 0x32f988, 512, 0x32f760)