Attachment 101568 Details for Bug 70461 – xorg.log full debug

xorg.log full debug

Xorg.0.log.old (text/plain), 168.02 KB, created by Jiri Slaby on 2014-06-23 10:28:14 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Jiri Slaby

Created: 2014-06-23 10:28:14 UTC

Size: 168.02 KB

patch

obsolete

>[  1903.328] 
>This is a pre-release version of the X server from The X.Org Foundation.
>It is not supported in any way.
>Bugs may be filed in the bugzilla at http://bugs.freedesktop.org/.
>Select the "xorg" product for bugs you find in this release.
>Before reporting bugs in pre-release versions please check the
>latest version in the X.Org Foundation git repository.
>See http://wiki.x.org/wiki/GitPage for git access instructions.
>[  1903.328] 
>X.Org X Server 1.14.3.901 (1.14.4 RC 1)
>Release Date: 2013-10-26
>[  1903.328] X Protocol Version 11, Revision 0
>[  1903.328] Build Operating System: openSUSE SUSE LINUX
>[  1903.328] Current Operating System: Linux anemoi 3.15.1-2-desktop #1 SMP PREEMPT Tue Jun 17 09:03:21 UTC 2014 (fb8e7ed) x86_64
>[  1903.328] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.15.1-2-desktop root=UUID=873864b1-7b56-463c-bdf6-f942627d9ab6 resume=/dev/sda3 commit=60 ipv6.disable=1 systemd.show_status=1 processor.ignore_ppc=1 nmi_watchdog=0 efi_no_storage_paranoia=1
>[  1903.328] Build Date: 17 April 2014  05:37:34AM
>[  1903.328]  
>[  1903.328] Current version of pixman: 0.30.2
>[  1903.328] 	Before reporting problems, check http://wiki.x.org
>	to make sure that you have the latest version.
>[  1903.328] Markers: (--) probed, (**) from config file, (==) default setting,
>	(++) from command line, (!!) notice, (II) informational,
>	(WW) warning, (EE) error, (NI) not implemented, (??) unknown.
>[  1903.328] (==) Log file: "/var/log/Xorg.0.log", Time: Mon Jun 23 12:25:12 2014
>[  1903.328] (==) Using config directory: "/etc/X11/xorg.conf.d"
>[  1903.328] (==) Using system config directory "/usr/share/X11/xorg.conf.d"
>[  1903.329] (==) No Layout section.  Using the first Screen section.
>[  1903.329] (==) No screen section available. Using defaults.
>[  1903.329] (**) |-->Screen "Default Screen Section" (0)
>[  1903.329] (**) |   |-->Monitor "<default monitor>"
>[  1903.329] (==) No device specified for screen "Default Screen Section".
>	Using the first device section listed.
>[  1903.329] (**) |   |-->Device "Default Device"
>[  1903.329] (==) No monitor specified for screen "Default Screen Section".
>	Using a default monitor configuration.
>[  1903.329] (==) Automatically adding devices
>[  1903.329] (==) Automatically enabling devices
>[  1903.329] (==) Automatically adding GPU devices
>[  1903.329] (WW) The directory "/usr/share/fonts/misc/sgi" does not exist.
>[  1903.329] 	Entry deleted from font path.
>[  1903.329] (==) FontPath set to:
>	/usr/share/fonts/misc:unscaled,
>	/usr/share/fonts/Type1/,
>	/usr/share/fonts/100dpi:unscaled,
>	/usr/share/fonts/75dpi:unscaled,
>	/usr/share/fonts/ghostscript/,
>	/usr/share/fonts/cyrillic:unscaled,
>	/usr/share/fonts/truetype/,
>	built-ins
>[  1903.329] (**) ModulePath set to "/opt/ddx/lib64/xorg/modules/,/usr/lib64/xorg/modules"
>[  1903.329] (II) The server relies on udev to provide the list of input devices.
>	If no devices become available, reconfigure udev or disable AutoAddDevices.
>[  1903.329] (II) Loader magic: 0x803c20
>[  1903.329] (II) Module ABI versions:
>[  1903.329] 	X.Org ANSI C Emulation: 0.4
>[  1903.329] 	X.Org Video Driver: 14.1
>[  1903.329] 	X.Org XInput driver : 19.1
>[  1903.329] 	X.Org Server Extension : 7.0
>[  1903.329] (II) xfree86: Adding drm device (/dev/dri/card0)
>[  1903.331] (--) PCI:*(0:0:2:0) 8086:0166:17aa:21fa rev 9, Mem @ 0xf0000000/4194304, 0xe0000000/268435456, I/O @ 0x00005000/64
>[  1903.331] Initializing built-in extension Generic Event Extension
>[  1903.331] Initializing built-in extension SHAPE
>[  1903.331] Initializing built-in extension MIT-SHM
>[  1903.331] Initializing built-in extension XInputExtension
>[  1903.331] Initializing built-in extension XTEST
>[  1903.331] Initializing built-in extension BIG-REQUESTS
>[  1903.331] Initializing built-in extension SYNC
>[  1903.331] Initializing built-in extension XKEYBOARD
>[  1903.331] Initializing built-in extension XC-MISC
>[  1903.331] Initializing built-in extension SECURITY
>[  1903.331] Initializing built-in extension XINERAMA
>[  1903.331] Initializing built-in extension XFIXES
>[  1903.331] Initializing built-in extension RENDER
>[  1903.331] Initializing built-in extension RANDR
>[  1903.331] Initializing built-in extension COMPOSITE
>[  1903.331] Initializing built-in extension DAMAGE
>[  1903.331] Initializing built-in extension MIT-SCREEN-SAVER
>[  1903.331] Initializing built-in extension DOUBLE-BUFFER
>[  1903.331] Initializing built-in extension RECORD
>[  1903.331] Initializing built-in extension DPMS
>[  1903.331] Initializing built-in extension X-Resource
>[  1903.331] Initializing built-in extension XVideo
>[  1903.331] Initializing built-in extension XVideo-MotionCompensation
>[  1903.331] Initializing built-in extension XFree86-VidModeExtension
>[  1903.331] Initializing built-in extension XFree86-DGA
>[  1903.331] Initializing built-in extension XFree86-DRI
>[  1903.331] Initializing built-in extension DRI2
>[  1903.331] (II) "glx" will be loaded by default.
>[  1903.331] (II) LoadModule: "dri2"
>[  1903.331] (II) Module "dri2" already built-in
>[  1903.331] (II) LoadModule: "glamoregl"
>[  1903.331] (II) Loading /usr/lib64/xorg/modules/libglamoregl.so
>[  1903.333] (II) Module glamoregl: vendor="X.Org Foundation"
>[  1903.333] 	compiled for 1.14.3.901, module version = 0.5.1
>[  1903.333] 	ABI class: X.Org ANSI C Emulation, version 0.4
>[  1903.333] (II) LoadModule: "glx"
>[  1903.333] (II) Loading /usr/lib64/xorg/modules/extensions/libglx.so
>[  1903.333] (II) Module glx: vendor="X.Org Foundation"
>[  1903.333] 	compiled for 1.14.3.901, module version = 1.0.0
>[  1903.333] 	ABI class: X.Org Server Extension, version 7.0
>[  1903.333] (==) AIGLX enabled
>[  1903.333] Loading extension GLX
>[  1903.333] (II) LoadModule: "intel"
>[  1903.333] (II) Loading /opt/ddx/lib64/xorg/modules/drivers/intel_drv.so
>[  1903.333] (II) Module intel: vendor="X.Org Foundation"
>[  1903.333] 	compiled for 1.14.3.901, module version = 2.99.912
>[  1903.333] 	Module class: X.Org Video Driver
>[  1903.333] 	ABI class: X.Org Video Driver, version 14.1
>[  1903.333] (II) intel: Driver for Intel(R) Integrated Graphics Chipsets:
>	i810, i810-dc100, i810e, i815, i830M, 845G, 854, 852GM/855GM, 865G,
>	915G, E7221 (i915), 915GM, 945G, 945GM, 945GME, Pineview GM,
>	Pineview G, 965G, G35, 965Q, 946GZ, 965GM, 965GME/GLE, G33, Q35, Q33,
>	GM45, 4 Series, G45/G43, Q45/Q43, G41, B43
>[  1903.334] (II) intel: Driver for Intel(R) HD Graphics: 2000-5000
>[  1903.334] (II) intel: Driver for Intel(R) Iris(TM) Graphics: 5100
>[  1903.334] (II) intel: Driver for Intel(R) Iris(TM) Pro Graphics: 5200
>[  1903.334] (++) using VT number 8
>
>[  1903.338] sna_init_scrn: entity_num=0
>[  1903.338] (II) intel(0): Using Kernel Mode Setting driver: i915, version 1.6.0 20080730
>[  1903.338] (II) intel(0): SNA compiled from 2.99.912-125-ge1e853edee67
>[  1903.338] (II) intel(0): SNA compiled with assertions enabled
>[  1903.338] (II) intel(0): SNA compiled with memory allocation reporting enabled
>[  1903.338] (II) intel(0): SNA compiled with extra pixmap/damage validation
>[  1903.338] (II) intel(0): SNA compiled for use with valgrind
>[  1903.338] pixman version: 0.30.2
>[  1903.338] num_cores: processors=0x1, cores=0x3
>[  1903.338] sna_threads_init: creating a thread pool of 2 threads
>[  1903.338] sna_pre_init flags=0, numEntities=1
>[  1903.338] sna_acpi_open
>[  1903.339] (--) intel(0): Integrated Graphics Chipset: Intel(R) HD Graphics 4000
>[  1903.339] (--) intel(0): CPU: x86-64, sse2, sse3, ssse3, sse4.1, sse4.2, avx
>[  1903.339] (II) intel(0): Creating default Display subsection in Screen section
>	"Default Screen Section" for depth/fbbpp 24/32
>[  1903.339] (==) intel(0): Depth 24, (--) framebuffer bpp 32
>[  1903.339] (==) intel(0): RGB weight 888
>[  1903.339] (==) intel(0): Default visual is TrueColor
>[  1903.339] (**) intel(0): Option "AccelMethod" "sna"
>[  1903.339] kgem_init: fd=9, gen=56
>[  1903.339] kgem_init: has BLT ring? 1
>[  1903.339] kgem_init: has relaxed delta? 1
>[  1903.339] kgem_init: has relaxed fencing? 1
>[  1903.339] kgem_init: has shared last-level-cache? 1
>[  1903.339] kgem_init: has write-through caching for scanouts? 0
>[  1903.339] kgem_init: has set-cache-level? 1
>[  1903.339] gem_userptr: failed to map 0x943000 + 4096 bytes: 22
>[  1903.339] kgem_init: has userptr? 0
>[  1903.339] kgem_init: has create2? 0
>[  1903.339] kgem_init: has no-reloc? 1
>[  1903.339] kgem_init: has handle-lut? 1
>[  1903.339] kgem_init: semaphores enabled? 1
>[  1903.339] kgem_init: can blt to cpu? 1
>[  1903.339] kgem_init: can render to Y-tiled surfaces? 1
>[  1903.339] kgem_init: can use privileged batchbuffers? 1
>[  1903.339] kgem_init: can use pinned batchbuffers (to avoid CS w/a)? 1
>[  1903.339] kgem_init_pinned_batches: new handle=1, num_pages=1
>[  1903.339] __kgem_bo_init(handle=1, num_pages=1)
>[  1903.339] __kgem_bo_init(handle=1, num_pages=1)
>[  1903.339] __kgem_bo_init(handle=2, num_pages=4)
>[  1903.339] kgem_init: maximum batch size? 16384
>[  1903.339] kgem_init: last-level cache size: 3145728 bytes, threshold in pages: 384
>[  1903.339] kgem_init: cpu bo enabled 1: llc? 1, set-cache-level? 1, userptr? 0
>[  1903.339] kgem_init: aperture size 2147483648, available now 2138763264
>[  1903.339] kgem_init: aperture low=715827882 [682], high=1610612736 [1536]
>[  1903.339] kgem_init: aperture mappable=268435456 [256 MiB]
>[  1903.339] kgem_init: buffer size=262144 [256 KiB]
>[  1903.339] kgem_init: total ram=3987791872
>[  1903.339] kgem_init: maximum object size=1207959552
>[  1903.339] kgem_init: large object thresold=268435456
>[  1903.339] kgem_init: max object sizes (gpu=996947968, cpu=1207959552, tile upload=134217728, copy=134217728)
>[  1903.339] kgem_init: max fences=30
>[  1903.339] choose_memcpy_tiled_x: no swizzling
>[  1903.339] sna_pre_init: swapbuffer wait? enabled
>[  1903.339] sna_pre_init: vsync? enabled
>[  1903.339] sna_pre_init: page flips? enabled
>[  1903.339] sna_pre_init: triple buffer? enabled
>[  1903.339] probe_capabilities: page flips? enabled, async? disabled
>[  1903.339] sna_crtc_add(5)
>[  1903.339] sna_crtc_init__rotation: CRTC:5 [pipe=0], primary: supported-rotations=1, current-rotation=1, sprite: supported-rotations=1, current-rotation=1
>[  1903.339] sna_crtc_add: attached crtc[5] pipe=0
>[  1903.339] sna_crtc_add(8)
>[  1903.339] sna_crtc_init__rotation: CRTC:8 [pipe=1], primary: supported-rotations=1, current-rotation=1, sprite: supported-rotations=1, current-rotation=1
>[  1903.339] sna_crtc_add: attached crtc[8] pipe=1
>[  1903.339] sna_crtc_add(11)
>[  1903.339] sna_crtc_init__rotation: CRTC:11 [pipe=2], primary: supported-rotations=1, current-rotation=1, sprite: supported-rotations=1, current-rotation=1
>[  1903.339] sna_crtc_add: attached crtc[11] pipe=2
>[  1903.339] sna_output_add(13): serial=0
>[  1903.339] name_from_path: found? PATH=-1
>[  1903.339] (II) intel(0): Output LVDS1 has no monitor section
>[  1903.339] sna_output_add: found 'DPMS' (idx=1, id=2), initial value=0
>[  1903.339] sna_output_backlight_init(LVDS1) opening backlight acpi_video0
>[  1903.339] sna_output_backlight_init(LVDS1): initial backlight value 15
>[  1903.339] (--) intel(0): Found backlight control interface acpi_video0 (type 'firmware') for output LVDS1
>[  1903.339] sna_output_add: created output 'LVDS1' 13, encoder=14 (possible crtc:7, attached encoders:1, possible clones:1), serial=0, edid=0, dpms=2, crtc=5
>[  1903.339] sna_output_add(19): serial=0
>[  1903.339] name_from_path: found? PATH=-1
>[  1903.339] (II) intel(0): Output VGA1 has no monitor section
>[  1903.339] sna_output_add: found 'DPMS' (idx=1, id=2), initial value=0
>[  1903.339] sna_output_add: created output 'VGA1' 19, encoder=20 (possible crtc:7, attached encoders:2, possible clones:36), serial=0, edid=0, dpms=2, crtc=0
>[  1903.339] sna_output_add(22): serial=0
>[  1903.339] name_from_path: found? PATH=-1
>[  1903.339] (II) intel(0): Output HDMI1 has no monitor section
>[  1903.339] sna_output_add: found 'DPMS' (idx=1, id=2), initial value=0
>[  1903.339] sna_output_add: created output 'HDMI1' 22, encoder=21 (possible crtc:7, attached encoders:4, possible clones:6), serial=0, edid=0, dpms=2, crtc=0
>[  1903.339] sna_output_add(26): serial=0
>[  1903.339] name_from_path: found? PATH=-1
>[  1903.339] (II) intel(0): Output DP1 has no monitor section
>[  1903.339] sna_output_add: found 'DPMS' (idx=1, id=2), initial value=0
>[  1903.339] sna_output_add: created output 'DP1' 26, encoder=25 (possible crtc:7, attached encoders:8, possible clones:8), serial=0, edid=0, dpms=2, crtc=0
>[  1903.339] sna_output_add(28): serial=0
>[  1903.339] name_from_path: found? PATH=-1
>[  1903.339] (II) intel(0): Output HDMI2 has no monitor section
>[  1903.339] sna_output_add: found 'DPMS' (idx=1, id=2), initial value=0
>[  1903.339] sna_output_add: created output 'HDMI2' 28, encoder=27 (possible crtc:7, attached encoders:10, possible clones:12), serial=0, edid=0, dpms=2, crtc=0
>[  1903.339] sna_output_add(30): serial=0
>[  1903.339] name_from_path: found? PATH=-1
>[  1903.339] (II) intel(0): Output HDMI3 has no monitor section
>[  1903.339] sna_output_add: found 'DPMS' (idx=1, id=2), initial value=0
>[  1903.339] sna_output_add: created output 'HDMI3' 30, encoder=29 (possible crtc:7, attached encoders:20, possible clones:22), serial=0, edid=0, dpms=2, crtc=0
>[  1903.339] sna_output_add(32): serial=0
>[  1903.339] name_from_path: found? PATH=-1
>[  1903.339] (II) intel(0): Output DP2 has no monitor section
>[  1903.339] sna_output_add: found 'DPMS' (idx=1, id=2), initial value=0
>[  1903.339] sna_output_add: created output 'DP2' 32, encoder=31 (possible crtc:7, attached encoders:40, possible clones:40), serial=0, edid=0, dpms=2, crtc=8
>[  1903.339] sna_output_add(34): serial=0
>[  1903.339] name_from_path: found? PATH=-1
>[  1903.339] (II) intel(0): Output DP3 has no monitor section
>[  1903.339] sna_output_add: found 'DPMS' (idx=1, id=2), initial value=0
>[  1903.339] sna_output_add: created output 'DP3' 34, encoder=33 (possible crtc:7, attached encoders:80, possible clones:80), serial=0, edid=0, dpms=2, crtc=0
>[  1903.339] sna_mode_compute_possible_outputs: updated output 'LVDS1' 0 [13] (possible crtc:7, possible clones:0)
>[  1903.339] sna_mode_compute_possible_outputs: updated output 'VGA1' 1 [19] (possible crtc:7, possible clones:34)
>[  1903.339] sna_mode_compute_possible_outputs: updated output 'HDMI1' 2 [22] (possible crtc:7, possible clones:2)
>[  1903.339] sna_mode_compute_possible_outputs: updated output 'DP1' 3 [26] (possible crtc:7, possible clones:0)
>[  1903.339] sna_mode_compute_possible_outputs: updated output 'HDMI2' 4 [28] (possible crtc:7, possible clones:2)
>[  1903.339] sna_mode_compute_possible_outputs: updated output 'HDMI3' 5 [30] (possible crtc:7, possible clones:2)
>[  1903.339] sna_mode_compute_possible_outputs: updated output 'DP2' 6 [32] (possible crtc:7, possible clones:0)
>[  1903.339] sna_mode_compute_possible_outputs: updated output 'DP3' 7 [34] (possible crtc:7, possible clones:0)
>[  1903.339] sna_cursor_pre_init: cursor updates use_gtt?=1
>[  1903.339] (--) intel(0): Using a maximum size of 256x256 for hardware cursors
>[  1903.339] sna_backlight_pre_init: installed backlight monitor
>[  1903.340] add_fake_output(late=0, num_fake=1)
>[  1903.340] (II) intel(0): Output VIRTUAL1 has no monitor section
>[  1903.340] crtc_init_gamma: CRTC:5, pipe=0: gamma set?=1
>[  1903.340] sna_probe_initial_configuration: CRTC:5, pipe=0: has mode?=1
>[  1903.340] kmode: 1366x768, clock=69300, 1366 1414 1446 1454 0, 768 771 777 793 0, flags=a, type=48
>[  1903.340] crtc_init_gamma: CRTC:8, pipe=1: gamma set?=1
>[  1903.340] sna_probe_initial_configuration: CRTC:8, pipe=1: has mode?=1
>[  1903.340] kmode: 1920x1080, clock=148500, 1920 2008 2052 2200 0, 1080 1084 1089 1125 0, flags=5, type=48
>[  1903.340] crtc_init_gamma: CRTC:11, pipe=2: gamma set?=0
>[  1903.340] sna_probe_initial_configuration: CRTC:11, pipe=2: has mode?=0
>[  1903.340] (--) intel(0): Output LVDS1 using initial mode 1366x768 on pipe 0
>[  1903.340] sna_probe_initial_configuration: not using output VGA1, disconnected
>[  1903.340] sna_probe_initial_configuration: not using output HDMI1, disconnected
>[  1903.340] sna_probe_initial_configuration: not using output DP1, disconnected
>[  1903.340] sna_probe_initial_configuration: not using output HDMI2, disconnected
>[  1903.340] sna_probe_initial_configuration: not using output HDMI3, disconnected
>[  1903.340] (--) intel(0): Output DP2 using initial mode 1920x1080 on pipe 1
>[  1903.340] sna_probe_initial_configuration: not using output DP3, disconnected
>[  1903.340] sna_probe_initial_configuration: SetScrnInfoModes = 0x948320
>[  1903.340] (**) intel(0): TearFree disabled
>[  1903.340] (==) intel(0): DPI set to (96, 96)
>[  1903.340] (II) Loading sub module "dri2"
>[  1903.340] (II) LoadModule: "dri2"
>[  1903.340] (II) Module "dri2" already built-in
>[  1903.340] (==) Depth 24 pixmap format is 32 bpp
>[  1903.340] sna_screen_init
>[  1903.340] sna_accel_init
>[  1903.340] sna_picture_init
>[  1903.340] uploaded 36672 bytes of static state
>[  1903.340] kgem_create_linear(36672)
>[  1903.340] search_linear_cache: num_pages=9, flags=2, use_active? 0, use_large=0 [max=65536]
>[  1903.340] search_linear_cache: inactive and cache bucket empty
>[  1903.340] search_linear_cache: active cache bucket empty
>[  1903.340] kgem_create_linear: new handle=3, num_pages=9
>[  1903.340] __kgem_bo_init(handle=3, num_pages=9)
>[  1903.340] gem_write(handle=3, offset=0, len=36672)
>[  1903.340] kgem_bo_write: flush=0, domain=1
>[  1903.340] __kgem_busy: handle=3, busy=0, wedged=0
>[  1903.340] kgem_bo_maybe_retire: retiring bo handle=3 (needed flush? 0), rq? 0 [busy?=0]
>[  1903.340] sna_accel_init(backend=Ivybridge (gen7, gt2), prefer_gpu=7)
>[  1903.340] (II) intel(0): SNA initialized with Ivybridge (gen7, gt2) backend
>[  1903.340] (==) intel(0): Backing store disabled
>[  1903.340] (==) intel(0): Silken mouse enabled
>[  1903.340] (II) intel(0): HW Cursor enabled
>[  1903.340] (II) intel(0): RandR 1.2 enabled, ignore the following RandR disabled message.
>[  1903.340] (==) intel(0): DPMS enabled
>[  1903.340] sna_video_sprite_setup: 3 sprite planes
>[  1903.340] sna_dri2_open()
>[  1903.340] sna_dri2_open: loading dri driver 'i965' [gen=56] for device '/dev/dri/card0'
>[  1903.340] (II) intel(0): [DRI2] Setup complete
>[  1903.340] (II) intel(0): [DRI2]   DRI driver: i965
>[  1903.340] (II) intel(0): [DRI2]   VDPAU driver: i965
>[  1903.340] (II) intel(0): direct rendering: DRI2 enabled
>[  1903.340] sna_uevent_init
>[  1903.340] (==) intel(0): hotplug detection: "enabled"
>[  1903.340] sna_uevent_init: installed uvent handler
>[  1903.340] (--) RandR disabled
>[  1903.349] (II) AIGLX: enabled GLX_MESA_copy_sub_buffer
>[  1903.349] (II) AIGLX: enabled GLX_INTEL_swap_event
>[  1903.349] (II) AIGLX: enabled GLX_ARB_create_context
>[  1903.349] (II) AIGLX: enabled GLX_ARB_create_context_profile
>[  1903.349] (II) AIGLX: enabled GLX_EXT_create_context_es2_profile
>[  1903.349] (II) AIGLX: enabled GLX_SGI_swap_control and GLX_MESA_swap_control
>[  1903.349] (II) AIGLX: GLX_EXT_texture_from_pixmap backed by buffer objects
>[  1903.349] (II) AIGLX: Loaded and initialized i965
>[  1903.349] (II) GLX: Initialized DRI2 GL provider for screen 0
>[  1903.349] sna_create_screen_resources(1920x1080@24)
>[  1903.349] sna_accel_create
>[  1903.349] sna_glyphs_create
>[  1903.349] sna_create_pixmap(1024, 1024, 8, usage=11)
>[  1903.349] kgem_can_create_2d: 1024x1024 @ 8
>[  1903.349] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=1024, height=1024
>[  1903.349] kgem_can_create_2d: untiled size=1048576
>[  1903.349] kgem_choose_tiling: 1024x1024 -> 1
>[  1903.349] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=1024, height=1024
>[  1903.349] kgem_can_create_2d: tiled[1] size=1048576
>[  1903.349] sna_create_pixmap: usage=17, flags=b
>[  1903.349] sna_pixmap_create_scratch(1024, 1024, 8, tiling=2)
>[  1903.349] kgem_choose_tiling: 1024x1024 -> 2
>[  1903.349] create_pixmap: allocating pixmap 0x0, depth=8, size=0
>[  1903.349] create_pixmap: serial=1, usage=1, 0x0
>[  1903.349] kgem_create_2d(1024x1024, bpp=8, tiling=2, exact=0, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=1)
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=1024, height=1024
>[  1903.349] __kgem_bo_init(handle=4, num_pages=256)
>[  1903.349]   new pitch=1024, tiling=2, handle=4, id=1, num_pages=256 [256], bucket=8
>[  1903.349] __sna_damage_all(1024, 1024)
>[  1903.349] sna_pixmap_create_scratch: serial=1, 1024x1024, usage=1
>[  1903.349] sna_create_pixmap(1024, 1024, 32, usage=11)
>[  1903.349] kgem_can_create_2d: 1024x1024 @ 32
>[  1903.349] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=4096, height=1024
>[  1903.349] kgem_can_create_2d: untiled size=4194304
>[  1903.349] kgem_choose_tiling: TLB miss between lines 1024x1024 (pitch=4096), forcing tiling 1
>[  1903.349] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=4096, height=1024
>[  1903.349] kgem_can_create_2d: tiled[-1] size=4194304
>[  1903.349] sna_create_pixmap: usage=17, flags=b
>[  1903.349] sna_pixmap_create_scratch(1024, 1024, 32, tiling=2)
>[  1903.349] kgem_choose_tiling: TLB miss between lines 1024x1024 (pitch=4096), forcing tiling 2
>[  1903.349] create_pixmap: allocating pixmap 0x0, depth=32, size=0
>[  1903.349] create_pixmap: serial=2, usage=1, 0x0
>[  1903.349] kgem_create_2d(1024x1024, bpp=32, tiling=2, exact=1, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=1)
>[  1903.349] kgem_surface_size: tile_width=128, tile_height=32 => aligned pitch=4096, height=1024
>[  1903.349] __kgem_bo_init(handle=5, num_pages=1024)
>[  1903.349]   new pitch=4096, tiling=2, handle=5, id=2, num_pages=1024 [1024], bucket=10
>[  1903.349] __sna_damage_all(1024, 1024)
>[  1903.349] sna_pixmap_create_scratch: serial=2, 1024x1024, usage=1
>[  1903.349] sna_gradients_create
>[  1903.349] sna_alpha_cache_init
>[  1903.349] kgem_create_linear(1052)
>[  1903.349] search_linear_cache: num_pages=1, flags=2, use_active? 0, use_large=0 [max=65536]
>[  1903.349] search_linear_cache: inactive and cache bucket empty
>[  1903.349] search_linear_cache: active cache bucket empty
>[  1903.349] kgem_create_linear: new handle=6, num_pages=1
>[  1903.349] __kgem_bo_init(handle=6, num_pages=1)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=0, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=4, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=8, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=12, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=16, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=20, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=24, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=28, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=32, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=36, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=40, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=44, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=48, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=52, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=56, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=60, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=64, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=68, length=4, io=0
>[  1903.349] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.349] kgem_create_proxy: target handle=6 [proxy? -1], offset=72, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=76, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=80, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=84, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=88, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=92, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=96, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=100, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=104, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=108, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=112, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=116, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=120, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=124, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=128, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=132, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=136, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=140, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=144, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=148, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=152, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=156, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=160, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=164, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=168, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=172, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=176, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=180, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=184, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=188, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=192, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=196, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=200, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=204, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=208, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=212, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=216, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=220, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=224, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=228, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=232, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=236, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=240, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=244, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=248, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=252, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=256, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=260, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=264, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=268, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=272, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=276, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=280, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=284, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=288, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=292, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=296, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=300, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=304, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=308, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=312, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=316, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=320, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=324, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=328, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=332, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=336, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=340, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=344, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=348, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=352, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=356, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=360, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=364, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=368, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=372, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=376, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=380, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=384, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=388, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=392, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=396, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=400, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=404, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=408, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=412, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=416, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=420, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=424, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=428, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=432, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=436, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=440, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=444, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=448, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=452, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=456, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=460, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=464, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=468, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=472, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=476, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=480, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=484, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=488, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=492, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=496, length=4, io=0
>[  1903.350] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.350] kgem_create_proxy: target handle=6 [proxy? -1], offset=500, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=504, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=508, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=512, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=516, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=520, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=524, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=528, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=532, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=536, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=540, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=544, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=548, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=552, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=556, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=560, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=564, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=568, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=572, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=576, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=580, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=584, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=588, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=592, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=596, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=600, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=604, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=608, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=612, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=616, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=620, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=624, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=628, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=632, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=636, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=640, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=644, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=648, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=652, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=656, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=660, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=664, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=668, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=672, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=676, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=680, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=684, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=688, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=692, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=696, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=700, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=704, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=708, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=712, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=716, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=720, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=724, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=728, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=732, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=736, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=740, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=744, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=748, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=752, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=756, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=760, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=764, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=768, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=772, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=776, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=780, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=784, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=788, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=792, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=796, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=800, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=804, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=808, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=812, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=816, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=820, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=824, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=828, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=832, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=836, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=840, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=844, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=848, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=852, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=856, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=860, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=864, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=868, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=872, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=876, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=880, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=884, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=888, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=892, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=896, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=900, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=904, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=908, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=912, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=916, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=920, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=924, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=928, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=932, length=4, io=0
>[  1903.351] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.351] kgem_create_proxy: target handle=6 [proxy? -1], offset=936, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=940, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=944, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=948, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=952, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=956, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=960, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=964, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=968, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=972, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=976, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=980, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=984, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=988, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=992, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=996, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1000, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1004, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1008, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1012, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1016, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1020, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1024, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1028, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1032, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1036, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1040, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1044, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] kgem_create_proxy: target handle=6 [proxy? -1], offset=1048, length=4, io=0
>[  1903.352] __kgem_bo_init(handle=6, num_pages=4)
>[  1903.352] gem_write(handle=6, offset=0, len=1052)
>[  1903.352] kgem_bo_write: flush=0, domain=1
>[  1903.352] __kgem_busy: handle=6, busy=0, wedged=0
>[  1903.352] kgem_bo_maybe_retire: retiring bo handle=6 (needed flush? 0), rq? 0 [busy?=0]
>[  1903.352] sna_solid_cache_init
>[  1903.352] kgem_create_linear(4096)
>[  1903.352] search_linear_cache: num_pages=1, flags=2, use_active? 0, use_large=0 [max=65536]
>[  1903.352] search_linear_cache: inactive and cache bucket empty
>[  1903.352] search_linear_cache: active cache bucket empty
>[  1903.352] kgem_create_linear: new handle=7, num_pages=1
>[  1903.352] __kgem_bo_init(handle=7, num_pages=1)
>[  1903.352] sna_create_pixmap(1920, 1080, 24, usage=10)
>[  1903.352] kgem_can_create_2d: 1920x1080 @ 24
>[  1903.352] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=7680, height=1080
>[  1903.352] kgem_can_create_2d: untiled size=8294400
>[  1903.352] kgem_choose_tiling: TLB miss between lines 1920x1080 (pitch=7680), forcing tiling 1
>[  1903.352] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=7680, height=1080
>[  1903.352] kgem_can_create_2d: tiled[-1] size=8294400
>[  1903.352] sna_create_pixmap: usage=16, flags=b
>[  1903.352] sna_create_pixmap: creating GPU pixmap 1920x1080, stride=7680, flags=b
>[  1903.352] create_pixmap: allocating pixmap 0x0, depth=24, size=0
>[  1903.352] create_pixmap: serial=3, usage=16, 0x0
>[  1903.352] sna_create_pixmap: serial=3, 1920x1080, usage=16
>[  1903.352] sna_pixmap_force_to_gpu(pixmap=0x97a2f0, flags=1)
>[  1903.352] sna_pixmap_move_to_gpu(pixmap=3, usage=16), flags=41
>[  1903.352] sna_pixmap_move_to_gpu: CPU damage? 0
>[  1903.352] sna_pixmap_move_to_gpu: creating GPU bo (1920x1080@32), create=b
>[  1903.352] kgem_create_2d(1920x1080, bpp=32, tiling=1, exact=1, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=1, prime?=0, temp?=0)
>[  1903.352] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=7680, height=1080
>[  1903.352] __kgem_bo_init(handle=8, num_pages=2025)
>[  1903.352] __kgem_bo_make_scanout: create fb 1920x1080@24/32
>[  1903.352] __kgem_bo_map__gtt(handle=8, size=8294400)
>[  1903.354] __kgem_bo_make_scanout: attached fb=71 to handle=8
>[  1903.354]   new pitch=7680, tiling=1, handle=8, id=266, num_pages=2025 [2025], bucket=10
>[  1903.354] __sna_damage_all(1920, 1080)
>[  1903.354] sna_pixmap_move_to_gpu: marking as all-damaged for GPU
>[  1903.354] sna_pixmap_mark_active: pixmap=3, handle=8
>[  1903.354] sna_set_screen_pixmap: changing from pixmap=0 to pixmap=3, (sna->front=0)
>[  1903.354] sna_copy_fbcon
>[  1903.354] sna_copy_fbcon: found fbcon, size=1920x1080, depth=24, bpp=32
>[  1903.354] kgem_create_for_name(name=1)
>[  1903.354] kgem_create_for_name: new handle=10
>[  1903.354] kgem_create_for_name: handle=10, tiling=0
>[  1903.354] __kgem_bo_init(handle=10, num_pages=2025)
>[  1903.354] sna_copy_fbcon: fbcon handle=10
>[  1903.354] gen7_render_copy_boxes (0, 0)->(0, 0) x 1, alu=3, flags=0, self-copy=0, overlaps? 0
>[  1903.354] kgem_bo_is_render: handle=10, rq? 0 [0]
>[  1903.354] sna_blt_copy_boxes src=(0, 0) -> (0, 0) x 1, tiling=(0, 1), pitch=(7680, 7680)
>[  1903.354]   sna_blt_copy_boxes: box=(0, 0)x(1920, 1080)
>[  1903.354] kgem_add_reloc: handle=8, pos=4, delta=0, domains=28002
>[  1903.354] kgem_add_handle: handle=8, index=0
>[  1903.354] __kgem_bo_mark_dirty: handle=8 (proxy? 0)
>[  1903.354] kgem_add_reloc: handle=10, pos=7, delta=0, domains=28000
>[  1903.354] kgem_add_handle: handle=10, index=1
>[  1903.354] batch[3/3, flags=1c00]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=4050 [fenced=0]
>[  1903.354] gem_write__cachealigned(handle=1, offset=0, len=40)
>[  1903.354] kgem_commit: release handle=1 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=440b000
>[  1903.354] kgem_commit: release handle=8 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=3c22000
>[  1903.354] kgem_commit: release handle=10 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=394000
>[  1903.354] _kgem_bo_destroy: handle=10, proxy? 0
>[  1903.354] __kgem_bo_destroy: handle=10, size=8294400
>[  1903.354] kgem_bo_free: handle=10, size=8294400
>[  1903.354] kgem_bo_free: releasing 0x0:0x0 vma for handle=10, count=0
>[  1903.354] sna_set_desired_mode
>[  1903.354] (II) intel(0): switch to mode 1366x768@60.1 on LVDS1 using pipe 0, position (0, 0), rotation normal, reflection none
>[  1903.354] sna_pixmap_force_to_gpu(pixmap=0x97a2f0, flags=2)
>[  1903.354] sna_pixmap_move_to_gpu(pixmap=3, usage=16), flags=42
>[  1903.354] sna_pixmap_move_to_gpu: already all-damaged
>[  1903.354] sna_pixmap_mark_active: pixmap=3, handle=8
>[  1903.354] use_shadow? bounds (0, 0), (1366, 768), framebufer 1920x1080
>[  1903.354] sna_crtc_attach: attaching to framebuffer
>[  1903.354] sna_pixmap_force_to_gpu(pixmap=0x97a2f0, flags=2)
>[  1903.354] sna_pixmap_move_to_gpu(pixmap=3, usage=16), flags=42
>[  1903.354] sna_pixmap_move_to_gpu: already all-damaged
>[  1903.354] sna_pixmap_mark_active: pixmap=3, handle=8
>[  1903.354] get_fb: reusing fb=71 for handle=8
>[  1903.354] sna_crtc_apply CRTC:5 [pipe=0], handle=8
>[  1903.354] sna_crtc_apply: CRTC:5 [pipe=0] primary rotation set to 1
>[  1903.354] sna_crtc_apply: attaching output 'LVDS1' 0 [13] to crtc:5 (pipe 0) (possible crtc:7, possible clones:0)
>[  1903.354] sna_output_dpms(VGA1:19): dpms=3 (current: 0), active? 0
>[  1903.354] sna_output_dpms(HDMI1:22): dpms=3 (current: 0), active? 0
>[  1903.354] sna_output_dpms(DP1:26): dpms=3 (current: 0), active? 0
>[  1903.354] sna_output_dpms(HDMI2:28): dpms=3 (current: 0), active? 0
>[  1903.354] sna_output_dpms(HDMI3:30): dpms=3 (current: 0), active? 0
>[  1903.354] sna_output_dpms(DP3:34): dpms=3 (current: 0), active? 0
>[  1903.354] sna_crtc_apply: applying crtc [5, pipe=0] mode=1366x768+0+0@69300, fb=71 update to 1 outputs [13...]
>[  1903.364] sna_crtc_force_outputs_on(pipe=0), currently? -1
>[  1903.364] sna_output_dpms(LVDS1:13): dpms=0 (current: 0), active? 1
>[  1903.364] sna_crtc_randr: transform? 0, bounds (0, 0), (1366, 768)
>[  1903.364] (II) intel(0): switch to mode 1920x1080@60.0 on DP2 using pipe 1, position (0, 0), rotation normal, reflection none
>[  1903.364] sna_pixmap_force_to_gpu(pixmap=0x97a2f0, flags=2)
>[  1903.364] sna_pixmap_move_to_gpu(pixmap=3, usage=16), flags=42
>[  1903.364] sna_pixmap_move_to_gpu: already all-damaged
>[  1903.364] sna_pixmap_mark_active: pixmap=3, handle=8
>[  1903.364] use_shadow? bounds (0, 0), (1920, 1080), framebufer 1920x1080
>[  1903.364] sna_crtc_attach: attaching to framebuffer
>[  1903.364] sna_pixmap_force_to_gpu(pixmap=0x97a2f0, flags=2)
>[  1903.364] sna_pixmap_move_to_gpu(pixmap=3, usage=16), flags=42
>[  1903.364] sna_pixmap_move_to_gpu: already all-damaged
>[  1903.364] sna_pixmap_mark_active: pixmap=3, handle=8
>[  1903.364] get_fb: reusing fb=71 for handle=8
>[  1903.364] sna_crtc_apply CRTC:8 [pipe=1], handle=8
>[  1903.364] sna_crtc_apply: CRTC:8 [pipe=1] primary rotation set to 1
>[  1903.364] sna_output_dpms(VGA1:19): dpms=3 (current: 3), active? 0
>[  1903.364] sna_output_dpms(HDMI1:22): dpms=3 (current: 3), active? 0
>[  1903.364] sna_output_dpms(DP1:26): dpms=3 (current: 3), active? 0
>[  1903.364] sna_output_dpms(HDMI2:28): dpms=3 (current: 3), active? 0
>[  1903.364] sna_output_dpms(HDMI3:30): dpms=3 (current: 3), active? 0
>[  1903.364] sna_crtc_apply: attaching output 'DP2' 6 [32] to crtc:8 (pipe 1) (possible crtc:7, possible clones:0)
>[  1903.364] sna_output_dpms(DP3:34): dpms=3 (current: 3), active? 0
>[  1903.364] sna_crtc_apply: applying crtc [8, pipe=1] mode=1920x1080+0+0@148500, fb=71 update to 1 outputs [32...]
>[  1903.378] sna_crtc_force_outputs_on(pipe=1), currently? -1
>[  1903.378] sna_output_dpms(DP2:32): dpms=0 (current: 0), active? 1
>[  1903.378] sna_crtc_randr: transform? 0, bounds (0, 0), (1920, 1080)
>[  1903.378] sna_output_dpms(VGA1:19): dpms=3 (current: 3), active? 0
>[  1903.378] sna_output_dpms(HDMI1:22): dpms=3 (current: 3), active? 0
>[  1903.378] sna_output_dpms(DP1:26): dpms=3 (current: 3), active? 0
>[  1903.378] sna_output_dpms(HDMI2:28): dpms=3 (current: 3), active? 0
>[  1903.378] sna_output_dpms(HDMI3:30): dpms=3 (current: 3), active? 0
>[  1903.378] sna_output_dpms(DP3:34): dpms=3 (current: 3), active? 0
>[  1903.378] sna_crtc_dpms(pipe 2, dpms mode -> 3):= active=0
>[  1903.378] sna_crtc_disable: disabling crtc [11, pipe=2]
>[  1903.378] sna_crtc_force_outputs_off(pipe=2), currently? 3
>[  1903.378] sna_crtc_config_notify(dirty?=1)
>[  1903.378] probe_capabilities: page flips? enabled, async? disabled
>[  1903.378] update_flush_interval: CRTC:0 (pipe 0) vrefresh=60.10
>[  1903.378] update_flush_interval: CRTC:1 (pipe 1) vrefresh=60.00
>[  1903.378] update_flush_interval: CRTC:2 (pipe 2) disabled
>[  1903.378] max_vrefresh=60, vblank_interval=16 ms
>[  1903.378] sna_mode_check
>[  1903.378] sna_mode_check: crtc=5, valid?=1, fb attached?=71, expected=(71 or -1)
>[  1903.378] sna_mode_check: crtc=8, valid?=1, fb attached?=71, expected=(71 or -1)
>[  1903.378] sna_mode_check: crtc=11, valid?=0, fb attached?=0, expected=(0 or -1)
>[  1903.378] update_flush_interval: CRTC:0 (pipe 0) vrefresh=60.10
>[  1903.378] update_flush_interval: CRTC:1 (pipe 1) vrefresh=60.00
>[  1903.378] update_flush_interval: CRTC:2 (pipe 2) disabled
>[  1903.378] max_vrefresh=60, vblank_interval=16 ms
>[  1903.378] (II) intel(0): Setting screen physical size to 508 x 285
>[  1903.378] sna_mode_resize (1920, 1080) -> (1920, 1080)
>[  1903.378] sna_create_pixmap(16, 16, 1, usage=0)
>[  1903.378] kgem_can_create_2d: 16x16 @ 1
>[  1903.378] kgem_can_create_2d: unhandled depth 1
>[  1903.378] sna_create_pixmap: can not use GPU, just creating shadow
>[  1903.378] create_pixmap: allocating pixmap 16x16, depth=1, size=72
>[  1903.378] create_pixmap: serial=4, usage=0, 16x16
>[  1903.378] sna_validate_gc(0x97a6a0) changes=7fffff, previous serial=80000000, drawable=4
>[  1903.378] sna_validate_gc: recomputing clip
>[  1903.378] sna_validate_gc: composite clip=1x[(0, 0), (16, 16)] [0x97a630]
>[  1903.378] sna_poly_fill_rect(n=1, PlaneMask: ffffffffffffffff (solid 1), solid fill: 1 [style=0, tileIsPixel=1], alu=3)
>[  1903.378] sna_poly_fill_rect_extents: [0] = (0, 0)x(16, 16)
>[  1903.378] sna_poly_fill_rect: extents(0, 0), (16, 16), flags=1
>[  1903.378] sna_poly_fill_rect: fallback -- unattached
>[  1903.378] sna_poly_fill_rect: fallback (0, 0), (16, 16)
>[  1903.378] sna_gc_move_to_cpu(0x97a6a0) changes=7fffff
>[  1903.378] sfbValidateGC changes=77ffff
>[  1903.378] sfbValidateGC: computing rrop mask=1, depthMask=1, fg=1, bg=1, planemask=ffffffff
>[  1903.378] sfbValidateGC: rrop fg=ffffffff, bg=ffffffff, pm=ffffffff, and=0, xor=ffffffff, bgand=0, bgxor=ffffffff
>[  1903.378] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  1903.378] sna_drawable_move_region_to_cpu(pixmap=4 (16x16), [(0, 0), (16, 16)], flags=5)
>[  1903.378] sna_drawable_move_region_to_cpu: not attached to pixmap 4 (depth 1)
>[  1903.378] sna_poly_fill_rect: fallback - fbPolyFillRect
>[  1903.378] sfbPolyFillRect x 1
>[  1903.378] sfbPolyFillRect: rectangle (0, 0), (16, 16)
>[  1903.378] fbClipBoxes: box=(0, 0),(16, 16); region=(0, 0),(16, 16) x 1
>[  1903.378] fbDrawableRun: box=(0, 0), (16, 16), clip=(0, 0), (16, 16)
>[  1903.378] fbFillBox box=(0, 0), (16, 16)
>[  1903.378] sfbFill (0, 0)x(16, 16), style=0
>[  1903.378] sna_gc_move_to_gpu(0x97a6a0)
>[  1903.397] sna_realize_font (key=0)
>[  1903.397] sna_realize_font (key=0)
>[  1903.397] sna_create_pixmap(16, 16, 1, usage=1)
>[  1903.397] kgem_can_create_2d: 16x16 @ 1
>[  1903.397] kgem_can_create_2d: unhandled depth 1
>[  1903.397] sna_create_pixmap: can not use GPU, just creating shadow
>[  1903.397] create_pixmap: allocating pixmap 16x16, depth=1, size=72
>[  1903.397] create_pixmap: serial=6, usage=1, 16x16
>[  1903.397] sna_validate_gc(0x97a6a0) changes=7fffff, previous serial=80000000, drawable=6
>[  1903.397] sna_validate_gc: recomputing clip
>[  1903.397] sna_validate_gc: composite clip=1x[(0, 0), (16, 16)] [0x97a630]
>[  1903.397] sna_poly_fill_rect(n=1, PlaneMask: ffffffffffffffff (solid 1), solid fill: 1 [style=0, tileIsPixel=1], alu=3)
>[  1903.397] sna_poly_fill_rect_extents: [0] = (0, 0)x(16, 16)
>[  1903.397] sna_poly_fill_rect: extents(0, 0), (16, 16), flags=1
>[  1903.397] sna_poly_fill_rect: fallback -- unattached
>[  1903.397] sna_poly_fill_rect: fallback (0, 0), (16, 16)
>[  1903.397] sna_gc_move_to_cpu(0x97a6a0) changes=7fffff
>[  1903.397] sfbValidateGC changes=77ffff
>[  1903.397] sfbValidateGC: computing rrop mask=1, depthMask=1, fg=0, bg=1, planemask=ffffffff
>[  1903.397] sfbValidateGC: rrop fg=0, bg=ffffffff, pm=ffffffff, and=0, xor=0, bgand=0, bgxor=ffffffff
>[  1903.397] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  1903.397] sna_drawable_move_region_to_cpu(pixmap=6 (16x16), [(0, 0), (16, 16)], flags=5)
>[  1903.397] sna_drawable_move_region_to_cpu: not attached to pixmap 6 (depth 1)
>[  1903.397] sna_poly_fill_rect: fallback - fbPolyFillRect
>[  1903.397] sfbPolyFillRect x 1
>[  1903.397] sfbPolyFillRect: rectangle (0, 0), (16, 16)
>[  1903.397] fbClipBoxes: box=(0, 0),(16, 16); region=(0, 0),(16, 16) x 1
>[  1903.397] fbDrawableRun: box=(0, 0), (16, 16), clip=(0, 0), (16, 16)
>[  1903.397] fbFillBox box=(0, 0), (16, 16)
>[  1903.397] sfbFill (0, 0)x(16, 16), style=0
>[  1903.397] sna_gc_move_to_gpu(0x97a6a0)
>[  1903.397] sna_validate_gc(0x97a6a0) changes=4, previous serial=80000006, drawable=6
>[  1903.397] sna_font_too_large? (16 + 17) x 17: 99 > 124
>[  1903.397] sna_glyph_blt (7, 7) x 1, fg=1, bg=ffffffff alu=cc
>[  1903.397] sna_drawable_use_bo pixmap=6, box=((0, 0), (16, 16)), flags=1...
>[  1903.397] sna_drawable_use_bo: not attached
>[  1903.397] sna_poly_text16: fallback
>[  1903.397] sna_gc_move_to_cpu(0x97a6a0) changes=4
>[  1903.397] sfbValidateGC changes=4
>[  1903.397] sfbValidateGC: computing rrop mask=1, depthMask=1, fg=1, bg=1, planemask=ffffffff
>[  1903.397] sfbValidateGC: rrop fg=ffffffff, bg=ffffffff, pm=ffffffff, and=0, xor=ffffffff, bgand=0, bgxor=ffffffff
>[  1903.397] sna_drawable_move_region_to_cpu(pixmap=6 (16x16), [(0, 0), (16, 16)], flags=3)
>[  1903.397] sna_drawable_move_region_to_cpu: not attached to pixmap 6 (depth 1)
>[  1903.397] sna_poly_text16: fallback -- fbPolyGlyphBlt
>[  1903.397] sfbPolyGlyphBlt x 1
>[  1903.397] sfbPushImage (0, 0)x(16, 16)
>[  1903.397] fbClipBoxes: box=(0, 0),(16, 16); region=(0, 0),(16, 16) x 1
>[  1903.397] fbDrawableRun: box=(0, 0), (16, 16), clip=(0, 0), (16, 16)
>[  1903.397] sfbBlt 16x16, alu=7, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  1903.397] sna_gc_move_to_gpu(0x97a6a0)
>[  1903.397] sna_get_image: pixmap=6 (0, 0)x(16, 16), format=1, mask=1, depth=1
>[  1903.397] sna_drawable_move_region_to_cpu(pixmap=6 (16x16), [(0, 0), (16, 16)], flags=22)
>[  1903.397] sna_drawable_move_region_to_cpu: not attached to pixmap 6 (depth 1)
>[  1903.397] sfbGetImage (0, 0)x(16, 16)
>[  1903.397] sfbBlt 16x16, alu=3, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  1903.397] sfbBlt fast blt, src_stride=4, dst_stride=4, width=2 (offset=1691808)
>[  1903.397] sna_destroy_pixmap: pixmap=6, attached?=0
>[  1903.397] sna_create_pixmap(16, 16, 1, usage=1)
>[  1903.397] kgem_can_create_2d: 16x16 @ 1
>[  1903.397] kgem_can_create_2d: unhandled depth 1
>[  1903.397] sna_create_pixmap: can not use GPU, just creating shadow
>[  1903.397] create_pixmap: allocating pixmap 16x16, depth=1, size=72
>[  1903.397] create_pixmap: serial=7, usage=1, 16x16
>[  1903.397] sna_validate_gc(0x97a6a0) changes=7fffff, previous serial=80000000, drawable=7
>[  1903.397] sna_validate_gc: recomputing clip
>[  1903.397] sna_validate_gc: composite clip=1x[(0, 0), (16, 16)] [0x97a630]
>[  1903.397] sna_poly_fill_rect(n=1, PlaneMask: ffffffffffffffff (solid 1), solid fill: 1 [style=0, tileIsPixel=1], alu=3)
>[  1903.397] sna_poly_fill_rect_extents: [0] = (0, 0)x(16, 16)
>[  1903.397] sna_poly_fill_rect: extents(0, 0), (16, 16), flags=1
>[  1903.397] sna_poly_fill_rect: fallback -- unattached
>[  1903.397] sna_poly_fill_rect: fallback (0, 0), (16, 16)
>[  1903.397] sna_gc_move_to_cpu(0x97a6a0) changes=7fffff
>[  1903.397] sfbValidateGC changes=77ffff
>[  1903.397] sfbValidateGC: computing rrop mask=1, depthMask=1, fg=0, bg=1, planemask=ffffffff
>[  1903.397] sfbValidateGC: rrop fg=0, bg=ffffffff, pm=ffffffff, and=0, xor=0, bgand=0, bgxor=ffffffff
>[  1903.397] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  1903.397] sna_drawable_move_region_to_cpu(pixmap=7 (16x16), [(0, 0), (16, 16)], flags=5)
>[  1903.397] sna_drawable_move_region_to_cpu: not attached to pixmap 7 (depth 1)
>[  1903.397] sna_poly_fill_rect: fallback - fbPolyFillRect
>[  1903.397] sfbPolyFillRect x 1
>[  1903.397] sfbPolyFillRect: rectangle (0, 0), (16, 16)
>[  1903.397] fbClipBoxes: box=(0, 0),(16, 16); region=(0, 0),(16, 16) x 1
>[  1903.397] fbDrawableRun: box=(0, 0), (16, 16), clip=(0, 0), (16, 16)
>[  1903.397] fbFillBox box=(0, 0), (16, 16)
>[  1903.398] sfbFill (0, 0)x(16, 16), style=0
>[  1903.398] sna_gc_move_to_gpu(0x97a6a0)
>[  1903.398] sna_validate_gc(0x97a6a0) changes=4, previous serial=80000007, drawable=7
>[  1903.398] sna_font_too_large? (16 + 17) x 17: 99 > 124
>[  1903.398] sna_glyph_blt (7, 7) x 1, fg=1, bg=ffffffff alu=cc
>[  1903.398] sna_drawable_use_bo pixmap=7, box=((1, 1), (15, 15)), flags=1...
>[  1903.398] sna_drawable_use_bo: not attached
>[  1903.398] sna_poly_text16: fallback
>[  1903.398] sna_gc_move_to_cpu(0x97a6a0) changes=4
>[  1903.398] sfbValidateGC changes=4
>[  1903.398] sfbValidateGC: computing rrop mask=1, depthMask=1, fg=1, bg=1, planemask=ffffffff
>[  1903.398] sfbValidateGC: rrop fg=ffffffff, bg=ffffffff, pm=ffffffff, and=0, xor=ffffffff, bgand=0, bgxor=ffffffff
>[  1903.398] sna_drawable_move_region_to_cpu(pixmap=7 (16x16), [(1, 1), (15, 15)], flags=3)
>[  1903.398] sna_drawable_move_region_to_cpu: not attached to pixmap 7 (depth 1)
>[  1903.398] sna_poly_text16: fallback -- fbPolyGlyphBlt
>[  1903.398] sfbPolyGlyphBlt x 1
>[  1903.398] sfbPushImage (1, 1)x(14, 14)
>[  1903.398] fbClipBoxes: box=(1, 1),(15, 15); region=(1, 1),(15, 15) x 1
>[  1903.398] fbDrawableRun: box=(1, 1), (15, 15), clip=(1, 1), (15, 15)
>[  1903.398] sfbBlt 14x14, alu=7, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  1903.398] sna_gc_move_to_gpu(0x97a6a0)
>[  1903.398] sna_get_image: pixmap=7 (0, 0)x(16, 16), format=1, mask=1, depth=1
>[  1903.398] sna_drawable_move_region_to_cpu(pixmap=7 (16x16), [(0, 0), (16, 16)], flags=22)
>[  1903.398] sna_drawable_move_region_to_cpu: not attached to pixmap 7 (depth 1)
>[  1903.398] sfbGetImage (0, 0)x(16, 16)
>[  1903.398] sfbBlt 16x16, alu=3, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  1903.398] sfbBlt fast blt, src_stride=4, dst_stride=4, width=2 (offset=1691616)
>[  1903.398] sna_destroy_pixmap: pixmap=7, attached?=0
>[  1903.398] sna_change_window_attributes
>[  1903.398] sna_validate_gc(0x97a7a0) changes=7fffff, previous serial=80000000, drawable=5
>[  1903.398] sna_validate_gc: recomputing clip
>[  1903.398] sna_validate_gc: composite clip=1x[(0, 0), (1920, 1080)] [0x97afc0]
>[  1903.398] sna_poly_fill_rect(n=1, PlaneMask: ffffffffffffffff (solid 1), solid fill: 1 [style=0, tileIsPixel=1], alu=3)
>[  1903.398] sna_poly_fill_rect_extents: [0] = (0, 0)x(1920, 1080)
>[  1903.398] sna_poly_fill_rect: extents(0, 0), (1920, 1080), flags=1
>[  1903.398] discard_cpu_damage: discarding existing CPU damage
>[  1903.398] sna_poly_fill_rect: promoting to full GPU
>[  1903.398] sna_poly_fill_rect: dropping last-cpu hint
>[  1903.398] sna_drawable_use_bo pixmap=3, box=((0, 0), (1920, 1080)), flags=19...
>[  1903.398] sna_drawable_use_bo: pinned, never REPLACES
>[  1903.398] sna_drawable_use_bo: flush=0, shm=0, cpu=0 => flags=9
>[  1903.398] sna_drawable_use_bo: use GPU fast path (all-damaged)
>[  1903.398] sna_drawable_use_bo: using whole GPU bo
>[  1903.398] sna_poly_fill_rect: solid fill [0], testing for blt
>[  1903.398] sna_poly_fill_rect_blt pixmap=3 x 1 [(0, 0)x(1920, 1080)...]+(0,0), clipped?=0
>[  1903.398] sna_poly_fill_rect_blt: using fill_one() fast path: (0, 0), (1920, 1080). alu=3, pixel=0
>[  1903.398] kgem_bo_is_render: handle=8, rq? 1 [3]
>[  1903.398] kgem_bo_is_render: handle=8, rq? 1 [3]
>[  1903.398] kgem_bo_is_render: handle=8, rq? 1 [3]
>[  1903.398] sna_blt_fill_boxes (32, 0, 3) x 1
>[  1903.398] sna_blt_fill_box: box=((0, 0), (1920, 1080))
>[  1903.398] kgem_add_reloc: handle=8, pos=4, delta=0, domains=28002
>[  1903.398] kgem_add_handle: handle=8, index=0
>[  1903.398] __kgem_bo_mark_dirty: handle=8 (proxy? 0)
>[  1903.398] sna_poly_fill_rect_blt: pixmap=3, marking clear [0]
>[  1903.420] (II) config/udev: Adding input device Power Button (/dev/input/event4)
>[  1903.420] (**) Power Button: Applying InputClass "evdev keyboard catchall"
>[  1903.420] (**) Power Button: Applying InputClass "evdev keyboard catchall"
>[  1903.420] (**) Power Button: Applying InputClass "LocalKeyboard"
>[  1903.420] (II) LoadModule: "evdev"
>[  1903.420] (II) Loading /usr/lib64/xorg/modules/input/evdev_drv.so
>[  1903.420] (II) Module evdev: vendor="X.Org Foundation"
>[  1903.420] 	compiled for 1.14.3, module version = 2.8.2
>[  1903.420] 	Module class: X.Org XInput Driver
>[  1903.420] 	ABI class: X.Org XInput driver, version 19.1
>[  1903.421] (II) Using input driver 'evdev' for 'Power Button'
>[  1903.421] (**) Power Button: always reports core events
>[  1903.421] (**) evdev: Power Button: Device: "/dev/input/event4"
>[  1903.421] (--) evdev: Power Button: Vendor 0 Product 0x1
>[  1903.421] (--) evdev: Power Button: Found keys
>[  1903.421] (II) evdev: Power Button: Configuring as keyboard
>[  1903.421] (**) Option "config_info" "udev:/sys/devices/LNXSYSTM:00/LNXPWRBN:00/input/input6/event4"
>[  1903.421] (II) XINPUT: Adding extended input device "Power Button" (type: KEYBOARD, id 6)
>[  1903.421] (**) Option "xkb_rules" "evdev"
>[  1903.421] (**) Option "xkb_model" "evdev"
>[  1903.421] (**) Option "xkb_layout" "us"
>[  1903.439] (II) config/udev: Adding input device Video Bus (/dev/input/event6)
>[  1903.439] (**) Video Bus: Applying InputClass "evdev keyboard catchall"
>[  1903.439] (**) Video Bus: Applying InputClass "evdev keyboard catchall"
>[  1903.439] (**) Video Bus: Applying InputClass "LocalKeyboard"
>[  1903.439] (II) Using input driver 'evdev' for 'Video Bus'
>[  1903.439] (**) Video Bus: always reports core events
>[  1903.439] (**) evdev: Video Bus: Device: "/dev/input/event6"
>[  1903.439] (--) evdev: Video Bus: Vendor 0 Product 0x6
>[  1903.440] (--) evdev: Video Bus: Found keys
>[  1903.440] (II) evdev: Video Bus: Configuring as keyboard
>[  1903.440] (**) Option "config_info" "udev:/sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input8/event6"
>[  1903.440] (II) XINPUT: Adding extended input device "Video Bus" (type: KEYBOARD, id 7)
>[  1903.440] (**) Option "xkb_rules" "evdev"
>[  1903.440] (**) Option "xkb_model" "evdev"
>[  1903.440] (**) Option "xkb_layout" "us"
>[  1903.440] (II) config/udev: Adding input device Lid Switch (/dev/input/event2)
>[  1903.440] (II) No input driver specified, ignoring this device.
>[  1903.440] (II) This device may have been added with another device file.
>[  1903.440] (II) config/udev: Adding input device Sleep Button (/dev/input/event3)
>[  1903.440] (**) Sleep Button: Applying InputClass "evdev keyboard catchall"
>[  1903.440] (**) Sleep Button: Applying InputClass "evdev keyboard catchall"
>[  1903.440] (**) Sleep Button: Applying InputClass "LocalKeyboard"
>[  1903.440] (II) Using input driver 'evdev' for 'Sleep Button'
>[  1903.440] (**) Sleep Button: always reports core events
>[  1903.440] (**) evdev: Sleep Button: Device: "/dev/input/event3"
>[  1903.440] (--) evdev: Sleep Button: Vendor 0 Product 0x3
>[  1903.440] (--) evdev: Sleep Button: Found keys
>[  1903.440] (II) evdev: Sleep Button: Configuring as keyboard
>[  1903.440] (**) Option "config_info" "udev:/sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input5/event3"
>[  1903.440] (II) XINPUT: Adding extended input device "Sleep Button" (type: KEYBOARD, id 8)
>[  1903.440] (**) Option "xkb_rules" "evdev"
>[  1903.440] (**) Option "xkb_model" "evdev"
>[  1903.440] (**) Option "xkb_layout" "us"
>[  1903.441] (II) config/udev: Adding drm device (/dev/dri/card0)
>[  1903.441] (II) config/udev: Adding input device Microsoft Corporation Microsoft Â® Laser Mouse 6000 (/dev/input/event5)
>[  1903.441] (**) Microsoft Corporation Microsoft Â® Laser Mouse 6000: Applying InputClass "evdev pointer catchall"
>[  1903.441] (**) Microsoft Corporation Microsoft Â® Laser Mouse 6000: Applying InputClass "evdev pointer catchall"
>[  1903.441] (II) Using input driver 'evdev' for 'Microsoft Corporation Microsoft Â® Laser Mouse 6000'
>[  1903.441] (**) Microsoft Corporation Microsoft Â® Laser Mouse 6000: always reports core events
>[  1903.441] (**) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: Device: "/dev/input/event5"
>[  1903.441] (--) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: Vendor 0x45e Product 0xf0
>[  1903.441] (--) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: Found 9 mouse buttons
>[  1903.441] (--) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: Found scroll wheel(s)
>[  1903.441] (--) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: Found relative axes
>[  1903.441] (--) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: Found x and y relative axes
>[  1903.441] (II) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: Configuring as mouse
>[  1903.441] (II) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: Adding scrollwheel support
>[  1903.441] (**) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: YAxisMapping: buttons 4 and 5
>[  1903.441] (**) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: EmulateWheelButton: 4, EmulateWheelInertia: 10, EmulateWheelTimeout: 200
>[  1903.441] (**) Option "config_info" "udev:/sys/devices/pci0000:00/0000:00:14.0/usb3/3-3/3-3.2/3-3.2:1.0/0003:045E:00F0.0001/input/input7/event5"
>[  1903.441] (II) XINPUT: Adding extended input device "Microsoft Corporation Microsoft Â® Laser Mouse 6000" (type: MOUSE, id 9)
>[  1903.441] (II) evdev: Microsoft Corporation Microsoft Â® Laser Mouse 6000: initialized for relative axes.
>[  1903.442] (**) Microsoft Corporation Microsoft Â® Laser Mouse 6000: (accel) keeping acceleration scheme 1
>[  1903.442] (**) Microsoft Corporation Microsoft Â® Laser Mouse 6000: (accel) acceleration profile 0
>[  1903.442] (**) Microsoft Corporation Microsoft Â® Laser Mouse 6000: (accel) acceleration factor: 2.000
>[  1903.442] (**) Microsoft Corporation Microsoft Â® Laser Mouse 6000: (accel) acceleration threshold: 4
>[  1903.442] (II) config/udev: Adding input device Microsoft Corporation Microsoft Â® Laser Mouse 6000 (/dev/input/mouse1)
>[  1903.442] (II) No input driver specified, ignoring this device.
>[  1903.442] (II) This device may have been added with another device file.
>[  1903.442] (II) config/udev: Adding input device Integrated Camera (/dev/input/event9)
>[  1903.442] (**) Integrated Camera: Applying InputClass "evdev keyboard catchall"
>[  1903.442] (**) Integrated Camera: Applying InputClass "evdev keyboard catchall"
>[  1903.442] (**) Integrated Camera: Applying InputClass "LocalKeyboard"
>[  1903.442] (II) Using input driver 'evdev' for 'Integrated Camera'
>[  1903.442] (**) Integrated Camera: always reports core events
>[  1903.442] (**) evdev: Integrated Camera: Device: "/dev/input/event9"
>[  1903.442] (--) evdev: Integrated Camera: Vendor 0x5986 Product 0x2d2
>[  1903.442] (--) evdev: Integrated Camera: Found keys
>[  1903.442] (II) evdev: Integrated Camera: Configuring as keyboard
>[  1903.442] (**) Option "config_info" "udev:/sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6:1.0/input/input11/event9"
>[  1903.442] (II) XINPUT: Adding extended input device "Integrated Camera" (type: KEYBOARD, id 10)
>[  1903.442] (**) Option "xkb_rules" "evdev"
>[  1903.442] (**) Option "xkb_model" "evdev"
>[  1903.442] (**) Option "xkb_layout" "us"
>[  1903.443] (II) config/udev: Adding input device HDA Digital PCBeep (/dev/input/event10)
>[  1903.443] (II) No input driver specified, ignoring this device.
>[  1903.443] (II) This device may have been added with another device file.
>[  1903.443] (II) config/udev: Adding input device HDA Intel PCH Mic (/dev/input/event11)
>[  1903.443] (II) No input driver specified, ignoring this device.
>[  1903.443] (II) This device may have been added with another device file.
>[  1903.443] (II) config/udev: Adding input device HDA Intel PCH Dock Mic (/dev/input/event12)
>[  1903.443] (II) No input driver specified, ignoring this device.
>[  1903.443] (II) This device may have been added with another device file.
>[  1903.443] (II) config/udev: Adding input device HDA Intel PCH Headphone (/dev/input/event13)
>[  1903.443] (II) No input driver specified, ignoring this device.
>[  1903.443] (II) This device may have been added with another device file.
>[  1903.443] (II) config/udev: Adding input device HDA Intel PCH Dock Headphone (/dev/input/event14)
>[  1903.443] (II) No input driver specified, ignoring this device.
>[  1903.443] (II) This device may have been added with another device file.
>[  1903.444] (II) config/udev: Adding input device HDA Intel PCH HDMI/DP,pcm=3 (/dev/input/event15)
>[  1903.444] (II) No input driver specified, ignoring this device.
>[  1903.444] (II) This device may have been added with another device file.
>[  1903.444] (II) config/udev: Adding input device HDA Intel PCH HDMI/DP,pcm=7 (/dev/input/event16)
>[  1903.444] (II) No input driver specified, ignoring this device.
>[  1903.444] (II) This device may have been added with another device file.
>[  1903.444] (II) config/udev: Adding input device HDA Intel PCH HDMI/DP,pcm=8 (/dev/input/event17)
>[  1903.444] (II) No input driver specified, ignoring this device.
>[  1903.444] (II) This device may have been added with another device file.
>[  1903.444] (II) config/udev: Adding input device AT Translated Set 2 keyboard (/dev/input/event0)
>[  1903.444] (**) AT Translated Set 2 keyboard: Applying InputClass "evdev keyboard catchall"
>[  1903.444] (**) AT Translated Set 2 keyboard: Applying InputClass "evdev keyboard catchall"
>[  1903.444] (**) AT Translated Set 2 keyboard: Applying InputClass "LocalKeyboard"
>[  1903.444] (II) Using input driver 'evdev' for 'AT Translated Set 2 keyboard'
>[  1903.444] (**) AT Translated Set 2 keyboard: always reports core events
>[  1903.444] (**) evdev: AT Translated Set 2 keyboard: Device: "/dev/input/event0"
>[  1903.444] (--) evdev: AT Translated Set 2 keyboard: Vendor 0x1 Product 0x1
>[  1903.444] (--) evdev: AT Translated Set 2 keyboard: Found keys
>[  1903.444] (II) evdev: AT Translated Set 2 keyboard: Configuring as keyboard
>[  1903.444] (**) Option "config_info" "udev:/sys/devices/platform/i8042/serio0/input/input0/event0"
>[  1903.444] (II) XINPUT: Adding extended input device "AT Translated Set 2 keyboard" (type: KEYBOARD, id 11)
>[  1903.444] (**) Option "xkb_rules" "evdev"
>[  1903.444] (**) Option "xkb_model" "evdev"
>[  1903.444] (**) Option "xkb_layout" "us"
>[  1903.445] (II) config/udev: Adding input device SynPS/2 Synaptics TouchPad (/dev/input/event1)
>[  1903.445] (**) SynPS/2 Synaptics TouchPad: Applying InputClass "evdev touchpad catchall"
>[  1903.445] (**) SynPS/2 Synaptics TouchPad: Applying InputClass "evdev touchpad catchall"
>[  1903.445] (**) SynPS/2 Synaptics TouchPad: Applying InputClass "touchpad catchall"
>[  1903.445] (**) SynPS/2 Synaptics TouchPad: Applying InputClass "Default clickpad buttons"
>[  1903.445] (II) LoadModule: "synaptics"
>[  1903.445] (II) Loading /usr/lib64/xorg/modules/input/synaptics_drv.so
>[  1903.445] (II) Module synaptics: vendor="X.Org Foundation"
>[  1903.445] 	compiled for 1.14.3, module version = 1.7.1
>[  1903.445] 	Module class: X.Org XInput Driver
>[  1903.445] 	ABI class: X.Org XInput driver, version 19.1
>[  1903.445] (II) Using input driver 'synaptics' for 'SynPS/2 Synaptics TouchPad'
>[  1903.445] (**) SynPS/2 Synaptics TouchPad: always reports core events
>[  1903.445] (**) Option "Device" "/dev/input/event1"
>[  1903.460] (II) synaptics: SynPS/2 Synaptics TouchPad: found clickpad property
>[  1903.460] (--) synaptics: SynPS/2 Synaptics TouchPad: x-axis range 1472 - 5768 (res 65)
>[  1903.460] (--) synaptics: SynPS/2 Synaptics TouchPad: y-axis range 1408 - 5062 (res 136)
>[  1903.460] (--) synaptics: SynPS/2 Synaptics TouchPad: pressure range 0 - 255
>[  1903.460] (--) synaptics: SynPS/2 Synaptics TouchPad: finger width range 0 - 15
>[  1903.460] (--) synaptics: SynPS/2 Synaptics TouchPad: buttons: left double triple
>[  1903.460] (--) synaptics: SynPS/2 Synaptics TouchPad: Vendor 0x2 Product 0x7
>[  1903.460] (**) Option "HorizScrollDelta" "0"
>[  1903.460] (**) Option "TapButton1" "1"
>[  1903.460] (**) Option "TapButton2" "3"
>[  1903.460] (**) Option "TapButton3" "2"
>[  1903.460] (**) Option "SoftButtonAreas" "50% 0 82% 0 0 0 0 0"
>[  1903.460] (--) synaptics: SynPS/2 Synaptics TouchPad: touchpad found
>[  1903.460] (**) SynPS/2 Synaptics TouchPad: always reports core events
>[  1903.469] (**) Option "config_info" "udev:/sys/devices/platform/i8042/serio1/input/input2/event1"
>[  1903.469] (II) XINPUT: Adding extended input device "SynPS/2 Synaptics TouchPad" (type: TOUCHPAD, id 12)
>[  1903.469] (**) synaptics: SynPS/2 Synaptics TouchPad: (accel) MinSpeed is now constant deceleration 2.5
>[  1903.469] (**) synaptics: SynPS/2 Synaptics TouchPad: (accel) MaxSpeed is now 1.75
>[  1903.469] (**) synaptics: SynPS/2 Synaptics TouchPad: (accel) AccelFactor is now 0.035
>[  1903.469] (**) SynPS/2 Synaptics TouchPad: (accel) keeping acceleration scheme 1
>[  1903.469] (**) SynPS/2 Synaptics TouchPad: (accel) acceleration profile 1
>[  1903.469] (**) SynPS/2 Synaptics TouchPad: (accel) acceleration factor: 2.000
>[  1903.469] (**) SynPS/2 Synaptics TouchPad: (accel) acceleration threshold: 4
>[  1903.469] (--) synaptics: SynPS/2 Synaptics TouchPad: touchpad found
>[  1903.470] (II) config/udev: Adding input device SynPS/2 Synaptics TouchPad (/dev/input/mouse0)
>[  1903.470] (**) SynPS/2 Synaptics TouchPad: Ignoring device from InputClass "touchpad ignore duplicates"
>[  1903.470] (II) config/udev: Adding input device TPPS/2 IBM TrackPoint (/dev/input/event18)
>[  1903.470] (**) TPPS/2 IBM TrackPoint: Applying InputClass "evdev pointer catchall"
>[  1903.470] (**) TPPS/2 IBM TrackPoint: Applying InputClass "evdev pointer catchall"
>[  1903.470] (**) TPPS/2 IBM TrackPoint: Applying InputClass "IBM TPPS/2 TrackPoint|ThinkPad USB Keyboard with TrackPoint"
>[  1903.470] (II) Using input driver 'evdev' for 'TPPS/2 IBM TrackPoint'
>[  1903.470] (**) TPPS/2 IBM TrackPoint: always reports core events
>[  1903.470] (**) evdev: TPPS/2 IBM TrackPoint: Device: "/dev/input/event18"
>[  1903.470] (--) evdev: TPPS/2 IBM TrackPoint: Vendor 0x2 Product 0xa
>[  1903.470] (--) evdev: TPPS/2 IBM TrackPoint: Found 3 mouse buttons
>[  1903.470] (--) evdev: TPPS/2 IBM TrackPoint: Found relative axes
>[  1903.470] (--) evdev: TPPS/2 IBM TrackPoint: Found x and y relative axes
>[  1903.470] (II) evdev: TPPS/2 IBM TrackPoint: Configuring as mouse
>[  1903.470] (**) Option "EmulateWheel" "on"
>[  1903.470] (**) Option "EmulateWheelButton" "2"
>[  1903.470] (**) evdev: TPPS/2 IBM TrackPoint: YAxisMapping: buttons 4 and 5
>[  1903.470] (**) evdev: TPPS/2 IBM TrackPoint: EmulateWheelButton: 2, EmulateWheelInertia: 10, EmulateWheelTimeout: 200
>[  1903.470] (**) Option "config_info" "udev:/sys/devices/platform/i8042/serio1/serio2/input/input3/event18"
>[  1903.470] (II) XINPUT: Adding extended input device "TPPS/2 IBM TrackPoint" (type: MOUSE, id 13)
>[  1903.470] (II) evdev: TPPS/2 IBM TrackPoint: initialized for relative axes.
>[  1903.470] (**) TPPS/2 IBM TrackPoint: (accel) keeping acceleration scheme 1
>[  1903.470] (**) TPPS/2 IBM TrackPoint: (accel) acceleration profile 0
>[  1903.470] (**) TPPS/2 IBM TrackPoint: (accel) acceleration factor: 2.000
>[  1903.470] (**) TPPS/2 IBM TrackPoint: (accel) acceleration threshold: 4
>[  1903.470] (II) config/udev: Adding input device TPPS/2 IBM TrackPoint (/dev/input/mouse2)
>[  1903.470] (**) TPPS/2 IBM TrackPoint: Applying InputClass "IBM TPPS/2 TrackPoint|ThinkPad USB Keyboard with TrackPoint"
>[  1903.470] (II) Using input driver 'evdev' for 'TPPS/2 IBM TrackPoint'
>[  1903.470] (**) TPPS/2 IBM TrackPoint: always reports core events
>[  1903.470] (**) evdev: TPPS/2 IBM TrackPoint: Device: "/dev/input/mouse2"
>[  1903.470] (EE) evdev: TPPS/2 IBM TrackPoint: ioctl EVIOCGBIT for bitmask in EvdevOpenMTDev failed: Inappropriate ioctl for device
>[  1903.470] (EE) TPPS/2 IBM TrackPoint: Couldn't open mtdev device
>[  1903.478] (EE) PreInit returned 2 for "TPPS/2 IBM TrackPoint"
>[  1903.478] (II) UnloadModule: "evdev"
>[  1903.478] (II) config/udev: Adding input device PC Speaker (/dev/input/event7)
>[  1903.478] (II) No input driver specified, ignoring this device.
>[  1903.478] (II) This device may have been added with another device file.
>[  1903.480] (II) config/udev: Adding input device ThinkPad Extra Buttons (/dev/input/event8)
>[  1903.480] (**) ThinkPad Extra Buttons: Applying InputClass "evdev keyboard catchall"
>[  1903.480] (**) ThinkPad Extra Buttons: Applying InputClass "evdev keyboard catchall"
>[  1903.480] (**) ThinkPad Extra Buttons: Applying InputClass "LocalKeyboard"
>[  1903.480] (II) Using input driver 'evdev' for 'ThinkPad Extra Buttons'
>[  1903.480] (**) ThinkPad Extra Buttons: always reports core events
>[  1903.480] (**) evdev: ThinkPad Extra Buttons: Device: "/dev/input/event8"
>[  1903.480] (--) evdev: ThinkPad Extra Buttons: Vendor 0x17aa Product 0x5054
>[  1903.480] (--) evdev: ThinkPad Extra Buttons: Found keys
>[  1903.480] (II) evdev: ThinkPad Extra Buttons: Configuring as keyboard
>[  1903.480] (**) Option "config_info" "udev:/sys/devices/platform/thinkpad_acpi/input/input10/event8"
>[  1903.480] (II) XINPUT: Adding extended input device "ThinkPad Extra Buttons" (type: KEYBOARD, id 14)
>[  1903.480] (**) Option "xkb_rules" "evdev"
>[  1903.480] (**) Option "xkb_model" "evdev"
>[  1903.480] (**) Option "xkb_layout" "us"
>[  1903.483] sna_save_screen(mode=2)
>[  1903.483] sna_crtc_dpms(pipe 0, dpms mode -> 0):= active=1
>[  1903.483] sna_crtc_dpms(pipe 1, dpms mode -> 0):= active=1
>[  1903.483] sna_output_dpms(LVDS1:13): dpms=0 (current: 0), active? 1
>[  1903.483] sna_output_dpms(DP2:32): dpms=0 (current: 0), active? 1
>[  1903.483] sna_crtc_config_notify(dirty?=0)
>[  1903.483] sna_block_handler (tv=600.0)
>[  1903.483] kgem_retire, need_retire?=1
>[  1903.483] kgem_retire__flushing: 0 bo on flushing list
>[  1903.483] kgem_retire__requests_ring: ring=0, 0 outstanding requests, oldest=0
>[  1903.483] __kgem_busy: handle=1, busy=0, wedged=0
>[  1903.483] __kgem_retire_rq: request 1 complete
>[  1903.483] kgem_retire__requests_ring: ring=1, 0 outstanding requests, oldest=0
>[  1903.483] kgem_retire -- retired=0, need_retire=0
>[  1903.483] sna_accel_block_handler: GPU idle, flushing
>[  1903.483] batch[3/3, flags=1c00]: 8 8 16384 16384, nreloc=1, nexec=1, nfence=0, aperture=2025 [fenced=0]
>[  1903.483] gem_write__cachealigned(handle=1, offset=0, len=32)
>[  1903.483] kgem_commit: release handle=1 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=440b000
>[  1903.483] kgem_commit: release handle=8 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=3c22000
>[  1903.483] __kgem_busy: handle=8, busy=262145, wedged=0
>[  1903.483] __kgem_flush: handle=8, busy?=1
>[  1903.483] timer_enable (time=1903483), starting timer 1
>[  1903.483] sna_wakeup_handler
>[  1903.483] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  1903.483] sna_block_handler (tv=600.0)
>[  1903.483] kgem_retire, need_retire?=1
>[  1903.483] kgem_retire__flushing: 0 bo on flushing list
>[  1903.483] kgem_retire__requests_ring: ring=0, 0 outstanding requests, oldest=0
>[  1903.483] __kgem_busy: handle=1, busy=262145, wedged=0
>[  1903.483] kgem_retire__requests_ring: ring=1, 1 outstanding requests, oldest=1
>[  1903.483] kgem_retire -- retired=0, need_retire=1
>[  1903.483] sna_wakeup_handler
>[  1903.483] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  1903.483] sna_block_handler (tv=0.0)
>[  1903.483] sna_wakeup_handler
>[  1903.483] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  1903.484] sna_block_handler (tv=599.999000)
>[  1903.484] kgem_retire, need_retire?=1
>[  1903.484] kgem_retire__flushing: 0 bo on flushing list
>[  1903.484] kgem_retire__requests_ring: ring=0, 0 outstanding requests, oldest=0
>[  1903.484] __kgem_busy: handle=1, busy=262145, wedged=0
>[  1903.484] kgem_retire__requests_ring: ring=1, 1 outstanding requests, oldest=1
>[  1903.484] kgem_retire -- retired=0, need_retire=1
>[  1903.484] sna_wakeup_handler
>[  1903.484] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  1903.484] sna_block_handler (tv=599.999000)
>[  1903.484] kgem_retire, need_retire?=1
>[  1903.484] kgem_retire__flushing: 0 bo on flushing list
>[  1903.484] kgem_retire__requests_ring: ring=0, 0 outstanding requests, oldest=0
>[  1903.484] __kgem_busy: handle=1, busy=262145, wedged=0
>[  1903.484] kgem_retire__requests_ring: ring=1, 1 outstanding requests, oldest=1
>[  1903.484] kgem_retire -- retired=0, need_retire=1
>[  1903.484] sna_wakeup_handler
>[  1903.484] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  1903.484] sna_block_handler (tv=599.999000)
>[  1903.484] kgem_retire, need_retire?=1
>[  1903.484] kgem_retire__flushing: 0 bo on flushing list
>[  1903.484] kgem_retire__requests_ring: ring=0, 0 outstanding requests, oldest=0
>[  1903.484] __kgem_busy: handle=1, busy=0, wedged=0
>[  1903.484] __kgem_retire_rq: request 1 complete
>[  1903.484] kgem_retire__requests_ring: ring=1, 0 outstanding requests, oldest=0
>[  1903.484] kgem_retire -- retired=0, need_retire=0
>[  1903.484] sna_wakeup_handler
>[  1903.484] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.484] sna_block_handler (tv=599.999000)
>[  1903.484] sna_wakeup_handler
>[  1903.484] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.484] sna_block_handler (tv=599.999000)
>[  1903.485] sna_wakeup_handler
>[  1903.485] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.485] sna_block_handler (tv=599.998000)
>[  1903.485] sna_wakeup_handler
>[  1903.485] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.485] sna_block_handler (tv=599.998000)
>[  1903.496] sna_wakeup_handler
>[  1903.496] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.496] sna_block_handler (tv=599.987000)
>[  1903.496] sna_wakeup_handler
>[  1903.496] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.496] sna_block_handler (tv=0.0)
>[  1903.496] sna_wakeup_handler
>[  1903.496] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.496] sna_block_handler (tv=599.987000)
>[  1903.497] sna_wakeup_handler
>[  1903.497] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.497] sna_block_handler (tv=599.986000)
>[  1903.497] sna_wakeup_handler
>[  1903.497] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.497] sna_block_handler (tv=599.986000)
>[  1903.497] sna_wakeup_handler
>[  1903.497] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.497] sna_block_handler (tv=599.986000)
>[  1903.497] sna_wakeup_handler
>[  1903.497] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.497] sna_block_handler (tv=599.986000)
>[  1903.497] sna_wakeup_handler
>[  1903.497] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.497] sna_block_handler (tv=599.986000)
>[  1903.497] sna_wakeup_handler
>[  1903.497] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.497] sna_block_handler (tv=599.986000)
>[  1903.505] sna_wakeup_handler
>[  1903.506] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.506] sna_block_handler (tv=599.977000)
>[  1903.506] sna_accel_do_throttle (time=1903506), triggered
>[  1903.506] sna_accel_throttle (time=1903506)
>[  1903.506] sna_accel_disarm_timer[1] (time=1903506)
>[  1903.506] sna_wakeup_handler
>[  1903.506] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.506] sna_block_handler (tv=599.977000)
>[  1903.506] sna_accel_do_throttle -- no pending activity
>[  1903.507] sna_wakeup_handler
>[  1903.507] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.507] sna_block_handler (tv=599.976000)
>[  1903.507] sna_accel_do_throttle -- no pending activity
>[  1903.507] sna_wakeup_handler
>[  1903.507] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.507] sna_block_handler (tv=0.0)
>[  1903.507] sna_wakeup_handler
>[  1903.507] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.507] sna_block_handler (tv=599.976000)
>[  1903.507] sna_accel_do_throttle -- no pending activity
>[  1903.507] sna_wakeup_handler
>[  1903.507] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.507] sna_block_handler (tv=599.976000)
>[  1903.507] sna_accel_do_throttle -- no pending activity
>[  1903.507] sna_wakeup_handler
>[  1903.507] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.507] sna_block_handler (tv=599.976000)
>[  1903.507] sna_accel_do_throttle -- no pending activity
>[  1903.507] sna_wakeup_handler
>[  1903.507] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.507] sna_block_handler (tv=599.976000)
>[  1903.507] sna_accel_do_throttle -- no pending activity
>[  1903.507] sna_wakeup_handler
>[  1903.507] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.507] sna_block_handler (tv=599.976000)
>[  1903.507] sna_accel_do_throttle -- no pending activity
>[  1903.507] sna_wakeup_handler
>[  1903.507] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.507] sna_block_handler (tv=599.976000)
>[  1903.507] sna_accel_do_throttle -- no pending activity
>[  1903.507] sna_wakeup_handler
>[  1903.508] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.508] sna_block_handler (tv=599.975000)
>[  1903.508] sna_accel_do_throttle -- no pending activity
>[  1903.508] sna_wakeup_handler
>[  1903.508] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.508] sna_block_handler (tv=600.0)
>[  1903.508] sna_accel_do_throttle -- no pending activity
>[  1903.508] sna_wakeup_handler
>[  1903.508] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.508] sna_block_handler (tv=600.0)
>[  1903.508] sna_accel_do_throttle -- no pending activity
>[  1903.508] sna_wakeup_handler
>[  1903.508] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.508] sna_block_handler (tv=600.0)
>[  1903.508] sna_accel_do_throttle -- no pending activity
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.509] sna_block_handler (tv=599.999000)
>[  1903.509] sna_accel_do_throttle -- no pending activity
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.509] sna_block_handler (tv=0.0)
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.509] sna_block_handler (tv=599.999000)
>[  1903.509] sna_accel_do_throttle -- no pending activity
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.509] sna_block_handler (tv=599.999000)
>[  1903.509] sna_accel_do_throttle -- no pending activity
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.509] sna_block_handler (tv=599.999000)
>[  1903.509] sna_accel_do_throttle -- no pending activity
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.509] sna_block_handler (tv=599.999000)
>[  1903.509] sna_accel_do_throttle -- no pending activity
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.509] sna_block_handler (tv=599.999000)
>[  1903.509] sna_accel_do_throttle -- no pending activity
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.509] sna_block_handler (tv=599.999000)
>[  1903.509] sna_accel_do_throttle -- no pending activity
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.509] sna_block_handler (tv=599.999000)
>[  1903.509] sna_accel_do_throttle -- no pending activity
>[  1903.509] sna_wakeup_handler
>[  1903.509] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.510] sna_block_handler (tv=599.998000)
>[  1903.510] sna_accel_do_throttle -- no pending activity
>[  1903.510] sna_wakeup_handler
>[  1903.510] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.510] sna_block_handler (tv=599.998000)
>[  1903.510] sna_accel_do_throttle -- no pending activity
>[  1903.511] sna_wakeup_handler
>[  1903.511] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.511] sna_block_handler (tv=599.997000)
>[  1903.511] sna_accel_do_throttle -- no pending activity
>[  1903.511] sna_wakeup_handler
>[  1903.511] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.512] sna_block_handler (tv=599.996000)
>[  1903.512] sna_accel_do_throttle -- no pending activity
>[  1903.547] sna_wakeup_handler
>[  1903.547] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.547] sna_block_handler (tv=599.961000)
>[  1903.547] sna_accel_do_throttle -- no pending activity
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=0.0)
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=599.960000)
>[  1903.548] sna_accel_do_throttle -- no pending activity
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=599.960000)
>[  1903.548] sna_accel_do_throttle -- no pending activity
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=599.960000)
>[  1903.548] sna_accel_do_throttle -- no pending activity
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=599.960000)
>[  1903.548] sna_accel_do_throttle -- no pending activity
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=599.960000)
>[  1903.548] sna_accel_do_throttle -- no pending activity
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=599.960000)
>[  1903.548] sna_accel_do_throttle -- no pending activity
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=599.960000)
>[  1903.548] sna_accel_do_throttle -- no pending activity
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=599.960000)
>[  1903.548] sna_accel_do_throttle -- no pending activity
>[  1903.548] sna_wakeup_handler
>[  1903.548] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.548] sna_block_handler (tv=599.960000)
>[  1903.548] sna_accel_do_throttle -- no pending activity
>[  1903.549] sna_wakeup_handler
>[  1903.549] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.549] sna_block_handler (tv=599.959000)
>[  1903.549] sna_accel_do_throttle -- no pending activity
>[  1903.549] sna_wakeup_handler
>[  1903.549] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.549] sna_block_handler (tv=0.0)
>[  1903.549] sna_wakeup_handler
>[  1903.549] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.549] sna_block_handler (tv=599.959000)
>[  1903.549] sna_accel_do_throttle -- no pending activity
>[  1903.549] sna_wakeup_handler
>[  1903.549] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.549] sna_block_handler (tv=599.959000)
>[  1903.549] sna_accel_do_throttle -- no pending activity
>[  1903.549] sna_wakeup_handler
>[  1903.549] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.549] sna_block_handler (tv=599.959000)
>[  1903.549] sna_accel_do_throttle -- no pending activity
>[  1903.549] sna_wakeup_handler
>[  1903.549] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.549] sna_block_handler (tv=599.959000)
>[  1903.549] sna_accel_do_throttle -- no pending activity
>[  1903.549] sna_wakeup_handler
>[  1903.549] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.549] sna_block_handler (tv=599.959000)
>[  1903.549] sna_accel_do_throttle -- no pending activity
>[  1903.549] sna_wakeup_handler
>[  1903.549] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.549] sna_block_handler (tv=599.959000)
>[  1903.549] sna_accel_do_throttle -- no pending activity
>[  1903.549] sna_wakeup_handler
>[  1903.549] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.549] sna_block_handler (tv=599.959000)
>[  1903.549] sna_accel_do_throttle -- no pending activity
>[  1903.555] sna_wakeup_handler
>[  1903.555] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.555] sna_block_handler (tv=599.953000)
>[  1903.555] sna_accel_do_throttle -- no pending activity
>[  1903.555] sna_wakeup_handler
>[  1903.555] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.555] sna_block_handler (tv=599.953000)
>[  1903.555] sna_accel_do_throttle -- no pending activity
>[  1903.598] sna_wakeup_handler
>[  1903.598] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.598] sna_block_handler (tv=599.910000)
>[  1903.598] sna_accel_do_throttle -- no pending activity
>[  1903.598] sna_wakeup_handler
>[  1903.598] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.598] sna_block_handler (tv=0.0)
>[  1903.598] sna_wakeup_handler
>[  1903.598] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.598] sna_block_handler (tv=599.910000)
>[  1903.598] sna_accel_do_throttle -- no pending activity
>[  1903.598] sna_wakeup_handler
>[  1903.598] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.598] sna_block_handler (tv=599.910000)
>[  1903.598] sna_accel_do_throttle -- no pending activity
>[  1903.598] sna_wakeup_handler
>[  1903.598] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.598] sna_block_handler (tv=599.910000)
>[  1903.598] sna_accel_do_throttle -- no pending activity
>[  1903.598] sna_wakeup_handler
>[  1903.598] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.598] sna_block_handler (tv=599.910000)
>[  1903.598] sna_accel_do_throttle -- no pending activity
>[  1903.599] sna_wakeup_handler
>[  1903.599] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.599] sna_block_handler (tv=599.909000)
>[  1903.599] sna_accel_do_throttle -- no pending activity
>[  1903.599] sna_wakeup_handler
>[  1903.599] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.599] sna_block_handler (tv=599.909000)
>[  1903.599] sna_accel_do_throttle -- no pending activity
>[  1903.599] sna_wakeup_handler
>[  1903.599] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.599] sna_block_handler (tv=599.909000)
>[  1903.599] sna_accel_do_throttle -- no pending activity
>[  1903.603] sna_wakeup_handler
>[  1903.603] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.603] sna_block_handler (tv=599.905000)
>[  1903.603] sna_accel_do_throttle -- no pending activity
>[  1903.603] sna_wakeup_handler
>[  1903.603] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.603] sna_block_handler (tv=0.0)
>[  1903.603] sna_wakeup_handler
>[  1903.603] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.603] sna_block_handler (tv=599.905000)
>[  1903.603] sna_accel_do_throttle -- no pending activity
>[  1903.603] sna_wakeup_handler
>[  1903.603] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.603] sna_block_handler (tv=599.905000)
>[  1903.603] sna_accel_do_throttle -- no pending activity
>[  1903.603] sna_wakeup_handler
>[  1903.603] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.603] sna_block_handler (tv=599.905000)
>[  1903.603] sna_accel_do_throttle -- no pending activity
>[  1903.603] sna_wakeup_handler
>[  1903.603] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.603] sna_block_handler (tv=599.905000)
>[  1903.603] sna_accel_do_throttle -- no pending activity
>[  1903.603] sna_wakeup_handler
>[  1903.603] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.603] sna_block_handler (tv=599.905000)
>[  1903.603] sna_accel_do_throttle -- no pending activity
>[  1903.603] sna_wakeup_handler
>[  1903.603] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.603] sna_block_handler (tv=599.905000)
>[  1903.603] sna_accel_do_throttle -- no pending activity
>[  1903.603] sna_wakeup_handler
>[  1903.603] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.604] sna_block_handler (tv=599.904000)
>[  1903.604] sna_accel_do_throttle -- no pending activity
>[  1903.604] sna_wakeup_handler
>[  1903.604] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.604] sna_block_handler (tv=599.904000)
>[  1903.604] sna_accel_do_throttle -- no pending activity
>[  1903.604] sna_wakeup_handler
>[  1903.604] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.604] sna_block_handler (tv=599.904000)
>[  1903.604] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=0.0)
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.606] sna_wakeup_handler
>[  1903.606] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.606] sna_block_handler (tv=599.902000)
>[  1903.606] sna_accel_do_throttle -- no pending activity
>[  1903.618] sna_wakeup_handler
>[  1903.618] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.618] sna_block_handler (tv=599.890000)
>[  1903.618] sna_accel_do_throttle -- no pending activity
>[  1903.618] sna_wakeup_handler
>[  1903.618] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.618] sna_block_handler (tv=0.0)
>[  1903.618] sna_wakeup_handler
>[  1903.618] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.618] sna_block_handler (tv=599.890000)
>[  1903.618] sna_accel_do_throttle -- no pending activity
>[  1903.618] sna_wakeup_handler
>[  1903.618] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.618] sna_block_handler (tv=599.890000)
>[  1903.618] sna_accel_do_throttle -- no pending activity
>[  1903.618] sna_wakeup_handler
>[  1903.618] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.618] sna_block_handler (tv=599.890000)
>[  1903.618] sna_accel_do_throttle -- no pending activity
>[  1903.618] sna_wakeup_handler
>[  1903.618] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.618] sna_block_handler (tv=599.890000)
>[  1903.618] sna_accel_do_throttle -- no pending activity
>[  1903.618] sna_wakeup_handler
>[  1903.618] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.618] sna_block_handler (tv=599.890000)
>[  1903.618] sna_accel_do_throttle -- no pending activity
>[  1903.619] sna_wakeup_handler
>[  1903.619] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.619] sna_block_handler (tv=599.889000)
>[  1903.619] sna_accel_do_throttle -- no pending activity
>[  1903.619] sna_wakeup_handler
>[  1903.619] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.619] sna_block_handler (tv=599.889000)
>[  1903.619] sna_accel_do_throttle -- no pending activity
>[  1903.619] sna_wakeup_handler
>[  1903.619] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.619] sna_block_handler (tv=599.889000)
>[  1903.619] sna_accel_do_throttle -- no pending activity
>[  1903.619] sna_wakeup_handler
>[  1903.619] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.619] sna_block_handler (tv=599.889000)
>[  1903.619] sna_accel_do_throttle -- no pending activity
>[  1903.626] sna_wakeup_handler
>[  1903.626] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.626] sna_block_handler (tv=599.882000)
>[  1903.626] sna_accel_do_throttle -- no pending activity
>[  1903.627] sna_wakeup_handler
>[  1903.627] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.627] sna_block_handler (tv=0.0)
>[  1903.627] sna_wakeup_handler
>[  1903.627] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.627] sna_block_handler (tv=599.881000)
>[  1903.627] sna_accel_do_throttle -- no pending activity
>[  1903.627] sna_wakeup_handler
>[  1903.627] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.627] sna_block_handler (tv=599.881000)
>[  1903.627] sna_accel_do_throttle -- no pending activity
>[  1903.627] sna_wakeup_handler
>[  1903.627] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.627] sna_block_handler (tv=599.881000)
>[  1903.627] sna_accel_do_throttle -- no pending activity
>[  1903.627] sna_wakeup_handler
>[  1903.627] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.627] sna_block_handler (tv=599.881000)
>[  1903.627] sna_accel_do_throttle -- no pending activity
>[  1903.627] sna_wakeup_handler
>[  1903.627] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.627] sna_block_handler (tv=599.881000)
>[  1903.627] sna_accel_do_throttle -- no pending activity
>[  1903.627] sna_wakeup_handler
>[  1903.627] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.627] sna_block_handler (tv=599.881000)
>[  1903.627] sna_accel_do_throttle -- no pending activity
>[  1903.627] sna_wakeup_handler
>[  1903.627] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.627] sna_block_handler (tv=599.881000)
>[  1903.627] sna_accel_do_throttle -- no pending activity
>[  1903.627] sna_wakeup_handler
>[  1903.627] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.627] sna_block_handler (tv=599.881000)
>[  1903.627] sna_accel_do_throttle -- no pending activity
>[  1903.628] sna_wakeup_handler
>[  1903.628] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.628] sna_create_pixmap(24, 24, 32, usage=0)
>[  1903.628] kgem_can_create_2d: 24x24 @ 32
>[  1903.628] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=96, height=24
>[  1903.628] kgem_can_create_2d: untiled size=4096
>[  1903.628] kgem_choose_tiling: too thin [width 24, 32 bpp] for TILING_X
>[  1903.628] kgem_choose_tiling: 24x24 -> 0
>[  1903.628] sna_create_pixmap: usage=0, flags=a
>[  1903.628] sna_create_pixmap: small buffer [2304], attaching to shadow pixmap
>[  1903.628] create_pixmap: allocating pixmap 24x24, depth=32, size=2312
>[  1903.628] create_pixmap: serial=9, usage=0, 24x24
>[  1903.628] sna_create_pixmap: serial=9, 24x24, usage=0
>[  1903.628] sna_validate_gc(0xc1aed0) changes=7fffff, previous serial=80000000, drawable=a
>[  1903.628] sna_validate_gc: recomputing clip
>[  1903.628] sna_validate_gc: composite clip=1x[(0, 0), (24, 24)] [0xc1afd0]
>[  1903.628] sna_put_image((0, 0)x(24, 24), depth=32, format=2)
>[  1903.628] try_upload__inplace: bo? 0, can map? 0, replaces? 1
>[  1903.628] sna_pixmap_move_area_to_gpu: pixmap=10 box=(0, 0), (24, 24), flags=1
>[  1903.628] _sna_damage_subtract_box(None - (0, 0), (24, 24))...
>[  1903.628]   = None
>[  1903.628] sna_pixmap_move_to_gpu(pixmap=10, usage=0), flags=3
>[  1903.628] sna_pixmap_move_to_gpu: CPU damage? 0
>[  1903.628] sna_pixmap_move_to_gpu: creating GPU bo (24x24@32), create=8
>[  1903.628] sna_pixmap_move_to_gpu: not creating GPU bo
>[  1903.628] try_upload__fast: no, no gpu damage
>[  1903.628] sna_drawable_move_region_to_cpu(pixmap=10 (24x24), [(0, 0), (24, 24)], flags=1)
>[  1903.628] sna_drawable_move_region_to_cpu: region (0, 0), (24, 24) + (0, 0) subsumes pixmap (24x24)
>[  1903.628] _sna_pixmap_move_to_cpu(pixmap=10, 24x24, flags=1)
>[  1903.628] _sna_pixmap_move_to_cpu: gpu_bo=0, gpu_damage=0x0, cpu_damage=0x0, is-clear?=0
>[  1903.628] _sna_pixmap_move_to_cpu: no readback, discarding gpu damage [0], pending clear[0]
>[  1903.628] operate_inplace: no, inplace operation not suitable
>[  1903.628] _sna_pixmap_move_to_cpu: marking as damaged
>[  1903.628] __sna_damage_all(24, 24)
>[  1903.628] sna_pixmap_free_gpu: handle=0 (pinned? 0)
>[  1903.628] sna_put_zpixmap_blt: upload(0, 0, 24, 24) x 1 boxes
>[  1903.628] sna_put_zpixmap_blt: copy box (0, 0)->(0, 0)x(24, 24)
>[  1903.628] memcpy_blt: src=(0, 0), dst=(0, 0), size=24x24, pitch=96/96
>[  1903.628] sna_get_image: pixmap=10 (0, 0)x(24, 24), format=2, mask=ffffffff, depth=32
>[  1903.628] sna_get_image__fast: attached?=1, has gpu damage?=0
>[  1903.628] sna_drawable_move_region_to_cpu(pixmap=10 (24x24), [(0, 0), (24, 24)], flags=22)
>[  1903.628] sna_drawable_move_region_to_cpu: pixmap=10 all damaged on CPU
>[  1903.628] sna_get_image: copy box (0, 0), (24, 24)
>[  1903.628] memcpy_blt: src=(0, 0), dst=(0, 0), size=24x24, pitch=96/96
>[  1903.628] sna_destroy_pixmap: pixmap=10, attached?=1
>[  1903.628] __sna_free_pixmap(pixmap=10)
>[  1903.628] sna_block_handler (tv=599.880000)
>[  1903.628] sna_accel_do_throttle -- no pending activity
>[  1903.628] sna_wakeup_handler
>[  1903.628] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.628] sna_block_handler (tv=599.880000)
>[  1903.628] sna_accel_do_throttle -- no pending activity
>[  1903.628] sna_wakeup_handler
>[  1903.628] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.628] memcpy_blt: src=(0, 0), dst=(0, 0), size=24x24, pitch=96/256
>[  1903.628] sna_change_window_attributes
>[  1903.628] sna_block_handler (tv=599.880000)
>[  1903.628] sna_accel_do_throttle -- no pending activity
>[  1903.628] sna_wakeup_handler
>[  1903.628] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.628] sna_block_handler (tv=599.880000)
>[  1903.628] sna_accel_do_throttle -- no pending activity
>[  1903.630] sna_wakeup_handler
>[  1903.630] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.630] sna_block_handler (tv=599.878000)
>[  1903.630] sna_accel_do_throttle -- no pending activity
>[  1903.630] sna_wakeup_handler
>[  1903.630] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.630] sna_block_handler (tv=0.0)
>[  1903.630] sna_wakeup_handler
>[  1903.630] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.630] sna_block_handler (tv=599.878000)
>[  1903.630] sna_accel_do_throttle -- no pending activity
>[  1903.630] sna_wakeup_handler
>[  1903.630] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.630] sna_block_handler (tv=599.878000)
>[  1903.630] sna_accel_do_throttle -- no pending activity
>[  1903.630] sna_wakeup_handler
>[  1903.630] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=0.0)
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.631] sna_block_handler (tv=599.877000)
>[  1903.631] sna_accel_do_throttle -- no pending activity
>[  1903.631] sna_wakeup_handler
>[  1903.631] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.632] sna_block_handler (tv=599.876000)
>[  1903.632] sna_accel_do_throttle -- no pending activity
>[  1903.632] sna_wakeup_handler
>[  1903.632] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.632] sna_change_window_attributes
>[  1903.632] sna_block_handler (tv=599.876000)
>[  1903.632] sna_accel_do_throttle -- no pending activity
>[  1903.658] sna_wakeup_handler
>[  1903.658] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.658] sna_create_pixmap(1920, 1080, 24, usage=0)
>[  1903.658] kgem_can_create_2d: 1920x1080 @ 24
>[  1903.658] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=7680, height=1080
>[  1903.658] kgem_can_create_2d: untiled size=8294400
>[  1903.658] kgem_choose_tiling: TLB miss between lines 1920x1080 (pitch=7680), forcing tiling 1
>[  1903.658] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=7680, height=1080
>[  1903.658] kgem_can_create_2d: tiled[-1] size=8294400
>[  1903.658] sna_create_pixmap: usage=0, flags=b
>[  1903.658] sna_create_pixmap: creating GPU pixmap 1920x1080, stride=7680, flags=b
>[  1903.658] create_pixmap: allocating pixmap 0x0, depth=24, size=0
>[  1903.658] create_pixmap: serial=11, usage=0, 0x0
>[  1903.658] sna_create_pixmap: serial=11, 1920x1080, usage=0
>[  1903.658] sna_block_handler (tv=599.850000)
>[  1903.658] sna_accel_do_throttle -- no pending activity
>[  1903.658] sna_wakeup_handler
>[  1903.658] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.658] sna_block_handler (tv=599.850000)
>[  1903.658] sna_accel_do_throttle -- no pending activity
>[  1903.660] sna_wakeup_handler
>[  1903.660] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.660] sna_create_pixmap(1366, 768, 24, usage=0)
>[  1903.660] kgem_can_create_2d: 1366x768 @ 24
>[  1903.660] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=5464, height=768
>[  1903.660] kgem_can_create_2d: untiled size=4198400
>[  1903.660] kgem_choose_tiling: TLB miss between lines 1366x768 (pitch=5464), forcing tiling 1
>[  1903.660] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=5464, height=768
>[  1903.660] kgem_can_create_2d: tiled[-1] size=4198400
>[  1903.660] sna_create_pixmap: usage=0, flags=b
>[  1903.660] sna_create_pixmap: creating GPU pixmap 1366x768, stride=5464, flags=b
>[  1903.660] create_pixmap: allocating pixmap 0x0, depth=24, size=0
>[  1903.660] create_pixmap: serial=13, usage=0, 0x0
>[  1903.660] sna_create_pixmap: serial=13, 1366x768, usage=0
>[  1903.660] sna_validate_gc(0xc1aed0) changes=7fffff, previous serial=80000000, drawable=e
>[  1903.660] sna_validate_gc: recomputing clip
>[  1903.660] sna_validate_gc: composite clip=1x[(0, 0), (1366, 768)] [0xc1afd0]
>[  1903.660] sna_put_image((0, 0)x(1366, 768), depth=24, format=2)
>[  1903.660] try_upload__inplace: bo? 0, can map? 0, replaces? 1
>[  1903.660] sna_pixmap_move_area_to_gpu: pixmap=14 box=(0, 0), (1366, 768), flags=1
>[  1903.660] _sna_damage_subtract_box(None - (0, 0), (1366, 768))...
>[  1903.660]   = None
>[  1903.660] sna_pixmap_move_to_gpu(pixmap=14, usage=0), flags=3
>[  1903.660] sna_pixmap_move_to_gpu: CPU damage? 0
>[  1903.660] sna_pixmap_move_to_gpu: creating GPU bo (1366x768@32), create=b
>[  1903.660] kgem_choose_tiling: TLB miss between lines 1366x768 (pitch=5464), forcing tiling 1
>[  1903.660] kgem_create_2d(1366x768, bpp=32, tiling=1, exact=1, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=0)
>[  1903.660] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=5632, height=768
>[  1903.660] __kgem_bo_init(handle=11, num_pages=1056)
>[  1903.660]   new pitch=5632, tiling=1, handle=11, id=268, num_pages=1056 [1056], bucket=10
>[  1903.660] __sna_damage_all(1366, 768)
>[  1903.660] sna_pixmap_move_to_gpu: marking as all-damaged for GPU
>[  1903.660] sna_pixmap_mark_active: pixmap=14, handle=11
>[  1903.660] __kgem_bo_is_busy: handle=11, domain: 1 exec? 0, rq? 0
>[  1903.660] kgem_bo_is_busy: handle=11, domain: 1 exec? 0, rq? 0
>[  1903.660] try_upload__inplace: tiling=1
>[  1903.660] kgem_bo_can_map__cpu: handle=11
>[  1903.660] kgem_bo_can_map__cpu: yes, has LLC and target is in LLC
>[  1903.660] kgem_bo_map__cpu(handle=11, size=4325376, map=0x0:0x0)
>[  1903.660] kgem_trim_vma_cache: type=1, count=-32767 (bucket: 10)
>[  1903.660] kgem_bo_map__cpu: caching CPU vma for 11
>[  1903.660] kgem_bo_sync__cpu: handle=11
>[  1903.660] try_upload__tiled_x: upload(0, 0, 1366, 768) x 1
>[  1903.660] try_upload__tiled_x: copy tiled box (0, 0)->(0, 0)x(1366, 768)
>[  1903.660] memcpy_to_tiled_x__swizzle_0(bpp=32): src=(0, 0), dst=(0, 0), size=1366x768, pitch=5464/5632
>[  1903.663] sna_block_handler (tv=599.845000)
>[  1903.663] sna_accel_do_throttle -- no pending activity
>[  1903.703] sna_wakeup_handler
>[  1903.703] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.704] sna_validate_gc(0xc1aff0) changes=7fffff, previous serial=80000000, drawable=c
>[  1903.704] sna_validate_gc: recomputing clip
>[  1903.704] sna_validate_gc: composite clip=1x[(0, 0), (1920, 1080)] [0xc1b0f0]
>[  1903.704] sna_copy_area: src=(0, 0)x(1366, 768)+(0, 0) -> dst=(0, 0)+(0, 0); alu=3, pm=ffffffffffffffff, depth=24
>[  1903.704] sna_do_copy: src=(0, 0), dst=(0, 0), size=(1366x768)
>[  1903.704] sna_do_copy: after drawable: src=(0, 0), dst=(0, 0), size=(1366x768)
>[  1903.704] sna_do_copy: dst extents (0, 0), (1366, 768), dst clip extents (0, 0), (1920, 1080), dst size=1920x1080
>[  1903.704] sna_do_copy: clipped dst extents (0, 0), (1366, 768)
>[  1903.704] sna_do_copy: unclipped src extents (0, 0), (1366, 768)
>[  1903.704] sna_do_copy: pixmap -- no source clipping
>[  1903.704] sna_do_copy: src extents (0, 0), (1366, 768) x 1
>[  1903.704] sna_do_copy: copy region (0, 0), (1366, 768) x 1
>[  1903.704] sna_copy_boxes (boxes=1x[(0, 0), (1366, 768)...], src=+(0, 0), dst=+(0, 0), alu=3, src.size=1366x768, dst.size=1920x1080)
>[  1903.704] sna_copy_boxes: dst=(priv=0xc10670, gpu_bo=0, cpu_bo=0), src=(priv=0xb46ae0, gpu_bo=11, cpu_bo=0), replaces=0
>[  1903.704] copy_prefer_gpu: source has gpu damage, force gpu? 1
>[  1903.704] sna_drawable_use_bo pixmap=12, box=((0, 0), (1366, 768)), flags=b...
>[  1903.704] sna_drawable_use_bo: flush=0, shm=0, cpu=0 => flags=b
>[  1903.704] sna_drawable_use_bo: gpu? 0, damaged? 0; cpu? 0, damaged? 0
>[  1903.704] sna_pixmap_move_to_gpu(pixmap=12, usage=0), flags=43
>[  1903.704] sna_pixmap_move_to_gpu: CPU damage? 0
>[  1903.704] sna_pixmap_move_to_gpu: creating GPU bo (1920x1080@32), create=b
>[  1903.704] kgem_choose_tiling: TLB miss between lines 1920x1080 (pitch=7680), forcing tiling 1
>[  1903.704] kgem_create_2d(1920x1080, bpp=32, tiling=1, exact=1, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=0)
>[  1903.704] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=7680, height=1080
>[  1903.704] __kgem_bo_init(handle=12, num_pages=2025)
>[  1903.704]   new pitch=7680, tiling=1, handle=12, id=269, num_pages=2025 [2025], bucket=10
>[  1903.704] __sna_damage_all(1920, 1080)
>[  1903.704] sna_pixmap_move_to_gpu: marking as all-damaged for GPU
>[  1903.704] sna_pixmap_mark_active: pixmap=12, handle=12
>[  1903.704] sna_drawable_use_bo: allocated GPU bo for operation
>[  1903.704] sna_drawable_use_bo: using GPU bo with damage? 0
>[  1903.704] sna_pixmap_move_to_gpu(pixmap=14, usage=0), flags=a
>[  1903.704] sna_pixmap_move_to_gpu: already all-damaged
>[  1903.704] sna_pixmap_mark_active: pixmap=14, handle=11
>[  1903.704] sna_copy_boxes: move whole src_pixmap to GPU and copy
>[  1903.704] gen7_render_copy_boxes (0, 0)->(0, 0) x 1, alu=3, flags=0, self-copy=0, overlaps? 0
>[  1903.704] kgem_bo_is_render: handle=11, rq? 0 [0]
>[  1903.704] kgem_bo_is_render: handle=12, rq? 0 [0]
>[  1903.704] kgem_bo_is_render: handle=12, rq? 0 [0]
>[  1903.704] kgem_bo_is_render: handle=11, rq? 0 [0]
>[  1903.704] kgem_check_bo: num_pages=+3081, num_exec=+2
>[  1903.704] aligning vertex: was 0, now 2 floats per vertex
>[  1903.704] kgem_add_reloc: handle=0, pos=19, delta=1, domains=100000
>[  1903.704] kgem_add_reloc: handle=3, pos=20, delta=769, domains=100000
>[  1903.704] kgem_add_handle: handle=3, index=0
>[  1903.704] kgem_add_reloc: handle=3, pos=22, delta=769, domains=100000
>[  1903.704] gen7_composite_get_binding_table(ffe0)
>[  1903.704] kgem_add_reloc: handle=12, pos=16369, delta=0, domains=20002
>[  1903.704] kgem_add_handle: handle=12, index=1
>[  1903.704] __kgem_bo_mark_dirty: handle=12 (proxy? 0)
>[  1903.704] [3ff0] bind bo(handle=12, addr=0), format=192, width=1920, height=1080, pitch=7680, tiling=1 -> render
>[  1903.704] kgem_add_reloc: handle=11, pos=16361, delta=0, domains=40000
>[  1903.704] kgem_add_handle: handle=11, index=2
>[  1903.704] [3fe8] bind bo(handle=11, addr=0), format=192, width=1366, height=768, pitch=5632, tiling=1 -> sampler
>[  1903.704] gen7_emit_cc: blend = 980
>[  1903.704] gen7_emit_sampler: sampler = 0
>[  1903.704] gen7_emit_sf: num_sf_outputs=1, read_length=1, read_offset=0
>[  1903.704] gen7_emit_wm: switching to NOMASK, num_surfaces=2 (8-wide? 64, 16-wide? 192, 32-wide? 0)
>[  1903.704] gen7_emit_vertex_elements: setup id=0
>[  1903.705] gen7_emit_vertex_elements: first channel 0 floats, offset=4b
>[  1903.705] 	(0, 0) -> (0, 0) + (1366, 768)
>[  1903.705] gen4_vertex_flush[20c] = 3
>[  1903.705] sna_destroy_pixmap: pixmap=14, attached?=1
>[  1903.705] _kgem_bo_destroy: handle=11, proxy? 0
>[  1903.705] __kgem_bo_destroy: handle=11, size=4325376
>[  1903.705] __kgem_bo_destroy: handle=11 -> active
>[  1903.705] __sna_free_pixmap(pixmap=14)
>[  1903.705] sna_create_pixmap(1920, 1080, 24, usage=0)
>[  1903.705] kgem_can_create_2d: 1920x1080 @ 24
>[  1903.705] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=7680, height=1080
>[  1903.705] kgem_can_create_2d: untiled size=8294400
>[  1903.705] kgem_choose_tiling: TLB miss between lines 1920x1080 (pitch=7680), forcing tiling 1
>[  1903.705] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=7680, height=1080
>[  1903.705] kgem_can_create_2d: tiled[-1] size=8294400
>[  1903.705] sna_create_pixmap: usage=0, flags=b
>[  1903.705] sna_create_pixmap: creating GPU pixmap 1920x1080, stride=7680, flags=b
>[  1903.705] sna_create_pixmap: serial=15, 1920x1080, usage=0
>[  1903.705] sna_validate_gc(0xc1aed0) changes=0, previous serial=e, drawable=10
>[  1903.705] sna_validate_gc: recomputing clip
>[  1903.705] sna_validate_gc: composite clip=1x[(0, 0), (1920, 1080)] [0xc1afd0]
>[  1903.705] sna_put_image((0, 0)x(1920, 1080), depth=24, format=2)
>[  1903.705] try_upload__inplace: bo? 0, can map? 0, replaces? 1
>[  1903.705] sna_pixmap_move_area_to_gpu: pixmap=16 box=(0, 0), (1920, 1080), flags=1
>[  1903.705] _sna_damage_subtract_box(None - (0, 0), (1920, 1080))...
>[  1903.705]   = None
>[  1903.705] sna_pixmap_move_to_gpu(pixmap=16, usage=0), flags=3
>[  1903.705] sna_pixmap_move_to_gpu: CPU damage? 0
>[  1903.705] sna_pixmap_move_to_gpu: creating GPU bo (1920x1080@32), create=b
>[  1903.705] kgem_choose_tiling: TLB miss between lines 1920x1080 (pitch=7680), forcing tiling 1
>[  1903.705] kgem_create_2d(1920x1080, bpp=32, tiling=1, exact=1, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=0)
>[  1903.705] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=7680, height=1080
>[  1903.705] __kgem_bo_init(handle=13, num_pages=2025)
>[  1903.705]   new pitch=7680, tiling=1, handle=13, id=270, num_pages=2025 [2025], bucket=10
>[  1903.705] __sna_damage_all(1920, 1080)
>[  1903.705] sna_pixmap_move_to_gpu: marking as all-damaged for GPU
>[  1903.705] sna_pixmap_mark_active: pixmap=16, handle=13
>[  1903.705] __kgem_bo_is_busy: handle=13, domain: 1 exec? 0, rq? 0
>[  1903.705] kgem_bo_is_busy: handle=13, domain: 1 exec? 0, rq? 0
>[  1903.705] try_upload__inplace: tiling=1
>[  1903.705] kgem_bo_can_map__cpu: handle=13
>[  1903.705] kgem_bo_can_map__cpu: yes, has LLC and target is in LLC
>[  1903.705] kgem_bo_map__cpu(handle=13, size=8294400, map=0x0:0x0)
>[  1903.705] kgem_trim_vma_cache: type=1, count=-32767 (bucket: 10)
>[  1903.705] kgem_bo_map__cpu: caching CPU vma for 13
>[  1903.705] kgem_bo_sync__cpu: handle=13
>[  1903.705] try_upload__tiled_x: upload(0, 0, 1920, 1080) x 1
>[  1903.705] try_upload__tiled_x: copy tiled box (0, 0)->(0, 0)x(1920, 1080)
>[  1903.705] memcpy_to_tiled_x__swizzle_0(bpp=32): src=(0, 0), dst=(0, 0), size=1920x1080, pitch=7680/7680
>[  1903.710] sna_block_handler (tv=599.798000)
>[  1903.710] sna_accel_block_handler: GPU idle, flushing
>[  1903.710] gen4_vertex_close: used=6, vbo active? 0, vb=1, nreloc=1
>[  1903.710] gen4_vertex_close: copy to batch: 6 @ 138
>[  1903.710] gen4_vertex_close: reloc[0] = 126
>[  1903.710] kgem_add_reloc: handle=0, pos=126, delta=552, domains=200000
>[  1903.710] batch[1/1, flags=1c00]: 138 144 16360 16384, nreloc=6, nexec=3, nfence=0, aperture=3090 [fenced=0]
>[  1903.710] shrinking from 16384 to 1024
>[  1903.710] gem_write__cachealigned(handle=1, offset=0, len=576)
>[  1903.710] gem_write(handle=1, offset=4000, len=96)
>[  1903.712] kgem_commit: release handle=1 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=440b000
>[  1903.712] kgem_commit: release handle=12 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=4419000
>[  1903.712] kgem_commit: release handle=3 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=4410000
>[  1903.712] kgem_commit: release handle=11 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=4c02000
>[  1903.712] timer_enable (time=1903712), starting timer 1
>[  1903.714] sna_wakeup_handler
>[  1903.714] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  1903.716] sna_copy_area: src=(0, 0)x(1920, 1080)+(0, 0) -> dst=(0, 0)+(0, 0); alu=3, pm=ffffffffffffffff, depth=24
>[  1903.716] sna_do_copy: src=(0, 0), dst=(0, 0), size=(1920x1080)
>[  1903.716] sna_do_copy: after drawable: src=(0, 0), dst=(0, 0), size=(1920x1080)
>[  1903.716] sna_do_copy: dst extents (0, 0), (1920, 1080), dst clip extents (0, 0), (1920, 1080), dst size=1920x1080
>[  1903.716] sna_do_copy: clipped dst extents (0, 0), (1920, 1080)
>[  1903.716] sna_do_copy: unclipped src extents (0, 0), (1920, 1080)
>[  1903.716] sna_do_copy: pixmap -- no source clipping
>[  1903.716] sna_do_copy: src extents (0, 0), (1920, 1080) x 1
>[  1903.716] sna_do_copy: copy region (0, 0), (1920, 1080) x 1
>[  1903.716] sna_copy_boxes (boxes=1x[(0, 0), (1920, 1080)...], src=+(0, 0), dst=+(0, 0), alu=3, src.size=1920x1080, dst.size=1920x1080)
>[  1903.716] sna_copy_boxes: dst=(priv=0xc10670, gpu_bo=12, cpu_bo=0), src=(priv=0xb46ae0, gpu_bo=13, cpu_bo=0), replaces=1
>[  1903.716] copy_prefer_gpu: source has gpu damage, force gpu? 1
>[  1903.716] discard_cpu_damage: discarding existing CPU damage
>[  1903.716] sna_drawable_use_bo pixmap=12, box=((0, 0), (1920, 1080)), flags=1b...
>[  1903.716] sna_drawable_use_bo: flush=0, shm=0, cpu=0 => flags=1b
>[  1903.716] sna_drawable_use_bo: use GPU fast path (all-damaged)
>[  1903.716] sna_drawable_use_bo: using whole GPU bo
>[  1903.716] sna_pixmap_move_to_gpu(pixmap=16, usage=0), flags=a
>[  1903.716] sna_pixmap_move_to_gpu: already all-damaged
>[  1903.716] sna_pixmap_mark_active: pixmap=16, handle=13
>[  1903.716] sna_copy_boxes: move whole src_pixmap to GPU and copy
>[  1903.716] sna_pixmap_make_cow: make cow src=16, dst=12, handle=13 (already cow? src=0, dst=0)
>[  1903.716] sna_pixmap_make_cow: moo! attaching source cow to pixmap=16, handle=13
>[  1903.716] _kgem_bo_destroy: handle=12, proxy? 0
>[  1903.716] __kgem_bo_destroy: handle=12, size=8294400
>[  1903.716] __kgem_busy: handle=12, busy=0, wedged=0
>[  1903.716] __kgem_bo_clear_busy: handle=12
>[  1903.716] __kgem_bo_destroy: handle=12, purged
>[  1903.716] kgem_bo_move_to_inactive: moving handle=12 to inactive
>[  1903.716] sna_pixmap_make_cow: moo! attaching clone to pixmap=12 (source=16, handle=13)
>[  1903.716] sna_destroy_pixmap: pixmap=16, attached?=1
>[  1903.716] sna_destroy_pixmap: pixmap=16 discarding cow, refcnt=2
>[  1903.716] __sna_free_pixmap(pixmap=16)
>[  1903.716] sna_create_pixmap(408, 234, 24, usage=0)
>[  1903.716] kgem_can_create_2d: 408x234 @ 24
>[  1903.716] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=1632, height=234
>[  1903.716] kgem_can_create_2d: untiled size=385024
>[  1903.716] kgem_choose_tiling: 408x234 -> 1
>[  1903.716] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=2048, height=240
>[  1903.716] kgem_can_create_2d: tiled[1] size=491520
>[  1903.716] sna_create_pixmap: usage=0, flags=b
>[  1903.716] sna_create_pixmap: creating GPU pixmap 408x234, stride=1632, flags=b
>[  1903.716] sna_create_pixmap: serial=17, 408x234, usage=0
>[  1903.716] sna_validate_gc(0xc1aed0) changes=0, previous serial=10, drawable=12
>[  1903.716] sna_validate_gc: recomputing clip
>[  1903.716] sna_validate_gc: composite clip=1x[(0, 0), (408, 234)] [0xc1afd0]
>[  1903.716] sna_put_image((0, 0)x(408, 234), depth=24, format=2)
>[  1903.716] try_upload__inplace: bo? 0, can map? 0, replaces? 1
>[  1903.716] sna_pixmap_move_area_to_gpu: pixmap=18 box=(0, 0), (408, 234), flags=1
>[  1903.716] _sna_damage_subtract_box(None - (0, 0), (408, 234))...
>[  1903.716]   = None
>[  1903.716] sna_pixmap_move_to_gpu(pixmap=18, usage=0), flags=3
>[  1903.716] sna_pixmap_move_to_gpu: CPU damage? 0
>[  1903.716] sna_pixmap_move_to_gpu: creating GPU bo (408x234@32), create=b
>[  1903.716] kgem_choose_tiling: 408x234 -> 1
>[  1903.716] kgem_create_2d(408x234, bpp=32, tiling=1, exact=0, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=0)
>[  1903.716] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=2048, height=240
>[  1903.716] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=2048, height=240
>[  1903.716] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=2048, height=240
>[  1903.716] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=2048, height=240
>[  1903.716] __kgem_bo_init(handle=14, num_pages=120)
>[  1903.716]   new pitch=2048, tiling=1, handle=14, id=271, num_pages=120 [120], bucket=6
>[  1903.716] __sna_damage_all(408, 234)
>[  1903.716] sna_pixmap_move_to_gpu: marking as all-damaged for GPU
>[  1903.716] sna_pixmap_mark_active: pixmap=18, handle=14
>[  1903.716] __kgem_bo_is_busy: handle=14, domain: 1 exec? 0, rq? 0
>[  1903.716] kgem_bo_is_busy: handle=14, domain: 1 exec? 0, rq? 0
>[  1903.716] try_upload__inplace: tiling=1
>[  1903.716] kgem_bo_can_map__cpu: handle=14
>[  1903.716] kgem_bo_can_map__cpu: yes, has LLC and target is in LLC
>[  1903.716] kgem_bo_map__cpu(handle=14, size=491520, map=0x0:0x0)
>[  1903.716] kgem_trim_vma_cache: type=1, count=-32767 (bucket: 6)
>[  1903.716] kgem_bo_map__cpu: caching CPU vma for 14
>[  1903.716] kgem_bo_sync__cpu: handle=14
>[  1903.716] try_upload__tiled_x: upload(0, 0, 408, 234) x 1
>[  1903.716] try_upload__tiled_x: copy tiled box (0, 0)->(0, 0)x(408, 234)
>[  1903.716] memcpy_to_tiled_x__swizzle_0(bpp=32): src=(0, 0), dst=(0, 0), size=408x234, pitch=1632/2048
>[  1903.716] sna_block_handler (tv=599.792000)
>[  1903.716] kgem_retire, need_retire?=1
>[  1903.716] kgem_retire__flushing: 0 bo on flushing list
>[  1903.716] __kgem_busy: handle=1, busy=0, wedged=0
>[  1903.716] __kgem_retire_rq: request 1 complete
>[  1903.716] kgem_bo_move_to_cache: release handle=11
>[  1903.716] kgem_bo_move_to_inactive: moving handle=11 to inactive
>[  1903.716] kgem_retire__requests_ring: ring=0, 0 outstanding requests, oldest=0
>[  1903.716] kgem_retire__requests_ring: ring=1, 0 outstanding requests, oldest=0
>[  1903.717] kgem_retire -- retired=1, need_retire=0
>[  1903.717] timer_enable (time=1903717), starting timer 2
>[  1903.724] sna_wakeup_handler
>[  1903.724] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  1903.724] sna_copy_area: src=(0, 0)x(408, 234)+(0, 0) -> dst=(479, 267)+(0, 0); alu=3, pm=ffffffffffffffff, depth=24
>[  1903.724] sna_do_copy: src=(0, 0), dst=(479, 267), size=(408x234)
>[  1903.724] sna_do_copy: after drawable: src=(0, 0), dst=(479, 267), size=(408x234)
>[  1903.724] sna_do_copy: dst extents (479, 267), (887, 501), dst clip extents (0, 0), (1920, 1080), dst size=1920x1080
>[  1903.724] sna_do_copy: clipped dst extents (479, 267), (887, 501)
>[  1903.724] sna_do_copy: unclipped src extents (0, 0), (408, 234)
>[  1903.724] sna_do_copy: pixmap -- no source clipping
>[  1903.724] sna_do_copy: src extents (0, 0), (408, 234) x 1
>[  1903.724] sna_do_copy: copy region (479, 267), (887, 501) x 1
>[  1903.724] sna_copy_boxes (boxes=1x[(479, 267), (887, 501)...], src=+(-479, -267), dst=+(0, 0), alu=3, src.size=408x234, dst.size=1920x1080)
>[  1903.724] sna_copy_boxes: dst=(priv=0xc10670, gpu_bo=13, cpu_bo=0), src=(priv=0xb46ae0, gpu_bo=14, cpu_bo=0), replaces=0
>[  1903.724] copy_prefer_gpu: source has gpu damage, force gpu? 1
>[  1903.724] sna_drawable_use_bo pixmap=12, box=((479, 267), (887, 501)), flags=b...
>[  1903.724] region_subsumes_damage?
>[  1903.724] region_subsumes_damage: region (479, 267), (887, 501), damage (0, 0), (1920, 1080)
>[  1903.724] region_subsumes_damage: not contained
>[  1903.724] sna_pixmap_undo_cow: pixmap=12, handle=13 [refcnt=1], cow refcnt=1, flags=3
>[  1903.724] sna_pixmap_undo_cow: freeing cow
>[  1903.724] sna_drawable_use_bo: flush=0, shm=0, cpu=0 => flags=b
>[  1903.724] sna_drawable_use_bo: use GPU fast path (all-damaged)
>[  1903.724] sna_drawable_use_bo: using whole GPU bo
>[  1903.724] sna_pixmap_move_to_gpu(pixmap=18, usage=0), flags=a
>[  1903.724] sna_pixmap_move_to_gpu: already all-damaged
>[  1903.724] sna_pixmap_mark_active: pixmap=18, handle=14
>[  1903.724] sna_copy_boxes: move whole src_pixmap to GPU and copy
>[  1903.724] gen7_render_copy_boxes (-479, -267)->(0, 0) x 1, alu=3, flags=0, self-copy=0, overlaps? 0
>[  1903.724] kgem_bo_is_render: handle=14, rq? 0 [0]
>[  1903.724] kgem_bo_is_render: handle=13, rq? 0 [0]
>[  1903.724] kgem_bo_is_render: handle=13, rq? 0 [0]
>[  1903.724] kgem_bo_is_render: handle=14, rq? 0 [0]
>[  1903.724] kgem_check_bo: num_pages=+2145, num_exec=+2
>[  1903.724] kgem_add_reloc: handle=0, pos=19, delta=1, domains=100000
>[  1903.724] kgem_add_reloc: handle=3, pos=20, delta=769, domains=100000
>[  1903.724] kgem_add_handle: handle=3, index=0
>[  1903.724] kgem_add_reloc: handle=3, pos=22, delta=769, domains=100000
>[  1903.724] gen7_composite_get_binding_table(ffe0)
>[  1903.724] kgem_add_reloc: handle=13, pos=16369, delta=0, domains=20002
>[  1903.724] kgem_add_handle: handle=13, index=1
>[  1903.724] __kgem_bo_mark_dirty: handle=13 (proxy? 0)
>[  1903.724] [3ff0] bind bo(handle=13, addr=0), format=192, width=1920, height=1080, pitch=7680, tiling=1 -> render
>[  1903.724] kgem_add_reloc: handle=14, pos=16361, delta=0, domains=40000
>[  1903.724] kgem_add_handle: handle=14, index=2
>[  1903.724] [3fe8] bind bo(handle=14, addr=0), format=192, width=408, height=234, pitch=2048, tiling=1 -> sampler
>[  1903.724] gen7_emit_cc: blend = 980
>[  1903.724] gen7_emit_sampler: sampler = 0
>[  1903.724] gen7_emit_sf: num_sf_outputs=1, read_length=1, read_offset=0
>[  1903.724] gen7_emit_wm: switching to NOMASK, num_surfaces=2 (8-wide? 64, 16-wide? 192, 32-wide? 0)
>[  1903.724] gen7_emit_vertex_elements: setup id=0
>[  1903.724] gen7_emit_vertex_elements: first channel 0 floats, offset=4b
>[  1903.724] 	(0, 0) -> (479, 267) + (408, 234)
>[  1903.724] gen4_vertex_flush[20c] = 3
>[  1903.724] sna_destroy_pixmap: pixmap=18, attached?=1
>[  1903.724] _kgem_bo_destroy: handle=14, proxy? 0
>[  1903.724] __kgem_bo_destroy: handle=14, size=491520
>[  1903.724] __kgem_bo_destroy: handle=14 -> active
>[  1903.724] __sna_free_pixmap(pixmap=18)
>[  1903.724] sna_create_pixmap(780, 372, 24, usage=0)
>[  1903.724] kgem_can_create_2d: 780x372 @ 24
>[  1903.724] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=3120, height=372
>[  1903.724] kgem_can_create_2d: untiled size=1163264
>[  1903.724] kgem_choose_tiling: TLB near-miss between lines 780x372 (pitch=3120), forcing tiling 1
>[  1903.724] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=3120, height=372
>[  1903.724] kgem_can_create_2d: tiled[-1] size=1163264
>[  1903.724] sna_create_pixmap: usage=0, flags=b
>[  1903.724] sna_create_pixmap: creating GPU pixmap 780x372, stride=3120, flags=b
>[  1903.724] sna_create_pixmap: serial=19, 780x372, usage=0
>[  1903.724] sna_validate_gc(0xc1aed0) changes=0, previous serial=12, drawable=14
>[  1903.724] sna_validate_gc: recomputing clip
>[  1903.724] sna_validate_gc: composite clip=1x[(0, 0), (780, 372)] [0xc1afd0]
>[  1903.724] sna_put_image((0, 0)x(780, 372), depth=24, format=2)
>[  1903.724] try_upload__inplace: bo? 0, can map? 0, replaces? 1
>[  1903.724] sna_pixmap_move_area_to_gpu: pixmap=20 box=(0, 0), (780, 372), flags=1
>[  1903.724] _sna_damage_subtract_box(None - (0, 0), (780, 372))...
>[  1903.724]   = None
>[  1903.724] sna_pixmap_move_to_gpu(pixmap=20, usage=0), flags=3
>[  1903.724] sna_pixmap_move_to_gpu: CPU damage? 0
>[  1903.724] sna_pixmap_move_to_gpu: creating GPU bo (780x372@32), create=b
>[  1903.724] kgem_choose_tiling: TLB near-miss between lines 780x372 (pitch=3120), forcing tiling 1
>[  1903.724] kgem_create_2d(780x372, bpp=32, tiling=1, exact=1, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=0)
>[  1903.724] kgem_surface_size: tile_width=512, tile_height=8 => aligned pitch=3584, height=376
>[  1903.724] kgem_bo_remove_from_inactive: removing handle=11 from inactive
>[  1903.724]   from inactive: pitch=3584, tiling=1: handle=11, id=272
>[  1903.724] __sna_damage_all(780, 372)
>[  1903.724] sna_pixmap_move_to_gpu: marking as all-damaged for GPU
>[  1903.724] sna_pixmap_mark_active: pixmap=20, handle=11
>[  1903.724] __kgem_bo_is_busy: handle=11, domain: 0 exec? 0, rq? 0
>[  1903.724] kgem_bo_is_busy: handle=11, domain: 0 exec? 0, rq? 0
>[  1903.724] try_upload__inplace: tiling=1
>[  1903.724] kgem_bo_can_map__cpu: handle=11
>[  1903.724] kgem_bo_can_map__cpu: yes, has LLC and target is in LLC
>[  1903.724] kgem_bo_map__cpu(handle=11, size=4325376, map=0x0:0x7fd58c996000)
>[  1903.724] kgem_bo_sync__cpu: handle=11
>[  1903.724] __kgem_busy: handle=11, busy=0, wedged=0
>[  1903.724] kgem_bo_sync__cpu: SYNC: handle=11, needs_flush? 0, domain? 0, busy? 0
>[  1903.724] __kgem_busy: handle=11, busy=0, wedged=0
>[  1903.724] kgem_bo_retire: retiring bo handle=11 (needed flush? 0), rq? 0 [busy?=0]
>[  1903.724] try_upload__tiled_x: upload(0, 0, 780, 372) x 1
>[  1903.724] try_upload__tiled_x: copy tiled box (0, 0)->(0, 0)x(780, 372)
>[  1903.724] memcpy_to_tiled_x__swizzle_0(bpp=32): src=(0, 0), dst=(0, 0), size=780x372, pitch=3120/3584
>[  1903.725] sna_block_handler (tv=599.783000)
>[  1903.725] sna_accel_block_handler: GPU idle, flushing
>[  1903.725] gen4_vertex_close: used=6, vbo active? 0, vb=1, nreloc=1
>[  1903.725] gen4_vertex_close: copy to batch: 6 @ 138
>[  1903.725] gen4_vertex_close: reloc[0] = 126
>[  1903.725] kgem_add_reloc: handle=0, pos=126, delta=552, domains=200000
>[  1903.725] batch[1/1, flags=1c00]: 138 144 16360 16384, nreloc=6, nexec=3, nfence=0, aperture=2154 [fenced=0]
>[  1903.725] shrinking from 16384 to 1024
>[  1903.725] gem_write__cachealigned(handle=1, offset=0, len=576)
>[  1903.725] gem_write(handle=1, offset=4000, len=96)
>[  1903.725] kgem_commit: release handle=1 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=440b000
>[  1903.725] kgem_commit: release handle=13 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=b7d000
>[  1903.725] kgem_commit: release handle=3 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=4410000
>[  1903.725] kgem_commit: release handle=14 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=1366000
>[  1903.725] sna_wakeup_handler
>[  1903.725] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  1903.725] sna_create_pixmap(78, 124, 24, usage=0)
>[  1903.725] kgem_can_create_2d: 78x124 @ 24
>[  1903.725] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=312, height=124
>[  1903.725] kgem_can_create_2d: untiled size=40960
>[  1903.725] kgem_choose_tiling: too thin [width 78, 32 bpp] for TILING_X
>[  1903.725] kgem_choose_tiling: 78x124 -> 0
>[  1903.725] sna_create_pixmap: usage=0, flags=a
>[  1903.725] sna_create_pixmap: creating GPU pixmap 78x124, stride=312, flags=a
>[  1903.725] create_pixmap: allocating pixmap 0x0, depth=24, size=0
>[  1903.725] create_pixmap: serial=21, usage=0, 0x0
>[  1903.725] sna_create_pixmap: serial=21, 78x124, usage=0
>[  1903.725] sna_validate_gc(0xc1aff0) changes=0, previous serial=c, drawable=16
>[  1903.725] sna_validate_gc: recomputing clip
>[  1903.725] sna_validate_gc: composite clip=1x[(0, 0), (78, 124)] [0xc1b0f0]
>[  1903.725] sna_copy_area: src=(0, 0)x(78, 124)+(0, 0) -> dst=(0, 0)+(0, 0); alu=3, pm=ffffffffffffffff, depth=24
>[  1903.725] sna_do_copy: src=(0, 0), dst=(0, 0), size=(78x124)
>[  1903.725] sna_do_copy: after drawable: src=(0, 0), dst=(0, 0), size=(78x124)
>[  1903.725] sna_do_copy: dst extents (0, 0), (78, 124), dst clip extents (0, 0), (78, 124), dst size=78x124
>[  1903.725] sna_do_copy: clipped dst extents (0, 0), (78, 124)
>[  1903.725] sna_do_copy: unclipped src extents (0, 0), (78, 124)
>[  1903.725] sna_do_copy: pixmap -- no source clipping
>[  1903.725] sna_do_copy: src extents (0, 0), (78, 124) x 1
>[  1903.725] sna_do_copy: copy region (0, 0), (78, 124) x 1
>[  1903.725] sna_copy_boxes (boxes=1x[(0, 0), (78, 124)...], src=+(0, 0), dst=+(0, 0), alu=3, src.size=780x372, dst.size=78x124)
>[  1903.725] sna_copy_boxes: dst=(priv=0xc113f0, gpu_bo=0, cpu_bo=0), src=(priv=0xb46ae0, gpu_bo=11, cpu_bo=0), replaces=1
>[  1903.725] copy_prefer_gpu: source has gpu damage, force gpu? 1
>[  1903.725] discard_cpu_damage: discarding existing CPU damage
>[  1903.725] sna_drawable_use_bo pixmap=22, box=((0, 0), (78, 124)), flags=1b...
>[  1903.725] sna_drawable_use_bo: flush=0, shm=0, cpu=0 => flags=1b
>[  1903.725] sna_drawable_use_bo: gpu? 0, damaged? 0; cpu? 0, damaged? 0
>[  1903.726] sna_pixmap_move_to_gpu(pixmap=22, usage=0), flags=43
>[  1903.726] sna_pixmap_move_to_gpu: CPU damage? 0
>[  1903.726] sna_pixmap_move_to_gpu: creating GPU bo (78x124@32), create=a
>[  1903.726] kgem_choose_tiling: too thin [width 78, 32 bpp] for TILING_X
>[  1903.726] kgem_choose_tiling: 78x124 -> 0
>[  1903.726] kgem_create_2d(78x124, bpp=32, tiling=0, exact=0, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=0)
>[  1903.726] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=312, height=124
>[  1903.726] __kgem_bo_init(handle=15, num_pages=10)
>[  1903.726]   new pitch=312, tiling=0, handle=15, id=273, num_pages=10 [10], bucket=3
>[  1903.726] __sna_damage_all(78, 124)
>[  1903.726] sna_pixmap_move_to_gpu: marking as all-damaged for GPU
>[  1903.726] sna_pixmap_mark_active: pixmap=22, handle=15
>[  1903.726] sna_drawable_use_bo: allocated GPU bo for operation
>[  1903.726] sna_drawable_use_bo: using GPU bo with damage? 0
>[  1903.726] sna_pixmap_move_to_gpu(pixmap=20, usage=0), flags=a
>[  1903.726] sna_pixmap_move_to_gpu: already all-damaged
>[  1903.726] sna_pixmap_mark_active: pixmap=20, handle=11
>[  1903.726] sna_copy_boxes: move whole src_pixmap to GPU and copy
>[  1903.726] gen7_render_copy_boxes (0, 0)->(0, 0) x 1, alu=3, flags=0, self-copy=0, overlaps? 0
>[  1903.726] kgem_bo_is_render: handle=11, rq? 0 [0]
>[  1903.726] kgem_bo_is_render: handle=15, rq? 0 [0]
>[  1903.726] kgem_bo_is_render: handle=15, rq? 0 [0]
>[  1903.726] kgem_bo_is_render: handle=11, rq? 0 [0]
>[  1903.726] __kgem_busy: handle=1, busy=0, wedged=0
>[  1903.726] __kgem_ring_is_idle: ring=0 idle (handle=1)
>[  1903.726] __kgem_busy: handle=1, busy=0, wedged=0
>[  1903.726] __kgem_retire_rq: request 1 complete
>[  1903.726] __kgem_busy: handle=13, busy=0, wedged=0
>[  1903.726] kgem_bo_move_to_cache: release handle=14
>[  1903.726] kgem_bo_move_to_inactive: moving handle=14 to inactive
>[  1903.726] kgem_retire__requests_ring: ring=0, 0 outstanding requests, oldest=0
>[  1903.726] kgem_check_bo: num_pages=+1066, num_exec=+2
>[  1903.726] kgem_add_reloc: handle=0, pos=19, delta=1, domains=100000
>[  1903.726] kgem_add_reloc: handle=3, pos=20, delta=769, domains=100000
>[  1903.726] kgem_add_handle: handle=3, index=0
>[  1903.726] kgem_add_reloc: handle=3, pos=22, delta=769, domains=100000
>[  1903.726] gen7_composite_get_binding_table(ffe0)
>[  1903.726] kgem_add_reloc: handle=15, pos=16369, delta=0, domains=20002
>[  1903.726] kgem_add_handle: handle=15, index=1
>[  1903.726] __kgem_bo_mark_dirty: handle=15 (proxy? 0)
>[  1903.726] [3ff0] bind bo(handle=15, addr=0), format=192, width=78, height=124, pitch=312, tiling=0 -> render
>[  1903.726] kgem_add_reloc: handle=11, pos=16361, delta=0, domains=40000
>[  1903.726] kgem_add_handle: handle=11, index=2
>[  1903.726] [3fe8] bind bo(handle=11, addr=79699968), format=192, width=780, height=372, pitch=3584, tiling=1 -> sampler
>[  1903.726] gen7_emit_cc: blend = 980
>[  1903.726] gen7_emit_sampler: sampler = 0
>[  1903.726] gen7_emit_sf: num_sf_outputs=1, read_length=1, read_offset=0
>[  1903.726] gen7_emit_wm: switching to NOMASK, num_surfaces=2 (8-wide? 64, 16-wide? 192, 32-wide? 0)
>[  1903.726] gen7_emit_vertex_elements: setup id=0
>[  1903.726] gen7_emit_vertex_elements: first channel 0 floats, offset=4b
>[  1903.726] 	(0, 0) -> (0, 0) + (78, 124)
>[  1903.726] gen4_vertex_flush[20c] = 3
>[  1903.726] sna_create_pixmap(78, 124, 24, usage=0)
>[  1903.726] kgem_can_create_2d: 78x124 @ 24
>[  1903.726] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=312, height=124
>[  1903.726] kgem_can_create_2d: untiled size=40960
>[  1903.726] kgem_choose_tiling: too thin [width 78, 32 bpp] for TILING_X
>[  1903.726] kgem_choose_tiling: 78x124 -> 0
>[  1903.726] sna_create_pixmap: usage=0, flags=a
>[  1903.726] sna_create_pixmap: creating GPU pixmap 78x124, stride=312, flags=a
>[  1903.726] create_pixmap: allocating pixmap 0x0, depth=24, size=0
>[  1903.726] create_pixmap: serial=23, usage=0, 0x0
>[  1903.726] sna_create_pixmap: serial=23, 78x124, usage=0
>[  1903.726] sna_validate_gc(0xc1aff0) changes=0, previous serial=16, drawable=18
>[  1903.726] sna_validate_gc: recomputing clip
>[  1903.726] sna_validate_gc: composite clip=1x[(0, 0), (78, 124)] [0xc1b0f0]
>[  1903.726] sna_copy_area: src=(78, 0)x(78, 124)+(0, 0) -> dst=(0, 0)+(0, 0); alu=3, pm=ffffffffffffffff, depth=24
>[  1903.726] sna_do_copy: src=(78, 0), dst=(0, 0), size=(78x124)
>[  1903.726] sna_do_copy: after drawable: src=(78, 0), dst=(0, 0), size=(78x124)
>[  1903.726] sna_do_copy: dst extents (0, 0), (78, 124), dst clip extents (0, 0), (78, 124), dst size=78x124
>[  1903.726] sna_do_copy: clipped dst extents (0, 0), (78, 124)
>[  1903.726] sna_do_copy: unclipped src extents (78, 0), (156, 124)
>[  1903.726] sna_do_copy: pixmap -- no source clipping
>[  1903.726] sna_do_copy: src extents (78, 0), (156, 124) x 1
>[  1903.726] sna_do_copy: copy region (0, 0), (78, 124) x 1
>[  1903.726] sna_copy_boxes (boxes=1x[(0, 0), (78, 124)...], src=+(78, 0), dst=+(0, 0), alu=3, src.size=780x372, dst.size=78x124)
>[  1903.726] sna_copy_boxes: dst=(priv=0xc21550, gpu_bo=0, cpu_bo=0), src=(priv=0xb46ae0, gpu_bo=11, cpu_bo=0), replaces=1
>[  1903.726] copy_prefer_gpu: source has gpu damage, force gpu? 1
>[  1903.726] discard_cpu_damage: discarding existing CPU damage
>[  1903.726] sna_drawable_use_bo pixmap=24, box=((0, 0), (78, 124)), flags=1b...
>[  1903.726] sna_drawable_use_bo: flush=0, shm=0, cpu=0 => flags=1b
>[  1903.726] sna_drawable_use_bo: gpu? 0, damaged? 0; cpu? 0, damaged? 0
>[  1903.726] sna_pixmap_move_to_gpu(pixmap=24, usage=0), flags=43
>[  1903.726] sna_pixmap_move_to_gpu: CPU damage? 0
>[  1903.726] sna_pixmap_move_to_gpu: creating GPU bo (78x124@32), create=a
>[  1903.726] kgem_choose_tiling: too thin [width 78, 32 bpp] for TILING_X
>[  1903.726] kgem_choose_tiling: 78x124 -> 0
>[  1903.726] kgem_create_2d(78x124, bpp=32, tiling=0, exact=0, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=0)
>[  1903.726] kgem_surface_size: tile_width=8, tile_height=1 => aligned pitch=312, height=124
>[  1903.726] __kgem_bo_init(handle=16, num_pages=10)
>[  1903.726]   new pitch=312, tiling=0, handle=16, id=274, num_pages=10 [10], bucket=3
>[  1903.726] __sna_damage_all(78, 124)
>[  1903.726] sna_pixmap_move_to_gpu: marking as all-damaged for GPU
>[  1903.726] sna_pixmap_mark_active: pixmap=24, handle=16
>[  1903.726] sna_drawable_use_bo: allocated GPU bo for operation
>[  1903.726] sna_drawable_use_bo: using GPU bo with damage? 0
>[  1903.726] sna_pixmap_move_to_gpu(pixmap=20, usage=0), flags=a
>[  1903.726] sna_pixmap_move_to_gpu: already all-damaged
>[  1903.726] sna_pixmap_mark_active: pixmap=20, handle=11
>[  1903.726] sna_copy_boxes: move whole src_pixmap to GPU and copy
>[  1903.726] gen7_render_copy_boxes (78, 0)->(0, 0) x 1, alu=3, flags=0, self-copy=0, overlaps? 0
>[  1903.726] kgem_bo_is_render: handle=11, rq? 1 [1]
>[  1903.726] kgem_bo_is_render: handle=16, rq? 0 [0]
>[  1903.726] kgem_bo_is_render: handle=16, rq? 0 [0]
>[  1903.726] kgem_bo_is_render: handle=11, rq? 1 [1]
>[  1903.726] kgem_set_mode: flushing before new bo
>[  1903.726] gen4_vertex_close: used=6, vbo active? 0, vb=1, nreloc=1
>[  1903.726] gen4_vertex_close: copy to batch: 6 @ 138
>[  1903.726] gen4_vertex_close: reloc[0] = 126
>[  1903.726] kgem_add_reloc: handle=0, pos=126, delta=552, domains=200000
>[  1903.726] batch[1/1, flags=1c00]: 138 144 16360 16384, nreloc=6, nexec=3, nfence=0, aperture=1075 [fenced=0]
>[  1903.726] shrinking from 16384 to 1024
>[  1903.726] gem_write__cachealigned(handle=1, offset=0, len=576)
>[  1903.726] gem_write(handle=1, offset=4000, len=96)
>[  1903.726] kgem_commit: release handle=1 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=440b000
>[  1903.726] kgem_commit: release handle=15 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=13de000
>[  1903.726] kgem_commit: release handle=3 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=4410000
>[  1903.726] kgem_commit: release handle=11 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=4c02000
>[  1903.726] __kgem_busy: handle=1, busy=65537, wedged=0
>[  1903.726] __kgem_ring_is_idle: last requests handle=1 still busy
>[  1903.726] needs_batch_flush: flushing before handle=16 for new reservation
>[  1903.726] kgem_check_bo: num_pages=+1066, num_exec=+2

Actions: View

Attachments on bug 70461: 87618 | 101568 | 101570

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.