103432 - (more) images fetched from server when they should be in the cache

Status: RESOLVED FIXED

(Core :: Graphics: ImageLib, defect)

Description

[John Morrison]

I noticed in the server logs that some images were being fetched from the 
server when they should already be in the cache. 

Test  : create a new profile, collapse sidebar, shutdown, restart, 
        run http://cowtools.mcom.com/page-loader/loader.pl through 11 cycles

Summary of images fetched from server (excluding those with ?query strings)

Note: most of these occur twice 200 OK for the same page, up to 3 sec. apart!

First visit -- images pulled into cache
Second visit -- no redundant GET's               
Third visit --
  20:46:17 www.msn.com/res/AS_mickey1112.jpg                         200 1962
  20:46:18 www.msn.com/res/AS_mickey1112.jpg                         200 1962
  20:46:33 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:46:33 www.voodooextreme.com/res/images_comments.gif             200 1117
  20:46:35 www.voodooextreme.com/res/images_comments.gif             200 1117
  20:46:35 www.voodooextreme.com/res/_search.gif                     200 1496
  20:46:35 www.voodooextreme.com/res/images_alienware_promo.gif      200 9289
  20:46:35 www.voodooextreme.com/res/images_ew1.gif                  200 6644
  20:46:36 www.voodooextreme.com/res/images_shiny.gif                200 4506
  20:46:36 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:47:05 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994
  20:47:07 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994
Fourth visit --                                                      
  20:48:15 www.tomshardware.com/res/images_banner_cnet_searchbox.gif 200 2063
  20:48:15 www.tomshardware.com/res/images_banner_cnet_searchbox.gif 200 2063
Fifth visit --                                                       
  20:48:57 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:48:58 www.voodooextreme.com/res/images_comments.gif             200 1117
  20:48:59 www.voodooextreme.com/res/images_comments.gif             200 1117
  20:49:00 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:49:30 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994
  20:49:32 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994
Sixth visit -- no redundant GET's                                              
       
Seventh visit --                                                     
  20:51:28 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:51:30 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:52:08 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994
  20:52:10 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994
Eighth visit --                                                      
  20:52:41 www.msn.com/res/AS_mickey1112.jpg                         200 1962
  20:52:42 www.msn.com/res/AS_mickey1112.jpg                         200 1962
  20:52:59 www.voodooextreme.com/res/images_comments.gif             200 1117
  20:53:01 www.voodooextreme.com/res/images_comments.gif             200 1117
Ninth visit --                                                       
  20:54:22 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:54:24 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:55:00 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994
  20:55:02 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994
Tenth visit --                                                       
  20:55:30 www.msn.com/res/AL_thanksgiving1111.jpg                   200 4019
  20:55:31 www.msn.com/res/AL_thanksgiving1111.jpg                   200 4019
Eleventh visit                                                       
  20:57:22 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:57:22 www.voodooextreme.com/res/images_trans.gif                200 43
  20:57:25 www.voodooextreme.com/res/images_trans.gif                200 43
  20:57:25 www.voodooextreme.com/res/banners_LucyBanner2.gif         200 45369
  20:58:12 www.tomshardware.com/res/images_banner_cnet_searchbox.gif 200 2063
  20:58:13 www.tomshardware.com/res/images_banner_cnet_searchbox.gif 200 2063
  20:58:16 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994
  20:58:18 www.cnn.com/res/images_0012_top_bush_3.jpg                200 22994


Cache information after test run (with one window open to about:cache)
Note: cache max settings were not exceeded (i.e., no eviction should have occurred)

Memory cache device
 Number of entries: 204
 Maximum storage size: 4194304 Bytes
 Storage in use: 3771820 Bytes

Disk cache device
 Number of entries: 1588
 Maximum storage size: 51200000 Bytes
 Storage in use: 27017728 Bytes
 Cache Directory: G:\Documents...<snip>  


Direct links to these images:

http://cowtools/perf/content/base/www.cnn.com/res/images_0012_top_bush_3.jpg   
            
http://cowtools/perf/content/base/www.msn.com/res/AL_thanksgiving1111.jpg      
            
http://cowtools/perf/content/base/www.msn.com/res/AS_mickey1112.jpg            
            
http://cowtools/perf/content/base/www.tomshardware.com/res/images_banner_cnet_searchbox.gif

http://cowtools/perf/content/base/www.voodooextreme.com/res/_search.gif        
            
http://cowtools/perf/content/base/www.voodooextreme.com/res/banners_LucyBanner2.gif
        
http://cowtools/perf/content/base/www.voodooextreme.com/res/images_alienware_promo.gif
     
http://cowtools/perf/content/base/www.voodooextreme.com/res/images_comments.gif
            
http://cowtools/perf/content/base/www.voodooextreme.com/res/images_ew1.gif     
            
http://cowtools/perf/content/base/www.voodooextreme.com/res/images_shiny.gif   
            
http://cowtools/perf/content/base/www.voodooextreme.com/res/images_trans.gif

Comment 1

[John Morrison]

Note: test above was on win2k with 2001100514 comm. trunk build.

Comment 2

[John Morrison]

Same type of summary for Linux 2001100514

First round --
Second round --
Third round --
  22:04:12 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:04:16 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:04:53 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:04:56 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
Fourth round --
Fifth round --
  22:07:20 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:07:24 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:08:03 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:08:06 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
Sixth round --
Seventh round --
  22:10:36 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:10:40 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:11:21 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:11:23 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
Eighth round --
Ninth round --
  22:14:01 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:14:04 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:14:47 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:14:50 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
Tenth round --
Eleventh round --
  22:17:36 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:17:40 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:18:25 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:18:27 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
 

Comment 3

[John Morrison]

MacOS 9.x 2001100514

First round --
Second round --
Third round --
  22:23:11 www.msn.com/res/AL_thanksgiving1111.jpg              200 4019
  22:23:11 www.msn.com/res/AS_mickey1112.jpg                    200 1962
  22:23:13 www.msn.com/res/AL_thanksgiving1111.jpg              200 4019
  22:23:13 www.msn.com/res/AS_mickey1112.jpg                    200 1962
  22:23:32 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:23:35 www.voodooextreme.com/res/images_comments.gif        200 1117
  22:23:36 www.voodooextreme.com/res/images_trans.gif           200 43
  22:23:36 www.voodooextreme.com/res/images_shiny.gif           200 4506
  22:23:36 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:24:19 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:24:22 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
Fourth round --
  22:25:12 www.voodooextreme.com/res/images_ew1.gif             200 6644
  22:25:16 www.voodooextreme.com/res/images_ew1.gif             200 6644
Fifth round --
  22:26:32 www.msn.com/res/001240005_D2.gif                     200 842
  22:26:32 www.msn.com/res/AL_thanksgiving1111.jpg              200 4019
  22:26:33 www.msn.com/res/AL_thanksgiving1111.jpg              200 4019
  22:26:34 www.msn.com/res/AS_mickey1112.jpg                    200 1962
  22:26:34 www.msn.com/res/001240005_D2.gif                     200 842
  22:26:53 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:26:56 www.voodooextreme.com/res/images_comments.gif        200 1117
  22:26:57 www.voodooextreme.com/res/images_trans.gif           200 43
  22:26:57 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:27:41 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:27:44 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
Sixth round --
  22:28:36 www.voodooextreme.com/res/images_shiny.gif           200 4506
  22:28:40 www.voodooextreme.com/res/images_shiny.gif           200 4506
  22:29:25 
www.cnn.com/res/f_388_21_15m_www_cnn_com_images_0012_pres_trans_banner_2.gif 
200 2982
  22:29:27 
www.cnn.com/res/f_388_21_15m_www_cnn_com_images_0012_pres_trans_banner_2.gif 
200 2982
Seventh round --
  22:29:59 www.msn.com/res/AL_thanksgiving1111.jpg              200 4019
  22:30:01 www.msn.com/res/AS_mickey1112.jpg                    200 1962
  22:30:01 www.msn.com/res/AL_thanksgiving1111.jpg              200 4019
  22:30:22 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:30:24 www.voodooextreme.com/res/images_comments.gif        200 1117
  22:30:25 www.voodooextreme.com/res/images_trans.gif           200 43
  22:30:26 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:31:11 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:31:14 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
Eighth round --
  22:31:47 www.msn.com/res/dotline.gif                          200 47
  22:31:48 www.msn.com/res/001240005_D2.gif                     200 842
  22:31:49 www.msn.com/res/dotline.gif                          200 47
Ninth round --
  22:33:38 www.msn.com/res/AS_mickey1112.jpg                    200 1962
  22:33:38 www.msn.com/res/AL_thanksgiving1111.jpg              200 4019
  22:33:39 www.msn.com/res/AS_mickey1112.jpg                    200 1962
  22:33:39 www.msn.com/res/AL_thanksgiving1111.jpg              200 4019
  22:34:01 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:34:04 www.voodooextreme.com/res/images_comments.gif        200 1117
  22:34:05 www.voodooextreme.com/res/images_trans.gif           200 43
  22:34:05 www.voodooextreme.com/res/images_shiny.gif           200 4506
  22:34:05 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:34:53 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:34:56 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
Tenth round --
  22:35:32 www.msn.com/res/001240005_D2.gif                     200 842
  22:35:54 www.voodooextreme.com/res/images_ew1.gif             200 6644
  22:35:58 www.voodooextreme.com/res/images_ew1.gif             200 6644
Eleventh round --
  22:37:26 www.msn.com/res/AS_mickey1112.jpg                    200 1962
  22:37:27 www.msn.com/res/AS_mickey1112.jpg                    200 1962
  22:37:50 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:37:54 www.voodooextreme.com/res/images_trans.gif           200 43
  22:37:54 www.voodooextreme.com/res/banners_LucyBanner2.gif    200 45369
  22:38:45 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994
  22:38:48 www.cnn.com/res/images_0012_top_bush_3.jpg           200 22994

Comment 4

[Stuart Parmenter]

fixed