Attachment 92496 Details for Bug 73856 – Xorg log following sna: Include serial numbers in ValidateGC DBG

Xorg log following sna: Include serial numbers in ValidateGC DBG

Xorg.0.log-2.99.907-40-gf7121bf (text/plain), 137.84 KB, created by Janusz on 2014-01-21 01:09:16 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Janusz

Created: 2014-01-21 01:09:16 UTC

Size: 137.84 KB

patch

obsolete

>[  8986.397] 
>X.Org X Server 1.15.0
>Release Date: 2013-12-27
>[  8986.397] X Protocol Version 11, Revision 0
>[  8986.397] Build Operating System: Linux 3.12.0-gentoo-gnu x86_64 Gentoo
>[  8986.397] Current Operating System: Linux asus 3.12.7-gentoo-gnu #1 SMP PREEMPT Fri Jan 17 15:51:11 CET 2014 x86_64
>[  8986.397] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.12.7-gentoo-gnu root=/dev/sda2 ro quiet nosplash rootfstype=ext4
>[  8986.397] Build Date: 06 January 2014  07:55:40PM
>[  8986.397]  
>[  8986.397] Current version of pixman: 0.32.4
>[  8986.398] 	Before reporting problems, check http://wiki.x.org
>	to make sure that you have the latest version.
>[  8986.398] Markers: (--) probed, (**) from config file, (==) default setting,
>	(++) from command line, (!!) notice, (II) informational,
>	(WW) warning, (EE) error, (NI) not implemented, (??) unknown.
>[  8986.398] (==) Log file: "/var/log/Xorg.0.log", Time: Tue Jan 21 01:13:26 2014
>[  8986.403] (==) Using config directory: "/etc/X11/xorg.conf.d"
>[  8986.403] (==) Using system config directory "/usr/share/X11/xorg.conf.d"
>[  8986.404] (==) No Layout section.  Using the first Screen section.
>[  8986.404] (==) No screen section available. Using defaults.
>[  8986.404] (**) |-->Screen "Default Screen Section" (0)
>[  8986.404] (**) |   |-->Monitor "<default monitor>"
>[  8986.405] (==) No monitor specified for screen "Default Screen Section".
>	Using a default monitor configuration.
>[  8986.405] (==) Automatically adding devices
>[  8986.405] (==) Automatically enabling devices
>[  8986.405] (==) Automatically adding GPU devices
>[  8986.409] (==) FontPath set to:
>	/usr/share/fonts/misc/,
>	/usr/share/fonts/TTF/,
>	/usr/share/fonts/OTF/,
>	/usr/share/fonts/Type1/,
>	/usr/share/fonts/100dpi/,
>	/usr/share/fonts/75dpi/
>[  8986.409] (==) ModulePath set to "/usr/lib64/xorg/modules"
>[  8986.409] (II) The server relies on udev to provide the list of input devices.
>	If no devices become available, reconfigure udev or disable AutoAddDevices.
>[  8986.409] (II) Loader magic: 0x807c40
>[  8986.409] (II) Module ABI versions:
>[  8986.409] 	X.Org ANSI C Emulation: 0.4
>[  8986.409] 	X.Org Video Driver: 15.0
>[  8986.409] 	X.Org XInput driver : 20.0
>[  8986.409] 	X.Org Server Extension : 8.0
>[  8986.409] (II) xfree86: Adding drm device (/dev/dri/card0)
>[  8986.413] (--) PCI:*(0:0:2:0) 8086:2a42:1043:1862 rev 7, Mem @ 0xfe400000/4194304, 0xd0000000/268435456, I/O @ 0x0000dc00/8
>[  8986.413] (--) PCI: (0:0:2:1) 8086:2a43:1043:1862 rev 7, Mem @ 0xfe800000/1048576
>[  8986.413] Initializing built-in extension Generic Event Extension
>[  8986.413] Initializing built-in extension SHAPE
>[  8986.413] Initializing built-in extension MIT-SHM
>[  8986.413] Initializing built-in extension XInputExtension
>[  8986.413] Initializing built-in extension XTEST
>[  8986.413] Initializing built-in extension BIG-REQUESTS
>[  8986.413] Initializing built-in extension SYNC
>[  8986.413] Initializing built-in extension XKEYBOARD
>[  8986.413] Initializing built-in extension XC-MISC
>[  8986.413] Initializing built-in extension XINERAMA
>[  8986.413] Initializing built-in extension XFIXES
>[  8986.413] Initializing built-in extension RENDER
>[  8986.413] Initializing built-in extension RANDR
>[  8986.413] Initializing built-in extension COMPOSITE
>[  8986.413] Initializing built-in extension DAMAGE
>[  8986.413] Initializing built-in extension MIT-SCREEN-SAVER
>[  8986.413] Initializing built-in extension DOUBLE-BUFFER
>[  8986.413] Initializing built-in extension RECORD
>[  8986.413] Initializing built-in extension DPMS
>[  8986.413] Initializing built-in extension Present
>[  8986.413] Initializing built-in extension DRI3
>[  8986.413] Initializing built-in extension X-Resource
>[  8986.413] Initializing built-in extension XVideo
>[  8986.413] Initializing built-in extension XVideo-MotionCompensation
>[  8986.413] Initializing built-in extension XFree86-VidModeExtension
>[  8986.413] Initializing built-in extension XFree86-DGA
>[  8986.413] Initializing built-in extension XFree86-DRI
>[  8986.413] Initializing built-in extension DRI2
>[  8986.413] (II) LoadModule: "glx"
>[  8986.415] (II) Loading /usr/lib64/xorg/modules/extensions/libglx.so
>[  8986.419] (II) Module glx: vendor="X.Org Foundation"
>[  8986.419] 	compiled for 1.15.0, module version = 1.0.0
>[  8986.419] 	ABI class: X.Org Server Extension, version 8.0
>[  8986.419] (==) AIGLX enabled
>[  8986.419] Loading extension GLX
>[  8986.419] (==) Matched intel as autoconfigured driver 0
>[  8986.419] (==) Matched intel as autoconfigured driver 1
>[  8986.419] (==) Matched modesetting as autoconfigured driver 2
>[  8986.419] (==) Matched fbdev as autoconfigured driver 3
>[  8986.419] (==) Matched vesa as autoconfigured driver 4
>[  8986.419] (==) Assigned the driver to the xf86ConfigLayout
>[  8986.419] (II) LoadModule: "intel"
>[  8986.420] (II) Loading /usr/lib64/xorg/modules/drivers/intel_drv.so
>[  8986.420] (II) Module intel: vendor="X.Org Foundation"
>[  8986.420] 	compiled for 1.15.0, module version = 2.99.907
>[  8986.420] 	Module class: X.Org Video Driver
>[  8986.420] 	ABI class: X.Org Video Driver, version 15.0
>[  8986.420] (II) LoadModule: "modesetting"
>[  8986.421] (WW) Warning, couldn't open module modesetting
>[  8986.421] (II) UnloadModule: "modesetting"
>[  8986.421] (II) Unloading modesetting
>[  8986.421] (EE) Failed to load module "modesetting" (module does not exist, 0)
>[  8986.421] (II) LoadModule: "fbdev"
>[  8986.421] (WW) Warning, couldn't open module fbdev
>[  8986.421] (II) UnloadModule: "fbdev"
>[  8986.421] (II) Unloading fbdev
>[  8986.421] (EE) Failed to load module "fbdev" (module does not exist, 0)
>[  8986.421] (II) LoadModule: "vesa"
>[  8986.422] (WW) Warning, couldn't open module vesa
>[  8986.422] (II) UnloadModule: "vesa"
>[  8986.422] (II) Unloading vesa
>[  8986.422] (EE) Failed to load module "vesa" (module does not exist, 0)
>[  8986.422] (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
>[  8986.423] (II) intel: Driver for Intel(R) HD Graphics: 2000-5000
>[  8986.423] (II) intel: Driver for Intel(R) Iris(TM) Graphics: 5100
>[  8986.423] (II) intel: Driver for Intel(R) Iris(TM) Pro Graphics: 5200
>[  8986.423] (++) using VT number 7
>
>[  8986.423] sna_init_scrn: entity_num=0
>[  8986.423] (II) intel(0): SNA compiled from 2.99.907-40-gf7121bf
>[  8986.423] (II) intel(0): SNA compiled with assertions enabled
>[  8986.423] (II) intel(0): SNA compiled with memory allocation reporting enabled
>[  8986.423] (II) intel(0): SNA compiled with extra pixmap/damage validation
>[  8986.423] pixman version: 0.32.4
>[  8986.423] num_cores: processors=0x00000001, cores=0x00000003
>[  8986.423] sna_threads_init: creating a thread pool of 2 threads
>[  8986.424] sna_pre_init flags=0, numEntities=1
>[  8986.424] sna_acpi_open
>[  8986.425] (--) intel(0): Integrated Graphics Chipset: Intel(R) GM45
>[  8986.425] (--) intel(0): CPU: x86-64, sse2, sse3, ssse3
>[  8986.425] (II) intel(0): Creating default Display subsection in Screen section
>	"Default Screen Section" for depth/fbbpp 24/32
>[  8986.425] (==) intel(0): Depth 24, (--) framebuffer bpp 32
>[  8986.425] (==) intel(0): RGB weight 888
>[  8986.425] (==) intel(0): Default visual is TrueColor
>[  8986.425] kgem_init: fd=9, gen=37
>[  8986.425] kgem_init: has BLT ring? 0
>[  8986.425] kgem_init: has relaxed delta? 1
>[  8986.425] kgem_init: has relaxed fencing? 1
>[  8986.425] kgem_init: has shared last-level-cache? 0
>[  8986.425] kgem_init: has write-through caching for scanouts? 0
>[  8986.425] kgem_init: has set-cache-level? 1
>[  8986.425] kgem_init: has userptr? 0
>[  8986.425] kgem_init: has create2? 0
>[  8986.425] kgem_init: has no-reloc? 1
>[  8986.425] kgem_init: has handle-lut? 1
>[  8986.425] kgem_init: semaphores enabled? 0
>[  8986.425] kgem_init: can blt to cpu? 1
>[  8986.425] kgem_init: can render to Y-tiled surfaces? 0
>[  8986.425] kgem_init: can use privileged batchbuffers? 1
>[  8986.425] kgem_init: can use pinned batchbuffers (to avoid CS w/a)? 1
>[  8986.425] kgem_init_pinned_batches: new handle=1, num_pages=1
>[  8986.425] kgem_init_pinned_batches: new handle=2, num_pages=1
>[  8986.425] kgem_init_pinned_batches: new handle=3, num_pages=1
>[  8986.425] kgem_init_pinned_batches: new handle=4, num_pages=1
>[  8986.425] kgem_init_pinned_batches: new handle=5, num_pages=1
>[  8986.425] kgem_init_pinned_batches: new handle=6, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=7, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=8, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=9, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=10, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=11, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=12, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=13, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=14, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=15, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=16, num_pages=1
>[  8986.426] kgem_init_pinned_batches: new handle=17, num_pages=4
>[  8986.426] kgem_init_pinned_batches: new handle=18, num_pages=4
>[  8986.426] kgem_init_pinned_batches: new handle=19, num_pages=4
>[  8986.426] kgem_init_pinned_batches: new handle=20, num_pages=4
>[  8986.426] kgem_init: maximum batch size? 65528
>[  8986.426] kgem_init: last-level cache size: 1048576 bytes, threshold in pages: 128
>[  8986.426] kgem_init: cpu bo enabled 1: llc? 0, set-cache-level? 1, userptr? 0
>[  8986.426] kgem_init: aperture size 2147483648, available now 2142855168
>[  8986.426] kgem_init: aperture low=715827882 [682], high=1610612736 [1536]
>[  8986.426] kgem_init: aperture mappable=268435456 [256 MiB]
>[  8986.426] kgem_init: buffer size=262144 [256 KiB]
>[  8986.426] kgem_init: total ram=4081745920
>[  8986.426] kgem_init: maximum object size=1207959552
>[  8986.426] kgem_init: large object thresold=134217728
>[  8986.426] kgem_init: max object sizes (gpu=268435456, cpu=1207959552, tile upload=67108864, copy=134217728)
>[  8986.426] kgem_init: max fences=14
>[  8986.426] sna_pre_init: swapbuffer wait? enabled
>[  8986.426] sna_pre_init: vsync? enabled
>[  8986.426] sna_pre_init: page flips? enabled
>[  8986.426] sna_pre_init: triple buffer? enabled
>[  8986.426] (**) intel(0): Framebuffer tiled
>[  8986.427] (**) intel(0): Pixmaps tiled
>[  8986.427] (**) intel(0): "Tear free" disabled
>[  8986.427] (**) intel(0): Forcing per-crtc-pixmaps? no
>[  8986.427] sna_crtc_init
>[  8986.427] sna_crtc_init: created handle=21 for cursor on CRTC:3
>[  8986.427] sna_crtc_init: attached crtc[0] id=3, pipe=0
>[  8986.427] sna_crtc_init
>[  8986.427] sna_crtc_init: created handle=22 for cursor on CRTC:4
>[  8986.427] sna_crtc_init: attached crtc[1] id=4, pipe=1
>[  8986.427] sna_output_init(num=0)
>[  8986.427] (II) intel(0): Output LVDS1 has no monitor section
>[  8986.427] has_device_backlight: scanning /sys/bus/pci/devices/0000:00:02.0/backlight
>[  8986.427] has_device_backlight: acpi_video0
>[  8986.427] sna_output_backlight_get: level=4 (max=15)
>[  8986.427] (--) intel(0): found backlight control interface acpi_video0 (type 'firmware')
>[  8986.427] sna_output_init: created output 'LVDS1' 0 [5]  (possible crtc:3, possible clones:1), edid=0, dpms=2, crtc=3
>[  8986.427] sna_output_init(num=1)
>[  8986.427] (II) intel(0): Output VGA1 has no monitor section
>[  8986.427] sna_output_init: created output 'VGA1' 1 [11]  (possible crtc:7, possible clones:2), edid=0, dpms=2, crtc=0
>[  8986.427] sna_output_init(num=2)
>[  8986.427] (II) intel(0): Output HDMI1 has no monitor section
>[  8986.427] sna_output_init: created output 'HDMI1' 2 [14]  (possible crtc:7, possible clones:4), edid=0, dpms=2, crtc=0
>[  8986.427] sna_output_init(num=3)
>[  8986.427] (II) intel(0): Output DP1 has no monitor section
>[  8986.428] sna_output_init: created output 'DP1' 3 [18]  (possible crtc:7, possible clones:8), edid=0, dpms=2, crtc=0
>[  8986.428] sna_output_init(num=4)
>[  8986.428] (II) intel(0): Output DP2 has no monitor section
>[  8986.428] sna_output_init: created output 'DP2' 4 [20]  (possible crtc:7, possible clones:10), edid=0, dpms=2, crtc=0
>[  8986.428] sna_mode_compute_possible_outputs: updated output 'LVDS1' 0 [5] (possible crtc:3, possible clones:1)
>[  8986.428] sna_mode_compute_possible_outputs: updated output 'VGA1' 1 [11] (possible crtc:3, possible clones:2)
>[  8986.428] sna_mode_compute_possible_outputs: updated output 'HDMI1' 2 [14] (possible crtc:3, possible clones:4)
>[  8986.428] sna_mode_compute_possible_outputs: updated output 'DP1' 3 [18] (possible crtc:3, possible clones:8)
>[  8986.428] sna_mode_compute_possible_outputs: updated output 'DP2' 4 [20] (possible crtc:3, possible clones:10)
>[  8986.428] add_fake_output(late=0, num_fake=1)
>[  8986.428] (II) intel(0): Output VIRTUAL1 has no monitor section
>[  8986.428] crtc_init_gamma: CRTC:3, pipe=0: gamma set?=1
>[  8986.428] sna_probe_initial_configuration: CRTC:3, pipe=0: has mode?=1
>[  8986.428] kmode: 1366x768, clock=72000, 1366 1414 1446 1494 0, 768 771 777 803 0, flags=a, type=48
>[  8986.428] crtc_init_gamma: CRTC:4, pipe=1: gamma set?=0
>[  8986.428] sna_probe_initial_configuration: CRTC:4, pipe=1: has mode?=0
>[  8986.428] (--) intel(0): Output LVDS1 using initial mode 1366x768 on pipe 0
>[  8986.428] sna_probe_initial_configuration: SetScrnInfoModes = 0x197a140
>[  8986.428] (==) intel(0): DPI set to (96, 96)
>[  8986.428] (II) Loading sub module "dri2"
>[  8986.428] (II) LoadModule: "dri2"
>[  8986.428] (II) Module "dri2" already built-in
>[  8986.428] (==) Depth 24 pixmap format is 32 bpp
>[  8986.428] sna_screen_init
>[  8986.428] sna_accel_init
>[  8986.428] sna_picture_init
>[  8986.429] uploaded 85504 bytes of static state
>[  8986.429] kgem_create_linear(85504)
>[  8986.429] search_linear_cache: num_pages=21, flags=2, use_active? 0, use_large=0 [max=65536]
>[  8986.429] search_linear_cache: inactive and cache bucket empty
>[  8986.429] search_linear_cache: active cache bucket empty
>[  8986.429] kgem_create_linear: new handle=23, num_pages=21
>[  8986.429] gem_write(handle=23, offset=0, len=85504)
>[  8986.429] kgem_bo_write: flush=0, domain=1
>[  8986.429] __kgem_busy: handle=23, busy=0, wedged=0
>[  8986.429] kgem_bo_retire: retiring bo handle=23 (needed flush? 0), rq? 0 [busy?=0]
>[  8986.429] sna_accel_init(backend=Eaglelake (gen4.5), prefer_gpu=3)
>[  8986.429] (II) intel(0): SNA initialized with Eaglelake (gen4.5) backend
>[  8986.429] (==) intel(0): Backing store enabled
>[  8986.429] (==) intel(0): Silken mouse enabled
>[  8986.429] (II) intel(0): HW Cursor enabled
>[  8986.429] (II) intel(0): RandR 1.2 enabled, ignore the following RandR disabled message.
>[  8986.430] (==) intel(0): DPMS enabled
>[  8986.430] sna_video_sprite_setup: 0 sprite planes
>[  8986.430] (II) intel(0): [XvMC] xvmc_vld driver initialized.
>[  8986.430] sna_dri_open()
>[  8986.430] sna_dri_open: loading dri driver 'i965' [gen=37] for device '/dev/dri/card0'
>[  8986.430] (II) intel(0): [DRI2] Setup complete
>[  8986.430] (II) intel(0): [DRI2]   DRI driver: i965
>[  8986.430] (II) intel(0): [DRI2]   VDPAU driver: i965
>[  8986.430] (II) intel(0): direct rendering: DRI2 Enabled
>[  8986.430] sna_uevent_init
>[  8986.430] (==) intel(0): hotplug detection: "enabled"
>[  8986.430] sna_uevent_init: installed uvent handler
>[  8986.430] (--) RandR disabled
>[  8986.454] (II) AIGLX: enabled GLX_MESA_copy_sub_buffer
>[  8986.454] (II) AIGLX: enabled GLX_ARB_create_context
>[  8986.454] (II) AIGLX: enabled GLX_ARB_create_context_profile
>[  8986.454] (II) AIGLX: enabled GLX_EXT_create_context_es2_profile
>[  8986.454] (II) AIGLX: enabled GLX_INTEL_swap_event
>[  8986.454] (II) AIGLX: enabled GLX_SGI_swap_control and GLX_MESA_swap_control
>[  8986.454] (II) AIGLX: enabled GLX_EXT_framebuffer_sRGB
>[  8986.454] (II) AIGLX: enabled GLX_ARB_fbconfig_float
>[  8986.454] (II) AIGLX: GLX_EXT_texture_from_pixmap backed by buffer objects
>[  8986.454] (II) AIGLX: Loaded and initialized i965
>[  8986.454] (II) GLX: Initialized DRI2 GL provider for screen 0
>[  8986.455] sna_create_screen_resources(1366x768@24)
>[  8986.455] sna_accel_create
>[  8986.455] sna_glyphs_create
>[  8986.455] sna_create_pixmap(1024, 1024, 8, usage=11)
>[  8986.455] kgem_can_create_2d: 1024x1024 @ 8
>[  8986.455] kgem_can_create_2d: untiled size=1048576
>[  8986.455] kgem_choose_tiling: 1024x1024 -> 1
>[  8986.455] kgem_can_create_2d: tiled[1] size=1048576
>[  8986.455] sna_create_pixmap: usage=17, flags=b
>[  8986.455] sna_pixmap_create_scratch(1024, 1024, 8, tiling=2)
>[  8986.456] kgem_choose_tiling: 1024x1024 -> 1
>[  8986.456] create_pixmap: allocating pixmap 0x0, depth=8, size=0
>[  8986.456] create_pixmap: serial=1, usage=1, 0x0
>[  8986.456] kgem_create_2d(1024x1024, bpp=8, tiling=1, exact=0, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=1)
>[  8986.456]   new pitch=1024, tiling=1, handle=24, id=1, num_pages=256 [256], bucket=8
>[  8986.456] __sna_damage_all(1024, 1024)
>[  8986.456] sna_create_pixmap(1024, 1024, 32, usage=11)
>[  8986.456] kgem_can_create_2d: 1024x1024 @ 32
>[  8986.456] kgem_can_create_2d: untiled size=4194304
>[  8986.456] kgem_choose_tiling: TLB miss between lines 1024x1024 (pitch=4096), forcing tiling 1
>[  8986.456] kgem_can_create_2d: tiled[-1] size=4194304
>[  8986.456] sna_create_pixmap: usage=17, flags=b
>[  8986.456] sna_pixmap_create_scratch(1024, 1024, 32, tiling=2)
>[  8986.456] kgem_choose_tiling: TLB miss between lines 1024x1024 (pitch=4096), forcing tiling 1
>[  8986.456] create_pixmap: allocating pixmap 0x0, depth=32, size=0
>[  8986.456] create_pixmap: serial=2, usage=1, 0x0
>[  8986.456] kgem_create_2d(1024x1024, bpp=32, tiling=1, exact=1, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=0, prime?=0, temp?=1)
>[  8986.456]   new pitch=4096, tiling=1, handle=25, id=2, num_pages=1024 [1024], bucket=10
>[  8986.456] __sna_damage_all(1024, 1024)
>[  8986.456] sna_gradients_create
>[  8986.456] sna_alpha_cache_init
>[  8986.456] kgem_create_linear(1052)
>[  8986.456] search_linear_cache: num_pages=1, flags=2, use_active? 0, use_large=0 [max=65536]
>[  8986.456] search_linear_cache: inactive and cache bucket empty
>[  8986.456] search_linear_cache: active cache bucket empty
>[  8986.456] kgem_create_linear: new handle=26, num_pages=1
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=0, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=4, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=8, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=12, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=16, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=20, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=24, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=28, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=32, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=36, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=40, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=44, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=48, length=4, io=0
>[  8986.456] kgem_create_proxy: target handle=26 [proxy? -1], offset=52, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=56, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=60, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=64, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=68, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=72, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=76, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=80, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=84, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=88, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=92, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=96, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=100, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=104, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=108, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=112, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=116, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=120, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=124, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=128, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=132, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=136, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=140, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=144, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=148, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=152, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=156, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=160, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=164, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=168, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=172, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=176, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=180, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=184, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=188, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=192, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=196, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=200, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=204, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=208, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=212, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=216, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=220, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=224, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=228, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=232, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=236, length=4, io=0
>[  8986.457] kgem_create_proxy: target handle=26 [proxy? -1], offset=240, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=244, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=248, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=252, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=256, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=260, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=264, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=268, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=272, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=276, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=280, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=284, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=288, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=292, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=296, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=300, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=304, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=308, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=312, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=316, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=320, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=324, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=328, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=332, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=336, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=340, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=344, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=348, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=352, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=356, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=360, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=364, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=368, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=372, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=376, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=380, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=384, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=388, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=392, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=396, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=400, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=404, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=408, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=412, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=416, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=420, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=424, length=4, io=0
>[  8986.458] kgem_create_proxy: target handle=26 [proxy? -1], offset=428, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=432, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=436, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=440, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=444, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=448, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=452, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=456, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=460, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=464, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=468, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=472, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=476, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=480, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=484, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=488, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=492, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=496, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=500, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=504, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=508, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=512, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=516, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=520, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=524, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=528, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=532, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=536, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=540, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=544, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=548, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=552, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=556, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=560, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=564, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=568, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=572, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=576, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=580, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=584, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=588, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=592, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=596, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=600, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=604, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=608, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=612, length=4, io=0
>[  8986.459] kgem_create_proxy: target handle=26 [proxy? -1], offset=616, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=620, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=624, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=628, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=632, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=636, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=640, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=644, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=648, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=652, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=656, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=660, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=664, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=668, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=672, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=676, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=680, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=684, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=688, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=692, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=696, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=700, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=704, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=708, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=712, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=716, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=720, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=724, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=728, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=732, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=736, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=740, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=744, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=748, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=752, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=756, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=760, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=764, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=768, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=772, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=776, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=780, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=784, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=788, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=792, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=796, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=800, length=4, io=0
>[  8986.460] kgem_create_proxy: target handle=26 [proxy? -1], offset=804, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=808, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=812, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=816, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=820, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=824, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=828, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=832, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=836, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=840, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=844, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=848, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=852, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=856, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=860, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=864, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=868, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=872, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=876, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=880, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=884, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=888, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=892, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=896, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=900, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=904, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=908, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=912, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=916, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=920, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=924, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=928, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=932, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=936, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=940, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=944, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=948, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=952, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=956, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=960, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=964, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=968, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=972, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=976, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=980, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=984, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=988, length=4, io=0
>[  8986.461] kgem_create_proxy: target handle=26 [proxy? -1], offset=992, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=996, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1000, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1004, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1008, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1012, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1016, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1020, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1024, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1028, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1032, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1036, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1040, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1044, length=4, io=0
>[  8986.462] kgem_create_proxy: target handle=26 [proxy? -1], offset=1048, length=4, io=0
>[  8986.462] gem_write(handle=26, offset=0, len=1052)
>[  8986.462] kgem_bo_write: flush=0, domain=1
>[  8986.462] __kgem_busy: handle=26, busy=0, wedged=0
>[  8986.462] kgem_bo_retire: retiring bo handle=26 (needed flush? 0), rq? 0 [busy?=0]
>[  8986.462] sna_solid_cache_init
>[  8986.462] kgem_create_linear(4096)
>[  8986.462] search_linear_cache: num_pages=1, flags=2, use_active? 0, use_large=0 [max=65536]
>[  8986.462] search_linear_cache: inactive and cache bucket empty
>[  8986.462] search_linear_cache: active cache bucket empty
>[  8986.462] kgem_create_linear: new handle=27, num_pages=1
>[  8986.462] sna_create_pixmap(1366, 768, 24, usage=10)
>[  8986.462] kgem_can_create_2d: 1366x768 @ 24
>[  8986.462] kgem_can_create_2d: untiled size=4198400
>[  8986.462] kgem_choose_tiling: TLB miss between lines 1366x768 (pitch=5464), forcing tiling 1
>[  8986.462] kgem_can_create_2d: tiled[-1] size=4198400
>[  8986.462] sna_create_pixmap: usage=16, flags=b
>[  8986.462] sna_create_pixmap: creating GPU pixmap 1366x768, stride=5464, flags=b
>[  8986.462] create_pixmap: allocating pixmap 0x0, depth=24, size=0
>[  8986.462] create_pixmap: serial=3, usage=16, 0x0
>[  8986.462] sna_pixmap_force_to_gpu(pixmap=0x19aca30, flags=1)
>[  8986.462] sna_pixmap_move_to_gpu(pixmap=3, usage=16), flags=41
>[  8986.462] sna_pixmap_move_to_gpu: CPU damage? 0
>[  8986.462] sna_pixmap_move_to_gpu: creating GPU bo (1366x768@32), create=b
>[  8986.462] kgem_create_2d(1366x768, bpp=32, tiling=1, exact=1, inactive=0, cpu-mapping=0, gtt-mapping=0, scanout?=1, prime?=0, temp?=0)
>[  8986.462]   new pitch=5632, tiling=1, handle=28, id=266, num_pages=1056 [1056], bucket=10
>[  8986.462] __sna_damage_all(1366, 768)
>[  8986.462] sna_pixmap_move_to_gpu: marking as all-damaged for GPU
>[  8986.462] sna_pixmap_mark_active: pixmap=3, handle=28
>[  8986.462] sna_set_screen_pixmap: changing from pixmap=0 to pixmap=3, (sna->front=0)
>[  8986.463] sna_copy_fbcon
>[  8986.463] sna_copy_fbcon: found fbcon, size=1366x768, depth=24, bpp=32
>[  8986.463] kgem_create_for_name(name=1)
>[  8986.463] kgem_create_for_name: new handle=30
>[  8986.463] sna_copy_fbcon: fbcon handle=30
>[  8986.463] gen4_render_copy_boxes x 1
>[  8986.463] sna_blt_copy_boxes src=(0, 0) -> (0, 0) x 1, tiling=(0, 1), pitch=(5504, 5632)
>[  8986.463]   sna_blt_copy_boxes: box=(0, 0)x(1366, 768)
>[  8986.463] kgem_add_reloc: handle=28, pos=4, delta=0, domains=00028002
>[  8986.463] kgem_add_handle: handle=28, index=0
>[  8986.463] __kgem_bo_mark_dirty: handle=28 (proxy? 0)
>[  8986.463] kgem_add_reloc: handle=30, pos=7, delta=0, domains=00028000
>[  8986.463] kgem_add_handle: handle=30, index=1
>[  8986.463] batch[3/0, flags=1c00]: 10 10 65528 65528, nreloc=2, nexec=2, nfence=0, aperture=2088 [fenced=0]
>[  8986.463] gem_write__cachealigned(handle=16, offset=0, len=40)
>[  8986.470] kgem_commit: release handle=16 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=45d000
>[  8986.471] kgem_commit: release handle=28 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=46e000
>[  8986.471] kgem_commit: release handle=30 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=46000
>[  8986.471] _kgem_bo_destroy: handle=30, proxy? 0
>[  8986.471] __kgem_bo_destroy: handle=30
>[  8986.471] __kgem_bo_destroy: handle=30, not reusable
>[  8986.471] kgem_bo_free: handle=30
>[  8986.471] kgem_bo_free: releasing (nil):(nil) vma for handle=30, count=0
>[  8986.471] sna_set_desired_mode
>[  8986.471] (II) intel(0): switch to mode 1366x768@60.0 on LVDS1 using pipe 0, position (0, 0), rotation normal, reflection none
>[  8986.471] sna_pixmap_force_to_gpu(pixmap=0x19aca30, flags=3)
>[  8986.471] sna_pixmap_move_to_gpu(pixmap=3, usage=16), flags=43
>[  8986.471] sna_pixmap_move_to_gpu: already all-damaged
>[  8986.471] sna_pixmap_mark_active: pixmap=3, handle=28
>[  8986.471] use_shadow? bounds (0, 0), (1366, 768), framebufer 1366x768
>[  8986.471] sna_crtc_attach: attaching to framebuffer
>[  8986.471] sna_pixmap_force_to_gpu(pixmap=0x19aca30, flags=3)
>[  8986.471] sna_pixmap_move_to_gpu(pixmap=3, usage=16), flags=43
>[  8986.471] sna_pixmap_move_to_gpu: already all-damaged
>[  8986.471] sna_pixmap_mark_active: pixmap=3, handle=28
>[  8986.471] get_fb: create fb 1366x768@24/32
>[  8986.471] sna_crtc_apply
>[  8986.471] sna_crtc_apply: attaching output 'LVDS1' 0 [5] to crtc:3 (pipe 0) (possible crtc:3, possible clones:1)
>[  8986.471] sna_crtc_apply: applying crtc [3, pipe=0] mode=1366x768+0+0@72000, fb=23 update to 1 outputs [5...]
>[  8986.481] sna_crtc_force_outputs_on(pipe=0), currently? 3
>[  8986.481] sna_output_dpms(LVDS1): dpms=0 (current: 3), active? 1
>[  8986.481] sna_output_dpms_backlight(LVDS1) -- 3 -> 0
>[  8986.481] sna_output_backlight_set: level=4, max=15
>[  8986.487] sna_crtc_randr: transform? 0, bounds (0, 0), (1366, 768)
>[  8986.487] sna_output_dpms(VGA1): dpms=3 (current: 3), active? 0
>[  8986.487] sna_output_dpms(HDMI1): dpms=3 (current: 3), active? 0
>[  8986.487] sna_output_dpms(DP1): dpms=3 (current: 3), active? 0
>[  8986.487] sna_output_dpms(DP2): dpms=3 (current: 3), active? 0
>[  8986.487] sna_crtc_dpms(pipe 1, dpms mode -> 3):= active=0
>[  8986.487] sna_crtc_config_notify
>[  8986.487] sna_mode_update: crtc=3, valid?=1, fb attached?=23, expected=23
>[  8986.487] sna_mode_update: crtc=4, valid?=0, fb attached?=0, expected=0
>[  8986.487] update_flush_interval: CRTC:0 (pipe 0) vrefresh=60.015904
>[  8986.487] update_flush_interval: CRTC:1 (pipe 1) disabled
>[  8986.487] max_vrefresh=60, vblank_interval=16 ms
>[  8986.487] sna_mode_update: crtc=3, valid?=1, fb attached?=23, expected=23
>[  8986.487] sna_mode_update: crtc=4, valid?=0, fb attached?=0, expected=0
>[  8986.487] update_flush_interval: CRTC:0 (pipe 0) vrefresh=60.015904
>[  8986.487] update_flush_interval: CRTC:1 (pipe 1) disabled
>[  8986.487] max_vrefresh=60, vblank_interval=16 ms
>[  8986.487] (II) intel(0): Setting screen physical size to 361 x 203
>[  8986.487] sna_mode_resize (1366, 768) -> (1366, 768)
>[  8986.487] sna_create_pixmap(16, 16, 1, usage=0)
>[  8986.487] kgem_can_create_2d: 16x16 @ 1
>[  8986.487] kgem_can_create_2d: unhandled depth 1
>[  8986.487] sna_create_pixmap: can not use GPU, just creating shadow
>[  8986.487] create_pixmap: allocating pixmap 16x16, depth=1, size=72
>[  8986.487] create_pixmap: serial=4, usage=0, 16x16
>[  8986.487] sna_validate_gc changes=7fffff, previous serial=80000000, drawable=4
>[  8986.487] sna_validate_gc: recomputing clip
>[  8986.487] sna_validate_gc: composite clip=1x[(0, 0), (16, 16)]
>[  8986.487] sna_poly_fill_rect(n=1, PlaneMask: ffffffffffffffff (solid 1), solid fill: 1 [style=0, tileIsPixel=1], alu=3)
>[  8986.487] sna_poly_fill_rect_extents: [0] = (0, 0)x(16, 16)
>[  8986.487] sna_poly_fill_rect: extents(0, 0), (16, 16), flags=1
>[  8986.487] sna_poly_fill_rect: fallback -- unattached
>[  8986.487] sna_poly_fill_rect: fallback (0, 0), (16, 16)
>[  8986.487] sna_gc_move_to_cpu, changes=7fffff
>[  8986.488] sfbValidateGC changes=77ffff
>[  8986.488] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000001, bg=00000001, planemask=ffffffff
>[  8986.488] sfbValidateGC: rrop fg=ffffffff, bg=ffffffff, pm=ffffffff, and=00000000, xor=ffffffff, bgand=00000000, bgxor=ffffffff
>[  8986.488] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  8986.488] sna_drawable_move_region_to_cpu(pixmap=4 (16x16), [(0, 0), (16, 16)], flags=5)
>[  8986.488] sna_drawable_move_region_to_cpu: not attached to 0x19ad500
>[  8986.488] sna_poly_fill_rect: fallback - fbPolyFillRect
>[  8986.488] sfbPolyFillRect x 1
>[  8986.488] sfbPolyFillRect: rectangle (0, 0), (16, 16)
>[  8986.488] fbClipBoxes: box=(0, 0),(16, 16); region=(0, 0),(16, 16) x 1
>[  8986.488] fbDrawableRun: box=(0, 0), (16, 16), clip=(0, 0), (16, 16)
>[  8986.488] fbFillBox box=(0, 0), (16, 16)
>[  8986.488] sfbFill (0, 0)x(16, 16), style=0
>[  8986.622] sna_realize_font (key=0)
>[  8986.623] sna_realize_font (key=0)
>[  8986.623] sna_create_pixmap(16, 16, 1, usage=1)
>[  8986.623] kgem_can_create_2d: 16x16 @ 1
>[  8986.623] kgem_can_create_2d: unhandled depth 1
>[  8986.623] sna_create_pixmap: can not use GPU, just creating shadow
>[  8986.623] create_pixmap: allocating pixmap 16x16, depth=1, size=72
>[  8986.623] create_pixmap: serial=6, usage=1, 16x16
>[  8986.623] sna_validate_gc changes=7fffff, previous serial=80000000, drawable=6
>[  8986.623] sna_validate_gc: recomputing clip
>[  8986.623] sna_validate_gc: composite clip=1x[(0, 0), (16, 16)]
>[  8986.623] sna_poly_fill_rect(n=1, PlaneMask: ffffffffffffffff (solid 1), solid fill: 1 [style=0, tileIsPixel=1], alu=3)
>[  8986.623] sna_poly_fill_rect_extents: [0] = (0, 0)x(16, 16)
>[  8986.623] sna_poly_fill_rect: extents(0, 0), (16, 16), flags=1
>[  8986.623] sna_poly_fill_rect: fallback -- unattached
>[  8986.623] sna_poly_fill_rect: fallback (0, 0), (16, 16)
>[  8986.623] sna_gc_move_to_cpu, changes=7fffff
>[  8986.623] sfbValidateGC changes=77ffff
>[  8986.623] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000000, bg=00000001, planemask=ffffffff
>[  8986.623] sfbValidateGC: rrop fg=00000000, bg=ffffffff, pm=ffffffff, and=00000000, xor=00000000, bgand=00000000, bgxor=ffffffff
>[  8986.623] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  8986.623] sna_drawable_move_region_to_cpu(pixmap=6 (16x16), [(0, 0), (16, 16)], flags=5)
>[  8986.623] sna_drawable_move_region_to_cpu: not attached to 0x1ba91f0
>[  8986.623] sna_poly_fill_rect: fallback - fbPolyFillRect
>[  8986.623] sfbPolyFillRect x 1
>[  8986.623] sfbPolyFillRect: rectangle (0, 0), (16, 16)
>[  8986.623] fbClipBoxes: box=(0, 0),(16, 16); region=(0, 0),(16, 16) x 1
>[  8986.623] fbDrawableRun: box=(0, 0), (16, 16), clip=(0, 0), (16, 16)
>[  8986.623] fbFillBox box=(0, 0), (16, 16)
>[  8986.623] sfbFill (0, 0)x(16, 16), style=0
>[  8986.623] sna_validate_gc changes=4, previous serial=80000004, drawable=6
>[  8986.623] sna_validate_gc: recomputing clip
>[  8986.623] sna_validate_gc: composite clip=1x[(0, 0), (16, 16)]
>[  8986.623] sna_font_too_large? (16 + 17) x 17: 99 > 124
>[  8986.623] sna_glyph_blt (7, 7) x 1, fg=00000001, bg=ffffffff alu=cc
>[  8986.623] sna_drawable_use_bo pixmap=6, box=((0, 0), (16, 16)), flags=1...
>[  8986.623] sna_drawable_use_bo: not attached
>[  8986.623] sna_poly_text16: fallback
>[  8986.623] sna_gc_move_to_cpu, changes=4
>[  8986.623] sfbValidateGC changes=4
>[  8986.623] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000001, bg=00000001, planemask=ffffffff
>[  8986.623] sfbValidateGC: rrop fg=ffffffff, bg=ffffffff, pm=ffffffff, and=00000000, xor=ffffffff, bgand=00000000, bgxor=ffffffff
>[  8986.623] sna_drawable_move_region_to_cpu(pixmap=6 (16x16), [(0, 0), (16, 16)], flags=3)
>[  8986.624] sna_drawable_move_region_to_cpu: not attached to 0x1ba91f0
>[  8986.624] sna_poly_text16: fallback -- fbPolyGlyphBlt
>[  8986.624] sfbPolyGlyphBlt x 1
>[  8986.624] sfbPushImage (0, 0)x(16, 16)fbClipBoxes: box=(0, 0),(16, 16); region=(0, 0),(16, 16) x 1
>[  8986.624] fbDrawableRun: box=(0, 0), (16, 16), clip=(0, 0), (16, 16)
>[  8986.624] sfbBlt 16x16, alu=7, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  8986.624] sna_get_image: pixmap=6 (0, 0)x(16, 16), format=1, mask=1, depth=1
>[  8986.624] sna_drawable_move_region_to_cpu(pixmap=6 (16x16), [(0, 0), (16, 16)], flags=34)
>[  8986.624] sna_drawable_move_region_to_cpu: not attached to 0x1ba91f0
>[  8986.624] sfbGetImage (0, 0)x(16, 16)
>[  8986.624] sfbBlt 16x16, alu=3, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  8986.624] sfbBlt fast blt, src_stride=4, dst_stride=4, width=2 (offset=2075184)
>[  8986.624] sna_destroy_pixmap: pixmap=6, attached?=0
>[  8986.624] sna_create_pixmap(16, 16, 1, usage=1)
>[  8986.624] kgem_can_create_2d: 16x16 @ 1
>[  8986.624] kgem_can_create_2d: unhandled depth 1
>[  8986.624] sna_create_pixmap: can not use GPU, just creating shadow
>[  8986.624] create_pixmap: allocating pixmap 16x16, depth=1, size=72
>[  8986.624] create_pixmap: serial=7, usage=1, 16x16
>[  8986.624] sna_validate_gc changes=7fffff, previous serial=80000000, drawable=7
>[  8986.624] sna_validate_gc: recomputing clip
>[  8986.624] sna_validate_gc: composite clip=1x[(0, 0), (16, 16)]
>[  8986.624] sna_poly_fill_rect(n=1, PlaneMask: ffffffffffffffff (solid 1), solid fill: 1 [style=0, tileIsPixel=1], alu=3)
>[  8986.624] sna_poly_fill_rect_extents: [0] = (0, 0)x(16, 16)
>[  8986.624] sna_poly_fill_rect: extents(0, 0), (16, 16), flags=1
>[  8986.624] sna_poly_fill_rect: fallback -- unattached
>[  8986.624] sna_poly_fill_rect: fallback (0, 0), (16, 16)
>[  8986.624] sna_gc_move_to_cpu, changes=7fffff
>[  8986.624] sfbValidateGC changes=77ffff
>[  8986.624] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000000, bg=00000001, planemask=ffffffff
>[  8986.624] sfbValidateGC: rrop fg=00000000, bg=ffffffff, pm=ffffffff, and=00000000, xor=00000000, bgand=00000000, bgxor=ffffffff
>[  8986.624] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  8986.624] sna_drawable_move_region_to_cpu(pixmap=7 (16x16), [(0, 0), (16, 16)], flags=5)
>[  8986.624] sna_drawable_move_region_to_cpu: not attached to 0x1ba91f0
>[  8986.624] sna_poly_fill_rect: fallback - fbPolyFillRect
>[  8986.624] sfbPolyFillRect x 1
>[  8986.624] sfbPolyFillRect: rectangle (0, 0), (16, 16)
>[  8986.624] fbClipBoxes: box=(0, 0),(16, 16); region=(0, 0),(16, 16) x 1
>[  8986.624] fbDrawableRun: box=(0, 0), (16, 16), clip=(0, 0), (16, 16)
>[  8986.624] fbFillBox box=(0, 0), (16, 16)
>[  8986.624] sfbFill (0, 0)x(16, 16), style=0
>[  8986.624] sna_validate_gc changes=4, previous serial=80000006, drawable=7
>[  8986.624] sna_validate_gc: recomputing clip
>[  8986.624] sna_validate_gc: composite clip=1x[(0, 0), (16, 16)]
>[  8986.624] sna_font_too_large? (16 + 17) x 17: 99 > 124
>[  8986.624] sna_glyph_blt (7, 7) x 1, fg=00000001, bg=ffffffff alu=cc
>[  8986.625] sna_drawable_use_bo pixmap=7, box=((1, 1), (15, 15)), flags=1...
>[  8986.625] sna_drawable_use_bo: not attached
>[  8986.625] sna_poly_text16: fallback
>[  8986.625] sna_gc_move_to_cpu, changes=4
>[  8986.625] sfbValidateGC changes=4
>[  8986.625] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000001, bg=00000001, planemask=ffffffff
>[  8986.625] sfbValidateGC: rrop fg=ffffffff, bg=ffffffff, pm=ffffffff, and=00000000, xor=ffffffff, bgand=00000000, bgxor=ffffffff
>[  8986.625] sna_drawable_move_region_to_cpu(pixmap=7 (16x16), [(1, 1), (15, 15)], flags=3)
>[  8986.625] sna_drawable_move_region_to_cpu: not attached to 0x1ba91f0
>[  8986.625] sna_poly_text16: fallback -- fbPolyGlyphBlt
>[  8986.625] sfbPolyGlyphBlt x 1
>[  8986.625] sfbPushImage (1, 1)x(14, 14)fbClipBoxes: box=(1, 1),(15, 15); region=(1, 1),(15, 15) x 1
>[  8986.625] fbDrawableRun: box=(1, 1), (15, 15), clip=(1, 1), (15, 15)
>[  8986.625] sfbBlt 14x14, alu=7, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  8986.625] sna_get_image: pixmap=7 (0, 0)x(16, 16), format=1, mask=1, depth=1
>[  8986.625] sna_drawable_move_region_to_cpu(pixmap=7 (16x16), [(0, 0), (16, 16)], flags=34)
>[  8986.625] sna_drawable_move_region_to_cpu: not attached to 0x1ba91f0
>[  8986.625] sfbGetImage (0, 0)x(16, 16)
>[  8986.625] sfbBlt 16x16, alu=3, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  8986.625] sfbBlt fast blt, src_stride=4, dst_stride=4, width=2 (offset=752)
>[  8986.625] sna_destroy_pixmap: pixmap=7, attached?=0
>[  8986.625] sna_change_window_attributes
>[  8986.625] sna_validate_gc changes=7fffff, previous serial=80000000, drawable=5
>[  8986.625] sna_validate_gc: recomputing clip
>[  8986.625] sna_validate_gc: composite clip=1x[(0, 0), (1366, 768)]
>[  8986.625] sna_poly_fill_rect(n=1, PlaneMask: ffffffffffffffff (solid 1), solid fill: 1 [style=0, tileIsPixel=1], alu=3)
>[  8986.625] sna_poly_fill_rect_extents: [0] = (0, 0)x(1366, 768)
>[  8986.625] sna_poly_fill_rect: extents(0, 0), (1366, 768), flags=1
>[  8986.625] discard_cpu_damage: discarding existing CPU damage
>[  8986.625] sna_poly_fill_rect: promoting to full GPU
>[  8986.625] sna_poly_fill_rect: dropping last-cpu hint
>[  8986.625] sna_drawable_use_bo pixmap=3, box=((0, 0), (1366, 768)), flags=19...
>[  8986.625] sna_drawable_use_bo: flush=0, shm=0, cpu=0 => flags=9
>[  8986.625] sna_drawable_use_bo: use GPU fast path (all-damaged)
>[  8986.625] sna_drawable_use_bo: using whole GPU bo
>[  8986.625] sna_poly_fill_rect: solid fill [00000000], testing for blt
>[  8986.625] sna_poly_fill_rect_blt x 1 [(0, 0)x(1366, 768)...]+(0,0), clipped?=0
>[  8986.625] gen4_render_fill_one: color=00000000
>[  8986.625] sna_blt_fill_boxes (32, 00000000, 3) x 1
>[  8986.625] sna_blt_fill_box: box=((0, 0), (1366, 768))
>[  8986.625] kgem_add_reloc: handle=28, pos=4, delta=0, domains=00028002
>[  8986.625] kgem_add_handle: handle=28, index=0
>[  8986.625] __kgem_bo_mark_dirty: handle=28 (proxy? 0)
>[  8986.625] sna_poly_fill_rect_blt: pixmap=3, marking clear [00000000]
>[  8986.692] (II) config/udev: Adding input device Power Button (/dev/input/event2)
>[  8986.692] (**) Power Button: Applying InputClass "evdev keyboard catchall"
>[  8986.692] (II) LoadModule: "evdev"
>[  8986.692] (II) Loading /usr/lib64/xorg/modules/input/evdev_drv.so
>[  8986.692] (II) Module evdev: vendor="X.Org Foundation"
>[  8986.692] 	compiled for 1.15.0, module version = 2.8.1
>[  8986.692] 	Module class: X.Org XInput Driver
>[  8986.692] 	ABI class: X.Org XInput driver, version 20.0
>[  8986.692] (II) Using input driver 'evdev' for 'Power Button'
>[  8986.692] (**) Power Button: always reports core events
>[  8986.692] (**) evdev: Power Button: Device: "/dev/input/event2"
>[  8986.693] (--) evdev: Power Button: Vendor 0 Product 0x1
>[  8986.693] (--) evdev: Power Button: Found keys
>[  8986.693] (II) evdev: Power Button: Configuring as keyboard
>[  8986.693] (**) Option "config_info" "udev:/sys/devices/LNXSYSTM:00/LNXPWRBN:00/input/input2/event2"
>[  8986.693] (II) XINPUT: Adding extended input device "Power Button" (type: KEYBOARD, id 6)
>[  8986.693] (**) Option "xkb_rules" "evdev"
>[  8986.693] (**) Option "xkb_model" "pc104"
>[  8986.693] (**) Option "xkb_layout" "us"
>[  8986.743] (II) config/udev: Adding input device Video Bus (/dev/input/event3)
>[  8986.743] (**) Video Bus: Applying InputClass "evdev keyboard catchall"
>[  8986.743] (II) Using input driver 'evdev' for 'Video Bus'
>[  8986.743] (**) Video Bus: always reports core events
>[  8986.743] (**) evdev: Video Bus: Device: "/dev/input/event3"
>[  8986.743] (--) evdev: Video Bus: Vendor 0 Product 0x6
>[  8986.743] (--) evdev: Video Bus: Found keys
>[  8986.743] (II) evdev: Video Bus: Configuring as keyboard
>[  8986.743] (**) Option "config_info" "udev:/sys/devices/LNXSYSTM:00/device:00/PNP0A08:00/LNXVIDEO:00/input/input3/event3"
>[  8986.743] (II) XINPUT: Adding extended input device "Video Bus" (type: KEYBOARD, id 7)
>[  8986.743] (**) Option "xkb_rules" "evdev"
>[  8986.743] (**) Option "xkb_model" "pc104"
>[  8986.743] (**) Option "xkb_layout" "us"
>[  8986.744] (II) config/udev: Adding input device Lid Switch (/dev/input/event1)
>[  8986.744] (II) No input driver specified, ignoring this device.
>[  8986.744] (II) This device may have been added with another device file.
>[  8986.745] (II) config/udev: Adding input device Sleep Button (/dev/input/event0)
>[  8986.745] (**) Sleep Button: Applying InputClass "evdev keyboard catchall"
>[  8986.745] (II) Using input driver 'evdev' for 'Sleep Button'
>[  8986.745] (**) Sleep Button: always reports core events
>[  8986.745] (**) evdev: Sleep Button: Device: "/dev/input/event0"
>[  8986.745] (--) evdev: Sleep Button: Vendor 0 Product 0x3
>[  8986.745] (--) evdev: Sleep Button: Found keys
>[  8986.745] (II) evdev: Sleep Button: Configuring as keyboard
>[  8986.745] (**) Option "config_info" "udev:/sys/devices/LNXSYSTM:00/device:00/PNP0C0E:00/input/input0/event0"
>[  8986.745] (II) XINPUT: Adding extended input device "Sleep Button" (type: KEYBOARD, id 8)
>[  8986.745] (**) Option "xkb_rules" "evdev"
>[  8986.745] (**) Option "xkb_model" "pc104"
>[  8986.745] (**) Option "xkb_layout" "us"
>[  8986.746] (II) config/udev: Adding drm device (/dev/dri/card0)
>[  8986.747] (II) config/udev: Adding input device Asus Laptop extra buttons (/dev/input/event4)
>[  8986.747] (**) Asus Laptop extra buttons: Applying InputClass "evdev keyboard catchall"
>[  8986.747] (II) Using input driver 'evdev' for 'Asus Laptop extra buttons'
>[  8986.747] (**) Asus Laptop extra buttons: always reports core events
>[  8986.747] (**) evdev: Asus Laptop extra buttons: Device: "/dev/input/event4"
>[  8986.747] (--) evdev: Asus Laptop extra buttons: Vendor 0 Product 0
>[  8986.747] (--) evdev: Asus Laptop extra buttons: Found keys
>[  8986.747] (II) evdev: Asus Laptop extra buttons: Configuring as keyboard
>[  8986.747] (**) Option "config_info" "udev:/sys/devices/platform/asus_laptop/input/input5/event4"
>[  8986.747] (II) XINPUT: Adding extended input device "Asus Laptop extra buttons" (type: KEYBOARD, id 9)
>[  8986.747] (**) Option "xkb_rules" "evdev"
>[  8986.747] (**) Option "xkb_model" "pc104"
>[  8986.747] (**) Option "xkb_layout" "us"
>[  8986.748] (II) config/udev: Adding input device AT Translated Set 2 keyboard (/dev/input/event5)
>[  8986.748] (**) AT Translated Set 2 keyboard: Applying InputClass "evdev keyboard catchall"
>[  8986.748] (II) Using input driver 'evdev' for 'AT Translated Set 2 keyboard'
>[  8986.748] (**) AT Translated Set 2 keyboard: always reports core events
>[  8986.748] (**) evdev: AT Translated Set 2 keyboard: Device: "/dev/input/event5"
>[  8986.748] (--) evdev: AT Translated Set 2 keyboard: Vendor 0x1 Product 0x1
>[  8986.748] (--) evdev: AT Translated Set 2 keyboard: Found keys
>[  8986.748] (II) evdev: AT Translated Set 2 keyboard: Configuring as keyboard
>[  8986.748] (**) Option "config_info" "udev:/sys/devices/platform/i8042/serio0/input/input4/event5"
>[  8986.748] (II) XINPUT: Adding extended input device "AT Translated Set 2 keyboard" (type: KEYBOARD, id 10)
>[  8986.748] (**) Option "xkb_rules" "evdev"
>[  8986.748] (**) Option "xkb_model" "pc104"
>[  8986.748] (**) Option "xkb_layout" "us"
>[  8986.749] (II) config/udev: Adding input device ETPS/2 Elantech Touchpad (/dev/input/event6)
>[  8986.750] (**) ETPS/2 Elantech Touchpad: Applying InputClass "evdev touchpad catchall"
>[  8986.750] (**) ETPS/2 Elantech Touchpad: Applying InputClass "touchpad catchall"
>[  8986.750] (**) ETPS/2 Elantech Touchpad: Applying InputClass "Default clickpad buttons"
>[  8986.750] (II) LoadModule: "synaptics"
>[  8986.750] (II) Loading /usr/lib64/xorg/modules/input/synaptics_drv.so
>[  8986.750] (II) Module synaptics: vendor="X.Org Foundation"
>[  8986.750] 	compiled for 1.15.0, module version = 1.7.1
>[  8986.750] 	Module class: X.Org XInput Driver
>[  8986.750] 	ABI class: X.Org XInput driver, version 20.0
>[  8986.750] (II) Using input driver 'synaptics' for 'ETPS/2 Elantech Touchpad'
>[  8986.750] (**) ETPS/2 Elantech Touchpad: always reports core events
>[  8986.750] (**) Option "Device" "/dev/input/event6"
>[  8986.773] (II) synaptics: ETPS/2 Elantech Touchpad: ignoring touch events for semi-multitouch device
>[  8986.773] (--) synaptics: ETPS/2 Elantech Touchpad: x-axis range 0 - 1088 (res 0)
>[  8986.773] (--) synaptics: ETPS/2 Elantech Touchpad: y-axis range 0 - 704 (res 0)
>[  8986.773] (--) synaptics: ETPS/2 Elantech Touchpad: pressure range 0 - 255
>[  8986.773] (--) synaptics: ETPS/2 Elantech Touchpad: finger width range 0 - 15
>[  8986.773] (--) synaptics: ETPS/2 Elantech Touchpad: buttons: left right double triple
>[  8986.773] (--) synaptics: ETPS/2 Elantech Touchpad: Vendor 0x2 Product 0xe
>[  8986.773] (--) synaptics: ETPS/2 Elantech Touchpad: touchpad found
>[  8986.773] (**) ETPS/2 Elantech Touchpad: always reports core events
>[  8986.783] (**) Option "config_info" "udev:/sys/devices/platform/i8042/serio4/input/input14/event6"
>[  8986.783] (II) XINPUT: Adding extended input device "ETPS/2 Elantech Touchpad" (type: TOUCHPAD, id 11)
>[  8986.783] (**) synaptics: ETPS/2 Elantech Touchpad: (accel) MinSpeed is now constant deceleration 2.5
>[  8986.783] (**) synaptics: ETPS/2 Elantech Touchpad: (accel) MaxSpeed is now 1.75
>[  8986.783] (**) synaptics: ETPS/2 Elantech Touchpad: (accel) AccelFactor is now 0.154
>[  8986.784] (**) ETPS/2 Elantech Touchpad: (accel) keeping acceleration scheme 1
>[  8986.784] (**) ETPS/2 Elantech Touchpad: (accel) acceleration profile 1
>[  8986.784] (**) ETPS/2 Elantech Touchpad: (accel) acceleration factor: 2.000
>[  8986.784] (**) ETPS/2 Elantech Touchpad: (accel) acceleration threshold: 4
>[  8986.784] (--) synaptics: ETPS/2 Elantech Touchpad: touchpad found
>[  8986.785] (II) config/udev: Adding input device ETPS/2 Elantech Touchpad (/dev/input/mouse0)
>[  8986.785] (**) ETPS/2 Elantech Touchpad: Ignoring device from InputClass "touchpad ignore duplicates"
>[  8986.792] sna_crtc_dpms(pipe 0, dpms mode -> 0):= active=1
>[  8986.793] sna_output_dpms(LVDS1): dpms=0 (current: 0), active? 1
>[  8986.793] sna_block_handler (tv=600.000000)
>[  8986.793] kgem_retire, need_retire?=1
>[  8986.793] kgem_retire__flushing: 0 bo on flushing list
>[  8986.793] __kgem_busy: handle=16, busy=0, wedged=0
>[  8986.793] __kgem_retire_rq: request 16 complete
>[  8986.793] kgem_retire__requests_ring: ring=0, 0 outstanding requests, oldest=0
>[  8986.793] kgem_retire__requests_ring: ring=1, 0 outstanding requests, oldest=0
>[  8986.793] kgem_retire -- retired=0, need_retire=0
>[  8986.793] sna_accel_block_handler: GPU idle, flushing
>[  8986.793] batch[3/0, flags=1c00]: 8 8 65528 65528, nreloc=1, nexec=1, nfence=0, aperture=1056 [fenced=0]
>[  8986.793] gem_write__cachealigned(handle=15, offset=0, len=32)
>[  8986.793] kgem_commit: release handle=15 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=45c000
>[  8986.793] kgem_commit: release handle=28 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=46e000
>[  8986.793] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.793] sna_accel_do_flush -- no pending write to scanout
>[  8986.793] __kgem_busy: handle=28, busy=65537, wedged=0
>[  8986.793] __kgem_flush: handle=28, busy?=1
>[  8986.793] timer_enable (time=8986793), starting timer 1
>[  8986.794] sna_wakeup_handler
>[  8986.794] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  8986.794] sna_block_handler (tv=599.999000)
>[  8986.794] kgem_retire, need_retire?=1
>[  8986.794] kgem_retire__flushing: 0 bo on flushing list
>[  8986.794] __kgem_busy: handle=15, busy=65537, wedged=0
>[  8986.794] kgem_retire__requests_ring: ring=0, 1 outstanding requests, oldest=15
>[  8986.794] kgem_retire__requests_ring: ring=1, 0 outstanding requests, oldest=0
>[  8986.794] kgem_retire -- retired=0, need_retire=1
>[  8986.794] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.794] sna_accel_do_flush -- no pending write to scanout
>[  8986.794] sna_wakeup_handler
>[  8986.794] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  8986.794] sna_block_handler (tv=0.000000)
>[  8986.794] sna_wakeup_handler
>[  8986.794] sna_accel_wakeup_handler: nbatch=0, need_retire=1, need_purge=0
>[  8986.795] sna_block_handler (tv=599.998000)
>[  8986.795] kgem_retire, need_retire?=1
>[  8986.795] kgem_retire__flushing: 0 bo on flushing list
>[  8986.795] __kgem_busy: handle=15, busy=0, wedged=0
>[  8986.795] __kgem_retire_rq: request 15 complete
>[  8986.795] kgem_retire__requests_ring: ring=0, 0 outstanding requests, oldest=0
>[  8986.795] kgem_retire__requests_ring: ring=1, 0 outstanding requests, oldest=0
>[  8986.795] kgem_retire -- retired=0, need_retire=0
>[  8986.795] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.795] sna_accel_do_flush -- no pending write to scanout
>[  8986.795] sna_wakeup_handler
>[  8986.795] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  8986.795] sna_block_handler (tv=599.998000)
>[  8986.795] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.795] sna_accel_do_flush -- no pending write to scanout
>[  8986.795] sna_wakeup_handler
>[  8986.795] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  8986.795] sna_block_handler (tv=599.998000)
>[  8986.795] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.795] sna_accel_do_flush -- no pending write to scanout
>[  8986.795] sna_wakeup_handler
>[  8986.795] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  8986.795] sna_block_handler (tv=599.998000)
>[  8986.795] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.795] sna_accel_do_flush -- no pending write to scanout
>[  8986.795] sna_wakeup_handler
>[  8986.795] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  8986.795] sna_block_handler (tv=599.998000)
>[  8986.795] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.795] sna_accel_do_flush -- no pending write to scanout
>[  8986.795] sna_wakeup_handler
>[  8986.795] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  8986.795] sna_block_handler (tv=599.998000)
>[  8986.796] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.796] sna_accel_do_flush -- no pending write to scanout
>[  8986.796] sna_wakeup_handler
>[  8986.796] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  8986.796] sna_block_handler (tv=599.997000)
>[  8986.796] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.796] sna_accel_do_flush -- no pending write to scanout
>[  8986.796] sna_wakeup_handler
>[  8986.796] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  8986.796] sna_block_handler (tv=599.997000)
>[  8986.796] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  8986.796] sna_accel_do_flush -- no pending write to scanout
>[  8986.797] sna_wakeup_handler
>[  8986.797] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  8986.797] sna_create_pixmap(16, 16, 1, usage=1)
>[  8986.797] kgem_can_create_2d: 16x16 @ 1
>[  8986.797] kgem_can_create_2d: unhandled depth 1
>[  8986.797] sna_create_pixmap: can not use GPU, just creating shadow
>[  8986.797] create_pixmap: allocating pixmap 16x16, depth=1, size=72
>[  8986.797] create_pixmap: serial=8, usage=1, 16x16
>[  8986.797] sna_validate_gc changes=7fffff, previous serial=80000000, drawable=8
>[  8986.797] sna_validate_gc: recomputing clip
>[  8986.797] sna_validate_gc: composite clip=1x[(0, 0), (16, 16)]
>[  8986.797] sna_poly_fill_rect(n=1, PlaneMask: ffffffffffffffff (solid 1), solid fill: 1 [style=0, tileIsPixel=1], alu=3)
>[  8986.797] sna_poly_fill_rect_extents: [0] = (0, 0)x(16, 16)
>[  8986.797] sna_poly_fill_rect: extents(0, 0), (16, 16), flags=1
>[  8986.797] sna_poly_fill_rect: fallback -- unattached
>[  8986.797] sna_poly_fill_rect: fallback (0, 0), (16, 16)
>[  8986.797] sna_gc_move_to_cpu, changes=7fffff
>[  8986.797] sfbValidateGC changes=77ffff
>[  8986.797] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000000, bg=00000001, planemask=ffffffff
>[  8986.797] sfbValidateGC: rrop fg=00000000, bg=ffffffff, pm=ffffffff, and=00000000, xor=00000000, bgand=00000000, bgxor=ffffffff
>[  8986.797] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  8986.797] sna_drawable_move_region_to_cpu(pixmap=8 (16x16), [(0, 0), (16, 16)], flags=5)
>[  8986.797] sna_drawable_move_region_to_cpu: not attached to 0x1d61820
>[  8986.797] sna_poly_fill_rect: fallback - fbPolyFillRect
>[  8986.797] sfbPolyFillRect x 1
>[  8986.797] sfbPolyFillRect: rectangle (0, 0), (16, 16)
>[  8986.797] fbClipBoxes: box=(0, 0),(16, 16); region=(0, 0),(16, 16) x 1
>[  8986.797] fbDrawableRun: box=(0, 0), (16, 16), clip=(0, 0), (16, 16)
>
>
>========================================================================
>
>[  9103.601] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.601] sna_accel_do_flush -- no pending write to scanout
>[  9103.601] sna_accel_do_throttle -- no pending activity
>[  9103.608] sna_wakeup_handler
>[  9103.608] sna_block_handler (tv=0.014000)
>[  9103.608] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.608] sna_accel_do_flush -- no pending write to scanout
>[  9103.608] sna_accel_do_throttle -- no pending activity
>[  9103.622] sna_wakeup_handler
>[  9103.622] sna_block_handler (tv=0.014000)
>[  9103.622] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.622] sna_accel_do_flush -- no pending write to scanout
>[  9103.622] sna_accel_do_throttle -- no pending activity
>[  9103.625] sna_wakeup_handler
>[  9103.625] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.625] sna_block_handler (tv=0.011000)
>[  9103.625] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.625] sna_accel_do_flush -- no pending write to scanout
>[  9103.625] sna_accel_do_throttle -- no pending activity
>[  9103.626] sna_wakeup_handler
>[  9103.626] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.627] sna_block_handler (tv=0.009000)
>[  9103.627] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.627] sna_accel_do_flush -- no pending write to scanout
>[  9103.627] sna_accel_do_throttle -- no pending activity
>[  9103.630] sna_wakeup_handler
>[  9103.630] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.630] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.630] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.630] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.630] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.630] sna_do_copy: dst clipped out
>[  9103.630] sna_block_handler (tv=0.006000)
>[  9103.630] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.630] sna_accel_do_flush -- no pending write to scanout
>[  9103.630] sna_accel_do_throttle -- no pending activity
>[  9103.634] sna_wakeup_handler
>[  9103.634] sna_block_handler (tv=0.014000)
>[  9103.634] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.634] sna_accel_do_flush -- no pending write to scanout
>[  9103.634] sna_accel_do_throttle -- no pending activity
>[  9103.635] sna_wakeup_handler
>[  9103.635] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.635] sna_change_window_attributes
>[  9103.635] sna_block_handler (tv=0.013000)
>[  9103.635] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.635] sna_accel_do_flush -- no pending write to scanout
>[  9103.635] sna_accel_do_throttle -- no pending activity
>[  9103.646] sna_wakeup_handler
>[  9103.646] sna_block_handler (tv=0.014000)
>[  9103.646] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.646] sna_accel_do_flush -- no pending write to scanout
>[  9103.646] sna_accel_do_throttle -- no pending activity
>[  9103.656] sna_wakeup_handler
>[  9103.656] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.656] sna_block_handler (tv=0.004000)
>[  9103.656] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.656] sna_accel_do_flush -- no pending write to scanout
>[  9103.656] sna_accel_do_throttle -- no pending activity
>[  9103.657] sna_wakeup_handler
>[  9103.657] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.657] sna_block_handler (tv=0.013000)
>[  9103.657] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.657] sna_accel_do_flush -- no pending write to scanout
>[  9103.657] sna_accel_do_throttle -- no pending activity
>[  9103.664] sna_wakeup_handler
>[  9103.664] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.664] sna_copy_area: src=(0, 340)x(200, 295)+(0, 0) -> dst=(0, 340)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.664] sna_do_copy: src=(0, 340), dst=(0, 340), size=(200x295)
>[  9103.664] sna_do_copy: after drawable: src=(0, 340), dst=(137, 360), size=(200x295)
>[  9103.664] sna_do_copy: dst extents (137, 360), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.664] sna_do_copy: dst clipped out
>[  9103.664] sna_block_handler (tv=0.006000)
>[  9103.664] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.664] sna_accel_do_flush -- no pending write to scanout
>[  9103.664] sna_accel_do_throttle -- no pending activity
>[  9103.670] sna_wakeup_handler
>[  9103.670] sna_block_handler (tv=0.014000)
>[  9103.670] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.670] sna_accel_do_flush -- no pending write to scanout
>[  9103.670] sna_accel_do_throttle -- no pending activity
>[  9103.672] sna_wakeup_handler
>[  9103.672] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.672] sna_block_handler (tv=0.012000)
>[  9103.672] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.672] sna_accel_do_flush -- no pending write to scanout
>[  9103.672] sna_accel_do_throttle -- no pending activity
>[  9103.674] sna_wakeup_handler
>[  9103.674] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.674] sna_block_handler (tv=0.010000)
>[  9103.674] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.674] sna_accel_do_flush -- no pending write to scanout
>[  9103.674] sna_accel_do_throttle -- no pending activity
>[  9103.677] sna_wakeup_handler
>[  9103.677] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.678] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.678] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.678] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.678] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.678] sna_do_copy: dst clipped out
>[  9103.678] sna_block_handler (tv=0.006000)
>[  9103.678] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.678] sna_accel_do_flush -- no pending write to scanout
>[  9103.678] sna_accel_do_throttle -- no pending activity
>[  9103.683] sna_wakeup_handler
>[  9103.683] sna_block_handler (tv=0.014000)
>[  9103.683] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.683] sna_accel_do_flush -- no pending write to scanout
>[  9103.683] sna_accel_do_throttle -- no pending activity
>[  9103.685] sna_wakeup_handler
>[  9103.685] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.685] sna_block_handler (tv=0.012000)
>[  9103.685] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.686] sna_accel_do_flush -- no pending write to scanout
>[  9103.686] sna_accel_do_throttle -- no pending activity
>[  9103.686] sna_wakeup_handler
>[  9103.686] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.686] sna_copy_area: src=(505, 338)x(34, 34)+(0, 0) -> dst=(505, 338)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.686] sna_do_copy: src=(505, 338), dst=(505, 338), size=(34x34)
>[  9103.686] sna_do_copy: after drawable: src=(505, 338), dst=(642, 358), size=(34x34)
>[  9103.686] sna_do_copy: dst extents (642, 358), (676, 392), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.686] sna_do_copy: dst clipped out
>[  9103.686] sna_block_handler (tv=0.011000)
>[  9103.686] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.686] sna_accel_do_flush -- no pending write to scanout
>[  9103.686] sna_accel_do_throttle -- no pending activity
>[  9103.694] sna_wakeup_handler
>[  9103.694] sna_block_handler (tv=0.014000)
>[  9103.694] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.694] sna_accel_do_flush -- no pending write to scanout
>[  9103.694] sna_accel_do_throttle -- no pending activity
>[  9103.703] sna_wakeup_handler
>[  9103.703] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.703] sna_block_handler (tv=0.005000)
>[  9103.703] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.703] sna_accel_do_flush -- no pending write to scanout
>[  9103.703] sna_accel_do_throttle -- no pending activity
>[  9103.705] sna_wakeup_handler
>[  9103.705] sna_block_handler (tv=0.014000)
>[  9103.705] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.705] sna_accel_do_flush -- no pending write to scanout
>[  9103.705] sna_accel_do_throttle -- no pending activity
>[  9103.705] sna_wakeup_handler
>[  9103.705] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.705] sna_block_handler (tv=0.014000)
>[  9103.705] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.705] sna_accel_do_flush -- no pending write to scanout
>[  9103.705] sna_accel_do_throttle -- no pending activity
>[  9103.709] sna_wakeup_handler
>[  9103.709] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.709] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.709] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.709] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.709] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.710] sna_do_copy: dst clipped out
>[  9103.710] sna_block_handler (tv=0.009000)
>[  9103.710] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.710] sna_accel_do_flush -- no pending write to scanout
>[  9103.710] sna_accel_do_throttle -- no pending activity
>[  9103.718] sna_wakeup_handler
>[  9103.719] sna_block_handler (tv=0.013000)
>[  9103.719] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.719] sna_accel_do_flush -- no pending write to scanout
>[  9103.719] sna_accel_do_throttle -- no pending activity
>[  9103.720] sna_wakeup_handler
>[  9103.720] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.720] sna_block_handler (tv=0.012000)
>[  9103.720] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.720] sna_accel_do_flush -- no pending write to scanout
>[  9103.720] sna_accel_do_throttle -- no pending activity
>[  9103.721] sna_wakeup_handler
>[  9103.722] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.722] sna_block_handler (tv=0.010000)
>[  9103.722] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.722] sna_accel_do_flush -- no pending write to scanout
>[  9103.722] sna_accel_do_throttle -- no pending activity
>[  9103.725] sna_wakeup_handler
>[  9103.725] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.725] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.725] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.725] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.725] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.725] sna_do_copy: dst clipped out
>[  9103.726] sna_block_handler (tv=0.006000)
>[  9103.726] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.726] sna_accel_do_flush -- no pending write to scanout
>[  9103.726] sna_accel_do_throttle -- no pending activity
>[  9103.731] sna_wakeup_handler
>[  9103.731] sna_block_handler (tv=0.014000)
>[  9103.731] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.731] sna_accel_do_flush -- no pending write to scanout
>[  9103.731] sna_accel_do_throttle -- no pending activity
>[  9103.742] sna_wakeup_handler
>[  9103.743] sna_block_handler (tv=0.013000)
>[  9103.743] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.743] sna_accel_do_flush -- no pending write to scanout
>[  9103.743] sna_accel_do_throttle -- no pending activity
>[  9103.743] sna_wakeup_handler
>[  9103.743] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.743] sna_change_window_attributes
>[  9103.743] sna_block_handler (tv=0.013000)
>[  9103.743] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.743] sna_accel_do_flush -- no pending write to scanout
>[  9103.743] sna_accel_do_throttle -- no pending activity
>[  9103.750] sna_wakeup_handler
>[  9103.750] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.750] sna_block_handler (tv=0.006000)
>[  9103.750] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.750] sna_accel_do_flush -- no pending write to scanout
>[  9103.750] sna_accel_do_throttle -- no pending activity
>[  9103.752] sna_wakeup_handler
>[  9103.752] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.753] sna_block_handler (tv=0.003000)
>[  9103.753] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.753] sna_accel_do_flush -- no pending write to scanout
>[  9103.753] sna_accel_do_throttle -- no pending activity
>[  9103.753] sna_wakeup_handler
>[  9103.753] sna_block_handler (tv=0.014000)
>[  9103.753] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.753] sna_accel_do_flush -- no pending write to scanout
>[  9103.753] sna_accel_do_throttle -- no pending activity
>[  9103.757] sna_wakeup_handler
>[  9103.757] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.757] sna_block_handler (tv=0.010000)
>[  9103.757] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.757] sna_accel_do_flush -- no pending write to scanout
>[  9103.757] sna_accel_do_throttle -- no pending activity
>[  9103.758] sna_wakeup_handler
>[  9103.758] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.758] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.758] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.758] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.758] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.758] sna_do_copy: dst clipped out
>[  9103.758] sna_block_handler (tv=0.009000)
>[  9103.758] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.758] sna_accel_do_flush -- no pending write to scanout
>[  9103.758] sna_accel_do_throttle -- no pending activity
>[  9103.767] sna_wakeup_handler
>[  9103.767] sna_block_handler (tv=0.014000)
>[  9103.767] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.767] sna_accel_do_flush -- no pending write to scanout
>[  9103.767] sna_accel_do_throttle -- no pending activity
>[  9103.779] sna_wakeup_handler
>[  9103.779] sna_block_handler (tv=0.014000)
>[  9103.779] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.779] sna_accel_do_flush -- no pending write to scanout
>[  9103.779] sna_accel_do_throttle -- no pending activity
>[  9103.781] sna_wakeup_handler
>[  9103.781] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.782] sna_block_handler (tv=0.011000)
>[  9103.782] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.782] sna_accel_do_flush -- no pending write to scanout
>[  9103.782] sna_accel_do_throttle -- no pending activity
>[  9103.785] sna_wakeup_handler
>[  9103.785] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.785] sna_block_handler (tv=0.008000)
>[  9103.785] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.785] sna_accel_do_flush -- no pending write to scanout
>[  9103.785] sna_accel_do_throttle -- no pending activity
>[  9103.791] sna_wakeup_handler
>[  9103.791] sna_block_handler (tv=0.014000)
>[  9103.791] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.791] sna_accel_do_flush -- no pending write to scanout
>[  9103.791] sna_accel_do_throttle -- no pending activity
>[  9103.791] sna_wakeup_handler
>[  9103.791] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.791] sna_block_handler (tv=0.014000)
>[  9103.791] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.791] sna_accel_do_flush -- no pending write to scanout
>[  9103.791] sna_accel_do_throttle -- no pending activity
>[  9103.792] sna_wakeup_handler
>[  9103.792] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.792] sna_block_handler (tv=0.013000)
>[  9103.792] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.792] sna_accel_do_flush -- no pending write to scanout
>[  9103.792] sna_accel_do_throttle -- no pending activity
>[  9103.793] sna_wakeup_handler
>[  9103.793] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.793] sna_copy_area: src=(0, 338)x(539, 297)+(0, 0) -> dst=(0, 338)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.793] sna_do_copy: src=(0, 338), dst=(0, 338), size=(539x297)
>[  9103.793] sna_do_copy: after drawable: src=(0, 338), dst=(137, 358), size=(539x297)
>[  9103.793] sna_do_copy: dst extents (137, 358), (676, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.793] sna_do_copy: dst clipped out
>[  9103.793] sna_block_handler (tv=0.012000)
>[  9103.793] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.793] sna_accel_do_flush -- no pending write to scanout
>[  9103.793] sna_accel_do_throttle -- no pending activity
>[  9103.797] sna_wakeup_handler
>[  9103.797] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.797] sna_block_handler (tv=0.008000)
>[  9103.797] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.797] sna_accel_do_flush -- no pending write to scanout
>[  9103.797] sna_accel_do_throttle -- no pending activity
>[  9103.800] sna_wakeup_handler
>[  9103.800] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.800] sna_block_handler (tv=0.005000)
>[  9103.800] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.800] sna_accel_do_flush -- no pending write to scanout
>[  9103.800] sna_accel_do_throttle -- no pending activity
>[  9103.801] sna_wakeup_handler
>[  9103.801] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.801] sna_copy_area: src=(196, 104)x(10, 14)+(0, 0) -> dst=(196, 104)+(495, 286); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.801] sna_do_copy: src=(196, 104), dst=(196, 104), size=(10x14)
>[  9103.801] sna_do_copy: after drawable: src=(196, 104), dst=(691, 390), size=(10x14)
>[  9103.801] sna_do_copy: dst extents (691, 390), (701, 404), dst clip extents (0, 0), (0, 0), dst size=422x215
>[  9103.801] sna_do_copy: dst clipped out
>[  9103.801] sna_block_handler (tv=0.075000)
>[  9103.802] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.802] sna_accel_do_flush -- no pending write to scanout
>[  9103.802] sna_accel_do_throttle -- no pending activity
>[  9103.803] sna_wakeup_handler
>[  9103.803] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.803] sna_block_handler (tv=0.073000)
>[  9103.803] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.803] sna_accel_do_flush -- no pending write to scanout
>[  9103.803] sna_accel_do_throttle -- no pending activity
>[  9103.809] sna_wakeup_handler
>[  9103.809] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.809] sna_block_handler (tv=0.067000)
>[  9103.809] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.809] sna_accel_do_flush -- no pending write to scanout
>[  9103.809] sna_accel_do_throttle -- no pending activity
>[  9103.810] sna_wakeup_handler
>[  9103.810] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.810] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.810] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.810] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.810] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.810] sna_do_copy: dst clipped out
>[  9103.810] sna_block_handler (tv=0.066000)
>[  9103.810] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.810] sna_accel_do_flush -- no pending write to scanout
>[  9103.810] sna_accel_do_throttle -- no pending activity
>[  9103.812] sna_wakeup_handler
>[  9103.812] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.812] sna_block_handler (tv=0.064000)
>[  9103.812] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.812] sna_accel_do_flush -- no pending write to scanout
>[  9103.813] sna_accel_do_throttle -- no pending activity
>[  9103.813] sna_wakeup_handler
>[  9103.813] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.813] sna_block_handler (tv=0.063000)
>[  9103.813] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.813] sna_accel_do_flush -- no pending write to scanout
>[  9103.813] sna_accel_do_throttle -- no pending activity
>[  9103.815] sna_wakeup_handler
>[  9103.815] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.815] sna_copy_area: src=(0, 340)x(200, 20)+(0, 0) -> dst=(0, 340)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.815] sna_do_copy: src=(0, 340), dst=(0, 340), size=(200x20)
>[  9103.816] sna_do_copy: after drawable: src=(0, 340), dst=(137, 360), size=(200x20)
>[  9103.816] sna_do_copy: dst extents (137, 360), (337, 380), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.816] sna_do_copy: dst clipped out
>[  9103.816] sna_block_handler (tv=0.060000)
>[  9103.816] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.816] sna_accel_do_flush -- no pending write to scanout
>[  9103.816] sna_accel_do_throttle -- no pending activity
>[  9103.828] sna_wakeup_handler
>[  9103.828] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.829] sna_block_handler (tv=0.047000)
>[  9103.829] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.829] sna_accel_do_flush -- no pending write to scanout
>[  9103.829] sna_accel_do_throttle -- no pending activity
>[  9103.830] sna_wakeup_handler
>[  9103.830] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.830] sna_block_handler (tv=0.046000)
>[  9103.830] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.830] sna_accel_do_flush -- no pending write to scanout
>[  9103.830] sna_accel_do_throttle -- no pending activity
>[  9103.833] sna_wakeup_handler
>[  9103.833] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.834] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.834] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.834] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.834] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.834] sna_do_copy: dst clipped out
>[  9103.834] sna_block_handler (tv=0.042000)
>[  9103.834] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.834] sna_accel_do_flush -- no pending write to scanout
>[  9103.834] sna_accel_do_throttle -- no pending activity
>[  9103.845] sna_wakeup_handler
>[  9103.845] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.845] sna_block_handler (tv=0.031000)
>[  9103.845] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.845] sna_accel_do_flush -- no pending write to scanout
>[  9103.845] sna_accel_do_throttle -- no pending activity
>[  9103.846] sna_wakeup_handler
>[  9103.846] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.847] sna_block_handler (tv=0.029000)
>[  9103.847] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.847] sna_accel_do_flush -- no pending write to scanout
>[  9103.847] sna_accel_do_throttle -- no pending activity
>[  9103.850] sna_wakeup_handler
>[  9103.850] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.850] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.850] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.850] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.850] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.850] sna_do_copy: dst clipped out
>[  9103.850] sna_block_handler (tv=0.026000)
>[  9103.850] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.850] sna_accel_do_flush -- no pending write to scanout
>[  9103.850] sna_accel_do_throttle -- no pending activity
>[  9103.876] sna_wakeup_handler
>[  9103.876] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.877] sna_block_handler (tv=3527.616000)
>[  9103.877] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.877] sna_accel_do_flush -- no pending write to scanout
>[  9103.877] sna_accel_do_throttle -- no pending activity
>[  9103.877] sna_wakeup_handler
>[  9103.877] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.877] sna_block_handler (tv=3527.616000)
>[  9103.877] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.877] sna_accel_do_flush -- no pending write to scanout
>[  9103.877] sna_accel_do_throttle -- no pending activity
>[  9103.878] sna_wakeup_handler
>[  9103.878] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.879] sna_block_handler (tv=3527.614000)
>[  9103.879] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.879] sna_accel_do_flush -- no pending write to scanout
>[  9103.879] sna_accel_do_throttle -- no pending activity
>[  9103.882] sna_wakeup_handler
>[  9103.882] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.882] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.883] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.883] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.883] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.883] sna_do_copy: dst clipped out
>[  9103.883] sna_change_window_attributes
>[  9103.883] sna_block_handler (tv=3527.610000)
>[  9103.883] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.883] sna_accel_do_flush -- no pending write to scanout
>[  9103.883] sna_accel_do_throttle -- no pending activity
>[  9103.885] sna_wakeup_handler
>[  9103.885] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.885] sna_block_handler (tv=3527.608000)
>[  9103.885] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.885] sna_accel_do_flush -- no pending write to scanout
>[  9103.885] sna_accel_do_throttle -- no pending activity
>[  9103.886] sna_wakeup_handler
>[  9103.886] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.886] sna_copy_area: src=(505, 338)x(34, 34)+(0, 0) -> dst=(505, 338)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.886] sna_do_copy: src=(505, 338), dst=(505, 338), size=(34x34)
>[  9103.886] sna_do_copy: after drawable: src=(505, 338), dst=(642, 358), size=(34x34)
>[  9103.886] sna_do_copy: dst extents (642, 358), (676, 392), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.886] sna_do_copy: dst clipped out
>[  9103.886] sna_block_handler (tv=3527.607000)
>[  9103.886] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.886] sna_accel_do_flush -- no pending write to scanout
>[  9103.886] sna_accel_do_throttle -- no pending activity
>[  9103.908] sna_wakeup_handler
>[  9103.908] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.908] sna_block_handler (tv=3527.585000)
>[  9103.908] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.908] sna_accel_do_flush -- no pending write to scanout
>[  9103.908] sna_accel_do_throttle -- no pending activity
>[  9103.910] sna_wakeup_handler
>[  9103.910] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.910] sna_block_handler (tv=3527.583000)
>[  9103.910] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.910] sna_accel_do_flush -- no pending write to scanout
>[  9103.910] sna_accel_do_throttle -- no pending activity
>[  9103.913] sna_wakeup_handler
>[  9103.913] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.914] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.914] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.914] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.914] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.914] sna_do_copy: dst clipped out
>[  9103.914] sna_block_handler (tv=3527.579000)
>[  9103.914] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.914] sna_accel_do_flush -- no pending write to scanout
>[  9103.914] sna_accel_do_throttle -- no pending activity
>[  9103.924] sna_wakeup_handler
>[  9103.924] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.924] sna_block_handler (tv=3527.569000)
>[  9103.924] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.924] sna_accel_do_flush -- no pending write to scanout
>[  9103.924] sna_accel_do_throttle -- no pending activity
>[  9103.926] sna_wakeup_handler
>[  9103.926] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.926] sna_block_handler (tv=3527.567000)
>[  9103.926] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.926] sna_accel_do_flush -- no pending write to scanout
>[  9103.926] sna_accel_do_throttle -- no pending activity
>[  9103.929] sna_wakeup_handler
>[  9103.929] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.929] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.929] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.930] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.930] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.930] sna_do_copy: dst clipped out
>[  9103.930] sna_block_handler (tv=3527.563000)
>[  9103.930] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.930] sna_accel_do_flush -- no pending write to scanout
>[  9103.930] sna_accel_do_throttle -- no pending activity
>[  9103.955] sna_wakeup_handler
>[  9103.955] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.955] sna_block_handler (tv=3527.538000)
>[  9103.955] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.955] sna_accel_do_flush -- no pending write to scanout
>[  9103.955] sna_accel_do_throttle -- no pending activity
>[  9103.957] sna_wakeup_handler
>[  9103.957] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.957] sna_block_handler (tv=3527.536000)
>[  9103.957] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.957] sna_accel_do_flush -- no pending write to scanout
>[  9103.957] sna_accel_do_throttle -- no pending activity
>[  9103.960] sna_wakeup_handler
>[  9103.960] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.960] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.960] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9103.961] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9103.961] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.961] sna_do_copy: dst clipped out
>[  9103.961] sna_block_handler (tv=3527.532000)
>[  9103.961] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.961] sna_accel_do_flush -- no pending write to scanout
>[  9103.961] sna_accel_do_throttle -- no pending activity
>[  9103.971] sna_wakeup_handler
>[  9103.971] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.971] sna_block_handler (tv=3527.522000)
>[  9103.971] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.971] sna_accel_do_flush -- no pending write to scanout
>[  9103.971] sna_accel_do_throttle -- no pending activity
>[  9103.972] sna_wakeup_handler
>[  9103.972] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.972] sna_block_handler (tv=3527.521000)
>[  9103.972] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.972] sna_accel_do_flush -- no pending write to scanout
>[  9103.972] sna_accel_do_throttle -- no pending activity
>[  9103.979] sna_wakeup_handler
>[  9103.979] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.979] sna_block_handler (tv=3527.514000)
>[  9103.980] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.980] sna_accel_do_flush -- no pending write to scanout
>[  9103.980] sna_accel_do_throttle -- no pending activity
>[  9103.980] sna_wakeup_handler
>[  9103.980] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.980] sna_copy_area: src=(0, 340)x(200, 295)+(0, 0) -> dst=(0, 340)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.980] sna_do_copy: src=(0, 340), dst=(0, 340), size=(200x295)
>[  9103.980] sna_do_copy: after drawable: src=(0, 340), dst=(137, 360), size=(200x295)
>[  9103.980] sna_do_copy: dst extents (137, 360), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.980] sna_do_copy: dst clipped out
>[  9103.980] sna_block_handler (tv=3527.513000)
>[  9103.980] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.980] sna_accel_do_flush -- no pending write to scanout
>[  9103.980] sna_accel_do_throttle -- no pending activity
>[  9103.986] sna_wakeup_handler
>[  9103.986] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.986] sna_block_handler (tv=3527.507000)
>[  9103.986] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.986] sna_accel_do_flush -- no pending write to scanout
>[  9103.986] sna_accel_do_throttle -- no pending activity
>[  9103.987] sna_wakeup_handler
>[  9103.987] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.987] sna_block_handler (tv=3527.506000)
>[  9103.987] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.987] sna_accel_do_flush -- no pending write to scanout
>[  9103.987] sna_accel_do_throttle -- no pending activity
>[  9103.987] sna_wakeup_handler
>[  9103.988] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9103.988] sna_copy_area: src=(505, 338)x(34, 34)+(0, 0) -> dst=(505, 338)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9103.988] sna_do_copy: src=(505, 338), dst=(505, 338), size=(34x34)
>[  9103.988] sna_do_copy: after drawable: src=(505, 338), dst=(642, 358), size=(34x34)
>[  9103.988] sna_do_copy: dst extents (642, 358), (676, 392), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9103.988] sna_do_copy: dst clipped out
>[  9103.988] sna_block_handler (tv=3527.505000)
>[  9103.988] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9103.988] sna_accel_do_flush -- no pending write to scanout
>[  9103.988] sna_accel_do_throttle -- no pending activity
>[  9104.004] sna_wakeup_handler
>[  9104.004] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.004] sna_block_handler (tv=3527.489000)
>[  9104.004] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.004] sna_accel_do_flush -- no pending write to scanout
>[  9104.004] sna_accel_do_throttle -- no pending activity
>[  9104.006] sna_wakeup_handler
>[  9104.006] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.006] sna_block_handler (tv=3527.487000)
>[  9104.006] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.006] sna_accel_do_flush -- no pending write to scanout
>[  9104.006] sna_accel_do_throttle -- no pending activity
>[  9104.009] sna_wakeup_handler
>[  9104.010] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.010] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9104.010] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9104.010] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9104.010] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9104.010] sna_do_copy: dst clipped out
>[  9104.010] sna_block_handler (tv=3527.483000)
>[  9104.010] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.010] sna_accel_do_flush -- no pending write to scanout
>[  9104.010] sna_accel_do_throttle -- no pending activity
>[  9104.031] sna_wakeup_handler
>[  9104.031] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.031] sna_block_handler (tv=3527.462000)
>[  9104.031] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.031] sna_accel_do_flush -- no pending write to scanout
>[  9104.031] sna_accel_do_throttle -- no pending activity
>[  9104.033] sna_wakeup_handler
>[  9104.033] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.033] sna_block_handler (tv=3527.460000)
>[  9104.033] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.033] sna_accel_do_flush -- no pending write to scanout
>[  9104.033] sna_accel_do_throttle -- no pending activity
>[  9104.036] sna_wakeup_handler
>[  9104.036] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.036] sna_block_handler (tv=3527.457000)
>[  9104.037] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.037] sna_accel_do_flush -- no pending write to scanout
>[  9104.037] sna_accel_do_throttle -- no pending activity
>[  9104.037] sna_wakeup_handler
>[  9104.037] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.037] sna_block_handler (tv=3527.456000)
>[  9104.037] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.037] sna_accel_do_flush -- no pending write to scanout
>[  9104.037] sna_accel_do_throttle -- no pending activity
>[  9104.037] sna_wakeup_handler
>[  9104.037] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.037] sna_copy_area: src=(0, 436)x(200, 199)+(0, 0) -> dst=(0, 436)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9104.037] sna_do_copy: src=(0, 436), dst=(0, 436), size=(200x199)
>[  9104.037] sna_do_copy: after drawable: src=(0, 436), dst=(137, 456), size=(200x199)
>[  9104.037] sna_do_copy: dst extents (137, 456), (337, 655), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9104.037] sna_do_copy: dst clipped out
>[  9104.037] sna_block_handler (tv=3527.456000)
>[  9104.037] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.037] sna_accel_do_flush -- no pending write to scanout
>[  9104.037] sna_accel_do_throttle -- no pending activity
>[  9104.086] sna_wakeup_handler
>[  9104.086] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.086] sna_block_handler (tv=3527.407000)
>[  9104.086] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.086] sna_accel_do_flush -- no pending write to scanout
>[  9104.086] sna_accel_do_throttle -- no pending activity
>[  9104.087] sna_wakeup_handler
>[  9104.087] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.087] sna_block_handler (tv=3527.406000)
>[  9104.088] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.088] sna_accel_do_flush -- no pending write to scanout
>[  9104.088] sna_accel_do_throttle -- no pending activity
>[  9104.088] sna_wakeup_handler
>[  9104.088] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.088] sna_copy_area: src=(505, 338)x(34, 34)+(0, 0) -> dst=(505, 338)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9104.089] sna_do_copy: src=(505, 338), dst=(505, 338), size=(34x34)
>[  9104.089] sna_do_copy: after drawable: src=(505, 338), dst=(642, 358), size=(34x34)
>[  9104.089] sna_do_copy: dst extents (642, 358), (676, 392), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9104.089] sna_do_copy: dst clipped out
>[  9104.089] sna_block_handler (tv=3527.404000)
>[  9104.089] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.089] sna_accel_do_flush -- no pending write to scanout
>[  9104.089] sna_accel_do_throttle -- no pending activity
>[  9104.115] sna_wakeup_handler
>[  9104.115] sna_block_handler (tv=0.001000)
>[  9104.115] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.115] sna_accel_do_flush -- no pending write to scanout
>[  9104.115] sna_accel_do_throttle -- no pending activity
>[  9104.116] sna_wakeup_handler
>[  9104.116] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.116] sna_block_handler (tv=0.014000)
>[  9104.116] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.116] sna_accel_do_flush -- no pending write to scanout
>[  9104.116] sna_accel_do_throttle -- no pending activity
>[  9104.126] sna_wakeup_handler
>[  9104.126] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.126] sna_block_handler (tv=0.004000)
>[  9104.126] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.126] sna_accel_do_flush -- no pending write to scanout
>[  9104.126] sna_accel_do_throttle -- no pending activity
>[  9104.127] sna_wakeup_handler
>[  9104.127] sna_block_handler (tv=0.014000)
>[  9104.127] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.127] sna_accel_do_flush -- no pending write to scanout
>[  9104.127] sna_accel_do_throttle -- no pending activity
>[  9104.128] sna_wakeup_handler
>[  9104.128] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.128] sna_block_handler (tv=0.013000)
>[  9104.128] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.128] sna_accel_do_flush -- no pending write to scanout
>[  9104.128] sna_accel_do_throttle -- no pending activity
>[  9104.131] sna_wakeup_handler
>[  9104.132] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.132] sna_block_handler (tv=0.009000)
>[  9104.132] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.132] sna_accel_do_flush -- no pending write to scanout
>[  9104.132] sna_accel_do_throttle -- no pending activity
>[  9104.132] sna_wakeup_handler
>[  9104.132] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.132] sna_copy_area: src=(0, 340)x(200, 20)+(0, 0) -> dst=(0, 340)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9104.132] sna_do_copy: src=(0, 340), dst=(0, 340), size=(200x20)
>[  9104.132] sna_do_copy: after drawable: src=(0, 340), dst=(137, 360), size=(200x20)
>[  9104.132] sna_do_copy: dst extents (137, 360), (337, 380), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9104.132] sna_do_copy: dst clipped out
>[  9104.132] sna_block_handler (tv=0.009000)
>[  9104.132] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.132] sna_accel_do_flush -- no pending write to scanout
>[  9104.132] sna_accel_do_throttle -- no pending activity
>[  9104.140] sna_wakeup_handler
>[  9104.140] sna_block_handler (tv=0.014000)
>[  9104.140] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.140] sna_accel_do_flush -- no pending write to scanout
>[  9104.140] sna_accel_do_throttle -- no pending activity
>[  9104.154] sna_wakeup_handler
>[  9104.154] sna_block_handler (tv=0.014000)
>[  9104.154] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.154] sna_accel_do_flush -- no pending write to scanout
>[  9104.154] sna_accel_do_throttle -- no pending activity
>[  9104.165] sna_wakeup_handler
>[  9104.165] sna_block_handler (tv=0.014000)
>[  9104.165] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.165] sna_accel_do_flush -- no pending write to scanout
>[  9104.165] sna_accel_do_throttle -- no pending activity
>[  9104.165] sna_wakeup_handler
>[  9104.165] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.166] sna_change_window_attributes
>[  9104.166] sna_block_handler (tv=0.013000)
>[  9104.166] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.166] sna_accel_do_flush -- no pending write to scanout
>[  9104.166] sna_accel_do_throttle -- no pending activity
>[  9104.176] sna_wakeup_handler
>[  9104.176] sna_block_handler (tv=0.014000)
>[  9104.176] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.176] sna_accel_do_flush -- no pending write to scanout
>[  9104.176] sna_accel_do_throttle -- no pending activity
>[  9104.186] sna_wakeup_handler
>[  9104.186] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.186] sna_block_handler (tv=0.004000)
>[  9104.186] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.186] sna_accel_do_flush -- no pending write to scanout
>[  9104.186] sna_accel_do_throttle -- no pending activity
>[  9104.187] sna_wakeup_handler
>[  9104.187] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.187] sna_block_handler (tv=0.003000)
>[  9104.187] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.187] sna_accel_do_flush -- no pending write to scanout
>[  9104.187] sna_accel_do_throttle -- no pending activity
>[  9104.187] sna_wakeup_handler
>[  9104.188] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.188] sna_copy_area: src=(505, 338)x(34, 34)+(0, 0) -> dst=(505, 338)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9104.188] sna_do_copy: src=(505, 338), dst=(505, 338), size=(34x34)
>[  9104.188] sna_do_copy: after drawable: src=(505, 338), dst=(642, 358), size=(34x34)
>[  9104.188] sna_do_copy: dst extents (642, 358), (676, 392), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9104.188] sna_do_copy: dst clipped out
>[  9104.188] sna_block_handler (tv=0.002000)
>[  9104.188] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.188] sna_accel_do_flush -- no pending write to scanout
>[  9104.188] sna_accel_do_throttle -- no pending activity
>[  9104.189] sna_wakeup_handler
>[  9104.189] sna_block_handler (tv=0.014000)
>[  9104.189] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.189] sna_accel_do_flush -- no pending write to scanout
>[  9104.189] sna_accel_do_throttle -- no pending activity
>[  9104.201] sna_wakeup_handler
>[  9104.201] sna_block_handler (tv=0.014000)
>[  9104.201] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.201] sna_accel_do_flush -- no pending write to scanout
>[  9104.201] sna_accel_do_throttle -- no pending activity
>[  9104.213] sna_wakeup_handler
>[  9104.213] sna_block_handler (tv=0.014000)
>[  9104.213] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.214] sna_accel_do_flush -- no pending write to scanout
>[  9104.214] sna_accel_do_throttle -- no pending activity
>[  9104.224] sna_wakeup_handler
>[  9104.225] sna_block_handler (tv=0.013000)
>[  9104.225] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.225] sna_accel_do_flush -- no pending write to scanout
>[  9104.225] sna_accel_do_throttle -- no pending activity
>[  9104.238] sna_wakeup_handler
>[  9104.238] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.238] sna_block_handler (tv=0.014000)
>[  9104.238] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.238] sna_accel_do_flush -- no pending write to scanout
>[  9104.238] sna_accel_do_throttle -- no pending activity
>[  9104.239] sna_wakeup_handler
>[  9104.239] sna_block_handler (tv=0.014000)
>[  9104.239] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.239] sna_accel_do_flush -- no pending write to scanout
>[  9104.239] sna_accel_do_throttle -- no pending activity
>[  9104.251] sna_wakeup_handler
>[  9104.251] sna_block_handler (tv=0.014000)
>[  9104.251] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.251] sna_accel_do_flush -- no pending write to scanout
>[  9104.251] sna_accel_do_throttle -- no pending activity
>[  9104.262] sna_wakeup_handler
>[  9104.262] sna_block_handler (tv=0.014000)
>[  9104.263] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.263] sna_accel_do_flush -- no pending write to scanout
>[  9104.263] sna_accel_do_throttle -- no pending activity
>[  9104.277] sna_wakeup_handler
>[  9104.277] sna_block_handler (tv=0.014000)
>[  9104.277] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.277] sna_accel_do_flush -- no pending write to scanout
>[  9104.277] sna_accel_do_throttle -- no pending activity
>[  9104.277] sna_wakeup_handler
>[  9104.277] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.277] sna_change_window_attributes
>[  9104.277] sna_block_handler (tv=0.014000)
>[  9104.277] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.277] sna_accel_do_flush -- no pending write to scanout
>[  9104.277] sna_accel_do_throttle -- no pending activity
>[  9104.281] sna_wakeup_handler
>[  9104.281] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.281] sna_block_handler (tv=0.010000)
>[  9104.281] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.281] sna_accel_do_flush -- no pending write to scanout
>[  9104.281] sna_accel_do_throttle -- no pending activity
>[  9104.281] sna_wakeup_handler
>[  9104.281] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.281] sna_block_handler (tv=0.010000)
>[  9104.281] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.281] sna_accel_do_flush -- no pending write to scanout
>[  9104.281] sna_accel_do_throttle -- no pending activity
>[  9104.286] sna_wakeup_handler
>[  9104.286] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.286] sna_block_handler (tv=0.005000)
>[  9104.286] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.286] sna_accel_do_flush -- no pending write to scanout
>[  9104.286] sna_accel_do_throttle -- no pending activity
>[  9104.287] sna_wakeup_handler
>[  9104.287] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.287] sna_copy_area: src=(0, 338)x(539, 34)+(0, 0) -> dst=(0, 338)+(137, 20); alu=3, pm=ffffffffffffffff, depth=24
>[  9104.287] sna_do_copy: src=(0, 338), dst=(0, 338), size=(539x34)
>[  9104.287] sna_do_copy: after drawable: src=(0, 338), dst=(137, 358), size=(539x34)
>[  9104.287] sna_do_copy: dst extents (137, 358), (676, 392), dst clip extents (137, 706), (1229, 748), dst size=1092x728
>[  9104.287] sna_do_copy: dst clipped out
>[  9104.287] sna_block_handler (tv=0.004000)
>[  9104.287] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.287] sna_accel_do_flush -- no pending write to scanout
>[  9104.287] sna_accel_do_throttle -- no pending activity
>[  9104.289] sna_wakeup_handler
>[  9104.289] sna_block_handler (tv=0.014000)
>[  9104.289] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.289] sna_accel_do_flush -- no pending write to scanout
>[  9104.289] sna_accel_do_throttle -- no pending activity
>[  9104.300] sna_wakeup_handler
>[  9104.300] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.300] sna_block_handler (tv=0.014000)
>[  9104.300] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.300] sna_accel_do_flush -- no pending write to scanout
>[  9104.300] sna_accel_do_throttle -- no pending activity
>[  9104.301] sna_wakeup_handler
>[  9104.301] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.301] sna_copy_area: src=(196, 104)x(10, 14)+(0, 0) -> dst=(196, 104)+(495, 286); alu=3, pm=ffffffffffffffff, depth=24
>[  9104.301] sna_do_copy: src=(196, 104), dst=(196, 104), size=(10x14)
>[  9104.301] sna_do_copy: after drawable: src=(196, 104), dst=(691, 390), size=(10x14)
>[  9104.301] sna_do_copy: dst extents (691, 390), (701, 404), dst clip extents (0, 0), (0, 0), dst size=422x215
>[  9104.301] sna_do_copy: dst clipped out
>[  9104.301] sna_block_handler (tv=0.013000)
>[  9104.301] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.301] sna_accel_do_flush -- no pending write to scanout
>[  9104.301] sna_accel_do_throttle -- no pending activity
>[  9104.313] sna_wakeup_handler
>[  9104.313] sna_block_handler (tv=0.014000)
>[  9104.313] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.313] sna_accel_do_flush -- no pending write to scanout
>[  9104.313] sna_accel_do_throttle -- no pending activity
>[  9104.326] sna_wakeup_handler
>[  9104.326] sna_block_handler (tv=0.014000)
>[  9104.326] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.326] sna_accel_do_flush -- no pending write to scanout
>[  9104.326] sna_accel_do_throttle -- no pending activity
>[  9104.338] sna_wakeup_handler
>[  9104.338] sna_block_handler (tv=0.014000)
>[  9104.338] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.338] sna_accel_do_flush -- no pending write to scanout
>[  9104.338] sna_accel_do_throttle -- no pending activity
>[  9104.349] sna_wakeup_handler
>[  9104.349] sna_block_handler (tv=0.014000)
>[  9104.349] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.349] sna_accel_do_flush -- no pending write to scanout
>[  9104.349] sna_accel_do_throttle -- no pending activity
>[  9104.351] sna_wakeup_handler
>[  9104.351] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.351] sna_block_handler (tv=0.012000)
>[  9104.351] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.351] sna_accel_do_flush -- no pending write to scanout
>[  9104.351] sna_accel_do_throttle -- no pending activity
>[  9104.352] sna_wakeup_handler
>[  9104.352] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.352] sna_block_handler (tv=0.011000)
>[  9104.352] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.352] sna_accel_do_flush -- no pending write to scanout
>[  9104.352] sna_accel_do_throttle -- no pending activity
>[  9104.353] sna_wakeup_handler
>[  9104.353] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.353] sna_block_handler (tv=0.010000)
>[  9104.353] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.353] sna_accel_do_flush -- no pending write to scanout
>[  9104.353] sna_accel_do_throttle -- no pending activity
>[  9104.355] sna_wakeup_handler
>[  9104.355] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.355] sna_block_handler (tv=0.008000)
>[  9104.355] start_flush: scanout=28 shadow?=0, slaves?=0, (cpu?=0 || gpu?=0))
>[  9104.355] sna_accel_do_flush -- no pending write to scanout
>[  9104.355] sna_accel_do_throttle -- no pending activity
>[  9104.356] sna_wakeup_handler
>[  9104.356] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.356] sna_create_pixmap(32, 64, 1, usage=0)
>[  9104.357] kgem_can_create_2d: 32x64 @ 1
>[  9104.357] kgem_can_create_2d: unhandled depth 1
>[  9104.357] sna_create_pixmap: can not use GPU, just creating shadow
>[  9104.357] create_pixmap: allocating pixmap 32x64, depth=1, size=264
>[  9104.357] create_pixmap: serial=13078, usage=0, 32x64
>[  9104.357] sna_validate_gc changes=7fffff, previous serial=80000000, drawable=3317
>[  9104.357] sna_validate_gc: recomputing clip
>[  9104.357] sna_validate_gc: composite clip=1x[(0, 0), (32, 64)]
>[  9104.357] sna_put_image((0, 0)x(32, 64), depth=1, format=2)
>[  9104.357] sna_put_image: fallback -- unattached(0, 0, 32, 64)
>[  9104.357] sna_put_image: fallback
>[  9104.357] sna_gc_move_to_cpu, changes=7fffff
>[  9104.357] sna_gc_move_to_cpu: flushing stipple pixmap
>[  9104.357] sna_validate_pixmap: target bpp=1, source bpp=1
>[  9104.357] sna_validate_pixmap: flushing pixmap
>[  9104.357] sfbValidateGC changes=77ffff
>[  9104.357] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000000, bg=00000001, planemask=ffffffff
>[  9104.357] sfbValidateGC: rrop fg=00000000, bg=ffffffff, pm=ffffffff, and=00000000, xor=00000000, bgand=00000000, bgxor=ffffffff
>[  9104.357] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  9104.357] sna_drawable_move_region_to_cpu(pixmap=13079 (32x64), [(0, 0), (32, 64)], flags=5)
>[  9104.358] sna_drawable_move_region_to_cpu: not attached to 0x25c8da0
>[  9104.358] sna_put_image: fbPutImage(0, 0, 32, 64)
>[  9104.358] sfbPutImage (0, 0)x(32, 64)
>[  9104.358] fbClipBoxes: box=(0, 0),(32, 64); region=(0, 0),(32, 64) x 1
>[  9104.358] fbDrawableRun: box=(0, 0), (32, 64), clip=(0, 0), (32, 64)
>[  9104.358] sfbBlt 32x64, alu=3, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  9104.358] sfbBlt fast blt, src_stride=4, dst_stride=4, width=4 (offset=-1038712)
>[  9104.358] sna_create_pixmap(32, 32, 1, usage=0)
>[  9104.358] kgem_can_create_2d: 32x32 @ 1
>[  9104.358] kgem_can_create_2d: unhandled depth 1
>[  9104.358] sna_create_pixmap: can not use GPU, just creating shadow
>[  9104.358] create_pixmap: allocating pixmap 32x32, depth=1, size=136
>[  9104.358] create_pixmap: serial=13080, usage=0, 32x32
>[  9104.358] sna_create_pixmap(32, 32, 1, usage=0)
>[  9104.358] kgem_can_create_2d: 32x32 @ 1
>[  9104.358] kgem_can_create_2d: unhandled depth 1
>[  9104.358] sna_create_pixmap: can not use GPU, just creating shadow
>[  9104.358] create_pixmap: allocating pixmap 32x32, depth=1, size=136
>[  9104.358] create_pixmap: serial=13082, usage=0, 32x32
>[  9104.359] sna_validate_gc changes=7fffff, previous serial=80000000, drawable=3319
>[  9104.359] sna_validate_gc: recomputing clip
>[  9104.359] sna_validate_gc: composite clip=1x[(0, 0), (32, 32)]
>[  9104.359] sna_copy_area: src=(0, 0)x(32, 32)+(0, 0) -> dst=(0, 0)+(0, 0); alu=3, pm=ffffffffffffffff, depth=1
>[  9104.359] sna_do_copy: src=(0, 0), dst=(0, 0), size=(32x32)
>[  9104.359] sna_do_copy: after drawable: src=(0, 0), dst=(0, 0), size=(32x32)
>[  9104.359] sna_do_copy: dst extents (0, 0), (32, 32), dst clip extents (0, 0), (32, 32), dst size=32x32
>[  9104.359] sna_do_copy: clipped dst extents (0, 0), (32, 32)
>[  9104.359] sna_do_copy: unclipped src extents (0, 0), (32, 32)
>[  9104.359] sna_do_copy: pixmap -- no source clipping
>[  9104.359] sna_do_copy: src extents (0, 0), (32, 32) x 1
>[  9104.359] sna_do_copy: copy region (0, 0), (32, 32) x 1
>[  9104.359] sna_fallback_copy_boxes (boxes=1x[(0, 0), (32, 32)...], src=+(0, 0), alu=3
>[  9104.359] sna_gc_move_to_cpu, changes=7fffff
>[  9104.359] sna_gc_move_to_cpu: flushing stipple pixmap
>[  9104.359] sna_validate_pixmap: target bpp=1, source bpp=1
>[  9104.359] sna_validate_pixmap: flushing pixmap
>[  9104.360] sfbValidateGC changes=77ffff
>[  9104.360] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000000, bg=00000001, planemask=ffffffff
>[  9104.360] sfbValidateGC: rrop fg=00000000, bg=ffffffff, pm=ffffffff, and=00000000, xor=00000000, bgand=00000000, bgxor=ffffffff
>[  9104.360] sna_drawable_move_region_to_cpu(pixmap=13079 (32x64), [(0, 0), (32, 32)], flags=2)
>[  9104.360] sna_drawable_move_region_to_cpu: not attached to 0x25c8da0
>[  9104.360] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  9104.360] sna_drawable_move_region_to_cpu(pixmap=13081 (32x32), [(0, 0), (32, 32)], flags=5)
>[  9104.360] sna_drawable_move_region_to_cpu: not attached to 0x25ca4d0
>[  9104.360] sfbBlt 32x32, alu=3, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  9104.360] sfbBlt fast blt, src_stride=4, dst_stride=4, width=4 (offset=-5936)
>[  9104.360] sna_validate_gc changes=0, previous serial=0, drawable=331b
>[  9104.360] sna_validate_gc: recomputing clip
>[  9104.360] sna_validate_gc: composite clip=1x[(0, 0), (32, 32)]
>[  9104.360] sna_copy_area: src=(0, 0)x(32, 32)+(0, 0) -> dst=(0, 0)+(0, 0); alu=3, pm=ffffffffffffffff, depth=1
>[  9104.360] sna_do_copy: src=(0, 0), dst=(0, 0), size=(32x32)
>[  9104.360] sna_do_copy: after drawable: src=(0, 0), dst=(0, 0), size=(32x32)
>[  9104.360] sna_do_copy: dst extents (0, 0), (32, 32), dst clip extents (0, 0), (32, 32), dst size=32x32
>[  9104.360] sna_do_copy: clipped dst extents (0, 0), (32, 32)
>[  9104.360] sna_do_copy: unclipped src extents (0, 0), (32, 32)
>[  9104.360] sna_do_copy: pixmap -- no source clipping
>[  9104.360] sna_do_copy: src extents (0, 0), (32, 32) x 1
>[  9104.361] sna_do_copy: copy region (0, 0), (32, 32) x 1
>[  9104.361] sna_fallback_copy_boxes (boxes=1x[(0, 0), (32, 32)...], src=+(0, 0), alu=3
>[  9104.361] sna_gc_move_to_cpu, changes=0
>[  9104.361] sfbValidateGC changes=0
>[  9104.361] sna_drawable_move_region_to_cpu(pixmap=13079 (32x64), [(0, 0), (32, 32)], flags=2)
>[  9104.361] sna_drawable_move_region_to_cpu: not attached to 0x25c8da0
>[  9104.361] drawable_gc_flags: try operating on drawable inplace [hint? 1]
>[  9104.361] sna_drawable_move_region_to_cpu(pixmap=13083 (32x32), [(0, 0), (32, 32)], flags=5)
>[  9104.361] sna_drawable_move_region_to_cpu: not attached to 0x25c8f30
>[  9104.361] sfbBlt 32x32, alu=3, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  9104.361] sfbBlt fast blt, src_stride=4, dst_stride=4, width=4 (offset=-400)
>[  9104.361] sna_validate_gc changes=1, previous serial=80003319, drawable=3319
>[  9104.361] sna_copy_area: src=(0, 32)x(32, 32)+(0, 0) -> dst=(0, 0)+(0, 0); alu=2, pm=ffffffffffffffff, depth=1
>[  9104.361] sna_do_copy: src=(0, 32), dst=(0, 0), size=(32x32)
>[  9104.361] sna_do_copy: after drawable: src=(0, 32), dst=(0, 0), size=(32x32)
>[  9104.361] sna_do_copy: dst extents (0, 0), (32, 32), dst clip extents (0, 0), (32, 32), dst size=32x32
>[  9104.361] sna_do_copy: clipped dst extents (0, 0), (32, 32)
>[  9104.361] sna_do_copy: unclipped src extents (0, 32), (32, 64)
>[  9104.361] sna_do_copy: pixmap -- no source clipping
>[  9104.361] sna_do_copy: src extents (0, 32), (32, 64) x 1
>[  9104.361] sna_do_copy: copy region (0, 0), (32, 32) x 1
>[  9104.361] sna_fallback_copy_boxes (boxes=1x[(0, 0), (32, 32)...], src=+(0, 32), alu=2
>[  9104.361] sna_gc_move_to_cpu, changes=1
>[  9104.361] sfbValidateGC changes=1
>[  9104.361] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000000, bg=00000001, planemask=ffffffff
>[  9104.361] sfbValidateGC: rrop fg=00000000, bg=ffffffff, pm=ffffffff, and=00000000, xor=00000000, bgand=ffffffff, bgxor=ffffffff
>[  9104.361] sna_drawable_move_region_to_cpu(pixmap=13079 (32x64), [(0, 32), (32, 64)], flags=2)
>[  9104.361] sna_drawable_move_region_to_cpu: not attached to 0x25c8da0
>[  9104.361] drawable_gc_flags: read due to rrop 2:0
>[  9104.361] sna_drawable_move_region_to_cpu(pixmap=13081 (32x32), [(0, 0), (32, 32)], flags=3)
>[  9104.361] sna_drawable_move_region_to_cpu: not attached to 0x25ca4d0
>[  9104.361] sfbBlt 32x32, alu=2, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  9104.361] sna_block_handler (tv=0.000000)
>[  9104.362] sna_wakeup_handler
>[  9104.362] sna_accel_wakeup_handler: nbatch=0, need_retire=0, need_purge=0
>[  9104.362] sna_validate_gc changes=1, previous serial=8000331b, drawable=331b
>[  9104.362] sna_copy_area: src=(0, 32)x(32, 32)+(0, 0) -> dst=(0, 0)+(0, 0); alu=11, pm=ffffffffffffffff, depth=1
>[  9104.362] sna_do_copy: src=(0, 32), dst=(0, 0), size=(32x32)
>[  9104.362] sna_do_copy: after drawable: src=(0, 32), dst=(0, 0), size=(32x32)
>[  9104.362] sna_do_copy: dst extents (0, 0), (32, 32), dst clip extents (0, 0), (32, 32), dst size=32x32
>[  9104.362] sna_do_copy: clipped dst extents (0, 0), (32, 32)
>[  9104.362] sna_do_copy: unclipped src extents (0, 32), (32, 64)
>[  9104.362] sna_do_copy: pixmap -- no source clipping
>[  9104.362] sna_do_copy: src extents (0, 32), (32, 64) x 1
>[  9104.362] sna_do_copy: copy region (0, 0), (32, 32) x 1
>[  9104.362] sna_fallback_copy_boxes (boxes=1x[(0, 0), (32, 32)...], src=+(0, 32), alu=11
>[  9104.362] sna_gc_move_to_cpu, changes=1
>[  9104.362] sfbValidateGC changes=1
>[  9104.362] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000000, bg=00000001, planemask=ffffffff
>[  9104.362] sfbValidateGC: rrop fg=00000000, bg=ffffffff, pm=ffffffff, and=ffffffff, xor=ffffffff, bgand=00000000, bgxor=ffffffff
>[  9104.362] sna_drawable_move_region_to_cpu(pixmap=13079 (32x64), [(0, 32), (32, 64)], flags=2)
>[  9104.362] sna_drawable_move_region_to_cpu: not attached to 0x25c8da0
>[  9104.362] drawable_gc_flags: read due to rrop 11:ffffffff
>[  9104.362] sna_drawable_move_region_to_cpu(pixmap=13083 (32x32), [(0, 0), (32, 32)], flags=3)
>[  9104.362] sna_drawable_move_region_to_cpu: not attached to 0x25c8f30
>[  9104.362] sfbBlt 32x32, alu=11, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  9104.362] sna_validate_gc changes=1, previous serial=80003319, drawable=3317
>[  9104.362] sna_validate_gc: recomputing clip
>[  9104.362] sna_validate_gc: composite clip=1x[(0, 0), (32, 64)]
>[  9104.362] sna_copy_area: src=(0, 32)x(32, 32)+(0, 0) -> dst=(0, 0)+(0, 0); alu=1, pm=ffffffffffffffff, depth=1
>[  9104.362] sna_do_copy: src=(0, 32), dst=(0, 0), size=(32x32)
>[  9104.362] sna_do_copy: after drawable: src=(0, 32), dst=(0, 0), size=(32x32)
>[  9104.362] sna_do_copy: dst extents (0, 0), (32, 32), dst clip extents (0, 0), (32, 64), dst size=32x64
>[  9104.362] sna_do_copy: clipped dst extents (0, 0), (32, 32)
>[  9104.363] sna_do_copy: unclipped src extents (0, 32), (32, 64)
>[  9104.363] sna_do_copy: pixmap -- using gc clip
>[  9104.363] sna_do_copy: src extents (0, 32), (32, 64) x 1
>[  9104.363] sna_do_copy: copy region (0, 0), (32, 32) x 1
>[  9104.363] sna_fallback_copy_boxes (boxes=1x[(0, 0), (32, 32)...], src=+(0, 32), alu=1
>[  9104.363] sna_gc_move_to_cpu, changes=1
>[  9104.363] sfbValidateGC changes=1
>[  9104.363] sfbValidateGC: computing rrop mask=00000001, depthMask=00000001, fg=00000000, bg=00000001, planemask=ffffffff
>[  9104.363] sfbValidateGC: rrop fg=00000000, bg=ffffffff, pm=ffffffff, and=00000000, xor=00000000, bgand=ffffffff, bgxor=00000000
>[  9104.363] sna_drawable_move_region_to_cpu(pixmap=13079 (32x64), [(0, 32), (32, 64)], flags=2)
>[  9104.363] sna_drawable_move_region_to_cpu: not attached to 0x25c8da0
>[  9104.363] sna_fallback_copy_boxes: self-copy
>[  9104.363] _sna_pixmap_move_to_cpu(pixmap=13079, 32x64, flags=3)
>[  9104.363] _sna_pixmap_move_to_cpu: not attached
>[  9104.363] sfbBlt 32x32, alu=1, pm=ffffffff, bpp=1 (reverse=0, upsidedown=0)
>[  9104.363] sna_validate_gc changes=1, previous serial=8000331b, drawable=331b

Actions: View

Attachments on bug 73856: 92496 | 92516 | 92550

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.