src/session.c

   1 /* This file is part of Pazpar2.
   2    Copyright (C) 2006-2011 Index Data
   3
   4 Pazpar2 is free software; you can redistribute it and/or modify it under
   5 the terms of the GNU General Public License as published by the Free
   6 Software Foundation; either version 2, or (at your option) any later
   7 version.
   8
   9 Pazpar2 is distributed in the hope that it will be useful, but WITHOUT ANY
  10 WARRANTY; without even the implied warranty of MERCHANTABILITY or
  11 FITNESS FOR A PARTICULAR PURPOSE.  See the GNU General Public License
  12 for more details.
  13
  14 You should have received a copy of the GNU General Public License
  15 along with this program; if not, write to the Free Software
  16 Foundation, Inc., 51 Franklin St, Fifth Floor, Boston, MA  02110-1301  USA
  17
  18 */
  19
  20 /** \file session.c
  21     \brief high-level logic; mostly user sessions and settings
  22 */
  23
  24 #if HAVE_CONFIG_H
  25 #include <config.h>
  26 #endif
  27
  28 #include <time.h>
  29 #include <stdlib.h>
  30 #include <stdio.h>
  31 #include <string.h>
  32 #if HAVE_SYS_TIME_H
  33 #include <sys/time.h>
  34 #endif
  35 #if HAVE_UNISTD_H
  36 #include <unistd.h>
  37 #endif
  38 #ifdef WIN32
  39 #include <windows.h>
  40 #endif
  41 #include <signal.h>
  42 #include <ctype.h>
  43 #include <assert.h>
  44 #include <math.h>
  45
  46 #include <yaz/marcdisp.h>
  47 #include <yaz/comstack.h>
  48 #include <yaz/tcpip.h>
  49 #include <yaz/proto.h>
  50 #include <yaz/readconf.h>
  51 #include <yaz/pquery.h>
  52 #include <yaz/otherinfo.h>
  53 #include <yaz/yaz-util.h>
  54 #include <yaz/nmem.h>
  55 #include <yaz/query-charset.h>
  56 #include <yaz/querytowrbuf.h>
  57 #include <yaz/oid_db.h>
  58 #include <yaz/snprintf.h>
  59 #include <yaz/gettimeofday.h>
  60
  61 #define USE_TIMING 0
  62 #if USE_TIMING
  63 #include <yaz/timing.h>
  64 #endif
  65
  66 #include "ppmutex.h"
  67 #include "parameters.h"
  68 #include "session.h"
  69 #include "eventl.h"
  70 #include "http.h"
  71 #include "termlists.h"
  72 #include "reclists.h"
  73 #include "relevance.h"
  74 #include "database.h"
  75 #include "client.h"
  76 #include "settings.h"
  77 #include "normalize7bit.h"
  78
  79 #define TERMLIST_HIGH_SCORE 25
  80
  81 #define MAX_CHUNK 15
  82
  83 #define MAX(a,b) ((a)>(b)?(a):(b))
  84
  85 // Note: Some things in this structure will eventually move to configuration
  86 struct parameters global_parameters =
  87 {
  88     0,   // dump_records
  89     0,   // debug_mode
  90     0,   // predictable sessions
  91 };
  92
  93 struct client_list {
  94     struct client *client;
  95     struct client_list *next;
  96 };
  97
  98 /* session counting (1) , disable client counting (0) */
  99 static YAZ_MUTEX g_session_mutex = 0;
 100 static int no_sessions = 0;
 101 static int no_session_total = 0;
 102
 103 static int session_use(int delta)
 104 {
 105     int sessions;
 106     if (!g_session_mutex)
 107         yaz_mutex_create(&g_session_mutex);
 108     yaz_mutex_enter(g_session_mutex);
 109     no_sessions += delta;
 110     if (delta > 0)
 111         no_session_total += delta;
 112     sessions = no_sessions;
 113     yaz_mutex_leave(g_session_mutex);
 114     yaz_log(YLOG_DEBUG, "%s sesions=%d", delta == 0 ? "" : (delta > 0 ? "INC" : "DEC"), no_sessions);
 115     return sessions;
 116 }
 117
 118 int sessions_count(void) {
 119     return session_use(0);
 120 }
 121
 122 int  session_count_total(void) {
 123     int total = 0;
 124     if (!g_session_mutex)
 125         return 0;
 126     yaz_mutex_enter(g_session_mutex);
 127     total = no_session_total;
 128     yaz_mutex_leave(g_session_mutex);
 129     return total;
 130 }
 131
 132
 133 static void log_xml_doc(xmlDoc *doc)
 134 {
 135     FILE *lf = yaz_log_file();
 136     xmlChar *result = 0;
 137     int len = 0;
 138 #if LIBXML_VERSION >= 20600
 139     xmlDocDumpFormatMemory(doc, &result, &len, 1);
 140 #else
 141     xmlDocDumpMemory(doc, &result, &len);
 142 #endif
 143     if (lf && len)
 144     {
 145         (void) fwrite(result, 1, len, lf);
 146         fprintf(lf, "\n");
 147     }
 148     xmlFree(result);
 149 }
 150
 151 static void session_enter(struct session *s)
 152 {
 153     yaz_mutex_enter(s->session_mutex);
 154 }
 155
 156 static void session_leave(struct session *s)
 157 {
 158     yaz_mutex_leave(s->session_mutex);
 159 }
 160
 161 // Recursively traverse query structure to extract terms.
 162 void pull_terms(NMEM nmem, struct ccl_rpn_node *n, char **termlist, int *num)
 163 {
 164     char **words;
 165     int numwords;
 166     int i;
 167
 168     switch (n->kind)
 169     {
 170     case CCL_RPN_AND:
 171     case CCL_RPN_OR:
 172     case CCL_RPN_NOT:
 173     case CCL_RPN_PROX:
 174         pull_terms(nmem, n->u.p[0], termlist, num);
 175         pull_terms(nmem, n->u.p[1], termlist, num);
 176         break;
 177     case CCL_RPN_TERM:
 178         nmem_strsplit(nmem, " ", n->u.t.term, &words, &numwords);
 179         for (i = 0; i < numwords; i++)
 180             termlist[(*num)++] = words[i];
 181         break;
 182     default: // NOOP
 183         break;
 184     }
 185 }
 186
 187
 188 void add_facet(struct session *s, const char *type, const char *value, int count)
 189 {
 190     struct conf_service *service = s->service;
 191     pp2_relevance_token_t prt;
 192     const char *facet_component;
 193     WRBUF facet_wrbuf = wrbuf_alloc();
 194     prt = pp2_relevance_tokenize(service->facet_pct);
 195
 196     pp2_relevance_first(prt, value, 0);
 197     while ((facet_component = pp2_relevance_token_next(prt)))
 198     {
 199         if (*facet_component)
 200         {
 201             if (wrbuf_len(facet_wrbuf))
 202                 wrbuf_puts(facet_wrbuf, " ");
 203             wrbuf_puts(facet_wrbuf, facet_component);
 204         }
 205     }
 206     pp2_relevance_token_destroy(prt);
 207
 208     if (wrbuf_len(facet_wrbuf))
 209     {
 210         int i;
 211         for (i = 0; i < s->num_termlists; i++)
 212             if (!strcmp(s->termlists[i].name, type))
 213                 break;
 214         if (i == s->num_termlists)
 215         {
 216             if (i == SESSION_MAX_TERMLISTS)
 217             {
 218                 session_log(s, YLOG_FATAL, "Too many termlists");
 219                 wrbuf_destroy(facet_wrbuf);
 220                 return;
 221             }
 222
 223             s->termlists[i].name = nmem_strdup(s->nmem, type);
 224             s->termlists[i].termlist
 225                 = termlist_create(s->nmem, TERMLIST_HIGH_SCORE);
 226             s->num_termlists = i + 1;
 227         }
 228
 229 #if 0
 230         session_log(s, YLOG_DEBUG, "Facets for %s: %s norm:%s (%d)", type, value, wrbuf_cstr(facet_wrbuf), count);
 231 #endif
 232         termlist_insert(s->termlists[i].termlist, wrbuf_cstr(facet_wrbuf),
 233                         count);
 234     }
 235     wrbuf_destroy(facet_wrbuf);
 236 }
 237
 238 static xmlDoc *record_to_xml(struct session *se,
 239                              struct session_database *sdb, const char *rec)
 240 {
 241     struct database *db = sdb->database;
 242     xmlDoc *rdoc = 0;
 243
 244     rdoc = xmlParseMemory(rec, strlen(rec));
 245
 246     if (!rdoc)
 247     {
 248         session_log(se, YLOG_FATAL, "Non-wellformed XML received from %s",
 249                     db->url);
 250         return 0;
 251     }
 252
 253     if (global_parameters.dump_records)
 254     {
 255         session_log(se, YLOG_LOG, "Un-normalized record from %s", db->url);
 256         log_xml_doc(rdoc);
 257     }
 258
 259     return rdoc;
 260 }
 261
 262 #define MAX_XSLT_ARGS 16
 263
 264 // Add static values from session database settings if applicable
 265 static void insert_settings_parameters(struct session_database *sdb,
 266                                        struct conf_service *service,
 267                                        char **parms,
 268                                        NMEM nmem)
 269 {
 270     int i;
 271     int nparms = 0;
 272     int offset = 0;
 273
 274     for (i = 0; i < service->num_metadata; i++)
 275     {
 276         struct conf_metadata *md = &service->metadata[i];
 277         int setting;
 278
 279         if (md->setting == Metadata_setting_parameter &&
 280             (setting = settings_lookup_offset(service, md->name)) >= 0)
 281         {
 282             const char *val = session_setting_oneval(sdb, setting);
 283             if (val && nparms < MAX_XSLT_ARGS)
 284             {
 285                 char *buf;
 286                 int len = strlen(val);
 287                 buf = nmem_malloc(nmem, len + 3);
 288                 buf[0] = '\'';
 289                 strcpy(buf + 1, val);
 290                 buf[len+1] = '\'';
 291                 buf[len+2] = '\0';
 292                 parms[offset++] = md->name;
 293                 parms[offset++] = buf;
 294                 nparms++;
 295             }
 296         }
 297     }
 298     parms[offset] = 0;
 299 }
 300
 301 // Add static values from session database settings if applicable
 302 static void insert_settings_values(struct session_database *sdb, xmlDoc *doc,
 303     struct conf_service *service)
 304 {
 305     int i;
 306
 307     for (i = 0; i < service->num_metadata; i++)
 308     {
 309         struct conf_metadata *md = &service->metadata[i];
 310         int offset;
 311
 312         if (md->setting == Metadata_setting_postproc &&
 313             (offset = settings_lookup_offset(service, md->name)) >= 0)
 314         {
 315             const char *val = session_setting_oneval(sdb, offset);
 316             if (val)
 317             {
 318                 xmlNode *r = xmlDocGetRootElement(doc);
 319                 xmlNode *n = xmlNewTextChild(r, 0, (xmlChar *) "metadata",
 320                                              (xmlChar *) val);
 321                 xmlSetProp(n, (xmlChar *) "type", (xmlChar *) md->name);
 322             }
 323         }
 324     }
 325 }
 326
 327 static xmlDoc *normalize_record(struct session *se,
 328                                 struct session_database *sdb,
 329                                 struct conf_service *service,
 330                                 const char *rec, NMEM nmem)
 331 {
 332     xmlDoc *rdoc = record_to_xml(se, sdb, rec);
 333
 334     if (rdoc)
 335     {
 336         char *parms[MAX_XSLT_ARGS*2+1];
 337
 338         insert_settings_parameters(sdb, service, parms, nmem);
 339
 340         if (normalize_record_transform(sdb->map, &rdoc, (const char **)parms))
 341         {
 342             session_log(se, YLOG_WARN, "Normalize failed from %s",
 343                         sdb->database->url);
 344         }
 345         else
 346         {
 347             insert_settings_values(sdb, rdoc, service);
 348
 349             if (global_parameters.dump_records)
 350             {
 351                 session_log(se, YLOG_LOG, "Normalized record from %s",
 352                             sdb->database->url);
 353                 log_xml_doc(rdoc);
 354             }
 355         }
 356     }
 357     return rdoc;
 358 }
 359
 360 void session_settings_dump(struct session *se,
 361                            struct session_database *db,
 362                            WRBUF w)
 363 {
 364     if (db->settings)
 365     {
 366         int i, num = db->num_settings;
 367         for (i = 0; i < num; i++)
 368         {
 369             struct setting *s = db->settings[i];
 370             for (;s ; s = s->next)
 371             {
 372                 wrbuf_puts(w, "<set name=\"");
 373                 wrbuf_xmlputs(w, s->name);
 374                 wrbuf_puts(w, "\" value=\"");
 375                 wrbuf_xmlputs(w, s->value);
 376                 wrbuf_puts(w, "\"/>");
 377             }
 378             if (db->settings[i])
 379                 wrbuf_puts(w, "\n");
 380         }
 381     }
 382 }
 383
 384 // Retrieve first defined value for 'name' for given database.
 385 // Will be extended to take into account user associated with session
 386 const char *session_setting_oneval(struct session_database *db, int offset)
 387 {
 388     if (offset >= db->num_settings || !db->settings[offset])
 389         return "";
 390     return db->settings[offset]->value;
 391 }
 392
 393 // Prepare XSLT stylesheets for record normalization
 394 // Structures are allocated on the session_wide nmem to avoid having
 395 // to recompute this for every search. This would lead
 396 // to leaking if a single session was to repeatedly change the PZ_XSLT
 397 // setting. However, this is not a realistic use scenario.
 398 static int prepare_map(struct session *se, struct session_database *sdb)
 399 {
 400     const char *s;
 401
 402     if (!sdb->settings)
 403     {
 404         session_log(se, YLOG_WARN, "No settings on %s", sdb->database->url);
 405         return -1;
 406     }
 407     if ((s = session_setting_oneval(sdb, PZ_XSLT)))
 408     {
 409         char auto_stylesheet[256];
 410
 411         if (!strcmp(s, "auto"))
 412         {
 413             const char *request_syntax = session_setting_oneval(
 414                 sdb, PZ_REQUESTSYNTAX);
 415             if (request_syntax)
 416             {
 417                 char *cp;
 418                 yaz_snprintf(auto_stylesheet, sizeof(auto_stylesheet),
 419                              "%s.xsl", request_syntax);
 420                 for (cp = auto_stylesheet; *cp; cp++)
 421                 {
 422                     /* deliberately only consider ASCII */
 423                     if (*cp > 32 && *cp < 127)
 424                         *cp = tolower(*cp);
 425                 }
 426                 s = auto_stylesheet;
 427             }
 428             else
 429             {
 430                 session_log(se, YLOG_WARN,
 431                             "No pz:requestsyntax for auto stylesheet");
 432             }
 433         }
 434         sdb->map = normalize_cache_get(se->normalize_cache,
 435                                        se->service->server->config, s);
 436         if (!sdb->map)
 437             return -1;
 438     }
 439     return 0;
 440 }
 441
 442 // This analyzes settings and recomputes any supporting data structures
 443 // if necessary.
 444 static int prepare_session_database(struct session *se,
 445                                     struct session_database *sdb)
 446 {
 447     if (!sdb->settings)
 448     {
 449         session_log(se, YLOG_WARN,
 450                 "No settings associated with %s", sdb->database->url);
 451         return -1;
 452     }
 453     if (sdb->settings[PZ_XSLT] && !sdb->map)
 454     {
 455         if (prepare_map(se, sdb) < 0)
 456             return -1;
 457     }
 458     return 0;
 459 }
 460
 461 // called if watch should be removed because http_channel is to be destroyed
 462 static void session_watch_cancel(void *data, struct http_channel *c,
 463                                  void *data2)
 464 {
 465     struct session_watchentry *ent = data;
 466
 467     ent->fun = 0;
 468     ent->data = 0;
 469     ent->obs = 0;
 470 }
 471
 472 // set watch. Returns 0=OK, -1 if watch is already set
 473 int session_set_watch(struct session *s, int what,
 474                       session_watchfun fun, void *data,
 475                       struct http_channel *chan)
 476 {
 477     int ret;
 478     session_enter(s);
 479     if (s->watchlist[what].fun)
 480         ret = -1;
 481     else
 482     {
 483
 484         s->watchlist[what].fun = fun;
 485         s->watchlist[what].data = data;
 486         s->watchlist[what].obs = http_add_observer(chan, &s->watchlist[what],
 487                                                    session_watch_cancel);
 488         ret = 0;
 489     }
 490     session_leave(s);
 491     return ret;
 492 }
 493
 494 void session_alert_watch(struct session *s, int what)
 495 {
 496     assert(s);
 497     session_enter(s);
 498     if (s->watchlist[what].fun)
 499     {
 500         /* our watch is no longer associated with http_channel */
 501         void *data;
 502         session_watchfun fun;
 503
 504         http_remove_observer(s->watchlist[what].obs);
 505         fun  = s->watchlist[what].fun;
 506         data = s->watchlist[what].data;
 507
 508         /* reset watch before fun is invoked - in case fun wants to set
 509            it again */
 510         s->watchlist[what].fun = 0;
 511         s->watchlist[what].data = 0;
 512         s->watchlist[what].obs = 0;
 513
 514         session_leave(s);
 515         session_log(s, YLOG_DEBUG,
 516                     "Alert Watch: %d calling function: %p", what, fun);
 517         fun(data);
 518     }
 519     else
 520         session_leave(s);
 521 }
 522
 523 //callback for grep_databases
 524 static void select_targets_callback(void *context, struct session_database *db)
 525 {
 526     struct session *se = (struct session*) context;
 527     struct client *cl = client_create();
 528     struct client_list *l;
 529     client_set_database(cl, db);
 530
 531     client_set_session(cl, se);
 532
 533     l = xmalloc(sizeof(*l));
 534     l->client = cl;
 535     l->next = se->clients;
 536     se->clients = l;
 537 }
 538
 539 static void session_remove_clients(struct session *se)
 540 {
 541     struct client_list *l;
 542
 543     session_enter(se);
 544     l = se->clients;
 545     se->clients = 0;
 546     session_leave(se);
 547
 548     while (l)
 549     {
 550         struct client_list *l_next = l->next;
 551         client_lock(l->client);
 552         client_set_session(l->client, 0);
 553         client_set_database(l->client, 0);
 554         client_unlock(l->client);
 555         client_destroy(l->client);
 556         xfree(l);
 557         l = l_next;
 558     }
 559 }
 560
 561 // Associates a set of clients with a session;
 562 // Note: Session-databases represent databases with per-session
 563 // setting overrides
 564 static int select_targets(struct session *se, const char *filter)
 565 {
 566     return session_grep_databases(se, filter, select_targets_callback);
 567 }
 568
 569 int session_active_clients(struct session *s)
 570 {
 571     struct client_list *l;
 572     int res = 0;
 573
 574     for (l = s->clients; l; l = l->next)
 575         if (client_is_active(l->client))
 576             res++;
 577
 578     return res;
 579 }
 580
 581 int session_is_preferred_clients_ready(struct session *s)
 582 {
 583     struct client_list *l;
 584     int res = 0;
 585
 586     for (l = s->clients; l; l = l->next)
 587         if (client_is_active_preferred(l->client))
 588             res++;
 589     session_log(s, YLOG_DEBUG, "Has %d active preferred clients.", res);
 590     return res == 0;
 591 }
 592
 593 enum pazpar2_error_code search(struct session *se,
 594                                const char *query,
 595                                const char *startrecs, const char *maxrecs,
 596                                const char *filter,
 597                                const char *limit,
 598                                const char **addinfo)
 599 {
 600     int live_channels = 0;
 601     int no_working = 0;
 602     int no_failed = 0;
 603     struct client_list *l;
 604     struct timeval tval;
 605     facet_limits_t facet_limits;
 606
 607     session_log(se, YLOG_DEBUG, "Search");
 608
 609     *addinfo = 0;
 610
 611     session_remove_clients(se);
 612
 613     session_enter(se);
 614     reclist_destroy(se->reclist);
 615     se->reclist = 0;
 616     relevance_destroy(&se->relevance);
 617     nmem_reset(se->nmem);
 618     se->total_records = se->total_hits = se->total_merged = 0;
 619     se->num_termlists = 0;
 620     live_channels = select_targets(se, filter);
 621     if (!live_channels)
 622     {
 623         session_leave(se);
 624         return PAZPAR2_NO_TARGETS;
 625     }
 626     se->reclist = reclist_create(se->nmem);
 627
 628     yaz_gettimeofday(&tval);
 629
 630     tval.tv_sec += 5;
 631
 632     facet_limits = facet_limits_create(limit);
 633     if (!facet_limits)
 634     {
 635         *addinfo = "limit";
 636         session_leave(se);
 637         return PAZPAR2_MALFORMED_PARAMETER_VALUE;
 638     }
 639     for (l = se->clients; l; l = l->next)
 640     {
 641         struct client *cl = l->client;
 642
 643         if (maxrecs)
 644             client_set_maxrecs(cl, atoi(maxrecs));
 645         if (startrecs)
 646             client_set_startrecs(cl, atoi(startrecs));
 647         if (prepare_session_database(se, client_get_database(cl)) < 0)
 648             ;
 649         else if (client_parse_query(cl, query, facet_limits) < 0)
 650             no_failed++;
 651         else
 652         {
 653             no_working++;
 654             if (client_prep_connection(cl, se->service->z3950_operation_timeout,
 655                                        se->service->z3950_session_timeout,
 656                                        se->service->server->iochan_man,
 657                                        &tval))
 658                 client_start_search(cl);
 659         }
 660     }
 661     facet_limits_destroy(facet_limits);
 662     session_leave(se);
 663     if (no_working == 0)
 664     {
 665         if (no_failed > 0)
 666         {
 667             *addinfo = "query";
 668             return PAZPAR2_MALFORMED_PARAMETER_VALUE;
 669         }
 670         else
 671             return PAZPAR2_NO_TARGETS;
 672     }
 673     return PAZPAR2_NO_ERROR;
 674 }
 675
 676 // Creates a new session_database object for a database
 677 static void session_init_databases_fun(void *context, struct database *db)
 678 {
 679     struct session *se = (struct session *) context;
 680     struct session_database *new = nmem_malloc(se->session_nmem, sizeof(*new));
 681     int i;
 682
 683     new->database = db;
 684
 685     new->map = 0;
 686     assert(db->settings);
 687     new->settings = nmem_malloc(se->session_nmem,
 688                                 sizeof(struct settings *) * db->num_settings);
 689     new->num_settings = db->num_settings;
 690     for (i = 0; i < db->num_settings; i++)
 691     {
 692         struct setting *setting = db->settings[i];
 693         new->settings[i] = setting;
 694     }
 695     new->next = se->databases;
 696     se->databases = new;
 697 }
 698
 699 // Doesn't free memory associated with sdb -- nmem takes care of that
 700 static void session_database_destroy(struct session_database *sdb)
 701 {
 702     sdb->map = 0;
 703 }
 704
 705 // Initialize session_database list -- this represents this session's view
 706 // of the database list -- subject to modification by the settings ws command
 707 void session_init_databases(struct session *se)
 708 {
 709     se->databases = 0;
 710     predef_grep_databases(se, se->service, session_init_databases_fun);
 711 }
 712
 713 // Probably session_init_databases_fun should be refactored instead of
 714 // called here.
 715 static struct session_database *load_session_database(struct session *se,
 716                                                       char *id)
 717 {
 718     struct database *db = new_database(id, se->session_nmem);
 719
 720     resolve_database(se->service, db);
 721
 722     session_init_databases_fun((void*) se, db);
 723
 724     // New sdb is head of se->databases list
 725     return se->databases;
 726 }
 727
 728 // Find an existing session database. If not found, load it
 729 static struct session_database *find_session_database(struct session *se,
 730                                                       char *id)
 731 {
 732     struct session_database *sdb;
 733
 734     for (sdb = se->databases; sdb; sdb = sdb->next)
 735         if (!strcmp(sdb->database->url, id))
 736             return sdb;
 737     return load_session_database(se, id);
 738 }
 739
 740 // Apply a session override to a database
 741 void session_apply_setting(struct session *se, char *dbname, char *setting,
 742                            char *value)
 743 {
 744     struct session_database *sdb = find_session_database(se, dbname);
 745     struct conf_service *service = se->service;
 746     struct setting *new = nmem_malloc(se->session_nmem, sizeof(*new));
 747     int offset = settings_create_offset(service, setting);
 748
 749     expand_settings_array(&sdb->settings, &sdb->num_settings, offset,
 750                           se->session_nmem);
 751     new->precedence = 0;
 752     new->target = dbname;
 753     new->name = setting;
 754     new->value = value;
 755     new->next = sdb->settings[offset];
 756     sdb->settings[offset] = new;
 757
 758     // Force later recompute of settings-driven data structures
 759     // (happens when a search starts and client connections are prepared)
 760     switch (offset)
 761     {
 762     case PZ_XSLT:
 763         if (sdb->map)
 764         {
 765             sdb->map = 0;
 766         }
 767         break;
 768     }
 769 }
 770
 771 void session_destroy(struct session *se) {
 772     struct session_database *sdb;
 773     session_log(se, YLOG_DEBUG, "Destroying");
 774     session_use(-1);
 775     session_remove_clients(se);
 776
 777     for (sdb = se->databases; sdb; sdb = sdb->next)
 778         session_database_destroy(sdb);
 779     normalize_cache_destroy(se->normalize_cache);
 780     relevance_destroy(&se->relevance);
 781     reclist_destroy(se->reclist);
 782     nmem_destroy(se->nmem);
 783     service_destroy(se->service);
 784     yaz_mutex_destroy(&se->session_mutex);
 785     wrbuf_destroy(se->wrbuf);
 786 }
 787
 788 /* Depreciated: use session_destroy */
 789 void destroy_session(struct session *se)
 790 {
 791     session_destroy(se);
 792 }
 793
 794 size_t session_get_memory_status(struct session *session) {
 795     size_t session_nmem;
 796     if (session == 0)
 797         return 0;
 798     session_enter(session);
 799     session_nmem = nmem_total(session->nmem);
 800     session_leave(session);
 801     return session_nmem;
 802 }
 803
 804
 805 struct session *new_session(NMEM nmem, struct conf_service *service,
 806                             unsigned session_id)
 807 {
 808     int i;
 809     struct session *session = nmem_malloc(nmem, sizeof(*session));
 810
 811     char tmp_str[50];
 812
 813     sprintf(tmp_str, "session#%u", session_id);
 814
 815     session->session_id = session_id;
 816     session_log(session, YLOG_DEBUG, "New");
 817     session->service = service;
 818     session->relevance = 0;
 819     session->total_hits = 0;
 820     session->total_records = 0;
 821     session->number_of_warnings_unknown_elements = 0;
 822     session->number_of_warnings_unknown_metadata = 0;
 823     session->num_termlists = 0;
 824     session->reclist = 0;
 825     session->clients = 0;
 826     session->session_nmem = nmem;
 827     session->nmem = nmem_create();
 828     session->wrbuf = wrbuf_alloc();
 829     session->databases = 0;
 830     for (i = 0; i <= SESSION_WATCH_MAX; i++)
 831     {
 832         session->watchlist[i].data = 0;
 833         session->watchlist[i].fun = 0;
 834     }
 835     session->normalize_cache = normalize_cache_create();
 836     session->session_mutex = 0;
 837     pazpar2_mutex_create(&session->session_mutex, tmp_str);
 838     session_use(1);
 839     return session;
 840 }
 841
 842 struct hitsbytarget *hitsbytarget(struct session *se, int *count, NMEM nmem)
 843 {
 844     struct hitsbytarget *res = 0;
 845     struct client_list *l;
 846     size_t sz = 0;
 847
 848     session_enter(se);
 849     for (l = se->clients; l; l = l->next)
 850         sz++;
 851
 852     res = nmem_malloc(nmem, sizeof(*res) * sz);
 853     *count = 0;
 854     for (l = se->clients; l; l = l->next)
 855     {
 856         struct client *cl = l->client;
 857         WRBUF w = wrbuf_alloc();
 858         const char *name = session_setting_oneval(client_get_database(cl),
 859                                                   PZ_NAME);
 860
 861         res[*count].id = client_get_database(cl)->database->url;
 862         res[*count].name = *name ? name : "Unknown";
 863         res[*count].hits = client_get_hits(cl);
 864         res[*count].records = client_get_num_records(cl);
 865         res[*count].diagnostic = client_get_diagnostic(cl);
 866         res[*count].state = client_get_state_str(cl);
 867         res[*count].connected  = client_get_connection(cl) ? 1 : 0;
 868         session_settings_dump(se, client_get_database(cl), w);
 869         res[*count].settings_xml = nmem_strdup(nmem, wrbuf_cstr(w));
 870         wrbuf_destroy(w);
 871         (*count)++;
 872     }
 873     session_leave(se);
 874     return res;
 875 }
 876
 877 struct termlist_score **get_termlist_score(struct session *se,
 878                                            const char *name, int *num)
 879 {
 880     int i;
 881     struct termlist_score **tl = 0;
 882
 883     session_enter(se);
 884     for (i = 0; i < se->num_termlists; i++)
 885         if (!strcmp((const char *) se->termlists[i].name, name))
 886         {
 887             tl = termlist_highscore(se->termlists[i].termlist, num);
 888             break;
 889         }
 890     session_leave(se);
 891     return tl;
 892 }
 893
 894 #ifdef MISSING_HEADERS
 895 void report_nmem_stats(void)
 896 {
 897     size_t in_use, is_free;
 898
 899     nmem_get_memory_in_use(&in_use);
 900     nmem_get_memory_free(&is_free);
 901
 902     yaz_log(YLOG_LOG, "nmem stat: use=%ld free=%ld",
 903             (long) in_use, (long) is_free);
 904 }
 905 #endif
 906
 907 struct record_cluster *show_single_start(struct session *se, const char *id,
 908                                          struct record_cluster **prev_r,
 909                                          struct record_cluster **next_r)
 910 {
 911     struct record_cluster *r = 0;
 912
 913     session_enter(se);
 914     *prev_r = 0;
 915     *next_r = 0;
 916     if (se->reclist)
 917     {
 918         reclist_enter(se->reclist);
 919         while ((r = reclist_read_record(se->reclist)))
 920         {
 921             if (!strcmp(r->recid, id))
 922             {
 923                 *next_r = reclist_read_record(se->reclist);
 924                 break;
 925             }
 926             *prev_r = r;
 927         }
 928         reclist_leave(se->reclist);
 929     }
 930     if (!r)
 931         session_leave(se);
 932     return r;
 933 }
 934
 935 void show_single_stop(struct session *se, struct record_cluster *rec)
 936 {
 937     session_leave(se);
 938 }
 939
 940 struct record_cluster **show_range_start(struct session *se,
 941                                          struct reclist_sortparms *sp,
 942                                          int start, int *num, int *total, Odr_int *sumhits)
 943 {
 944     struct record_cluster **recs;
 945     struct reclist_sortparms *spp;
 946     int i;
 947 #if USE_TIMING
 948     yaz_timing_t t = yaz_timing_create();
 949 #endif
 950     session_enter(se);
 951     recs = nmem_malloc(se->nmem, *num * sizeof(struct record_cluster *));
 952     if (!se->relevance)
 953     {
 954         *num = 0;
 955         *total = 0;
 956         *sumhits = 0;
 957         recs = 0;
 958     }
 959     else
 960     {
 961         for (spp = sp; spp; spp = spp->next)
 962             if (spp->type == Metadata_sortkey_relevance)
 963             {
 964                 relevance_prepare_read(se->relevance, se->reclist);
 965                 break;
 966             }
 967         reclist_sort(se->reclist, sp);
 968
 969         reclist_enter(se->reclist);
 970         *total = reclist_get_num_records(se->reclist);
 971         *sumhits = se->total_hits;
 972
 973         for (i = 0; i < start; i++)
 974             if (!reclist_read_record(se->reclist))
 975             {
 976                 *num = 0;
 977                 recs = 0;
 978                 break;
 979             }
 980
 981         for (i = 0; i < *num; i++)
 982         {
 983             struct record_cluster *r = reclist_read_record(se->reclist);
 984             if (!r)
 985             {
 986                 *num = i;
 987                 break;
 988             }
 989             recs[i] = r;
 990         }
 991         reclist_leave(se->reclist);
 992     }
 993 #if USE_TIMING
 994     yaz_timing_stop(t);
 995     yaz_log(YLOG_LOG, "show %6.5f %3.2f %3.2f",
 996             yaz_timing_get_real(t), yaz_timing_get_user(t),
 997             yaz_timing_get_sys(t));
 998     yaz_timing_destroy(&t);
 999 #endif
1000     return recs;
1001 }
1002
1003 void show_range_stop(struct session *se, struct record_cluster **recs)
1004 {
1005     session_leave(se);
1006 }
1007
1008 void statistics(struct session *se, struct statistics *stat)
1009 {
1010     struct client_list *l;
1011     int count = 0;
1012
1013     memset(stat, 0, sizeof(*stat));
1014     for (l = se->clients; l; l = l->next)
1015     {
1016         struct client *cl = l->client;
1017         if (!client_get_connection(cl))
1018             stat->num_no_connection++;
1019         switch (client_get_state(cl))
1020         {
1021         case Client_Connecting: stat->num_connecting++; break;
1022         case Client_Working: stat->num_working++; break;
1023         case Client_Idle: stat->num_idle++; break;
1024         case Client_Failed: stat->num_failed++; break;
1025         case Client_Error: stat->num_error++; break;
1026         default: break;
1027         }
1028         count++;
1029     }
1030     stat->num_hits = se->total_hits;
1031     stat->num_records = se->total_records;
1032
1033     stat->num_clients = count;
1034 }
1035
1036 static struct record_metadata *record_metadata_init(
1037     NMEM nmem, const char *value, enum conf_metadata_type type,
1038     struct _xmlAttr *attr)
1039 {
1040     struct record_metadata *rec_md = record_metadata_create(nmem);
1041     struct record_metadata_attr **attrp = &rec_md->attributes;
1042
1043     for (; attr; attr = attr->next)
1044     {
1045         if (attr->children && attr->children->content)
1046         {
1047             if (strcmp((const char *) attr->name, "type"))
1048             {  /* skip the "type" attribute.. Its value is already part of
1049                   the element in output (md-%s) and so repeating it here
1050                   is redundant */
1051                 *attrp = nmem_malloc(nmem, sizeof(**attrp));
1052                 (*attrp)->name =
1053                     nmem_strdup(nmem, (const char *) attr->name);
1054                 (*attrp)->value =
1055                     nmem_strdup(nmem, (const char *) attr->children->content);
1056                 attrp = &(*attrp)->next;
1057             }
1058         }
1059     }
1060     *attrp = 0;
1061
1062     if (type == Metadata_type_generic)
1063     {
1064         char *p = nmem_strdup(nmem, value);
1065
1066         p = normalize7bit_generic(p, " ,/.:([");
1067
1068         rec_md->data.text.disp = p;
1069         rec_md->data.text.sort = 0;
1070     }
1071     else if (type == Metadata_type_year || type == Metadata_type_date)
1072     {
1073         int first, last;
1074         int longdate = 0;
1075
1076         if (type == Metadata_type_date)
1077             longdate = 1;
1078         if (extract7bit_dates((char *) value, &first, &last, longdate) < 0)
1079             return 0;
1080
1081         rec_md->data.number.min = first;
1082         rec_md->data.number.max = last;
1083     }
1084     else
1085         return 0;
1086     return rec_md;
1087 }
1088
1089 static int get_mergekey_from_doc(xmlDoc *doc, xmlNode *root, const char *name,
1090                                  struct conf_service *service, WRBUF norm_wr)
1091 {
1092     xmlNode *n;
1093     int no_found = 0;
1094     for (n = root->children; n; n = n->next)
1095     {
1096         if (n->type != XML_ELEMENT_NODE)
1097             continue;
1098         if (!strcmp((const char *) n->name, "metadata"))
1099         {
1100             xmlChar *type = xmlGetProp(n, (xmlChar *) "type");
1101             if (type == NULL) {
1102                 yaz_log(YLOG_FATAL, "Missing type attribute on metadata element. Skipping!");
1103             }
1104             else if (!strcmp(name, (const char *) type))
1105             {
1106                 xmlChar *value = xmlNodeListGetString(doc, n->children, 1);
1107                 if (value)
1108                 {
1109                     const char *norm_str;
1110                     pp2_relevance_token_t prt =
1111                         pp2_relevance_tokenize(service->mergekey_pct);
1112
1113                     pp2_relevance_first(prt, (const char *) value, 0);
1114                     if (wrbuf_len(norm_wr) > 0)
1115                         wrbuf_puts(norm_wr, " ");
1116                     wrbuf_puts(norm_wr, name);
1117                     while ((norm_str =
1118                             pp2_relevance_token_next(prt)))
1119                     {
1120                         if (*norm_str)
1121                         {
1122                             wrbuf_puts(norm_wr, " ");
1123                             wrbuf_puts(norm_wr, norm_str);
1124                         }
1125                     }
1126                     xmlFree(value);
1127                     pp2_relevance_token_destroy(prt);
1128                     no_found++;
1129                 }
1130             }
1131             xmlFree(type);
1132         }
1133     }
1134     return no_found;
1135 }
1136
1137 static const char *get_mergekey(xmlDoc *doc, struct client *cl, int record_no,
1138                                 struct conf_service *service, NMEM nmem)
1139 {
1140     char *mergekey_norm = 0;
1141     xmlNode *root = xmlDocGetRootElement(doc);
1142     WRBUF norm_wr = wrbuf_alloc();
1143
1144     /* consider mergekey from XSL first */
1145     xmlChar *mergekey = xmlGetProp(root, (xmlChar *) "mergekey");
1146     if (mergekey)
1147     {
1148         const char *norm_str;
1149         pp2_relevance_token_t prt =
1150             pp2_relevance_tokenize(service->mergekey_pct);
1151
1152         pp2_relevance_first(prt, (const char *) mergekey, 0);
1153         while ((norm_str = pp2_relevance_token_next(prt)))
1154         {
1155             if (*norm_str)
1156             {
1157                 if (wrbuf_len(norm_wr))
1158                     wrbuf_puts(norm_wr, " ");
1159                 wrbuf_puts(norm_wr, norm_str);
1160             }
1161         }
1162         pp2_relevance_token_destroy(prt);
1163         xmlFree(mergekey);
1164     }
1165     else
1166     {
1167         /* no mergekey defined in XSL. Look for mergekey metadata instead */
1168         int field_id;
1169         for (field_id = 0; field_id < service->num_metadata; field_id++)
1170         {
1171             struct conf_metadata *ser_md = &service->metadata[field_id];
1172             if (ser_md->mergekey != Metadata_mergekey_no)
1173             {
1174                 int r = get_mergekey_from_doc(doc, root, ser_md->name,
1175                                               service, norm_wr);
1176                 if (r == 0 && ser_md->mergekey == Metadata_mergekey_required)
1177                 {
1178                     /* no mergekey on this one and it is required..
1179                        Generate unique key instead */
1180                     wrbuf_rewind(norm_wr);
1181                     break;
1182                 }
1183             }
1184         }
1185     }
1186
1187     /* generate unique key if none is not generated already or is empty */
1188     if (wrbuf_len(norm_wr) == 0)
1189     {
1190         wrbuf_printf(norm_wr, "%s-%d",
1191                      client_get_database(cl)->database->url, record_no);
1192     }
1193     if (wrbuf_len(norm_wr) > 0)
1194         mergekey_norm = nmem_strdup(nmem, wrbuf_cstr(norm_wr));
1195     wrbuf_destroy(norm_wr);
1196     return mergekey_norm;
1197 }
1198
1199 /** \brief see if metadata for pz:recordfilter exists
1200     \param root xml root element of normalized record
1201     \param sdb session database for client
1202     \retval 0 if there is no metadata for pz:recordfilter
1203     \retval 1 if there is metadata for pz:recordfilter
1204
1205     If there is no pz:recordfilter defined, this function returns 1
1206     as well.
1207 */
1208
1209 static int check_record_filter(xmlNode *root, struct session_database *sdb)
1210 {
1211     int match = 0;
1212     xmlNode *n;
1213     const char *s;
1214     s = session_setting_oneval(sdb, PZ_RECORDFILTER);
1215
1216     if (!s || !*s)
1217         return 1;
1218
1219     for (n = root->children; n; n = n->next)
1220     {
1221         if (n->type != XML_ELEMENT_NODE)
1222             continue;
1223         if (!strcmp((const char *) n->name, "metadata"))
1224         {
1225             xmlChar *type = xmlGetProp(n, (xmlChar *) "type");
1226             if (type)
1227             {
1228                 size_t len;
1229                 int substring;
1230                 const char *eq;
1231
1232                 if ((eq = strchr(s, '=')))
1233                     substring = 0;
1234                 else if ((eq = strchr(s, '~')))
1235                     substring = 1;
1236                 if (eq)
1237                     len = eq - s;
1238                 else
1239                     len = strlen(s);
1240                 if (len == strlen((const char *)type) &&
1241                     !memcmp((const char *) type, s, len))
1242                 {
1243                     xmlChar *value = xmlNodeGetContent(n);
1244                     if (value && *value)
1245                     {
1246                         if (!eq ||
1247                             (substring && strstr((const char *) value, eq+1)) ||
1248                             (!substring && !strcmp((const char *) value, eq + 1)))
1249                             match = 1;
1250                     }
1251                     xmlFree(value);
1252                 }
1253                 xmlFree(type);
1254             }
1255         }
1256     }
1257     return match;
1258 }
1259
1260
1261 static int ingest_to_cluster(struct client *cl,
1262                              xmlDoc *xdoc,
1263                              xmlNode *root,
1264                              int record_no,
1265                              const char *mergekey_norm);
1266
1267 /** \brief ingest XML record
1268     \param cl client holds the result set for record
1269     \param rec record buffer (0 terminated)
1270     \param record_no record position (1, 2, ..)
1271     \param nmem working NMEM
1272     \retval 0 OK
1273     \retval -1 failure
1274     \retval -2 Filtered
1275 */
1276 int ingest_record(struct client *cl, const char *rec,
1277                   int record_no, NMEM nmem)
1278 {
1279     struct session *se = client_get_session(cl);
1280     int ret = 0;
1281     struct session_database *sdb = client_get_database(cl);
1282     struct conf_service *service = se->service;
1283     xmlDoc *xdoc = normalize_record(se, sdb, service, rec, nmem);
1284     xmlNode *root;
1285     const char *mergekey_norm;
1286
1287     if (!xdoc)
1288         return -1;
1289
1290     root = xmlDocGetRootElement(xdoc);
1291
1292     if (!check_record_filter(root, sdb))
1293     {
1294         session_log(se, YLOG_LOG, "Filtered out record no %d from %s",
1295                     record_no, sdb->database->url);
1296         xmlFreeDoc(xdoc);
1297         return -2;
1298     }
1299
1300     mergekey_norm = get_mergekey(xdoc, cl, record_no, service, nmem);
1301     if (!mergekey_norm)
1302     {
1303         session_log(se, YLOG_WARN, "Got no mergekey");
1304         xmlFreeDoc(xdoc);
1305         return -1;
1306     }
1307     session_enter(se);
1308     if (client_get_session(cl) == se)
1309         ret = ingest_to_cluster(cl, xdoc, root, record_no, mergekey_norm);
1310     session_leave(se);
1311
1312     xmlFreeDoc(xdoc);
1313     return ret;
1314 }
1315
1316 static int ingest_to_cluster(struct client *cl,
1317                              xmlDoc *xdoc,
1318                              xmlNode *root,
1319                              int record_no,
1320                              const char *mergekey_norm)
1321 {
1322     xmlNode *n;
1323     xmlChar *type = 0;
1324     xmlChar *value = 0;
1325     struct session_database *sdb = client_get_database(cl);
1326     struct session *se = client_get_session(cl);
1327     struct conf_service *service = se->service;
1328     struct record *record = record_create(se->nmem,
1329                                           service->num_metadata,
1330                                           service->num_sortkeys, cl,
1331                                           record_no);
1332     struct record_cluster *cluster = reclist_insert(se->reclist,
1333                                                     service,
1334                                                     record,
1335                                                     mergekey_norm,
1336                                                     &se->total_merged);
1337
1338     const char *use_term_factor_str = session_setting_oneval(sdb, PZ_TERMLIST_TERM_FACTOR);
1339     int use_term_factor = 0;
1340     int term_factor = 1;
1341     if (use_term_factor_str && use_term_factor_str[0] != 0)
1342        use_term_factor =  atoi(use_term_factor_str);
1343     if (use_term_factor) {
1344         int maxrecs = client_get_maxrecs(cl);
1345         int hits = (int) client_get_hits(cl);
1346         term_factor = MAX(hits, maxrecs) /  MAX(1, maxrecs);
1347         assert(term_factor >= 1);
1348         yaz_log(YLOG_DEBUG, "Using term factor: %d (%d / %d)", term_factor, MAX(hits, maxrecs), MAX(1, maxrecs));
1349     }
1350
1351     if (!cluster)
1352         return -1;
1353     if (global_parameters.dump_records)
1354         session_log(se, YLOG_LOG, "Cluster id %s from %s (#%d)", cluster->recid,
1355                     sdb->database->url, record_no);
1356     relevance_newrec(se->relevance, cluster);
1357
1358     // now parsing XML record and adding data to cluster or record metadata
1359     for (n = root->children; n; n = n->next)
1360     {
1361         pp2_relevance_token_t prt;
1362         if (type)
1363             xmlFree(type);
1364         if (value)
1365             xmlFree(value);
1366         type = value = 0;
1367
1368         if (n->type != XML_ELEMENT_NODE)
1369             continue;
1370         if (!strcmp((const char *) n->name, "metadata"))
1371         {
1372             struct conf_metadata *ser_md = 0;
1373             struct conf_sortkey *ser_sk = 0;
1374             struct record_metadata **wheretoput = 0;
1375             struct record_metadata *rec_md = 0;
1376             int md_field_id = -1;
1377             int sk_field_id = -1;
1378
1379             type = xmlGetProp(n, (xmlChar *) "type");
1380             value = xmlNodeListGetString(xdoc, n->children, 1);
1381
1382             if (!type || !value || !*value)
1383                 continue;
1384
1385             md_field_id
1386                 = conf_service_metadata_field_id(service, (const char *) type);
1387             if (md_field_id < 0)
1388             {
1389                 if (se->number_of_warnings_unknown_metadata == 0)
1390                 {
1391                     session_log(se, YLOG_WARN,
1392                             "Ignoring unknown metadata element: %s", type);
1393                 }
1394                 se->number_of_warnings_unknown_metadata++;
1395                 continue;
1396             }
1397
1398             ser_md = &service->metadata[md_field_id];
1399
1400             if (ser_md->sortkey_offset >= 0){
1401                 sk_field_id = ser_md->sortkey_offset;
1402                 ser_sk = &service->sortkeys[sk_field_id];
1403             }
1404
1405             // non-merged metadata
1406             rec_md = record_metadata_init(se->nmem, (const char *) value,
1407                                           ser_md->type, n->properties);
1408             if (!rec_md)
1409             {
1410                 session_log(se, YLOG_WARN, "bad metadata data '%s' "
1411                             "for element '%s'", value, type);
1412                 continue;
1413             }
1414             wheretoput = &record->metadata[md_field_id];
1415             while (*wheretoput)
1416                 wheretoput = &(*wheretoput)->next;
1417             *wheretoput = rec_md;
1418
1419             // merged metadata
1420             rec_md = record_metadata_init(se->nmem, (const char *) value,
1421                                           ser_md->type, 0);
1422             wheretoput = &cluster->metadata[md_field_id];
1423
1424             // and polulate with data:
1425             // assign cluster or record based on merge action
1426             if (ser_md->merge == Metadata_merge_unique)
1427             {
1428                 struct record_metadata *mnode;
1429                 for (mnode = *wheretoput; mnode; mnode = mnode->next)
1430                     if (!strcmp((const char *) mnode->data.text.disp,
1431                                 rec_md->data.text.disp))
1432                         break;
1433                 if (!mnode)
1434                 {
1435                     rec_md->next = *wheretoput;
1436                     *wheretoput = rec_md;
1437                 }
1438             }
1439             else if (ser_md->merge == Metadata_merge_longest)
1440             {
1441                 if (!*wheretoput
1442                     || strlen(rec_md->data.text.disp)
1443                     > strlen((*wheretoput)->data.text.disp))
1444                 {
1445                     *wheretoput = rec_md;
1446                     if (ser_sk)
1447                     {
1448                         const char *sort_str = 0;
1449                         int skip_article =
1450                             ser_sk->type == Metadata_sortkey_skiparticle;
1451
1452                         if (!cluster->sortkeys[sk_field_id])
1453                             cluster->sortkeys[sk_field_id] =
1454                                 nmem_malloc(se->nmem,
1455                                             sizeof(union data_types));
1456
1457                         prt = pp2_relevance_tokenize(service->sort_pct);
1458
1459                         pp2_relevance_first(prt, rec_md->data.text.disp,
1460                                             skip_article);
1461
1462                         pp2_relevance_token_next(prt);
1463
1464                         sort_str = pp2_get_sort(prt);
1465
1466                         cluster->sortkeys[sk_field_id]->text.disp =
1467                             rec_md->data.text.disp;
1468                         if (!sort_str)
1469                         {
1470                             sort_str = rec_md->data.text.disp;
1471                             session_log(se, YLOG_WARN,
1472                                     "Could not make sortkey. Bug #1858");
1473                         }
1474                         cluster->sortkeys[sk_field_id]->text.sort =
1475                             nmem_strdup(se->nmem, sort_str);
1476                         pp2_relevance_token_destroy(prt);
1477                     }
1478                 }
1479             }
1480             else if (ser_md->merge == Metadata_merge_all)
1481             {
1482                 rec_md->next = *wheretoput;
1483                 *wheretoput = rec_md;
1484             }
1485             else if (ser_md->merge == Metadata_merge_range)
1486             {
1487                 if (!*wheretoput)
1488                 {
1489                     *wheretoput = rec_md;
1490                     if (ser_sk)
1491                         cluster->sortkeys[sk_field_id]
1492                             = &rec_md->data;
1493                 }
1494                 else
1495                 {
1496                     int this_min = rec_md->data.number.min;
1497                     int this_max = rec_md->data.number.max;
1498                     if (this_min < (*wheretoput)->data.number.min)
1499                         (*wheretoput)->data.number.min = this_min;
1500                     if (this_max > (*wheretoput)->data.number.max)
1501                         (*wheretoput)->data.number.max = this_max;
1502                 }
1503             }
1504
1505
1506             // ranking of _all_ fields enabled ...
1507             if (ser_md->rank)
1508                 relevance_countwords(se->relevance, cluster,
1509                                      (char *) value, ser_md->rank,
1510                                      ser_md->name);
1511
1512             // construct facets ... unless the client already has reported them
1513             if (ser_md->termlist && !client_has_facet(cl, (char *) type))
1514             {
1515                 if (ser_md->type == Metadata_type_year)
1516                 {
1517                     char year[64];
1518                     sprintf(year, "%d", rec_md->data.number.max);
1519
1520                     add_facet(se, (char *) type, year, term_factor);
1521                     if (rec_md->data.number.max != rec_md->data.number.min)
1522                     {
1523                         sprintf(year, "%d", rec_md->data.number.min);
1524                         add_facet(se, (char *) type, year, term_factor);
1525                     }
1526                 }
1527                 else
1528                     add_facet(se, (char *) type, (char *) value, term_factor);
1529             }
1530
1531             // cleaning up
1532             xmlFree(type);
1533             xmlFree(value);
1534             type = value = 0;
1535         }
1536         else
1537         {
1538             if (se->number_of_warnings_unknown_elements == 0)
1539                 session_log(se, YLOG_WARN,
1540                         "Unexpected element in internal record: %s", n->name);
1541             se->number_of_warnings_unknown_elements++;
1542         }
1543     }
1544     if (type)
1545         xmlFree(type);
1546     if (value)
1547         xmlFree(value);
1548
1549     relevance_donerecord(se->relevance, cluster);
1550     se->total_records++;
1551
1552     return 0;
1553 }
1554
1555 void session_log(struct session *s, int level, const char *fmt, ...)
1556 {
1557     char buf[1024];
1558     va_list ap;
1559     va_start(ap, fmt);
1560
1561     yaz_vsnprintf(buf, sizeof(buf)-30, fmt, ap);
1562     yaz_log(level, "Session (%u): %s", s->session_id, buf);
1563
1564     va_end(ap);
1565 }
1566
1567 /*
1568  * Local variables:
1569  * c-basic-offset: 4
1570  * c-file-style: "Stroustrup"
1571  * indent-tabs-mode: nil
1572  * End:
1573  * vim: shiftwidth=4 tabstop=8 expandtab
1574  */
1575