Ticket #475: mp4-bug-dump.txt

File mp4-bug-dump.txt, 14.0 KB (added by MP4Man, 12 years ago)
Line 
12013/12/17 03:00:15 [debug] 15706#0: epoll: fd:9 ev:0001 d:B6BD1008
22013/12/17 03:00:15 [debug] 15706#0: accept on 0.0.0.0:80, ready: 0
32013/12/17 03:00:15 [debug] 15706#0: posix_memalign: 09E5C2A0:256 @16
42013/12/17 03:00:15 [debug] 15706#0: *6 accept: 192.168.38.1 fd:6
52013/12/17 03:00:15 [debug] 15706#0: *6 event timer add: 6: 60000:3639087
62013/12/17 03:00:15 [debug] 15706#0: *6 reusable connection: 1
72013/12/17 03:00:15 [debug] 15706#0: *6 epoll add event: fd:6 op:1 ev:80002001
82013/12/17 03:00:15 [debug] 15706#0: timer delta: 3038
92013/12/17 03:00:15 [debug] 15706#0: posted events 00000000
102013/12/17 03:00:15 [debug] 15706#0: worker cycle
112013/12/17 03:00:15 [debug] 15706#0: epoll timer: 60000
122013/12/17 03:00:15 [debug] 15706#0: epoll: fd:6 ev:0001 d:B6BD1198
132013/12/17 03:00:15 [debug] 15706#0: *6 http wait request handler
142013/12/17 03:00:15 [debug] 15706#0: *6 malloc: 09E1DC10:1024
152013/12/17 03:00:15 [debug] 15706#0: *6 recv: fd:6 417 of 1024
162013/12/17 03:00:15 [debug] 15706#0: *6 reusable connection: 0
172013/12/17 03:00:15 [debug] 15706#0: *6 posix_memalign: 09E22870:4096 @16
182013/12/17 03:00:15 [debug] 15706#0: *6 http process request line
192013/12/17 03:00:15 [debug] 15706#0: *6 http request line: "GET /zusccllrtqsaj2eyd2pjr7hidb6qgynecc65uzyntm6bnhuinro3ootdq7aq/v.mp4?start=5 HTTP/1.1"
202013/12/17 03:00:15 [debug] 15706#0: *6 http uri: "/zusccllrtqsaj2eyd2pjr7hidb6qgynecc65uzyntm6bnhuinro3ootdq7aq/v.mp4"
212013/12/17 03:00:15 [debug] 15706#0: *6 http args: "start=5"
222013/12/17 03:00:15 [debug] 15706#0: *6 http exten: "mp4"
232013/12/17 03:00:15 [debug] 15706#0: *6 http process request header line
242013/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"
252013/12/17 03:00:15 [debug] 15706#0: *6 http header: "Host: xvs-s1.tt"
262013/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"
272013/12/17 03:00:15 [debug] 15706#0: *6 http header: "Accept-Language: ru-RU,ru;q=0.9,en;q=0.8"
282013/12/17 03:00:15 [debug] 15706#0: *6 http header: "Accept-Encoding: gzip, deflate"
292013/12/17 03:00:15 [debug] 15706#0: *6 http header: "Connection: Keep-Alive"
302013/12/17 03:00:15 [debug] 15706#0: *6 http header done
312013/12/17 03:00:15 [debug] 15706#0: *6 event timer del: 6: 3639087
322013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 0
332013/12/17 03:00:15 [debug] 15706#0: *6 http script value: "/home/xvs-s1/cgi-bin"
342013/12/17 03:00:15 [debug] 15706#0: *6 http script set $cgidir
352013/12/17 03:00:15 [debug] 15706#0: *6 http script var
362013/12/17 03:00:15 [debug] 15706#0: *6 http script var: "GET"
372013/12/17 03:00:15 [debug] 15706#0: *6 http script regex: "^(GET|HEAD|POST)$"
382013/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"
392013/12/17 03:00:15 [debug] 15706#0: *6 http script if
402013/12/17 03:00:15 [debug] 15706#0: *6 http script if: false
412013/12/17 03:00:15 [debug] 15706#0: *6 test location: "/"
422013/12/17 03:00:15 [debug] 15706#0: *6 test location: "transfer/"
432013/12/17 03:00:15 [debug] 15706#0: *6 test location: "video_mp4/"
442013/12/17 03:00:15 [debug] 15706#0: *6 test location: "vod_handler"
452013/12/17 03:00:15 [debug] 15706#0: *6 test location: ~ "^/(\w{48,})/"
462013/12/17 03:00:15 [debug] 15706#0: *6 using configuration "^/(\w{48,})/"
472013/12/17 03:00:15 [debug] 15706#0: *6 http cl:-1 max:1048576
482013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 2
492013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 3
502013/12/17 03:00:15 [debug] 15706#0: *6 post rewrite phase: 4
512013/12/17 03:00:15 [debug] 15706#0: *6 generic phase: 5
522013/12/17 03:00:15 [debug] 15706#0: *6 generic phase: 6
532013/12/17 03:00:15 [debug] 15706#0: *6 access phase: 7
542013/12/17 03:00:15 [debug] 15706#0: *6 access phase: 8
552013/12/17 03:00:15 [debug] 15706#0: *6 post access phase: 9
562013/12/17 03:00:15 [debug] 15706#0: *6 perl handler
572013/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"
582013/12/17 03:00:15 [debug] 15706#0: *6 call_sv: 0
592013/12/17 03:00:15 [debug] 15706#0: *6 perl handler done: 0
602013/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"
612013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 0
622013/12/17 03:00:15 [debug] 15706#0: *6 http script value: "/home/xvs-s1/cgi-bin"
632013/12/17 03:00:15 [debug] 15706#0: *6 http script set $cgidir
642013/12/17 03:00:15 [debug] 15706#0: *6 http script var
652013/12/17 03:00:15 [debug] 15706#0: *6 http script var: "GET"
662013/12/17 03:00:15 [debug] 15706#0: *6 http script regex: "^(GET|HEAD|POST)$"
672013/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"
682013/12/17 03:00:15 [debug] 15706#0: *6 http script if
692013/12/17 03:00:15 [debug] 15706#0: *6 http script if: false
702013/12/17 03:00:15 [debug] 15706#0: *6 test location: "/"
712013/12/17 03:00:15 [debug] 15706#0: *6 test location: "transfer/"
722013/12/17 03:00:15 [debug] 15706#0: *6 test location: "video_mp4/"
732013/12/17 03:00:15 [debug] 15706#0: *6 test location: ~ "^/(\w{48,})/"
742013/12/17 03:00:15 [debug] 15706#0: *6 using configuration "/video_mp4/"
752013/12/17 03:00:15 [debug] 15706#0: *6 http cl:-1 max:1048576
762013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 2
772013/12/17 03:00:15 [debug] 15706#0: *6 rewrite phase: 3
782013/12/17 03:00:15 [debug] 15706#0: *6 http script complex value
792013/12/17 03:00:15 [debug] 15706#0: *6 http script var: "70k"
802013/12/17 03:00:15 [debug] 15706#0: *6 http script set var handler
812013/12/17 03:00:15 [debug] 15706#0: *6 post rewrite phase: 4
822013/12/17 03:00:15 [debug] 15706#0: *6 generic phase: 5
832013/12/17 03:00:15 [debug] 15706#0: *6 generic phase: 6
842013/12/17 03:00:15 [debug] 15706#0: shmtx lock
852013/12/17 03:00:15 [debug] 15706#0: slab alloc: 24 slot: 2
862013/12/17 03:00:15 [debug] 15706#0: slab alloc: B6ED6060
872013/12/17 03:00:15 [debug] 15706#0: *6 limit conn: 34BB8E70 1
882013/12/17 03:00:15 [debug] 15706#0: shmtx unlock
892013/12/17 03:00:15 [debug] 15706#0: *6 add cleanup: 09E233A0
902013/12/17 03:00:15 [debug] 15706#0: *6 access phase: 7
912013/12/17 03:00:15 [debug] 15706#0: *6 access phase: 8
922013/12/17 03:00:15 [debug] 15706#0: *6 post access phase: 9
932013/12/17 03:00:15 [debug] 15706#0: *6 http set discard body
942013/12/17 03:00:15 [debug] 15706#0: *6 http script var: "/home/xvs-s1/cgi-bin"
952013/12/17 03:00:15 [debug] 15706#0: *6 http script copy: "/uploads/"
962013/12/17 03:00:15 [debug] 15706#0: *6 http mp4 filename: "/home/xvs-s1/cgi-bin/uploads/01/00000/broljxe8iyse_n"
972013/12/17 03:00:15 [debug] 15706#0: *6 add cleanup: 09E233EC
982013/12/17 03:00:15 [debug] 15706#0: *6 posix_memalign: 09E23890:4096 @16
992013/12/17 03:00:15 [debug] 15706#0: *6 mp4 start:53000
1002013/12/17 03:00:15 [debug] 15706#0: *6 malloc: B6A4A008:524288
1012013/12/17 03:00:15 [debug] 15706#0: *6 read: 14, B6A4A008, 524288, 0
1022013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: ftyp @0:32
1032013/12/17 03:00:15 [debug] 15706#0: *6 mp4 ftyp atom
1042013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: moov @32:27790
1052013/12/17 03:00:15 [debug] 15706#0: *6 mp4 moov atom
1062013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mvhd @40:108
1072013/12/17 03:00:15 [debug] 15706#0: *6 mp4 mvhd atom
1082013/12/17 03:00:15 [debug] 15706#0: *6 mvhd timescale:1000, duration:33920, time:33.920s
1092013/12/17 03:00:15 [debug] 15706#0: *6 mvhd new duration:18446744073709532536, time:18446744073709532.000s
1102013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: trak @148:12228
1112013/12/17 03:00:15 [debug] 15706#0: *6 mp4 trak atom
1122013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: tkhd @156:92
1132013/12/17 03:00:15 [debug] 15706#0: *6 mp4 tkhd atom
1142013/12/17 03:00:15 [debug] 15706#0: *6 tkhd duration:33920, time:33.920s
1152013/12/17 03:00:15 [debug] 15706#0: *6 tkhd new duration:18446744073709532536, time:18446744073709532.000s
1162013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: edts @248:48
1172013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdia @296:12080
1182013/12/17 03:00:15 [debug] 15706#0: *6 process mdia atom
1192013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdhd @304:32
1202013/12/17 03:00:15 [debug] 15706#0: *6 mp4 mdhd atom
1212013/12/17 03:00:15 [debug] 15706#0: *6 mdhd timescale:12800, duration:434176, time:33.920s
1222013/12/17 03:00:15 [debug] 15706#0: *6 mdhd new duration:18446744073709307392, time:1441151880758539.750s
1232013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: hdlr @336:45
1242013/12/17 03:00:15 [debug] 15706#0: *6 mp4 hdlr atom
1252013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: minf @381:11995
1262013/12/17 03:00:15 [debug] 15706#0: *6 process minf atom
1272013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: vmhd @389:20
1282013/12/17 03:00:15 [debug] 15706#0: *6 mp4 vmhd atom
1292013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: dinf @409:36
1302013/12/17 03:00:15 [debug] 15706#0: *6 mp4 dinf atom
1312013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stbl @445:11931
1322013/12/17 03:00:15 [debug] 15706#0: *6 process stbl atom
1332013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsd @453:171
1342013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsd atom
1352013/12/17 03:00:15 [debug] 15706#0: *6 stsd entries:1, media:avc1
1362013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stts @624:24
1372013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stts atom
1382013/12/17 03:00:15 [debug] 15706#0: *6 mp4 time-to-sample entries:1
1392013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stss @648:56
1402013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stss atom
1412013/12/17 03:00:15 [debug] 15706#0: *6 sync sample entries:10
1422013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: ctts @704:4824
1432013/12/17 03:00:15 [debug] 15706#0: *6 mp4 ctts atom
1442013/12/17 03:00:15 [debug] 15706#0: *6 composition offset entries:601
1452013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsc @5528:28
1462013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsc atom
1472013/12/17 03:00:15 [debug] 15706#0: *6 sample-to-chunk entries:1
1482013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsz @5556:3412
1492013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsz atom
1502013/12/17 03:00:15 [debug] 15706#0: *6 sample uniform size:0, entries:848
1512013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stco @8968:3408
1522013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stco atom
1532013/12/17 03:00:15 [debug] 15706#0: *6 chunks:848
1542013/12/17 03:00:15 [debug] 15706#0: *6 mp4 trak atom: 0
1552013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: trak @12376:15348
1562013/12/17 03:00:15 [debug] 15706#0: *6 mp4 trak atom
1572013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: tkhd @12384:92
1582013/12/17 03:00:15 [debug] 15706#0: *6 mp4 tkhd atom
1592013/12/17 03:00:15 [debug] 15706#0: *6 tkhd duration:33891, time:33.891s
1602013/12/17 03:00:15 [debug] 15706#0: *6 tkhd new duration:18446744073709532507, time:18446744073709532.000s
1612013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: edts @12476:36
1622013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdia @12512:15212
1632013/12/17 03:00:15 [debug] 15706#0: *6 process mdia atom
1642013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdhd @12520:32
1652013/12/17 03:00:15 [debug] 15706#0: *6 mp4 mdhd atom
1662013/12/17 03:00:15 [debug] 15706#0: *6 mdhd timescale:44100, duration:1494592, time:33.891s
1672013/12/17 03:00:15 [debug] 15706#0: *6 mdhd new duration:18446744073708708908, time:418293516410628.313s
1682013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: hdlr @12552:45
1692013/12/17 03:00:15 [debug] 15706#0: *6 mp4 hdlr atom
1702013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: minf @12597:15127
1712013/12/17 03:00:15 [debug] 15706#0: *6 process minf atom
1722013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: smhd @12605:16
1732013/12/17 03:00:15 [debug] 15706#0: *6 mp4 smhd atom
1742013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: dinf @12621:36
1752013/12/17 03:00:15 [debug] 15706#0: *6 mp4 dinf atom
1762013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stbl @12657:15067
1772013/12/17 03:00:15 [debug] 15706#0: *6 process stbl atom
1782013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsd @12665:103
1792013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsd atom
1802013/12/17 03:00:15 [debug] 15706#0: *6 stsd entries:1, media:mp4a
1812013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stts @12768:32
1822013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stts atom
1832013/12/17 03:00:15 [debug] 15706#0: *6 mp4 time-to-sample entries:2
1842013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsc @12800:5656
1852013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsc atom
1862013/12/17 03:00:15 [debug] 15706#0: *6 sample-to-chunk entries:470
1872013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stsz @18456:5860
1882013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stsz atom
1892013/12/17 03:00:15 [debug] 15706#0: *6 sample uniform size:0, entries:1460
1902013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: stco @24316:3408
1912013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stco atom
1922013/12/17 03:00:15 [debug] 15706#0: *6 chunks:848
1932013/12/17 03:00:15 [debug] 15706#0: *6 mp4 trak atom: 0
1942013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: udta @27724:98
1952013/12/17 03:00:15 [debug] 15706#0: *6 mp4 moov atom done
1962013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: free @27822:8
1972013/12/17 03:00:15 [debug] 15706#0: *6 mp4 atom: mdat @27830:2134981
1982013/12/17 03:00:15 [debug] 15706#0: *6 mp4 mdat atom
1992013/12/17 03:00:15 [debug] 15706#0: *6 mp4 stts atom update
2002013/12/17 03:00:15 [debug] 15706#0: *6 time-to-sample start_time:678400
2012013/12/17 03:00:15 [debug] 15706#0: *6 count:848, duration:512
2022013/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"