LinuxQuestions.org

LinuxQuestions.org (/questions/)
-   Linux - Newbie (https://www.linuxquestions.org/questions/linux-newbie-8/)
-   -   GNOME starts in 3.5 minutes and I have timestamped the X log. Remove the bottlenecks! (https://www.linuxquestions.org/questions/linux-newbie-8/gnome-starts-in-3-5-minutes-and-i-have-timestamped-the-x-log-remove-the-bottlenecks-778387/)

gregorian 12-27-2009 09:37 PM

GNOME starts in 3.5 minutes and I have timestamped the X log. Remove the bottlenecks!
 
My radeon driver loads GNOME in 3.5 minutes while vesa takes 5 seconds.

I've installed the Radeon firmware, and I have the Radeon modules installed. There are no errors in the Xorg.0.log which can be found here.

I've written a script that extracts and appends the last line of Xorg.0.log to a separate file every one second and inserts the current time. This is that log file:

Code:

[ 8:27:31 ] drmOpenDevice: node name is /dev/dri/card0
[ 8:27:32 ] (II) RADEON(0): I2C device "VGA-0:ddc2" registered at address 0xA0.
[ 8:27:33 ] (II) RADEON(0): I2C device "VGA-0:ddc2" registered at address 0xA0.
[ 8:27:34 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:35 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:36 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:37 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:38 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:39 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:40 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:41 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:42 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:43 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:44 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:45 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:46 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:47 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:48 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:49 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:50 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:51 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:52 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:53 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:54 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:55 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:56 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:57 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:58 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:27:59 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:00 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:01 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:02 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:03 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:04 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:05 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:07 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:08 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:09 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:10 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:11 ] (II) RADEON(0): I2C device "LVDS:ddc2" registered at address 0xA0.
[ 8:28:12 ] before xf86InitialConfiguration
[ 8:28:13 ] before xf86InitialConfiguration
[ 8:28:14 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:15 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:16 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:17 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:18 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:19 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:20 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:21 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:22 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:23 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:24 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:25 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:26 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:27 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:28 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:29 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:30 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:31 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:32 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:33 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:34 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:35 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:36 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:37 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:38 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:39 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:40 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:41 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:42 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:43 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:44 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:45 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:46 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:47 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:48 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:49 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:50 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:51 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:28:52 ] enable LVDS
[ 8:28:53 ] drmOpenByBusid: drmGetBusid reports pci:0000:01:05.0
[ 8:28:54 ] (**) Option "xkb_options" "terminate:ctrl_alt_bksp"
[ 8:28:55 ] (**) Option "xkb_options" "terminate:ctrl_alt_bksp"
[ 8:28:56 ] (**) Option "xkb_options" "terminate:ctrl_alt_bksp"
[ 8:28:57 ] (**) Option "xkb_options" "terminate:ctrl_alt_bksp"
[ 8:28:58 ] (**) Option "xkb_options" "terminate:ctrl_alt_bksp"
[ 8:28:59 ] (**) Option "xkb_options" "terminate:ctrl_alt_bksp"
[ 8:29:01 ] (**) Option "xkb_options" "terminate:ctrl_alt_bksp"
[ 8:29:02 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:03 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:04 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:05 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:06 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:07 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:08 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:09 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:10 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:11 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:12 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:13 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:14 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:15 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:16 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:17 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:18 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:19 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:20 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:21 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:22 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:23 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:24 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:25 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:26 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:27 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:28 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:29 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:30 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:31 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:32 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:33 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:34 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:35 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:36 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:37 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:38 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:39 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:29:40 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:29:41 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:42 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:43 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:44 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:45 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:46 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:47 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:48 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:49 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:50 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:52 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:53 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:54 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:55 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:56 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:57 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:58 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:29:59 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:00 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:01 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:02 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:03 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:04 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:05 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:06 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:07 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:08 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:09 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:10 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:11 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:12 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:13 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:14 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:15 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:16 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:17 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:18 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:19 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:20 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:30:21 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:30:22 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:23 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:24 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:25 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:26 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:27 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:28 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:29 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:30 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:31 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:32 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:33 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:34 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:35 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:36 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:37 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:38 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:39 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:40 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:41 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:43 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:44 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:45 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:46 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:47 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:48 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:49 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:50 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:51 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:52 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:53 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:54 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:55 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:56 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:57 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:58 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:30:59 ] (II) RADEON(0): Output: VGA-0, Detected Monitor Type: 0
[ 8:31:00 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:01 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:02 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:03 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:04 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:05 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:06 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:07 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:08 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:09 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:10 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:11 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:12 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:13 ] (II) RADEON(0): Output: S-video, Detected Monitor Type: 0
[ 8:31:14 ] (II) RADEON(0): MC_AGP_LOCATION : 0x003f0000
[ 8:31:15 ] Leaving Restore TV
[ 8:31:16 ] Leaving Restore TV

You can see how much time is being wasted at particular lines in the log (or rather the lines immediately following these lines in the log, since tail will keep extracting the same line while the bottleneck is being executed)

Note: This is the continuation of an earlier thread which has addressed all the minor problems I had before I narrowed it down here.

gregorian 12-28-2009 01:59 AM

Problem solved by adding
Option "DefaultConnectorTable" "on"
to my xorg.conf to bypass scanning (which was the bottleneck)


All times are GMT -5. The time now is 06:58 PM.