Am Donnerstag, 6. Januar 2005 22:01 schrieb Alan Stern:
> On Thu, 6 Jan 2005, Oliver Neukum wrote:
>
> > Am Donnerstag, 6. Januar 2005 20:11 schrieb Alan Stern:
> > > It's also possible that the flip-flop is changed during the suspend
> > > operation rather than the resume operation. ÂPerhaps Oliver can add some
> > > debugging lines to print the values of the regs->port_status[] entries in
> > > those three loops (one in ehci_hub_suspend and two in ehci_hub_resume).
> >
> > As part of suspension is cutting power I fail to see how it could not
> > affect the flip-flop. Could you explain what you mean with that?
>
> If the power was shut off entirely, upon resume the controller would have
> seen a connect change event. No such event shows up in the system logs
> you posted with ehci-hcd unloaded. But it does show up in the logs with
> ehci-hcd loaded.
>
> I'm just suggesting that in ehci-hub.c, you add code to ehci_hub_suspend
> to print the values of port and t1 inside the loop. Similarly, in
> ehci_hub_resume print the values of i and temp in the two loops.
Here we go:
Jan 6 23:42:52 macbeth kernel: Stopping tasks:
================================================================================|
Jan 6 23:42:52 macbeth kernel: Freeing memory...
^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^Hdone
(48306 pages freed)
Jan 6 23:42:52 macbeth kernel: usb 1-1: no poweroff yet, suspending instead
Jan 6 23:42:52 macbeth kernel: usb 1-1: usb suspend
Jan 6 23:42:52 macbeth kernel: usb usb4: no poweroff yet, suspending instead
Jan 6 23:42:52 macbeth kernel: Port is 5. t1 is 00001000
Jan 6 23:42:52 macbeth kernel: Port is 4. t1 is 00001000
Jan 6 23:42:52 macbeth kernel: Port is 3. t1 is 00001000
Jan 6 23:42:52 macbeth kernel: Port is 2. t1 is 00001000
Jan 6 23:42:52 macbeth kernel: Port is 1. t1 is 00001000
Jan 6 23:42:52 macbeth kernel: Port is 0. t1 is 00003002
Jan 6 23:42:52 macbeth kernel: usb usb3: no poweroff yet, suspending instead
Jan 6 23:42:53 macbeth kernel: usb usb2: no poweroff yet, suspending instead
Jan 6 23:42:53 macbeth kernel: usb usb1: no poweroff yet, suspending instead
Jan 6 23:42:53 macbeth kernel: radeonfb: suspending to state: 3...
Jan 6 23:42:53 macbeth kernel: agpgart: Found an AGP 2.0 compliant device at
0000:00:00.0.
Jan 6 23:42:53 macbeth kernel: agpgart: Putting AGP V2 device at 0000:00:00.0
into 0x mode
Jan 6 23:42:53 macbeth kernel: agpgart: Putting AGP V2 device at 0000:01:00.0
into 0x mode
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: --> PCI D3hot
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.2: suspend_hc
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.2: --> PCI D0/legacy
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.1: suspend_hc
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.1: --> PCI D0/legacy
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: suspend_hc
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: --> PCI D0/legacy
Jan 6 23:42:53 macbeth kernel: swsusp: Need to copy 38202 pages
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: resume from PCI D0
(legacy)
Jan 6 23:42:53 macbeth kernel: PCI: Setting latency timer of device
0000:00:1d.0 to 64
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.1: resume from PCI D0
(legacy)
Jan 6 23:42:53 macbeth kernel: PCI: Setting latency timer of device
0000:00:1d.1 to 64
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.2: resume from PCI D0
(legacy)
Jan 6 23:42:53 macbeth kernel: PCI: Setting latency timer of device
0000:00:1d.2 to 64
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: resume from PCI D3hot
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: reset command 080002
(park)=0 ithresh=8 period=1024 Reset HALT
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: reset hcs_params
0x103206 dbg=1 cc=3 pcc=2 ordered !ppc ports=6
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: reset hcc_params 6871
thresh 7 uframes 1024 64 bit addr
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: capability 0001 at 68
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: reset command 080002
(park)=0 ithresh=8 period=1024 Reset HALT
Jan 6 23:42:53 macbeth kernel: PCI: cache line size of 32 is not supported by
device 0000:00:1d.7
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: init command 010001
(park)=0 ithresh=1 period=1024 RUN
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: USB 2.0 restarted, EHCI
1.00, driver 26 Oct 2004
Jan 6 23:42:53 macbeth kernel: ACPI: PCI interrupt 0000:00:1f.1[A] -> GSI 11
(level, low) -> IRQ 11
Jan 6 23:42:53 macbeth kernel: ACPI: PCI interrupt 0000:00:1f.5[B] -> GSI 11
(level, low) -> IRQ 11
Jan 6 23:42:53 macbeth kernel: PCI: Setting latency timer of device
0000:00:1f.5 to 64
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.2: wakeup_hc
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: wakeup_hc
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.1: wakeup_hc
Jan 6 23:42:53 macbeth kernel: ACPI: PCI interrupt 0000:00:1f.6[B] -> GSI 11
(level, low) -> IRQ 11
Jan 6 23:42:53 macbeth kernel: PCI: Setting latency timer of device
0000:00:1f.6 to 64
Jan 6 23:42:53 macbeth kernel: radeonfb: resumed !
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: port 1 portsc 108a,02
Jan 6 23:42:53 macbeth kernel: ehci_hcd 0000:00:1d.7: resume root hub
Jan 6 23:42:53 macbeth kernel: Port: 5, Status: 00001000
Jan 6 23:42:53 macbeth kernel: Port: 4, Status: 00001000
Jan 6 23:42:53 macbeth kernel: Port: 3, Status: 00001000
Jan 6 23:42:53 macbeth kernel: Port: 2, Status: 00001000
Jan 6 23:42:53 macbeth kernel: Port: 1, Status: 00001000
Jan 6 23:42:53 macbeth kernel: Port: 0, Status: 00001403
Jan 6 23:42:53 macbeth kernel: 2nd loop - Port: 5, Status: 00001000
Jan 6 23:42:53 macbeth kernel: 2nd loop - Port: 4, Status: 00001000
Jan 6 23:42:53 macbeth kernel: 2nd loop - Port: 3, Status: 00001000
Jan 6 23:42:53 macbeth kernel: 2nd loop - Port: 2, Status: 00001000
Jan 6 23:42:53 macbeth kernel: 2nd loop - Port: 1, Status: 00001000
Jan 6 23:42:53 macbeth kernel: 2nd loop - Port: 0, Status: 00001401
Jan 6 23:42:53 macbeth kernel: usb 1-1: RESUME
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: port 1 portsc 008a,01
Jan 6 23:42:53 macbeth kernel: hub 1-0:1.0: port 1 status 0007.0100 after
resume, 0
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.2: suspend_hc
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: suspend_hc
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.1: suspend_hc
Jan 6 23:42:53 macbeth kernel: Restarting tasks... done
Jan 6 23:42:53 macbeth kernel: hub 1-0:1.0: state 5 ports 2 chg fffc evt ffff
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: port 1 portsc 008a,01
Jan 6 23:42:53 macbeth kernel: usb 1-1: RESUME (wakeup)
Jan 6 23:42:53 macbeth kernel: usb 1-1: usb resume
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: wakeup_hc
Jan 6 23:42:53 macbeth kernel: uhci_hcd 0000:00:1d.0: uhci_result_control:
failed with status 440000
Jan 6 23:42:53 macbeth kernel: [dfc5e240] link (1fc5e1b2) element (1fc7c000)
Jan 6 23:42:53 macbeth kernel: 0: [dfc7c000] link (1fc7c040) e0 LS Stalled
CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=3, PID=2d(SETUP) (buf=1f8dd5a0)
Jan 6 23:42:53 macbeth kernel: 1: [dfc7c040] link (1fc7c080) e3 SPD LS
Active Length=0 MaxLen=1 DT1 EndPt=0 Dev=3, PID=69(IN) (buf=1d24ca20)
Jan 6 23:42:53 macbeth kernel: 2: [dfc7c080] link (00000001) e3 LS IOC
Active Length=0 MaxLen=7ff DT1 EndPt=0 Dev=3, PID=e1(OUT) (buf=00000000)
Jan 6 23:42:53 macbeth kernel:
Jan 6 23:42:53 macbeth kernel: usb 1-1: gone after usb resume? status -71
Jan 6 23:42:53 macbeth kernel: hub 1-0:1.0: resume on port 1, status -71
Jan 6 23:42:53 macbeth kernel: hub 1-0:1.0: port 1, status 0100, change 0007,
12 Mb/s
Jan 6 23:42:53 macbeth kernel: usb 1-1: USB disconnect, address 3
Jan 6 23:42:53 macbeth kernel: usb 1-1: usb_disable_device nuking all URBs
Jan 6 23:42:53 macbeth kernel: usb 1-1: unregistering interface 1-1:1.0
Jan 6 23:42:53 macbeth kernel: usb 1-1:1.0: hotplug
Jan 6 23:42:53 macbeth kernel: usb 1-1: unregistering device
Jan 6 23:42:53 macbeth kernel: usb 1-1: hotplug
Jan 6 23:42:53 macbeth kernel: hub 1-0:1.0: debounce: port 1: total 100ms
stable 100ms status 0x100
Jan 6 23:42:53 macbeth kernel: hub 2-0:1.0: state 5 ports 2 chg fffc evt ffff
Jan 6 23:42:53 macbeth kernel: hub 3-0:1.0: state 5 ports 2 chg fffc evt ffff
Jan 6 23:42:53 macbeth kernel: hub 4-0:1.0: state 5 ports 6 chg ffc0 evt ffff
Jan 6 23:42:54 macbeth kernel: uhci_hcd 0000:00:1d.0: suspend_hc
Jan 6 23:42:59 macbeth /etc/hotplug/usb.agent[16706]: need a device for this
command
Replug:
Jan 6 23:43:35 macbeth kernel: hub 4-0:1.0: state 5 ports 6 chg ffc0 evt 0002
Jan 6 23:43:35 macbeth kernel: ehci_hcd 0000:00:1d.7: GetStatus port 1 status
001002 POWER sig=se0 CSC
Jan 6 23:43:35 macbeth kernel: hub 4-0:1.0: port 1, status 0100, change 0001,
12 Mb/s
Jan 6 23:43:35 macbeth kernel: hub 4-0:1.0: debounce: port 1: total 100ms
stable 100ms status 0x100
Jan 6 23:43:36 macbeth kernel: hub 4-0:1.0: state 5 ports 6 chg ffc0 evt 0002
Jan 6 23:43:36 macbeth kernel: ehci_hcd 0000:00:1d.7: GetStatus port 1 status
001403 POWER sig=k CSC CONNECT
Jan 6 23:43:36 macbeth kernel: hub 4-0:1.0: port 1, status 0501, change 0001,
480 Mb/s
Jan 6 23:43:36 macbeth kernel: hub 4-0:1.0: debounce: port 1: total 100ms
stable 100ms status 0x501
Jan 6 23:43:36 macbeth kernel: ehci_hcd 0000:00:1d.7: port 1 low speed -->
companion
Jan 6 23:43:36 macbeth kernel: uhci_hcd 0000:00:1d.0: wakeup_hc
Jan 6 23:43:36 macbeth kernel: ehci_hcd 0000:00:1d.7: GetStatus port 1 status
003002 POWER OWNER sig=se0 CSC
Jan 6 23:43:36 macbeth kernel: hub 1-0:1.0: state 5 ports 2 chg fffc evt 0002
Jan 6 23:43:36 macbeth kernel: uhci_hcd 0000:00:1d.0: port 1 portsc 0183,00
Jan 6 23:43:36 macbeth kernel: hub 1-0:1.0: port 1, status 0301, change 0001,
1.5 Mb/s
Jan 6 23:43:36 macbeth kernel: hub 1-0:1.0: debounce: port 1: total 100ms
stable 100ms status 0x301
Jan 6 23:43:36 macbeth kernel: usb 1-1: new low speed USB device using
uhci_hcd and address 4
Jan 6 23:43:37 macbeth kernel: usb 1-1: skipped 1 descriptor after interface
Jan 6 23:43:37 macbeth kernel: usb 1-1: new device strings: Mfr=1, Product=2,
SerialNumber=0
Jan 6 23:43:37 macbeth kernel: usb 1-1: default language 0x0409
Jan 6 23:43:37 macbeth kernel: usb 1-1: Product: Microsoft IntelliMouse®
Explorer
Jan 6 23:43:37 macbeth kernel: usb 1-1: Manufacturer: Microsoft
Jan 6 23:43:37 macbeth kernel: usb 1-1: hotplug
Jan 6 23:43:37 macbeth kernel: usb 1-1: adding 1-1:1.0 (config #1, interface 0)
Jan 6 23:43:37 macbeth kernel: usb 1-1:1.0: hotplug
Jan 6 23:43:37 macbeth kernel: usbhid 1-1:1.0: usb_probe_interface
Jan 6 23:43:37 macbeth kernel: usbhid 1-1:1.0: usb_probe_interface - got id
Jan 6 23:43:37 macbeth /etc/hotplug/usb.agent[17484]: need a device for this
command
Jan 6 23:43:37 macbeth kernel: input: USB HID v1.11 Mouse [Microsoft Microsoft
IntelliMouse® Explorer] on usb-0000:00:1d.0-1
Jan 6 23:43:37 macbeth kernel: hub 1-0:1.0: state 5 ports 2 chg fffc evt 0002
lspci:
0000:00:1d.0 USB Controller: Intel Corp. 82801DB USB (Hub #1) (rev 03)
00: 86 80 c2 24 05 00 80 02 03 00 03 0c 00 00 80 00
10: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
20: 01 12 00 00 00 00 00 00 00 00 00 00 79 11 10 ff
30: 00 00 00 00 00 00 00 00 00 00 00 00 0b 01 00 00
40: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
50: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
60: 10 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
70: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
90: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
a0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
b0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
c0: 00 2f 00 00 03 00 00 00 00 00 00 00 00 00 00 00
d0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
e0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
f0: 00 00 00 00 00 00 00 00 60 0f 00 00 00 00 00 00
0000:00:1d.1 USB Controller: Intel Corp. 82801DB USB (Hub #2) (rev 03)
00: 86 80 c4 24 05 00 80 02 03 00 03 0c 00 00 00 00
10: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
20: 21 12 00 00 00 00 00 00 00 00 00 00 79 11 10 ff
30: 00 00 00 00 00 00 00 00 00 00 00 00 0b 02 00 00
40: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
50: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
60: 10 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
70: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
90: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
a0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
b0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
c0: 00 2f 00 00 03 00 00 00 00 00 00 00 00 00 00 00
d0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
e0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
f0: 00 00 00 00 00 00 00 00 60 0f 00 00 00 00 00 00
0000:00:1d.2 USB Controller: Intel Corp. 82801DB USB (Hub #3) (rev 03)
00: 86 80 c7 24 05 00 80 02 03 00 03 0c 00 00 00 00
10: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
20: 41 12 00 00 00 00 00 00 00 00 00 00 79 11 10 ff
30: 00 00 00 00 00 00 00 00 00 00 00 00 0b 03 00 00
40: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
50: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
60: 10 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
70: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
90: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
a0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
b0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
c0: 00 2f 00 00 03 00 00 00 00 00 00 00 00 00 00 00
d0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
e0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
f0: 00 00 00 00 00 00 00 00 60 0f 00 00 00 00 00 00
0000:00:1d.7 USB Controller: Intel Corp. 82801DB USB2 (rev 03)
00: 86 80 cd 24 06 00 90 02 03 20 03 0c 00 00 00 00
10: 00 00 00 f4 00 00 00 00 00 00 00 00 00 00 00 00
20: 00 00 00 00 00 00 00 00 00 00 00 00 79 11 10 ff
30: 00 00 00 00 50 00 00 00 00 00 00 00 00 04 00 00
40: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
50: 01 58 c2 c9 00 00 00 00 0a 00 80 20 00 00 00 00
60: 20 20 7f 00 00 00 00 00 01 00 00 00 00 00 08 c0
70: 00 00 f7 0f 00 00 00 00 00 00 00 00 00 00 00 00
80: 00 00 00 00 01 00 00 00 00 00 00 00 00 00 00 00
90: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
a0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
b0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
c0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
d0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 15 00
e0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
f0: 78 bf 1f 00 88 83 00 00 60 0f 00 00 06 00 00 00
I've noticed during writing out the image there are several wake_up,resume
cycles from uhci.
Regards
Oliver
-------------------------------------------------------
The SF.Net email is sponsored by: Beat the post-holiday blues
Get a FREE limited edition SourceForge.net t-shirt from ThinkGeek.
It's fun and FREE -- well, almost....http://www.thinkgeek.com/sfshirt
_______________________________________________
linux-usb-devel@lists.sourceforge.net
To unsubscribe, use the last form field at:
https://lists.sourceforge.net/lists/listinfo/linux-usb-devel
