wrong fps during the play

[gventuri]

Hello,
I've got an m4v file that on VLC doesn't play correctly I tryed it on VLC 1.0.2 and 1.1.4 on Linux and on 0.9.8a and 1.1.4 on Windows. The result is the same, so it's a generic VLC issue. In the information of the media VLC says 100 frame per second, but opening it on mplayer it says about 7 fps, so mplayer reproduces it correctly with its ~7 fps and VLC plays it very quickly with its 100 fps. Why the fps detection is not correct on VLC? How can I set it manually? I tryed the option --vc1-fps using 7 as value, 0.25 as value, but the parameter is ignored. How can I do? What is the correct option?
The fps is something that is written into the original file? I suppose it's evalued by the software that plays the clip. How is determined by VLC?
Thank you,
Giovanni

[Lotesdelere]

Open Tools -> Messages (set Verbosity to 2) before you start the playback and then paste the resulting log here.
Also upload a SHORT sample of a non working file on some file sharing site like Rapidshare or Megaupload.

[gventuri]

Open Tools -> Messages (set Verbosity to 2) before you start the playback and then paste the resulting log here.
Also upload a SHORT sample of a non working file on some file sharing site like Rapidshare or Megaupload.

main debug: adding item `1278324008.m4v' ( /home/giovanni/1278324008.m4v )
main debug: rebuilding array of current - root Scaletta
main debug: rebuild done - 1 items, index -1
main debug: processing request item 1278324008.m4v node null skip 0
main debug: resyncing on 1278324008.m4v
main debug: 1278324008.m4v is at 0
main debug: starting new item
main debug: creating new input thread
main debug: Creating an input for '1278324008.m4v'
main debug: thread started
main debug: using timeshift granularity of 50 MBytes
main debug: using timeshift path '/tmp'
qt4 debug: Adding a new MRL to recent ones: /home/giovanni/1278324008.m4v
main debug: thread (input) created at priority 10 (input/input.c:230)
main debug: `/home/giovanni/1278324008.m4v' gives access `' demux `' path `/home/giovanni/1278324008.m4v'
main debug: creating demux: access='' demux='' path='/home/giovanni/1278324008.m4v'
main debug: looking for access_demux module: 7 candidates
qt4 debug: IM: Setting an input
qt4 debug: Updating the geometry
qt4 debug: Updating the geometry
main debug: TIMER module_need() : 105,390 ms - Total 105,390 ms / 1 intvls (Avg 105,390 ms)
main debug: creating access '' path='/home/giovanni/1278324008.m4v'
main debug: looking for access module: 9 candidates
vcd debug: trying .cue file: /home/giovanni/1278324008.cue
vcd debug: could not find .cue file
access_file debug: opening file `/home/giovanni/1278324008.m4v'
main debug: using access module "access_file"
main debug: TIMER module_need() : 44,193 ms - Total 44,193 ms / 1 intvls (Avg 44,193 ms)
main debug: Using AStream*Stream
main debug: pre buffering
main debug: received first data after 0 ms
main debug: pre-buffering done 1024 bytes in 0s - 40000 kbytes/s
main debug: looking for stream_filter module: 4 candidates
main debug: TIMER module_need() : 0,256 ms - Total 0,256 ms / 1 intvls (Avg 0,256 ms)
main debug: looking for stream_filter module: 1 candidate
main debug: using stream_filter module "stream_filter_record"
main debug: TIMER module_need() : 0,439 ms - Total 0,439 ms / 1 intvls (Avg 0,439 ms)
main debug: creating demux: access='' demux='' path='/home/giovanni/1278324008.m4v'
main debug: looking for demux module: 49 candidates
m4v warning: m4v module discarded (no startcode)
ts warning: TS module discarded (lost sync)
avformat debug: detected format: m4v
main debug: selecting program id=0
qt4 debug: Updating the geometry
avformat debug: adding es: video codec = DIVX
avformat debug: AVFormat supported stream
avformat debug: - format = m4v (raw MPEG-4 video format)
avformat debug: - start time = -1
avformat debug: - duration = -1
main debug: using demux module "avformat"
main debug: TIMER module_need() : 730,406 ms - Total 730,406 ms / 1 intvls (Avg 730,406 ms)
main debug: looking for a subtitle file in /home/giovanni/
main debug: looking for decoder module: 30 candidates
qt4 debug: Updating the geometry
qt4 debug: Updating the geometry
qt4 debug: Updating the geometry
qt4 debug: Updating the geometry
avcodec debug: libavcodec initialized (interface 0x342300)
avcodec debug: using direct rendering
avcodec debug: ffmpeg codec (MPEG-4 Video) started
main debug: using decoder module "avcodec"
main debug: TIMER module_need() : 201,217 ms - Total 201,217 ms / 1 intvls (Avg 201,217 ms)
main debug: thread started
main debug: thread (decoder) created at priority 0 (input/decoder.c:315)
main debug: looking for meta reader module: 1 candidate
qt4 debug: Updating the geometry
qt4 debug: Updating the geometry
main debug: TIMER module_need() : 58,314 ms - Total 58,314 ms / 1 intvls (Avg 58,314 ms)
main debug: `/home/giovanni/1278324008.m4v' successfully opened
main debug: Buffering 0%
main debug: Buffering 3%
main debug: Buffering 6%
main debug: Buffering 10%
main debug: Buffering 13%
main debug: Buffering 16%
main debug: Buffering 20%
main debug: Buffering 23%
main debug: Buffering 26%
main debug: Buffering 29%
main debug: Buffering 33%
main debug: Buffering 36%
main debug: Buffering 40%
main debug: Buffering 43%
main debug: Buffering 46%
main debug: Buffering 50%
main debug: Buffering 53%
main debug: Buffering 56%
main debug: Buffering 59%
main debug: Buffering 63%
main debug: no usable vout present, spawning one
main debug: looking for text renderer module: 2 candidates
qt4 debug: New caching: 63
qt4 debug: New caching: 63
main debug: Buffering 66%
main debug: Buffering 69%
main debug: Buffering 73%
main debug: Buffering 76%
main debug: Buffering 80%
main debug: Buffering 83%
main debug: Buffering 86%
main debug: Buffering 90%
main debug: Buffering 93%
main debug: Buffering 96%
main debug: Buffering 100%
main debug: Stream buffering done (310 ms in 17 ms)
main debug: thread started
freetype debug: Building font database...
freetype debug: Finished building font database.
freetype debug: Took 1944 microseconds
main debug: thread (fontlist builder) created at priority 0 (freetype.c:475)
main debug: thread ended
freetype debug: using fontsize: 2
main debug: using text renderer module "freetype"
main debug: TIMER module_need() : 50,683 ms - Total 50,683 ms / 1 intvls (Avg 50,683 ms)
main debug: looking for video filter2 module: 20 candidates
qt4 debug: New caching: 100
qt4 debug: New caching: 100
swscale debug: 32x32 chroma: YUVA -> 16x16 chroma: YUVA with scaling using Bicubic (good quality)
main debug: using video filter2 module "swscale"
main debug: TIMER module_need() : 66,175 ms - Total 66,175 ms / 1 intvls (Avg 66,175 ms)
main debug: looking for video filter2 module: 20 candidates
yuvp debug: YUVP to YUVA converter
main debug: using video filter2 module "yuvp"
main debug: TIMER module_need() : 28,553 ms - Total 28,553 ms / 1 intvls (Avg 28,553 ms)
main debug: window size: 640x480
main debug: looking for video output module: 7 candidates
xvideo debug: adaptor 0, port 80, format 0x32315659 (YV12) planar
main debug: looking for xwindow module: 3 candidates
qt4 debug: requesting video...
qt4 debug: Video was requested -1, -1
qt4 debug: Video is resizing to: 640 480
qt4 debug: Updating the geometry
main debug: using xwindow module "qt4"
main debug: TIMER module_need() : 27,687 ms - Total 27,687 ms / 1 intvls (Avg 27,687 ms)
xvideo debug: XShm video extension v1.1 (without pixmaps, opcode: 139)
xvideo debug: Window manager supports NetWM
xvideo debug: Window manager supports _NET_WM_STATE_FULLSCREEN
xvideo debug: Window manager supports _NET_WM_STATE_ABOVE
xvideo debug: Window manager supports _NET_WM_STATE_BELOW
xvideo debug: Window manager supports _NET_WM_STATE_STAYS_ON_TOP
main debug: using video output module "xvideo"
main debug: TIMER module_need() : 487,775 ms - Total 487,775 ms / 1 intvls (Avg 487,775 ms)
main debug: Deinterlacing available
main debug: got 16 direct buffer(s)
main debug: pic render sz 640x480, of (0,0), vsz 640x480, 4cc I420, ar 4:3, sar 1:1, msk r0x0 g0x0 b0x0
main debug: pic in sz 640x480, of (0,0), vsz 640x480, 4cc I420, ar 4:3, sar 1:1, msk r0x0 g0x0 b0x0
main debug: pic out sz 640x480, of (0,0), vsz 640x480, 4cc I420, ar 4:3, sar 1:1, msk r0x0 g0x0 b0x0
main debug: direct render, mapping render pictures 0-14 to system pictures 1-15
qt4 debug: Qt: Entering Fullscreen
main debug: End of video preroll
main debug: Received first picture
freetype debug: using fontsize: 30
main debug: looking for video blending module: 1 candidate
blend debug: chroma: YUVA -> I420
main debug: using video blending module "blend"
main debug: TIMER module_need() : 2,465 ms - Total 2,465 ms / 1 intvls (Avg 2,465 ms)
main debug: Post-processing available
main debug: Decoder buffering done in 968 ms
main warning: late picture skipped (230 > -1083)
main warning: late picture skipped (-89 > -692)
main warning: late picture skipped (12016 > -692)
main warning: late picture skipped (23203 > -754)
main warning: late picture skipped (32833 > -754)
main warning: late picture skipped (45988 > -756)
main warning: late picture skipped (56180 > -756)
main warning: late picture skipped (409 > -755)
main warning: late picture skipped (25741 > -745)
main warning: late picture skipped (37368 > -745)
main warning: late picture skipped (53117 > -778)
main warning: late picture skipped (61220 > -778)
main warning: late picture skipped (1232 > -731)
main warning: late picture skipped (17052 > -731)
main warning: late picture skipped (28360 > -739)
main warning: late picture skipped (52160 > -740)
main warning: late picture skipped (62664 > -740)
main warning: late picture skipped (-13 > -697)
main warning: late picture skipped (15113 > -697)
main warning: late picture skipped (29131 > -720)
main warning: late picture skipped (61729 > -712)
main warning: late picture skipped (75742 > -712)
main warning: late picture skipped (92131 > -750)
main warning: late picture skipped (8291 > -749)
main warning: late picture skipped (24508 > -749)
main warning: late picture skipped (48069 > -761)
main warning: late picture skipped (56551 > -761)
main warning: late picture skipped (76395 > -795)
main warning: late picture skipped (4096 > -648)
main warning: late picture skipped (11932 > -648)
main warning: late picture skipped (28704 > -695)
main warning: late picture skipped (39409 > -695)
main warning: late picture skipped (65596 > -735)
main warning: late picture skipped (6231 > -643)
main warning: late picture skipped (22698 > -643)
main warning: late picture skipped (38490 > -713)
main warning: late picture skipped (59786 > -713)
main warning: late picture skipped (81413 > -736)
main warning: late picture skipped (-16 > -763)
main warning: late picture skipped (18250 > -763)
main warning: late picture skipped (38046 > -791)
main warning: late picture skipped (52566 > -791)
main warning: late picture skipped (70115 > -796)
main warning: late picture skipped (87060 > -796)
main warning: late picture skipped (9885 > -801)
main warning: late picture skipped (27534 > -801)
main warning: late picture skipped (44189 > -801)
main warning: late picture skipped (67300 > -801)
main warning: late picture skipped (84493 > -821)
main warning: late picture skipped (2837 > -788)
main warning: late picture skipped (15870 > -788)
main warning: late picture skipped (32672 > -802)
main warning: late picture skipped (49079 > -802)
main warning: late picture skipped (65938 > -799)
main warning: late picture skipped (1718 > -684)
main warning: late picture skipped (18326 > -684)
main warning: late picture skipped (37851 > -711)
main warning: late picture skipped (48610 > -711)
main warning: late picture skipped (60030 > -737)
main warning: late picture skipped (-548 > -646)
main warning: late picture skipped (13892 > -646)
main warning: late picture skipped (29812 > -733)
main warning: late picture skipped (44651 > -733)
main warning: late picture skipped (61315 > -758)
main warning: late picture skipped (73326 > -758)
main warning: late picture skipped (3477 > -795)
main warning: late picture skipped (64062 > -798)
main warning: late picture skipped (126105 > -843)
main warning: late picture skipped (138966 > -843)
main warning: late picture skipped (172533 > -844)
main warning: late picture skipped (1484 > -15)
main warning: late picture skipped (17118 > -15)
main warning: late picture skipped (28454 > -24)
main warning: late picture skipped (85474 > -22)
main warning: late picture skipped (89207 > -22)
main warning: late picture skipped (9650 > -12)
main warning: late picture skipped (33268 > -12)
main warning: late picture skipped (83328 > -21)
main warning: late picture skipped (101785 > -19)
main warning: late picture skipped (131070 > -19)
avcodec error: more than 5 seconds of late video -> dropping frame (computer too slow ?)
main warning: late picture skipped (179452 > -12)
main warning: late picture skipped (186879 > -12)
main warning: late picture skipped (205747 > -13)
main warning: late picture skipped (216131 > -13)
main warning: late picture skipped (231394 > -13)
main warning: late picture skipped (1918 > -12)
main warning: late picture skipped (9585 > -12)
main warning: late picture skipped (32425 > -12)
main warning: late picture skipped (43244 > -12)
main warning: late picture skipped (54361 > -13)
main warning: late picture skipped (1703 > -13)
main warning: late picture skipped (19144 > -13)
main warning: late picture skipped (30824 > -21)
main warning: late picture skipped (59456 > -19)
main warning: late picture skipped (71090 > -19)
main warning: late picture skipped (12067 > -16)
main warning: late picture skipped (30783 > -16)
main warning: late picture skipped (49539 > -23)
main warning: late picture skipped (59073 > -23)
main warning: late picture skipped (74628 > -28)
main warning: late picture skipped (1351 > -13)
main warning: late picture skipped (16596 > -13)
main warning: late picture skipped (28414 > -18)
main warning: late picture skipped (40035 > -18)
main warning: late picture skipped (62954 > -30)
main warning: late picture skipped (2839 > -16)
main warning: late picture skipped (19131 > -16)
main warning: late picture skipped (34563 > -22)
main warning: late picture skipped (64630 > -19)
main warning: late picture skipped (79550 > -19)
main warning: late picture skipped (5481 > -13)
main warning: late picture skipped (19772 > -13)
main warning: late picture skipped (37671 > -20)
main warning: late picture skipped (56275 > -20)
main warning: late picture skipped (72488 > -26)
main warning: late picture skipped (1922 > -13)
main warning: late picture skipped (17202 > -13)
main warning: late picture skipped (34402 > -19)
main warning: late picture skipped (64736 > -17)
main warning: late picture skipped (79074 > -17)
main warning: late picture skipped (96825 > -15)
main warning: late picture skipped (1893 > -13)
main warning: late picture skipped (9582 > -13)
main warning: late picture skipped (26870 > -13)
main warning: late picture skipped (42403 > -13)
main warning: late picture skipped (74741 > -12)
main warning: late picture skipped (27 > -13)
main warning: late picture skipped (16167 > -13)
main warning: late picture skipped (41651 > -20)
main warning: late picture skipped (54262 > -20)
main warning: late picture skipped (71436 > -27)
main warning: late picture skipped (87800 > -27)
main warning: late picture skipped (1991 > -17)
main warning: late picture skipped (18898 > -17)
main warning: late picture skipped (35773 > -21)
main warning: late picture skipped (62167 > -19)
main warning: late picture skipped (82422 > -19)
main warning: late picture skipped (14390 > -14)
main warning: late picture skipped (28191 > -14)
main warning: late picture skipped (44395 > -14)
main warning: late picture skipped (61790 > -14)
main warning: late picture skipped (77344 > -20)
main warning: late picture skipped (4023 > -13)
main warning: late picture skipped (26680 > -13)
main warning: late picture skipped (41746 > -19)
main warning: late picture skipped (67750 > -17)
main warning: late picture skipped (81623 > -17)
main warning: late picture skipped (17943 > -13)
main warning: late picture skipped (39419 > -21)
main warning: late picture skipped (74837 > -19)
main warning: late picture skipped (86226 > -19)
main warning: late picture skipped (104281 > -25)
main warning: late picture skipped (4918 > -14)
main warning: late picture skipped (19001 > -14)
main warning: late picture skipped (28091 > -19)
main warning: late picture skipped (45370 > -19)
main warning: late picture skipped (63734 > -24)
main warning: late picture skipped (3897 > -13)
main warning: late picture skipped (17678 > -13)
main warning: late picture skipped (36339 > -19)
main warning: late picture skipped (51320 > -19)
main warning: late picture skipped (62579 > -24)
main warning: late picture skipped (9480 > -14)
main warning: late picture skipped (16773 > -14)
main warning: late picture skipped (29636 > -14)
main warning: late picture skipped (46690 > -14)
main warning: late picture skipped (69309 > -13)
main warning: late picture skipped (4564 > -13)
main warning: late picture skipped (9778 > -13)
main warning: late picture skipped (26475 > -13)
main warning: late picture skipped (42482 > -13)
main warning: late picture skipped (57338 > -13)
main warning: late picture skipped (9833 > -23)
main warning: late picture skipped (18289 > -23)
main warning: late picture skipped (43213 > -27)
main warning: late picture skipped (59126 > -27)
main warning: late picture skipped (69872 > -30)
main warning: late picture skipped (3392 > -13)
main warning: late picture skipped (16143 > -13)
main warning: late picture skipped (30913 > -20)
main warning: late picture skipped (47202 > -20)
main warning: late picture skipped (69622 > -26)
main warning: late picture skipped (1620 > -13)
main warning: late picture skipped (15563 > -13)
main warning: late picture skipped (34879 > -18)
main warning: late picture skipped (47626 > -18)
main warning: late picture skipped (65361 > -23)
main warning: late picture skipped (1458 > -13)
main warning: late picture skipped (19755 > -13)
main warning: late picture skipped (44884 > -19)
main warning: late picture skipped (59285 > -19)
main warning: late picture skipped (75982 > -24)
main warning: late picture skipped (1126 > -14)
main warning: late picture skipped (16505 > -14)
main warning: late picture skipped (34256 > -14)
main warning: late picture skipped (47415 > -14)
main warning: late picture skipped (63616 > -14)
main warning: late picture skipped (880 > -13)
main warning: late picture skipped (14129 > -13)
main warning: late picture skipped (25114 > -18)
main warning: late picture skipped (42387 > -18)
main warning: late picture skipped (56384 > -23)
main warning: late picture skipped (760 > -16)
main warning: late picture skipped (14040 > -16)
main warning: late picture skipped (39264 > -24)
main warning: late picture skipped (53277 > -24)
main warning: late picture skipped (64780 > -28)
main warning: late picture skipped (671 > -14)
main warning: late picture skipped (14107 > -14)
main warning: late picture skipped (41702 > -18)
main warning: late picture skipped (53516 > -16)
main warning: late picture skipped (68701 > -16)
main warning: late picture skipped (3665 > -13)
main warning: late picture skipped (17147 > -13)
main warning: late picture skipped (28084 > -19)
main warning: late picture skipped (58824 > -17)
main warning: late picture skipped (71689 > -17)
main warning: late picture skipped (1817 > -13)
main warning: late picture skipped (14819 > -13)
main warning: late picture skipped (33919 > -19)
main warning: late picture skipped (48115 > -19)
main warning: late picture skipped (66979 > -24)
main warning: late picture skipped (5136 > -15)
main warning: late picture skipped (21953 > -21)
main warning: late picture skipped (36882 > -21)
main warning: late picture skipped (54437 > -27)
main warning: late picture skipped (68078 > -27)
main warning: late picture skipped (1082 > -15)
main warning: late picture skipped (15897 > -15)
main warning: late picture skipped (34307 > -20)
main warning: late picture skipped (47590 > -20)
main warning: late picture skipped (65072 > -25)
main warning: late picture skipped (3088 > -13)
main warning: late picture skipped (18617 > -13)
main warning: late picture skipped (35111 > -20)
main warning: late picture skipped (56857 > -20)
main warning: late picture skipped (65047 > -25)
main warning: late picture skipped (1031 > -13)
main warning: late picture skipped (12739 > -13)
main warning: late picture skipped (29637 > -17)
main warning: late picture skipped (46129 > -17)
main warning: late picture skipped (67726 > -21)
main warning: late picture skipped (15403 > -13)
main warning: late picture skipped (28981 > -13)
main warning: late picture skipped (45072 > -13)
main warning: late picture skipped (58180 > -13)
main warning: late picture skipped (74109 > -20)
main warning: late picture skipped (1150 > -14)
main warning: late picture skipped (14842 > -14)
main warning: late picture skipped (24978 > -21)
main warning: late picture skipped (41548 > -21)
main warning: late picture skipped (58898 > -27)
main debug: EOF reached
main debug: waiting decoder fifos to empty
main debug: waiting decoder fifos to empty
main debug: waiting decoder fifos to empty
main warning: late picture skipped (4134 > -26)
main warning: late picture skipped (19154 > -26)
main warning: late picture skipped (27224 > -22)
main warning: late picture skipped (42742 > -22)
main debug: waiting decoder fifos to empty
main warning: late picture skipped (72699 > -20)
main debug: finished input
avcodec debug: ffmpeg codec (MPEG-4 Video) stopped
main debug: removing module "avcodec"
main debug: killing decoder fourcc `DIVX', 0 PES in FIFO
main debug: [0] 4 0
main debug: [1] 4 0
main debug: [2] 4 0
main debug: [3] 4 0
main debug: [4] 4 0
main debug: [5] 4 0
main debug: [6] 4 0
main debug: [7] 4 0
main debug: [8] 4 0
main debug: [9] 2 0
main debug: [10] 4 0
main debug: [11] 4 0
main debug: [12] 4 0
main debug: [13] 4 0
main debug: [14] 4 0
main debug: saving a free vout
main debug: removing module "avformat"
main debug: removing module "stream_filter_record"
main debug: removing module "access_file"
main debug: Program doesn't contain anymore ES
main debug: thread ended
main debug: dead input
main debug: changing item without a request (current 0/1)
main debug: nothing to play
main debug: destroying useless vout
qt4 debug: IM: Deleting the input
qt4 debug: Updating the geometry
qt4 debug: Updating the geometry
qt4 debug: Qt: Entering Fullscreen
main debug: TIMER input launching for '1278324008.m4v' : 1186,362 ms - Total 1186,362 ms / 1 intvls (Avg 1186,362 ms)
qt4 debug: releasing video...
qt4 debug: Video is not needed anymore
qt4 debug: Updating the geometry
main debug: removing module "qt4"
main debug: removing module "xvideo"
main debug: removing module "blend"
main debug: removing module "freetype"
main debug: removing module "yuvp"
main debug: removing module "swscale"


I cannot upload the video because of privacy. It's a clip from an Axis Network Camera into a train station.

[Lotesdelere]

Sorry but we do need a sample. 10 MB will be enough.