New GFS search member: present_number
[yaz-moved-to-github.git] / src / seshigh.c
1 /* This file is part of the YAZ toolkit.
2  * Copyright (C) 1995-2013 Index Data
3  * See the file LICENSE for details.
4  */
5 /**
6  * \file seshigh.c
7  * \brief Implements GFS session logic.
8  *
9  * Frontend server logic.
10  *
11  * This code receives incoming APDUs, and handles client requests by means
12  * of the backend API.
13  *
14  * Some of the code is getting quite involved, compared to simpler servers -
15  * primarily because it is asynchronous both in the communication with
16  * the user and the backend. We think the complexity will pay off in
17  * the form of greater flexibility when more asynchronous facilities
18  * are implemented.
19  *
20  * Memory management has become somewhat involved. In the simple case, where
21  * only one PDU is pending at a time, it will simply reuse the same memory,
22  * once it has found its working size. When we enable multiple concurrent
23  * operations, perhaps even with multiple parallel calls to the backend, it
24  * will maintain a pool of buffers for encoding and decoding, trying to
25  * minimize memory allocation/deallocation during normal operation.
26  *
27  */
28 #if HAVE_CONFIG_H
29 #include <config.h>
30 #endif
31
32 #include <limits.h>
33 #include <stdlib.h>
34 #include <stdio.h>
35 #include <assert.h>
36
37 #if HAVE_SYS_TYPES_H
38 #include <sys/types.h>
39 #endif
40 #if HAVE_SYS_STAT_H
41 #include <sys/stat.h>
42 #endif
43
44 #ifdef WIN32
45 #include <io.h>
46 #define S_ISREG(x) (x & _S_IFREG)
47 #include <process.h>
48 #endif
49
50 #if HAVE_UNISTD_H
51 #include <unistd.h>
52 #endif
53
54 #if YAZ_HAVE_XML2
55 #include <libxml/parser.h>
56 #include <libxml/tree.h>
57 #endif
58
59 #include <yaz/xmalloc.h>
60 #include <yaz/comstack.h>
61 #include "eventl.h"
62 #include "session.h"
63 #include "mime.h"
64 #include <yaz/proto.h>
65 #include <yaz/oid_db.h>
66 #include <yaz/log.h>
67 #include <yaz/logrpn.h>
68 #include <yaz/querytowrbuf.h>
69 #include <yaz/statserv.h>
70 #include <yaz/diagbib1.h>
71 #include <yaz/charneg.h>
72 #include <yaz/otherinfo.h>
73 #include <yaz/yaz-util.h>
74 #include <yaz/pquery.h>
75 #include <yaz/oid_db.h>
76
77 #include <yaz/srw.h>
78 #include <yaz/backend.h>
79 #include <yaz/yaz-ccl.h>
80
81 static void process_gdu_request(association *assoc, request *req);
82 static int process_z_request(association *assoc, request *req, char **msg);
83 static int process_gdu_response(association *assoc, request *req, Z_GDU *res);
84 static int process_z_response(association *assoc, request *req, Z_APDU *res);
85 static Z_APDU *process_initRequest(association *assoc, request *reqb);
86 static Z_External *init_diagnostics(ODR odr, int errcode,
87                                     const char *errstring);
88 static Z_APDU *process_searchRequest(association *assoc, request *reqb);
89 static Z_APDU *response_searchRequest(association *assoc, request *reqb,
90                                       bend_search_rr *bsrr);
91 static Z_APDU *process_presentRequest(association *assoc, request *reqb);
92 static Z_APDU *process_scanRequest(association *assoc, request *reqb);
93 static Z_APDU *process_sortRequest(association *assoc, request *reqb);
94 static void process_close(association *assoc, request *reqb);
95 static Z_APDU *process_deleteRequest(association *assoc, request *reqb);
96 static Z_APDU *process_segmentRequest(association *assoc, request *reqb);
97 static Z_APDU *process_ESRequest(association *assoc, request *reqb);
98
99 /* dynamic logging levels */
100 static int logbits_set = 0;
101 static int log_session = 0; /* one-line logs for session */
102 static int log_sessiondetail = 0; /* more detailed stuff */
103 static int log_request = 0; /* one-line logs for requests */
104 static int log_requestdetail = 0;  /* more detailed stuff */
105
106 /** get_logbits sets global loglevel bits */
107 static void get_logbits(void)
108 { /* needs to be called after parsing cmd-line args that can set loglevels!*/
109     if (!logbits_set)
110     {
111         logbits_set = 1;
112         log_session = yaz_log_module_level("session");
113         log_sessiondetail = yaz_log_module_level("sessiondetail");
114         log_request = yaz_log_module_level("request");
115         log_requestdetail = yaz_log_module_level("requestdetail");
116     }
117 }
118
119 static void wr_diag(WRBUF w, int error, const char *addinfo)
120 {
121     wrbuf_printf(w, "ERROR %d+", error);
122     wrbuf_puts_replace_char(w, diagbib1_str(error), ' ', '_');
123     if (addinfo)
124     {
125         wrbuf_puts(w, "+");
126         wrbuf_puts_replace_char(w, addinfo, ' ', '_');
127     }
128     wrbuf_puts(w, " ");
129 }
130
131 static int odr_int_to_int(Odr_int v)
132 {
133     if (v >= INT_MAX)
134         return INT_MAX;
135     else if (v <= INT_MIN)
136         return INT_MIN;
137     else
138         return (int) v;
139 }
140
141 /*
142  * Create and initialize a new association-handle.
143  *  channel  : iochannel for the current line.
144  *  link     : communications channel.
145  * Returns: 0 or a new association handle.
146  */
147 association *create_association(IOCHAN channel, COMSTACK link,
148                                 const char *apdufile)
149 {
150     association *anew;
151
152     if (!logbits_set)
153         get_logbits();
154     if (!(anew = (association *)xmalloc(sizeof(*anew))))
155         return 0;
156     anew->init = 0;
157     anew->version = 0;
158     anew->last_control = 0;
159     anew->client_chan = channel;
160     anew->client_link = link;
161     anew->cs_get_mask = 0;
162     anew->cs_put_mask = 0;
163     anew->cs_accept_mask = 0;
164     if (!(anew->decode = odr_createmem(ODR_DECODE)) ||
165         !(anew->encode = odr_createmem(ODR_ENCODE)))
166         return 0;
167     if (apdufile && *apdufile)
168     {
169         FILE *f;
170
171         if (!(anew->print = odr_createmem(ODR_PRINT)))
172             return 0;
173         if (*apdufile == '@')
174         {
175             odr_setprint(anew->print, yaz_log_file());
176         }
177         else if (*apdufile != '-')
178         {
179             char filename[256];
180             sprintf(filename, "%.200s.%ld", apdufile, (long)getpid());
181             if (!(f = fopen(filename, "w")))
182             {
183                 yaz_log(YLOG_WARN|YLOG_ERRNO, "%s", filename);
184                 return 0;
185             }
186             setvbuf(f, 0, _IONBF, 0);
187             odr_setprint(anew->print, f);
188         }
189     }
190     else
191         anew->print = 0;
192     anew->input_buffer = 0;
193     anew->input_buffer_len = 0;
194     anew->backend = 0;
195     anew->state = ASSOC_NEW;
196     request_initq(&anew->incoming);
197     request_initq(&anew->outgoing);
198     anew->proto = cs_getproto(link);
199     anew->server = 0;
200     return anew;
201 }
202
203 /*
204  * Free association and release resources.
205  */
206 void destroy_association(association *h)
207 {
208     statserv_options_block *cb = statserv_getcontrol();
209     request *req;
210
211     xfree(h->init);
212     odr_destroy(h->decode);
213     odr_destroy(h->encode);
214     if (h->print)
215         odr_destroy(h->print);
216     if (h->input_buffer)
217     xfree(h->input_buffer);
218     if (h->backend)
219         (*cb->bend_close)(h->backend);
220     while ((req = request_deq(&h->incoming)))
221         request_release(req);
222     while ((req = request_deq(&h->outgoing)))
223         request_release(req);
224     request_delq(&h->incoming);
225     request_delq(&h->outgoing);
226     xfree(h);
227     xmalloc_trav("session closed");
228 }
229
230 static void do_close_req(association *a, int reason, char *message,
231                          request *req)
232 {
233     Z_APDU *apdu = zget_APDU(a->encode, Z_APDU_close);
234     Z_Close *cls = apdu->u.close;
235
236     /* Purge request queue */
237     while (request_deq(&a->incoming));
238     while (request_deq(&a->outgoing));
239     if (a->version >= 3)
240     {
241         yaz_log(log_requestdetail, "Sending Close PDU, reason=%d, message=%s",
242             reason, message ? message : "none");
243         *cls->closeReason = reason;
244         cls->diagnosticInformation = message;
245         process_z_response(a, req, apdu);
246         iochan_settimeout(a->client_chan, 20);
247     }
248     else
249     {
250         request_release(req);
251         yaz_log(log_requestdetail, "v2 client. No Close PDU");
252         iochan_setevent(a->client_chan, EVENT_TIMEOUT); /* force imm close */
253         a->cs_put_mask = 0;
254     }
255     a->state = ASSOC_DEAD;
256 }
257
258 static void do_close(association *a, int reason, char *message)
259 {
260     request *req = request_get(&a->outgoing);
261     do_close_req(a, reason, message, req);
262 }
263
264
265 int ir_read(IOCHAN h, int event)
266 {
267     association *assoc = (association *)iochan_getdata(h);
268     COMSTACK conn = assoc->client_link;
269     request *req;
270
271     if ((assoc->cs_put_mask & EVENT_INPUT) == 0 && (event & assoc->cs_get_mask))
272     {
273         /* We aren't speaking to this fellow */
274         if (assoc->state == ASSOC_DEAD)
275         {
276             yaz_log(log_session, "Connection closed - end of session");
277             cs_close(conn);
278             destroy_association(assoc);
279             iochan_destroy(h);
280             return 0;
281         }
282         assoc->cs_get_mask = EVENT_INPUT;
283
284         do
285         {
286             int res = cs_get(conn, &assoc->input_buffer,
287                              &assoc->input_buffer_len);
288             if (res < 0 && cs_errno(conn) == CSBUFSIZE)
289             {
290                 yaz_log(log_session, "Connection error: %s res=%d",
291                         cs_errmsg(cs_errno(conn)), res);
292                 req = request_get(&assoc->incoming); /* get a new request */
293                 do_close_req(assoc, Z_Close_protocolError,
294                              "Incoming package too large", req);
295                 return 0;
296             }
297             else if (res <= 0)
298             {
299                 assoc->state = ASSOC_DEAD;
300                 yaz_log(log_session, "Connection closed by client");
301                 return 0;
302             }
303             else if (res == 1) /* incomplete read - wait for more  */
304             {
305                 if (conn->io_pending & CS_WANT_WRITE)
306                     assoc->cs_get_mask |= EVENT_OUTPUT;
307                 iochan_setflag(h, assoc->cs_get_mask);
308                 return 0;
309             }
310             /* we got a complete PDU. Let's decode it */
311             yaz_log(YLOG_DEBUG, "Got PDU, %d bytes: lead=%02X %02X %02X", res,
312                     assoc->input_buffer[0] & 0xff,
313                     assoc->input_buffer[1] & 0xff,
314                     assoc->input_buffer[2] & 0xff);
315             req = request_get(&assoc->incoming); /* get a new request */
316             odr_reset(assoc->decode);
317             odr_setbuf(assoc->decode, assoc->input_buffer, res, 0);
318             if (!z_GDU(assoc->decode, &req->gdu_request, 0, 0))
319             {
320                 yaz_log(YLOG_WARN, "ODR error on incoming PDU: %s [element %s] "
321                         "[near byte %ld] ",
322                         odr_errmsg(odr_geterror(assoc->decode)),
323                         odr_getelement(assoc->decode),
324                         (long) odr_offset(assoc->decode));
325                 if (assoc->decode->error != OHTTP)
326                 {
327                     yaz_log(YLOG_WARN, "PDU dump:");
328                     odr_dumpBER(yaz_log_file(), assoc->input_buffer, res);
329                     request_release(req);
330                     do_close(assoc, Z_Close_protocolError, "Malformed package");
331                 }
332                 else
333                 {
334                     Z_GDU *p = z_get_HTTP_Response(assoc->encode, 400);
335                     assoc->state = ASSOC_DEAD;
336                     process_gdu_response(assoc, req, p);
337                 }
338                 return 0;
339             }
340             req->request_mem = odr_extract_mem(assoc->decode);
341             if (assoc->print)
342             {
343                 if (!z_GDU(assoc->print, &req->gdu_request, 0, 0))
344                     yaz_log(YLOG_WARN, "ODR print error: %s",
345                             odr_errmsg(odr_geterror(assoc->print)));
346                 odr_reset(assoc->print);
347             }
348             request_enq(&assoc->incoming, req);
349         }
350         while (cs_more(conn));
351     }
352     return 1;
353 }
354
355 /*
356  * This is where PDUs from the client are read and the further
357  * processing is initiated. Flow of control moves down through the
358  * various process_* functions below, until the encoded result comes back up
359  * to the output handler in here.
360  *
361  *  h     : the I/O channel that has an outstanding event.
362  *  event : the current outstanding event.
363  */
364 void ir_session(IOCHAN h, int event)
365 {
366     int res;
367     association *assoc = (association *)iochan_getdata(h);
368     COMSTACK conn = assoc->client_link;
369     request *req;
370
371     assert(h && conn && assoc);
372     if (event == EVENT_TIMEOUT)
373     {
374         if (assoc->state != ASSOC_UP)
375         {
376             yaz_log(log_session, "Timeout. Closing connection");
377             /* do we need to lod this at all */
378             cs_close(conn);
379             destroy_association(assoc);
380             iochan_destroy(h);
381         }
382         else
383         {
384             yaz_log(log_sessiondetail, "Timeout. Sending Z39.50 Close");
385             do_close(assoc, Z_Close_lackOfActivity, 0);
386         }
387         return;
388     }
389     if (event & assoc->cs_accept_mask)
390     {
391         if (!cs_accept(conn))
392         {
393             yaz_log(YLOG_WARN, "accept failed");
394             destroy_association(assoc);
395             iochan_destroy(h);
396             return;
397         }
398         iochan_clearflag(h, EVENT_OUTPUT);
399         if (conn->io_pending)
400         {   /* cs_accept didn't complete */
401             assoc->cs_accept_mask =
402                 ((conn->io_pending & CS_WANT_WRITE) ? EVENT_OUTPUT : 0) |
403                 ((conn->io_pending & CS_WANT_READ) ? EVENT_INPUT : 0);
404
405             iochan_setflag(h, assoc->cs_accept_mask);
406         }
407         else
408         {   /* cs_accept completed. Prepare for reading (cs_get) */
409             assoc->cs_accept_mask = 0;
410             assoc->cs_get_mask = EVENT_INPUT;
411             iochan_setflag(h, assoc->cs_get_mask);
412         }
413         return;
414     }
415     if (event & assoc->cs_get_mask) /* input */
416     {
417         if (!ir_read(h, event))
418             return;
419         req = request_head(&assoc->incoming);
420         if (req->state == REQUEST_IDLE)
421         {
422             request_deq(&assoc->incoming);
423             process_gdu_request(assoc, req);
424         }
425     }
426     if (event & assoc->cs_put_mask)
427     {
428         request *req = request_head(&assoc->outgoing);
429
430         assoc->cs_put_mask = 0;
431         yaz_log(YLOG_DEBUG, "ir_session (output)");
432         req->state = REQUEST_PENDING;
433         switch (res = cs_put(conn, req->response, req->len_response))
434         {
435         case -1:
436             yaz_log(log_sessiondetail, "Connection closed by client");
437             cs_close(conn);
438             destroy_association(assoc);
439             iochan_destroy(h);
440             break;
441         case 0: /* all sent - release the request structure */
442             yaz_log(YLOG_DEBUG, "Wrote PDU, %d bytes", req->len_response);
443 #if 0
444             yaz_log(YLOG_DEBUG, "HTTP out:\n%.*s", req->len_response,
445                     req->response);
446 #endif
447             request_deq(&assoc->outgoing);
448             request_release(req);
449             if (!request_head(&assoc->outgoing))
450             {   /* restore mask for cs_get operation ... */
451                 iochan_clearflag(h, EVENT_OUTPUT|EVENT_INPUT);
452                 iochan_setflag(h, assoc->cs_get_mask);
453                 if (assoc->state == ASSOC_DEAD)
454                     iochan_setevent(assoc->client_chan, EVENT_TIMEOUT);
455             }
456             else
457             {
458                 assoc->cs_put_mask = EVENT_OUTPUT;
459             }
460             break;
461         default:
462             if (conn->io_pending & CS_WANT_WRITE)
463                 assoc->cs_put_mask |= EVENT_OUTPUT;
464             if (conn->io_pending & CS_WANT_READ)
465                 assoc->cs_put_mask |= EVENT_INPUT;
466             iochan_setflag(h, assoc->cs_put_mask);
467         }
468     }
469     if (event & EVENT_EXCEPT)
470     {
471         yaz_log(YLOG_WARN, "ir_session (exception)");
472         cs_close(conn);
473         destroy_association(assoc);
474         iochan_destroy(h);
475     }
476 }
477
478 static int process_z_request(association *assoc, request *req, char **msg);
479
480
481 static void assoc_init_reset(association *assoc)
482 {
483     xfree(assoc->init);
484     assoc->init = (bend_initrequest *) xmalloc(sizeof(*assoc->init));
485
486     assoc->init->stream = assoc->encode;
487     assoc->init->print = assoc->print;
488     assoc->init->auth = 0;
489     assoc->init->referenceId = 0;
490     assoc->init->implementation_version = 0;
491     assoc->init->implementation_id = 0;
492     assoc->init->implementation_name = 0;
493     assoc->init->query_charset = 0;
494     assoc->init->records_in_same_charset = 0;
495     assoc->init->bend_sort = NULL;
496     assoc->init->bend_search = NULL;
497     assoc->init->bend_present = NULL;
498     assoc->init->bend_esrequest = NULL;
499     assoc->init->bend_delete = NULL;
500     assoc->init->bend_scan = NULL;
501     assoc->init->bend_segment = NULL;
502     assoc->init->bend_fetch = NULL;
503     assoc->init->bend_explain = NULL;
504     assoc->init->bend_srw_scan = NULL;
505     assoc->init->bend_srw_update = NULL;
506     assoc->init->named_result_sets = 0;
507
508     assoc->init->charneg_request = NULL;
509     assoc->init->charneg_response = NULL;
510
511     assoc->init->decode = assoc->decode;
512     assoc->init->peer_name =
513         odr_strdup(assoc->encode, cs_addrstr(assoc->client_link));
514
515     yaz_log(log_requestdetail, "peer %s", assoc->init->peer_name);
516 }
517
518 static int srw_bend_init(association *assoc, Z_SRW_diagnostic **d, int *num, Z_SRW_PDU *sr)
519 {
520     statserv_options_block *cb = statserv_getcontrol();
521     if (!assoc->init)
522     {
523         const char *encoding = "UTF-8";
524         Z_External *ce;
525         bend_initresult *binitres;
526
527         yaz_log(log_requestdetail, "srw_bend_init config=%s", cb->configname);
528         assoc_init_reset(assoc);
529
530         if (sr->username)
531         {
532             Z_IdAuthentication *auth = (Z_IdAuthentication *)
533                 odr_malloc(assoc->decode, sizeof(*auth));
534             size_t len;
535
536             len = strlen(sr->username) + 1;
537             if (sr->password)
538                 len += strlen(sr->password) + 2;
539             yaz_log(log_requestdetail, "username=%s password-len=%ld",
540                     sr->username, (long)
541                     (sr->password ? strlen(sr->password) : 0));
542             auth->which = Z_IdAuthentication_open;
543             auth->u.open = (char *) odr_malloc(assoc->decode, len);
544             strcpy(auth->u.open, sr->username);
545             if (sr->password && *sr->password)
546             {
547                 strcat(auth->u.open, "/");
548                 strcat(auth->u.open, sr->password);
549             }
550             assoc->init->auth = auth;
551         }
552
553 #if 1
554         ce = yaz_set_proposal_charneg(assoc->decode, &encoding, 1, 0, 0, 1);
555         assoc->init->charneg_request = ce->u.charNeg3;
556 #endif
557         assoc->backend = 0;
558         if (!(binitres = (*cb->bend_init)(assoc->init)))
559         {
560             assoc->state = ASSOC_DEAD;
561             yaz_add_srw_diagnostic(assoc->encode, d, num,
562                             YAZ_SRW_AUTHENTICATION_ERROR, 0);
563             return 0;
564         }
565         assoc->backend = binitres->handle;
566         assoc->init->auth = 0;
567         if (binitres->errcode)
568         {
569             int srw_code = yaz_diag_bib1_to_srw(binitres->errcode);
570             assoc->state = ASSOC_DEAD;
571             yaz_add_srw_diagnostic(assoc->encode, d, num, srw_code,
572                                    binitres->errstring);
573             return 0;
574         }
575         return 1;
576     }
577     return 1;
578 }
579
580 static int retrieve_fetch(association *assoc, bend_fetch_rr *rr)
581 {
582 #if YAZ_HAVE_XML2
583     yaz_record_conv_t rc = 0;
584     const char *match_schema = 0;
585     Odr_oid *match_syntax = 0;
586
587     if (assoc->server)
588     {
589         int r;
590         const char *input_schema = yaz_get_esn(rr->comp);
591         Odr_oid *input_syntax_raw = rr->request_format;
592
593         const char *backend_schema = 0;
594         Odr_oid *backend_syntax = 0;
595
596         r = yaz_retrieval_request(assoc->server->retrieval,
597                                   input_schema,
598                                   input_syntax_raw,
599                                   &match_schema,
600                                   &match_syntax,
601                                   &rc,
602                                   &backend_schema,
603                                   &backend_syntax);
604         if (r == -1) /* error ? */
605         {
606             const char *details = yaz_retrieval_get_error(
607                 assoc->server->retrieval);
608
609             rr->errcode = YAZ_BIB1_SYSTEM_ERROR_IN_PRESENTING_RECORDS;
610             if (details)
611                 rr->errstring = odr_strdup(rr->stream, details);
612             return -1;
613         }
614         else if (r == 1 || r == 3)
615         {
616             const char *details = input_schema;
617             rr->errcode =
618                 YAZ_BIB1_SPECIFIED_ELEMENT_SET_NAME_NOT_VALID_FOR_SPECIFIED_;
619             if (details)
620                 rr->errstring = odr_strdup(rr->stream, details);
621             return -1;
622         }
623         else if (r == 2)
624         {
625             rr->errcode = YAZ_BIB1_RECORD_SYNTAX_UNSUPP;
626             if (input_syntax_raw)
627             {
628                 char oidbuf[OID_STR_MAX];
629                 oid_oid_to_dotstring(input_syntax_raw, oidbuf);
630                 rr->errstring = odr_strdup(rr->stream, oidbuf);
631             }
632             return -1;
633         }
634         if (backend_schema)
635         {
636             yaz_set_esn(&rr->comp, backend_schema, odr_getmem(rr->stream));
637         }
638         if (backend_syntax)
639             rr->request_format = backend_syntax;
640     }
641     (*assoc->init->bend_fetch)(assoc->backend, rr);
642     if (rc && rr->record && rr->errcode == 0 && rr->len > 0)
643     {   /* post conversion must take place .. */
644         WRBUF output_record = wrbuf_alloc();
645         int r = yaz_record_conv_record(rc, rr->record, rr->len, output_record);
646         if (r)
647         {
648             const char *details = yaz_record_conv_get_error(rc);
649             rr->errcode = YAZ_BIB1_SYSTEM_ERROR_IN_PRESENTING_RECORDS;
650             if (details)
651                 rr->errstring = odr_strdup(rr->stream, details);
652         }
653         else
654         {
655             rr->len = wrbuf_len(output_record);
656             rr->record = (char *) odr_malloc(rr->stream, rr->len);
657             memcpy(rr->record, wrbuf_buf(output_record), rr->len);
658         }
659         wrbuf_destroy(output_record);
660     }
661     if (match_syntax)
662         rr->output_format = match_syntax;
663     if (match_schema)
664         rr->schema = odr_strdup(rr->stream, match_schema);
665 #else
666     (*assoc->init->bend_fetch)(assoc->backend, rr);
667 #endif
668     return 0;
669 }
670
671 static int srw_bend_fetch(association *assoc, int pos,
672                           Z_SRW_searchRetrieveRequest *srw_req,
673                           Z_SRW_record *record,
674                           const char **addinfo, int *last_in_set)
675 {
676     bend_fetch_rr rr;
677     ODR o = assoc->encode;
678
679     rr.setname = "default";
680     rr.number = pos;
681     rr.referenceId = 0;
682     rr.request_format = odr_oiddup(assoc->decode, yaz_oid_recsyn_xml);
683
684     rr.comp = (Z_RecordComposition *)
685             odr_malloc(assoc->decode, sizeof(*rr.comp));
686     rr.comp->which = Z_RecordComp_complex;
687     rr.comp->u.complex = (Z_CompSpec *)
688             odr_malloc(assoc->decode, sizeof(Z_CompSpec));
689     rr.comp->u.complex->selectAlternativeSyntax = (bool_t *)
690         odr_malloc(assoc->encode, sizeof(bool_t));
691     *rr.comp->u.complex->selectAlternativeSyntax = 0;
692     rr.comp->u.complex->num_dbSpecific = 0;
693     rr.comp->u.complex->dbSpecific = 0;
694     rr.comp->u.complex->num_recordSyntax = 0;
695     rr.comp->u.complex->recordSyntax = 0;
696
697     rr.comp->u.complex->generic = (Z_Specification *)
698             odr_malloc(assoc->decode, sizeof(Z_Specification));
699
700     /* schema uri = recordSchema (or NULL if recordSchema is not given) */
701     rr.comp->u.complex->generic->which = Z_Schema_uri;
702     rr.comp->u.complex->generic->schema.uri = srw_req->recordSchema;
703
704     /* ESN = recordSchema if recordSchema is present */
705     rr.comp->u.complex->generic->elementSpec = 0;
706     if (srw_req->recordSchema)
707     {
708         rr.comp->u.complex->generic->elementSpec =
709             (Z_ElementSpec *) odr_malloc(assoc->encode, sizeof(Z_ElementSpec));
710         rr.comp->u.complex->generic->elementSpec->which =
711             Z_ElementSpec_elementSetName;
712         rr.comp->u.complex->generic->elementSpec->u.elementSetName =
713             srw_req->recordSchema;
714     }
715
716     rr.stream = assoc->encode;
717     rr.print = assoc->print;
718
719     rr.basename = 0;
720     rr.len = 0;
721     rr.record = 0;
722     rr.last_in_set = 0;
723     rr.errcode = 0;
724     rr.errstring = 0;
725     rr.surrogate_flag = 0;
726     rr.schema = srw_req->recordSchema;
727
728     if (!assoc->init->bend_fetch)
729         return 1;
730
731     retrieve_fetch(assoc, &rr);
732
733     *last_in_set = rr.last_in_set;
734
735     if (rr.errcode && rr.surrogate_flag)
736     {
737         int code = yaz_diag_bib1_to_srw(rr.errcode);
738         yaz_mk_sru_surrogate(o, record, pos, code, rr.errstring);
739         return 0;
740     }
741     else if (rr.len >= 0)
742     {
743         record->recordData_buf = rr.record;
744         record->recordData_len = rr.len;
745         record->recordPosition = odr_intdup(o, pos);
746         record->recordSchema = odr_strdup_null(
747             o, rr.schema ? rr.schema : srw_req->recordSchema);
748     }
749     if (rr.errcode)
750     {
751         *addinfo = rr.errstring;
752         return rr.errcode;
753     }
754     return 0;
755 }
756
757 static int cql2pqf(ODR odr, const char *cql, cql_transform_t ct,
758                    Z_Query *query_result, char **sortkeys_p)
759 {
760     /* have a CQL query and  CQL to PQF transform .. */
761     CQL_parser cp = cql_parser_create();
762     int r;
763     int srw_errcode = 0;
764     const char *add = 0;
765     WRBUF rpn_buf = wrbuf_alloc();
766
767     *sortkeys_p = 0;
768     r = cql_parser_string(cp, cql);
769     if (r)
770     {
771         srw_errcode = YAZ_SRW_QUERY_SYNTAX_ERROR;
772     }
773     if (!r)
774     {
775         struct cql_node *cn = cql_parser_result(cp);
776
777         /* Syntax OK */
778         r = cql_transform(ct, cn, wrbuf_vp_puts, rpn_buf);
779         if (r)
780             srw_errcode = cql_transform_error(ct, &add);
781         else
782         {
783             char out[100];
784             int r = cql_sortby_to_sortkeys_buf(cn, out, sizeof(out)-1);
785
786             if (r == 0)
787             {
788                 if (*out)
789                     yaz_log(log_requestdetail, "srw_sortKeys '%s'", out);
790                 *sortkeys_p = odr_strdup(odr, out);
791             }
792             else
793             {
794                 yaz_log(log_requestdetail, "failed to create srw_sortKeys");
795                 srw_errcode = YAZ_SRW_UNSUPP_SORT_TYPE;
796             }
797         }
798     }
799     if (!r)
800     {
801         /* Syntax & transform OK. */
802         /* Convert PQF string to Z39.50 to RPN query struct */
803         YAZ_PQF_Parser pp = yaz_pqf_create();
804         Z_RPNQuery *rpnquery = yaz_pqf_parse(pp, odr, wrbuf_cstr(rpn_buf));
805         if (!rpnquery)
806         {
807             size_t off;
808             const char *pqf_msg;
809             int code = yaz_pqf_error(pp, &pqf_msg, &off);
810             yaz_log(YLOG_WARN, "PQF Parser Error %s (code %d)",
811                     pqf_msg, code);
812             srw_errcode = YAZ_SRW_QUERY_SYNTAX_ERROR;
813         }
814         else
815         {
816             query_result->which = Z_Query_type_1;
817             query_result->u.type_1 = rpnquery;
818         }
819         yaz_pqf_destroy(pp);
820     }
821     cql_parser_destroy(cp);
822     wrbuf_destroy(rpn_buf);
823     return srw_errcode;
824 }
825
826 static int cql2pqf_scan(ODR odr, const char *cql, cql_transform_t ct,
827                         Z_AttributesPlusTerm *result)
828 {
829     Z_Query query;
830     Z_RPNQuery *rpn;
831     char *sortkeys = 0;
832     int srw_error = cql2pqf(odr, cql, ct, &query, &sortkeys);
833     if (srw_error)
834         return srw_error;
835     if (query.which != Z_Query_type_1 && query.which != Z_Query_type_101)
836         return YAZ_SRW_QUERY_SYNTAX_ERROR; /* bad query type */
837     rpn = query.u.type_1;
838     if (!rpn->RPNStructure)
839         return YAZ_SRW_QUERY_SYNTAX_ERROR; /* must be structure */
840     if (rpn->RPNStructure->which != Z_RPNStructure_simple)
841         return YAZ_SRW_QUERY_SYNTAX_ERROR; /* must be simple */
842     if (rpn->RPNStructure->u.simple->which != Z_Operand_APT)
843         return YAZ_SRW_QUERY_SYNTAX_ERROR; /* must be be attributes + term */
844     memcpy(result, rpn->RPNStructure->u.simple->u.attributesPlusTerm,
845            sizeof(*result));
846     return 0;
847 }
848
849
850 static int ccl2pqf(ODR odr, const Odr_oct *ccl, CCL_bibset bibset,
851                    bend_search_rr *bsrr)
852 {
853     char *ccl0;
854     struct ccl_rpn_node *node;
855     int errcode, pos;
856
857     ccl0 = odr_strdupn(odr, (char*) ccl->buf, ccl->len);
858     if ((node = ccl_find_str(bibset, ccl0, &errcode, &pos)) == 0)
859     {
860         bsrr->errstring = (char*) ccl_err_msg(errcode);
861         return YAZ_SRW_QUERY_SYNTAX_ERROR;    /* Query syntax error */
862     }
863
864     bsrr->query->which = Z_Query_type_1;
865     bsrr->query->u.type_1 = ccl_rpn_query(odr, node);
866     return 0;
867 }
868
869 static void srw_bend_search(association *assoc,
870                             Z_SRW_PDU *sr,
871                             Z_SRW_PDU *res,
872                             int *http_code)
873 {
874     Z_SRW_searchRetrieveResponse *srw_res = res->u.response;
875     int srw_error = 0;
876     Z_External *ext;
877     Z_SRW_searchRetrieveRequest *srw_req = sr->u.request;
878
879     *http_code = 200;
880     yaz_log(log_requestdetail, "Got SRW SearchRetrieveRequest");
881     srw_bend_init(assoc, &srw_res->diagnostics, &srw_res->num_diagnostics, sr);
882     if (srw_res->num_diagnostics == 0 && assoc->init)
883     {
884         bend_search_rr rr;
885         rr.setname = "default";
886         rr.replace_set = 1;
887         rr.num_bases = 1;
888         rr.basenames = &srw_req->database;
889         rr.referenceId = 0;
890         rr.srw_sortKeys = 0;
891         rr.srw_setname = 0;
892         rr.srw_setnameIdleTime = 0;
893         rr.estimated_hit_count = 0;
894         rr.partial_resultset = 0;
895         rr.query = (Z_Query *) odr_malloc(assoc->decode, sizeof(*rr.query));
896         rr.query->u.type_1 = 0;
897         rr.extra_args = sr->extra_args;
898         rr.extra_response_data = 0;
899         rr.present_number = srw_req->maximumRecords ?
900             *srw_req->maximumRecords : 0;
901
902         if (srw_req->query_type == Z_SRW_query_type_cql)
903         {
904             if (assoc->server && assoc->server->cql_transform)
905             {
906                 int srw_errcode = cql2pqf(assoc->encode, srw_req->query.cql,
907                                           assoc->server->cql_transform,
908                                           rr.query,
909                                           &rr.srw_sortKeys);
910
911                 if (srw_errcode)
912                 {
913                     yaz_add_srw_diagnostic(assoc->encode,
914                                            &srw_res->diagnostics,
915                                            &srw_res->num_diagnostics,
916                                            srw_errcode, 0);
917                 }
918             }
919             else
920             {
921                 /* CQL query to backend. Wrap it - Z39.50 style */
922                 ext = (Z_External *) odr_malloc(assoc->decode, sizeof(*ext));
923                 ext->direct_reference = odr_getoidbystr(assoc->decode,
924                                                         "1.2.840.10003.16.2");
925                 ext->indirect_reference = 0;
926                 ext->descriptor = 0;
927                 ext->which = Z_External_CQL;
928                 ext->u.cql = srw_req->query.cql;
929
930                 rr.query->which = Z_Query_type_104;
931                 rr.query->u.type_104 =  ext;
932             }
933         }
934         else if (srw_req->query_type == Z_SRW_query_type_pqf)
935         {
936             Z_RPNQuery *RPNquery;
937             YAZ_PQF_Parser pqf_parser;
938
939             pqf_parser = yaz_pqf_create();
940
941             RPNquery = yaz_pqf_parse(pqf_parser, assoc->decode,
942                                      srw_req->query.pqf);
943             if (!RPNquery)
944             {
945                 const char *pqf_msg;
946                 size_t off;
947                 int code = yaz_pqf_error(pqf_parser, &pqf_msg, &off);
948                 yaz_log(log_requestdetail, "Parse error %d %s near offset %ld",
949                         code, pqf_msg, (long) off);
950                 srw_error = YAZ_SRW_QUERY_SYNTAX_ERROR;
951             }
952
953             rr.query->which = Z_Query_type_1;
954             rr.query->u.type_1 =  RPNquery;
955
956             yaz_pqf_destroy(pqf_parser);
957         }
958         else
959         {
960             yaz_add_srw_diagnostic(assoc->encode, &srw_res->diagnostics,
961                                    &srw_res->num_diagnostics,
962                                    YAZ_SRW_UNSUPP_QUERY_TYPE, 0);
963         }
964         if (rr.query->u.type_1)
965         {
966             rr.stream = assoc->encode;
967             rr.decode = assoc->decode;
968             rr.print = assoc->print;
969             if (srw_req->sort.sortKeys)
970                 rr.srw_sortKeys = odr_strdup(assoc->encode,
971                                              srw_req->sort.sortKeys);
972             rr.association = assoc;
973             rr.hits = 0;
974             rr.errcode = 0;
975             rr.errstring = 0;
976             rr.search_info = 0;
977             rr.search_input = 0;
978             yaz_log_zquery_level(log_requestdetail,rr.query);
979
980             (assoc->init->bend_search)(assoc->backend, &rr);
981             if (rr.errcode)
982             {
983                 if (rr.errcode == YAZ_BIB1_DATABASE_UNAVAILABLE)
984                 {
985                     *http_code = 404;
986                 }
987                 else
988                 {
989                     srw_error = yaz_diag_bib1_to_srw(rr.errcode);
990                     yaz_add_srw_diagnostic(assoc->encode,
991                                            &srw_res->diagnostics,
992                                            &srw_res->num_diagnostics,
993                                            srw_error, rr.errstring);
994                 }
995             }
996             else
997             {
998                 int number = srw_req->maximumRecords ?
999                     odr_int_to_int(*srw_req->maximumRecords) : 0;
1000                 int start = srw_req->startRecord ?
1001                     odr_int_to_int(*srw_req->startRecord) : 1;
1002
1003                 yaz_log(log_requestdetail, "Request to pack %d+%d out of "
1004                         ODR_INT_PRINTF,
1005                         start, number, rr.hits);
1006
1007                 srw_res->numberOfRecords = odr_intdup(assoc->encode, rr.hits);
1008                 if (rr.srw_setname)
1009                 {
1010                     srw_res->resultSetId =
1011                         odr_strdup(assoc->encode, rr.srw_setname );
1012                     srw_res->resultSetIdleTime =
1013                         odr_intdup(assoc->encode, *rr.srw_setnameIdleTime );
1014                 }
1015
1016                 if (start > rr.hits || start < 1)
1017                 {
1018                     /* if hits<=0 and start=1 we don't return a diagnostic */
1019                     if (start != 1)
1020                         yaz_add_srw_diagnostic(
1021                             assoc->encode,
1022                             &srw_res->diagnostics, &srw_res->num_diagnostics,
1023                             YAZ_SRW_FIRST_RECORD_POSITION_OUT_OF_RANGE, 0);
1024                 }
1025                 else if (number > 0)
1026                 {
1027                     int i;
1028                     int ok = 1;
1029                     if (start + number > rr.hits)
1030                         number = odr_int_to_int(rr.hits) - start + 1;
1031
1032                     /* Call bend_present if defined */
1033                     if (assoc->init->bend_present)
1034                     {
1035                         bend_present_rr *bprr = (bend_present_rr*)
1036                             odr_malloc(assoc->decode, sizeof(*bprr));
1037                         bprr->setname = "default";
1038                         bprr->start = start;
1039                         bprr->number = number;
1040                         if (srw_req->recordSchema)
1041                         {
1042                             bprr->comp = (Z_RecordComposition *) odr_malloc(assoc->decode,
1043                                                                             sizeof(*bprr->comp));
1044                             bprr->comp->which = Z_RecordComp_simple;
1045                             bprr->comp->u.simple = (Z_ElementSetNames *)
1046                                 odr_malloc(assoc->decode, sizeof(Z_ElementSetNames));
1047                             bprr->comp->u.simple->which = Z_ElementSetNames_generic;
1048                             bprr->comp->u.simple->u.generic = srw_req->recordSchema;
1049                         }
1050                         else
1051                         {
1052                             bprr->comp = 0;
1053                         }
1054                         bprr->stream = assoc->encode;
1055                         bprr->referenceId = 0;
1056                         bprr->print = assoc->print;
1057                         bprr->association = assoc;
1058                         bprr->errcode = 0;
1059                         bprr->errstring = NULL;
1060                         (*assoc->init->bend_present)(assoc->backend, bprr);
1061
1062                         if (bprr->errcode)
1063                         {
1064                             srw_error = yaz_diag_bib1_to_srw(bprr->errcode);
1065                             yaz_add_srw_diagnostic(assoc->encode,
1066                                                    &srw_res->diagnostics,
1067                                                    &srw_res->num_diagnostics,
1068                                                    srw_error, bprr->errstring);
1069                             ok = 0;
1070                         }
1071                     }
1072
1073                     if (ok)
1074                     {
1075                         int j = 0;
1076                         int packing = Z_SRW_recordPacking_string;
1077                         if (srw_req->recordPacking)
1078                         {
1079                             packing =
1080                                 yaz_srw_str_to_pack(srw_req->recordPacking);
1081                             if (packing == -1)
1082                                 packing = Z_SRW_recordPacking_string;
1083                         }
1084                         srw_res->records = (Z_SRW_record *)
1085                             odr_malloc(assoc->encode,
1086                                        number * sizeof(*srw_res->records));
1087
1088                         srw_res->extra_records = (Z_SRW_extra_record **)
1089                             odr_malloc(assoc->encode,
1090                                        number*sizeof(*srw_res->extra_records));
1091
1092                         for (i = 0; i<number; i++)
1093                         {
1094                             int errcode;
1095                             int last_in_set = 0;
1096                             const char *addinfo = 0;
1097
1098                             srw_res->records[j].recordPacking = packing;
1099                             srw_res->records[j].recordData_buf = 0;
1100                             srw_res->extra_records[j] = 0;
1101                             yaz_log(YLOG_DEBUG, "srw_bend_fetch %d", i+start);
1102                             errcode = srw_bend_fetch(assoc, i+start, srw_req,
1103                                                      srw_res->records + j,
1104                                                      &addinfo, &last_in_set);
1105                             if (errcode)
1106                             {
1107                                 yaz_add_srw_diagnostic(assoc->encode,
1108                                                        &srw_res->diagnostics,
1109                                                        &srw_res->num_diagnostics,
1110                                                        yaz_diag_bib1_to_srw(errcode),
1111                                                        addinfo);
1112
1113                                 break;
1114                             }
1115                             if (srw_res->records[j].recordData_buf)
1116                                 j++;
1117                             if (last_in_set)
1118                                 break;
1119                         }
1120                         srw_res->num_records = j;
1121                         if (!j)
1122                             srw_res->records = 0;
1123                     }
1124                 }
1125                 if (rr.extra_response_data)
1126                 {
1127                     res->extraResponseData_buf = rr.extra_response_data;
1128                     res->extraResponseData_len = strlen(rr.extra_response_data);
1129                 }
1130                 if (rr.estimated_hit_count || rr.partial_resultset)
1131                 {
1132                     yaz_add_srw_diagnostic(
1133                         assoc->encode,
1134                         &srw_res->diagnostics,
1135                         &srw_res->num_diagnostics,
1136                         YAZ_SRW_RESULT_SET_CREATED_WITH_VALID_PARTIAL_RESULTS_AVAILABLE,
1137                         0);
1138                 }
1139             }
1140         }
1141     }
1142     if (log_request)
1143     {
1144         const char *querystr = "?";
1145         const char *querytype = "?";
1146         WRBUF wr = wrbuf_alloc();
1147
1148         switch (srw_req->query_type)
1149         {
1150         case Z_SRW_query_type_cql:
1151             querytype = "CQL";
1152             querystr = srw_req->query.cql;
1153             break;
1154         case Z_SRW_query_type_pqf:
1155             querytype = "PQF";
1156             querystr = srw_req->query.pqf;
1157             break;
1158         }
1159         wrbuf_printf(wr, "SRWSearch %s ", srw_req->database);
1160         if (srw_res->num_diagnostics)
1161             wrbuf_printf(wr, "ERROR %s", srw_res->diagnostics[0].uri);
1162         else if (*http_code != 200)
1163             wrbuf_printf(wr, "ERROR info:http/%d", *http_code);
1164         else if (srw_res->numberOfRecords)
1165         {
1166             wrbuf_printf(wr, "OK " ODR_INT_PRINTF,
1167                          (srw_res->numberOfRecords ?
1168                           *srw_res->numberOfRecords : 0));
1169         }
1170         wrbuf_printf(wr, " %s " ODR_INT_PRINTF "+%d",
1171                      (srw_res->resultSetId ?
1172                       srw_res->resultSetId : "-"),
1173                      (srw_req->startRecord ? *srw_req->startRecord : 1),
1174                      srw_res->num_records);
1175         yaz_log(log_request, "%s %s: %s", wrbuf_cstr(wr), querytype, querystr);
1176         wrbuf_destroy(wr);
1177     }
1178 }
1179
1180 static char *srw_bend_explain_default(bend_explain_rr *rr)
1181 {
1182 #if YAZ_HAVE_XML2
1183     xmlNodePtr ptr = (xmlNode *) rr->server_node_ptr;
1184     if (!ptr)
1185         return 0;
1186     for (ptr = ptr->children; ptr; ptr = ptr->next)
1187     {
1188         if (ptr->type != XML_ELEMENT_NODE)
1189             continue;
1190         if (!strcmp((const char *) ptr->name, "explain"))
1191         {
1192             int len;
1193             xmlDocPtr doc = xmlNewDoc(BAD_CAST "1.0");
1194             xmlChar *buf_out;
1195             char *content;
1196
1197             ptr = xmlCopyNode(ptr, 1);
1198
1199             xmlDocSetRootElement(doc, ptr);
1200
1201             xmlDocDumpMemory(doc, &buf_out, &len);
1202             content = (char*) odr_malloc(rr->stream, 1+len);
1203             memcpy(content, buf_out, len);
1204             content[len] = '\0';
1205
1206             xmlFree(buf_out);
1207             xmlFreeDoc(doc);
1208             rr->explain_buf = content;
1209             return 0;
1210         }
1211     }
1212 #endif
1213     return 0;
1214 }
1215
1216 static void srw_bend_explain(association *assoc,
1217                              Z_SRW_PDU *sr,
1218                              Z_SRW_explainResponse *srw_res,
1219                              int *http_code)
1220 {
1221     Z_SRW_explainRequest *srw_req = sr->u.explain_request;
1222     yaz_log(log_requestdetail, "Got SRW ExplainRequest");
1223     *http_code = 404;
1224     srw_bend_init(assoc, &srw_res->diagnostics, &srw_res->num_diagnostics, sr);
1225     if (assoc->init)
1226     {
1227         bend_explain_rr rr;
1228
1229         rr.stream = assoc->encode;
1230         rr.decode = assoc->decode;
1231         rr.print = assoc->print;
1232         rr.explain_buf = 0;
1233         rr.database = srw_req->database;
1234         if (assoc->server)
1235             rr.server_node_ptr = assoc->server->server_node_ptr;
1236         else
1237             rr.server_node_ptr = 0;
1238         rr.schema = "http://explain.z3950.org/dtd/2.0/";
1239         if (assoc->init->bend_explain)
1240             (*assoc->init->bend_explain)(assoc->backend, &rr);
1241         else
1242             srw_bend_explain_default(&rr);
1243
1244         if (rr.explain_buf)
1245         {
1246             int packing = Z_SRW_recordPacking_string;
1247             if (srw_req->recordPacking)
1248             {
1249                 packing =
1250                     yaz_srw_str_to_pack(srw_req->recordPacking);
1251                 if (packing == -1)
1252                     packing = Z_SRW_recordPacking_string;
1253             }
1254             srw_res->record.recordSchema = rr.schema;
1255             srw_res->record.recordPacking = packing;
1256             srw_res->record.recordData_buf = rr.explain_buf;
1257             srw_res->record.recordData_len = strlen(rr.explain_buf);
1258             srw_res->record.recordPosition = 0;
1259             *http_code = 200;
1260         }
1261     }
1262 }
1263
1264 static void srw_bend_scan(association *assoc,
1265                           Z_SRW_PDU *sr,
1266                           Z_SRW_scanResponse *srw_res,
1267                           int *http_code)
1268 {
1269     Z_SRW_scanRequest *srw_req = sr->u.scan_request;
1270     yaz_log(log_requestdetail, "Got SRW ScanRequest");
1271
1272     *http_code = 200;
1273     srw_bend_init(assoc, &srw_res->diagnostics, &srw_res->num_diagnostics, sr);
1274     if (srw_res->num_diagnostics == 0 && assoc->init)
1275     {
1276         int step_size = 0;
1277         struct scan_entry *save_entries;
1278
1279         bend_scan_rr *bsrr = (bend_scan_rr *)
1280             odr_malloc(assoc->encode, sizeof(*bsrr));
1281         bsrr->num_bases = 1;
1282         bsrr->basenames = &srw_req->database;
1283
1284         bsrr->num_entries = srw_req->maximumTerms ?
1285             odr_int_to_int(*srw_req->maximumTerms) : 10;
1286         bsrr->term_position = srw_req->responsePosition ?
1287             odr_int_to_int(*srw_req->responsePosition) : 1;
1288
1289         bsrr->errcode = 0;
1290         bsrr->errstring = 0;
1291         bsrr->referenceId = 0;
1292         bsrr->stream = assoc->encode;
1293         bsrr->print = assoc->print;
1294         bsrr->step_size = &step_size;
1295         bsrr->entries = 0;
1296         bsrr->setname = 0;
1297
1298         if (bsrr->num_entries > 0)
1299         {
1300             int i;
1301             bsrr->entries = (struct scan_entry *)
1302                 odr_malloc(assoc->decode, sizeof(*bsrr->entries) *
1303                            bsrr->num_entries);
1304             for (i = 0; i<bsrr->num_entries; i++)
1305             {
1306                 bsrr->entries[i].term = 0;
1307                 bsrr->entries[i].occurrences = 0;
1308                 bsrr->entries[i].errcode = 0;
1309                 bsrr->entries[i].errstring = 0;
1310                 bsrr->entries[i].display_term = 0;
1311             }
1312         }
1313         save_entries = bsrr->entries;  /* save it so we can compare later */
1314
1315         if (srw_req->query_type == Z_SRW_query_type_pqf &&
1316             assoc->init->bend_scan)
1317         {
1318             YAZ_PQF_Parser pqf_parser = yaz_pqf_create();
1319
1320             bsrr->term = yaz_pqf_scan(pqf_parser, assoc->decode,
1321                                       &bsrr->attributeset,
1322                                       srw_req->scanClause.pqf);
1323             yaz_pqf_destroy(pqf_parser);
1324             bsrr->scanClause = 0;
1325             ((int (*)(void *, bend_scan_rr *))
1326              (*assoc->init->bend_scan))(assoc->backend, bsrr);
1327         }
1328         else if (srw_req->query_type == Z_SRW_query_type_cql
1329                  && assoc->init->bend_scan && assoc->server
1330                  && assoc->server->cql_transform)
1331         {
1332             int srw_error;
1333             bsrr->scanClause = 0;
1334             bsrr->attributeset = 0;
1335             bsrr->term = (Z_AttributesPlusTerm *)
1336                 odr_malloc(assoc->decode, sizeof(*bsrr->term));
1337             srw_error = cql2pqf_scan(assoc->encode,
1338                                      srw_req->scanClause.cql,
1339                                      assoc->server->cql_transform,
1340                                      bsrr->term);
1341             if (srw_error)
1342                 yaz_add_srw_diagnostic(assoc->encode, &srw_res->diagnostics,
1343                                        &srw_res->num_diagnostics,
1344                                        srw_error, 0);
1345             else
1346             {
1347                 ((int (*)(void *, bend_scan_rr *))
1348                  (*assoc->init->bend_scan))(assoc->backend, bsrr);
1349             }
1350         }
1351         else if (srw_req->query_type == Z_SRW_query_type_cql
1352                  && assoc->init->bend_srw_scan)
1353         {
1354             bsrr->term = 0;
1355             bsrr->attributeset = 0;
1356             bsrr->scanClause = srw_req->scanClause.cql;
1357             ((int (*)(void *, bend_scan_rr *))
1358              (*assoc->init->bend_srw_scan))(assoc->backend, bsrr);
1359         }
1360         else
1361         {
1362             yaz_add_srw_diagnostic(assoc->encode, &srw_res->diagnostics,
1363                                    &srw_res->num_diagnostics,
1364                                    YAZ_SRW_UNSUPP_OPERATION, "scan");
1365         }
1366         if (bsrr->errcode)
1367         {
1368             int srw_error;
1369             if (bsrr->errcode == YAZ_BIB1_DATABASE_UNAVAILABLE)
1370             {
1371                 *http_code = 404;
1372                 return;
1373             }
1374             srw_error = yaz_diag_bib1_to_srw(bsrr->errcode);
1375
1376             yaz_add_srw_diagnostic(assoc->encode, &srw_res->diagnostics,
1377                                    &srw_res->num_diagnostics,
1378                                    srw_error, bsrr->errstring);
1379         }
1380         else if (srw_res->num_diagnostics == 0 && bsrr->num_entries)
1381         {
1382             int i;
1383             srw_res->terms = (Z_SRW_scanTerm*)
1384                 odr_malloc(assoc->encode, sizeof(*srw_res->terms) *
1385                            bsrr->num_entries);
1386
1387             srw_res->num_terms =  bsrr->num_entries;
1388             for (i = 0; i<bsrr->num_entries; i++)
1389             {
1390                 Z_SRW_scanTerm *t = srw_res->terms + i;
1391                 t->value = odr_strdup(assoc->encode, bsrr->entries[i].term);
1392                 t->numberOfRecords =
1393                     odr_intdup(assoc->encode, bsrr->entries[i].occurrences);
1394                 t->displayTerm = 0;
1395                 if (save_entries == bsrr->entries &&
1396                     bsrr->entries[i].display_term)
1397                 {
1398                     /* the entries was _not_ set by the handler. So it's
1399                        safe to test for new member display_term. It is
1400                        NULL'ed by us.
1401                     */
1402                     t->displayTerm = odr_strdup(assoc->encode,
1403                                                 bsrr->entries[i].display_term);
1404                 }
1405                 t->whereInList = 0;
1406             }
1407         }
1408     }
1409     if (log_request)
1410     {
1411         WRBUF wr = wrbuf_alloc();
1412         const char *querytype = 0;
1413         const char *querystr = 0;
1414
1415         switch(srw_req->query_type)
1416         {
1417         case Z_SRW_query_type_pqf:
1418             querytype = "PQF";
1419             querystr = srw_req->scanClause.pqf;
1420             break;
1421         case Z_SRW_query_type_cql:
1422             querytype = "CQL";
1423             querystr = srw_req->scanClause.cql;
1424             break;
1425         default:
1426             querytype = "UNKNOWN";
1427             querystr = "";
1428         }
1429
1430         wrbuf_printf(wr, "SRWScan %s ", srw_req->database);
1431
1432         if (srw_res->num_diagnostics)
1433             wrbuf_printf(wr, "ERROR %s - ", srw_res->diagnostics[0].uri);
1434         else if (srw_res->num_terms)
1435             wrbuf_printf(wr, "OK %d - ", srw_res->num_terms);
1436         else
1437             wrbuf_printf(wr, "OK - - ");
1438
1439         wrbuf_printf(wr, ODR_INT_PRINTF "+" ODR_INT_PRINTF " ",
1440                      (srw_req->responsePosition ?
1441                       *srw_req->responsePosition : 1),
1442                      (srw_req->maximumTerms ?
1443                       *srw_req->maximumTerms : 1));
1444         /* there is no step size in SRU/W ??? */
1445         wrbuf_printf(wr, "%s: %s ", querytype, querystr);
1446         yaz_log(log_request, "%s ", wrbuf_cstr(wr) );
1447         wrbuf_destroy(wr);
1448     }
1449
1450 }
1451
1452 static void srw_bend_update(association *assoc,
1453                             Z_SRW_PDU *sr,
1454                             Z_SRW_updateResponse *srw_res,
1455                             int *http_code)
1456 {
1457     Z_SRW_updateRequest *srw_req = sr->u.update_request;
1458     yaz_log(log_session, "SRWUpdate action=%s", srw_req->operation);
1459     yaz_log(YLOG_DEBUG, "num_diag = %d", srw_res->num_diagnostics );
1460     *http_code = 404;
1461     srw_bend_init(assoc, &srw_res->diagnostics, &srw_res->num_diagnostics, sr);
1462     if (assoc->init)
1463     {
1464         bend_update_rr rr;
1465         Z_SRW_extra_record *extra = srw_req->extra_record;
1466
1467         rr.stream = assoc->encode;
1468         rr.print = assoc->print;
1469         rr.num_bases = 1;
1470         rr.basenames = &srw_req->database;
1471         rr.operation = srw_req->operation;
1472         rr.operation_status = "failed";
1473         rr.record_id = 0;
1474         rr.record_versions = 0;
1475         rr.num_versions = 0;
1476         rr.record_packing = "string";
1477         rr.record_schema = 0;
1478         rr.record_data = 0;
1479         rr.extra_record_data = 0;
1480         rr.extra_request_data = 0;
1481         rr.extra_response_data = 0;
1482         rr.uri = 0;
1483         rr.message = 0;
1484         rr.details = 0;
1485
1486         *http_code = 200;
1487         if (rr.operation == 0)
1488         {
1489             yaz_add_sru_update_diagnostic(
1490                 assoc->encode, &srw_res->diagnostics,
1491                 &srw_res->num_diagnostics,
1492                 YAZ_SRU_UPDATE_MISSING_MANDATORY_ELEMENT_RECORD_REJECTED,
1493                 "action" );
1494             return;
1495         }
1496         yaz_log(YLOG_DEBUG, "basename = %s", rr.basenames[0] );
1497         yaz_log(YLOG_DEBUG, "Operation = %s", rr.operation );
1498         if (!strcmp( rr.operation, "delete"))
1499         {
1500             if (srw_req->record && !srw_req->record->recordSchema)
1501             {
1502                 rr.record_schema = odr_strdup(
1503                     assoc->encode,
1504                     srw_req->record->recordSchema);
1505             }
1506             if (srw_req->record)
1507             {
1508                 rr.record_data = odr_strdupn(
1509                     assoc->encode,
1510                     srw_req->record->recordData_buf,
1511                     srw_req->record->recordData_len );
1512             }
1513             if (extra && extra->extraRecordData_len)
1514             {
1515                 rr.extra_record_data = odr_strdupn(
1516                     assoc->encode,
1517                     extra->extraRecordData_buf,
1518                     extra->extraRecordData_len );
1519             }
1520             if (srw_req->recordId)
1521                 rr.record_id = srw_req->recordId;
1522             else if (extra && extra->recordIdentifier)
1523                 rr.record_id = extra->recordIdentifier;
1524         }
1525         else if (!strcmp(rr.operation, "replace"))
1526         {
1527             if (srw_req->recordId)
1528                 rr.record_id = srw_req->recordId;
1529             else if (extra && extra->recordIdentifier)
1530                 rr.record_id = extra->recordIdentifier;
1531             else
1532             {
1533                 yaz_add_sru_update_diagnostic(
1534                     assoc->encode, &srw_res->diagnostics,
1535                     &srw_res->num_diagnostics,
1536                     YAZ_SRU_UPDATE_MISSING_MANDATORY_ELEMENT_RECORD_REJECTED,
1537                     "recordIdentifier");
1538             }
1539             if (!srw_req->record)
1540             {
1541                 yaz_add_sru_update_diagnostic(
1542                     assoc->encode, &srw_res->diagnostics,
1543                     &srw_res->num_diagnostics,
1544                     YAZ_SRU_UPDATE_MISSING_MANDATORY_ELEMENT_RECORD_REJECTED,
1545                     "record");
1546             }
1547             else
1548             {
1549                 if (srw_req->record->recordSchema)
1550                     rr.record_schema = odr_strdup(
1551                         assoc->encode, srw_req->record->recordSchema);
1552                 if (srw_req->record->recordData_len )
1553                 {
1554                     rr.record_data = odr_strdupn(assoc->encode,
1555                                                  srw_req->record->recordData_buf,
1556                                                  srw_req->record->recordData_len );
1557                 }
1558                 else
1559                 {
1560                     yaz_add_sru_update_diagnostic(
1561                         assoc->encode, &srw_res->diagnostics,
1562                         &srw_res->num_diagnostics,
1563                         YAZ_SRU_UPDATE_MISSING_MANDATORY_ELEMENT_RECORD_REJECTED,
1564                         "recordData" );
1565                 }
1566             }
1567             if (extra && extra->extraRecordData_len)
1568             {
1569                 rr.extra_record_data = odr_strdupn(
1570                     assoc->encode,
1571                     extra->extraRecordData_buf,
1572                     extra->extraRecordData_len );
1573             }
1574         }
1575         else if (!strcmp(rr.operation, "insert"))
1576         {
1577             if (srw_req->recordId)
1578                 rr.record_id = srw_req->recordId;
1579             else if (extra)
1580                 rr.record_id = extra->recordIdentifier;
1581
1582             if (srw_req->record)
1583             {
1584                 if (srw_req->record->recordSchema)
1585                     rr.record_schema = odr_strdup(
1586                         assoc->encode, srw_req->record->recordSchema);
1587
1588                 if (srw_req->record->recordData_len)
1589                     rr.record_data = odr_strdupn(
1590                         assoc->encode,
1591                         srw_req->record->recordData_buf,
1592                         srw_req->record->recordData_len );
1593             }
1594             if (extra && extra->extraRecordData_len)
1595             {
1596                 rr.extra_record_data = odr_strdupn(
1597                     assoc->encode,
1598                     extra->extraRecordData_buf,
1599                     extra->extraRecordData_len );
1600             }
1601         }
1602         else
1603             yaz_add_sru_update_diagnostic(assoc->encode, &srw_res->diagnostics,
1604                                           &srw_res->num_diagnostics,
1605                                           YAZ_SRU_UPDATE_INVALID_ACTION,
1606                                           rr.operation );
1607
1608         if (srw_req->record)
1609         {
1610             const char *pack_str =
1611                 yaz_srw_pack_to_str(srw_req->record->recordPacking);
1612             if (pack_str)
1613                 rr.record_packing = odr_strdup(assoc->encode, pack_str);
1614         }
1615
1616         if (srw_req->num_recordVersions)
1617         {
1618             rr.record_versions = srw_req->recordVersions;
1619             rr.num_versions = srw_req->num_recordVersions;
1620         }
1621         if (srw_req->extraRequestData_len)
1622         {
1623             rr.extra_request_data = odr_strdupn(assoc->encode,
1624                                                 srw_req->extraRequestData_buf,
1625                                                 srw_req->extraRequestData_len );
1626         }
1627         if (srw_res->num_diagnostics == 0)
1628         {
1629             if ( assoc->init->bend_srw_update)
1630                 (*assoc->init->bend_srw_update)(assoc->backend, &rr);
1631             else
1632                 yaz_add_sru_update_diagnostic(
1633                     assoc->encode, &srw_res->diagnostics,
1634                     &srw_res->num_diagnostics,
1635                     YAZ_SRU_UPDATE_UNSPECIFIED_DATABASE_ERROR,
1636                     "No Update backend handler");
1637         }
1638
1639         if (rr.uri)
1640             yaz_add_srw_diagnostic_uri(assoc->encode,
1641                                        &srw_res->diagnostics,
1642                                        &srw_res->num_diagnostics,
1643                                        rr.uri,
1644                                        rr.message,
1645                                        rr.details);
1646         srw_res->recordId = rr.record_id;
1647         srw_res->operationStatus = rr.operation_status;
1648         srw_res->recordVersions = rr.record_versions;
1649         srw_res->num_recordVersions = rr.num_versions;
1650         if (srw_res->extraResponseData_len)
1651         {
1652             srw_res->extraResponseData_buf = rr.extra_response_data;
1653             srw_res->extraResponseData_len = strlen(rr.extra_response_data);
1654         }
1655         if (srw_res->num_diagnostics == 0 && rr.record_data)
1656         {
1657             srw_res->record = yaz_srw_get_record(assoc->encode);
1658             srw_res->record->recordSchema = rr.record_schema;
1659             if (rr.record_packing)
1660             {
1661                 int pack = yaz_srw_str_to_pack(rr.record_packing);
1662
1663                 if (pack == -1)
1664                 {
1665                     pack = Z_SRW_recordPacking_string;
1666                     yaz_log(YLOG_WARN, "Back packing %s from backend",
1667                             rr.record_packing);
1668                 }
1669                 srw_res->record->recordPacking = pack;
1670             }
1671             srw_res->record->recordData_buf = rr.record_data;
1672             srw_res->record->recordData_len = strlen(rr.record_data);
1673             if (rr.extra_record_data)
1674             {
1675                 Z_SRW_extra_record *ex =
1676                     yaz_srw_get_extra_record(assoc->encode);
1677                 srw_res->extra_record = ex;
1678                 ex->extraRecordData_buf = rr.extra_record_data;
1679                 ex->extraRecordData_len = strlen(rr.extra_record_data);
1680             }
1681         }
1682     }
1683 }
1684
1685 /* check if path is OK (1); BAD (0) */
1686 static int check_path(const char *path)
1687 {
1688     if (*path != '/')
1689         return 0;
1690     if (strstr(path, ".."))
1691         return 0;
1692     return 1;
1693 }
1694
1695 static char *read_file(const char *fname, ODR o, size_t *sz)
1696 {
1697     char *buf;
1698     FILE *inf = fopen(fname, "rb");
1699     if (!inf)
1700         return 0;
1701
1702     fseek(inf, 0L, SEEK_END);
1703     *sz = ftell(inf);
1704     rewind(inf);
1705     buf = (char *) odr_malloc(o, *sz);
1706     if (fread(buf, 1, *sz, inf) != *sz)
1707         yaz_log(YLOG_WARN|YLOG_ERRNO, "short read %s", fname);
1708     fclose(inf);
1709     return buf;
1710 }
1711
1712 static void process_http_request(association *assoc, request *req)
1713 {
1714     Z_HTTP_Request *hreq = req->gdu_request->u.HTTP_Request;
1715     ODR o = assoc->encode;
1716     int r = 2;  /* 2=NOT TAKEN, 1=TAKEN, 0=SOAP TAKEN */
1717     Z_SRW_PDU *sr = 0;
1718     Z_SOAP *soap_package = 0;
1719     Z_GDU *p = 0;
1720     char *charset = 0;
1721     Z_HTTP_Response *hres = 0;
1722     int keepalive = 1;
1723     const char *stylesheet = 0; /* for now .. set later */
1724     Z_SRW_diagnostic *diagnostic = 0;
1725     int num_diagnostic = 0;
1726     const char *host = z_HTTP_header_lookup(hreq->headers, "Host");
1727
1728     yaz_log(log_request, "%s %s HTTP/%s", hreq->method, hreq->path, hreq->version);
1729     if (!control_association(assoc, host, 0))
1730     {
1731         p = z_get_HTTP_Response(o, 404);
1732         r = 1;
1733     }
1734     if (r == 2 && assoc->server && assoc->server->docpath
1735         && hreq->path[0] == '/'
1736         &&
1737         /* check if path is a proper prefix of documentroot */
1738         strncmp(hreq->path+1, assoc->server->docpath,
1739                 strlen(assoc->server->docpath))
1740         == 0)
1741     {
1742         if (!check_path(hreq->path))
1743         {
1744             yaz_log(YLOG_LOG, "File %s access forbidden", hreq->path+1);
1745             p = z_get_HTTP_Response(o, 404);
1746         }
1747         else
1748         {
1749             size_t content_size = 0;
1750             char *content_buf = read_file(hreq->path+1, o, &content_size);
1751             if (!content_buf)
1752             {
1753                 yaz_log(YLOG_LOG, "File %s not found", hreq->path+1);
1754                 p = z_get_HTTP_Response(o, 404);
1755             }
1756             else
1757             {
1758                 const char *ctype = 0;
1759                 yaz_mime_types types = yaz_mime_types_create();
1760
1761                 yaz_mime_types_add(types, "xsl", "application/xml");
1762                 yaz_mime_types_add(types, "xml", "application/xml");
1763                 yaz_mime_types_add(types, "css", "text/css");
1764                 yaz_mime_types_add(types, "html", "text/html");
1765                 yaz_mime_types_add(types, "htm", "text/html");
1766                 yaz_mime_types_add(types, "txt", "text/plain");
1767                 yaz_mime_types_add(types, "js", "application/x-javascript");
1768
1769                 yaz_mime_types_add(types, "gif", "image/gif");
1770                 yaz_mime_types_add(types, "png", "image/png");
1771                 yaz_mime_types_add(types, "jpg", "image/jpeg");
1772                 yaz_mime_types_add(types, "jpeg", "image/jpeg");
1773
1774                 ctype = yaz_mime_lookup_fname(types, hreq->path);
1775                 if (!ctype)
1776                 {
1777                     yaz_log(YLOG_LOG, "No mime type for %s", hreq->path+1);
1778                     p = z_get_HTTP_Response(o, 404);
1779                 }
1780                 else
1781                 {
1782                     p = z_get_HTTP_Response(o, 200);
1783                     hres = p->u.HTTP_Response;
1784                     hres->content_buf = content_buf;
1785                     hres->content_len = content_size;
1786                     z_HTTP_header_add(o, &hres->headers, "Content-Type", ctype);
1787                 }
1788                 yaz_mime_types_destroy(types);
1789             }
1790         }
1791         r = 1;
1792     }
1793
1794     if (r == 2)
1795     {
1796         r = yaz_srw_decode(hreq, &sr, &soap_package, assoc->decode, &charset);
1797         yaz_log(YLOG_DEBUG, "yaz_srw_decode returned %d", r);
1798     }
1799     if (r == 2)  /* not taken */
1800     {
1801         r = yaz_sru_decode(hreq, &sr, &soap_package, assoc->decode, &charset,
1802                            &diagnostic, &num_diagnostic);
1803         yaz_log(YLOG_DEBUG, "yaz_sru_decode returned %d", r);
1804     }
1805     if (r == 0)  /* decode SRW/SRU OK .. */
1806     {
1807         int http_code = 200;
1808         if (sr->which == Z_SRW_searchRetrieve_request)
1809         {
1810             Z_SRW_PDU *res =
1811                 yaz_srw_get_pdu(assoc->encode, Z_SRW_searchRetrieve_response,
1812                                 sr->srw_version);
1813             stylesheet = sr->u.request->stylesheet;
1814             if (num_diagnostic)
1815             {
1816                 res->u.response->diagnostics = diagnostic;
1817                 res->u.response->num_diagnostics = num_diagnostic;
1818             }
1819             else
1820             {
1821                 srw_bend_search(assoc, sr, res, &http_code);
1822             }
1823             if (http_code == 200)
1824                 soap_package->u.generic->p = res;
1825         }
1826         else if (sr->which == Z_SRW_explain_request)
1827         {
1828             Z_SRW_PDU *res = yaz_srw_get_pdu(o, Z_SRW_explain_response,
1829                                              sr->srw_version);
1830             stylesheet = sr->u.explain_request->stylesheet;
1831             if (num_diagnostic)
1832             {
1833                 res->u.explain_response->diagnostics = diagnostic;
1834                 res->u.explain_response->num_diagnostics = num_diagnostic;
1835             }
1836             srw_bend_explain(assoc, sr, res->u.explain_response, &http_code);
1837             if (http_code == 200)
1838                 soap_package->u.generic->p = res;
1839         }
1840         else if (sr->which == Z_SRW_scan_request)
1841         {
1842             Z_SRW_PDU *res = yaz_srw_get_pdu(o, Z_SRW_scan_response,
1843                                              sr->srw_version);
1844             stylesheet = sr->u.scan_request->stylesheet;
1845             if (num_diagnostic)
1846             {
1847                 res->u.scan_response->diagnostics = diagnostic;
1848                 res->u.scan_response->num_diagnostics = num_diagnostic;
1849             }
1850             srw_bend_scan(assoc, sr, res->u.scan_response, &http_code);
1851             if (http_code == 200)
1852                 soap_package->u.generic->p = res;
1853         }
1854         else if (sr->which == Z_SRW_update_request)
1855         {
1856             Z_SRW_PDU *res = yaz_srw_get_pdu(o, Z_SRW_update_response,
1857                                              sr->srw_version);
1858             yaz_log(YLOG_DEBUG, "handling SRW UpdateRequest");
1859             if (num_diagnostic)
1860             {
1861                 res->u.update_response->diagnostics = diagnostic;
1862                 res->u.update_response->num_diagnostics = num_diagnostic;
1863             }
1864             yaz_log(YLOG_DEBUG, "num_diag = %d", res->u.update_response->num_diagnostics );
1865             srw_bend_update(assoc, sr, res->u.update_response, &http_code);
1866             if (http_code == 200)
1867                 soap_package->u.generic->p = res;
1868         }
1869         else
1870         {
1871             yaz_log(log_request, "SOAP ERROR");
1872             /* FIXME - what error, what query */
1873             http_code = 500;
1874             z_soap_error(assoc->encode, soap_package,
1875                          "SOAP-ENV:Client", "Bad method", 0);
1876         }
1877         if (http_code == 200 || http_code == 500)
1878         {
1879             static Z_SOAP_Handler soap_handlers[4] = {
1880 #if YAZ_HAVE_XML2
1881                 {YAZ_XMLNS_SRU_v1_1, 0, (Z_SOAP_fun) yaz_srw_codec},
1882                 {YAZ_XMLNS_SRU_v1_0, 0, (Z_SOAP_fun) yaz_srw_codec},
1883                 {YAZ_XMLNS_UPDATE_v0_9, 0, (Z_SOAP_fun) yaz_ucp_codec},
1884 #endif
1885                 {0, 0, 0}
1886             };
1887             char ctype[80];
1888             p = z_get_HTTP_Response(o, 200);
1889             hres = p->u.HTTP_Response;
1890
1891             if (!stylesheet && assoc->server)
1892                 stylesheet = assoc->server->stylesheet;
1893
1894             /* empty stylesheet means NO stylesheet */
1895             if (stylesheet && *stylesheet == '\0')
1896                 stylesheet = 0;
1897
1898             z_soap_codec_enc_xsl(assoc->encode, &soap_package,
1899                                  &hres->content_buf, &hres->content_len,
1900                                  soap_handlers, charset, stylesheet);
1901             hres->code = http_code;
1902
1903             strcpy(ctype, "text/xml");
1904             if (charset && strlen(charset) < sizeof(ctype)-30)
1905             {
1906                 strcat(ctype, "; charset=");
1907                 strcat(ctype, charset);
1908             }
1909             z_HTTP_header_add(o, &hres->headers, "Content-Type", ctype);
1910         }
1911         else
1912             p = z_get_HTTP_Response(o, http_code);
1913     }
1914
1915     if (p == 0)
1916         p = z_get_HTTP_Response(o, 500);
1917     hres = p->u.HTTP_Response;
1918     if (!strcmp(hreq->version, "1.0"))
1919     {
1920         const char *v = z_HTTP_header_lookup(hreq->headers, "Connection");
1921         if (v && !strcmp(v, "Keep-Alive"))
1922             keepalive = 1;
1923         else
1924             keepalive = 0;
1925         hres->version = "1.0";
1926     }
1927     else
1928     {
1929         const char *v = z_HTTP_header_lookup(hreq->headers, "Connection");
1930         if (v && !strcmp(v, "close"))
1931             keepalive = 0;
1932         else
1933             keepalive = 1;
1934         hres->version = "1.1";
1935     }
1936     if (!keepalive || !assoc->last_control->keepalive)
1937     {
1938         z_HTTP_header_add(o, &hres->headers, "Connection", "close");
1939         assoc->state = ASSOC_DEAD;
1940         assoc->cs_get_mask = 0;
1941     }
1942     else
1943     {
1944         int t;
1945         const char *alive = z_HTTP_header_lookup(hreq->headers, "Keep-Alive");
1946
1947         if (alive && yaz_isdigit(*(const unsigned char *) alive))
1948             t = atoi(alive);
1949         else
1950             t = 15;
1951         if (t < 0 || t > 3600)
1952             t = 3600;
1953         iochan_settimeout(assoc->client_chan,t);
1954         z_HTTP_header_add(o, &hres->headers, "Connection", "Keep-Alive");
1955     }
1956     process_gdu_response(assoc, req, p);
1957 }
1958
1959 static void process_gdu_request(association *assoc, request *req)
1960 {
1961     if (req->gdu_request->which == Z_GDU_Z3950)
1962     {
1963         char *msg = 0;
1964         req->apdu_request = req->gdu_request->u.z3950;
1965         if (process_z_request(assoc, req, &msg) < 0)
1966             do_close_req(assoc, Z_Close_systemProblem, msg, req);
1967     }
1968     else if (req->gdu_request->which == Z_GDU_HTTP_Request)
1969         process_http_request(assoc, req);
1970     else
1971     {
1972         do_close_req(assoc, Z_Close_systemProblem, "bad protocol packet", req);
1973     }
1974 }
1975
1976 /*
1977  * Initiate request processing.
1978  */
1979 static int process_z_request(association *assoc, request *req, char **msg)
1980 {
1981     Z_APDU *res;
1982     int retval;
1983
1984     *msg = "Unknown Error";
1985     assert(req && req->state == REQUEST_IDLE);
1986     if (req->apdu_request->which != Z_APDU_initRequest && !assoc->init)
1987     {
1988         *msg = "Missing InitRequest";
1989         return -1;
1990     }
1991     switch (req->apdu_request->which)
1992     {
1993     case Z_APDU_initRequest:
1994         res = process_initRequest(assoc, req); break;
1995     case Z_APDU_searchRequest:
1996         res = process_searchRequest(assoc, req); break;
1997     case Z_APDU_presentRequest:
1998         res = process_presentRequest(assoc, req); break;
1999     case Z_APDU_scanRequest:
2000         if (assoc->init->bend_scan)
2001             res = process_scanRequest(assoc, req);
2002         else
2003         {
2004             *msg = "Cannot handle Scan APDU";
2005             return -1;
2006         }
2007         break;
2008     case Z_APDU_extendedServicesRequest:
2009         if (assoc->init->bend_esrequest)
2010             res = process_ESRequest(assoc, req);
2011         else
2012         {
2013             *msg = "Cannot handle Extended Services APDU";
2014             return -1;
2015         }
2016         break;
2017     case Z_APDU_sortRequest:
2018         if (assoc->init->bend_sort)
2019             res = process_sortRequest(assoc, req);
2020         else
2021         {
2022             *msg = "Cannot handle Sort APDU";
2023             return -1;
2024         }
2025         break;
2026     case Z_APDU_close:
2027         process_close(assoc, req);
2028         return 0;
2029     case Z_APDU_deleteResultSetRequest:
2030         if (assoc->init->bend_delete)
2031             res = process_deleteRequest(assoc, req);
2032         else
2033         {
2034             *msg = "Cannot handle Delete APDU";
2035             return -1;
2036         }
2037         break;
2038     case Z_APDU_segmentRequest:
2039         if (assoc->init->bend_segment)
2040         {
2041             res = process_segmentRequest(assoc, req);
2042         }
2043         else
2044         {
2045             *msg = "Cannot handle Segment APDU";
2046             return -1;
2047         }
2048         break;
2049     case Z_APDU_triggerResourceControlRequest:
2050         return 0;
2051     default:
2052         *msg = "Bad APDU received";
2053         return -1;
2054     }
2055     if (res)
2056     {
2057         yaz_log(YLOG_DEBUG, "  result immediately available");
2058         retval = process_z_response(assoc, req, res);
2059     }
2060     else
2061     {
2062         yaz_log(YLOG_DEBUG, "  result unavailable");
2063         retval = -1;
2064     }
2065     return retval;
2066 }
2067
2068 /*
2069  * Encode response, and transfer the request structure to the outgoing queue.
2070  */
2071 static int process_gdu_response(association *assoc, request *req, Z_GDU *res)
2072 {
2073     odr_setbuf(assoc->encode, req->response, req->size_response, 1);
2074
2075     if (assoc->print)
2076     {
2077         if (!z_GDU(assoc->print, &res, 0, 0))
2078             yaz_log(YLOG_WARN, "ODR print error: %s",
2079                 odr_errmsg(odr_geterror(assoc->print)));
2080         odr_reset(assoc->print);
2081     }
2082     if (!z_GDU(assoc->encode, &res, 0, 0))
2083     {
2084         yaz_log(YLOG_WARN, "ODR error when encoding PDU: %s [element %s]",
2085                 odr_errmsg(odr_geterror(assoc->decode)),
2086                 odr_getelement(assoc->decode));
2087         return -1;
2088     }
2089     req->response = odr_getbuf(assoc->encode, &req->len_response,
2090         &req->size_response);
2091     odr_setbuf(assoc->encode, 0, 0, 0); /* don'txfree if we abort later */
2092     odr_reset(assoc->encode);
2093     req->state = REQUEST_IDLE;
2094     request_enq(&assoc->outgoing, req);
2095     /* turn the work over to the ir_session handler */
2096     iochan_setflag(assoc->client_chan, EVENT_OUTPUT);
2097     assoc->cs_put_mask = EVENT_OUTPUT;
2098     /* Is there more work to be done? give that to the input handler too */
2099     for (;;)
2100     {
2101         req = request_head(&assoc->incoming);
2102         if (req && req->state == REQUEST_IDLE)
2103         {
2104             request_deq(&assoc->incoming);
2105             process_gdu_request(assoc, req);
2106         }
2107         else
2108             break;
2109     }
2110     return 0;
2111 }
2112
2113 /*
2114  * Encode response, and transfer the request structure to the outgoing queue.
2115  */
2116 static int process_z_response(association *assoc, request *req, Z_APDU *res)
2117 {
2118     Z_GDU *gres = (Z_GDU *) odr_malloc(assoc->encode, sizeof(*gres));
2119     gres->which = Z_GDU_Z3950;
2120     gres->u.z3950 = res;
2121
2122     return process_gdu_response(assoc, req, gres);
2123 }
2124
2125 static char *get_vhost(Z_OtherInformation *otherInfo)
2126 {
2127     return yaz_oi_get_string_oid(&otherInfo, yaz_oid_userinfo_proxy, 1, 0);
2128 }
2129
2130 /*
2131  * Handle init request.
2132  * At the moment, we don't check the options
2133  * anywhere else in the code - we just try not to do anything that would
2134  * break a naive client. We'll toss 'em into the association block when
2135  * we need them there.
2136  */
2137 static Z_APDU *process_initRequest(association *assoc, request *reqb)
2138 {
2139     Z_InitRequest *req = reqb->apdu_request->u.initRequest;
2140     Z_APDU *apdu = zget_APDU(assoc->encode, Z_APDU_initResponse);
2141     Z_InitResponse *resp = apdu->u.initResponse;
2142     bend_initresult *binitres;
2143     char options[140];
2144     statserv_options_block *cb = 0;  /* by default no control for backend */
2145
2146     if (control_association(assoc, get_vhost(req->otherInfo), 1))
2147         cb = statserv_getcontrol();  /* got control block for backend */
2148
2149     if (cb && assoc->backend)
2150         (*cb->bend_close)(assoc->backend);
2151
2152     yaz_log(log_requestdetail, "Got initRequest");
2153     if (req->implementationId)
2154         yaz_log(log_requestdetail, "Id:        %s",
2155                 req->implementationId);
2156     if (req->implementationName)
2157         yaz_log(log_requestdetail, "Name:      %s",
2158                 req->implementationName);
2159     if (req->implementationVersion)
2160         yaz_log(log_requestdetail, "Version:   %s",
2161                 req->implementationVersion);
2162
2163     assoc_init_reset(assoc);
2164
2165     assoc->init->auth = req->idAuthentication;
2166     assoc->init->referenceId = req->referenceId;
2167
2168     if (ODR_MASK_GET(req->options, Z_Options_negotiationModel))
2169     {
2170         Z_CharSetandLanguageNegotiation *negotiation =
2171             yaz_get_charneg_record (req->otherInfo);
2172         if (negotiation &&
2173             negotiation->which == Z_CharSetandLanguageNegotiation_proposal)
2174             assoc->init->charneg_request = negotiation;
2175     }
2176
2177     /* by default named_result_sets is 0 .. Enable it if client asks for it. */
2178     if (ODR_MASK_GET(req->options, Z_Options_namedResultSets))
2179         assoc->init->named_result_sets = 1;
2180
2181     assoc->backend = 0;
2182     if (cb)
2183     {
2184         if (req->implementationVersion)
2185             yaz_log(log_requestdetail, "Config:    %s",
2186                     cb->configname);
2187
2188         iochan_settimeout(assoc->client_chan, cb->idle_timeout);
2189
2190         /* we have a backend control block, so call that init function */
2191         if (!(binitres = (*cb->bend_init)(assoc->init)))
2192         {
2193             yaz_log(YLOG_WARN, "Bad response from backend.");
2194             return 0;
2195         }
2196         assoc->backend = binitres->handle;
2197     }
2198     else
2199     {
2200         /* no backend. return error */
2201         binitres = (bend_initresult *)
2202             odr_malloc(assoc->encode, sizeof(*binitres));
2203         binitres->errstring = 0;
2204         binitres->errcode = YAZ_BIB1_PERMANENT_SYSTEM_ERROR;
2205         iochan_settimeout(assoc->client_chan, 10);
2206     }
2207     if ((assoc->init->bend_sort))
2208         yaz_log(YLOG_DEBUG, "Sort handler installed");
2209     if ((assoc->init->bend_search))
2210         yaz_log(YLOG_DEBUG, "Search handler installed");
2211     if ((assoc->init->bend_present))
2212         yaz_log(YLOG_DEBUG, "Present handler installed");
2213     if ((assoc->init->bend_esrequest))
2214         yaz_log(YLOG_DEBUG, "ESRequest handler installed");
2215     if ((assoc->init->bend_delete))
2216         yaz_log(YLOG_DEBUG, "Delete handler installed");
2217     if ((assoc->init->bend_scan))
2218         yaz_log(YLOG_DEBUG, "Scan handler installed");
2219     if ((assoc->init->bend_segment))
2220         yaz_log(YLOG_DEBUG, "Segment handler installed");
2221
2222     resp->referenceId = req->referenceId;
2223     *options = '\0';
2224     /* let's tell the client what we can do */
2225     if (ODR_MASK_GET(req->options, Z_Options_search))
2226     {
2227         ODR_MASK_SET(resp->options, Z_Options_search);
2228         strcat(options, "srch");
2229     }
2230     if (ODR_MASK_GET(req->options, Z_Options_present))
2231     {
2232         ODR_MASK_SET(resp->options, Z_Options_present);
2233         strcat(options, " prst");
2234     }
2235     if (ODR_MASK_GET(req->options, Z_Options_delSet) &&
2236         assoc->init->bend_delete)
2237     {
2238         ODR_MASK_SET(resp->options, Z_Options_delSet);
2239         strcat(options, " del");
2240     }
2241     if (ODR_MASK_GET(req->options, Z_Options_extendedServices) &&
2242         assoc->init->bend_esrequest)
2243     {
2244         ODR_MASK_SET(resp->options, Z_Options_extendedServices);
2245         strcat(options, " extendedServices");
2246     }
2247     if (ODR_MASK_GET(req->options, Z_Options_namedResultSets)
2248         && assoc->init->named_result_sets)
2249     {
2250         ODR_MASK_SET(resp->options, Z_Options_namedResultSets);
2251         strcat(options, " namedresults");
2252     }
2253     if (ODR_MASK_GET(req->options, Z_Options_scan) && assoc->init->bend_scan)
2254     {
2255         ODR_MASK_SET(resp->options, Z_Options_scan);
2256         strcat(options, " scan");
2257     }
2258     if (ODR_MASK_GET(req->options, Z_Options_concurrentOperations))
2259     {
2260         ODR_MASK_SET(resp->options, Z_Options_concurrentOperations);
2261         strcat(options, " concurrop");
2262     }
2263     if (ODR_MASK_GET(req->options, Z_Options_sort) && assoc->init->bend_sort)
2264     {
2265         ODR_MASK_SET(resp->options, Z_Options_sort);
2266         strcat(options, " sort");
2267     }
2268
2269     if (ODR_MASK_GET(req->options, Z_Options_negotiationModel))
2270     {
2271         Z_OtherInformationUnit *p0;
2272
2273         if (!assoc->init->charneg_response)
2274         {
2275             if (assoc->init->query_charset)
2276             {
2277                 assoc->init->charneg_response = yaz_set_response_charneg(
2278                     assoc->encode, assoc->init->query_charset, 0,
2279                     assoc->init->records_in_same_charset);
2280             }
2281             else
2282             {
2283                 yaz_log(YLOG_WARN, "default query_charset not defined by backend");
2284             }
2285         }
2286         if (assoc->init->charneg_response
2287             && (p0=yaz_oi_update(&resp->otherInfo, assoc->encode, NULL, 0, 0)))
2288         {
2289             p0->which = Z_OtherInfo_externallyDefinedInfo;
2290             p0->information.externallyDefinedInfo =
2291                 assoc->init->charneg_response;
2292             ODR_MASK_SET(resp->options, Z_Options_negotiationModel);
2293             strcat(options, " negotiation");
2294         }
2295     }
2296     if (ODR_MASK_GET(req->options, Z_Options_triggerResourceCtrl))
2297         ODR_MASK_SET(resp->options, Z_Options_triggerResourceCtrl);
2298
2299     if (ODR_MASK_GET(req->protocolVersion, Z_ProtocolVersion_1))
2300     {
2301         ODR_MASK_SET(resp->protocolVersion, Z_ProtocolVersion_1);
2302         assoc->version = 1; /* 1 & 2 are equivalent */
2303     }
2304     if (ODR_MASK_GET(req->protocolVersion, Z_ProtocolVersion_2))
2305     {
2306         ODR_MASK_SET(resp->protocolVersion, Z_ProtocolVersion_2);
2307         assoc->version = 2;
2308     }
2309     if (ODR_MASK_GET(req->protocolVersion, Z_ProtocolVersion_3))
2310     {
2311         ODR_MASK_SET(resp->protocolVersion, Z_ProtocolVersion_3);
2312         assoc->version = 3;
2313     }
2314
2315     yaz_log(log_requestdetail, "Negotiated to v%d: %s", assoc->version, options);
2316
2317     if (*req->maximumRecordSize < assoc->maximumRecordSize)
2318         assoc->maximumRecordSize = odr_int_to_int(*req->maximumRecordSize);
2319
2320     if (*req->preferredMessageSize < assoc->preferredMessageSize)
2321         assoc->preferredMessageSize = odr_int_to_int(*req->preferredMessageSize);
2322
2323     resp->preferredMessageSize =
2324         odr_intdup(assoc->encode, assoc->preferredMessageSize);
2325     resp->maximumRecordSize =
2326         odr_intdup(assoc->encode, assoc->maximumRecordSize);
2327
2328     resp->implementationId = odr_prepend(assoc->encode,
2329                 assoc->init->implementation_id,
2330                 resp->implementationId);
2331
2332     resp->implementationVersion = odr_prepend(assoc->encode,
2333                 assoc->init->implementation_version,
2334                 resp->implementationVersion);
2335
2336     resp->implementationName = odr_prepend(assoc->encode,
2337                 assoc->init->implementation_name,
2338                 odr_prepend(assoc->encode, "GFS", resp->implementationName));
2339
2340     if (binitres->errcode)
2341     {
2342         assoc->state = ASSOC_DEAD;
2343         resp->userInformationField =
2344             init_diagnostics(assoc->encode, binitres->errcode,
2345                              binitres->errstring);
2346         *resp->result = 0;
2347     }
2348     else
2349         assoc->state = ASSOC_UP;
2350
2351     if (log_request)
2352     {
2353         if (!req->idAuthentication)
2354             yaz_log(log_request, "Auth none");
2355         else if (req->idAuthentication->which == Z_IdAuthentication_open)
2356         {
2357             const char *open = req->idAuthentication->u.open;
2358             const char *slash = strchr(open, '/');
2359             int len;
2360             if (slash)
2361                 len = slash - open;
2362             else
2363                 len = strlen(open);
2364                 yaz_log(log_request, "Auth open %.*s", len, open);
2365         }
2366         else if (req->idAuthentication->which == Z_IdAuthentication_idPass)
2367         {
2368             const char *user = req->idAuthentication->u.idPass->userId;
2369             const char *group = req->idAuthentication->u.idPass->groupId;
2370             yaz_log(log_request, "Auth idPass %s %s",
2371                     user ? user : "-", group ? group : "-");
2372         }
2373         else if (req->idAuthentication->which
2374                  == Z_IdAuthentication_anonymous)
2375         {
2376             yaz_log(log_request, "Auth anonymous");
2377         }
2378         else
2379         {
2380             yaz_log(log_request, "Auth other");
2381         }
2382     }
2383     if (log_request)
2384     {
2385         WRBUF wr = wrbuf_alloc();
2386         wrbuf_printf(wr, "Init ");
2387         if (binitres->errcode)
2388             wrbuf_printf(wr, "ERROR %d", binitres->errcode);
2389         else
2390             wrbuf_printf(wr, "OK -");
2391         wrbuf_printf(wr, " ID:%s Name:%s Version:%s",
2392                      (req->implementationId ? req->implementationId :"-"),
2393                      (req->implementationName ?
2394                       req->implementationName : "-"),
2395                      (req->implementationVersion ?
2396                       req->implementationVersion : "-")
2397             );
2398         yaz_log(log_request, "%s", wrbuf_cstr(wr));
2399         wrbuf_destroy(wr);
2400     }
2401     return apdu;
2402 }
2403
2404 /*
2405  * Set the specified `errcode' and `errstring' into a UserInfo-1
2406  * external to be returned to the client in accordance with Z35.90
2407  * Implementor Agreement 5 (Returning diagnostics in an InitResponse):
2408  *      http://lcweb.loc.gov/z3950/agency/agree/initdiag.html
2409  */
2410 static Z_External *init_diagnostics(ODR odr, int error, const char *addinfo)
2411 {
2412     yaz_log(log_requestdetail, "[%d] %s%s%s", error, diagbib1_str(error),
2413         addinfo ? " -- " : "", addinfo ? addinfo : "");
2414     return zget_init_diagnostics(odr, error, addinfo);
2415 }
2416
2417 /*
2418  * nonsurrogate diagnostic record.
2419  */
2420 static Z_Records *diagrec(association *assoc, int error, char *addinfo)
2421 {
2422     Z_Records *rec = (Z_Records *) odr_malloc(assoc->encode, sizeof(*rec));
2423
2424     yaz_log(log_requestdetail, "[%d] %s%s%s", error, diagbib1_str(error),
2425             addinfo ? " -- " : "", addinfo ? addinfo : "");
2426
2427     rec->which = Z_Records_NSD;
2428     rec->u.nonSurrogateDiagnostic = zget_DefaultDiagFormat(assoc->encode,
2429                                                            error, addinfo);
2430     return rec;
2431 }
2432
2433 /*
2434  * surrogate diagnostic.
2435  */
2436 static Z_NamePlusRecord *surrogatediagrec(association *assoc,
2437                                           const char *dbname,
2438                                           int error, const char *addinfo)
2439 {
2440     yaz_log(log_requestdetail, "[%d] %s%s%s", error, diagbib1_str(error),
2441             addinfo ? " -- " : "", addinfo ? addinfo : "");
2442     return zget_surrogateDiagRec(assoc->encode, dbname, error, addinfo);
2443 }
2444
2445 static Z_Records *pack_records(association *a, char *setname, Odr_int start,
2446                                Odr_int *num, Z_RecordComposition *comp,
2447                                Odr_int *next, Odr_int *pres,
2448                                Z_ReferenceId *referenceId,
2449                                Odr_oid *oid, int *errcode)
2450 {
2451     int recno, total_length = 0, dumped_records = 0;
2452     int toget = odr_int_to_int(*num);
2453     Z_Records *records =
2454         (Z_Records *) odr_malloc(a->encode, sizeof(*records));
2455     Z_NamePlusRecordList *reclist =
2456         (Z_NamePlusRecordList *) odr_malloc(a->encode, sizeof(*reclist));
2457
2458     records->which = Z_Records_DBOSD;
2459     records->u.databaseOrSurDiagnostics = reclist;
2460     reclist->num_records = 0;
2461
2462     if (toget < 0)
2463         return diagrec(a, YAZ_BIB1_PRESENT_REQUEST_OUT_OF_RANGE, 0);
2464     else if (toget == 0)
2465         reclist->records = odr_nullval();
2466     else
2467         reclist->records = (Z_NamePlusRecord **)
2468             odr_malloc(a->encode, sizeof(*reclist->records) * toget);
2469
2470     *pres = Z_PresentStatus_success;
2471     *num = 0;
2472     *next = 0;
2473
2474     yaz_log(log_requestdetail, "Request to pack " ODR_INT_PRINTF "+%d %s", start, toget, setname);
2475     yaz_log(log_requestdetail, "pms=%d, mrs=%d", a->preferredMessageSize,
2476         a->maximumRecordSize);
2477     for (recno = odr_int_to_int(start); reclist->num_records < toget; recno++)
2478     {
2479         bend_fetch_rr freq;
2480         Z_NamePlusRecord *thisrec;
2481         int this_length = 0;
2482         /*
2483          * we get the number of bytes allocated on the stream before any
2484          * allocation done by the backend - this should give us a reasonable
2485          * idea of the total size of the data so far.
2486          */
2487         total_length = odr_total(a->encode) - dumped_records;
2488         freq.errcode = 0;
2489         freq.errstring = 0;
2490         freq.basename = 0;
2491         freq.len = 0;
2492         freq.record = 0;
2493         freq.last_in_set = 0;
2494         freq.setname = setname;
2495         freq.surrogate_flag = 0;
2496         freq.number = recno;
2497         freq.comp = comp;
2498         freq.request_format = oid;
2499         freq.output_format = 0;
2500         freq.stream = a->encode;
2501         freq.print = a->print;
2502         freq.referenceId = referenceId;
2503         freq.schema = 0;
2504
2505         retrieve_fetch(a, &freq);
2506
2507         *next = freq.last_in_set ? 0 : recno + 1;
2508
2509         if (freq.errcode)
2510         {
2511             if (!freq.surrogate_flag) /* non-surrogate diagnostic i.e. global */
2512             {
2513                 char s[20];
2514                 *pres = Z_PresentStatus_failure;
2515                 /* for 'present request out of range',
2516                    set addinfo to record position if not set */
2517                 if (freq.errcode == YAZ_BIB1_PRESENT_REQUEST_OUT_OF_RANGE  &&
2518                                 freq.errstring == 0)
2519                 {
2520                     sprintf(s, "%d", recno);
2521                     freq.errstring = s;
2522                 }
2523                 if (errcode)
2524                     *errcode = freq.errcode;
2525                 return diagrec(a, freq.errcode, freq.errstring);
2526             }
2527             reclist->records[reclist->num_records] =
2528                 surrogatediagrec(a, freq.basename, freq.errcode,
2529                                  freq.errstring);
2530             reclist->num_records++;
2531             continue;
2532         }
2533         if (freq.record == 0)  /* no error and no record ? */
2534         {
2535             *pres = Z_PresentStatus_partial_4;
2536             *next = 0;   /* signal end-of-set and stop */
2537             break;
2538         }
2539         if (freq.len >= 0)
2540             this_length = freq.len;
2541         else
2542             this_length = odr_total(a->encode) - total_length - dumped_records;
2543         yaz_log(YLOG_DEBUG, "  fetched record, len=%d, total=%d dumped=%d",
2544             this_length, total_length, dumped_records);
2545         if (a->preferredMessageSize > 0 &&
2546                 this_length + total_length > a->preferredMessageSize)
2547         {
2548             /* record is small enough, really */
2549             if (this_length <= a->preferredMessageSize && recno > start)
2550             {
2551                 yaz_log(log_requestdetail, "  Dropped last normal-sized record");
2552                 *pres = Z_PresentStatus_partial_2;
2553                 if (*next > 0)
2554                     (*next)--;
2555                 break;
2556             }
2557             /* record can only be fetched by itself */
2558             if (this_length < a->maximumRecordSize)
2559             {
2560                 yaz_log(log_requestdetail, "  Record > prefmsgsz");
2561                 if (toget > 1)
2562                 {
2563                     yaz_log(YLOG_DEBUG, "  Dropped it");
2564                     reclist->records[reclist->num_records] =
2565                          surrogatediagrec(
2566                              a, freq.basename,
2567                              YAZ_BIB1_RECORD_EXCEEDS_PREFERRED_MESSAGE_SIZE, 0);
2568                     reclist->num_records++;
2569                     dumped_records += this_length;
2570                     continue;
2571                 }
2572             }
2573             else /* too big entirely */
2574             {
2575                 yaz_log(log_requestdetail, "Record > maxrcdsz "
2576                         "this=%d max=%d",
2577                         this_length, a->maximumRecordSize);
2578                 reclist->records[reclist->num_records] =
2579                     surrogatediagrec(
2580                         a, freq.basename,
2581                         YAZ_BIB1_RECORD_EXCEEDS_MAXIMUM_RECORD_SIZE, 0);
2582                 reclist->num_records++;
2583                 dumped_records += this_length;
2584                 continue;
2585             }
2586         }
2587
2588         if (!(thisrec = (Z_NamePlusRecord *)
2589               odr_malloc(a->encode, sizeof(*thisrec))))
2590             return 0;
2591         thisrec->databaseName = odr_strdup_null(a->encode, freq.basename);
2592         thisrec->which = Z_NamePlusRecord_databaseRecord;
2593
2594         if (!freq.output_format)
2595         {
2596             yaz_log(YLOG_WARN, "bend_fetch output_format not set");
2597             return 0;
2598         }
2599         thisrec->u.databaseRecord = z_ext_record_oid(
2600             a->encode, freq.output_format, freq.record, freq.len);
2601         if (!thisrec->u.databaseRecord)
2602             return 0;
2603         reclist->records[reclist->num_records] = thisrec;
2604         reclist->num_records++;
2605         if (freq.last_in_set)
2606             break;
2607     }
2608     *num = reclist->num_records;
2609     return records;
2610 }
2611
2612 static Z_APDU *process_searchRequest(association *assoc, request *reqb)
2613 {
2614     Z_SearchRequest *req = reqb->apdu_request->u.searchRequest;
2615     bend_search_rr *bsrr =
2616         (bend_search_rr *)nmem_malloc(reqb->request_mem, sizeof(*bsrr));
2617
2618     yaz_log(log_requestdetail, "Got SearchRequest.");
2619     bsrr->association = assoc;
2620     bsrr->referenceId = req->referenceId;
2621     bsrr->srw_sortKeys = 0;
2622     bsrr->srw_setname = 0;
2623     bsrr->srw_setnameIdleTime = 0;
2624     bsrr->estimated_hit_count = 0;
2625     bsrr->partial_resultset = 0;
2626     bsrr->extra_args = 0;
2627     bsrr->extra_response_data = 0;
2628
2629     yaz_log(log_requestdetail, "ResultSet '%s'", req->resultSetName);
2630     if (req->databaseNames)
2631     {
2632         int i;
2633         for (i = 0; i < req->num_databaseNames; i++)
2634             yaz_log(log_requestdetail, "Database '%s'", req->databaseNames[i]);
2635     }
2636
2637     yaz_log_zquery_level(log_requestdetail,req->query);
2638
2639     if (assoc->init->bend_search)
2640     {
2641         bsrr->setname = req->resultSetName;
2642         bsrr->replace_set = *req->replaceIndicator;
2643         bsrr->num_bases = req->num_databaseNames;
2644         bsrr->basenames = req->databaseNames;
2645         bsrr->query = req->query;
2646         bsrr->stream = assoc->encode;
2647         nmem_transfer(odr_getmem(bsrr->stream), reqb->request_mem);
2648         bsrr->decode = assoc->decode;
2649         bsrr->print = assoc->print;
2650         bsrr->hits = 0;
2651         bsrr->errcode = 0;
2652         bsrr->errstring = NULL;
2653         bsrr->search_info = NULL;
2654         bsrr->search_input = req->otherInfo;
2655         bsrr->present_number = *req->mediumSetPresentNumber;
2656
2657         if (assoc->server && assoc->server->cql_transform
2658             && req->query->which == Z_Query_type_104
2659             && req->query->u.type_104->which == Z_External_CQL)
2660         {
2661             /* have a CQL query and a CQL to PQF transform .. */
2662             int srw_errcode =
2663                 cql2pqf(bsrr->stream, req->query->u.type_104->u.cql,
2664                         assoc->server->cql_transform, bsrr->query,
2665                         &bsrr->srw_sortKeys);
2666             if (srw_errcode)
2667                 bsrr->errcode = yaz_diag_srw_to_bib1(srw_errcode);
2668         }
2669
2670         if (assoc->server && assoc->server->ccl_transform
2671             && req->query->which == Z_Query_type_2) /*CCL*/
2672         {
2673             /* have a CCL query and a CCL to PQF transform .. */
2674             int srw_errcode =
2675                 ccl2pqf(bsrr->stream, req->query->u.type_2,
2676                         assoc->server->ccl_transform, bsrr);
2677             if (srw_errcode)
2678                 bsrr->errcode = yaz_diag_srw_to_bib1(srw_errcode);
2679         }
2680
2681         if (!bsrr->errcode)
2682             (assoc->init->bend_search)(assoc->backend, bsrr);
2683     }
2684     else
2685     {
2686         /* FIXME - make a diagnostic for it */
2687         yaz_log(YLOG_WARN,"Search not supported ?!?!");
2688     }
2689     return response_searchRequest(assoc, reqb, bsrr);
2690 }
2691
2692 /*
2693  * Prepare a searchresponse based on the backend results. We probably want
2694  * to look at making the fetching of records nonblocking as well, but
2695  * so far, we'll keep things simple.
2696  * If bsrt is null, that means we're called in response to a communications
2697  * event, and we'll have to get the response for ourselves.
2698  */
2699 static Z_APDU *response_searchRequest(association *assoc, request *reqb,
2700                                       bend_search_rr *bsrt)
2701 {
2702     Z_SearchRequest *req = reqb->apdu_request->u.searchRequest;
2703     Z_APDU *apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
2704     Z_SearchResponse *resp = (Z_SearchResponse *)
2705         odr_malloc(assoc->encode, sizeof(*resp));
2706     Odr_int *nulint = odr_intdup(assoc->encode, 0);
2707     Odr_int *next = odr_intdup(assoc->encode, 0);
2708     Odr_int *none = odr_intdup(assoc->encode, Z_SearchResponse_none);
2709     Odr_int returnedrecs = 0;
2710
2711     apdu->which = Z_APDU_searchResponse;
2712     apdu->u.searchResponse = resp;
2713     resp->referenceId = req->referenceId;
2714     resp->additionalSearchInfo = 0;
2715     resp->otherInfo = 0;
2716     if (!bsrt)
2717     {
2718         yaz_log(YLOG_FATAL, "Bad result from backend");
2719         return 0;
2720     }
2721     else if (bsrt->errcode)
2722     {
2723         resp->records = diagrec(assoc, bsrt->errcode, bsrt->errstring);
2724         resp->resultCount = nulint;
2725         resp->numberOfRecordsReturned = nulint;
2726         resp->nextResultSetPosition = nulint;
2727         resp->searchStatus = odr_booldup(assoc->encode, 0);
2728         resp->resultSetStatus = none;
2729         resp->presentStatus = 0;
2730     }
2731     else
2732     {
2733         bool_t *sr = odr_booldup(assoc->encode, 1);
2734         Odr_int *toget = odr_intdup(assoc->encode, 0);
2735         Z_RecordComposition comp, *compp = 0;
2736
2737         yaz_log(log_requestdetail, "resultCount: " ODR_INT_PRINTF, bsrt->hits);
2738
2739         resp->records = 0;
2740         resp->resultCount = &bsrt->hits;
2741
2742         comp.which = Z_RecordComp_simple;
2743         /* how many records does the user agent want, then? */
2744         if (bsrt->hits < 0)
2745             *toget = 0;
2746         else if (bsrt->hits <= *req->smallSetUpperBound)
2747         {
2748             *toget = bsrt->hits;
2749             if ((comp.u.simple = req->smallSetElementSetNames))
2750                 compp = &comp;
2751         }
2752         else if (bsrt->hits < *req->largeSetLowerBound)
2753         {
2754             *toget = *req->mediumSetPresentNumber;
2755             if (*toget > bsrt->hits)
2756                 *toget = bsrt->hits;
2757             if ((comp.u.simple = req->mediumSetElementSetNames))
2758                 compp = &comp;
2759         }
2760         else
2761             *toget = 0;
2762
2763         if (*toget && !resp->records)
2764         {
2765             Odr_int *presst = odr_intdup(assoc->encode, 0);
2766             /* Call bend_present if defined */
2767             if (assoc->init->bend_present)
2768             {
2769                 bend_present_rr *bprr = (bend_present_rr *)
2770                     nmem_malloc(reqb->request_mem, sizeof(*bprr));
2771                 bprr->setname = req->resultSetName;
2772                 bprr->start = 1;
2773                 bprr->number = odr_int_to_int(*toget);
2774                 bprr->format = req->preferredRecordSyntax;
2775                 bprr->comp = compp;
2776                 bprr->referenceId = req->referenceId;
2777                 bprr->stream = assoc->encode;
2778                 bprr->print = assoc->print;
2779                 bprr->association = assoc;
2780                 bprr->errcode = 0;
2781                 bprr->errstring = NULL;
2782                 (*assoc->init->bend_present)(assoc->backend, bprr);
2783
2784                 if (bprr->errcode)
2785                 {
2786                     resp->records = diagrec(assoc, bprr->errcode, bprr->errstring);
2787                     *resp->presentStatus = Z_PresentStatus_failure;
2788                 }
2789             }
2790
2791             if (!resp->records)
2792                 resp->records = pack_records(
2793                     assoc, req->resultSetName, 1,
2794                     toget, compp, next, presst, req->referenceId,
2795                     req->preferredRecordSyntax, NULL);
2796             if (!resp->records)
2797                 return 0;
2798             resp->numberOfRecordsReturned = toget;
2799             returnedrecs = *toget;
2800             resp->presentStatus = presst;
2801         }
2802         else
2803         {
2804             if (*resp->resultCount)
2805                 *next = 1;
2806             resp->numberOfRecordsReturned = nulint;
2807             resp->presentStatus = 0;
2808         }
2809         resp->nextResultSetPosition = next;
2810         resp->searchStatus = sr;
2811         resp->resultSetStatus = 0;
2812         if (bsrt->estimated_hit_count)
2813         {
2814             resp->resultSetStatus = odr_intdup(assoc->encode,
2815                                                Z_SearchResponse_estimate);
2816         }
2817         else if (bsrt->partial_resultset)
2818         {
2819             resp->resultSetStatus = odr_intdup(assoc->encode,
2820                                                Z_SearchResponse_subset);
2821         }
2822     }
2823     resp->additionalSearchInfo = bsrt->search_info;
2824
2825     if (log_request)
2826     {
2827         int i;
2828         WRBUF wr = wrbuf_alloc();
2829
2830         for (i = 0 ; i < req->num_databaseNames; i++)
2831         {
2832             if (i)
2833                 wrbuf_printf(wr, "+");
2834             wrbuf_puts(wr, req->databaseNames[i]);
2835         }
2836         wrbuf_printf(wr, " ");
2837
2838         if (bsrt->errcode)
2839             wrbuf_printf(wr, "ERROR %d", bsrt->errcode);
2840         else
2841             wrbuf_printf(wr, "OK " ODR_INT_PRINTF, bsrt->hits);
2842         wrbuf_printf(wr, " %s 1+" ODR_INT_PRINTF " ",
2843                      req->resultSetName, returnedrecs);
2844         yaz_query_to_wrbuf(wr, req->query);
2845
2846         yaz_log(log_request, "Search %s", wrbuf_cstr(wr));
2847         wrbuf_destroy(wr);
2848     }
2849     return apdu;
2850 }
2851
2852 /*
2853  * Maybe we got a little over-friendly when we designed bend_fetch to
2854  * get only one record at a time. Some backends can optimise multiple-record
2855  * fetches, and at any rate, there is some overhead involved in
2856  * all that selecting and hopping around. Problem is, of course, that the
2857  * frontend can't know ahead of time how many records it'll need to
2858  * fill the negotiated PDU size. Annoying. Segmentation or not, Z/SR
2859  * is downright lousy as a bulk data transfer protocol.
2860  *
2861  * To start with, we'll do the fetching of records from the backend
2862  * in one operation: To save some trips in and out of the event-handler,
2863  * and to simplify the interface to pack_records. At any rate, asynch
2864  * operation is more fun in operations that have an unpredictable execution
2865  * speed - which is normally more true for search than for present.
2866  */
2867 static Z_APDU *process_presentRequest(association *assoc, request *reqb)
2868 {
2869     Z_PresentRequest *req = reqb->apdu_request->u.presentRequest;
2870     Z_APDU *apdu;
2871     Z_PresentResponse *resp;
2872     Odr_int *next;
2873     Odr_int *num;
2874     int errcode = 0;
2875
2876     yaz_log(log_requestdetail, "Got PresentRequest.");
2877
2878     resp = (Z_PresentResponse *)odr_malloc(assoc->encode, sizeof(*resp));
2879     resp->records = 0;
2880     resp->presentStatus = odr_intdup(assoc->encode, 0);
2881     if (assoc->init->bend_present)
2882     {
2883         bend_present_rr *bprr = (bend_present_rr *)
2884             nmem_malloc(reqb->request_mem, sizeof(*bprr));
2885         bprr->setname = req->resultSetId;
2886         bprr->start = odr_int_to_int(*req->resultSetStartPoint);
2887         bprr->number = odr_int_to_int(*req->numberOfRecordsRequested);
2888         bprr->format = req->preferredRecordSyntax;
2889         bprr->comp = req->recordComposition;
2890         bprr->referenceId = req->referenceId;
2891         bprr->stream = assoc->encode;
2892         bprr->print = assoc->print;
2893         bprr->association = assoc;
2894         bprr->errcode = 0;
2895         bprr->errstring = NULL;
2896         (*assoc->init->bend_present)(assoc->backend, bprr);
2897
2898         if (bprr->errcode)
2899         {
2900             resp->records = diagrec(assoc, bprr->errcode, bprr->errstring);
2901             *resp->presentStatus = Z_PresentStatus_failure;
2902             errcode = bprr->errcode;
2903         }
2904     }
2905     apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
2906     next = odr_intdup(assoc->encode, 0);
2907     num = odr_intdup(assoc->encode, 0);
2908
2909     apdu->which = Z_APDU_presentResponse;
2910     apdu->u.presentResponse = resp;
2911     resp->referenceId = req->referenceId;
2912     resp->otherInfo = 0;
2913
2914     if (!resp->records)
2915     {
2916         *num = *req->numberOfRecordsRequested;
2917         resp->records =
2918             pack_records(assoc, req->resultSetId, *req->resultSetStartPoint,
2919                          num, req->recordComposition, next,
2920                          resp->presentStatus,
2921                          req->referenceId, req->preferredRecordSyntax,
2922                          &errcode);
2923     }
2924     if (log_request)
2925     {
2926         WRBUF wr = wrbuf_alloc();
2927         wrbuf_printf(wr, "Present ");
2928
2929         if (*resp->presentStatus == Z_PresentStatus_failure)
2930             wrbuf_printf(wr, "ERROR %d ", errcode);
2931         else if (*resp->presentStatus == Z_PresentStatus_success)
2932             wrbuf_printf(wr, "OK -  ");
2933         else
2934             wrbuf_printf(wr, "Partial " ODR_INT_PRINTF " - ",
2935                          *resp->presentStatus);
2936
2937         wrbuf_printf(wr, " %s " ODR_INT_PRINTF "+" ODR_INT_PRINTF " ",
2938                 req->resultSetId, *req->resultSetStartPoint,
2939                 *req->numberOfRecordsRequested);
2940         yaz_log(log_request, "%s", wrbuf_cstr(wr) );
2941         wrbuf_destroy(wr);
2942     }
2943     if (!resp->records)
2944         return 0;
2945     resp->numberOfRecordsReturned = num;
2946     resp->nextResultSetPosition = next;
2947
2948     return apdu;
2949 }
2950
2951 /*
2952  * Scan was implemented rather in a hurry, and with support for only the basic
2953  * elements of the service in the backend API. Suggestions are welcome.
2954  */
2955 static Z_APDU *process_scanRequest(association *assoc, request *reqb)
2956 {
2957     Z_ScanRequest *req = reqb->apdu_request->u.scanRequest;
2958     Z_APDU *apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
2959     Z_ScanResponse *res = (Z_ScanResponse *)
2960         odr_malloc(assoc->encode, sizeof(*res));
2961     Odr_int *scanStatus = odr_intdup(assoc->encode, Z_Scan_failure);
2962     Odr_int *numberOfEntriesReturned = odr_intdup(assoc->encode, 0);
2963     Z_ListEntries *ents = (Z_ListEntries *)
2964         odr_malloc(assoc->encode, sizeof(*ents));
2965     Z_DiagRecs *diagrecs_p = NULL;
2966     bend_scan_rr *bsrr = (bend_scan_rr *)
2967         odr_malloc(assoc->encode, sizeof(*bsrr));
2968     struct scan_entry *save_entries;
2969     int step_size = 0;
2970
2971     yaz_log(log_requestdetail, "Got ScanRequest");
2972
2973     apdu->which = Z_APDU_scanResponse;
2974     apdu->u.scanResponse = res;
2975     res->referenceId = req->referenceId;
2976
2977     /* if step is absent, set it to 0 */
2978     if (req->stepSize)
2979         step_size = odr_int_to_int(*req->stepSize);
2980
2981     res->stepSize = 0;
2982     res->scanStatus = scanStatus;
2983     res->numberOfEntriesReturned = numberOfEntriesReturned;
2984     res->positionOfTerm = 0;
2985     res->entries = ents;
2986     ents->num_entries = 0;
2987     ents->entries = NULL;
2988     ents->num_nonsurrogateDiagnostics = 0;
2989     ents->nonsurrogateDiagnostics = NULL;
2990     res->attributeSet = 0;
2991     res->otherInfo = 0;
2992
2993     if (req->databaseNames)
2994     {
2995         int i;
2996         for (i = 0; i < req->num_databaseNames; i++)
2997             yaz_log(log_requestdetail, "Database '%s'", req->databaseNames[i]);
2998     }
2999     bsrr->scanClause = 0;
3000     bsrr->errcode = 0;
3001     bsrr->errstring = 0;
3002     bsrr->num_bases = req->num_databaseNames;
3003     bsrr->basenames = req->databaseNames;
3004     bsrr->num_entries = odr_int_to_int(*req->numberOfTermsRequested);
3005     bsrr->term = req->termListAndStartPoint;
3006     bsrr->referenceId = req->referenceId;
3007     bsrr->stream = assoc->encode;
3008     bsrr->print = assoc->print;
3009     bsrr->step_size = &step_size;
3010     bsrr->setname = yaz_oi_get_string_oid(&req->otherInfo,
3011                                           yaz_oid_userinfo_scan_set, 1, 0);
3012     bsrr->entries = 0;
3013     /* For YAZ 2.0 and earlier it was the backend handler that
3014        initialized entries (member display_term did not exist)
3015        YAZ 2.0 and later sets 'entries'  and initialize all members
3016        including 'display_term'. If YAZ 2.0 or later sees that
3017        entries was modified - we assume that it is an old handler and
3018        that 'display_term' is _not_ set.
3019     */
3020     if (bsrr->num_entries > 0)
3021     {
3022         int i;
3023         bsrr->entries = (struct scan_entry *)
3024             odr_malloc(assoc->decode, sizeof(*bsrr->entries) *
3025                        bsrr->num_entries);
3026         for (i = 0; i<bsrr->num_entries; i++)
3027         {
3028             bsrr->entries[i].term = 0;
3029             bsrr->entries[i].occurrences = 0;
3030             bsrr->entries[i].errcode = 0;
3031             bsrr->entries[i].errstring = 0;
3032             bsrr->entries[i].display_term = 0;
3033         }
3034     }
3035     save_entries = bsrr->entries;  /* save it so we can compare later */
3036
3037     bsrr->attributeset = req->attributeSet;
3038     log_scan_term_level(log_requestdetail, req->termListAndStartPoint,
3039                         bsrr->attributeset);
3040     bsrr->term_position = req->preferredPositionInResponse ?
3041         odr_int_to_int(*req->preferredPositionInResponse) : 1;
3042
3043     ((int (*)(void *, bend_scan_rr *))
3044      (*assoc->init->bend_scan))(assoc->backend, bsrr);
3045
3046     if (bsrr->errcode)
3047         diagrecs_p = zget_DiagRecs(assoc->encode,
3048                                    bsrr->errcode, bsrr->errstring);
3049     else
3050     {
3051         int i;
3052         Z_Entry **tab = (Z_Entry **)
3053             odr_malloc(assoc->encode, sizeof(*tab) * bsrr->num_entries);
3054
3055         if (bsrr->status == BEND_SCAN_PARTIAL)
3056             *scanStatus = Z_Scan_partial_5;
3057         else
3058             *scanStatus = Z_Scan_success;
3059         res->stepSize = odr_intdup(assoc->encode, step_size);
3060         ents->entries = tab;
3061         ents->num_entries = bsrr->num_entries;
3062         res->numberOfEntriesReturned = odr_intdup(assoc->encode,
3063                                                    ents->num_entries);
3064         res->positionOfTerm = odr_intdup(assoc->encode, bsrr->term_position);
3065         for (i = 0; i < bsrr->num_entries; i++)
3066         {
3067             Z_Entry *e;
3068             Z_TermInfo *t;
3069             Odr_oct *o;
3070
3071             tab[i] = e = (Z_Entry *)odr_malloc(assoc->encode, sizeof(*e));
3072             if (bsrr->entries[i].occurrences >= 0)
3073             {
3074                 e->which = Z_Entry_termInfo;
3075                 e->u.termInfo = t = (Z_TermInfo *)
3076                     odr_malloc(assoc->encode, sizeof(*t));
3077                 t->suggestedAttributes = 0;
3078                 t->displayTerm = 0;
3079                 if (save_entries == bsrr->entries &&
3080                     bsrr->entries[i].display_term)
3081                 {
3082                     /* the entries was _not_ set by the handler. So it's
3083                        safe to test for new member display_term. It is
3084                        NULL'ed by us.
3085                     */
3086                     t->displayTerm = odr_strdup(assoc->encode,
3087                                                 bsrr->entries[i].display_term);
3088                 }
3089                 t->alternativeTerm = 0;
3090                 t->byAttributes = 0;
3091                 t->otherTermInfo = 0;
3092                 t->globalOccurrences = &bsrr->entries[i].occurrences;
3093                 t->term = (Z_Term *)
3094                     odr_malloc(assoc->encode, sizeof(*t->term));
3095                 t->term->which = Z_Term_general;
3096                 t->term->u.general = o =
3097                     (Odr_oct *)odr_malloc(assoc->encode, sizeof(Odr_oct));
3098                 o->buf = (unsigned char *)
3099                     odr_malloc(assoc->encode, o->len = o->size =
3100                                strlen(bsrr->entries[i].term));
3101                 memcpy(o->buf, bsrr->entries[i].term, o->len);
3102                 yaz_log(YLOG_DEBUG, "  term #%d: '%s' (" ODR_INT_PRINTF ")", i,
3103                          bsrr->entries[i].term, bsrr->entries[i].occurrences);
3104             }
3105             else
3106             {
3107                 Z_DiagRecs *drecs = zget_DiagRecs(assoc->encode,
3108                                                   bsrr->entries[i].errcode,
3109                                                   bsrr->entries[i].errstring);
3110                 assert(drecs->num_diagRecs == 1);
3111                 e->which = Z_Entry_surrogateDiagnostic;
3112                 assert(drecs->diagRecs[0]);
3113                 e->u.surrogateDiagnostic = drecs->diagRecs[0];
3114             }
3115         }
3116     }
3117     if (diagrecs_p)
3118     {
3119         ents->num_nonsurrogateDiagnostics = diagrecs_p->num_diagRecs;
3120         ents->nonsurrogateDiagnostics = diagrecs_p->diagRecs;
3121     }
3122     if (log_request)
3123     {
3124         int i;
3125         WRBUF wr = wrbuf_alloc();
3126         wrbuf_printf(wr, "Scan ");
3127         for (i = 0 ; i < req->num_databaseNames; i++)
3128         {
3129             if (i)
3130                 wrbuf_printf(wr, "+");
3131             wrbuf_puts(wr, req->databaseNames[i]);
3132         }
3133
3134         wrbuf_printf(wr, " ");
3135
3136         if (bsrr->errcode)
3137             wr_diag(wr, bsrr->errcode, bsrr->errstring);
3138         else
3139             wrbuf_printf(wr, "OK");
3140
3141         wrbuf_printf(wr, " " ODR_INT_PRINTF " - " ODR_INT_PRINTF "+"
3142                      ODR_INT_PRINTF "+" ODR_INT_PRINTF,
3143                      res->numberOfEntriesReturned ?
3144                      *res->numberOfEntriesReturned : 0,
3145                      (req->preferredPositionInResponse ?
3146                       *req->preferredPositionInResponse : 1),
3147                      *req->numberOfTermsRequested,
3148                      (res->stepSize ? *res->stepSize : 1));
3149
3150         if (bsrr->setname)
3151             wrbuf_printf(wr, "+%s", bsrr->setname);
3152
3153         wrbuf_printf(wr, " ");
3154         yaz_scan_to_wrbuf(wr, req->termListAndStartPoint,
3155                           bsrr->attributeset);
3156         yaz_log(log_request, "%s", wrbuf_cstr(wr) );
3157         wrbuf_destroy(wr);
3158     }
3159     return apdu;
3160 }
3161
3162 static Z_APDU *process_sortRequest(association *assoc, request *reqb)
3163 {
3164     int i;
3165     Z_SortRequest *req = reqb->apdu_request->u.sortRequest;
3166     Z_SortResponse *res = (Z_SortResponse *)
3167         odr_malloc(assoc->encode, sizeof(*res));
3168     bend_sort_rr *bsrr = (bend_sort_rr *)
3169         odr_malloc(assoc->encode, sizeof(*bsrr));
3170
3171     Z_APDU *apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
3172
3173     yaz_log(log_requestdetail, "Got SortRequest.");
3174
3175     bsrr->num_input_setnames = req->num_inputResultSetNames;
3176     for (i=0;i<req->num_inputResultSetNames;i++)
3177         yaz_log(log_requestdetail, "Input resultset: '%s'",
3178                 req->inputResultSetNames[i]);
3179     bsrr->input_setnames = req->inputResultSetNames;
3180     bsrr->referenceId = req->referenceId;
3181     bsrr->output_setname = req->sortedResultSetName;
3182     yaz_log(log_requestdetail, "Output resultset: '%s'",
3183                 req->sortedResultSetName);
3184     bsrr->sort_sequence = req->sortSequence;
3185        /*FIXME - dump those sequences too */
3186     bsrr->stream = assoc->encode;
3187     bsrr->print = assoc->print;
3188
3189     bsrr->sort_status = Z_SortResponse_failure;
3190     bsrr->errcode = 0;
3191     bsrr->errstring = 0;
3192
3193     (*assoc->init->bend_sort)(assoc->backend, bsrr);
3194
3195     res->referenceId = bsrr->referenceId;
3196     res->sortStatus = odr_intdup(assoc->encode, bsrr->sort_status);
3197     res->resultSetStatus = 0;
3198     if (bsrr->errcode)
3199     {
3200         Z_DiagRecs *dr = zget_DiagRecs(assoc->encode,
3201                                        bsrr->errcode, bsrr->errstring);
3202         res->diagnostics = dr->diagRecs;
3203         res->num_diagnostics = dr->num_diagRecs;
3204     }
3205     else
3206     {
3207         res->num_diagnostics = 0;
3208         res->diagnostics = 0;
3209     }
3210     res->resultCount = 0;
3211     res->otherInfo = 0;
3212
3213     apdu->which = Z_APDU_sortResponse;
3214     apdu->u.sortResponse = res;
3215     if (log_request)
3216     {
3217         WRBUF wr = wrbuf_alloc();
3218         wrbuf_printf(wr, "Sort ");
3219         if (bsrr->errcode)
3220             wrbuf_printf(wr, " ERROR %d", bsrr->errcode);
3221         else
3222             wrbuf_printf(wr,  "OK -");
3223         wrbuf_printf(wr, " (");
3224         for (i = 0; i<req->num_inputResultSetNames; i++)
3225         {
3226             if (i)
3227                 wrbuf_printf(wr, "+");
3228             wrbuf_puts(wr, req->inputResultSetNames[i]);
3229         }
3230         wrbuf_printf(wr, ")->%s ",req->sortedResultSetName);
3231
3232         yaz_log(log_request, "%s", wrbuf_cstr(wr) );
3233         wrbuf_destroy(wr);
3234     }
3235     return apdu;
3236 }
3237
3238 static Z_APDU *process_deleteRequest(association *assoc, request *reqb)
3239 {
3240     int i;
3241     Z_DeleteResultSetRequest *req =
3242         reqb->apdu_request->u.deleteResultSetRequest;
3243     Z_DeleteResultSetResponse *res = (Z_DeleteResultSetResponse *)
3244         odr_malloc(assoc->encode, sizeof(*res));
3245     bend_delete_rr *bdrr = (bend_delete_rr *)
3246         odr_malloc(assoc->encode, sizeof(*bdrr));
3247     Z_APDU *apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
3248
3249     yaz_log(log_requestdetail, "Got DeleteRequest.");
3250
3251     bdrr->num_setnames = req->num_resultSetList;
3252     bdrr->setnames = req->resultSetList;
3253     for (i = 0; i<req->num_resultSetList; i++)
3254         yaz_log(log_requestdetail, "resultset: '%s'",
3255                 req->resultSetList[i]);
3256     bdrr->stream = assoc->encode;
3257     bdrr->print = assoc->print;
3258     bdrr->function = odr_int_to_int(*req->deleteFunction);
3259     bdrr->referenceId = req->referenceId;
3260     bdrr->statuses = 0;
3261     if (bdrr->num_setnames > 0)
3262     {
3263         bdrr->statuses = (int*)
3264             odr_malloc(assoc->encode, sizeof(*bdrr->statuses) *
3265                        bdrr->num_setnames);
3266         for (i = 0; i < bdrr->num_setnames; i++)
3267             bdrr->statuses[i] = 0;
3268     }
3269     (*assoc->init->bend_delete)(assoc->backend, bdrr);
3270
3271     res->referenceId = req->referenceId;
3272
3273     res->deleteOperationStatus = odr_intdup(assoc->encode,bdrr->delete_status);
3274
3275     res->deleteListStatuses = 0;
3276     if (bdrr->num_setnames > 0)
3277     {
3278         int i;
3279         res->deleteListStatuses = (Z_ListStatuses *)
3280             odr_malloc(assoc->encode, sizeof(*res->deleteListStatuses));
3281         res->deleteListStatuses->num = bdrr->num_setnames;
3282         res->deleteListStatuses->elements =
3283             (Z_ListStatus **)
3284             odr_malloc(assoc->encode,
3285                         sizeof(*res->deleteListStatuses->elements) *
3286                         bdrr->num_setnames);
3287         for (i = 0; i<bdrr->num_setnames; i++)
3288         {
3289             res->deleteListStatuses->elements[i] =
3290                 (Z_ListStatus *)
3291                 odr_malloc(assoc->encode,
3292                             sizeof(**res->deleteListStatuses->elements));
3293             res->deleteListStatuses->elements[i]->status =
3294                 odr_intdup(assoc->encode, bdrr->statuses[i]);
3295             res->deleteListStatuses->elements[i]->id =
3296                 odr_strdup(assoc->encode, bdrr->setnames[i]);
3297         }
3298     }
3299     res->numberNotDeleted = 0;
3300     res->bulkStatuses = 0;
3301     res->deleteMessage = 0;
3302     res->otherInfo = 0;
3303
3304     apdu->which = Z_APDU_deleteResultSetResponse;
3305     apdu->u.deleteResultSetResponse = res;
3306     if (log_request)
3307     {
3308         WRBUF wr = wrbuf_alloc();
3309         wrbuf_printf(wr, "Delete ");
3310         if (bdrr->delete_status)
3311             wrbuf_printf(wr, "ERROR %d", bdrr->delete_status);
3312         else
3313             wrbuf_printf(wr, "OK -");
3314         for (i = 0; i<req->num_resultSetList; i++)
3315             wrbuf_printf(wr, " %s ", req->resultSetList[i]);
3316         yaz_log(log_request, "%s", wrbuf_cstr(wr) );
3317         wrbuf_destroy(wr);
3318     }
3319     return apdu;
3320 }
3321
3322 static void process_close(association *assoc, request *reqb)
3323 {
3324     Z_Close *req = reqb->apdu_request->u.close;
3325     static char *reasons[] =
3326     {
3327         "finished",
3328         "shutdown",
3329         "systemProblem",
3330         "costLimit",
3331         "resources",
3332         "securityViolation",
3333         "protocolError",
3334         "lackOfActivity",
3335         "peerAbort",
3336         "unspecified"
3337     };
3338
3339     yaz_log(log_requestdetail, "Got Close, reason %s, message %s",
3340         reasons[*req->closeReason], req->diagnosticInformation ?
3341         req->diagnosticInformation : "NULL");
3342     if (assoc->version < 3) /* to make do_force respond with close */
3343         assoc->version = 3;
3344     do_close_req(assoc, Z_Close_finished,
3345                  "Association terminated by client", reqb);
3346     yaz_log(log_request,"Close OK");
3347 }
3348
3349 static Z_APDU *process_segmentRequest(association *assoc, request *reqb)
3350 {
3351     bend_segment_rr req;
3352
3353     req.segment = reqb->apdu_request->u.segmentRequest;
3354     req.stream = assoc->encode;
3355     req.decode = assoc->decode;
3356     req.print = assoc->print;
3357     req.association = assoc;
3358
3359     (*assoc->init->bend_segment)(assoc->backend, &req);
3360
3361     return 0;
3362 }
3363
3364 static Z_APDU *process_ESRequest(association *assoc, request *reqb)
3365 {
3366     bend_esrequest_rr esrequest;
3367     const char *ext_name = "unknown";
3368
3369     Z_ExtendedServicesRequest *req =
3370         reqb->apdu_request->u.extendedServicesRequest;
3371     Z_APDU *apdu = zget_APDU(assoc->encode, Z_APDU_extendedServicesResponse);
3372
3373     Z_ExtendedServicesResponse *resp = apdu->u.extendedServicesResponse;
3374
3375     esrequest.esr = reqb->apdu_request->u.extendedServicesRequest;
3376     esrequest.stream = assoc->encode;
3377     esrequest.decode = assoc->decode;
3378     esrequest.print = assoc->print;
3379     esrequest.errcode = 0;
3380     esrequest.errstring = NULL;
3381     esrequest.association = assoc;
3382     esrequest.taskPackage = 0;
3383     esrequest.referenceId = req->referenceId;
3384
3385     if (esrequest.esr && esrequest.esr->taskSpecificParameters)
3386     {
3387         switch(esrequest.esr->taskSpecificParameters->which)
3388         {
3389         case Z_External_itemOrder:
3390             ext_name = "ItemOrder"; break;
3391         case Z_External_update:
3392             ext_name = "Update"; break;
3393         case Z_External_update0:
3394             ext_name = "Update0"; break;
3395         case Z_External_ESAdmin:
3396             ext_name = "Admin"; break;
3397
3398         }
3399     }
3400
3401     (*assoc->init->bend_esrequest)(assoc->backend, &esrequest);
3402
3403     resp->referenceId = req->referenceId;
3404
3405     if (esrequest.errcode == -1)
3406     {
3407         /* Backend service indicates request will be processed */
3408         yaz_log(log_request, "Extended Service: %s (accepted)", ext_name);
3409         *resp->operationStatus = Z_ExtendedServicesResponse_accepted;
3410     }
3411     else if (esrequest.errcode == 0)
3412     {
3413         /* Backend service indicates request will be processed */
3414         yaz_log(log_request, "Extended Service: %s (done)", ext_name);
3415         *resp->operationStatus = Z_ExtendedServicesResponse_done;
3416     }
3417     else
3418     {
3419         Z_DiagRecs *diagRecs =
3420             zget_DiagRecs(assoc->encode, esrequest.errcode,
3421