Reply to topic

KDE rather slow to start

glepore70
Registered Member
Posts
30
Karma
0

Re: KDE rather slow to start

Thu Sep 20, 2012 7:31 pm
I upgraded to Quantal just to see if anything in there addressed this issue with no luck. I don't have keychain installed (nor a .bash_profile) so that can't be the problem. I am willing to test the startup sequence any way possible, but I need instructions.
User avatar bcooksley
Administrator
Posts
18657
Karma
83
OS

Re: KDE rather slow to start

Sun Sep 23, 2012 3:51 am
If possible, maybe try creating a bootchart of your specific KDE startup and post that here.
Please see https://wiki.archlinux.org/index.php/Bootchart for some information on it.


System Settings and Device Actions KCM maintainer
Image
glepore70
Registered Member
Posts
30
Karma
0

Re: KDE rather slow to start

Sun Sep 23, 2012 11:45 am
I've been looking at bootcharts of this problem for over a year, here is the most recent:
http://rhobard.com/bootchart.png
you can clearly see a long pause starting around 10 seconds. I've tried removing all plasmoids and unnecessary programs, but I've since re-added them because they did not affect the boot time. It's pretty clearly plasma-desktop.
Thanks for helping out!
User avatar bcooksley
Administrator
Posts
18657
Karma
83
OS

Re: KDE rather slow to start

Wed Sep 26, 2012 9:26 am
10 seconds sounds like a timeout - it certainly isn't interacting with disk.
Would it be possible for you to try attaching a debugger inside that small time window using a virtual terminal and generating a backtrace to see what it is doing?

I'm assuming this bootchart was generated with cold disk caches.


System Settings and Device Actions KCM maintainer
Image
glepore70
Registered Member
Posts
30
Karma
0

Re: KDE rather slow to start

Wed Sep 26, 2012 11:46 am
If there are instructions out there that I can follow I will try what you suggest. I'd really like to get this solved. I've never done any debugging with virtual terminals.
User avatar bcooksley
Administrator
Posts
18657
Karma
83
OS

Re: KDE rather slow to start

Wed Sep 26, 2012 9:01 pm
You should be able to attach gdb to Plasma by running:
Code: Select all
gdb -p `pidof plasma-desktop`


When it starts, it should stop plasma-desktop from processing anything further. You can get a full backtrace by running:
Code: Select all
thread apply all bt


Not sure how easy it will be to copy + paste that however... (I think gdb is able to write backtraces to files though, not sure how to though).


System Settings and Device Actions KCM maintainer
Image
glepore70
Registered Member
Posts
30
Karma
0

Re: KDE rather slow to start

Thu Sep 27, 2012 12:58 pm
Here's what I did, I hope it's correct. I rebooted the computer and as soon as the KDE splashscreen came up, I entered a virtual terminal and started gdb against plasma-desktop. After it finished loading the symbols I sent the output to a text file with "set logging on", then I did "thread apply all bt". It sent the output to the screen for the first 5 threads, then paused. I typed "continue" and it sent out a bit more on newer threads. The results are below.

Code: Select all
Thread 5 (Thread 0x7f1f4318f700 (LWP 1705)):
#0  pthread_cond_wait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162
#1  0x00007f1f70daccd7 in ?? () from /usr/lib/x86_64-linux-gnu/libQtScript.so.4
#2  0x00007f1f70dacd09 in ?? () from /usr/lib/x86_64-linux-gnu/libQtScript.so.4
#3  0x00007f1f6867d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#4  0x00007f1f6b446e9a in start_thread (arg=0x7f1f4318f700) at pthread_create.c:308
#5  0x00007f1f770ab39d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#6  0x0000000000000000 in ?? ()

Thread 4 (Thread 0x7f1f36f86700 (LWP 1706)):
#0  0x00007f1f7709f9e3 in __GI___poll (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:87
#1  0x00007f1f6ad47e84 in ?? () from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#2  0x00007f1f6ad47fa4 in g_main_context_iteration () from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#3  0x00007f1f73d55bf6 in QEventDispatcherGlib::processEvents (this=0x7f1f300008f0, flags=...) at kernel/qeventdispatcher_glib.cpp:424
#4  0x00007f1f73d262bf in QEventLoop::processEvents (this=this@entry=0x7f1f36f85cd0, flags=...) at kernel/qeventloop.cpp:149
#5  0x00007f1f73d26548 in QEventLoop::exec (this=0x7f1f36f85cd0, flags=...) at kernel/qeventloop.cpp:204
#6  0x00007f1f73c27b10 in QThread::exec (this=<optimized out>) at thread/qthread.cpp:501
#7  0x00007f1f73d069af in QInotifyFileSystemWatcherEngine::run (this=0x3dce5d0) at io/qfilesystemwatcher_inotify.cpp:248
#8  0x00007f1f73c2aaec in QThreadPrivate::start (arg=0x3dce5d0) at thread/qthread_unix.cpp:338
#9  0x00007f1f6867d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#10 0x00007f1f6b446e9a in start_thread (arg=0x7f1f36f86700) at pthread_create.c:308
#11 0x00007f1f770ab39d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#12 0x0000000000000000 in ?? ()

Thread 3 (Thread 0x7f1f360bd700 (LWP 1707)):
#0  0x00007f1f7709f9e3 in __GI___poll (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:87
#1  0x00007f1f6ad47e84 in ?? () from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#2  0x00007f1f6ad47fa4 in g_main_context_iteration () from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#3  0x00007f1f73d55c16 in QEventDispatcherGlib::processEvents (this=0x7f1f280008f0, flags=...) at kernel/qeventdispatcher_glib.cpp:426
#4  0x00007f1f73d262bf in QEventLoop::processEvents (this=this@entry=0x7f1f360bccd0, flags=...) at kernel/qeventloop.cpp:149
#5  0x00007f1f73d26548 in QEventLoop::exec (this=0x7f1f360bccd0, flags=...) at kernel/qeventloop.cpp:204
#6  0x00007f1f73c27b10 in QThread::exec (this=<optimized out>) at thread/qthread.cpp:501
#7  0x00007f1f73d069af in QInotifyFileSystemWatcherEngine::run (this=0x4263da0) at io/qfilesystemwatcher_inotify.cpp:248
#8  0x00007f1f73c2aaec in QThreadPrivate::start (arg=0x4263da0) at thread/qthread_unix.cpp:338
#9  0x00007f1f6867d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#10 0x00007f1f6b446e9a in start_thread (arg=0x7f1f360bd700) at pthread_create.c:308
#11 0x00007f1f770ab39d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#12 0x0000000000000000 in ?? ()

Thread 2 (Thread 0x7f1f2ffff700 (LWP 1816)):
#0  0x00007f1f770a4703 in select () at ../sysdeps/unix/syscall-template.S:82
#1  0x00007f1f73d05fe2 in QProcessManager::run (this=0x7f1f7407f520 <processManager()::processManager>) at io/qprocess_unix.cpp:245
#2  0x00007f1f73c2aaec in QThreadPrivate::start (arg=0x7f1f7407f520 <processManager()::processManager>) at thread/qthread_unix.cpp:338
#3  0x00007f1f6867d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#4  0x00007f1f6b446e9a in start_thread (arg=0x7f1f2ffff700) at pthread_create.c:308
#5  0x00007f1f770ab39d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#6  0x0000000000000000 in ?? ()

Thread 1 (Thread 0x7f1f777ba7c0 (LWP 1657)):
#0  0x00007f1f7709f9e3 in __GI___poll (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:87
#1  0x00007f1f6ad47e84 in ?? () from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#2  0x00007f1f6ad47fa4 in g_main_context_iteration () from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#3  0x00007f1f73d55bf6 in QEventDispatcherGlib::processEvents (this=0x2398ad0, flags=...) at kernel/qeventdispatcher_glib.cpp:424
#4  0x00007f1f73173c1e in QGuiEventDispatcherGlib::processEvents (this=<optimized out>, flags=...) at kernel/qguieventdispatcher_glib.cpp:204
#5  0x00007f1f73d262bf in QEventLoop::processEvents (this=this@entry=0x7fff09ec5570, flags=...) at kernel/qeventloop.cpp:149
#6  0x00007f1f73d26548 in QEventLoop::exec (this=0x7fff09ec5570, flags=...) at kernel/qeventloop.cpp:204
#7  0x00007f1f73d2b708 in QCoreApplication::exec () at kernel/qcoreapplication.cpp:1187
#8  0x00007f1f773b0fe5 in kdemain (argc=1, argv=0x7fff09ec5868) at ../../../../plasma/desktop/shell/main.cpp:120
#9  0x00007f1f76fda76d in __libc_start_main (main=0x4006a0 <main(int, char**)>, argc=1, ubp_av=0x7fff09ec5868, init=<optimized out>,
    fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7fff09ec5858) at libc-start.c:226
#10 0x00000000004006d1 in _start ()
Undefined command: "exit".  Try "help".
A debugging session is active.

   Inferior 1 [process 1657] will be detached.

Quit anyway? (y or n) Detaching from program: /usr/bin/plasma-desktop, process 1657

Thread 1 (Thread 0x7f3684c5a7c0 (LWP 1638)):
#0  0x00007f368453f9a8 in __GI___poll (fds=0x7fff73790990, nfds=1,
    timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:83
#1  0x00007f36784bb3d0 in ?? () from /lib/x86_64-linux-gnu/libdbus-1.so.3
#2  0x00007f36784ba29d in ?? () from /lib/x86_64-linux-gnu/libdbus-1.so.3
#3  0x00007f36784a4fa4 in ?? () from /lib/x86_64-linux-gnu/libdbus-1.so.3
#4  0x00007f36784a634d in ?? () from /lib/x86_64-linux-gnu/libdbus-1.so.3
#5  0x00007f36784a574c in dbus_connection_send_with_reply_and_block ()
   from /lib/x86_64-linux-gnu/libdbus-1.so.3
#6  0x00007f3681546da3 in q_dbus_connection_send_with_reply_and_block (
    error=0x7fff73790ce0, timeout_milliseconds=-1, message=0x21d55f0,
    connection=<optimized out>) at qdbus_symbols_p.h:135
#7  QDBusConnectionPrivate::sendWithReply (this=0x2366980, message=...,
    sendMode=1, timeout=-1) at qdbusintegrator.cpp:1904
#8  0x00007f36815347fb in QDBusConnection::call (this=0x236fdc8, message=...,
    mode=<optimized out>, timeout=<optimized out>) at qdbusconnection.cpp:597
#9  0x00007f3681553d96 in QDBusAbstractInterface::callWithArgumentList (
    this=0x7fff73790ff0, mode=QDBus::Block, method=..., args=...)
    at qdbusabstractinterface.cpp:468
#10 0x00007f367d6ed535 in ServiceBrowserNew (flags=0, domain=..., type=...,
    protocol=-1, interface=-1, this=0x7fff73790ff0)
    at ../../dnssd/avahi_server_interface.h:208
#11 DNSSD::ServiceBrowser::startBrowse (this=0x23599c0)
    at ../../dnssd/avahi-servicebrowser.cpp:66
#12 0x00007f36840e2ce0 in Plasma::AccessManagerPrivate::AccessManagerPrivate (
    this=0x236ae60, manager=<optimized out>)
    at ../../plasma/remote/accessmanager.cpp:113
#13 0x00007f36840e2d26 in Plasma::AccessManager::AccessManager (this=0x23541a0)
    at ../../plasma/remote/accessmanager.cpp:61
#14 0x00007f36840e2ee2 in AccessManagerSingleton (this=<optimized out>)
    at ../../plasma/remote/accessmanager.cpp:46
#15 operator-> (this=<optimized out>)
    at ../../plasma/remote/accessmanager.cpp:52
#16 Plasma::AccessManager::self () at ../../plasma/remote/accessmanager.cpp:56
#17 0x00007f3684867514 in PlasmaApp::PlasmaApp (this=0x21cf530)
    at ../../../../plasma/desktop/shell/plasmaapp.cpp:274
#18 0x00007f3684867907 in PlasmaApp::self ()
    at ../../../../plasma/desktop/shell/plasmaapp.cpp:107
#19 0x00007f3684850f6e in kdemain (argc=1, argv=0x7fff73791538)
    at ../../../../plasma/desktop/shell/main.cpp:116
#20 0x00007f368447a76d in __libc_start_main (main=
    0x4006a0 <main(int, char**)>, argc=1, ubp_av=0x7fff73791538,
    init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>,
    stack_end=0x7fff73791528) at libc-start.c:226
#21 0x00000000004006d1 in _start ()
The program being debugged has been started already.
Start it from the beginning? (y or n) Program not restarted.
Continuing.
[New Thread 0x7f3660498700 (LWP 1938)]
[New Thread 0x7f365fc97700 (LWP 1939)]
[New Thread 0x7f365f496700 (LWP 1940)]
[New Thread 0x7f365ec95700 (LWP 1941)]
[New Thread 0x7f364ffff700 (LWP 1946)]
[New Thread 0x7f364d4ab700 (LWP 1947)]
[New Thread 0x7f3642f86700 (LWP 1948)]
[New Thread 0x7f36415fc700 (LWP 2050)]

Program received signal SIGINT, Interrupt.
0x00007f368453f9e3 in __GI___poll (fds=<optimized out>, nfds=<optimized out>,
    timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:87
87   in ../sysdeps/unix/sysv/linux/poll.c

Thread 9 (Thread 0x7f36415fc700 (LWP 2050)):
#0  0x00007f3684544703 in select () at ../sysdeps/unix/syscall-template.S:82
#1  0x00007f36811a5fe2 in QProcessManager::run (
    this=0x7f368151f520 <processManager()::processManager>)
    at io/qprocess_unix.cpp:245
#2  0x00007f36810caaec in QThreadPrivate::start (
    arg=0x7f368151f520 <processManager()::processManager>)
    at thread/qthread_unix.cpp:338
#3  0x00007f3675b1d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#4  0x00007f36788e6e9a in start_thread (arg=0x7f36415fc700)
    at pthread_create.c:308
#5  0x00007f368454b39d in clone ()
    at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#6  0x0000000000000000 in ?? ()

Thread 8 (Thread 0x7f3642f86700 (LWP 1948)):
#0  0x00007f368453f9e3 in __GI___poll (fds=<optimized out>,
    nfds=<optimized out>, timeout=<optimized out>)
    at ../sysdeps/unix/sysv/linux/poll.c:87
#1  0x00007f36781e7e84 in ?? () from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#2  0x00007f36781e7fa4 in g_main_context_iteration ()
   from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#3  0x00007f36811f5c16 in QEventDispatcherGlib::processEvents (this=
    0x7f36340008f0, flags=...) at kernel/qeventdispatcher_glib.cpp:426
#4  0x00007f36811c62bf in QEventLoop::processEvents (this=this@entry=
    0x7f3642f85cd0, flags=...) at kernel/qeventloop.cpp:149
#5  0x00007f36811c6548 in QEventLoop::exec (this=0x7f3642f85cd0, flags=...)
    at kernel/qeventloop.cpp:204
#6  0x00007f36810c7b10 in QThread::exec (this=<optimized out>)
    at thread/qthread.cpp:501
#7  0x00007f36811a69af in QInotifyFileSystemWatcherEngine::run (this=0x3a5c420)
    at io/qfilesystemwatcher_inotify.cpp:248
#8  0x00007f36810caaec in QThreadPrivate::start (arg=0x3a5c420)
    at thread/qthread_unix.cpp:338
#9  0x00007f3675b1d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#10 0x00007f36788e6e9a in start_thread (arg=0x7f3642f86700)
    at pthread_create.c:308
#11 0x00007f368454b39d in clone ()
    at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#12 0x0000000000000000 in ?? ()

Thread 7 (Thread 0x7f364d4ab700 (LWP 1947)):
#0  0x00007f368453f9e3 in __GI___poll (fds=<optimized out>,
    nfds=<optimized out>, timeout=<optimized out>)
    at ../sysdeps/unix/sysv/linux/poll.c:87
#1  0x00007f36781e7e84 in ?? () from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#2  0x00007f36781e7fa4 in g_main_context_iteration ()
   from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#3  0x00007f36811f5c16 in QEventDispatcherGlib::processEvents (
    this=0x7f363c0008f0, flags=...) at kernel/qeventdispatcher_glib.cpp:426
#4  0x00007f36811c62bf in QEventLoop::processEvents (
    this=this@entry=0x7f364d4aacd0, flags=...) at kernel/qeventloop.cpp:149
#5  0x00007f36811c6548 in QEventLoop::exec (this=0x7f364d4aacd0, flags=...)
    at kernel/qeventloop.cpp:204
#6  0x00007f36810c7b10 in QThread::exec (this=<optimized out>)
    at thread/qthread.cpp:501
#7  0x00007f36811a69af in QInotifyFileSystemWatcherEngine::run (this=0x3b28320)
    at io/qfilesystemwatcher_inotify.cpp:248
#8  0x00007f36810caaec in QThreadPrivate::start (arg=0x3b28320)
    at thread/qthread_unix.cpp:338
#9  0x00007f3675b1d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#10 0x00007f36788e6e9a in start_thread (arg=0x7f364d4ab700)
    at pthread_create.c:308
#11 0x00007f368454b39d in clone ()
    at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#12 0x0000000000000000 in ?? ()

Thread 6 (Thread 0x7f364ffff700 (LWP 1946)):
#0  pthread_cond_wait@@GLIBC_2.3.2 ()
    at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_wait.S:162
#1  0x00007f367e24ccd7 in ?? () from /usr/lib/x86_64-linux-gnu/libQtScript.so.4
#2  0x00007f367e24cd09 in ?? () from /usr/lib/x86_64-linux-gnu/libQtScript.so.4
#3  0x00007f3675b1d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#4  0x00007f36788e6e9a in start_thread (arg=0x7f364ffff700)
    at pthread_create.c:308
#5  0x00007f368454b39d in clone ()
    at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#6  0x0000000000000000 in ?? ()

Thread 5 (Thread 0x7f365ec95700 (LWP 1941)):
#0  pthread_cond_timedwait@@GLIBC_2.3.2 ()
    at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:215
#1  0x00007f36810cafa7 in wait (time=30000, this=0x2d48f00)
    at thread/qwaitcondition_unix.cpp:84
#2  QWaitCondition::wait (this=<optimized out>, mutex=0x238ec18, time=30000)
    at thread/qwaitcondition_unix.cpp:158
#3  0x00007f36810be54f in QThreadPoolThread::run (this=0x21e1940)
    at concurrent/qthreadpool.cpp:141
#4  0x00007f36810caaec in QThreadPrivate::start (arg=0x21e1940)
    at thread/qthread_unix.cpp:338
#5  0x00007f3675b1d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#6  0x00007f36788e6e9a in start_thread (arg=0x7f365ec95700)
    at pthread_create.c:308
#7  0x00007f368454b39d in clone ()
    at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#8  0x0000000000000000 in ?? ()

Thread 4 (Thread 0x7f365f496700 (LWP 1940)):
#0  pthread_cond_timedwait@@GLIBC_2.3.2 ()
    at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:215
#1  0x00007f36810cafa7 in wait (time=30000, this=0x2d48f00)
    at thread/qwaitcondition_unix.cpp:84
#2  QWaitCondition::wait (this=<optimized out>, mutex=0x238ec18, time=30000)
    at thread/qwaitcondition_unix.cpp:158
#3  0x00007f36810be54f in QThreadPoolThread::run (this=0x21e2f10)
    at concurrent/qthreadpool.cpp:141
#4  0x00007f36810caaec in QThreadPrivate::start (arg=0x21e2f10)
    at thread/qthread_unix.cpp:338
#5  0x00007f3675b1d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#6  0x00007f36788e6e9a in start_thread (arg=0x7f365f496700)
    at pthread_create.c:308
#7  0x00007f368454b39d in clone ()
    at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#8  0x0000000000000000 in ?? ()

Thread 3 (Thread 0x7f365fc97700 (LWP 1939)):
#0  pthread_cond_timedwait@@GLIBC_2.3.2 ()
    at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:215
#1  0x00007f36810cafa7 in wait (time=30000, this=0x2d48f00)
    at thread/qwaitcondition_unix.cpp:84
#2  QWaitCondition::wait (this=<optimized out>, mutex=0x238ec18, time=30000)
    at thread/qwaitcondition_unix.cpp:158
#3  0x00007f36810be54f in QThreadPoolThread::run (this=0x2166dc0)
    at concurrent/qthreadpool.cpp:141
#4  0x00007f36810caaec in QThreadPrivate::start (arg=0x2166dc0)
    at thread/qthread_unix.cpp:338
#5  0x00007f3675b1d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#6  0x00007f36788e6e9a in start_thread (arg=0x7f365fc97700)
    at pthread_create.c:308
#7  0x00007f368454b39d in clone ()
    at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#8  0x0000000000000000 in ?? ()

Thread 2 (Thread 0x7f3660498700 (LWP 1938)):
#0  pthread_cond_timedwait@@GLIBC_2.3.2 ()
    at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:215
#1  0x00007f36810cafa7 in wait (time=30000, this=0x2d48f00)
    at thread/qwaitcondition_unix.cpp:84
#2  QWaitCondition::wait (this=<optimized out>, mutex=0x238ec18, time=30000)
    at thread/qwaitcondition_unix.cpp:158
#3  0x00007f36810be54f in QThreadPoolThread::run (this=0x238e8a0)
    at concurrent/qthreadpool.cpp:141
#4  0x00007f36810caaec in QThreadPrivate::start (arg=0x238e8a0)
    at thread/qthread_unix.cpp:338
#5  0x00007f3675b1d734 in ?? () from /usr/lib/nvidia-current/libGL.so.1
#6  0x00007f36788e6e9a in start_thread (arg=0x7f3660498700)
    at pthread_create.c:308
#7  0x00007f368454b39d in clone ()
    at ../sysdeps/unix/sysv/linux/x86_64/clone.S:112
#8  0x0000000000000000 in ?? ()

Thread 1 (Thread 0x7f3684c5a7c0 (LWP 1638)):
#0  0x00007f368453f9e3 in __GI___poll (fds=<optimized out>,
    nfds=<optimized out>, timeout=<optimized out>)
    at ../sysdeps/unix/sysv/linux/poll.c:87
#1  0x00007f36781e7e84 in ?? () from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#2  0x00007f36781e7fa4 in g_main_context_iteration ()
   from /lib/x86_64-linux-gnu/libglib-2.0.so.0
#3  0x00007f36811f5bf6 in QEventDispatcherGlib::processEvents (this=0x20f2ad0,
    flags=...) at kernel/qeventdispatcher_glib.cpp:424
#4  0x00007f3680613c1e in QGuiEventDispatcherGlib::processEvents (
    this=<optimized out>, flags=...) at kernel/qguieventdispatcher_glib.cpp:204
#5  0x00007f36811c62bf in QEventLoop::processEvents (
    this=this@entry=0x7fff73791240, flags=...) at kernel/qeventloop.cpp:149
#6  0x00007f36811c6548 in QEventLoop::exec (this=0x7fff73791240, flags=...)
    at kernel/qeventloop.cpp:204
#7  0x00007f36811cb708 in QCoreApplication::exec ()
    at kernel/qcoreapplication.cpp:1187
#8  0x00007f3684850fe5 in kdemain (argc=1, argv=0x7fff73791538)
    at ../../../../plasma/desktop/shell/main.cpp:120
#9  0x00007f368447a76d in __libc_start_main (
    main=0x4006a0 <main(int, char**)>, argc=1, ubp_av=0x7fff73791538,
    init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>,
    stack_end=0x7fff73791528) at libc-start.c:226
#10 0x00000000004006d1 in _start ()
A debugging session is active.

   Inferior 1 [process 1638] will be detached.

Quit anyway? (y or n) Detaching from program: /usr/bin/plasma-desktop, process 1638
lamarque
Registered Member
Posts
150
Karma
2
OS

Re: KDE rather slow to start

Fri Sep 28, 2012 11:36 am
I am not sure what I am about to say is the cause of the slow startup but kdelibs/dnssd/avahi_server_interface.h was created using synchronous QtDBus API, which can lead to problems like this one. I think we must update kdelibs/dnssd/avahi_server_interface.h using qdbusxml2cpp to avoid the synchronous QtDBus API. avahi_server_interface.h has not been updated for quite some time (since 2009) and was created using an old command (dbusxml2cpp, which is even older, from 2006).


Software engineer at Petrobrás http://www.petrobras.com.br/en/about-us/
KDE's Network Management maintainer
virgilsebirot
Registered Member
Posts
1
Karma
0

Re: KDE rather slow to start

Sat Nov 03, 2012 7:38 pm
I was also affected by this problem, but my latest update got me rid of it.

Here's my pacman log, maybe it can help...

Code: Select all
[2012-10-31 17:11] Running 'pacman -Sy'
[2012-10-31 17:11] synchronizing package lists
[2012-10-31 17:11] Running 'pacman -S -u'
[2012-10-31 17:11] starting full system upgrade
[2012-10-31 17:19] upgraded glib2 (2.32.4-1 -> 2.34.1-1)
[2012-10-31 17:19] upgraded atk (2.4.0-1 -> 2.6.0-1)
[2012-10-31 17:19] upgraded linux-api-headers (3.5.5-1 -> 3.6.3-1)
[2012-10-31 17:19] upgraded tzdata (2012g-1 -> 2012h-1)
[2012-10-31 17:19] Generating locales...
[2012-10-31 17:19]   fr_FR.UTF-8... done
[2012-10-31 17:19]   fr_FR.ISO-8859-1... done
[2012-10-31 17:19]   fr_FR.ISO-8859-15@euro... done
[2012-10-31 17:19] Generation complete.
[2012-10-31 17:19] upgraded glibc (2.16.0-4 -> 2.16.0-5)
[2012-10-31 17:19] upgraded avr-binutils (2.22-3 -> 2.23-1)
[2012-10-31 17:19] upgraded binutils (2.22-10 -> 2.23-1)
[2012-10-31 17:19] upgraded bison (2.6.2-1 -> 2.6.4-1)
[2012-10-31 17:19] upgraded cairo (1.12.2-3 -> 1.12.6-2)
[2012-10-31 17:19] upgraded hwids (20121012-1 -> 20121022-1)
[2012-10-31 17:19] upgraded coreutils (8.19-1 -> 8.20-1)
[2012-10-31 17:19] upgraded util-linux (2.22.1-1 -> 2.22.1-2)
[2012-10-31 17:19] upgraded systemd (194-4 -> 195-2)
[2012-10-31 17:19] upgraded nspr (4.9.2-1 -> 4.9.3-1)
[2012-10-31 17:19] upgraded gcc-libs (4.7.2-1 -> 4.7.2-2)
[2012-10-31 17:19] installed js (1.8.5-3)
[2012-10-31 17:19] upgraded polkit (0.105-1 -> 0.107-4)
[2012-10-31 17:19] upgraded colord (0.1.21-2 -> 0.1.24-1)
[2012-10-31 17:19] upgraded device-mapper (2.02.97-1 -> 2.02.98-1)
[2012-10-31 17:19] upgraded cryptsetup (1.5.0-2 -> 1.5.1-1)
[2012-10-31 17:19] upgraded e2fsprogs (1.42.5-1 -> 1.42.6-1)
[2012-10-31 17:19] installed gstreamer (1.0.2-1)
[2012-10-31 17:19] installed gst-plugins-base-libs (1.0.2-1)
[2012-10-31 17:19] upgraded libnice (0.1.2-1 -> 0.1.3-1)
[2012-10-31 17:19] upgraded farstream (0.1.2-1 -> 0.2.1-1)
[2012-10-31 17:19] upgraded nss (3.13.6-1 -> 3.14-1)
[2012-10-31 17:19] upgraded firefox (16.0.1-1 -> 16.0.2-1)
[2012-10-31 17:19] upgraded firefox-i18n-fr (16.0.1-1 -> 16.0.2-1)
[2012-10-31 17:19] upgraded gcc (4.7.2-1 -> 4.7.2-2)
[2012-10-31 17:19] upgraded gdk-pixbuf2 (2.26.3-1 -> 2.26.4-1)
[2012-10-31 17:19] upgraded gegl (0.2.0-4 -> 0.2.0-5)
[2012-10-31 17:19] upgraded libtasn1 (2.14-1 -> 3.0-1)
[2012-10-31 17:19] upgraded gnutls (3.1.3-1 -> 3.1.3-2)
[2012-10-31 17:19] upgraded gpm (1.20.6-10 -> 1.20.7-1)
[2012-10-31 17:19] upgraded ilmbase (1.0.2-1 -> 1.0.3-1)
[2012-10-31 17:19] installed iptables (1.4.16.2-1)
[2012-10-31 17:19] upgraded iproute2 (3.5.1-1 -> 3.6.0-2)
[2012-10-31 17:19] upgraded libxklavier (5.2.1-2 -> 5.3-1)
[2012-10-31 17:19] warning: /usr/share/config/kdm/kdmrc installed as /usr/share/config/kdm/kdmrc.pacnew
[2012-10-31 17:19] upgraded kdebase-workspace (4.9.2-4 -> 4.9.2-6)
[2012-10-31 17:19] upgraded openexr (1.7.1-1 -> 1.7.1-2)
[2012-10-31 17:19] upgraded phonon (1:4.6.0-2 -> 1:4.6.0-3)
[2012-10-31 17:19] upgraded kdelibs (4.9.2-2 -> 4.9.2-3)
[2012-10-31 17:19] upgraded kdeplasma-addons-applets-rssnow (4.9.2-1 -> 4.9.2-3)
[2012-10-31 17:19] upgraded lib32-glibc (2.16.0-4 -> 2.16.0-5)
[2012-10-31 17:19] upgraded libcanberra (0.28-5 -> 0.30-1)
[2012-10-31 17:19] upgraded libcroco (0.6.5-1 -> 0.6.8-1)
[2012-10-31 17:19] installed harfbuzz (0.9.5-1)
[2012-10-31 17:19] upgraded pango (1.30.1-1 -> 1.32.1-1)
[2012-10-31 17:19] upgraded librsvg (2.36.3-1 -> 2.36.4-1)
[2012-10-31 17:19] upgraded libwbclient (3.6.8-1 -> 3.6.9-1)
[2012-10-31 17:19] upgraded mkinitcpio (0.10-1 -> 0.11.0-1)
[2012-10-31 17:19] >>> Updating module dependencies. Please wait ...
[2012-10-31 17:19] >>> Generating initial ramdisk, using mkinitcpio.  Please wait...
[2012-10-31 17:19] ==> Building image from preset: 'default'
[2012-10-31 17:19]   -> -k /boot/vmlinuz-linux -c /etc/mkinitcpio.conf -g /boot/initramfs-linux.img
[2012-10-31 17:19] ==> Starting build: 3.6.4-1-ARCH
[2012-10-31 17:19]   -> Running build hook: [base]
[2012-10-31 17:19]   -> Running build hook: [udev]
[2012-10-31 17:19]   -> Running build hook: [autodetect]
[2012-10-31 17:19]   -> Running build hook: [pata]
[2012-10-31 17:19]   -> Running build hook: [scsi]
[2012-10-31 17:19]   -> Running build hook: [sata]
[2012-10-31 17:19]   -> Running build hook: [filesystems]
[2012-10-31 17:19]   -> Running build hook: [usbinput]
[2012-10-31 17:19]   -> Running build hook: [fsck]
[2012-10-31 17:19] ==> Generating module dependencies
[2012-10-31 17:19] ==> Creating lzma initcpio image: /boot/initramfs-linux.img
[2012-10-31 17:19] ==> Image generation successful
[2012-10-31 17:19] ==> Building image from preset: 'fallback'
[2012-10-31 17:19]   -> -k /boot/vmlinuz-linux -c /etc/mkinitcpio.conf -g /boot/initramfs-linux-fallback.img -S autodetect
[2012-10-31 17:19] ==> Starting build: 3.6.4-1-ARCH
[2012-10-31 17:19]   -> Running build hook: [base]
[2012-10-31 17:19]   -> Running build hook: [udev]
[2012-10-31 17:19]   -> Running build hook: [pata]
[2012-10-31 17:19]   -> Running build hook: [scsi]
[2012-10-31 17:19]   -> Running build hook: [sata]
[2012-10-31 17:19]   -> Running build hook: [filesystems]
[2012-10-31 17:19]   -> Running build hook: [usbinput]
[2012-10-31 17:19]   -> Running build hook: [fsck]
[2012-10-31 17:19] ==> Generating module dependencies
[2012-10-31 17:19] ==> Creating lzma initcpio image: /boot/initramfs-linux-fallback.img
[2012-10-31 17:20] ==> Image generation successful
[2012-10-31 17:20] upgraded linux (3.6.3-1 -> 3.6.4-1)
[2012-10-31 17:20] upgraded lirc-utils (1:0.9.0-33 -> 1:0.9.0-34)
[2012-10-31 17:20] upgraded lvm2 (2.02.97-1 -> 2.02.98-1)
[2012-10-31 17:20] upgraded mdadm (3.2.5-2 -> 3.2.6-1)
[2012-10-31 17:20] upgraded package-query (1.1-1 -> 1.1-2)
[2012-10-31 17:20] upgraded perl (5.16.1-1 -> 5.16.1-2)
[2012-10-31 17:20] upgraded smbclient (3.6.8-1 -> 3.6.9-1)
[2012-10-31 17:20] Syslinux update successful
[2012-10-31 17:20] upgraded syslinux (4.05-7 -> 4.06-1)
[2012-10-31 17:20] upgraded telepathy-glib (0.18.2-1 -> 0.20.0-1)
[2012-10-31 17:20] upgraded telepathy-farstream (0.4.0-1 -> 0.6.0-1)
[2012-10-31 17:20] upgraded wget (1.14-1 -> 1.14-2)
[2012-10-31 17:20] installed lib32-libice (1.0.8-1)
[2012-10-31 17:20] installed lib32-util-linux (2.22.1-1)
[2012-10-31 17:20] installed lib32-libsm (1.2.1-1)
[2012-10-31 17:20] upgraded wine (1.5.15-1 -> 1.5.16-1)
[2012-10-31 17:20] upgraded xorg-xinit (1.3.2-1 -> 1.3.2-3)
[2012-10-31 17:20] upgraded xterm (285-1 -> 286-1)
[2012-10-31 17:20] upgraded yaourt (1.1-1 -> 1.2.1-1)
[2012-10-31 17:25] Running 'pacman -Rcsn yaourt -Qqdt'
[2012-10-31 17:26] Running 'pacman -Rs automoc4 cmake consolekit git gstreamer0.10-bad-plugins gstreamer0.10-ffmpeg gstreamer0.10-good lib32-mesa rpmextract ttf-freefont wget'
[2012-10-31 17:27] removed wget (1.14-2)
[2012-10-31 17:27] removed ttf-freefont (20120503-1)
[2012-10-31 17:27] removed rpmextract (1.0-5)
[2012-10-31 17:27] removed lib32-mesa (9.0-1)
[2012-10-31 17:27] removed mesa (9.0-1)
[2012-10-31 17:27] removed gstreamer0.10-good (0.10.31-1)
[2012-10-31 17:27] removed gstreamer0.10-ffmpeg (0.10.13-1)
[2012-10-31 17:27] Aucun fichier schéma trouvé : fichier de sortie existant supprimé.
[2012-10-31 17:27] removed gstreamer0.10-bad-plugins (0.10.23-3)
[2012-10-31 17:27] removed wildmidi (0.2.3.5-2)
[2012-10-31 17:27] removed soundtouch (1.6.0-1)
[2012-10-31 17:27] removed opus (1.0.1-2)
[2012-10-31 17:27] removed musicbrainz (2.1.5-5)
[2012-10-31 17:27] removed mjpegtools (2.0.0-2)
[2012-10-31 17:27] removed libdv (1.0.0-4)
[2012-10-31 17:27] removed libofa (0.9.3-4)
[2012-10-31 17:27] removed fftw (3.3.2-1)
[2012-10-31 17:27] removed liblrdf (0.5.0-1)
[2012-10-31 17:27] removed ladspa (1.13-4)
[2012-10-31 17:27] removed libgme (0.6.0-2)
[2012-10-31 17:27] removed libdc1394 (2.1.3-2)
[2012-10-31 17:27] removed libcdaudio (0.99.12-6)
[2012-10-31 17:27] removed gstreamer0.10-bad (0.10.23-3)
[2012-10-31 17:27] removed git (1.8.0-1)
[2012-10-31 17:27] removed perl-error (0.17018-1)
[2012-10-31 17:27] removed consolekit (0.4.6-4)
[2012-10-31 17:27] removed cmake (2.8.9-1)
[2012-10-31 17:27] removed automoc4 (0.9.88-3)
User avatar sylvainsjc
Registered Member
Posts
22
Karma
0
OS

Re: KDE rather slow to start

Tue Jan 15, 2013 1:16 pm
Hi,
One of the reasons responsible of slowness KDE session start is a bug Pulseaudio.

I wrote an article on my blog here : http://linuxadvantage.blogspot.fr/2013/ ... audio.html
The relative KDE bug : https://bugs.kde.org/show_bug.cgi?id=312560
The relative pulseaudio bug : https://bugs.freedesktop.org/show_bug.cgi?id=58758
glepore70
Registered Member
Posts
30
Karma
0

Re: KDE rather slow to start

Thu Feb 28, 2013 6:18 pm
I keep coming back to this thread, since the problem hasn't been solved or addressed by any recent updates. Today I ssh'ed into my machine while it was sitting for 30 seconds at the K logo on the splashscreen and absolutely nothing was happening! I used htop to show processes, sorted by CPU use and nothing much was going on, just the usual stuff, nothing using more than 1% of CPU. The 30 second pause started before plasma-desktop appeared in the listing, and plasma-desktop continued until after I finally got the desktop (occasionally using tons of CPU).

My question is - how do I track down a 30 second period of inaction, when nothing is happening? What log do I look at, what program do I run to examine that inactivity, what configuration file do I examine?

I tune my system quite a bit, removing cruft, etc. and I installed a fast SSD, but for over a year my KDE boot has taken close to 45 seconds, instead of the 10-15 seconds before. I realize it's not that big a deal, it's just annoying that there doesn't seem to be any way of debugging the problem.
User avatar toad
Global Moderator
Posts
876
Karma
6
OS

Re: KDE rather slow to start

Fri Mar 01, 2013 8:30 am
Have you also checked iotop during the lag? If it is down to the disk e4rat will help your cause enormously.


Sid
glepore70
Registered Member
Posts
30
Karma
0

Re: KDE rather slow to start

Fri Mar 01, 2013 12:26 pm
I'm using EXT4, but on an SSD, so e4rat wouldn't help. I used iotop --only during the boot and nothing is doing any disk reading of note. There were a couple of brief blips on the output, but no sustained read/writes. That tallies with my bootchart (http://rhobard.com/bootchart.png) which also shows very little disk access during the long pause.

Still at a loss.
User avatar bcooksley
Administrator
Posts
18657
Karma
83
OS

Re: KDE rather slow to start

Sat Mar 02, 2013 3:38 am
Based on the massive pause (and the sudden start/stop of plasma-desktop's use of the system) during the startup process, it may be worthwhile attaching a debugger to Plasma during this time and generating a full backtrace.

The '30 seconds' you mention is suspiciously similar to the default D-Bus timeout - which is also 30 seconds...


System Settings and Device Actions KCM maintainer
Image
glepore70
Registered Member
Posts
30
Karma
0

Re: KDE rather slow to start

Sat Mar 02, 2013 10:00 am
My gdb results are further up the thread... if I did them correctly.

 
Reply to topic

Bookmarks



Who is online

Registered users: 16777216, Azzart, Baidu [Spider], Bing [Bot], Buddlespit, eddiej, Exabot [Bot], garthecho, Google [Bot], Hans, housepig, irisuser, La Ninje, Majestic-12 [Bot], Naver Yeti [Spider], orbmiser, paulmcvay, searchfgold6789, Sentynel, soldier9599, tparrott, Uri_Herrera, veqz, Yahoo [Bot]