[Prism54-devel] [Bug 2] islpci_mgt_response(): queue empty, retrying (jiffies left = 90

bugzilla-daemon@mcgrof.com bugzilla-daemon@mcgrof.com
Wed, 28 Jan 2004 22:20:57 +0000 (UTC)


http://prism54.org/cgi-bin/bugzilla/show_bug.cgi?id=2

avvisi@spalletti.it changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
                 CC|                            |avvisi@spalletti.it

marcus.better@abc.se changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
                 CC|                            |marcus.better@abc.se

mcgrof@ruslug.rutgers.edu changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
             Status|NEW                         |ASSIGNED

kate.ward@forestent.com changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
                 CC|                            |kate.ward@forestent.com

mcgrof@ruslug.rutgers.edu changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
             Status|ASSIGNED                    |RESOLVED
         Resolution|                            |FIXED

mathiasb@email.dk changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
             Status|RESOLVED                    |REOPENED
         OS/Version|Linux 2.4                   |Linux 2.6
         Resolution|FIXED                       |

Jens.Maurer@gmx.net changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
             Status|REOPENED                    |RESOLVED
         Resolution|                            |FIXED



------- Additional Comments From nthiery@users.sf.net  2003-11-17 19:17 -------
I had the exact same symptoms with a Fedora Core 1 distrib + linux 2.6-test9. 
 
Nov 17 23:53:03 eole kernel: Loaded prism54 driver, version 1.0.2.2 
Nov 17 23:53:03 eole kernel: PCI: Enabling device 0000:06:00.0 (0000 -> 0002) 
Nov 17 23:53:23 eole kernel: islpci_mgt_response(): queue empty, retrying 
(jiffies left = 
 900 
... 
 
Furthermore, the kernel freezed consistently as soon when the redhat network 
tools tried to call pump on that interface. 
 
Hope that helps ... 

------- Additional Comments From mycroft@virgaria.org  2003-11-19 17:43 -------
I get the same problem with a pcmcia netgear wg511;
I can't use the card, but, sometimes, I can launch a successful "iwlist eth0
scanning" or "iwconfig eth0", and just after, I get theses timeout messages.
A "ifconfig eth0 down && ifconfig eth0 up" allows me to try one again.

------- Additional Comments From bugzilla@waglers.net  2003-11-22 22:15 -------
The same problems here: "islpci_mgt_response(): queue empty, retrying 
(jiffies [...]".

That's what's been logged before the system did nothing more (freeze ?!):

kernel: eth1: islpci_open()
kernel: eth1: resetting device...
kernel: eth1: uploading firmware...
kernel: eth1: firmware uploaded done, now triggering reset...
kernel: eth1: prism54_mib_init()
kernel: ------------[ cut here ]------------
kernel: kernel BUG at /data/src/kernel/kernel-2.6.
0-test9/prism54/prism54-cvs/prism54-ng/ksrc/isl_ioctl.c:233!
kernel: invalid operand: 0000 [#1]
kernel: CPU:    0
kernel: EIP:    0060:[_end+542000442/1068698488]    Not tainted
kernel: EFLAGS: 00010246
kernel: EIP is at prism54_mib_init+0xf86/0x1027 [prism54]
kernel: eax: 00000000   ebx: d741f200   ecx: 00000000   edx: d741f80c
kernel: esi: d741f208   edi: 00000297   ebp: dffc5e00   esp: dff89df4
kernel: ds: 007b   es: 007b   ss: 0068
kernel: Process events/0 (pid: 4, threadinfo=dff88000 task=dff8e6b0)
kernel: Stack: d741f80c d741f6f8 dff89f54 dff89f58 dff89f5c dff89f60 00000000 
dff8e6b0
kernel:        c150bc80 d427bfbc c011bfe1 dff89e74 00000046 00000001 000000d0 
dffed3c0
kernel:        00000004 dffef940 dadf7940 c013eacb dffef940 000000d0 dff89e64 
dadf7940
kernel: Call Trace:
kernel:  [schedule+817/1575] schedule+0x331/0x627
kernel:  [cache_alloc_refill+362/539] cache_alloc_refill+0x16a/0x21b
kernel:  [wait_for_completion+121/183] wait_for_completion+0x79/0xb7
kernel:  [default_wake_function+0/46] default_wake_function+0x0/0x2e
kernel:  [copy_process+1844/2804] copy_process+0x734/0xaf4
kernel:  [default_wake_function+0/46] default_wake_function+0x0/0x2e
kernel:  [recalc_task_prio+144/426] recalc_task_prio+0x90/0x1aa
kernel:  [schedule+817/1575] schedule+0x331/0x627
kernel:  [__wake_up_common+56/87] __wake_up_common+0x38/0x57
kernel:  [worker_thread+446/643] worker_thread+0x1be/0x283
kernel:  [_end+541996468/1068698488] prism54_mib_init+0x0/0x1027 [prism54]
kernel:  [default_wake_function+0/46] default_wake_function+0x0/0x2e
kernel:  [ret_from_fork+6/20] ret_from_fork+0x6/0x14
kernel:  [default_wake_function+0/46] default_wake_function+0x0/0x2e
kernel:  [worker_thread+0/643] worker_thread+0x0/0x283
kernel:  [kernel_thread_helper+5/11] kernel_thread_helper+0x5/0xb
kernel:
kernel: Code: 0f 0b e9 00 40 93 9b e0 e9 a0 f2 ff ff 8b 84 24 6c 01 00 00


(BTW: There's a bug in bugzilla's login procedure: the system claims a single 
hyphen is not allowed in email address)

------- Additional Comments From mcgrof@ruslug.rutgers.edu  2003-12-04 02:21 -------
The last part may have been fixed with the new spinlocks. Please try the cvs
snapshot driver in client mode only and let us know if this fixed it.

------- Additional Comments From kate.ward@forestent.com  2003-12-05 17:25 -------
This bug is fixed for me too (although the card still does not find a link)

Kernel: 2.4.23
Card: Netgear WG511
Hotplug: CVS 2003-11-20
Firmware: 1.0.4.3
OS: Mandrake 9.2
Hardware: Fuijtsu Siemens Lifebook E Series; Intel P4 2GHz

------- Additional Comments From mcgrof@ruslug.rutgers.edu  2003-12-17 22:37 -------
This has been fixed with the latest releases. 

------- Additional Comments From mathiasb@email.dk  2004-01-13 08:50 -------
Hello

I still have this problem with my SMC2835W PCMCIA card on kernel 2.6.1 (on 2.6
too). I have tried loads of snapshots and the newest one too, but i still get
this when i start the 
card:

>ifconfig eth1 up
>iwconfig eth1 essid "$1"
>dhcpcd eth1

gives me this in dmesg:
eth1: islpci_open()
eth1: resetting device...
eth1: uploading firmware...
eth1: firmware uploaded done, now triggering reset...
eth1: prism54_mib_init()
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 1000
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 900
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 800
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 700
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 600
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 500
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 400
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 300
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 200
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 100
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 0
islpci_mgt_response(): flushed 1 entries
TRAP: oid 0x18000001, device 3, flags 0x0 length 12
TRAP: oid 0x18000001, device 3, flags 0x0 length 12
TRAP: oid 0x18000003, device 3, flags 0x0 length 12
TRAP: oid 0x1, device 3, flags 0x0 length 4
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 1000
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 900
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 800
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 700
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 600
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 500
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 400
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 300
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 200
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 100
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 0
islpci_mgt_response(): flushed 1 entries
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 999
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 899
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 799
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 699
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 599
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 499
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 399
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 299
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 199
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 99
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = -1
islpci_mgt_response(): flushed 1 entries
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 999
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 899
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 799
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 699
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 599
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 499
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 399
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 299
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 199
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 99
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = -1
islpci_mgt_response(): flushed 1 entries
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 999
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 899
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 799
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 699
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 599
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 499
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 399
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 299
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 199
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 99
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = -1
islpci_mgt_response(): flushed 1 entries
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 999
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 899
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 799
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 699
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 599
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 499
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 399
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 299
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 199
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 99
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = -1
islpci_mgt_response(): flushed 1 entries
_mgt_get_request(): data length (124!=1452) mismatch for oid=0x1c000043
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 1000
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 900
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 800
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 700
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 600
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 500
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 400
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 300
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 200
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 100
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 0


I do get a link and is able to use the card, but it is very unstable, and
doesn't like too heavy a load, which make it loose the connection. Furthermore
the card only works if it was plugged in while booting, and then i only have 2
or 3 tries to get it up and working. If i try too many times to change the link
or make it or anything the card just stops working, without any output to dmesg.
Finally if i try to use any wireless GUI tools, the computer hangs, from too
many islpci_mgt_response() messages. 

Is this bug still being worked on?

------- Additional Comments From andreas@florath.net  2004-01-14 20:27 -------
(This is mostly a copy from the forum - TheOneKEA told me to post this here.)

We have some APs here around. My Netgear W511 works fine, except that it looses
the link every halfe a minute, and each time it takes some seconds to
reestablish the connection. Please have a look at the following iwevent output.
(The 00:0C:CE:88:2F:A8 is the good AP, that I will use, but there is also the
bad one: 00:03:93:EA:47:BB.)

17:46:18.213669 eth1 New Access Point/Cell address:00:0C:CE:88:2F:A8
17:46:18.548775 eth1 Custom driver event:Authenticate request to
00:03:93:EA:47:BB : REJECTED
17:46:20.005760 eth1 Custom driver event:Link lost
17:46:23.872102 eth1 Custom driver event:Authenticate request to
00:03:93:EA:47:BB : REJECTED
17:46:25.385227 eth1 Custom driver event:Authenticate request to
00:0C:CE:88:2F:A8 : ACCEPTED
17:46:25.686747 eth1 Custom driver event:Associate request to 00:0C:CE:88:2F:A8
: ACCEPTED
17:46:27.181045 eth1 New Access Point/Cell address:00:0C:CE:88:2F:A8
17:46:27.515879 eth1 Custom driver event:Authenticate request to
00:03:93:EA:47:BB : REJECTED
17:46:28.972546 eth1 New Access Point/Cell address:00:0C:CE:88:2F:A8
17:46:29.277735 eth1 Custom driver event:Authenticate request to
00:03:93:EA:47:BB : REJECTED


I'm in a big office building with lots of APs, but I'm not moving at all.
Yes, the signal is randomly lost (somewhat between half a minute and three
minutes). 

It's a Netgear WG511.
Current driver: cvs from 2004-01-14 about 12:00. 

I found the following output in the /var/log/messages. Each time a "REJECT" is
reported in the iwevent output, the following is logged:

Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 90
Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 80
Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 70
Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 60
Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 50
Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 40
Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 30
Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 20
Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 10
Jan 14 20:07:27 jason kernel: islpci_mgt_response(): queue empty, retrying
(jiffies left = 0 

Rest: mostly the same behaviour as reported already by  Mathias B.)

Best regards

Andre

------- Additional Comments From andreas@florath.net  2004-01-15 08:10 -------
Hello!

I just fixed the problem for me.  It works fine now for some hours without any
problems.

1. I set the essid explicit to the one I used (although it was automagically set
during startup).
2. I use the original firmware that was shipped with the card: WG511DCB.arm
(this is version "Version 0.8.1.0 built on Wed Feb 12 12:40:43 CET 2003 by
inlbuild@tix")

Hope this helps a bit.

Regards

Andre

------- Additional Comments From mathiasb@email.dk  2004-01-15 09:03 -------
No, that doesn't fix it for me. Iv'e been using a specific essid from the start.
And i doesn't help using the vendors firmware either... 

inspired by mr. Florath i tried having a iwevent open for a while. It doesn't
spit  out anything that looks like what Florath gets. whenever my dmesg looks
something like this:

TRAP: oid 0x1, device 3, flags 0x0 length 4
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 699
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 599
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 499
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 399
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 299
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 199
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = 99
islpci_mgt_response(): entry in queue not found yet, retrying (jiffies left = -1
TRAP: oid 0x18000001, device 3, flags 0x0 length 12
TRAP: oid 0x1800000b, device 3, flags 0x0 length 12
islpci_mgt_response(): flushed 1 entries
TRAP: oid 0x1, device 3, flags 0x0 length 4
TRAP: oid 0x18000001, device 3, flags 0x0 length 12
TRAP: oid 0x1800000b, device 3, flags 0x0 length 12
TRAP: oid 0x1, device 3, flags 0x0 length 4

i get this in my iwevent:
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.
handle_netlink_events: error reading netlink: Invalid argument.

I've tried having iwevent open from before i start up the card, but it never
prints anything else than this... Hope that helps solve it... :)

By the way, i start up the card like this:

ifconfig eth1 down
sleep 2
ifconfig eth1 up
sleep 2
iwconfig eth1 essid "MYESSID"
dhcpcd eth1




------- Additional Comments From jens@jensflorian.com  2004-01-15 15:04 -------
Confirming the same problems with my Netgear WG511. I'm getting messages
like this: "islpci_mgt_response(): entry in queue not found yet, retrying
(jiffies left = 1000" and sometimes the kernel freezes with a very simliar dump
like S.Wagler.

At first it seemes to me appearing randomly, but I managed to check out some things:
- I never appears on the first time when inerting the card, or booting with the
card. It happens only when removing the card or playing with then network settings.
- Unloading the prism54 module and reloading before reinserting the card works
for me. 
- You get the error when you type quick ifconfig ethX down and ifconfig ethX up
therafter.

------- Additional Comments From mathiasb@email.dk  2004-01-16 13:03 -------
after a fix for iwevent given to me by mr. Florath my iwevent now shows the
following, which looks ok (same dmesg as before):

12:45:20.909719    eth1     ESSID:"MYESSID"
12:45:22.193583    eth1     Custom driver event:Authenticate request to
00:0D:88:A0:CF:9D  : ACCEPTED
12:45:22.195463    eth1     Custom driver event:Associate request to
00:0D:88:A0:CF:9D  : ACCEPTED
12:45:22.196212    eth1     New Access Point/Cell address:00:0D:88:A0:CF:9D

(the fix is to add this line:

sanllen = sizeof(struct sockaddr_nl);

in front of this line: 

      amt = recvfrom(rth->fd, buf, sizeof(buf), MSG_DONTWAIT, (struct
sockaddr*)&sanl, &sanllen);

in iwevent.c of wireless-tools26
)

------- Additional Comments From Jens.Maurer@gmx.net  2004-01-28 22:20 -------
I have just checked in a complete rework of the mgmt frame handling.  This may
or may not fix your problems.  Could you please retest?



------- You are receiving this mail because: -------
You are the assignee for the bug, or are watching the assignee.