2013/12/17 03:00:15 [debug] 15706#0: epoll: fd:9 ev:0001 d:B6BD1008
2013/12/17 03:00:15 [debug] 15706#0: accept on 0.0.0.0:80, ready: 0
2013/12/17 03:00:15 [debug] 15706#0: posix_memalign: 09E5C2A0:256 @16
2013/12/17 03:00:15 [debug] 15706#0: *6 accept: 192.168.38.1 fd:6
2013/12/17 03:00:15 [debug] 15706#0: *6 event timer add: 6: 60000:3639087
2013/12/17 03:00:15 [debug] 15706#0: *6 reusable connection: 1
2013/12/17 03:00:15 [debug] 15706#0: *6 epoll add event: fd:6 op:1 ev:80002001
2013/12/17 03:00:15 [debug] 15706#0: timer delta: 3038
2013/12/17 03:00:15 [debug] 15706#0: posted events 00000000
2013/12/17 03:00:15 [debug] 15706#0: worker cycle
2013/12/17 03:00:15 [debug] 15706#0: epoll timer: 60000
2013/12/17 03:00:15 [debug] 15706#0: epoll: fd:6 ev:0001 d:B6BD1198
2013/12/17 03:00:15 [debug] 15706#0: *6 http wait request handler
2013/12/17 03:00:15 [debug] 15706#0: *6 malloc: 09E1DC10:1024
2013/12/17 03:00:15 [debug] 15706#0: *6 recv: fd:6 417 of 1024
2013/12/17 03:00:15 [debug] 15706#0: *6 reusable connection: 0
2013/12/17 03:00:15 [debug] 15706#0: *6 posix_memalign: 09E22870:4096 @16
2013/12/17 03:00:15 [debug] 15706#0: *6 http process request line
2013/12/17 03:00:15 [debug] 15706#0: *6 http request line: "GET /zusccllrtqsaj2eyd2pjr7hidb6qgynecc65uzyntm6bnhuinro3ootdq7aq/v.mp4?start=5 HTTP/1.1"
2013/12/17 03:00:15 [debug] 15706#0: *6 http uri: "/zusccllrtqsaj2eyd2pjr7hidb6qgynecc65uzyntm6bnhuinro3ootdq7aq/v.mp4"
2013/12/17 03:00:15 [debug] 15706#0: *6 http args: "start=5"
2013/12/17 03:00:15 [debug] 15706#0: *6 http exten: "mp4"
2013/12/17 03:00:15 [debug] 15706#0: *6 http process request header line
2013/12/17 03:00:15 [debug] 15706#0: *6 http header: "User-Agent: Opera/9.80 (Windows NT 6.1) Presto/2.12.388 Version/12.16"
2013/12/17 03:00:15 [debug] 15706#0: *6 http header: "Host: xvs-s1.tt"
2013/12/17 03:00:15 [debug] 15706#0: *6 http header: "Accept: text/html, application/xml;q=0.9, application/xhtml+xml, image/png, image/webp, image/jpeg, image/gif, image/x-xbitmap, */*;q=0.1"
2013/12/17 03:00:15 [debug] 15706#0: *6 http header: "Accept-Language: ru-RU,ru;q=0.9,en;q=0.8"
2013/12/17 03:00:15 [debug] 15706#0: *6 http header: "Accept-Encoding: gzip, deflate"
2013/12/17 03:00:15 [debug] 15706#0: *6 http header: "Connection: Keep-Alive"
2013/12/17 03:00:15 [debug] 15706#0: *6 http header done
2013/12/17 03:00:15 [debug] 15706#0: *6 event timer del: 6: 3639087
2013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 0
2013/12/17 03:00:15 [debug] 15706#0: *6 http script value: "/home/xvs-s1/cgi-bin"
2013/12/17 03:00:15 [debug] 15706#0: *6 http script set $cgidir
2013/12/17 03:00:15 [debug] 15706#0: *6 http script var
2013/12/17 03:00:15 [debug] 15706#0: *6 http script var: "GET"
2013/12/17 03:00:15 [debug] 15706#0: *6 http script regex: "^(GET|HEAD|POST)$"
2013/12/17 03:00:15 [notice] 15706#0: *6 "^(GET|HEAD|POST)$" matches "GET", client: 192.168.38.1, server: xvs-s1.tt, request: "GET /zusccllrtqsaj2eyd2pjr7hidb6qgynecc65uzyntm6bnhuinro3ootdq7aq/v.mp4?start=5 HTTP/1.1", host: "xvs-s1.tt"
2013/12/17 03:00:15 [debug] 15706#0: *6 http script if
2013/12/17 03:00:15 [debug] 15706#0: *6 http script if: false
2013/12/17 03:00:15 [debug] 15706#0: *6 test location: "/"
2013/12/17 03:00:15 [debug] 15706#0: *6 test location: "transfer/"
2013/12/17 03:00:15 [debug] 15706#0: *6 test location: "video_mp4/"
2013/12/17 03:00:15 [debug] 15706#0: *6 test location: "vod_handler"
2013/12/17 03:00:15 [debug] 15706#0: *6 test location: ~ "^/(\w{48,})/"
2013/12/17 03:00:15 [debug] 15706#0: *6 using configuration "^/(\w{48,})/"
2013/12/17 03:00:15 [debug] 15706#0: *6 http cl:-1 max:1048576
2013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 2
2013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 3
2013/12/17 03:00:15 [debug] 15706#0: *6 post rewrite phase: 4
2013/12/17 03:00:15 [debug] 15706#0: *6 generic phase: 5
2013/12/17 03:00:15 [debug] 15706#0: *6 generic phase: 6
2013/12/17 03:00:15 [debug] 15706#0: *6 access phase: 7
2013/12/17 03:00:15 [debug] 15706#0: *6 access phase: 8
2013/12/17 03:00:15 [debug] 15706#0: *6 post access phase: 9
2013/12/17 03:00:15 [debug] 15706#0: *6 perl handler
2013/12/17 03:00:15 [debug] 15706#0: *6 perl sv2str: 00024405 "/video_mp4/01/00000/broljxe8iyse_n?id=219&usr=1&speed=70k&ip=192.168.38.1&dmode=n&flags=0&start=5"
2013/12/17 03:00:15 [debug] 15706#0: *6 call_sv: 0
2013/12/17 03:00:15 [debug] 15706#0: *6 perl handler done: 0
2013/12/17 03:00:15 [debug] 15706#0: *6 internal redirect: "/video_mp4/01/00000/broljxe8iyse_n?id=219&usr=1&speed=70k&ip=192.168.38.1&dmode=n&flags=0&start=5"
2013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 0
2013/12/17 03:00:15 [debug] 15706#0: *6 http script value: "/home/xvs-s1/cgi-bin"
2013/12/17 03:00:15 [debug] 15706#0: *6 http script set $cgidir
2013/12/17 03:00:15 [debug] 15706#0: *6 http script var
2013/12/17 03:00:15 [debug] 15706#0: *6 http script var: "GET"
2013/12/17 03:00:15 [debug] 15706#0: *6 http script regex: "^(GET|HEAD|POST)$"
2013/12/17 03:00:15 [notice] 15706#0: *6 "^(GET|HEAD|POST)$" matches "GET", client: 192.168.38.1, server: xvs-s1.tt, request: "GET /zusccllrtqsaj2eyd2pjr7hidb6qgynecc65uzyntm6bnhuinro3ootdq7aq/v.mp4?start=5 HTTP/1.1", host: "xvs-s1.tt"
2013/12/17 03:00:15 [debug] 15706#0: *6 http script if
2013/12/17 03:00:15 [debug] 15706#0: *6 http script if: false
2013/12/17 03:00:15 [debug] 15706#0: *6 test location: "/"
2013/12/17 03:00:15 [debug] 15706#0: *6 test location: "transfer/"
2013/12/17 03:00:15 [debug] 15706#0: *6 test location: "video_mp4/"
2013/12/17 03:00:15 [debug] 15706#0: *6 test location: ~ "^/(\w{48,})/"
2013/12/17 03:00:15 [debug] 15706#0: *6 using configuration "/video_mp4/"
2013/12/17 03:00:15 [debug] 15706#0: *6 http cl:-1 max:1048576
2013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 2
2013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 3
2013/12/17 03:00:15 [debug] 15706#0: *6 http script complex value
2013/12/17 03:00:15 [debug] 15706#0: *6 http script var: "70k"
2013/12/17 03:00:15 [debug] 15706#0: *6 http script set var handler
2013/12/17 03:00:15 [debug] 15706#0: *6 post rewrite phase: 4
2013/12/17 03:00:15 [debug] 15706#0: *6 generic phase: 5
2013/12/17 03:00:15 [debug] 15706#0: *6 generic phase: 6
2013/12/17 03:00:15 [debug] 15706#0: shmtx lock
2013/12/17 03:00:15 [debug] 15706#0: slab alloc: 24 slot: 2
2013/12/17 03:00:15 [debug] 15706#0: slab alloc: B6ED6060
2013/12/17 03:00:15 [debug] 15706#0: *6 limit conn: 34BB8E70 1
2013/12/17 03:00:15 [debug] 15706#0: shmtx unlock
2013/12/17 03:00:15 [debug] 15706#0: *6 add cleanup: 09E233A0
2013/12/17 03:00:15 [debug] 15706#0: *6 access phase: 7
2013/12/17 03:00:15 [debug] 15706#0: *6 access phase: 8
2013/12/17 03:00:15 [debug] 15706#0: *6 post access phase: 9
2013/12/17 03:00:15 [debug] 15706#0: *6 http set discard body
2013/12/17 03:00:15 [debug] 15706#0: *6 http script var: "/home/xvs-s1/cgi-bin"
2013/12/17 03:00:15 [debug] 15706#0: *6 http script copy: "/uploads/"
2013/12/17 03:00:15 [debug] 15706#0: *6 http mp4 filename: "/home/xvs-s1/cgi-bin/uploads/01/00000/broljxe8iyse_n"
2013/12/17 03:00:15 [debug] 15706#0: *6 add cleanup: 09E233EC
2013/12/17 03:00:15 [debug] 15706#0: *6 posix_memalign: 09E23890:4096 @16
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 start:53000
2013/12/17 03:00:15 [debug] 15706#0: *6 malloc: B6A4A008:524288
2013/12/17 03:00:15 [debug] 15706#0: *6 read: 14, B6A4A008, 524288, 0
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: ftyp @0:32
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 ftyp atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: moov @32:27790
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 moov atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mvhd @40:108
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 mvhd atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mvhd timescale:1000, duration:33920, time:33.920s
2013/12/17 03:00:15 [debug] 15706#0: *6 mvhd new duration:18446744073709532536, time:18446744073709532.000s
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: trak @148:12228
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 trak atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: tkhd @156:92
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 tkhd atom
2013/12/17 03:00:15 [debug] 15706#0: *6 tkhd duration:33920, time:33.920s
2013/12/17 03:00:15 [debug] 15706#0: *6 tkhd new duration:18446744073709532536, time:18446744073709532.000s
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: edts @248:48
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdia @296:12080
2013/12/17 03:00:15 [debug] 15706#0: *6 process mdia atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdhd @304:32
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 mdhd atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mdhd timescale:12800, duration:434176, time:33.920s
2013/12/17 03:00:15 [debug] 15706#0: *6 mdhd new duration:18446744073709307392, time:1441151880758539.750s
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: hdlr @336:45
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 hdlr atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: minf @381:11995
2013/12/17 03:00:15 [debug] 15706#0: *6 process minf atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: vmhd @389:20
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 vmhd atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: dinf @409:36
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 dinf atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stbl @445:11931
2013/12/17 03:00:15 [debug] 15706#0: *6 process stbl atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsd @453:171
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsd atom
2013/12/17 03:00:15 [debug] 15706#0: *6 stsd entries:1, media:avc1
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stts @624:24
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stts atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 time-to-sample entries:1
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stss @648:56
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stss atom
2013/12/17 03:00:15 [debug] 15706#0: *6 sync sample entries:10
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: ctts @704:4824
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 ctts atom
2013/12/17 03:00:15 [debug] 15706#0: *6 composition offset entries:601
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsc @5528:28
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsc atom
2013/12/17 03:00:15 [debug] 15706#0: *6 sample-to-chunk entries:1
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsz @5556:3412
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsz atom
2013/12/17 03:00:15 [debug] 15706#0: *6 sample uniform size:0, entries:848
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stco @8968:3408
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stco atom
2013/12/17 03:00:15 [debug] 15706#0: *6 chunks:848
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 trak atom: 0
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: trak @12376:15348
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 trak atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: tkhd @12384:92
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 tkhd atom
2013/12/17 03:00:15 [debug] 15706#0: *6 tkhd duration:33891, time:33.891s
2013/12/17 03:00:15 [debug] 15706#0: *6 tkhd new duration:18446744073709532507, time:18446744073709532.000s
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: edts @12476:36
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdia @12512:15212
2013/12/17 03:00:15 [debug] 15706#0: *6 process mdia atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdhd @12520:32
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 mdhd atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mdhd timescale:44100, duration:1494592, time:33.891s
2013/12/17 03:00:15 [debug] 15706#0: *6 mdhd new duration:18446744073708708908, time:418293516410628.313s
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: hdlr @12552:45
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 hdlr atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: minf @12597:15127
2013/12/17 03:00:15 [debug] 15706#0: *6 process minf atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: smhd @12605:16
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 smhd atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: dinf @12621:36
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 dinf atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stbl @12657:15067
2013/12/17 03:00:15 [debug] 15706#0: *6 process stbl atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsd @12665:103
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsd atom
2013/12/17 03:00:15 [debug] 15706#0: *6 stsd entries:1, media:mp4a
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stts @12768:32
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stts atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 time-to-sample entries:2
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsc @12800:5656
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsc atom
2013/12/17 03:00:15 [debug] 15706#0: *6 sample-to-chunk entries:470
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsz @18456:5860
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsz atom
2013/12/17 03:00:15 [debug] 15706#0: *6 sample uniform size:0, entries:1460
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stco @24316:3408
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stco atom
2013/12/17 03:00:15 [debug] 15706#0: *6 chunks:848
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 trak atom: 0
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: udta @27724:98
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 moov atom done
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: free @27822:8
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdat @27830:2134981
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 mdat atom
2013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stts atom update
2013/12/17 03:00:15 [debug] 15706#0: *6 time-to-sample start_time:678400
2013/12/17 03:00:15 [debug] 15706#0: *6 count:848, duration:512
2013/12/17 03:00:15 [error] 15706#0: *6 start time is out mp4 stts samples in "/home/xvs-s1/cgi-bin/uploads/01/00000/broljxe8iyse_n", client: 192.168.38.1, server: xvs-s1.tt, request: "GET /zusccllrtqsaj2eyd2pjr7hidb6qgynecc65uzyntm6bnhuinro3ootdq7aq/v.mp4?start=5 HTTP/1.1", host: "xvs-s1.tt"