GFS: bail out of fetch if last_in_set is set
[yaz-moved-to-github.git] / src / seshigh.c
1 /* This file is part of the YAZ toolkit.
2  * Copyright (C) 1995-2012 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
900         if (srw_req->query_type == Z_SRW_query_type_cql)
901         {
902             if (assoc->server && assoc->server->cql_transform)
903             {
904                 int srw_errcode = cql2pqf(assoc->encode, srw_req->query.cql,
905                                           assoc->server->cql_transform,
906                                           rr.query,
907                                           &rr.srw_sortKeys);
908
909                 if (srw_errcode)
910                 {
911                     yaz_add_srw_diagnostic(assoc->encode,
912                                            &srw_res->diagnostics,
913                                            &srw_res->num_diagnostics,
914                                            srw_errcode, 0);
915                 }
916             }
917             else
918             {
919                 /* CQL query to backend. Wrap it - Z39.50 style */
920                 ext = (Z_External *) odr_malloc(assoc->decode, sizeof(*ext));
921                 ext->direct_reference = odr_getoidbystr(assoc->decode,
922                                                         "1.2.840.10003.16.2");
923                 ext->indirect_reference = 0;
924                 ext->descriptor = 0;
925                 ext->which = Z_External_CQL;
926                 ext->u.cql = srw_req->query.cql;
927
928                 rr.query->which = Z_Query_type_104;
929                 rr.query->u.type_104 =  ext;
930             }
931         }
932         else if (srw_req->query_type == Z_SRW_query_type_pqf)
933         {
934             Z_RPNQuery *RPNquery;
935             YAZ_PQF_Parser pqf_parser;
936
937             pqf_parser = yaz_pqf_create();
938
939             RPNquery = yaz_pqf_parse(pqf_parser, assoc->decode,
940                                      srw_req->query.pqf);
941             if (!RPNquery)
942             {
943                 const char *pqf_msg;
944                 size_t off;
945                 int code = yaz_pqf_error(pqf_parser, &pqf_msg, &off);
946                 yaz_log(log_requestdetail, "Parse error %d %s near offset %ld",
947                         code, pqf_msg, (long) off);
948                 srw_error = YAZ_SRW_QUERY_SYNTAX_ERROR;
949             }
950
951             rr.query->which = Z_Query_type_1;
952             rr.query->u.type_1 =  RPNquery;
953
954             yaz_pqf_destroy(pqf_parser);
955         }
956         else
957         {
958             yaz_add_srw_diagnostic(assoc->encode, &srw_res->diagnostics,
959                                    &srw_res->num_diagnostics,
960                                    YAZ_SRW_UNSUPP_QUERY_TYPE, 0);
961         }
962         if (rr.query->u.type_1)
963         {
964             rr.stream = assoc->encode;
965             rr.decode = assoc->decode;
966             rr.print = assoc->print;
967             if (srw_req->sort.sortKeys)
968                 rr.srw_sortKeys = odr_strdup(assoc->encode,
969                                              srw_req->sort.sortKeys);
970             rr.association = assoc;
971             rr.hits = 0;
972             rr.errcode = 0;
973             rr.errstring = 0;
974             rr.search_info = 0;
975             rr.search_input = 0;
976             yaz_log_zquery_level(log_requestdetail,rr.query);
977
978             (assoc->init->bend_search)(assoc->backend, &rr);
979             if (rr.errcode)
980             {
981                 if (rr.errcode == YAZ_BIB1_DATABASE_UNAVAILABLE)
982                 {
983                     *http_code = 404;
984                 }
985                 else
986                 {
987                     srw_error = yaz_diag_bib1_to_srw(rr.errcode);
988                     yaz_add_srw_diagnostic(assoc->encode,
989                                            &srw_res->diagnostics,
990                                            &srw_res->num_diagnostics,
991                                            srw_error, rr.errstring);
992                 }
993             }
994             else
995             {
996                 int number = srw_req->maximumRecords ?
997                     odr_int_to_int(*srw_req->maximumRecords) : 0;
998                 int start = srw_req->startRecord ?
999                     odr_int_to_int(*srw_req->startRecord) : 1;
1000
1001                 yaz_log(log_requestdetail, "Request to pack %d+%d out of "
1002                         ODR_INT_PRINTF,
1003                         start, number, rr.hits);
1004
1005                 srw_res->numberOfRecords = odr_intdup(assoc->encode, rr.hits);
1006                 if (rr.srw_setname)
1007                 {
1008                     srw_res->resultSetId =
1009                         odr_strdup(assoc->encode, rr.srw_setname );
1010                     srw_res->resultSetIdleTime =
1011                         odr_intdup(assoc->encode, *rr.srw_setnameIdleTime );
1012                 }
1013
1014                 if (start > rr.hits || start < 1)
1015                 {
1016                     /* if hits<=0 and start=1 we don't return a diagnostic */
1017                     if (start != 1)
1018                         yaz_add_srw_diagnostic(
1019                             assoc->encode,
1020                             &srw_res->diagnostics, &srw_res->num_diagnostics,
1021                             YAZ_SRW_FIRST_RECORD_POSITION_OUT_OF_RANGE, 0);
1022                 }
1023                 else if (number > 0)
1024                 {
1025                     int i;
1026                     int ok = 1;
1027                     if (start + number > rr.hits)
1028                         number = odr_int_to_int(rr.hits) - start + 1;
1029
1030                     /* Call bend_present if defined */
1031                     if (assoc->init->bend_present)
1032                     {
1033                         bend_present_rr *bprr = (bend_present_rr*)
1034                             odr_malloc(assoc->decode, sizeof(*bprr));
1035                         bprr->setname = "default";
1036                         bprr->start = start;
1037                         bprr->number = number;
1038                         if (srw_req->recordSchema)
1039                         {
1040                             bprr->comp = (Z_RecordComposition *) odr_malloc(assoc->decode,
1041                                                                             sizeof(*bprr->comp));
1042                             bprr->comp->which = Z_RecordComp_simple;
1043                             bprr->comp->u.simple = (Z_ElementSetNames *)
1044                                 odr_malloc(assoc->decode, sizeof(Z_ElementSetNames));
1045                             bprr->comp->u.simple->which = Z_ElementSetNames_generic;
1046                             bprr->comp->u.simple->u.generic = srw_req->recordSchema;
1047                         }
1048                         else
1049                         {
1050                             bprr->comp = 0;
1051                         }
1052                         bprr->stream = assoc->encode;
1053                         bprr->referenceId = 0;
1054                         bprr->print = assoc->print;
1055                         bprr->association = assoc;
1056                         bprr->errcode = 0;
1057                         bprr->errstring = NULL;
1058                         (*assoc->init->bend_present)(assoc->backend, bprr);
1059
1060                         if (bprr->errcode)
1061                         {
1062                             srw_error = yaz_diag_bib1_to_srw(bprr->errcode);
1063                             yaz_add_srw_diagnostic(assoc->encode,
1064                                                    &srw_res->diagnostics,
1065                                                    &srw_res->num_diagnostics,
1066                                                    srw_error, bprr->errstring);
1067                             ok = 0;
1068                         }
1069                     }
1070
1071                     if (ok)
1072                     {
1073                         int j = 0;
1074                         int packing = Z_SRW_recordPacking_string;
1075                         if (srw_req->recordPacking)
1076                         {
1077                             packing =
1078                                 yaz_srw_str_to_pack(srw_req->recordPacking);
1079                             if (packing == -1)
1080                                 packing = Z_SRW_recordPacking_string;
1081                         }
1082                         srw_res->records = (Z_SRW_record *)
1083                             odr_malloc(assoc->encode,
1084                                        number * sizeof(*srw_res->records));
1085
1086                         srw_res->extra_records = (Z_SRW_extra_record **)
1087                             odr_malloc(assoc->encode,
1088                                        number*sizeof(*srw_res->extra_records));
1089
1090                         for (i = 0; i<number; i++)
1091                         {
1092                             int errcode;
1093                             int last_in_set = 0;
1094                             const char *addinfo = 0;
1095
1096                             srw_res->records[j].recordPacking = packing;
1097                             srw_res->records[j].recordData_buf = 0;
1098                             srw_res->extra_records[j] = 0;
1099                             yaz_log(YLOG_DEBUG, "srw_bend_fetch %d", i+start);
1100                             errcode = srw_bend_fetch(assoc, i+start, srw_req,
1101                                                      srw_res->records + j,
1102                                                      &addinfo, &last_in_set);
1103                             if (errcode)
1104                             {
1105                                 yaz_add_srw_diagnostic(assoc->encode,
1106                                                        &srw_res->diagnostics,
1107                                                        &srw_res->num_diagnostics,
1108                                                        yaz_diag_bib1_to_srw(errcode),
1109                                                        addinfo);
1110
1111                                 break;
1112                             }
1113                             if (srw_res->records[j].recordData_buf)
1114                                 j++;
1115                             if (last_in_set)
1116                                 break;
1117                         }
1118                         srw_res->num_records = j;
1119                         if (!j)
1120                             srw_res->records = 0;
1121                     }
1122                 }
1123                 if (rr.extra_response_data)
1124                 {
1125                     res->extraResponseData_buf = rr.extra_response_data;
1126                     res->extraResponseData_len = strlen(rr.extra_response_data);
1127                 }
1128                 if (rr.estimated_hit_count || rr.partial_resultset)
1129                 {
1130                     yaz_add_srw_diagnostic(
1131                         assoc->encode,
1132                         &srw_res->diagnostics,
1133                         &srw_res->num_diagnostics,
1134                         YAZ_SRW_RESULT_SET_CREATED_WITH_VALID_PARTIAL_RESULTS_AVAILABLE,
1135                         0);
1136                 }
1137             }
1138         }
1139     }
1140     if (log_request)
1141     {
1142         const char *querystr = "?";
1143         const char *querytype = "?";
1144         WRBUF wr = wrbuf_alloc();
1145
1146         switch (srw_req->query_type)
1147         {
1148         case Z_SRW_query_type_cql:
1149             querytype = "CQL";
1150             querystr = srw_req->query.cql;
1151             break;
1152         case Z_SRW_query_type_pqf:
1153             querytype = "PQF";
1154             querystr = srw_req->query.pqf;
1155             break;
1156         }
1157         wrbuf_printf(wr, "SRWSearch %s ", srw_req->database);
1158         if (srw_res->num_diagnostics)
1159             wrbuf_printf(wr, "ERROR %s", srw_res->diagnostics[0].uri);
1160         else if (*http_code != 200)
1161             wrbuf_printf(wr, "ERROR info:http/%d", *http_code);
1162         else if (srw_res->numberOfRecords)
1163         {
1164             wrbuf_printf(wr, "OK " ODR_INT_PRINTF,
1165                          (srw_res->numberOfRecords ?
1166                           *srw_res->numberOfRecords : 0));
1167         }
1168         wrbuf_printf(wr, " %s " ODR_INT_PRINTF "+%d",
1169                      (srw_res->resultSetId ?
1170                       srw_res->resultSetId : "-"),
1171                      (srw_req->startRecord ? *srw_req->startRecord : 1),
1172                      srw_res->num_records);
1173         yaz_log(log_request, "%s %s: %s", wrbuf_cstr(wr), querytype, querystr);
1174         wrbuf_destroy(wr);
1175     }
1176 }
1177
1178 static char *srw_bend_explain_default(bend_explain_rr *rr)
1179 {
1180 #if YAZ_HAVE_XML2
1181     xmlNodePtr ptr = (xmlNode *) rr->server_node_ptr;
1182     if (!ptr)
1183         return 0;
1184     for (ptr = ptr->children; ptr; ptr = ptr->next)
1185     {
1186         if (ptr->type != XML_ELEMENT_NODE)
1187             continue;
1188         if (!strcmp((const char *) ptr->name, "explain"))
1189         {
1190             int len;
1191             xmlDocPtr doc = xmlNewDoc(BAD_CAST "1.0");
1192             xmlChar *buf_out;
1193             char *content;
1194
1195             ptr = xmlCopyNode(ptr, 1);
1196
1197             xmlDocSetRootElement(doc, ptr);
1198
1199             xmlDocDumpMemory(doc, &buf_out, &len);
1200             content = (char*) odr_malloc(rr->stream, 1+len);
1201             memcpy(content, buf_out, len);
1202             content[len] = '\0';
1203
1204             xmlFree(buf_out);
1205             xmlFreeDoc(doc);
1206             rr->explain_buf = content;
1207             return 0;
1208         }
1209     }
1210 #endif
1211     return 0;
1212 }
1213
1214 static void srw_bend_explain(association *assoc,
1215                              Z_SRW_PDU *sr,
1216                              Z_SRW_explainResponse *srw_res,
1217                              int *http_code)
1218 {
1219     Z_SRW_explainRequest *srw_req = sr->u.explain_request;
1220     yaz_log(log_requestdetail, "Got SRW ExplainRequest");
1221     *http_code = 404;
1222     srw_bend_init(assoc, &srw_res->diagnostics, &srw_res->num_diagnostics, sr);
1223     if (assoc->init)
1224     {
1225         bend_explain_rr rr;
1226
1227         rr.stream = assoc->encode;
1228         rr.decode = assoc->decode;
1229         rr.print = assoc->print;
1230         rr.explain_buf = 0;
1231         rr.database = srw_req->database;
1232         if (assoc->server)
1233             rr.server_node_ptr = assoc->server->server_node_ptr;
1234         else
1235             rr.server_node_ptr = 0;
1236         rr.schema = "http://explain.z3950.org/dtd/2.0/";
1237         if (assoc->init->bend_explain)
1238             (*assoc->init->bend_explain)(assoc->backend, &rr);
1239         else
1240             srw_bend_explain_default(&rr);
1241
1242         if (rr.explain_buf)
1243         {
1244             int packing = Z_SRW_recordPacking_string;
1245             if (srw_req->recordPacking)
1246             {
1247                 packing =
1248                     yaz_srw_str_to_pack(srw_req->recordPacking);
1249                 if (packing == -1)
1250                     packing = Z_SRW_recordPacking_string;
1251             }
1252             srw_res->record.recordSchema = rr.schema;
1253             srw_res->record.recordPacking = packing;
1254             srw_res->record.recordData_buf = rr.explain_buf;
1255             srw_res->record.recordData_len = strlen(rr.explain_buf);
1256             srw_res->record.recordPosition = 0;
1257             *http_code = 200;
1258         }
1259     }
1260 }
1261
1262 static void srw_bend_scan(association *assoc,
1263                           Z_SRW_PDU *sr,
1264                           Z_SRW_scanResponse *srw_res,
1265                           int *http_code)
1266 {
1267     Z_SRW_scanRequest *srw_req = sr->u.scan_request;
1268     yaz_log(log_requestdetail, "Got SRW ScanRequest");
1269
1270     *http_code = 200;
1271     srw_bend_init(assoc, &srw_res->diagnostics, &srw_res->num_diagnostics, sr);
1272     if (srw_res->num_diagnostics == 0 && assoc->init)
1273     {
1274         int step_size = 0;
1275         struct scan_entry *save_entries;
1276
1277         bend_scan_rr *bsrr = (bend_scan_rr *)
1278             odr_malloc(assoc->encode, sizeof(*bsrr));
1279         bsrr->num_bases = 1;
1280         bsrr->basenames = &srw_req->database;
1281
1282         bsrr->num_entries = srw_req->maximumTerms ?
1283             odr_int_to_int(*srw_req->maximumTerms) : 10;
1284         bsrr->term_position = srw_req->responsePosition ?
1285             odr_int_to_int(*srw_req->responsePosition) : 1;
1286
1287         bsrr->errcode = 0;
1288         bsrr->errstring = 0;
1289         bsrr->referenceId = 0;
1290         bsrr->stream = assoc->encode;
1291         bsrr->print = assoc->print;
1292         bsrr->step_size = &step_size;
1293         bsrr->entries = 0;
1294         bsrr->setname = 0;
1295
1296         if (bsrr->num_entries > 0)
1297         {
1298             int i;
1299             bsrr->entries = (struct scan_entry *)
1300                 odr_malloc(assoc->decode, sizeof(*bsrr->entries) *
1301                            bsrr->num_entries);
1302             for (i = 0; i<bsrr->num_entries; i++)
1303             {
1304                 bsrr->entries[i].term = 0;
1305                 bsrr->entries[i].occurrences = 0;
1306                 bsrr->entries[i].errcode = 0;
1307                 bsrr->entries[i].errstring = 0;
1308                 bsrr->entries[i].display_term = 0;
1309             }
1310         }
1311         save_entries = bsrr->entries;  /* save it so we can compare later */
1312
1313         if (srw_req->query_type == Z_SRW_query_type_pqf &&
1314             assoc->init->bend_scan)
1315         {
1316             YAZ_PQF_Parser pqf_parser = yaz_pqf_create();
1317
1318             bsrr->term = yaz_pqf_scan(pqf_parser, assoc->decode,
1319                                       &bsrr->attributeset,
1320                                       srw_req->scanClause.pqf);
1321             yaz_pqf_destroy(pqf_parser);
1322             bsrr->scanClause = 0;
1323             ((int (*)(void *, bend_scan_rr *))
1324              (*assoc->init->bend_scan))(assoc->backend, bsrr);
1325         }
1326         else if (srw_req->query_type == Z_SRW_query_type_cql
1327                  && assoc->init->bend_scan && assoc->server
1328                  && assoc->server->cql_transform)
1329         {
1330             int srw_error;
1331             bsrr->scanClause = 0;
1332             bsrr->attributeset = 0;
1333             bsrr->term = (Z_AttributesPlusTerm *)
1334                 odr_malloc(assoc->decode, sizeof(*bsrr->term));
1335             srw_error = cql2pqf_scan(assoc->encode,
1336                                      srw_req->scanClause.cql,
1337                                      assoc->server->cql_transform,
1338                                      bsrr->term);
1339             if (srw_error)
1340                 yaz_add_srw_diagnostic(assoc->encode, &srw_res->diagnostics,
1341                                        &srw_res->num_diagnostics,
1342                                        srw_error, 0);
1343             else
1344             {
1345                 ((int (*)(void *, bend_scan_rr *))
1346                  (*assoc->init->bend_scan))(assoc->backend, bsrr);
1347             }
1348         }
1349         else if (srw_req->query_type == Z_SRW_query_type_cql
1350                  && assoc->init->bend_srw_scan)
1351         {
1352             bsrr->term = 0;
1353             bsrr->attributeset = 0;
1354             bsrr->scanClause = srw_req->scanClause.cql;
1355             ((int (*)(void *, bend_scan_rr *))
1356              (*assoc->init->bend_srw_scan))(assoc->backend, bsrr);
1357         }
1358         else
1359         {
1360             yaz_add_srw_diagnostic(assoc->encode, &srw_res->diagnostics,
1361                                    &srw_res->num_diagnostics,
1362                                    YAZ_SRW_UNSUPP_OPERATION, "scan");
1363         }
1364         if (bsrr->errcode)
1365         {
1366             int srw_error;
1367             if (bsrr->errcode == YAZ_BIB1_DATABASE_UNAVAILABLE)
1368             {
1369                 *http_code = 404;
1370                 return;
1371             }
1372             srw_error = yaz_diag_bib1_to_srw(bsrr->errcode);
1373
1374             yaz_add_srw_diagnostic(assoc->encode, &srw_res->diagnostics,
1375                                    &srw_res->num_diagnostics,
1376                                    srw_error, bsrr->errstring);
1377         }
1378         else if (srw_res->num_diagnostics == 0 && bsrr->num_entries)
1379         {
1380             int i;
1381             srw_res->terms = (Z_SRW_scanTerm*)
1382                 odr_malloc(assoc->encode, sizeof(*srw_res->terms) *
1383                            bsrr->num_entries);
1384
1385             srw_res->num_terms =  bsrr->num_entries;
1386             for (i = 0; i<bsrr->num_entries; i++)
1387             {
1388                 Z_SRW_scanTerm *t = srw_res->terms + i;
1389                 t->value = odr_strdup(assoc->encode, bsrr->entries[i].term);
1390                 t->numberOfRecords =
1391                     odr_intdup(assoc->encode, bsrr->entries[i].occurrences);
1392                 t->displayTerm = 0;
1393                 if (save_entries == bsrr->entries &&
1394                     bsrr->entries[i].display_term)
1395                 {
1396                     /* the entries was _not_ set by the handler. So it's
1397                        safe to test for new member display_term. It is
1398                        NULL'ed by us.
1399                     */
1400                     t->displayTerm = odr_strdup(assoc->encode,
1401                                                 bsrr->entries[i].display_term);
1402                 }
1403                 t->whereInList = 0;
1404             }
1405         }
1406     }
1407     if (log_request)
1408     {
1409         WRBUF wr = wrbuf_alloc();
1410         const char *querytype = 0;
1411         const char *querystr = 0;
1412
1413         switch(srw_req->query_type)
1414         {
1415         case Z_SRW_query_type_pqf:
1416             querytype = "PQF";
1417             querystr = srw_req->scanClause.pqf;
1418             break;
1419         case Z_SRW_query_type_cql:
1420             querytype = "CQL";
1421             querystr = srw_req->scanClause.cql;
1422             break;
1423         default:
1424             querytype = "UNKNOWN";
1425             querystr = "";
1426         }
1427
1428         wrbuf_printf(wr, "SRWScan %s ", srw_req->database);
1429
1430         if (srw_res->num_diagnostics)
1431             wrbuf_printf(wr, "ERROR %s - ", srw_res->diagnostics[0].uri);
1432         else if (srw_res->num_terms)
1433             wrbuf_printf(wr, "OK %d - ", srw_res->num_terms);
1434         else
1435             wrbuf_printf(wr, "OK - - ");
1436
1437         wrbuf_printf(wr, ODR_INT_PRINTF "+" ODR_INT_PRINTF " ",
1438                      (srw_req->responsePosition ?
1439                       *srw_req->responsePosition : 1),
1440                      (srw_req->maximumTerms ?
1441                       *srw_req->maximumTerms : 1));
1442         /* there is no step size in SRU/W ??? */
1443         wrbuf_printf(wr, "%s: %s ", querytype, querystr);
1444         yaz_log(log_request, "%s ", wrbuf_cstr(wr) );
1445         wrbuf_destroy(wr);
1446     }
1447
1448 }
1449
1450 static void srw_bend_update(association *assoc,
1451                             Z_SRW_PDU *sr,
1452                             Z_SRW_updateResponse *srw_res,
1453                             int *http_code)
1454 {
1455     Z_SRW_updateRequest *srw_req = sr->u.update_request;
1456     yaz_log(log_session, "SRWUpdate action=%s", srw_req->operation);
1457     yaz_log(YLOG_DEBUG, "num_diag = %d", srw_res->num_diagnostics );
1458     *http_code = 404;
1459     srw_bend_init(assoc, &srw_res->diagnostics, &srw_res->num_diagnostics, sr);
1460     if (assoc->init)
1461     {
1462         bend_update_rr rr;
1463         Z_SRW_extra_record *extra = srw_req->extra_record;
1464
1465         rr.stream = assoc->encode;
1466         rr.print = assoc->print;
1467         rr.num_bases = 1;
1468         rr.basenames = &srw_req->database;
1469         rr.operation = srw_req->operation;
1470         rr.operation_status = "failed";
1471         rr.record_id = 0;
1472         rr.record_versions = 0;
1473         rr.num_versions = 0;
1474         rr.record_packing = "string";
1475         rr.record_schema = 0;
1476         rr.record_data = 0;
1477         rr.extra_record_data = 0;
1478         rr.extra_request_data = 0;
1479         rr.extra_response_data = 0;
1480         rr.uri = 0;
1481         rr.message = 0;
1482         rr.details = 0;
1483
1484         *http_code = 200;
1485         if (rr.operation == 0)
1486         {
1487             yaz_add_sru_update_diagnostic(
1488                 assoc->encode, &srw_res->diagnostics,
1489                 &srw_res->num_diagnostics,
1490                 YAZ_SRU_UPDATE_MISSING_MANDATORY_ELEMENT_RECORD_REJECTED,
1491                 "action" );
1492             return;
1493         }
1494         yaz_log(YLOG_DEBUG, "basename = %s", rr.basenames[0] );
1495         yaz_log(YLOG_DEBUG, "Operation = %s", rr.operation );
1496         if (!strcmp( rr.operation, "delete"))
1497         {
1498             if (srw_req->record && !srw_req->record->recordSchema)
1499             {
1500                 rr.record_schema = odr_strdup(
1501                     assoc->encode,
1502                     srw_req->record->recordSchema);
1503             }
1504             if (srw_req->record)
1505             {
1506                 rr.record_data = odr_strdupn(
1507                     assoc->encode,
1508                     srw_req->record->recordData_buf,
1509                     srw_req->record->recordData_len );
1510             }
1511             if (extra && extra->extraRecordData_len)
1512             {
1513                 rr.extra_record_data = odr_strdupn(
1514                     assoc->encode,
1515                     extra->extraRecordData_buf,
1516                     extra->extraRecordData_len );
1517             }
1518             if (srw_req->recordId)
1519                 rr.record_id = srw_req->recordId;
1520             else if (extra && extra->recordIdentifier)
1521                 rr.record_id = extra->recordIdentifier;
1522         }
1523         else if (!strcmp(rr.operation, "replace"))
1524         {
1525             if (srw_req->recordId)
1526                 rr.record_id = srw_req->recordId;
1527             else if (extra && extra->recordIdentifier)
1528                 rr.record_id = extra->recordIdentifier;
1529             else
1530             {
1531                 yaz_add_sru_update_diagnostic(
1532                     assoc->encode, &srw_res->diagnostics,
1533                     &srw_res->num_diagnostics,
1534                     YAZ_SRU_UPDATE_MISSING_MANDATORY_ELEMENT_RECORD_REJECTED,
1535                     "recordIdentifier");
1536             }
1537             if (!srw_req->record)
1538             {
1539                 yaz_add_sru_update_diagnostic(
1540                     assoc->encode, &srw_res->diagnostics,
1541                     &srw_res->num_diagnostics,
1542                     YAZ_SRU_UPDATE_MISSING_MANDATORY_ELEMENT_RECORD_REJECTED,
1543                     "record");
1544             }
1545             else
1546             {
1547                 if (srw_req->record->recordSchema)
1548                     rr.record_schema = odr_strdup(
1549                         assoc->encode, srw_req->record->recordSchema);
1550                 if (srw_req->record->recordData_len )
1551                 {
1552                     rr.record_data = odr_strdupn(assoc->encode,
1553                                                  srw_req->record->recordData_buf,
1554                                                  srw_req->record->recordData_len );
1555                 }
1556                 else
1557                 {
1558                     yaz_add_sru_update_diagnostic(
1559                         assoc->encode, &srw_res->diagnostics,
1560                         &srw_res->num_diagnostics,
1561                         YAZ_SRU_UPDATE_MISSING_MANDATORY_ELEMENT_RECORD_REJECTED,
1562                         "recordData" );
1563                 }
1564             }
1565             if (extra && extra->extraRecordData_len)
1566             {
1567                 rr.extra_record_data = odr_strdupn(
1568                     assoc->encode,
1569                     extra->extraRecordData_buf,
1570                     extra->extraRecordData_len );
1571             }
1572         }
1573         else if (!strcmp(rr.operation, "insert"))
1574         {
1575             if (srw_req->recordId)
1576                 rr.record_id = srw_req->recordId;
1577             else if (extra)
1578                 rr.record_id = extra->recordIdentifier;
1579
1580             if (srw_req->record)
1581             {
1582                 if (srw_req->record->recordSchema)
1583                     rr.record_schema = odr_strdup(
1584                         assoc->encode, srw_req->record->recordSchema);
1585
1586                 if (srw_req->record->recordData_len)
1587                     rr.record_data = odr_strdupn(
1588                         assoc->encode,
1589                         srw_req->record->recordData_buf,
1590                         srw_req->record->recordData_len );
1591             }
1592             if (extra && extra->extraRecordData_len)
1593             {
1594                 rr.extra_record_data = odr_strdupn(
1595                     assoc->encode,
1596                     extra->extraRecordData_buf,
1597                     extra->extraRecordData_len );
1598             }
1599         }
1600         else
1601             yaz_add_sru_update_diagnostic(assoc->encode, &srw_res->diagnostics,
1602                                           &srw_res->num_diagnostics,
1603                                           YAZ_SRU_UPDATE_INVALID_ACTION,
1604                                           rr.operation );
1605
1606         if (srw_req->record)
1607         {
1608             const char *pack_str =
1609                 yaz_srw_pack_to_str(srw_req->record->recordPacking);
1610             if (pack_str)
1611                 rr.record_packing = odr_strdup(assoc->encode, pack_str);
1612         }
1613
1614         if (srw_req->num_recordVersions)
1615         {
1616             rr.record_versions = srw_req->recordVersions;
1617             rr.num_versions = srw_req->num_recordVersions;
1618         }
1619         if (srw_req->extraRequestData_len)
1620         {
1621             rr.extra_request_data = odr_strdupn(assoc->encode,
1622                                                 srw_req->extraRequestData_buf,
1623                                                 srw_req->extraRequestData_len );
1624         }
1625         if (srw_res->num_diagnostics == 0)
1626         {
1627             if ( assoc->init->bend_srw_update)
1628                 (*assoc->init->bend_srw_update)(assoc->backend, &rr);
1629             else
1630                 yaz_add_sru_update_diagnostic(
1631                     assoc->encode, &srw_res->diagnostics,
1632                     &srw_res->num_diagnostics,
1633                     YAZ_SRU_UPDATE_UNSPECIFIED_DATABASE_ERROR,
1634                     "No Update backend handler");
1635         }
1636
1637         if (rr.uri)
1638             yaz_add_srw_diagnostic_uri(assoc->encode,
1639                                        &srw_res->diagnostics,
1640                                        &srw_res->num_diagnostics,
1641                                        rr.uri,
1642                                        rr.message,
1643                                        rr.details);
1644         srw_res->recordId = rr.record_id;
1645         srw_res->operationStatus = rr.operation_status;
1646         srw_res->recordVersions = rr.record_versions;
1647         srw_res->num_recordVersions = rr.num_versions;
1648         if (srw_res->extraResponseData_len)
1649         {
1650             srw_res->extraResponseData_buf = rr.extra_response_data;
1651             srw_res->extraResponseData_len = strlen(rr.extra_response_data);
1652         }
1653         if (srw_res->num_diagnostics == 0 && rr.record_data)
1654         {
1655             srw_res->record = yaz_srw_get_record(assoc->encode);
1656             srw_res->record->recordSchema = rr.record_schema;
1657             if (rr.record_packing)
1658             {
1659                 int pack = yaz_srw_str_to_pack(rr.record_packing);
1660
1661                 if (pack == -1)
1662                 {
1663                     pack = Z_SRW_recordPacking_string;
1664                     yaz_log(YLOG_WARN, "Back packing %s from backend",
1665                             rr.record_packing);
1666                 }
1667                 srw_res->record->recordPacking = pack;
1668             }
1669             srw_res->record->recordData_buf = rr.record_data;
1670             srw_res->record->recordData_len = strlen(rr.record_data);
1671             if (rr.extra_record_data)
1672             {
1673                 Z_SRW_extra_record *ex =
1674                     yaz_srw_get_extra_record(assoc->encode);
1675                 srw_res->extra_record = ex;
1676                 ex->extraRecordData_buf = rr.extra_record_data;
1677                 ex->extraRecordData_len = strlen(rr.extra_record_data);
1678             }
1679         }
1680     }
1681 }
1682
1683 /* check if path is OK (1); BAD (0) */
1684 static int check_path(const char *path)
1685 {
1686     if (*path != '/')
1687         return 0;
1688     if (strstr(path, ".."))
1689         return 0;
1690     return 1;
1691 }
1692
1693 static char *read_file(const char *fname, ODR o, size_t *sz)
1694 {
1695     char *buf;
1696     FILE *inf = fopen(fname, "rb");
1697     if (!inf)
1698         return 0;
1699
1700     fseek(inf, 0L, SEEK_END);
1701     *sz = ftell(inf);
1702     rewind(inf);
1703     buf = (char *) odr_malloc(o, *sz);
1704     if (fread(buf, 1, *sz, inf) != *sz)
1705         yaz_log(YLOG_WARN|YLOG_ERRNO, "short read %s", fname);
1706     fclose(inf);
1707     return buf;
1708 }
1709
1710 static void process_http_request(association *assoc, request *req)
1711 {
1712     Z_HTTP_Request *hreq = req->gdu_request->u.HTTP_Request;
1713     ODR o = assoc->encode;
1714     int r = 2;  /* 2=NOT TAKEN, 1=TAKEN, 0=SOAP TAKEN */
1715     Z_SRW_PDU *sr = 0;
1716     Z_SOAP *soap_package = 0;
1717     Z_GDU *p = 0;
1718     char *charset = 0;
1719     Z_HTTP_Response *hres = 0;
1720     int keepalive = 1;
1721     const char *stylesheet = 0; /* for now .. set later */
1722     Z_SRW_diagnostic *diagnostic = 0;
1723     int num_diagnostic = 0;
1724     const char *host = z_HTTP_header_lookup(hreq->headers, "Host");
1725
1726     yaz_log(log_request, "%s %s HTTP/%s", hreq->method, hreq->path, hreq->version);
1727     if (!control_association(assoc, host, 0))
1728     {
1729         p = z_get_HTTP_Response(o, 404);
1730         r = 1;
1731     }
1732     if (r == 2 && assoc->server && assoc->server->docpath
1733         && hreq->path[0] == '/'
1734         &&
1735         /* check if path is a proper prefix of documentroot */
1736         strncmp(hreq->path+1, assoc->server->docpath,
1737                 strlen(assoc->server->docpath))
1738         == 0)
1739     {
1740         if (!check_path(hreq->path))
1741         {
1742             yaz_log(YLOG_LOG, "File %s access forbidden", hreq->path+1);
1743             p = z_get_HTTP_Response(o, 404);
1744         }
1745         else
1746         {
1747             size_t content_size = 0;
1748             char *content_buf = read_file(hreq->path+1, o, &content_size);
1749             if (!content_buf)
1750             {
1751                 yaz_log(YLOG_LOG, "File %s not found", hreq->path+1);
1752                 p = z_get_HTTP_Response(o, 404);
1753             }
1754             else
1755             {
1756                 const char *ctype = 0;
1757                 yaz_mime_types types = yaz_mime_types_create();
1758
1759                 yaz_mime_types_add(types, "xsl", "application/xml");
1760                 yaz_mime_types_add(types, "xml", "application/xml");
1761                 yaz_mime_types_add(types, "css", "text/css");
1762                 yaz_mime_types_add(types, "html", "text/html");
1763                 yaz_mime_types_add(types, "htm", "text/html");
1764                 yaz_mime_types_add(types, "txt", "text/plain");
1765                 yaz_mime_types_add(types, "js", "application/x-javascript");
1766
1767                 yaz_mime_types_add(types, "gif", "image/gif");
1768                 yaz_mime_types_add(types, "png", "image/png");
1769                 yaz_mime_types_add(types, "jpg", "image/jpeg");
1770                 yaz_mime_types_add(types, "jpeg", "image/jpeg");
1771
1772                 ctype = yaz_mime_lookup_fname(types, hreq->path);
1773                 if (!ctype)
1774                 {
1775                     yaz_log(YLOG_LOG, "No mime type for %s", hreq->path+1);
1776                     p = z_get_HTTP_Response(o, 404);
1777                 }
1778                 else
1779                 {
1780                     p = z_get_HTTP_Response(o, 200);
1781                     hres = p->u.HTTP_Response;
1782                     hres->content_buf = content_buf;
1783                     hres->content_len = content_size;
1784                     z_HTTP_header_add(o, &hres->headers, "Content-Type", ctype);
1785                 }
1786                 yaz_mime_types_destroy(types);
1787             }
1788         }
1789         r = 1;
1790     }
1791
1792     if (r == 2)
1793     {
1794         r = yaz_srw_decode(hreq, &sr, &soap_package, assoc->decode, &charset);
1795         yaz_log(YLOG_DEBUG, "yaz_srw_decode returned %d", r);
1796     }
1797     if (r == 2)  /* not taken */
1798     {
1799         r = yaz_sru_decode(hreq, &sr, &soap_package, assoc->decode, &charset,
1800                            &diagnostic, &num_diagnostic);
1801         yaz_log(YLOG_DEBUG, "yaz_sru_decode returned %d", r);
1802     }
1803     if (r == 0)  /* decode SRW/SRU OK .. */
1804     {
1805         int http_code = 200;
1806         if (sr->which == Z_SRW_searchRetrieve_request)
1807         {
1808             Z_SRW_PDU *res =
1809                 yaz_srw_get_pdu(assoc->encode, Z_SRW_searchRetrieve_response,
1810                                 sr->srw_version);
1811             stylesheet = sr->u.request->stylesheet;
1812             if (num_diagnostic)
1813             {
1814                 res->u.response->diagnostics = diagnostic;
1815                 res->u.response->num_diagnostics = num_diagnostic;
1816             }
1817             else
1818             {
1819                 srw_bend_search(assoc, sr, res, &http_code);
1820             }
1821             if (http_code == 200)
1822                 soap_package->u.generic->p = res;
1823         }
1824         else if (sr->which == Z_SRW_explain_request)
1825         {
1826             Z_SRW_PDU *res = yaz_srw_get_pdu(o, Z_SRW_explain_response,
1827                                              sr->srw_version);
1828             stylesheet = sr->u.explain_request->stylesheet;
1829             if (num_diagnostic)
1830             {
1831                 res->u.explain_response->diagnostics = diagnostic;
1832                 res->u.explain_response->num_diagnostics = num_diagnostic;
1833             }
1834             srw_bend_explain(assoc, sr, res->u.explain_response, &http_code);
1835             if (http_code == 200)
1836                 soap_package->u.generic->p = res;
1837         }
1838         else if (sr->which == Z_SRW_scan_request)
1839         {
1840             Z_SRW_PDU *res = yaz_srw_get_pdu(o, Z_SRW_scan_response,
1841                                              sr->srw_version);
1842             stylesheet = sr->u.scan_request->stylesheet;
1843             if (num_diagnostic)
1844             {
1845                 res->u.scan_response->diagnostics = diagnostic;
1846                 res->u.scan_response->num_diagnostics = num_diagnostic;
1847             }
1848             srw_bend_scan(assoc, sr, res->u.scan_response, &http_code);
1849             if (http_code == 200)
1850                 soap_package->u.generic->p = res;
1851         }
1852         else if (sr->which == Z_SRW_update_request)
1853         {
1854             Z_SRW_PDU *res = yaz_srw_get_pdu(o, Z_SRW_update_response,
1855                                              sr->srw_version);
1856             yaz_log(YLOG_DEBUG, "handling SRW UpdateRequest");
1857             if (num_diagnostic)
1858             {
1859                 res->u.update_response->diagnostics = diagnostic;
1860                 res->u.update_response->num_diagnostics = num_diagnostic;
1861             }
1862             yaz_log(YLOG_DEBUG, "num_diag = %d", res->u.update_response->num_diagnostics );
1863             srw_bend_update(assoc, sr, res->u.update_response, &http_code);
1864             if (http_code == 200)
1865                 soap_package->u.generic->p = res;
1866         }
1867         else
1868         {
1869             yaz_log(log_request, "SOAP ERROR");
1870             /* FIXME - what error, what query */
1871             http_code = 500;
1872             z_soap_error(assoc->encode, soap_package,
1873                          "SOAP-ENV:Client", "Bad method", 0);
1874         }
1875         if (http_code == 200 || http_code == 500)
1876         {
1877             static Z_SOAP_Handler soap_handlers[4] = {
1878 #if YAZ_HAVE_XML2
1879                 {YAZ_XMLNS_SRU_v1_1, 0, (Z_SOAP_fun) yaz_srw_codec},
1880                 {YAZ_XMLNS_SRU_v1_0, 0, (Z_SOAP_fun) yaz_srw_codec},
1881                 {YAZ_XMLNS_UPDATE_v0_9, 0, (Z_SOAP_fun) yaz_ucp_codec},
1882 #endif
1883                 {0, 0, 0}
1884             };
1885             char ctype[80];
1886             p = z_get_HTTP_Response(o, 200);
1887             hres = p->u.HTTP_Response;
1888
1889             if (!stylesheet && assoc->server)
1890                 stylesheet = assoc->server->stylesheet;
1891
1892             /* empty stylesheet means NO stylesheet */
1893             if (stylesheet && *stylesheet == '\0')
1894                 stylesheet = 0;
1895
1896             z_soap_codec_enc_xsl(assoc->encode, &soap_package,
1897                                  &hres->content_buf, &hres->content_len,
1898                                  soap_handlers, charset, stylesheet);
1899             hres->code = http_code;
1900
1901             strcpy(ctype, "text/xml");
1902             if (charset && strlen(charset) < sizeof(ctype)-30)
1903             {
1904                 strcat(ctype, "; charset=");
1905                 strcat(ctype, charset);
1906             }
1907             z_HTTP_header_add(o, &hres->headers, "Content-Type", ctype);
1908         }
1909         else
1910             p = z_get_HTTP_Response(o, http_code);
1911     }
1912
1913     if (p == 0)
1914         p = z_get_HTTP_Response(o, 500);
1915     hres = p->u.HTTP_Response;
1916     if (!strcmp(hreq->version, "1.0"))
1917     {
1918         const char *v = z_HTTP_header_lookup(hreq->headers, "Connection");
1919         if (v && !strcmp(v, "Keep-Alive"))
1920             keepalive = 1;
1921         else
1922             keepalive = 0;
1923         hres->version = "1.0";
1924     }
1925     else
1926     {
1927         const char *v = z_HTTP_header_lookup(hreq->headers, "Connection");
1928         if (v && !strcmp(v, "close"))
1929             keepalive = 0;
1930         else
1931             keepalive = 1;
1932         hres->version = "1.1";
1933     }
1934     if (!keepalive || !assoc->last_control->keepalive)
1935     {
1936         z_HTTP_header_add(o, &hres->headers, "Connection", "close");
1937         assoc->state = ASSOC_DEAD;
1938         assoc->cs_get_mask = 0;
1939     }
1940     else
1941     {
1942         int t;
1943         const char *alive = z_HTTP_header_lookup(hreq->headers, "Keep-Alive");
1944
1945         if (alive && yaz_isdigit(*(const unsigned char *) alive))
1946             t = atoi(alive);
1947         else
1948             t = 15;
1949         if (t < 0 || t > 3600)
1950             t = 3600;
1951         iochan_settimeout(assoc->client_chan,t);
1952         z_HTTP_header_add(o, &hres->headers, "Connection", "Keep-Alive");
1953     }
1954     process_gdu_response(assoc, req, p);
1955 }
1956
1957 static void process_gdu_request(association *assoc, request *req)
1958 {
1959     if (req->gdu_request->which == Z_GDU_Z3950)
1960     {
1961         char *msg = 0;
1962         req->apdu_request = req->gdu_request->u.z3950;
1963         if (process_z_request(assoc, req, &msg) < 0)
1964             do_close_req(assoc, Z_Close_systemProblem, msg, req);
1965     }
1966     else if (req->gdu_request->which == Z_GDU_HTTP_Request)
1967         process_http_request(assoc, req);
1968     else
1969     {
1970         do_close_req(assoc, Z_Close_systemProblem, "bad protocol packet", req);
1971     }
1972 }
1973
1974 /*
1975  * Initiate request processing.
1976  */
1977 static int process_z_request(association *assoc, request *req, char **msg)
1978 {
1979     Z_APDU *res;
1980     int retval;
1981
1982     *msg = "Unknown Error";
1983     assert(req && req->state == REQUEST_IDLE);
1984     if (req->apdu_request->which != Z_APDU_initRequest && !assoc->init)
1985     {
1986         *msg = "Missing InitRequest";
1987         return -1;
1988     }
1989     switch (req->apdu_request->which)
1990     {
1991     case Z_APDU_initRequest:
1992         res = process_initRequest(assoc, req); break;
1993     case Z_APDU_searchRequest:
1994         res = process_searchRequest(assoc, req); break;
1995     case Z_APDU_presentRequest:
1996         res = process_presentRequest(assoc, req); break;
1997     case Z_APDU_scanRequest:
1998         if (assoc->init->bend_scan)
1999             res = process_scanRequest(assoc, req);
2000         else
2001         {
2002             *msg = "Cannot handle Scan APDU";
2003             return -1;
2004         }
2005         break;
2006     case Z_APDU_extendedServicesRequest:
2007         if (assoc->init->bend_esrequest)
2008             res = process_ESRequest(assoc, req);
2009         else
2010         {
2011             *msg = "Cannot handle Extended Services APDU";
2012             return -1;
2013         }
2014         break;
2015     case Z_APDU_sortRequest:
2016         if (assoc->init->bend_sort)
2017             res = process_sortRequest(assoc, req);
2018         else
2019         {
2020             *msg = "Cannot handle Sort APDU";
2021             return -1;
2022         }
2023         break;
2024     case Z_APDU_close:
2025         process_close(assoc, req);
2026         return 0;
2027     case Z_APDU_deleteResultSetRequest:
2028         if (assoc->init->bend_delete)
2029             res = process_deleteRequest(assoc, req);
2030         else
2031         {
2032             *msg = "Cannot handle Delete APDU";
2033             return -1;
2034         }
2035         break;
2036     case Z_APDU_segmentRequest:
2037         if (assoc->init->bend_segment)
2038         {
2039             res = process_segmentRequest(assoc, req);
2040         }
2041         else
2042         {
2043             *msg = "Cannot handle Segment APDU";
2044             return -1;
2045         }
2046         break;
2047     case Z_APDU_triggerResourceControlRequest:
2048         return 0;
2049     default:
2050         *msg = "Bad APDU received";
2051         return -1;
2052     }
2053     if (res)
2054     {
2055         yaz_log(YLOG_DEBUG, "  result immediately available");
2056         retval = process_z_response(assoc, req, res);
2057     }
2058     else
2059     {
2060         yaz_log(YLOG_DEBUG, "  result unavailable");
2061         retval = -1;
2062     }
2063     return retval;
2064 }
2065
2066 /*
2067  * Encode response, and transfer the request structure to the outgoing queue.
2068  */
2069 static int process_gdu_response(association *assoc, request *req, Z_GDU *res)
2070 {
2071     odr_setbuf(assoc->encode, req->response, req->size_response, 1);
2072
2073     if (assoc->print)
2074     {
2075         if (!z_GDU(assoc->print, &res, 0, 0))
2076             yaz_log(YLOG_WARN, "ODR print error: %s",
2077                 odr_errmsg(odr_geterror(assoc->print)));
2078         odr_reset(assoc->print);
2079     }
2080     if (!z_GDU(assoc->encode, &res, 0, 0))
2081     {
2082         yaz_log(YLOG_WARN, "ODR error when encoding PDU: %s [element %s]",
2083                 odr_errmsg(odr_geterror(assoc->decode)),
2084                 odr_getelement(assoc->decode));
2085         return -1;
2086     }
2087     req->response = odr_getbuf(assoc->encode, &req->len_response,
2088         &req->size_response);
2089     odr_setbuf(assoc->encode, 0, 0, 0); /* don'txfree if we abort later */
2090     odr_reset(assoc->encode);
2091     req->state = REQUEST_IDLE;
2092     request_enq(&assoc->outgoing, req);
2093     /* turn the work over to the ir_session handler */
2094     iochan_setflag(assoc->client_chan, EVENT_OUTPUT);
2095     assoc->cs_put_mask = EVENT_OUTPUT;
2096     /* Is there more work to be done? give that to the input handler too */
2097     for (;;)
2098     {
2099         req = request_head(&assoc->incoming);
2100         if (req && req->state == REQUEST_IDLE)
2101         {
2102             request_deq(&assoc->incoming);
2103             process_gdu_request(assoc, req);
2104         }
2105         else
2106             break;
2107     }
2108     return 0;
2109 }
2110
2111 /*
2112  * Encode response, and transfer the request structure to the outgoing queue.
2113  */
2114 static int process_z_response(association *assoc, request *req, Z_APDU *res)
2115 {
2116     Z_GDU *gres = (Z_GDU *) odr_malloc(assoc->encode, sizeof(*gres));
2117     gres->which = Z_GDU_Z3950;
2118     gres->u.z3950 = res;
2119
2120     return process_gdu_response(assoc, req, gres);
2121 }
2122
2123 static char *get_vhost(Z_OtherInformation *otherInfo)
2124 {
2125     return yaz_oi_get_string_oid(&otherInfo, yaz_oid_userinfo_proxy, 1, 0);
2126 }
2127
2128 /*
2129  * Handle init request.
2130  * At the moment, we don't check the options
2131  * anywhere else in the code - we just try not to do anything that would
2132  * break a naive client. We'll toss 'em into the association block when
2133  * we need them there.
2134  */
2135 static Z_APDU *process_initRequest(association *assoc, request *reqb)
2136 {
2137     Z_InitRequest *req = reqb->apdu_request->u.initRequest;
2138     Z_APDU *apdu = zget_APDU(assoc->encode, Z_APDU_initResponse);
2139     Z_InitResponse *resp = apdu->u.initResponse;
2140     bend_initresult *binitres;
2141     char options[140];
2142     statserv_options_block *cb = 0;  /* by default no control for backend */
2143
2144     if (control_association(assoc, get_vhost(req->otherInfo), 1))
2145         cb = statserv_getcontrol();  /* got control block for backend */
2146
2147     if (cb && assoc->backend)
2148         (*cb->bend_close)(assoc->backend);
2149
2150     yaz_log(log_requestdetail, "Got initRequest");
2151     if (req->implementationId)
2152         yaz_log(log_requestdetail, "Id:        %s",
2153                 req->implementationId);
2154     if (req->implementationName)
2155         yaz_log(log_requestdetail, "Name:      %s",
2156                 req->implementationName);
2157     if (req->implementationVersion)
2158         yaz_log(log_requestdetail, "Version:   %s",
2159                 req->implementationVersion);
2160
2161     assoc_init_reset(assoc);
2162
2163     assoc->init->auth = req->idAuthentication;
2164     assoc->init->referenceId = req->referenceId;
2165
2166     if (ODR_MASK_GET(req->options, Z_Options_negotiationModel))
2167     {
2168         Z_CharSetandLanguageNegotiation *negotiation =
2169             yaz_get_charneg_record (req->otherInfo);
2170         if (negotiation &&
2171             negotiation->which == Z_CharSetandLanguageNegotiation_proposal)
2172             assoc->init->charneg_request = negotiation;
2173     }
2174
2175     /* by default named_result_sets is 0 .. Enable it if client asks for it. */
2176     if (ODR_MASK_GET(req->options, Z_Options_namedResultSets))
2177         assoc->init->named_result_sets = 1;
2178
2179     assoc->backend = 0;
2180     if (cb)
2181     {
2182         if (req->implementationVersion)
2183             yaz_log(log_requestdetail, "Config:    %s",
2184                     cb->configname);
2185
2186         iochan_settimeout(assoc->client_chan, cb->idle_timeout);
2187
2188         /* we have a backend control block, so call that init function */
2189         if (!(binitres = (*cb->bend_init)(assoc->init)))
2190         {
2191             yaz_log(YLOG_WARN, "Bad response from backend.");
2192             return 0;
2193         }
2194         assoc->backend = binitres->handle;
2195     }
2196     else
2197     {
2198         /* no backend. return error */
2199         binitres = (bend_initresult *)
2200             odr_malloc(assoc->encode, sizeof(*binitres));
2201         binitres->errstring = 0;
2202         binitres->errcode = YAZ_BIB1_PERMANENT_SYSTEM_ERROR;
2203         iochan_settimeout(assoc->client_chan, 10);
2204     }
2205     if ((assoc->init->bend_sort))
2206         yaz_log(YLOG_DEBUG, "Sort handler installed");
2207     if ((assoc->init->bend_search))
2208         yaz_log(YLOG_DEBUG, "Search handler installed");
2209     if ((assoc->init->bend_present))
2210         yaz_log(YLOG_DEBUG, "Present handler installed");
2211     if ((assoc->init->bend_esrequest))
2212         yaz_log(YLOG_DEBUG, "ESRequest handler installed");
2213     if ((assoc->init->bend_delete))
2214         yaz_log(YLOG_DEBUG, "Delete handler installed");
2215     if ((assoc->init->bend_scan))
2216         yaz_log(YLOG_DEBUG, "Scan handler installed");
2217     if ((assoc->init->bend_segment))
2218         yaz_log(YLOG_DEBUG, "Segment handler installed");
2219
2220     resp->referenceId = req->referenceId;
2221     *options = '\0';
2222     /* let's tell the client what we can do */
2223     if (ODR_MASK_GET(req->options, Z_Options_search))
2224     {
2225         ODR_MASK_SET(resp->options, Z_Options_search);
2226         strcat(options, "srch");
2227     }
2228     if (ODR_MASK_GET(req->options, Z_Options_present))
2229     {
2230         ODR_MASK_SET(resp->options, Z_Options_present);
2231         strcat(options, " prst");
2232     }
2233     if (ODR_MASK_GET(req->options, Z_Options_delSet) &&
2234         assoc->init->bend_delete)
2235     {
2236         ODR_MASK_SET(resp->options, Z_Options_delSet);
2237         strcat(options, " del");
2238     }
2239     if (ODR_MASK_GET(req->options, Z_Options_extendedServices) &&
2240         assoc->init->bend_esrequest)
2241     {
2242         ODR_MASK_SET(resp->options, Z_Options_extendedServices);
2243         strcat(options, " extendedServices");
2244     }
2245     if (ODR_MASK_GET(req->options, Z_Options_namedResultSets)
2246         && assoc->init->named_result_sets)
2247     {
2248         ODR_MASK_SET(resp->options, Z_Options_namedResultSets);
2249         strcat(options, " namedresults");
2250     }
2251     if (ODR_MASK_GET(req->options, Z_Options_scan) && assoc->init->bend_scan)
2252     {
2253         ODR_MASK_SET(resp->options, Z_Options_scan);
2254         strcat(options, " scan");
2255     }
2256     if (ODR_MASK_GET(req->options, Z_Options_concurrentOperations))
2257     {
2258         ODR_MASK_SET(resp->options, Z_Options_concurrentOperations);
2259         strcat(options, " concurrop");
2260     }
2261     if (ODR_MASK_GET(req->options, Z_Options_sort) && assoc->init->bend_sort)
2262     {
2263         ODR_MASK_SET(resp->options, Z_Options_sort);
2264         strcat(options, " sort");
2265     }
2266
2267     if (ODR_MASK_GET(req->options, Z_Options_negotiationModel))
2268     {
2269         Z_OtherInformationUnit *p0;
2270
2271         if (!assoc->init->charneg_response)
2272         {
2273             if (assoc->init->query_charset)
2274             {
2275                 assoc->init->charneg_response = yaz_set_response_charneg(
2276                     assoc->encode, assoc->init->query_charset, 0,
2277                     assoc->init->records_in_same_charset);
2278             }
2279             else
2280             {
2281                 yaz_log(YLOG_WARN, "default query_charset not defined by backend");
2282             }
2283         }
2284         if (assoc->init->charneg_response
2285             && (p0=yaz_oi_update(&resp->otherInfo, assoc->encode, NULL, 0, 0)))
2286         {
2287             p0->which = Z_OtherInfo_externallyDefinedInfo;
2288             p0->information.externallyDefinedInfo =
2289                 assoc->init->charneg_response;
2290             ODR_MASK_SET(resp->options, Z_Options_negotiationModel);
2291             strcat(options, " negotiation");
2292         }
2293     }
2294     if (ODR_MASK_GET(req->options, Z_Options_triggerResourceCtrl))
2295         ODR_MASK_SET(resp->options, Z_Options_triggerResourceCtrl);
2296
2297     if (ODR_MASK_GET(req->protocolVersion, Z_ProtocolVersion_1))
2298     {
2299         ODR_MASK_SET(resp->protocolVersion, Z_ProtocolVersion_1);
2300         assoc->version = 1; /* 1 & 2 are equivalent */
2301     }
2302     if (ODR_MASK_GET(req->protocolVersion, Z_ProtocolVersion_2))
2303     {
2304         ODR_MASK_SET(resp->protocolVersion, Z_ProtocolVersion_2);
2305         assoc->version = 2;
2306     }
2307     if (ODR_MASK_GET(req->protocolVersion, Z_ProtocolVersion_3))
2308     {
2309         ODR_MASK_SET(resp->protocolVersion, Z_ProtocolVersion_3);
2310         assoc->version = 3;
2311     }
2312
2313     yaz_log(log_requestdetail, "Negotiated to v%d: %s", assoc->version, options);
2314
2315     if (*req->maximumRecordSize < assoc->maximumRecordSize)
2316         assoc->maximumRecordSize = odr_int_to_int(*req->maximumRecordSize);
2317
2318     if (*req->preferredMessageSize < assoc->preferredMessageSize)
2319         assoc->preferredMessageSize = odr_int_to_int(*req->preferredMessageSize);
2320
2321     resp->preferredMessageSize =
2322         odr_intdup(assoc->encode, assoc->preferredMessageSize);
2323     resp->maximumRecordSize =
2324         odr_intdup(assoc->encode, assoc->maximumRecordSize);
2325
2326     resp->implementationId = odr_prepend(assoc->encode,
2327                 assoc->init->implementation_id,
2328                 resp->implementationId);
2329
2330     resp->implementationVersion = odr_prepend(assoc->encode,
2331                 assoc->init->implementation_version,
2332                 resp->implementationVersion);
2333
2334     resp->implementationName = odr_prepend(assoc->encode,
2335                 assoc->init->implementation_name,
2336                 odr_prepend(assoc->encode, "GFS", resp->implementationName));
2337
2338     if (binitres->errcode)
2339     {
2340         assoc->state = ASSOC_DEAD;
2341         resp->userInformationField =
2342             init_diagnostics(assoc->encode, binitres->errcode,
2343                              binitres->errstring);
2344         *resp->result = 0;
2345     }
2346     else
2347         assoc->state = ASSOC_UP;
2348
2349     if (log_request)
2350     {
2351         if (!req->idAuthentication)
2352             yaz_log(log_request, "Auth none");
2353         else if (req->idAuthentication->which == Z_IdAuthentication_open)
2354         {
2355             const char *open = req->idAuthentication->u.open;
2356             const char *slash = strchr(open, '/');
2357             int len;
2358             if (slash)
2359                 len = slash - open;
2360             else
2361                 len = strlen(open);
2362                 yaz_log(log_request, "Auth open %.*s", len, open);
2363         }
2364         else if (req->idAuthentication->which == Z_IdAuthentication_idPass)
2365         {
2366             const char *user = req->idAuthentication->u.idPass->userId;
2367             const char *group = req->idAuthentication->u.idPass->groupId;
2368             yaz_log(log_request, "Auth idPass %s %s",
2369                     user ? user : "-", group ? group : "-");
2370         }
2371         else if (req->idAuthentication->which
2372                  == Z_IdAuthentication_anonymous)
2373         {
2374             yaz_log(log_request, "Auth anonymous");
2375         }
2376         else
2377         {
2378             yaz_log(log_request, "Auth other");
2379         }
2380     }
2381     if (log_request)
2382     {
2383         WRBUF wr = wrbuf_alloc();
2384         wrbuf_printf(wr, "Init ");
2385         if (binitres->errcode)
2386             wrbuf_printf(wr, "ERROR %d", binitres->errcode);
2387         else
2388             wrbuf_printf(wr, "OK -");
2389         wrbuf_printf(wr, " ID:%s Name:%s Version:%s",
2390                      (req->implementationId ? req->implementationId :"-"),
2391                      (req->implementationName ?
2392                       req->implementationName : "-"),
2393                      (req->implementationVersion ?
2394                       req->implementationVersion : "-")
2395             );
2396         yaz_log(log_request, "%s", wrbuf_cstr(wr));
2397         wrbuf_destroy(wr);
2398     }
2399     return apdu;
2400 }
2401
2402 /*
2403  * Set the specified `errcode' and `errstring' into a UserInfo-1
2404  * external to be returned to the client in accordance with Z35.90
2405  * Implementor Agreement 5 (Returning diagnostics in an InitResponse):
2406  *      http://lcweb.loc.gov/z3950/agency/agree/initdiag.html
2407  */
2408 static Z_External *init_diagnostics(ODR odr, int error, const char *addinfo)
2409 {
2410     yaz_log(log_requestdetail, "[%d] %s%s%s", error, diagbib1_str(error),
2411         addinfo ? " -- " : "", addinfo ? addinfo : "");
2412     return zget_init_diagnostics(odr, error, addinfo);
2413 }
2414
2415 /*
2416  * nonsurrogate diagnostic record.
2417  */
2418 static Z_Records *diagrec(association *assoc, int error, char *addinfo)
2419 {
2420     Z_Records *rec = (Z_Records *) odr_malloc(assoc->encode, sizeof(*rec));
2421
2422     yaz_log(log_requestdetail, "[%d] %s%s%s", error, diagbib1_str(error),
2423             addinfo ? " -- " : "", addinfo ? addinfo : "");
2424
2425     rec->which = Z_Records_NSD;
2426     rec->u.nonSurrogateDiagnostic = zget_DefaultDiagFormat(assoc->encode,
2427                                                            error, addinfo);
2428     return rec;
2429 }
2430
2431 /*
2432  * surrogate diagnostic.
2433  */
2434 static Z_NamePlusRecord *surrogatediagrec(association *assoc,
2435                                           const char *dbname,
2436                                           int error, const char *addinfo)
2437 {
2438     yaz_log(log_requestdetail, "[%d] %s%s%s", error, diagbib1_str(error),
2439             addinfo ? " -- " : "", addinfo ? addinfo : "");
2440     return zget_surrogateDiagRec(assoc->encode, dbname, error, addinfo);
2441 }
2442
2443 static Z_Records *pack_records(association *a, char *setname, Odr_int start,
2444                                Odr_int *num, Z_RecordComposition *comp,
2445                                Odr_int *next, Odr_int *pres,
2446                                Z_ReferenceId *referenceId,
2447                                Odr_oid *oid, int *errcode)
2448 {
2449     int recno, total_length = 0, dumped_records = 0;
2450     int toget = odr_int_to_int(*num);
2451     Z_Records *records =
2452         (Z_Records *) odr_malloc(a->encode, sizeof(*records));
2453     Z_NamePlusRecordList *reclist =
2454         (Z_NamePlusRecordList *) odr_malloc(a->encode, sizeof(*reclist));
2455
2456     records->which = Z_Records_DBOSD;
2457     records->u.databaseOrSurDiagnostics = reclist;
2458     reclist->num_records = 0;
2459
2460     if (toget < 0)
2461         return diagrec(a, YAZ_BIB1_PRESENT_REQUEST_OUT_OF_RANGE, 0);
2462     else if (toget == 0)
2463         reclist->records = odr_nullval();
2464     else
2465         reclist->records = (Z_NamePlusRecord **)
2466             odr_malloc(a->encode, sizeof(*reclist->records) * toget);
2467
2468     *pres = Z_PresentStatus_success;
2469     *num = 0;
2470     *next = 0;
2471
2472     yaz_log(log_requestdetail, "Request to pack " ODR_INT_PRINTF "+%d %s", start, toget, setname);
2473     yaz_log(log_requestdetail, "pms=%d, mrs=%d", a->preferredMessageSize,
2474         a->maximumRecordSize);
2475     for (recno = odr_int_to_int(start); reclist->num_records < toget; recno++)
2476     {
2477         bend_fetch_rr freq;
2478         Z_NamePlusRecord *thisrec;
2479         int this_length = 0;
2480         /*
2481          * we get the number of bytes allocated on the stream before any
2482          * allocation done by the backend - this should give us a reasonable
2483          * idea of the total size of the data so far.
2484          */
2485         total_length = odr_total(a->encode) - dumped_records;
2486         freq.errcode = 0;
2487         freq.errstring = 0;
2488         freq.basename = 0;
2489         freq.len = 0;
2490         freq.record = 0;
2491         freq.last_in_set = 0;
2492         freq.setname = setname;
2493         freq.surrogate_flag = 0;
2494         freq.number = recno;
2495         freq.comp = comp;
2496         freq.request_format = oid;
2497         freq.output_format = 0;
2498         freq.stream = a->encode;
2499         freq.print = a->print;
2500         freq.referenceId = referenceId;
2501         freq.schema = 0;
2502
2503         retrieve_fetch(a, &freq);
2504
2505         *next = freq.last_in_set ? 0 : recno + 1;
2506
2507         if (freq.errcode)
2508         {
2509             if (!freq.surrogate_flag) /* non-surrogate diagnostic i.e. global */
2510             {
2511                 char s[20];
2512                 *pres = Z_PresentStatus_failure;
2513                 /* for 'present request out of range',
2514                    set addinfo to record position if not set */
2515                 if (freq.errcode == YAZ_BIB1_PRESENT_REQUEST_OUT_OF_RANGE  &&
2516                                 freq.errstring == 0)
2517                 {
2518                     sprintf(s, "%d", recno);
2519                     freq.errstring = s;
2520                 }
2521                 if (errcode)
2522                     *errcode = freq.errcode;
2523                 return diagrec(a, freq.errcode, freq.errstring);
2524             }
2525             reclist->records[reclist->num_records] =
2526                 surrogatediagrec(a, freq.basename, freq.errcode,
2527                                  freq.errstring);
2528             reclist->num_records++;
2529             continue;
2530         }
2531         if (freq.record == 0)  /* no error and no record ? */
2532         {
2533             *pres = Z_PresentStatus_partial_4;
2534             *next = 0;   /* signal end-of-set and stop */
2535             break;
2536         }
2537         if (freq.len >= 0)
2538             this_length = freq.len;
2539         else
2540             this_length = odr_total(a->encode) - total_length - dumped_records;
2541         yaz_log(YLOG_DEBUG, "  fetched record, len=%d, total=%d dumped=%d",
2542             this_length, total_length, dumped_records);
2543         if (a->preferredMessageSize > 0 &&
2544                 this_length + total_length > a->preferredMessageSize)
2545         {
2546             /* record is small enough, really */
2547             if (this_length <= a->preferredMessageSize && recno > start)
2548             {
2549                 yaz_log(log_requestdetail, "  Dropped last normal-sized record");
2550                 *pres = Z_PresentStatus_partial_2;
2551                 if (*next > 0)
2552                     (*next)--;
2553                 break;
2554             }
2555             /* record can only be fetched by itself */
2556             if (this_length < a->maximumRecordSize)
2557             {
2558                 yaz_log(log_requestdetail, "  Record > prefmsgsz");
2559                 if (toget > 1)
2560                 {
2561                     yaz_log(YLOG_DEBUG, "  Dropped it");
2562                     reclist->records[reclist->num_records] =
2563                          surrogatediagrec(
2564                              a, freq.basename,
2565                              YAZ_BIB1_RECORD_EXCEEDS_PREFERRED_MESSAGE_SIZE, 0);
2566                     reclist->num_records++;
2567                     dumped_records += this_length;
2568                     continue;
2569                 }
2570             }
2571             else /* too big entirely */
2572             {
2573                 yaz_log(log_requestdetail, "Record > maxrcdsz "
2574                         "this=%d max=%d",
2575                         this_length, a->maximumRecordSize);
2576                 reclist->records[reclist->num_records] =
2577                     surrogatediagrec(
2578                         a, freq.basename,
2579                         YAZ_BIB1_RECORD_EXCEEDS_MAXIMUM_RECORD_SIZE, 0);
2580                 reclist->num_records++;
2581                 dumped_records += this_length;
2582                 continue;
2583             }
2584         }
2585
2586         if (!(thisrec = (Z_NamePlusRecord *)
2587               odr_malloc(a->encode, sizeof(*thisrec))))
2588             return 0;
2589         thisrec->databaseName = odr_strdup_null(a->encode, freq.basename);
2590         thisrec->which = Z_NamePlusRecord_databaseRecord;
2591
2592         if (!freq.output_format)
2593         {
2594             yaz_log(YLOG_WARN, "bend_fetch output_format not set");
2595             return 0;
2596         }
2597         thisrec->u.databaseRecord = z_ext_record_oid(
2598             a->encode, freq.output_format, freq.record, freq.len);
2599         if (!thisrec->u.databaseRecord)
2600             return 0;
2601         reclist->records[reclist->num_records] = thisrec;
2602         reclist->num_records++;
2603         if (freq.last_in_set)
2604             break;
2605     }
2606     *num = reclist->num_records;
2607     return records;
2608 }
2609
2610 static Z_APDU *process_searchRequest(association *assoc, request *reqb)
2611 {
2612     Z_SearchRequest *req = reqb->apdu_request->u.searchRequest;
2613     bend_search_rr *bsrr =
2614         (bend_search_rr *)nmem_malloc(reqb->request_mem, sizeof(*bsrr));
2615
2616     yaz_log(log_requestdetail, "Got SearchRequest.");
2617     bsrr->association = assoc;
2618     bsrr->referenceId = req->referenceId;
2619     bsrr->srw_sortKeys = 0;
2620     bsrr->srw_setname = 0;
2621     bsrr->srw_setnameIdleTime = 0;
2622     bsrr->estimated_hit_count = 0;
2623     bsrr->partial_resultset = 0;
2624     bsrr->extra_args = 0;
2625     bsrr->extra_response_data = 0;
2626
2627     yaz_log(log_requestdetail, "ResultSet '%s'", req->resultSetName);
2628     if (req->databaseNames)
2629     {
2630         int i;
2631         for (i = 0; i < req->num_databaseNames; i++)
2632             yaz_log(log_requestdetail, "Database '%s'", req->databaseNames[i]);
2633     }
2634
2635     yaz_log_zquery_level(log_requestdetail,req->query);
2636
2637     if (assoc->init->bend_search)
2638     {
2639         bsrr->setname = req->resultSetName;
2640         bsrr->replace_set = *req->replaceIndicator;
2641         bsrr->num_bases = req->num_databaseNames;
2642         bsrr->basenames = req->databaseNames;
2643         bsrr->query = req->query;
2644         bsrr->stream = assoc->encode;
2645         nmem_transfer(odr_getmem(bsrr->stream), reqb->request_mem);
2646         bsrr->decode = assoc->decode;
2647         bsrr->print = assoc->print;
2648         bsrr->hits = 0;
2649         bsrr->errcode = 0;
2650         bsrr->errstring = NULL;
2651         bsrr->search_info = NULL;
2652         bsrr->search_input = req->otherInfo;
2653
2654         if (assoc->server && assoc->server->cql_transform
2655             && req->query->which == Z_Query_type_104
2656             && req->query->u.type_104->which == Z_External_CQL)
2657         {
2658             /* have a CQL query and a CQL to PQF transform .. */
2659             int srw_errcode =
2660                 cql2pqf(bsrr->stream, req->query->u.type_104->u.cql,
2661                         assoc->server->cql_transform, bsrr->query,
2662                         &bsrr->srw_sortKeys);
2663             if (srw_errcode)
2664                 bsrr->errcode = yaz_diag_srw_to_bib1(srw_errcode);
2665         }
2666
2667         if (assoc->server && assoc->server->ccl_transform
2668             && req->query->which == Z_Query_type_2) /*CCL*/
2669         {
2670             /* have a CCL query and a CCL to PQF transform .. */
2671             int srw_errcode =
2672                 ccl2pqf(bsrr->stream, req->query->u.type_2,
2673                         assoc->server->ccl_transform, bsrr);
2674             if (srw_errcode)
2675                 bsrr->errcode = yaz_diag_srw_to_bib1(srw_errcode);
2676         }
2677
2678         if (!bsrr->errcode)
2679             (assoc->init->bend_search)(assoc->backend, bsrr);
2680     }
2681     else
2682     {
2683         /* FIXME - make a diagnostic for it */
2684         yaz_log(YLOG_WARN,"Search not supported ?!?!");
2685     }
2686     return response_searchRequest(assoc, reqb, bsrr);
2687 }
2688
2689 /*
2690  * Prepare a searchresponse based on the backend results. We probably want
2691  * to look at making the fetching of records nonblocking as well, but
2692  * so far, we'll keep things simple.
2693  * If bsrt is null, that means we're called in response to a communications
2694  * event, and we'll have to get the response for ourselves.
2695  */
2696 static Z_APDU *response_searchRequest(association *assoc, request *reqb,
2697                                       bend_search_rr *bsrt)
2698 {
2699     Z_SearchRequest *req = reqb->apdu_request->u.searchRequest;
2700     Z_APDU *apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
2701     Z_SearchResponse *resp = (Z_SearchResponse *)
2702         odr_malloc(assoc->encode, sizeof(*resp));
2703     Odr_int *nulint = odr_intdup(assoc->encode, 0);
2704     Odr_int *next = odr_intdup(assoc->encode, 0);
2705     Odr_int *none = odr_intdup(assoc->encode, Z_SearchResponse_none);
2706     Odr_int returnedrecs = 0;
2707
2708     apdu->which = Z_APDU_searchResponse;
2709     apdu->u.searchResponse = resp;
2710     resp->referenceId = req->referenceId;
2711     resp->additionalSearchInfo = 0;
2712     resp->otherInfo = 0;
2713     if (!bsrt)
2714     {
2715         yaz_log(YLOG_FATAL, "Bad result from backend");
2716         return 0;
2717     }
2718     else if (bsrt->errcode)
2719     {
2720         resp->records = diagrec(assoc, bsrt->errcode, bsrt->errstring);
2721         resp->resultCount = nulint;
2722         resp->numberOfRecordsReturned = nulint;
2723         resp->nextResultSetPosition = nulint;
2724         resp->searchStatus = odr_booldup(assoc->encode, 0);
2725         resp->resultSetStatus = none;
2726         resp->presentStatus = 0;
2727     }
2728     else
2729     {
2730         bool_t *sr = odr_booldup(assoc->encode, 1);
2731         Odr_int *toget = odr_intdup(assoc->encode, 0);
2732         Z_RecordComposition comp, *compp = 0;
2733
2734         yaz_log(log_requestdetail, "resultCount: " ODR_INT_PRINTF, bsrt->hits);
2735
2736         resp->records = 0;
2737         resp->resultCount = &bsrt->hits;
2738
2739         comp.which = Z_RecordComp_simple;
2740         /* how many records does the user agent want, then? */
2741         if (bsrt->hits < 0)
2742             *toget = 0;
2743         else if (bsrt->hits <= *req->smallSetUpperBound)
2744         {
2745             *toget = bsrt->hits;
2746             if ((comp.u.simple = req->smallSetElementSetNames))
2747                 compp = &comp;
2748         }
2749         else if (bsrt->hits < *req->largeSetLowerBound)
2750         {
2751             *toget = *req->mediumSetPresentNumber;
2752             if (*toget > bsrt->hits)
2753                 *toget = bsrt->hits;
2754             if ((comp.u.simple = req->mediumSetElementSetNames))
2755                 compp = &comp;
2756         }
2757         else
2758             *toget = 0;
2759
2760         if (*toget && !resp->records)
2761         {
2762             Odr_int *presst = odr_intdup(assoc->encode, 0);
2763             /* Call bend_present if defined */
2764             if (assoc->init->bend_present)
2765             {
2766                 bend_present_rr *bprr = (bend_present_rr *)
2767                     nmem_malloc(reqb->request_mem, sizeof(*bprr));
2768                 bprr->setname = req->resultSetName;
2769                 bprr->start = 1;
2770                 bprr->number = odr_int_to_int(*toget);
2771                 bprr->format = req->preferredRecordSyntax;
2772                 bprr->comp = compp;
2773                 bprr->referenceId = req->referenceId;
2774                 bprr->stream = assoc->encode;
2775                 bprr->print = assoc->print;
2776                 bprr->association = assoc;
2777                 bprr->errcode = 0;
2778                 bprr->errstring = NULL;
2779                 (*assoc->init->bend_present)(assoc->backend, bprr);
2780
2781                 if (bprr->errcode)
2782                 {
2783                     resp->records = diagrec(assoc, bprr->errcode, bprr->errstring);
2784                     *resp->presentStatus = Z_PresentStatus_failure;
2785                 }
2786             }
2787
2788             if (!resp->records)
2789                 resp->records = pack_records(
2790                     assoc, req->resultSetName, 1,
2791                     toget, compp, next, presst, req->referenceId,
2792                     req->preferredRecordSyntax, NULL);
2793             if (!resp->records)
2794                 return 0;
2795             resp->numberOfRecordsReturned = toget;
2796             returnedrecs = *toget;
2797             resp->presentStatus = presst;
2798         }
2799         else
2800         {
2801             if (*resp->resultCount)
2802                 *next = 1;
2803             resp->numberOfRecordsReturned = nulint;
2804             resp->presentStatus = 0;
2805         }
2806         resp->nextResultSetPosition = next;
2807         resp->searchStatus = sr;
2808         resp->resultSetStatus = 0;
2809         if (bsrt->estimated_hit_count)
2810         {
2811             resp->resultSetStatus = odr_intdup(assoc->encode,
2812                                                Z_SearchResponse_estimate);
2813         }
2814         else if (bsrt->partial_resultset)
2815         {
2816             resp->resultSetStatus = odr_intdup(assoc->encode,
2817                                                Z_SearchResponse_subset);
2818         }
2819     }
2820     resp->additionalSearchInfo = bsrt->search_info;
2821
2822     if (log_request)
2823     {
2824         int i;
2825         WRBUF wr = wrbuf_alloc();
2826
2827         for (i = 0 ; i < req->num_databaseNames; i++)
2828         {
2829             if (i)
2830                 wrbuf_printf(wr, "+");
2831             wrbuf_puts(wr, req->databaseNames[i]);
2832         }
2833         wrbuf_printf(wr, " ");
2834
2835         if (bsrt->errcode)
2836             wrbuf_printf(wr, "ERROR %d", bsrt->errcode);
2837         else
2838             wrbuf_printf(wr, "OK " ODR_INT_PRINTF, bsrt->hits);
2839         wrbuf_printf(wr, " %s 1+" ODR_INT_PRINTF " ",
2840                      req->resultSetName, returnedrecs);
2841         yaz_query_to_wrbuf(wr, req->query);
2842
2843         yaz_log(log_request, "Search %s", wrbuf_cstr(wr));
2844         wrbuf_destroy(wr);
2845     }
2846     return apdu;
2847 }
2848
2849 /*
2850  * Maybe we got a little over-friendly when we designed bend_fetch to
2851  * get only one record at a time. Some backends can optimise multiple-record
2852  * fetches, and at any rate, there is some overhead involved in
2853  * all that selecting and hopping around. Problem is, of course, that the
2854  * frontend can't know ahead of time how many records it'll need to
2855  * fill the negotiated PDU size. Annoying. Segmentation or not, Z/SR
2856  * is downright lousy as a bulk data transfer protocol.
2857  *
2858  * To start with, we'll do the fetching of records from the backend
2859  * in one operation: To save some trips in and out of the event-handler,
2860  * and to simplify the interface to pack_records. At any rate, asynch
2861  * operation is more fun in operations that have an unpredictable execution
2862  * speed - which is normally more true for search than for present.
2863  */
2864 static Z_APDU *process_presentRequest(association *assoc, request *reqb)
2865 {
2866     Z_PresentRequest *req = reqb->apdu_request->u.presentRequest;
2867     Z_APDU *apdu;
2868     Z_PresentResponse *resp;
2869     Odr_int *next;
2870     Odr_int *num;
2871     int errcode = 0;
2872
2873     yaz_log(log_requestdetail, "Got PresentRequest.");
2874
2875     resp = (Z_PresentResponse *)odr_malloc(assoc->encode, sizeof(*resp));
2876     resp->records = 0;
2877     resp->presentStatus = odr_intdup(assoc->encode, 0);
2878     if (assoc->init->bend_present)
2879     {
2880         bend_present_rr *bprr = (bend_present_rr *)
2881             nmem_malloc(reqb->request_mem, sizeof(*bprr));
2882         bprr->setname = req->resultSetId;
2883         bprr->start = odr_int_to_int(*req->resultSetStartPoint);
2884         bprr->number = odr_int_to_int(*req->numberOfRecordsRequested);
2885         bprr->format = req->preferredRecordSyntax;
2886         bprr->comp = req->recordComposition;
2887         bprr->referenceId = req->referenceId;
2888         bprr->stream = assoc->encode;
2889         bprr->print = assoc->print;
2890         bprr->association = assoc;
2891         bprr->errcode = 0;
2892         bprr->errstring = NULL;
2893         (*assoc->init->bend_present)(assoc->backend, bprr);
2894
2895         if (bprr->errcode)
2896         {
2897             resp->records = diagrec(assoc, bprr->errcode, bprr->errstring);
2898             *resp->presentStatus = Z_PresentStatus_failure;
2899             errcode = bprr->errcode;
2900         }
2901     }
2902     apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
2903     next = odr_intdup(assoc->encode, 0);
2904     num = odr_intdup(assoc->encode, 0);
2905
2906     apdu->which = Z_APDU_presentResponse;
2907     apdu->u.presentResponse = resp;
2908     resp->referenceId = req->referenceId;
2909     resp->otherInfo = 0;
2910
2911     if (!resp->records)
2912     {
2913         *num = *req->numberOfRecordsRequested;
2914         resp->records =
2915             pack_records(assoc, req->resultSetId, *req->resultSetStartPoint,
2916                          num, req->recordComposition, next,
2917                          resp->presentStatus,
2918                          req->referenceId, req->preferredRecordSyntax,
2919                          &errcode);
2920     }
2921     if (log_request)
2922     {
2923         WRBUF wr = wrbuf_alloc();
2924         wrbuf_printf(wr, "Present ");
2925
2926         if (*resp->presentStatus == Z_PresentStatus_failure)
2927             wrbuf_printf(wr, "ERROR %d ", errcode);
2928         else if (*resp->presentStatus == Z_PresentStatus_success)
2929             wrbuf_printf(wr, "OK -  ");
2930         else
2931             wrbuf_printf(wr, "Partial " ODR_INT_PRINTF " - ",
2932                          *resp->presentStatus);
2933
2934         wrbuf_printf(wr, " %s " ODR_INT_PRINTF "+" ODR_INT_PRINTF " ",
2935                 req->resultSetId, *req->resultSetStartPoint,
2936                 *req->numberOfRecordsRequested);
2937         yaz_log(log_request, "%s", wrbuf_cstr(wr) );
2938         wrbuf_destroy(wr);
2939     }
2940     if (!resp->records)
2941         return 0;
2942     resp->numberOfRecordsReturned = num;
2943     resp->nextResultSetPosition = next;
2944
2945     return apdu;
2946 }
2947
2948 /*
2949  * Scan was implemented rather in a hurry, and with support for only the basic
2950  * elements of the service in the backend API. Suggestions are welcome.
2951  */
2952 static Z_APDU *process_scanRequest(association *assoc, request *reqb)
2953 {
2954     Z_ScanRequest *req = reqb->apdu_request->u.scanRequest;
2955     Z_APDU *apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
2956     Z_ScanResponse *res = (Z_ScanResponse *)
2957         odr_malloc(assoc->encode, sizeof(*res));
2958     Odr_int *scanStatus = odr_intdup(assoc->encode, Z_Scan_failure);
2959     Odr_int *numberOfEntriesReturned = odr_intdup(assoc->encode, 0);
2960     Z_ListEntries *ents = (Z_ListEntries *)
2961         odr_malloc(assoc->encode, sizeof(*ents));
2962     Z_DiagRecs *diagrecs_p = NULL;
2963     bend_scan_rr *bsrr = (bend_scan_rr *)
2964         odr_malloc(assoc->encode, sizeof(*bsrr));
2965     struct scan_entry *save_entries;
2966     int step_size = 0;
2967
2968     yaz_log(log_requestdetail, "Got ScanRequest");
2969
2970     apdu->which = Z_APDU_scanResponse;
2971     apdu->u.scanResponse = res;
2972     res->referenceId = req->referenceId;
2973
2974     /* if step is absent, set it to 0 */
2975     if (req->stepSize)
2976         step_size = odr_int_to_int(*req->stepSize);
2977
2978     res->stepSize = 0;
2979     res->scanStatus = scanStatus;
2980     res->numberOfEntriesReturned = numberOfEntriesReturned;
2981     res->positionOfTerm = 0;
2982     res->entries = ents;
2983     ents->num_entries = 0;
2984     ents->entries = NULL;
2985     ents->num_nonsurrogateDiagnostics = 0;
2986     ents->nonsurrogateDiagnostics = NULL;
2987     res->attributeSet = 0;
2988     res->otherInfo = 0;
2989
2990     if (req->databaseNames)
2991     {
2992         int i;
2993         for (i = 0; i < req->num_databaseNames; i++)
2994             yaz_log(log_requestdetail, "Database '%s'", req->databaseNames[i]);
2995     }
2996     bsrr->scanClause = 0;
2997     bsrr->errcode = 0;
2998     bsrr->errstring = 0;
2999     bsrr->num_bases = req->num_databaseNames;
3000     bsrr->basenames = req->databaseNames;
3001     bsrr->num_entries = odr_int_to_int(*req->numberOfTermsRequested);
3002     bsrr->term = req->termListAndStartPoint;
3003     bsrr->referenceId = req->referenceId;
3004     bsrr->stream = assoc->encode;
3005     bsrr->print = assoc->print;
3006     bsrr->step_size = &step_size;
3007     bsrr->setname = yaz_oi_get_string_oid(&req->otherInfo,
3008                                           yaz_oid_userinfo_scan_set, 1, 0);
3009     bsrr->entries = 0;
3010     /* For YAZ 2.0 and earlier it was the backend handler that
3011        initialized entries (member display_term did not exist)
3012        YAZ 2.0 and later sets 'entries'  and initialize all members
3013        including 'display_term'. If YAZ 2.0 or later sees that
3014        entries was modified - we assume that it is an old handler and
3015        that 'display_term' is _not_ set.
3016     */
3017     if (bsrr->num_entries > 0)
3018     {
3019         int i;
3020         bsrr->entries = (struct scan_entry *)
3021             odr_malloc(assoc->decode, sizeof(*bsrr->entries) *
3022                        bsrr->num_entries);
3023         for (i = 0; i<bsrr->num_entries; i++)
3024         {
3025             bsrr->entries[i].term = 0;
3026             bsrr->entries[i].occurrences = 0;
3027             bsrr->entries[i].errcode = 0;
3028             bsrr->entries[i].errstring = 0;
3029             bsrr->entries[i].display_term = 0;
3030         }
3031     }
3032     save_entries = bsrr->entries;  /* save it so we can compare later */
3033
3034     bsrr->attributeset = req->attributeSet;
3035     log_scan_term_level(log_requestdetail, req->termListAndStartPoint,
3036                         bsrr->attributeset);
3037     bsrr->term_position = req->preferredPositionInResponse ?
3038         odr_int_to_int(*req->preferredPositionInResponse) : 1;
3039
3040     ((int (*)(void *, bend_scan_rr *))
3041      (*assoc->init->bend_scan))(assoc->backend, bsrr);
3042
3043     if (bsrr->errcode)
3044         diagrecs_p = zget_DiagRecs(assoc->encode,
3045                                    bsrr->errcode, bsrr->errstring);
3046     else
3047     {
3048         int i;
3049         Z_Entry **tab = (Z_Entry **)
3050             odr_malloc(assoc->encode, sizeof(*tab) * bsrr->num_entries);
3051
3052         if (bsrr->status == BEND_SCAN_PARTIAL)
3053             *scanStatus = Z_Scan_partial_5;
3054         else
3055             *scanStatus = Z_Scan_success;
3056         res->stepSize = odr_intdup(assoc->encode, step_size);
3057         ents->entries = tab;
3058         ents->num_entries = bsrr->num_entries;
3059         res->numberOfEntriesReturned = odr_intdup(assoc->encode,
3060                                                    ents->num_entries);
3061         res->positionOfTerm = odr_intdup(assoc->encode, bsrr->term_position);
3062         for (i = 0; i < bsrr->num_entries; i++)
3063         {
3064             Z_Entry *e;
3065             Z_TermInfo *t;
3066             Odr_oct *o;
3067
3068             tab[i] = e = (Z_Entry *)odr_malloc(assoc->encode, sizeof(*e));
3069             if (bsrr->entries[i].occurrences >= 0)
3070             {
3071                 e->which = Z_Entry_termInfo;
3072                 e->u.termInfo = t = (Z_TermInfo *)
3073                     odr_malloc(assoc->encode, sizeof(*t));
3074                 t->suggestedAttributes = 0;
3075                 t->displayTerm = 0;
3076                 if (save_entries == bsrr->entries &&
3077                     bsrr->entries[i].display_term)
3078                 {
3079                     /* the entries was _not_ set by the handler. So it's
3080                        safe to test for new member display_term. It is
3081                        NULL'ed by us.
3082                     */
3083                     t->displayTerm = odr_strdup(assoc->encode,
3084                                                 bsrr->entries[i].display_term);
3085                 }
3086                 t->alternativeTerm = 0;
3087                 t->byAttributes = 0;
3088                 t->otherTermInfo = 0;
3089                 t->globalOccurrences = &bsrr->entries[i].occurrences;
3090                 t->term = (Z_Term *)
3091                     odr_malloc(assoc->encode, sizeof(*t->term));
3092                 t->term->which = Z_Term_general;
3093                 t->term->u.general = o =
3094                     (Odr_oct *)odr_malloc(assoc->encode, sizeof(Odr_oct));
3095                 o->buf = (unsigned char *)
3096                     odr_malloc(assoc->encode, o->len = o->size =
3097                                strlen(bsrr->entries[i].term));
3098                 memcpy(o->buf, bsrr->entries[i].term, o->len);
3099                 yaz_log(YLOG_DEBUG, "  term #%d: '%s' (" ODR_INT_PRINTF ")", i,
3100                          bsrr->entries[i].term, bsrr->entries[i].occurrences);
3101             }
3102             else
3103             {
3104                 Z_DiagRecs *drecs = zget_DiagRecs(assoc->encode,
3105                                                   bsrr->entries[i].errcode,
3106                                                   bsrr->entries[i].errstring);
3107                 assert(drecs->num_diagRecs == 1);
3108                 e->which = Z_Entry_surrogateDiagnostic;
3109                 assert(drecs->diagRecs[0]);
3110                 e->u.surrogateDiagnostic = drecs->diagRecs[0];
3111             }
3112         }
3113     }
3114     if (diagrecs_p)
3115     {
3116         ents->num_nonsurrogateDiagnostics = diagrecs_p->num_diagRecs;
3117         ents->nonsurrogateDiagnostics = diagrecs_p->diagRecs;
3118     }
3119     if (log_request)
3120     {
3121         int i;
3122         WRBUF wr = wrbuf_alloc();
3123         wrbuf_printf(wr, "Scan ");
3124         for (i = 0 ; i < req->num_databaseNames; i++)
3125         {
3126             if (i)
3127                 wrbuf_printf(wr, "+");
3128             wrbuf_puts(wr, req->databaseNames[i]);
3129         }
3130
3131         wrbuf_printf(wr, " ");
3132
3133         if (bsrr->errcode)
3134             wr_diag(wr, bsrr->errcode, bsrr->errstring);
3135         else
3136             wrbuf_printf(wr, "OK");
3137
3138         wrbuf_printf(wr, " " ODR_INT_PRINTF " - " ODR_INT_PRINTF "+"
3139                      ODR_INT_PRINTF "+" ODR_INT_PRINTF,
3140                      res->numberOfEntriesReturned ?
3141                      *res->numberOfEntriesReturned : 0,
3142                      (req->preferredPositionInResponse ?
3143                       *req->preferredPositionInResponse : 1),
3144                      *req->numberOfTermsRequested,
3145                      (res->stepSize ? *res->stepSize : 1));
3146
3147         if (bsrr->setname)
3148             wrbuf_printf(wr, "+%s", bsrr->setname);
3149
3150         wrbuf_printf(wr, " ");
3151         yaz_scan_to_wrbuf(wr, req->termListAndStartPoint,
3152                           bsrr->attributeset);
3153         yaz_log(log_request, "%s", wrbuf_cstr(wr) );
3154         wrbuf_destroy(wr);
3155     }
3156     return apdu;
3157 }
3158
3159 static Z_APDU *process_sortRequest(association *assoc, request *reqb)
3160 {
3161     int i;
3162     Z_SortRequest *req = reqb->apdu_request->u.sortRequest;
3163     Z_SortResponse *res = (Z_SortResponse *)
3164         odr_malloc(assoc->encode, sizeof(*res));
3165     bend_sort_rr *bsrr = (bend_sort_rr *)
3166         odr_malloc(assoc->encode, sizeof(*bsrr));
3167
3168     Z_APDU *apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
3169
3170     yaz_log(log_requestdetail, "Got SortRequest.");
3171
3172     bsrr->num_input_setnames = req->num_inputResultSetNames;
3173     for (i=0;i<req->num_inputResultSetNames;i++)
3174         yaz_log(log_requestdetail, "Input resultset: '%s'",
3175                 req->inputResultSetNames[i]);
3176     bsrr->input_setnames = req->inputResultSetNames;
3177     bsrr->referenceId = req->referenceId;
3178     bsrr->output_setname = req->sortedResultSetName;
3179     yaz_log(log_requestdetail, "Output resultset: '%s'",
3180                 req->sortedResultSetName);
3181     bsrr->sort_sequence = req->sortSequence;
3182        /*FIXME - dump those sequences too */
3183     bsrr->stream = assoc->encode;
3184     bsrr->print = assoc->print;
3185
3186     bsrr->sort_status = Z_SortResponse_failure;
3187     bsrr->errcode = 0;
3188     bsrr->errstring = 0;
3189
3190     (*assoc->init->bend_sort)(assoc->backend, bsrr);
3191
3192     res->referenceId = bsrr->referenceId;
3193     res->sortStatus = odr_intdup(assoc->encode, bsrr->sort_status);
3194     res->resultSetStatus = 0;
3195     if (bsrr->errcode)
3196     {
3197         Z_DiagRecs *dr = zget_DiagRecs(assoc->encode,
3198                                        bsrr->errcode, bsrr->errstring);
3199         res->diagnostics = dr->diagRecs;
3200         res->num_diagnostics = dr->num_diagRecs;
3201     }
3202     else
3203     {
3204         res->num_diagnostics = 0;
3205         res->diagnostics = 0;
3206     }
3207     res->resultCount = 0;
3208     res->otherInfo = 0;
3209
3210     apdu->which = Z_APDU_sortResponse;
3211     apdu->u.sortResponse = res;
3212     if (log_request)
3213     {
3214         WRBUF wr = wrbuf_alloc();
3215         wrbuf_printf(wr, "Sort ");
3216         if (bsrr->errcode)
3217             wrbuf_printf(wr, " ERROR %d", bsrr->errcode);
3218         else
3219             wrbuf_printf(wr,  "OK -");
3220         wrbuf_printf(wr, " (");
3221         for (i = 0; i<req->num_inputResultSetNames; i++)
3222         {
3223             if (i)
3224                 wrbuf_printf(wr, "+");
3225             wrbuf_puts(wr, req->inputResultSetNames[i]);
3226         }
3227         wrbuf_printf(wr, ")->%s ",req->sortedResultSetName);
3228
3229         yaz_log(log_request, "%s", wrbuf_cstr(wr) );
3230         wrbuf_destroy(wr);
3231     }
3232     return apdu;
3233 }
3234
3235 static Z_APDU *process_deleteRequest(association *assoc, request *reqb)
3236 {
3237     int i;
3238     Z_DeleteResultSetRequest *req =
3239         reqb->apdu_request->u.deleteResultSetRequest;
3240     Z_DeleteResultSetResponse *res = (Z_DeleteResultSetResponse *)
3241         odr_malloc(assoc->encode, sizeof(*res));
3242     bend_delete_rr *bdrr = (bend_delete_rr *)
3243         odr_malloc(assoc->encode, sizeof(*bdrr));
3244     Z_APDU *apdu = (Z_APDU *)odr_malloc(assoc->encode, sizeof(*apdu));
3245
3246     yaz_log(log_requestdetail, "Got DeleteRequest.");
3247
3248     bdrr->num_setnames = req->num_resultSetList;
3249     bdrr->setnames = req->resultSetList;
3250     for (i = 0; i<req->num_resultSetList; i++)
3251         yaz_log(log_requestdetail, "resultset: '%s'",
3252                 req->resultSetList[i]);
3253     bdrr->stream = assoc->encode;
3254     bdrr->print = assoc->print;
3255     bdrr->function = odr_int_to_int(*req->deleteFunction);
3256     bdrr->referenceId = req->referenceId;
3257     bdrr->statuses = 0;
3258     if (bdrr->num_setnames > 0)
3259     {
3260         bdrr->statuses = (int*)
3261             odr_malloc(assoc->encode, sizeof(*bdrr->statuses) *
3262                        bdrr->num_setnames);
3263         for (i = 0; i < bdrr->num_setnames; i++)
3264             bdrr->statuses[i] = 0;
3265     }
3266     (*assoc->init->bend_delete)(assoc->backend, bdrr);
3267
3268     res->referenceId = req->referenceId;
3269
3270     res->deleteOperationStatus = odr_intdup(assoc->encode,bdrr->delete_status);
3271
3272     res->deleteListStatuses = 0;
3273     if (bdrr->num_setnames > 0)
3274     {
3275         int i;
3276         res->deleteListStatuses = (Z_ListStatuses *)
3277             odr_malloc(assoc->encode, sizeof(*res->deleteListStatuses));
3278         res->deleteListStatuses->num = bdrr->num_setnames;
3279         res->deleteListStatuses->elements =
3280             (Z_ListStatus **)
3281             odr_malloc(assoc->encode,
3282                         sizeof(*res->deleteListStatuses->elements) *
3283                         bdrr->num_setnames);
3284         for (i = 0; i<bdrr->num_setnames; i++)
3285         {
3286             res->deleteListStatuses->elements[i] =
3287                 (Z_ListStatus *)
3288                 odr_malloc(assoc->encode,
3289                             sizeof(**res->deleteListStatuses->elements));
3290             res->deleteListStatuses->elements[i]->status =
3291                 odr_intdup(assoc->encode, bdrr->statuses[i]);
3292             res->deleteListStatuses->elements[i]->id =
3293                 odr_strdup(assoc->encode, bdrr->setnames[i]);
3294         }
3295     }
3296     res->numberNotDeleted = 0;
3297     res->bulkStatuses = 0;
3298     res->deleteMessage = 0;
3299     res->otherInfo = 0;
3300
3301     apdu->which = Z_APDU_deleteResultSetResponse;
3302     apdu->u.deleteResultSetResponse = res;
3303     if (log_request)
3304     {
3305         WRBUF wr = wrbuf_alloc();
3306         wrbuf_printf(wr, "Delete ");
3307         if (bdrr->delete_status)
3308             wrbuf_printf(wr, "ERROR %d", bdrr->delete_status);
3309         else
3310             wrbuf_printf(wr, "OK -");
3311         for (i = 0; i<req->num_resultSetList; i++)
3312             wrbuf_printf(wr, " %s ", req->resultSetList[i]);
3313         yaz_log(log_request, "%s", wrbuf_cstr(wr) );
3314         wrbuf_destroy(wr);
3315     }
3316     return apdu;
3317 }
3318
3319 static void process_close(association *assoc, request *reqb)
3320 {
3321     Z_Close *req = reqb->apdu_request->u.close;
3322     static char *reasons[] =
3323     {
3324         "finished",
3325         "shutdown",
3326         "systemProblem",
3327         "costLimit",
3328         "resources",
3329         "securityViolation",
3330         "protocolError",
3331         "lackOfActivity",
3332         "peerAbort",
3333         "unspecified"
3334     };
3335
3336     yaz_log(log_requestdetail, "Got Close, reason %s, message %s",
3337         reasons[*req->closeReason], req->diagnosticInformation ?
3338         req->diagnosticInformation : "NULL");
3339     if (assoc->version < 3) /* to make do_force respond with close */
3340         assoc->version = 3;
3341     do_close_req(assoc, Z_Close_finished,
3342                  "Association terminated by client", reqb);
3343     yaz_log(log_request,"Close OK");
3344 }
3345
3346 static Z_APDU *process_segmentRequest(association *assoc, request *reqb)
3347 {
3348     bend_segment_rr req;
3349
3350     req.segment = reqb->apdu_request->u.segmentRequest;
3351     req.stream = assoc->encode;
3352     req.decode = assoc->decode;
3353     req.print = assoc->print;
3354     req.association = assoc;
3355
3356     (*assoc->init->bend_segment)(assoc->backend, &req);
3357
3358     return 0;
3359 }
3360
3361 static Z_APDU *process_ESRequest(association *assoc, request *reqb)
3362 {
3363     bend_esrequest_rr esrequest;
3364     const char *ext_name = "unknown";
3365
3366     Z_ExtendedServicesRequest *req =
3367         reqb->apdu_request->u.extendedServicesRequest;
3368     Z_APDU *apdu = zget_APDU(assoc->encode, Z_APDU_extendedServicesResponse);
3369
3370     Z_ExtendedServicesResponse *resp = apdu->u.extendedServicesResponse;
3371
3372     esrequest.esr = reqb->apdu_request->u.extendedServicesRequest;
3373     esrequest.stream = assoc->encode;
3374     esrequest.decode = assoc->decode;
3375     esrequest.print = assoc->print;
3376     esrequest.errcode = 0;
3377     esrequest.errstring = NULL;
3378     esrequest.association = assoc;
3379     esrequest.taskPackage = 0;
3380     esrequest.referenceId = req->referenceId;
3381
3382     if (esrequest.esr && esrequest.esr->taskSpecificParameters)
3383     {
3384         switch(esrequest.esr->taskSpecificParameters->which)
3385         {
3386         case Z_External_itemOrder:
3387             ext_name = "ItemOrder"; break;
3388         case Z_External_update:
3389             ext_name = "Update"; break;
3390         case Z_External_update0:
3391             ext_name = "Update0"; break;
3392         case Z_External_ESAdmin:
3393             ext_name = "Admin"; break;
3394
3395         }
3396     }
3397
3398     (*assoc->init->bend_esrequest)(assoc->backend, &esrequest);
3399
3400     resp->referenceId = req->referenceId;
3401
3402     if (esrequest.errcode == -1)
3403     {
3404         /* Backend service indicates request will be processed */
3405         yaz_log(log_request, "Extended Service: %s (accepted)", ext_name);
3406         *resp->operationStatus = Z_ExtendedServicesResponse_accepted;
3407     }
3408     else if (esrequest.errcode == 0)
3409     {
3410         /* Backend service indicates request will be processed */
3411         yaz_log(log_request, "Extended Service: %s (done)", ext_name);
3412         *resp->operationStatus = Z_ExtendedServicesResponse_done;
3413     }
3414     else
3415     {
3416         Z_DiagRecs *diagRecs =
3417             zget_DiagRecs(assoc->encode, esrequest.errcode,
3418                           esrequest.errstring);
3419         /* Backend indicates error, request will not be processed */
3420         yaz_log(log_request, "Extended Service: %s (failed)", ext_name);