Uploaded image for project: 'Traffic Server'
  1. Traffic Server
  2. TS-3276

Cache incompatible between 5.0.1 and 5.2.0

    XMLWordPrintableJSON

Details

    • Bug
    • Status: Closed
    • Minor
    • Resolution: Fixed
    • None
    • 5.2.0
    • Cache
    • None

    Description

      When upgrading from 5.0.1 to 5.2.0 RC3 I notice that there were no cache entries and the cache had 0 bytes. I was able to reproduce this on my development box.

      Running 5.0.1:

      curl -D - -o /dev/null -s -x 127.0.0.1:8080 'http://l1.ycs.vip.lax.yahoo.com/17k.gif'
      Via: (ApacheTrafficServer/5.0.1 [cHs f ])
      
      [Jan  6 14:34:50.967] Server {0x7fff7b295300} DEBUG: (cache_init) Store::read_config, fd = -1, "/usr/local/etc/trafficserver/storage.config"
      [Jan  6 14:34:50.968] Server {0x7fff7b295300} DEBUG: (cache_init) Store::read_config: "var/trafficserver 256M
      "
      [Jan  6 14:34:50.968] Server {0x7fff7b295300} DEBUG: (cache_init) Store::read_config - ns = new Span; ns->init("/usr/local/var/trafficserver",268435456), ns->vol_num=0
      [Jan  6 14:34:50.968] Server {0x7fff7b295300} DEBUG: (cache_init) Span::init - /usr/local/var/trafficserver hw_sector_size = 1048576  size = 268435456, blocks = 32768, disk_id = 16777220, file_pathname = 0
      [Jan  6 14:34:50.982] Server {0x7fff7b295300} DEBUG: (cache_init) Span::init - /usr/local/var/trafficserver hw_sector_size = 1048576  size = 33554432, blocks = 4096, disk_id = 16777220, file_pathname = 0
      [Jan  6 14:34:51.006] Server {0xff85000} DEBUG: (cache_init) Cache::open - proxy.config.cache.min_average_object_size = 8000
      [Jan  6 14:34:51.008] Server {0xff85000} DEBUG: (cache_init) allocating 352256 directory bytes for a 268419072 byte volume (0.131234%)
      [Jan  6 14:34:51.016] Server {0xfb79000} DEBUG: (cache_init) build_vol_hash_table index 0 mapped to 0 requested 32707 got 32707
      [Jan  6 14:34:51.016] Server {0xfb79000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - theCache, total_size = 32766 = 255 MB
      [Jan  6 14:34:51.016] Server {0xfb79000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - caches_ready=0x3, gnvol=1
      [Jan  6 14:34:51.016] Server {0xfb79000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - cache_config_ram_cache_size == AUTO_SIZE_RAM_CACHE
      [Jan  6 14:34:51.016] Server {0xfb79000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - ram_cache_bytes = 352256 = 0Mb
      [Jan  6 14:34:51.016] Server {0xfb79000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - total_cache_bytes = 268066816 = 255Mb
      [Jan  6 14:34:52.937] Server {0xf567000} DEBUG: (cache_new) new 0x7fdaa2842c60
      [Jan  6 14:34:52.938] Server {0xf567000} DEBUG: (cache_read) Read complete on fragment 0B9EF20BA07FE10DE08A3C04FAC4F722. Length: data payload=18104 this fragment=21016 total doc=18104 prefix=2912
      [Jan  6 14:34:52.938] Server {0xf567000} DEBUG: (cache_read) CacheReadStartHead - read 0B9EF20BA07FE10DE08A3C04FAC4F722 target AE93D67FD96B9386253B02F1DA044B54 - single 21016 of 18104 bytes, 0 fragments
      [Jan  6 14:34:52.938] Server {0xf567000} DEBUG: (cache_free) free 0x7fdaa2842c6
      

      Running 5.2.0:

      curl -D - -o /dev/null -s -x 127.0.0.1:8080 'http://l1.ycs.vip.lax.yahoo.com/17k.gif'
      Via: (ApacheTrafficServer/5.2.0 [cMsSfW])
      
      [Jan  6 14:35:54.684] Server {0x7fff7b295300} DEBUG: (cache_init) Store::read_config, fd = -1, "/usr/local/etc/trafficserver/storage.config"
      [Jan  6 14:35:54.685] Server {0x7fff7b295300} DEBUG: (cache_init) Store::read_config: "var/trafficserver"
      [Jan  6 14:35:54.685] Server {0x7fff7b295300} DEBUG: (cache_init) Store::read_config - ns = new Span; ns->init("/usr/local/var/trafficserver",268435456), forced volume=-1
      [Jan  6 14:35:54.685] Server {0x7fff7b295300} DEBUG: (cache_init) initialized span '/usr/local/var/trafficserver'
      [Jan  6 14:35:54.685] Server {0x7fff7b295300} DEBUG: (cache_init) hw_sector_size=1048576, size=268435456, blocks=32768, disk_id=16777220/45700045, file_pathname=0
      [Jan  6 14:35:54.698] Server {0x7fff7b295300} DEBUG: (cache_init) initialized span '/usr/local/var/trafficserver'
      [Jan  6 14:35:54.698] Server {0x7fff7b295300} DEBUG: (cache_init) hw_sector_size=1048576, size=33554432, blocks=4096, disk_id=16777220/45700045, file_pathname=0
      [Jan  6 14:35:54.788] Server {0x7fff7b295300} DEBUG: (cache_init) Cache::open - proxy.config.cache.min_average_object_size = 8000
      [Jan  6 14:35:54.790] Server {0x7fff7b295300} DEBUG: (cache_init) allocating 352256 directory bytes for a 268419072 byte volume (0.131234%)
      [Jan  6 14:35:54.797] Server {0x113fd000} DEBUG: (cache_init) build_vol_hash_table index 0 mapped to 0 requested 32707 got 32707
      [Jan  6 14:35:54.797] Server {0x113fd000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - theCache, total_size = 32766 = 255 MB
      [Jan  6 14:35:54.797] Server {0x113fd000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - caches_ready=0x9, gnvol=1
      [Jan  6 14:35:54.797] Server {0x113fd000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - cache_config_ram_cache_size == AUTO_SIZE_RAM_CACHE
      [Jan  6 14:35:54.797] Server {0x113fd000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - ram_cache_bytes = 352256 = 0Mb
      [Jan  6 14:35:54.797] Server {0x113fd000} DEBUG: (cache_init) CacheProcessor::cacheInitialized - total_cache_bytes = 268066816 = 255Mb
      [Jan  6 14:35:56.922] Server {0x10deb000} DEBUG: (cache_new) new 0x7ff70c9e4e60
      [Jan  6 14:35:57.157] Server {0x10deb000} DEBUG: (cache_free) free 0x7ff70c9e4e60
      

      Attachments

        Activity

          People

            amc Alan M. Carroll
            bcall Bryan Call
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: