> We need the kernel log up to this point - the on-screen messages are not > sufficient. They should have made it into /var/log/messages. If there > are any error messages in the log file from udev, those should also be > informative. (Sorry if my reply comes out as garbled HTML mail. I'm not too familiar with the webmail interface I'm using.) Anyway my boot problem doesn't produce any logs in /var because errors prevent prevent /var from being mounted. However I managed to pipe the output of dmesg to file. The part where the boot first stalls is reproduced below (with two lines of context included before and after). I'm also attaching as a tar.xz file the complete dmesg output from the failed boot under linux-image-3.16-2 and, for comparison, the dmesg from a successful boot under linux-image-3.16-1. [ 12.658117] systemd-udevd[417]: renamed network interface wlan0 to wlan2 [ 12.798356] [drm] Enabling RC6 states: RC6 on, RC6p on, RC6pp off [ 153.192245] Adding 8388604k swap on /dev/sda10. Priority:-1 extents:1 across:8388604k FS [ 153.245182] EXT4-fs (sda11): re-mounted. Opts: (null) [ 153.762270] EXT4-fs (sda11): re-mounted. Opts: errors=remount-ro [ 240.061772] INFO: task kworker/2:1:46 blocked for more than 120 seconds. [ 240.061870] Not tainted 3.16-2-amd64 #1 [ 240.064844] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 240.067911] kworker/2:1 D ffff8800d22a8468 0 46 2 0x00000000 [ 240.067940] Workqueue: pm pm_runtime_work [ 240.067944] ffff8800d22a8010 0000000000000046 0000000000014240 ffff8800d22affd8 [ 240.067950] 0000000000014240 ffff8800d22a8010 ffff8800368eff08 ffff8800d22afc60 [ 240.067955] ffff8800368eff0c ffff8800d22a8010 00000000ffffffff ffff8800368eff10 [ 240.067961] Call Trace: [ 240.067974] [<ffffffff81508e35>] ? schedule_preempt_disabled+0x25/0x70 [ 240.067983] [<ffffffff8150a8f3>] ? __mutex_lock_slowpath+0xd3/0x1c0 [ 240.067990] [<ffffffff8150a9fb>] ? mutex_lock+0x1b/0x2a [ 240.068021] [<ffffffffa00dd5b6>] ? rtsx_usb_suspend+0x26/0x80 [rtsx_usb] [ 240.068045] [<ffffffffa0017d0a>] ? usb_suspend_both+0x9a/0x1d0 [usbcore] [ 240.068062] [<ffffffffa001913e>] ? usb_runtime_suspend+0x2e/0x70 [usbcore] [ 240.068068] [<ffffffff813a68cc>] ? __rpm_callback+0x2c/0x80 [ 240.068074] [<ffffffff813a693f>] ? rpm_callback+0x1f/0x80 [ 240.068080] [<ffffffff813a6aa7>] ? rpm_suspend+0x107/0x5f0 [ 240.068086] [<ffffffff813a7e3c>] ? __pm_runtime_suspend+0x5c/0x80 [ 240.068102] [<ffffffffa00191c6>] ? usb_runtime_idle+0x26/0x30 [usbcore] [ 240.068108] [<ffffffff813a68cc>] ? __rpm_callback+0x2c/0x80 [ 240.068113] [<ffffffff813a71f8>] ? rpm_idle+0x198/0x290 [ 240.068119] [<ffffffff813a7f67>] ? pm_runtime_work+0x97/0xa0 [ 240.068128] [<ffffffff8107f4a2>] ? process_one_work+0x172/0x420 [ 240.068135] [<ffffffff8107fb35>] ? worker_thread+0x115/0x520 [ 240.068141] [<ffffffff81508591>] ? __schedule+0x2b1/0x710 [ 240.068148] [<ffffffff8107fa20>] ? rescuer_thread+0x2d0/0x2d0 [ 240.068154] [<ffffffff81085dcd>] ? kthread+0xbd/0xe0 [ 240.068160] [<ffffffff81085d10>] ? kthread_create_on_node+0x180/0x180 [ 240.068165] [<ffffffff8150c1bc>] ? ret_from_fork+0x7c/0xb0 [ 240.068171] [<ffffffff81085d10>] ? kthread_create_on_node+0x180/0x180 [ 240.068181] INFO: task kworker/u8:5:111 blocked for more than 120 seconds. [ 240.070936] Not tainted 3.16-2-amd64 #1 [ 240.073676] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 240.076462] kworker/u8:5 D ffff880119a245a8 0 111 2 0x00000000 [ 240.076484] Workqueue: kmmcd mmc_rescan [mmc_core] [ 240.076487] ffff880119a24150 0000000000000046 0000000000014240 ffff8800364e7fd8 [ 240.076492] 0000000000014240 ffff880119a24150 ffff8800369c0090 ffff8800369c0140 [ 240.076497] ffff8800369c0200 0000000000000000 0000000000000000 ffff8800364e7c30 [ 240.076502] Call Trace: [ 240.076509] [<ffffffff813a7501>] ? rpm_resume+0x191/0x5d0 [ 240.076517] [<ffffffff81070980>] ? ftrace_raw_event_tick_stop+0xb0/0xb0 [ 240.076524] [<ffffffff810a57f0>] ? prepare_to_wait_event+0xf0/0xf0 [ 240.076530] [<ffffffff813a763a>] ? rpm_resume+0x2ca/0x5d0 [ 240.076535] [<ffffffff813a763a>] ? rpm_resume+0x2ca/0x5d0 [ 240.076541] [<ffffffff813a7988>] ? __pm_runtime_resume+0x48/0x70 [ 240.076551] [<ffffffffa0173858>] ? sdmmc_set_ios+0x318/0xa20 [rtsx_usb_sdmmc] [ 240.076561] [<ffffffffa0173b15>] ? sdmmc_set_ios+0x5d5/0xa20 [rtsx_usb_sdmmc] [ 240.076573] [<ffffffffa019a8ba>] ? mmc_power_up+0x7a/0x2a0 [mmc_core] [ 240.076585] [<ffffffffa019a0c2>] ? mmc_power_off.part.19+0x72/0xe0 [mmc_core] [ 240.076591] [<ffffffff812b2b02>] ? delay_tsc+0x42/0x70 [ 240.076605] [<ffffffffa019b71e>] ? mmc_rescan+0x26e/0x320 [mmc_core] [ 240.076612] [<ffffffff8107f4a2>] ? process_one_work+0x172/0x420 [ 240.076619] [<ffffffff8107fb35>] ? worker_thread+0x115/0x520 [ 240.076626] [<ffffffff8107fa20>] ? rescuer_thread+0x2d0/0x2d0 [ 240.076631] [<ffffffff81085dcd>] ? kthread+0xbd/0xe0 [ 240.076637] [<ffffffff81085d10>] ? kthread_create_on_node+0x180/0x180 [ 240.076642] [<ffffffff8150c1bc>] ? ret_from_fork+0x7c/0xb0 [ 240.076647] [<ffffffff81085d10>] ? kthread_create_on_node+0x180/0x180 [ 240.076656] INFO: task udevd:414 blocked for more than 120 seconds. [ 240.079458] Not tainted 3.16-2-amd64 #1 [ 240.082007] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 240.084570] udevd D ffff8800d1c5b078 0 414 377 0x00000000 [ 240.084575] ffff8800d1c5ac20 0000000000000086 0000000000014240 ffff880119b2ffd8 [ 240.084579] 0000000000014240 ffff8800d1c5ac20 ffff8800368eff08 ffff880119b2fbd0 [ 240.084584] ffff8800368eff0c ffff8800d1c5ac20 00000000ffffffff ffff8800368eff10 [ 240.084588] Call Trace: [ 240.084595] [<ffffffff81508e35>] ? schedule_preempt_disabled+0x25/0x70 [ 240.084601] [<ffffffff8150a8f3>] ? __mutex_lock_slowpath+0xd3/0x1c0 [ 240.084607] [<ffffffff8150a9fb>] ? mutex_lock+0x1b/0x2a [ 240.084614] [<ffffffffa070c56f>] ? rtsx_usb_ms_set_param+0x3f/0x870 [rtsx_usb_ms] [ 240.084620] [<ffffffffa071e78f>] ? memstick_add_host+0x7f/0xd0 [memstick] [ 240.084626] [<ffffffffa070c427>] ? rtsx_usb_ms_drv_probe+0x147/0x1e0 [rtsx_usb_ms] [ 240.084634] [<ffffffff813a0a16>] ? platform_drv_probe+0x26/0x80 [ 240.084639] [<ffffffff8139e9ed>] ? driver_probe_device+0x9d/0x3d0 [ 240.084644] [<ffffffff8139edeb>] ? __driver_attach+0x8b/0x90 [ 240.084648] [<ffffffff8139ed60>] ? __device_attach+0x40/0x40 [ 240.084653] [<ffffffff8139cafb>] ? bus_for_each_dev+0x5b/0x90 [ 240.084657] [<ffffffff8139e080>] ? bus_add_driver+0x180/0x250 [ 240.084669] [<ffffffffa0712000>] ? 0xffffffffa0711fff [ 240.084673] [<ffffffff8139f53b>] ? driver_register+0x5b/0xe0 [ 240.084680] [<ffffffff8100213c>] ? do_one_initcall+0xcc/0x200 [ 240.084687] [<ffffffff810d89ea>] ? load_module+0x20ca/0x26a0 [ 240.084691] [<ffffffff810d45a0>] ? store_uevent+0x40/0x40 [ 240.084698] [<ffffffff810d911d>] ? SyS_finit_module+0x7d/0xa0 [ 240.084703] [<ffffffff8150c26d>] ? system_call_fast_compare_end+0x10/0x15 [ 240.084710] INFO: task rtsx_usb_ms_3:529 blocked for more than 120 seconds. [ 240.087293] Not tainted 3.16-2-amd64 #1 [ 240.089896] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 240.092345] rtsx_usb_ms_3 D ffff88003674d848 0 529 2 0x00000000 [ 240.092349] ffff88003674d3f0 0000000000000046 0000000000014240 ffff8800d212bfd8 [ 240.092353] 0000000000014240 ffff88003674d3f0 ffff8800d1ed8d40 ffff8800d1ad2740 [ 240.092357] ffffffffa070c200 0000000000000000 0000000000000000 0000000000000000 [ 240.092361] Call Trace: [ 240.092367] [<ffffffffa070c200>] ? rtsx_usb_ms_drv_remove+0x160/0x160 [rtsx_usb_ms] [ 240.092372] [<ffffffff81085da9>] ? kthread+0x99/0xe0 [ 240.092377] [<ffffffff81085d10>] ? kthread_create_on_node+0x180/0x180 [ 240.092381] [<ffffffff8150c1bc>] ? ret_from_fork+0x7c/0xb0 [ 240.092385] [<ffffffff81085d10>] ? kthread_create_on_node+0x180/0x180 [ 330.617173] usb 1-1.2: new high-speed USB device number 5 using ehci-pci [ 331.033983] usb 1-1.2: New USB device found, idVendor=05dc, idProduct=c75c
Attachment:
dmesg-v1-vs-v2.tar.xz
Description: application/xz