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