W dniu 14.11.2011 13:40, Julian Sikorski pisze: > > > W dniu 14.11.2011 10:27, Julian Sikorski pisze: >> W dniu 2011-11-14 10:24, Andiry Xu pisze: >>> On 11/12/2011 02:20 PM, Julian Sikorski wrote: >>>> W dniu 11.11.2011 21:11, Julian Sikorski pisze: >>>>> W dniu 31.08.2011 22:25, Julian Sikorski pisze: >>>>>> Hi, >>>>>> >>>>>> I originally reported this problem here: >>>>>> https://bugzilla.kernel.org/show_bug.cgi?id=35212 >>>>>> Summing up, the external hard drive will produce an io-error after >>>>>> about >>>>>> 30 minutes of being connected. After such event, system does not >>>>>> notice >>>>>> if the device is re-connected upon disconnection. I am attaching the >>>>>> relevant portion of /var/log/messages. >>>>>> The problem happens on an up-to-date Fedora 15 x86_64 (running kernel >>>>>> 2.6.40.3-0.fc15.x86_64) on a Clevo P150HM laptop and Lacie Rugged USB >>>>>> 3.0 hard disk. >>>>>> Please let me know if I can provide more information >>>>>> >>>>>> Regards, >>>>>> Julian >>>>> I have recently upgraded to Fedora 16, and I am now running kernel >>>>> 3.1.0-7.fc16.x86_64. This problem is far from being gone, >>>>> unfortunately. >>>>> It will go as follows: >>>>> - you plug the drive into one of USB3 ports >>>>> - everything works fine >>>>> - suspend and resume (not sure if this is necessary) >>> >>> Have you figured out if this suspend/resume step is necessary? >> >> Not yet. I will try later today (but bear with me given the hour needed >> to trigger the problem). >> > > Due to long time needed to reproduce the problem please accept this > partial report. > I have updated the kernel to 3.1.1-1.fc16.x86_64 (which showed up in > Fedora repositories earlier today). I then rebooted and am now running > with the drive connected for more than an hour downloading something off > bittorrent. Here is the fragment of /var/log/messages from the drive > connection until now. Keep in mind that these "stalled endpoint" > messages show up every 30 minutes (12:26, 12:56 and 13:26) - maybe if > the PC was suspended before they trigger the error? > > Nov 14 12:26:51 snowball2 kernel: [ 248.735018] usb 3-2: new full speed > USB device number 2 using xhci_hcd > Nov 14 12:26:51 snowball2 kernel: [ 248.735442] usb 3-2: Device not > responding to set address. > Nov 14 12:26:51 snowball2 kernel: [ 248.936230] usb 3-2: Device not > responding to set address. > Nov 14 12:26:52 snowball2 kernel: [ 249.136661] usb 3-2: device not > accepting address 2, error -71 > Nov 14 12:26:52 snowball2 kernel: [ 249.289464] usb 3-2: new full speed > USB device number 3 using xhci_hcd > Nov 14 12:26:52 snowball2 kernel: [ 249.289803] usb 3-2: Device not > responding to set address. > Nov 14 12:26:52 snowball2 kernel: [ 249.490591] usb 3-2: Device not > responding to set address. > Nov 14 12:26:52 snowball2 kernel: [ 249.691060] usb 3-2: device not > accepting address 3, error -71 > Nov 14 12:26:52 snowball2 kernel: [ 249.742014] hub 3-0:1.0: unable to > enumerate USB device on port 2 > Nov 14 12:26:53 snowball2 kernel: [ 250.877922] usb 4-2: new SuperSpeed > USB device number 2 using xhci_hcd > Nov 14 12:26:53 snowball2 kernel: [ 250.891680] xhci_hcd 0000:02:00.0: > WARN: short transfer on control ep > Nov 14 12:26:53 snowball2 kernel: [ 250.892291] xhci_hcd 0000:02:00.0: > WARN: short transfer on control ep > Nov 14 12:26:53 snowball2 kernel: [ 250.892877] xhci_hcd 0000:02:00.0: > WARN: short transfer on control ep > Nov 14 12:26:53 snowball2 kernel: [ 250.893496] xhci_hcd 0000:02:00.0: > WARN: short transfer on control ep > Nov 14 12:26:53 snowball2 kernel: [ 250.893766] usb 4-2: New USB device > found, idVendor=059f, idProduct=103e > Nov 14 12:26:53 snowball2 kernel: [ 250.893774] usb 4-2: New USB device > strings: Mfr=2, Product=3, SerialNumber=1 > Nov 14 12:26:53 snowball2 kernel: [ 250.893780] usb 4-2: Product: > Rugged USB 3 > Nov 14 12:26:53 snowball2 kernel: [ 250.893785] usb 4-2: Manufacturer: > LaCie > Nov 14 12:26:53 snowball2 kernel: [ 250.893789] usb 4-2: SerialNumber: > ce0238914a4c0000000 > Nov 14 12:26:53 snowball2 mtp-probe: checking bus 4, device 2: > "/sys/devices/pci0000:00/0000:00:1c.0/0000:02:00.0/usb4/4-2" > Nov 14 12:26:53 snowball2 mtp-probe: bus: 4, device: 2 was not an MTP device > Nov 14 12:26:54 snowball2 kernel: [ 251.916187] usbcore: registered new > interface driver uas > Nov 14 12:26:54 snowball2 kernel: [ 251.927250] Initializing USB Mass > Storage driver... > Nov 14 12:26:54 snowball2 kernel: [ 251.927704] scsi6 : usb-storage 4-2:1.0 > Nov 14 12:26:54 snowball2 kernel: [ 251.928205] usbcore: registered new > interface driver usb-storage > Nov 14 12:26:54 snowball2 kernel: [ 251.928210] USB Mass Storage > support registered. > Nov 14 12:26:55 snowball2 kernel: [ 252.936594] scsi 6:0:0:0: > Direct-Access ST950032 5AS 0002 PQ: 0 ANSI: 0 > Nov 14 12:26:55 snowball2 kernel: [ 252.936887] scsi: killing requests > for dead queue > Nov 14 12:26:55 snowball2 kernel: [ 252.937145] scsi: killing requests > for dead queue > Nov 14 12:26:55 snowball2 kernel: [ 252.937293] scsi: killing requests > for dead queue > Nov 14 12:26:55 snowball2 kernel: [ 252.937545] scsi: killing requests > for dead queue > Nov 14 12:26:55 snowball2 kernel: [ 252.937737] scsi: killing requests > for dead queue > Nov 14 12:26:55 snowball2 kernel: [ 252.937886] scsi: killing requests > for dead queue > Nov 14 12:26:55 snowball2 kernel: [ 252.938034] scsi: killing requests > for dead queue > Nov 14 12:26:55 snowball2 kernel: [ 252.938161] scsi: killing requests > for dead queue > Nov 14 12:26:55 snowball2 kernel: [ 252.938975] sd 6:0:0:0: Attached > scsi generic sg2 type 0 > Nov 14 12:26:55 snowball2 kernel: [ 252.939052] sd 6:0:0:0: [sdb] > 976773168 512-byte logical blocks: (500 GB/465 GiB) > Nov 14 12:26:55 snowball2 kernel: [ 252.939189] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:55 snowball2 kernel: [ 252.939774] sd 6:0:0:0: [sdb] Write > Protect is off > Nov 14 12:26:55 snowball2 kernel: [ 252.939924] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:55 snowball2 kernel: [ 252.940476] sd 6:0:0:0: [sdb] No > Caching mode page present > Nov 14 12:26:55 snowball2 kernel: [ 252.940489] sd 6:0:0:0: [sdb] > Assuming drive cache: write through > Nov 14 12:26:55 snowball2 kernel: [ 252.941688] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:55 snowball2 kernel: [ 252.942389] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:55 snowball2 kernel: [ 252.942994] sd 6:0:0:0: [sdb] No > Caching mode page present > Nov 14 12:26:55 snowball2 kernel: [ 252.943002] sd 6:0:0:0: [sdb] > Assuming drive cache: write through > Nov 14 12:26:55 snowball2 kernel: [ 253.040098] sdb: sdb1 sdb2 > Nov 14 12:26:55 snowball2 kernel: [ 253.041711] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:55 snowball2 kernel: [ 253.042525] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:55 snowball2 kernel: [ 253.043115] sd 6:0:0:0: [sdb] No > Caching mode page present > Nov 14 12:26:55 snowball2 kernel: [ 253.043129] sd 6:0:0:0: [sdb] > Assuming drive cache: write through > Nov 14 12:26:55 snowball2 kernel: [ 253.043140] sd 6:0:0:0: [sdb] > Attached SCSI disk > Nov 14 12:26:56 snowball2 kernel: [ 253.111205] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:56 snowball2 kernel: [ 253.112108] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:56 snowball2 kernel: [ 253.405005] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:56 snowball2 kernel: [ 253.506974] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:56 snowball2 kernel: [ 253.518140] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:56 snowball2 kernel: [ 253.555874] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:56 snowball2 kernel: [ 253.678503] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:56 snowball2 kernel: [ 253.720672] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:26:58 snowball2 ntfs-3g[2084]: Version 2011.4.12 integrated > FUSE 27 > Nov 14 12:26:58 snowball2 ntfs-3g[2084]: Mounted /dev/sdb1 (Read-Write, > label "lacie", NTFS 3.1) > Nov 14 12:26:58 snowball2 ntfs-3g[2084]: Cmdline options: > rw,nosuid,nodev,uhelper=udisks,uid=500,gid=500,dmask=0077,fmask=0177 > Nov 14 12:26:58 snowball2 ntfs-3g[2084]: Mount options: > rw,nosuid,nodev,uhelper=udisks,allow_other,nonempty,atime,fsname=/dev/sdb1,blkdev,blksize=512,default_permissions > Nov 14 12:26:58 snowball2 ntfs-3g[2084]: Global ownership and > permissions enforced, configuration type 1 > Nov 14 12:27:22 snowball2 dbus[1181]: [system] Activating service > name='net.reactivated.Fprint' (using servicehelper) > Nov 14 12:27:22 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Activating service name='net.reactivated.Fprint' (using servicehelper) > Nov 14 12:27:22 snowball2 dbus-daemon[1181]: Launching FprintObject > Nov 14 12:27:22 snowball2 dbus[1181]: [system] Successfully activated > service 'net.reactivated.Fprint' > Nov 14 12:27:22 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Successfully activated service 'net.reactivated.Fprint' > Nov 14 12:27:22 snowball2 dbus-daemon[1181]: ** Message: D-Bus service > launched with name: net.reactivated.Fprint > Nov 14 12:27:22 snowball2 dbus-daemon[1181]: ** Message: entering main loop > Nov 14 12:27:42 snowball2 ntfs-3g[2205]: Version 2011.4.12 integrated > FUSE 27 > Nov 14 12:27:42 snowball2 ntfs-3g[2205]: Mounted /dev/mapper/realcrypt1 > (Read-Write, label "", NTFS 3.1) > Nov 14 12:27:42 snowball2 ntfs-3g[2205]: Cmdline options: > rw,uid=0,gid=0,umask=077,dmask=000,fmask=111 > Nov 14 12:27:42 snowball2 ntfs-3g[2205]: Mount options: > rw,allow_other,nonempty,atime,fsname=/dev/mapper/realcrypt1,blkdev,blksize=4096,default_permissions > Nov 14 12:27:42 snowball2 ntfs-3g[2205]: Global ownership and > permissions enforced, configuration type 1 > Nov 14 12:27:53 snowball2 dbus-daemon[1181]: ** Message: No devices in > use, exit > Nov 14 12:28:12 snowball2 kernel: [ 329.358198] process `skype' is > using obsolete setsockopt SO_BSDCOMPAT > Nov 14 12:28:14 snowball2 pulseaudio[1759]: alsa-sink.c: ALSA została > wybudzona, aby zapisać nowe dane do urządzenia, ale nie było nic do > zapisania. > Nov 14 12:28:14 snowball2 pulseaudio[1759]: alsa-sink.c: Prawdopodobnie > jest to błąd w sterowniku ALSA "snd_hda_intel". Proszę zgłosić ten > problem programistom ALSA. > Nov 14 12:28:14 snowball2 pulseaudio[1759]: alsa-sink.c: Wybudzono za > pomocą ustawienia POLLOUT - ale jednoczesne wywołanie snd_pcm_avail() > zwróciło zero lub inną wartość < min_avail. > Nov 14 12:37:43 snowball2 systemd-tmpfiles[3021]: Successfully loaded > SELinux database in 9ms 553us, size on heap is 479K. > Nov 14 12:38:36 snowball2 ntpd[1117]: 0.0.0.0 c612 02 freq_set kernel > -25.621 PPM > Nov 14 12:38:36 snowball2 ntpd[1117]: 0.0.0.0 c615 05 clock_sync > Nov 14 12:51:18 snowball2 dbus[1181]: [system] Activating service > name='org.freedesktop.PackageKit' (using servicehelper) > Nov 14 12:51:19 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Activating service name='org.freedesktop.PackageKit' (using servicehelper) > Nov 14 12:51:21 snowball2 dbus[1181]: [system] Successfully activated > service 'org.freedesktop.PackageKit' > Nov 14 12:51:21 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Successfully activated service 'org.freedesktop.PackageKit' > Nov 14 12:51:21 snowball2 dbus[1181]: [system] Activating service > name='net.reactivated.Fprint' (using servicehelper) > Nov 14 12:51:21 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Activating service name='net.reactivated.Fprint' (using servicehelper) > Nov 14 12:51:21 snowball2 dbus-daemon[1181]: Launching FprintObject > Nov 14 12:51:21 snowball2 dbus[1181]: [system] Successfully activated > service 'net.reactivated.Fprint' > Nov 14 12:51:21 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Successfully activated service 'net.reactivated.Fprint' > Nov 14 12:51:21 snowball2 dbus-daemon[1181]: ** Message: D-Bus service > launched with name: net.reactivated.Fprint > Nov 14 12:51:21 snowball2 dbus-daemon[1181]: ** Message: entering main loop > Nov 14 12:51:52 snowball2 dbus-daemon[1181]: ** Message: No devices in > use, exit > Nov 14 12:56:30 snowball2 kernel: [ 2025.456413] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:56:30 snowball2 kernel: [ 2025.457321] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:56:30 snowball2 kernel: [ 2025.789154] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:56:30 snowball2 kernel: [ 2025.922752] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 12:56:30 snowball2 kernel: [ 2025.964922] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 13:01:01 snowball2 systemd-logind[1120]: New user root logged in. > Nov 14 13:01:01 snowball2 systemd-logind[1120]: New session 3 of user root. > Nov 14 13:01:02 snowball2 systemd-logind[1120]: Removed session 3. > Nov 14 13:01:02 snowball2 systemd-logind[1120]: User root logged out. > Nov 14 13:10:28 snowball2 dbus[1181]: [system] Activating service > name='net.reactivated.Fprint' (using servicehelper) > Nov 14 13:10:28 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Activating service name='net.reactivated.Fprint' (using servicehelper) > Nov 14 13:10:28 snowball2 dbus-daemon[1181]: Launching FprintObject > Nov 14 13:10:28 snowball2 dbus[1181]: [system] Successfully activated > service 'net.reactivated.Fprint' > Nov 14 13:10:28 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Successfully activated service 'net.reactivated.Fprint' > Nov 14 13:10:28 snowball2 dbus-daemon[1181]: ** Message: D-Bus service > launched with name: net.reactivated.Fprint > Nov 14 13:10:28 snowball2 dbus-daemon[1181]: ** Message: entering main loop > Nov 14 13:10:59 snowball2 dbus-daemon[1181]: ** Message: No devices in > use, exit > Nov 14 13:20:45 snowball2 dbus[1181]: [system] Activating service > name='org.freedesktop.PackageKit' (using servicehelper) > Nov 14 13:20:45 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Activating service name='org.freedesktop.PackageKit' (using servicehelper) > Nov 14 13:20:45 snowball2 dbus[1181]: [system] Successfully activated > service 'org.freedesktop.PackageKit' > Nov 14 13:20:45 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Successfully activated service 'org.freedesktop.PackageKit' > > Nov 14 13:26:30 snowball2 kernel: [ 3823.423450] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 13:26:30 snowball2 kernel: [ 3823.424550] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 13:26:30 snowball2 kernel: [ 3823.755151] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 13:26:30 snowball2 kernel: [ 3823.888851] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 13:26:30 snowball2 kernel: [ 3823.996842] xhci_hcd 0000:02:00.0: > WARN: Stalled endpoint > Nov 14 13:31:30 snowball2 dbus[1181]: [system] Activating service > name='org.freedesktop.PackageKit' (using servicehelper) > Nov 14 13:31:30 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Activating service name='org.freedesktop.PackageKit' (using servicehelper) > Nov 14 13:31:30 snowball2 dbus[1181]: [system] Successfully activated > service 'org.freedesktop.PackageKit' > Nov 14 13:31:30 snowball2 dbus-daemon[1181]: dbus[1181]: [system] > Successfully activated service 'org.freedesktop.PackageKit' > I have waited a bit longer and the stalled endpoint error occured again: Nov 14 13:31:30 snowball2 dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 13:31:30 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 13:31:30 snowball2 dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 13:31:30 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 13:49:02 snowball2 dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 13:49:02 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 13:49:02 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 13:49:02 snowball2 dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 13:49:04 snowball2 kernel: [ 5176.427133] TCP lp registered Nov 14 13:55:09 snowball2 kernel: [ 5540.805177] iwlagn 0000:04:00.0: Tx aggregation enabled on ra = c0:3f:0e:2d:f8:f0 tid = 6 Nov 14 13:56:30 snowball2 kernel: [ 5621.383158] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 13:56:30 snowball2 kernel: [ 5621.384283] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 13:56:30 snowball2 kernel: [ 5621.463760] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 13:56:30 snowball2 kernel: [ 5621.586453] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 13:56:30 snowball2 kernel: [ 5621.628626] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint I then figured the problem is not gonna happen so I suspended the machine without disconnecting the drive: Nov 14 13:56:59 snowball2 NetworkManager[1113]: <info> sleep requested (sleeping: no enabled: yes) Nov 14 13:56:59 snowball2 NetworkManager[1113]: <info> sleeping or disabling... Nov 14 13:56:59 snowball2 NetworkManager[1113]: <info> (p1p1): now unmanaged Nov 14 13:56:59 snowball2 NetworkManager[1113]: <info> (p1p1): device state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37] Nov 14 13:56:59 snowball2 NetworkManager[1113]: <info> (p1p1): cleaning up... Nov 14 13:56:59 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> sleep requested (sleeping: no enabled: yes) Nov 14 13:56:59 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> sleeping or disabling... Nov 14 13:56:59 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (p1p1): now unmanaged Nov 14 13:56:59 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (p1p1): device state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37] Nov 14 13:56:59 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (p1p1): cleaning up... Nov 14 13:56:59 snowball2 NetworkManager[1113]: <info> (p1p1): taking down device. Nov 14 13:56:59 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (p1p1): taking down device. Nov 14 13:57:00 snowball2 NetworkManager[1113]: <info> (wlan0): now unmanaged Nov 14 13:57:00 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37] Nov 14 13:57:00 snowball2 NetworkManager[1113]: <info> (wlan0): deactivating device (reason 'sleeping') [37] Nov 14 13:57:00 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): now unmanaged Nov 14 13:57:00 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37] Nov 14 13:57:00 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): deactivating device (reason 'sleeping') [37] Nov 14 13:57:00 snowball2 NetworkManager[1113]: <info> (wlan0): canceled DHCP transaction, DHCP client pid 1362 Nov 14 13:57:00 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): canceled DHCP transaction, DHCP client pid 1362 Nov 14 13:57:00 snowball2 avahi-daemon[1122]: Withdrawing address record for 192.168.1.2 on wlan0. Nov 14 13:57:00 snowball2 NetworkManager[1113]: <info> (wlan0): cleaning up... Nov 14 13:57:00 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): cleaning up... Nov 14 13:57:00 snowball2 NetworkManager[1113]: <info> (wlan0): taking down device. Nov 14 13:57:00 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): taking down device. Nov 14 13:57:00 snowball2 kernel: [ 5651.580556] cfg80211: Calling CRDA to update world regulatory domain Nov 14 13:57:00 snowball2 avahi-daemon[1122]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.2. Nov 14 13:57:00 snowball2 avahi-daemon[1122]: Interface wlan0.IPv4 no longer relevant for mDNS. Nov 14 13:57:00 snowball2 avahi-daemon[1122]: Withdrawing address record for fe80::8a53:2eff:fe03:74f1 on wlan0. Nov 14 13:57:00 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper) Nov 14 13:57:00 snowball2 dbus[1181]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper) Nov 14 13:57:00 snowball2 dbus[1181]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 14 13:57:00 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 14 13:57:00 snowball2 kernel: [ 5652.102818] cfg80211: World regulatory domain updated: Nov 14 13:57:00 snowball2 kernel: [ 5652.102827] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) Nov 14 13:57:00 snowball2 kernel: [ 5652.102836] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Nov 14 13:57:01 snowball2 kernel: [ 5652.102844] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Nov 14 13:57:01 snowball2 kernel: [ 5652.102851] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Nov 14 13:57:01 snowball2 kernel: [ 5652.102857] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Nov 14 13:57:01 snowball2 kernel: [ 5652.102864] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Nov 14 13:57:01 snowball2 kernel: [ 5652.102890] cfg80211: Calling CRDA for country: CH Nov 14 13:57:01 snowball2 kernel: [ 5652.112014] cfg80211: Regulatory domain changed to country: CH Nov 14 13:57:01 snowball2 kernel: [ 5652.112016] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) Nov 14 13:57:01 snowball2 kernel: [ 5652.112018] cfg80211: (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm) Nov 14 13:57:01 snowball2 kernel: [ 5652.112020] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (N/A, 2000 mBm) Nov 14 13:57:01 snowball2 kernel: [ 5652.112022] cfg80211: (5250000 KHz - 5330000 KHz @ 40000 KHz), (N/A, 2000 mBm) Nov 14 13:57:01 snowball2 kernel: [ 5652.112023] cfg80211: (5490000 KHz - 5710000 KHz @ 40000 KHz), (N/A, 2700 mBm) Nov 14 13:57:02 snowball2 ntpd[1117]: Deleting interface #6 wlan0, 192.168.1.2#123, interface stats: received=276, sent=276, dropped=0, active_time=5624 secs Nov 14 13:57:02 snowball2 ntpd[1117]: 77.245.18.26 interface 192.168.1.2 -> (none) Nov 14 13:57:02 snowball2 ntpd[1117]: 134.34.3.19 interface 192.168.1.2 -> (none) Nov 14 13:57:02 snowball2 ntpd[1117]: 153.109.180.3 interface 192.168.1.2 -> (none) Nov 14 13:57:02 snowball2 ntpd[1117]: 212.101.4.253 interface 192.168.1.2 -> (none) Nov 14 13:57:02 snowball2 ntpd[1117]: Deleting interface #5 wlan0, fe80::8a53:2eff:fe03:74f1#123, interface stats: received=0, sent=0, dropped=0, active_time=5630 secs Nov 14 13:57:02 snowball2 ntpd[1117]: peers refreshed Nov 14 13:57:18 snowball2 kernel: [ 5659.624113] PM: Syncing filesystems ... done. Nov 14 13:57:18 snowball2 kernel: [ 5659.625461] Freezing user space processes ... (elapsed 0.51 seconds) done. Nov 14 13:57:18 snowball2 kernel: [ 5660.141881] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. Nov 14 13:57:18 snowball2 kernel: [ 5660.153008] Suspending console(s) (use no_console_suspend to debug) Nov 14 13:57:18 snowball2 kernel: [ 5660.153471] sd 0:0:0:0: [sda] Synchronizing SCSI cache Nov 14 13:57:18 snowball2 kernel: [ 5660.216329] sd 0:0:0:0: [sda] Stopping disk Nov 14 13:57:18 snowball2 kernel: [ 5660.718468] jmb38x_ms 0000:03:00.3: PCI INT B disabled Nov 14 13:57:18 snowball2 kernel: [ 5660.718542] sdhci-pci 0000:03:00.1: PCI INT B disabled Nov 14 13:57:18 snowball2 kernel: [ 5660.729090] ehci_hcd 0000:00:1d.0: PCI INT A disabled Nov 14 13:57:18 snowball2 kernel: [ 5660.729093] ehci_hcd 0000:00:1a.0: PCI INT A disabled Nov 14 13:57:18 snowball2 kernel: [ 5661.020794] snd_hda_intel 0000:00:1b.0: PCI INT A disabled Nov 14 13:57:18 snowball2 kernel: [ 5661.133671] snd_hda_intel 0000:01:00.1: PCI INT B disabled Nov 14 13:57:18 snowball2 kernel: [ 5661.144839] PM: suspend of devices complete after 992.826 msecs Nov 14 13:57:18 snowball2 kernel: [ 5661.155826] jme 0000:03:00.0: wake-up capability enabled by ACPI Nov 14 13:57:18 snowball2 kernel: [ 5661.199692] PM: late suspend of devices complete after 54.910 msecs Nov 14 13:57:18 snowball2 kernel: [ 5661.199890] ACPI: Preparing to enter system sleep state S3 Nov 14 13:57:18 snowball2 kernel: [ 5661.204766] PM: Saving platform NVS memory Nov 14 13:57:18 snowball2 kernel: [ 5661.211616] Disabling non-boot CPUs ... Nov 14 13:57:18 snowball2 kernel: [ 5661.213365] CPU 1 is now offline Nov 14 13:57:18 snowball2 kernel: [ 5661.215294] CPU 2 is now offline Nov 14 13:57:18 snowball2 kernel: [ 5661.217088] CPU 3 is now offline Nov 14 13:57:18 snowball2 kernel: [ 5661.218989] CPU 4 is now offline Nov 14 13:57:18 snowball2 kernel: [ 5661.219658] Broke affinity for irq 23 Nov 14 13:57:18 snowball2 kernel: [ 5661.219662] Broke affinity for irq 42 Nov 14 13:57:18 snowball2 kernel: [ 5661.219668] Broke affinity for irq 46 Nov 14 13:57:18 snowball2 kernel: [ 5661.219673] Broke affinity for irq 50 Nov 14 13:57:18 snowball2 kernel: [ 5661.220692] CPU 5 is now offline Nov 14 13:57:18 snowball2 kernel: [ 5661.221464] Broke affinity for irq 43 Nov 14 13:57:18 snowball2 kernel: [ 5661.221468] Broke affinity for irq 45 Nov 14 13:57:18 snowball2 kernel: [ 5661.221471] Broke affinity for irq 47 Nov 14 13:57:18 snowball2 kernel: [ 5661.221475] Broke affinity for irq 49 Nov 14 13:57:18 snowball2 kernel: [ 5661.222507] CPU 6 is now offline Nov 14 13:57:18 snowball2 kernel: [ 5661.223092] Broke affinity for irq 16 Nov 14 13:57:18 snowball2 kernel: [ 5661.223095] Broke affinity for irq 18 Nov 14 13:57:18 snowball2 kernel: [ 5661.223101] Broke affinity for irq 44 Nov 14 13:57:18 snowball2 kernel: [ 5661.223107] Broke affinity for irq 48 Nov 14 13:57:18 snowball2 kernel: [ 5661.224129] CPU 7 is now offline Nov 14 13:57:18 snowball2 kernel: [ 5661.224469] Extended CMOS year: 2000 Nov 14 13:57:18 snowball2 kernel: [ 5661.224746] ACPI: Low-level resume complete Nov 14 13:57:18 snowball2 kernel: [ 5661.224784] PM: Restoring platform NVS memory Nov 14 13:57:18 snowball2 kernel: [ 5661.225613] Extended CMOS year: 2000 Nov 14 13:57:18 snowball2 kernel: [ 5661.225651] Enabling non-boot CPUs ... Nov 14 13:57:18 snowball2 kernel: [ 5661.225763] Booting Node 0 Processor 1 APIC 0x2 Nov 14 13:57:18 snowball2 acpid: client 1297[0:0] has disconnected Nov 14 13:57:18 snowball2 kernel: [ 5661.236774] Calibrating delay loop (skipped) already calibrated this CPU Nov 14 13:57:18 snowball2 kernel: [ 5661.257166] NMI watchdog enabled, takes one hw-pmu counter. Nov 14 13:57:18 snowball2 kernel: [ 5661.257496] CPU1 is up Nov 14 13:57:18 snowball2 kernel: [ 5661.257578] Booting Node 0 Processor 2 APIC 0x4 Nov 14 13:57:18 snowball2 kernel: [ 5661.257603] Switched to NOHz mode on CPU #1 Nov 14 13:57:18 snowball2 kernel: [ 5661.268587] Calibrating delay loop (skipped) already calibrated this CPU Nov 14 13:57:18 snowball2 kernel: [ 5661.288965] NMI watchdog enabled, takes one hw-pmu counter. Nov 14 13:57:18 snowball2 kernel: [ 5661.289262] CPU2 is up Nov 14 13:57:18 snowball2 kernel: [ 5661.289323] Booting Node 0 Processor 3 APIC 0x6 Nov 14 13:57:18 snowball2 kernel: [ 5661.289567] Switched to NOHz mode on CPU #2 Nov 14 13:57:18 snowball2 kernel: [ 5661.300332] Calibrating delay loop (skipped) already calibrated this CPU Nov 14 13:57:18 snowball2 kernel: [ 5661.320533] Switched to NOHz mode on CPU #3 Nov 14 13:57:18 snowball2 kernel: [ 5661.320719] NMI watchdog enabled, takes one hw-pmu counter. Nov 14 13:57:18 snowball2 kernel: [ 5661.320991] CPU3 is up Nov 14 13:57:18 snowball2 kernel: [ 5661.321049] Booting Node 0 Processor 4 APIC 0x1 Nov 14 13:57:18 snowball2 kernel: [ 5661.332099] Calibrating delay loop (skipped) already calibrated this CPU Nov 14 13:57:18 snowball2 kernel: [ 5661.352508] Switched to NOHz mode on CPU #4 Nov 14 13:57:18 snowball2 kernel: [ 5661.352515] NMI watchdog enabled, takes one hw-pmu counter. Nov 14 13:57:18 snowball2 kernel: [ 5661.352801] CPU4 is up Nov 14 13:57:18 snowball2 kernel: [ 5661.352864] Booting Node 0 Processor 5 APIC 0x3 Nov 14 13:57:18 snowball2 kernel: [ 5661.363871] Calibrating delay loop (skipped) already calibrated this CPU Nov 14 13:57:18 snowball2 kernel: [ 5661.384343] NMI watchdog enabled, takes one hw-pmu counter. Nov 14 13:57:18 snowball2 kernel: [ 5661.384464] Switched to NOHz mode on CPU #5 Nov 14 13:57:18 snowball2 kernel: [ 5661.384683] CPU5 is up Nov 14 13:57:18 snowball2 kernel: [ 5661.384757] Booting Node 0 Processor 6 APIC 0x5 Nov 14 13:57:18 snowball2 kernel: [ 5661.395763] Calibrating delay loop (skipped) already calibrated this CPU Nov 14 13:57:18 snowball2 kernel: [ 5661.416274] NMI watchdog enabled, takes one hw-pmu counter. Nov 14 13:57:18 snowball2 kernel: [ 5661.416429] Switched to NOHz mode on CPU #6 Nov 14 13:57:18 snowball2 kernel: [ 5661.416635] CPU6 is up Nov 14 13:57:18 snowball2 kernel: [ 5661.416765] Booting Node 0 Processor 7 APIC 0x7 Nov 14 13:57:18 snowball2 kernel: [ 5661.427770] Calibrating delay loop (skipped) already calibrated this CPU Nov 14 13:57:18 snowball2 kernel: [ 5661.448302] NMI watchdog enabled, takes one hw-pmu counter. Nov 14 13:57:18 snowball2 kernel: [ 5661.448394] Switched to NOHz mode on CPU #7 Nov 14 13:57:18 snowball2 kernel: [ 5661.448600] CPU7 is up Nov 14 13:57:18 snowball2 kernel: [ 5661.454849] ACPI: Waking up from system sleep state S3 Nov 14 13:57:18 snowball2 kernel: [ 5661.463178] PM: early resume of devices complete after 1.438 msecs Nov 14 13:57:18 snowball2 kernel: [ 5661.463288] ehci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 Nov 14 13:57:18 snowball2 kernel: [ 5661.463315] snd_hda_intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 Nov 14 13:57:18 snowball2 kernel: [ 5661.463326] ehci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 Nov 14 13:57:18 snowball2 kernel: [ 5661.463364] snd_hda_intel 0000:01:00.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Nov 14 13:57:18 snowball2 kernel: [ 5661.463422] jme 0000:03:00.0: wake-up capability disabled by ACPI Nov 14 13:57:18 snowball2 kernel: [ 5661.463548] iwlagn 0000:04:00.0: RF_KILL bit toggled to enable radio. Nov 14 13:57:18 snowball2 kernel: [ 5661.463686] sdhci-pci 0000:03:00.1: PCI INT B -> GSI 18 (level, low) -> IRQ 18 Nov 14 13:57:18 snowball2 kernel: [ 5661.463692] jmb38x_ms 0000:03:00.3: PCI INT B -> GSI 18 (level, low) -> IRQ 18 Nov 14 13:57:18 snowball2 kernel: [ 5661.463781] sd 0:0:0:0: [sda] Starting disk Nov 14 13:57:18 snowball2 kernel: [ 5661.514516] firewire_core: skipped bus generations, destroying all nodes Nov 14 13:57:18 snowball2 kernel: [ 5661.695267] usb 2-1.5: reset full speed USB device number 3 using ehci_hcd Nov 14 13:57:18 snowball2 kernel: [ 5661.770060] ata4: SATA link down (SStatus 0 SControl 300) Nov 14 13:57:18 snowball2 kernel: [ 5661.772082] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Nov 14 13:57:18 snowball2 kernel: [ 5661.776612] ata3.00: configured for UDMA/133 Nov 14 13:57:18 snowball2 kernel: [ 5662.075550] irq 19: nobody cared (try booting with the "irqpoll" option) Nov 14 13:57:18 snowball2 kernel: [ 5662.075554] Pid: 0, comm: swapper Tainted: P 3.1.1-1.fc16.x86_64 #1 Nov 14 13:57:18 snowball2 kernel: [ 5662.075555] Call Trace: Nov 14 13:57:18 snowball2 kernel: [ 5662.075557] <IRQ> [<ffffffff810b2222>] __report_bad_irq+0x38/0xc3 Nov 14 13:57:18 snowball2 kernel: [ 5662.075566] [<ffffffff810b24bc>] note_interrupt+0x176/0x1fa Nov 14 13:57:18 snowball2 kernel: [ 5662.075568] [<ffffffff810b0a0f>] handle_irq_event_percpu+0x15d/0x1a5 Nov 14 13:57:18 snowball2 kernel: [ 5662.075571] [<ffffffff810b0a92>] handle_irq_event+0x3b/0x59 Nov 14 13:57:18 snowball2 kernel: [ 5662.075574] [<ffffffff81078268>] ? sched_clock_cpu+0x42/0xc6 Nov 14 13:57:18 snowball2 kernel: [ 5662.075577] [<ffffffff810b2c7c>] handle_fasteoi_irq+0x80/0xa4 Nov 14 13:57:18 snowball2 kernel: [ 5662.075580] [<ffffffff81010af9>] handle_irq+0x88/0x8e Nov 14 13:57:18 snowball2 kernel: [ 5662.075582] [<ffffffff814c03cd>] do_IRQ+0x4d/0xa5 Nov 14 13:57:18 snowball2 kernel: [ 5662.075586] [<ffffffff814b752e>] common_interrupt+0x6e/0x6e Nov 14 13:57:18 snowball2 kernel: [ 5662.075587] <EOI> [<ffffffff81014b35>] ? paravirt_read_tsc+0x9/0xd Nov 14 13:57:18 snowball2 kernel: [ 5662.075593] [<ffffffff8126972c>] ? intel_idle+0xd8/0x100 Nov 14 13:57:18 snowball2 kernel: [ 5662.075595] [<ffffffff8126970e>] ? intel_idle+0xba/0x100 Nov 14 13:57:18 snowball2 kernel: [ 5662.075598] [<ffffffff813a5fae>] cpuidle_idle_call+0xe8/0x182 Nov 14 13:57:18 snowball2 kernel: [ 5662.075600] [<ffffffff8100e2e3>] cpu_idle+0xa4/0xe8 Nov 14 13:57:18 snowball2 kernel: [ 5662.075604] [<ffffffff81494a5e>] rest_init+0x72/0x74 Nov 14 13:57:18 snowball2 kernel: [ 5662.075607] [<ffffffff81b76b7d>] start_kernel+0x3ab/0x3b6 Nov 14 13:57:18 snowball2 kernel: [ 5662.075609] [<ffffffff81b762c4>] x86_64_start_reservations+0xaf/0xb3 Nov 14 13:57:18 snowball2 kernel: [ 5662.075611] [<ffffffff81b76140>] ? early_idt_handlers+0x140/0x140 Nov 14 13:57:18 snowball2 kernel: [ 5662.075612] [<ffffffff81b763ca>] x86_64_start_kernel+0x102/0x111 Nov 14 13:57:18 snowball2 kernel: [ 5662.075614] handlers: Nov 14 13:57:18 snowball2 kernel: [ 5662.075626] [<ffffffffa004472c>] irq_handler Nov 14 13:57:18 snowball2 kernel: [ 5662.075627] Disabling IRQ #19 Nov 14 13:57:18 snowball2 kernel: [ 5662.221294] firewire_core: rediscovered device fw0 Nov 14 13:57:18 snowball2 kernel: [ 5663.890536] Extended CMOS year: 2000 Nov 14 13:57:18 snowball2 kernel: [ 5665.487052] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Nov 14 13:57:18 snowball2 kernel: [ 5665.493114] ata1.00: configured for UDMA/133 Nov 14 13:57:18 snowball2 kernel: [ 5665.520734] PM: resume of devices complete after 4061.985 msecs Nov 14 13:57:18 snowball2 kernel: [ 5665.521076] Restarting tasks ... done. Nov 14 13:57:18 snowball2 kernel: [ 5665.527425] video LNXVIDEO:00: Restoring backlight state Nov 14 13:57:18 snowball2 dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 13:57:18 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 13:57:18 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 13:57:18 snowball2 dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> wake requested (sleeping: yes enabled: yes) Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> wake requested (sleeping: yes enabled: yes) Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> waking up and re-enabling... Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> waking up and re-enabling... Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> WWAN now enabled by management service Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> WWAN now enabled by management service Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> (p1p1): now managed Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (p1p1): now managed Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> (p1p1): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (p1p1): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> (p1p1): bringing up device. Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (p1p1): bringing up device. Nov 14 13:57:18 snowball2 kernel: [ 5666.076457] jme 0000:03:00.0: p1p1: Link is down Nov 14 13:57:18 snowball2 kernel: [ 5666.076966] jme 0000:03:00.0: p1p1: Link is down Nov 14 13:57:18 snowball2 kernel: [ 5666.077395] ADDRCONF(NETDEV_UP): p1p1: link is not ready Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> (p1p1): preparing device. Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> (p1p1): deactivating device (reason 'managed') [2] Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (p1p1): preparing device. Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (p1p1): deactivating device (reason 'managed') [2] Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> (wlan0): now managed Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): now managed Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 14 13:57:18 snowball2 NetworkManager[1113]: <info> (wlan0): bringing up device. Nov 14 13:57:18 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): bringing up device. Nov 14 13:57:18 snowball2 kernel: [ 5666.078899] iwlagn 0000:04:00.0: L1 Enabled; Disabling L0S Nov 14 13:57:18 snowball2 kernel: [ 5666.086040] iwlagn 0000:04:00.0: Radio type=0x1-0x2-0x0 Nov 14 13:57:19 snowball2 NetworkManager[1113]: <info> (wlan0): preparing device. Nov 14 13:57:19 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): preparing device. Nov 14 13:57:19 snowball2 NetworkManager[1113]: <info> (wlan0): deactivating device (reason 'managed') [2] Nov 14 13:57:19 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): deactivating device (reason 'managed') [2] Nov 14 13:57:19 snowball2 kernel: [ 5666.208255] ADDRCONF(NETDEV_UP): wlan0: link is not ready Nov 14 13:57:19 snowball2 NetworkManager[1113]: <info> (wlan0): supplicant interface state: starting -> ready Nov 14 13:57:19 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] Nov 14 13:57:19 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): supplicant interface state: starting -> ready Nov 14 13:57:19 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] Nov 14 13:57:19 snowball2 NetworkManager[1113]: <info> (wlan0): supplicant interface state: ready -> inactive Nov 14 13:57:19 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): supplicant interface state: ready -> inactive Nov 14 13:57:20 snowball2 acpid: client connected from 1297[0:0] Nov 14 13:57:20 snowball2 acpid: 1 client rule loaded Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Auto-activating connection 'System julas (wlan0)'. Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) starting connection 'System julas (wlan0)' Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Auto-activating connection 'System julas (wlan0)'. Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) starting connection 'System julas (wlan0)' Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0/wireless): access point 'System julas (wlan0)' has security, but secrets are required. Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0/wireless): access point 'System julas (wlan0)' has security, but secrets are required. Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0/wireless): connection 'System julas (wlan0)' has security, and secrets exist. No new secrets needed. Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0/wireless): connection 'System julas (wlan0)' has security, and secrets exist. No new secrets needed. Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Config: added 'ssid' value 'julas' Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Config: added 'scan_ssid' value '1' Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Config: added 'key_mgmt' value 'WPA-PSK' Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Config: added 'ssid' value 'julas' Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Config: added 'scan_ssid' value '1' Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Config: added 'psk' value '<omitted>' Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Config: added 'key_mgmt' value 'WPA-PSK' Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Config: added 'psk' value '<omitted>' Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Config: added 'proto' value 'WPA RSN' Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Config: added 'proto' value 'WPA RSN' Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> Config: set interface ap_scan to 1 Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Config: set interface ap_scan to 1 Nov 14 13:57:22 snowball2 NetworkManager[1113]: <info> (wlan0): supplicant interface state: inactive -> scanning Nov 14 13:57:22 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): supplicant interface state: inactive -> scanning Nov 14 13:57:25 snowball2 NetworkManager[1113]: <info> (wlan0): supplicant interface state: scanning -> authenticating Nov 14 13:57:25 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): supplicant interface state: scanning -> authenticating Nov 14 13:57:25 snowball2 NetworkManager[1113]: <info> (wlan0): supplicant interface state: authenticating -> associating Nov 14 13:57:25 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): supplicant interface state: authenticating -> associating Nov 14 13:57:25 snowball2 kernel: [ 5672.841527] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready Nov 14 13:57:25 snowball2 NetworkManager[1113]: <info> (wlan0): supplicant interface state: associating -> associated Nov 14 13:57:25 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): supplicant interface state: associating -> associated Nov 14 13:57:25 snowball2 dnsmasq[1330]: no servers found in /etc/resolv.conf, will retry Nov 14 13:57:25 snowball2 NetworkManager[1113]: <info> (wlan0): supplicant interface state: associated -> 4-way handshake Nov 14 13:57:25 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): supplicant interface state: associated -> 4-way handshake Nov 14 13:57:26 snowball2 NetworkManager[1113]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed Nov 14 13:57:26 snowball2 NetworkManager[1113]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'julas'. Nov 14 13:57:26 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. Nov 14 13:57:26 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed Nov 14 13:57:26 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'julas'. Nov 14 13:57:26 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. Nov 14 13:57:26 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... Nov 14 13:57:26 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] Nov 14 13:57:26 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... Nov 14 13:57:26 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] Nov 14 13:57:26 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) Nov 14 13:57:26 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) Nov 14 13:57:26 snowball2 NetworkManager[1113]: <info> dhclient started with pid 15096 Nov 14 13:57:26 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> dhclient started with pid 15096 Nov 14 13:57:26 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. Nov 14 13:57:26 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. Nov 14 13:57:27 snowball2 dhclient[15096]: Internet Systems Consortium DHCP Client 4.2.3 Nov 14 13:57:27 snowball2 dhclient[15096]: Copyright 2004-2011 Internet Systems Consortium. Nov 14 13:57:27 snowball2 dhclient[15096]: All rights reserved. Nov 14 13:57:27 snowball2 dhclient[15096]: For info, please visit https://www.isc.org/software/dhcp/ Nov 14 13:57:27 snowball2 dhclient[15096]: Nov 14 13:57:27 snowball2 NetworkManager[1113]: Internet Systems Consortium DHCP Client 4.2.3 Nov 14 13:57:27 snowball2 NetworkManager[1113]: Copyright 2004-2011 Internet Systems Consortium. Nov 14 13:57:27 snowball2 NetworkManager[1113]: All rights reserved. Nov 14 13:57:27 snowball2 NetworkManager[1113]: For info, please visit https://www.isc.org/software/dhcp/ Nov 14 13:57:27 snowball2 NetworkManager[1113]: <info> (wlan0): DHCPv4 state changed nbi -> preinit Nov 14 13:57:27 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): DHCPv4 state changed nbi -> preinit Nov 14 13:57:27 snowball2 avahi-daemon[1122]: Registering new address record for fe80::8a53:2eff:fe03:74f1 on wlan0.*. Nov 14 13:57:28 snowball2 ntpd[1117]: Listen normally on 7 wlan0 fe80::8a53:2eff:fe03:74f1 UDP 123 Nov 14 13:57:28 snowball2 ntpd[1117]: peers refreshed Nov 14 13:57:28 snowball2 dhclient[15096]: Listening on LPF/wlan0/88:53:2e:03:74:f1 Nov 14 13:57:28 snowball2 dhclient[15096]: Sending on LPF/wlan0/88:53:2e:03:74:f1 Nov 14 13:57:28 snowball2 NetworkManager[1113]: Listening on LPF/wlan0/88:53:2e:03:74:f1 Nov 14 13:57:28 snowball2 NetworkManager[1113]: Sending on LPF/wlan0/88:53:2e:03:74:f1 Nov 14 13:57:28 snowball2 dhclient[15096]: Sending on Socket/fallback Nov 14 13:57:28 snowball2 NetworkManager[1113]: Sending on Socket/fallback Nov 14 13:57:28 snowball2 dhclient[15096]: DHCPREQUEST on wlan0 to 255.255.255.255 port 67 Nov 14 13:57:28 snowball2 NetworkManager[1113]: DHCPREQUEST on wlan0 to 255.255.255.255 port 67 Nov 14 13:57:28 snowball2 dhclient[15096]: DHCPACK from 192.168.1.1 Nov 14 13:57:28 snowball2 NetworkManager[1113]: DHCPACK from 192.168.1.1 Nov 14 13:57:28 snowball2 dhclient[15096]: bound to 192.168.1.2 -- renewal in 40855 seconds. Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> (wlan0): DHCPv4 state changed preinit -> reboot Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) scheduled... Nov 14 13:57:28 snowball2 NetworkManager[1113]: bound to 192.168.1.2 -- renewal in 40855 seconds. Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) started... Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): DHCPv4 state changed preinit -> reboot Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> address 192.168.1.2 Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) scheduled... Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> prefix 24 (255.255.255.0) Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) started... Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> gateway 192.168.1.1 Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> nameserver '192.168.1.1' Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> address 192.168.1.2 Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> prefix 24 (255.255.255.0) Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> gateway 192.168.1.1 Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> nameserver '192.168.1.1' Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) scheduled... Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) complete. Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) scheduled... Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) complete. Nov 14 13:57:28 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started... Nov 14 13:57:28 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started... Nov 14 13:57:28 snowball2 avahi-daemon[1122]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.2. Nov 14 13:57:28 snowball2 avahi-daemon[1122]: New relevant interface wlan0.IPv4 for mDNS. Nov 14 13:57:28 snowball2 avahi-daemon[1122]: Registering new address record for 192.168.1.2 on wlan0.IPv4. Nov 14 13:57:29 snowball2 NetworkManager[1113]: <info> (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0] Nov 14 13:57:29 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0] Nov 14 13:57:30 snowball2 NetworkManager[1113]: <info> Policy set 'System julas (wlan0)' (wlan0) as default for IPv4 routing and DNS. Nov 14 13:57:30 snowball2 dnsmasq[1330]: reading /etc/resolv.conf Nov 14 13:57:30 snowball2 NetworkManager[1113]: <info> Activation (wlan0) successful, device activated. Nov 14 13:57:30 snowball2 dnsmasq[1330]: using nameserver 192.168.1.1#53 Nov 14 13:57:30 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Policy set 'System julas (wlan0)' (wlan0) as default for IPv4 routing and DNS. Nov 14 13:57:30 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) successful, device activated. Nov 14 13:57:30 snowball2 NetworkManager[1113]: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete. Nov 14 13:57:30 snowball2 NetworkManager[1113]: NetworkManager[1113]: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete. Nov 14 13:57:30 snowball2 ntpd[1117]: Listen normally on 8 wlan0 192.168.1.2 UDP 123 Nov 14 13:57:30 snowball2 ntpd[1117]: peers refreshed Nov 14 13:57:31 snowball2 ntpd[1117]: 0.0.0.0 0618 08 no_sys_peer Nov 14 13:57:32 snowball2 kernel: [ 5679.834353] iwlagn 0000:04:00.0: Tx aggregation enabled on ra = c0:3f:0e:2d:f8:f0 tid = 0 Nov 14 13:57:48 snowball2 dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 13:57:48 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 13:57:48 snowball2 dbus-daemon[1181]: Launching FprintObject Nov 14 13:57:48 snowball2 dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 13:57:48 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 13:57:48 snowball2 dbus-daemon[1181]: ** Message: D-Bus service launched with name: net.reactivated.Fprint Nov 14 13:57:48 snowball2 dbus-daemon[1181]: ** Message: entering main loop Nov 14 13:58:18 snowball2 dbus-daemon[1181]: ** Message: No devices in use, exit Nov 14 13:58:42 snowball2 ntpd[1117]: 0.0.0.0 0613 03 spike_detect +0.872527 s Nov 14 13:59:35 snowball2 kernel: [ 5802.207751] iwlagn 0000:04:00.0: Tx aggregation enabled on ra = c0:3f:0e:2d:f8:f0 tid = 6 Nov 14 14:01:01 snowball2 systemd-logind[1120]: New user root logged in. Nov 14 14:01:01 snowball2 systemd-logind[1120]: New session 4 of user root. Nov 14 14:01:01 snowball2 systemd-logind[1120]: Removed session 4. Nov 14 14:06:15 snowball2 dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 14:06:15 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 14:06:15 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 14:06:15 snowball2 dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 14:26:34 snowball2 kernel: [ 7419.396868] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 14:26:34 snowball2 kernel: [ 7419.397834] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 14:26:34 snowball2 kernel: [ 7419.746477] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 14:26:34 snowball2 kernel: [ 7419.880166] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 14:26:34 snowball2 kernel: [ 7419.933308] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 14:26:57 snowball2 dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 14:26:57 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 14:26:57 snowball2 dbus-daemon[1181]: Launching FprintObject Nov 14 14:26:57 snowball2 dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 14:26:57 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 14:26:57 snowball2 dbus-daemon[1181]: ** Message: D-Bus service launched with name: net.reactivated.Fprint Nov 14 14:26:57 snowball2 dbus-daemon[1181]: ** Message: entering main loop Nov 14 14:27:28 snowball2 dbus-daemon[1181]: ** Message: No devices in use, exit Nov 14 14:29:17 snowball2 acpid: client 1297[0:0] has disconnected Nov 14 14:29:23 snowball2 acpid: client connected from 1297[0:0] Nov 14 14:29:23 snowball2 acpid: 1 client rule loaded Nov 14 14:31:34 snowball2 dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 14:31:34 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 14:31:34 snowball2 dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 14:31:34 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 14:35:16 snowball2 ntpd[1117]: 0.0.0.0 061c 0c clock_step +0.873075 s Nov 14 14:35:17 snowball2 ntpd[1117]: 0.0.0.0 0615 05 clock_sync Nov 14 14:35:18 snowball2 ntpd[1117]: 0.0.0.0 c618 08 no_sys_peer Nov 14 14:56:35 snowball2 kernel: [ 9217.401716] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 14:56:35 snowball2 kernel: [ 9217.403200] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 14:56:35 snowball2 kernel: [ 9217.744429] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 14:56:35 snowball2 kernel: [ 9217.878274] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 14:56:35 snowball2 kernel: [ 9217.942552] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:01:01 snowball2 systemd-logind[1120]: New session 5 of user root. Nov 14 15:01:01 snowball2 systemd-logind[1120]: Removed session 5. Nov 14 15:17:09 snowball2 kernel: [10450.939105] gnome-mplayer[17679]: segfault at 0 ip 00000032de40e6ab sp 00007f02d3ffe330 error 6 in libgmtk.so.0.0.0[32de400000+14000] Nov 14 15:17:12 snowball2 kernel: [10453.364633] gnome-mplayer[17699]: segfault at 0 ip 00000032de40e6ab sp 00007f1ba600c330 error 6 in libgmtk.so.0.0.0[32de400000+14000] Nov 14 15:17:14 snowball2 kernel: [10455.609352] gnome-mplayer[17719]: segfault at 0 ip 00000032de40e6ab sp 00007fb460ff8330 error 6 in libgmtk.so.0.0.0[32de400000+14000] Nov 14 15:17:16 snowball2 kernel: [10457.035253] gnome-mplayer[17738]: segfault at 0 ip 00000032de40e6ab sp 00007fbaeb7f5330 error 6 in libgmtk.so.0.0.0[32de400000+14000] Nov 14 15:17:35 snowball2 kernel: [10476.256285] gnome-mplayer[17884]: segfault at 0 ip 00000032de40e6ab sp 00007f0db2ff4330 error 6 in libgmtk.so.0.0.0[32de400000+14000] Nov 14 15:18:37 snowball2 kernel: [10538.463006] gnome-mplayer[17954] general protection ip:32dca8ebcc sp:7fffda7d8740 error:0 in libgtk-3.so.0.200.1[32dc800000+43b000] Nov 14 15:23:59 snowball2 dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 15:23:59 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 15:23:59 snowball2 dbus-daemon[1181]: Launching FprintObject Nov 14 15:23:59 snowball2 dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 15:23:59 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 15:23:59 snowball2 dbus-daemon[1181]: ** Message: D-Bus service launched with name: net.reactivated.Fprint Nov 14 15:23:59 snowball2 dbus-daemon[1181]: ** Message: entering main loop Nov 14 15:24:29 snowball2 dbus-daemon[1181]: ** Message: No devices in use, exit Nov 14 15:25:06 snowball2 yum[18333]: Installed: mplayer-debuginfo-1.0-0.126.20110816svn.fc16.x86_64 Nov 14 15:25:07 snowball2 dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 15:25:07 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 15:25:07 snowball2 dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 15:25:07 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 15:26:35 snowball2 kernel: [11015.501944] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:26:35 snowball2 kernel: [11015.502975] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:26:35 snowball2 kernel: [11015.837184] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:26:35 snowball2 kernel: [11016.014988] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:26:35 snowball2 kernel: [11016.089967] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:28:19 snowball2 dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 15:28:19 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 15:28:19 snowball2 dbus-daemon[1181]: Launching FprintObject Nov 14 15:28:19 snowball2 dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 15:28:20 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 15:28:20 snowball2 dbus-daemon[1181]: ** Message: D-Bus service launched with name: net.reactivated.Fprint Nov 14 15:28:20 snowball2 dbus-daemon[1181]: ** Message: entering main loop Nov 14 15:28:43 snowball2 yum[27056]: Updated: libass-0.10.0-1.fc16.x86_64 Nov 14 15:28:44 snowball2 yum[27056]: Installed: fribidi-0.19.2-3.fc15.i686 Nov 14 15:28:45 snowball2 yum[27056]: Updated: libass-0.10.0-1.fc16.i686 Nov 14 15:28:49 snowball2 dbus-daemon[1181]: ** Message: No devices in use, exit Nov 14 15:31:28 snowball2 gnome-keyring-prompt: could not grab keyboard: not viewable Nov 14 15:31:28 snowball2 gnome-keyring-prompt: could not grab keyboard: not viewable Nov 14 15:48:54 snowball2 dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 15:48:54 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 15:48:54 snowball2 dbus-daemon[1181]: Launching FprintObject Nov 14 15:48:54 snowball2 dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 15:48:54 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 15:48:54 snowball2 dbus-daemon[1181]: ** Message: D-Bus service launched with name: net.reactivated.Fprint Nov 14 15:48:54 snowball2 dbus-daemon[1181]: ** Message: entering main loop Nov 14 15:49:06 snowball2 yum[31951]: Installed: mono-locale-extras-2.10.5-1.fc16.x86_64 Nov 14 15:49:09 snowball2 yum[31951]: Installed: gnome-subtitles-1.2-1.fc16.x86_64 Nov 14 15:49:10 snowball2 dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 15:49:10 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper) Nov 14 15:49:10 snowball2 dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 15:49:10 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'org.freedesktop.PackageKit' Nov 14 15:49:25 snowball2 dbus-daemon[1181]: ** Message: No devices in use, exit Nov 14 15:56:35 snowball2 kernel: [12813.460976] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:56:35 snowball2 kernel: [12813.461822] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:56:35 snowball2 kernel: [12813.548045] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:56:35 snowball2 kernel: [12813.670723] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 15:56:35 snowball2 kernel: [12813.712884] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 16:01:01 snowball2 systemd-logind[1120]: New session 6 of user root. Nov 14 16:01:01 snowball2 systemd-logind[1120]: Removed session 6. Nov 14 16:01:01 snowball2 systemd-logind[1120]: User root logged out. Nov 14 16:06:56 snowball2 dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 16:06:56 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 16:06:56 snowball2 dbus-daemon[1181]: Launching FprintObject Nov 14 16:06:56 snowball2 dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 16:06:56 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 16:06:56 snowball2 dbus-daemon[1181]: ** Message: D-Bus service launched with name: net.reactivated.Fprint Nov 14 16:06:56 snowball2 dbus-daemon[1181]: ** Message: entering main loop Nov 14 16:07:25 snowball2 dbus-daemon[1181]: ** Message: No devices in use, exit Nov 14 16:07:31 snowball2 dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 16:07:31 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper) Nov 14 16:07:31 snowball2 dbus-daemon[1181]: Launching FprintObject Nov 14 16:07:31 snowball2 dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 16:07:31 snowball2 dbus-daemon[1181]: dbus[1181]: [system] Successfully activated service 'net.reactivated.Fprint' Nov 14 16:07:31 snowball2 dbus-daemon[1181]: ** Message: D-Bus service launched with name: net.reactivated.Fprint Nov 14 16:07:31 snowball2 dbus-daemon[1181]: ** Message: entering main loop I was able to watch the movie and the drive was working correctly. I then tried to disconnect and reconnect it to see if it triggers the problem. Unfortunately, upon reconnection the laptop did not see the drive anymore. The logs below contain a connection to USB2 port just to see if the drive is working. I am sorry for this chaotic reports but, as you can see, it is not exactly easy to reproduce the problem. What is certain is that the USB3 ports do not survive suspend/resume too well. Nov 14 16:07:34 snowball2 ntfs-3g[2205]: Unmounting /dev/mapper/realcrypt1 () Nov 14 16:07:44 snowball2 ntfs-3g[2084]: Unmounting /dev/sdb1 (lacie) Nov 14 16:07:44 snowball2 kernel: [13481.798270] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 16:07:44 snowball2 kernel: [13481.799603] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 16:07:46 snowball2 kernel: [13483.711382] usb 4-2: USB disconnect, device number 2 Nov 14 16:07:46 snowball2 kernel: [13483.713240] scsi: killing requests for dead queue Nov 14 16:07:46 snowball2 kernel: [13484.120961] hub 4-0:1.0: unable to enumerate USB device on port 2 Nov 14 16:08:02 snowball2 dbus-daemon[1181]: ** Message: No devices in use, exit Nov 14 16:08:05 snowball2 kernel: [13503.249888] usb 3-1: new full speed USB device number 5 using xhci_hcd Nov 14 16:08:05 snowball2 kernel: [13503.250268] usb 3-1: Device not responding to set address. Nov 14 16:08:05 snowball2 kernel: [13503.450927] usb 3-1: Device not responding to set address. Nov 14 16:08:06 snowball2 kernel: [13503.651302] usb 3-1: device not accepting address 5, error -71 Nov 14 16:08:06 snowball2 kernel: [13503.804173] usb 3-1: new full speed USB device number 6 using xhci_hcd Nov 14 16:08:06 snowball2 kernel: [13503.804532] usb 3-1: Device not responding to set address. Nov 14 16:08:06 snowball2 kernel: [13504.004985] usb 3-1: Device not responding to set address. Nov 14 16:08:06 snowball2 kernel: [13504.205703] usb 3-1: device not accepting address 6, error -71 Nov 14 16:08:06 snowball2 kernel: [13504.256755] hub 3-0:1.0: unable to enumerate USB device on port 1 Nov 14 16:08:07 snowball2 kernel: [13505.259804] usb 4-1: new SuperSpeed USB device number 4 using xhci_hcd Nov 14 16:08:07 snowball2 kernel: [13505.273952] xhci_hcd 0000:02:00.0: WARN: short transfer on control ep Nov 14 16:08:07 snowball2 kernel: [13505.274575] xhci_hcd 0000:02:00.0: WARN: short transfer on control ep Nov 14 16:08:07 snowball2 kernel: [13505.275188] xhci_hcd 0000:02:00.0: WARN: short transfer on control ep Nov 14 16:08:07 snowball2 kernel: [13505.275812] xhci_hcd 0000:02:00.0: WARN: short transfer on control ep Nov 14 16:08:07 snowball2 kernel: [13505.276073] usb 4-1: New USB device found, idVendor=059f, idProduct=103e Nov 14 16:08:07 snowball2 kernel: [13505.276077] usb 4-1: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Nov 14 16:08:07 snowball2 kernel: [13505.276079] usb 4-1: Product: Rugged USB 3 Nov 14 16:08:07 snowball2 kernel: [13505.276081] usb 4-1: Manufacturer: LaCie Nov 14 16:08:07 snowball2 kernel: [13505.276083] usb 4-1: SerialNumber: ce0238914a4c0000000 Nov 14 16:08:07 snowball2 kernel: [13505.277963] scsi7 : usb-storage 4-1:1.0 Nov 14 16:08:07 snowball2 mtp-probe: checking bus 4, device 4: "/sys/devices/pci0000:00/0000:00:1c.0/0000:02:00.0/usb4/4-1" Nov 14 16:08:07 snowball2 mtp-probe: bus: 4, device: 4 was not an MTP device Nov 14 16:08:09 snowball2 kernel: [13507.247509] scsi 7:0:0:0: Direct-Access ST950032 5AS 0002 PQ: 0 ANSI: 0 Nov 14 16:08:09 snowball2 kernel: [13507.247802] scsi: killing requests for dead queue Nov 14 16:08:09 snowball2 kernel: [13507.248020] scsi: killing requests for dead queue Nov 14 16:08:09 snowball2 kernel: [13507.248163] scsi: killing requests for dead queue Nov 14 16:08:09 snowball2 kernel: [13507.248406] scsi: killing requests for dead queue Nov 14 16:08:09 snowball2 kernel: [13507.248752] scsi: killing requests for dead queue Nov 14 16:08:09 snowball2 kernel: [13507.248948] scsi: killing requests for dead queue Nov 14 16:08:09 snowball2 kernel: [13507.249087] scsi: killing requests for dead queue Nov 14 16:08:09 snowball2 kernel: [13507.249218] scsi: killing requests for dead queue Nov 14 16:08:09 snowball2 kernel: [13507.250027] sd 7:0:0:0: Attached scsi generic sg2 type 0 Nov 14 16:08:09 snowball2 kernel: [13507.250483] sd 7:0:0:0: [sdb] 976773168 512-byte logical blocks: (500 GB/465 GiB) Nov 14 16:08:09 snowball2 kernel: [13507.250641] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 16:08:09 snowball2 kernel: [13507.251325] sd 7:0:0:0: [sdb] Write Protect is off Nov 14 16:08:09 snowball2 kernel: [13507.251481] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 16:08:09 snowball2 kernel: [13507.252113] sd 7:0:0:0: [sdb] No Caching mode page present Nov 14 16:08:09 snowball2 kernel: [13507.252121] sd 7:0:0:0: [sdb] Assuming drive cache: write through Nov 14 16:08:09 snowball2 kernel: [13507.253533] xhci_hcd 0000:02:00.0: WARN: Stalled endpoint Nov 14 16:08:29 snowball2 kernel: [13526.717872] usb 4-1: USB disconnect, device number 4 Nov 14 16:08:44 snowball2 kernel: [13542.299576] xhci_hcd 0000:02:00.0: xHCI host not responding to stop endpoint command. Nov 14 16:08:44 snowball2 kernel: [13542.299586] xhci_hcd 0000:02:00.0: Assuming host is dying, halting host. Nov 14 16:08:44 snowball2 kernel: [13542.307983] xhci_hcd 0000:02:00.0: HC died; cleaning up Nov 14 16:08:44 snowball2 kernel: [13542.308044] sd 7:0:0:0: Device offlined - not ready after error recovery Nov 14 16:08:44 snowball2 kernel: [13542.310694] sd 7:0:0:0: [sdb] Asking for cache data failed Nov 14 16:08:44 snowball2 kernel: [13542.310703] sd 7:0:0:0: [sdb] Assuming drive cache: write through Nov 14 16:08:44 snowball2 kernel: [13542.310861] Dev sdb: unable to read RDB block 0 Nov 14 16:08:44 snowball2 kernel: [13542.310904] sdb: unable to read partition table Nov 14 16:08:44 snowball2 kernel: [13542.311365] sd 7:0:0:0: [sdb] READ CAPACITY failed Nov 14 16:08:44 snowball2 kernel: [13542.311373] sd 7:0:0:0: [sdb] Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK Nov 14 16:08:44 snowball2 kernel: [13542.311381] sd 7:0:0:0: [sdb] Sense not available. Nov 14 16:08:44 snowball2 kernel: [13542.311462] sd 7:0:0:0: [sdb] Asking for cache data failed Nov 14 16:08:44 snowball2 kernel: [13542.311470] sd 7:0:0:0: [sdb] Assuming drive cache: write through Nov 14 16:08:44 snowball2 kernel: [13542.311476] sd 7:0:0:0: [sdb] Attached SCSI disk Nov 14 16:08:44 snowball2 kernel: [13542.311941] scsi: killing requests for dead queue Nov 14 16:08:44 snowball2 kernel: [13542.312681] hub 4-0:1.0: hub_port_status failed (err = -19) Nov 14 16:08:44 snowball2 kernel: [13542.312689] hub 4-0:1.0: connect-debounce failed, port 1 disabled Nov 14 16:08:44 snowball2 kernel: [13542.312697] hub 4-0:1.0: hub_port_status failed (err = -19) Nov 14 16:08:51 snowball2 kernel: [13548.987375] usb 2-1.2: new full speed USB device number 5 using ehci_hcd Nov 14 16:08:51 snowball2 kernel: [13549.050314] usb 2-1.2: device descriptor read/64, error -32 Nov 14 16:08:51 snowball2 kernel: [13549.224115] usb 2-1.2: device descriptor read/64, error -32 Nov 14 16:08:51 snowball2 kernel: [13549.397891] usb 2-1.2: new full speed USB device number 6 using ehci_hcd Nov 14 16:08:51 snowball2 kernel: [13549.461034] usb 2-1.2: device descriptor read/64, error -32 Nov 14 16:08:51 snowball2 kernel: [13549.572942] hub 2-1:1.0: unable to enumerate USB device on port 2 Nov 14 16:08:53 snowball2 kernel: [13551.544687] usb 2-1.2: new high speed USB device number 7 using ehci_hcd Nov 14 16:08:54 snowball2 kernel: [13551.943114] usb 2-1.2: New USB device found, idVendor=059f, idProduct=103e Nov 14 16:08:54 snowball2 kernel: [13551.943124] usb 2-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Nov 14 16:08:54 snowball2 kernel: [13551.943131] usb 2-1.2: Product: Rugged USB 3 Nov 14 16:08:54 snowball2 kernel: [13551.943136] usb 2-1.2: Manufacturer: LaCie Nov 14 16:08:54 snowball2 kernel: [13551.943140] usb 2-1.2: SerialNumber: ce0238914a4c0000000 Nov 14 16:08:54 snowball2 kernel: [13551.944630] scsi8 : usb-storage 2-1.2:1.0 Nov 14 16:08:54 snowball2 mtp-probe: checking bus 2, device 7: "/sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.2" Nov 14 16:08:54 snowball2 mtp-probe: bus: 2, device: 7 was not an MTP device Nov 14 16:08:55 snowball2 kernel: [13552.945355] scsi 8:0:0:0: Direct-Access ST950032 5AS 0002 PQ: 0 ANSI: 0 Nov 14 16:08:55 snowball2 kernel: [13552.945531] scsi: killing requests for dead queue Nov 14 16:08:55 snowball2 kernel: [13552.945680] scsi: killing requests for dead queue Nov 14 16:08:55 snowball2 kernel: [13552.945870] scsi: killing requests for dead queue Nov 14 16:08:55 snowball2 kernel: [13552.946032] scsi: killing requests for dead queue Nov 14 16:08:55 snowball2 kernel: [13552.946184] scsi: killing requests for dead queue Nov 14 16:08:55 snowball2 kernel: [13552.946336] scsi: killing requests for dead queue Nov 14 16:08:55 snowball2 kernel: [13552.946483] scsi: killing requests for dead queue Nov 14 16:08:55 snowball2 kernel: [13552.946630] scsi: killing requests for dead queue Nov 14 16:08:55 snowball2 kernel: [13552.947797] sd 8:0:0:0: Attached scsi generic sg2 type 0 Nov 14 16:08:55 snowball2 kernel: [13552.947870] sd 8:0:0:0: [sdb] 976773168 512-byte logical blocks: (500 GB/465 GiB) Nov 14 16:08:55 snowball2 kernel: [13552.948709] sd 8:0:0:0: [sdb] Write Protect is off Nov 14 16:08:55 snowball2 kernel: [13552.951215] sd 8:0:0:0: [sdb] No Caching mode page present Nov 14 16:08:55 snowball2 kernel: [13552.951224] sd 8:0:0:0: [sdb] Assuming drive cache: write through Nov 14 16:08:55 snowball2 kernel: [13552.954078] sd 8:0:0:0: [sdb] No Caching mode page present Nov 14 16:08:55 snowball2 kernel: [13552.954090] sd 8:0:0:0: [sdb] Assuming drive cache: write through Nov 14 16:08:55 snowball2 kernel: [13553.021157] sdb: sdb1 sdb2 Nov 14 16:08:55 snowball2 kernel: [13553.024734] sd 8:0:0:0: [sdb] No Caching mode page present Nov 14 16:08:55 snowball2 kernel: [13553.024744] sd 8:0:0:0: [sdb] Assuming drive cache: write through Nov 14 16:08:55 snowball2 kernel: [13553.024760] sd 8:0:0:0: [sdb] Attached SCSI disk Nov 14 16:08:56 snowball2 ntfs-3g[32756]: Version 2011.4.12 integrated FUSE 27 Nov 14 16:08:56 snowball2 ntfs-3g[32756]: Mounted /dev/sdb1 (Read-Write, label "lacie", NTFS 3.1) Nov 14 16:08:56 snowball2 ntfs-3g[32756]: Cmdline options: rw,nosuid,nodev,uhelper=udisks,uid=500,gid=500,dmask=0077,fmask=0177 Nov 14 16:08:56 snowball2 ntfs-3g[32756]: Mount options: rw,nosuid,nodev,uhelper=udisks,allow_other,nonempty,atime,fsname=/dev/sdb1,blkdev,blksize=512,default_permissions Nov 14 16:08:56 snowball2 ntfs-3g[32756]: Global ownership and permissions enforced, configuration type 1 Nov 14 16:09:03 snowball2 ntfs-3g[32756]: Unmounting /dev/sdb1 (lacie) Nov 14 16:09:07 snowball2 kernel: [13565.176668] usb 2-1.2: USB disconnect, device number 7 Nov 14 16:09:07 snowball2 kernel: [13565.178467] scsi: killing requests for dead queue >>> >>>>> - plug the drive again >>>>> - everything works fine again for about an hour >>>>> - BOOM >>>>> by boom, I mean the following: >>>>> >>>>> >>>>> Nov 11 20:25:36 snowball2 kernel: [ 9244.406224] xhci_hcd 0000:02:00.0: >>>>> WARN: Stalled endpoint >>>>> Nov 11 20:25:36 snowball2 kernel: [ 9244.406818] sd 7:0:0:0: [sdc] >>>>> Sense >>>>> Key : Recovered Error [current] [descriptor] >>>>> Nov 11 20:25:36 snowball2 kernel: [ 9244.406822] Descriptor sense data >>>>> with sense descriptors (in hex): >>>>> Nov 11 20:25:36 snowball2 kernel: [ 9244.406824] 72 01 04 1d 00 >>>>> 00 00 0e 09 0c 00 00 00 00 00 fd >>>>> Nov 11 20:25:36 snowball2 kernel: [ 9244.406829] 00 49 00 6a >>>>> 40 50 >>>>> Nov 11 20:25:36 snowball2 kernel: [ 9244.406832] sd 7:0:0:0: [sdc] >>>>> ASC=0x4 ASCQ=0x1d >>>>> Nov 11 20:25:36 snowball2 kernel: [ 9244.407175] xhci_hcd 0000:02:00.0: >>>>> WARN: Stalled endpoint >>>>> Nov 11 20:25:37 snowball2 kernel: [ 9244.759971] xhci_hcd 0000:02:00.0: >>>>> WARN: Stalled endpoint >>>>> Nov 11 20:25:49 snowball2 kernel: [ 9256.969686] xhci_hcd 0000:02:00.0: >>>>> xHCI host not responding to stop endpoint command. >>>>> Nov 11 20:25:49 snowball2 kernel: [ 9256.969696] xhci_hcd 0000:02:00.0: >>>>> Assuming host is dying, halting host. >>>>> Nov 11 20:25:49 snowball2 kernel: [ 9256.978610] xhci_hcd 0000:02:00.0: >>>>> HC died; cleaning up >>>>> Nov 11 20:25:49 snowball2 kernel: [ 9256.978687] usb 4-2: USB >>>>> disconnect, device number 2 >>>>> Nov 11 20:25:49 snowball2 kernel: [ 9256.978810] sd 7:0:0:0: Device >>>>> offlined - not ready after error recovery >>>>> Nov 11 20:25:49 snowball2 ntfs-3g[17800]: Unmounting /dev/sdc1 (lacie) >>>>> Nov 11 20:25:49 snowball2 ntfs-3g[17800]: Failed to sync device >>>>> /dev/sdc1: Input/output error >>>>> Nov 11 20:25:49 snowball2 ntfs-3g[17800]: Failed to fsync device >>>>> /dev/sdc1: Input/output error >>>>> Nov 11 20:25:49 snowball2 ntfs-3g[17800]: Failed to close volume >>>>> /dev/sdc1: Device or resource busy >>>>> >>>>> As a side question, are these recovered errors something to be >>>>> concerned >>>>> about? The drive is encrypted with truecrypt and they have been showing >>>>> since the day I bought it. >>>>> >>>>> Julian >>>>> >>>>> -- >>>>> To unsubscribe from this list: send the line "unsubscribe linux-usb" in >>>>> the body of a message to >>>>> majordomo-u79uwXL29TY76Z2rM5mHXA-XMD5yJDbdMReXY1tMh2IBg@xxxxxxxxxxxxxxxx >>>>> More majordomo info at http://vger.kernel.org/majordomo-info.html >>>>> >>>> One more thing: if you attempt to suspend after this happens, the >>>> machine will lock up. In Fedora 15 it would just go back to gnome-shell. >>>> Finally, I believe I never posted lspci output, here it is: >>>> >>> >>> The host driver is dead and unable to perform any suspend requests. >>> Does this issue occur with other USB3.0 devices? >>> >>> Thanks, >>> Andiry >> >> I only have this one Lacie hard drive so I am afraid I cannot answer >> this question. >> >> Julian >> >>> >>>> 02:00.0 USB Controller: NEC Corporation uPD720200 USB 3.0 Host >>>> Controller (rev 03) (prog-if 30 [XHCI]) >>>> Subsystem: CLEVO/KAPOK Computer Device 5102 >>>> Flags: bus master, fast devsel, latency 0, IRQ 16 >>>> Memory at f6400000 (64-bit, non-prefetchable) [size=8K] >>>> Capabilities: [50] Power Management version 3 >>>> Capabilities: [70] MSI: Enable- Count=1/8 Maskable- 64bit+ >>>> Capabilities: [90] MSI-X: Enable+ Count=8 Masked- >>>> Capabilities: [a0] Express Endpoint, MSI 00 >>>> Capabilities: [100] Advanced Error Reporting >>>> Capabilities: [140] Device Serial Number ff-ff-ff-ff-ff-ff-ff-ff >>>> Capabilities: [150] #18 >>>> Kernel driver in use: xhci_hcd >>>> >>> >>> >>> >>> >> >> -- >> To unsubscribe from this list: send the line "unsubscribe linux-usb" in >> the body of a message to majordomo-u79uwXL29TY76Z2rM5mHXA-XMD5yJDbdMStu3cLTcvVIw@xxxxxxxxxxxxxxxxxxxxx >> More majordomo info at http://vger.kernel.org/majordomo-info.html >> > > > -- > To unsubscribe from this list: send the line "unsubscribe linux-usb" in > the body of a message to majordomo-u79uwXL29TY76Z2rM5mHXA@xxxxxxxxxxxxxxxx > More majordomo info at http://vger.kernel.org/majordomo-info.html > -- To unsubscribe from this list: send the line "unsubscribe linux-usb" in the body of a message to majordomo@xxxxxxxxxxxxxxx More majordomo info at http://vger.kernel.org/majordomo-info.html
