Le Fri, Aug 28, 2015 at 05:42:04PM +0200, maderios a écrit : > > Quelques pistes pour déboguer l'usb mais il y a certainement d'autres moyens > (après la déconnexion de l'usb du clavier) > dmesg > cat /sys/kernel/debug/usb/devices > cat /var/log/debug/ > cat /var/log/syslog
Voici en pièce jointe la différence pour chaque fichier entre avant et après la veille. On y retrouve le message d'erreur de atkbd, mais rien d'autre ne me saute aux yeux... Bonne fin de semaine, -- Charles
--- debug.avant 2015-08-29 07:17:09.562595231 +0900 +++ debug.apres 2015-08-29 07:18:09.130028950 +0900 @@ -3885,3 +3885,29 @@ Aug 29 07:10:33 bubu rtkit-daemon[948]: Supervising 7 threads of 2 processes of 2 users. Aug 29 07:10:33 bubu rtkit-daemon[948]: Supervising 7 threads of 2 processes of 2 users. Aug 29 07:10:33 bubu rtkit-daemon[948]: Supervising 8 threads of 2 processes of 2 users. +Aug 29 07:17:36 bubu kernel: [ 426.402965] PM: Preparing system for mem sleep +Aug 29 07:17:36 bubu kernel: [ 426.406152] PM: Entering mem sleep +Aug 29 07:17:36 bubu kernel: [ 427.760572] PM: Finishing wakeup. +Aug 29 07:17:36 bubu kernel: [ 427.764854] pci_bus 0000:01: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.764868] pci_bus 0000:02: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765023] pcieport 0000:00:1c.2: bridge window [io 0x1000-0x0fff] to [bus 02] add_size 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765026] pcieport 0000:00:1c.2: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 02] add_size 200000 add_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765033] pci_bus 0000:03: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765138] pci_bus 0000:08: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765152] pci_bus 0000:09: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765224] pcieport 0000:00:1c.5: bridge window [io 0x1000-0x0fff] to [bus 09] add_size 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765227] pcieport 0000:00:1c.5: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 09] add_size 200000 add_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765238] pcieport 0000:00:1c.2: res[15]=[mem 0x00100000-0x000fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765241] pcieport 0000:00:1c.2: res[15]=[mem 0x00100000-0x002fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765243] pcieport 0000:00:1c.5: res[15]=[mem 0x00100000-0x000fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765246] pcieport 0000:00:1c.5: res[15]=[mem 0x00100000-0x002fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765249] pcieport 0000:00:1c.2: res[13]=[io 0x1000-0x0fff] res_to_dev_res add_size 1000 min_align 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765251] pcieport 0000:00:1c.2: res[13]=[io 0x1000-0x1fff] res_to_dev_res add_size 1000 min_align 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765254] pcieport 0000:00:1c.5: res[13]=[io 0x1000-0x0fff] res_to_dev_res add_size 1000 min_align 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765256] pcieport 0000:00:1c.5: res[13]=[io 0x1000-0x1fff] res_to_dev_res add_size 1000 min_align 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765574] pci_bus 0000:01: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765586] pci_bus 0000:02: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765743] pci_bus 0000:03: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765761] pci_bus 0000:08: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765775] pci_bus 0000:09: Allocating resources +Aug 29 07:17:41 bubu kernel: [ 432.459479] wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 10:9a:dd:85:6f:76 --- dmesg.avant 2015-08-29 07:15:48.160331773 +0900 +++ dmesg.apres 2015-08-29 07:17:47.413760304 +0900 @@ -802,3 +802,181 @@ [ 7.046720] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) [ 7.046721] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) [ 7.046722] cfg80211: (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2300 mBm), (0 s) +[ 425.673784] i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment +[ 425.776110] wlan0: deauthenticating from 10:9a:dd:85:6f:75 by local choice (Reason: 3=DEAUTH_LEAVING) +[ 425.797983] cfg80211: Calling CRDA to update world regulatory domain +[ 425.803170] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready +[ 425.818646] cfg80211: World regulatory domain updated: +[ 425.818650] cfg80211: DFS Master region: unset +[ 425.818652] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) +[ 425.818654] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) +[ 425.818657] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) +[ 425.818659] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) +[ 425.818661] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) +[ 425.818664] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) +[ 425.818666] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) +[ 425.818668] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) +[ 425.818670] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) +[ 426.393478] PM: Syncing filesystems ... done. +[ 426.402965] PM: Preparing system for mem sleep +[ 426.403350] (NULL device *): firmware: direct-loading firmware iwlwifi-7265D-10.ucode +[ 426.403378] (NULL device *): firmware: direct-loading firmware intel/ibt-hw-37.8.10-fw-1.10.3.11.e.bseq +[ 426.403385] Freezing user space processes ... (elapsed 0.001 seconds) done. +[ 426.405062] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. +[ 426.406152] PM: Entering mem sleep +[ 426.406166] Suspending console(s) (use no_console_suspend to debug) +[ 426.406561] sd 0:0:0:0: [sda] Synchronizing SCSI cache +[ 426.410592] sd 0:0:0:0: [sda] Stopping disk +[ 426.545965] PM: suspend of devices complete after 139.541 msecs +[ 426.551489] ------------[ cut here ]------------ +[ 426.551511] WARNING: CPU: 0 PID: 1952 at /home/zumbi/linux-4.1.3/debian/build/source_rt/drivers/gpu/drm/i915/intel_display.c:8263 hsw_enable_pc8+0x639/0x7a0 [i915]() +[ 426.551512] SPLL enabled +[ 426.551527] Modules linked in: bnep joydev nfsd auth_rpcgss oid_registry nfs_acl btusb btbcm btintel nfs bluetooth lockd grace fscache sunrpc uvcvideo videobuf2_vmalloc videobuf2_memops videobuf2_core v4l2_common videodev media iTCO_wdt iTCO_vendor_support snd_hda_codec_hdmi nls_utf8 nls_cp437 vfat fat intel_powerclamp intel_rapl iosf_mbi coretemp tpm_infineon kvm_intel kvm arc4 crct10dif_pclmul crc32_pclmul ghash_clmulni_intel aesni_intel aes_x86_64 lrw gf128mul glue_helper efi_pstore ablk_helper cryptd evdev snd_hda_codec_realtek snd_hda_codec_generic iwlmvm psmouse serio_raw pcspkr efivars mac80211 rtsx_pci_ms iwlwifi memstick snd_hda_intel i915 cfg80211 snd_hda_controller drm_kms_helper snd_hda_codec rfkill lpc_ich mei_me i2c_i801 snd_hda_core drm snd_hwdep mei shpchp i2c_algo_bit snd_soc_rt5640 +[ 426.551542] snd_soc_rl6231 snd_soc_core snd_compress snd_pcm snd_timer snd dw_dmac video soundcore dw_dmac_core regmap_i2c snd_soc_sst_acpi i2c_designware_platform i2c_designware_core battery tpm_tis tpm acpi_pad ac wmi button processor fuse parport_pc ppdev lp parport autofs4 ext4 crc16 mbcache jbd2 sg sd_mod rtsx_pci_sdmmc crc32c_intel ahci libahci libata ehci_pci scsi_mod xhci_pci rtsx_pci r8169 ehci_hcd mfd_core mii xhci_hcd usbcore thermal usb_common thermal_sys sdhci_acpi sdhci mmc_core i2c_hid hid +[ 426.551545] CPU: 0 PID: 1952 Comm: kworker/u16:4 Not tainted 4.1.0-0.bpo.1-rt-amd64 #1 Debian 4.1.3-1~bpo8+1 +[ 426.551545] Hardware name: VAIO Corporation VJP132/VAIO, BIOS R0220MA 05/06/2015 +[ 426.551550] Workqueue: events_unbound async_run_entry_fn +[ 426.551551] 0000000000000000 ffffffffa0661e08 ffffffff81594654 ffff8800a64afc88 +[ 426.551552] ffffffff81077101 ffff880036850000 ffff8802432c1ca8 ffff8802432c1cb8 +[ 426.551553] ffff8802432c1800 0000000000000002 ffffffff8107719a ffffffffa066f4fe +[ 426.551554] Call Trace: +[ 426.551559] [<ffffffff81594654>] ? dump_stack+0x4a/0x89 +[ 426.551561] [<ffffffff81077101>] ? warn_slowpath_common+0x81/0xd0 +[ 426.551562] [<ffffffff8107719a>] ? warn_slowpath_fmt+0x4a/0x50 +[ 426.551573] [<ffffffffa0609d89>] ? hsw_enable_pc8+0x639/0x7a0 [i915] +[ 426.551579] [<ffffffffa0599e78>] ? intel_suspend_complete+0xe8/0x6d0 [i915] +[ 426.551584] [<ffffffffa059a481>] ? i915_drm_suspend_late+0x21/0x90 [i915] +[ 426.551589] [<ffffffffa059a610>] ? i915_pm_poweroff_late+0x40/0x40 [i915] +[ 426.551590] [<ffffffff81422a9a>] ? dpm_run_callback+0x4a/0x180 +[ 426.551591] [<ffffffff81423370>] ? __device_suspend_late+0xa0/0x180 +[ 426.551592] [<ffffffff8142346e>] ? async_suspend_late+0x1e/0xa0 +[ 426.551594] [<ffffffff810997b3>] ? async_run_entry_fn+0x43/0x150 +[ 426.551596] [<ffffffff810911c6>] ? process_one_work+0x146/0x480 +[ 426.551597] [<ffffffff8109187b>] ? worker_thread+0x6b/0x500 +[ 426.551599] [<ffffffff81091810>] ? rescuer_thread+0x310/0x310 +[ 426.551600] [<ffffffff81096d95>] ? kthread+0xc5/0xe0 +[ 426.551602] [<ffffffff81096cd0>] ? kthread_worker_fn+0x1a0/0x1a0 +[ 426.551604] [<ffffffff81599d32>] ? ret_from_fork+0x42/0x70 +[ 426.551606] [<ffffffff81096cd0>] ? kthread_worker_fn+0x1a0/0x1a0 +[ 426.551607] ---[ end trace 0000000000000002 ]--- +[ 426.565586] PM: late suspend of devices complete after 19.601 msecs +[ 426.568184] r8169 0000:08:00.0: System wakeup enabled by ACPI +[ 426.568298] ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI +[ 426.568435] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI +[ 426.581736] PM: noirq suspend of devices complete after 16.133 msecs +[ 426.582067] ACPI: Preparing to enter system sleep state S3 +[ 426.621677] ACPI : EC: EC stopped +[ 426.621678] PM: Saving platform NVS memory +[ 426.621683] Disabling non-boot CPUs ... +[ 426.621740] intel_pstate CPU 1 exiting +[ 426.622929] kvm: disabling virtualization on CPU1 +[ 426.622934] smpboot: CPU 1 is now offline +[ 426.627235] intel_pstate CPU 2 exiting +[ 426.627390] Broke affinity for irq 44 +[ 426.628402] kvm: disabling virtualization on CPU2 +[ 426.628407] smpboot: CPU 2 is now offline +[ 426.629054] intel_pstate CPU 3 exiting +[ 426.629160] Broke affinity for irq 23 +[ 426.629166] Broke affinity for irq 45 +[ 426.630169] kvm: disabling virtualization on CPU3 +[ 426.630183] smpboot: CPU 3 is now offline +[ 426.631748] ACPI: Low-level resume complete +[ 426.631805] ACPI : EC: EC started +[ 426.631805] PM: Restoring platform NVS memory +[ 426.632181] Enabling non-boot CPUs ... +[ 426.632212] x86: Booting SMP configuration: +[ 426.632213] smpboot: Booting Node 0 Processor 1 APIC 0x1 +[ 426.644368] kvm: enabling virtualization on CPU1 +[ 426.646490] cache: parent cpu1 should not be sleeping +[ 426.646608] CPU1 is up +[ 426.646628] smpboot: Booting Node 0 Processor 2 APIC 0x2 +[ 426.658644] kvm: enabling virtualization on CPU2 +[ 426.660780] cache: parent cpu2 should not be sleeping +[ 426.660883] CPU2 is up +[ 426.660902] smpboot: Booting Node 0 Processor 3 APIC 0x3 +[ 426.672933] kvm: enabling virtualization on CPU3 +[ 426.675076] cache: parent cpu3 should not be sleeping +[ 426.675175] CPU3 is up +[ 426.678433] ACPI: Waking up from system sleep state S3 +[ 426.740106] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI +[ 426.758471] ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI +[ 426.758942] PM: noirq resume of devices complete after 19.006 msecs +[ 426.765226] PM: early resume of devices complete after 6.254 msecs +[ 426.765321] usb usb1: root hub lost power or was reset +[ 426.765324] usb usb2: root hub lost power or was reset +[ 426.765903] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. +[ 426.766256] r8169 0000:08:00.0: System wakeup disabled by ACPI +[ 426.779425] sd 0:0:0:0: [sda] Starting disk +[ 426.783567] rtc_cmos 00:01: System wakeup disabled by ACPI +[ 426.806076] r8169 0000:08:00.0 eth0: link down +[ 426.991584] usb 3-1: reset high-speed USB device number 2 using ehci-pci +[ 427.103803] usb 1-6: reset full-speed USB device number 3 using xhci_hcd +[ 427.107661] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) +[ 427.109418] ata1.00: configured for UDMA/133 +[ 427.344425] usb 1-6: No LPM exit latency info found, disabling LPM. +[ 427.456034] usb 1-5: reset high-speed USB device number 2 using xhci_hcd +[ 427.711577] PM: resume of devices complete after 945.583 msecs +[ 427.725986] Bluetooth: hci0: read Intel version: 370810011003110e00 +[ 427.725991] Bluetooth: hci0: Intel Bluetooth firmware file: intel/ibt-hw-37.8.10-fw-1.10.3.11.e.bseq +[ 427.760572] PM: Finishing wakeup. +[ 427.760574] Restarting tasks ... done. +[ 427.764625] atkbd serio0: Spurious ACK on isa0060/serio0. Some program might be trying to access hardware directly. +[ 427.764854] pci_bus 0000:01: Allocating resources +[ 427.764868] pci_bus 0000:02: Allocating resources +[ 427.765023] pcieport 0000:00:1c.2: bridge window [io 0x1000-0x0fff] to [bus 02] add_size 1000 +[ 427.765026] pcieport 0000:00:1c.2: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 02] add_size 200000 add_align 100000 +[ 427.765033] pci_bus 0000:03: Allocating resources +[ 427.765138] pci_bus 0000:08: Allocating resources +[ 427.765152] pci_bus 0000:09: Allocating resources +[ 427.765224] pcieport 0000:00:1c.5: bridge window [io 0x1000-0x0fff] to [bus 09] add_size 1000 +[ 427.765227] pcieport 0000:00:1c.5: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 09] add_size 200000 add_align 100000 +[ 427.765232] i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment +[ 427.765238] pcieport 0000:00:1c.2: res[15]=[mem 0x00100000-0x000fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +[ 427.765241] pcieport 0000:00:1c.2: res[15]=[mem 0x00100000-0x002fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +[ 427.765243] pcieport 0000:00:1c.5: res[15]=[mem 0x00100000-0x000fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +[ 427.765246] pcieport 0000:00:1c.5: res[15]=[mem 0x00100000-0x002fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +[ 427.765249] pcieport 0000:00:1c.2: res[13]=[io 0x1000-0x0fff] res_to_dev_res add_size 1000 min_align 1000 +[ 427.765251] pcieport 0000:00:1c.2: res[13]=[io 0x1000-0x1fff] res_to_dev_res add_size 1000 min_align 1000 +[ 427.765254] pcieport 0000:00:1c.5: res[13]=[io 0x1000-0x0fff] res_to_dev_res add_size 1000 min_align 1000 +[ 427.765256] pcieport 0000:00:1c.5: res[13]=[io 0x1000-0x1fff] res_to_dev_res add_size 1000 min_align 1000 +[ 427.765270] pcieport 0000:00:1c.2: BAR 15: assigned [mem 0xb0500000-0xb06fffff 64bit pref] +[ 427.765279] pcieport 0000:00:1c.5: BAR 15: assigned [mem 0xb0700000-0xb08fffff 64bit pref] +[ 427.765283] pcieport 0000:00:1c.2: BAR 13: assigned [io 0x6000-0x6fff] +[ 427.765286] pcieport 0000:00:1c.5: BAR 13: assigned [io 0x7000-0x7fff] +[ 427.765574] pci_bus 0000:01: Allocating resources +[ 427.765586] pci_bus 0000:02: Allocating resources +[ 427.765743] pci_bus 0000:03: Allocating resources +[ 427.765761] pci_bus 0000:08: Allocating resources +[ 427.765775] pci_bus 0000:09: Allocating resources +[ 427.765785] i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment +[ 427.766460] atkbd serio0: Spurious ACK on isa0060/serio0. Some program might be trying to access hardware directly. +[ 427.821997] Bluetooth: hci0: Intel Bluetooth firmware patch completed and activated +[ 428.333006] ACPI Error: Needed [Integer/String/Buffer], found [Reference] ffff880240beeca8 (20150410/exresop-502) +[ 428.333014] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20150410/dswexec-461) +[ 428.333021] ACPI Error: Method parse/execution failed [\_SB_.BAT1._BTP] (Node ffff880245cc1be0), AE_AML_OPERAND_TYPE (20150410/psparse-536) +[ 428.413593] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready +[ 428.455243] r8169 0000:08:00.0 eth0: link down +[ 428.456472] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled +[ 428.457236] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled +[ 428.518238] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled +[ 428.518682] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled +[ 428.629337] psmouse serio2: synaptics: queried max coordinates: x [..5746], y [..4934] +[ 428.658920] psmouse serio2: synaptics: queried min coordinates: x [1258..], y [1134..] +[ 432.374400] wlan0: authenticate with 10:9a:dd:85:6f:76 +[ 432.380854] wlan0: send auth to 10:9a:dd:85:6f:76 (try 1/3) +[ 432.381453] wlan0: authenticated +[ 432.383864] wlan0: associate with 10:9a:dd:85:6f:76 (try 1/3) +[ 432.385601] wlan0: RX AssocResp from 10:9a:dd:85:6f:76 (capab=0x501 status=0 aid=3) +[ 432.386815] wlan0: associated +[ 432.386962] cfg80211: Calling CRDA for country: JP +[ 432.389475] cfg80211: Regulatory domain changed to country: JP +[ 432.389479] cfg80211: DFS Master region: JP +[ 432.389481] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) +[ 432.389484] cfg80211: (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) +[ 432.389486] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) +[ 432.389487] cfg80211: (4910000 KHz - 4990000 KHz @ 40000 KHz), (N/A, 2300 mBm), (N/A) +[ 432.389489] cfg80211: (5030000 KHz - 5090000 KHz @ 40000 KHz), (N/A, 2300 mBm), (N/A) +[ 432.389491] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) +[ 432.389494] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) +[ 432.389496] cfg80211: (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2300 mBm), (0 s) +[ 432.459479] wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 10:9a:dd:85:6f:76 --- syslog.avant 2015-08-29 07:17:20.010487799 +0900 +++ syslog.apres 2015-08-29 07:18:14.678127539 +0900 @@ -39705,3 +39705,325 @@ Aug 29 07:16:21 bubu org.gnome.Terminal[1159]: (gnome-terminal-server:1781): GLib-GIO-WARNING **: Using untranslated default instead. Aug 29 07:16:32 bubu dleyna-server-service[1878]: dLeyna: Exit Aug 29 07:17:01 bubu CRON[1916]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) +Aug 29 07:17:29 bubu NetworkManager[531]: <info> sleep requested (sleeping: no enabled: yes) +Aug 29 07:17:29 bubu NetworkManager[531]: <info> sleeping... +Aug 29 07:17:29 bubu NetworkManager[531]: <info> (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37] +Aug 29 07:17:29 bubu NetworkManager[531]: <info> (wlan0): deactivating device (reason 'sleeping') [37] +Aug 29 07:17:29 bubu kernel: [ 425.673784] i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment +Aug 29 07:17:29 bubu NetworkManager[531]: <info> (wlan0): canceled DHCP transaction, DHCP client pid 1001 +Aug 29 07:17:29 bubu avahi-daemon[549]: Withdrawing address record for fe80::5ee0:c5ff:fed1:e6d8 on wlan0. +Aug 29 07:17:29 bubu avahi-daemon[549]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::5ee0:c5ff:fed1:e6d8. +Aug 29 07:17:29 bubu kernel: [ 425.776110] wlan0: deauthenticating from 10:9a:dd:85:6f:75 by local choice (Reason: 3=DEAUTH_LEAVING) +Aug 29 07:17:29 bubu wpa_supplicant[858]: wlan0: CTRL-EVENT-DISCONNECTED bssid=10:9a:dd:85:6f:75 reason=3 locally_generated=1 +Aug 29 07:17:29 bubu avahi-daemon[549]: Interface wlan0.IPv6 no longer relevant for mDNS. +Aug 29 07:17:29 bubu NetworkManager[531]: _nl_get_vtable: assertion 'vtable.handle' failed +Aug 29 07:17:29 bubu NetworkManager[531]: <info> NetworkManager state is now ASLEEP +Aug 29 07:17:29 bubu avahi-daemon[549]: Withdrawing address record for 192.168.0.53 on wlan0. +Aug 29 07:17:29 bubu avahi-daemon[549]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.53. +Aug 29 07:17:29 bubu kernel: [ 425.797983] cfg80211: Calling CRDA to update world regulatory domain +Aug 29 07:17:29 bubu avahi-daemon[549]: Interface wlan0.IPv4 no longer relevant for mDNS. +Aug 29 07:17:29 bubu kernel: [ 425.803170] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready +Aug 29 07:17:29 bubu dbus[551]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' +Aug 29 07:17:29 bubu kernel: [ 425.818646] cfg80211: World regulatory domain updated: +Aug 29 07:17:29 bubu kernel: [ 425.818650] cfg80211: DFS Master region: unset +Aug 29 07:17:29 bubu kernel: [ 425.818652] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) +Aug 29 07:17:29 bubu kernel: [ 425.818654] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:17:29 bubu kernel: [ 425.818657] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:17:29 bubu kernel: [ 425.818659] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:17:29 bubu kernel: [ 425.818661] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) +Aug 29 07:17:29 bubu kernel: [ 425.818664] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) +Aug 29 07:17:29 bubu kernel: [ 425.818666] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) +Aug 29 07:17:29 bubu kernel: [ 425.818668] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:17:29 bubu kernel: [ 425.818670] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) +Aug 29 07:17:29 bubu dbus[551]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' +Aug 29 07:17:29 bubu nm-dispatcher: Dispatching action 'down' for wlan0 +Aug 29 07:17:30 bubu systemd-sleep[1949]: Suspending system... +Aug 29 07:17:36 bubu kernel: [ 426.393478] PM: Syncing filesystems ... done. +Aug 29 07:17:36 bubu kernel: [ 426.402965] PM: Preparing system for mem sleep +Aug 29 07:17:36 bubu kernel: [ 426.403350] (NULL device *): firmware: direct-loading firmware iwlwifi-7265D-10.ucode +Aug 29 07:17:36 bubu kernel: [ 426.403378] (NULL device *): firmware: direct-loading firmware intel/ibt-hw-37.8.10-fw-1.10.3.11.e.bseq +Aug 29 07:17:36 bubu kernel: [ 426.403385] Freezing user space processes ... (elapsed 0.001 seconds) done. +Aug 29 07:17:36 bubu kernel: [ 426.405062] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. +Aug 29 07:17:36 bubu kernel: [ 426.406152] PM: Entering mem sleep +Aug 29 07:17:36 bubu kernel: [ 426.406166] Suspending console(s) (use no_console_suspend to debug) +Aug 29 07:17:36 bubu kernel: [ 426.406561] sd 0:0:0:0: [sda] Synchronizing SCSI cache +Aug 29 07:17:36 bubu kernel: [ 426.410592] sd 0:0:0:0: [sda] Stopping disk +Aug 29 07:17:36 bubu kernel: [ 426.545965] PM: suspend of devices complete after 139.541 msecs +Aug 29 07:17:36 bubu kernel: [ 426.551489] ------------[ cut here ]------------ +Aug 29 07:17:36 bubu kernel: [ 426.551511] WARNING: CPU: 0 PID: 1952 at /home/zumbi/linux-4.1.3/debian/build/source_rt/drivers/gpu/drm/i915/intel_display.c:8263 hsw_enable_pc8+0x639/0x7a0 [i915]() +Aug 29 07:17:36 bubu kernel: [ 426.551512] SPLL enabled +Aug 29 07:17:36 bubu kernel: [ 426.551527] Modules linked in: bnep joydev nfsd auth_rpcgss oid_registry nfs_acl btusb btbcm btintel nfs bluetooth lockd grace fscache sunrpc uvcvideo videobuf2_vmalloc videobuf2_memops videobuf2_core v4l2_common videodev media iTCO_wdt iTCO_vendor_support snd_hda_codec_hdmi nls_utf8 nls_cp437 vfat fat intel_powerclamp intel_rapl iosf_mbi coretemp tpm_infineon kvm_intel kvm arc4 crct10dif_pclmul crc32_pclmul ghash_clmulni_intel aesni_intel aes_x86_64 lrw gf128mul glue_helper efi_pstore ablk_helper cryptd evdev snd_hda_codec_realtek snd_hda_codec_generic iwlmvm psmouse serio_raw pcspkr efivars mac80211 rtsx_pci_ms iwlwifi memstick snd_hda_intel i915 cfg80211 snd_hda_controller drm_kms_helper snd_hda_codec rfkill lpc_ich mei_me i2c_i801 snd_hda_core drm snd_hwdep mei shpchp i2c_algo_bit snd_soc_rt5640 snd_soc_rl6231 snd_soc_core snd_compress snd_pcm snd_timer snd dw_dmac video soundcore dw_dmac_core regmap_i2c snd_soc_sst_acpi i2c_designware_platform i2c_designware_core battery tpm_tis tpm acpi_pad ac wmi button processor fuse parport_pc ppdev lp parport autofs4 ext4 crc16 mbcache jbd2 sg sd_mod rtsx_pci_sdmmc crc32c_intel ahci libahci libata ehci_pci scsi_mod xhci_pci rtsx_pci r8169 ehci_hcd mfd_core mii xhci_hcd usbcore thermal usb_common thermal_sys sdhci_acpi sdhci mmc_core i2c_hid hid +Aug 29 07:17:36 bubu kernel: [ 426.551545] CPU: 0 PID: 1952 Comm: kworker/u16:4 Not tainted 4.1.0-0.bpo.1-rt-amd64 #1 Debian 4.1.3-1~bpo8+1 +Aug 29 07:17:36 bubu kernel: [ 426.551545] Hardware name: VAIO Corporation VJP132/VAIO, BIOS R0220MA 05/06/2015 +Aug 29 07:17:36 bubu kernel: [ 426.551550] Workqueue: events_unbound async_run_entry_fn +Aug 29 07:17:36 bubu kernel: [ 426.551551] 0000000000000000 ffffffffa0661e08 ffffffff81594654 ffff8800a64afc88 +Aug 29 07:17:36 bubu kernel: [ 426.551552] ffffffff81077101 ffff880036850000 ffff8802432c1ca8 ffff8802432c1cb8 +Aug 29 07:17:36 bubu kernel: [ 426.551553] ffff8802432c1800 0000000000000002 ffffffff8107719a ffffffffa066f4fe +Aug 29 07:17:36 bubu kernel: [ 426.551554] Call Trace: +Aug 29 07:17:36 bubu kernel: [ 426.551559] [<ffffffff81594654>] ? dump_stack+0x4a/0x89 +Aug 29 07:17:36 bubu kernel: [ 426.551561] [<ffffffff81077101>] ? warn_slowpath_common+0x81/0xd0 +Aug 29 07:17:36 bubu kernel: [ 426.551562] [<ffffffff8107719a>] ? warn_slowpath_fmt+0x4a/0x50 +Aug 29 07:17:36 bubu kernel: [ 426.551573] [<ffffffffa0609d89>] ? hsw_enable_pc8+0x639/0x7a0 [i915] +Aug 29 07:17:36 bubu kernel: [ 426.551579] [<ffffffffa0599e78>] ? intel_suspend_complete+0xe8/0x6d0 [i915] +Aug 29 07:17:36 bubu kernel: [ 426.551584] [<ffffffffa059a481>] ? i915_drm_suspend_late+0x21/0x90 [i915] +Aug 29 07:17:36 bubu kernel: [ 426.551589] [<ffffffffa059a610>] ? i915_pm_poweroff_late+0x40/0x40 [i915] +Aug 29 07:17:36 bubu kernel: [ 426.551590] [<ffffffff81422a9a>] ? dpm_run_callback+0x4a/0x180 +Aug 29 07:17:36 bubu kernel: [ 426.551591] [<ffffffff81423370>] ? __device_suspend_late+0xa0/0x180 +Aug 29 07:17:36 bubu kernel: [ 426.551592] [<ffffffff8142346e>] ? async_suspend_late+0x1e/0xa0 +Aug 29 07:17:36 bubu kernel: [ 426.551594] [<ffffffff810997b3>] ? async_run_entry_fn+0x43/0x150 +Aug 29 07:17:36 bubu kernel: [ 426.551596] [<ffffffff810911c6>] ? process_one_work+0x146/0x480 +Aug 29 07:17:36 bubu kernel: [ 426.551597] [<ffffffff8109187b>] ? worker_thread+0x6b/0x500 +Aug 29 07:17:36 bubu kernel: [ 426.551599] [<ffffffff81091810>] ? rescuer_thread+0x310/0x310 +Aug 29 07:17:36 bubu kernel: [ 426.551600] [<ffffffff81096d95>] ? kthread+0xc5/0xe0 +Aug 29 07:17:36 bubu kernel: [ 426.551602] [<ffffffff81096cd0>] ? kthread_worker_fn+0x1a0/0x1a0 +Aug 29 07:17:36 bubu kernel: [ 426.551604] [<ffffffff81599d32>] ? ret_from_fork+0x42/0x70 +Aug 29 07:17:36 bubu kernel: [ 426.551606] [<ffffffff81096cd0>] ? kthread_worker_fn+0x1a0/0x1a0 +Aug 29 07:17:36 bubu kernel: [ 426.551607] ---[ end trace 0000000000000002 ]--- +Aug 29 07:17:36 bubu kernel: [ 426.565586] PM: late suspend of devices complete after 19.601 msecs +Aug 29 07:17:36 bubu kernel: [ 426.568184] r8169 0000:08:00.0: System wakeup enabled by ACPI +Aug 29 07:17:36 bubu kernel: [ 426.568298] ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI +Aug 29 07:17:36 bubu kernel: [ 426.568435] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI +Aug 29 07:17:36 bubu kernel: [ 426.581736] PM: noirq suspend of devices complete after 16.133 msecs +Aug 29 07:17:36 bubu kernel: [ 426.582067] ACPI: Preparing to enter system sleep state S3 +Aug 29 07:17:36 bubu kernel: [ 426.621677] ACPI : EC: EC stopped +Aug 29 07:17:36 bubu kernel: [ 426.621678] PM: Saving platform NVS memory +Aug 29 07:17:36 bubu kernel: [ 426.621683] Disabling non-boot CPUs ... +Aug 29 07:17:36 bubu kernel: [ 426.621740] intel_pstate CPU 1 exiting +Aug 29 07:17:36 bubu kernel: [ 426.622929] kvm: disabling virtualization on CPU1 +Aug 29 07:17:36 bubu kernel: [ 426.622934] smpboot: CPU 1 is now offline +Aug 29 07:17:36 bubu kernel: [ 426.627235] intel_pstate CPU 2 exiting +Aug 29 07:17:36 bubu kernel: [ 426.627390] Broke affinity for irq 44 +Aug 29 07:17:36 bubu kernel: [ 426.628402] kvm: disabling virtualization on CPU2 +Aug 29 07:17:36 bubu kernel: [ 426.628407] smpboot: CPU 2 is now offline +Aug 29 07:17:36 bubu kernel: [ 426.629054] intel_pstate CPU 3 exiting +Aug 29 07:17:36 bubu kernel: [ 426.629160] Broke affinity for irq 23 +Aug 29 07:17:36 bubu kernel: [ 426.629166] Broke affinity for irq 45 +Aug 29 07:17:36 bubu kernel: [ 426.630169] kvm: disabling virtualization on CPU3 +Aug 29 07:17:36 bubu kernel: [ 426.630183] smpboot: CPU 3 is now offline +Aug 29 07:17:36 bubu kernel: [ 426.631748] ACPI: Low-level resume complete +Aug 29 07:17:36 bubu kernel: [ 426.631805] ACPI : EC: EC started +Aug 29 07:17:36 bubu kernel: [ 426.631805] PM: Restoring platform NVS memory +Aug 29 07:17:36 bubu kernel: [ 426.632181] Enabling non-boot CPUs ... +Aug 29 07:17:36 bubu kernel: [ 426.632212] x86: Booting SMP configuration: +Aug 29 07:17:36 bubu kernel: [ 426.632213] smpboot: Booting Node 0 Processor 1 APIC 0x1 +Aug 29 07:17:36 bubu kernel: [ 426.644368] kvm: enabling virtualization on CPU1 +Aug 29 07:17:36 bubu kernel: [ 426.646490] cache: parent cpu1 should not be sleeping +Aug 29 07:17:36 bubu kernel: [ 426.646608] CPU1 is up +Aug 29 07:17:36 bubu kernel: [ 426.646628] smpboot: Booting Node 0 Processor 2 APIC 0x2 +Aug 29 07:17:36 bubu kernel: [ 426.658644] kvm: enabling virtualization on CPU2 +Aug 29 07:17:36 bubu kernel: [ 426.660780] cache: parent cpu2 should not be sleeping +Aug 29 07:17:36 bubu kernel: [ 426.660883] CPU2 is up +Aug 29 07:17:36 bubu kernel: [ 426.660902] smpboot: Booting Node 0 Processor 3 APIC 0x3 +Aug 29 07:17:36 bubu kernel: [ 426.672933] kvm: enabling virtualization on CPU3 +Aug 29 07:17:36 bubu kernel: [ 426.675076] cache: parent cpu3 should not be sleeping +Aug 29 07:17:36 bubu kernel: [ 426.675175] CPU3 is up +Aug 29 07:17:36 bubu kernel: [ 426.678433] ACPI: Waking up from system sleep state S3 +Aug 29 07:17:36 bubu kernel: [ 426.740106] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI +Aug 29 07:17:36 bubu kernel: [ 426.758471] ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI +Aug 29 07:17:36 bubu kernel: [ 426.758942] PM: noirq resume of devices complete after 19.006 msecs +Aug 29 07:17:36 bubu kernel: [ 426.765226] PM: early resume of devices complete after 6.254 msecs +Aug 29 07:17:36 bubu kernel: [ 426.765321] usb usb1: root hub lost power or was reset +Aug 29 07:17:36 bubu kernel: [ 426.765324] usb usb2: root hub lost power or was reset +Aug 29 07:17:36 bubu kernel: [ 426.765903] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. +Aug 29 07:17:36 bubu kernel: [ 426.766256] r8169 0000:08:00.0: System wakeup disabled by ACPI +Aug 29 07:17:36 bubu kernel: [ 426.779425] sd 0:0:0:0: [sda] Starting disk +Aug 29 07:17:36 bubu kernel: [ 426.783567] rtc_cmos 00:01: System wakeup disabled by ACPI +Aug 29 07:17:36 bubu kernel: [ 426.806076] r8169 0000:08:00.0 eth0: link down +Aug 29 07:17:36 bubu kernel: [ 426.991584] usb 3-1: reset high-speed USB device number 2 using ehci-pci +Aug 29 07:17:36 bubu kernel: [ 427.103803] usb 1-6: reset full-speed USB device number 3 using xhci_hcd +Aug 29 07:17:36 bubu kernel: [ 427.107661] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) +Aug 29 07:17:36 bubu kernel: [ 427.109418] ata1.00: configured for UDMA/133 +Aug 29 07:17:36 bubu kernel: [ 427.344425] usb 1-6: No LPM exit latency info found, disabling LPM. +Aug 29 07:17:36 bubu kernel: [ 427.456034] usb 1-5: reset high-speed USB device number 2 using xhci_hcd +Aug 29 07:17:36 bubu kernel: [ 427.711577] PM: resume of devices complete after 945.583 msecs +Aug 29 07:17:36 bubu kernel: [ 427.725986] Bluetooth: hci0: read Intel version: 370810011003110e00 +Aug 29 07:17:36 bubu kernel: [ 427.725991] Bluetooth: hci0: Intel Bluetooth firmware file: intel/ibt-hw-37.8.10-fw-1.10.3.11.e.bseq +Aug 29 07:17:36 bubu kernel: [ 427.760572] PM: Finishing wakeup. +Aug 29 07:17:36 bubu kernel: [ 427.760574] Restarting tasks ... done. +Aug 29 07:17:36 bubu kernel: [ 427.764625] atkbd serio0: Spurious ACK on isa0060/serio0. Some program might be trying to access hardware directly. +Aug 29 07:17:36 bubu kernel: [ 427.764854] pci_bus 0000:01: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.764868] pci_bus 0000:02: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765023] pcieport 0000:00:1c.2: bridge window [io 0x1000-0x0fff] to [bus 02] add_size 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765026] pcieport 0000:00:1c.2: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 02] add_size 200000 add_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765033] pci_bus 0000:03: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765138] pci_bus 0000:08: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765152] pci_bus 0000:09: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765224] pcieport 0000:00:1c.5: bridge window [io 0x1000-0x0fff] to [bus 09] add_size 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765227] pcieport 0000:00:1c.5: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 09] add_size 200000 add_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765232] i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment +Aug 29 07:17:36 bubu kernel: [ 427.765238] pcieport 0000:00:1c.2: res[15]=[mem 0x00100000-0x000fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765241] pcieport 0000:00:1c.2: res[15]=[mem 0x00100000-0x002fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765243] pcieport 0000:00:1c.5: res[15]=[mem 0x00100000-0x000fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765246] pcieport 0000:00:1c.5: res[15]=[mem 0x00100000-0x002fffff 64bit pref] res_to_dev_res add_size 200000 min_align 100000 +Aug 29 07:17:36 bubu kernel: [ 427.765249] pcieport 0000:00:1c.2: res[13]=[io 0x1000-0x0fff] res_to_dev_res add_size 1000 min_align 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765251] pcieport 0000:00:1c.2: res[13]=[io 0x1000-0x1fff] res_to_dev_res add_size 1000 min_align 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765254] pcieport 0000:00:1c.5: res[13]=[io 0x1000-0x0fff] res_to_dev_res add_size 1000 min_align 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765256] pcieport 0000:00:1c.5: res[13]=[io 0x1000-0x1fff] res_to_dev_res add_size 1000 min_align 1000 +Aug 29 07:17:36 bubu kernel: [ 427.765270] pcieport 0000:00:1c.2: BAR 15: assigned [mem 0xb0500000-0xb06fffff 64bit pref] +Aug 29 07:17:36 bubu kernel: [ 427.765279] pcieport 0000:00:1c.5: BAR 15: assigned [mem 0xb0700000-0xb08fffff 64bit pref] +Aug 29 07:17:36 bubu kernel: [ 427.765283] pcieport 0000:00:1c.2: BAR 13: assigned [io 0x6000-0x6fff] +Aug 29 07:17:36 bubu kernel: [ 427.765286] pcieport 0000:00:1c.5: BAR 13: assigned [io 0x7000-0x7fff] +Aug 29 07:17:36 bubu kernel: [ 427.765574] pci_bus 0000:01: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765586] pci_bus 0000:02: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765743] pci_bus 0000:03: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765761] pci_bus 0000:08: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765775] pci_bus 0000:09: Allocating resources +Aug 29 07:17:36 bubu kernel: [ 427.765785] i915 0000:00:02.0: BAR 6: [??? 0x00000000 flags 0x2] has bogus alignment +Aug 29 07:17:36 bubu kernel: [ 427.766460] atkbd serio0: Spurious ACK on isa0060/serio0. Some program might be trying to access hardware directly. +Aug 29 07:17:36 bubu systemd-timesyncd[371]: System time changed. Resyncing. +Aug 29 07:17:36 bubu systemd-timesyncd[371]: Using NTP server 129.250.35.251:123 (2.debian.pool.ntp.org). +Aug 29 07:17:36 bubu systemd-timesyncd[371]: Using NTP server 59.106.180.168:123 (2.debian.pool.ntp.org). +Aug 29 07:17:36 bubu systemd-timesyncd[371]: Using NTP server 202.181.103.212:123 (2.debian.pool.ntp.org). +Aug 29 07:17:36 bubu systemd[1078]: Time has been changed +Aug 29 07:17:36 bubu kernel: [ 427.821997] Bluetooth: hci0: Intel Bluetooth firmware patch completed and activated +Aug 29 07:17:36 bubu bluetoothd[525]: Sap driver initialization failed. +Aug 29 07:17:36 bubu bluetoothd[525]: sap-server: Operation not permitted (1) +Aug 29 07:17:36 bubu bluetoothd[525]: Failed to set mode: Not Powered (0x0f) +Aug 29 07:17:36 bubu kernel: [ 428.333006] ACPI Error: Needed [Integer/String/Buffer], found [Reference] ffff880240beeca8 (20150410/exresop-502) +Aug 29 07:17:36 bubu kernel: [ 428.333014] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20150410/dswexec-461) +Aug 29 07:17:36 bubu kernel: [ 428.333021] ACPI Error: Method parse/execution failed [\_SB_.BAT1._BTP] (Node ffff880245cc1be0), AE_AML_OPERAND_TYPE (20150410/psparse-536) +Aug 29 07:17:36 bubu systemd-sleep[1949]: System resumed. +Aug 29 07:17:36 bubu NetworkManager[531]: <info> wake requested (sleeping: yes enabled: yes) +Aug 29 07:17:36 bubu NetworkManager[531]: <info> waking up... +Aug 29 07:17:36 bubu NetworkManager[531]: <info> (eth0): device state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37] +Aug 29 07:17:37 bubu NetworkManager[531]: <info> (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] +Aug 29 07:17:37 bubu kernel: [ 428.413593] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready +Aug 29 07:17:37 bubu NetworkManager[531]: <info> (eth0): preparing device +Aug 29 07:17:37 bubu NetworkManager[531]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] +Aug 29 07:17:37 bubu kernel: [ 428.455243] r8169 0000:08:00.0 eth0: link down +Aug 29 07:17:37 bubu kernel: [ 428.456472] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled +Aug 29 07:17:37 bubu kernel: [ 428.457236] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled +Aug 29 07:17:37 bubu kernel: [ 428.518238] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled +Aug 29 07:17:37 bubu kernel: [ 428.518682] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled +Aug 29 07:17:37 bubu NetworkManager[531]: <info> (wlan0): preparing device +Aug 29 07:17:37 bubu NetworkManager[531]: <info> NetworkManager state is now DISCONNECTED +Aug 29 07:17:37 bubu NetworkManager[531]: <info> (wlan0) supports 5 scan SSIDs +Aug 29 07:17:37 bubu NetworkManager[531]: <info> (wlan0): supplicant interface state: starting -> ready +Aug 29 07:17:37 bubu NetworkManager[531]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] +Aug 29 07:17:37 bubu NetworkManager[531]: <info> (wlan0): supplicant interface state: ready -> disconnected +Aug 29 07:17:37 bubu NetworkManager[531]: <info> (wlan0) supports 5 scan SSIDs +Aug 29 07:17:37 bubu kernel: [ 428.629337] psmouse serio2: synaptics: queried max coordinates: x [..5746], y [..4934] +Aug 29 07:17:37 bubu kernel: [ 428.658920] psmouse serio2: synaptics: queried min coordinates: x [1258..], y [1134..] +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Auto-activating connection '701'. +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) starting connection '701' +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started... +Aug 29 07:17:40 bubu NetworkManager[531]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] +Aug 29 07:17:40 bubu NetworkManager[531]: <info> NetworkManager state is now CONNECTING +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting... +Aug 29 07:17:40 bubu NetworkManager[531]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0/wireless): connection '701' requires no security. No secrets needed. +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Config: added 'ssid' value '701' +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Config: added 'scan_ssid' value '1' +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Config: added 'key_mgmt' value 'NONE' +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete. +Aug 29 07:17:40 bubu NetworkManager[531]: <info> (wlan0): supplicant interface state: disconnected -> inactive +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Config: set interface ap_scan to 1 +Aug 29 07:17:40 bubu wpa_supplicant[858]: wlan0: SME: Trying to authenticate with 10:9a:dd:85:6f:76 (SSID='701' freq=5280 MHz) +Aug 29 07:17:40 bubu kernel: [ 432.374400] wlan0: authenticate with 10:9a:dd:85:6f:76 +Aug 29 07:17:40 bubu NetworkManager[531]: <info> (wlan0): supplicant interface state: inactive -> authenticating +Aug 29 07:17:40 bubu wpa_supplicant[858]: wlan0: Trying to associate with 10:9a:dd:85:6f:76 (SSID='701' freq=5280 MHz) +Aug 29 07:17:40 bubu kernel: [ 432.380854] wlan0: send auth to 10:9a:dd:85:6f:76 (try 1/3) +Aug 29 07:17:40 bubu kernel: [ 432.381453] wlan0: authenticated +Aug 29 07:17:40 bubu kernel: [ 432.383864] wlan0: associate with 10:9a:dd:85:6f:76 (try 1/3) +Aug 29 07:17:40 bubu wpa_supplicant[858]: wlan0: Associated with 10:9a:dd:85:6f:76 +Aug 29 07:17:40 bubu wpa_supplicant[858]: wlan0: CTRL-EVENT-CONNECTED - Connection to 10:9a:dd:85:6f:76 completed [id=0 id_str=] +Aug 29 07:17:40 bubu kernel: [ 432.385601] wlan0: RX AssocResp from 10:9a:dd:85:6f:76 (capab=0x501 status=0 aid=3) +Aug 29 07:17:40 bubu kernel: [ 432.386815] wlan0: associated +Aug 29 07:17:40 bubu kernel: [ 432.386962] cfg80211: Calling CRDA for country: JP +Aug 29 07:17:40 bubu NetworkManager[531]: <info> (wlan0): supplicant interface state: authenticating -> associating +Aug 29 07:17:40 bubu wpa_supplicant[858]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP +Aug 29 07:17:40 bubu kernel: [ 432.389475] cfg80211: Regulatory domain changed to country: JP +Aug 29 07:17:40 bubu kernel: [ 432.389479] cfg80211: DFS Master region: JP +Aug 29 07:17:40 bubu kernel: [ 432.389481] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) +Aug 29 07:17:40 bubu kernel: [ 432.389484] cfg80211: (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:17:40 bubu kernel: [ 432.389486] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:17:40 bubu kernel: [ 432.389487] cfg80211: (4910000 KHz - 4990000 KHz @ 40000 KHz), (N/A, 2300 mBm), (N/A) +Aug 29 07:17:40 bubu kernel: [ 432.389489] cfg80211: (5030000 KHz - 5090000 KHz @ 40000 KHz), (N/A, 2300 mBm), (N/A) +Aug 29 07:17:40 bubu kernel: [ 432.389491] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) +Aug 29 07:17:40 bubu kernel: [ 432.389494] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) +Aug 29 07:17:40 bubu kernel: [ 432.389496] cfg80211: (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2300 mBm), (0 s) +Aug 29 07:17:40 bubu NetworkManager[531]: <info> (wlan0): supplicant interface state: associating -> completed +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network '701'. +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... +Aug 29 07:17:40 bubu NetworkManager[531]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) +Aug 29 07:17:40 bubu NetworkManager[531]: <info> dhclient started with pid 2051 +Aug 29 07:17:40 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. +Aug 29 07:17:41 bubu NetworkManager[531]: <info> (wlan0): DHCPv4 state changed nbi -> preinit +Aug 29 07:17:41 bubu dhclient: DHCPREQUEST on wlan0 to 255.255.255.255 port 67 +Aug 29 07:17:41 bubu dhclient: DHCPACK from 192.168.0.1 +Aug 29 07:17:41 bubu kernel: [ 432.459479] wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 10:9a:dd:85:6f:76 +Aug 29 07:17:41 bubu NetworkManager[531]: <info> (wlan0): DHCPv4 state changed preinit -> reboot +Aug 29 07:17:41 bubu NetworkManager[531]: <info> address 192.168.0.53 +Aug 29 07:17:41 bubu NetworkManager[531]: <info> plen 24 (255.255.255.0) +Aug 29 07:17:41 bubu NetworkManager[531]: <info> gateway 192.168.0.1 +Aug 29 07:17:41 bubu NetworkManager[531]: <info> server identifier 192.168.0.1 +Aug 29 07:17:41 bubu NetworkManager[531]: <info> lease time 43200 +Aug 29 07:17:41 bubu NetworkManager[531]: <info> hostname 'bubu' +Aug 29 07:17:41 bubu NetworkManager[531]: <info> nameserver '192.168.0.1' +Aug 29 07:17:41 bubu NetworkManager[531]: <info> domain name 'igloo' +Aug 29 07:17:41 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled... +Aug 29 07:17:41 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started... +Aug 29 07:17:41 bubu avahi-daemon[549]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.53. +Aug 29 07:17:41 bubu avahi-daemon[549]: New relevant interface wlan0.IPv4 for mDNS. +Aug 29 07:17:41 bubu avahi-daemon[549]: Registering new address record for 192.168.0.53 on wlan0.IPv4. +Aug 29 07:17:41 bubu NetworkManager[531]: <info> (wlan0): device state change: ip-config -> ip-check (reason 'none') [70 80 0] +Aug 29 07:17:41 bubu NetworkManager[531]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete. +Aug 29 07:17:41 bubu NetworkManager[531]: <info> (wlan0): device state change: ip-check -> secondaries (reason 'none') [80 90 0] +Aug 29 07:17:41 bubu NetworkManager[531]: <info> (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0] +Aug 29 07:17:41 bubu NetworkManager[531]: <info> NetworkManager state is now CONNECTED_LOCAL +Aug 29 07:17:41 bubu dhclient: bound to 192.168.0.53 -- renewal in 16492 seconds. +Aug 29 07:17:41 bubu NetworkManager[531]: <info> (wlan0): roamed from BSSID 10:9A:DD:85:6F:75 (701) to 10:9A:DD:85:6F:76 (701) +Aug 29 07:17:41 bubu NetworkManager[531]: <info> NetworkManager state is now CONNECTED_GLOBAL +Aug 29 07:17:41 bubu NetworkManager[531]: <info> Policy set '701' (wlan0) as default for IPv4 routing and DNS. +Aug 29 07:17:41 bubu NetworkManager[531]: <info> Activation (wlan0) successful, device activated. +Aug 29 07:17:41 bubu geoclue[1291]: (geoclue:1291): Geoclue-WARNING **: Failed to query location: Error resolving 'location.services.mozilla.com': Nom ou service inconnu +Aug 29 07:17:41 bubu nm-dispatcher: Dispatching action 'up' for wlan0 +Aug 29 07:17:42 bubu avahi-daemon[549]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::5ee0:c5ff:fed1:e6d8. +Aug 29 07:17:42 bubu avahi-daemon[549]: New relevant interface wlan0.IPv6 for mDNS. +Aug 29 07:17:42 bubu avahi-daemon[549]: Registering new address record for fe80::5ee0:c5ff:fed1:e6d8 on wlan0.*. +Aug 29 07:18:04 bubu wpa_supplicant[858]: wlan0: SME: Trying to authenticate with 10:9a:dd:85:6f:75 (SSID='701' freq=2442 MHz) +Aug 29 07:18:04 bubu kernel: [ 456.360289] wlan0: authenticate with 10:9a:dd:85:6f:75 +Aug 29 07:18:04 bubu kernel: [ 456.366024] wlan0: send auth to 10:9a:dd:85:6f:75 (try 1/3) +Aug 29 07:18:04 bubu kernel: [ 456.366375] cfg80211: Calling CRDA to update world regulatory domain +Aug 29 07:18:04 bubu NetworkManager[531]: <info> (wlan0): roamed from BSSID 10:9A:DD:85:6F:76 (701) to (none) ((none)) +Aug 29 07:18:04 bubu NetworkManager[531]: <info> (wlan0): supplicant interface state: completed -> authenticating +Aug 29 07:18:04 bubu gnome-session[1086]: Gjs-Message: JS LOG: An active wireless connection, in infrastructure mode, involves no access point? +Aug 29 07:18:04 bubu wpa_supplicant[858]: wlan0: Trying to associate with 10:9a:dd:85:6f:75 (SSID='701' freq=2442 MHz) +Aug 29 07:18:04 bubu wpa_supplicant[858]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD +Aug 29 07:18:04 bubu kernel: [ 456.368990] wlan0: authenticated +Aug 29 07:18:04 bubu kernel: [ 456.369023] cfg80211: World regulatory domain updated: +Aug 29 07:18:04 bubu kernel: [ 456.369026] cfg80211: DFS Master region: unset +Aug 29 07:18:04 bubu kernel: [ 456.369028] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) +Aug 29 07:18:04 bubu kernel: [ 456.369031] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.369033] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.369035] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.369038] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.369040] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) +Aug 29 07:18:04 bubu kernel: [ 456.369043] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) +Aug 29 07:18:04 bubu kernel: [ 456.369045] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.369047] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.371044] wlan0: associate with 10:9a:dd:85:6f:75 (try 1/3) +Aug 29 07:18:04 bubu NetworkManager[531]: <info> (wlan0): supplicant interface state: authenticating -> associating +Aug 29 07:18:04 bubu kernel: [ 456.374891] wlan0: RX AssocResp from 10:9a:dd:85:6f:75 (capab=0x421 status=0 aid=3) +Aug 29 07:18:04 bubu wpa_supplicant[858]: wlan0: Associated with 10:9a:dd:85:6f:75 +Aug 29 07:18:04 bubu wpa_supplicant[858]: wlan0: CTRL-EVENT-CONNECTED - Connection to 10:9a:dd:85:6f:75 completed [id=0 id_str=] +Aug 29 07:18:04 bubu wpa_supplicant[858]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP +Aug 29 07:18:04 bubu kernel: [ 456.376193] wlan0: associated +Aug 29 07:18:04 bubu kernel: [ 456.376247] cfg80211: Calling CRDA for country: JP +Aug 29 07:18:04 bubu kernel: [ 456.377984] cfg80211: Regulatory domain changed to country: JP +Aug 29 07:18:04 bubu kernel: [ 456.377987] cfg80211: DFS Master region: JP +Aug 29 07:18:04 bubu kernel: [ 456.377988] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) +Aug 29 07:18:04 bubu kernel: [ 456.377989] cfg80211: (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.377991] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.377992] cfg80211: (4910000 KHz - 4990000 KHz @ 40000 KHz), (N/A, 2300 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.377993] cfg80211: (5030000 KHz - 5090000 KHz @ 40000 KHz), (N/A, 2300 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.377994] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) +Aug 29 07:18:04 bubu kernel: [ 456.377995] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) +Aug 29 07:18:04 bubu kernel: [ 456.377996] cfg80211: (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2300 mBm), (0 s) +Aug 29 07:18:04 bubu NetworkManager[531]: <info> (wlan0): supplicant interface state: associating -> completed +Aug 29 07:18:04 bubu NetworkManager[531]: <info> (wlan0): roamed from BSSID (none) ((none)) to 10:9A:DD:85:6F:75 (701)
