src/session.c

   1 /* This file is part of Pazpar2.
   2    Copyright (C) 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/xml_get.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 #include <libxml/tree.h>
  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
 102 static int session_use(int delta)
 103 {
 104     int sessions;
 105     if (!g_session_mutex)
 106         yaz_mutex_create(&g_session_mutex);
 107     yaz_mutex_enter(g_session_mutex);
 108     no_sessions += delta;
 109     sessions = no_sessions;
 110     yaz_mutex_leave(g_session_mutex);
 111     yaz_log(YLOG_DEBUG, "%s sessions=%d", delta == 0 ? "" :
 112             (delta > 0 ? "INC" : "DEC"), no_sessions);
 113     return sessions;
 114 }
 115
 116 int sessions_count(void)
 117 {
 118     return session_use(0);
 119 }
 120
 121 static void log_xml_doc(xmlDoc *doc)
 122 {
 123     FILE *lf = yaz_log_file();
 124     xmlChar *result = 0;
 125     int len = 0;
 126 #if LIBXML_VERSION >= 20600
 127     xmlDocDumpFormatMemory(doc, &result, &len, 1);
 128 #else
 129     xmlDocDumpMemory(doc, &result, &len);
 130 #endif
 131     if (lf && len)
 132     {
 133         (void) fwrite(result, 1, len, lf);
 134         fprintf(lf, "\n");
 135     }
 136     xmlFree(result);
 137 }
 138
 139 static void session_enter(struct session *s, const char *caller)
 140 {
 141     if (caller)
 142         session_log(s, YLOG_DEBUG, "Session lock by %s", caller);
 143     yaz_mutex_enter(s->session_mutex);
 144 }
 145
 146 static void session_leave(struct session *s, const char *caller)
 147 {
 148     yaz_mutex_leave(s->session_mutex);
 149     if (caller)
 150         session_log(s, YLOG_DEBUG, "Session unlock by %s", caller);
 151 }
 152
 153 static int run_icu(struct session *s, const char *icu_chain_id,
 154                    const char *value,
 155                    WRBUF norm_wr, WRBUF disp_wr)
 156 {
 157     const char *facet_component;
 158     struct conf_service *service = s->service;
 159     pp2_charset_token_t prt =
 160         pp2_charset_token_create(service->charsets, icu_chain_id);
 161     if (!prt)
 162     {
 163         session_log(s, YLOG_FATAL,
 164                     "Unknown ICU chain '%s'", icu_chain_id);
 165         return 0;
 166     }
 167     pp2_charset_token_first(prt, value, 0);
 168     while ((facet_component = pp2_charset_token_next(prt)))
 169     {
 170         const char *display_component;
 171         if (*facet_component)
 172         {
 173             if (wrbuf_len(norm_wr))
 174                 wrbuf_puts(norm_wr, " ");
 175             wrbuf_puts(norm_wr, facet_component);
 176         }
 177         display_component = pp2_get_display(prt);
 178         if (display_component)
 179         {
 180             if (wrbuf_len(disp_wr))
 181                 wrbuf_puts(disp_wr, " ");
 182             wrbuf_puts(disp_wr, display_component);
 183         }
 184     }
 185     pp2_charset_token_destroy(prt);
 186     return 1;
 187 }
 188
 189 static void session_normalize_facet(struct session *s,
 190                                     const char *type, const char *value,
 191                                     WRBUF display_wrbuf, WRBUF facet_wrbuf)
 192 {
 193     struct conf_service *service = s->service;
 194     int i;
 195     const char *icu_chain_id = 0;
 196
 197     for (i = 0; i < service->num_metadata; i++)
 198         if (!strcmp((service->metadata + i)->name, type))
 199             icu_chain_id = (service->metadata + i)->facetrule;
 200     if (!icu_chain_id)
 201         icu_chain_id = "facet";
 202
 203     run_icu(s, icu_chain_id, value, facet_wrbuf, display_wrbuf);
 204 }
 205
 206 void add_facet(struct session *s, const char *type, const char *value, int count)
 207 {
 208     WRBUF facet_wrbuf = wrbuf_alloc();
 209     WRBUF display_wrbuf = wrbuf_alloc();
 210
 211     session_normalize_facet(s, type, value, display_wrbuf, facet_wrbuf);
 212
 213     if (wrbuf_len(facet_wrbuf))
 214     {
 215         struct named_termlist **tp = &s->termlists;
 216         for (; (*tp); tp = &(*tp)->next)
 217             if (!strcmp((*tp)->name, type))
 218                 break;
 219         if (!*tp)
 220         {
 221             *tp = nmem_malloc(s->nmem, sizeof(**tp));
 222             (*tp)->name = nmem_strdup(s->nmem, type);
 223             (*tp)->termlist = termlist_create(s->nmem);
 224             (*tp)->next = 0;
 225         }
 226         termlist_insert((*tp)->termlist, wrbuf_cstr(display_wrbuf),
 227                         wrbuf_cstr(facet_wrbuf), count);
 228     }
 229     wrbuf_destroy(facet_wrbuf);
 230     wrbuf_destroy(display_wrbuf);
 231 }
 232
 233 static xmlDoc *record_to_xml(struct session *se,
 234                              struct session_database *sdb, const char *rec)
 235 {
 236     struct database *db = sdb->database;
 237     xmlDoc *rdoc = 0;
 238
 239     rdoc = xmlParseMemory(rec, strlen(rec));
 240
 241     if (!rdoc)
 242     {
 243         session_log(se, YLOG_WARN, "Non-wellformed XML");
 244         return 0;
 245     }
 246
 247     if (global_parameters.dump_records)
 248     {
 249         session_log(se, YLOG_LOG, "Un-normalized record from %s", db->id);
 250         log_xml_doc(rdoc);
 251     }
 252
 253     return rdoc;
 254 }
 255
 256 #define MAX_XSLT_ARGS 16
 257
 258 // Add static values from session database settings if applicable
 259 static void insert_settings_parameters(struct session_database *sdb,
 260                                        struct conf_service *service,
 261                                        char **parms,
 262                                        NMEM nmem)
 263 {
 264     int i;
 265     int nparms = 0;
 266     int offset = 0;
 267
 268     for (i = 0; i < service->num_metadata; i++)
 269     {
 270         struct conf_metadata *md = &service->metadata[i];
 271         int setting;
 272
 273         if (md->setting == Metadata_setting_parameter &&
 274             (setting = settings_lookup_offset(service, md->name)) >= 0)
 275         {
 276             const char *val = session_setting_oneval(sdb, setting);
 277             if (val && nparms < MAX_XSLT_ARGS)
 278             {
 279                 char *buf;
 280                 int len = strlen(val);
 281                 buf = nmem_malloc(nmem, len + 3);
 282                 buf[0] = '\'';
 283                 strcpy(buf + 1, val);
 284                 buf[len+1] = '\'';
 285                 buf[len+2] = '\0';
 286                 parms[offset++] = md->name;
 287                 parms[offset++] = buf;
 288                 nparms++;
 289             }
 290         }
 291     }
 292     parms[offset] = 0;
 293 }
 294
 295 // Add static values from session database settings if applicable
 296 static void insert_settings_values(struct session_database *sdb, xmlDoc *doc,
 297                                    xmlNode *root,
 298                                    struct conf_service *service)
 299 {
 300     int i;
 301
 302     for (i = 0; i < service->num_metadata; i++)
 303     {
 304         struct conf_metadata *md = &service->metadata[i];
 305         int offset;
 306
 307         if (md->setting == Metadata_setting_postproc &&
 308             (offset = settings_lookup_offset(service, md->name)) >= 0)
 309         {
 310             const char *val = session_setting_oneval(sdb, offset);
 311             if (val)
 312             {
 313                 xmlNode *n = xmlNewTextChild(root, 0, (xmlChar *) "metadata",
 314                                              (xmlChar *) val);
 315                 xmlSetProp(n, (xmlChar *) "type", (xmlChar *) md->name);
 316             }
 317         }
 318     }
 319 }
 320
 321 static xmlDoc *normalize_record(struct session *se,
 322                                 struct session_database *sdb,
 323                                 struct conf_service *service,
 324                                 const char *rec, NMEM nmem)
 325 {
 326     xmlDoc *rdoc = record_to_xml(se, sdb, rec);
 327
 328     if (rdoc)
 329     {
 330         char *parms[MAX_XSLT_ARGS*2+1];
 331
 332         insert_settings_parameters(sdb, service, parms, nmem);
 333
 334         if (normalize_record_transform(sdb->map, &rdoc, (const char **)parms))
 335         {
 336             session_log(se, YLOG_WARN, "Normalize failed");
 337         }
 338     }
 339     return rdoc;
 340 }
 341
 342 void session_settings_dump(struct session *se,
 343                            struct session_database *db,
 344                            WRBUF w)
 345 {
 346     if (db->settings)
 347     {
 348         int i, num = db->num_settings;
 349         for (i = 0; i < num; i++)
 350         {
 351             struct setting *s = db->settings[i];
 352             for (;s ; s = s->next)
 353             {
 354                 wrbuf_puts(w, "<set name=\"");
 355                 wrbuf_xmlputs(w, s->name);
 356                 wrbuf_puts(w, "\" value=\"");
 357                 wrbuf_xmlputs(w, s->value);
 358                 wrbuf_puts(w, "\"/>");
 359             }
 360             if (db->settings[i])
 361                 wrbuf_puts(w, "\n");
 362         }
 363     }
 364 }
 365
 366 // Retrieve first defined value for 'name' for given database.
 367 // Will be extended to take into account user associated with session
 368 const char *session_setting_oneval(struct session_database *db, int offset)
 369 {
 370     if (offset >= db->num_settings || !db->settings[offset])
 371         return "";
 372     return db->settings[offset]->value;
 373 }
 374
 375 // Prepare XSLT stylesheets for record normalization
 376 // Structures are allocated on the session_wide nmem to avoid having
 377 // to recompute this for every search. This would lead
 378 // to leaking if a single session was to repeatedly change the PZ_XSLT
 379 // setting. However, this is not a realistic use scenario.
 380 static int prepare_map(struct session *se, struct session_database *sdb)
 381 {
 382     if (sdb->settings && !sdb->map)
 383     {
 384         const char *s;
 385
 386         if (sdb->settings[PZ_XSLT] &&
 387             (s = session_setting_oneval(sdb, PZ_XSLT)))
 388         {
 389             char auto_stylesheet[256];
 390
 391             if (!strcmp(s, "auto"))
 392             {
 393                 const char *request_syntax = session_setting_oneval(
 394                     sdb, PZ_REQUESTSYNTAX);
 395                 if (request_syntax)
 396                 {
 397                     char *cp;
 398                     yaz_snprintf(auto_stylesheet, sizeof(auto_stylesheet),
 399                                  "%s.xsl", request_syntax);
 400                     for (cp = auto_stylesheet; *cp; cp++)
 401                     {
 402                         /* deliberately only consider ASCII */
 403                         if (*cp > 32 && *cp < 127)
 404                             *cp = tolower(*cp);
 405                     }
 406                     s = auto_stylesheet;
 407                 }
 408                 else
 409                 {
 410                     session_log(se, YLOG_WARN,
 411                                 "No pz:requestsyntax for auto stylesheet");
 412                 }
 413             }
 414             sdb->map = normalize_cache_get(se->normalize_cache,
 415                                            se->service, s);
 416             if (!sdb->map)
 417                 return -1;
 418         }
 419     }
 420     return 0;
 421 }
 422
 423 // called if watch should be removed because http_channel is to be destroyed
 424 static void session_watch_cancel(void *data, struct http_channel *c,
 425                                  void *data2)
 426 {
 427     struct session_watchentry *ent = data;
 428
 429     ent->fun = 0;
 430     ent->data = 0;
 431     ent->obs = 0;
 432 }
 433
 434 // set watch. Returns 0=OK, -1 if watch is already set
 435 int session_set_watch(struct session *s, int what,
 436                       session_watchfun fun, void *data,
 437                       struct http_channel *chan)
 438 {
 439     int ret;
 440     session_enter(s, "session_set_watch");
 441     if (s->watchlist[what].fun)
 442         ret = -1;
 443     else
 444     {
 445
 446         s->watchlist[what].fun = fun;
 447         s->watchlist[what].data = data;
 448         s->watchlist[what].obs = http_add_observer(chan, &s->watchlist[what],
 449                                                    session_watch_cancel);
 450         ret = 0;
 451     }
 452     session_leave(s, "session_set_watch");
 453     return ret;
 454 }
 455
 456 void session_alert_watch(struct session *s, int what)
 457 {
 458     assert(s);
 459     session_enter(s, "session_alert_watch");
 460     if (s->watchlist[what].fun)
 461     {
 462         /* our watch is no longer associated with http_channel */
 463         void *data;
 464         session_watchfun fun;
 465
 466         http_remove_observer(s->watchlist[what].obs);
 467         fun  = s->watchlist[what].fun;
 468         data = s->watchlist[what].data;
 469
 470         /* reset watch before fun is invoked - in case fun wants to set
 471            it again */
 472         s->watchlist[what].fun = 0;
 473         s->watchlist[what].data = 0;
 474         s->watchlist[what].obs = 0;
 475
 476         session_leave(s, "session_alert_watch");
 477         session_log(s, YLOG_DEBUG,
 478                     "Alert Watch: %d calling function: %p", what, fun);
 479         fun(data);
 480     }
 481     else
 482         session_leave(s,"session_alert_watch");
 483 }
 484
 485 //callback for grep_databases
 486 static void select_targets_callback(struct session *se,
 487                                     struct session_database *db)
 488 {
 489     struct client *cl;
 490     struct client_list *l;
 491
 492     for (l = se->clients_cached; l; l = l->next)
 493         if (client_get_database(l->client) == db)
 494             break;
 495
 496     if (l)
 497         cl = l->client;
 498     else
 499     {
 500         cl = client_create(db->database->id);
 501         client_set_database(cl, db);
 502
 503         l = xmalloc(sizeof(*l));
 504         l->client = cl;
 505         l->next = se->clients_cached;
 506         se->clients_cached = l;
 507     }
 508     /* set session always. If may be 0 if client is not active */
 509     client_set_session(cl, se);
 510
 511     l = xmalloc(sizeof(*l));
 512     l->client = cl;
 513     l->next = se->clients_active;
 514     se->clients_active = l;
 515 }
 516
 517 static void session_reset_active_clients(struct session *se,
 518                                          struct client_list *new_list)
 519 {
 520     struct client_list *l;
 521
 522     session_enter(se, "session_reset_active_clients");
 523     l = se->clients_active;
 524     se->clients_active = new_list;
 525     session_leave(se, "session_reset_active_clients");
 526
 527     while (l)
 528     {
 529         struct client_list *l_next = l->next;
 530
 531         client_lock(l->client);
 532         client_set_session(l->client, 0); /* mark client inactive */
 533         client_unlock(l->client);
 534
 535         xfree(l);
 536         l = l_next;
 537     }
 538 }
 539
 540 static void session_remove_cached_clients(struct session *se)
 541 {
 542     struct client_list *l;
 543
 544     session_reset_active_clients(se, 0);
 545
 546     session_enter(se, "session_remove_cached_clients");
 547     l = se->clients_cached;
 548     se->clients_cached = 0;
 549     session_leave(se, "session_remove_cached_clients");
 550
 551     while (l)
 552     {
 553         struct client_list *l_next = l->next;
 554         client_lock(l->client);
 555         client_set_session(l->client, 0);
 556         client_set_database(l->client, 0);
 557         client_unlock(l->client);
 558         client_destroy(l->client);
 559         xfree(l);
 560         l = l_next;
 561     }
 562 }
 563
 564 // Associates a set of clients with a session;
 565 // Note: Session-databases represent databases with per-session
 566 // setting overrides
 567 static int select_targets(struct session *se, const char *filter)
 568 {
 569     return session_grep_databases(se, filter, select_targets_callback);
 570 }
 571
 572 int session_active_clients(struct session *s)
 573 {
 574     struct client_list *l;
 575     int res = 0;
 576
 577     for (l = s->clients_active; l; l = l->next)
 578         if (client_is_active(l->client))
 579             res++;
 580
 581     return res;
 582 }
 583
 584 int session_is_preferred_clients_ready(struct session *s)
 585 {
 586     struct client_list *l;
 587     int res = 0;
 588
 589     for (l = s->clients_active; l; l = l->next)
 590         if (client_is_active_preferred(l->client))
 591             res++;
 592     session_log(s, YLOG_DEBUG, "Has %d active preferred clients.", res);
 593     return res == 0;
 594 }
 595
 596 static void session_clear_set(struct session *se, struct reclist_sortparms *sp)
 597 {
 598     reclist_destroy(se->reclist);
 599     if (nmem_total(se->nmem))
 600         session_log(se, YLOG_DEBUG, "NMEN operation usage %zd",
 601                     nmem_total(se->nmem));
 602     nmem_reset(se->nmem);
 603     se->total_records = se->total_merged = 0;
 604     se->termlists = 0;
 605     relevance_clear(se->relevance);
 606
 607     /* reset list of sorted results and clear to relevance search */
 608     se->sorted_results = nmem_malloc(se->nmem, sizeof(*se->sorted_results));
 609     se->sorted_results->name = nmem_strdup(se->nmem, sp->name);
 610     se->sorted_results->increasing = sp->increasing;
 611     se->sorted_results->type = sp->type;
 612     se->sorted_results->next = 0;
 613
 614     session_log(se, YLOG_DEBUG, "clear_set session_sort: field=%s increasing=%d type=%d configured",
 615             sp->name, sp->increasing, sp->type);
 616
 617     se->reclist = reclist_create(se->nmem);
 618 }
 619
 620 void session_sort(struct session *se, struct reclist_sortparms *sp,
 621                   const char *mergekey, const char *rank)
 622 {
 623     struct client_list *l;
 624     const char *field = sp->name;
 625     int increasing = sp->increasing;
 626     int type  = sp->type;
 627     int clients_research = 0;
 628
 629     session_enter(se, "session_sort");
 630     session_log(se, YLOG_DEBUG, "session_sort field=%s increasing=%d type=%d",
 631                 field, increasing, type);
 632
 633     if (rank && (!se->rank || strcmp(se->rank, rank)))
 634     {
 635         /* new rank must research/reingest anyway */
 636         assert(rank);
 637         xfree(se->rank);
 638         se->rank = *rank ? xstrdup(rank) : 0;
 639         clients_research = 1;
 640         session_log(se, YLOG_DEBUG, "session_sort: new rank = %s",
 641                     rank);
 642     }
 643     if (mergekey && (!se->mergekey || strcmp(se->mergekey, mergekey)))
 644     {
 645         /* new mergekey must research/reingest anyway */
 646         assert(mergekey);
 647         xfree(se->mergekey);
 648         se->mergekey = *mergekey ? xstrdup(mergekey) : 0;
 649         clients_research = 1;
 650         session_log(se, YLOG_DEBUG, "session_sort: new mergekey = %s",
 651                     mergekey);
 652     }
 653     if (clients_research == 0)
 654     {
 655         struct reclist_sortparms *sr;
 656         for (sr = se->sorted_results; sr; sr = sr->next)
 657             if (!reclist_sortparms_cmp(sr, sp))
 658                 break;
 659         if (sr)
 660         {
 661             session_log(se, YLOG_DEBUG, "session_sort: field=%s increasing=%d type=%d already fetched",
 662                         field, increasing, type);
 663             session_leave(se, "session_sort");
 664             return;
 665         }
 666     }
 667     session_log(se, YLOG_DEBUG, "session_sort: field=%s increasing=%d type=%d must fetch",
 668                 field, increasing, type);
 669
 670     // We need to reset reclist on every sort that changes the records, not just for position
 671     // So if just one client requires new searching, we need to clear set.
 672     // Ask each of the client if sorting requires re-search due to native sort
 673     // If it does it will require us to
 674     for (l = se->clients_active; l; l = l->next)
 675     {
 676         struct client *cl = l->client;
 677         // Assume no re-search is required.
 678         client_parse_init(cl, 1);
 679         clients_research += client_parse_sort(cl, sp);
 680     }
 681     if (!clients_research || se->clients_starting)
 682     {
 683         // A new sorting based on same record set
 684         struct reclist_sortparms *sr = nmem_malloc(se->nmem, sizeof(*sr));
 685         sr->name = nmem_strdup(se->nmem, field);
 686         sr->increasing = increasing;
 687         sr->type = type;
 688         sr->next = se->sorted_results;
 689         se->sorted_results = sr;
 690         session_log(se, YLOG_DEBUG, "session_sort: no research/ingesting done");
 691         session_leave(se, "session_sort");
 692     }
 693     else
 694     {
 695         se->clients_starting = 1;
 696         session_log(se, YLOG_DEBUG,
 697                     "session_sort: reset results due to %d clients researching",
 698                     clients_research);
 699         session_clear_set(se, sp);
 700         session_log(se, YLOG_DEBUG, "Re- search/ingesting for clients due to change in sort order");
 701
 702         session_leave(se, "session_sort");
 703         for (l = se->clients_active; l; l = l->next)
 704         {
 705             struct client *cl = l->client;
 706             if (client_get_state(cl) == Client_Connecting ||
 707                 client_get_state(cl) == Client_Idle ||
 708                 client_get_state(cl) == Client_Working) {
 709                 client_start_search(cl);
 710             }
 711             else
 712             {
 713                 session_log(se, YLOG_DEBUG,
 714                             "session_sort: %s: No re-start/ingest in show. "
 715                             "Wrong client state: %d",
 716                             client_get_id(cl), client_get_state(cl));
 717             }
 718         }
 719         session_enter(se, "session_sort");
 720         se->clients_starting = 0;
 721         session_leave(se, "session_sort");
 722     }
 723 }
 724
 725 void session_stop(struct session *se)
 726 {
 727     struct client_list *l;
 728     session_enter(se, "session_stop1");
 729     if (se->clients_starting)
 730     {
 731         session_leave(se, "session_stop1");
 732         return;
 733     }
 734     se->clients_starting = 1;
 735     session_leave(se, "session_stop1");
 736
 737     session_alert_watch(se, SESSION_WATCH_SHOW);
 738     session_alert_watch(se, SESSION_WATCH_BYTARGET);
 739     session_alert_watch(se, SESSION_WATCH_TERMLIST);
 740     session_alert_watch(se, SESSION_WATCH_SHOW_PREF);
 741
 742     for (l = se->clients_active; l; l = l->next)
 743     {
 744         struct client *cl = l->client;
 745         client_stop(cl);
 746     }
 747     session_enter(se, "session_stop2");
 748     se->clients_starting = 0;
 749     session_leave(se, "session_stop2");
 750 }
 751
 752 enum pazpar2_error_code session_search(struct session *se,
 753                                        const char *query,
 754                                        const char *startrecs,
 755                                        const char *maxrecs,
 756                                        const char *filter,
 757                                        const char *limit,
 758                                        const char **addinfo,
 759                                        const char **addinfo2,
 760                                        struct reclist_sortparms *sp,
 761                                        const char *mergekey,
 762                                        const char *rank)
 763 {
 764     int live_channels = 0;
 765     int no_working = 0;
 766     int no_failed_query = 0;
 767     int no_failed_limit = 0;
 768     struct client_list *l;
 769
 770     session_log(se, YLOG_DEBUG, "Search");
 771
 772     *addinfo = 0;
 773
 774     session_enter(se, "session_search0");
 775     if (se->clients_starting)
 776     {
 777         session_leave(se, "session_search0");
 778         return PAZPAR2_NO_ERROR;
 779     }
 780     se->clients_starting = 1;
 781     session_leave(se, "session_search0");
 782
 783     if (se->settings_modified) {
 784         session_remove_cached_clients(se);
 785     }
 786     else
 787         session_reset_active_clients(se, 0);
 788
 789     session_enter(se, "session_search");
 790     se->settings_modified = 0;
 791
 792     if (mergekey)
 793     {
 794         xfree(se->mergekey);
 795         se->mergekey = *mergekey ? xstrdup(mergekey) : 0;
 796     }
 797     if (rank)
 798     {
 799         xfree(se->rank);
 800         se->rank = *rank ? xstrdup(rank) : 0;
 801     }
 802
 803     session_clear_set(se, sp);
 804     relevance_destroy(&se->relevance);
 805
 806     live_channels = select_targets(se, filter);
 807     if (!live_channels)
 808     {
 809         session_leave(se, "session_search");
 810         se->clients_starting = 0;
 811         return PAZPAR2_NO_TARGETS;
 812     }
 813
 814     facet_limits_destroy(se->facet_limits);
 815     se->facet_limits = facet_limits_create(limit);
 816     if (!se->facet_limits)
 817     {
 818         *addinfo = "limit";
 819         session_leave(se, "session_search");
 820         se->clients_starting = 0;
 821         return PAZPAR2_MALFORMED_PARAMETER_VALUE;
 822     }
 823
 824     session_leave(se, "session_search");
 825
 826     session_alert_watch(se, SESSION_WATCH_SHOW);
 827     session_alert_watch(se, SESSION_WATCH_BYTARGET);
 828     session_alert_watch(se, SESSION_WATCH_TERMLIST);
 829     session_alert_watch(se, SESSION_WATCH_SHOW_PREF);
 830
 831     for (l = se->clients_active; l; l = l->next)
 832     {
 833         int parse_ret;
 834         struct client *cl = l->client;
 835         client_parse_init(cl, 1);
 836         if (prepare_map(se, client_get_database(cl)) < 0)
 837             continue;
 838
 839         parse_ret = client_parse_query(cl, query, se->facet_limits, addinfo2);
 840         if (parse_ret == -1)
 841             no_failed_query++;
 842         else if (parse_ret == -2)
 843             no_failed_limit++;
 844         else if (parse_ret < 0)
 845             no_working++; /* other error, such as bad CCL map */
 846         else
 847         {
 848             client_parse_range(cl, startrecs, maxrecs);
 849             client_parse_sort(cl, sp);
 850             client_start_search(cl);
 851             no_working++;
 852         }
 853     }
 854     session_enter(se, "session_search2");
 855     se->clients_starting = 0;
 856     session_leave(se, "session_search2");
 857     if (no_working == 0)
 858     {
 859         if (no_failed_query > 0)
 860         {
 861             *addinfo = "query";
 862             return PAZPAR2_MALFORMED_PARAMETER_VALUE;
 863         }
 864         else if (no_failed_limit > 0)
 865         {
 866             *addinfo = "limit";
 867             return PAZPAR2_MALFORMED_PARAMETER_VALUE;
 868         }
 869         else
 870             return PAZPAR2_NO_TARGETS;
 871     }
 872     return PAZPAR2_NO_ERROR;
 873 }
 874
 875 // Creates a new session_database object for a database
 876 static void session_init_databases_fun(void *context, struct database *db)
 877 {
 878     struct session *se = (struct session *) context;
 879     struct session_database *new = nmem_malloc(se->session_nmem, sizeof(*new));
 880     int i;
 881
 882     new->database = db;
 883
 884     new->map = 0;
 885     assert(db->settings);
 886     new->settings = nmem_malloc(se->session_nmem,
 887                                 sizeof(struct settings *) * db->num_settings);
 888     new->num_settings = db->num_settings;
 889     for (i = 0; i < db->num_settings; i++)
 890     {
 891         struct setting *setting = db->settings[i];
 892         new->settings[i] = setting;
 893     }
 894     new->next = se->databases;
 895     se->databases = new;
 896 }
 897
 898 // Doesn't free memory associated with sdb -- nmem takes care of that
 899 static void session_database_destroy(struct session_database *sdb)
 900 {
 901     sdb->map = 0;
 902 }
 903
 904 // Initialize session_database list -- this represents this session's view
 905 // of the database list -- subject to modification by the settings ws command
 906 void session_init_databases(struct session *se)
 907 {
 908     se->databases = 0;
 909     predef_grep_databases(se, se->service, session_init_databases_fun);
 910 }
 911
 912 // Probably session_init_databases_fun should be refactored instead of
 913 // called here.
 914 static struct session_database *load_session_database(struct session *se,
 915                                                       const char *id)
 916 {
 917     struct database *db = new_database_inherit_settings(id, se->session_nmem, se->service->settings);
 918     session_init_databases_fun((void*) se, db);
 919
 920     // New sdb is head of se->databases list
 921     return se->databases;
 922 }
 923
 924 // Find an existing session database. If not found, load it
 925 static struct session_database *find_session_database(struct session *se,
 926                                                       const char *id)
 927 {
 928     struct session_database *sdb;
 929
 930     for (sdb = se->databases; sdb; sdb = sdb->next)
 931         if (!strcmp(sdb->database->id, id))
 932             return sdb;
 933     return load_session_database(se, id);
 934 }
 935
 936 // Apply a session override to a database
 937 void session_apply_setting(struct session *se, const char *dbname,
 938                            const char *name, const char *value)
 939 {
 940     session_enter(se, "session_apply_setting");
 941     {
 942         struct session_database *sdb = find_session_database(se, dbname);
 943         struct conf_service *service = se->service;
 944         struct setting *s;
 945         int offset = settings_create_offset(service, name);
 946
 947         expand_settings_array(&sdb->settings, &sdb->num_settings, offset,
 948                               se->session_nmem);
 949         // Force later recompute of settings-driven data structures
 950         // (happens when a search starts and client connections are prepared)
 951         if (offset == PZ_XSLT)
 952             sdb->map = 0;
 953         se->settings_modified = 1;
 954         for (s = sdb->settings[offset]; s; s = s->next)
 955             if (!strcmp(s->name, name) &&
 956                 dbname && s->target && !strcmp(dbname, s->target))
 957                 break;
 958         if (!s)
 959         {
 960             s = nmem_malloc(se->session_nmem, sizeof(*s));
 961             s->precedence = 0;
 962             s->target = nmem_strdup(se->session_nmem, dbname);
 963             s->name = nmem_strdup(se->session_nmem, name);
 964             s->next = sdb->settings[offset];
 965             sdb->settings[offset] = s;
 966         }
 967         s->value = nmem_strdup(se->session_nmem, value);
 968     }
 969     session_leave(se, "session_apply_setting");
 970 }
 971
 972 void session_destroy(struct session *se)
 973 {
 974     struct session_database *sdb;
 975     session_log(se, YLOG_LOG, "destroy");
 976     session_use(-1);
 977     session_remove_cached_clients(se);
 978
 979     for (sdb = se->databases; sdb; sdb = sdb->next)
 980         session_database_destroy(sdb);
 981     normalize_cache_destroy(se->normalize_cache);
 982     relevance_destroy(&se->relevance);
 983     reclist_destroy(se->reclist);
 984     xfree(se->mergekey);
 985     xfree(se->rank);
 986     if (nmem_total(se->nmem))
 987         session_log(se, YLOG_DEBUG, "NMEN operation usage %zd", nmem_total(se->nmem));
 988     if (nmem_total(se->session_nmem))
 989         session_log(se, YLOG_DEBUG, "NMEN session usage %zd", nmem_total(se->session_nmem));
 990     facet_limits_destroy(se->facet_limits);
 991     nmem_destroy(se->nmem);
 992     service_destroy(se->service);
 993     yaz_mutex_destroy(&se->session_mutex);
 994 }
 995
 996 size_t session_get_memory_status(struct session *session) {
 997     size_t session_nmem;
 998     if (session == 0)
 999         return 0;
1000     session_enter(session, "session_get_memory_status");
1001     session_nmem = nmem_total(session->nmem);
1002     session_leave(session, "session_get_memory_status");
1003     return session_nmem;
1004 }
1005
1006
1007 struct session *new_session(NMEM nmem, struct conf_service *service,
1008                             unsigned session_id)
1009 {
1010     int i;
1011     struct session *session = nmem_malloc(nmem, sizeof(*session));
1012
1013     char tmp_str[50];
1014
1015     sprintf(tmp_str, "session#%u", session_id);
1016
1017     session->session_id = session_id;
1018     session_log(session, YLOG_DEBUG, "New");
1019     session->service = service;
1020     session->relevance = 0;
1021     session->total_records = 0;
1022     session->number_of_warnings_unknown_elements = 0;
1023     session->number_of_warnings_unknown_metadata = 0;
1024     session->termlists = 0;
1025     session->reclist = reclist_create(nmem);
1026     session->clients_active = 0;
1027     session->clients_cached = 0;
1028     session->settings_modified = 0;
1029     session->session_nmem = nmem;
1030     session->nmem = nmem_create();
1031     session->databases = 0;
1032     session->sorted_results = 0;
1033     session->facet_limits = 0;
1034     session->mergekey = 0;
1035     session->rank = 0;
1036     session->clients_starting = 0;
1037
1038     for (i = 0; i <= SESSION_WATCH_MAX; i++)
1039     {
1040         session->watchlist[i].data = 0;
1041         session->watchlist[i].fun = 0;
1042     }
1043     session->normalize_cache = normalize_cache_create();
1044     session->session_mutex = 0;
1045     pazpar2_mutex_create(&session->session_mutex, tmp_str);
1046     session_log(session, YLOG_LOG, "create");
1047
1048     session_use(1);
1049     return session;
1050 }
1051
1052 static struct hitsbytarget *hitsbytarget_nb(struct session *se,
1053                                             int *count, NMEM nmem)
1054 {
1055     struct hitsbytarget *res = 0;
1056     struct client_list *l;
1057     size_t sz = 0;
1058
1059     for (l = se->clients_active; l; l = l->next)
1060         sz++;
1061
1062     res = nmem_malloc(nmem, sizeof(*res) * sz);
1063     *count = 0;
1064     for (l = se->clients_active; l; l = l->next)
1065     {
1066         struct client *cl = l->client;
1067         WRBUF w = wrbuf_alloc();
1068         const char *name = session_setting_oneval(client_get_database(cl),
1069                                                   PZ_NAME);
1070         res[*count].id = client_get_id(cl);
1071         res[*count].name = *name ? name : "Unknown";
1072         res[*count].hits = client_get_hits(cl);
1073         res[*count].approximation = client_get_approximation(cl);
1074         res[*count].records = client_get_num_records(cl,
1075                                                      &res[*count].filtered,
1076                                                      0, 0);
1077         res[*count].diagnostic =
1078             client_get_diagnostic(cl, &res[*count].message,
1079                                   &res[*count].addinfo);
1080         res[*count].state = client_get_state_str(cl);
1081         res[*count].connected  = client_get_connection(cl) ? 1 : 0;
1082         session_settings_dump(se, client_get_database(cl), w);
1083         res[*count].settings_xml = nmem_strdup(nmem, wrbuf_cstr(w));
1084         wrbuf_rewind(w);
1085         res[*count].suggestions_xml =
1086             nmem_strdup(nmem, client_get_suggestions_xml(cl, w));
1087
1088         res[*count].query_data =
1089             client_get_query(cl, &res[*count].query_type, nmem);
1090         wrbuf_destroy(w);
1091         (*count)++;
1092     }
1093     return res;
1094 }
1095
1096 struct hitsbytarget *get_hitsbytarget(struct session *se, int *count, NMEM nmem)
1097 {
1098     struct hitsbytarget *p;
1099     session_enter(se, "get_hitsbytarget");
1100     p = hitsbytarget_nb(se, count, nmem);
1101     session_leave(se, "get_hitsbytarget");
1102     return p;
1103 }
1104
1105 // Compares two hitsbytarget nodes by hitcount
1106 static int cmp_ht(const void *p1, const void *p2)
1107 {
1108     const struct hitsbytarget *h1 = p1;
1109     const struct hitsbytarget *h2 = p2;
1110     return h2->hits - h1->hits;
1111 }
1112
1113 // Compares two hitsbytarget nodes by hitcount
1114 static int cmp_ht_approx(const void *p1, const void *p2)
1115 {
1116     const struct hitsbytarget *h1 = p1;
1117     const struct hitsbytarget *h2 = p2;
1118     return h2->approximation - h1->approximation;
1119 }
1120
1121 static int targets_termlist_nb(WRBUF wrbuf, struct session *se, int num,
1122                                NMEM nmem, int version)
1123 {
1124     struct hitsbytarget *ht;
1125     int count, i;
1126
1127     ht = hitsbytarget_nb(se, &count, nmem);
1128     if (version >= 2)
1129         qsort(ht, count, sizeof(struct hitsbytarget), cmp_ht_approx);
1130     else
1131         qsort(ht, count, sizeof(struct hitsbytarget), cmp_ht);
1132     for (i = 0; i < count && i < num && ht[i].hits > 0; i++)
1133     {
1134
1135         // do only print terms which have display names
1136
1137         wrbuf_puts(wrbuf, "<term>\n");
1138
1139         wrbuf_puts(wrbuf, "<id>");
1140         wrbuf_xmlputs(wrbuf, ht[i].id);
1141         wrbuf_puts(wrbuf, "</id>\n");
1142
1143         wrbuf_puts(wrbuf, "<name>");
1144         if (!ht[i].name || !ht[i].name[0])
1145             wrbuf_xmlputs(wrbuf, "NO TARGET NAME");
1146         else
1147             wrbuf_xmlputs(wrbuf, ht[i].name);
1148         wrbuf_puts(wrbuf, "</name>\n");
1149
1150         wrbuf_printf(wrbuf, "<frequency>" ODR_INT_PRINTF "</frequency>\n",
1151                      ht[i].hits);
1152
1153         if (version >= 2) {
1154             // Should not print if we know it isn't a approximation.
1155             wrbuf_printf(wrbuf, "<approximation>" ODR_INT_PRINTF "</approximation>\n", ht[i].approximation);
1156             wrbuf_printf(wrbuf, "<records>%d</records>\n", ht[i].records - ht[i].filtered);
1157             wrbuf_printf(wrbuf, "<filtered>%d</filtered>\n", ht[i].filtered);
1158         }
1159
1160         wrbuf_puts(wrbuf, "<state>");
1161         wrbuf_xmlputs(wrbuf, ht[i].state);
1162         wrbuf_puts(wrbuf, "</state>\n");
1163
1164         wrbuf_printf(wrbuf, "<diagnostic>%d</diagnostic>\n",
1165                      ht[i].diagnostic);
1166         wrbuf_puts(wrbuf, "</term>\n");
1167     }
1168     return count;
1169 }
1170
1171 void perform_termlist(struct http_channel *c, struct session *se,
1172                       const char *name, int num, int version)
1173 {
1174     int j;
1175     NMEM nmem_tmp = nmem_create();
1176     char **names;
1177     int num_names = 0;
1178
1179     if (!name)
1180         name = "*";
1181
1182     nmem_strsplit(nmem_tmp, ",", name, &names, &num_names);
1183
1184     session_enter(se, "perform_termlist");
1185
1186     for (j = 0; j < num_names; j++)
1187     {
1188         const char *tname;
1189         int must_generate_empty = 1; /* bug 5350 */
1190
1191         struct named_termlist *t = se->termlists;
1192         for (; t; t = t->next)
1193         {
1194             tname = t->name;
1195             if (!strcmp(names[j], tname) || !strcmp(names[j], "*"))
1196             {
1197                 struct termlist_score **p = 0;
1198                 int len;
1199
1200                 wrbuf_puts(c->wrbuf, "<list name=\"");
1201                 wrbuf_xmlputs(c->wrbuf, tname);
1202                 wrbuf_puts(c->wrbuf, "\">\n");
1203                 must_generate_empty = 0;
1204
1205                 p = termlist_highscore(t->termlist, &len, nmem_tmp);
1206                 if (p)
1207                 {
1208                     int i;
1209                     for (i = 0; i < len && i < num; i++)
1210                     {
1211                         // prevent sending empty term elements
1212                         if (!p[i]->display_term || !p[i]->display_term[0])
1213                             continue;
1214
1215                         wrbuf_puts(c->wrbuf, "<term>");
1216                         wrbuf_puts(c->wrbuf, "<name>");
1217                         wrbuf_xmlputs(c->wrbuf, p[i]->display_term);
1218                         wrbuf_puts(c->wrbuf, "</name>");
1219
1220                         wrbuf_printf(c->wrbuf,
1221                                      "<frequency>%d</frequency>",
1222                                      p[i]->frequency);
1223                         wrbuf_puts(c->wrbuf, "</term>\n");
1224                     }
1225                 }
1226                 wrbuf_puts(c->wrbuf, "</list>\n");
1227             }
1228         }
1229         tname = "xtargets";
1230         if (!strcmp(names[j], tname) || !strcmp(names[j], "*"))
1231         {
1232             wrbuf_puts(c->wrbuf, "<list name=\"");
1233             wrbuf_xmlputs(c->wrbuf, tname);
1234             wrbuf_puts(c->wrbuf, "\">\n");
1235
1236             targets_termlist_nb(c->wrbuf, se, num, c->nmem, version);
1237             wrbuf_puts(c->wrbuf, "</list>\n");
1238             must_generate_empty = 0;
1239         }
1240         if (must_generate_empty)
1241         {
1242             wrbuf_puts(c->wrbuf, "<list name=\"");
1243             wrbuf_xmlputs(c->wrbuf, names[j]);
1244             wrbuf_puts(c->wrbuf, "\"/>\n");
1245         }
1246     }
1247     session_leave(se, "perform_termlist");
1248     nmem_destroy(nmem_tmp);
1249 }
1250
1251 #ifdef MISSING_HEADERS
1252 void report_nmem_stats(void)
1253 {
1254     size_t in_use, is_free;
1255
1256     nmem_get_memory_in_use(&in_use);
1257     nmem_get_memory_free(&is_free);
1258
1259     yaz_log(YLOG_LOG, "nmem stat: use=%ld free=%ld",
1260             (long) in_use, (long) is_free);
1261 }
1262 #endif
1263
1264 struct record_cluster *show_single_start(struct session *se, const char *id,
1265                                          struct record_cluster **prev_r,
1266                                          struct record_cluster **next_r)
1267 {
1268     struct record_cluster *r = 0;
1269
1270     session_enter(se, "show_single_start");
1271     *prev_r = 0;
1272     *next_r = 0;
1273     reclist_limit(se->reclist, se, 1);
1274
1275     reclist_enter(se->reclist);
1276     while ((r = reclist_read_record(se->reclist)))
1277     {
1278         if (!strcmp(r->recid, id))
1279         {
1280             *next_r = reclist_read_record(se->reclist);
1281             break;
1282         }
1283         *prev_r = r;
1284     }
1285     reclist_leave(se->reclist);
1286     if (!r)
1287         session_leave(se, "show_single_start");
1288     return r;
1289 }
1290
1291 void show_single_stop(struct session *se, struct record_cluster *rec)
1292 {
1293     session_leave(se, "show_single_stop");
1294 }
1295
1296
1297 int session_fetch_more(struct session *se)
1298 {
1299     struct client_list *l;
1300     int ret = 0;
1301
1302     for (l = se->clients_active; l; l = l->next)
1303     {
1304         struct client *cl = l->client;
1305         if (client_get_state(cl) == Client_Idle)
1306         {
1307             if (client_fetch_more(cl))
1308             {
1309                 session_log(se, YLOG_LOG, "%s: more to fetch",
1310                             client_get_id(cl));
1311                 ret = 1;
1312             }
1313             else
1314             {
1315                 int filtered;
1316                 int ingest_failures;
1317                 int record_failures;
1318                 int num = client_get_num_records(
1319                     cl, &filtered, &ingest_failures, &record_failures);
1320
1321                 session_log(se, YLOG_LOG, "%s: hits=" ODR_INT_PRINTF
1322                             " fetched=%d filtered=%d",
1323                             client_get_id(cl),
1324                             client_get_hits(cl),
1325                             num, filtered);
1326                 if (ingest_failures || record_failures)
1327                 {
1328                     session_log(se, YLOG_WARN, "%s:"
1329                                 " ingest failures=%d record failures=%d",
1330                                 client_get_id(cl),
1331                                 ingest_failures, record_failures);
1332                 }
1333             }
1334         }
1335         else
1336         {
1337             session_log(se, YLOG_LOG, "%s: no fetch due to state=%s",
1338                         client_get_id(cl), client_get_state_str(cl));
1339         }
1340
1341     }
1342     return ret;
1343 }
1344
1345 struct record_cluster **show_range_start(struct session *se,
1346                                          struct reclist_sortparms *sp,
1347                                          int start, int *num, int *total,
1348                                          Odr_int *sumhits, Odr_int *approx_hits,
1349                                          void (*show_records_ready)(void *data),
1350                                          struct http_channel *chan)
1351 {
1352     struct record_cluster **recs = 0;
1353     struct reclist_sortparms *spp;
1354     struct client_list *l;
1355     int i;
1356 #if USE_TIMING
1357     yaz_timing_t t = yaz_timing_create();
1358 #endif
1359     session_enter(se, "show_range_start");
1360     *sumhits = 0;
1361     *approx_hits = 0;
1362     *total = 0;
1363     reclist_limit(se->reclist, se, 0);
1364     if (se->relevance)
1365     {
1366         for (spp = sp; spp; spp = spp->next)
1367             if (spp->type == Metadata_type_relevance)
1368             {
1369                 relevance_prepare_read(se->relevance, se->reclist);
1370                 break;
1371             }
1372         for (l = se->clients_active; l; l = l->next) {
1373             *sumhits += client_get_hits(l->client);
1374             *approx_hits += client_get_approximation(l->client);
1375         }
1376     }
1377     reclist_sort(se->reclist, sp);
1378
1379     reclist_enter(se->reclist);
1380     *total = reclist_get_num_records(se->reclist);
1381
1382     for (l = se->clients_active; l; l = l->next)
1383         client_update_show_stat(l->client, 0);
1384
1385     for (i = 0; i < start; i++)
1386     {
1387         struct record_cluster *r = reclist_read_record(se->reclist);
1388         if (!r)
1389         {
1390             *num = 0;
1391             break;
1392         }
1393         else
1394         {
1395             struct record *rec = r->records;
1396             for (;rec; rec = rec->next)
1397                 client_update_show_stat(rec->client, 1);
1398         }
1399     }
1400     recs = nmem_malloc(se->nmem, (*num > 0 ? *num : 1) * sizeof(*recs));
1401     for (i = 0; i < *num; i++)
1402     {
1403         struct record_cluster *r = reclist_read_record(se->reclist);
1404         if (!r)
1405         {
1406             *num = i;
1407             break;
1408         }
1409         else
1410         {
1411             struct record *rec = r->records;
1412             for (;rec; rec = rec->next)
1413                 client_update_show_stat(rec->client, 1);
1414             recs[i] = r;
1415         }
1416     }
1417     reclist_leave(se->reclist);
1418 #if USE_TIMING
1419     yaz_timing_stop(t);
1420     session_log(se, YLOG_LOG, "show %6.5f %3.2f %3.2f",
1421             yaz_timing_get_real(t), yaz_timing_get_user(t),
1422             yaz_timing_get_sys(t));
1423     yaz_timing_destroy(&t);
1424 #endif
1425
1426     if (!session_fetch_more(se))
1427         session_log(se, YLOG_LOG, "can not fetch more");
1428     else
1429     {
1430         show_range_stop(se, recs);
1431         session_log(se, YLOG_LOG, "fetching more in progress");
1432         if (session_set_watch(se, SESSION_WATCH_SHOW,
1433                               show_records_ready, chan, chan))
1434         {
1435             session_log(se, YLOG_WARN, "Ignoring show block");
1436             session_enter(se, "show_range_start");
1437         }
1438         else
1439         {
1440             session_log(se, YLOG_LOG, "session watch OK");
1441             return 0;
1442         }
1443     }
1444     return recs;
1445 }
1446
1447 void show_range_stop(struct session *se, struct record_cluster **recs)
1448 {
1449     session_leave(se, "show_range_stop");
1450 }
1451
1452 void statistics(struct session *se, struct statistics *stat)
1453 {
1454     struct client_list *l;
1455     int count = 0;
1456
1457     memset(stat, 0, sizeof(*stat));
1458     stat->num_hits = 0;
1459     for (l = se->clients_active; l; l = l->next)
1460     {
1461         struct client *cl = l->client;
1462         if (!client_get_connection(cl))
1463             stat->num_no_connection++;
1464         stat->num_hits += client_get_hits(cl);
1465         switch (client_get_state(cl))
1466         {
1467         case Client_Connecting: stat->num_connecting++; break;
1468         case Client_Working: stat->num_working++; break;
1469         case Client_Idle: stat->num_idle++; break;
1470         case Client_Failed: stat->num_failed++; break;
1471         case Client_Error: stat->num_error++; break;
1472         default: break;
1473         }
1474         count++;
1475     }
1476     stat->num_records = se->total_records;
1477
1478     stat->num_clients = count;
1479 }
1480
1481 static struct record_metadata *record_metadata_init(
1482     NMEM nmem, const char *value, const char *norm,
1483     enum conf_metadata_type type,
1484     struct _xmlAttr *attr)
1485 {
1486     struct record_metadata *rec_md = record_metadata_create(nmem);
1487     struct record_metadata_attr **attrp = &rec_md->attributes;
1488
1489     for (; attr; attr = attr->next)
1490     {
1491         if (attr->children && attr->children->content)
1492         {
1493             if (strcmp((const char *) attr->name, "type")
1494                 && strcmp((const char *) attr->name, "empty"))
1495             {  /* skip the "type" + "empty" attribute..
1496                   The "Type" is already part of the element in output
1497                   (md-%s) and so repeating it here is redundant */
1498                 *attrp = nmem_malloc(nmem, sizeof(**attrp));
1499                 (*attrp)->name =
1500                     nmem_strdup(nmem, (const char *) attr->name);
1501                 (*attrp)->value =
1502                     nmem_strdup(nmem, (const char *) attr->children->content);
1503                 attrp = &(*attrp)->next;
1504             }
1505         }
1506     }
1507     *attrp = 0;
1508
1509     switch (type)
1510     {
1511     case Metadata_type_generic:
1512     case Metadata_type_skiparticle:
1513         if (norm)
1514         {
1515             rec_md->data.text.disp = nmem_strdup(nmem, value);
1516             rec_md->data.text.norm = nmem_strdup(nmem, norm);
1517         }
1518         else
1519         {
1520             if (strstr(value, "://")) /* looks like a URL */
1521                 rec_md->data.text.disp = nmem_strdup(nmem, value);
1522             else
1523                 rec_md->data.text.disp =
1524                     normalize7bit_generic(nmem_strdup(nmem, value), " ,/.:([");
1525             rec_md->data.text.norm = rec_md->data.text.disp;
1526         }
1527         rec_md->data.text.sort = 0;
1528         rec_md->data.text.snippet = 0;
1529         break;
1530     case Metadata_type_year:
1531     case Metadata_type_date:
1532     {
1533         int first, last;
1534         int longdate = 0;
1535
1536         if (type == Metadata_type_date)
1537             longdate = 1;
1538         if (extract7bit_dates((char *) value, &first, &last, longdate) < 0)
1539             return 0;
1540
1541         rec_md->data.number.min = first;
1542         rec_md->data.number.max = last;
1543     }
1544     break;
1545     case Metadata_type_float:
1546         rec_md->data.fnumber = atof(value);
1547         break;
1548     case Metadata_type_relevance:
1549     case Metadata_type_position:
1550     case Metadata_type_retrieval:
1551         return 0;
1552     }
1553     return rec_md;
1554 }
1555
1556 static void mergekey_norm_wr(pp2_charset_fact_t charsets,
1557                              WRBUF norm_wr, const char *value)
1558 {
1559     const char *norm_str;
1560     pp2_charset_token_t prt =
1561         pp2_charset_token_create(charsets, "mergekey");
1562
1563     pp2_charset_token_first(prt, value, 0);
1564     while ((norm_str = pp2_charset_token_next(prt)))
1565     {
1566         if (*norm_str)
1567         {
1568             if (wrbuf_len(norm_wr))
1569                 wrbuf_puts(norm_wr, " ");
1570             wrbuf_puts(norm_wr, norm_str);
1571         }
1572     }
1573     pp2_charset_token_destroy(prt);
1574 }
1575
1576 static int get_mergekey_from_doc(xmlDoc *doc, xmlNode *root, const char *name,
1577                                  struct conf_service *service, WRBUF norm_wr)
1578 {
1579     xmlNode *n;
1580     int no_found = 0;
1581     for (n = root->children; n; n = n->next)
1582     {
1583         if (n->type != XML_ELEMENT_NODE)
1584             continue;
1585         if (!strcmp((const char *) n->name, "metadata"))
1586         {
1587             const char *type = yaz_xml_get_prop(n, "type");
1588             if (type == NULL) {
1589                 yaz_log(YLOG_FATAL, "Missing type attribute on metadata element. Skipping!");
1590             }
1591             else if (!strcmp(name, (const char *) type))
1592             {
1593                 xmlChar *value = xmlNodeListGetString(doc, n->children, 1);
1594                 if (value && *value)
1595                 {
1596                     if (wrbuf_len(norm_wr) > 0)
1597                         wrbuf_puts(norm_wr, " ");
1598                     wrbuf_puts(norm_wr, name);
1599                     mergekey_norm_wr(service->charsets, norm_wr,
1600                                      (const char *) value);
1601                     no_found++;
1602                 }
1603                 if (value)
1604                     xmlFree(value);
1605             }
1606         }
1607     }
1608     return no_found;
1609 }
1610
1611 static const char *get_mergekey(xmlDoc *doc, xmlNode *root,
1612                                 struct client *cl, int record_no,
1613                                 struct conf_service *service, NMEM nmem,
1614                                 const char *session_mergekey)
1615 {
1616     char *mergekey_norm = 0;
1617     WRBUF norm_wr = wrbuf_alloc();
1618     const char *mergekey;
1619
1620     if (session_mergekey)
1621     {
1622         int i, num = 0;
1623         char **values = 0;
1624         nmem_strsplit_escape2(nmem, ",", session_mergekey, &values,
1625                               &num, 1, '\\', 1);
1626
1627         for (i = 0; i < num; i++)
1628             get_mergekey_from_doc(doc, root, values[i], service, norm_wr);
1629     }
1630     else if ((mergekey = yaz_xml_get_prop(root, "mergekey")))
1631     {
1632         mergekey_norm_wr(service->charsets, norm_wr, mergekey);
1633     }
1634     else
1635     {
1636         /* no mergekey defined in XSL. Look for mergekey metadata instead */
1637         int field_id;
1638         for (field_id = 0; field_id < service->num_metadata; field_id++)
1639         {
1640             struct conf_metadata *ser_md = &service->metadata[field_id];
1641             if (ser_md->mergekey != Metadata_mergekey_no)
1642             {
1643                 int r = get_mergekey_from_doc(doc, root, ser_md->name,
1644                                               service, norm_wr);
1645                 if (r == 0 && ser_md->mergekey == Metadata_mergekey_required)
1646                 {
1647                     /* no mergekey on this one and it is required..
1648                        Generate unique key instead */
1649                     wrbuf_rewind(norm_wr);
1650                     break;
1651                 }
1652             }
1653         }
1654     }
1655
1656     /* generate unique key if none is not generated already or is empty */
1657     if (wrbuf_len(norm_wr) == 0)
1658     {
1659         wrbuf_printf(norm_wr, "position: %s-%d",
1660                      client_get_id(cl), record_no);
1661     }
1662     else
1663     {
1664         const char *lead = "content: ";
1665         wrbuf_insert(norm_wr, 0, lead, strlen(lead));
1666     }
1667     if (wrbuf_len(norm_wr) > 0)
1668         mergekey_norm = nmem_strdup(nmem, wrbuf_cstr(norm_wr));
1669     wrbuf_destroy(norm_wr);
1670     return mergekey_norm;
1671 }
1672
1673 /** \brief see if metadata for pz:recordfilter exists
1674     \param root xml root element of normalized record
1675     \param sdb session database for client
1676     \retval 0 if there is no metadata for pz:recordfilter
1677     \retval 1 if there is metadata for pz:recordfilter
1678
1679     If there is no pz:recordfilter defined, this function returns 1
1680     as well.
1681 */
1682
1683 static int check_record_filter(xmlNode *root, struct session_database *sdb)
1684 {
1685     int match = 0;
1686     xmlNode *n;
1687     const char *s;
1688     s = session_setting_oneval(sdb, PZ_RECORDFILTER);
1689
1690     if (!s || !*s)
1691         return 1;
1692
1693     for (n = root->children; n; n = n->next)
1694     {
1695         if (n->type != XML_ELEMENT_NODE)
1696             continue;
1697         if (!strcmp((const char *) n->name, "metadata"))
1698         {
1699             const char *type = yaz_xml_get_prop(n, "type");
1700             if (type)
1701             {
1702                 size_t len;
1703                 int substring;
1704                 const char *eq;
1705
1706                 if ((eq = strchr(s, '=')))
1707                     substring = 0;
1708                 else if ((eq = strchr(s, '~')))
1709                     substring = 1;
1710                 if (eq)
1711                     len = eq - s;
1712                 else
1713                     len = strlen(s);
1714                 if (len == strlen((const char *)type) &&
1715                     !memcmp((const char *) type, s, len))
1716                 {
1717                     xmlChar *value = xmlNodeGetContent(n);
1718                     if (value && *value)
1719                     {
1720                         if (!eq ||
1721                             (substring && strstr((const char *) value, eq+1)) ||
1722                             (!substring && !strcmp((const char *) value, eq + 1)))
1723                             match = 1;
1724                     }
1725                     xmlFree(value);
1726                 }
1727             }
1728         }
1729     }
1730     return match;
1731 }
1732
1733 static int ingest_to_cluster(struct client *cl,
1734                              WRBUF wrbuf_disp,
1735                              WRBUF wrbuf_norm,
1736                              xmlDoc *xdoc,
1737                              xmlNode *root,
1738                              int record_no,
1739                              struct record_metadata_attr *mergekey);
1740
1741 static int ingest_sub_record(struct client *cl, xmlDoc *xdoc, xmlNode *root,
1742                              int record_no, NMEM nmem,
1743                              struct session_database *sdb,
1744                              struct record_metadata_attr *mergekeys)
1745 {
1746     int ret = 0;
1747     struct session *se = client_get_session(cl);
1748     WRBUF wrbuf_disp, wrbuf_norm;
1749
1750     if (!check_record_filter(root, sdb))
1751     {
1752         session_log(se, YLOG_LOG,
1753                     "Filtered out record no %d from %s",
1754                     record_no, sdb->database->id);
1755         return 0;
1756     }
1757     wrbuf_disp = wrbuf_alloc();
1758     wrbuf_norm = wrbuf_alloc();
1759     session_enter(se, "ingest_sub_record");
1760     if (client_get_session(cl) == se && se->relevance)
1761         ret = ingest_to_cluster(cl, wrbuf_disp, wrbuf_norm,
1762                                 xdoc, root, record_no, mergekeys);
1763     session_leave(se, "ingest_sub_record");
1764     wrbuf_destroy(wrbuf_norm);
1765     wrbuf_destroy(wrbuf_disp);
1766     return ret;
1767 }
1768
1769 /** \brief ingest XML record
1770     \param cl client holds the result set for record
1771     \param rec record buffer (0 terminated)
1772     \param record_no record position (1, 2, ..)
1773     \param nmem working NMEM
1774     \retval 0 OK
1775     \retval -1 failure
1776     \retval -2 Filtered
1777 */
1778 int ingest_record(struct client *cl, const char *rec,
1779                   int record_no, NMEM nmem)
1780 {
1781     struct session *se = client_get_session(cl);
1782     struct session_database *sdb = client_get_database(cl);
1783     struct conf_service *service = se->service;
1784     xmlDoc *xdoc = normalize_record(se, sdb, service, rec, nmem);
1785     int r = ingest_xml_record(cl, xdoc, record_no, nmem, 0);
1786     client_store_xdoc(cl, record_no, xdoc);
1787     return r;
1788 }
1789
1790 int ingest_xml_record(struct client *cl, xmlDoc *xdoc,
1791                       int record_no, NMEM nmem, int cached_copy)
1792 {
1793     struct session *se = client_get_session(cl);
1794     struct session_database *sdb = client_get_database(cl);
1795     struct conf_service *service = se->service;
1796     xmlNode *root;
1797     int r = 0;
1798     if (!xdoc)
1799         return -1;
1800
1801     if (global_parameters.dump_records)
1802     {
1803         session_log(se, YLOG_LOG, "Normalized record from %s",
1804                     sdb->database->id);
1805         log_xml_doc(xdoc);
1806     }
1807
1808     root = xmlDocGetRootElement(xdoc);
1809
1810     if (!strcmp((const char *) root->name, "cluster"))
1811     {
1812         int no_merge_keys = 0;
1813         int no_merge_dups = 0;
1814         xmlNode *sroot;
1815         struct record_metadata_attr *mk = 0;
1816
1817         for (sroot = root->children; sroot; sroot = sroot->next)
1818             if (sroot->type == XML_ELEMENT_NODE &&
1819                 !strcmp((const char *) sroot->name, "record"))
1820             {
1821                 struct record_metadata_attr **mkp;
1822                 const char *mergekey_norm =
1823                     get_mergekey(xdoc, sroot, cl, record_no, service, nmem,
1824                                  se->mergekey);
1825                 if (!mergekey_norm)
1826                 {
1827                     r = -1;
1828                     break;
1829                 }
1830                 for (mkp = &mk; *mkp; mkp = &(*mkp)->next)
1831                     if (!strcmp((*mkp)->value, mergekey_norm))
1832                         break;
1833                 if (!*mkp)
1834                 {
1835                     *mkp = (struct record_metadata_attr*)
1836                         nmem_malloc(nmem, sizeof(**mkp));
1837                     (*mkp)->name = 0;
1838                     (*mkp)->value = nmem_strdup(nmem, mergekey_norm);
1839                     (*mkp)->next = 0;
1840                     no_merge_keys++;
1841                 }
1842                 else
1843                     no_merge_dups++;
1844             }
1845         if (no_merge_keys > 1 || no_merge_dups > 0)
1846         {
1847             yaz_log(YLOG_LOG, "Got %d mergekeys, %d dups for position %d",
1848                     no_merge_keys, no_merge_dups, record_no);
1849         }
1850         for (sroot = root->children; !r && sroot; sroot = sroot->next)
1851             if (sroot->type == XML_ELEMENT_NODE &&
1852                 !strcmp((const char *) sroot->name, "record"))
1853             {
1854                 if (!cached_copy)
1855                     insert_settings_values(sdb, xdoc, root, service);
1856                 r = ingest_sub_record(cl, xdoc, sroot, record_no, nmem, sdb,
1857                                       mk);
1858             }
1859     }
1860     else if (!strcmp((const char *) root->name, "record"))
1861     {
1862         const char *mergekey_norm =
1863             get_mergekey(xdoc, root, cl, record_no, service, nmem,
1864                          se->mergekey);
1865         if (mergekey_norm)
1866         {
1867             struct record_metadata_attr *mk = (struct record_metadata_attr*)
1868                 nmem_malloc(nmem, sizeof(*mk));
1869             mk->name = 0;
1870             mk->value = nmem_strdup(nmem, mergekey_norm);
1871             mk->next = 0;
1872
1873             if (!cached_copy)
1874                 insert_settings_values(sdb, xdoc, root, service);
1875             r = ingest_sub_record(cl, xdoc, root, record_no, nmem, sdb, mk);
1876         }
1877     }
1878     else
1879     {
1880         session_log(se, YLOG_WARN, "Bad pz root element: %s",
1881                     (const char *) root->name);
1882         r = -1;
1883     }
1884     return r;
1885 }
1886
1887
1888 //    struct conf_metadata *ser_md = &service->metadata[md_field_id];
1889 //    struct record_metadata *rec_md = record->metadata[md_field_id];
1890 static int match_metadata_local(struct conf_service *service,
1891                                 struct conf_metadata *ser_md,
1892                                 struct record_metadata *rec_md0,
1893                                 char **values, int num_v)
1894 {
1895     int i;
1896     struct record_metadata *rec_md = rec_md0;
1897     WRBUF val_wr = 0;
1898     WRBUF text_wr = wrbuf_alloc();
1899     for (i = 0; i < num_v; )
1900     {
1901         if (rec_md)
1902         {
1903             if (ser_md->type == Metadata_type_year
1904                 || ser_md->type == Metadata_type_date)
1905             {
1906                 int y = atoi(values[i]);
1907                 if (y >= rec_md->data.number.min
1908                     && y <= rec_md->data.number.max)
1909                     break;
1910             }
1911             else
1912             {
1913                 if (!val_wr)
1914                 {
1915                     val_wr = wrbuf_alloc();
1916                     mergekey_norm_wr(service->charsets, val_wr, values[i]);
1917                 }
1918                 wrbuf_rewind(text_wr);
1919                 mergekey_norm_wr(service->charsets, text_wr,
1920                                  rec_md->data.text.disp);
1921                 if (!strcmp(wrbuf_cstr(val_wr), wrbuf_cstr(text_wr)))
1922                     break;
1923             }
1924             rec_md = rec_md->next;
1925         }
1926         else
1927         {
1928             rec_md = rec_md0;
1929             wrbuf_destroy(val_wr);
1930             val_wr = 0;
1931             i++;
1932         }
1933     }
1934     wrbuf_destroy(val_wr);
1935     wrbuf_destroy(text_wr);
1936     return i < num_v ? 1 : 0;
1937 }
1938
1939 int session_check_cluster_limit(struct session *se, struct record_cluster *rec)
1940 {
1941     int i;
1942     struct conf_service *service = se->service;
1943     int ret = 1;
1944     const char *name;
1945     const char *value;
1946     NMEM nmem_tmp = nmem_create();
1947
1948     for (i = 0; (name = facet_limits_get(se->facet_limits, i, &value)); i++)
1949     {
1950         int j;
1951         for (j = 0; j < service->num_metadata; j++)
1952         {
1953             struct conf_metadata *md = service->metadata + j;
1954             if (!strcmp(md->name, name) && md->limitcluster)
1955             {
1956                 char **values = 0;
1957                 int num = 0;
1958                 int md_field_id =
1959                     conf_service_metadata_field_id(service,
1960                                                    md->limitcluster);
1961
1962                 if (md_field_id < 0)
1963                 {
1964                     ret = 0;
1965                     break;
1966                 }
1967
1968                 nmem_strsplit_escape2(nmem_tmp, "|", value, &values,
1969                                       &num, 1, '\\', 1);
1970
1971                 if (!match_metadata_local(service,
1972                                           &service->metadata[md_field_id],
1973                                           rec->metadata[md_field_id],
1974                                           values, num))
1975                 {
1976                     ret = 0;
1977                     break;
1978                 }
1979             }
1980         }
1981     }
1982     nmem_destroy(nmem_tmp);
1983     return ret;
1984 }
1985
1986 // Skip record on non-zero
1987 static int check_limit_local(struct client *cl,
1988                              struct record *record,
1989                              int record_no)
1990 {
1991     int skip_record = 0;
1992     struct session *se = client_get_session(cl);
1993     struct conf_service *service = se->service;
1994     NMEM nmem_tmp = nmem_create();
1995     struct session_database *sdb = client_get_database(cl);
1996     int l = 0;
1997     while (!skip_record)
1998     {
1999         int md_field_id;
2000         char **values = 0;
2001         int num_v = 0;
2002         const char *name =
2003             client_get_facet_limit_local(cl, sdb, &l, nmem_tmp,
2004                                          &num_v, &values);
2005         if (!name)
2006             break;
2007
2008         if (!strcmp(name, "*"))
2009         {
2010             for (md_field_id = 0; md_field_id < service->num_metadata;
2011                  md_field_id++)
2012             {
2013                 if (match_metadata_local(
2014                         service,
2015                         &service->metadata[md_field_id],
2016                         record->metadata[md_field_id],
2017                         values, num_v))
2018                     break;
2019             }
2020             if (md_field_id == service->num_metadata)
2021                 skip_record = 1;
2022         }
2023         else
2024         {
2025             md_field_id = conf_service_metadata_field_id(service, name);
2026             if (md_field_id < 0)
2027             {
2028                 skip_record = 1;
2029                 break;
2030             }
2031             if (!match_metadata_local(
2032                     service,
2033                     &service->metadata[md_field_id],
2034                     record->metadata[md_field_id],
2035                     values, num_v))
2036             {
2037                 skip_record = 1;
2038             }
2039         }
2040     }
2041     nmem_destroy(nmem_tmp);
2042     return skip_record;
2043 }
2044
2045 static int ingest_to_cluster(struct client *cl,
2046                              WRBUF wrbuf_disp,
2047                              WRBUF wrbuf_norm,
2048                              xmlDoc *xdoc,
2049                              xmlNode *root,
2050                              int record_no,
2051                              struct record_metadata_attr *merge_keys)
2052 {
2053     xmlNode *n;
2054     struct session *se = client_get_session(cl);
2055     struct conf_service *service = se->service;
2056     int term_factor = 1;
2057     struct record_cluster *cluster;
2058     struct record_metadata **metadata0;
2059     struct session_database *sdb = client_get_database(cl);
2060     NMEM ingest_nmem = 0;
2061     char **rank_values = 0;
2062     int rank_num = 0;
2063     struct record *record = record_create(se->nmem,
2064                                           service->num_metadata,
2065                                           service->num_sortkeys, cl,
2066                                           record_no);
2067
2068     for (n = root->children; n; n = n->next)
2069     {
2070         if (n->type != XML_ELEMENT_NODE)
2071             continue;
2072         if (!strcmp((const char *) n->name, "metadata"))
2073         {
2074             struct conf_metadata *ser_md = 0;
2075             struct record_metadata **wheretoput = 0;
2076             struct record_metadata *rec_md = 0;
2077             int md_field_id = -1;
2078             xmlChar *value0;
2079             const char *type = yaz_xml_get_prop(n, "type");
2080
2081             if (!type)
2082                 continue;
2083
2084             md_field_id
2085                 = conf_service_metadata_field_id(service, (const char *) type);
2086             if (md_field_id < 0)
2087             {
2088                 if (se->number_of_warnings_unknown_metadata == 0)
2089                 {
2090                     session_log(se, YLOG_WARN,
2091                             "Ignoring unknown metadata element: %s", type);
2092                 }
2093                 se->number_of_warnings_unknown_metadata++;
2094                 continue;
2095             }
2096
2097             wrbuf_rewind(wrbuf_disp);
2098             value0 = xmlNodeListGetString(xdoc, n->children, 1);
2099             if (!value0 || !*value0)
2100             {
2101                 const char *empty = yaz_xml_get_prop(n, "empty");
2102                 if (!empty)
2103                     continue;
2104                 wrbuf_puts(wrbuf_disp, (const char *) empty);
2105             }
2106             else
2107             {
2108                 wrbuf_puts(wrbuf_disp, (const char *) value0);
2109             }
2110             if (value0)
2111                 xmlFree(value0);
2112             ser_md = &service->metadata[md_field_id];
2113
2114             // non-merged metadata
2115             rec_md = record_metadata_init(se->nmem, wrbuf_cstr(wrbuf_disp), 0,
2116                                           ser_md->type, n->properties);
2117             if (!rec_md)
2118             {
2119                 session_log(se, YLOG_WARN, "bad metadata data '%s' "
2120                             "for element '%s'", wrbuf_cstr(wrbuf_disp), type);
2121                 continue;
2122             }
2123
2124             if (ser_md->type == Metadata_type_generic)
2125             {
2126                 WRBUF w = wrbuf_alloc();
2127                 if (relevance_snippet(se->relevance,
2128                                       wrbuf_cstr(wrbuf_disp), ser_md->name, w))
2129                     rec_md->data.text.snippet = nmem_strdup(se->nmem,
2130                                                             wrbuf_cstr(w));
2131                 wrbuf_destroy(w);
2132             }
2133
2134
2135             wheretoput = &record->metadata[md_field_id];
2136             while (*wheretoput)
2137                 wheretoput = &(*wheretoput)->next;
2138             *wheretoput = rec_md;
2139         }
2140     }
2141
2142     if (check_limit_local(cl, record, record_no))
2143     {
2144         return -2;
2145     }
2146     cluster = reclist_insert(se->reclist, se->relevance, service, record,
2147                              merge_keys, &se->total_merged);
2148     if (!cluster)
2149     {
2150         return 0; // complete match with existing record
2151     }
2152
2153     {
2154         const char *use_term_factor_str =
2155             session_setting_oneval(sdb, PZ_TERMLIST_TERM_FACTOR);
2156         if (use_term_factor_str && use_term_factor_str[0] == '1')
2157         {
2158             int maxrecs = client_get_maxrecs(cl);
2159             int hits = (int) client_get_hits(cl);
2160             term_factor = MAX(hits, maxrecs) /  MAX(1, maxrecs);
2161             assert(term_factor >= 1);
2162             session_log(se, YLOG_DEBUG, "Using term factor: %d (%d / %d)",
2163                         term_factor, MAX(hits, maxrecs), MAX(1, maxrecs));
2164         }
2165     }
2166
2167     if (global_parameters.dump_records)
2168         session_log(se, YLOG_LOG, "Cluster id %s from %s (#%d)", cluster->recid,
2169                     sdb->database->id, record_no);
2170
2171     // original metadata, to check if first existence of a field
2172     metadata0 = xmalloc(sizeof(*metadata0) * service->num_metadata);
2173     memcpy(metadata0, cluster->metadata,
2174            sizeof(*metadata0) * service->num_metadata);
2175
2176     ingest_nmem = nmem_create();
2177     if (se->rank)
2178     {
2179         yaz_log(YLOG_LOG, "local in sort : %s", se->rank);
2180         nmem_strsplit_escape2(ingest_nmem, ",", se->rank, &rank_values,
2181                               &rank_num, 1, '\\', 1);
2182     }
2183
2184     // now parsing XML record and adding data to cluster or record metadata
2185     for (n = root->children; n; n = n->next)
2186     {
2187         if (n->type != XML_ELEMENT_NODE)
2188             continue;
2189         if (!strcmp((const char *) n->name, "metadata"))
2190         {
2191             struct conf_metadata *ser_md = 0;
2192             struct conf_sortkey *ser_sk = 0;
2193             struct record_metadata **wheretoput = 0;
2194             struct record_metadata *rec_md = 0;
2195             int md_field_id = -1;
2196             int sk_field_id = -1;
2197             const char *rank = 0;
2198             const char *xml_rank = 0;
2199             const char *type = 0;
2200             xmlChar *value0;
2201
2202             type = yaz_xml_get_prop(n, "type");
2203             if (!type)
2204                 continue;
2205
2206             md_field_id
2207                 = conf_service_metadata_field_id(service, (const char *) type);
2208             if (md_field_id < 0)
2209                 continue;
2210
2211             ser_md = &service->metadata[md_field_id];
2212
2213             if (ser_md->sortkey_offset >= 0)
2214             {
2215                 sk_field_id = ser_md->sortkey_offset;
2216                 ser_sk = &service->sortkeys[sk_field_id];
2217             }
2218
2219             wrbuf_rewind(wrbuf_disp);
2220             wrbuf_rewind(wrbuf_norm);
2221
2222             value0 = xmlNodeListGetString(xdoc, n->children, 1);
2223             if (!value0 || !*value0)
2224             {
2225                 if (value0)
2226                     xmlFree(value0);
2227                 continue;
2228             }
2229
2230             if (ser_md->icurule)
2231             {
2232                 run_icu(se, ser_md->icurule, (const char *) value0,
2233                         wrbuf_norm, wrbuf_disp);
2234                 yaz_log(YLOG_LOG, "run_icu input=%s norm=%s disp=%s",
2235                         (const char *) value0,
2236                         wrbuf_cstr(wrbuf_norm), wrbuf_cstr(wrbuf_disp));
2237                 rec_md = record_metadata_init(se->nmem, wrbuf_cstr(wrbuf_disp),
2238                                               wrbuf_cstr(wrbuf_norm),
2239                                               ser_md->type, 0);
2240             }
2241             else
2242             {
2243                 wrbuf_puts(wrbuf_disp, (const char *) value0);
2244                 rec_md = record_metadata_init(se->nmem, wrbuf_cstr(wrbuf_disp),
2245                                               0,
2246                                               ser_md->type, 0);
2247             }
2248
2249             xmlFree(value0);
2250
2251             // see if the field was not in cluster already (from beginning)
2252             if (!rec_md)
2253                 continue;
2254
2255             if (rank_num)
2256             {
2257                 int i;
2258                 for (i = 0; i < rank_num; i++)
2259                 {
2260                     const char *val = rank_values[i];
2261                     const char *cp = strchr(val, '=');
2262                     if (!cp)
2263                         continue;
2264                     if ((cp - val) == strlen((const char *) type)
2265                         && !memcmp(val, type, cp - val))
2266                     {
2267                         rank = cp + 1;
2268                         break;
2269                     }
2270                 }
2271             }
2272             else
2273             {
2274                 xml_rank = yaz_xml_get_prop(n, "rank");
2275                 rank = xml_rank ? (const char *) xml_rank : ser_md->rank;
2276             }
2277
2278             wheretoput = &cluster->metadata[md_field_id];
2279
2280             if (ser_md->merge == Metadata_merge_first)
2281             {
2282                 if (!metadata0[md_field_id])
2283                 {
2284                     while (*wheretoput)
2285                         wheretoput = &(*wheretoput)->next;
2286                     *wheretoput = rec_md;
2287                 }
2288             }
2289             else if (ser_md->merge == Metadata_merge_unique)
2290             {
2291                 while (*wheretoput)
2292                 {
2293                     if (!strcmp((const char *) (*wheretoput)->data.text.norm,
2294                                 rec_md->data.text.norm))
2295                         break;
2296                     wheretoput = &(*wheretoput)->next;
2297                 }
2298                 if (!*wheretoput)
2299                     *wheretoput = rec_md;
2300             }
2301             else if (ser_md->merge == Metadata_merge_longest)
2302             {
2303                 if (!*wheretoput
2304                     || strlen(rec_md->data.text.norm)
2305                     > strlen((*wheretoput)->data.text.norm))
2306                 {
2307                     *wheretoput = rec_md;
2308                     if (ser_sk)
2309                     {
2310                         pp2_charset_token_t prt;
2311                         const char *sort_str = 0;
2312                         int skip_article =
2313                             ser_sk->type == Metadata_type_skiparticle;
2314
2315                         if (!cluster->sortkeys[sk_field_id])
2316                             cluster->sortkeys[sk_field_id] =
2317                                 nmem_malloc(se->nmem,
2318                                             sizeof(union data_types));
2319
2320                         prt =
2321                             pp2_charset_token_create(service->charsets, "sort");
2322
2323                         pp2_charset_token_first(prt, rec_md->data.text.disp,
2324                                                 skip_article);
2325
2326                         pp2_charset_token_next(prt);
2327
2328                         sort_str = pp2_get_sort(prt);
2329
2330                         cluster->sortkeys[sk_field_id]->text.disp =
2331                             rec_md->data.text.disp;
2332                         if (!sort_str)
2333                         {
2334                             sort_str = rec_md->data.text.disp;
2335                             session_log(se, YLOG_WARN,
2336                                     "Could not make sortkey. Bug #1858");
2337                         }
2338                         cluster->sortkeys[sk_field_id]->text.sort =
2339                             nmem_strdup(se->nmem, sort_str);
2340                         pp2_charset_token_destroy(prt);
2341                     }
2342                 }
2343             }
2344             else if (ser_md->merge == Metadata_merge_all)
2345             {
2346                 while (*wheretoput)
2347                     wheretoput = &(*wheretoput)->next;
2348                 *wheretoput = rec_md;
2349             }
2350             else if (ser_md->merge == Metadata_merge_range)
2351             {
2352                 if (!*wheretoput)
2353                 {
2354                     *wheretoput = rec_md;
2355                     if (ser_sk)
2356                         cluster->sortkeys[sk_field_id]
2357                             = &rec_md->data;
2358                 }
2359                 else
2360                 {
2361                     int this_min = rec_md->data.number.min;
2362                     int this_max = rec_md->data.number.max;
2363                     if (this_min < (*wheretoput)->data.number.min)
2364                         (*wheretoput)->data.number.min = this_min;
2365                     if (this_max > (*wheretoput)->data.number.max)
2366                         (*wheretoput)->data.number.max = this_max;
2367                 }
2368             }
2369
2370             // ranking of _all_ fields enabled ...
2371             if (rank)
2372             {
2373                 relevance_countwords(se->relevance, cluster,
2374                                      wrbuf_cstr(wrbuf_disp),
2375                                      rank, ser_md->name);
2376             }
2377             // construct facets ... unless the client already has reported them
2378             if (ser_md->termlist && !client_has_facet(cl, (char *) type))
2379             {
2380                 if (ser_md->type == Metadata_type_year)
2381                 {
2382                     char year[64];
2383                     sprintf(year, "%d", rec_md->data.number.max);
2384
2385                     add_facet(se, (char *) type, year, term_factor);
2386                     if (rec_md->data.number.max != rec_md->data.number.min)
2387                     {
2388                         sprintf(year, "%d", rec_md->data.number.min);
2389                         add_facet(se, (char *) type, year, term_factor);
2390                     }
2391                 }
2392                 else
2393                     add_facet(se, type, wrbuf_cstr(wrbuf_disp), term_factor);
2394             }
2395         }
2396         else
2397         {
2398             if (se->number_of_warnings_unknown_elements == 0)
2399                 session_log(se, YLOG_WARN,
2400                         "Unexpected element in internal record: %s", n->name);
2401             se->number_of_warnings_unknown_elements++;
2402         }
2403     }
2404     nmem_destroy(ingest_nmem);
2405     xfree(metadata0);
2406     relevance_donerecord(se->relevance, cluster);
2407     se->total_records++;
2408
2409     return 0;
2410 }
2411
2412 void session_log(struct session *s, int level, const char *fmt, ...)
2413 {
2414     char buf[1024];
2415     va_list ap;
2416     va_start(ap, fmt);
2417
2418     yaz_vsnprintf(buf, sizeof(buf)-30, fmt, ap);
2419     yaz_log(level, "Session %u: %s", s ? s->session_id : 0, buf);
2420
2421     va_end(ap);
2422 }
2423
2424 /*
2425  * Local variables:
2426  * c-basic-offset: 4
2427  * c-file-style: "Stroustrup"
2428  * indent-tabs-mode: nil
2429  * End:
2430  * vim: shiftwidth=4 tabstop=8 expandtab
2431  */
2432