Skip to content

Instantly share code, notes, and snippets.

@karubabu

karubabu/dmesg.txt

Last active May 3, 2018 08:43
Show Gist options
  • Save karubabu/4ad67b9338d88b21d2766f1787d84dde to your computer and use it in GitHub Desktop.
Save karubabu/4ad67b9338d88b21d2766f1787d84dde to your computer and use it in GitHub Desktop.
Download ZIP
起動時に出てくる怪しい部分 このスタックトレースの様な物が出る迄に十数秒かかるので異様に起動に時間がかかる かつこの後更にlightdmの起動も異様に遅れる 遅れているのは May 03 17:24:23 Arigatori lightdm[2644]: Failed to get list of logind seats: Timeout was reachedに何かしらの問題がありそうだけれど、わからん…
Raw
dmesg.txt
[ 5.544793] [drm] Replacing VGA console driver
[ 5.545202] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 5.545204] [drm] Driver supports precise vblank timestamp query.
[ 5.755366] input: HDA NVidia HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.0/0000:01:00.0/0000:02:10.0/0000:04:00.1/sound/card3/input9
[ 5.755398] input: HDA NVidia HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:01.0/0000:01:00.0/0000:02:10.0/0000:04:00.1/sound/card3/input10
[ 5.755423] input: HDA NVidia HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:01.0/0000:01:00.0/0000:02:10.0/0000:04:00.1/sound/card3/input11
[ 5.755447] input: HDA NVidia HDMI/DP,pcm=9 as /devices/pci0000:00/0000:00:01.0/0000:01:00.0/0000:02:10.0/0000:04:00.1/sound/card3/input12
[ 5.814795] usbcore: registered new interface driver snd-usb-audio
[ 5.961468] [drm] Initialized i915 1.6.0 20171222 for 0000:00:02.0 on minor 1
[ 5.961633] snd_hda_intel 0000:00:03.0: bound 0000:00:02.0 (ops i915_audio_component_bind_ops [i915])
[ 5.978971] [drm] Cannot find any crtc or sizes
[ 6.053315] snd_hda_codec_ca0132 hdaudioC2D2: ca0132 DSP downloaded and running
[ 6.081885] input: HDA Intel HDMI HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:03.0/sound/card1/input13
[ 6.081922] input: HDA Intel HDMI HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:03.0/sound/card1/input14
[ 6.081957] input: HDA Intel HDMI HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:03.0/sound/card1/input15
[ 6.082112] input: HDA Intel HDMI HDMI/DP,pcm=9 as /devices/pci0000:00/0000:00:03.0/sound/card1/input16
[ 6.082136] input: HDA Intel HDMI HDMI/DP,pcm=10 as /devices/pci0000:00/0000:00:03.0/sound/card1/input17
[ 6.179190] usb 3-9.3: reset high-speed USB device number 6 using xhci_hcd
[ 6.237865] input: HDA Intel PCH Front Line Out as /devices/pci0000:00/0000:00:1b.0/sound/card2/input18
[ 6.237891] input: HDA Intel PCH Line Out as /devices/pci0000:00/0000:00:1b.0/sound/card2/input19
[ 6.237912] input: HDA Intel PCH Front Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card2/input20
[ 6.279484] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 2872, rev 0202 detected
[ 6.333756] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 0001 detected
[ 6.338135] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[ 6.338274] usbcore: registered new interface driver rt2800usb
[ 6.339273] rt2800usb 3-9.3:1.0 wlp0s20u9u3: renamed from wlan0
[ 6.381644] resource sanity check: requesting [mem 0x000c0000-0x000fffff], which spans more than PCI Bus 0000:00 [mem 0x000d0000-0x000d3fff window]
[ 6.381727] caller _nv001112rm+0xe3/0x1d0 [nvidia] mapping multiple BARs
[ 6.712218] 8021q: 802.1Q VLAN Support v1.8
[ 6.716508] ieee80211 phy0: rt2x00lib_request_firmware: Info - Loading firmware file 'rt2870.bin'
[ 6.717156] ieee80211 phy0: rt2x00lib_request_firmware: Info - Firmware detected - version: 0.36
[ 6.766867] random: crng init done
[ 6.815820] IPv6: ADDRCONF(NETDEV_UP): wlp0s20u9u3: link is not ready
[ 6.815869] IPv6: ADDRCONF(NETDEV_UP): bond0: link is not ready
[ 6.815872] 8021q: adding VLAN 0 to HW filter on device bond0
[ 6.816221] snd_hda_codec_ca0132 hdaudioC2D2: ca0132 DSP downloaded and running
[ 7.056114] IPv6: ADDRCONF(NETDEV_UP): eno1: link is not ready
[ 27.929003] INFO: rcu_sched self-detected stall on CPU
[ 27.929006] 3-....: (20999 ticks this GP) idle=aba/1/4611686018427387906 softirq=2325/2325 fqs=5196
[ 27.929006] (t=21000 jiffies g=291 c=290 q=723)
[ 27.929007] NMI backtrace for cpu 3
[ 27.929008] CPU: 3 PID: 2116 Comm: nvidia-smi Tainted: P OE 4.16.6-gentoo #1
[ 27.929009] Hardware name: Gigabyte Technology Co., Ltd. Z97X-Gaming G1/Z97X-Gaming G1, BIOS F9 07/31/2015
[ 27.929009] Call Trace:
[ 27.929010] <IRQ>
[ 27.929014] dump_stack+0x5e/0x91
[ 27.929016] nmi_cpu_backtrace+0xb4/0xc0
[ 27.929018] ? lapic_can_unplug_cpu+0x90/0x90
[ 27.929019] nmi_trigger_cpumask_backtrace+0xd6/0x110
[ 27.929022] rcu_dump_cpu_stacks+0x8c/0xcb
[ 27.929023] rcu_check_callbacks+0x759/0x890
[ 27.929025] ? _raw_write_unlock_irqrestore+0x21/0x30
[ 27.929027] ? tick_sched_handle.isra.5+0x60/0x60
[ 27.929028] update_process_times+0x28/0x50
[ 27.929029] tick_sched_handle.isra.5+0x20/0x60
[ 27.929030] tick_sched_timer+0x38/0x80
[ 27.929031] __hrtimer_run_queues+0xe8/0x250
[ 27.929032] hrtimer_interrupt+0x122/0x270
[ 27.929033] ? trace_hardirqs_off_thunk+0x1a/0x30
[ 27.929034] smp_apic_timer_interrupt+0x56/0x120
[ 27.929035] apic_timer_interrupt+0xf/0x20
[ 27.929036] </IRQ>
[ 27.929107] RIP: 0010:os_io_read_dword+0x8/0x10 [nvidia]
[ 27.929107] RSP: 0018:ffffc900007afc20 EFLAGS: 00000202 ORIG_RAX: ffffffffffffff12
[ 27.929108] RAX: 00000000ca56efa0 RBX: ffff880317eb71e0 RCX: 0000000000000002
[ 27.929108] RDX: 000000000000e00c RSI: 00000000000c0000 RDI: 000000000000e00c
[ 27.929109] RBP: ffff880317eb71a8 R08: 00000000000c43ae R09: 00000000000c43ae
[ 27.929109] R10: 0000000000000000 R11: ffffffffa12ad4e0 R12: 000000000000c000
[ 27.929109] R13: 00000000000017d5 R14: ffff880317eb71e4 R15: ffff880317eb71e8
[ 27.929182] ? nv_rdtsc+0x170/0x270 [nvidia]
[ 27.929254] _nv035608rm+0x84ea/0xbd70 [nvidia]
[ 27.929323] ? _nv001281rm+0x85/0xb0 [nvidia]
[ 27.929391] ? _nv027315rm+0x164/0x220 [nvidia]
[ 27.929459] ? _nv028631rm+0x3c/0xe0 [nvidia]
[ 27.929526] ? _nv001152rm+0x345/0x430 [nvidia]
[ 27.929593] ? _nv001009rm+0x277/0x490 [nvidia]
[ 27.929660] ? _nv001028rm+0x30a/0x370 [nvidia]
[ 27.929726] ? rm_disable_adapter+0x6a/0x130 [nvidia]
[ 27.929763] ? nv_pci_register_driver+0x327/0x790 [nvidia]
[ 27.929797] ? nv_pci_register_driver+0x471/0x790 [nvidia]
[ 27.929833] ? nvidia_close+0xc8/0x350 [nvidia]
[ 27.929868] ? nvidia_frontend_close+0x2a/0x40 [nvidia]
[ 27.929870] ? __fput+0xab/0x210
[ 27.929871] ? task_work_run+0x7e/0xa0
[ 27.929873] ? exit_to_usermode_loop+0xb1/0xc0
[ 27.929873] ? do_syscall_64+0x10b/0x130
[ 27.929876] ? entry_SYSCALL_64_after_hwframe+0x42/0xb7
[ 28.128022] INFO: rcu_sched detected expedited stalls on CPUs/tasks: { 3-... } 21048 jiffies s: 37 root: 0x8/.
[ 28.128023] blocking rcu_node structures:
[ 28.128024] Task dump for CPU 3:
[ 28.128024] nvidia-smi R running task 0 2116 2109 0x00000108
[ 28.128026] Call Trace:
[ 28.128116] ? _nv020275rm+0x202/0x3d0 [nvidia]
[ 28.128117] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128153] ? os_alloc_mem+0xc2/0xd0 [nvidia]
[ 28.128155] ? __kmalloc+0x182/0x1f0
[ 28.128156] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128157] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128158] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128159] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128160] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128161] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128161] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128162] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128163] ? _raw_spin_lock_irqsave+0x12/0x40
[ 28.128269] ? _nv007448rm+0x85/0xc0 [nvidia]
[ 28.128374] ? _nv007448rm+0x85/0xc0 [nvidia]
[ 28.128458] ? _nv019074rm+0x1a/0x30 [nvidia]
[ 28.128496] ? _nv010505rm+0x4b3/0x970 [nvidia]
[ 28.128533] ? _nv010505rm+0x766/0x970 [nvidia]
[ 28.128638] ? _nv025353rm+0x13/0x170 [nvidia]
[ 28.128743] ? _nv025286rm+0xf41/0x11a0 [nvidia]
[ 28.128847] ? _nv025345rm+0x25f/0x400 [nvidia]
[ 28.128949] ? _nv025286rm+0xf41/0x11a0 [nvidia]
[ 28.128950] ? trace_hardirqs_on_thunk+0x1a/0x1c
[ 28.128951] ? trace_hardirqs_on_thunk+0x1a/0x1c
[ 28.128952] ? retint_kernel+0x10/0x10
[ 28.129019] ? nv_rdtsc+0x170/0x270 [nvidia]
[ 28.129086] ? nv_rdtsc+0xfe/0x270 [nvidia]
[ 28.129151] ? nv_rdtsc+0xfe/0x270 [nvidia]
[ 28.129216] ? _nv017611rm+0x29/0x40 [nvidia]
[ 28.129281] ? _nv035608rm+0x4d4d/0xbd70 [nvidia]
[ 28.129347] ? _nv035608rm+0x54c6/0xbd70 [nvidia]
[ 28.129411] ? _nv001281rm+0x85/0xb0 [nvidia]
[ 28.129476] ? _nv027315rm+0x164/0x220 [nvidia]
[ 28.129542] ? _nv028631rm+0x3c/0xe0 [nvidia]
[ 28.129607] ? _nv001152rm+0x345/0x430 [nvidia]
[ 28.129672] ? _nv001009rm+0x277/0x490 [nvidia]
[ 28.129737] ? _nv001028rm+0x30a/0x370 [nvidia]
[ 28.129802] ? rm_disable_adapter+0x6a/0x130 [nvidia]
[ 28.129836] ? nv_pci_register_driver+0x327/0x790 [nvidia]
[ 28.129869] ? nv_pci_register_driver+0x471/0x790 [nvidia]
[ 28.129902] ? nvidia_close+0xc8/0x350 [nvidia]
[ 28.129935] ? nvidia_frontend_close+0x2a/0x40 [nvidia]
[ 28.129936] ? __fput+0xab/0x210
[ 28.129938] ? task_work_run+0x7e/0xa0
[ 28.129938] ? exit_to_usermode_loop+0xb1/0xc0
[ 28.129939] ? do_syscall_64+0x10b/0x130
[ 28.129940] ? entry_SYSCALL_64_after_hwframe+0x42/0xb7
Raw
journalctl-eu-dbus.txt
-- Reboot --
May 03 17:23:10 Arigatori systemd[1]: Started D-Bus System Message Bus.
May 03 17:23:40 Arigatori dbus-daemon[2165]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30029ms)
May 03 17:23:58 Arigatori dbus-daemon[2165]: [system] Activating via systemd: service name='org.freedesktop.login1' unit='dbus-org.freedesktop.login1.service' requested by ':1.1' (uid=0 pid=2644 comm="/usr/sbin/l>
May 03 17:24:23 Arigatori dbus-daemon[2165]: [system] Failed to activate service 'org.freedesktop.login1': timed out (service_start_timeout=25000ms)
May 03 17:24:23 Arigatori dbus-daemon[2165]: [system] Activating via systemd: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' requested by ':1.1' (uid=0 pid=2644 comm="/usr/sbin/lightdm " l>
May 03 17:24:23 Arigatori dbus-daemon[2165]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.2' (uid=0 pid=2700 comm="/usr/libexec/accounts-daemon>
May 03 17:24:23 Arigatori dbus-daemon[2165]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
May 03 17:24:23 Arigatori dbus-daemon[2165]: [system] Successfully activated service 'org.freedesktop.Accounts'
May 03 17:24:23 Arigatori dbus-daemon[2165]: [system] Activating via systemd: service name='org.freedesktop.login1' unit='dbus-org.freedesktop.login1.service' requested by ':1.6' (uid=0 pid=2722 comm="lightdm --s>
May 03 17:24:40 Arigatori dbus-daemon[2165]: [system] Successfully activated service 'org.freedesktop.login1'
Raw
journalctl-eu-lightdm.txt
-- Reboot --
May 03 17:23:58 Arigatori systemd[1]: Starting Light Display Manager...
May 03 17:24:23 Arigatori lightdm[2644]: Failed to get list of logind seats: Timeout was reached
May 03 17:24:23 Arigatori systemd[1]: Started Light Display Manager.
May 03 17:24:23 Arigatori lightdm[2722]: pam_unix(lightdm-greeter:session): session opened for user root >
May 03 17:24:44 Arigatori lightdm[2768]: pam_unix(lightdm:session): session opened for user nedakinde by >
lines 995-1042/1042 (END)
Raw
journalctl-eu-systemd-logind.txt
-- Reboot --
May 03 17:23:10 Arigatori systemd[1]: Starting Login Service...
May 03 17:23:10 Arigatori systemd-logind[2162]: New seat seat0.
May 03 17:23:10 Arigatori systemd-logind[2162]: Watching system buttons on /dev/input/event2 (Power Button)
May 03 17:23:10 Arigatori systemd-logind[2162]: Watching system buttons on /dev/input/event0 (Power Button)
May 03 17:23:10 Arigatori systemd-logind[2162]: Watching system buttons on /dev/input/event1 (Sleep Button)
May 03 17:23:44 Arigatori systemd-logind[2162]: Watching system buttons on /dev/input/event4 (USB Keyboard)
May 03 17:23:44 Arigatori systemd-logind[2162]: Watching system buttons on /dev/input/event5 (USB Keyboard)
May 03 17:23:44 Arigatori systemd-logind[2162]: Watching system buttons on /dev/input/event3 (Topre Corporation RealForce Compact)
May 03 17:23:44 Arigatori systemd-logind[2162]: Watching system buttons on /dev/input/event7 (ELECOM TrackBall Mouse HUGE TrackBall)
May 03 17:24:40 Arigatori systemd[1]: systemd-logind.service: Start operation timed out. Terminating.
May 03 17:24:40 Arigatori systemd[1]: systemd-logind.service: Failed with result 'timeout'.
May 03 17:24:40 Arigatori systemd[1]: Failed to start Login Service.
May 03 17:24:40 Arigatori systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart.
May 03 17:24:40 Arigatori systemd[1]: systemd-logind.service: Scheduled restart job, restart counter is at 1.
May 03 17:24:40 Arigatori systemd[1]: Stopped Login Service.
May 03 17:24:40 Arigatori systemd[1]: Starting Login Service...
May 03 17:24:40 Arigatori systemd-logind[2733]: New seat seat0.
May 03 17:24:40 Arigatori systemd-logind[2733]: Watching system buttons on /dev/input/event2 (Power Button)
May 03 17:24:40 Arigatori systemd-logind[2733]: Watching system buttons on /dev/input/event0 (Power Button)
May 03 17:24:40 Arigatori systemd-logind[2733]: Watching system buttons on /dev/input/event1 (Sleep Button)
May 03 17:24:40 Arigatori systemd-logind[2733]: Watching system buttons on /dev/input/event4 (USB Keyboard)
May 03 17:24:40 Arigatori systemd-logind[2733]: Watching system buttons on /dev/input/event5 (USB Keyboard)
May 03 17:24:40 Arigatori systemd-logind[2733]: Watching system buttons on /dev/input/event3 (Topre Corporation RealForce Compact)
May 03 17:24:40 Arigatori systemd-logind[2733]: Watching system buttons on /dev/input/event7 (ELECOM TrackBall Mouse HUGE TrackBall)
May 03 17:24:40 Arigatori systemd[1]: Started Login Service.
May 03 17:24:40 Arigatori systemd-logind[2733]: New session 1 of user root.
May 03 17:24:44 Arigatori systemd-logind[2733]: Removed session 1.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment