Attachment 48768 Details for Bug 38800 – drm.debug=0xf dmesg snippet, showing timings of page flips

drm.debug=0xf dmesg snippet, showing timings of page flips

flips-dmesg.txt (text/plain), 11.07 KB, created by Simon Farnsworth on 2011-07-05 05:24:19 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Simon Farnsworth

Created: 2011-07-05 05:24:19 UTC

Size: 11.07 KB

patch

obsolete

>[68774.468678] [drm:drm_ioctl], pid=955, cmd=0xc01c64ae, nr=0xae, dev 0xe200, auth=1
>[68774.468694] [drm:drm_mode_addfb], [FB:45]
>[68774.468700] [drm:drm_ioctl], pid=955, cmd=0xc01864b0, nr=0xb0, dev 0xe200, auth=1
>[68774.468711] [drm:radeon_crtc_page_flip], flip-ioctl() cur_fbo = f4405600, cur_bbo = f6c63400
>[68774.468732] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.468736] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.468741] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.475219] [drm:evergreen_irq_process], r600_irq_process start: rptr 8400, wptr 8416
>[68774.475582] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1354,2)@ 1309862042.189847 -> 1309862042.189811 [e 2 us, 0 rep]
>[68774.475598] [drm:evergreen_page_flip], Update pending now high. Unlocking vupdate_lock.
>[68774.475607] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.491902] [drm:evergreen_irq_process], r600_irq_process start: rptr 8416, wptr 8432
>[68774.492265] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1325,2)@ 1309862042.206531 -> 1309862042.206496 [e 2 us, 0 rep]
>[68774.492304] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.492309] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.492314] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.492325] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.492416] [drm:drm_ioctl], pid=955, cmd=0xc00464af, nr=0xaf, dev 0xe200, auth=1
>[68774.492764] [drm:drm_ioctl], pid=1360, cmd=0xc010640b, nr=0x0b, dev 0xe200, auth=1
>[68774.492785] [drm:drm_ioctl], pid=1360, cmd=0xc00c6469, nr=0x69, dev 0xe200, auth=1
>[68774.492794] [drm:radeon_gem_get_tiling_ioctl], 
>[68774.492836] [drm:drm_ioctl], pid=1360, cmd=0x40086409, nr=0x09, dev 0xe200, auth=1
>[68774.492988] [drm:drm_ioctl], pid=1360, cmd=0xc0206466, nr=0x66, dev 0xe200, auth=1
>[68774.501921] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.501936] [drm:drm_wait_vblank], waiting on vblank count 218601, crtc 0
>[68774.501943] [drm:drm_wait_vblank], returning 218601 to client
>[68774.501956] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.501965] [drm:drm_queue_vblank_event], event on vblank count 218601, current 218601, crtc 0
>
>[68774.502164] [drm:drm_ioctl], pid=955, cmd=0xc01c64ae, nr=0xae, dev 0xe200, auth=1
>[68774.502187] [drm:drm_mode_addfb], [FB:43]
>[68774.502193] [drm:drm_ioctl], pid=955, cmd=0xc01864b0, nr=0xb0, dev 0xe200, auth=1
>[68774.502205] [drm:radeon_crtc_page_flip], flip-ioctl() cur_fbo = f6c63400, cur_bbo = f4405600
>[68774.502229] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.502237] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.502246] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.508586] [drm:evergreen_irq_process], r600_irq_process start: rptr 8432, wptr 8448
>[68774.508949] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1288,2)@ 1309862042.223215 -> 1309862042.223180 [e 3 us, 0 rep]
>[68774.508966] [drm:evergreen_page_flip], Update pending now high. Unlocking vupdate_lock.
>[68774.508974] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.525269] [drm:evergreen_irq_process], r600_irq_process start: rptr 8448, wptr 8464
>[68774.525633] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1206,2)@ 1309862042.239898 -> 1309862042.239863 [e 2 us, 0 rep]
>[68774.525672] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.525677] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.525682] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.525694] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.525780] [drm:drm_ioctl], pid=955, cmd=0xc00464af, nr=0xaf, dev 0xe200, auth=1
>[68774.526139] [drm:drm_ioctl], pid=1360, cmd=0xc010640b, nr=0x0b, dev 0xe200, auth=1
>[68774.526162] [drm:drm_ioctl], pid=1360, cmd=0xc00c6469, nr=0x69, dev 0xe200, auth=1
>[68774.526170] [drm:radeon_gem_get_tiling_ioctl], 
>[68774.526211] [drm:drm_ioctl], pid=1360, cmd=0x40086409, nr=0x09, dev 0xe200, auth=1
>[68774.526371] [drm:drm_ioctl], pid=1360, cmd=0xc0206466, nr=0x66, dev 0xe200, auth=1
>[68774.535264] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.535279] [drm:drm_wait_vblank], waiting on vblank count 218603, crtc 0
>[68774.535286] [drm:drm_wait_vblank], returning 218603 to client
>[68774.535299] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.535308] [drm:drm_queue_vblank_event], event on vblank count 218603, current 218603, crtc 0
>
>[68774.535472] [drm:drm_ioctl], pid=955, cmd=0xc01c64ae, nr=0xae, dev 0xe200, auth=1
>[68774.535488] [drm:drm_mode_addfb], [FB:45]
>[68774.535494] [drm:drm_ioctl], pid=955, cmd=0xc01864b0, nr=0xb0, dev 0xe200, auth=1
>[68774.535506] [drm:radeon_crtc_page_flip], flip-ioctl() cur_fbo = f4405600, cur_bbo = f6c63400
>[68774.535527] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.535531] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.535536] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.541954] [drm:evergreen_irq_process], r600_irq_process start: rptr 8464, wptr 8480
>[68774.542317] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1266,2)@ 1309862042.256582 -> 1309862042.256547 [e 2 us, 0 rep]
>[68774.542334] [drm:evergreen_page_flip], Update pending now high. Unlocking vupdate_lock.
>[68774.542342] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.558638] [drm:evergreen_irq_process], r600_irq_process start: rptr 8480, wptr 8496
>[68774.559002] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1399,2)@ 1309862042.273267 -> 1309862042.273231 [e 2 us, 0 rep]
>[68774.559039] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.559044] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.559049] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.559060] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.559149] [drm:drm_ioctl], pid=955, cmd=0xc00464af, nr=0xaf, dev 0xe200, auth=1
>[68774.559500] [drm:drm_ioctl], pid=1360, cmd=0xc010640b, nr=0x0b, dev 0xe200, auth=1
>[68774.559521] [drm:drm_ioctl], pid=1360, cmd=0xc00c6469, nr=0x69, dev 0xe200, auth=1
>[68774.559529] [drm:radeon_gem_get_tiling_ioctl], 
>[68774.559570] [drm:drm_ioctl], pid=1360, cmd=0x40086409, nr=0x09, dev 0xe200, auth=1
>[68774.559723] [drm:drm_ioctl], pid=1360, cmd=0xc0206466, nr=0x66, dev 0xe200, auth=1
>[68774.568616] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.568632] [drm:drm_wait_vblank], waiting on vblank count 218605, crtc 0
>[68774.568639] [drm:drm_wait_vblank], returning 218605 to client
>[68774.568652] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.568661] [drm:drm_queue_vblank_event], event on vblank count 218605, current 218605, crtc 0
>
>[68774.568825] [drm:drm_ioctl], pid=955, cmd=0xc01c64ae, nr=0xae, dev 0xe200, auth=1
>[68774.568840] [drm:drm_mode_addfb], [FB:43]
>[68774.568846] [drm:drm_ioctl], pid=955, cmd=0xc01864b0, nr=0xb0, dev 0xe200, auth=1
>[68774.568858] [drm:radeon_crtc_page_flip], flip-ioctl() cur_fbo = f6c63400, cur_bbo = f4405600
>[68774.568878] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.568882] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.568887] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.575322] [drm:evergreen_irq_process], r600_irq_process start: rptr 8496, wptr 8512
>[68774.575685] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1322,2)@ 1309862042.289951 -> 1309862042.289916 [e 3 us, 0 rep]
>[68774.575702] [drm:evergreen_page_flip], Update pending now high. Unlocking vupdate_lock.
>[68774.575711] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.592006] [drm:evergreen_irq_process], r600_irq_process start: rptr 8512, wptr 8528
>[68774.592370] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1379,2)@ 1309862042.306635 -> 1309862042.306599 [e 2 us, 0 rep]
>[68774.592407] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.592412] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.592417] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.592429] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.592517] [drm:drm_ioctl], pid=955, cmd=0xc00464af, nr=0xaf, dev 0xe200, auth=1
>[68774.592868] [drm:drm_ioctl], pid=1360, cmd=0xc010640b, nr=0x0b, dev 0xe200, auth=1
>[68774.592890] [drm:drm_ioctl], pid=1360, cmd=0xc00c6469, nr=0x69, dev 0xe200, auth=1
>[68774.592898] [drm:radeon_gem_get_tiling_ioctl], 
>[68774.592940] [drm:drm_ioctl], pid=1360, cmd=0x40086409, nr=0x09, dev 0xe200, auth=1
>[68774.593143] [drm:drm_ioctl], pid=1360, cmd=0xc0206466, nr=0x66, dev 0xe200, auth=1
>[68774.602077] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.602094] [drm:drm_wait_vblank], waiting on vblank count 218607, crtc 0
>[68774.602101] [drm:drm_wait_vblank], returning 218607 to client
>[68774.602113] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.602122] [drm:drm_queue_vblank_event], event on vblank count 218607, current 218607, crtc 0
>
>[68774.602285] [drm:drm_ioctl], pid=955, cmd=0xc01c64ae, nr=0xae, dev 0xe200, auth=1
>[68774.602300] [drm:drm_mode_addfb], [FB:45]
>[68774.602307] [drm:drm_ioctl], pid=955, cmd=0xc01864b0, nr=0xb0, dev 0xe200, auth=1
>[68774.602318] [drm:radeon_crtc_page_flip], flip-ioctl() cur_fbo = f4405600, cur_bbo = f6c63400
>[68774.602339] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.602343] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.602348] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.608689] [drm:evergreen_irq_process], r600_irq_process start: rptr 8528, wptr 8544
>[68774.609052] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1154,2)@ 1309862042.323318 -> 1309862042.323284 [e 3 us, 0 rep]
>[68774.609069] [drm:evergreen_page_flip], Update pending now high. Unlocking vupdate_lock.
>[68774.609077] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.625374] [drm:evergreen_irq_process], r600_irq_process start: rptr 8544, wptr 8560
>[68774.625737] [drm:drm_calc_vbltimestamp_from_scanoutpos], crtc 0 : v 5 p(1310,2)@ 1309862042.340003 -> 1309862042.339968 [e 3 us, 0 rep]
>[68774.625774] [drm:evergreen_irq_set], evergreen_irq_set: vblank 0
>[68774.625779] [drm:evergreen_irq_set], evergreen_irq_set: vblank 1
>[68774.625784] [drm:evergreen_irq_set], evergreen_irq_set: hpd 2
>[68774.625796] [drm:evergreen_irq_process], IH: D1 vblank
>[68774.625883] [drm:drm_ioctl], pid=955, cmd=0xc00464af, nr=0xaf, dev 0xe200, auth=1
>[68774.626204] [drm:drm_ioctl], pid=1360, cmd=0xc010640b, nr=0x0b, dev 0xe200, auth=1
>[68774.626221] [drm:drm_ioctl], pid=1360, cmd=0xc00c6469, nr=0x69, dev 0xe200, auth=1
>[68774.626229] [drm:radeon_gem_get_tiling_ioctl], 
>[68774.626266] [drm:drm_ioctl], pid=1360, cmd=0x40086409, nr=0x09, dev 0xe200, auth=1
>[68774.626425] [drm:drm_ioctl], pid=1360, cmd=0xc0206466, nr=0x66, dev 0xe200, auth=1
>[68774.635308] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.635323] [drm:drm_wait_vblank], waiting on vblank count 218609, crtc 0
>[68774.635330] [drm:drm_wait_vblank], returning 218609 to client
>[68774.635343] [drm:drm_ioctl], pid=955, cmd=0xc010643a, nr=0x3a, dev 0xe200, auth=1
>[68774.635352] [drm:drm_queue_vblank_event], event on vblank count 218609, current 218609, crtc 0

Actions: View

Attachments on bug 38800: 48588 | 48589 | 48590 | 48657 | 48768 | 48883 | 48888 | 48892 | 48897 | 48898

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.