[   217.413] __kgem_bo_clear_busy: handle=65333
[   217.413] __kgem_bo_clear_busy: handle=65334
[   217.414] __kgem_bo_clear_busy: handle=65335
[   217.414] __kgem_bo_clear_busy: handle=65336
[   217.414] __kgem_bo_clear_busy: handle=65337
[   217.414] __kgem_bo_clear_busy: handle=65338
[   217.416] __kgem_bo_map__cpu: failed to mmap handle=65340 (prime? 0), 65536 bytes, into CPU domain: 12
[   217.416] kgem_new_batch: unable to map batch bo, mallocing(size=65536)
[   217.416] _kgem_bo_destroy: handle=65340, proxy? 0
[   217.416] __kgem_bo_destroy: handle=65340, size=65536
[   217.416] __kgem_bo_destroy: handle=65340, purged
[   217.416] kgem_bo_move_to_inactive: moving handle=65340 to inactive
[   217.416] kgem_new_batch: using last batch handle=65339
[   217.416] kgem_commit: release handle=65339 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=15fd9000
[   217.416] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.416] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.416] sna_accel_flush: flush?=0, dirty?=0
[   217.416] sna_accel_flush: flush?=0, dirty?=0
[   217.416] sna_block_handler (tv=0.0)
[   217.416] sna_wakeup_handler
[   217.416] sna_accel_flush: flush?=0, dirty?=0
[   217.416] sna_accel_flush: flush?=0, dirty?=0
[   217.416] sna_accel_flush: flush?=0, dirty?=0
[   217.416] sna_accel_flush: flush?=0, dirty?=0
[   217.416] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.417] sna_covering_crtc for box=(0, 0), (1366, 768)
[   217.417] sna_covering_crtc: have PrimaryOutput? 1 marking as desired
[   217.417] sna_box_intersect: (0, 0), (1366, 768) intersect (0, 0), (1366, 768) = (0, 0), (1366, 768)
[   217.417] sna_covering_crtc: box overlaps desired crtc: (0, 0), (1366, 768)
[   217.417] sna_dri2_schedule_wait_msc(pipe=0, target_msc=0, divisor=1, rem=0)
[   217.417] sna_wait_vblank(pipe=0, waiting until seq=0 [relative])
[   217.417] sna_crtc_record_swap: recording last swap on pipe=0, frame 13021 [32dd], time 217.405242
[   217.417] sna_dri2_add_event: adding event to window 6291466)
[   217.417] sna_dri2_schedule_wait_msc: missed target, queueing event for next: current=13021, target=0, divisor=1, remainder=0
[   217.417] draw_target_seq: converting target_msc=13022 to seq 13022
[   217.417] sna_wait_vblank(pipe=0, waiting until seq=13022)
[   217.417] sna_accel_flush: flush?=0, dirty?=0
[   217.418] sna_block_handler (tv=0.0)
[   217.418] sna_wakeup_handler
[   217.418] sna_copy_area: src=pixmap=1586:(0, 0)x(5, 20)+(0, 0) -> dst=pixmap=1170:(382, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.418] sna_copy_area: normal copy
[   217.418] sna_do_copy: src=(0, 0), dst=(382, 641), size=(5x20)
[   217.418] sna_do_copy: after drawable: src=(0, 0), dst=(382, 697), size=(5x20)
[   217.418] sna_do_copy: dst extents (382, 697), (387, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.418] sna_do_copy: clipped dst extents (382, 697), (387, 717)
[   217.418] sna_do_copy: unclipped src extents (0, 0), (5, 20)
[   217.418] sna_do_copy: clipped src extents (0, 0), (5, 20)
[   217.418] sna_do_copy: pixmap -- no source clipping
[   217.418] sna_do_copy: src extents (0, 0), (5, 20) x 1
[   217.418] sna_do_copy: copy region (382, 697), (387, 717) x 1 + (-382, -697)
[   217.418] sna_copy_boxes (boxes=1x[(382, 697), (387, 717)...], src pixmap=1586+(-382, -697), dst pixmap=1170+(0, -19), alu=3, src.size=5x20, dst.size=1366x749)
[   217.418] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bcaa80, gpu_bo=0, cpu_bo=0), replaces=0
[   217.418] sna_drawable_use_bo pixmap=1170, box=((382, 678), (387, 698)), flags=8...
[   217.418] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.418] sna_drawable_use_bo: pinned, never REPLACES
[   217.418] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.418] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.418] sna_drawable_use_bo: using whole GPU bo
[   217.418] region_overlaps_damage?
[   217.418] use_shm_bo: no, not attached
[   217.418] sna_drawable_move_region_to_cpu(pixmap=1586 (5x20), [(0, 0), (5, 20)], flags=2)
[   217.418] sna_drawable_move_region_to_cpu: pixmap=1586 all damaged on CPU
[   217.418] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.418] sna_write_boxes x 1, src stride=20,  src dx=(-382, -678)
[   217.418] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.418] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.418] __kgem_busy: handle=112, busy=1, wedged=0
[   217.418] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.418] kgem_create_buffer: size=400, flags=3 [write?=1, inplace?=1, last?=0]
[   217.418] kgem_create_buffer: reusing buffer? used=118784 + size=400, total=262144
[   217.418] kgem_create_proxy: target handle=65310 [proxy? -1], offset=118784, length=400, io=1
[   217.418] __kgem_bo_init(handle=65310, num_pages=400)
[   217.418]   sna_write_boxes: box src=(0, 0), dst=(382, 678) size=(5, 20), dst offset=0, dst pitch=20
[   217.418] memcpy_blt: src=(0, 0), dst=(0, 0), size=5x20, pitch=20/20
[   217.418] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.418] kgem_add_handle: handle=112, index=0
[   217.418] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.418] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.419] kgem_add_reloc: adding proxy [delta=118784] for handle=65310
[   217.419] kgem_add_handle: handle=65310, index=1
[   217.419] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.419] sna_accel_flush: flush?=1, dirty?=0
[   217.419] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.419] kgem_finish_buffers: buffer handle=65310, used=119296, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.419] kgem_finish_buffers: retaining upload buffer (119296/262144): used=122880, refcnt=1
[   217.419] kgem_commit: release handle=2 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=15fe9000
[   217.419] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.419] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.419] sna_accel_flush: flush?=0, dirty?=0
[   217.419] sna_copy_area: src=pixmap=1718:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(387, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.419] sna_copy_area: normal copy
[   217.419] sna_do_copy: src=(0, 0), dst=(387, 641), size=(8x20)
[   217.419] sna_do_copy: after drawable: src=(0, 0), dst=(387, 697), size=(8x20)
[   217.419] sna_do_copy: dst extents (387, 697), (395, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.419] sna_do_copy: clipped dst extents (387, 697), (395, 717)
[   217.419] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.419] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.419] sna_do_copy: pixmap -- no source clipping
[   217.419] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.419] sna_do_copy: copy region (387, 697), (395, 717) x 1 + (-387, -697)
[   217.419] sna_copy_boxes (boxes=1x[(387, 697), (395, 717)...], src pixmap=1718+(-387, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.419] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf4560, gpu_bo=0, cpu_bo=0), replaces=0
[   217.419] sna_drawable_use_bo pixmap=1170, box=((387, 678), (395, 698)), flags=8...
[   217.419] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.419] sna_drawable_use_bo: pinned, never REPLACES
[   217.419] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.419] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.419] sna_drawable_use_bo: using whole GPU bo
[   217.419] region_overlaps_damage?
[   217.419] use_shm_bo: no, not attached
[   217.419] sna_drawable_move_region_to_cpu(pixmap=1718 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.419] sna_drawable_move_region_to_cpu: pixmap=1718 all damaged on CPU
[   217.419] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.419] sna_write_boxes x 1, src stride=32,  src dx=(-387, -678)
[   217.419] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.419] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.419] __kgem_busy: handle=112, busy=1, wedged=0
[   217.419] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.419] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.420] kgem_create_buffer: reusing buffer? used=122880 + size=640, total=262144
[   217.420] kgem_create_proxy: target handle=65310 [proxy? -1], offset=122880, length=640, io=1
[   217.420] __kgem_bo_init(handle=65310, num_pages=640)
[   217.420]   sna_write_boxes: box src=(0, 0), dst=(387, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.420] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.420] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.420] kgem_add_handle: handle=112, index=0
[   217.420] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.420] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.420] kgem_add_reloc: adding proxy [delta=122880] for handle=65310
[   217.420] kgem_add_handle: handle=65310, index=1
[   217.420] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.420] sna_accel_flush: flush?=1, dirty?=0
[   217.420] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.420] kgem_finish_buffers: buffer handle=65310, used=123648, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.420] kgem_finish_buffers: retaining upload buffer (123648/262144): used=126976, refcnt=1
[   217.420] __kgem_busy: handle=2, busy=1, wedged=0
[   217.420] kgem_commit: release handle=3 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=15fea000
[   217.420] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.420] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.420] sna_accel_flush: flush?=0, dirty?=0
[   217.420] sna_copy_area: src=pixmap=1716:(0, 0)x(10, 20)+(0, 0) -> dst=pixmap=1170:(395, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.420] sna_copy_area: normal copy
[   217.420] sna_do_copy: src=(0, 0), dst=(395, 641), size=(10x20)
[   217.420] sna_do_copy: after drawable: src=(0, 0), dst=(395, 697), size=(10x20)
[   217.420] sna_do_copy: dst extents (395, 697), (405, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.420] sna_do_copy: clipped dst extents (395, 697), (405, 717)
[   217.420] sna_do_copy: unclipped src extents (0, 0), (10, 20)
[   217.420] sna_do_copy: clipped src extents (0, 0), (10, 20)
[   217.420] sna_do_copy: pixmap -- no source clipping
[   217.420] sna_do_copy: src extents (0, 0), (10, 20) x 1
[   217.420] sna_do_copy: copy region (395, 697), (405, 717) x 1 + (-395, -697)
[   217.420] sna_copy_boxes (boxes=1x[(395, 697), (405, 717)...], src pixmap=1716+(-395, -697), dst pixmap=1170+(0, -19), alu=3, src.size=10x20, dst.size=1366x749)
[   217.420] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf4b00, gpu_bo=0, cpu_bo=0), replaces=0
[   217.420] sna_drawable_use_bo pixmap=1170, box=((395, 678), (405, 698)), flags=8...
[   217.420] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.420] sna_drawable_use_bo: pinned, never REPLACES
[   217.420] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.420] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.420] sna_drawable_use_bo: using whole GPU bo
[   217.420] region_overlaps_damage?
[   217.421] use_shm_bo: no, not attached
[   217.421] sna_drawable_move_region_to_cpu(pixmap=1716 (10x20), [(0, 0), (10, 20)], flags=2)
[   217.421] sna_drawable_move_region_to_cpu: pixmap=1716 all damaged on CPU
[   217.421] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.421] sna_write_boxes x 1, src stride=40,  src dx=(-395, -678)
[   217.421] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.421] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.421] __kgem_busy: handle=112, busy=1, wedged=0
[   217.421] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.421] kgem_create_buffer: size=800, flags=3 [write?=1, inplace?=1, last?=0]
[   217.421] kgem_create_buffer: reusing buffer? used=126976 + size=800, total=262144
[   217.421] kgem_create_proxy: target handle=65310 [proxy? -1], offset=126976, length=800, io=1
[   217.421] __kgem_bo_init(handle=65310, num_pages=800)
[   217.421]   sna_write_boxes: box src=(0, 0), dst=(395, 678) size=(10, 20), dst offset=0, dst pitch=40
[   217.421] memcpy_blt: src=(0, 0), dst=(0, 0), size=10x20, pitch=40/40
[   217.421] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.421] kgem_add_handle: handle=112, index=0
[   217.421] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.421] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.421] kgem_add_reloc: adding proxy [delta=126976] for handle=65310
[   217.421] kgem_add_handle: handle=65310, index=1
[   217.421] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.421] sna_accel_flush: flush?=1, dirty?=0
[   217.421] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.421] kgem_finish_buffers: buffer handle=65310, used=128000, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.421] kgem_finish_buffers: retaining upload buffer (128000/262144): used=131072, refcnt=1
[   217.421] __kgem_busy: handle=2, busy=1, wedged=0
[   217.421] __kgem_busy: handle=3, busy=1, wedged=0
[   217.421] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.421] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.421] sna_accel_flush: flush?=0, dirty?=0
[   217.421] sna_copy_area: src=pixmap=1722:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(405, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.421] sna_copy_area: normal copy
[   217.421] sna_do_copy: src=(0, 0), dst=(405, 641), size=(8x20)
[   217.421] sna_do_copy: after drawable: src=(0, 0), dst=(405, 697), size=(8x20)
[   217.421] sna_do_copy: dst extents (405, 697), (413, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.421] sna_do_copy: clipped dst extents (405, 697), (413, 717)
[   217.421] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.421] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.421] sna_do_copy: pixmap -- no source clipping
[   217.421] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.421] sna_do_copy: copy region (405, 697), (413, 717) x 1 + (-405, -697)
[   217.422] sna_copy_boxes (boxes=1x[(405, 697), (413, 717)...], src pixmap=1722+(-405, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.422] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf6220, gpu_bo=0, cpu_bo=0), replaces=0
[   217.422] sna_drawable_use_bo pixmap=1170, box=((405, 678), (413, 698)), flags=8...
[   217.422] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.422] sna_drawable_use_bo: pinned, never REPLACES
[   217.422] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.422] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.422] sna_drawable_use_bo: using whole GPU bo
[   217.422] region_overlaps_damage?
[   217.422] use_shm_bo: no, not attached
[   217.422] sna_drawable_move_region_to_cpu(pixmap=1722 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.422] sna_drawable_move_region_to_cpu: pixmap=1722 all damaged on CPU
[   217.422] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.422] sna_write_boxes x 1, src stride=32,  src dx=(-405, -678)
[   217.422] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.422] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.422] __kgem_busy: handle=112, busy=1, wedged=0
[   217.422] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.422] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.422] kgem_create_buffer: reusing buffer? used=131072 + size=640, total=262144
[   217.422] kgem_create_proxy: target handle=65310 [proxy? -1], offset=131072, length=640, io=1
[   217.422] __kgem_bo_init(handle=65310, num_pages=640)
[   217.422]   sna_write_boxes: box src=(0, 0), dst=(405, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.422] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.422] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.422] kgem_add_handle: handle=112, index=0
[   217.422] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.422] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.422] kgem_add_reloc: adding proxy [delta=131072] for handle=65310
[   217.422] kgem_add_handle: handle=65310, index=1
[   217.422] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.422] sna_accel_flush: flush?=1, dirty?=0
[   217.422] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.422] kgem_finish_buffers: buffer handle=65310, used=131840, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.422] kgem_finish_buffers: retaining upload buffer (131840/262144): used=135168, refcnt=1
[   217.422] __kgem_busy: handle=2, busy=1, wedged=0
[   217.422] __kgem_busy: handle=3, busy=1, wedged=0
[   217.422] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.422] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.422] sna_accel_flush: flush?=0, dirty?=0
[   217.422] sna_copy_area: src=pixmap=1624:(0, 0)x(10, 20)+(0, 0) -> dst=pixmap=1170:(413, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.422] sna_copy_area: normal copy
[   217.423] sna_do_copy: src=(0, 0), dst=(413, 641), size=(10x20)
[   217.423] sna_do_copy: after drawable: src=(0, 0), dst=(413, 697), size=(10x20)
[   217.423] sna_do_copy: dst extents (413, 697), (423, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.423] sna_do_copy: clipped dst extents (413, 697), (423, 717)
[   217.423] sna_do_copy: unclipped src extents (0, 0), (10, 20)
[   217.423] sna_do_copy: clipped src extents (0, 0), (10, 20)
[   217.423] sna_do_copy: pixmap -- no source clipping
[   217.423] sna_do_copy: src extents (0, 0), (10, 20) x 1
[   217.423] sna_do_copy: copy region (413, 697), (423, 717) x 1 + (-413, -697)
[   217.423] sna_copy_boxes (boxes=1x[(413, 697), (423, 717)...], src pixmap=1624+(-413, -697), dst pixmap=1170+(0, -19), alu=3, src.size=10x20, dst.size=1366x749)
[   217.423] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd2830, gpu_bo=0, cpu_bo=0), replaces=0
[   217.423] sna_drawable_use_bo pixmap=1170, box=((413, 678), (423, 698)), flags=8...
[   217.423] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.423] sna_drawable_use_bo: pinned, never REPLACES
[   217.423] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.423] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.423] sna_drawable_use_bo: using whole GPU bo
[   217.423] region_overlaps_damage?
[   217.423] use_shm_bo: no, not attached
[   217.423] sna_drawable_move_region_to_cpu(pixmap=1624 (10x20), [(0, 0), (10, 20)], flags=2)
[   217.423] sna_drawable_move_region_to_cpu: pixmap=1624 all damaged on CPU
[   217.423] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.423] sna_write_boxes x 1, src stride=40,  src dx=(-413, -678)
[   217.423] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.423] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.423] __kgem_busy: handle=112, busy=1, wedged=0
[   217.423] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.423] kgem_create_buffer: size=800, flags=3 [write?=1, inplace?=1, last?=0]
[   217.423] kgem_create_buffer: reusing buffer? used=135168 + size=800, total=262144
[   217.423] kgem_create_proxy: target handle=65310 [proxy? -1], offset=135168, length=800, io=1
[   217.423] __kgem_bo_init(handle=65310, num_pages=800)
[   217.423]   sna_write_boxes: box src=(0, 0), dst=(413, 678) size=(10, 20), dst offset=0, dst pitch=40
[   217.423] memcpy_blt: src=(0, 0), dst=(0, 0), size=10x20, pitch=40/40
[   217.423] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.423] kgem_add_handle: handle=112, index=0
[   217.423] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.423] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.423] kgem_add_reloc: adding proxy [delta=135168] for handle=65310
[   217.423] kgem_add_handle: handle=65310, index=1
[   217.423] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.423] sna_accel_flush: flush?=1, dirty?=0
[   217.423] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.423] kgem_finish_buffers: buffer handle=65310, used=136192, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.424] kgem_finish_buffers: retaining upload buffer (136192/262144): used=139264, refcnt=1
[   217.424] __kgem_busy: handle=2, busy=1, wedged=0
[   217.424] __kgem_busy: handle=3, busy=1, wedged=0
[   217.424] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.424] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.424] sna_accel_flush: flush?=0, dirty?=0
[   217.424] sna_accel_flush: flush?=0, dirty?=0
[   217.424] sna_block_handler (tv=0.0)
[   217.424] sna_wakeup_handler
[   217.424] sna_mode_wakeup: len=32
[   217.424] sna_dri2_vblank_handler(type=0, sequence=13022)
[   217.424] sna_crtc_record_swap: recording last swap on pipe=0, frame 13022 [32de], time 217.421905
[   217.424] sna_accel_flush: flush?=0, dirty?=0
[   217.424] sna_dri2_event_free(draw?=1)
[   217.424] sna_dri2_remove_event: remove[0x38de620] from window 6291466, active? 1
[   217.424] sna_dri2_vblank_handler complete
[   217.424] sna_copy_area: src=pixmap=1734:(0, 0)x(5, 20)+(0, 0) -> dst=pixmap=1170:(423, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.424] sna_copy_area: normal copy
[   217.424] sna_do_copy: src=(0, 0), dst=(423, 641), size=(5x20)
[   217.424] sna_do_copy: after drawable: src=(0, 0), dst=(423, 697), size=(5x20)
[   217.424] sna_do_copy: dst extents (423, 697), (428, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.424] sna_do_copy: clipped dst extents (423, 697), (428, 717)
[   217.424] sna_do_copy: unclipped src extents (0, 0), (5, 20)
[   217.424] sna_do_copy: clipped src extents (0, 0), (5, 20)
[   217.424] sna_do_copy: pixmap -- no source clipping
[   217.424] sna_do_copy: src extents (0, 0), (5, 20) x 1
[   217.424] sna_do_copy: copy region (423, 697), (428, 717) x 1 + (-423, -697)
[   217.424] sna_copy_boxes (boxes=1x[(423, 697), (428, 717)...], src pixmap=1734+(-423, -697), dst pixmap=1170+(0, -19), alu=3, src.size=5x20, dst.size=1366x749)
[   217.424] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf90a0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.424] sna_drawable_use_bo pixmap=1170, box=((423, 678), (428, 698)), flags=8...
[   217.424] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.424] sna_drawable_use_bo: pinned, never REPLACES
[   217.424] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.424] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.424] sna_drawable_use_bo: using whole GPU bo
[   217.424] region_overlaps_damage?
[   217.424] use_shm_bo: no, not attached
[   217.424] sna_drawable_move_region_to_cpu(pixmap=1734 (5x20), [(0, 0), (5, 20)], flags=2)
[   217.424] sna_drawable_move_region_to_cpu: pixmap=1734 all damaged on CPU
[   217.424] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.424] sna_write_boxes x 1, src stride=20,  src dx=(-423, -678)
[   217.425] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.425] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.425] __kgem_busy: handle=112, busy=1, wedged=0
[   217.425] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.425] kgem_create_buffer: size=400, flags=3 [write?=1, inplace?=1, last?=0]
[   217.425] kgem_create_buffer: reusing buffer? used=139264 + size=400, total=262144
[   217.425] kgem_create_proxy: target handle=65310 [proxy? -1], offset=139264, length=400, io=1
[   217.425] __kgem_bo_init(handle=65310, num_pages=400)
[   217.425]   sna_write_boxes: box src=(0, 0), dst=(423, 678) size=(5, 20), dst offset=0, dst pitch=20
[   217.425] memcpy_blt: src=(0, 0), dst=(0, 0), size=5x20, pitch=20/20
[   217.425] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.425] kgem_add_handle: handle=112, index=0
[   217.425] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.425] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.425] kgem_add_reloc: adding proxy [delta=139264] for handle=65310
[   217.425] kgem_add_handle: handle=65310, index=1
[   217.425] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.425] sna_accel_flush: flush?=1, dirty?=0
[   217.425] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.425] kgem_finish_buffers: buffer handle=65310, used=139776, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.425] kgem_finish_buffers: retaining upload buffer (139776/262144): used=143360, refcnt=1
[   217.425] __kgem_busy: handle=2, busy=1, wedged=0
[   217.425] __kgem_busy: handle=3, busy=1, wedged=0
[   217.425] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.425] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.425] sna_accel_flush: flush?=0, dirty?=0
[   217.425] sna_copy_area: src=pixmap=1736:(0, 0)x(10, 20)+(0, 0) -> dst=pixmap=1170:(428, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.425] sna_copy_area: normal copy
[   217.425] sna_do_copy: src=(0, 0), dst=(428, 641), size=(10x20)
[   217.425] sna_do_copy: after drawable: src=(0, 0), dst=(428, 697), size=(10x20)
[   217.425] sna_do_copy: dst extents (428, 697), (438, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.425] sna_do_copy: clipped dst extents (428, 697), (438, 717)
[   217.425] sna_do_copy: unclipped src extents (0, 0), (10, 20)
[   217.425] sna_do_copy: clipped src extents (0, 0), (10, 20)
[   217.425] sna_do_copy: pixmap -- no source clipping
[   217.425] sna_do_copy: src extents (0, 0), (10, 20) x 1
[   217.425] sna_do_copy: copy region (428, 697), (438, 717) x 1 + (-428, -697)
[   217.425] sna_copy_boxes (boxes=1x[(428, 697), (438, 717)...], src pixmap=1736+(-428, -697), dst pixmap=1170+(0, -19), alu=3, src.size=10x20, dst.size=1366x749)
[   217.425] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf9120, gpu_bo=0, cpu_bo=0), replaces=0
[   217.425] sna_drawable_use_bo pixmap=1170, box=((428, 678), (438, 698)), flags=8...
[   217.425] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.425] sna_drawable_use_bo: pinned, never REPLACES
[   217.426] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.426] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.426] sna_drawable_use_bo: using whole GPU bo
[   217.426] region_overlaps_damage?
[   217.426] use_shm_bo: no, not attached
[   217.426] sna_drawable_move_region_to_cpu(pixmap=1736 (10x20), [(0, 0), (10, 20)], flags=2)
[   217.426] sna_drawable_move_region_to_cpu: pixmap=1736 all damaged on CPU
[   217.426] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.426] sna_write_boxes x 1, src stride=40,  src dx=(-428, -678)
[   217.426] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.426] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.426] __kgem_busy: handle=112, busy=1, wedged=0
[   217.426] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.426] kgem_create_buffer: size=800, flags=3 [write?=1, inplace?=1, last?=0]
[   217.426] kgem_create_buffer: reusing buffer? used=143360 + size=800, total=262144
[   217.426] kgem_create_proxy: target handle=65310 [proxy? -1], offset=143360, length=800, io=1
[   217.426] __kgem_bo_init(handle=65310, num_pages=800)
[   217.426]   sna_write_boxes: box src=(0, 0), dst=(428, 678) size=(10, 20), dst offset=0, dst pitch=40
[   217.426] memcpy_blt: src=(0, 0), dst=(0, 0), size=10x20, pitch=40/40
[   217.426] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.426] kgem_add_handle: handle=112, index=0
[   217.426] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.426] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.426] kgem_add_reloc: adding proxy [delta=143360] for handle=65310
[   217.426] kgem_add_handle: handle=65310, index=1
[   217.426] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.426] sna_accel_flush: flush?=1, dirty?=0
[   217.426] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.426] kgem_finish_buffers: buffer handle=65310, used=144384, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.426] kgem_finish_buffers: retaining upload buffer (144384/262144): used=147456, refcnt=1
[   217.426] __kgem_busy: handle=2, busy=1, wedged=0
[   217.426] __kgem_busy: handle=3, busy=1, wedged=0
[   217.426] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.426] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.426] sna_accel_flush: flush?=0, dirty?=0
[   217.426] sna_copy_area: src=pixmap=1586:(0, 0)x(5, 20)+(0, 0) -> dst=pixmap=1170:(438, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.426] sna_copy_area: normal copy
[   217.426] sna_do_copy: src=(0, 0), dst=(438, 641), size=(5x20)
[   217.426] sna_do_copy: after drawable: src=(0, 0), dst=(438, 697), size=(5x20)
[   217.426] sna_do_copy: dst extents (438, 697), (443, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.426] sna_do_copy: clipped dst extents (438, 697), (443, 717)
[   217.426] sna_do_copy: unclipped src extents (0, 0), (5, 20)
[   217.426] sna_do_copy: clipped src extents (0, 0), (5, 20)
[   217.427] sna_do_copy: pixmap -- no source clipping
[   217.427] sna_do_copy: src extents (0, 0), (5, 20) x 1
[   217.427] sna_do_copy: copy region (438, 697), (443, 717) x 1 + (-438, -697)
[   217.427] sna_copy_boxes (boxes=1x[(438, 697), (443, 717)...], src pixmap=1586+(-438, -697), dst pixmap=1170+(0, -19), alu=3, src.size=5x20, dst.size=1366x749)
[   217.427] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bcaa80, gpu_bo=0, cpu_bo=0), replaces=0
[   217.427] sna_drawable_use_bo pixmap=1170, box=((438, 678), (443, 698)), flags=8...
[   217.427] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.427] sna_drawable_use_bo: pinned, never REPLACES
[   217.427] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.427] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.427] sna_drawable_use_bo: using whole GPU bo
[   217.427] region_overlaps_damage?
[   217.427] use_shm_bo: no, not attached
[   217.427] sna_drawable_move_region_to_cpu(pixmap=1586 (5x20), [(0, 0), (5, 20)], flags=2)
[   217.427] sna_drawable_move_region_to_cpu: pixmap=1586 all damaged on CPU
[   217.427] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.427] sna_write_boxes x 1, src stride=20,  src dx=(-438, -678)
[   217.427] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.427] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.427] __kgem_busy: handle=112, busy=1, wedged=0
[   217.427] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.427] kgem_create_buffer: size=400, flags=3 [write?=1, inplace?=1, last?=0]
[   217.427] kgem_create_buffer: reusing buffer? used=147456 + size=400, total=262144
[   217.427] kgem_create_proxy: target handle=65310 [proxy? -1], offset=147456, length=400, io=1
[   217.427] __kgem_bo_init(handle=65310, num_pages=400)
[   217.427]   sna_write_boxes: box src=(0, 0), dst=(438, 678) size=(5, 20), dst offset=0, dst pitch=20
[   217.427] memcpy_blt: src=(0, 0), dst=(0, 0), size=5x20, pitch=20/20
[   217.427] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.427] kgem_add_handle: handle=112, index=0
[   217.427] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.427] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.427] kgem_add_reloc: adding proxy [delta=147456] for handle=65310
[   217.427] kgem_add_handle: handle=65310, index=1
[   217.427] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.427] sna_accel_flush: flush?=1, dirty?=0
[   217.427] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.427] kgem_finish_buffers: buffer handle=65310, used=147968, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.427] kgem_finish_buffers: retaining upload buffer (147968/262144): used=151552, refcnt=1
[   217.427] __kgem_busy: handle=2, busy=1, wedged=0
[   217.427] __kgem_busy: handle=3, busy=1, wedged=0
[   217.427] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.427] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.428] sna_accel_flush: flush?=0, dirty?=0
[   217.428] sna_copy_area: src=pixmap=1616:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(443, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.428] sna_copy_area: normal copy
[   217.428] sna_do_copy: src=(0, 0), dst=(443, 641), size=(8x20)
[   217.428] sna_do_copy: after drawable: src=(0, 0), dst=(443, 697), size=(8x20)
[   217.428] sna_do_copy: dst extents (443, 697), (451, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.428] sna_do_copy: clipped dst extents (443, 697), (451, 717)
[   217.428] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.428] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.428] sna_do_copy: pixmap -- no source clipping
[   217.428] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.428] sna_do_copy: copy region (443, 697), (451, 717) x 1 + (-443, -697)
[   217.428] sna_copy_boxes (boxes=1x[(443, 697), (451, 717)...], src pixmap=1616+(-443, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.428] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd0de0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.428] sna_drawable_use_bo pixmap=1170, box=((443, 678), (451, 698)), flags=8...
[   217.428] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.428] sna_drawable_use_bo: pinned, never REPLACES
[   217.428] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.428] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.428] sna_drawable_use_bo: using whole GPU bo
[   217.428] region_overlaps_damage?
[   217.428] use_shm_bo: no, not attached
[   217.428] sna_drawable_move_region_to_cpu(pixmap=1616 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.428] sna_drawable_move_region_to_cpu: pixmap=1616 all damaged on CPU
[   217.428] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.428] sna_write_boxes x 1, src stride=32,  src dx=(-443, -678)
[   217.428] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.428] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.428] __kgem_busy: handle=112, busy=1, wedged=0
[   217.428] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.428] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.428] kgem_create_buffer: reusing buffer? used=151552 + size=640, total=262144
[   217.428] kgem_create_proxy: target handle=65310 [proxy? -1], offset=151552, length=640, io=1
[   217.428] __kgem_bo_init(handle=65310, num_pages=640)
[   217.428]   sna_write_boxes: box src=(0, 0), dst=(443, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.428] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.428] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.428] kgem_add_handle: handle=112, index=0
[   217.428] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.428] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.428] kgem_add_reloc: adding proxy [delta=151552] for handle=65310
[   217.428] kgem_add_handle: handle=65310, index=1
[   217.429] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.429] sna_accel_flush: flush?=1, dirty?=0
[   217.429] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.429] kgem_finish_buffers: buffer handle=65310, used=152320, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.429] kgem_finish_buffers: retaining upload buffer (152320/262144): used=155648, refcnt=1
[   217.429] __kgem_busy: handle=2, busy=1, wedged=0
[   217.429] __kgem_busy: handle=3, busy=1, wedged=0
[   217.429] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.429] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.429] sna_accel_flush: flush?=0, dirty?=0
[   217.429] sna_copy_area: src=pixmap=1614:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(451, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.429] sna_copy_area: normal copy
[   217.429] sna_do_copy: src=(0, 0), dst=(451, 641), size=(8x20)
[   217.429] sna_do_copy: after drawable: src=(0, 0), dst=(451, 697), size=(8x20)
[   217.429] sna_do_copy: dst extents (451, 697), (459, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.429] sna_do_copy: clipped dst extents (451, 697), (459, 717)
[   217.429] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.429] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.429] sna_do_copy: pixmap -- no source clipping
[   217.429] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.429] sna_do_copy: copy region (451, 697), (459, 717) x 1 + (-451, -697)
[   217.429] sna_copy_boxes (boxes=1x[(451, 697), (459, 717)...], src pixmap=1614+(-451, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.429] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd08c0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.429] sna_drawable_use_bo pixmap=1170, box=((451, 678), (459, 698)), flags=8...
[   217.429] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.429] sna_drawable_use_bo: pinned, never REPLACES
[   217.429] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.429] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.429] sna_drawable_use_bo: using whole GPU bo
[   217.429] region_overlaps_damage?
[   217.429] use_shm_bo: no, not attached
[   217.429] sna_drawable_move_region_to_cpu(pixmap=1614 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.429] sna_drawable_move_region_to_cpu: pixmap=1614 all damaged on CPU
[   217.429] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.429] sna_write_boxes x 1, src stride=32,  src dx=(-451, -678)
[   217.429] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.429] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.429] __kgem_busy: handle=112, busy=1, wedged=0
[   217.429] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.429] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.429] kgem_create_buffer: reusing buffer? used=155648 + size=640, total=262144
[   217.429] kgem_create_proxy: target handle=65310 [proxy? -1], offset=155648, length=640, io=1
[   217.430] __kgem_bo_init(handle=65310, num_pages=640)
[   217.430]   sna_write_boxes: box src=(0, 0), dst=(451, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.430] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.430] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.430] kgem_add_handle: handle=112, index=0
[   217.430] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.430] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.430] kgem_add_reloc: adding proxy [delta=155648] for handle=65310
[   217.430] kgem_add_handle: handle=65310, index=1
[   217.430] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.430] sna_accel_flush: flush?=1, dirty?=0
[   217.430] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.430] kgem_finish_buffers: buffer handle=65310, used=156416, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.430] kgem_finish_buffers: retaining upload buffer (156416/262144): used=159744, refcnt=1
[   217.430] __kgem_busy: handle=2, busy=1, wedged=0
[   217.430] __kgem_busy: handle=3, busy=1, wedged=0
[   217.430] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.430] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.430] sna_accel_flush: flush?=0, dirty?=0
[   217.430] sna_accel_flush: flush?=0, dirty?=0
[   217.430] sna_block_handler (tv=0.0)
[   217.430] sna_wakeup_handler
[   217.430] sna_copy_area: src=pixmap=1720:(0, 0)x(15, 20)+(0, 0) -> dst=pixmap=1170:(459, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.430] sna_copy_area: normal copy
[   217.430] sna_do_copy: src=(0, 0), dst=(459, 641), size=(15x20)
[   217.430] sna_do_copy: after drawable: src=(0, 0), dst=(459, 697), size=(15x20)
[   217.430] sna_do_copy: dst extents (459, 697), (474, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.430] sna_do_copy: clipped dst extents (459, 697), (474, 717)
[   217.430] sna_do_copy: unclipped src extents (0, 0), (15, 20)
[   217.430] sna_do_copy: clipped src extents (0, 0), (15, 20)
[   217.430] sna_do_copy: pixmap -- no source clipping
[   217.430] sna_do_copy: src extents (0, 0), (15, 20) x 1
[   217.430] sna_do_copy: copy region (459, 697), (474, 717) x 1 + (-459, -697)
[   217.430] sna_copy_boxes (boxes=1x[(459, 697), (474, 717)...], src pixmap=1720+(-459, -697), dst pixmap=1170+(0, -19), alu=3, src.size=15x20, dst.size=1366x749)
[   217.430] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf5970, gpu_bo=0, cpu_bo=0), replaces=0
[   217.430] sna_drawable_use_bo pixmap=1170, box=((459, 678), (474, 698)), flags=8...
[   217.430] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.430] sna_drawable_use_bo: pinned, never REPLACES
[   217.430] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.430] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.430] sna_drawable_use_bo: using whole GPU bo
[   217.430] region_overlaps_damage?
[   217.431] use_shm_bo: no, not attached
[   217.431] sna_drawable_move_region_to_cpu(pixmap=1720 (15x20), [(0, 0), (15, 20)], flags=2)
[   217.431] sna_drawable_move_region_to_cpu: pixmap=1720 all damaged on CPU
[   217.431] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.431] sna_write_boxes x 1, src stride=60,  src dx=(-459, -678)
[   217.431] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.431] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.431] __kgem_busy: handle=112, busy=1, wedged=0
[   217.431] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.431] kgem_create_buffer: size=1200, flags=3 [write?=1, inplace?=1, last?=0]
[   217.431] kgem_create_buffer: reusing buffer? used=159744 + size=1200, total=262144
[   217.431] kgem_create_proxy: target handle=65310 [proxy? -1], offset=159744, length=1200, io=1
[   217.431] __kgem_bo_init(handle=65310, num_pages=1200)
[   217.431]   sna_write_boxes: box src=(0, 0), dst=(459, 678) size=(15, 20), dst offset=0, dst pitch=60
[   217.431] memcpy_blt: src=(0, 0), dst=(0, 0), size=15x20, pitch=60/60
[   217.431] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.431] kgem_add_handle: handle=112, index=0
[   217.431] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.431] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.431] kgem_add_reloc: adding proxy [delta=159744] for handle=65310
[   217.431] kgem_add_handle: handle=65310, index=1
[   217.431] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.431] sna_accel_flush: flush?=1, dirty?=0
[   217.431] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.431] kgem_finish_buffers: buffer handle=65310, used=161024, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.431] kgem_finish_buffers: retaining upload buffer (161024/262144): used=163840, refcnt=1
[   217.431] __kgem_busy: handle=2, busy=1, wedged=0
[   217.431] __kgem_busy: handle=3, busy=1, wedged=0
[   217.431] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.431] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.431] sna_accel_flush: flush?=0, dirty?=0
[   217.431] sna_copy_area: src=pixmap=1722:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(474, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.431] sna_copy_area: normal copy
[   217.431] sna_do_copy: src=(0, 0), dst=(474, 641), size=(8x20)
[   217.431] sna_do_copy: after drawable: src=(0, 0), dst=(474, 697), size=(8x20)
[   217.431] sna_do_copy: dst extents (474, 697), (482, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.431] sna_do_copy: clipped dst extents (474, 697), (482, 717)
[   217.431] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.431] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.431] sna_do_copy: pixmap -- no source clipping
[   217.431] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.431] sna_do_copy: copy region (474, 697), (482, 717) x 1 + (-474, -697)
[   217.432] sna_copy_boxes (boxes=1x[(474, 697), (482, 717)...], src pixmap=1722+(-474, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.432] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf6220, gpu_bo=0, cpu_bo=0), replaces=0
[   217.432] sna_drawable_use_bo pixmap=1170, box=((474, 678), (482, 698)), flags=8...
[   217.432] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.432] sna_drawable_use_bo: pinned, never REPLACES
[   217.432] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.432] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.432] sna_drawable_use_bo: using whole GPU bo
[   217.432] region_overlaps_damage?
[   217.432] use_shm_bo: no, not attached
[   217.432] sna_drawable_move_region_to_cpu(pixmap=1722 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.432] sna_drawable_move_region_to_cpu: pixmap=1722 all damaged on CPU
[   217.432] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.432] sna_write_boxes x 1, src stride=32,  src dx=(-474, -678)
[   217.432] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.432] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.432] __kgem_busy: handle=112, busy=1, wedged=0
[   217.432] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.432] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.432] kgem_create_buffer: reusing buffer? used=163840 + size=640, total=262144
[   217.432] kgem_create_proxy: target handle=65310 [proxy? -1], offset=163840, length=640, io=1
[   217.432] __kgem_bo_init(handle=65310, num_pages=640)
[   217.432]   sna_write_boxes: box src=(0, 0), dst=(474, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.432] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.432] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.432] kgem_add_handle: handle=112, index=0
[   217.432] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.432] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.432] kgem_add_reloc: adding proxy [delta=163840] for handle=65310
[   217.432] kgem_add_handle: handle=65310, index=1
[   217.432] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.432] sna_accel_flush: flush?=1, dirty?=0
[   217.432] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.432] kgem_finish_buffers: buffer handle=65310, used=164608, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.432] kgem_finish_buffers: retaining upload buffer (164608/262144): used=167936, refcnt=1
[   217.432] __kgem_busy: handle=2, busy=1, wedged=0
[   217.432] __kgem_busy: handle=3, busy=1, wedged=0
[   217.432] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.432] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.432] sna_accel_flush: flush?=0, dirty?=0
[   217.432] sna_copy_area: src=pixmap=1618:(0, 0)x(9, 20)+(0, 0) -> dst=pixmap=1170:(482, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.432] sna_copy_area: normal copy
[   217.433] sna_do_copy: src=(0, 0), dst=(482, 641), size=(9x20)
[   217.433] sna_do_copy: after drawable: src=(0, 0), dst=(482, 697), size=(9x20)
[   217.433] sna_do_copy: dst extents (482, 697), (491, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.433] sna_do_copy: clipped dst extents (482, 697), (491, 717)
[   217.433] sna_do_copy: unclipped src extents (0, 0), (9, 20)
[   217.433] sna_do_copy: clipped src extents (0, 0), (9, 20)
[   217.433] sna_do_copy: pixmap -- no source clipping
[   217.433] sna_do_copy: src extents (0, 0), (9, 20) x 1
[   217.433] sna_do_copy: copy region (482, 697), (491, 717) x 1 + (-482, -697)
[   217.433] sna_copy_boxes (boxes=1x[(482, 697), (491, 717)...], src pixmap=1618+(-482, -697), dst pixmap=1170+(0, -19), alu=3, src.size=9x20, dst.size=1366x749)
[   217.433] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd03c0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.433] sna_drawable_use_bo pixmap=1170, box=((482, 678), (491, 698)), flags=8...
[   217.433] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.433] sna_drawable_use_bo: pinned, never REPLACES
[   217.433] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.433] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.433] sna_drawable_use_bo: using whole GPU bo
[   217.433] region_overlaps_damage?
[   217.433] use_shm_bo: no, not attached
[   217.433] sna_drawable_move_region_to_cpu(pixmap=1618 (9x20), [(0, 0), (9, 20)], flags=2)
[   217.433] sna_drawable_move_region_to_cpu: pixmap=1618 all damaged on CPU
[   217.433] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.433] sna_write_boxes x 1, src stride=36,  src dx=(-482, -678)
[   217.433] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.433] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.433] __kgem_busy: handle=112, busy=1, wedged=0
[   217.433] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.433] kgem_create_buffer: size=720, flags=3 [write?=1, inplace?=1, last?=0]
[   217.433] kgem_create_buffer: reusing buffer? used=167936 + size=720, total=262144
[   217.433] kgem_create_proxy: target handle=65310 [proxy? -1], offset=167936, length=720, io=1
[   217.433] __kgem_bo_init(handle=65310, num_pages=720)
[   217.433]   sna_write_boxes: box src=(0, 0), dst=(482, 678) size=(9, 20), dst offset=0, dst pitch=36
[   217.433] memcpy_blt: src=(0, 0), dst=(0, 0), size=9x20, pitch=36/36
[   217.433] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.433] kgem_add_handle: handle=112, index=0
[   217.433] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.433] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.433] kgem_add_reloc: adding proxy [delta=167936] for handle=65310
[   217.433] kgem_add_handle: handle=65310, index=1
[   217.433] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.433] sna_accel_flush: flush?=1, dirty?=0
[   217.433] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.433] kgem_finish_buffers: buffer handle=65310, used=168704, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.434] kgem_finish_buffers: retaining upload buffer (168704/262144): used=172032, refcnt=1
[   217.434] __kgem_busy: handle=2, busy=1, wedged=0
[   217.434] __kgem_busy: handle=3, busy=1, wedged=0
[   217.434] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.434] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.434] sna_accel_flush: flush?=0, dirty?=0
[   217.434] sna_copy_area: src=pixmap=1614:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(491, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.434] sna_copy_area: normal copy
[   217.434] sna_do_copy: src=(0, 0), dst=(491, 641), size=(8x20)
[   217.434] sna_do_copy: after drawable: src=(0, 0), dst=(491, 697), size=(8x20)
[   217.434] sna_do_copy: dst extents (491, 697), (499, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.434] sna_do_copy: clipped dst extents (491, 697), (499, 717)
[   217.434] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.434] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.434] sna_do_copy: pixmap -- no source clipping
[   217.434] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.434] sna_do_copy: copy region (491, 697), (499, 717) x 1 + (-491, -697)
[   217.434] sna_copy_boxes (boxes=1x[(491, 697), (499, 717)...], src pixmap=1614+(-491, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.434] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd08c0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.434] sna_drawable_use_bo pixmap=1170, box=((491, 678), (499, 698)), flags=8...
[   217.434] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.434] sna_drawable_use_bo: pinned, never REPLACES
[   217.434] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.434] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.434] sna_drawable_use_bo: using whole GPU bo
[   217.434] region_overlaps_damage?
[   217.434] use_shm_bo: no, not attached
[   217.434] sna_drawable_move_region_to_cpu(pixmap=1614 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.434] sna_drawable_move_region_to_cpu: pixmap=1614 all damaged on CPU
[   217.434] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.434] sna_write_boxes x 1, src stride=32,  src dx=(-491, -678)
[   217.434] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.434] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.434] __kgem_busy: handle=112, busy=1, wedged=0
[   217.434] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.434] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.434] kgem_create_buffer: reusing buffer? used=172032 + size=640, total=262144
[   217.434] kgem_create_proxy: target handle=65310 [proxy? -1], offset=172032, length=640, io=1
[   217.434] __kgem_bo_init(handle=65310, num_pages=640)
[   217.434]   sna_write_boxes: box src=(0, 0), dst=(491, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.434] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.434] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.435] kgem_add_handle: handle=112, index=0
[   217.435] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.435] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.435] kgem_add_reloc: adding proxy [delta=172032] for handle=65310
[   217.435] kgem_add_handle: handle=65310, index=1
[   217.435] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.435] sna_accel_flush: flush?=1, dirty?=0
[   217.435] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.435] kgem_finish_buffers: buffer handle=65310, used=172800, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.435] kgem_finish_buffers: retaining upload buffer (172800/262144): used=176128, refcnt=1
[   217.435] __kgem_busy: handle=2, busy=1, wedged=0
[   217.435] __kgem_busy: handle=3, busy=1, wedged=0
[   217.435] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.435] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.435] sna_accel_flush: flush?=0, dirty?=0
[   217.435] sna_copy_area: src=pixmap=1586:(0, 0)x(5, 20)+(0, 0) -> dst=pixmap=1170:(499, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.435] sna_copy_area: normal copy
[   217.435] sna_do_copy: src=(0, 0), dst=(499, 641), size=(5x20)
[   217.435] sna_do_copy: after drawable: src=(0, 0), dst=(499, 697), size=(5x20)
[   217.435] sna_do_copy: dst extents (499, 697), (504, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.435] sna_do_copy: clipped dst extents (499, 697), (504, 717)
[   217.435] sna_do_copy: unclipped src extents (0, 0), (5, 20)
[   217.435] sna_do_copy: clipped src extents (0, 0), (5, 20)
[   217.435] sna_do_copy: pixmap -- no source clipping
[   217.435] sna_do_copy: src extents (0, 0), (5, 20) x 1
[   217.435] sna_do_copy: copy region (499, 697), (504, 717) x 1 + (-499, -697)
[   217.435] sna_copy_boxes (boxes=1x[(499, 697), (504, 717)...], src pixmap=1586+(-499, -697), dst pixmap=1170+(0, -19), alu=3, src.size=5x20, dst.size=1366x749)
[   217.435] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bcaa80, gpu_bo=0, cpu_bo=0), replaces=0
[   217.435] sna_drawable_use_bo pixmap=1170, box=((499, 678), (504, 698)), flags=8...
[   217.435] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.435] sna_drawable_use_bo: pinned, never REPLACES
[   217.435] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.435] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.435] sna_drawable_use_bo: using whole GPU bo
[   217.435] region_overlaps_damage?
[   217.435] use_shm_bo: no, not attached
[   217.435] sna_drawable_move_region_to_cpu(pixmap=1586 (5x20), [(0, 0), (5, 20)], flags=2)
[   217.435] sna_drawable_move_region_to_cpu: pixmap=1586 all damaged on CPU
[   217.435] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.435] sna_write_boxes x 1, src stride=20,  src dx=(-499, -678)
[   217.435] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.435] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.435] __kgem_busy: handle=112, busy=1, wedged=0
[   217.436] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.436] kgem_create_buffer: size=400, flags=3 [write?=1, inplace?=1, last?=0]
[   217.436] kgem_create_buffer: reusing buffer? used=176128 + size=400, total=262144
[   217.436] kgem_create_proxy: target handle=65310 [proxy? -1], offset=176128, length=400, io=1
[   217.436] __kgem_bo_init(handle=65310, num_pages=400)
[   217.436]   sna_write_boxes: box src=(0, 0), dst=(499, 678) size=(5, 20), dst offset=0, dst pitch=20
[   217.436] memcpy_blt: src=(0, 0), dst=(0, 0), size=5x20, pitch=20/20
[   217.436] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.436] kgem_add_handle: handle=112, index=0
[   217.436] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.436] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.436] kgem_add_reloc: adding proxy [delta=176128] for handle=65310
[   217.436] kgem_add_handle: handle=65310, index=1
[   217.436] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.436] sna_accel_flush: flush?=1, dirty?=0
[   217.436] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.436] kgem_finish_buffers: buffer handle=65310, used=176640, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.436] kgem_finish_buffers: retaining upload buffer (176640/262144): used=180224, refcnt=1
[   217.436] __kgem_busy: handle=2, busy=1, wedged=0
[   217.436] __kgem_busy: handle=3, busy=1, wedged=0
[   217.436] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.436] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.436] sna_accel_flush: flush?=0, dirty?=0
[   217.436] sna_accel_flush: flush?=0, dirty?=0
[   217.436] sna_block_handler (tv=0.0)
[   217.436] sna_wakeup_handler
[   217.436] sna_copy_area: src=pixmap=1726:(0, 0)x(7, 20)+(0, 0) -> dst=pixmap=1170:(504, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.436] sna_copy_area: normal copy
[   217.436] sna_do_copy: src=(0, 0), dst=(504, 641), size=(7x20)
[   217.436] sna_do_copy: after drawable: src=(0, 0), dst=(504, 697), size=(7x20)
[   217.436] sna_do_copy: dst extents (504, 697), (511, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.436] sna_do_copy: clipped dst extents (504, 697), (511, 717)
[   217.436] sna_do_copy: unclipped src extents (0, 0), (7, 20)
[   217.436] sna_do_copy: clipped src extents (0, 0), (7, 20)
[   217.436] sna_do_copy: pixmap -- no source clipping
[   217.436] sna_do_copy: src extents (0, 0), (7, 20) x 1
[   217.436] sna_do_copy: copy region (504, 697), (511, 717) x 1 + (-504, -697)
[   217.436] sna_copy_boxes (boxes=1x[(504, 697), (511, 717)...], src pixmap=1726+(-504, -697), dst pixmap=1170+(0, -19), alu=3, src.size=7x20, dst.size=1366x749)
[   217.436] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf62c0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.436] sna_drawable_use_bo pixmap=1170, box=((504, 678), (511, 698)), flags=8...
[   217.436] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.437] sna_drawable_use_bo: pinned, never REPLACES
[   217.437] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.437] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.437] sna_drawable_use_bo: using whole GPU bo
[   217.437] region_overlaps_damage?
[   217.437] use_shm_bo: no, not attached
[   217.437] sna_drawable_move_region_to_cpu(pixmap=1726 (7x20), [(0, 0), (7, 20)], flags=2)
[   217.437] sna_drawable_move_region_to_cpu: pixmap=1726 all damaged on CPU
[   217.437] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.437] sna_write_boxes x 1, src stride=28,  src dx=(-504, -678)
[   217.437] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.437] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.437] __kgem_busy: handle=112, busy=1, wedged=0
[   217.437] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.437] kgem_create_buffer: size=560, flags=3 [write?=1, inplace?=1, last?=0]
[   217.437] kgem_create_buffer: reusing buffer? used=180224 + size=560, total=262144
[   217.437] kgem_create_proxy: target handle=65310 [proxy? -1], offset=180224, length=560, io=1
[   217.437] __kgem_bo_init(handle=65310, num_pages=560)
[   217.437]   sna_write_boxes: box src=(0, 0), dst=(504, 678) size=(7, 20), dst offset=0, dst pitch=28
[   217.437] memcpy_blt: src=(0, 0), dst=(0, 0), size=7x20, pitch=28/28
[   217.437] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.437] kgem_add_handle: handle=112, index=0
[   217.437] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.437] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.437] kgem_add_reloc: adding proxy [delta=180224] for handle=65310
[   217.437] kgem_add_handle: handle=65310, index=1
[   217.437] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.437] sna_accel_flush: flush?=1, dirty?=0
[   217.437] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.437] kgem_finish_buffers: buffer handle=65310, used=180992, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.437] kgem_finish_buffers: retaining upload buffer (180992/262144): used=184320, refcnt=1
[   217.437] __kgem_busy: handle=2, busy=1, wedged=0
[   217.437] __kgem_busy: handle=3, busy=1, wedged=0
[   217.437] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.437] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.437] sna_accel_flush: flush?=0, dirty?=0
[   217.437] sna_copy_area: src=pixmap=1716:(0, 0)x(10, 20)+(0, 0) -> dst=pixmap=1170:(511, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.437] sna_copy_area: normal copy
[   217.437] sna_do_copy: src=(0, 0), dst=(511, 641), size=(10x20)
[   217.437] sna_do_copy: after drawable: src=(0, 0), dst=(511, 697), size=(10x20)
[   217.437] sna_do_copy: dst extents (511, 697), (521, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.437] sna_do_copy: clipped dst extents (511, 697), (521, 717)
[   217.438] sna_do_copy: unclipped src extents (0, 0), (10, 20)
[   217.438] sna_do_copy: clipped src extents (0, 0), (10, 20)
[   217.438] sna_do_copy: pixmap -- no source clipping
[   217.438] sna_do_copy: src extents (0, 0), (10, 20) x 1
[   217.438] sna_do_copy: copy region (511, 697), (521, 717) x 1 + (-511, -697)
[   217.438] sna_copy_boxes (boxes=1x[(511, 697), (521, 717)...], src pixmap=1716+(-511, -697), dst pixmap=1170+(0, -19), alu=3, src.size=10x20, dst.size=1366x749)
[   217.438] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf4b00, gpu_bo=0, cpu_bo=0), replaces=0
[   217.438] sna_drawable_use_bo pixmap=1170, box=((511, 678), (521, 698)), flags=8...
[   217.438] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.438] sna_drawable_use_bo: pinned, never REPLACES
[   217.438] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.438] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.438] sna_drawable_use_bo: using whole GPU bo
[   217.438] region_overlaps_damage?
[   217.438] use_shm_bo: no, not attached
[   217.438] sna_drawable_move_region_to_cpu(pixmap=1716 (10x20), [(0, 0), (10, 20)], flags=2)
[   217.438] sna_drawable_move_region_to_cpu: pixmap=1716 all damaged on CPU
[   217.438] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.438] sna_write_boxes x 1, src stride=40,  src dx=(-511, -678)
[   217.438] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.438] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.438] __kgem_busy: handle=112, busy=1, wedged=0
[   217.438] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.438] kgem_create_buffer: size=800, flags=3 [write?=1, inplace?=1, last?=0]
[   217.438] kgem_create_buffer: reusing buffer? used=184320 + size=800, total=262144
[   217.438] kgem_create_proxy: target handle=65310 [proxy? -1], offset=184320, length=800, io=1
[   217.438] __kgem_bo_init(handle=65310, num_pages=800)
[   217.438]   sna_write_boxes: box src=(0, 0), dst=(511, 678) size=(10, 20), dst offset=0, dst pitch=40
[   217.438] memcpy_blt: src=(0, 0), dst=(0, 0), size=10x20, pitch=40/40
[   217.438] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.438] kgem_add_handle: handle=112, index=0
[   217.438] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.438] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.438] kgem_add_reloc: adding proxy [delta=184320] for handle=65310
[   217.438] kgem_add_handle: handle=65310, index=1
[   217.438] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.438] sna_accel_flush: flush?=1, dirty?=0
[   217.438] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.438] kgem_finish_buffers: buffer handle=65310, used=185344, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.438] kgem_finish_buffers: retaining upload buffer (185344/262144): used=188416, refcnt=1
[   217.438] __kgem_busy: handle=2, busy=1, wedged=0
[   217.438] __kgem_busy: handle=3, busy=1, wedged=0
[   217.438] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.439] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.439] sna_accel_flush: flush?=0, dirty?=0
[   217.439] sna_copy_area: src=pixmap=1614:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(521, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.439] sna_copy_area: normal copy
[   217.439] sna_do_copy: src=(0, 0), dst=(521, 641), size=(8x20)
[   217.439] sna_do_copy: after drawable: src=(0, 0), dst=(521, 697), size=(8x20)
[   217.439] sna_do_copy: dst extents (521, 697), (529, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.439] sna_do_copy: clipped dst extents (521, 697), (529, 717)
[   217.439] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.439] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.439] sna_do_copy: pixmap -- no source clipping
[   217.439] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.439] sna_do_copy: copy region (521, 697), (529, 717) x 1 + (-521, -697)
[   217.439] sna_copy_boxes (boxes=1x[(521, 697), (529, 717)...], src pixmap=1614+(-521, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.439] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd08c0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.439] sna_drawable_use_bo pixmap=1170, box=((521, 678), (529, 698)), flags=8...
[   217.439] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.439] sna_drawable_use_bo: pinned, never REPLACES
[   217.439] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.439] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.439] sna_drawable_use_bo: using whole GPU bo
[   217.439] region_overlaps_damage?
[   217.439] use_shm_bo: no, not attached
[   217.439] sna_drawable_move_region_to_cpu(pixmap=1614 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.439] sna_drawable_move_region_to_cpu: pixmap=1614 all damaged on CPU
[   217.439] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.439] sna_write_boxes x 1, src stride=32,  src dx=(-521, -678)
[   217.439] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.439] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.439] __kgem_busy: handle=112, busy=1, wedged=0
[   217.439] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.439] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.439] kgem_create_buffer: reusing buffer? used=188416 + size=640, total=262144
[   217.439] kgem_create_proxy: target handle=65310 [proxy? -1], offset=188416, length=640, io=1
[   217.439] __kgem_bo_init(handle=65310, num_pages=640)
[   217.439]   sna_write_boxes: box src=(0, 0), dst=(521, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.439] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.439] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.439] kgem_add_handle: handle=112, index=0
[   217.439] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.439] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.439] kgem_add_reloc: adding proxy [delta=188416] for handle=65310
[   217.439] kgem_add_handle: handle=65310, index=1
[   217.440] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.440] sna_accel_flush: flush?=1, dirty?=0
[   217.440] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.440] kgem_finish_buffers: buffer handle=65310, used=189184, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.440] kgem_finish_buffers: retaining upload buffer (189184/262144): used=192512, refcnt=1
[   217.440] __kgem_busy: handle=2, busy=1, wedged=0
[   217.440] __kgem_busy: handle=3, busy=1, wedged=0
[   217.440] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.440] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.440] sna_accel_flush: flush?=0, dirty?=0
[   217.440] sna_copy_area: src=pixmap=1586:(0, 0)x(5, 20)+(0, 0) -> dst=pixmap=1170:(529, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.440] sna_copy_area: normal copy
[   217.440] sna_do_copy: src=(0, 0), dst=(529, 641), size=(5x20)
[   217.440] sna_do_copy: after drawable: src=(0, 0), dst=(529, 697), size=(5x20)
[   217.440] sna_do_copy: dst extents (529, 697), (534, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.440] sna_do_copy: clipped dst extents (529, 697), (534, 717)
[   217.440] sna_do_copy: unclipped src extents (0, 0), (5, 20)
[   217.440] sna_do_copy: clipped src extents (0, 0), (5, 20)
[   217.440] sna_do_copy: pixmap -- no source clipping
[   217.440] sna_do_copy: src extents (0, 0), (5, 20) x 1
[   217.440] sna_do_copy: copy region (529, 697), (534, 717) x 1 + (-529, -697)
[   217.440] sna_copy_boxes (boxes=1x[(529, 697), (534, 717)...], src pixmap=1586+(-529, -697), dst pixmap=1170+(0, -19), alu=3, src.size=5x20, dst.size=1366x749)
[   217.440] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bcaa80, gpu_bo=0, cpu_bo=0), replaces=0
[   217.440] sna_drawable_use_bo pixmap=1170, box=((529, 678), (534, 698)), flags=8...
[   217.440] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.440] sna_drawable_use_bo: pinned, never REPLACES
[   217.440] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.440] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.440] sna_drawable_use_bo: using whole GPU bo
[   217.440] region_overlaps_damage?
[   217.440] use_shm_bo: no, not attached
[   217.440] sna_drawable_move_region_to_cpu(pixmap=1586 (5x20), [(0, 0), (5, 20)], flags=2)
[   217.440] sna_drawable_move_region_to_cpu: pixmap=1586 all damaged on CPU
[   217.440] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.440] sna_write_boxes x 1, src stride=20,  src dx=(-529, -678)
[   217.440] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.440] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.440] __kgem_busy: handle=112, busy=1, wedged=0
[   217.440] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.440] kgem_create_buffer: size=400, flags=3 [write?=1, inplace?=1, last?=0]
[   217.440] kgem_create_buffer: reusing buffer? used=192512 + size=400, total=262144
[   217.440] kgem_create_proxy: target handle=65310 [proxy? -1], offset=192512, length=400, io=1
[   217.441] __kgem_bo_init(handle=65310, num_pages=400)
[   217.441]   sna_write_boxes: box src=(0, 0), dst=(529, 678) size=(5, 20), dst offset=0, dst pitch=20
[   217.441] memcpy_blt: src=(0, 0), dst=(0, 0), size=5x20, pitch=20/20
[   217.441] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.441] kgem_add_handle: handle=112, index=0
[   217.441] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.441] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.441] kgem_add_reloc: adding proxy [delta=192512] for handle=65310
[   217.441] kgem_add_handle: handle=65310, index=1
[   217.441] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.441] sna_accel_flush: flush?=1, dirty?=0
[   217.441] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.441] kgem_finish_buffers: buffer handle=65310, used=193024, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.441] kgem_finish_buffers: retaining upload buffer (193024/262144): used=196608, refcnt=1
[   217.441] __kgem_busy: handle=2, busy=1, wedged=0
[   217.441] __kgem_busy: handle=3, busy=1, wedged=0
[   217.441] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.441] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.441] sna_accel_flush: flush?=0, dirty?=0
[   217.441] sna_copy_area: src=pixmap=1742:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(534, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.441] sna_copy_area: normal copy
[   217.441] sna_do_copy: src=(0, 0), dst=(534, 641), size=(8x20)
[   217.441] sna_do_copy: after drawable: src=(0, 0), dst=(534, 697), size=(8x20)
[   217.441] sna_do_copy: dst extents (534, 697), (542, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.441] sna_do_copy: clipped dst extents (534, 697), (542, 717)
[   217.441] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.441] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.441] sna_do_copy: pixmap -- no source clipping
[   217.441] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.441] sna_do_copy: copy region (534, 697), (542, 717) x 1 + (-534, -697)
[   217.441] sna_copy_boxes (boxes=1x[(534, 697), (542, 717)...], src pixmap=1742+(-534, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.441] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bfc700, gpu_bo=0, cpu_bo=0), replaces=0
[   217.441] sna_drawable_use_bo pixmap=1170, box=((534, 678), (542, 698)), flags=8...
[   217.441] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.441] sna_drawable_use_bo: pinned, never REPLACES
[   217.441] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.441] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.441] sna_drawable_use_bo: using whole GPU bo
[   217.441] region_overlaps_damage?
[   217.441] use_shm_bo: no, not attached
[   217.441] sna_drawable_move_region_to_cpu(pixmap=1742 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.442] sna_drawable_move_region_to_cpu: pixmap=1742 all damaged on CPU
[   217.442] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.442] sna_write_boxes x 1, src stride=32,  src dx=(-534, -678)
[   217.442] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.442] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.442] __kgem_busy: handle=112, busy=1, wedged=0
[   217.442] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.442] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.442] kgem_create_buffer: reusing buffer? used=196608 + size=640, total=262144
[   217.442] kgem_create_proxy: target handle=65310 [proxy? -1], offset=196608, length=640, io=1
[   217.442] __kgem_bo_init(handle=65310, num_pages=640)
[   217.442]   sna_write_boxes: box src=(0, 0), dst=(534, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.442] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.442] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.442] kgem_add_handle: handle=112, index=0
[   217.442] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.442] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.442] kgem_add_reloc: adding proxy [delta=196608] for handle=65310
[   217.442] kgem_add_handle: handle=65310, index=1
[   217.442] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.442] sna_accel_flush: flush?=1, dirty?=0
[   217.442] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.442] kgem_finish_buffers: buffer handle=65310, used=197376, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.442] kgem_finish_buffers: retaining upload buffer (197376/262144): used=200704, refcnt=1
[   217.442] __kgem_busy: handle=2, busy=1, wedged=0
[   217.442] __kgem_busy: handle=3, busy=1, wedged=0
[   217.442] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.442] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.442] sna_accel_flush: flush?=0, dirty?=0
[   217.442] sna_accel_flush: flush?=0, dirty?=0
[   217.442] sna_block_handler (tv=0.0)
[   217.442] sna_wakeup_handler
[   217.442] sna_copy_area: src=pixmap=1722:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(542, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.442] sna_copy_area: normal copy
[   217.442] sna_do_copy: src=(0, 0), dst=(542, 641), size=(8x20)
[   217.442] sna_do_copy: after drawable: src=(0, 0), dst=(542, 697), size=(8x20)
[   217.442] sna_do_copy: dst extents (542, 697), (550, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.442] sna_do_copy: clipped dst extents (542, 697), (550, 717)
[   217.442] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.442] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.442] sna_do_copy: pixmap -- no source clipping
[   217.442] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.443] sna_do_copy: copy region (542, 697), (550, 717) x 1 + (-542, -697)
[   217.443] sna_copy_boxes (boxes=1x[(542, 697), (550, 717)...], src pixmap=1722+(-542, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.443] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf6220, gpu_bo=0, cpu_bo=0), replaces=0
[   217.443] sna_drawable_use_bo pixmap=1170, box=((542, 678), (550, 698)), flags=8...
[   217.443] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.443] sna_drawable_use_bo: pinned, never REPLACES
[   217.443] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.443] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.443] sna_drawable_use_bo: using whole GPU bo
[   217.443] region_overlaps_damage?
[   217.443] use_shm_bo: no, not attached
[   217.443] sna_drawable_move_region_to_cpu(pixmap=1722 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.443] sna_drawable_move_region_to_cpu: pixmap=1722 all damaged on CPU
[   217.443] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.443] sna_write_boxes x 1, src stride=32,  src dx=(-542, -678)
[   217.443] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.443] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.443] __kgem_busy: handle=112, busy=1, wedged=0
[   217.443] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.443] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.443] kgem_create_buffer: reusing buffer? used=200704 + size=640, total=262144
[   217.443] kgem_create_proxy: target handle=65310 [proxy? -1], offset=200704, length=640, io=1
[   217.443] __kgem_bo_init(handle=65310, num_pages=640)
[   217.443]   sna_write_boxes: box src=(0, 0), dst=(542, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.443] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.443] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.443] kgem_add_handle: handle=112, index=0
[   217.443] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.443] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.443] kgem_add_reloc: adding proxy [delta=200704] for handle=65310
[   217.443] kgem_add_handle: handle=65310, index=1
[   217.443] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.443] sna_accel_flush: flush?=1, dirty?=0
[   217.443] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.443] kgem_finish_buffers: buffer handle=65310, used=201472, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.443] kgem_finish_buffers: retaining upload buffer (201472/262144): used=204800, refcnt=1
[   217.443] __kgem_busy: handle=2, busy=1, wedged=0
[   217.443] __kgem_busy: handle=3, busy=1, wedged=0
[   217.443] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.443] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.443] sna_accel_flush: flush?=0, dirty?=0
[   217.443] sna_copy_area: src=pixmap=1720:(0, 0)x(15, 20)+(0, 0) -> dst=pixmap=1170:(550, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.444] sna_copy_area: normal copy
[   217.444] sna_do_copy: src=(0, 0), dst=(550, 641), size=(15x20)
[   217.444] sna_do_copy: after drawable: src=(0, 0), dst=(550, 697), size=(15x20)
[   217.444] sna_do_copy: dst extents (550, 697), (565, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.444] sna_do_copy: clipped dst extents (550, 697), (565, 717)
[   217.444] sna_do_copy: unclipped src extents (0, 0), (15, 20)
[   217.444] sna_do_copy: clipped src extents (0, 0), (15, 20)
[   217.444] sna_do_copy: pixmap -- no source clipping
[   217.444] sna_do_copy: src extents (0, 0), (15, 20) x 1
[   217.444] sna_do_copy: copy region (550, 697), (565, 717) x 1 + (-550, -697)
[   217.444] sna_copy_boxes (boxes=1x[(550, 697), (565, 717)...], src pixmap=1720+(-550, -697), dst pixmap=1170+(0, -19), alu=3, src.size=15x20, dst.size=1366x749)
[   217.444] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf5970, gpu_bo=0, cpu_bo=0), replaces=0
[   217.444] sna_drawable_use_bo pixmap=1170, box=((550, 678), (565, 698)), flags=8...
[   217.444] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.444] sna_drawable_use_bo: pinned, never REPLACES
[   217.444] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.444] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.444] sna_drawable_use_bo: using whole GPU bo
[   217.444] region_overlaps_damage?
[   217.444] use_shm_bo: no, not attached
[   217.444] sna_drawable_move_region_to_cpu(pixmap=1720 (15x20), [(0, 0), (15, 20)], flags=2)
[   217.444] sna_drawable_move_region_to_cpu: pixmap=1720 all damaged on CPU
[   217.444] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.444] sna_write_boxes x 1, src stride=60,  src dx=(-550, -678)
[   217.444] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.444] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.444] __kgem_busy: handle=112, busy=1, wedged=0
[   217.444] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.444] kgem_create_buffer: size=1200, flags=3 [write?=1, inplace?=1, last?=0]
[   217.444] kgem_create_buffer: reusing buffer? used=204800 + size=1200, total=262144
[   217.444] kgem_create_proxy: target handle=65310 [proxy? -1], offset=204800, length=1200, io=1
[   217.444] __kgem_bo_init(handle=65310, num_pages=1200)
[   217.444]   sna_write_boxes: box src=(0, 0), dst=(550, 678) size=(15, 20), dst offset=0, dst pitch=60
[   217.444] memcpy_blt: src=(0, 0), dst=(0, 0), size=15x20, pitch=60/60
[   217.444] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.444] kgem_add_handle: handle=112, index=0
[   217.444] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.444] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.444] kgem_add_reloc: adding proxy [delta=204800] for handle=65310
[   217.444] kgem_add_handle: handle=65310, index=1
[   217.444] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.444] sna_accel_flush: flush?=1, dirty?=0
[   217.444] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.445] kgem_finish_buffers: buffer handle=65310, used=206080, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.445] kgem_finish_buffers: retaining upload buffer (206080/262144): used=208896, refcnt=1
[   217.445] __kgem_busy: handle=2, busy=1, wedged=0
[   217.445] __kgem_busy: handle=3, busy=1, wedged=0
[   217.445] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.445] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.445] sna_accel_flush: flush?=0, dirty?=0
[   217.445] sna_copy_area: src=pixmap=1720:(0, 0)x(15, 20)+(0, 0) -> dst=pixmap=1170:(565, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.445] sna_copy_area: normal copy
[   217.445] sna_do_copy: src=(0, 0), dst=(565, 641), size=(15x20)
[   217.445] sna_do_copy: after drawable: src=(0, 0), dst=(565, 697), size=(15x20)
[   217.445] sna_do_copy: dst extents (565, 697), (580, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.445] sna_do_copy: clipped dst extents (565, 697), (580, 717)
[   217.445] sna_do_copy: unclipped src extents (0, 0), (15, 20)
[   217.445] sna_do_copy: clipped src extents (0, 0), (15, 20)
[   217.445] sna_do_copy: pixmap -- no source clipping
[   217.445] sna_do_copy: src extents (0, 0), (15, 20) x 1
[   217.445] sna_do_copy: copy region (565, 697), (580, 717) x 1 + (-565, -697)
[   217.445] sna_copy_boxes (boxes=1x[(565, 697), (580, 717)...], src pixmap=1720+(-565, -697), dst pixmap=1170+(0, -19), alu=3, src.size=15x20, dst.size=1366x749)
[   217.445] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf5970, gpu_bo=0, cpu_bo=0), replaces=0
[   217.445] sna_drawable_use_bo pixmap=1170, box=((565, 678), (580, 698)), flags=8...
[   217.445] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.445] sna_drawable_use_bo: pinned, never REPLACES
[   217.445] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.445] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.445] sna_drawable_use_bo: using whole GPU bo
[   217.445] region_overlaps_damage?
[   217.445] use_shm_bo: no, not attached
[   217.445] sna_drawable_move_region_to_cpu(pixmap=1720 (15x20), [(0, 0), (15, 20)], flags=2)
[   217.445] sna_drawable_move_region_to_cpu: pixmap=1720 all damaged on CPU
[   217.445] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.445] sna_write_boxes x 1, src stride=60,  src dx=(-565, -678)
[   217.445] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.445] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.445] __kgem_busy: handle=112, busy=1, wedged=0
[   217.445] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.445] kgem_create_buffer: size=1200, flags=3 [write?=1, inplace?=1, last?=0]
[   217.445] kgem_create_buffer: reusing buffer? used=208896 + size=1200, total=262144
[   217.445] kgem_create_proxy: target handle=65310 [proxy? -1], offset=208896, length=1200, io=1
[   217.445] __kgem_bo_init(handle=65310, num_pages=1200)
[   217.445]   sna_write_boxes: box src=(0, 0), dst=(565, 678) size=(15, 20), dst offset=0, dst pitch=60
[   217.445] memcpy_blt: src=(0, 0), dst=(0, 0), size=15x20, pitch=60/60
[   217.446] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.446] kgem_add_handle: handle=112, index=0
[   217.446] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.446] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.446] kgem_add_reloc: adding proxy [delta=208896] for handle=65310
[   217.446] kgem_add_handle: handle=65310, index=1
[   217.446] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.446] sna_accel_flush: flush?=1, dirty?=0
[   217.446] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.446] kgem_finish_buffers: buffer handle=65310, used=210176, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.446] kgem_finish_buffers: retaining upload buffer (210176/262144): used=212992, refcnt=1
[   217.446] __kgem_busy: handle=2, busy=1, wedged=0
[   217.446] __kgem_busy: handle=3, busy=1, wedged=0
[   217.446] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.446] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.446] sna_accel_flush: flush?=0, dirty?=0
[   217.446] sna_copy_area: src=pixmap=1614:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(580, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.446] sna_copy_area: normal copy
[   217.446] sna_do_copy: src=(0, 0), dst=(580, 641), size=(8x20)
[   217.446] sna_do_copy: after drawable: src=(0, 0), dst=(580, 697), size=(8x20)
[   217.446] sna_do_copy: dst extents (580, 697), (588, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.446] sna_do_copy: clipped dst extents (580, 697), (588, 717)
[   217.446] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.446] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.446] sna_do_copy: pixmap -- no source clipping
[   217.446] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.446] sna_do_copy: copy region (580, 697), (588, 717) x 1 + (-580, -697)
[   217.446] sna_copy_boxes (boxes=1x[(580, 697), (588, 717)...], src pixmap=1614+(-580, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.446] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd08c0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.446] sna_drawable_use_bo pixmap=1170, box=((580, 678), (588, 698)), flags=8...
[   217.446] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.446] sna_drawable_use_bo: pinned, never REPLACES
[   217.446] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.446] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.446] sna_drawable_use_bo: using whole GPU bo
[   217.446] region_overlaps_damage?
[   217.446] use_shm_bo: no, not attached
[   217.446] sna_drawable_move_region_to_cpu(pixmap=1614 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.446] sna_drawable_move_region_to_cpu: pixmap=1614 all damaged on CPU
[   217.446] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.446] sna_write_boxes x 1, src stride=32,  src dx=(-580, -678)
[   217.446] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.447] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.447] __kgem_busy: handle=112, busy=1, wedged=0
[   217.447] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.447] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.447] kgem_create_buffer: reusing buffer? used=212992 + size=640, total=262144
[   217.447] kgem_create_proxy: target handle=65310 [proxy? -1], offset=212992, length=640, io=1
[   217.447] __kgem_bo_init(handle=65310, num_pages=640)
[   217.447]   sna_write_boxes: box src=(0, 0), dst=(580, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.447] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.447] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.447] kgem_add_handle: handle=112, index=0
[   217.447] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.447] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.447] kgem_add_reloc: adding proxy [delta=212992] for handle=65310
[   217.447] kgem_add_handle: handle=65310, index=1
[   217.447] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.447] sna_accel_flush: flush?=1, dirty?=0
[   217.447] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.447] kgem_finish_buffers: buffer handle=65310, used=213760, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.447] kgem_finish_buffers: retaining upload buffer (213760/262144): used=217088, refcnt=1
[   217.447] __kgem_busy: handle=2, busy=1, wedged=0
[   217.447] __kgem_busy: handle=3, busy=1, wedged=0
[   217.447] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.447] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.447] sna_accel_flush: flush?=0, dirty?=0
[   217.447] sna_copy_area: src=pixmap=1630:(0, 0)x(10, 20)+(0, 0) -> dst=pixmap=1170:(588, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.447] sna_copy_area: normal copy
[   217.447] sna_do_copy: src=(0, 0), dst=(588, 641), size=(10x20)
[   217.447] sna_do_copy: after drawable: src=(0, 0), dst=(588, 697), size=(10x20)
[   217.447] sna_do_copy: dst extents (588, 697), (598, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.447] sna_do_copy: clipped dst extents (588, 697), (598, 717)
[   217.447] sna_do_copy: unclipped src extents (0, 0), (10, 20)
[   217.447] sna_do_copy: clipped src extents (0, 0), (10, 20)
[   217.447] sna_do_copy: pixmap -- no source clipping
[   217.447] sna_do_copy: src extents (0, 0), (10, 20) x 1
[   217.447] sna_do_copy: copy region (588, 697), (598, 717) x 1 + (-588, -697)
[   217.447] sna_copy_boxes (boxes=1x[(588, 697), (598, 717)...], src pixmap=1630+(-588, -697), dst pixmap=1170+(0, -19), alu=3, src.size=10x20, dst.size=1366x749)
[   217.447] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd28d0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.447] sna_drawable_use_bo pixmap=1170, box=((588, 678), (598, 698)), flags=8...
[   217.447] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.447] sna_drawable_use_bo: pinned, never REPLACES
[   217.447] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.448] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.448] sna_drawable_use_bo: using whole GPU bo
[   217.448] region_overlaps_damage?
[   217.448] use_shm_bo: no, not attached
[   217.448] sna_drawable_move_region_to_cpu(pixmap=1630 (10x20), [(0, 0), (10, 20)], flags=2)
[   217.448] sna_drawable_move_region_to_cpu: pixmap=1630 all damaged on CPU
[   217.448] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.448] sna_write_boxes x 1, src stride=40,  src dx=(-588, -678)
[   217.448] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.448] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.448] __kgem_busy: handle=112, busy=1, wedged=0
[   217.448] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.448] kgem_create_buffer: size=800, flags=3 [write?=1, inplace?=1, last?=0]
[   217.448] kgem_create_buffer: reusing buffer? used=217088 + size=800, total=262144
[   217.448] kgem_create_proxy: target handle=65310 [proxy? -1], offset=217088, length=800, io=1
[   217.448] __kgem_bo_init(handle=65310, num_pages=800)
[   217.448]   sna_write_boxes: box src=(0, 0), dst=(588, 678) size=(10, 20), dst offset=0, dst pitch=40
[   217.448] memcpy_blt: src=(0, 0), dst=(0, 0), size=10x20, pitch=40/40
[   217.448] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.448] kgem_add_handle: handle=112, index=0
[   217.448] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.448] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.448] kgem_add_reloc: adding proxy [delta=217088] for handle=65310
[   217.448] kgem_add_handle: handle=65310, index=1
[   217.448] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.448] sna_accel_flush: flush?=1, dirty?=0
[   217.448] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.448] kgem_finish_buffers: buffer handle=65310, used=218112, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.448] kgem_finish_buffers: retaining upload buffer (218112/262144): used=221184, refcnt=1
[   217.448] __kgem_busy: handle=2, busy=1, wedged=0
[   217.448] __kgem_busy: handle=3, busy=1, wedged=0
[   217.448] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.448] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.448] sna_accel_flush: flush?=0, dirty?=0
[   217.448] sna_accel_flush: flush?=0, dirty?=0
[   217.448] sna_block_handler (tv=0.0)
[   217.448] sna_wakeup_handler
[   217.448] sna_copy_area: src=pixmap=1726:(0, 0)x(7, 20)+(0, 0) -> dst=pixmap=1170:(598, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.448] sna_copy_area: normal copy
[   217.448] sna_do_copy: src=(0, 0), dst=(598, 641), size=(7x20)
[   217.448] sna_do_copy: after drawable: src=(0, 0), dst=(598, 697), size=(7x20)
[   217.448] sna_do_copy: dst extents (598, 697), (605, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.449] sna_do_copy: clipped dst extents (598, 697), (605, 717)
[   217.449] sna_do_copy: unclipped src extents (0, 0), (7, 20)
[   217.449] sna_do_copy: clipped src extents (0, 0), (7, 20)
[   217.449] sna_do_copy: pixmap -- no source clipping
[   217.449] sna_do_copy: src extents (0, 0), (7, 20) x 1
[   217.449] sna_do_copy: copy region (598, 697), (605, 717) x 1 + (-598, -697)
[   217.449] sna_copy_boxes (boxes=1x[(598, 697), (605, 717)...], src pixmap=1726+(-598, -697), dst pixmap=1170+(0, -19), alu=3, src.size=7x20, dst.size=1366x749)
[   217.449] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf62c0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.449] sna_drawable_use_bo pixmap=1170, box=((598, 678), (605, 698)), flags=8...
[   217.449] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.449] sna_drawable_use_bo: pinned, never REPLACES
[   217.449] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.449] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.449] sna_drawable_use_bo: using whole GPU bo
[   217.449] region_overlaps_damage?
[   217.449] use_shm_bo: no, not attached
[   217.449] sna_drawable_move_region_to_cpu(pixmap=1726 (7x20), [(0, 0), (7, 20)], flags=2)
[   217.449] sna_drawable_move_region_to_cpu: pixmap=1726 all damaged on CPU
[   217.449] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.449] sna_write_boxes x 1, src stride=28,  src dx=(-598, -678)
[   217.449] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.449] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.449] __kgem_busy: handle=112, busy=1, wedged=0
[   217.449] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.449] kgem_create_buffer: size=560, flags=3 [write?=1, inplace?=1, last?=0]
[   217.449] kgem_create_buffer: reusing buffer? used=221184 + size=560, total=262144
[   217.449] kgem_create_proxy: target handle=65310 [proxy? -1], offset=221184, length=560, io=1
[   217.449] __kgem_bo_init(handle=65310, num_pages=560)
[   217.449]   sna_write_boxes: box src=(0, 0), dst=(598, 678) size=(7, 20), dst offset=0, dst pitch=28
[   217.449] memcpy_blt: src=(0, 0), dst=(0, 0), size=7x20, pitch=28/28
[   217.449] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.449] kgem_add_handle: handle=112, index=0
[   217.449] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.449] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.449] kgem_add_reloc: adding proxy [delta=221184] for handle=65310
[   217.449] kgem_add_handle: handle=65310, index=1
[   217.449] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.449] sna_accel_flush: flush?=1, dirty?=0
[   217.449] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.449] kgem_finish_buffers: buffer handle=65310, used=221952, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.449] kgem_finish_buffers: retaining upload buffer (221952/262144): used=225280, refcnt=1
[   217.449] __kgem_busy: handle=2, busy=1, wedged=0
[   217.449] __kgem_busy: handle=3, busy=1, wedged=0
[   217.450] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.450] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.450] sna_accel_flush: flush?=0, dirty?=0
[   217.450] sna_copy_area: src=pixmap=1586:(0, 0)x(5, 20)+(0, 0) -> dst=pixmap=1170:(605, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.450] sna_copy_area: normal copy
[   217.450] sna_do_copy: src=(0, 0), dst=(605, 641), size=(5x20)
[   217.450] sna_do_copy: after drawable: src=(0, 0), dst=(605, 697), size=(5x20)
[   217.450] sna_do_copy: dst extents (605, 697), (610, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.450] sna_do_copy: clipped dst extents (605, 697), (610, 717)
[   217.450] sna_do_copy: unclipped src extents (0, 0), (5, 20)
[   217.450] sna_do_copy: clipped src extents (0, 0), (5, 20)
[   217.450] sna_do_copy: pixmap -- no source clipping
[   217.450] sna_do_copy: src extents (0, 0), (5, 20) x 1
[   217.450] sna_do_copy: copy region (605, 697), (610, 717) x 1 + (-605, -697)
[   217.450] sna_copy_boxes (boxes=1x[(605, 697), (610, 717)...], src pixmap=1586+(-605, -697), dst pixmap=1170+(0, -19), alu=3, src.size=5x20, dst.size=1366x749)
[   217.450] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bcaa80, gpu_bo=0, cpu_bo=0), replaces=0
[   217.450] sna_drawable_use_bo pixmap=1170, box=((605, 678), (610, 698)), flags=8...
[   217.450] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.450] sna_drawable_use_bo: pinned, never REPLACES
[   217.450] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.450] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.450] sna_drawable_use_bo: using whole GPU bo
[   217.450] region_overlaps_damage?
[   217.450] use_shm_bo: no, not attached
[   217.450] sna_drawable_move_region_to_cpu(pixmap=1586 (5x20), [(0, 0), (5, 20)], flags=2)
[   217.450] sna_drawable_move_region_to_cpu: pixmap=1586 all damaged on CPU
[   217.450] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.450] sna_write_boxes x 1, src stride=20,  src dx=(-605, -678)
[   217.450] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.450] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.450] __kgem_busy: handle=112, busy=1, wedged=0
[   217.450] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.450] kgem_create_buffer: size=400, flags=3 [write?=1, inplace?=1, last?=0]
[   217.450] kgem_create_buffer: reusing buffer? used=225280 + size=400, total=262144
[   217.450] kgem_create_proxy: target handle=65310 [proxy? -1], offset=225280, length=400, io=1
[   217.450] __kgem_bo_init(handle=65310, num_pages=400)
[   217.450]   sna_write_boxes: box src=(0, 0), dst=(605, 678) size=(5, 20), dst offset=0, dst pitch=20
[   217.450] memcpy_blt: src=(0, 0), dst=(0, 0), size=5x20, pitch=20/20
[   217.450] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.450] kgem_add_handle: handle=112, index=0
[   217.450] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.450] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.451] kgem_add_reloc: adding proxy [delta=225280] for handle=65310
[   217.451] kgem_add_handle: handle=65310, index=1
[   217.451] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.451] sna_accel_flush: flush?=1, dirty?=0
[   217.451] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.451] kgem_finish_buffers: buffer handle=65310, used=225792, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.451] kgem_finish_buffers: retaining upload buffer (225792/262144): used=229376, refcnt=1
[   217.451] __kgem_busy: handle=2, busy=1, wedged=0
[   217.451] __kgem_busy: handle=3, busy=1, wedged=0
[   217.451] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.451] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.451] sna_accel_flush: flush?=0, dirty?=0
[   217.451] sna_copy_area: src=pixmap=1718:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(610, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.451] sna_copy_area: normal copy
[   217.451] sna_do_copy: src=(0, 0), dst=(610, 641), size=(8x20)
[   217.451] sna_do_copy: after drawable: src=(0, 0), dst=(610, 697), size=(8x20)
[   217.451] sna_do_copy: dst extents (610, 697), (618, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.451] sna_do_copy: clipped dst extents (610, 697), (618, 717)
[   217.451] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.451] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.451] sna_do_copy: pixmap -- no source clipping
[   217.451] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.451] sna_do_copy: copy region (610, 697), (618, 717) x 1 + (-610, -697)
[   217.451] sna_copy_boxes (boxes=1x[(610, 697), (618, 717)...], src pixmap=1718+(-610, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.451] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf4560, gpu_bo=0, cpu_bo=0), replaces=0
[   217.451] sna_drawable_use_bo pixmap=1170, box=((610, 678), (618, 698)), flags=8...
[   217.451] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.451] sna_drawable_use_bo: pinned, never REPLACES
[   217.451] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.451] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.451] sna_drawable_use_bo: using whole GPU bo
[   217.451] region_overlaps_damage?
[   217.451] use_shm_bo: no, not attached
[   217.451] sna_drawable_move_region_to_cpu(pixmap=1718 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.451] sna_drawable_move_region_to_cpu: pixmap=1718 all damaged on CPU
[   217.451] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.451] sna_write_boxes x 1, src stride=32,  src dx=(-610, -678)
[   217.451] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.451] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.451] __kgem_busy: handle=112, busy=1, wedged=0
[   217.451] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.451] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.452] kgem_create_buffer: reusing buffer? used=229376 + size=640, total=262144
[   217.452] kgem_create_proxy: target handle=65310 [proxy? -1], offset=229376, length=640, io=1
[   217.452] __kgem_bo_init(handle=65310, num_pages=640)
[   217.452]   sna_write_boxes: box src=(0, 0), dst=(610, 678) size=(8, 20), dst offset=0, dst pitch=32
[   217.452] memcpy_blt: src=(0, 0), dst=(0, 0), size=8x20, pitch=32/32
[   217.452] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.452] kgem_add_handle: handle=112, index=0
[   217.452] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.452] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.452] kgem_add_reloc: adding proxy [delta=229376] for handle=65310
[   217.452] kgem_add_handle: handle=65310, index=1
[   217.452] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.452] sna_accel_flush: flush?=1, dirty?=0
[   217.452] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.452] kgem_finish_buffers: buffer handle=65310, used=230144, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.452] kgem_finish_buffers: retaining upload buffer (230144/262144): used=233472, refcnt=1
[   217.452] __kgem_busy: handle=2, busy=1, wedged=0
[   217.452] __kgem_busy: handle=3, busy=1, wedged=0
[   217.452] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.452] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.452] sna_accel_flush: flush?=0, dirty?=0
[   217.452] sna_copy_area: src=pixmap=1628:(0, 0)x(5, 20)+(0, 0) -> dst=pixmap=1170:(618, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.452] sna_copy_area: normal copy
[   217.452] sna_do_copy: src=(0, 0), dst=(618, 641), size=(5x20)
[   217.452] sna_do_copy: after drawable: src=(0, 0), dst=(618, 697), size=(5x20)
[   217.452] sna_do_copy: dst extents (618, 697), (623, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.452] sna_do_copy: clipped dst extents (618, 697), (623, 717)
[   217.452] sna_do_copy: unclipped src extents (0, 0), (5, 20)
[   217.452] sna_do_copy: clipped src extents (0, 0), (5, 20)
[   217.452] sna_do_copy: pixmap -- no source clipping
[   217.452] sna_do_copy: src extents (0, 0), (5, 20) x 1
[   217.452] sna_do_copy: copy region (618, 697), (623, 717) x 1 + (-618, -697)
[   217.452] sna_copy_boxes (boxes=1x[(618, 697), (623, 717)...], src pixmap=1628+(-618, -697), dst pixmap=1170+(0, -19), alu=3, src.size=5x20, dst.size=1366x749)
[   217.452] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd3330, gpu_bo=0, cpu_bo=0), replaces=0
[   217.452] sna_drawable_use_bo pixmap=1170, box=((618, 678), (623, 698)), flags=8...
[   217.452] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.452] sna_drawable_use_bo: pinned, never REPLACES
[   217.452] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.452] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.452] sna_drawable_use_bo: using whole GPU bo
[   217.452] region_overlaps_damage?
[   217.452] use_shm_bo: no, not attached
[   217.453] sna_drawable_move_region_to_cpu(pixmap=1628 (5x20), [(0, 0), (5, 20)], flags=2)
[   217.453] sna_drawable_move_region_to_cpu: pixmap=1628 all damaged on CPU
[   217.453] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.453] sna_write_boxes x 1, src stride=20,  src dx=(-618, -678)
[   217.453] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.453] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.453] __kgem_busy: handle=112, busy=1, wedged=0
[   217.453] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.453] kgem_create_buffer: size=400, flags=3 [write?=1, inplace?=1, last?=0]
[   217.453] kgem_create_buffer: reusing buffer? used=233472 + size=400, total=262144
[   217.453] kgem_create_proxy: target handle=65310 [proxy? -1], offset=233472, length=400, io=1
[   217.453] __kgem_bo_init(handle=65310, num_pages=400)
[   217.453]   sna_write_boxes: box src=(0, 0), dst=(618, 678) size=(5, 20), dst offset=0, dst pitch=20
[   217.453] memcpy_blt: src=(0, 0), dst=(0, 0), size=5x20, pitch=20/20
[   217.453] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.453] kgem_add_handle: handle=112, index=0
[   217.453] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.453] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.453] kgem_add_reloc: adding proxy [delta=233472] for handle=65310
[   217.453] kgem_add_handle: handle=65310, index=1
[   217.453] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.453] sna_accel_flush: flush?=1, dirty?=0
[   217.453] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.453] kgem_finish_buffers: buffer handle=65310, used=233984, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.453] kgem_finish_buffers: retaining upload buffer (233984/262144): used=237568, refcnt=1
[   217.453] __kgem_busy: handle=2, busy=1, wedged=0
[   217.453] __kgem_busy: handle=3, busy=1, wedged=0
[   217.453] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.453] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.453] sna_accel_flush: flush?=0, dirty?=0
[   217.453] sna_copy_area: src=pixmap=1626:(0, 0)x(9, 20)+(0, 0) -> dst=pixmap=1170:(623, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.453] sna_copy_area: normal copy
[   217.453] sna_do_copy: src=(0, 0), dst=(623, 641), size=(9x20)
[   217.453] sna_do_copy: after drawable: src=(0, 0), dst=(623, 697), size=(9x20)
[   217.453] sna_do_copy: dst extents (623, 697), (632, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.453] sna_do_copy: clipped dst extents (623, 697), (632, 717)
[   217.453] sna_do_copy: unclipped src extents (0, 0), (9, 20)
[   217.453] sna_do_copy: clipped src extents (0, 0), (9, 20)
[   217.453] sna_do_copy: pixmap -- no source clipping
[   217.453] sna_do_copy: src extents (0, 0), (9, 20) x 1
[   217.453] sna_do_copy: copy region (623, 697), (632, 717) x 1 + (-623, -697)
[   217.453] sna_copy_boxes (boxes=1x[(623, 697), (632, 717)...], src pixmap=1626+(-623, -697), dst pixmap=1170+(0, -19), alu=3, src.size=9x20, dst.size=1366x749)
[   217.454] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd2e20, gpu_bo=0, cpu_bo=0), replaces=0
[   217.454] sna_drawable_use_bo pixmap=1170, box=((623, 678), (632, 698)), flags=8...
[   217.454] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.454] sna_drawable_use_bo: pinned, never REPLACES
[   217.454] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.454] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.454] sna_drawable_use_bo: using whole GPU bo
[   217.454] region_overlaps_damage?
[   217.454] use_shm_bo: no, not attached
[   217.454] sna_drawable_move_region_to_cpu(pixmap=1626 (9x20), [(0, 0), (9, 20)], flags=2)
[   217.454] sna_drawable_move_region_to_cpu: pixmap=1626 all damaged on CPU
[   217.454] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.454] sna_write_boxes x 1, src stride=36,  src dx=(-623, -678)
[   217.454] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.454] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.454] __kgem_busy: handle=112, busy=1, wedged=0
[   217.454] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.454] kgem_create_buffer: size=720, flags=3 [write?=1, inplace?=1, last?=0]
[   217.454] kgem_create_buffer: reusing buffer? used=237568 + size=720, total=262144
[   217.454] kgem_create_proxy: target handle=65310 [proxy? -1], offset=237568, length=720, io=1
[   217.454] __kgem_bo_init(handle=65310, num_pages=720)
[   217.454]   sna_write_boxes: box src=(0, 0), dst=(623, 678) size=(9, 20), dst offset=0, dst pitch=36
[   217.454] memcpy_blt: src=(0, 0), dst=(0, 0), size=9x20, pitch=36/36
[   217.454] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.454] kgem_add_handle: handle=112, index=0
[   217.454] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.454] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.454] kgem_add_reloc: adding proxy [delta=237568] for handle=65310
[   217.454] kgem_add_handle: handle=65310, index=1
[   217.454] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.454] sna_accel_flush: flush?=1, dirty?=0
[   217.454] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.454] kgem_finish_buffers: buffer handle=65310, used=238336, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.454] kgem_finish_buffers: retaining upload buffer (238336/262144): used=241664, refcnt=1
[   217.454] __kgem_busy: handle=2, busy=1, wedged=0
[   217.454] __kgem_busy: handle=3, busy=1, wedged=0
[   217.454] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.454] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.454] sna_accel_flush: flush?=0, dirty?=0
[   217.454] sna_accel_flush: flush?=0, dirty?=0
[   217.454] sna_block_handler (tv=0.0)
[   217.454] sna_wakeup_handler
[   217.455] sna_dri2_copy_region: pixmap=3, src=10 (refs=1/1, flush=0, attach=1) , dst=32 (refs=3/3, flush=1, attach=0)
[   217.455] sna_dri2_copy_region: region (29, 695), (335, 718) x 1
[   217.455] is_clipped: region[1]x(0, 0),(1366, 768) against drawable 1366x768
[   217.455] __sna_dri2_copy_region: source size 1366x768, region size 306x23, src offset 0x0
[   217.455] sna_pixmap_move_area_to_gpu: pixmap=3 box=(29, 695), (335, 718), flags=41
[   217.455] _sna_damage_subtract_box(None - (29, 695), (335, 718))...
[   217.455]   = None
[   217.455] sna_pixmap_move_area_to_gpu: already all-damaged
[   217.455] sna_pixmap_unclean(pixmap=3): cleaning foreign bo handle=32, busy=0 [ring=0]
[   217.455] __kgem_bo_clear_busy: handle=32
[   217.455] sna_pixmap_mark_active: pixmap=3, handle=32
[   217.455] __sna_dri2_copy_region: updated FrontLeft dst_bo from handle=32 to handle=32
[   217.455] __sna_dri2_copy_region: marking region as damaged
[   217.455] __sna_dri2_copy_region: copying [(29, 695), (335, 718)]x1 src=(0, 0), dst=(0, 0)
[   217.455] gen7_render_copy_boxes (0, 0)->(0, 0) x 1, alu=3, flags=11, self-copy=0, overlaps? 0
[   217.455] kgem_bo_is_render: handle=10, rq? 0 [0]
[   217.455] kgem_bo_is_render: handle=32, rq? 0 [0]
[   217.455] kgem_bo_is_render: handle=32, rq? 0 [0]
[   217.455] kgem_bo_is_render: handle=10, rq? 0 [0]
[   217.455] sna_blt_copy_boxes src=(0, 0) -> (0, 0) x 1, tiling=(1, 1), pitch=(5632, 5632)
[   217.455] __kgem_bcs_set_tiling: src handle=10:tiling=1, dst handle=32:tiling=1
[   217.455] sna_blt_copy_boxes: emitting 1 boxes out of 1 (batch space 16376)
[   217.455]   sna_blt_copy_boxes: box=(29, 695)x(306, 23)
[   217.455] kgem_add_reloc: handle=32, pos=4, delta=0, domains=28002
[   217.455] kgem_add_handle: handle=32, index=0
[   217.455] __kgem_bo_mark_dirty: handle=32 (proxy? 0)
[   217.455] kgem_add_reloc: handle=10, pos=7, delta=0, domains=28000
[   217.455] kgem_add_handle: handle=10, index=1
[   217.455] sna_accel_flush: flush?=1, dirty?=0
[   217.455] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=2112 [fenced=0]
[   217.455] __kgem_busy: handle=2, busy=1, wedged=0
[   217.455] __kgem_busy: handle=3, busy=1, wedged=0
[   217.455] kgem_commit: release handle=32 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=f742000
[   217.455] kgem_commit: release handle=10 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=e120000
[   217.455] sna_accel_flush: flush?=0, dirty?=0
[   217.455] sna_block_handler (tv=0.0)
[   217.455] sna_wakeup_handler
[   217.455] sna_accel_flush: flush?=0, dirty?=0
[   217.455] sna_block_handler (tv=0.0)
[   217.455] sna_wakeup_handler
[   217.455] sna_copy_area: src=pixmap=1630:(0, 0)x(10, 20)+(0, 0) -> dst=pixmap=1170:(632, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.456] sna_copy_area: normal copy
[   217.456] sna_do_copy: src=(0, 0), dst=(632, 641), size=(10x20)
[   217.456] sna_do_copy: after drawable: src=(0, 0), dst=(632, 697), size=(10x20)
[   217.456] sna_do_copy: dst extents (632, 697), (642, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.456] sna_do_copy: clipped dst extents (632, 697), (642, 717)
[   217.456] sna_do_copy: unclipped src extents (0, 0), (10, 20)
[   217.456] sna_do_copy: clipped src extents (0, 0), (10, 20)
[   217.456] sna_do_copy: pixmap -- no source clipping
[   217.456] sna_do_copy: src extents (0, 0), (10, 20) x 1
[   217.456] sna_do_copy: copy region (632, 697), (642, 717) x 1 + (-632, -697)
[   217.456] sna_copy_boxes (boxes=1x[(632, 697), (642, 717)...], src pixmap=1630+(-632, -697), dst pixmap=1170+(0, -19), alu=3, src.size=10x20, dst.size=1366x749)
[   217.456] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bd28d0, gpu_bo=0, cpu_bo=0), replaces=0
[   217.456] sna_drawable_use_bo pixmap=1170, box=((632, 678), (642, 698)), flags=8...
[   217.456] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.456] sna_drawable_use_bo: pinned, never REPLACES
[   217.456] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.456] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.456] sna_drawable_use_bo: using whole GPU bo
[   217.456] region_overlaps_damage?
[   217.456] use_shm_bo: no, not attached
[   217.456] sna_drawable_move_region_to_cpu(pixmap=1630 (10x20), [(0, 0), (10, 20)], flags=2)
[   217.456] sna_drawable_move_region_to_cpu: pixmap=1630 all damaged on CPU
[   217.456] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.456] sna_write_boxes x 1, src stride=40,  src dx=(-632, -678)
[   217.456] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.456] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.456] __kgem_busy: handle=112, busy=1, wedged=0
[   217.456] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.456] kgem_create_buffer: size=800, flags=3 [write?=1, inplace?=1, last?=0]
[   217.456] kgem_create_buffer: reusing buffer? used=241664 + size=800, total=262144
[   217.456] kgem_create_proxy: target handle=65310 [proxy? -1], offset=241664, length=800, io=1
[   217.456] __kgem_bo_init(handle=65310, num_pages=800)
[   217.456]   sna_write_boxes: box src=(0, 0), dst=(632, 678) size=(10, 20), dst offset=0, dst pitch=40
[   217.456] memcpy_blt: src=(0, 0), dst=(0, 0), size=10x20, pitch=40/40
[   217.456] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.456] kgem_add_handle: handle=112, index=0
[   217.456] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.456] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.456] kgem_add_reloc: adding proxy [delta=241664] for handle=65310
[   217.456] kgem_add_handle: handle=65310, index=1
[   217.456] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.456] sna_accel_flush: flush?=1, dirty?=0
[   217.457] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.457] kgem_finish_buffers: buffer handle=65310, used=242688, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.457] kgem_finish_buffers: retaining upload buffer (242688/262144): used=245760, refcnt=1
[   217.457] __kgem_busy: handle=2, busy=1, wedged=0
[   217.457] __kgem_busy: handle=3, busy=1, wedged=0
[   217.457] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.457] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.457] sna_accel_flush: flush?=0, dirty?=0
[   217.457] sna_copy_area: src=pixmap=1586:(0, 0)x(5, 20)+(0, 0) -> dst=pixmap=1170:(642, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.457] sna_copy_area: normal copy
[   217.457] sna_do_copy: src=(0, 0), dst=(642, 641), size=(5x20)
[   217.457] sna_do_copy: after drawable: src=(0, 0), dst=(642, 697), size=(5x20)
[   217.457] sna_do_copy: dst extents (642, 697), (647, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.457] sna_do_copy: clipped dst extents (642, 697), (647, 717)
[   217.457] sna_do_copy: unclipped src extents (0, 0), (5, 20)
[   217.457] sna_do_copy: clipped src extents (0, 0), (5, 20)
[   217.457] sna_do_copy: pixmap -- no source clipping
[   217.457] sna_do_copy: src extents (0, 0), (5, 20) x 1
[   217.457] sna_do_copy: copy region (642, 697), (647, 717) x 1 + (-642, -697)
[   217.457] sna_copy_boxes (boxes=1x[(642, 697), (647, 717)...], src pixmap=1586+(-642, -697), dst pixmap=1170+(0, -19), alu=3, src.size=5x20, dst.size=1366x749)
[   217.457] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bcaa80, gpu_bo=0, cpu_bo=0), replaces=0
[   217.457] sna_drawable_use_bo pixmap=1170, box=((642, 678), (647, 698)), flags=8...
[   217.457] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.457] sna_drawable_use_bo: pinned, never REPLACES
[   217.457] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.457] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.457] sna_drawable_use_bo: using whole GPU bo
[   217.457] region_overlaps_damage?
[   217.457] use_shm_bo: no, not attached
[   217.457] sna_drawable_move_region_to_cpu(pixmap=1586 (5x20), [(0, 0), (5, 20)], flags=2)
[   217.457] sna_drawable_move_region_to_cpu: pixmap=1586 all damaged on CPU
[   217.457] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.457] sna_write_boxes x 1, src stride=20,  src dx=(-642, -678)
[   217.457] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.457] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.457] __kgem_busy: handle=112, busy=1, wedged=0
[   217.457] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.457] kgem_create_buffer: size=400, flags=3 [write?=1, inplace?=1, last?=0]
[   217.457] kgem_create_buffer: reusing buffer? used=245760 + size=400, total=262144
[   217.457] kgem_create_proxy: target handle=65310 [proxy? -1], offset=245760, length=400, io=1
[   217.457] __kgem_bo_init(handle=65310, num_pages=400)
[   217.457]   sna_write_boxes: box src=(0, 0), dst=(642, 678) size=(5, 20), dst offset=0, dst pitch=20
[   217.457] memcpy_blt: src=(0, 0), dst=(0, 0), size=5x20, pitch=20/20
[   217.458] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.458] kgem_add_handle: handle=112, index=0
[   217.458] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.458] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.458] kgem_add_reloc: adding proxy [delta=245760] for handle=65310
[   217.458] kgem_add_handle: handle=65310, index=1
[   217.458] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.458] sna_accel_flush: flush?=1, dirty?=0
[   217.458] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.458] kgem_finish_buffers: buffer handle=65310, used=246272, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.458] kgem_finish_buffers: retaining upload buffer (246272/262144): used=249856, refcnt=1
[   217.458] __kgem_busy: handle=2, busy=1, wedged=0
[   217.458] __kgem_busy: handle=3, busy=1, wedged=0
[   217.458] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.458] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.458] sna_accel_flush: flush?=0, dirty?=0
[   217.458] sna_copy_area: src=pixmap=1930:(0, 0)x(10, 20)+(0, 0) -> dst=pixmap=1170:(647, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.458] sna_copy_area: normal copy
[   217.458] sna_do_copy: src=(0, 0), dst=(647, 641), size=(10x20)
[   217.458] sna_do_copy: after drawable: src=(0, 0), dst=(647, 697), size=(10x20)
[   217.458] sna_do_copy: dst extents (647, 697), (657, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.458] sna_do_copy: clipped dst extents (647, 697), (657, 717)
[   217.458] sna_do_copy: unclipped src extents (0, 0), (10, 20)
[   217.458] sna_do_copy: clipped src extents (0, 0), (10, 20)
[   217.458] sna_do_copy: pixmap -- no source clipping
[   217.458] sna_do_copy: src extents (0, 0), (10, 20) x 1
[   217.458] sna_do_copy: copy region (647, 697), (657, 717) x 1 + (-647, -697)
[   217.458] sna_copy_boxes (boxes=1x[(647, 697), (657, 717)...], src pixmap=1930+(-647, -697), dst pixmap=1170+(0, -19), alu=3, src.size=10x20, dst.size=1366x749)
[   217.458] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2d2b310, gpu_bo=0, cpu_bo=0), replaces=0
[   217.458] sna_drawable_use_bo pixmap=1170, box=((647, 678), (657, 698)), flags=8...
[   217.458] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.458] sna_drawable_use_bo: pinned, never REPLACES
[   217.458] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.458] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.458] sna_drawable_use_bo: using whole GPU bo
[   217.458] region_overlaps_damage?
[   217.458] use_shm_bo: no, not attached
[   217.458] sna_drawable_move_region_to_cpu(pixmap=1930 (10x20), [(0, 0), (10, 20)], flags=2)
[   217.458] sna_drawable_move_region_to_cpu: pixmap=1930 all damaged on CPU
[   217.458] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.458] sna_write_boxes x 1, src stride=40,  src dx=(-647, -678)
[   217.459] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.459] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.459] __kgem_busy: handle=112, busy=1, wedged=0
[   217.459] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.459] kgem_create_buffer: size=800, flags=3 [write?=1, inplace?=1, last?=0]
[   217.459] kgem_create_buffer: reusing buffer? used=249856 + size=800, total=262144
[   217.459] kgem_create_proxy: target handle=65310 [proxy? -1], offset=249856, length=800, io=1
[   217.459] __kgem_bo_init(handle=65310, num_pages=800)
[   217.459]   sna_write_boxes: box src=(0, 0), dst=(647, 678) size=(10, 20), dst offset=0, dst pitch=40
[   217.459] memcpy_blt: src=(0, 0), dst=(0, 0), size=10x20, pitch=40/40
[   217.459] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.459] kgem_add_handle: handle=112, index=0
[   217.459] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.459] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.459] kgem_add_reloc: adding proxy [delta=249856] for handle=65310
[   217.459] kgem_add_handle: handle=65310, index=1
[   217.459] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.459] sna_accel_flush: flush?=1, dirty?=0
[   217.459] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.459] kgem_finish_buffers: buffer handle=65310, used=250880, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.459] kgem_finish_buffers: retaining upload buffer (250880/262144): used=253952, refcnt=1
[   217.459] __kgem_busy: handle=2, busy=1, wedged=0
[   217.459] __kgem_busy: handle=3, busy=1, wedged=0
[   217.459] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.459] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.459] sna_accel_flush: flush?=0, dirty?=0
[   217.459] sna_copy_area: src=pixmap=1586:(0, 0)x(5, 20)+(0, 0) -> dst=pixmap=1170:(657, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.459] sna_copy_area: normal copy
[   217.459] sna_do_copy: src=(0, 0), dst=(657, 641), size=(5x20)
[   217.459] sna_do_copy: after drawable: src=(0, 0), dst=(657, 697), size=(5x20)
[   217.459] sna_do_copy: dst extents (657, 697), (662, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.459] sna_do_copy: clipped dst extents (657, 697), (662, 717)
[   217.459] sna_do_copy: unclipped src extents (0, 0), (5, 20)
[   217.459] sna_do_copy: clipped src extents (0, 0), (5, 20)
[   217.459] sna_do_copy: pixmap -- no source clipping
[   217.459] sna_do_copy: src extents (0, 0), (5, 20) x 1
[   217.459] sna_do_copy: copy region (657, 697), (662, 717) x 1 + (-657, -697)
[   217.459] sna_copy_boxes (boxes=1x[(657, 697), (662, 717)...], src pixmap=1586+(-657, -697), dst pixmap=1170+(0, -19), alu=3, src.size=5x20, dst.size=1366x749)
[   217.459] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bcaa80, gpu_bo=0, cpu_bo=0), replaces=0
[   217.459] sna_drawable_use_bo pixmap=1170, box=((657, 678), (662, 698)), flags=8...
[   217.459] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.459] sna_drawable_use_bo: pinned, never REPLACES
[   217.460] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.460] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.460] sna_drawable_use_bo: using whole GPU bo
[   217.460] region_overlaps_damage?
[   217.460] use_shm_bo: no, not attached
[   217.460] sna_drawable_move_region_to_cpu(pixmap=1586 (5x20), [(0, 0), (5, 20)], flags=2)
[   217.460] sna_drawable_move_region_to_cpu: pixmap=1586 all damaged on CPU
[   217.460] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.460] sna_write_boxes x 1, src stride=20,  src dx=(-657, -678)
[   217.460] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.460] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.460] __kgem_busy: handle=112, busy=1, wedged=0
[   217.460] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.460] kgem_create_buffer: size=400, flags=3 [write?=1, inplace?=1, last?=0]
[   217.460] kgem_create_buffer: reusing buffer? used=253952 + size=400, total=262144
[   217.460] kgem_create_proxy: target handle=65310 [proxy? -1], offset=253952, length=400, io=1
[   217.460] __kgem_bo_init(handle=65310, num_pages=400)
[   217.460]   sna_write_boxes: box src=(0, 0), dst=(657, 678) size=(5, 20), dst offset=0, dst pitch=20
[   217.460] memcpy_blt: src=(0, 0), dst=(0, 0), size=5x20, pitch=20/20
[   217.460] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.460] kgem_add_handle: handle=112, index=0
[   217.460] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.460] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.460] kgem_add_reloc: adding proxy [delta=253952] for handle=65310
[   217.460] kgem_add_handle: handle=65310, index=1
[   217.460] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.460] sna_accel_flush: flush?=1, dirty?=0
[   217.460] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.460] kgem_finish_buffers: buffer handle=65310, used=254464, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.460] kgem_finish_buffers: retaining upload buffer (254464/262144): used=258048, refcnt=1
[   217.460] __kgem_busy: handle=2, busy=1, wedged=0
[   217.460] __kgem_busy: handle=3, busy=1, wedged=0
[   217.460] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.460] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.460] sna_accel_flush: flush?=0, dirty?=0
[   217.460] sna_copy_area: src=pixmap=1748:(0, 0)x(7, 20)+(0, 0) -> dst=pixmap=1170:(662, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.460] sna_copy_area: normal copy
[   217.460] sna_do_copy: src=(0, 0), dst=(662, 641), size=(7x20)
[   217.460] sna_do_copy: after drawable: src=(0, 0), dst=(662, 697), size=(7x20)
[   217.460] sna_do_copy: dst extents (662, 697), (669, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.460] sna_do_copy: clipped dst extents (662, 697), (669, 717)
[   217.461] sna_do_copy: unclipped src extents (0, 0), (7, 20)
[   217.461] sna_do_copy: clipped src extents (0, 0), (7, 20)
[   217.461] sna_do_copy: pixmap -- no source clipping
[   217.461] sna_do_copy: src extents (0, 0), (7, 20) x 1
[   217.461] sna_do_copy: copy region (662, 697), (669, 717) x 1 + (-662, -697)
[   217.461] sna_copy_boxes (boxes=1x[(662, 697), (669, 717)...], src pixmap=1748+(-662, -697), dst pixmap=1170+(0, -19), alu=3, src.size=7x20, dst.size=1366x749)
[   217.461] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2c00420, gpu_bo=0, cpu_bo=0), replaces=0
[   217.461] sna_drawable_use_bo pixmap=1170, box=((662, 678), (669, 698)), flags=8...
[   217.461] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.461] sna_drawable_use_bo: pinned, never REPLACES
[   217.461] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.461] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.461] sna_drawable_use_bo: using whole GPU bo
[   217.461] region_overlaps_damage?
[   217.461] use_shm_bo: no, not attached
[   217.461] sna_drawable_move_region_to_cpu(pixmap=1748 (7x20), [(0, 0), (7, 20)], flags=2)
[   217.461] sna_drawable_move_region_to_cpu: pixmap=1748 all damaged on CPU
[   217.461] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.461] sna_write_boxes x 1, src stride=28,  src dx=(-662, -678)
[   217.461] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.461] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.461] __kgem_busy: handle=112, busy=1, wedged=0
[   217.461] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.461] kgem_create_buffer: size=560, flags=3 [write?=1, inplace?=1, last?=0]
[   217.461] kgem_create_buffer: reusing buffer? used=258048 + size=560, total=262144
[   217.461] kgem_create_proxy: target handle=65310 [proxy? -1], offset=258048, length=560, io=1
[   217.461] __kgem_bo_init(handle=65310, num_pages=560)
[   217.461]   sna_write_boxes: box src=(0, 0), dst=(662, 678) size=(7, 20), dst offset=0, dst pitch=28
[   217.461] memcpy_blt: src=(0, 0), dst=(0, 0), size=7x20, pitch=28/28
[   217.461] kgem_add_reloc: handle=112, pos=4, delta=0, domains=28002
[   217.461] kgem_add_handle: handle=112, index=0
[   217.461] __kgem_bo_mark_dirty: handle=112 (proxy? 0)
[   217.461] kgem_add_reloc: handle=65310, pos=7, delta=0, domains=28000
[   217.461] kgem_add_reloc: adding proxy [delta=258048] for handle=65310
[   217.461] kgem_add_handle: handle=65310, index=1
[   217.461] _kgem_bo_destroy: handle=65310, proxy? 1
[   217.461] sna_accel_flush: flush?=1, dirty?=0
[   217.461] batch[3/3, flags=1800]: 10 10 16384 16384, nreloc=2, nexec=2, nfence=0, aperture=1120 [fenced=0]
[   217.461] kgem_finish_buffers: buffer handle=65310, used=258816, exec?=1, write=1, mmapped=cpu, refcnt=1
[   217.461] kgem_finish_buffers: discarding mmapped buffer, used=258816, map type=2
[   217.461] kgem_finish_buffers: releasing handle=65310
[   217.461] __kgem_bo_destroy: handle=65310, size=262144
[   217.461] kgem_bo_replace_io: transferring io handle=65310 to bo
[   217.462] __kgem_bo_destroy: handle=65310 -> active
[   217.462] __kgem_busy: handle=2, busy=1, wedged=0
[   217.462] __kgem_busy: handle=3, busy=1, wedged=0
[   217.462] kgem_commit: release handle=112 (proxy? 0), dirty? 1 flush? 1, snoop? 0 -> offset=635f4000
[   217.462] kgem_commit: release handle=65310 (proxy? 0), dirty? 0 flush? 0, snoop? 0 -> offset=16479000
[   217.462] sna_accel_flush: flush?=0, dirty?=0
[   217.462] sna_accel_flush: flush?=0, dirty?=0
[   217.462] sna_block_handler (tv=0.0)
[   217.462] sna_wakeup_handler
[   217.462] sna_accel_flush: flush?=0, dirty?=0
[   217.462] sna_accel_flush: flush?=0, dirty?=0
[   217.462] sna_block_handler (tv=0.0)
[   217.462] sna_wakeup_handler
[   217.462] sna_copy_area: src=pixmap=1722:(0, 0)x(8, 20)+(0, 0) -> dst=pixmap=1170:(669, 641)+(0, 56); alu=3, pm=ffffffff, depth=24
[   217.462] sna_copy_area: normal copy
[   217.462] sna_do_copy: src=(0, 0), dst=(669, 641), size=(8x20)
[   217.462] sna_do_copy: after drawable: src=(0, 0), dst=(669, 697), size=(8x20)
[   217.462] sna_do_copy: dst extents (669, 697), (677, 717), dst clip extents (0, 72), (1354, 752), dst size=1366x712
[   217.462] sna_do_copy: clipped dst extents (669, 697), (677, 717)
[   217.462] sna_do_copy: unclipped src extents (0, 0), (8, 20)
[   217.462] sna_do_copy: clipped src extents (0, 0), (8, 20)
[   217.462] sna_do_copy: pixmap -- no source clipping
[   217.462] sna_do_copy: src extents (0, 0), (8, 20) x 1
[   217.462] sna_do_copy: copy region (669, 697), (677, 717) x 1 + (-669, -697)
[   217.462] sna_copy_boxes (boxes=1x[(669, 697), (677, 717)...], src pixmap=1722+(-669, -697), dst pixmap=1170+(0, -19), alu=3, src.size=8x20, dst.size=1366x749)
[   217.462] sna_copy_boxes: dst=(priv=0x28987d0, gpu_bo=112, cpu_bo=23), src=(priv=0x2bf6220, gpu_bo=0, cpu_bo=0), replaces=0
[   217.462] sna_drawable_use_bo pixmap=1170, box=((669, 678), (677, 698)), flags=8...
[   217.462] sna_drawable_use_bo: exported target, set PREFER_GPU
[   217.462] sna_drawable_use_bo: pinned, never REPLACES
[   217.462] sna_drawable_use_bo: flush=3, shm=0, cpu=0 => flags=9
[   217.462] sna_drawable_use_bo: use GPU fast path (all-damaged)
[   217.462] sna_drawable_use_bo: using whole GPU bo
[   217.462] region_overlaps_damage?
[   217.462] use_shm_bo: no, not attached
[   217.462] sna_drawable_move_region_to_cpu(pixmap=1722 (8x20), [(0, 0), (8, 20)], flags=2)
[   217.462] sna_drawable_move_region_to_cpu: pixmap=1722 all damaged on CPU
[   217.462] sna_copy_boxes: dst is on the GPU, src is on the CPU, uploading into dst
[   217.462] sna_write_boxes x 1, src stride=32,  src dx=(-669, -678)
[   217.462] kgem_bo_can_map: handle=112, map=0x0:0x0:0x0, tiling=1, domain=3, offset=1667186688
[   217.462] __kgem_bo_is_busy: handle=112, domain: 3 exec? 0, rq? 1
[   217.462] __kgem_busy: handle=112, busy=1, wedged=0
[   217.463] __kgem_bcs_set_tiling: src handle=0:tiling=0, dst handle=112:tiling=1
[   217.463] kgem_create_buffer: size=640, flags=3 [write?=1, inplace?=1, last?=0]
[   217.463] kgem_create_buffer: searching for an inactive GTT map for upload
[   217.463] search_linear_cache: num_pages=64, flags=b, use_active? 0, use_large=0 [max=65536]
[   217.463] search_linear_cache: inactive and cache bucket empty
[   217.463] kgem_retire, need_retire?=1
[   217.463] __kgem_busy: handle=43, busy=1, wedged=0
[   217.463] kgem_retire__flushing: 3 bo on flushing list
[   217.463] sigtrap_handler(sig=11) sigtrap=0
[   217.465] (EE) 
[   217.466] (EE) Backtrace:
[   217.472] (EE) 0: /usr/bin/Xorg (OsSigHandler+0x29) [0x5a34a9]
[   217.535] (EE) 1: /lib64/libc.so.6 (killpg+0x40) [0x7f070117652f]
[   217.614] (EE) 2: /usr/lib64/xorg/modules/drivers/intel_drv.so (kgem_retire__requests_ring+0x1a) [0x7f06ff119490]
[   217.673] (EE) 3: /usr/lib64/xorg/modules/drivers/intel_drv.so (kgem_retire__requests+0x1e) [0x7f06ff11955e]
[   217.735] (EE) 4: /usr/lib64/xorg/modules/drivers/intel_drv.so (kgem_retire+0x50) [0x7f06ff119abb]
[   217.794] (EE) 5: /usr/lib64/xorg/modules/drivers/intel_drv.so (__kgem_throttle_retire+0x3f) [0x7f06ff119b37]
[   217.854] (EE) 6: /usr/lib64/xorg/modules/drivers/intel_drv.so (search_linear_cache+0x26b) [0x7f06ff119fd0]
[   217.914] (EE) 7: /usr/lib64/xorg/modules/drivers/intel_drv.so (kgem_create_buffer+0x5fa) [0x7f06ff124470]
[   217.973] (EE) 8: /usr/lib64/xorg/modules/drivers/intel_drv.so (sna_write_boxes+0x13c6) [0x7f06ff18dc18]
[   218.033] (EE) 9: /usr/lib64/xorg/modules/drivers/intel_drv.so (sna_copy_boxes+0x14dc) [0x7f06ff1595b1]
[   218.093] (EE) 10: /usr/lib64/xorg/modules/drivers/intel_drv.so (sna_do_copy+0x7c8) [0x7f06ff12fd07]
[   218.152] (EE) 11: /usr/lib64/xorg/modules/drivers/intel_drv.so (sna_copy_area+0x1e2) [0x7f06ff12ff9a]
[   218.153] (EE) 12: /usr/bin/Xorg (damageCopyArea+0xd3) [0x526123]
[   218.153] (EE) 13: /usr/bin/Xorg (ProcCopyArea+0x161) [0x435cb1]
[   218.153] (EE) 14: /usr/bin/Xorg (Dispatch+0x287) [0x439ed7]
[   218.153] (EE) 15: /usr/bin/Xorg (dix_main+0x3f5) [0x43e0a5]
[   218.213] (EE) 16: /lib64/libc.so.6 (__libc_start_main+0xf0) [0x7f0701163730]
[   218.213] (EE) 17: /usr/bin/Xorg (_start+0x29) [0x427e59]
[   218.278] (EE) 18: ? (?+0x29) [0x29]
[   218.278] (EE) 
[   218.278] (EE) Segmentation fault at address 0x80
[   218.278] (EE) 
Fatal server error:
[   218.278] (EE) Caught signal 11 (Segmentation fault). Server aborting
[   218.278] (EE) 
[   218.280] (EE) 
Please consult the The X.Org Foundation support 
	 at http://wiki.x.org
 for help. 
[   218.280] (EE) Please also check the log file at "/home/dominic/.local/share/xorg/Xorg.0.log" for additional information.
[   218.280] (EE) 
[   218.281] (II) AIGLX: Suspending AIGLX clients for VT switch
[   218.281] sna_leave_vt
[   218.281] sna_accel_leave
[   218.281] sna_accel_leave: dropping render privileges
[   218.281] sna_mode_reset
[   218.282] sna_disable_cursors
[   218.282] sna_crtc_disable_cursor: CRTC:20, handle=13
[   218.286] __sna_crtc_disable: releasing handle=32 from scanout, active=0
[   218.286] rotation_set: obj=22, type=eeeeeeee prop=18 set-rotation=1
[   218.286] rotation_set: obj=26, type=eeeeeeee prop=18 set-rotation=1
[   218.307] (EE) Server terminated with error (1). Closing log file.