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);
557 		DEBUGP(5, dev, "Timeout reading num_bytes_read\n");
562 	DEBUGP(5, dev, "Reset the CARDMAN CONTROLLER\n");
566 	DEBUGP(5, dev, "Read PPS reply\n");
573 	DEBUGP(2, dev, "PTSreply: ");
580 	DEBUGP(5, dev, "Clear Tactive in Flags1\n");
600 	DEBUGP(3, dev, "<- set_protocol\n");
631 	DEBUGP(3, dev, "-> terminate_monitor\n");  in terminate_monitor()
641 	DEBUGP(5, dev, "Now allow last cycle of monitor!\n");  in terminate_monitor()
645 	DEBUGP(5, dev, "Delete timer\n");  in terminate_monitor()
651 	DEBUGP(3, dev, "<- terminate_monitor\n");  in terminate_monitor()
670 	DEBUGP(7, dev, "->  monitor_card\n");  in monitor_card()
674 		DEBUGP(4, dev, "About to stop monitor\n");  in monitor_card()
683 		DEBUGP(2, dev, "<- monitor_card (we are done now)\n");  in monitor_card()
689 		DEBUGP(4, dev, "Couldn't get IO lock\n");  in monitor_card()
695 	DEBUGP(7, dev, "dev->flags0 = 0x%2x\n", dev->flags0);  in monitor_card()
696 	DEBUGP(7, dev, "smartcard present: %s\n",  in monitor_card()
698 	DEBUGP(7, dev, "cardman present: %s\n",  in monitor_card()
712 			DEBUGP(4, dev, "set IS_CMM_ABSENT bit\n");  in monitor_card()
715 			DEBUGP(4, dev, "clear IS_CMM_ABSENT bit "  in monitor_card()
724 		DEBUGP(4, dev, "clear IS_CMM_ABSENT bit (card is inserted)\n");  in monitor_card()
729 		DEBUGP(7, dev, "believe ATR is already valid (do nothing)\n");  in monitor_card()
736 		DEBUGP(4, dev, "M_CARDOFF\n");  in monitor_card()
759 		DEBUGP(4, dev, "M_FETCH_ATR\n");  in monitor_card()
761 		DEBUGP(4, dev, "Reset BAUDV to 9600\n");  in monitor_card()
773 		DEBUGP(4, dev, "M_TIMEOUT_WAIT\n");  in monitor_card()
780 		DEBUGP(4, dev, "M_READ_ATR_LEN\n");  in monitor_card()
795 		DEBUGP(4, dev, "Current ATR_LEN = %i\n", dev->atr_len);  in monitor_card()
798 		DEBUGP(4, dev, "M_READ_ATR\n");  in monitor_card()
805 		DEBUGP(4, dev, "Deactivate T_Active flags\n");  in monitor_card()
824 			DEBUGP(4, dev, "monitor_card: ATR valid\n");  in monitor_card()
831 				DEBUGP(4, dev, "Perform AUTOPPS\n");  in monitor_card()
839 					DEBUGP(4, dev, "AUTOPPS ret SUCC\n");  in monitor_card()
843 					DEBUGP(4, dev, "AUTOPPS failed: "  in monitor_card()
861 					DEBUGP(4, dev, "AUTOPPS already active "  in monitor_card()
864 					DEBUGP(4, dev, "No AUTOPPS necessary "  in monitor_card()
868 					DEBUGP(4, dev, "Do NOT perform AUTOPPS "  in monitor_card()
874 			DEBUGP(4, dev, "ATR invalid\n");  in monitor_card()
879 		DEBUGP(4, dev, "M_BAD_CARD\n");  in monitor_card()
885 				DEBUGP(4, dev, "ATR checksum (0x%.2x, should "  in monitor_card()
890 				DEBUGP(4, dev, "ATR length error\n");  in monitor_card()
892 				DEBUGP(4, dev, "card damaged or wrong way "  in monitor_card()
904 		DEBUGP(7, dev, "Unknown action\n");  in monitor_card()
909 	DEBUGP(7, dev, "release_io\n");  in monitor_card()
914 	DEBUGP(7, dev, "<- monitor_card (returns with timer)\n");  in monitor_card()
929 	DEBUGP(2, dev, "-> cmm_read(%s,%d)\n", current->comm, current->pid);  in cmm_read()
987 	DEBUGP(4, dev, "begin read answer\n");  in cmm_read()
992 	DEBUGP(4, dev, "read1 j=%d\n", j);  in cmm_read()
999 		DEBUGP(4, dev, "read2 j=%d\n", j);  in cmm_read()
1009 		DEBUGP(4, dev, "T=0 and count > buffer\n");  in cmm_read()
1019 	DEBUGP(4, dev, "Clear T1Active\n");  in cmm_read()
1040 	DEBUGP(2, dev, "<- cmm_read returns: rc = %Zi\n",  in cmm_read()
1059 	DEBUGP(2, dev, "-> cmm_write(%s,%d)\n", current->comm, current->pid);  in cmm_write()
1066 		DEBUGP(4, dev, "T0 short write\n");  in cmm_write()
1079 		DEBUGP(4, dev, "bad csum\n");  in cmm_write()
1104 		DEBUGP(4, dev, "invalid ATR\n");  in cmm_write()
1130 			DEBUGP(4, dev, "IO error\n");  in cmm_write()
1155 	DEBUGP(1, dev, "set dev->flags1 = 0x%.2x\n", dev->flags1);  in cmm_write()
1159 	DEBUGP(4, dev, "Xmit data\n");  in cmm_write()
1168 			DEBUGP(4, dev, "dev->flags = 0x%.2x - set address "  in cmm_write()
1173 			DEBUGP(4, dev, "Apply inverse convention for 0x%.2x "  in cmm_write()
1184 	DEBUGP(4, dev, "Xmit done\n");  in cmm_write()
1189 			DEBUGP(4, dev, "T=0 assumes 0 byte reply\n");  in cmm_write()
1214 		DEBUGP(4, dev, "T=0 set Procedure byte (inverse-reverse) "  in cmm_write()
1218 		DEBUGP(4, dev, "T=0 set Procedure byte 0x%.2x\n", dev->sbuf[1]);  in cmm_write()
1222 	DEBUGP(1, dev, "set NumSendBytes = 0x%.2x\n",  in cmm_write()
1226 	DEBUGP(1, dev, "Trigger CARDMAN CONTROLLER (0x%.2x)\n",  in cmm_write()
1239 		DEBUGP(4, dev, "Wait for xmit done\n");  in cmm_write()
1246 			DEBUGP(4, dev, "timeout waiting for xmit done\n");  in cmm_write()
1261 				DEBUGP(4, dev, "infolen=%d\n", infolen);  in cmm_write()
1267 			DEBUGP(4, dev, "timeout waiting for infoLen\n");  in cmm_write()
1285 			DEBUGP(1, dev, "NumRecBytes inc (reset timeout)\n");  in cmm_write()
1299 				DEBUGP(1, dev, "NoProcedure byte set\n");  in cmm_write()
1303 				DEBUGP(1, dev, "NoProcedure byte unset "  in cmm_write()
1306 				DEBUGP(1, dev, "Read procedure byte 0x%.2x\n",  in cmm_write()
1311 				DEBUGP(1, dev, "T0Done flag (read reply)\n");  in cmm_write()
1319 		DEBUGP(1, dev, "timeout waiting for numRecBytes\n");  in cmm_write()
1324 			DEBUGP(1, dev, "Wait for T0Done bit to be  set\n");  in cmm_write()
1331 				DEBUGP(1, dev, "timeout waiting for T0Done\n");  in cmm_write()
1337 			DEBUGP(4, dev, "Read procedure byte 0x%.2x\n",  in cmm_write()
1341 			DEBUGP(4, dev, "Read NumRecBytes = %i\n", dev->rlen);  in cmm_write()
1347 	DEBUGP(4, dev, "dev->rlen = %i,  dev->rpos = %i, nr = %i\n",  in cmm_write()
1351 	DEBUGP(4, dev, "Reset SM\n");  in cmm_write()
1355 		DEBUGP(4, dev, "Write failed but clear T_Active\n");  in cmm_write()
1368 	DEBUGP(2, dev, "<- cmm_write\n");  in cmm_write()
1374 	DEBUGP(3, dev, "-> start_monitor\n");  in start_monitor()
1376 		DEBUGP(5, dev, "create, init and add timer\n");  in start_monitor()
1381 		DEBUGP(5, dev, "monitor already running\n");  in start_monitor()
1382 	DEBUGP(3, dev, "<- start_monitor\n");  in start_monitor()
1387 	DEBUGP(3, dev, "-> stop_monitor\n");  in stop_monitor()
1389 		DEBUGP(5, dev, "stopping monitor\n");  in stop_monitor()
1395 		DEBUGP(5, dev, "monitor already stopped\n");  in stop_monitor()
1396 	DEBUGP(3, dev, "<- stop_monitor\n");  in stop_monitor()
1416 	DEBUGP(3, dev, "cmm_ioctl(device=%d.%d) %s\n", imajor(inode),  in cmm_ioctl()
1424 		DEBUGP(4, dev, "DEV_OK false\n");  in cmm_ioctl()
1429 		DEBUGP(4, dev, "CMM_ABSENT flag set\n");  in cmm_ioctl()
1435 		DEBUGP(4, dev, "ioctype mismatch\n");  in cmm_ioctl()
1439 		DEBUGP(4, dev, "iocnr mismatch\n");  in cmm_ioctl()
1444 	DEBUGP(4, dev, "iocdir=%.4x iocr=%.4x iocw=%.4x iocsize=%d cmd=%.4x\n",  in cmm_ioctl()
1459 		DEBUGP(4, dev, " ... in CM_IOCGSTATUS\n");  in cmm_ioctl()
1479 		DEBUGP(4, dev, "... in CM_IOCGATR\n");  in cmm_ioctl()
1517 		DEBUGP(4, dev, "... in CM_IOCARDOFF\n");  in cmm_ioctl()
1519 			DEBUGP(4, dev, "    Card inserted\n");  in cmm_ioctl()
1521 			DEBUGP(2, dev, "    No card inserted\n");  in cmm_ioctl()
1524 			DEBUGP(4, dev, "    Card powered\n");  in cmm_ioctl()
1526 			DEBUGP(2, dev, "    Card not powered\n");  in cmm_ioctl()
1546 			DEBUGP(4, dev, "Set Flags0=0x42 \n");  in cmm_ioctl()
1581 			DEBUGP(4, dev, "... in CM_IOCSPTS\n");  in cmm_ioctl()
1624 		DEBUGP(4, dev, "... in default (unknown IOCTL code)\n");  in cmm_ioctl()
1657 	DEBUGP(2, dev, "-> cmm_open(device=%d.%d process=%s,%d)\n",  in cmm_open()
1684 	DEBUGP(2, dev, "<- cmm_open\n");  in cmm_open()
1706 	DEBUGP(2, dev, "-> cmm_close(maj/min=%d.%d)\n",  in cmm_close()
1716 	DEBUGP(2, dev, "cmm_close\n");  in cmm_close()
1727 	DEBUGP(3, dev, "-> cmm_cm4000_release\n");  in cmm_cm4000_release()
1738 	DEBUGP(3, dev, "<- cmm_cm4000_release\n");  in cmm_cm4000_release()