Boot charting support.

Select (B)ootchart in advanced options in configure, and logf will record timings for various stages of boot, for performance comparisons. Format logged is:
BC:>function_name,123,80
where 123 is the line number, 80 is the number of ticks since boot. This can be loaded as CSV into a spreadsheet.


git-svn-id: svn://svn.rockbox.org/rockbox/trunk@25426 a1c6a512-1295-4272-9138-f99709370657

3 files changed, 76 insertions, 3 deletions

diff --git a/apps/gui/theme_settings.c b/apps/gui/theme_settings.c
index 4ab18b53fe..086dff5385 100644
--- a/apps/gui/theme_settings.c
+++ b/apps/gui/theme_settings.c
@@ -33,6 +33,7 @@
 #include "skin_engine/skin_engine.h"
 #include "skin_engine/skin_fonts.h"
 #include "statusbar-skinned.h"
+#include "bootchart.h"
 
 
 /* call this after loading a .wps/.rwps or other skin files, so that the
@@ -73,6 +74,7 @@ void settings_apply_skins(void)
 #ifdef HAVE_REMOTE_LCD
         screen = skins[i].suffix[0] == 'r' ? SCREEN_REMOTE : SCREEN_MAIN;
 #endif
+        CHART2(">skin load ", skins[i].suffix);
         if (skins[i].setting[0] && skins[i].setting[0] != '-')
         {
             snprintf(buf, sizeof buf, WPS_DIR "/%s.%s",
@@ -83,6 +85,7 @@ void settings_apply_skins(void)
         {
             skins[i].loadfunc(screen, NULL, true);
         }
+        CHART2("<skin load ", skins[i].suffix);
     }
     viewportmanager_theme_changed(THEME_STATUSBAR);
 #if LCD_DEPTH > 1 || defined(HAVE_REMOTE_LCD) && LCD_REMOTE_DEPTH > 1
diff --git a/apps/main.c b/apps/main.c
index 7c43c0c277..487848caaf 100644
--- a/apps/main.c
+++ b/apps/main.c
@@ -75,6 +75,7 @@
 #include "icon.h"
 #include "viewport.h"
 #include "statusbar-skinned.h"
+#include "bootchart.h"
 
 #ifdef IPOD_ACCESSORY_PROTOCOL
 #include "iap.h"
@@ -136,7 +137,9 @@ int main(void)
 #endif
 {
     int i;
+    CHART(">init");
     init();
+    CHART("<init");
     FOR_NB_SCREENS(i)
     {
         screens[i].clear_display();
@@ -167,6 +170,7 @@ int main(void)
     global_status.last_volume_change = 0;
     /* no calls INIT_ATTR functions after this point anymore!
      * see definition of INIT_ATTR in config.h */
+    CHART(">root_menu");
     root_menu();
 }
 
@@ -414,13 +418,18 @@ static void init(void)
 #ifdef CPU_ARM
     enable_fiq();
 #endif
+    /* current_tick should be ticking by now */
+    CHART("ticking");
+
     lcd_init();
 #ifdef HAVE_REMOTE_LCD
     lcd_remote_init();
 #endif
     font_init();
 
+    CHART(">show_logo");
     show_logo();
+    CHART("<show_logo");
     lang_init(core_language_builtin, language_strings, 
               LANG_LAST_INDEX_IN_ARRAY);
 
@@ -436,7 +445,9 @@ static void init(void)
     rtc_init();
 #endif
 #ifdef HAVE_RTC_RAM
+    CHART(">settings_load(RTC)");
     settings_load(SETTINGS_RTC); /* early load parts of global_settings */
+    CHART("<settings_load(RTC)");
 #endif
 
     adc_init();
@@ -460,10 +471,18 @@ static void init(void)
 
     /* Keep the order of this 3 (viewportmanager handles statusbars)
      * Must be done before any code uses the multi-screen API */
+    CHART(">gui_syncstatusbar_init");
     gui_syncstatusbar_init(&statusbars);
+    CHART("<gui_syncstatusbar_init");
+    CHART(">sb_skin_init");
     sb_skin_init();
+    CHART("<sb_skin_init");
+    CHART(">gui_sync_wps_init");
     gui_sync_wps_init();
+    CHART("<gui_sync_wps_init");
+    CHART(">viewportmanager_init");
     viewportmanager_init();
+    CHART("<viewportmanager_init");
 
 #if CONFIG_CHARGING && (CONFIG_CPU == SH7034)
     /* charger_inserted() can't be used here because power_thread()
@@ -483,7 +502,9 @@ static void init(void)
     }
 #endif
 
+    CHART(">storage_init");
     rc = storage_init();
+    CHART("<storage_init");
     if(rc)
     {
 #ifdef HAVE_LCD_BITMAP
@@ -498,7 +519,9 @@ static void init(void)
     }
 
 #ifdef HAVE_EEPROM_SETTINGS
+    CHART(">eeprom_settings_init");
     eeprom_settings_init();
+    CHART("<eeprom_settings_init");
 #endif
 
 #ifndef HAVE_USBSTACK
@@ -527,7 +550,9 @@ static void init(void)
 
     if (!mounted)
     {
+        CHART(">disk_mount_all");
         rc = disk_mount_all();
+        CHART("<disk_mount_all");
         if (rc<=0)
         {
             lcd_clear_display();
@@ -561,19 +586,32 @@ static void init(void)
     }
     else
 #endif
+    {
+        CHART(">settings_load(ALL)");
         settings_load(SETTINGS_ALL);
+        CHART("<settings_load(ALL)");
+    }
 
-    if (init_dircache(true) < 0)
+    CHART(">init_dircache(true)");
+    rc = init_dircache(true);
+    CHART("<init_dircache(true");
+    if (rc < 0)
     {
 #ifdef HAVE_TAGCACHE
         remove(TAGCACHE_STATEFILE);
 #endif
     }
 
+    CHART(">settings_apply(true)");
     settings_apply(true);        
+    CHART("<settings_apply(true)");
+    CHART(">init_dircache(false)");
     init_dircache(false);
+    CHART("<init_dircache(false)");
 #ifdef HAVE_TAGCACHE
+    CHART(">init_tagcache");
     init_tagcache();
+    CHART("<init_tagcache");
 #endif
 
 #ifdef HAVE_EEPROM_SETTINGS
@@ -581,7 +619,9 @@ static void init(void)
     {
         /* In case we crash. */
         firmware_settings.disk_clean = false;
+        CHART(">eeprom_settings_store");
         eeprom_settings_store();
+        CHART("<eeprom_settings_store");
     }
 #endif
     playlist_init();
@@ -614,7 +654,9 @@ static void init(void)
     talk_init();
 #endif /* CONFIG_CODEC != SWCODEC */
 
+    CHART(">audio_init");
     audio_init();
+    CHART("<audio_init");
 
 #if (CONFIG_CODEC == SWCODEC) && defined(HAVE_RECORDING) && !defined(SIMULATOR)
     pcm_rec_init();
@@ -636,9 +678,13 @@ static void init(void)
     lineout_set(global_settings.lineout_active);
 #endif
 #ifdef HAVE_HOTSWAP_STORAGE_AS_MAIN
+    CHART("<check_bootfile(false)");
     check_bootfile(false); /* remember write time and filesize */
+    CHART(">check_bootfile(false)");
 #endif
+    CHART("<settings_apply_skins");
     settings_apply_skins();
+    CHART(">settings_apply_skins");
 }
 
 #ifdef CPU_PP
diff --git a/apps/settings.c b/apps/settings.c
index 412bedc464..d5fd98e70a 100644
--- a/apps/settings.c
+++ b/apps/settings.c
@@ -70,6 +70,7 @@
 #include "skin_engine/skin_engine.h"
 #include "viewport.h"
 #include "statusbar-skinned.h"
+#include "bootchart.h"
 
 #if CONFIG_CODEC == MAS3507D
 void dac_line_in(bool enable);
@@ -745,6 +746,7 @@ void settings_apply(bool read_disk)
 {
     
     char buf[64];
+    int rc;
 #if CONFIG_CODEC == SWCODEC
     int i;
 #endif
@@ -841,7 +843,10 @@ void settings_apply(bool read_disk)
             && global_settings.font_file[0] != '-') {
             snprintf(buf, sizeof buf, FONT_DIR "/%s.fnt",
                      global_settings.font_file);
-            if (font_load(NULL, buf) < 0)
+            CHART2(">font_load ", global_settings.font_file);
+            rc = font_load(NULL, buf);
+            CHART2("<font_load ", global_settings.font_file);
+            if (rc < 0)
                 font_reset(NULL);
         }
         else
@@ -851,7 +856,10 @@ void settings_apply(bool read_disk)
             && global_settings.remote_font_file[0] != '-') {
             snprintf(buf, sizeof buf, FONT_DIR "/%s.fnt",
                      global_settings.remote_font_file);
-            if (font_load_remoteui(buf) < 0)
+            CHART2(">font_load_remoteui ", global_settings.remote_font_file);
+            rc = font_load_remoteui(buf);
+            CHART2("<font_load_remoteui ", global_settings.remote_font_file);
+            if (rc < 0)
                 font_load_remoteui(NULL);
         }
         else
@@ -860,7 +868,9 @@ void settings_apply(bool read_disk)
         if ( global_settings.kbd_file[0]) {
             snprintf(buf, sizeof buf, ROCKBOX_DIR "/%s.kbd",
                      global_settings.kbd_file);
+            CHART(">load_kbd");
             load_kbd(buf);
+            CHART("<load_kbd");
         }
         else
             load_kbd(NULL);
@@ -869,16 +879,26 @@ void settings_apply(bool read_disk)
         if ( global_settings.lang_file[0]) {
             snprintf(buf, sizeof buf, LANG_DIR "/%s.lng",
                      global_settings.lang_file);
+            CHART(">lang_core_load");
             lang_core_load(buf);
+            CHART("<lang_core_load");
+            CHART(">talk_init");
             talk_init(); /* use voice of same language */
+            CHART("<talk_init");
         }
 
         /* load the icon set */
+        CHART(">icons_init");
         icons_init();
+        CHART("<icons_init");
 
 #ifdef HAVE_LCD_COLOR
         if (global_settings.colors_file[0])
+        {
+            CHART(">read_color_theme_file");
             read_color_theme_file();
+            CHART("<read_color_theme_file");
+        }
 #endif
     }
 #ifdef HAVE_LCD_COLOR
@@ -901,7 +921,9 @@ void settings_apply(bool read_disk)
     lcd_scroll_delay(global_settings.scroll_delay);
 
 
+    CHART(">set_codepage");
     set_codepage(global_settings.default_codepage);
+    CHART("<set_codepage");
 
 #if CONFIG_CODEC == SWCODEC
 #ifdef HAVE_CROSSFADE
@@ -966,7 +988,9 @@ void settings_apply(bool read_disk)
 #endif
 #ifdef HAVE_LCD_BITMAP
     /* already called with THEME_STATUSBAR in settings_apply_skins() */
+    CHART(">viewportmanager_theme_changed");
     viewportmanager_theme_changed(THEME_UI_VIEWPORT|THEME_LANGUAGE|THEME_BUTTONBAR);
+    CHART("<viewportmanager_theme_changed");
 #endif
 }