[60.380899] Initializing watchdogs
[60.380943]   /dev/watchdog0
[60.394972] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.399801] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.402026] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.405769] [001/132] (960s left) gem_exec_schedule (u-submit-golden-slice)
[60.499424] Starting subtest: u-submit-golden-slice
[60.501299] Starting dynamic subtest: rcs0
[60.552583] Dynamic subtest rcs0: SUCCESS (0.058s)
[60.560454] Starting dynamic subtest: bcs0
[60.595918] Dynamic subtest bcs0: SUCCESS (0.043s)
[60.605085] Starting dynamic subtest: vcs0
[60.644904] Dynamic subtest vcs0: SUCCESS (0.049s)
[60.652235] Starting dynamic subtest: vcs1
[60.689824] Dynamic subtest vcs1: SUCCESS (0.044s)
[60.700294] Starting dynamic subtest: vecs0
[60.743750] Dynamic subtest vecs0: SUCCESS (0.053s)
[60.754333] Starting dynamic subtest: ccs0
[60.797368] Dynamic subtest ccs0: SUCCESS (0.053s)
[60.800393] Subtest u-submit-golden-slice: SUCCESS (0.303s)
[62.000810] [002/132] (958s left) gem_create (busy-create)
[62.053327] Starting subtest: busy-create
[62.055592] Starting dynamic subtest: smem0
[95.903073] Dynamic subtest smem0: SUCCESS (33.848s)
[95.905502] Subtest busy-create: SUCCESS (33.849s)
[96.098744] [003/132] (924s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[96.203605] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[96.207662] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[96.276889] [004/132] (924s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[96.382227] Starting subtest: 4-tiled-64bpp-rotate-180
[97.995285] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.614s)
[98.170993] [005/132] (922s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[98.235961] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[98.300756] [006/132] (922s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[98.398930] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[98.402341] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.490786] [007/132] (922s left) kms_vrr (seamless-rr-switch-drrs)
[98.597304] Starting subtest: seamless-rr-switch-drrs
[98.602623] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[98.667184] [008/132] (922s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[98.731991] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[98.735851] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[98.911936] [009/132] (922s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[99.032622] Starting subtest: protected-encrypted-src-copy-not-readible
[99.145079] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[99.246591] [010/132] (921s left) kms_big_fb (linear-64bpp-rotate-180)
[99.344405] Starting subtest: linear-64bpp-rotate-180
[100.977441] Subtest linear-64bpp-rotate-180: SUCCESS (1.634s)
[101.165517] [011/132] (920s left) syncobj_basic (bad-fd-to-handle)
[101.218237] Starting subtest: bad-fd-to-handle
[101.220564] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[101.303198] [012/132] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[101.395076] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[108.492450] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.101s)
[108.648573] [013/132] (912s left) gem_exec_big (single)
[108.707819] Starting subtest: single
[112.204743] Subtest single: FAIL (3.437s)
[112.240822] [014/132] (909s left) kms_psr (psr-cursor-plane-onoff)
[112.378739] Starting subtest: psr-cursor-plane-onoff
[112.381078] Starting dynamic subtest: eDP-1
[114.092366] Dynamic subtest eDP-1: SUCCESS (1.712s)
[114.094610] Subtest psr-cursor-plane-onoff: SUCCESS (1.712s)
[114.941867] [015/132] (906s left) gem_ctx_create (basic)
[115.016579] Starting subtest: basic
[115.018956] Subtest basic: SUCCESS (0.000s)
[115.199026] [016/132] (906s left) perf_pmu (rc6-suspend)
[115.247721] Starting subtest: rc6-suspend
[137.864471] Subtest rc6-suspend: SUCCESS (7.687s)
[138.724868] [017/132] (882s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[138.791818] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[138.900248] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[138.975851] [018/132] (882s left) sw_sync (alloc_merge_fence)
[139.008851] Starting subtest: alloc_merge_fence
[139.011093] Subtest alloc_merge_fence: SUCCESS (0.000s)
[139.061612] [019/132] (882s left) kms_content_protection (content-type-change)
[139.200182] Starting subtest: content-type-change
[139.204605] Subtest content-type-change: SKIP (0.000s)
[139.329478] [020/132] (882s left) kms_joiner (basic-max-non-joiner)
[139.432837] Starting subtest: basic-max-non-joiner
[139.437088] Subtest basic-max-non-joiner: SKIP (0.000s)
[139.495226] [021/132] (882s left) kms_rotation_crc (primary-rotation-90)
[139.591182] Starting subtest: primary-rotation-90
[139.595487] Subtest primary-rotation-90: SKIP (0.001s)
[139.671594] [022/132] (882s left) gem_exec_schedule (preempt-other-chain)
[139.738037] Starting subtest: preempt-other-chain
[139.739973] Starting dynamic subtest: rcs0
[139.820673] Dynamic subtest rcs0: SUCCESS (0.086s)
[139.830124] Starting dynamic subtest: bcs0
[139.910708] Dynamic subtest bcs0: SUCCESS (0.094s)
[139.922782] Starting dynamic subtest: vcs0
[139.999249] Dynamic subtest vcs0: SUCCESS (0.089s)
[140.009302] Starting dynamic subtest: vcs1
[140.083612] Dynamic subtest vcs1: SUCCESS (0.084s)
[140.100524] Starting dynamic subtest: vecs0
[140.160385] Dynamic subtest vecs0: SUCCESS (0.076s)
[140.177479] Starting dynamic subtest: ccs0
[140.241030] Dynamic subtest ccs0: SUCCESS (0.080s)
[140.243276] Subtest preempt-other-chain: SUCCESS (0.510s)
[140.932370] [023/132] (880s left) gem_exec_params (invalid-bsd-ring)
[140.989551] Starting subtest: invalid-bsd-ring
[140.991589] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[141.087823] [024/132] (880s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[141.201391] Starting subtest: y-tiled-64bpp-rotate-180
[141.205412] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[141.286017] [025/132] (880s left) kms_cursor_edge_walk (256x256-top-edge)
[141.391132] Starting subtest: 256x256-top-edge
[141.393417] Starting dynamic subtest: pipe-A-eDP-1
[144.854105] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[144.865846] Starting dynamic subtest: pipe-D-eDP-1
[147.982108] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[147.984633] Subtest 256x256-top-edge: SUCCESS (6.591s)
[148.771229] [026/132] (873s left) kms_color (ctm-green-to-red)
[148.854444] Starting subtest: ctm-green-to-red
[148.856680] Starting dynamic subtest: pipe-A-eDP-1
[149.519464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.664s)
[149.530062] Starting dynamic subtest: pipe-B-eDP-1
[150.981537] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s)
[150.991437] Starting dynamic subtest: pipe-C-eDP-1
[152.314453] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.333s)
[152.323919] Starting dynamic subtest: pipe-D-eDP-1
[153.644173] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[153.646204] Subtest ctm-green-to-red: SUCCESS (4.788s)
[154.486316] [027/132] (867s left) kms_flip (plain-flip-fb-recreate-interruptible)
[154.579761] Starting subtest: plain-flip-fb-recreate-interruptible
[154.582058] Starting dynamic subtest: A-eDP1
[163.389202] Dynamic subtest A-eDP1: SUCCESS (8.809s)
[163.398321] Starting dynamic subtest: B-eDP1
[172.222441] Dynamic subtest B-eDP1: SUCCESS (8.831s)
[172.231889] Starting dynamic subtest: C-eDP1
[181.054748] Dynamic subtest C-eDP1: SUCCESS (8.831s)
[181.064033] Starting dynamic subtest: D-eDP1
[189.897463] Dynamic subtest D-eDP1: SUCCESS (8.841s)
[189.903840] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.323s)
[191.068692] [028/132] (830s left) kms_flip (2x-flip-vs-fences-interruptible)
[191.160430] Starting subtest: 2x-flip-vs-fences-interruptible
[191.164657] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[191.283791] [029/132] (830s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[191.398211] Starting subtest: flip-vs-cursor-legacy
[198.851196] Subtest flip-vs-cursor-legacy: SUCCESS (7.450s)
[199.698496] [030/132] (822s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[199.800058] Starting subtest: yf-tiled-16bpp-rotate-0
[199.804000] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[199.901078] [031/132] (822s left) gem_exec_whisper (basic-queues-forked-all)
[199.960935] Starting subtest: basic-queues-forked-all
[218.336149] Subtest basic-queues-forked-all: SUCCESS (18.370s)
[218.518370] [032/132] (803s left) kms_psr (pr-sprite-mmap-cpu)
[218.609513] Starting subtest: pr-sprite-mmap-cpu
[218.613773] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[218.689020] [033/132] (803s left) kms_draw_crc (draw-method-blt)
[218.781398] Starting subtest: draw-method-blt
[218.783229] Starting dynamic subtest: xrgb8888-untiled
[219.037610] Dynamic subtest xrgb8888-untiled: SUCCESS (0.258s)
[219.048450] Starting dynamic subtest: rgb565-untiled
[219.248751] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[219.260026] Starting dynamic subtest: xrgb2101010-untiled
[219.460178] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[219.471887] Starting dynamic subtest: xbgr16161616f-untiled
[219.681271] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[219.694727] Starting dynamic subtest: xrgb8888-xtiled
[219.792428] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[219.800908] Starting dynamic subtest: rgb565-xtiled
[219.903757] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[219.912831] Starting dynamic subtest: xrgb2101010-xtiled
[220.003955] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.100s)
[220.014738] Starting dynamic subtest: xbgr16161616f-xtiled
[220.114860] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[220.123363] Starting dynamic subtest: xrgb8888-4tiled
[220.237148] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[220.246943] Starting dynamic subtest: rgb565-4tiled
[220.370321] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[220.379840] Starting dynamic subtest: xrgb2101010-4tiled
[220.470436] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.100s)
[220.480037] Starting dynamic subtest: xbgr16161616f-4tiled
[220.570494] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[220.572391] Subtest draw-method-blt: SUCCESS (1.791s)
[220.674257] [034/132] (801s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[220.776605] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[224.760243] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.987s)
[225.918221] [035/132] (796s left) prime_mmap (test_forked_cpu_write)
[225.969483] Starting subtest: test_forked_cpu_write
[225.971472] Starting dynamic subtest: test_forked_cpu_write-smem
[225.979569] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.012s)
[225.981857] Subtest test_forked_cpu_write: SUCCESS (0.013s)
[226.089354] [036/132] (796s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[226.179997] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[229.912135] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.735s)
[231.111727] [037/132] (791s left) syncobj_timeline (invalid-signal-illegal-point)
[231.166826] Starting subtest: invalid-signal-illegal-point
[231.169069] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[231.260089] [038/132] (791s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[231.349059] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[231.353225] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[231.418236] [039/132] (790s left) gem_busy (extended)
[231.610758] Starting subtest: extended
[231.612894] Starting dynamic subtest: rcs0
[231.703444] Dynamic subtest rcs0: SUCCESS (0.096s)
[231.714841] Starting dynamic subtest: bcs0
[231.746698] Dynamic subtest bcs0: SUCCESS (0.041s)
[231.757907] Starting dynamic subtest: vcs0
[232.873988] Dynamic subtest vcs0: SUCCESS (1.124s)
[232.884626] Starting dynamic subtest: vcs1
[234.856231] Dynamic subtest vcs1: SUCCESS (1.979s)
[234.867389] Starting dynamic subtest: vecs0
[236.841433] Dynamic subtest vecs0: SUCCESS (1.984s)
[236.854491] Starting dynamic subtest: ccs0
[236.887888] Dynamic subtest ccs0: SUCCESS (0.045s)
[236.890347] Subtest extended: SUCCESS (5.282s)
[237.127683] [040/132] (785s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[237.224568] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[237.226847] Starting dynamic subtest: pipe-A-eDP-1
[237.309069] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[237.319036] Starting dynamic subtest: pipe-B-eDP-1
[238.476770] Dynamic subtest pipe-B-eDP-1: SKIP (1.165s)
[238.481338] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.256s)
[239.670957] [041/132] (782s left) gem_wait (write-busy)
[239.731002] Starting subtest: write-busy
[239.733413] Starting dynamic subtest: all-engines
[240.386707] Dynamic subtest all-engines: SUCCESS (0.655s)
[240.403123] Starting dynamic subtest: rcs0
[240.938117] Dynamic subtest rcs0: SUCCESS (0.549s)
[240.954016] Starting dynamic subtest: bcs0
[241.485387] Dynamic subtest bcs0: SUCCESS (0.546s)
[241.502486] Starting dynamic subtest: vcs0
[242.855281] Dynamic subtest vcs0: SUCCESS (1.368s)
[242.871712] Starting dynamic subtest: vcs1
[244.852380] Dynamic subtest vcs1: SUCCESS (1.985s)
[244.861570] Starting dynamic subtest: vecs0
[246.822990] Dynamic subtest vecs0: SUCCESS (1.979s)
[246.839267] Starting dynamic subtest: ccs0
[247.372892] Dynamic subtest ccs0: SUCCESS (0.549s)
[247.375627] Subtest write-busy: SUCCESS (7.642s)
[247.581288] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[247.584804] [042/132] (774s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[247.703156] Starting subtest: flip-vs-cursor-busy-crc-legacy
[248.486185] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.784s)
[249.317437] [043/132] (773s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[249.412378] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[249.414733] Starting dynamic subtest: pipe-A-eDP-1
[251.523431] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.113s)
[251.532561] Starting dynamic subtest: pipe-B-eDP-1
[253.789172] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.266s)
[253.801287] Starting dynamic subtest: pipe-C-eDP-1
[255.881410] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.090s)
[255.891557] Starting dynamic subtest: pipe-D-eDP-1
[257.982859] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.100s)
[257.984864] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.574s)
[259.157701] [044/132] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[259.264199] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[259.268305] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[259.373315] [045/132] (763s left) gem_linear_blits (interruptible)
[259.583598] Starting subtest: interruptible
[263.707974] Subtest interruptible: SUCCESS (4.124s)
[263.900223] [046/132] (758s left) kms_lease (lease-invalid-crtc)
[264.041129] Starting subtest: lease-invalid-crtc
[264.043251] Starting dynamic subtest: pipe-A-eDP-1
[264.045513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[264.055007] Starting dynamic subtest: pipe-B-eDP-1
[264.057181] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[264.066605] Starting dynamic subtest: pipe-C-eDP-1
[264.068847] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[264.077483] Starting dynamic subtest: pipe-D-eDP-1
[264.079509] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[264.081660] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[264.118686] [047/132] (758s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[264.202820] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[264.205089] Starting dynamic subtest: pipe-A-eDP-1
[264.355221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s)
[264.376295] Starting dynamic subtest: pipe-B-eDP-1
[264.397526] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[264.413881] Starting dynamic subtest: pipe-C-eDP-1
[264.432974] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[264.442643] Starting dynamic subtest: pipe-D-eDP-1
[264.461636] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[264.463857] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.181s)
[266.624866] [048/132] (756s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[266.736092] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[273.331900] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.599s)
[273.448752] [049/132] (749s left) kms_pm_rpm (modeset-lpsp-stress)
[274.997694] Starting subtest: modeset-lpsp-stress
[291.421491] Subtest modeset-lpsp-stress: SUCCESS (16.426s)
[291.511029] [050/132] (731s left) syncobj_timeline (multi-wait-submitted-signaled)
[291.570032] Starting subtest: multi-wait-submitted-signaled
[291.572314] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[291.645266] [051/132] (731s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[291.742175] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[296.591203] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.852s)
[297.786425] [052/132] (725s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[297.893212] Starting subtest: x-tiled-8bpp-rotate-0
[299.118267] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.226s)
[299.241672] [053/132] (723s left) gem_exec_schedule (promotion)
[299.312372] Starting subtest: promotion
[299.314112] Starting dynamic subtest: rcs0
[299.417458] Dynamic subtest rcs0: SUCCESS (0.107s)
[299.430508] Starting dynamic subtest: vcs0
[299.508722] Dynamic subtest vcs0: SUCCESS (0.090s)
[299.529967] Starting dynamic subtest: vcs1
[299.597838] Dynamic subtest vcs1: SUCCESS (0.088s)
[299.610218] Starting dynamic subtest: vecs0
[299.681484] Dynamic subtest vecs0: SUCCESS (0.082s)
[299.693810] Starting dynamic subtest: ccs0
[299.771612] Dynamic subtest ccs0: SUCCESS (0.089s)
[299.773872] Subtest promotion: SUCCESS (0.463s)
[300.943926] [054/132] (722s left) kms_cursor_crc (cursor-onscreen-128x128)
[301.141058] Starting subtest: cursor-onscreen-128x128
[301.145874] Starting dynamic subtest: pipe-A-eDP-1
[303.257092] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[303.285369] Starting dynamic subtest: pipe-D-eDP-1
[306.046239] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[306.048380] Subtest cursor-onscreen-128x128: SUCCESS (4.905s)
[306.839301] [055/132] (716s left) kms_getfb (getfb2-handle-not-fb)
[306.945315] Starting subtest: getfb2-handle-not-fb
[306.947466] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[307.047720] [056/132] (716s left) gem_mmap_offset (perf)
[307.115285] Starting subtest: perf
[307.117409] Starting dynamic subtest: smem0
[307.472448] Dynamic subtest smem0: SUCCESS (0.354s)
[307.475065] Subtest perf: SUCCESS (0.356s)
[307.597918] [057/132] (715s left) gem_ctx_param (invalid-get-ringsize)
[307.665573] Starting subtest: invalid-get-ringsize
[307.667942] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[307.773307] [058/132] (715s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[307.870437] Starting subtest: yf-tiled-8bpp-rotate-180
[307.874906] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[307.978876] [059/132] (715s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[308.084149] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[308.088166] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[308.194319] [060/132] (715s left) gem_exec_flush (basic-batch-kernel-default-uc)
[308.260014] Starting subtest: basic-batch-kernel-default-uc
[315.734605] Subtest basic-batch-kernel-default-uc: SUCCESS (7.474s)
[315.925174] [061/132] (707s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[316.030105] Starting subtest: fbc-rgb565-draw-render
[320.174074] Subtest fbc-rgb565-draw-render: SUCCESS (4.147s)
[321.344366] [062/132] (701s left) kms_pm_dc (dc5-dpms)
[322.456526] Starting subtest: dc5-dpms
[324.511169] Subtest dc5-dpms: SUCCESS (2.054s)
[324.589523] [063/132] (698s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[324.693412] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[331.467340] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.780s)
[331.632076] [064/132] (691s left) kms_fbcon_fbt (fbc)
[331.688299] Starting subtest: fbc
[338.014049] Subtest fbc: SUCCESS (6.327s)
[339.108052] [065/132] (684s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[339.243905] Starting subtest: cursorB-vs-flipB-legacy
[339.248657] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[339.388847] [066/132] (684s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[339.474186] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[339.478498] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[339.586856] [067/132] (683s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[339.639488] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[339.748745] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[339.822851] [068/132] (683s left) gem_exec_flush (basic-uc-ro-default)
[339.883224] Starting subtest: basic-uc-ro-default
[345.370446] Subtest basic-uc-ro-default: SUCCESS (5.453s)
[345.539933] [069/132] (678s left) kms_scaling_modes (scaling-mode-full)
[345.644143] Starting subtest: scaling-mode-full
[345.645950] Starting dynamic subtest: pipe-A-eDP-1
[345.748312] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[345.758332] Starting dynamic subtest: pipe-B-eDP-1
[346.937185] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.188s)
[346.948034] Starting dynamic subtest: pipe-C-eDP-1
[348.053253] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[348.063322] Starting dynamic subtest: pipe-D-eDP-1
[349.192191] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[349.194532] Subtest scaling-mode-full: SUCCESS (3.550s)
[350.346108] [070/132] (673s left) i915_drm_fdinfo (basics)
[350.394723] Starting subtest: basics
[350.397051] Subtest basics: SUCCESS (0.000s)
[350.471569] [071/132] (673s left) syncobj_eventfd (invalid-bad-pad)
[350.534583] Starting subtest: invalid-bad-pad
[350.536741] Subtest invalid-bad-pad: SUCCESS (0.000s)
[350.632065] [072/132] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[350.726691] Starting subtest: fbcpsr-2p-rte
[350.730642] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[350.833221] [073/132] (672s left) gem_exec_fence (syncobj-import)
[351.282877] Starting subtest: syncobj-import
[351.288043] Subtest syncobj-import: SUCCESS (0.005s)
[352.876990] [074/132] (670s left) dmabuf_sync_file (import-multiple-read-only)
[352.915799] Starting subtest: import-multiple-read-only
[352.918186] Subtest import-multiple-read-only: SUCCESS (0.003s)
[352.974712] [075/132] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[353.082154] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[357.675353] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.596s)
[358.844120] [076/132] (665s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[358.945910] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[358.948304] Starting dynamic subtest: pipe-A
[360.152007] Dynamic subtest pipe-A: SUCCESS (1.207s)
[360.160952] Starting dynamic subtest: pipe-B
[362.345434] Dynamic subtest pipe-B: SUCCESS (2.192s)
[362.354855] Starting dynamic subtest: pipe-C
[363.521190] Dynamic subtest pipe-C: SUCCESS (1.174s)
[363.531667] Starting dynamic subtest: pipe-D
[364.653451] Dynamic subtest pipe-D: SUCCESS (1.132s)
[364.655562] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.709s)
[365.838103] [077/132] (658s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[366.226137] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[367.045308] [078/132] (656s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[367.168041] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[367.172648] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[367.327198] [079/132] (656s left) gem_userptr_blits (coherency-sync)
[367.394370] Starting subtest: coherency-sync
[367.543787] Subtest coherency-sync: SKIP (0.116s)
[367.682464] [080/132] (656s left) perf_pmu (rc6)
[367.777722] Starting subtest: rc6
[367.780002] Starting dynamic subtest: gt0
[374.202208] Dynamic subtest gt0: SUCCESS (6.364s)
[374.215473] Starting dynamic subtest: runtime-pm-gt0
[381.921191] Dynamic subtest runtime-pm-gt0: SUCCESS (7.778s)
[381.933671] Starting dynamic subtest: runtime-pm-long-gt0
[394.355075] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.431s)
[394.367743] Starting dynamic subtest: other-idle-gt0
[400.750838] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[400.763192] Starting dynamic subtest: gt1
[407.039796] Dynamic subtest gt1: SUCCESS (6.338s)
[407.053457] Starting dynamic subtest: runtime-pm-gt1
[414.463484] Dynamic subtest runtime-pm-gt1: SUCCESS (7.421s)
[414.476133] Starting dynamic subtest: runtime-pm-long-gt1
[426.924030] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.458s)
[426.937000] Starting dynamic subtest: other-idle-gt1
[433.318922] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[433.321266] Subtest rc6: SUCCESS (65.490s)
[434.359973] [081/132] (589s left) gem_basic (bad-close)
[434.413528] Starting subtest: bad-close
[434.417502] Subtest bad-close: SUCCESS (0.000s)
[434.487847] [082/132] (589s left) syncobj_timeline (single-wait-for-submit-signaled)
[434.547846] Starting subtest: single-wait-for-submit-signaled
[434.549982] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[434.625098] [083/132] (589s left) kms_plane_cursor (primary)
[434.715636] Starting subtest: primary
[434.719147] Starting dynamic subtest: pipe-A-eDP-1-size-64
[437.261454] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.544s)
[437.284878] Starting dynamic subtest: pipe-A-eDP-1-size-128
[439.861214] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[439.888203] Starting dynamic subtest: pipe-A-eDP-1-size-256
[442.461858] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[442.784059] Starting dynamic subtest: pipe-B-eDP-1-size-64
[446.069193] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.294s)
[446.094463] Starting dynamic subtest: pipe-B-eDP-1-size-128
[448.637870] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.550s)
[448.664218] Starting dynamic subtest: pipe-B-eDP-1-size-256
[451.205474] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[451.519836] Starting dynamic subtest: pipe-C-eDP-1-size-64
[454.438171] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.931s)
[454.465404] Starting dynamic subtest: pipe-C-eDP-1-size-128
[456.705036] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.248s)
[456.732417] Starting dynamic subtest: pipe-C-eDP-1-size-256
[458.949823] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[459.272451] Starting dynamic subtest: pipe-D-eDP-1-size-64
[462.207506] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.947s)
[462.234879] Starting dynamic subtest: pipe-D-eDP-1-size-128
[464.518645] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.292s)
[464.546645] Starting dynamic subtest: pipe-D-eDP-1-size-256
[466.718965] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[467.030971] Subtest primary: SUCCESS (32.313s)
[467.810872] [084/132] (556s left) gem_mmap_wc (read)
[467.876107] Subtest read: SKIP (0.000s)
[467.947329] [085/132] (556s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[468.013901] Starting subtest: legacy-engines-hostile-preempt
[468.016177] Starting dynamic subtest: render
[468.096072] Dynamic subtest render: SUCCESS (0.081s)
[468.109981] Starting dynamic subtest: bsd1
[469.876136] Dynamic subtest bsd1: SUCCESS (1.757s)
[469.885443] Starting dynamic subtest: bsd2
[471.841048] Dynamic subtest bsd2: SUCCESS (1.980s)
[471.857435] Starting dynamic subtest: blt
[471.874830] Dynamic subtest blt: SUCCESS (0.033s)
[471.884852] Starting dynamic subtest: vebox
[473.805308] Dynamic subtest vebox: SUCCESS (1.927s)
[473.808121] Subtest legacy-engines-hostile-preempt: SUCCESS (5.791s)
[473.900033] [086/132] (550s left) i915_suspend (fence-restore-tiled2untiled)
[473.952463] Starting subtest: fence-restore-tiled2untiled
[473.956591] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[474.032921] [087/132] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[474.159974] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[474.164047] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[474.240254] [088/132] (550s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[474.331044] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[474.333257] Starting dynamic subtest: pipe-A-eDP-1
[475.561189] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.232s)
[475.571311] Starting dynamic subtest: pipe-B-eDP-1
[477.822339] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.260s)
[477.833738] Starting dynamic subtest: pipe-C-eDP-1
[480.053260] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.230s)
[480.063821] Starting dynamic subtest: pipe-D-eDP-1
[482.318446] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.264s)
[482.320790] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (7.990s)
[483.530151] [089/132] (540s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[483.625532] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[483.627665] Starting dynamic subtest: pipe-A
[483.644423] Dynamic subtest pipe-A: SKIP (0.016s)
[483.654226] Starting dynamic subtest: pipe-B
[483.674599] Dynamic subtest pipe-B: SKIP (0.029s)
[483.684468] Starting dynamic subtest: pipe-C
[483.709751] Dynamic subtest pipe-C: SKIP (0.033s)
[483.719114] Starting dynamic subtest: pipe-D
[483.741491] Dynamic subtest pipe-D: SKIP (0.031s)
[483.745662] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.112s)
[483.800075] [090/132] (540s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[483.899446] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[483.901737] Starting dynamic subtest: pipe-A-eDP-1
[483.924759] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[483.936210] Starting dynamic subtest: pipe-B-eDP-1
[483.957715] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[483.966528] Starting dynamic subtest: pipe-C-eDP-1
[483.988183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[483.997052] Starting dynamic subtest: pipe-D-eDP-1
[484.018225] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[484.022456] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[486.098232] [091/132] (538s left) gem_exec_gttfill (all-engines)
[486.169946] Starting subtest: all-engines
[509.014832] Subtest all-engines: SUCCESS (22.842s)
[509.184283] [092/132] (515s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[509.322422] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[516.571883] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.254s)
[516.690204] [093/132] (507s left) kms_psr (fbc-psr2-primary-render)
[516.784956] Starting subtest: fbc-psr2-primary-render
[516.787231] Starting dynamic subtest: eDP-1
[516.791358] Dynamic subtest eDP-1: SKIP (0.000s)
[516.795469] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[516.833133] [094/132] (507s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[516.930823] Starting subtest: basic-modeset-with-all-modifiers-formats
[517.301170] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[518.095177] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.795s)
[518.104834] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[518.116868] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[518.128175] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[518.139299] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[518.151228] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[518.295060] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[518.305535] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[518.317096] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[518.326992] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[518.340070] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[518.352657] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[518.361575] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[518.370751] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[518.383811] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[518.393090] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[518.405732] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[518.414861] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[518.428248] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[518.437499] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[518.450465] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[518.459425] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[518.472665] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[518.481586] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[518.617155] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[518.627646] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[518.639411] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[518.648930] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[518.661650] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[518.670914] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[518.683807] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[518.693168] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[518.706176] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[518.717171] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[518.728000] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[518.738096] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[518.750469] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[518.760349] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[518.772642] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[518.785131] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[518.795046] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[518.804192] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[518.950569] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[518.960935] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[518.973131] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[518.982387] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[518.995369] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[519.004381] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[519.017326] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[519.026329] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[519.039815] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[519.048987] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[519.062020] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[519.071142] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[519.084171] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[519.092907] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[519.106199] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[519.114934] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[519.128208] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[519.524078] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.595s)
[520.349791] [095/132] (504s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[520.453471] Starting subtest: fbc-pr-cursor-mmap-cpu
[520.457855] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[520.501482] [096/132] (504s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[520.600785] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[520.603054] Starting dynamic subtest: pipe-A-eDP-1
[520.677347] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[520.689510] Starting dynamic subtest: pipe-B-eDP-1
[521.852675] Dynamic subtest pipe-B-eDP-1: SKIP (1.171s)
[521.856724] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.252s)
[523.010901] [097/132] (501s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[523.107380] Starting subtest: coverage-vs-premult-vs-constant
[523.384375] Starting dynamic subtest: pipe-A-eDP-1
[523.973010] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[523.984161] Starting dynamic subtest: pipe-D-eDP-1
[525.251664] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.276s)
[525.254170] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.146s)
[526.079113] [098/132] (498s left) core_auth (getclient-master-drop)
[526.122037] Starting subtest: getclient-master-drop
[526.144691] Subtest getclient-master-drop: SUCCESS (0.022s)
[526.227000] [099/132] (498s left) i915_pm_rpm (system-suspend)
[527.979354] Starting subtest: system-suspend
[546.506747] Subtest system-suspend: SUCCESS (2.875s)
[546.868104] [100/132] (478s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[546.979660] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[546.984282] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[547.056003] [101/132] (477s left) gem_mmap_wc (coherency)
[547.113299] Subtest coherency: SKIP (0.000s)
[547.179505] [102/132] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[547.283312] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[547.288176] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[547.371104] [103/132] (477s left) gem_softpin (zero)
[547.442301] Starting subtest: zero
[547.447666] Subtest zero: SUCCESS (0.005s)
[547.541038] [104/132] (477s left) syncobj_wait (invalid-signal-zero-handles)
[547.605691] Starting subtest: invalid-signal-zero-handles
[547.608298] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[547.659342] [105/132] (477s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[547.770105] Starting subtest: short-flip-before-cursor-atomic-transitions
[548.728422] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.959s)
[549.588766] [106/132] (475s left) gem_exec_params (invalid-ring)
[549.638301] Starting subtest: invalid-ring
[549.641241] Subtest invalid-ring: SUCCESS (0.000s)
[549.717900] [107/132] (475s left) kms_psr (fbc-psr-no-drrs)
[549.798047] Starting subtest: fbc-psr-no-drrs
[549.800698] Starting dynamic subtest: eDP-1
[549.806113] Dynamic subtest eDP-1: SKIP (0.000s)
[549.811205] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[549.851344] [108/132] (475s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[549.956292] Starting subtest: primary-yf-tiled-reflect-x-270
[549.960714] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[550.005349] [109/132] (475s left) api_intel_bb (crc32)
[550.073956] Starting subtest: crc32
[550.076584] Starting dynamic subtest: rcs0-smem0
[550.372439] Dynamic subtest rcs0-smem0: SUCCESS (0.297s)
[550.387625] Starting dynamic subtest: bcs0-smem0
[550.691213] Dynamic subtest bcs0-smem0: SUCCESS (0.316s)
[550.705500] Starting dynamic subtest: vcs0-smem0
[551.042348] Dynamic subtest vcs0-smem0: SUCCESS (0.349s)
[551.056848] Starting dynamic subtest: vcs1-smem0
[551.442052] Dynamic subtest vcs1-smem0: SUCCESS (0.395s)
[551.455956] Starting dynamic subtest: vecs0-smem0
[551.747113] Dynamic subtest vecs0-smem0: SUCCESS (0.301s)
[551.760336] Starting dynamic subtest: ccs0-smem0
[552.056439] Dynamic subtest ccs0-smem0: SUCCESS (0.306s)
[552.059432] Subtest crc32: SUCCESS (1.982s)
[552.153135] [110/132] (473s left) kms_vblank (wait-forked-busy)
[552.256169] Starting subtest: wait-forked-busy
[552.258864] Starting dynamic subtest: pipe-A-eDP-1
[554.131479] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[554.149453] Starting dynamic subtest: pipe-D-eDP-1
[556.692292] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.552s)
[556.695024] Subtest wait-forked-busy: SUCCESS (4.432s)
[557.480767] [111/132] (467s left) kms_chamelium_edid (vga-edid-read)
[557.871354] Subtest vga-edid-read: SKIP (0.000s)
[558.707820] [112/132] (466s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[558.810120] Starting subtest: fb-8bpc-vs-panel-8bpc
[558.812436] Starting dynamic subtest: pipe-A-eDP-1
[560.188316] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.379s)
[560.191250] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.381s)
[560.978938] [113/132] (464s left) gem_exec_balancer (hang)
[561.257550] Starting subtest: hang
[562.885370] Subtest hang: SUCCESS (1.632s)
[562.980169] [114/132] (462s left) perf_pmu (semaphore-wait-idle)
[563.021403] Starting subtest: semaphore-wait-idle
[563.023839] Starting dynamic subtest: rcs0
[563.532811] Dynamic subtest rcs0: SUCCESS (0.514s)
[563.548446] Starting dynamic subtest: bcs0
[564.052826] Dynamic subtest bcs0: SUCCESS (0.515s)
[564.065993] Starting dynamic subtest: vcs0
[564.568553] Dynamic subtest vcs0: SUCCESS (0.513s)
[564.581807] Starting dynamic subtest: vcs1
[565.083839] Dynamic subtest vcs1: SUCCESS (0.512s)
[565.095130] Starting dynamic subtest: vecs0
[565.600354] Dynamic subtest vecs0: SUCCESS (0.512s)
[565.613152] Starting dynamic subtest: ccs0
[566.116365] Dynamic subtest ccs0: SUCCESS (0.513s)
[566.119224] Subtest semaphore-wait-idle: SUCCESS (3.097s)
[566.530525] [115/132] (459s left) kms_busy (basic-hang)
[566.642149] Starting subtest: basic-hang
[566.644728] Starting dynamic subtest: flip-pipe-A
[567.225269] Dynamic subtest flip-pipe-A: SUCCESS (0.584s)
[567.236849] Starting dynamic subtest: modeset-pipe-A
[570.634009] Dynamic subtest modeset-pipe-A: SUCCESS (3.407s)
[570.644349] Starting dynamic subtest: flip-pipe-D
[571.819405] Dynamic subtest flip-pipe-D: SUCCESS (1.182s)
[571.829770] Starting dynamic subtest: modeset-pipe-D
[575.256280] Dynamic subtest modeset-pipe-D: SUCCESS (3.434s)
[575.258915] Subtest basic-hang: SUCCESS (8.613s)
[576.036236] [116/132] (449s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[576.134594] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[576.136805] Starting dynamic subtest: pipe-A-default-mode
[578.905269] Dynamic subtest pipe-A-default-mode: SUCCESS (2.770s)
[578.908289] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.771s)
[579.722190] [117/132] (445s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[579.814638] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[579.819250] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[580.956874] [118/132] (444s left) gem_exec_params (cliprects-invalid)
[581.015315] Starting subtest: cliprects-invalid
[581.018213] Subtest cliprects-invalid: SUCCESS (0.000s)
[581.087718] [119/132] (444s left) gen7_exec_parse (oacontrol-tracking)
[581.145739] Subtest oacontrol-tracking: SKIP (0.000s)
[581.218581] [120/132] (444s left) gem_mmap_wc (write-prefaulted)
[581.268038] Subtest write-prefaulted: SKIP (0.000s)
[581.349387] [121/132] (444s left) sysfs_preempt_timeout (timeout)
[581.404705] Starting subtest: timeout
[581.407293] Starting dynamic subtest: vecs0
[591.498443] Dynamic subtest vecs0: SUCCESS (10.086s)
[591.510949] Starting dynamic subtest: ccs0
[592.746060] Dynamic subtest ccs0: SUCCESS (1.247s)
[592.759430] Starting dynamic subtest: vcs0
[602.507782] Dynamic subtest vcs0: SUCCESS (9.755s)
[602.518738] Starting dynamic subtest: bcs0
[603.718015] Dynamic subtest bcs0: SUCCESS (1.208s)
[603.731750] Starting dynamic subtest: rcs0
[604.977307] Dynamic subtest rcs0: SUCCESS (1.257s)
[604.989882] Starting dynamic subtest: vcs1
[614.471326] Dynamic subtest vcs1: SUCCESS (9.490s)
[614.474460] Subtest timeout: SUCCESS (33.056s)
[614.526976] [122/132] (411s left) gem_mmap_gtt (cpuset-big-copy-xy)
[614.579615] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[614.649760] [123/132] (411s left) syncobj_wait (wait-all-for-submit-snapshot)
[614.709427] Starting subtest: wait-all-for-submit-snapshot
[614.790440] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[614.850136] [124/132] (411s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[614.956233] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[614.961321] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[615.034191] [125/132] (411s left) kms_async_flips (test-time-stamp-atomic)
[615.124410] Starting subtest: test-time-stamp-atomic
[615.500308] Starting dynamic subtest: pipe-A-eDP-1
[616.285992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s)
[616.656007] Starting dynamic subtest: pipe-B-eDP-1
[617.412178] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[617.795334] Starting dynamic subtest: pipe-C-eDP-1
[618.556800] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[618.919591] Starting dynamic subtest: pipe-D-eDP-1
[619.684719] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[619.687423] Subtest test-time-stamp-atomic: SUCCESS (4.559s)
[620.843410] [126/132] (405s left) i915_hangman (engine-engine-hang)
[620.910309] Starting subtest: engine-engine-hang
[620.913097] Starting dynamic subtest: rcs0
[622.443548] Dynamic subtest rcs0: SUCCESS (1.531s)
[622.460418] Starting dynamic subtest: bcs0
[624.425451] Dynamic subtest bcs0: SUCCESS (1.978s)
[624.439090] Starting dynamic subtest: vcs0
[626.473695] Dynamic subtest vcs0: SUCCESS (2.045s)
[626.487560] Starting dynamic subtest: vcs1
[628.457445] Dynamic subtest vcs1: SUCCESS (1.980s)
[628.469839] Starting dynamic subtest: vecs0
[630.441901] Dynamic subtest vecs0: SUCCESS (1.981s)
[630.455355] Starting dynamic subtest: ccs0
[632.425220] Dynamic subtest ccs0: SUCCESS (1.980s)
[632.428280] Subtest engine-engine-hang: SUCCESS (11.512s)
[632.530078] [127/132] (393s left) syncobj_wait (multi-wait-all-submitted-signaled)
[632.595452] Starting subtest: multi-wait-all-submitted-signaled
[632.694172] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[632.750455] [128/132] (393s left) gem_exec_reloc (basic-wc-active)
[632.820099] Subtest basic-wc-active: SKIP (0.000s)
[632.892707] [129/132] (393s left) kms_scaling_modes (scaling-mode-none)
[633.000022] Starting subtest: scaling-mode-none
[633.002558] Starting dynamic subtest: pipe-A-eDP-1
[633.124447] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[633.135658] Starting dynamic subtest: pipe-B-eDP-1
[633.161355] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[633.171585] Starting dynamic subtest: pipe-C-eDP-1
[633.194237] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s)
[633.204446] Starting dynamic subtest: pipe-D-eDP-1
[633.227803] Dynamic subtest pipe-D-eDP-1: SKIP (0.033s)
[633.232436] Subtest scaling-mode-none: SKIP (0.226s)
[633.320655] [130/132] (392s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[633.550900] Starting subtest: cursor-rapid-movement-128x42
[633.597142] Subtest cursor-rapid-movement-128x42: SKIP (0.039s)
[633.766093] [131/132] (392s left) gem_exec_reloc (basic-gtt-active)
[633.814305] Subtest basic-gtt-active: SKIP (0.000s)
[633.873586] [132/132] (392s left) kms_addfb_basic (addfb25-bad-modifier)
[633.962418] Starting subtest: addfb25-bad-modifier
[633.964430] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[634.030071] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_create
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_vrr
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: syncobj_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_big
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_ctx_create
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: sw_sync
results: parsing output: 18/ for test: kms_content_protection
results: parsing output: 19/ for test: kms_joiner
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_cursor_edge_walk
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_exec_whisper
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_draw_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: gem_busy
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: gem_wait
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_linear_blits
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_getfb
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_pm_dc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_fbcon_fbt
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_exec_flush
results: parsing output: 68/ for test: kms_scaling_modes
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: syncobj_eventfd
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_fence
results: parsing output: 73/ for test: dmabuf_sync_file
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: gem_basic
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_plane_cursor
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: i915_suspend
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_exec_gttfill
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: kms_plane_alpha_blend
results: parsing output: 97/ for test: core_auth
results: parsing output: 98/ for test: i915_pm_rpm
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_wc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_rotation_crc
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: kms_chamelium_edid
results: parsing output: 111/ for test: kms_dither
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_busy
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: gen7_exec_parse
results: parsing output: 119/ for test: gem_mmap_wc
results: parsing output: 120/ for test: sysfs_preempt_timeout
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: i915_hangman
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: kms_scaling_modes
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_addfb_basic
Done.