odbc-store/odbc-store.cpp

   1 /**
   2  * Licensed to the University Corporation for Advanced Internet
   3  * Development, Inc. (UCAID) under one or more contributor license
   4  * agreements. See the NOTICE file distributed with this work for
   5  * additional information regarding copyright ownership.
   6  *
   7  * UCAID licenses this file to you under the Apache License,
   8  * Version 2.0 (the "License"); you may not use this file except
   9  * in compliance with the License. You may obtain a copy of the
  10  * License at
  11  *
  12  * http://www.apache.org/licenses/LICENSE-2.0
  13  *
  14  * Unless required by applicable law or agreed to in writing,
  15  * software distributed under the License is distributed on an
  16  * "AS IS" BASIS, WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND,
  17  * either express or implied. See the License for the specific
  18  * language governing permissions and limitations under the License.
  19  */
  20
  21 /**
  22  * odbc-store.cpp
  23  *
  24  * Storage Service using ODBC.
  25  */
  26
  27 #if defined (_MSC_VER) || defined(__BORLANDC__)
  28 # include "config_win32.h"
  29 #else
  30 # include "config.h"
  31 #endif
  32
  33 #ifdef WIN32
  34 # define _CRT_NONSTDC_NO_DEPRECATE 1
  35 # define _CRT_SECURE_NO_DEPRECATE 1
  36 #endif
  37
  38 #ifdef WIN32
  39 # define ODBCSTORE_EXPORTS __declspec(dllexport)
  40 #else
  41 # define ODBCSTORE_EXPORTS
  42 #endif
  43
  44 #include <xmltooling/logging.h>
  45 #include <xmltooling/unicode.h>
  46 #include <xmltooling/XMLToolingConfig.h>
  47 #include <xmltooling/util/NDC.h>
  48 #include <xmltooling/util/StorageService.h>
  49 #include <xmltooling/util/Threads.h>
  50 #include <xmltooling/util/XMLHelper.h>
  51 #include <xercesc/util/XMLUniDefs.hpp>
  52
  53 #include <sql.h>
  54 #include <sqlext.h>
  55
  56 #include <boost/lexical_cast.hpp>
  57 #include <boost/algorithm/string.hpp>
  58
  59 using namespace xmltooling::logging;
  60 using namespace xmltooling;
  61 using namespace xercesc;
  62 using namespace boost;
  63 using namespace std;
  64
  65 #define PLUGIN_VER_MAJOR 1
  66 #define PLUGIN_VER_MINOR 1
  67
  68 #define LONGDATA_BUFLEN 16384
  69
  70 #define COLSIZE_CONTEXT 255
  71 #define COLSIZE_ID 255
  72 #define COLSIZE_STRING_VALUE 255
  73
  74 #define STRING_TABLE "strings"
  75 #define TEXT_TABLE "texts"
  76
  77 /* table definitions
  78 CREATE TABLE version (
  79     major int NOT nullptr,
  80     minor int NOT nullptr
  81     )
  82
  83 CREATE TABLE strings (
  84     context varchar(255) not null,
  85     id varchar(255) not null,
  86     expires datetime not null,
  87     version int not null,
  88     value varchar(255) not null,
  89     PRIMARY KEY (context, id)
  90     )
  91
  92 CREATE TABLE texts (
  93     context varchar(255) not null,
  94     id varchar(255) not null,
  95     expires datetime not null,
  96     version int not null,
  97     value text not null,
  98     PRIMARY KEY (context, id)
  99     )
 100 */
 101
 102 namespace {
 103     static const XMLCh cleanupInterval[] =  UNICODE_LITERAL_15(c,l,e,a,n,u,p,I,n,t,e,r,v,a,l);
 104     static const XMLCh isolationLevel[] =   UNICODE_LITERAL_14(i,s,o,l,a,t,i,o,n,L,e,v,e,l);
 105     static const XMLCh ConnectionString[] = UNICODE_LITERAL_16(C,o,n,n,e,c,t,i,o,n,S,t,r,i,n,g);
 106     static const XMLCh RetryOnError[] =     UNICODE_LITERAL_12(R,e,t,r,y,O,n,E,r,r,o,r);
 107     static const XMLCh contextSize[] =      UNICODE_LITERAL_11(c,o,n,t,e,x,t,S,i,z,e);
 108     static const XMLCh keySize[] =          UNICODE_LITERAL_7(k,e,y,S,i,z,e);
 109     static const XMLCh stringSize[] =       UNICODE_LITERAL_10(s,t,r,i,n,g,S,i,z,e);
 110
 111     // RAII for ODBC handles
 112     struct ODBCConn {
 113         ODBCConn(SQLHDBC conn) : handle(conn), autoCommit(true) {}
 114         ~ODBCConn() {
 115             if (handle != SQL_NULL_HDBC) {
 116                 SQLRETURN sr = SQL_SUCCESS;
 117                 if (!autoCommit)
 118                     sr = SQLSetConnectAttr(handle, SQL_ATTR_AUTOCOMMIT, (SQLPOINTER)SQL_AUTOCOMMIT_ON, 0);
 119                 SQLDisconnect(handle);
 120                 SQLFreeHandle(SQL_HANDLE_DBC, handle);
 121                 if (!SQL_SUCCEEDED(sr))
 122                     throw IOException("Failed to commit connection and return to auto-commit mode.");
 123             }
 124         }
 125         operator SQLHDBC() {return handle;}
 126         SQLHDBC handle;
 127         bool autoCommit;
 128     };
 129
 130     class ODBCStorageService : public StorageService
 131     {
 132     public:
 133         ODBCStorageService(const DOMElement* e);
 134         virtual ~ODBCStorageService();
 135
 136         const Capabilities& getCapabilities() const {
 137             return m_caps;
 138         }
 139
 140         bool createString(const char* context, const char* key, const char* value, time_t expiration) {
 141             return createRow(STRING_TABLE, context, key, value, expiration);
 142         }
 143         int readString(const char* context, const char* key, string* pvalue=nullptr, time_t* pexpiration=nullptr, int version=0) {
 144             return readRow(STRING_TABLE, context, key, pvalue, pexpiration, version);
 145         }
 146         int updateString(const char* context, const char* key, const char* value=nullptr, time_t expiration=0, int version=0) {
 147             return updateRow(STRING_TABLE, context, key, value, expiration, version);
 148         }
 149         bool deleteString(const char* context, const char* key) {
 150             return deleteRow(STRING_TABLE, context, key);
 151         }
 152
 153         bool createText(const char* context, const char* key, const char* value, time_t expiration) {
 154             return createRow(TEXT_TABLE, context, key, value, expiration);
 155         }
 156         int readText(const char* context, const char* key, string* pvalue=nullptr, time_t* pexpiration=nullptr, int version=0) {
 157             return readRow(TEXT_TABLE, context, key, pvalue, pexpiration, version);
 158         }
 159         int updateText(const char* context, const char* key, const char* value=nullptr, time_t expiration=0, int version=0) {
 160             return updateRow(TEXT_TABLE, context, key, value, expiration, version);
 161         }
 162         bool deleteText(const char* context, const char* key) {
 163             return deleteRow(TEXT_TABLE, context, key);
 164         }
 165
 166         void reap(const char* context) {
 167             reap(STRING_TABLE, context);
 168             reap(TEXT_TABLE, context);
 169         }
 170
 171         void updateContext(const char* context, time_t expiration) {
 172             updateContext(STRING_TABLE, context, expiration);
 173             updateContext(TEXT_TABLE, context, expiration);
 174         }
 175
 176         void deleteContext(const char* context) {
 177             deleteContext(STRING_TABLE, context);
 178             deleteContext(TEXT_TABLE, context);
 179         }
 180
 181
 182     private:
 183         bool createRow(const char *table, const char* context, const char* key, const char* value, time_t expiration);
 184         int readRow(const char *table, const char* context, const char* key, string* pvalue, time_t* pexpiration, int version);
 185         int updateRow(const char *table, const char* context, const char* key, const char* value, time_t expiration, int version);
 186         bool deleteRow(const char *table, const char* context, const char* key);
 187
 188         void reap(const char* table, const char* context);
 189         void updateContext(const char* table, const char* context, time_t expiration);
 190         void deleteContext(const char* table, const char* context);
 191
 192         SQLHDBC getHDBC();
 193         SQLHSTMT getHSTMT(SQLHDBC);
 194         pair<SQLINTEGER,SQLINTEGER> getVersion(SQLHDBC);
 195         pair<bool,bool> log_error(SQLHANDLE handle, SQLSMALLINT htype, const char* checkfor=nullptr);
 196
 197         static void* cleanup_fn(void*);
 198         void cleanup();
 199
 200         Category& m_log;
 201         Capabilities m_caps;
 202         int m_cleanupInterval;
 203         scoped_ptr<CondWait> shutdown_wait;
 204         Thread* cleanup_thread;
 205         bool shutdown;
 206
 207         SQLHENV m_henv;
 208         string m_connstring;
 209         long m_isolation;
 210         bool m_wideVersion;
 211         vector<SQLINTEGER> m_retries;
 212     };
 213
 214     StorageService* ODBCStorageServiceFactory(const DOMElement* const & e)
 215     {
 216         return new ODBCStorageService(e);
 217     }
 218
 219     // convert SQL timestamp to time_t
 220     time_t timeFromTimestamp(SQL_TIMESTAMP_STRUCT expires)
 221     {
 222         time_t ret;
 223         struct tm t;
 224         t.tm_sec=expires.second;
 225         t.tm_min=expires.minute;
 226         t.tm_hour=expires.hour;
 227         t.tm_mday=expires.day;
 228         t.tm_mon=expires.month-1;
 229         t.tm_year=expires.year-1900;
 230         t.tm_isdst=0;
 231 #if defined(HAVE_TIMEGM)
 232         ret = timegm(&t);
 233 #else
 234         ret = mktime(&t) - timezone;
 235 #endif
 236         return (ret);
 237     }
 238
 239     // conver time_t to SQL string
 240     void timestampFromTime(time_t t, char* ret)
 241     {
 242 #ifdef HAVE_GMTIME_R
 243         struct tm res;
 244         struct tm* ptime=gmtime_r(&t,&res);
 245 #else
 246         struct tm* ptime=gmtime(&t);
 247 #endif
 248         strftime(ret,32,"{ts '%Y-%m-%d %H:%M:%S'}",ptime);
 249     }
 250
 251     class SQLString {
 252         const char* m_src;
 253         string m_copy;
 254     public:
 255         SQLString(const char* src) : m_src(src) {
 256             if (strchr(src, '\'')) {
 257                 m_copy = src;
 258                 replace_all(m_copy, "'", "''");
 259             }
 260         }
 261
 262         operator const char*() const {
 263             return tostr();
 264         }
 265
 266         const char* tostr() const {
 267             return m_copy.empty() ? m_src : m_copy.c_str();
 268         }
 269     };
 270 };
 271
 272 ODBCStorageService::ODBCStorageService(const DOMElement* e) : m_log(Category::getInstance("XMLTooling.StorageService")),
 273     m_caps(XMLHelper::getAttrInt(e, 255, contextSize), XMLHelper::getAttrInt(e, 255, keySize), XMLHelper::getAttrInt(e, 255, stringSize)),
 274     m_cleanupInterval(XMLHelper::getAttrInt(e, 900, cleanupInterval)),
 275     cleanup_thread(nullptr), shutdown(false), m_henv(SQL_NULL_HENV), m_isolation(SQL_TXN_SERIALIZABLE), m_wideVersion(false)
 276 {
 277 #ifdef _DEBUG
 278     xmltooling::NDC ndc("ODBCStorageService");
 279 #endif
 280     string iso(XMLHelper::getAttrString(e, "SERIALIZABLE", isolationLevel));
 281     if (iso == "SERIALIZABLE")
 282         m_isolation = SQL_TXN_SERIALIZABLE;
 283     else if (iso == "REPEATABLE_READ")
 284         m_isolation = SQL_TXN_REPEATABLE_READ;
 285     else if (iso == "READ_COMMITTED")
 286         m_isolation = SQL_TXN_READ_COMMITTED;
 287     else if (iso == "READ_UNCOMMITTED")
 288         m_isolation = SQL_TXN_READ_UNCOMMITTED;
 289     else
 290         throw XMLToolingException("Unknown transaction isolationLevel property.");
 291
 292     if (m_henv == SQL_NULL_HENV) {
 293         // Enable connection pooling.
 294         SQLSetEnvAttr(SQL_NULL_HANDLE, SQL_ATTR_CONNECTION_POOLING, (void*)SQL_CP_ONE_PER_HENV, 0);
 295
 296         // Allocate the environment.
 297         if (!SQL_SUCCEEDED(SQLAllocHandle(SQL_HANDLE_ENV, SQL_NULL_HANDLE, &m_henv)))
 298             throw XMLToolingException("ODBC failed to initialize.");
 299
 300         // Specify ODBC 3.x
 301         SQLSetEnvAttr(m_henv, SQL_ATTR_ODBC_VERSION, (void*)SQL_OV_ODBC3, 0);
 302
 303         m_log.info("ODBC initialized");
 304     }
 305
 306     // Grab connection string from the configuration.
 307     e = e ? XMLHelper::getFirstChildElement(e, ConnectionString) : nullptr;
 308     auto_ptr_char arg(e ? e->getTextContent() : nullptr);
 309     if (!arg.get() || !*arg.get()) {
 310         SQLFreeHandle(SQL_HANDLE_ENV, m_henv);
 311         throw XMLToolingException("ODBC StorageService requires ConnectionString element in configuration.");
 312     }
 313     m_connstring = arg.get();
 314
 315     // Connect and check version.
 316     ODBCConn conn(getHDBC());
 317     pair<SQLINTEGER,SQLINTEGER> v = getVersion(conn);
 318
 319     // Make sure we've got the right version.
 320     if (v.first != PLUGIN_VER_MAJOR) {
 321         SQLFreeHandle(SQL_HANDLE_ENV, m_henv);
 322         m_log.crit("unknown database version: %d.%d", v.first, v.second);
 323         throw XMLToolingException("Unknown database version for ODBC StorageService.");
 324     }
 325
 326     if (v.first > 1 || v.second > 0) {
 327         m_log.info("using 32-bit int type for version fields in tables");
 328         m_wideVersion = true;
 329     }
 330
 331     // Load any retry errors to check.
 332     e = XMLHelper::getNextSiblingElement(e, RetryOnError);
 333     while (e) {
 334         if (e->hasChildNodes()) {
 335             try {
 336                 int code = XMLString::parseInt(e->getTextContent());
 337                 m_retries.push_back(code);
 338                 m_log.info("will retry operations when native ODBC error (%d) is returned", code);
 339             }
 340             catch (XMLException&) {
 341                 m_log.error("skipping non-numeric ODBC retry code");
 342             }
 343         }
 344         e = XMLHelper::getNextSiblingElement(e, RetryOnError);
 345     }
 346
 347     // Initialize the cleanup thread
 348     shutdown_wait.reset(CondWait::create());
 349     cleanup_thread = Thread::create(&cleanup_fn, (void*)this);
 350 }
 351
 352 ODBCStorageService::~ODBCStorageService()
 353 {
 354     shutdown = true;
 355     shutdown_wait->signal();
 356     cleanup_thread->join(nullptr);
 357     if (m_henv != SQL_NULL_HANDLE)
 358         SQLFreeHandle(SQL_HANDLE_ENV, m_henv);
 359 }
 360
 361 pair<bool,bool> ODBCStorageService::log_error(SQLHANDLE handle, SQLSMALLINT htype, const char* checkfor)
 362 {
 363     SQLSMALLINT  i = 0;
 364     SQLINTEGER   native;
 365     SQLCHAR      state[7];
 366     SQLCHAR      text[256];
 367     SQLSMALLINT  len;
 368     SQLRETURN    ret;
 369
 370     pair<bool,bool> res = make_pair(false,false);
 371     do {
 372         ret = SQLGetDiagRec(htype, handle, ++i, state, &native, text, sizeof(text), &len);
 373         if (SQL_SUCCEEDED(ret)) {
 374             m_log.error("ODBC Error: %s:%ld:%ld:%s", state, i, native, text);
 375             for (vector<SQLINTEGER>::const_iterator n = m_retries.begin(); !res.first && n != m_retries.end(); ++n)
 376                 res.first = (*n == native);
 377             if (checkfor && !strcmp(checkfor, (const char*)state))
 378                 res.second = true;
 379         }
 380     } while(SQL_SUCCEEDED(ret));
 381     return res;
 382 }
 383
 384 SQLHDBC ODBCStorageService::getHDBC()
 385 {
 386 #ifdef _DEBUG
 387     xmltooling::NDC ndc("getHDBC");
 388 #endif
 389
 390     // Get a handle.
 391     SQLHDBC handle = SQL_NULL_HDBC;
 392     SQLRETURN sr = SQLAllocHandle(SQL_HANDLE_DBC, m_henv, &handle);
 393     if (!SQL_SUCCEEDED(sr) || handle == SQL_NULL_HDBC) {
 394         m_log.error("failed to allocate connection handle");
 395         log_error(m_henv, SQL_HANDLE_ENV);
 396         throw IOException("ODBC StorageService failed to allocate a connection handle.");
 397     }
 398
 399     sr = SQLDriverConnect(handle,nullptr,(SQLCHAR*)m_connstring.c_str(),m_connstring.length(),nullptr,0,nullptr,SQL_DRIVER_NOPROMPT);
 400     if (!SQL_SUCCEEDED(sr)) {
 401         m_log.error("failed to connect to database");
 402         log_error(handle, SQL_HANDLE_DBC);
 403         SQLFreeHandle(SQL_HANDLE_DBC, handle);
 404         throw IOException("ODBC StorageService failed to connect to database.");
 405     }
 406
 407     sr = SQLSetConnectAttr(handle, SQL_ATTR_TXN_ISOLATION, (SQLPOINTER)m_isolation, 0);
 408     if (!SQL_SUCCEEDED(sr)) {
 409         SQLDisconnect(handle);
 410         SQLFreeHandle(SQL_HANDLE_DBC, handle);
 411         throw IOException("ODBC StorageService failed to set transaction isolation level.");
 412     }
 413
 414     return handle;
 415 }
 416
 417 SQLHSTMT ODBCStorageService::getHSTMT(SQLHDBC conn)
 418 {
 419     SQLHSTMT hstmt = SQL_NULL_HSTMT;
 420     SQLRETURN sr = SQLAllocHandle(SQL_HANDLE_STMT, conn, &hstmt);
 421     if (!SQL_SUCCEEDED(sr) || hstmt == SQL_NULL_HSTMT) {
 422         m_log.error("failed to allocate statement handle");
 423         log_error(conn, SQL_HANDLE_DBC);
 424         throw IOException("ODBC StorageService failed to allocate a statement handle.");
 425     }
 426     return hstmt;
 427 }
 428
 429 pair<SQLINTEGER,SQLINTEGER> ODBCStorageService::getVersion(SQLHDBC conn)
 430 {
 431     // Grab the version number from the database.
 432     SQLHSTMT stmt = getHSTMT(conn);
 433
 434     SQLRETURN sr = SQLExecDirect(stmt, (SQLCHAR*)"SELECT major,minor FROM version", SQL_NTS);
 435     if (!SQL_SUCCEEDED(sr)) {
 436         m_log.error("failed to read version from database");
 437         log_error(stmt, SQL_HANDLE_STMT);
 438         throw IOException("ODBC StorageService failed to read version from database.");
 439     }
 440
 441     SQLINTEGER major;
 442     SQLINTEGER minor;
 443     SQLBindCol(stmt, 1, SQL_C_SLONG, &major, 0, nullptr);
 444     SQLBindCol(stmt, 2, SQL_C_SLONG, &minor, 0, nullptr);
 445
 446     if ((sr = SQLFetch(stmt)) != SQL_NO_DATA)
 447         return make_pair(major,minor);
 448
 449     m_log.error("no rows returned in version query");
 450     throw IOException("ODBC StorageService failed to read version from database.");
 451 }
 452
 453 bool ODBCStorageService::createRow(const char* table, const char* context, const char* key, const char* value, time_t expiration)
 454 {
 455 #ifdef _DEBUG
 456     xmltooling::NDC ndc("createRow");
 457 #endif
 458
 459     char timebuf[32];
 460     timestampFromTime(expiration, timebuf);
 461
 462     // Get statement handle.
 463     ODBCConn conn(getHDBC());
 464     SQLHSTMT stmt = getHSTMT(conn);
 465
 466     string q  = string("INSERT INTO ") + table + " VALUES (?,?," + timebuf + ",1,?)";
 467
 468     SQLRETURN sr = SQLPrepare(stmt, (SQLCHAR*)q.c_str(), SQL_NTS);
 469     if (!SQL_SUCCEEDED(sr)) {
 470         m_log.error("SQLPrepare failed (t=%s, c=%s, k=%s)", table, context, key);
 471         log_error(stmt, SQL_HANDLE_STMT);
 472         throw IOException("ODBC StorageService failed to insert record.");
 473     }
 474     m_log.debug("SQLPrepare succeeded. SQL: %s", q.c_str());
 475
 476     SQLLEN b_ind = SQL_NTS;
 477     sr = SQLBindParam(stmt, 1, SQL_C_CHAR, SQL_VARCHAR, 255, 0, const_cast<char*>(context), &b_ind);
 478     if (!SQL_SUCCEEDED(sr)) {
 479         m_log.error("SQLBindParam failed (context = %s)", context);
 480         log_error(stmt, SQL_HANDLE_STMT);
 481         throw IOException("ODBC StorageService failed to insert record.");
 482     }
 483     m_log.debug("SQLBindParam succeeded (context = %s)", context);
 484
 485     sr = SQLBindParam(stmt, 2, SQL_C_CHAR, SQL_VARCHAR, 255, 0, const_cast<char*>(key), &b_ind);
 486     if (!SQL_SUCCEEDED(sr)) {
 487         m_log.error("SQLBindParam failed (key = %s)", key);
 488         log_error(stmt, SQL_HANDLE_STMT);
 489         throw IOException("ODBC StorageService failed to insert record.");
 490     }
 491     m_log.debug("SQLBindParam succeeded (key = %s)", key);
 492
 493     if (strcmp(table, TEXT_TABLE)==0)
 494         sr = SQLBindParam(stmt, 3, SQL_C_CHAR, SQL_LONGVARCHAR, strlen(value), 0, const_cast<char*>(value), &b_ind);
 495     else
 496         sr = SQLBindParam(stmt, 3, SQL_C_CHAR, SQL_VARCHAR, 255, 0, const_cast<char*>(value), &b_ind);
 497     if (!SQL_SUCCEEDED(sr)) {
 498         m_log.error("SQLBindParam failed (value = %s)", value);
 499         log_error(stmt, SQL_HANDLE_STMT);
 500         throw IOException("ODBC StorageService failed to insert record.");
 501     }
 502     m_log.debug("SQLBindParam succeeded (value = %s)", value);
 503
 504     int attempts = 3;
 505     pair<bool,bool> logres;
 506     do {
 507         logres = make_pair(false,false);
 508         attempts--;
 509         sr = SQLExecute(stmt);
 510         if (SQL_SUCCEEDED(sr)) {
 511             m_log.debug("SQLExecute of insert succeeded");
 512             return true;
 513         }
 514         m_log.error("insert record failed (t=%s, c=%s, k=%s)", table, context, key);
 515         logres = log_error(stmt, SQL_HANDLE_STMT, "23000");
 516         if (logres.second) {
 517             // Supposedly integrity violation.
 518             // Try and delete any expired record still hanging around until the final attempt.
 519             if (attempts > 0) {
 520                 reap(table, context);
 521                 continue;
 522             }
 523             return false;
 524         }
 525     } while (attempts && logres.first);
 526
 527     throw IOException("ODBC StorageService failed to insert record.");
 528 }
 529
 530 int ODBCStorageService::readRow(const char *table, const char* context, const char* key, string* pvalue, time_t* pexpiration, int version)
 531 {
 532 #ifdef _DEBUG
 533     xmltooling::NDC ndc("readRow");
 534 #endif
 535
 536     // Get statement handle.
 537     ODBCConn conn(getHDBC());
 538     SQLHSTMT stmt = getHSTMT(conn);
 539
 540     // Prepare and exectute select statement.
 541     char timebuf[32];
 542     timestampFromTime(time(nullptr), timebuf);
 543     SQLString scontext(context);
 544     SQLString skey(key);
 545     string q("SELECT version");
 546     if (pexpiration)
 547         q += ",expires";
 548     if (pvalue) {
 549         pvalue->erase();
 550         q = q + ",CASE version WHEN " + lexical_cast<string>(version) + " THEN null ELSE value END";
 551     }
 552     q = q + " FROM " + table + " WHERE context='" + scontext.tostr() + "' AND id='" + skey.tostr() + "' AND expires > " + timebuf;
 553     if (m_log.isDebugEnabled())
 554         m_log.debug("SQL: %s", q.c_str());
 555
 556     SQLRETURN sr=SQLExecDirect(stmt, (SQLCHAR*)q.c_str(), SQL_NTS);
 557     if (!SQL_SUCCEEDED(sr)) {
 558         m_log.error("error searching for (t=%s, c=%s, k=%s)", table, context, key);
 559         log_error(stmt, SQL_HANDLE_STMT);
 560         throw IOException("ODBC StorageService search failed.");
 561     }
 562
 563     SQLSMALLINT ver;
 564     SQLINTEGER widever;
 565     SQL_TIMESTAMP_STRUCT expiration;
 566
 567     if (m_wideVersion)
 568         SQLBindCol(stmt, 1, SQL_C_SLONG, &widever, 0, nullptr);
 569     else
 570         SQLBindCol(stmt, 1, SQL_C_SSHORT, &ver, 0, nullptr);
 571     if (pexpiration)
 572         SQLBindCol(stmt, 2, SQL_C_TYPE_TIMESTAMP, &expiration, 0, nullptr);
 573
 574     if ((sr = SQLFetch(stmt)) == SQL_NO_DATA) {
 575         if (m_log.isDebugEnabled())
 576             m_log.debug("search returned no data (t=%s, c=%s, k=%s)", table, context, key);
 577         return 0;
 578     }
 579
 580     if (pexpiration)
 581         *pexpiration = timeFromTimestamp(expiration);
 582
 583     if (version == (m_wideVersion ? widever : ver)) {
 584         if (m_log.isDebugEnabled())
 585             m_log.debug("versioned search detected no change (t=%s, c=%s, k=%s)", table, context, key);
 586         return version; // nothing's changed, so just echo back the version
 587     }
 588
 589     if (pvalue) {
 590         SQLLEN len;
 591         SQLCHAR buf[LONGDATA_BUFLEN];
 592         while ((sr = SQLGetData(stmt, (pexpiration ? 3 : 2), SQL_C_CHAR, buf, sizeof(buf), &len)) != SQL_NO_DATA) {
 593             if (!SQL_SUCCEEDED(sr)) {
 594                 m_log.error("error while reading text field from result set");
 595                 log_error(stmt, SQL_HANDLE_STMT);
 596                 throw IOException("ODBC StorageService search failed to read data from result set.");
 597             }
 598             pvalue->append((char*)buf);
 599         }
 600     }
 601
 602     return (m_wideVersion ? widever : ver);
 603 }
 604
 605 int ODBCStorageService::updateRow(const char *table, const char* context, const char* key, const char* value, time_t expiration, int version)
 606 {
 607 #ifdef _DEBUG
 608     xmltooling::NDC ndc("updateRow");
 609 #endif
 610
 611     if (!value && !expiration)
 612         throw IOException("ODBC StorageService given invalid update instructions.");
 613
 614     // Get statement handle. Disable auto-commit mode to wrap select + update.
 615     ODBCConn conn(getHDBC());
 616     SQLRETURN sr = SQLSetConnectAttr(conn, SQL_ATTR_AUTOCOMMIT, SQL_AUTOCOMMIT_OFF, 0);
 617     if (!SQL_SUCCEEDED(sr))
 618         throw IOException("ODBC StorageService failed to disable auto-commit mode.");
 619     conn.autoCommit = false;
 620     SQLHSTMT stmt = getHSTMT(conn);
 621
 622     // First, fetch the current version for later, which also ensures the record still exists.
 623     char timebuf[32];
 624     timestampFromTime(time(nullptr), timebuf);
 625     SQLString scontext(context);
 626     SQLString skey(key);
 627     string q("SELECT version FROM ");
 628     q = q + table + " WHERE context='" + scontext.tostr() + "' AND id='" + skey.tostr() + "' AND expires > " + timebuf;
 629
 630     m_log.debug("SQL: %s", q.c_str());
 631
 632     sr = SQLExecDirect(stmt, (SQLCHAR*)q.c_str(), SQL_NTS);
 633     if (!SQL_SUCCEEDED(sr)) {
 634         m_log.error("error searching for (t=%s, c=%s, k=%s)", table, context, key);
 635         log_error(stmt, SQL_HANDLE_STMT);
 636         throw IOException("ODBC StorageService search failed.");
 637     }
 638
 639     SQLSMALLINT ver;
 640     SQLINTEGER widever;
 641     if (m_wideVersion)
 642         SQLBindCol(stmt, 1, SQL_C_SLONG, &widever, 0, nullptr);
 643     else
 644         SQLBindCol(stmt, 1, SQL_C_SSHORT, &ver, 0, nullptr);
 645     if ((sr = SQLFetch(stmt)) == SQL_NO_DATA) {
 646         return 0;
 647     }
 648
 649     // Check version?
 650     if (version > 0 && version != (m_wideVersion ? widever : ver)) {
 651         return -1;
 652     }
 653     else if ((m_wideVersion && widever == INT_MAX) || (!m_wideVersion && ver == 32767)) {
 654         m_log.error("record version overflow (t=%s, c=%s, k=%s)", table, context, key);
 655         throw IOException("Version overflow, record in ODBC StorageService could not be updated.");
 656     }
 657
 658     SQLFreeHandle(SQL_HANDLE_STMT, stmt);
 659     stmt = getHSTMT(conn);
 660
 661     // Prepare and exectute update statement.
 662     q = string("UPDATE ") + table + " SET ";
 663
 664     if (value)
 665         q = q + "value=?, version=version+1";
 666
 667     if (expiration) {
 668         timestampFromTime(expiration, timebuf);
 669         if (value)
 670             q += ',';
 671         q = q + "expires = " + timebuf;
 672     }
 673
 674     q = q + " WHERE context='" + scontext.tostr() + "' AND id='" + skey.tostr() + "'";
 675
 676     sr = SQLPrepare(stmt, (SQLCHAR*)q.c_str(), SQL_NTS);
 677     if (!SQL_SUCCEEDED(sr)) {
 678         m_log.error("update of record failed (t=%s, c=%s, k=%s", table, context, key);
 679         log_error(stmt, SQL_HANDLE_STMT);
 680         throw IOException("ODBC StorageService failed to update record.");
 681     }
 682     m_log.debug("SQLPrepare succeeded. SQL: %s", q.c_str());
 683
 684     SQLLEN b_ind = SQL_NTS;
 685     if (value) {
 686         if (strcmp(table, TEXT_TABLE)==0)
 687             sr = SQLBindParam(stmt, 1, SQL_C_CHAR, SQL_LONGVARCHAR, strlen(value), 0, const_cast<char*>(value), &b_ind);
 688         else
 689             sr = SQLBindParam(stmt, 1, SQL_C_CHAR, SQL_VARCHAR, 255, 0, const_cast<char*>(value), &b_ind);
 690         if (!SQL_SUCCEEDED(sr)) {
 691             m_log.error("SQLBindParam failed (value = %s)", value);
 692             log_error(stmt, SQL_HANDLE_STMT);
 693             throw IOException("ODBC StorageService failed to update record.");
 694         }
 695         m_log.debug("SQLBindParam succeeded (value = %s)", value);
 696     }
 697
 698     int attempts = 3;
 699     pair<bool,bool> logres;
 700     do {
 701         logres = make_pair(false,false);
 702         attempts--;
 703         sr = SQLExecute(stmt);
 704         if (sr == SQL_NO_DATA)
 705             return 0;   // went missing?
 706         else if (SQL_SUCCEEDED(sr)) {
 707             m_log.debug("SQLExecute of update succeeded");
 708             return (m_wideVersion ? widever : ver) + 1;
 709         }
 710
 711         m_log.error("update of record failed (t=%s, c=%s, k=%s)", table, context, key);
 712         logres = log_error(stmt, SQL_HANDLE_STMT);
 713     } while (attempts && logres.first);
 714
 715     throw IOException("ODBC StorageService failed to update record.");
 716 }
 717
 718 bool ODBCStorageService::deleteRow(const char *table, const char *context, const char* key)
 719 {
 720 #ifdef _DEBUG
 721     xmltooling::NDC ndc("deleteRow");
 722 #endif
 723
 724     // Get statement handle.
 725     ODBCConn conn(getHDBC());
 726     SQLHSTMT stmt = getHSTMT(conn);
 727
 728     // Prepare and execute delete statement.
 729     SQLString scontext(context);
 730     SQLString skey(key);
 731     string q = string("DELETE FROM ") + table + " WHERE context='" + scontext.tostr() + "' AND id='" + skey.tostr() + "'";
 732     m_log.debug("SQL: %s", q.c_str());
 733
 734     SQLRETURN sr = SQLExecDirect(stmt, (SQLCHAR*)q.c_str(), SQL_NTS);
 735      if (sr == SQL_NO_DATA)
 736         return false;
 737     else if (!SQL_SUCCEEDED(sr)) {
 738         m_log.error("error deleting record (t=%s, c=%s, k=%s)", table, context, key);
 739         log_error(stmt, SQL_HANDLE_STMT);
 740         throw IOException("ODBC StorageService failed to delete record.");
 741     }
 742
 743     return true;
 744 }
 745
 746
 747 void ODBCStorageService::cleanup()
 748 {
 749 #ifdef _DEBUG
 750     xmltooling::NDC ndc("cleanup");
 751 #endif
 752
 753     scoped_ptr<Mutex> mutex(Mutex::create());
 754
 755     mutex->lock();
 756
 757     m_log.info("cleanup thread started... running every %d secs", m_cleanupInterval);
 758
 759     while (!shutdown) {
 760         shutdown_wait->timedwait(mutex.get(), m_cleanupInterval);
 761         if (shutdown)
 762             break;
 763         try {
 764             reap(nullptr);
 765         }
 766         catch (std::exception& ex) {
 767             m_log.error("cleanup thread swallowed exception: %s", ex.what());
 768         }
 769     }
 770
 771     m_log.info("cleanup thread exiting...");
 772
 773     mutex->unlock();
 774     Thread::exit(nullptr);
 775 }
 776
 777 void* ODBCStorageService::cleanup_fn(void* cache_p)
 778 {
 779   ODBCStorageService* cache = (ODBCStorageService*)cache_p;
 780
 781 #ifndef WIN32
 782   // First, let's block all signals
 783   Thread::mask_all_signals();
 784 #endif
 785
 786   // Now run the cleanup process.
 787   cache->cleanup();
 788   return nullptr;
 789 }
 790
 791 void ODBCStorageService::updateContext(const char *table, const char* context, time_t expiration)
 792 {
 793 #ifdef _DEBUG
 794     xmltooling::NDC ndc("updateContext");
 795 #endif
 796
 797     // Get statement handle.
 798     ODBCConn conn(getHDBC());
 799     SQLHSTMT stmt = getHSTMT(conn);
 800
 801     char timebuf[32];
 802     timestampFromTime(expiration, timebuf);
 803
 804     char nowbuf[32];
 805     timestampFromTime(time(nullptr), nowbuf);
 806
 807     SQLString scontext(context);
 808     string q = string("UPDATE ") + table + " SET expires = " + timebuf + " WHERE context='" + scontext.tostr() + "' AND expires > " + nowbuf;
 809
 810     m_log.debug("SQL: %s", q.c_str());
 811
 812     SQLRETURN sr = SQLExecDirect(stmt, (SQLCHAR*)q.c_str(), SQL_NTS);
 813     if ((sr != SQL_NO_DATA) && !SQL_SUCCEEDED(sr)) {
 814         m_log.error("error updating records (t=%s, c=%s)", table, context ? context : "all");
 815         log_error(stmt, SQL_HANDLE_STMT);
 816         throw IOException("ODBC StorageService failed to update context expiration.");
 817     }
 818 }
 819
 820 void ODBCStorageService::reap(const char *table, const char* context)
 821 {
 822 #ifdef _DEBUG
 823     xmltooling::NDC ndc("reap");
 824 #endif
 825
 826     // Get statement handle.
 827     ODBCConn conn(getHDBC());
 828     SQLHSTMT stmt = getHSTMT(conn);
 829
 830     // Prepare and execute delete statement.
 831     char nowbuf[32];
 832     timestampFromTime(time(nullptr), nowbuf);
 833     string q;
 834     if (context) {
 835         SQLString scontext(context);
 836         q = string("DELETE FROM ") + table + " WHERE context='" + scontext.tostr() + "' AND expires <= " + nowbuf;
 837     }
 838     else {
 839         q = string("DELETE FROM ") + table + " WHERE expires <= " + nowbuf;
 840     }
 841     m_log.debug("SQL: %s", q.c_str());
 842
 843     SQLRETURN sr = SQLExecDirect(stmt, (SQLCHAR*)q.c_str(), SQL_NTS);
 844     if ((sr != SQL_NO_DATA) && !SQL_SUCCEEDED(sr)) {
 845         m_log.error("error expiring records (t=%s, c=%s)", table, context ? context : "all");
 846         log_error(stmt, SQL_HANDLE_STMT);
 847         throw IOException("ODBC StorageService failed to purge expired records.");
 848     }
 849 }
 850
 851 void ODBCStorageService::deleteContext(const char *table, const char* context)
 852 {
 853 #ifdef _DEBUG
 854     xmltooling::NDC ndc("deleteContext");
 855 #endif
 856
 857     // Get statement handle.
 858     ODBCConn conn(getHDBC());
 859     SQLHSTMT stmt = getHSTMT(conn);
 860
 861     // Prepare and execute delete statement.
 862     SQLString scontext(context);
 863     string q = string("DELETE FROM ") + table + " WHERE context='" + scontext.tostr() + "'";
 864     m_log.debug("SQL: %s", q.c_str());
 865
 866     SQLRETURN sr = SQLExecDirect(stmt, (SQLCHAR*)q.c_str(), SQL_NTS);
 867     if ((sr != SQL_NO_DATA) && !SQL_SUCCEEDED(sr)) {
 868         m_log.error("error deleting context (t=%s, c=%s)", table, context);
 869         log_error(stmt, SQL_HANDLE_STMT);
 870         throw IOException("ODBC StorageService failed to delete context.");
 871     }
 872 }
 873
 874 extern "C" int ODBCSTORE_EXPORTS xmltooling_extension_init(void*)
 875 {
 876     // Register this SS type
 877     XMLToolingConfig::getConfig().StorageServiceManager.registerFactory("ODBC", ODBCStorageServiceFactory);
 878     return 0;
 879 }
 880
 881 extern "C" void ODBCSTORE_EXPORTS xmltooling_extension_term()
 882 {
 883     XMLToolingConfig::getConfig().StorageServiceManager.deregisterFactory("ODBC");
 884 }