2010/6/9 Michael Bayer <[email protected]>: > OK, here's something else to try, this would help with the pyodbc issue in > any case. Turn on ODBC logging (its a setting with your ODBC driver). You > should get a dumpfile like the one here: > http://www.egenix.com/mailman-archives/egenix-users/2008-November/114471.html
I turned on unixodbc tracing by following this procedure: http://www.easysoft.com/support/kb/kb00945.html By doing that, I got a very different trace file from the one on your link. The relevant part is: (...) [ODBC][19475][SQLGetInfo.c][214] Entry: Connection = 0x9626f60 Info Type = SQL_DBMS_VER (18) Info Value = 0xbfb955ac Buffer Length = 4096 StrLen = 0xbfb955a8 [ODBC][19475][SQLGetInfo.c][528] Exit:[SQL_SUCCESS] (...) It seems that the SQLGetInfo succeded (SQL_SUCCESS) but I don't get to see the actual return value. The full log is attached (I changed only connection info like password). > I would wonder if the ODBC driver you're using is the issue here. The odbc driver I'm using is FreeTDS 0.82, from the default ubuntu 10.04 package. I have also enabled tracing, using the instructions I found here: http://www.freetds.org/userguide/logging.htm The full log is also attached (with connection info mangled). I think the relevant part of the log is: odbc.c:5587:SQLGetInfo(0x93b9750, 24, 0xbfd494e6, 8, 0xbfd494e4) odbc.c:4841:_SQLGetInfo(0x93b9750, 24, 0xbfd494e6, 8, 0xbfd494e4 So again we don't see the actual results in the log. -- nosklo -- You received this message because you are subscribed to the Google Groups "sqlalchemy" group. To post to this group, send email to [email protected]. To unsubscribe from this group, send email to [email protected]. For more options, visit this group at http://groups.google.com/group/sqlalchemy?hl=en.
[ODBC][19475][__handles.c][444] Exit:[SQL_SUCCESS] Environment = 0x9623948 [ODBC][19475][SQLSetEnvAttr.c][182] Entry: Environment = 0x9623948 Attribute = SQL_ATTR_ODBC_VERSION Value = 0x3 StrLen = 4 [ODBC][19475][SQLSetEnvAttr.c][349] Exit:[SQL_SUCCESS] [ODBC][19475][SQLAllocHandle.c][345] Entry: Handle Type = 2 Input Handle = 0x9623948 [ODBC][19475][SQLAllocHandle.c][463] Exit:[SQL_SUCCESS] Output Handle = 0x9626f60 [ODBC][19475][SQLDriverConnectW.c][246] Entry: Connection = 0x9626f60 Window Hdl = (nil) Str In = [PWD=sa;DATABASE=mydb;DRIVER=FreeTDS;UID=sa;SERVER=myserver][length = 70 (SQL_NTS)] Str Out = (nil) Str Out Max = 0 Str Out Ptr = (nil) Completion = 0 UNICODE Using encoding ASCII 'ISO8859-1' and UNICODE 'UCS-2LE' [ODBC][19475][SQLDriverConnectW.c][802] Exit:[SQL_SUCCESS] Connection Out [[NULL]] [ODBC][19475][SQLSetConnectAttr.c][318] Entry: Connection = 0x9626f60 Attribute = SQL_ATTR_AUTOCOMMIT Value = (nil) StrLen = -5 [ODBC][19475][SQLSetConnectAttr.c][671] Exit:[SQL_SUCCESS] [ODBC][19475][SQLGetInfo.c][214] Entry: Connection = 0x9626f60 Info Type = SQL_DRIVER_ODBC_VER (77) Info Value = 0xbfb964a8 Buffer Length = 20 StrLen = 0xbfb964a6 [ODBC][19475][SQLGetInfo.c][528] Exit:[SQL_SUCCESS] [ODBC][19475][SQLGetInfo.c][214] Entry: Connection = 0x9626f60 Info Type = SQL_DESCRIBE_PARAMETER (10002) Info Value = 0xbfb9649c Buffer Length = 2 StrLen = 0xbfb964a6 [ODBC][19475][SQLGetInfo.c][528] Exit:[SQL_SUCCESS] [ODBC][19475][SQLAllocHandle.c][510] Entry: Handle Type = 3 Input Handle = 0x9626f60 [ODBC][19475][SQLAllocHandle.c][872] Exit:[SQL_SUCCESS] Output Handle = 0x962b690 [ODBC][19475][SQLGetTypeInfo.c][164] Entry: Statement = 0x962b690 Data Type = SQL_TYPE_TIMESTAMP [ODBC][19475][SQLGetTypeInfo.c][314] Exit:[SQL_SUCCESS] [ODBC][19475][SQLFetch.c][158] Entry: Statement = 0x962b690 [ODBC][19475][SQLFetch.c][340] Exit:[SQL_SUCCESS] [ODBC][19475][SQLGetData.c][224] Entry: Statement = 0x962b690 Column Number = 3 Target Type = 4 SQL_INTEGER Buffer Length = 4 Target Value = 0xbfb96490 StrLen Or Ind = (nil) [ODBC][19475][SQLGetData.c][470] Exit:[SQL_SUCCESS] Buffer = [23] Strlen Or Ind = NULLPTR [ODBC][19475][SQLFreeStmt.c][140] Entry: Statement = 0x962b690 Option = 0 [ODBC][19475][SQLFreeStmt.c][246] Exit:[SQL_SUCCESS] [ODBC][19475][SQLGetInfo.c][214] Entry: Connection = 0x9626f60 Info Type = SQL_DBMS_VER (18) Info Value = 0xbfb955ac Buffer Length = 4096 StrLen = 0xbfb955a8 [ODBC][19475][SQLGetInfo.c][528] Exit:[SQL_SUCCESS] [ODBC][19475][SQLEndTran.c][315] Entry: Connection = 0x9626f60 Completion Type = 1 [ODBC][19475][SQLGetInfo.c][214] Entry: Connection = 0x9626f60 Info Type = SQL_CURSOR_ROLLBACK_BEHAVIOR (24) Info Value = 0xbfb965b6 Buffer Length = 8 StrLen = 0xbfb965b4 [ODBC][19475][SQLGetInfo.c][528] Exit:[SQL_SUCCESS] [ODBC][19475][SQLEndTran.c][488] Exit:[SQL_SUCCESS] [ODBC][19475][SQLDisconnect.c][204] Entry: Connection = 0x9626f60 [ODBC][19475][SQLDisconnect.c][341] Exit:[SQL_SUCCESS] [ODBC][19475][SQLFreeHandle.c][268] Entry: Handle Type = 2 Input Handle = 0x9626f60 [ODBC][19475][SQLFreeHandle.c][317] Exit:[SQL_SUCCESS]
log.c:190:Starting log file for FreeTDS 0.82 on 2010-06-09 19:43:02 with debug flags 0x4fff. iconv.c:197:names for ISO-8859-1: ISO-8859-1 iconv.c:197:names for UTF-8: UTF-8 iconv.c:197:names for UCS-2LE: UCS-2LE iconv.c:197:names for UCS-2BE: UCS-2BE iconv.c:363:iconv to convert client-side data to the "ANSI_X3.4-1968" character set iconv.c:516:tds_iconv_info_init: converting "US-ASCII"->"UCS-2LE" net.c:210:Connecting to 10.32.42.69 port 1433 (TDS version 4.2) net.c:264:tds_open_socket: connect(2) returned "Operation now in progress" net.c:303:tds_open_socket() succeeded util.c:162:Changed query state from DEAD to IDLE net.c:779:Sending packet 0000 02 00 02 00 00 00 00 00-## ## ## ## ## ## ## ## |........ ########| 0010 ## ## ## 00 00 00 00 00-00 00 00 00 00 00 00 00 |###..... ........| 0020 00 00 00 00 00 00 0b 73-61 00 00 00 00 00 00 00 |.......s a.......| 0030 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0040 00 00 00 00 00 02 ## ##-## ## ## ## ## 00 00 00 |......## #####...| 0050 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0060 00 00 00 00 07 33 37 38-37 36 00 00 00 00 00 00 |.....378 76......| 0070 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0080 00 00 00 05 03 01 06 0a-09 01 00 00 00 00 02 00 |........ ........| 0090 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 00a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 00b0 00 00 00 ## ## ## ## ##-## ## ## ## ## ## 00 00 |...##### ######..| 00c0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 00d0 00 0b 6d 6f 7a 69 6c 6c-61 00 00 00 00 00 00 00 |..###### #.......| 00e0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 00f0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0100 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0110 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0120 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0130 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0140 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0150 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0160 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0170 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0180 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 0190 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 01a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 01b0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 01c0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 01d0 00 07 04 02 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........| 01e0 00 00 00 00 00 00 0d 11-75 73 5f 65 6e 67 6c 69 |........ us_engli| 01f0 73 68 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |sh...... ........| net.c:779:Sending packet 0000 02 01 00 4c 00 00 00 00-00 00 00 00 00 00 0a 00 |...L.... ........| 0010 00 00 00 00 00 00 00 00-00 00 00 00 00 41 4e 53 |........ .....ANS| 0020 49 5f 58 33 2e 34 2d 31-39 36 38 00 00 00 00 00 |I_X3.4-1 968.....| 0030 00 00 00 00 00 00 00 00-00 00 00 0e 01 35 31 32 |........ .....512| 0040 00 00 00 03 00 00 00 00-00 00 00 00 |........ ....| token.c:312:tds_process_login_tokens() net.c:592:Received header 0000 04 01 00 9e 00 33 01 00- |.....3..| net.c:671:Received packet 0000 e3 0f 00 01 06 6d 61 73-74 65 72 06 6d 61 73 74 |.....mas ter.mast| 0010 65 72 ab 3c 00 45 16 00-00 02 00 25 00 43 68 61 |er.<.E.. ...%.Cha| 0020 6e 67 65 64 20 64 61 74-61 62 61 73 65 20 63 6f |nged dat abase co| 0030 6e 74 65 78 74 20 74 6f-20 27 6d 61 73 74 65 72 |ntext to 'master| 0040 27 2e 0b 4d 47 37 36 38-34 4e 54 30 30 35 00 00 |'..MG768 4NT005..| 0050 00 e3 09 00 03 05 69 73-6f 5f 31 01 00 ad 20 00 |......is o_1... .| 0060 01 04 02 00 00 16 4d 69-63 72 6f 73 6f 66 74 20 |......Mi crosoft | 0070 53 51 4c 20 53 65 72 76-65 72 00 00 5f 08 00 ff |SQL Serv er.._...| 0080 e3 0a 00 04 03 35 31 32-04 34 30 39 36 fd 00 00 |.....512 .4096...| 0090 00 00 00 00 00 00 - |......| token.c:316:looking for login token, got e3(ENVCHANGE) token.c:108:tds_process_default_tokens() marker is e3(ENVCHANGE) token.c:316:looking for login token, got ab(INFO) token.c:108:tds_process_default_tokens() marker is ab(INFO) token.c:2451:tds_process_msg() reading message from server token.c:2516:tds_process_msg() calling client msg handler odbc.c:2032:msgno 5701 20003 token.c:2529:tds_process_msg() returning TDS_SUCCEED token.c:316:looking for login token, got e3(ENVCHANGE) token.c:108:tds_process_default_tokens() marker is e3(ENVCHANGE) token.c:2356:server indicated charset change to "iso_1" iconv.c:985:setting server single-byte charset to "ISO-8859-1" iconv.c:516:tds_iconv_info_init: converting "US-ASCII"->"ISO-8859-1" token.c:316:looking for login token, got ad(LOGINACK) token.c:316:looking for login token, got e3(ENVCHANGE) token.c:108:tds_process_default_tokens() marker is e3(ENVCHANGE) token.c:316:looking for login token, got fd(DONE) token.c:108:tds_process_default_tokens() marker is fd(DONE) token.c:2201:tds_process_end: more_results = 0 was_cancelled = 0 error = 0 done_count_valid = 0 token.c:2217:tds_process_end() state set to TDS_IDLE token.c:2232: rows_affected = 0 token.c:393:leaving tds_process_login_tokens() returning 1 mem.c:563:tds_free_all_results() util.c:162:Changed query state from IDLE to QUERYING util.c:162:Changed query state from QUERYING to PENDING net.c:779:Sending packet 0000 01 01 00 14 00 00 00 00-75 73 65 20 43 6f 6e 74 |........ use Cont| 0010 61 62 69 6c - |abil| token.c:495:tds_process_tokens(0x93564f8, 0xbfd4729c, 0xbfd47298, 0x100) util.c:162:Changed query state from PENDING to READING net.c:592:Received header 0000 04 01 00 66 00 33 01 00- |...f.3..| net.c:671:Received packet 0000 e3 11 00 01 08 43 6f 6e-74 61 62 69 6c 06 6d 61 |.....Con tabil.ma| 0010 73 74 65 72 ab 3e 00 45-16 00 00 01 00 27 00 43 |ster.>.E .....'.C| 0020 68 61 6e 67 65 64 20 64-61 74 61 62 61 73 65 20 |hanged d atabase | 0030 63 6f 6e 74 65 78 74 20-74 6f 20 27 43 6f 6e 74 |context to 'Cont| 0040 61 62 69 6c 27 2e 0b 4d-47 37 36 38 34 4e 54 30 |abil'..M G7684NT0| 0050 30 35 00 01 00 fd 00 00-e2 00 00 00 00 00 |05...... ......| token.c:510:processing result tokens. marker is e3(ENVCHANGE) token.c:108:tds_process_default_tokens() marker is e3(ENVCHANGE) token.c:510:processing result tokens. marker is ab(INFO) token.c:108:tds_process_default_tokens() marker is ab(INFO) token.c:2451:tds_process_msg() reading message from server token.c:2516:tds_process_msg() calling client msg handler odbc.c:2032:msgno 5701 20003 token.c:2529:tds_process_msg() returning TDS_SUCCEED token.c:510:processing result tokens. marker is fd(DONE) token.c:2201:tds_process_end: more_results = 0 was_cancelled = 0 error = 0 done_count_valid = 0 token.c:2217:tds_process_end() state set to TDS_IDLE util.c:162:Changed query state from READING to IDLE token.c:2232: rows_affected = 0 util.c:110:logic error: cannot change query state from IDLE to PENDING token.c:495:tds_process_tokens(0x93564f8, 0xbfd4729c, 0xbfd47298, 0x100) token.c:498:tds_process_tokens() state is COMPLETED odbc.c:4672:SQLGetFunctions: fFunction is 999 odbc.c:5587:SQLGetInfo(0x93b9750, 77, 0xbfd475ec, 20, (nil)) odbc.c:4841:_SQLGetInfo(0x93b9750, 77, 0xbfd475ec, 20, (nil) odbc.c:5587:SQLGetInfo(0x93b9750, 10000, 0xbfd475ec, 5, (nil)) odbc.c:4841:_SQLGetInfo(0x93b9750, 10000, 0xbfd475ec, 5, (nil) odbc.c:5909:SQLSetConnectAttr(0x93b9750, 102, (nil), -5) odbc.c:5827:_SQLSetConnectAttr(0x93b9750, 102, (nil), -5) odbc.c:213:change_autocommit: executing SET IMPLICIT_TRANSACTIONS ON mem.c:563:tds_free_all_results() util.c:162:Changed query state from IDLE to QUERYING util.c:162:Changed query state from QUERYING to PENDING net.c:779:Sending packet 0000 01 01 00 24 00 00 00 00-53 45 54 20 49 4d 50 4c |...$.... SET IMPL| 0010 49 43 49 54 5f 54 52 41-4e 53 41 43 54 49 4f 4e |ICIT_TRA NSACTION| 0020 53 20 4f 4e - |S ON| token.c:495:tds_process_tokens(0x93564f8, 0xbfd4918c, 0xbfd49188, 0x100) util.c:162:Changed query state from PENDING to READING net.c:592:Received header 0000 04 01 00 11 00 33 01 00- |.....3..| net.c:671:Received packet 0000 fd 00 00 b9 00 00 00 00-00 |........ .| token.c:510:processing result tokens. marker is fd(DONE) token.c:2201:tds_process_end: more_results = 0 was_cancelled = 0 error = 0 done_count_valid = 0 token.c:2217:tds_process_end() state set to TDS_IDLE util.c:162:Changed query state from READING to IDLE token.c:2232: rows_affected = 0 util.c:110:logic error: cannot change query state from IDLE to PENDING token.c:495:tds_process_tokens(0x93564f8, 0xbfd4918c, 0xbfd49188, 0x100) token.c:498:tds_process_tokens() state is COMPLETED odbc.c:5587:SQLGetInfo(0x93b9750, 77, 0xbfd493d8, 20, 0xbfd493d6) odbc.c:4841:_SQLGetInfo(0x93b9750, 77, 0xbfd493d8, 20, 0xbfd493d6 odbc.c:5587:SQLGetInfo(0x93b9750, 10002, 0xbfd493cc, 2, 0xbfd493d6) odbc.c:4841:_SQLGetInfo(0x93b9750, 10002, 0xbfd493cc, 2, 0xbfd493d6 odbc.c:1504:SQLAllocStmt(0x93b9750, 0x939bc08) odbc.c:1403:_SQLAllocStmt(0x93b9750, 0x939bc08) odbc.c:4079:SQLGetStmtAttr(0x9385338, 10010, 0xbfd492c8, 4, (nil)) odbc.c:3917:_SQLGetStmtAttr(0x9385338, 10010, 0xbfd492c8, 4, (nil)) odbc.c:4079:SQLGetStmtAttr(0x9385338, 10011, 0xbfd492c8, 4, (nil)) odbc.c:3917:_SQLGetStmtAttr(0x9385338, 10011, 0xbfd492c8, 4, (nil)) odbc.c:4079:SQLGetStmtAttr(0x9385338, 10012, 0xbfd492c8, 4, (nil)) odbc.c:3917:_SQLGetStmtAttr(0x9385338, 10012, 0xbfd492c8, 4, (nil)) odbc.c:4079:SQLGetStmtAttr(0x9385338, 10013, 0xbfd492c8, 4, (nil)) odbc.c:3917:_SQLGetStmtAttr(0x9385338, 10013, 0xbfd492c8, 4, (nil)) odbc.c:5680:SQLGetTypeInfo(0x9385338, 93) odbc.c:2965:_SQLExecute(0x9385338) odbc.c:2970:_SQLExecute() starting with state 0 mem.c:563:tds_free_all_results() util.c:162:Changed query state from IDLE to QUERYING util.c:162:Changed query state from QUERYING to PENDING net.c:779:Sending packet 0000 01 01 00 22 00 00 00 00-45 58 45 43 20 73 70 5f |...".... EXEC sp_| 0010 64 61 74 61 74 79 70 65-5f 69 6e 66 6f 20 39 33 |datatype _info 93| 0020 2c 33 - |,3| token.c:495:tds_process_tokens(0x93564f8, 0xbfd490ec, 0xbfd490e8, 0x6914) util.c:162:Changed query state from PENDING to READING net.c:592:Received header 0000 04 00 02 00 00 33 01 00- |.....3..| net.c:671:Received packet 0000 ff 01 00 c0 00 00 00 00-00 ff 01 00 c0 00 00 00 |........ ........| 0010 00 00 ff 11 00 c1 00 01-00 00 00 ff 11 00 c1 00 |........ ........| 0020 01 00 00 00 a0 0b 01 09-54 59 50 45 5f 4e 41 4d |........ TYPE_NAM| 0030 45 09 44 41 54 41 5f 54-59 50 45 09 50 52 45 43 |E.DATA_T YPE.PREC| 0040 49 53 49 4f 4e 0e 4c 49-54 45 52 41 4c 5f 50 52 |ISION.LI TERAL_PR| 0050 45 46 49 58 0e 4c 49 54-45 52 41 4c 5f 53 55 46 |EFIX.LIT ERAL_SUF| 0060 46 49 58 0d 43 52 45 41-54 45 5f 50 41 52 41 4d |FIX.CREA TE_PARAM| 0070 53 08 4e 55 4c 4c 41 42-4c 45 0e 43 41 53 45 5f |S.NULLAB LE.CASE_| 0080 53 45 4e 53 49 54 49 56-45 0a 53 45 41 52 43 48 |SENSITIV E.SEARCH| 0090 41 42 4c 45 12 55 4e 53-49 47 4e 45 44 5f 41 54 |ABLE.UNS IGNED_AT| 00a0 54 52 49 42 55 54 45 05-4d 4f 4e 45 59 0e 41 55 |TRIBUTE. MONEY.AU| 00b0 54 4f 5f 49 4e 43 52 45-4d 45 4e 54 0f 4c 4f 43 |TO_INCRE MENT.LOC| 00c0 41 4c 5f 54 59 50 45 5f-4e 41 4d 45 0d 4d 49 4e |AL_TYPE_ NAME.MIN| 00d0 49 4d 55 4d 5f 53 43 41-4c 45 0d 4d 41 58 49 4d |IMUM_SCA LE.MAXIM| 00e0 55 4d 5f 53 43 41 4c 45-0d 53 51 4c 5f 44 41 54 |UM_SCALE .SQL_DAT| 00f0 41 5f 54 59 50 45 10 53-51 4c 5f 44 41 54 45 54 |A_TYPE.S QL_DATET| 0100 49 4d 45 5f 53 55 42 0e-4e 55 4d 5f 50 52 45 43 |IME_SUB. NUM_PREC| 0110 5f 52 41 44 49 58 12 49-4e 54 45 52 56 41 4c 5f |_RADIX.I NTERVAL_| 0120 50 52 45 43 49 53 49 4f-4e 08 55 53 45 52 54 59 |PRECISIO N.USERTY| 0130 50 45 a1 73 00 12 00 01-00 27 ff 06 00 08 00 34 |PE.s.... .'.....4| 0140 0d 00 01 00 26 04 02 00-09 00 27 20 02 00 09 00 |....&... ..' ....| 0150 27 20 02 00 09 00 27 20-0d 00 01 00 26 02 06 00 |' ....' ....&...| 0160 08 00 34 06 00 08 00 34-0d 00 09 00 26 02 06 00 |..4....4 ....&...| 0170 08 00 34 0d 00 09 00 26-02 12 00 01 00 27 ff 0d |..4....& .....'..| 0180 00 01 00 26 02 0d 00 01-00 26 02 06 00 08 00 34 |...&.... .&.....4| 0190 0d 00 09 00 26 02 0d 00-01 00 26 04 0d 00 01 00 |....&... ..&.....| 01a0 26 02 0d 00 21 00 26 02-a9 04 00 02 0c 0b 00 d1 |&...!.&. ........| 01b0 08 64 61 74 65 74 69 6d-65 5d 00 04 17 00 00 00 |.datetim e]......| 01c0 01 27 01 27 00 02 01 00-00 00 03 00 00 00 00 00 |.'.'.... ........| 01d0 08 64 61 74 65 74 69 6d-65 02 03 00 02 03 00 09 |.datetim e.......| 01e0 00 02 03 00 00 00 02 0c-00 d1 0d 73 6d 61 6c 6c |........ ...small| 01f0 64 61 74 65 74 69 6d 65- |datetime| token.c:510:processing result tokens. marker is ff(DONEINPROC) token.c:2201:tds_process_end: more_results = 1 was_cancelled = 0 error = 0 done_count_valid = 0 token.c:2232: rows_affected = 0 util.c:162:Changed query state from READING to PENDING odbc.c:3269:odbc_process_tokens: tds_process_tokens returned 1 odbc.c:3270: result_type=4054, TDS_DONE_COUNT=0, TDS_DONE_ERROR=0 odbc.c:3334:odbc_process_tokens: processed TDS_DONEINPROC_RESULT odbc.c:3119:_SQLExecute: odbc_process_tokens returned result_type 4054 token.c:495:tds_process_tokens(0x93564f8, 0xbfd490ec, 0xbfd490e8, 0x6914) util.c:162:Changed query state from PENDING to READING token.c:510:processing result tokens. marker is ff(DONEINPROC) token.c:2201:tds_process_end: more_results = 1 was_cancelled = 0 error = 0 done_count_valid = 0 token.c:2232: rows_affected = 0 util.c:162:Changed query state from READING to PENDING odbc.c:3269:odbc_process_tokens: tds_process_tokens returned 1 odbc.c:3270: result_type=4054, TDS_DONE_COUNT=0, TDS_DONE_ERROR=0 odbc.c:3334:odbc_process_tokens: processed TDS_DONEINPROC_RESULT odbc.c:3119:_SQLExecute: odbc_process_tokens returned result_type 4054 token.c:495:tds_process_tokens(0x93564f8, 0xbfd490ec, 0xbfd490e8, 0x6914) util.c:162:Changed query state from PENDING to READING token.c:510:processing result tokens. marker is ff(DONEINPROC) token.c:2201:tds_process_end: more_results = 1 was_cancelled = 0 error = 0 done_count_valid = 1 token.c:2232: rows_affected = 1 util.c:162:Changed query state from READING to PENDING odbc.c:3269:odbc_process_tokens: tds_process_tokens returned 1 odbc.c:3270: result_type=4054, TDS_DONE_COUNT=10, TDS_DONE_ERROR=0 odbc.c:3334:odbc_process_tokens: processed TDS_DONEINPROC_RESULT odbc.c:3119:_SQLExecute: odbc_process_tokens returned result_type 4054 token.c:495:tds_process_tokens(0x93564f8, 0xbfd490ec, 0xbfd490e8, 0x6914) util.c:162:Changed query state from PENDING to READING token.c:510:processing result tokens. marker is ff(DONEINPROC) token.c:2201:tds_process_end: more_results = 1 was_cancelled = 0 error = 0 done_count_valid = 1 token.c:2232: rows_affected = 1 util.c:162:Changed query state from READING to PENDING odbc.c:3269:odbc_process_tokens: tds_process_tokens returned 1 odbc.c:3270: result_type=4054, TDS_DONE_COUNT=10, TDS_DONE_ERROR=0 odbc.c:3334:odbc_process_tokens: processed TDS_DONEINPROC_RESULT odbc.c:3119:_SQLExecute: odbc_process_tokens returned result_type 4054 token.c:495:tds_process_tokens(0x93564f8, 0xbfd490ec, 0xbfd490e8, 0x6914) util.c:162:Changed query state from PENDING to READING token.c:510:processing result tokens. marker is a0(COLNAME) mem.c:563:tds_free_all_results() token.c:510:processing result tokens. marker is a1(COLFMT) token.c:977:processing result. type = 39(varchar), varint_size 1 token.c:977:processing result. type = 52(smallint), varint_size 0 token.c:977:processing result. type = 38(integer-null), varint_size 1 token.c:977:processing result. type = 39(varchar), varint_size 1 token.c:977:processing result. type = 39(varchar), varint_size 1 token.c:977:processing result. type = 39(varchar), varint_size 1 token.c:977:processing result. type = 38(integer-null), varint_size 1 token.c:977:processing result. type = 52(smallint), varint_size 0 token.c:977:processing result. type = 52(smallint), varint_size 0 token.c:977:processing result. type = 38(integer-null), varint_size 1 token.c:977:processing result. type = 52(smallint), varint_size 0 token.c:977:processing result. type = 38(integer-null), varint_size 1 token.c:977:processing result. type = 39(varchar), varint_size 1 token.c:977:processing result. type = 38(integer-null), varint_size 1 token.c:977:processing result. type = 38(integer-null), varint_size 1 token.c:977:processing result. type = 52(smallint), varint_size 0 token.c:977:processing result. type = 38(integer-null), varint_size 1 token.c:977:processing result. type = 38(integer-null), varint_size 1 token.c:977:processing result. type = 38(integer-null), varint_size 1 token.c:977:processing result. type = 38(integer-null), varint_size 1 util.c:162:Changed query state from READING to PENDING odbc.c:3269:odbc_process_tokens: tds_process_tokens returned 1 odbc.c:3270: result_type=4049, TDS_DONE_COUNT=10, TDS_DONE_ERROR=0 odbc.c:3340:odbc_process_tokens: returning result_type 4049 odbc.c:3119:_SQLExecute: odbc_process_tokens returned result_type 4049 token.c:495:tds_process_tokens(0x93564f8, 0xbfd490ec, 0xbfd490e8, 0x6914) util.c:162:Changed query state from PENDING to READING token.c:510:processing result tokens. marker is a9(ORDERBY) token.c:108:tds_process_default_tokens() marker is a9(ORDERBY) token.c:223:Eating ORDERBY token token.c:510:processing result tokens. marker is d1(ROW) token.c:621:tds_process_tokens::SET_RETURN stopping on current token util.c:162:Changed query state from READING to PENDING odbc.c:3269:odbc_process_tokens: tds_process_tokens returned 1 odbc.c:3270: result_type=4040, TDS_DONE_COUNT=10, TDS_DONE_ERROR=0 odbc.c:3340:odbc_process_tokens: returning result_type 4040 odbc.c:3119:_SQLExecute: odbc_process_tokens returned result_type 4040 odbc.c:3653:SQLFetch(0x9385338) odbc.c:3396:_SQLFetch(0x9385338, 1, 0) token.c:495:tds_process_tokens(0x93564f8, 0xbfd4911c, 0xbfd49118, 0x6508) util.c:162:Changed query state from PENDING to READING token.c:510:processing result tokens. marker is d1(ROW) token.c:2166:tds_process_row(): reading column 0 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is 8 token.c:2166:tds_process_row(): reading column 1 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 2 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 4 token.c:2166:tds_process_row(): reading column 3 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is 1 token.c:2166:tds_process_row(): reading column 4 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is 1 token.c:2166:tds_process_row(): reading column 5 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 6 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 7 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 8 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 9 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 10 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 11 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 12 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is 8 token.c:2166:tds_process_row(): reading column 13 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 14 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 15 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 16 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 17 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 18 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 19 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 util.c:162:Changed query state from READING to PENDING odbc.c:3269:odbc_process_tokens: tds_process_tokens returned 1 odbc.c:3270: result_type=4040, TDS_DONE_COUNT=10, TDS_DONE_ERROR=0 odbc.c:3340:odbc_process_tokens: returning result_type 4040 odbc.c:4569:SQLGetData(0x9385338, 3, 4, 0xbfd493c0, 4, (nil)) convert_tds2sql.c:62:convert_tds2sql: src is 56 dest = 4 odbc.c:3848:SQLFreeStmt(0x9385338, 0) odbc.c:3769:_SQLFreeStmt(0x9385338, 0, 0) query.c:1934:tds_send_cancel: not in_cancel and not idle query.c:1943:tds_send_cancel: sending cancel packet net.c:779:Sending packet 0000 06 01 00 08 00 00 00 00- |........| token.c:495:tds_process_tokens(0x93564f8, 0xbfd491cc, (nil), 0x0) util.c:162:Changed query state from PENDING to READING token.c:510:processing result tokens. marker is d1(ROW) token.c:2166:tds_process_row(): reading column 0 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is 13 token.c:2166:tds_process_row(): reading column 1 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 net.c:592:Received header 0000 04 01 00 54 00 33 02 00- |...T.3..| net.c:671:Received packet 0000 5d 00 04 10 00 00 00 01-27 01 27 00 02 01 00 00 |]....... '.'.....| 0010 00 03 00 00 00 00 00 0d-73 6d 61 6c 6c 64 61 74 |........ smalldat| 0020 65 74 69 6d 65 02 00 00-02 00 00 09 00 02 03 00 |etime... ........| 0030 00 00 02 16 00 ff 11 00-c1 00 02 00 00 00 79 00 |........ ......y.| 0040 00 00 00 fe 00 00 e0 00-02 00 00 00 |........ ....| token.c:2166:tds_process_row(): reading column 2 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 4 token.c:2166:tds_process_row(): reading column 3 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is 1 token.c:2166:tds_process_row(): reading column 4 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is 1 token.c:2166:tds_process_row(): reading column 5 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 6 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 7 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 8 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 9 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 10 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 11 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 12 token.c:1915:tds_get_data: type 39, varint size 1 token.c:1975:tds_get_data(): wire column size is 13 token.c:2166:tds_process_row(): reading column 13 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 14 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 15 token.c:1915:tds_get_data: type 52, varint size 0 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 16 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 token.c:2166:tds_process_row(): reading column 17 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 18 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is -1 token.c:2166:tds_process_row(): reading column 19 token.c:1915:tds_get_data: type 38, varint size 1 token.c:1975:tds_get_data(): wire column size is 2 token.c:510:processing result tokens. marker is ff(DONEINPROC) token.c:2201:tds_process_end: more_results = 1 was_cancelled = 0 error = 0 done_count_valid = 1 token.c:2232: rows_affected = 2 token.c:510:processing result tokens. marker is 79(RETURNSTATUS) token.c:645:tds_process_tokens: return status is 0 token.c:510:processing result tokens. marker is fe(DONEPROC) token.c:2201:tds_process_end: more_results = 0 was_cancelled = 0 error = 0 done_count_valid = 0 token.c:2232: rows_affected = 2 net.c:592:Received header 0000 04 01 00 11 00 33 01 00- |.....3..| net.c:671:Received packet 0000 fd 20 00 fd 00 00 00 00-00 |. ...... .| token.c:510:processing result tokens. marker is fd(DONE) token.c:2201:tds_process_end: more_results = 0 was_cancelled = 1 error = 0 done_count_valid = 0 token.c:2217:tds_process_end() state set to TDS_IDLE util.c:162:Changed query state from READING to IDLE token.c:2232: rows_affected = 0 odbc.c:5587:SQLGetInfo(0x93b9750, 18, 0xbfd484dc, 4096, 0xbfd484d8) odbc.c:4841:_SQLGetInfo(0x93b9750, 18, 0xbfd484dc, 4096, 0xbfd484d8 odbc.c:4388:SQLEndTran(2, 0x93b9750, 1) odbc.c:4366:_SQLTransact((nil), 0x93b9750, 1) odbc.c:4327:change_transaction(0x0x93b9750,0) mem.c:563:tds_free_all_results() util.c:162:Changed query state from IDLE to QUERYING util.c:162:Changed query state from QUERYING to PENDING net.c:779:Sending packet 0000 01 01 00 23 00 00 00 00-49 46 20 40 40 54 52 41 |...#.... IF @@TRA| 0010 4e 43 4f 55 4e 54 20 3e-20 30 20 52 4f 4c 4c 42 |NCOUNT > 0 ROLLB| 0020 41 43 4b - |ACK| token.c:495:tds_process_tokens(0x93564f8, 0xbfd4941c, 0xbfd49418, 0x100) util.c:162:Changed query state from PENDING to READING net.c:592:Received header 0000 04 01 00 23 00 33 01 00- |...#.3..| net.c:671:Received packet 0000 fd 01 00 c0 00 00 00 00-00 fd 01 00 d2 00 00 00 |........ ........| 0010 00 00 fd 00 00 ca 00 00-00 00 00 |........ ...| token.c:510:processing result tokens. marker is fd(DONE) token.c:2201:tds_process_end: more_results = 1 was_cancelled = 0 error = 0 done_count_valid = 0 token.c:2232: rows_affected = 0 util.c:162:Changed query state from READING to PENDING token.c:495:tds_process_tokens(0x93564f8, 0xbfd4941c, 0xbfd49418, 0x100) util.c:162:Changed query state from PENDING to READING token.c:510:processing result tokens. marker is fd(DONE) token.c:2201:tds_process_end: more_results = 1 was_cancelled = 0 error = 0 done_count_valid = 0 token.c:2232: rows_affected = 0 util.c:162:Changed query state from READING to PENDING token.c:495:tds_process_tokens(0x93564f8, 0xbfd4941c, 0xbfd49418, 0x100) util.c:162:Changed query state from PENDING to READING token.c:510:processing result tokens. marker is fd(DONE) token.c:2201:tds_process_end: more_results = 0 was_cancelled = 0 error = 0 done_count_valid = 0 token.c:2217:tds_process_end() state set to TDS_IDLE util.c:162:Changed query state from READING to IDLE token.c:2232: rows_affected = 0 util.c:110:logic error: cannot change query state from IDLE to PENDING token.c:495:tds_process_tokens(0x93564f8, 0xbfd4941c, 0xbfd49418, 0x100) token.c:498:tds_process_tokens() state is COMPLETED odbc.c:5587:SQLGetInfo(0x93b9750, 24, 0xbfd494e6, 8, 0xbfd494e4) odbc.c:4841:_SQLGetInfo(0x93b9750, 24, 0xbfd494e6, 8, 0xbfd494e4 odbc.c:2005:SQLDisconnect(0x93b9750) odbc.c:3769:_SQLFreeStmt(0x9385338, 1, 1) mem.c:563:tds_free_all_results() util.c:162:Changed query state from IDLE to DEAD odbc.c:3680:SQLFreeHandle(2, 0x0x93b9750) odbc.c:3706:_SQLFreeConnect(0x93b9750) odbc.c:3680:SQLFreeHandle(1, 0x0x92efc38) odbc.c:3744:_SQLFreeEnv(0x92efc38)
