1 /* -*- mode: c; c-basic-offset: 8; indent-tabs-mode: nil; -*-
2 * vim:expandtab:shiftwidth=8:tabstop=8:
4 * Copyright (C) 2002 Cluster File Systems, Inc.
6 * This file is part of the Lustre file system, http://www.lustre.org
7 * Lustre is a trademark of Cluster File Systems, Inc.
9 * You may have signed or agreed to another license before downloading
10 * this software. If so, you are bound by the terms and conditions
11 * of that agreement, and the following does not apply to you. See the
12 * LICENSE file included with this distribution for more information.
14 * If you did not agree to a different license, then this copy of Lustre
15 * is open source software; you can redistribute it and/or modify it
16 * under the terms of version 2 of the GNU General Public License as
17 * published by the Free Software Foundation.
19 * In either case, Lustre is distributed in the hope that it will be
20 * useful, but WITHOUT ANY WARRANTY; without even the implied warranty
21 * of MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
22 * license text for more details.
26 #define DEBUG_SUBSYSTEM S_RPC
28 #include <liblustre.h>
29 #include <libcfs/kp30.h>
31 #include <obd_support.h>
32 #include <obd_class.h>
33 #include <lustre_net.h>
34 #include <lu_object.h>
35 #include <lnet/types.h>
36 #include "ptlrpc_internal.h"
38 int test_req_buffer_pressure = 0;
39 CFS_MODULE_PARM(test_req_buffer_pressure, "i", int, 0444,
40 "set non-zero to put pressure on request buffer pools");
43 static int ptlrpc_server_post_idle_rqbds (struct ptlrpc_service *svc);
45 static CFS_LIST_HEAD (ptlrpc_all_services);
46 spinlock_t ptlrpc_all_services_lock;
49 ptlrpc_alloc_request_buffer (int size)
53 if (size > SVC_BUF_VMALLOC_THRESHOLD)
54 OBD_VMALLOC(ptr, size);
62 ptlrpc_free_request_buffer (char *ptr, int size)
64 if (size > SVC_BUF_VMALLOC_THRESHOLD)
70 struct ptlrpc_request_buffer_desc *
71 ptlrpc_alloc_rqbd (struct ptlrpc_service *svc)
73 struct ptlrpc_request_buffer_desc *rqbd;
79 rqbd->rqbd_service = svc;
80 rqbd->rqbd_refcount = 0;
81 rqbd->rqbd_cbid.cbid_fn = request_in_callback;
82 rqbd->rqbd_cbid.cbid_arg = rqbd;
83 CFS_INIT_LIST_HEAD(&rqbd->rqbd_reqs);
84 rqbd->rqbd_buffer = ptlrpc_alloc_request_buffer(svc->srv_buf_size);
86 if (rqbd->rqbd_buffer == NULL) {
91 spin_lock(&svc->srv_lock);
92 list_add(&rqbd->rqbd_list, &svc->srv_idle_rqbds);
94 spin_unlock(&svc->srv_lock);
100 ptlrpc_free_rqbd (struct ptlrpc_request_buffer_desc *rqbd)
102 struct ptlrpc_service *svc = rqbd->rqbd_service;
104 LASSERT (rqbd->rqbd_refcount == 0);
105 LASSERT (list_empty(&rqbd->rqbd_reqs));
107 spin_lock(&svc->srv_lock);
108 list_del(&rqbd->rqbd_list);
110 spin_unlock(&svc->srv_lock);
112 ptlrpc_free_request_buffer (rqbd->rqbd_buffer, svc->srv_buf_size);
117 ptlrpc_grow_req_bufs(struct ptlrpc_service *svc)
119 struct ptlrpc_request_buffer_desc *rqbd;
122 CDEBUG(D_RPCTRACE, "%s: allocate %d new %d-byte reqbufs (%d/%d left)\n",
123 svc->srv_name, svc->srv_nbuf_per_group, svc->srv_buf_size,
124 svc->srv_nrqbd_receiving, svc->srv_nbufs);
125 for (i = 0; i < svc->srv_nbuf_per_group; i++) {
126 rqbd = ptlrpc_alloc_rqbd(svc);
129 CERROR ("%s: Can't allocate request buffer\n",
134 if (ptlrpc_server_post_idle_rqbds(svc) < 0)
142 ptlrpc_save_lock (struct ptlrpc_request *req,
143 struct lustre_handle *lock, int mode)
145 struct ptlrpc_reply_state *rs = req->rq_reply_state;
149 LASSERT(rs->rs_nlocks < RS_MAX_LOCKS);
151 idx = rs->rs_nlocks++;
152 rs->rs_locks[idx] = *lock;
153 rs->rs_modes[idx] = mode;
154 rs->rs_difficult = 1;
158 ptlrpc_schedule_difficult_reply (struct ptlrpc_reply_state *rs)
160 struct ptlrpc_service *svc = rs->rs_service;
163 LASSERT (spin_is_locked (&svc->srv_lock));
165 LASSERT (rs->rs_difficult);
166 rs->rs_scheduled_ever = 1; /* flag any notification attempt */
168 if (rs->rs_scheduled) /* being set up or already notified */
171 rs->rs_scheduled = 1;
172 list_del (&rs->rs_list);
173 list_add (&rs->rs_list, &svc->srv_reply_queue);
174 cfs_waitq_signal (&svc->srv_waitq);
178 ptlrpc_commit_replies (struct obd_device *obd)
180 struct list_head *tmp;
181 struct list_head *nxt;
183 /* Find any replies that have been committed and get their service
184 * to attend to complete them. */
186 /* CAVEAT EMPTOR: spinlock ordering!!! */
187 spin_lock(&obd->obd_uncommitted_replies_lock);
189 list_for_each_safe (tmp, nxt, &obd->obd_uncommitted_replies) {
190 struct ptlrpc_reply_state *rs =
191 list_entry(tmp, struct ptlrpc_reply_state, rs_obd_list);
193 LASSERT (rs->rs_difficult);
195 if (rs->rs_transno <= obd->obd_last_committed) {
196 struct ptlrpc_service *svc = rs->rs_service;
198 spin_lock (&svc->srv_lock);
199 list_del_init (&rs->rs_obd_list);
200 ptlrpc_schedule_difficult_reply (rs);
201 spin_unlock (&svc->srv_lock);
205 spin_unlock(&obd->obd_uncommitted_replies_lock);
209 ptlrpc_server_post_idle_rqbds (struct ptlrpc_service *svc)
211 struct ptlrpc_request_buffer_desc *rqbd;
216 spin_lock(&svc->srv_lock);
218 if (list_empty (&svc->srv_idle_rqbds)) {
219 spin_unlock(&svc->srv_lock);
223 rqbd = list_entry(svc->srv_idle_rqbds.next,
224 struct ptlrpc_request_buffer_desc,
226 list_del (&rqbd->rqbd_list);
228 /* assume we will post successfully */
229 svc->srv_nrqbd_receiving++;
230 list_add (&rqbd->rqbd_list, &svc->srv_active_rqbds);
232 spin_unlock(&svc->srv_lock);
234 rc = ptlrpc_register_rqbd(rqbd);
241 spin_lock(&svc->srv_lock);
243 svc->srv_nrqbd_receiving--;
244 list_del(&rqbd->rqbd_list);
245 list_add_tail(&rqbd->rqbd_list, &svc->srv_idle_rqbds);
247 /* Don't complain if no request buffers are posted right now; LNET
248 * won't drop requests because we set the portal lazy! */
250 spin_unlock(&svc->srv_lock);
255 struct ptlrpc_service *ptlrpc_init_svc_conf(struct ptlrpc_service_conf *c,
256 svc_handler_t h, char *name,
257 struct proc_dir_entry *proc_entry,
258 svcreq_printfn_t prntfn,
261 return ptlrpc_init_svc(c->psc_nbufs, c->psc_bufsize,
262 c->psc_max_req_size, c->psc_max_reply_size,
263 c->psc_req_portal, c->psc_rep_portal,
264 c->psc_watchdog_timeout,
266 prntfn, c->psc_min_threads, c->psc_max_threads,
267 threadname, c->psc_ctx_tags);
269 EXPORT_SYMBOL(ptlrpc_init_svc_conf);
271 /* @threadname should be 11 characters or less - 3 will be added on */
272 struct ptlrpc_service *
273 ptlrpc_init_svc(int nbufs, int bufsize, int max_req_size, int max_reply_size,
274 int req_portal, int rep_portal, int watchdog_timeout,
275 svc_handler_t handler, char *name,
276 cfs_proc_dir_entry_t *proc_entry,
277 svcreq_printfn_t svcreq_printfn,
278 int min_threads, int max_threads,
279 char *threadname, __u32 ctx_tags)
282 struct ptlrpc_service *service;
286 LASSERT (bufsize >= max_req_size + SPTLRPC_MAX_PAYLOAD);
287 LASSERT (ctx_tags != 0);
289 OBD_ALLOC_PTR(service);
293 /* First initialise enough for early teardown */
295 service->srv_name = name;
296 spin_lock_init(&service->srv_lock);
297 CFS_INIT_LIST_HEAD(&service->srv_threads);
298 cfs_waitq_init(&service->srv_waitq);
300 service->srv_nbuf_per_group = test_req_buffer_pressure ? 1 : nbufs;
301 service->srv_max_req_size = max_req_size + SPTLRPC_MAX_PAYLOAD;
302 service->srv_buf_size = bufsize;
303 service->srv_rep_portal = rep_portal;
304 service->srv_req_portal = req_portal;
305 service->srv_watchdog_timeout = watchdog_timeout;
306 service->srv_handler = handler;
307 service->srv_request_history_print_fn = svcreq_printfn;
308 service->srv_request_seq = 1; /* valid seq #s start at 1 */
309 service->srv_request_max_cull_seq = 0;
310 service->srv_threads_min = min_threads;
311 service->srv_threads_max = max_threads;
312 service->srv_thread_name = threadname;
313 service->srv_ctx_tags = ctx_tags;
315 rc = LNetSetLazyPortal(service->srv_req_portal);
318 CFS_INIT_LIST_HEAD(&service->srv_request_queue);
319 CFS_INIT_LIST_HEAD(&service->srv_idle_rqbds);
320 CFS_INIT_LIST_HEAD(&service->srv_active_rqbds);
321 CFS_INIT_LIST_HEAD(&service->srv_history_rqbds);
322 CFS_INIT_LIST_HEAD(&service->srv_request_history);
323 CFS_INIT_LIST_HEAD(&service->srv_active_replies);
324 CFS_INIT_LIST_HEAD(&service->srv_reply_queue);
325 CFS_INIT_LIST_HEAD(&service->srv_free_rs_list);
326 cfs_waitq_init(&service->srv_free_rs_waitq);
328 spin_lock (&ptlrpc_all_services_lock);
329 list_add (&service->srv_list, &ptlrpc_all_services);
330 spin_unlock (&ptlrpc_all_services_lock);
332 /* Now allocate the request buffers */
333 rc = ptlrpc_grow_req_bufs(service);
334 /* We shouldn't be under memory pressure at startup, so
335 * fail if we can't post all our buffers at this time. */
339 /* Now allocate pool of reply buffers */
340 /* Increase max reply size to next power of two */
341 service->srv_max_reply_size = 1;
342 while (service->srv_max_reply_size <
343 max_reply_size + SPTLRPC_MAX_PAYLOAD)
344 service->srv_max_reply_size <<= 1;
346 if (proc_entry != NULL)
347 ptlrpc_lprocfs_register_service(proc_entry, service);
349 CDEBUG(D_NET, "%s: Started, listening on portal %d\n",
350 service->srv_name, service->srv_req_portal);
354 ptlrpc_unregister_service(service);
358 static void __ptlrpc_server_free_request(struct ptlrpc_request *req)
360 struct ptlrpc_request_buffer_desc *rqbd = req->rq_rqbd;
362 list_del(&req->rq_list);
364 if (req->rq_reply_state != NULL) {
365 ptlrpc_rs_decref(req->rq_reply_state);
366 req->rq_reply_state = NULL;
369 sptlrpc_svc_ctx_decref(req);
371 if (req != &rqbd->rqbd_req) {
372 /* NB request buffers use an embedded
373 * req if the incoming req unlinked the
374 * MD; this isn't one of them! */
375 OBD_FREE(req, sizeof(*req));
380 ptlrpc_server_free_request(struct ptlrpc_request *req)
382 struct ptlrpc_request_buffer_desc *rqbd = req->rq_rqbd;
383 struct ptlrpc_service *svc = rqbd->rqbd_service;
385 struct list_head *tmp;
386 struct list_head *nxt;
388 spin_lock(&svc->srv_lock);
390 svc->srv_n_active_reqs--;
391 list_add(&req->rq_list, &rqbd->rqbd_reqs);
393 refcount = --(rqbd->rqbd_refcount);
395 /* request buffer is now idle: add to history */
396 list_del(&rqbd->rqbd_list);
397 list_add_tail(&rqbd->rqbd_list, &svc->srv_history_rqbds);
398 svc->srv_n_history_rqbds++;
400 /* cull some history?
401 * I expect only about 1 or 2 rqbds need to be recycled here */
402 while (svc->srv_n_history_rqbds > svc->srv_max_history_rqbds) {
403 rqbd = list_entry(svc->srv_history_rqbds.next,
404 struct ptlrpc_request_buffer_desc,
407 list_del(&rqbd->rqbd_list);
408 svc->srv_n_history_rqbds--;
410 /* remove rqbd's reqs from svc's req history while
411 * I've got the service lock */
412 list_for_each(tmp, &rqbd->rqbd_reqs) {
413 req = list_entry(tmp, struct ptlrpc_request,
415 /* Track the highest culled req seq */
416 if (req->rq_history_seq >
417 svc->srv_request_max_cull_seq)
418 svc->srv_request_max_cull_seq =
420 list_del(&req->rq_history_list);
423 spin_unlock(&svc->srv_lock);
425 list_for_each_safe(tmp, nxt, &rqbd->rqbd_reqs) {
426 req = list_entry(rqbd->rqbd_reqs.next,
427 struct ptlrpc_request,
429 __ptlrpc_server_free_request(req);
432 spin_lock(&svc->srv_lock);
434 /* schedule request buffer for re-use.
435 * NB I can only do this after I've disposed of their
436 * reqs; particularly the embedded req */
437 list_add_tail(&rqbd->rqbd_list, &svc->srv_idle_rqbds);
439 } else if (req->rq_reply_state && req->rq_reply_state->rs_prealloc) {
440 /* If we are low on memory, we are not interested in
442 list_del(&req->rq_history_list);
443 __ptlrpc_server_free_request(req);
446 spin_unlock(&svc->srv_lock);
450 /* This function makes sure dead exports are evicted in a timely manner.
451 This function is only called when some export receives a message (i.e.,
452 the network is up.) */
453 static void ptlrpc_update_export_timer(struct obd_export *exp, long extra_delay)
455 struct obd_export *oldest_exp;
462 /* Compensate for slow machines, etc, by faking our request time
463 into the future. Although this can break the strict time-ordering
464 of the list, we can be really lazy here - we don't have to evict
465 at the exact right moment. Eventually, all silent exports
466 will make it to the top of the list. */
467 exp->exp_last_request_time = max(exp->exp_last_request_time,
468 (time_t)CURRENT_SECONDS + extra_delay);
470 CDEBUG(D_HA, "updating export %s at %ld exp %p\n",
471 exp->exp_client_uuid.uuid,
472 exp->exp_last_request_time, exp);
474 /* exports may get disconnected from the chain even though the
475 export has references, so we must keep the spin lock while
476 manipulating the lists */
477 spin_lock(&exp->exp_obd->obd_dev_lock);
479 if (list_empty(&exp->exp_obd_chain_timed)) {
480 /* this one is not timed */
481 spin_unlock(&exp->exp_obd->obd_dev_lock);
486 list_move_tail(&exp->exp_obd_chain_timed,
487 &exp->exp_obd->obd_exports_timed);
489 oldest_exp = list_entry(exp->exp_obd->obd_exports_timed.next,
490 struct obd_export, exp_obd_chain_timed);
491 oldest_time = oldest_exp->exp_last_request_time;
492 spin_unlock(&exp->exp_obd->obd_dev_lock);
494 if (exp->exp_obd->obd_recovering) {
495 /* be nice to everyone during recovery */
500 /* Note - racing to start/reset the obd_eviction timer is safe */
501 if (exp->exp_obd->obd_eviction_timer == 0) {
502 /* Check if the oldest entry is expired. */
503 if (CURRENT_SECONDS > (oldest_time +
504 (3 * obd_timeout / 2) + extra_delay)) {
505 /* We need a second timer, in case the net was down and
506 * it just came back. Since the pinger may skip every
507 * other PING_INTERVAL (see note in ptlrpc_pinger_main),
508 * we better wait for 3. */
509 exp->exp_obd->obd_eviction_timer = CURRENT_SECONDS +
511 CDEBUG(D_HA, "%s: Think about evicting %s from %ld\n",
512 exp->exp_obd->obd_name, obd_export_nid2str(exp),
516 if (CURRENT_SECONDS > (exp->exp_obd->obd_eviction_timer +
518 /* The evictor won't evict anyone who we've heard from
519 * recently, so we don't have to check before we start
521 if (!ping_evictor_wake(exp))
522 exp->exp_obd->obd_eviction_timer = 0;
530 int lu_context_init(struct lu_context *ctx, __u32 tags)
535 void lu_context_fini(struct lu_context *ctx)
539 void lu_context_enter(struct lu_context *ctx)
543 void lu_context_exit(struct lu_context *ctx)
550 ptlrpc_server_handle_request(struct ptlrpc_service *svc,
551 struct ptlrpc_thread *thread)
553 struct obd_export *export = NULL;
554 struct ptlrpc_request *request;
555 struct timeval work_start;
556 struct timeval work_end;
563 spin_lock(&svc->srv_lock);
564 if (unlikely(list_empty (&svc->srv_request_queue) ||
565 (svc->srv_n_difficult_replies != 0 &&
566 svc->srv_n_active_reqs >= (svc->srv_threads_running - 1)))) {
567 /* If all the other threads are handling requests, I must
568 * remain free to handle any 'difficult' reply that might
570 spin_unlock(&svc->srv_lock);
574 request = list_entry (svc->srv_request_queue.next,
575 struct ptlrpc_request, rq_list);
576 list_del_init (&request->rq_list);
577 svc->srv_n_queued_reqs--;
578 svc->srv_n_active_reqs++;
580 spin_unlock(&svc->srv_lock);
582 do_gettimeofday(&work_start);
583 timediff = cfs_timeval_sub(&work_start, &request->rq_arrival_time,NULL);
584 if (likely(svc->srv_stats != NULL)) {
585 lprocfs_counter_add(svc->srv_stats, PTLRPC_REQWAIT_CNTR,
587 lprocfs_counter_add(svc->srv_stats, PTLRPC_REQQDEPTH_CNTR,
588 svc->srv_n_queued_reqs);
589 lprocfs_counter_add(svc->srv_stats, PTLRPC_REQACTIVE_CNTR,
590 svc->srv_n_active_reqs);
593 /* go through security check/transform */
594 rc = sptlrpc_svc_unwrap_request(request);
598 case SECSVC_COMPLETE:
599 target_send_reply(request, 0, OBD_FAIL_MDS_ALL_REPLY_NET);
607 /* Clear request swab mask; this is a new request */
608 request->rq_req_swab_mask = 0;
610 rc = lustre_unpack_msg(request->rq_reqmsg, request->rq_reqlen);
612 CERROR ("error unpacking request: ptl %d from %s"
613 " xid "LPU64"\n", svc->srv_req_portal,
614 libcfs_id2str(request->rq_peer), request->rq_xid);
618 rc = lustre_unpack_req_ptlrpc_body(request, MSG_PTLRPC_BODY_OFF);
620 CERROR ("error unpacking ptlrpc body: ptl %d from %s"
621 " xid "LPU64"\n", svc->srv_req_portal,
622 libcfs_id2str(request->rq_peer), request->rq_xid);
627 if (lustre_msg_get_type(request->rq_reqmsg) != PTL_RPC_MSG_REQUEST) {
628 CERROR("wrong packet type received (type=%u) from %s\n",
629 lustre_msg_get_type(request->rq_reqmsg),
630 libcfs_id2str(request->rq_peer));
634 rc = lu_context_init(&request->rq_session, LCT_SESSION);
636 CERROR("Failure to initialize session: %d\n", rc);
639 request->rq_session.lc_thread = thread;
640 lu_context_enter(&request->rq_session);
642 CDEBUG(D_NET, "got req "LPD64"\n", request->rq_xid);
644 request->rq_svc_thread = thread;
646 request->rq_svc_thread->t_env->le_ses = &request->rq_session;
648 request->rq_export = class_conn2export(
649 lustre_msg_get_handle(request->rq_reqmsg));
651 if (likely(request->rq_export)) {
652 if (unlikely(lustre_msg_get_conn_cnt(request->rq_reqmsg) <
653 request->rq_export->exp_conn_cnt)) {
654 DEBUG_REQ(D_ERROR, request,
655 "DROPPING req from old connection %d < %d",
656 lustre_msg_get_conn_cnt(request->rq_reqmsg),
657 request->rq_export->exp_conn_cnt);
660 if (unlikely(request->rq_export->exp_obd &&
661 request->rq_export->exp_obd->obd_fail)) {
662 /* Failing over, don't handle any more reqs, send
663 error response instead. */
664 CDEBUG(D_RPCTRACE,"Dropping req %p for failed obd %s\n",
665 request, request->rq_export->exp_obd->obd_name);
666 request->rq_status = -ENODEV;
667 ptlrpc_error(request);
671 rc = sptlrpc_target_export_check(request->rq_export, request);
673 DEBUG_REQ(D_ERROR, request,
674 "DROPPING req with illegal security flavor,");
678 ptlrpc_update_export_timer(request->rq_export, timediff/500000);
679 export = class_export_rpc_get(request->rq_export);
682 /* Discard requests queued for longer than my timeout. If the
683 * client's timeout is similar to mine, she'll be timing out this
684 * REQ anyway (bug 1502) */
685 if (unlikely(timediff / 1000000 > (long)obd_timeout)) {
686 CERROR("Dropping timed-out opc %d request from %s"
687 ": %ld seconds old\n",
688 lustre_msg_get_opc(request->rq_reqmsg),
689 libcfs_id2str(request->rq_peer),
694 request->rq_phase = RQ_PHASE_INTERPRET;
696 CDEBUG(D_RPCTRACE, "Handling RPC pname:cluuid+ref:pid:xid:nid:opc "
697 "%s:%s+%d:%d:"LPU64":%s:%d\n", cfs_curproc_comm(),
698 (request->rq_export ?
699 (char *)request->rq_export->exp_client_uuid.uuid : "0"),
700 (request->rq_export ?
701 atomic_read(&request->rq_export->exp_refcount) : -99),
702 lustre_msg_get_status(request->rq_reqmsg), request->rq_xid,
703 libcfs_id2str(request->rq_peer),
704 lustre_msg_get_opc(request->rq_reqmsg));
706 rc = svc->srv_handler(request);
708 request->rq_phase = RQ_PHASE_COMPLETE;
710 CDEBUG(D_RPCTRACE, "Handled RPC pname:cluuid+ref:pid:xid:nid:opc "
711 "%s:%s+%d:%d:"LPU64":%s:%d\n", cfs_curproc_comm(),
712 (request->rq_export ?
713 (char *)request->rq_export->exp_client_uuid.uuid : "0"),
714 (request->rq_export ?
715 atomic_read(&request->rq_export->exp_refcount) : -99),
716 lustre_msg_get_status(request->rq_reqmsg), request->rq_xid,
717 libcfs_id2str(request->rq_peer),
718 lustre_msg_get_opc(request->rq_reqmsg));
722 class_export_rpc_put(export);
724 if (likely(request->rq_export != NULL))
725 class_export_put(request->rq_export);
727 lu_context_exit(&request->rq_session);
728 lu_context_fini(&request->rq_session);
730 reply = request->rq_reply_state && request->rq_repmsg; /* bug 11169 */
732 do_gettimeofday(&work_end);
734 timediff = cfs_timeval_sub(&work_end, &work_start, NULL);
736 if (unlikely(timediff / 1000000 > (long)obd_timeout))
737 CERROR("request "LPU64" opc %u from %s processed in %lds "
738 "trans "LPU64" rc %d/%d\n",
741 lustre_msg_get_opc(request->rq_reqmsg) : 0,
742 libcfs_id2str(request->rq_peer),
743 cfs_timeval_sub(&work_end, &request->rq_arrival_time,
745 reply ? lustre_msg_get_transno(request->rq_repmsg) :
746 request->rq_transno, request->rq_status,
747 reply ? lustre_msg_get_status(request->rq_repmsg) : -999);
749 CDEBUG(D_RPCTRACE,"request "LPU64" opc %u from %s processed in "
750 "%ldus (%ldus total) trans "LPU64" rc %d/%d\n",
753 lustre_msg_get_opc(request->rq_reqmsg) : 0,
754 libcfs_id2str(request->rq_peer), timediff,
755 cfs_timeval_sub(&work_end, &request->rq_arrival_time,
757 request->rq_transno, request->rq_status,
758 reply ? lustre_msg_get_status(request->rq_repmsg) : -999);
760 if (likely(svc->srv_stats != NULL && request->rq_reqmsg != NULL)) {
761 int opc = opcode_offset(lustre_msg_get_opc(request->rq_reqmsg));
763 LASSERT(opc < LUSTRE_MAX_OPCODES);
764 lprocfs_counter_add(svc->srv_stats,
765 opc + PTLRPC_LAST_CNTR,
771 ptlrpc_server_free_request(request);
777 ptlrpc_server_handle_reply (struct ptlrpc_service *svc)
779 struct ptlrpc_reply_state *rs;
780 struct obd_export *exp;
781 struct obd_device *obd;
786 spin_lock(&svc->srv_lock);
787 if (list_empty (&svc->srv_reply_queue)) {
788 spin_unlock(&svc->srv_lock);
792 rs = list_entry (svc->srv_reply_queue.next,
793 struct ptlrpc_reply_state, rs_list);
798 LASSERT (rs->rs_difficult);
799 LASSERT (rs->rs_scheduled);
801 list_del_init (&rs->rs_list);
803 /* Disengage from notifiers carefully (lock order - irqrestore below!)*/
804 spin_unlock(&svc->srv_lock);
806 spin_lock (&obd->obd_uncommitted_replies_lock);
807 /* Noop if removed already */
808 list_del_init (&rs->rs_obd_list);
809 spin_unlock (&obd->obd_uncommitted_replies_lock);
811 spin_lock (&exp->exp_lock);
812 /* Noop if removed already */
813 list_del_init (&rs->rs_exp_list);
814 spin_unlock (&exp->exp_lock);
816 spin_lock(&svc->srv_lock);
818 been_handled = rs->rs_handled;
821 nlocks = rs->rs_nlocks; /* atomic "steal", but */
822 rs->rs_nlocks = 0; /* locks still on rs_locks! */
824 if (nlocks == 0 && !been_handled) {
825 /* If we see this, we should already have seen the warning
826 * in mds_steal_ack_locks() */
827 CWARN("All locks stolen from rs %p x"LPD64".t"LPD64
830 rs->rs_xid, rs->rs_transno,
831 lustre_msg_get_opc(rs->rs_msg),
832 libcfs_nid2str(exp->exp_connection->c_peer.nid));
835 if ((!been_handled && rs->rs_on_net) || nlocks > 0) {
836 spin_unlock(&svc->srv_lock);
838 if (!been_handled && rs->rs_on_net) {
839 LNetMDUnlink(rs->rs_md_h);
840 /* Ignore return code; we're racing with
845 ldlm_lock_decref(&rs->rs_locks[nlocks],
846 rs->rs_modes[nlocks]);
848 spin_lock(&svc->srv_lock);
851 rs->rs_scheduled = 0;
853 if (!rs->rs_on_net) {
855 svc->srv_n_difficult_replies--;
856 spin_unlock(&svc->srv_lock);
858 class_export_put (exp);
859 rs->rs_export = NULL;
860 ptlrpc_rs_decref (rs);
861 atomic_dec (&svc->srv_outstanding_replies);
865 /* still on the net; callback will schedule */
866 spin_unlock(&svc->srv_lock);
871 /* FIXME make use of timeout later */
873 liblustre_check_services (void *arg)
875 int did_something = 0;
877 struct list_head *tmp, *nxt;
880 /* I'm relying on being single threaded, not to have to lock
881 * ptlrpc_all_services etc */
882 list_for_each_safe (tmp, nxt, &ptlrpc_all_services) {
883 struct ptlrpc_service *svc =
884 list_entry (tmp, struct ptlrpc_service, srv_list);
886 if (svc->srv_threads_running != 0) /* I've recursed */
889 /* service threads can block for bulk, so this limits us
890 * (arbitrarily) to recursing 1 stack frame per service.
891 * Note that the problem with recursion is that we have to
892 * unwind completely before our caller can resume. */
894 svc->srv_threads_running++;
897 rc = ptlrpc_server_handle_reply(svc);
898 rc |= ptlrpc_server_handle_request(svc, NULL);
899 rc |= (ptlrpc_server_post_idle_rqbds(svc) > 0);
903 svc->srv_threads_running--;
906 RETURN(did_something);
908 #define ptlrpc_stop_all_threads(s) do {} while (0)
910 #else /* __KERNEL__ */
912 /* Don't use daemonize, it removes fs struct from new thread (bug 418) */
913 void ptlrpc_daemonize(char *name)
915 struct fs_struct *fs = current->fs;
917 atomic_inc(&fs->count);
919 exit_fs(cfs_current());
921 ll_set_fs_pwd(current->fs, init_task.fs->pwdmnt, init_task.fs->pwd);
925 ptlrpc_check_rqbd_pool(struct ptlrpc_service *svc)
927 int avail = svc->srv_nrqbd_receiving;
928 int low_water = test_req_buffer_pressure ? 0 :
929 svc->srv_nbuf_per_group/2;
931 /* NB I'm not locking; just looking. */
933 /* CAVEAT EMPTOR: We might be allocating buffers here because we've
934 * allowed the request history to grow out of control. We could put a
935 * sanity check on that here and cull some history if we need the
938 if (avail <= low_water)
939 ptlrpc_grow_req_bufs(svc);
942 lprocfs_counter_add(svc->srv_stats, PTLRPC_REQBUF_AVAIL_CNTR,
947 ptlrpc_retry_rqbds(void *arg)
949 struct ptlrpc_service *svc = (struct ptlrpc_service *)arg;
951 svc->srv_rqbd_timeout = 0;
955 static int ptlrpc_main(void *arg)
957 struct ptlrpc_svc_data *data = (struct ptlrpc_svc_data *)arg;
958 struct ptlrpc_service *svc = data->svc;
959 struct ptlrpc_thread *thread = data->thread;
960 struct obd_device *dev = data->dev;
961 struct ptlrpc_reply_state *rs;
962 struct lc_watchdog *watchdog;
963 #ifdef WITH_GROUP_INFO
964 struct group_info *ginfo = NULL;
970 ptlrpc_daemonize(data->name);
972 #if defined(HAVE_NODE_TO_CPUMASK) && defined(CONFIG_NUMA)
973 /* we need to do this before any per-thread allocation is done so that
974 * we get the per-thread allocations on local node. bug 7342 */
975 if (svc->srv_cpu_affinity) {
978 for (cpu = 0, num_cpu = 0; cpu < num_possible_cpus(); cpu++) {
979 if (!cpu_online(cpu))
981 if (num_cpu == thread->t_id % num_online_cpus())
985 set_cpus_allowed(cfs_current(), node_to_cpumask(cpu_to_node(cpu)));
989 #ifdef WITH_GROUP_INFO
990 ginfo = groups_alloc(0);
996 set_current_groups(ginfo);
997 put_group_info(ginfo);
1000 if (svc->srv_init != NULL) {
1001 rc = svc->srv_init(thread);
1006 rc = lu_context_init(&env.le_ctx, svc->srv_ctx_tags);
1010 thread->t_env = &env;
1011 env.le_ctx.lc_thread = thread;
1013 /* Alloc reply state structure for this one */
1014 OBD_ALLOC_GFP(rs, svc->srv_max_reply_size, CFS_ALLOC_STD);
1020 /* Record that the thread is running */
1021 thread->t_flags = SVC_RUNNING;
1023 * wake up our creator. Note: @data is invalid after this point,
1024 * because it's allocated on ptlrpc_start_thread() stack.
1026 cfs_waitq_signal(&thread->t_ctl_waitq);
1028 watchdog = lc_watchdog_add(svc->srv_watchdog_timeout, NULL, NULL);
1030 spin_lock(&svc->srv_lock);
1031 svc->srv_threads_running++;
1032 list_add(&rs->rs_list, &svc->srv_free_rs_list);
1033 spin_unlock(&svc->srv_lock);
1034 cfs_waitq_signal(&svc->srv_free_rs_waitq);
1036 CDEBUG(D_NET, "service thread %d (#%d)started\n", thread->t_id,
1037 svc->srv_threads_running);
1039 /* XXX maintain a list of all managed devices: insert here */
1041 while ((thread->t_flags & SVC_STOPPING) == 0 ||
1042 svc->srv_n_difficult_replies != 0) {
1043 /* Don't exit while there are replies to be handled */
1044 struct l_wait_info lwi = LWI_TIMEOUT(svc->srv_rqbd_timeout,
1045 ptlrpc_retry_rqbds, svc);
1047 lc_watchdog_disable(watchdog);
1051 l_wait_event_exclusive (svc->srv_waitq,
1052 ((thread->t_flags & SVC_STOPPING) != 0 &&
1053 svc->srv_n_difficult_replies == 0) ||
1054 (!list_empty(&svc->srv_idle_rqbds) &&
1055 svc->srv_rqbd_timeout == 0) ||
1056 !list_empty (&svc->srv_reply_queue) ||
1057 (!list_empty (&svc->srv_request_queue) &&
1058 (svc->srv_n_difficult_replies == 0 ||
1059 svc->srv_n_active_reqs <
1060 (svc->srv_threads_running - 1))),
1063 lc_watchdog_touch(watchdog);
1065 ptlrpc_check_rqbd_pool(svc);
1067 if ((svc->srv_threads_started < svc->srv_threads_max) &&
1068 (svc->srv_n_active_reqs >= (svc->srv_threads_started - 1))){
1069 /* Ignore return code - we tried... */
1070 ptlrpc_start_thread(dev, svc);
1073 if (!list_empty (&svc->srv_reply_queue))
1074 ptlrpc_server_handle_reply (svc);
1076 /* only handle requests if there are no difficult replies
1077 * outstanding, or I'm not the last thread handling
1079 if (!list_empty (&svc->srv_request_queue) &&
1080 (svc->srv_n_difficult_replies == 0 ||
1081 svc->srv_n_active_reqs < (svc->srv_threads_running - 1))) {
1082 lu_context_enter(&env.le_ctx);
1083 ptlrpc_server_handle_request(svc, thread);
1084 lu_context_exit(&env.le_ctx);
1087 if (!list_empty(&svc->srv_idle_rqbds) &&
1088 ptlrpc_server_post_idle_rqbds(svc) < 0) {
1089 /* I just failed to repost request buffers. Wait
1090 * for a timeout (unless something else happens)
1091 * before I try again */
1092 svc->srv_rqbd_timeout = cfs_time_seconds(1)/10;
1093 CDEBUG(D_RPCTRACE,"Posted buffers: %d\n",
1094 svc->srv_nrqbd_receiving);
1098 lc_watchdog_delete(watchdog);
1102 * deconstruct service specific state created by ptlrpc_start_thread()
1104 if (svc->srv_done != NULL)
1105 svc->srv_done(thread);
1109 CDEBUG(D_NET, "service thread %d exiting: rc %d\n", thread->t_id, rc);
1111 spin_lock(&svc->srv_lock);
1112 svc->srv_threads_running--; /* must know immediately */
1114 thread->t_flags = SVC_STOPPED;
1116 cfs_waitq_signal(&thread->t_ctl_waitq);
1117 spin_unlock(&svc->srv_lock);
1122 static void ptlrpc_stop_thread(struct ptlrpc_service *svc,
1123 struct ptlrpc_thread *thread)
1125 struct l_wait_info lwi = { 0 };
1127 spin_lock(&svc->srv_lock);
1128 thread->t_flags = SVC_STOPPING;
1129 spin_unlock(&svc->srv_lock);
1131 cfs_waitq_broadcast(&svc->srv_waitq);
1132 l_wait_event(thread->t_ctl_waitq, (thread->t_flags & SVC_STOPPED),
1135 spin_lock(&svc->srv_lock);
1136 list_del(&thread->t_link);
1137 spin_unlock(&svc->srv_lock);
1139 OBD_FREE_PTR(thread);
1142 void ptlrpc_stop_all_threads(struct ptlrpc_service *svc)
1144 struct ptlrpc_thread *thread;
1146 spin_lock(&svc->srv_lock);
1147 while (!list_empty(&svc->srv_threads)) {
1148 thread = list_entry(svc->srv_threads.next,
1149 struct ptlrpc_thread, t_link);
1151 spin_unlock(&svc->srv_lock);
1152 ptlrpc_stop_thread(svc, thread);
1153 spin_lock(&svc->srv_lock);
1156 spin_unlock(&svc->srv_lock);
1159 int ptlrpc_start_threads(struct obd_device *dev, struct ptlrpc_service *svc)
1164 LASSERT(svc->srv_threads_min > 0);
1165 for (i = 0; i < svc->srv_threads_min; i++) {
1166 rc = ptlrpc_start_thread(dev, svc);
1168 CERROR("cannot start %s thread #%d: rc %d\n",
1169 svc->srv_thread_name, i, rc);
1170 ptlrpc_stop_all_threads(svc);
1176 int ptlrpc_start_thread(struct obd_device *dev, struct ptlrpc_service *svc)
1178 struct l_wait_info lwi = { 0 };
1179 struct ptlrpc_svc_data d;
1180 struct ptlrpc_thread *thread;
1185 CDEBUG(D_RPCTRACE, "%s started %d min %d max %d running %d\n",
1186 svc->srv_name, svc->srv_threads_started, svc->srv_threads_min,
1187 svc->srv_threads_max, svc->srv_threads_running);
1188 if (svc->srv_threads_started >= svc->srv_threads_max)
1191 OBD_ALLOC_PTR(thread);
1194 cfs_waitq_init(&thread->t_ctl_waitq);
1196 spin_lock(&svc->srv_lock);
1197 if (svc->srv_threads_started >= svc->srv_threads_max) {
1198 spin_unlock(&svc->srv_lock);
1199 OBD_FREE_PTR(thread);
1202 list_add(&thread->t_link, &svc->srv_threads);
1203 id = svc->srv_threads_started++;
1204 spin_unlock(&svc->srv_lock);
1207 sprintf(name, "%s_%02d", svc->srv_thread_name, id);
1213 CDEBUG(D_RPCTRACE, "starting thread '%s'\n", name);
1215 /* CLONE_VM and CLONE_FILES just avoid a needless copy, because we
1216 * just drop the VM and FILES in ptlrpc_daemonize() right away.
1218 rc = cfs_kernel_thread(ptlrpc_main, &d, CLONE_VM | CLONE_FILES);
1220 CERROR("cannot start thread '%s': rc %d\n", name, rc);
1222 spin_lock(&svc->srv_lock);
1223 list_del(&thread->t_link);
1224 --svc->srv_threads_started;
1225 spin_unlock(&svc->srv_lock);
1227 OBD_FREE(thread, sizeof(*thread));
1230 l_wait_event(thread->t_ctl_waitq,
1231 thread->t_flags & (SVC_RUNNING | SVC_STOPPED), &lwi);
1233 rc = (thread->t_flags & SVC_STOPPED) ? thread->t_id : 0;
1238 int ptlrpc_unregister_service(struct ptlrpc_service *service)
1241 struct l_wait_info lwi;
1242 struct list_head *tmp;
1243 struct ptlrpc_reply_state *rs, *t;
1245 ptlrpc_stop_all_threads(service);
1246 LASSERT(list_empty(&service->srv_threads));
1248 spin_lock (&ptlrpc_all_services_lock);
1249 list_del_init (&service->srv_list);
1250 spin_unlock (&ptlrpc_all_services_lock);
1252 ptlrpc_lprocfs_unregister_service(service);
1254 /* All history will be culled when the next request buffer is
1256 service->srv_max_history_rqbds = 0;
1258 CDEBUG(D_NET, "%s: tearing down\n", service->srv_name);
1260 rc = LNetClearLazyPortal(service->srv_req_portal);
1263 /* Unlink all the request buffers. This forces a 'final' event with
1264 * its 'unlink' flag set for each posted rqbd */
1265 list_for_each(tmp, &service->srv_active_rqbds) {
1266 struct ptlrpc_request_buffer_desc *rqbd =
1267 list_entry(tmp, struct ptlrpc_request_buffer_desc,
1270 rc = LNetMDUnlink(rqbd->rqbd_md_h);
1271 LASSERT (rc == 0 || rc == -ENOENT);
1274 /* Wait for the network to release any buffers it's currently
1277 spin_lock(&service->srv_lock);
1278 rc = service->srv_nrqbd_receiving;
1279 spin_unlock(&service->srv_lock);
1284 /* Network access will complete in finite time but the HUGE
1285 * timeout lets us CWARN for visibility of sluggish NALs */
1286 lwi = LWI_TIMEOUT(cfs_time_seconds(300), NULL, NULL);
1287 rc = l_wait_event(service->srv_waitq,
1288 service->srv_nrqbd_receiving == 0,
1290 if (rc == -ETIMEDOUT)
1291 CWARN("Service %s waiting for request buffers\n",
1295 /* schedule all outstanding replies to terminate them */
1296 spin_lock(&service->srv_lock);
1297 while (!list_empty(&service->srv_active_replies)) {
1298 struct ptlrpc_reply_state *rs =
1299 list_entry(service->srv_active_replies.next,
1300 struct ptlrpc_reply_state, rs_list);
1301 ptlrpc_schedule_difficult_reply(rs);
1303 spin_unlock(&service->srv_lock);
1305 /* purge the request queue. NB No new replies (rqbds all unlinked)
1306 * and no service threads, so I'm the only thread noodling the
1307 * request queue now */
1308 while (!list_empty(&service->srv_request_queue)) {
1309 struct ptlrpc_request *req =
1310 list_entry(service->srv_request_queue.next,
1311 struct ptlrpc_request,
1314 list_del(&req->rq_list);
1315 service->srv_n_queued_reqs--;
1316 service->srv_n_active_reqs++;
1318 ptlrpc_server_free_request(req);
1320 LASSERT(service->srv_n_queued_reqs == 0);
1321 LASSERT(service->srv_n_active_reqs == 0);
1322 LASSERT(service->srv_n_history_rqbds == 0);
1323 LASSERT(list_empty(&service->srv_active_rqbds));
1325 /* Now free all the request buffers since nothing references them
1327 while (!list_empty(&service->srv_idle_rqbds)) {
1328 struct ptlrpc_request_buffer_desc *rqbd =
1329 list_entry(service->srv_idle_rqbds.next,
1330 struct ptlrpc_request_buffer_desc,
1333 ptlrpc_free_rqbd(rqbd);
1336 /* wait for all outstanding replies to complete (they were
1337 * scheduled having been flagged to abort above) */
1338 while (atomic_read(&service->srv_outstanding_replies) != 0) {
1339 struct l_wait_info lwi = LWI_TIMEOUT(cfs_time_seconds(10), NULL, NULL);
1341 rc = l_wait_event(service->srv_waitq,
1342 !list_empty(&service->srv_reply_queue), &lwi);
1343 LASSERT(rc == 0 || rc == -ETIMEDOUT);
1346 ptlrpc_server_handle_reply(service);
1349 CWARN("Unexpectedly long timeout %p\n", service);
1352 list_for_each_entry_safe(rs, t, &service->srv_free_rs_list, rs_list) {
1353 list_del(&rs->rs_list);
1354 OBD_FREE(rs, service->srv_max_reply_size);
1357 OBD_FREE_PTR(service);
1361 /* Returns 0 if the service is healthy.
1363 * Right now, it just checks to make sure that requests aren't languishing
1364 * in the queue. We'll use this health check to govern whether a node needs
1365 * to be shot, so it's intentionally non-aggressive. */
1366 int ptlrpc_service_health_check(struct ptlrpc_service *svc)
1368 struct ptlrpc_request *request;
1369 struct timeval right_now;
1370 long timediff, cutoff;
1376 spin_lock(&svc->srv_lock);
1378 if (list_empty(&svc->srv_request_queue))
1381 request = list_entry(svc->srv_request_queue.next,
1382 struct ptlrpc_request, rq_list);
1384 do_gettimeofday(&right_now);
1385 timediff = cfs_timeval_sub(&right_now, &request->rq_arrival_time, NULL);
1387 cutoff = obd_health_check_timeout;
1389 if (timediff / 1000000 > cutoff) {
1395 spin_unlock(&svc->srv_lock);