Re: freetds - invalid cursor state
| Newsgroups | gmane.comp.db.tds.freetds |
|---|---|
| Message-ID | <[email protected]> |
Hello Frediano, I was busy with another tasks, but today I had some spare time so I've generated ODBC logs when using freetds and easysoft drivers. Both are attached. I would really apreciate if you can take a look at these logs and try to identify the root cause. I really would like to have this issue fixed. Thanks, Jakub ______________________________________________________________ > Od: Frediano Ziglio <[email protected]> > Komu: FreeTDS Development Group <[email protected]> > Datum: 13.02.2016 09:20 > Předmět: Re: [freetds] freetds - invalid cursor state > 2016-02-12 6:26 GMT+00:00 <[email protected]>: > Hi again, > I was investigating further a bit: > > 1) Have tried to use easysoft driver and tried to compare unixodbc log. Logs > are same except the log when easysoft driver is used does continue with > fetching of other data. > Could you post these logs? Frediano > 2) I have played with stored procedures and I have found that you do not > need to call second procedure with print, or raiserror, these commands can > be in one proc only. i.e.: > > Create procedure testproc as > select getdate() > print test > select getdate() > > The invalid cursor state is thrown only when you do attempt to fetch data > from procedure. > > This is fetching of first getdate of procedure: > odbc.c:3615:SQLExecute returns SQL_SUCCESS > odbc.c:4626:_SQLRowCount(0xb6130a0, 0xb612588), -1 rows > odbc.c:4637:SQLRowCount returns 0, row count -1 > odbc.c:4545:SQLNumResultCols(0xb6130a0, 0x7fff718bda50) > odbc.c:4545:SQLNumResultCols(0xb6130a0, 0x7fff718bd9f6) > odbc_export.h:195:SQLDescribeCol(0xb6130a0, 1, 0xb61d8d0, 128, 0xb61d870, > 0xb61d882, 0xb61d878, 0xb61d880, 0xb61d884) > odbc.c:2047:_SQLColAttribute(0xb6130a0, 1, 6, (nil), 0, (nil), 0xb61d890) > odbc.c:2089:SQLColAttribute: fDescType is 6 > odbc.c:2047:_SQLColAttribute(0xb6130a0, 1, 1003, (nil), 0, (nil), 0xb61d888) > odbc.c:2089:SQLColAttribute: fDescType is 1003 > odbc.c:1803:SQLBindCol(0xb6130a0, 1, 1, 0xb41c870, 24, 0xb61d8a8) > odbc.c:4033:SQLFetch(0xb6130a0) > odbc.c:3768:_SQLFetch(0xb6130a0, 1, 0) > token.c:549:tds_process_tokens(0xb5ce7d0, 0x7fff718bd794, 0x7fff718bd790, > 0x6508) > util.c:165:Changed query state from PENDING to READING > > When you try to fetch second getdate log continues with: > odbc.c:3697:odbc_process_tokens: processed TDS_DONEINPROC_RESULT > odbc.c:895:SQLMoreResults: result_type=4054, row_count=-1, lastrc=1 > error_export.h:6:SQLGetDiagRec(3, 0xb6130a0, 1, 0x7fff718bd870, > 0x7fff718bd88c, 0x7fff718bd670, 512, 0x7fff718bd888) > error.c:565:SQLGetDiagRec: "[FreeTDS][SQL Server]test" > error_export.h:6:SQLGetDiagRec(3, 0xb6130a0, 2, 0x7fff718bd870, > 0x7fff718bd88c, 0x7fff718bd670, 512, 0x7fff718bd888) > odbc.c:4263:SQLFreeStmt(0xb6130a0, 2) > odbc.c:4179:_SQLFreeStmt(0xb6130a0, 2, 0) > odbc.c:4545:SQLNumResultCols(0xb6130a0, 0x7fff718bd9d6) > odbc.c:4033:SQLFetch(0xb6130a0) > odbc.c:3768:_SQLFetch(0xb6130a0, 1, 0) > error.c:414:odbc_errs_add: "Invalid cursor state" > error_export.h:6:SQLGetDiagRec(3, 0xb6130a0, 1, 0x7fff718bd870, > 0x7fff718bd88c, 0x7fff718bd670, 512, 0x7fff718bd888) > error.c:565:SQLGetDiagRec: "[FreeTDS][SQL Server]Invalid cursor state" > error_export.h:6:SQLGetDiagRec(3, 0xb6130a0, 2, 0x7fff718bd870, > 0x7fff718bd88c, 0x7fff718bd670, 512, 0x7fff718bd888) > odbc.c:4263:SQLFreeStmt(0xb6130a0, 0) > odbc.c:4179:_SQLFreeStmt(0xb6130a0, 0, 0) > query.c:2189:tds_send_cancel: not in_cancel and not idle > > I have tried to rewrite the procedure: > > Create procedure testproc as > print test > select getdate() > select getdate() > > And the tracefile is different and procedure runs fine: > odbc.c:3615:SQLExecute returns SQL_SUCCESS_WITH_INFO > error_export.h:6:SQLGetDiagRec(3, 0x2e4b0b0, 1, 0x7fff9ea22de0, > 0x7fff9ea22dfc, 0x7fff9ea22be0, 512, 0x7fff9ea22df8) > error.c:565:SQLGetDiagRec: "[FreeTDS][SQL Server]test" > error_export.h:6:SQLGetDiagRec(3, 0x2e4b0b0, 2, 0x7fff9ea22de0, > 0x7fff9ea22dfc, 0x7fff9ea22be0, 512, 0x7fff9ea22df8) > odbc.c:4626:_SQLRowCount(0x2e4b0b0, 0x2e4a598), -1 rows > odbc.c:4637:SQLRowCount returns 0, row count -1 > odbc.c:4545:SQLNumResultCols(0x2e4b0b0, 0x7fff9ea22fa0) > odbc.c:4545:SQLNumResultCols(0x2e4b0b0, 0x7fff9ea22f46) > odbc_export.h:195:SQLDescribeCol(0x2e4b0b0, 1, 0x2e5a5d0, 128, 0x2e5a570, > 0x2e5a582, 0x2e5a578, 0x2e5a580, 0x2e5a584) > odbc.c:2047:_SQLColAttribute(0x2e4b0b0, 1, 6, (nil), 0, (nil), 0x2e5a590) > odbc.c:2089:SQLColAttribute: fDescType is 6 > odbc.c:2047:_SQLColAttribute(0x2e4b0b0, 1, 1003, (nil), 0, (nil), 0x2e5a588) > odbc.c:2089:SQLColAttribute: fDescType is 1003 > odbc.c:1803:SQLBindCol(0x2e4b0b0, 1, 1, 0x2c54880, 24, 0x2e5a5a8) > odbc.c:4033:SQLFetch(0x2e4b0b0) > odbc.c:3768:_SQLFetch(0x2e4b0b0, 1, 0) > token.c:549:tds_process_tokens(0x2e067e0, 0x7fff9ea22ce4, 0x7fff9ea22ce0, > 0x6508) > util.c:165:Changed query state from PENDING to READING > > The main difference is that SQLExecute returns SQL_SUCCESS_WITH_INFO, but in > case of failure it returns odbc.c:3615:SQLExecute returns SQL_SUCCESS > > Will this information be sufficient to get the issue fixed? Or do you want > some more information from me to help you with investigation? > Thanks & Regards, > JJ > > ______________________________________________________________ >> >> Od: <[email protected]> >> Komu: FreeTDS Development Group <[email protected]> >> Datum: 10.02.2016 08:57 >> >> Předmět: Re: [freetds] freetds - invalid cursor state >> > Hello Frediano, > > thank you for looking into this issue. In the meantime I will rebuild our > Perl::DBD to use latest unixODBC (2.3.4) nad let you know results. Please > let me know your findings about status of SQLNumResultCols and > SQLMoreResults when using Windows driver. > > Thank you, > JJ > > ______________________________________________________________ >> >> Od: Frediano Ziglio <[email protected]> >> Komu: FreeTDS Development Group <[email protected]> >> Datum: 10.02.2016 01:05 >> Předmět: Re: [freetds] freetds - invalid cursor state >> > 2016-02-09 20:22 GMT+00:00 <[email protected]>: >> >> >> Hi guys, we have to find some solution. >> >> We have perl script using DBD::ODBC to connect to MSSQL using unixODBC >> driver and FreeTDS. When we execute stored procedure and this stored >> procedure is executing another stored procedure with raiserror or print >> functions we get invalid cursor state error. >> >> i.e.: >> CREATE PROCEDURE [dbo].[dummyproc] as >> RAISERROR('test', 0, 0) >> return 0 >> >> CREATE PROCEDURE [dbo].[testproc] as >> select GETDATE() >> exec dummyproc >> select GETDATE() >> return 0 >> >> This happens ONLY when we try to fetch results from second getdate() >> function. >> i.e.: >> my $query = 'exec testproc'; >> my $sth = $dbh->prepare($query); >> $sth->execute || die "Error running query $query"; >> while ( my $d = $sth->fetchrow_arrayref ) { >> print Dumper $d; #should return first getdate() >> } >> while ( my $d = $sth->fetchrow_arrayref ) { >> print Dumper $d; #should return second getdate() >> } >> >> We’re using: >> Old perl 5.8.8. >> DBD::ODBC version 1.45 >> unixODBC 2.3.1 (also tried newest 2.3.4.) >> FreeTDS 0.91.dev.20110409RC1 (also tried FreeTDS 0.95.81) >> >> In case we use Easysoft database driver instead of FreeTDS the error does >> not appear. >> When I call out the procedure from tsql error does not appear. >> >> The log using latest FreeTDS can be found here: >> http://jezecek.dyndns.org/freetds.log <http://jezecek.dyndns.org/freetds.log> >> <http://jezecek.dyndns.org/freetds.log <http://jezecek.dyndns.org/freetds.log>> >> <http://jezecek.dyndns.org/freetds.log <http://jezecek.dyndns.org/freetds.log> >> <http://jezecek.dyndns.org/freetds.log <http://jezecek.dyndns.org/freetds.log>>> >> The unixODBC log (not sure it will help) can be found here: >> http://jezecek.dyndns.org/odbc.log <http://jezecek.dyndns.org/odbc.log> <http://jezecek.dyndns.org/odbc.log <http://jezecek.dyndns.org/odbc.log>> >> <http://jezecek.dyndns.org/odbc.log <http://jezecek.dyndns.org/odbc.log> <http://jezecek.dyndns.org/odbc.log <http://jezecek.dyndns.org/odbc.log>>> >> >> I would really really appreciate if you can let me know what to focus on. >> Thank you for any hints& supprt from you. >> >> Regards, >> JJ >> > > Does not look so weird. In ODBC 3 resultset can have no records, for > instance they can contains an error. You got an error in between two > recordsets with rows. It seems that DBD::ODBC calls > SQLFreeStmt(SQL_UNBIND) but this should not skip the error. > I'll check exactly in this condition what SQLNumResultCols and > SQLMoreResults returns with a Windows driver. I remember a similar > problem using an old unixODBC version. > > Frediano > _______________________________________________ > FreeTDS mailing list > [email protected] > http://lists.ibiblio.org/mailman/listinfo/freetds <http://lists.ibiblio.org/mailman/listinfo/freetds> > <http://lists.ibiblio.org/mailman/listinfo/freetds <http://lists.ibiblio.org/mailman/listinfo/freetds>> > <http://lists.ibiblio.org/mailman/listinfo/freetds <http://lists.ibiblio.org/mailman/listinfo/freetds> > <http://lists.ibiblio.org/mailman/listinfo/freetds <http://lists.ibiblio.org/mailman/listinfo/freetds>>> > > > _______________________________________________ > FreeTDS mailing list > [email protected] > http://lists.ibiblio.org/mailman/listinfo/freetds <http://lists.ibiblio.org/mailman/listinfo/freetds> > <http://lists.ibiblio.org/mailman/listinfo/freetds <http://lists.ibiblio.org/mailman/listinfo/freetds>> > > _______________________________________________ > FreeTDS mailing list > [email protected] > http://lists.ibiblio.org/mailman/listinfo/freetds <http://lists.ibiblio.org/mailman/listinfo/freetds> _______________________________________________ FreeTDS mailing list [email protected] http://lists.ibiblio.org/mailman/listinfo/freetds <http://lists.ibiblio.org/mailman/listinfo/freetds> _______________________________________________ FreeTDS mailing list [email protected] http://lists.ibiblio.org/mailman/listinfo/freetds
odbc_freetds.log
(text/x-log, 12.2 KB)
[ODBC][21590][1456398626.328756][__handles.c][460] Exit:[SQL_SUCCESS] Environment = 0xa6b43d0 [ODBC][21590][1456398626.328848][SQLSetEnvAttr.c][189] Entry: Environment = 0xa6b43d0 Attribute = SQL_ATTR_ODBC_VERSION Value = 0x3 StrLen = -6 [ODBC][21590][1456398626.328872][SQLSetEnvAttr.c][364] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.328896][SQLAllocHandle.c][375] Entry: Handle Type = 2 Input Handle = 0xa6b43d0 [ODBC][21590][1456398626.328919][SQLAllocHandle.c][493] Exit:[SQL_SUCCESS] Output Handle = 0xa6b4cd0 [ODBC][21590][1456398626.328958][SQLDriverConnect.c][728] Entry: Connection = 0xa6b4cd0 Window Hdl = (nil) Str In = [DSN=MSPointDev;APP=testTDS.pl;LogonTimeout=5000;UID=pntdbadm;PWD=***********][length = 76] Str Out = 0x7fff2ad0eba0 Str Out Max = 512 Str Out Ptr = 0x7fff2ad0eb9e Completion = 0 UNICODE Using encoding ASCII 'ANSI_X3.4-1968' and UNICODE 'UCS-2LE' [ODBC][21590][1456398626.469561][SQLDriverConnect.c][1697] Exit:[SQL_SUCCESS] Connection Out [DSN=MSPointDev;APP=testTDS.pl;LogonTimeout=5000;UID=pntdbadm;PWD...] [ODBC][21590][1456398626.469617][SQLSetConnectAttr.c][396] Entry: Connection = 0xa6b4cd0 Attribute = SQL_ATTR_AUTOCOMMIT Value = 0x1 StrLen = 0 [ODBC][21590][1456398626.469644][SQLSetConnectAttr.c][842] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.469672][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_DRIVER_ODBC_VER (77) Info Value = 0xa6b3d18 Buffer Length = 20 StrLen = 0x7fff2ad0eb9e [ODBC][21590][1456398626.469700][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.469722][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_DRIVER_NAME (6) Info Value = 0xa6b3da4 Buffer Length = 80 StrLen = 0x7fff2ad0eb9e [ODBC][21590][1456398626.469744][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.469766][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_DRIVER_VER (7) Info Value = 0xa6b3df4 Buffer Length = 20 StrLen = 0x7fff2ad0eb9e [ODBC][21590][1456398626.469789][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.469811][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_DBMS_NAME (17) Info Value = 0xa6b3e08 Buffer Length = 80 StrLen = 0x7fff2ad0eb9e [ODBC][21590][1456398626.469832][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.469861][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_DBMS_VER (18) Info Value = 0xa6b3e58 Buffer Length = 80 StrLen = 0x7fff2ad0eb9e [ODBC][21590][1456398626.469877][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.469892][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_MAX_COLUMN_NAME_LEN (30) Info Value = 0xa6b3d2c Buffer Length = 2 StrLen = 0x7fff2ad0eb9e [ODBC][21590][1456398626.469905][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.469920][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_CATALOG_NAME (10003) Info Value = 0x7fff2ad0eba0 Buffer Length = 10 StrLen = 0x7fff2ad0eb9e [ODBC][21590][1456398626.469934][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.469949][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_SCHEMA_USAGE (91) Info Value = 0xa6b3ec4 Buffer Length = 4 StrLen = 0x7fff2ad0eb9e [ODBC][21590][1456398626.469963][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.469979][SQLGetFunctions.c][151] Entry: Connection = 0xa6b4cd0 Id = SQLMoreResults Supported = 0x7fff2ad0eb9c [ODBC][21590][1456398626.469993][SQLGetFunctions.c][186] Exit:[SQL_SUCCESS] Supported = 0x7fff2ad0eb9c -> 1 [ODBC][21590][1456398626.470007][SQLGetFunctions.c][151] Entry: Connection = 0xa6b4cd0 Id = SQLDescribeParam Supported = 0x7fff2ad0eb9c [ODBC][21590][1456398626.470021][SQLGetFunctions.c][186] Exit:[SQL_SUCCESS] Supported = 0x7fff2ad0eb9c -> 0 [ODBC][21590][1456398626.470216][SQLSetConnectAttr.c][396] Entry: Connection = 0xa6b4cd0 Attribute = SQL_ATTR_AUTOCOMMIT Value = 0x1 StrLen = -5 [ODBC][21590][1456398626.470268][SQLSetConnectAttr.c][842] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.470425][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_DBMS_NAME (17) Info Value = 0xa7095b0 Buffer Length = 255 StrLen = 0x7fff2ad0efc6 [ODBC][21590][1456398626.470442][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.470464][SQLGetInfo.c][554] Entry: Connection = 0xa6b4cd0 Info Type = SQL_DBMS_NAME (17) Info Value = 0xa7095b0 Buffer Length = 255 StrLen = 0x7fff2ad0efc6 [ODBC][21590][1456398626.470479][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.470636][SQLAllocHandle.c][540] Entry: Handle Type = 3 Input Handle = 0xa6b4cd0 [ODBC][21590][1456398626.470668][SQLAllocHandle.c][1085] Exit:[SQL_SUCCESS] Output Handle = 0xa70a2b0 [ODBC][21590][1456398626.470692][SQLPrepare.c][196] Entry: Statement = 0xa70a2b0 SQL = [exec point..JJ_testproc][length = 23 (SQL_NTS)] [ODBC][21590][1456398626.470716][SQLPrepare.c][377] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.471251][SQLExecute.c][187] Entry: Statement = 0xa70a2b0 [ODBC][21590][1456398626.471945][SQLExecute.c][357] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.471975][SQLRowCount.c][173] Entry: Statement = 0xa70a2b0 Row Count = 0xa709dc8 [ODBC][21590][1456398626.471997][SQLRowCount.c][247] Exit:[SQL_SUCCESS] Row Count = 0xa709dc8 -> -1 [ODBC][21590][1456398626.472022][SQLNumResultCols.c][156] Entry: Statement = 0xa70a2b0 Column Count = 0x7fff2ad0f0f0 [ODBC][21590][1456398626.472044][SQLNumResultCols.c][251] Exit:[SQL_SUCCESS] Count = 0x7fff2ad0f0f0 -> 1 [ODBC][21590][1456398626.472069][SQLNumResultCols.c][156] Entry: Statement = 0xa70a2b0 Column Count = 0x7fff2ad0f096 [ODBC][21590][1456398626.472090][SQLNumResultCols.c][251] Exit:[SQL_SUCCESS] Count = 0x7fff2ad0f096 -> 1 [ODBC][21590][1456398626.472119][SQLDescribeCol.c][247] Entry: Statement = 0xa70a2b0 Column Number = 1 Column Name = 0xa7143e0 Buffer Length = 128 Name Length = 0xa714380 Data Type = 0xa714392 Column Size = 0xa714388 Decimal Digits = 0xa714390 Nullable = 0xa714394 [ODBC][21590][1456398626.472149][SQLDescribeCol.c][504] Exit:[SQL_SUCCESS] Column Name = [] Data Type = 0xa714392 -> 93 Column Size = 0xa714388 -> 23 Decimal Digits = 0xa714390 -> 3 Nullable = 0xa714394 -> 0 [ODBC][21590][1456398626.472177][SQLColAttribute.c][293] Entry: Statement = 0xa70a2b0 Column Number = 1 Field Identifier = SQL_DESC_DISPLAY_SIZE Character Attr = (nil) Buffer Length = 0 String Length = (nil) Numeric Attribute = 0xa7143a0 [ODBC][21590][1456398626.472200][SQLColAttribute.c][669] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.472222][SQLColAttribute.c][293] Entry: Statement = 0xa70a2b0 Column Number = 1 Field Identifier = SQL_DESC_LENGTH Character Attr = (nil) Buffer Length = 0 String Length = (nil) Numeric Attribute = 0xa714398 [ODBC][21590][1456398626.472242][SQLColAttribute.c][669] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.472291][SQLBindCol.c][236] Entry: Statement = 0xa70a2b0 Column Number = 1 Target Type = 1 SQL_CHAR Target Value = 0xa710890 Buffer Length = 24 StrLen Or Ind = 0xa7143b8 [ODBC][21590][1456398626.472306][SQLBindCol.c][344] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.472322][SQLFetch.c][162] Entry: Statement = 0xa70a2b0 [ODBC][21590][1456398626.472366][SQLFetch.c][351] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.472467][SQLFetch.c][162] Entry: Statement = 0xa70a2b0 [ODBC][21590][1456398626.472484][SQLFetch.c][351] Exit:[SQL_NO_DATA] [ODBC][21590][1456398626.472501][SQLMoreResults.c][162] Entry: Statement = 0xa70a2b0 [ODBC][21590][1456398626.472531][SQLMoreResults.c][345] Exit:[SQL_SUCCESS_WITH_INFO] DIAG [01000] [FreeTDS][SQL Server]test [ODBC][21590][1456398626.472577][SQLError.c][352] Entry: Statement = 0xa70a2b0 SQLState = 0x7fff2ad0ec50 Native = 0x7fff2ad0ec58 Message Text = 0x7fff2ad0ec60 Buffer Length = 1023 Text Len Ptr = 0x7fff2ad0ec5e [ODBC][21590][1456398626.472609][SQLError.c][389] Exit:[SQL_SUCCESS] SQLState = 01000 Native = 0x7fff2ad0ec58 -> 0 Message Text = [[FreeTDS][SQL Server]test] [ODBC][21590][1456398626.472858][SQLError.c][352] Entry: Statement = 0xa70a2b0 SQLState = 0x7fff2ad0ec50 Native = 0x7fff2ad0ec58 Message Text = 0x7fff2ad0ec60 Buffer Length = 1023 Text Len Ptr = 0x7fff2ad0ec5e [ODBC][21590][1456398626.472875][SQLError.c][389] Exit:[SQL_NO_DATA] [ODBC][21590][1456398626.472890][SQLError.c][434] Entry: Connection = 0xa6b4cd0 SQLState = 0x7fff2ad0ec50 Native = 0x7fff2ad0ec58 Message Text = 0x7fff2ad0ec60 Buffer Length = 1023 Text Len Ptr = 0x7fff2ad0ec5e [ODBC][21590][1456398626.472904][SQLError.c][471] Exit:[SQL_NO_DATA] [ODBC][21590][1456398626.472918][SQLError.c][514] Entry: Environment = 0xa6b43d0 SQLState = 0x7fff2ad0ec50 Native = 0x7fff2ad0ec58 Message Text = 0x7fff2ad0ec60 Buffer Length = 1023 Text Len Ptr = 0x7fff2ad0ec5e [ODBC][21590][1456398626.472932][SQLError.c][551] Exit:[SQL_NO_DATA] [ODBC][21590][1456398626.472957][SQLFreeStmt.c][144] Entry: Statement = 0xa70a2b0 Option = 2 [ODBC][21590][1456398626.472973][SQLFreeStmt.c][266] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.472988][SQLNumResultCols.c][156] Entry: Statement = 0xa70a2b0 Column Count = 0x7fff2ad0f076 [ODBC][21590][1456398626.473003][SQLNumResultCols.c][251] Exit:[SQL_SUCCESS] Count = 0x7fff2ad0f076 -> 0 [ODBC][21590][1456398626.473022][SQLFetch.c][162] Entry: Statement = 0xa70a2b0 [ODBC][21590][1456398626.473040][SQLFetch.c][351] Exit:[SQL_ERROR] DIAG [24000] [FreeTDS][SQL Server]Invalid cursor state [ODBC][21590][1456398626.473074][SQLError.c][352] Entry: Statement = 0xa70a2b0 SQLState = 0x7fff2ad0ec50 Native = 0x7fff2ad0ec58 Message Text = 0x7fff2ad0ec60 Buffer Length = 1023 Text Len Ptr = 0x7fff2ad0ec5e [ODBC][21590][1456398626.473093][SQLError.c][389] Exit:[SQL_SUCCESS] SQLState = 24000 Native = 0x7fff2ad0ec58 -> 0 Message Text = [[FreeTDS][SQL Server]Invalid cursor state] [ODBC][21590][1456398626.473165][SQLError.c][352] Entry: Statement = 0xa70a2b0 SQLState = 0x7fff2ad0ec50 Native = 0x7fff2ad0ec58 Message Text = 0x7fff2ad0ec60 Buffer Length = 1023 Text Len Ptr = 0x7fff2ad0ec5e [ODBC][21590][1456398626.473180][SQLError.c][389] Exit:[SQL_NO_DATA] [ODBC][21590][1456398626.473195][SQLError.c][434] Entry: Connection = 0xa6b4cd0 SQLState = 0x7fff2ad0ec50 Native = 0x7fff2ad0ec58 Message Text = 0x7fff2ad0ec60 Buffer Length = 1023 Text Len Ptr = 0x7fff2ad0ec5e [ODBC][21590][1456398626.473209][SQLError.c][471] Exit:[SQL_NO_DATA] [ODBC][21590][1456398626.473223][SQLError.c][514] Entry: Environment = 0xa6b43d0 SQLState = 0x7fff2ad0ec50 Native = 0x7fff2ad0ec58 Message Text = 0x7fff2ad0ec60 Buffer Length = 1023 Text Len Ptr = 0x7fff2ad0ec5e [ODBC][21590][1456398626.473236][SQLError.c][551] Exit:[SQL_NO_DATA] [ODBC][21590][1456398626.474209][SQLFreeStmt.c][144] Entry: Statement = 0xa70a2b0 Option = 0 [ODBC][21590][1456398626.474575][SQLFreeStmt.c][266] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.474599][SQLFreeHandle.c][381] Entry: Handle Type = 3 Input Handle = 0xa70a2b0 [ODBC][21590][1456398626.474907][SQLFreeHandle.c][494] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.474941][SQLGetConnectAttr.c][292] Entry: Connection = 0xa6b4cd0 Attribute = SQL_ATTR_AUTOCOMMIT Value = 0x7fff2ad0eddc Buffer Length = -5 StrLen = (nil) [ODBC][21590][1456398626.474958][SQLGetConnectAttr.c][758] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.474975][SQLDisconnect.c][208] Entry: Connection = 0xa6b4cd0 [ODBC][21590][1456398626.475046][SQLDisconnect.c][379] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.475062][SQLFreeHandle.c][284] Entry: Handle Type = 2 Input Handle = 0xa6b4cd0 [ODBC][21590][1456398626.475094][SQLFreeHandle.c][333] Exit:[SQL_SUCCESS] [ODBC][21590][1456398626.475109][SQLFreeHandle.c][219] Entry: Handle Type = 1 Input Handle = 0xa6b43d0
odbc_easysoft.log
(text/x-log, 14.6 KB)
[ODBC][24495][1456398798.749151][__handles.c][460] Exit:[SQL_SUCCESS] Environment = 0x100de3d0 [ODBC][24495][1456398798.749241][SQLSetEnvAttr.c][189] Entry: Environment = 0x100de3d0 Attribute = SQL_ATTR_ODBC_VERSION Value = 0x3 StrLen = -6 [ODBC][24495][1456398798.749257][SQLSetEnvAttr.c][364] Exit:[SQL_SUCCESS] [ODBC][24495][1456398798.749273][SQLAllocHandle.c][375] Entry: Handle Type = 2 Input Handle = 0x100de3d0 [ODBC][24495][1456398798.749290][SQLAllocHandle.c][493] Exit:[SQL_SUCCESS] Output Handle = 0x100decd0 [ODBC][24495][1456398798.749317][SQLDriverConnect.c][728] Entry: Connection = 0x100decd0 Window Hdl = (nil) Str In = [DSN=MSPointDev;APP=testTDS.pl;LogonTimeout=5000;UID=pntdbadm;PWD=***********][length = 76] Str Out = 0x7fff8ee4f110 Str Out Max = 512 Str Out Ptr = 0x7fff8ee4f10e Completion = 0 UNICODE Using encoding ASCII 'ANSI_X3.4-1968' and UNICODE 'UCS-2LE' DIAG [01000] [Easysoft][SQL Server Driver][SQL Server]Changed database context to 'point'. DIAG [01000] [Easysoft][SQL Server Driver][SQL Server]Changed language setting to us_english. [ODBC][24495][1456398799.077854][SQLDriverConnect.c][1697] Exit:[SQL_SUCCESS_WITH_INFO] Connection Out [DSN=MSPointDev;UID=pntdbadm;PWD=pntdbadm778;SERVER=NYKDCM05673V0...] [ODBC][24495][1456398799.077911][SQLError.c][434] Entry: Connection = 0x100decd0 SQLState = 0x7fff8ee4ec60 Native = 0x7fff8ee4ec68 Message Text = 0x7fff8ee4ec70 Buffer Length = 1023 Text Len Ptr = 0x7fff8ee4ec6e [ODBC][24495][1456398799.077945][SQLError.c][471] Exit:[SQL_SUCCESS] SQLState = 01000 Native = 0x7fff8ee4ec68 -> 5701 Message Text = [[unixODBC][Easysoft][SQL Server Driver][SQL Server]Changed database context to 'point'.] [ODBC][24495][1456398799.077978][SQLError.c][434] Entry: Connection = 0x100decd0 SQLState = 0x7fff8ee4ec60 Native = 0x7fff8ee4ec68 Message Text = 0x7fff8ee4ec70 Buffer Length = 1023 Text Len Ptr = 0x7fff8ee4ec6e [ODBC][24495][1456398799.077995][SQLError.c][471] Exit:[SQL_SUCCESS] SQLState = 01000 Native = 0x7fff8ee4ec68 -> 5703 Message Text = [[unixODBC][Easysoft][SQL Server Driver][SQL Server]Changed language setting to us_english.] [ODBC][24495][1456398799.078019][SQLError.c][434] Entry: Connection = 0x100decd0 SQLState = 0x7fff8ee4ec60 Native = 0x7fff8ee4ec68 Message Text = 0x7fff8ee4ec70 Buffer Length = 1023 Text Len Ptr = 0x7fff8ee4ec6e [ODBC][24495][1456398799.078032][SQLError.c][471] Exit:[SQL_NO_DATA] [ODBC][24495][1456398799.078047][SQLError.c][514] Entry: Environment = 0x100de3d0 SQLState = 0x7fff8ee4ec60 Native = 0x7fff8ee4ec68 Message Text = 0x7fff8ee4ec70 Buffer Length = 1023 Text Len Ptr = 0x7fff8ee4ec6e [ODBC][24495][1456398799.078060][SQLError.c][551] Exit:[SQL_NO_DATA] [ODBC][24495][1456398799.078080][SQLSetConnectAttr.c][396] Entry: Connection = 0x100decd0 Attribute = SQL_ATTR_AUTOCOMMIT Value = 0x1 StrLen = 0 [ODBC][24495][1456398799.078100][SQLSetConnectAttr.c][842] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078118][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_DRIVER_ODBC_VER (77) Info Value = 0x100ddd18 Buffer Length = 20 StrLen = 0x7fff8ee4f10e [ODBC][24495][1456398799.078138][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078154][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_DRIVER_NAME (6) Info Value = 0x100ddda4 Buffer Length = 80 StrLen = 0x7fff8ee4f10e [ODBC][24495][1456398799.078169][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078184][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_DRIVER_VER (7) Info Value = 0x100dddf4 Buffer Length = 20 StrLen = 0x7fff8ee4f10e [ODBC][24495][1456398799.078198][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078212][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_DBMS_NAME (17) Info Value = 0x100dde08 Buffer Length = 80 StrLen = 0x7fff8ee4f10e [ODBC][24495][1456398799.078244][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078261][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_DBMS_VER (18) Info Value = 0x100dde58 Buffer Length = 80 StrLen = 0x7fff8ee4f10e [ODBC][24495][1456398799.078275][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078289][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_MAX_COLUMN_NAME_LEN (30) Info Value = 0x100ddd2c Buffer Length = 2 StrLen = 0x7fff8ee4f10e [ODBC][24495][1456398799.078303][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078317][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_CATALOG_NAME (10003) Info Value = 0x7fff8ee4f110 Buffer Length = 10 StrLen = 0x7fff8ee4f10e [ODBC][24495][1456398799.078331][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078345][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_SCHEMA_USAGE (91) Info Value = 0x100ddec4 Buffer Length = 4 StrLen = 0x7fff8ee4f10e [ODBC][24495][1456398799.078358][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078374][SQLGetFunctions.c][151] Entry: Connection = 0x100decd0 Id = SQLMoreResults Supported = 0x7fff8ee4f10c [ODBC][24495][1456398799.078387][SQLGetFunctions.c][186] Exit:[SQL_SUCCESS] Supported = 0x7fff8ee4f10c -> 1 [ODBC][24495][1456398799.078401][SQLGetFunctions.c][151] Entry: Connection = 0x100decd0 Id = SQLDescribeParam Supported = 0x7fff8ee4f10c [ODBC][24495][1456398799.078414][SQLGetFunctions.c][186] Exit:[SQL_SUCCESS] Supported = 0x7fff8ee4f10c -> 1 [ODBC][24495][1456398799.078667][SQLSetConnectAttr.c][396] Entry: Connection = 0x100decd0 Attribute = SQL_ATTR_AUTOCOMMIT Value = 0x1 StrLen = -5 [ODBC][24495][1456398799.078683][SQLSetConnectAttr.c][842] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078903][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_DBMS_NAME (17) Info Value = 0x100f3c60 Buffer Length = 255 StrLen = 0x7fff8ee4f536 [ODBC][24495][1456398799.078919][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.078942][SQLGetInfo.c][554] Entry: Connection = 0x100decd0 Info Type = SQL_DBMS_NAME (17) Info Value = 0x100f3c60 Buffer Length = 255 StrLen = 0x7fff8ee4f536 [ODBC][24495][1456398799.078957][SQLGetInfo.c][617] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.079190][SQLAllocHandle.c][540] Entry: Handle Type = 3 Input Handle = 0x100decd0 [ODBC][24495][1456398799.079220][SQLAllocHandle.c][1085] Exit:[SQL_SUCCESS] Output Handle = 0x100f6c80 [ODBC][24495][1456398799.079241][SQLPrepare.c][196] Entry: Statement = 0x100f6c80 SQL = [exec point..JJ_testproc][length = 23 (SQL_NTS)] [ODBC][24495][1456398799.079275][SQLPrepare.c][377] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.080053][SQLExecute.c][187] Entry: Statement = 0x100f6c80 [ODBC][24495][1456398799.081156][SQLExecute.c][357] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.081185][SQLRowCount.c][173] Entry: Statement = 0x100f6c80 Row Count = 0x100f4478 [ODBC][24495][1456398799.081211][SQLRowCount.c][247] Exit:[SQL_SUCCESS] Row Count = 0x100f4478 -> -1 [ODBC][24495][1456398799.081236][SQLNumResultCols.c][156] Entry: Statement = 0x100f6c80 Column Count = 0x7fff8ee4f660 [ODBC][24495][1456398799.081260][SQLNumResultCols.c][251] Exit:[SQL_SUCCESS] Count = 0x7fff8ee4f660 -> 1 [ODBC][24495][1456398799.081284][SQLNumResultCols.c][156] Entry: Statement = 0x100f6c80 Column Count = 0x7fff8ee4f606 [ODBC][24495][1456398799.081304][SQLNumResultCols.c][251] Exit:[SQL_SUCCESS] Count = 0x7fff8ee4f606 -> 1 [ODBC][24495][1456398799.081333][SQLDescribeCol.c][247] Entry: Statement = 0x100f6c80 Column Number = 1 Column Name = 0x101018e0 Buffer Length = 128 Name Length = 0x10101880 Data Type = 0x10101892 Column Size = 0x10101888 Decimal Digits = 0x10101890 Nullable = 0x10101894 [ODBC][24495][1456398799.081363][SQLDescribeCol.c][504] Exit:[SQL_SUCCESS] Column Name = [] Data Type = 0x10101892 -> 93 Column Size = 0x10101888 -> 23 Decimal Digits = 0x10101890 -> 3 Nullable = 0x10101894 -> 0 [ODBC][24495][1456398799.081407][SQLColAttribute.c][293] Entry: Statement = 0x100f6c80 Column Number = 1 Field Identifier = SQL_DESC_DISPLAY_SIZE Character Attr = (nil) Buffer Length = 0 String Length = (nil) Numeric Attribute = 0x101018a0 [ODBC][24495][1456398799.081425][SQLColAttribute.c][669] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.081439][SQLColAttribute.c][293] Entry: Statement = 0x100f6c80 Column Number = 1 Field Identifier = SQL_DESC_LENGTH Character Attr = (nil) Buffer Length = 0 String Length = (nil) Numeric Attribute = 0x10101898 [ODBC][24495][1456398799.081453][SQLColAttribute.c][669] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.081484][SQLBindCol.c][236] Entry: Statement = 0x100f6c80 Column Number = 1 Target Type = 1 SQL_CHAR Target Value = 0x100fdf70 Buffer Length = 24 StrLen Or Ind = 0x101018b8 [ODBC][24495][1456398799.081507][SQLBindCol.c][344] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.081522][SQLFetch.c][162] Entry: Statement = 0x100f6c80 [ODBC][24495][1456398799.081569][SQLFetch.c][351] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.081712][SQLFetch.c][162] Entry: Statement = 0x100f6c80 [ODBC][24495][1456398799.081729][SQLFetch.c][351] Exit:[SQL_NO_DATA] [ODBC][24495][1456398799.081749][SQLMoreResults.c][162] Entry: Statement = 0x100f6c80 [ODBC][24495][1456398799.081792][SQLMoreResults.c][345] Exit:[SQL_SUCCESS_WITH_INFO] DIAG [01000] [Easysoft][SQL Server Driver 10.0][SQL Server]test [ODBC][24495][1456398799.081826][SQLError.c][352] Entry: Statement = 0x100f6c80 SQLState = 0x7fff8ee4f1c0 Native = 0x7fff8ee4f1c8 Message Text = 0x7fff8ee4f1d0 Buffer Length = 1023 Text Len Ptr = 0x7fff8ee4f1ce [ODBC][24495][1456398799.081844][SQLError.c][389] Exit:[SQL_SUCCESS] SQLState = 01000 Native = 0x7fff8ee4f1c8 -> 0 Message Text = [[Easysoft][SQL Server Driver 10.0][SQL Server]test] [ODBC][24495][1456398799.082080][SQLError.c][352] Entry: Statement = 0x100f6c80 SQLState = 0x7fff8ee4f1c0 Native = 0x7fff8ee4f1c8 Message Text = 0x7fff8ee4f1d0 Buffer Length = 1023 Text Len Ptr = 0x7fff8ee4f1ce [ODBC][24495][1456398799.082095][SQLError.c][389] Exit:[SQL_NO_DATA] [ODBC][24495][1456398799.082110][SQLError.c][434] Entry: Connection = 0x100decd0 SQLState = 0x7fff8ee4f1c0 Native = 0x7fff8ee4f1c8 Message Text = 0x7fff8ee4f1d0 Buffer Length = 1023 Text Len Ptr = 0x7fff8ee4f1ce [ODBC][24495][1456398799.082123][SQLError.c][471] Exit:[SQL_NO_DATA] [ODBC][24495][1456398799.082137][SQLError.c][514] Entry: Environment = 0x100de3d0 SQLState = 0x7fff8ee4f1c0 Native = 0x7fff8ee4f1c8 Message Text = 0x7fff8ee4f1d0 Buffer Length = 1023 Text Len Ptr = 0x7fff8ee4f1ce [ODBC][24495][1456398799.082151][SQLError.c][551] Exit:[SQL_NO_DATA] [ODBC][24495][1456398799.082174][SQLFreeStmt.c][144] Entry: Statement = 0x100f6c80 Option = 2 [ODBC][24495][1456398799.082193][SQLFreeStmt.c][266] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.082207][SQLNumResultCols.c][156] Entry: Statement = 0x100f6c80 Column Count = 0x7fff8ee4f5e6 [ODBC][24495][1456398799.082221][SQLNumResultCols.c][251] Exit:[SQL_SUCCESS] Count = 0x7fff8ee4f5e6 -> 1 [ODBC][24495][1456398799.082237][SQLDescribeCol.c][247] Entry: Statement = 0x100f6c80 Column Number = 1 Column Name = 0x10101b50 Buffer Length = 128 Name Length = 0x100f6af0 Data Type = 0x100f6b02 Column Size = 0x100f6af8 Decimal Digits = 0x100f6b00 Nullable = 0x100f6b04 [ODBC][24495][1456398799.082254][SQLDescribeCol.c][504] Exit:[SQL_SUCCESS] Column Name = [] Data Type = 0x100f6b02 -> 93 Column Size = 0x100f6af8 -> 23 Decimal Digits = 0x100f6b00 -> 3 Nullable = 0x100f6b04 -> 0 [ODBC][24495][1456398799.082278][SQLColAttribute.c][293] Entry: Statement = 0x100f6c80 Column Number = 1 Field Identifier = SQL_DESC_DISPLAY_SIZE Character Attr = (nil) Buffer Length = 0 String Length = (nil) Numeric Attribute = 0x100f6b10 [ODBC][24495][1456398799.082292][SQLColAttribute.c][669] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.082306][SQLColAttribute.c][293] Entry: Statement = 0x100f6c80 Column Number = 1 Field Identifier = SQL_DESC_LENGTH Character Attr = (nil) Buffer Length = 0 String Length = (nil) Numeric Attribute = 0x100f6b08 [ODBC][24495][1456398799.082319][SQLColAttribute.c][669] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.082337][SQLBindCol.c][236] Entry: Statement = 0x100f6c80 Column Number = 1 Target Type = 1 SQL_CHAR Target Value = 0x10102260 Buffer Length = 24 StrLen Or Ind = 0x100f6b28 [ODBC][24495][1456398799.082353][SQLBindCol.c][344] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.082366][SQLFetch.c][162] Entry: Statement = 0x100f6c80 [ODBC][24495][1456398799.082383][SQLFetch.c][351] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.082457][SQLFetch.c][162] Entry: Statement = 0x100f6c80 [ODBC][24495][1456398799.082473][SQLFetch.c][351] Exit:[SQL_NO_DATA] [ODBC][24495][1456398799.082486][SQLMoreResults.c][162] Entry: Statement = 0x100f6c80 [ODBC][24495][1456398799.082501][SQLMoreResults.c][345] Exit:[SQL_NO_DATA] [ODBC][24495][1456398799.082516][SQLFreeStmt.c][144] Entry: Statement = 0x100f6c80 Option = 0 [ODBC][24495][1456398799.082530][SQLFreeStmt.c][266] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.082592][SQLFreeHandle.c][381] Entry: Handle Type = 3 Input Handle = 0x100f6c80 [ODBC][24495][1456398799.082975][SQLFreeHandle.c][494] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.083019][SQLGetConnectAttr.c][292] Entry: Connection = 0x100decd0 Attribute = SQL_ATTR_AUTOCOMMIT Value = 0x7fff8ee4f40c Buffer Length = -5 StrLen = (nil) [ODBC][24495][1456398799.083044][SQLGetConnectAttr.c][758] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.083066][SQLDisconnect.c][208] Entry: Connection = 0x100decd0 [ODBC][24495][1456398799.083130][SQLDisconnect.c][379] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.083152][SQLFreeHandle.c][284] Entry: Handle Type = 2 Input Handle = 0x100decd0 [ODBC][24495][1456398799.083175][SQLFreeHandle.c][333] Exit:[SQL_SUCCESS] [ODBC][24495][1456398799.083219][SQLFreeHandle.c][219] Entry: Handle Type = 1 Input Handle = 0x100de3d0