[Varnish] #1486: Failing assert in cnt_deliver(): (req->t_prev > req->obj->exp.t_origin) not true

[Varnish]

#1486: Failing assert in cnt_deliver(): (req->t_prev > req->obj->exp.t_origin) not
true
----------------------+-------------------
 Reporter:  lkarsten  |      Owner:
     Type:  defect    |     Status:  new
 Priority:  normal    |  Milestone:
Component:  varnishd  |    Version:  trunk
 Severity:  normal    |   Keywords:
----------------------+-------------------
 Fryer ran into this assert on current master:
 35308a3c975ce3bd3690fe3afa4f25bb78b887e5

 {{{
 Last panic at: Wed, 23 Apr 2014 00:43:26 GMT
 Assert error in cnt_deliver(), cache/cache_req_fsm.c line 121:
   Condition(req->t_prev > req->obj->exp.t_origin) not true.
 thread = (cache-worker)
 ident = Linux,3.2.0-51-generic,x86_64,-smalloc,-smalloc,-hcritbit,epoll
 Backtrace:
   0x43b31f: pan_backtrace+0x19
   0x43b630: pan_ic+0x1e9
   0x43e5b4: cnt_deliver+0x50b
   0x441b2c: CNT_Request+0x529
   0x434475: HTTP1_Session+0x427
   0x444a07: ses_req_pool_task+0x166
   0x444cd2: ses_sess_pool_task+0x23b
   0x445271: SES_pool_accept_task+0x1f9
   0x43d2a4: Pool_Work_Thread+0x416
   0x455e20: wrk_thread_real+0x204
 req = 0x7fccdc060a00 {
   sp = 0x7fccd80014b0, vxid = 1075189378,  step = R_STP_DELIVER,
   req_body = R_BODY_NONE,
   restarts = 0, esi_level = 0
   sp = 0x7fccd80014b0 {
     fd = 22, vxid = 1447553,
     client = 194.31.39.161 56800,
     step = S_STP_WORKING,
   },
   worker = 0x7fccf9d2dc60 {
     ws = 0x7fccf9d2de70 {
       id = "wrk",
       {s,f,r,e} = {0x7fccf9d2d410,0x7fccf9d2d410,(nil),+2048},
     },
   VCL::method = 0x0,
   VCL::return = deliver,
   },
   ws = 0x7fccdc060b90 {
     id = "req",
     {s,f,r,e} = {0x7fccdc0629d0,+296,(nil),+57392},
   },
   http[req] = {
     ws = 0x7fccdc060b90[req]
       "GET",
       "/cacheabledata/set_imagehosting1/0/image13790.jpg",
       "HTTP/1.1",
       "Host: fryer1.varnish-software.com:6081",
       "Accept: */*",
       "Accept-Encoding: gzip",
       "User-Agent: Mozilla/5.0 (unknown-x86_64-linux-gnu) Siege/3.0.4",
       "Connection: close",
       "X-Forwarded-For: 194.31.39.161",
   },
   http[resp] = {
     ws = 0x7fccdc060b90[req]
       "HTTP/1.1",
       "200",
       "OK",
       "Date: Wed, 23 Apr 2014 00:43:25 GMT",
       "Server: Apache/2.2.22 (Ubuntu)",
       "Last-Modified: Mon, 26 Aug 2013 14:11:34 GMT",
       "ETag: "824156-1af8-4e4da5578d683"",
       "Content-Type: image/jpeg",
       "X-Varnish: 1447554 2039678",
   },
   vcl = {
     srcname = {
       "input",
       "Builtin",
     },
   },
   obj (REQ) = 0x7fcc6c62e640 {
     vxid = 2149523326,
     http[obj] = {
       ws = 0x7fcce4050c18[]
         "HTTP/1.1",
         "200",
         "OK",
         "Date: Wed, 23 Apr 2014 00:43:25 GMT",
         "Server: Apache/2.2.22 (Ubuntu)",
         "Last-Modified: Mon, 26 Aug 2013 14:11:34 GMT",
         "ETag: "824156-1af8-4e4da5578d683"",
         "Content-Type: image/jpeg",
     },
     len = 6904,
     store = {
       6904 {
         00 00 00 af 9a be b0 41 00 00 80 8a ae a3 e3 41 |.......A.......A|
         00 00 80 76 65 db cc 41 00 00 00 b8 e4 0d 9b 41 |...ve..A.......A|
         00 00 80 e6 a8 5b cb 41 00 00 20 f2 1d 1d e4 41 |.....[.A.. ....A|
         00 00 20 6f e7 88 e0 41 00 00 c0 94 34 87 d3 41 |.. o...A....4..A|
         [6840 more]
       },
     },
   },
 },
 }}}

-- 
Ticket URL: <https://www.varnish-cache.org/trac/ticket/1486>
Varnish <https://varnish-cache.org/>
The Varnish HTTP Accelerator