Greetings, I've made another of my occasional attempts to get IrComm working with my Dell Inspiron 7000 and an SH-888. Story so far... Win98SE no problems. I'm using IrDA irda-utils 0.9.10 Linux 2.2.12(unpatched) and 2.2.14(unpatched) connects inconsistently and I can send AT commands with cu to /dev/ircomm. Automated dialers (wvdial etc) seem to fall over but very occasionally work in which case PPP works to my ISP. Its a case of when it works it works well but most of the time it doesn't work at all: the auto dialers time out trying to communicate with the modem but mysteriously cu works just fine. I've tried lots of other kernel versions and had no joy with IrComm at all (connecting to /dev/ircomm0 of course). I tried various 2.2.15preX versions and currently 2.2.16. I can try the 2.2.17preX stuff if that might help. The symptoms on all of these are similar. I can 'cat' discovery and the SH-888 is recognised just fine. Any attempt to connect to /dev/ircomm0 however results in cu reporting a write error. I've followed the instructions re /etc/conf.modules and lsmod seems to report the various IrComm modules being loaded. I've attached some debugging info in case this helps. The first is irdadump when I attempt to connect to ircomm0 (discovery turned off). The second if the output of dmesg when I change the debugging level to 4. If there's any more info I can provide or things I can try then please let me know. I'm not familiar with the IrDA protocol itself or the code so it may take some time if I have to try and manually trace the problem. Steve.
23:41:44.018870 snrm:cmd ca=fe pf=1 4a0fd1ac > 674872ff new-ca=7e (32) 23:41:44.125320 ua:rsp ca=7e pf=1 4a0fd1ac < 674872ff (31) 23:41:44.125377 rr:cmd > ca=7e pf=1 nr=0 (2) 23:41:44.375323 rr:cmd > ca=7e pf=1 nr=0 (2) 23:41:44.875318 rr:cmd > ca=7e pf=1 nr=0 (2) 23:41:44.905318 rr:rsp < ca=7e pf=1 nr=0 (2) 23:41:44.905339 i:cmd > ca=7e pf=1 nr=0 ns=0 LM slsap=33 dlsap=00 CONN_CMD (6) 23:41:44.935319 i:rsp < ca=7e pf=1 nr=1 ns=0 LM slsap=00 dlsap=33 CONN_RSP (6) 23:41:44.935352 i:cmd > ca=7e pf=1 nr=1 ns=1 LM slsap=33 dlsap=00 GET_VALUE_BY_CLASS: "IrDA:IrCOMM" "Parameters" (28) 23:41:44.965320 i:rsp < ca=7e pf=1 nr=2 ns=1 LM slsap=00 dlsap=33 GET_VALUE_BY_CLASS: Success N/A (19) 23:41:44.965346 i:cmd > ca=7e pf=1 nr=2 ns=2 LM slsap=33 dlsap=00 DISC (6) 23:41:44.995320 rr:rsp < ca=7e pf=1 nr=3 (2) 23:41:44.995336 i:cmd > ca=7e pf=1 nr=2 ns=3 LM slsap=34 dlsap=00 CONN_CMD (6) 23:41:45.025318 i:rsp < ca=7e pf=1 nr=4 ns=2 LM slsap=00 dlsap=34 CONN_RSP (6) 23:41:45.025338 i:cmd > ca=7e pf=1 nr=3 ns=4 LM slsap=34 dlsap=00 GET_VALUE_BY_CLASS: "IrDA:IrCOMM" "IrDA:TinyTP:LsapSel" (37) 23:41:45.065319 i:rsp < ca=7e pf=1 nr=5 ns=3 LM slsap=00 dlsap=34 GET_VALUE_BY_CLASS: Success Integer: 04 (15) 23:41:45.065338 i:cmd > ca=7e pf=1 nr=4 ns=5 LM slsap=34 dlsap=00 DISC (6) 23:41:45.095318 rr:rsp < ca=7e pf=1 nr=6 (2) 23:41:45.095331 i:cmd > ca=7e pf=1 nr=4 ns=6 LM slsap=32 dlsap=04 CONN_CMD TTP credits=0(7) 23:41:45.125317 i:rsp < ca=7e pf=1 nr=7 ns=4 LM slsap=04 dlsap=32 CONN_RSP TTP credits=0(7) 23:41:45.125363 rr:cmd > ca=7e pf=1 nr=5 (2) 23:41:45.155322 i:rsp < ca=7e pf=1 nr=7 ns=5 LM slsap=04 dlsap=32 TTP credits=0 (29) 23:41:45.155376 i:cmd > ca=7e pf=1 nr=6 ns=7 LM slsap=32 dlsap=04 TTP credits=0 (24) 23:41:45.185321 i:rsp < ca=7e pf=1 nr=0 ns=6 LM slsap=04 dlsap=32 TTP credits=1 (5) 23:41:45.185342 i:cmd > ca=7e pf=1 nr=7 ns=0 LM slsap=32 dlsap=04 DISC (6) 23:41:45.215317 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.215328 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.245329 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.255321 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.285316 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.305315 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.335316 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.365317 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.395317 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.435316 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.465316 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.515315 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.545317 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.605315 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.635317 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.705316 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.735317 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.815317 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.845316 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:45.935316 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:45.965316 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:46.065316 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:46.095317 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:46.195316 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:46.225316 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:46.325315 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:46.355318 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:46.455375 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:46.485316 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:46.585315 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:46.615319 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:46.715317 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:46.745316 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:46.845315 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:46.875317 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:46.975316 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:47.005319 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:47.105326 rr:cmd > ca=7e pf=1 nr=7 (2) 23:41:47.135316 rr:rsp < ca=7e pf=1 nr=1 (2) 23:41:47.155324 disc:cmd > ca=0x7e pf=1 (2) 23:41:47.175318 ua:rsp ca=7e pf=1 10040100 < 01023284 (2) 66 packets received by filter
_xmit_p(), POLL_TIMER_EXPIRED (104620) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104623) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=4 (104623) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104627) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104630) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=5 (104630) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104635) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104638) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=6 (104638) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104644) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104647) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=7 (104647) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104654) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104657) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=8 (104657) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104665) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104668) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=9 (104668) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104677) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104680) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104680) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104690) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104693) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104693) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104703) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104706) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104706) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104716) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104719) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104719) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104729) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104732) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104732) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104742) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104745) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104745) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104755) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104758) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104758) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104768) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104771) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104771) ircomm_tty_close() ircomm_tty_close(), returning 1 irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104781) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104784) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104784) irlap_do_event(), event = POLL_TIMER_EXPIRED, state = LAP_XMIT_P irlap_state_xmit_p(), POLL_TIMER_EXPIRED (104794) async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_NRM_P irtty_receive_buf(104797) irlap_do_event(), event = RECV_RR_RSP, state = LAP_NRM_P irlap_validate_nr_received(), expected! next LAP state = LAP_XMIT_P irlap_start_poll_timer(), timeout=10 (104797) irlmp_idle_timer_expired() irlmp_do_lap_event(), EVENT = LM_LAP_IDLE_TIMEOUT, STATE = LAP_ACTIVE irlmp_state_active() irlmp_next_lap_state(), LMP LAP = LAP_STANDBY irlap_disconnect_request() irlap_do_event(), event = DISCONNECT_REQUEST, state = LAP_XMIT_P irlap_send_disc_frame() async_wrap_skb_R4987a0cf(), xbofs=115 next LAP state = LAP_PCLOSE irtty_receive_buf(104801) irlap_do_event(), event = RECV_UA_RSP, state = LAP_PCLOSE irlap_state_pclose() irlap_apply_default_connection_parameters() irlap_change_speed(), setting speed to 9600 irda_device_change_speed() irtty_net_ioctl(), irda0, (cmd=0x89F2) irda_task_execute_Rf78752ee() hashbin_insert_Rd3002c1b() enqueue_first() irda_task_kick_R0c99734b() irtty_change_speed(), <104801> irda_task_next_state_R55d25a36(), state = IRDA_TASK_WAIT irda_task_next_state_R55d25a36(), state = IRDA_TASK_CHILD_DONE irda_device_set_media_busy_Rbd25969f(TRUE) Media busy! next LAP state = LAP_NDM irlap_disconnect_indication(), reason=LAP_DISC_INDICATION irda_free_compression() irlmp_link_disconnect_indication() irlmp_do_lap_event(), EVENT = LM_LAP_DISCONNECT_INDICATION, STATE = LAP_STANDBY irlmp_state_standby() irlmp_state_standby(), Error LM_LAP_DISCONNECT_INDICATION irlmp_next_lap_state(), LMP LAP = LAP_STANDBY irda_task_timer_expired() irda_task_kick_R0c99734b() irtty_change_speed(), <104803> __irtty_change_speed(), Setting speed to 9600 irda_task_next_state_R55d25a36(), state = IRDA_TASK_DONE hashbin_remove_R4015e32f() dequeue_general() irda_device_set_media_busy_Rbd25969f(FALSE) irlmp_discovery_timer_expired() irlmp_discovery_timer_expired() irlmp_discovery_timer_expired()
