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