blob: 2fcfe9bec5543a86f8c545eeaafe3b3e74bc7df3 [file] [log] [blame]
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001/*
Andreas Herrmann4a9d2d82006-05-22 18:14:08 +02002 * This file is part of the zfcp device driver for
3 * FCP adapters for IBM System z9 and zSeries.
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02004 *
Andreas Herrmann4a9d2d82006-05-22 18:14:08 +02005 * (C) Copyright IBM Corp. 2002, 2006
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02006 *
7 * This program is free software; you can redistribute it and/or modify
8 * it under the terms of the GNU General Public License as published by
9 * the Free Software Foundation; either version 2, or (at your option)
10 * any later version.
11 *
12 * This program is distributed in the hope that it will be useful,
13 * but WITHOUT ANY WARRANTY; without even the implied warranty of
14 * MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
15 * GNU General Public License for more details.
16 *
17 * You should have received a copy of the GNU General Public License
18 * along with this program; if not, write to the Free Software
19 * Foundation, Inc., 675 Mass Ave, Cambridge, MA 02139, USA.
20 */
21
Maxim Shchetynin8a36e452005-09-13 21:50:38 +020022#include <linux/ctype.h>
Heiko Carstens364c8552007-10-12 16:11:35 +020023#include <asm/debug.h>
Maxim Shchetynin8a36e452005-09-13 21:50:38 +020024#include "zfcp_ext.h"
25
26static u32 dbfsize = 4;
27
28module_param(dbfsize, uint, 0400);
29MODULE_PARM_DESC(dbfsize,
30 "number of pages for each debug feature area (default 4)");
31
32#define ZFCP_LOG_AREA ZFCP_LOG_AREA_OTHER
33
Martin Peschkec15450e2008-03-27 14:21:55 +010034static void zfcp_dbf_hexdump(debug_info_t *dbf, void *to, int to_len,
35 int level, char *from, int from_len)
36{
37 int offset;
38 struct zfcp_dbf_dump *dump = to;
39 int room = to_len - sizeof(*dump);
40
41 for (offset = 0; offset < from_len; offset += dump->size) {
42 memset(to, 0, to_len);
43 strncpy(dump->tag, "dump", ZFCP_DBF_TAG_SIZE);
44 dump->total_size = from_len;
45 dump->offset = offset;
46 dump->size = min(from_len - offset, room);
47 memcpy(dump->data, from + offset, dump->size);
48 debug_event(dbf, level, dump, dump->size);
49 }
50}
51
Heiko Carstens4d284ca2007-02-05 21:18:53 +010052static int
Maxim Shchetynin8a36e452005-09-13 21:50:38 +020053zfcp_dbf_stck(char *out_buf, const char *label, unsigned long long stck)
54{
55 unsigned long long sec;
Heiko Carstens364c8552007-10-12 16:11:35 +020056 struct timespec dbftime;
Maxim Shchetynin8a36e452005-09-13 21:50:38 +020057 int len = 0;
58
59 stck -= 0x8126d60e46000000LL - (0x3c26700LL * 1000000 * 4096);
60 sec = stck >> 12;
61 do_div(sec, 1000000);
Heiko Carstens364c8552007-10-12 16:11:35 +020062 dbftime.tv_sec = sec;
Maxim Shchetynin8a36e452005-09-13 21:50:38 +020063 stck -= (sec * 1000000) << 12;
Heiko Carstens364c8552007-10-12 16:11:35 +020064 dbftime.tv_nsec = ((stck * 1000) >> 12);
Maxim Shchetynin8a36e452005-09-13 21:50:38 +020065 len += sprintf(out_buf + len, "%-24s%011lu:%06lu\n",
Heiko Carstens364c8552007-10-12 16:11:35 +020066 label, dbftime.tv_sec, dbftime.tv_nsec);
Maxim Shchetynin8a36e452005-09-13 21:50:38 +020067
68 return len;
69}
70
71static int zfcp_dbf_tag(char *out_buf, const char *label, const char *tag)
72{
73 int len = 0, i;
74
75 len += sprintf(out_buf + len, "%-24s", label);
76 for (i = 0; i < ZFCP_DBF_TAG_SIZE; i++)
77 len += sprintf(out_buf + len, "%c", tag[i]);
78 len += sprintf(out_buf + len, "\n");
79
80 return len;
81}
82
83static int
84zfcp_dbf_view(char *out_buf, const char *label, const char *format, ...)
85{
86 va_list arg;
87 int len = 0;
88
89 len += sprintf(out_buf + len, "%-24s", label);
90 va_start(arg, format);
91 len += vsprintf(out_buf + len, format, arg);
92 va_end(arg);
93 len += sprintf(out_buf + len, "\n");
94
95 return len;
96}
97
Martin Peschke10223c62008-03-27 14:21:59 +010098static void zfcp_dbf_outs(char **buf, const char *s1, const char *s2)
99{
100 *buf += sprintf(*buf, "%-24s%s\n", s1, s2);
101}
102
103static void zfcp_dbf_out(char **buf, const char *s, const char *format, ...)
104{
105 va_list arg;
106
107 *buf += sprintf(*buf, "%-24s", s);
108 va_start(arg, format);
109 *buf += vsprintf(*buf, format, arg);
110 va_end(arg);
111 *buf += sprintf(*buf, "\n");
112}
113
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200114static int
115zfcp_dbf_view_dump(char *out_buf, const char *label,
116 char *buffer, int buflen, int offset, int total_size)
117{
118 int len = 0;
119
120 if (offset == 0)
121 len += sprintf(out_buf + len, "%-24s ", label);
122
123 while (buflen--) {
124 if (offset > 0) {
125 if ((offset % 32) == 0)
126 len += sprintf(out_buf + len, "\n%-24c ", ' ');
127 else if ((offset % 4) == 0)
128 len += sprintf(out_buf + len, " ");
129 }
130 len += sprintf(out_buf + len, "%02x", *buffer++);
131 if (++offset == total_size) {
132 len += sprintf(out_buf + len, "\n");
133 break;
134 }
135 }
136
137 if (total_size == 0)
138 len += sprintf(out_buf + len, "\n");
139
140 return len;
141}
142
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100143static int
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200144zfcp_dbf_view_header(debug_info_t * id, struct debug_view *view, int area,
145 debug_entry_t * entry, char *out_buf)
146{
147 struct zfcp_dbf_dump *dump = (struct zfcp_dbf_dump *)DEBUG_DATA(entry);
148 int len = 0;
149
150 if (strncmp(dump->tag, "dump", ZFCP_DBF_TAG_SIZE) != 0) {
151 len += zfcp_dbf_stck(out_buf + len, "timestamp",
152 entry->id.stck);
153 len += zfcp_dbf_view(out_buf + len, "cpu", "%02i",
154 entry->id.fields.cpuid);
155 } else {
156 len += zfcp_dbf_view_dump(out_buf + len, NULL,
157 dump->data,
158 dump->size,
159 dump->offset, dump->total_size);
160 if ((dump->offset + dump->size) == dump->total_size)
161 len += sprintf(out_buf + len, "\n");
162 }
163
164 return len;
165}
166
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100167void zfcp_hba_dbf_event_fsf_response(struct zfcp_fsf_req *fsf_req)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200168{
169 struct zfcp_adapter *adapter = fsf_req->adapter;
170 struct fsf_qtcb *qtcb = fsf_req->qtcb;
171 union fsf_prot_status_qual *prot_status_qual =
172 &qtcb->prefix.prot_status_qual;
173 union fsf_status_qual *fsf_status_qual = &qtcb->header.fsf_status_qual;
174 struct scsi_cmnd *scsi_cmnd;
175 struct zfcp_port *port;
176 struct zfcp_unit *unit;
177 struct zfcp_send_els *send_els;
178 struct zfcp_hba_dbf_record *rec = &adapter->hba_dbf_buf;
179 struct zfcp_hba_dbf_record_response *response = &rec->type.response;
180 int level;
181 unsigned long flags;
182
183 spin_lock_irqsave(&adapter->hba_dbf_lock, flags);
184 memset(rec, 0, sizeof(struct zfcp_hba_dbf_record));
185 strncpy(rec->tag, "resp", ZFCP_DBF_TAG_SIZE);
186
187 if ((qtcb->prefix.prot_status != FSF_PROT_GOOD) &&
188 (qtcb->prefix.prot_status != FSF_PROT_FSF_STATUS_PRESENTED)) {
189 strncpy(rec->tag2, "perr", ZFCP_DBF_TAG_SIZE);
190 level = 1;
191 } else if (qtcb->header.fsf_status != FSF_GOOD) {
192 strncpy(rec->tag2, "ferr", ZFCP_DBF_TAG_SIZE);
193 level = 1;
194 } else if ((fsf_req->fsf_command == FSF_QTCB_OPEN_PORT_WITH_DID) ||
195 (fsf_req->fsf_command == FSF_QTCB_OPEN_LUN)) {
196 strncpy(rec->tag2, "open", ZFCP_DBF_TAG_SIZE);
197 level = 4;
Martin Peschkeb75db732008-03-27 14:21:58 +0100198 } else if (qtcb->header.log_length) {
199 strncpy(rec->tag2, "qtcb", ZFCP_DBF_TAG_SIZE);
200 level = 5;
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200201 } else {
202 strncpy(rec->tag2, "norm", ZFCP_DBF_TAG_SIZE);
203 level = 6;
204 }
205
206 response->fsf_command = fsf_req->fsf_command;
207 response->fsf_reqid = (unsigned long)fsf_req;
208 response->fsf_seqno = fsf_req->seq_no;
209 response->fsf_issued = fsf_req->issued;
210 response->fsf_prot_status = qtcb->prefix.prot_status;
211 response->fsf_status = qtcb->header.fsf_status;
212 memcpy(response->fsf_prot_status_qual,
213 prot_status_qual, FSF_PROT_STATUS_QUAL_SIZE);
214 memcpy(response->fsf_status_qual,
215 fsf_status_qual, FSF_STATUS_QUALIFIER_SIZE);
216 response->fsf_req_status = fsf_req->status;
217 response->sbal_first = fsf_req->sbal_first;
218 response->sbal_curr = fsf_req->sbal_curr;
219 response->sbal_last = fsf_req->sbal_last;
220 response->pool = fsf_req->pool != NULL;
221 response->erp_action = (unsigned long)fsf_req->erp_action;
222
223 switch (fsf_req->fsf_command) {
224 case FSF_QTCB_FCP_CMND:
225 if (fsf_req->status & ZFCP_STATUS_FSFREQ_TASK_MANAGEMENT)
226 break;
227 scsi_cmnd = (struct scsi_cmnd *)fsf_req->data;
228 if (scsi_cmnd != NULL) {
229 response->data.send_fcp.scsi_cmnd
230 = (unsigned long)scsi_cmnd;
231 response->data.send_fcp.scsi_serial
232 = scsi_cmnd->serial_number;
233 }
234 break;
235
236 case FSF_QTCB_OPEN_PORT_WITH_DID:
237 case FSF_QTCB_CLOSE_PORT:
238 case FSF_QTCB_CLOSE_PHYSICAL_PORT:
239 port = (struct zfcp_port *)fsf_req->data;
240 response->data.port.wwpn = port->wwpn;
241 response->data.port.d_id = port->d_id;
242 response->data.port.port_handle = qtcb->header.port_handle;
243 break;
244
245 case FSF_QTCB_OPEN_LUN:
246 case FSF_QTCB_CLOSE_LUN:
247 unit = (struct zfcp_unit *)fsf_req->data;
248 port = unit->port;
249 response->data.unit.wwpn = port->wwpn;
250 response->data.unit.fcp_lun = unit->fcp_lun;
251 response->data.unit.port_handle = qtcb->header.port_handle;
252 response->data.unit.lun_handle = qtcb->header.lun_handle;
253 break;
254
255 case FSF_QTCB_SEND_ELS:
256 send_els = (struct zfcp_send_els *)fsf_req->data;
257 response->data.send_els.d_id = qtcb->bottom.support.d_id;
258 response->data.send_els.ls_code = send_els->ls_code >> 24;
259 break;
260
261 case FSF_QTCB_ABORT_FCP_CMND:
262 case FSF_QTCB_SEND_GENERIC:
263 case FSF_QTCB_EXCHANGE_CONFIG_DATA:
264 case FSF_QTCB_EXCHANGE_PORT_DATA:
265 case FSF_QTCB_DOWNLOAD_CONTROL_FILE:
266 case FSF_QTCB_UPLOAD_CONTROL_FILE:
267 break;
268 }
269
270 debug_event(adapter->hba_dbf, level,
271 rec, sizeof(struct zfcp_hba_dbf_record));
Martin Peschkeb75db732008-03-27 14:21:58 +0100272
273 /* have fcp channel microcode fixed to use as little as possible */
274 if (fsf_req->fsf_command != FSF_QTCB_FCP_CMND) {
275 /* adjust length skipping trailing zeros */
276 char *buf = (char *)qtcb + qtcb->header.log_start;
277 int len = qtcb->header.log_length;
278 for (; len && !buf[len - 1]; len--);
279 zfcp_dbf_hexdump(adapter->hba_dbf, rec, sizeof(*rec), level,
280 buf, len);
281 }
282
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200283 spin_unlock_irqrestore(&adapter->hba_dbf_lock, flags);
284}
285
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100286void
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200287zfcp_hba_dbf_event_fsf_unsol(const char *tag, struct zfcp_adapter *adapter,
288 struct fsf_status_read_buffer *status_buffer)
289{
290 struct zfcp_hba_dbf_record *rec = &adapter->hba_dbf_buf;
291 unsigned long flags;
292
293 spin_lock_irqsave(&adapter->hba_dbf_lock, flags);
294 memset(rec, 0, sizeof(struct zfcp_hba_dbf_record));
295 strncpy(rec->tag, "stat", ZFCP_DBF_TAG_SIZE);
296 strncpy(rec->tag2, tag, ZFCP_DBF_TAG_SIZE);
297
298 rec->type.status.failed = adapter->status_read_failed;
299 if (status_buffer != NULL) {
300 rec->type.status.status_type = status_buffer->status_type;
301 rec->type.status.status_subtype = status_buffer->status_subtype;
302 memcpy(&rec->type.status.queue_designator,
303 &status_buffer->queue_designator,
304 sizeof(struct fsf_queue_designator));
305
306 switch (status_buffer->status_type) {
307 case FSF_STATUS_READ_SENSE_DATA_AVAIL:
308 rec->type.status.payload_size =
309 ZFCP_DBF_UNSOL_PAYLOAD_SENSE_DATA_AVAIL;
310 break;
311
312 case FSF_STATUS_READ_BIT_ERROR_THRESHOLD:
313 rec->type.status.payload_size =
314 ZFCP_DBF_UNSOL_PAYLOAD_BIT_ERROR_THRESHOLD;
315 break;
316
317 case FSF_STATUS_READ_LINK_DOWN:
Maxim Shchetyninaef4a982005-09-13 21:51:16 +0200318 switch (status_buffer->status_subtype) {
319 case FSF_STATUS_READ_SUB_NO_PHYSICAL_LINK:
320 case FSF_STATUS_READ_SUB_FDISC_FAILED:
321 rec->type.status.payload_size =
322 sizeof(struct fsf_link_down_info);
323 }
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200324 break;
325
Maxim Shchetyninaef4a982005-09-13 21:51:16 +0200326 case FSF_STATUS_READ_FEATURE_UPDATE_ALERT:
327 rec->type.status.payload_size =
328 ZFCP_DBF_UNSOL_PAYLOAD_FEATURE_UPDATE_ALERT;
329 break;
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200330 }
331 memcpy(&rec->type.status.payload,
332 &status_buffer->payload, rec->type.status.payload_size);
333 }
334
335 debug_event(adapter->hba_dbf, 2,
336 rec, sizeof(struct zfcp_hba_dbf_record));
337 spin_unlock_irqrestore(&adapter->hba_dbf_lock, flags);
338}
339
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100340void
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200341zfcp_hba_dbf_event_qdio(struct zfcp_adapter *adapter, unsigned int status,
342 unsigned int qdio_error, unsigned int siga_error,
343 int sbal_index, int sbal_count)
344{
345 struct zfcp_hba_dbf_record *rec = &adapter->hba_dbf_buf;
346 unsigned long flags;
347
348 spin_lock_irqsave(&adapter->hba_dbf_lock, flags);
349 memset(rec, 0, sizeof(struct zfcp_hba_dbf_record));
350 strncpy(rec->tag, "qdio", ZFCP_DBF_TAG_SIZE);
351 rec->type.qdio.status = status;
352 rec->type.qdio.qdio_error = qdio_error;
353 rec->type.qdio.siga_error = siga_error;
354 rec->type.qdio.sbal_index = sbal_index;
355 rec->type.qdio.sbal_count = sbal_count;
356 debug_event(adapter->hba_dbf, 0,
357 rec, sizeof(struct zfcp_hba_dbf_record));
358 spin_unlock_irqrestore(&adapter->hba_dbf_lock, flags);
359}
360
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100361static int
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200362zfcp_hba_dbf_view_response(char *out_buf,
363 struct zfcp_hba_dbf_record_response *rec)
364{
365 int len = 0;
366
367 len += zfcp_dbf_view(out_buf + len, "fsf_command", "0x%08x",
368 rec->fsf_command);
369 len += zfcp_dbf_view(out_buf + len, "fsf_reqid", "0x%0Lx",
370 rec->fsf_reqid);
371 len += zfcp_dbf_view(out_buf + len, "fsf_seqno", "0x%08x",
372 rec->fsf_seqno);
373 len += zfcp_dbf_stck(out_buf + len, "fsf_issued", rec->fsf_issued);
374 len += zfcp_dbf_view(out_buf + len, "fsf_prot_status", "0x%08x",
375 rec->fsf_prot_status);
376 len += zfcp_dbf_view(out_buf + len, "fsf_status", "0x%08x",
377 rec->fsf_status);
378 len += zfcp_dbf_view_dump(out_buf + len, "fsf_prot_status_qual",
379 rec->fsf_prot_status_qual,
380 FSF_PROT_STATUS_QUAL_SIZE,
381 0, FSF_PROT_STATUS_QUAL_SIZE);
382 len += zfcp_dbf_view_dump(out_buf + len, "fsf_status_qual",
383 rec->fsf_status_qual,
384 FSF_STATUS_QUALIFIER_SIZE,
385 0, FSF_STATUS_QUALIFIER_SIZE);
386 len += zfcp_dbf_view(out_buf + len, "fsf_req_status", "0x%08x",
387 rec->fsf_req_status);
388 len += zfcp_dbf_view(out_buf + len, "sbal_first", "0x%02x",
389 rec->sbal_first);
390 len += zfcp_dbf_view(out_buf + len, "sbal_curr", "0x%02x",
391 rec->sbal_curr);
392 len += zfcp_dbf_view(out_buf + len, "sbal_last", "0x%02x",
393 rec->sbal_last);
394 len += zfcp_dbf_view(out_buf + len, "pool", "0x%02x", rec->pool);
395
396 switch (rec->fsf_command) {
397 case FSF_QTCB_FCP_CMND:
398 if (rec->fsf_req_status & ZFCP_STATUS_FSFREQ_TASK_MANAGEMENT)
399 break;
400 len += zfcp_dbf_view(out_buf + len, "scsi_cmnd", "0x%0Lx",
401 rec->data.send_fcp.scsi_cmnd);
402 len += zfcp_dbf_view(out_buf + len, "scsi_serial", "0x%016Lx",
403 rec->data.send_fcp.scsi_serial);
404 break;
405
406 case FSF_QTCB_OPEN_PORT_WITH_DID:
407 case FSF_QTCB_CLOSE_PORT:
408 case FSF_QTCB_CLOSE_PHYSICAL_PORT:
409 len += zfcp_dbf_view(out_buf + len, "wwpn", "0x%016Lx",
410 rec->data.port.wwpn);
411 len += zfcp_dbf_view(out_buf + len, "d_id", "0x%06x",
412 rec->data.port.d_id);
413 len += zfcp_dbf_view(out_buf + len, "port_handle", "0x%08x",
414 rec->data.port.port_handle);
415 break;
416
417 case FSF_QTCB_OPEN_LUN:
418 case FSF_QTCB_CLOSE_LUN:
419 len += zfcp_dbf_view(out_buf + len, "wwpn", "0x%016Lx",
420 rec->data.unit.wwpn);
421 len += zfcp_dbf_view(out_buf + len, "fcp_lun", "0x%016Lx",
422 rec->data.unit.fcp_lun);
423 len += zfcp_dbf_view(out_buf + len, "port_handle", "0x%08x",
424 rec->data.unit.port_handle);
425 len += zfcp_dbf_view(out_buf + len, "lun_handle", "0x%08x",
426 rec->data.unit.lun_handle);
427 break;
428
429 case FSF_QTCB_SEND_ELS:
430 len += zfcp_dbf_view(out_buf + len, "d_id", "0x%06x",
431 rec->data.send_els.d_id);
432 len += zfcp_dbf_view(out_buf + len, "ls_code", "0x%02x",
433 rec->data.send_els.ls_code);
434 break;
435
436 case FSF_QTCB_ABORT_FCP_CMND:
437 case FSF_QTCB_SEND_GENERIC:
438 case FSF_QTCB_EXCHANGE_CONFIG_DATA:
439 case FSF_QTCB_EXCHANGE_PORT_DATA:
440 case FSF_QTCB_DOWNLOAD_CONTROL_FILE:
441 case FSF_QTCB_UPLOAD_CONTROL_FILE:
442 break;
443 }
444
445 return len;
446}
447
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100448static int
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200449zfcp_hba_dbf_view_status(char *out_buf, struct zfcp_hba_dbf_record_status *rec)
450{
451 int len = 0;
452
453 len += zfcp_dbf_view(out_buf + len, "failed", "0x%02x", rec->failed);
454 len += zfcp_dbf_view(out_buf + len, "status_type", "0x%08x",
455 rec->status_type);
456 len += zfcp_dbf_view(out_buf + len, "status_subtype", "0x%08x",
457 rec->status_subtype);
458 len += zfcp_dbf_view_dump(out_buf + len, "queue_designator",
459 (char *)&rec->queue_designator,
460 sizeof(struct fsf_queue_designator),
461 0, sizeof(struct fsf_queue_designator));
462 len += zfcp_dbf_view_dump(out_buf + len, "payload",
463 (char *)&rec->payload,
464 rec->payload_size, 0, rec->payload_size);
465
466 return len;
467}
468
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100469static int
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200470zfcp_hba_dbf_view_qdio(char *out_buf, struct zfcp_hba_dbf_record_qdio *rec)
471{
472 int len = 0;
473
474 len += zfcp_dbf_view(out_buf + len, "status", "0x%08x", rec->status);
475 len += zfcp_dbf_view(out_buf + len, "qdio_error", "0x%08x",
476 rec->qdio_error);
477 len += zfcp_dbf_view(out_buf + len, "siga_error", "0x%08x",
478 rec->siga_error);
479 len += zfcp_dbf_view(out_buf + len, "sbal_index", "0x%02x",
480 rec->sbal_index);
481 len += zfcp_dbf_view(out_buf + len, "sbal_count", "0x%02x",
482 rec->sbal_count);
483
484 return len;
485}
486
487static int
488zfcp_hba_dbf_view_format(debug_info_t * id, struct debug_view *view,
489 char *out_buf, const char *in_buf)
490{
491 struct zfcp_hba_dbf_record *rec = (struct zfcp_hba_dbf_record *)in_buf;
492 int len = 0;
493
494 if (strncmp(rec->tag, "dump", ZFCP_DBF_TAG_SIZE) == 0)
495 return 0;
496
497 len += zfcp_dbf_tag(out_buf + len, "tag", rec->tag);
498 if (isalpha(rec->tag2[0]))
499 len += zfcp_dbf_tag(out_buf + len, "tag2", rec->tag2);
500 if (strncmp(rec->tag, "resp", ZFCP_DBF_TAG_SIZE) == 0)
501 len += zfcp_hba_dbf_view_response(out_buf + len,
502 &rec->type.response);
503 else if (strncmp(rec->tag, "stat", ZFCP_DBF_TAG_SIZE) == 0)
504 len += zfcp_hba_dbf_view_status(out_buf + len,
505 &rec->type.status);
506 else if (strncmp(rec->tag, "qdio", ZFCP_DBF_TAG_SIZE) == 0)
507 len += zfcp_hba_dbf_view_qdio(out_buf + len, &rec->type.qdio);
508
509 len += sprintf(out_buf + len, "\n");
510
511 return len;
512}
513
Heiko Carstens2b67fc42007-02-05 21:16:47 +0100514static struct debug_view zfcp_hba_dbf_view = {
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200515 "structured",
516 NULL,
517 &zfcp_dbf_view_header,
518 &zfcp_hba_dbf_view_format,
519 NULL,
520 NULL
521};
522
Martin Peschked79a83d2008-03-27 14:22:00 +0100523static const char *zfcp_rec_dbf_tags[] = {
Martin Peschke348447e2008-03-27 14:22:01 +0100524 [ZFCP_REC_DBF_ID_THREAD] = "thread",
Martin Peschke698ec0162008-03-27 14:22:02 +0100525 [ZFCP_REC_DBF_ID_TARGET] = "target",
Martin Peschked79a83d2008-03-27 14:22:00 +0100526};
527
528static const char *zfcp_rec_dbf_ids[] = {
Martin Peschke348447e2008-03-27 14:22:01 +0100529 [1] = "new",
530 [2] = "ready",
531 [3] = "kill",
532 [4] = "down sleep",
533 [5] = "down wakeup",
534 [6] = "down sleep ecd",
535 [7] = "down wakeup ecd",
536 [8] = "down sleep epd",
537 [9] = "down wakeup epd",
Martin Peschke698ec0162008-03-27 14:22:02 +0100538 [10] = "online",
539 [11] = "operational",
540 [12] = "scsi slave destroy",
541 [13] = "propagate failed adapter",
542 [14] = "propagate failed port",
543 [15] = "block adapter",
544 [16] = "unblock adapter",
545 [17] = "block port",
546 [18] = "unblock port",
547 [19] = "block unit",
548 [20] = "unblock unit",
549 [21] = "unit recovery failed",
550 [22] = "port recovery failed",
551 [23] = "adapter recovery failed",
552 [24] = "qdio queues down",
553 [25] = "p2p failed",
554 [26] = "nameserver lookup failed",
555 [27] = "nameserver port failed",
556 [28] = "link up",
557 [29] = "link down",
558 [30] = "link up status read",
559 [31] = "open port failed",
560 [32] = "open port failed",
561 [33] = "close port",
562 [34] = "open unit failed",
563 [35] = "exclusive open unit failed",
564 [36] = "shared open unit failed",
565 [37] = "link down",
566 [38] = "link down status read no link",
567 [39] = "link down status read fdisc login",
568 [40] = "link down status read firmware update",
569 [41] = "link down status read unknown reason",
570 [42] = "link down ecd incomplete",
571 [43] = "link down epd incomplete",
572 [44] = "sysfs adapter recovery",
573 [45] = "sysfs port recovery",
574 [46] = "sysfs unit recovery",
575 [47] = "port boxed abort",
576 [48] = "unit boxed abort",
577 [49] = "port boxed ct",
578 [50] = "port boxed close physical",
579 [51] = "port boxed open unit",
580 [52] = "port boxed close unit",
581 [53] = "port boxed fcp",
582 [54] = "unit boxed fcp",
583 [55] = "port access denied ct",
584 [56] = "port access denied els",
585 [57] = "port access denied open port",
586 [58] = "port access denied close physical",
587 [59] = "unit access denied open unit",
588 [60] = "shared unit access denied open unit",
589 [61] = "unit access denied fcp",
Martin Peschked79a83d2008-03-27 14:22:00 +0100590};
591
592static int zfcp_rec_dbf_view_format(debug_info_t *id, struct debug_view *view,
593 char *buf, const char *_rec)
594{
595 struct zfcp_rec_dbf_record *r = (struct zfcp_rec_dbf_record *)_rec;
596 char *p = buf;
597
598 zfcp_dbf_outs(&p, "tag", zfcp_rec_dbf_tags[r->id]);
599 zfcp_dbf_outs(&p, "hint", zfcp_rec_dbf_ids[r->id2]);
600 zfcp_dbf_out(&p, "id", "%d", r->id2);
601 switch (r->id) {
Martin Peschke348447e2008-03-27 14:22:01 +0100602 case ZFCP_REC_DBF_ID_THREAD:
603 zfcp_dbf_out(&p, "sema", "%d", r->u.thread.sema);
604 zfcp_dbf_out(&p, "total", "%d", r->u.thread.total);
605 zfcp_dbf_out(&p, "ready", "%d", r->u.thread.ready);
606 zfcp_dbf_out(&p, "running", "%d", r->u.thread.running);
607 break;
Martin Peschke698ec0162008-03-27 14:22:02 +0100608 case ZFCP_REC_DBF_ID_TARGET:
609 zfcp_dbf_out(&p, "reference", "0x%016Lx", r->u.target.ref);
610 zfcp_dbf_out(&p, "status", "0x%08x", r->u.target.status);
611 zfcp_dbf_out(&p, "erp_count", "%d", r->u.target.erp_count);
612 zfcp_dbf_out(&p, "d_id", "0x%06x", r->u.target.d_id);
613 zfcp_dbf_out(&p, "wwpn", "0x%016Lx", r->u.target.wwpn);
614 zfcp_dbf_out(&p, "fcp_lun", "0x%016Lx", r->u.target.fcp_lun);
615 break;
Martin Peschked79a83d2008-03-27 14:22:00 +0100616 }
617 sprintf(p, "\n");
618 return (p - buf) + 1;
619}
620
621static struct debug_view zfcp_rec_dbf_view = {
622 "structured",
623 NULL,
624 &zfcp_dbf_view_header,
625 &zfcp_rec_dbf_view_format,
626 NULL,
627 NULL
628};
629
Martin Peschke348447e2008-03-27 14:22:01 +0100630/**
631 * zfcp_rec_dbf_event_thread - trace event related to recovery thread operation
632 * @id2: identifier for event
633 * @adapter: adapter
634 * @lock: non-zero value indicates that erp_lock has not yet been acquired
635 */
636void zfcp_rec_dbf_event_thread(u8 id2, struct zfcp_adapter *adapter, int lock)
637{
638 struct zfcp_rec_dbf_record *r = &adapter->rec_dbf_buf;
639 unsigned long flags = 0;
640 struct list_head *entry;
641 unsigned ready = 0, running = 0, total;
642
643 if (lock)
644 read_lock_irqsave(&adapter->erp_lock, flags);
645 list_for_each(entry, &adapter->erp_ready_head)
646 ready++;
647 list_for_each(entry, &adapter->erp_running_head)
648 running++;
649 total = adapter->erp_total_count;
650 if (lock)
651 read_unlock_irqrestore(&adapter->erp_lock, flags);
652
653 spin_lock_irqsave(&adapter->rec_dbf_lock, flags);
654 memset(r, 0, sizeof(*r));
655 r->id = ZFCP_REC_DBF_ID_THREAD;
656 r->id2 = id2;
657 r->u.thread.sema = atomic_read(&adapter->erp_ready_sem.count);
658 r->u.thread.total = total;
659 r->u.thread.ready = ready;
660 r->u.thread.running = running;
661 debug_event(adapter->rec_dbf, 5, r, sizeof(*r));
662 spin_unlock_irqrestore(&adapter->rec_dbf_lock, flags);
663}
664
Martin Peschke698ec0162008-03-27 14:22:02 +0100665static void zfcp_rec_dbf_event_target(u8 id2, u64 ref,
666 struct zfcp_adapter *adapter,
667 atomic_t *status, atomic_t *erp_count,
668 u64 wwpn, u32 d_id, u64 fcp_lun)
669{
670 struct zfcp_rec_dbf_record *r = &adapter->rec_dbf_buf;
671 unsigned long flags;
672
673 spin_lock_irqsave(&adapter->rec_dbf_lock, flags);
674 memset(r, 0, sizeof(*r));
675 r->id = ZFCP_REC_DBF_ID_TARGET;
676 r->id2 = id2;
677 r->u.target.ref = ref;
678 r->u.target.status = atomic_read(status);
679 r->u.target.wwpn = wwpn;
680 r->u.target.d_id = d_id;
681 r->u.target.fcp_lun = fcp_lun;
682 r->u.target.erp_count = atomic_read(erp_count);
683 debug_event(adapter->rec_dbf, 3, r, sizeof(*r));
684 spin_unlock_irqrestore(&adapter->rec_dbf_lock, flags);
685}
686
687/**
688 * zfcp_rec_dbf_event_adapter - trace event for adapter state change
689 * @id: identifier for trigger of state change
690 * @ref: additional reference (e.g. request)
691 * @adapter: adapter
692 */
693void zfcp_rec_dbf_event_adapter(u8 id, u64 ref, struct zfcp_adapter *adapter)
694{
695 zfcp_rec_dbf_event_target(id, ref, adapter, &adapter->status,
696 &adapter->erp_counter, 0, 0, 0);
697}
698
699/**
700 * zfcp_rec_dbf_event_port - trace event for port state change
701 * @id: identifier for trigger of state change
702 * @ref: additional reference (e.g. request)
703 * @port: port
704 */
705void zfcp_rec_dbf_event_port(u8 id, u64 ref, struct zfcp_port *port)
706{
707 struct zfcp_adapter *adapter = port->adapter;
708
709 zfcp_rec_dbf_event_target(id, ref, adapter, &port->status,
710 &port->erp_counter, port->wwpn, port->d_id,
711 0);
712}
713
714/**
715 * zfcp_rec_dbf_event_unit - trace event for unit state change
716 * @id: identifier for trigger of state change
717 * @ref: additional reference (e.g. request)
718 * @unit: unit
719 */
720void zfcp_rec_dbf_event_unit(u8 id, u64 ref, struct zfcp_unit *unit)
721{
722 struct zfcp_port *port = unit->port;
723 struct zfcp_adapter *adapter = port->adapter;
724
725 zfcp_rec_dbf_event_target(id, ref, adapter, &unit->status,
726 &unit->erp_counter, port->wwpn, port->d_id,
727 unit->fcp_lun);
728}
729
Heiko Carstens763968e2007-05-10 15:45:46 +0200730static void
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200731_zfcp_san_dbf_event_common_ct(const char *tag, struct zfcp_fsf_req *fsf_req,
Andreas Herrmann13e1e1f2005-09-19 16:56:17 +0200732 u32 s_id, u32 d_id, void *buffer, int buflen)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200733{
734 struct zfcp_send_ct *send_ct = (struct zfcp_send_ct *)fsf_req->data;
735 struct zfcp_port *port = send_ct->port;
736 struct zfcp_adapter *adapter = port->adapter;
737 struct ct_hdr *header = (struct ct_hdr *)buffer;
738 struct zfcp_san_dbf_record *rec = &adapter->san_dbf_buf;
739 struct zfcp_san_dbf_record_ct *ct = &rec->type.ct;
740 unsigned long flags;
741
742 spin_lock_irqsave(&adapter->san_dbf_lock, flags);
743 memset(rec, 0, sizeof(struct zfcp_san_dbf_record));
744 strncpy(rec->tag, tag, ZFCP_DBF_TAG_SIZE);
745 rec->fsf_reqid = (unsigned long)fsf_req;
746 rec->fsf_seqno = fsf_req->seq_no;
747 rec->s_id = s_id;
748 rec->d_id = d_id;
749 if (strncmp(tag, "octc", ZFCP_DBF_TAG_SIZE) == 0) {
750 ct->type.request.cmd_req_code = header->cmd_rsp_code;
751 ct->type.request.revision = header->revision;
752 ct->type.request.gs_type = header->gs_type;
753 ct->type.request.gs_subtype = header->gs_subtype;
754 ct->type.request.options = header->options;
755 ct->type.request.max_res_size = header->max_res_size;
756 } else if (strncmp(tag, "rctc", ZFCP_DBF_TAG_SIZE) == 0) {
757 ct->type.response.cmd_rsp_code = header->cmd_rsp_code;
758 ct->type.response.revision = header->revision;
759 ct->type.response.reason_code = header->reason_code;
760 ct->type.response.reason_code_expl = header->reason_code_expl;
761 ct->type.response.vendor_unique = header->vendor_unique;
762 }
763 ct->payload_size =
764 min(buflen - (int)sizeof(struct ct_hdr), ZFCP_DBF_CT_PAYLOAD);
765 memcpy(ct->payload, buffer + sizeof(struct ct_hdr), ct->payload_size);
766 debug_event(adapter->san_dbf, 3,
767 rec, sizeof(struct zfcp_san_dbf_record));
768 spin_unlock_irqrestore(&adapter->san_dbf_lock, flags);
769}
770
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100771void zfcp_san_dbf_event_ct_request(struct zfcp_fsf_req *fsf_req)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200772{
773 struct zfcp_send_ct *ct = (struct zfcp_send_ct *)fsf_req->data;
774 struct zfcp_port *port = ct->port;
775 struct zfcp_adapter *adapter = port->adapter;
776
Andreas Herrmann13e1e1f2005-09-19 16:56:17 +0200777 _zfcp_san_dbf_event_common_ct("octc", fsf_req,
778 fc_host_port_id(adapter->scsi_host),
779 port->d_id, zfcp_sg_to_address(ct->req),
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200780 ct->req->length);
781}
782
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100783void zfcp_san_dbf_event_ct_response(struct zfcp_fsf_req *fsf_req)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200784{
785 struct zfcp_send_ct *ct = (struct zfcp_send_ct *)fsf_req->data;
786 struct zfcp_port *port = ct->port;
787 struct zfcp_adapter *adapter = port->adapter;
788
Andreas Herrmann13e1e1f2005-09-19 16:56:17 +0200789 _zfcp_san_dbf_event_common_ct("rctc", fsf_req, port->d_id,
790 fc_host_port_id(adapter->scsi_host),
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200791 zfcp_sg_to_address(ct->resp),
792 ct->resp->length);
793}
794
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100795static void
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200796_zfcp_san_dbf_event_common_els(const char *tag, int level,
Andreas Herrmann13e1e1f2005-09-19 16:56:17 +0200797 struct zfcp_fsf_req *fsf_req, u32 s_id,
798 u32 d_id, u8 ls_code, void *buffer, int buflen)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200799{
800 struct zfcp_adapter *adapter = fsf_req->adapter;
801 struct zfcp_san_dbf_record *rec = &adapter->san_dbf_buf;
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200802 unsigned long flags;
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200803
804 spin_lock_irqsave(&adapter->san_dbf_lock, flags);
Martin Peschke0f65e952008-03-27 14:21:56 +0100805 memset(rec, 0, sizeof(struct zfcp_san_dbf_record));
806 strncpy(rec->tag, tag, ZFCP_DBF_TAG_SIZE);
807 rec->fsf_reqid = (unsigned long)fsf_req;
808 rec->fsf_seqno = fsf_req->seq_no;
809 rec->s_id = s_id;
810 rec->d_id = d_id;
811 rec->type.els.ls_code = ls_code;
812 debug_event(adapter->san_dbf, level, rec, sizeof(*rec));
813 zfcp_dbf_hexdump(adapter->san_dbf, rec, sizeof(*rec), level,
814 buffer, min(buflen, ZFCP_DBF_ELS_MAX_PAYLOAD));
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200815 spin_unlock_irqrestore(&adapter->san_dbf_lock, flags);
816}
817
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100818void zfcp_san_dbf_event_els_request(struct zfcp_fsf_req *fsf_req)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200819{
820 struct zfcp_send_els *els = (struct zfcp_send_els *)fsf_req->data;
821
Andreas Herrmann13e1e1f2005-09-19 16:56:17 +0200822 _zfcp_san_dbf_event_common_els("oels", 2, fsf_req,
823 fc_host_port_id(els->adapter->scsi_host),
824 els->d_id,
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200825 *(u8 *) zfcp_sg_to_address(els->req),
826 zfcp_sg_to_address(els->req),
827 els->req->length);
828}
829
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100830void zfcp_san_dbf_event_els_response(struct zfcp_fsf_req *fsf_req)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200831{
832 struct zfcp_send_els *els = (struct zfcp_send_els *)fsf_req->data;
833
Andreas Herrmann13e1e1f2005-09-19 16:56:17 +0200834 _zfcp_san_dbf_event_common_els("rels", 2, fsf_req, els->d_id,
835 fc_host_port_id(els->adapter->scsi_host),
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200836 *(u8 *) zfcp_sg_to_address(els->req),
837 zfcp_sg_to_address(els->resp),
838 els->resp->length);
839}
840
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100841void zfcp_san_dbf_event_incoming_els(struct zfcp_fsf_req *fsf_req)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200842{
843 struct zfcp_adapter *adapter = fsf_req->adapter;
844 struct fsf_status_read_buffer *status_buffer =
845 (struct fsf_status_read_buffer *)fsf_req->data;
846 int length = (int)status_buffer->length -
847 (int)((void *)&status_buffer->payload - (void *)status_buffer);
848
Andreas Herrmann13e1e1f2005-09-19 16:56:17 +0200849 _zfcp_san_dbf_event_common_els("iels", 1, fsf_req, status_buffer->d_id,
850 fc_host_port_id(adapter->scsi_host),
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200851 *(u8 *) status_buffer->payload,
852 (void *)status_buffer->payload, length);
853}
854
855static int
856zfcp_san_dbf_view_format(debug_info_t * id, struct debug_view *view,
857 char *out_buf, const char *in_buf)
858{
859 struct zfcp_san_dbf_record *rec = (struct zfcp_san_dbf_record *)in_buf;
860 char *buffer = NULL;
861 int buflen = 0, total = 0;
862 int len = 0;
863
864 if (strncmp(rec->tag, "dump", ZFCP_DBF_TAG_SIZE) == 0)
865 return 0;
866
867 len += zfcp_dbf_tag(out_buf + len, "tag", rec->tag);
868 len += zfcp_dbf_view(out_buf + len, "fsf_reqid", "0x%0Lx",
869 rec->fsf_reqid);
870 len += zfcp_dbf_view(out_buf + len, "fsf_seqno", "0x%08x",
871 rec->fsf_seqno);
872 len += zfcp_dbf_view(out_buf + len, "s_id", "0x%06x", rec->s_id);
873 len += zfcp_dbf_view(out_buf + len, "d_id", "0x%06x", rec->d_id);
874
875 if (strncmp(rec->tag, "octc", ZFCP_DBF_TAG_SIZE) == 0) {
876 len += zfcp_dbf_view(out_buf + len, "cmd_req_code", "0x%04x",
877 rec->type.ct.type.request.cmd_req_code);
878 len += zfcp_dbf_view(out_buf + len, "revision", "0x%02x",
879 rec->type.ct.type.request.revision);
880 len += zfcp_dbf_view(out_buf + len, "gs_type", "0x%02x",
881 rec->type.ct.type.request.gs_type);
882 len += zfcp_dbf_view(out_buf + len, "gs_subtype", "0x%02x",
883 rec->type.ct.type.request.gs_subtype);
884 len += zfcp_dbf_view(out_buf + len, "options", "0x%02x",
885 rec->type.ct.type.request.options);
886 len += zfcp_dbf_view(out_buf + len, "max_res_size", "0x%04x",
887 rec->type.ct.type.request.max_res_size);
888 total = rec->type.ct.payload_size;
889 buffer = rec->type.ct.payload;
890 buflen = min(total, ZFCP_DBF_CT_PAYLOAD);
891 } else if (strncmp(rec->tag, "rctc", ZFCP_DBF_TAG_SIZE) == 0) {
892 len += zfcp_dbf_view(out_buf + len, "cmd_rsp_code", "0x%04x",
893 rec->type.ct.type.response.cmd_rsp_code);
894 len += zfcp_dbf_view(out_buf + len, "revision", "0x%02x",
895 rec->type.ct.type.response.revision);
896 len += zfcp_dbf_view(out_buf + len, "reason_code", "0x%02x",
897 rec->type.ct.type.response.reason_code);
898 len +=
899 zfcp_dbf_view(out_buf + len, "reason_code_expl", "0x%02x",
900 rec->type.ct.type.response.reason_code_expl);
901 len +=
902 zfcp_dbf_view(out_buf + len, "vendor_unique", "0x%02x",
903 rec->type.ct.type.response.vendor_unique);
904 total = rec->type.ct.payload_size;
905 buffer = rec->type.ct.payload;
906 buflen = min(total, ZFCP_DBF_CT_PAYLOAD);
907 } else if (strncmp(rec->tag, "oels", ZFCP_DBF_TAG_SIZE) == 0 ||
908 strncmp(rec->tag, "rels", ZFCP_DBF_TAG_SIZE) == 0 ||
909 strncmp(rec->tag, "iels", ZFCP_DBF_TAG_SIZE) == 0) {
910 len += zfcp_dbf_view(out_buf + len, "ls_code", "0x%02x",
911 rec->type.els.ls_code);
912 total = rec->type.els.payload_size;
913 buffer = rec->type.els.payload;
914 buflen = min(total, ZFCP_DBF_ELS_PAYLOAD);
915 }
916
917 len += zfcp_dbf_view_dump(out_buf + len, "payload",
918 buffer, buflen, 0, total);
919
920 if (buflen == total)
921 len += sprintf(out_buf + len, "\n");
922
923 return len;
924}
925
Heiko Carstens2b67fc42007-02-05 21:16:47 +0100926static struct debug_view zfcp_san_dbf_view = {
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200927 "structured",
928 NULL,
929 &zfcp_dbf_view_header,
930 &zfcp_san_dbf_view_format,
931 NULL,
932 NULL
933};
934
Heiko Carstens4d284ca2007-02-05 21:18:53 +0100935static void
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200936_zfcp_scsi_dbf_event_common(const char *tag, const char *tag2, int level,
937 struct zfcp_adapter *adapter,
938 struct scsi_cmnd *scsi_cmnd,
Maxim Shchetynined829ad2006-02-11 01:42:58 +0100939 struct zfcp_fsf_req *fsf_req,
Andreas Herrmann4eff4a32006-09-18 22:29:20 +0200940 unsigned long old_req_id)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200941{
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200942 struct zfcp_scsi_dbf_record *rec = &adapter->scsi_dbf_buf;
943 struct zfcp_dbf_dump *dump = (struct zfcp_dbf_dump *)rec;
944 unsigned long flags;
945 struct fcp_rsp_iu *fcp_rsp;
946 char *fcp_rsp_info = NULL, *fcp_sns_info = NULL;
947 int offset = 0, buflen = 0;
948
949 spin_lock_irqsave(&adapter->scsi_dbf_lock, flags);
950 do {
951 memset(rec, 0, sizeof(struct zfcp_scsi_dbf_record));
952 if (offset == 0) {
953 strncpy(rec->tag, tag, ZFCP_DBF_TAG_SIZE);
954 strncpy(rec->tag2, tag2, ZFCP_DBF_TAG_SIZE);
Maxim Shchetynined829ad2006-02-11 01:42:58 +0100955 if (scsi_cmnd != NULL) {
956 if (scsi_cmnd->device) {
957 rec->scsi_id = scsi_cmnd->device->id;
958 rec->scsi_lun = scsi_cmnd->device->lun;
959 }
960 rec->scsi_result = scsi_cmnd->result;
961 rec->scsi_cmnd = (unsigned long)scsi_cmnd;
962 rec->scsi_serial = scsi_cmnd->serial_number;
963 memcpy(rec->scsi_opcode, &scsi_cmnd->cmnd,
964 min((int)scsi_cmnd->cmd_len,
965 ZFCP_DBF_SCSI_OPCODE));
966 rec->scsi_retries = scsi_cmnd->retries;
967 rec->scsi_allowed = scsi_cmnd->allowed;
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200968 }
Maxim Shchetynin8a36e452005-09-13 21:50:38 +0200969 if (fsf_req != NULL) {
970 fcp_rsp = (struct fcp_rsp_iu *)
971 &(fsf_req->qtcb->bottom.io.fcp_rsp);
972 fcp_rsp_info =
973 zfcp_get_fcp_rsp_info_ptr(fcp_rsp);
974 fcp_sns_info =
975 zfcp_get_fcp_sns_info_ptr(fcp_rsp);
976
977 rec->type.fcp.rsp_validity =
978 fcp_rsp->validity.value;
979 rec->type.fcp.rsp_scsi_status =
980 fcp_rsp->scsi_status;
981 rec->type.fcp.rsp_resid = fcp_rsp->fcp_resid;
982 if (fcp_rsp->validity.bits.fcp_rsp_len_valid)
983 rec->type.fcp.rsp_code =
984 *(fcp_rsp_info + 3);
985 if (fcp_rsp->validity.bits.fcp_sns_len_valid) {
986 buflen = min((int)fcp_rsp->fcp_sns_len,
987 ZFCP_DBF_SCSI_MAX_FCP_SNS_INFO);
988 rec->type.fcp.sns_info_len = buflen;
989 memcpy(rec->type.fcp.sns_info,
990 fcp_sns_info,
991 min(buflen,
992 ZFCP_DBF_SCSI_FCP_SNS_INFO));
993 offset += min(buflen,
994 ZFCP_DBF_SCSI_FCP_SNS_INFO);
995 }
996
997 rec->fsf_reqid = (unsigned long)fsf_req;
998 rec->fsf_seqno = fsf_req->seq_no;
999 rec->fsf_issued = fsf_req->issued;
1000 }
Andreas Herrmann4eff4a32006-09-18 22:29:20 +02001001 rec->type.old_fsf_reqid = old_req_id;
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001002 } else {
1003 strncpy(dump->tag, "dump", ZFCP_DBF_TAG_SIZE);
1004 dump->total_size = buflen;
1005 dump->offset = offset;
1006 dump->size = min(buflen - offset,
1007 (int)sizeof(struct
1008 zfcp_scsi_dbf_record) -
1009 (int)sizeof(struct zfcp_dbf_dump));
1010 memcpy(dump->data, fcp_sns_info + offset, dump->size);
1011 offset += dump->size;
1012 }
1013 debug_event(adapter->scsi_dbf, level,
1014 rec, sizeof(struct zfcp_scsi_dbf_record));
1015 } while (offset < buflen);
1016 spin_unlock_irqrestore(&adapter->scsi_dbf_lock, flags);
1017}
1018
Heiko Carstens4d284ca2007-02-05 21:18:53 +01001019void
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001020zfcp_scsi_dbf_event_result(const char *tag, int level,
1021 struct zfcp_adapter *adapter,
Maxim Shchetynined829ad2006-02-11 01:42:58 +01001022 struct scsi_cmnd *scsi_cmnd,
1023 struct zfcp_fsf_req *fsf_req)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001024{
Maxim Shchetynined829ad2006-02-11 01:42:58 +01001025 _zfcp_scsi_dbf_event_common("rslt", tag, level,
Andreas Herrmann4eff4a32006-09-18 22:29:20 +02001026 adapter, scsi_cmnd, fsf_req, 0);
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001027}
1028
Heiko Carstens4d284ca2007-02-05 21:18:53 +01001029void
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001030zfcp_scsi_dbf_event_abort(const char *tag, struct zfcp_adapter *adapter,
1031 struct scsi_cmnd *scsi_cmnd,
Maxim Shchetynined829ad2006-02-11 01:42:58 +01001032 struct zfcp_fsf_req *new_fsf_req,
Andreas Herrmann4eff4a32006-09-18 22:29:20 +02001033 unsigned long old_req_id)
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001034{
Maxim Shchetynined829ad2006-02-11 01:42:58 +01001035 _zfcp_scsi_dbf_event_common("abrt", tag, 1,
Andreas Herrmann4eff4a32006-09-18 22:29:20 +02001036 adapter, scsi_cmnd, new_fsf_req, old_req_id);
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001037}
1038
Heiko Carstens4d284ca2007-02-05 21:18:53 +01001039void
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001040zfcp_scsi_dbf_event_devreset(const char *tag, u8 flag, struct zfcp_unit *unit,
1041 struct scsi_cmnd *scsi_cmnd)
1042{
1043 struct zfcp_adapter *adapter = unit->port->adapter;
1044
1045 _zfcp_scsi_dbf_event_common(flag == FCP_TARGET_RESET ? "trst" : "lrst",
Andreas Herrmann4eff4a32006-09-18 22:29:20 +02001046 tag, 1, adapter, scsi_cmnd, NULL, 0);
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001047}
1048
1049static int
1050zfcp_scsi_dbf_view_format(debug_info_t * id, struct debug_view *view,
1051 char *out_buf, const char *in_buf)
1052{
1053 struct zfcp_scsi_dbf_record *rec =
1054 (struct zfcp_scsi_dbf_record *)in_buf;
1055 int len = 0;
1056
1057 if (strncmp(rec->tag, "dump", ZFCP_DBF_TAG_SIZE) == 0)
1058 return 0;
1059
1060 len += zfcp_dbf_tag(out_buf + len, "tag", rec->tag);
1061 len += zfcp_dbf_tag(out_buf + len, "tag2", rec->tag2);
1062 len += zfcp_dbf_view(out_buf + len, "scsi_id", "0x%08x", rec->scsi_id);
1063 len += zfcp_dbf_view(out_buf + len, "scsi_lun", "0x%08x",
1064 rec->scsi_lun);
1065 len += zfcp_dbf_view(out_buf + len, "scsi_result", "0x%08x",
1066 rec->scsi_result);
1067 len += zfcp_dbf_view(out_buf + len, "scsi_cmnd", "0x%0Lx",
1068 rec->scsi_cmnd);
1069 len += zfcp_dbf_view(out_buf + len, "scsi_serial", "0x%016Lx",
1070 rec->scsi_serial);
1071 len += zfcp_dbf_view_dump(out_buf + len, "scsi_opcode",
1072 rec->scsi_opcode,
1073 ZFCP_DBF_SCSI_OPCODE,
1074 0, ZFCP_DBF_SCSI_OPCODE);
1075 len += zfcp_dbf_view(out_buf + len, "scsi_retries", "0x%02x",
1076 rec->scsi_retries);
1077 len += zfcp_dbf_view(out_buf + len, "scsi_allowed", "0x%02x",
1078 rec->scsi_allowed);
Maxim Shchetynined829ad2006-02-11 01:42:58 +01001079 if (strncmp(rec->tag, "abrt", ZFCP_DBF_TAG_SIZE) == 0) {
1080 len += zfcp_dbf_view(out_buf + len, "old_fsf_reqid", "0x%0Lx",
1081 rec->type.old_fsf_reqid);
1082 }
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001083 len += zfcp_dbf_view(out_buf + len, "fsf_reqid", "0x%0Lx",
1084 rec->fsf_reqid);
1085 len += zfcp_dbf_view(out_buf + len, "fsf_seqno", "0x%08x",
1086 rec->fsf_seqno);
1087 len += zfcp_dbf_stck(out_buf + len, "fsf_issued", rec->fsf_issued);
1088 if (strncmp(rec->tag, "rslt", ZFCP_DBF_TAG_SIZE) == 0) {
1089 len +=
1090 zfcp_dbf_view(out_buf + len, "fcp_rsp_validity", "0x%02x",
1091 rec->type.fcp.rsp_validity);
1092 len +=
1093 zfcp_dbf_view(out_buf + len, "fcp_rsp_scsi_status",
1094 "0x%02x", rec->type.fcp.rsp_scsi_status);
1095 len +=
1096 zfcp_dbf_view(out_buf + len, "fcp_rsp_resid", "0x%08x",
1097 rec->type.fcp.rsp_resid);
1098 len +=
1099 zfcp_dbf_view(out_buf + len, "fcp_rsp_code", "0x%08x",
1100 rec->type.fcp.rsp_code);
1101 len +=
1102 zfcp_dbf_view(out_buf + len, "fcp_sns_info_len", "0x%08x",
1103 rec->type.fcp.sns_info_len);
1104 len +=
1105 zfcp_dbf_view_dump(out_buf + len, "fcp_sns_info",
1106 rec->type.fcp.sns_info,
1107 min((int)rec->type.fcp.sns_info_len,
1108 ZFCP_DBF_SCSI_FCP_SNS_INFO), 0,
1109 rec->type.fcp.sns_info_len);
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001110 }
1111
1112 len += sprintf(out_buf + len, "\n");
1113
1114 return len;
1115}
1116
Heiko Carstens2b67fc42007-02-05 21:16:47 +01001117static struct debug_view zfcp_scsi_dbf_view = {
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001118 "structured",
1119 NULL,
1120 &zfcp_dbf_view_header,
1121 &zfcp_scsi_dbf_view_format,
1122 NULL,
1123 NULL
1124};
1125
1126/**
1127 * zfcp_adapter_debug_register - registers debug feature for an adapter
1128 * @adapter: pointer to adapter for which debug features should be registered
1129 * return: -ENOMEM on error, 0 otherwise
1130 */
1131int zfcp_adapter_debug_register(struct zfcp_adapter *adapter)
1132{
1133 char dbf_name[DEBUG_MAX_NAME_LEN];
1134
1135 /* debug feature area which records recovery activity */
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001136 sprintf(dbf_name, "zfcp_%s_erp", zfcp_get_busid_by_adapter(adapter));
1137 adapter->erp_dbf = debug_register(dbf_name, dbfsize, 2,
1138 sizeof(struct zfcp_erp_dbf_record));
1139 if (!adapter->erp_dbf)
1140 goto failed;
1141 debug_register_view(adapter->erp_dbf, &debug_hex_ascii_view);
1142 debug_set_level(adapter->erp_dbf, 3);
1143
Martin Peschked79a83d2008-03-27 14:22:00 +01001144 /* debug feature area which records recovery activity */
1145 sprintf(dbf_name, "zfcp_%s_rec", zfcp_get_busid_by_adapter(adapter));
1146 adapter->rec_dbf = debug_register(dbf_name, dbfsize, 1,
1147 sizeof(struct zfcp_rec_dbf_record));
1148 if (!adapter->rec_dbf)
1149 goto failed;
1150 debug_register_view(adapter->rec_dbf, &debug_hex_ascii_view);
1151 debug_register_view(adapter->rec_dbf, &zfcp_rec_dbf_view);
1152 debug_set_level(adapter->rec_dbf, 3);
1153
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001154 /* debug feature area which records HBA (FSF and QDIO) conditions */
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001155 sprintf(dbf_name, "zfcp_%s_hba", zfcp_get_busid_by_adapter(adapter));
1156 adapter->hba_dbf = debug_register(dbf_name, dbfsize, 1,
1157 sizeof(struct zfcp_hba_dbf_record));
1158 if (!adapter->hba_dbf)
1159 goto failed;
1160 debug_register_view(adapter->hba_dbf, &debug_hex_ascii_view);
1161 debug_register_view(adapter->hba_dbf, &zfcp_hba_dbf_view);
1162 debug_set_level(adapter->hba_dbf, 3);
1163
1164 /* debug feature area which records SAN command failures and recovery */
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001165 sprintf(dbf_name, "zfcp_%s_san", zfcp_get_busid_by_adapter(adapter));
1166 adapter->san_dbf = debug_register(dbf_name, dbfsize, 1,
1167 sizeof(struct zfcp_san_dbf_record));
1168 if (!adapter->san_dbf)
1169 goto failed;
1170 debug_register_view(adapter->san_dbf, &debug_hex_ascii_view);
1171 debug_register_view(adapter->san_dbf, &zfcp_san_dbf_view);
1172 debug_set_level(adapter->san_dbf, 6);
1173
1174 /* debug feature area which records SCSI command failures and recovery */
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001175 sprintf(dbf_name, "zfcp_%s_scsi", zfcp_get_busid_by_adapter(adapter));
1176 adapter->scsi_dbf = debug_register(dbf_name, dbfsize, 1,
1177 sizeof(struct zfcp_scsi_dbf_record));
1178 if (!adapter->scsi_dbf)
1179 goto failed;
1180 debug_register_view(adapter->scsi_dbf, &debug_hex_ascii_view);
1181 debug_register_view(adapter->scsi_dbf, &zfcp_scsi_dbf_view);
1182 debug_set_level(adapter->scsi_dbf, 3);
1183
1184 return 0;
1185
1186 failed:
1187 zfcp_adapter_debug_unregister(adapter);
1188
1189 return -ENOMEM;
1190}
1191
1192/**
1193 * zfcp_adapter_debug_unregister - unregisters debug feature for an adapter
1194 * @adapter: pointer to adapter for which debug features should be unregistered
1195 */
1196void zfcp_adapter_debug_unregister(struct zfcp_adapter *adapter)
1197{
1198 debug_unregister(adapter->scsi_dbf);
1199 debug_unregister(adapter->san_dbf);
1200 debug_unregister(adapter->hba_dbf);
Martin Peschked79a83d2008-03-27 14:22:00 +01001201 debug_unregister(adapter->rec_dbf);
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001202 debug_unregister(adapter->erp_dbf);
1203 adapter->scsi_dbf = NULL;
1204 adapter->san_dbf = NULL;
1205 adapter->hba_dbf = NULL;
Martin Peschked79a83d2008-03-27 14:22:00 +01001206 adapter->rec_dbf = NULL;
Maxim Shchetynin8a36e452005-09-13 21:50:38 +02001207 adapter->erp_dbf = NULL;
1208}
1209
1210#undef ZFCP_LOG_AREA