52 #define DEBUGP(n, rdr, x, args...) do { 		\  macro
325 	DEBUGP(3, dev, "-> parse_atr: dev->atr_len = %i\n", dev->atr_len);  in parse_atr()
328 		DEBUGP(5, dev, "parse_atr: atr_len < 3\n");  in parse_atr()
346 			DEBUGP(5, dev, "Card says FiDi is 0x%.2x\n", dev->ta1);  in parse_atr()
353 		DEBUGP(5, dev, "Yi=%.2x\n", ch & 0xf0);  in parse_atr()
363 				DEBUGP(5, dev, "card is capable of T=1\n");  in parse_atr()
366 				DEBUGP(5, dev, "card is capable of T=0\n");  in parse_atr()
372 	DEBUGP(5, dev, "ix=%d noHist=%d any_t1=%d\n",  in parse_atr()
375 		DEBUGP(5, dev, "length error\n");  in parse_atr()
388 			DEBUGP(5, dev, "bad checksum\n");  in parse_atr()
426 	DEBUGP(3, dev, "-> set_cardparameter\n");  in set_cardparameter()
430 	DEBUGP(5, dev, "flags1 = 0x%02x\n", dev->flags1);  in set_cardparameter()
435 	DEBUGP(5, dev, "baudv = %i -> write 0x%02x\n", dev->baudv,  in set_cardparameter()
446 	DEBUGP(3, dev, "<- set_cardparameter\n");  in set_cardparameter()
460 	DEBUGP(3, dev, "-> set_protocol\n");  in set_protocol()
461 	DEBUGP(5, dev, "ptsreq->Protocol = 0x%.8x, ptsreq->Flags=0x%.8x, "  in set_protocol()
477 	DEBUGP(5, dev, "Ta(1) from ATR is 0x%.2x\n", dev->ta1);  in set_protocol()
484 	DEBUGP(5, dev, "pts0=%.2x, pts1=%.2x, pts2=%.2x, pts3=%.2x\n",  in set_protocol()
495 	DEBUGP(5, dev, "Enable access to the messages buffer\n");  in set_protocol()
501 	DEBUGP(5, dev, "Enable message buffer -> flags1 = 0x%.2x\n",  in set_protocol()
505 	DEBUGP(5, dev, "Write challenge to buffer: ");  in set_protocol()
518 	DEBUGP(5, dev, "Set number of bytes to write\n");
526 	DEBUGP(5, dev, "Waiting for NumRecBytes getting valid\n");
530 			DEBUGP(5, dev, "NumRecBytes is valid\n");
536 		DEBUGP(5, dev, "Timeout waiting for NumRecBytes getting "
542 	DEBUGP(5, dev, "Reading NumRecBytes\n");
546 			DEBUGP(2, dev, "NumRecBytes = %i\n", num_bytes_read);
561 		DEBUGP(5, dev, "Timeout reading num_bytes_read\n");
566 	DEBUGP(5, dev, "Reset the CARDMAN CONTROLLER\n");
570 	DEBUGP(5, dev, "Read PPS reply\n");
577 	DEBUGP(2, dev, "PTSreply: ");
584 	DEBUGP(5, dev, "Clear Tactive in Flags1\n");
604 	DEBUGP(3, dev, "<- set_protocol\n");
635 	DEBUGP(3, dev, "-> terminate_monitor\n");  in terminate_monitor()
645 	DEBUGP(5, dev, "Now allow last cycle of monitor!\n");  in terminate_monitor()
649 	DEBUGP(5, dev, "Delete timer\n");  in terminate_monitor()
655 	DEBUGP(3, dev, "<- terminate_monitor\n");  in terminate_monitor()
674 	DEBUGP(7, dev, "->  monitor_card\n");  in monitor_card()
678 		DEBUGP(4, dev, "About to stop monitor\n");  in monitor_card()
687 		DEBUGP(2, dev, "<- monitor_card (we are done now)\n");  in monitor_card()
693 		DEBUGP(4, dev, "Couldn't get IO lock\n");  in monitor_card()
699 	DEBUGP(7, dev, "dev->flags0 = 0x%2x\n", dev->flags0);  in monitor_card()
700 	DEBUGP(7, dev, "smartcard present: %s\n",  in monitor_card()
702 	DEBUGP(7, dev, "cardman present: %s\n",  in monitor_card()
716 			DEBUGP(4, dev, "set IS_CMM_ABSENT bit\n");  in monitor_card()
719 			DEBUGP(4, dev, "clear IS_CMM_ABSENT bit "  in monitor_card()
728 		DEBUGP(4, dev, "clear IS_CMM_ABSENT bit (card is inserted)\n");  in monitor_card()
733 		DEBUGP(7, dev, "believe ATR is already valid (do nothing)\n");  in monitor_card()
741 		DEBUGP(4, dev, "M_CARDOFF\n");  in monitor_card()
765 		DEBUGP(4, dev, "M_FETCH_ATR\n");  in monitor_card()
767 		DEBUGP(4, dev, "Reset BAUDV to 9600\n");  in monitor_card()
779 		DEBUGP(4, dev, "M_TIMEOUT_WAIT\n");  in monitor_card()
786 		DEBUGP(4, dev, "M_READ_ATR_LEN\n");  in monitor_card()
801 		DEBUGP(4, dev, "Current ATR_LEN = %i\n", dev->atr_len);  in monitor_card()
804 		DEBUGP(4, dev, "M_READ_ATR\n");  in monitor_card()
811 		DEBUGP(4, dev, "Deactivate T_Active flags\n");  in monitor_card()
830 			DEBUGP(4, dev, "monitor_card: ATR valid\n");  in monitor_card()
837 				DEBUGP(4, dev, "Perform AUTOPPS\n");  in monitor_card()
845 					DEBUGP(4, dev, "AUTOPPS ret SUCC\n");  in monitor_card()
849 					DEBUGP(4, dev, "AUTOPPS failed: "  in monitor_card()
867 					DEBUGP(4, dev, "AUTOPPS already active "  in monitor_card()
870 					DEBUGP(4, dev, "No AUTOPPS necessary "  in monitor_card()
874 					DEBUGP(4, dev, "Do NOT perform AUTOPPS "  in monitor_card()
880 			DEBUGP(4, dev, "ATR invalid\n");  in monitor_card()
885 		DEBUGP(4, dev, "M_BAD_CARD\n");  in monitor_card()
891 				DEBUGP(4, dev, "ATR checksum (0x%.2x, should "  in monitor_card()
896 				DEBUGP(4, dev, "ATR length error\n");  in monitor_card()
898 				DEBUGP(4, dev, "card damaged or wrong way "  in monitor_card()
910 		DEBUGP(7, dev, "Unknown action\n");  in monitor_card()
915 	DEBUGP(7, dev, "release_io\n");  in monitor_card()
920 	DEBUGP(7, dev, "<- monitor_card (returns with timer)\n");  in monitor_card()
935 	DEBUGP(2, dev, "-> cmm_read(%s,%d)\n", current->comm, current->pid);  in cmm_read()
993 	DEBUGP(4, dev, "begin read answer\n");  in cmm_read()
998 	DEBUGP(4, dev, "read1 j=%d\n", j);  in cmm_read()
1005 		DEBUGP(4, dev, "read2 j=%d\n", j);  in cmm_read()
1015 		DEBUGP(4, dev, "T=0 and count > buffer\n");  in cmm_read()
1025 	DEBUGP(4, dev, "Clear T1Active\n");  in cmm_read()
1046 	DEBUGP(2, dev, "<- cmm_read returns: rc = %zi\n",  in cmm_read()
1065 	DEBUGP(2, dev, "-> cmm_write(%s,%d)\n", current->comm, current->pid);  in cmm_write()
1072 		DEBUGP(4, dev, "T0 short write\n");  in cmm_write()
1085 		DEBUGP(4, dev, "bad csum\n");  in cmm_write()
1110 		DEBUGP(4, dev, "invalid ATR\n");  in cmm_write()
1136 			DEBUGP(4, dev, "IO error\n");  in cmm_write()
1161 	DEBUGP(1, dev, "set dev->flags1 = 0x%.2x\n", dev->flags1);  in cmm_write()
1165 	DEBUGP(4, dev, "Xmit data\n");  in cmm_write()
1174 			DEBUGP(4, dev, "dev->flags = 0x%.2x - set address "  in cmm_write()
1179 			DEBUGP(4, dev, "Apply inverse convention for 0x%.2x "  in cmm_write()
1190 	DEBUGP(4, dev, "Xmit done\n");  in cmm_write()
1195 			DEBUGP(4, dev, "T=0 assumes 0 byte reply\n");  in cmm_write()
1220 		DEBUGP(4, dev, "T=0 set Procedure byte (inverse-reverse) "  in cmm_write()
1224 		DEBUGP(4, dev, "T=0 set Procedure byte 0x%.2x\n", dev->sbuf[1]);  in cmm_write()
1228 	DEBUGP(1, dev, "set NumSendBytes = 0x%.2x\n",  in cmm_write()
1232 	DEBUGP(1, dev, "Trigger CARDMAN CONTROLLER (0x%.2x)\n",  in cmm_write()
1245 		DEBUGP(4, dev, "Wait for xmit done\n");  in cmm_write()
1252 			DEBUGP(4, dev, "timeout waiting for xmit done\n");  in cmm_write()
1267 				DEBUGP(4, dev, "infolen=%d\n", infolen);  in cmm_write()
1273 			DEBUGP(4, dev, "timeout waiting for infoLen\n");  in cmm_write()
1291 			DEBUGP(1, dev, "NumRecBytes inc (reset timeout)\n");  in cmm_write()
1305 				DEBUGP(1, dev, "NoProcedure byte set\n");  in cmm_write()
1309 				DEBUGP(1, dev, "NoProcedure byte unset "  in cmm_write()
1312 				DEBUGP(1, dev, "Read procedure byte 0x%.2x\n",  in cmm_write()
1317 				DEBUGP(1, dev, "T0Done flag (read reply)\n");  in cmm_write()
1325 		DEBUGP(1, dev, "timeout waiting for numRecBytes\n");  in cmm_write()
1330 			DEBUGP(1, dev, "Wait for T0Done bit to be  set\n");  in cmm_write()
1337 				DEBUGP(1, dev, "timeout waiting for T0Done\n");  in cmm_write()
1343 			DEBUGP(4, dev, "Read procedure byte 0x%.2x\n",  in cmm_write()
1347 			DEBUGP(4, dev, "Read NumRecBytes = %i\n", dev->rlen);  in cmm_write()
1353 	DEBUGP(4, dev, "dev->rlen = %i,  dev->rpos = %i, nr = %i\n",  in cmm_write()
1357 	DEBUGP(4, dev, "Reset SM\n");  in cmm_write()
1361 		DEBUGP(4, dev, "Write failed but clear T_Active\n");  in cmm_write()
1374 	DEBUGP(2, dev, "<- cmm_write\n");  in cmm_write()
1380 	DEBUGP(3, dev, "-> start_monitor\n");  in start_monitor()
1382 		DEBUGP(5, dev, "create, init and add timer\n");  in start_monitor()
1387 		DEBUGP(5, dev, "monitor already running\n");  in start_monitor()
1388 	DEBUGP(3, dev, "<- start_monitor\n");  in start_monitor()
1393 	DEBUGP(3, dev, "-> stop_monitor\n");  in stop_monitor()
1395 		DEBUGP(5, dev, "stopping monitor\n");  in stop_monitor()
1401 		DEBUGP(5, dev, "monitor already stopped\n");  in stop_monitor()
1402 	DEBUGP(3, dev, "<- stop_monitor\n");  in stop_monitor()
1421 	DEBUGP(3, dev, "cmm_ioctl(device=%d.%d) %s\n", imajor(inode),  in cmm_ioctl()
1429 		DEBUGP(4, dev, "DEV_OK false\n");  in cmm_ioctl()
1434 		DEBUGP(4, dev, "CMM_ABSENT flag set\n");  in cmm_ioctl()
1440 		DEBUGP(4, dev, "ioctype mismatch\n");  in cmm_ioctl()
1444 		DEBUGP(4, dev, "iocnr mismatch\n");  in cmm_ioctl()
1451 		DEBUGP(4, dev, " ... in CM_IOCGSTATUS\n");  in cmm_ioctl()
1471 		DEBUGP(4, dev, "... in CM_IOCGATR\n");  in cmm_ioctl()
1509 		DEBUGP(4, dev, "... in CM_IOCARDOFF\n");  in cmm_ioctl()
1511 			DEBUGP(4, dev, "    Card inserted\n");  in cmm_ioctl()
1513 			DEBUGP(2, dev, "    No card inserted\n");  in cmm_ioctl()
1516 			DEBUGP(4, dev, "    Card powered\n");  in cmm_ioctl()
1518 			DEBUGP(2, dev, "    Card not powered\n");  in cmm_ioctl()
1538 			DEBUGP(4, dev, "Set Flags0=0x42 \n");  in cmm_ioctl()
1573 			DEBUGP(4, dev, "... in CM_IOCSPTS\n");  in cmm_ioctl()
1616 		DEBUGP(4, dev, "... in default (unknown IOCTL code)\n");  in cmm_ioctl()
1649 	DEBUGP(2, dev, "-> cmm_open(device=%d.%d process=%s,%d)\n",  in cmm_open()
1676 	DEBUGP(2, dev, "<- cmm_open\n");  in cmm_open()
1698 	DEBUGP(2, dev, "-> cmm_close(maj/min=%d.%d)\n",  in cmm_close()
1708 	DEBUGP(2, dev, "cmm_close\n");  in cmm_close()
1719 	DEBUGP(3, dev, "-> cmm_cm4000_release\n");  in cmm_cm4000_release()
1730 	DEBUGP(3, dev, "<- cmm_cm4000_release\n");  in cmm_cm4000_release()