[59.509765] Initializing watchdogs
[59.509812]   /dev/watchdog0
[59.523854] [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]
[59.528270] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.530993] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.534191] [001/133] (960s left) kms_vrr (flip-dpms)
[59.646545] Starting subtest: flip-dpms
[59.652636] Subtest flip-dpms: SKIP (0.000s)
[59.724942] [002/133] (960s left) gem_softpin (evict-snoop-interruptible)
[59.788537] Starting subtest: evict-snoop-interruptible
[59.793176] Subtest evict-snoop-interruptible: SKIP (0.000s)
[59.900486] [003/133] (960s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[59.948098] Starting subtest: single-wait-all-for-submit-unsubmitted
[60.049265] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[60.122857] [004/133] (960s left) gem_ctx_persistence (engines-hostile)
[60.180805] Starting subtest: engines-hostile
[60.183165] Starting dynamic subtest: rcs0
[60.301876] Dynamic subtest rcs0: SUCCESS (0.123s)
[60.312050] Starting dynamic subtest: bcs0
[60.407754] Dynamic subtest bcs0: SUCCESS (0.105s)
[60.417263] Starting dynamic subtest: vcs0
[60.518253] Dynamic subtest vcs0: SUCCESS (0.110s)
[60.528215] Starting dynamic subtest: vcs1
[60.585321] Dynamic subtest vcs1: SUCCESS (0.067s)
[60.593807] Starting dynamic subtest: vecs0
[60.692592] Dynamic subtest vecs0: SUCCESS (0.107s)
[60.701217] Starting dynamic subtest: ccs0
[60.767029] Dynamic subtest ccs0: SUCCESS (0.074s)
[60.769497] Subtest engines-hostile: SUCCESS (0.591s)
[60.875533] [005/133] (959s left) kms_big_fb (4-tiled-addfb)
[60.970407] Starting subtest: 4-tiled-addfb
[60.972643] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[61.060344] [006/133] (959s left) syncobj_basic (create-signaled)
[61.115332] Starting subtest: create-signaled
[61.117094] Subtest create-signaled: SUCCESS (0.000s)
[61.199704] [007/133] (959s left) gem_wait (busy)
[61.255512] Starting subtest: busy
[61.257585] Starting dynamic subtest: all-engines
[62.934873] Dynamic subtest all-engines: SUCCESS (1.680s)
[62.946955] Starting dynamic subtest: rcs0
[63.479664] Dynamic subtest rcs0: SUCCESS (0.545s)
[63.488867] Starting dynamic subtest: bcs0
[64.018325] Dynamic subtest bcs0: SUCCESS (0.540s)
[64.027416] Starting dynamic subtest: vcs0
[65.942357] Dynamic subtest vcs0: SUCCESS (1.924s)
[65.952195] Starting dynamic subtest: vcs1
[67.926776] Dynamic subtest vcs1: SUCCESS (1.985s)
[67.936577] Starting dynamic subtest: vecs0
[69.910082] Dynamic subtest vecs0: SUCCESS (1.984s)
[69.920085] Starting dynamic subtest: ccs0
[70.451138] Dynamic subtest ccs0: SUCCESS (0.542s)
[70.453527] Subtest busy: SUCCESS (9.206s)
[70.639473] [008/133] (949s left) gem_mmap_gtt (big-bo-tiledx)
[70.707943] Subtest big-bo-tiledX: SKIP (0.000s)
[70.768802] [009/133] (949s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[70.870610] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[75.153990] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.288s)
[76.312458] [010/133] (944s left) kms_plane_cursor (primary)
[76.407272] Starting subtest: primary
[76.412594] Starting dynamic subtest: pipe-A-eDP-1-size-64
[78.980370] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.577s)
[79.004272] Starting dynamic subtest: pipe-A-eDP-1-size-128
[81.591302] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.594s)
[81.615356] Starting dynamic subtest: pipe-A-eDP-1-size-256
[84.168412] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.561s)
[84.482099] Starting dynamic subtest: pipe-B-eDP-1-size-64
[87.784790] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.314s)
[87.811050] Starting dynamic subtest: pipe-B-eDP-1-size-128
[90.385691] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[90.407903] Starting dynamic subtest: pipe-B-eDP-1-size-256
[92.986257] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[93.308286] Starting dynamic subtest: pipe-C-eDP-1-size-64
[96.241604] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.946s)
[96.269126] Starting dynamic subtest: pipe-C-eDP-1-size-128
[98.441206] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[98.465713] Starting dynamic subtest: pipe-C-eDP-1-size-256
[100.652111] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[100.971130] Starting dynamic subtest: pipe-D-eDP-1-size-64
[103.846284] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.887s)
[103.871450] Starting dynamic subtest: pipe-D-eDP-1-size-128
[106.078726] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[106.104165] Starting dynamic subtest: pipe-D-eDP-1-size-256
[108.312096] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[108.626072] Subtest primary: SUCCESS (32.228s)
[109.410380] [011/133] (910s left) syncobj_wait (multi-wait-submitted-signaled)
[109.477234] Starting subtest: multi-wait-submitted-signaled
[109.479579] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[109.561077] [012/133] (910s left) gem_flink_basic (flink-lifetime)
[109.614572] Starting subtest: flink-lifetime
[109.616818] Subtest flink-lifetime: SUCCESS (0.002s)
[109.707955] [013/133] (910s left) i915_pm_rc6_residency (rc6-accuracy)
[109.776761] Starting subtest: rc6-accuracy
[109.778956] Starting dynamic subtest: gt0
[112.954551] Dynamic subtest gt0: SUCCESS (3.172s)
[112.964064] Starting dynamic subtest: gt1
[116.125702] Dynamic subtest gt1: SUCCESS (3.169s)
[116.128346] Subtest rc6-accuracy: SUCCESS (6.348s)
[116.198380] [014/133] (904s left) gem_exec_flush (basic-uc-pro-default)
[116.263248] Starting subtest: basic-uc-pro-default
[121.732069] Subtest basic-uc-pro-default: SUCCESS (5.472s)
[121.913652] [015/133] (898s left) kms_vrr (seamless-rr-switch-vrr)
[122.018850] Starting subtest: seamless-rr-switch-vrr
[122.025262] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[122.089222] [016/133] (898s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[122.200280] Starting subtest: modeset-atomic-cursor-hotspot
[122.204547] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[122.354419] [017/133] (898s left) syncobj_timeline (invalid-signal-bad-pad)
[122.410848] Starting subtest: invalid-signal-bad-pad
[122.413079] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[122.497224] [018/133] (898s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[122.555033] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[122.557365] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[122.643855] [019/133] (898s left) kms_color (ctm-red-to-blue)
[122.731165] Starting subtest: ctm-red-to-blue
[122.733381] Starting dynamic subtest: pipe-A-eDP-1
[123.445629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[123.454133] Starting dynamic subtest: pipe-B-eDP-1
[124.829040] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[124.837107] Starting dynamic subtest: pipe-C-eDP-1
[126.184625] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[126.192851] Starting dynamic subtest: pipe-D-eDP-1
[127.532926] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[127.535255] Subtest ctm-red-to-blue: SUCCESS (4.802s)
[128.335227] [020/133] (892s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[128.436733] Starting subtest: psr-rgb101010-draw-render
[135.647963] Subtest psr-rgb101010-draw-render: SUCCESS (7.216s)
[135.767604] [021/133] (884s left) kms_pm_lpsp (kms-lpsp)
[136.880787] Starting subtest: kms-lpsp
[136.883129] Starting dynamic subtest: pipe-A-eDP-1
[137.049429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.172s)
[137.359497] Subtest kms-lpsp: SUCCESS (0.483s)
[138.215364] [022/133] (882s left) prime_self_import (basic-with_fd_dup)
[138.259834] Starting subtest: basic-with_fd_dup
[138.279263] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[138.367494] [023/133] (882s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[138.458056] Starting subtest: x-tiled-32bpp-rotate-270
[138.477790] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[138.594632] [024/133] (882s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[138.687589] Starting subtest: fbc-psr2-sprite-plane-onoff
[138.689912] Starting dynamic subtest: eDP-1
[138.694270] Dynamic subtest eDP-1: SKIP (0.000s)
[138.698291] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[138.761656] [025/133] (882s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[138.844638] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[138.846731] Starting dynamic subtest: pipe-A-eDP-1
[138.868608] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[138.877985] Starting dynamic subtest: pipe-B-eDP-1
[138.899393] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[138.906792] Starting dynamic subtest: pipe-C-eDP-1
[138.928182] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.935395] Starting dynamic subtest: pipe-D-eDP-1
[138.957157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.961192] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[141.074042] [026/133] (879s left) kms_flip (modeset-vs-vblank-race-interruptible)
[141.172041] Starting subtest: modeset-vs-vblank-race-interruptible
[141.174392] Starting dynamic subtest: A-eDP1
[145.811914] Dynamic subtest A-eDP1: SUCCESS (4.638s)
[145.822564] Starting dynamic subtest: B-eDP1
[150.451514] Dynamic subtest B-eDP1: SUCCESS (4.637s)
[150.461076] Starting dynamic subtest: C-eDP1
[155.062276] Dynamic subtest C-eDP1: SUCCESS (4.608s)
[155.070298] Starting dynamic subtest: D-eDP1
[159.684056] Dynamic subtest D-eDP1: SUCCESS (4.620s)
[159.688947] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.514s)
[160.841841] [027/133] (860s left) gem_ctx_persistence (heartbeat-stop)
[160.905190] Starting subtest: heartbeat-stop
[160.909826] Subtest heartbeat-stop: SKIP (0.000s)
[160.997063] [028/133] (860s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[161.107480] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[162.057415] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.948s)
[162.865077] [029/133] (858s left) gem_partial_pwrite_pread (write-display)
[162.931804] Subtest write-display: SKIP (0.000s)
[163.001517] [030/133] (858s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[163.099249] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[169.766666] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.669s)
[169.912774] [031/133] (851s left) api_intel_bb (reset-bb)
[169.970391] Starting subtest: reset-bb
[169.972668] Subtest reset-bb: SUCCESS (0.003s)
[170.086783] [032/133] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[170.182893] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[170.187302] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[170.294568] [033/133] (850s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[170.377305] Starting subtest: flip-vs-dpms-on-nop-interruptible
[170.379584] Starting dynamic subtest: A-eDP1
[172.277485] Dynamic subtest A-eDP1: SUCCESS (1.899s)
[172.287615] Starting dynamic subtest: B-eDP1
[174.116474] Dynamic subtest B-eDP1: SUCCESS (1.836s)
[174.126592] Starting dynamic subtest: C-eDP1
[175.940519] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[175.952762] Starting dynamic subtest: D-eDP1
[177.783263] Dynamic subtest D-eDP1: SUCCESS (1.840s)
[177.785506] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.409s)
[178.984994] [034/133] (842s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[179.085213] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[179.087118] Starting dynamic subtest: pipe-A-eDP-1
[179.904475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[179.912181] Starting dynamic subtest: pipe-B-eDP-1
[181.464607] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.556s)
[181.472974] Starting dynamic subtest: pipe-C-eDP-1
[182.997216] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s)
[183.005869] Starting dynamic subtest: pipe-D-eDP-1
[184.504595] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.508s)
[184.506758] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.414s)
[185.696067] [035/133] (835s left) kms_cursor_edge_walk (256x256-top-bottom)
[185.786303] Starting subtest: 256x256-top-bottom
[185.788561] Starting dynamic subtest: pipe-A-eDP-1
[189.244950] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.460s)
[189.252733] Starting dynamic subtest: pipe-D-eDP-1
[192.364193] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[192.368612] Subtest 256x256-top-bottom: SUCCESS (6.580s)
[193.177390] [036/133] (828s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[193.279682] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[193.281917] Starting dynamic subtest: pipe-A-eDP-1
[204.593647] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.318s)
[204.603945] Starting dynamic subtest: pipe-B-eDP-1
[216.598419] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.004s)
[216.600794] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.325s)
[217.436256] [037/133] (803s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[217.533199] Starting subtest: primary-yf-tiled-reflect-x-90
[217.537646] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[217.606756] [038/133] (803s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[217.699913] Starting subtest: pr-cursor-plane-move-continuous-sf
[217.704399] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[217.767673] [039/133] (803s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[217.859476] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[224.648453] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.790s)
[224.786362] [040/133] (796s left) kms_legacy_colorkey (basic)
[224.884321] Starting subtest: basic
[224.886492] Starting dynamic subtest: pipe-A
[224.927749] Dynamic subtest pipe-A: SUCCESS (0.045s)
[224.938627] Starting dynamic subtest: pipe-B
[224.940637] Dynamic subtest pipe-B: SUCCESS (0.000s)
[224.947782] Starting dynamic subtest: pipe-C
[224.950174] Dynamic subtest pipe-C: SUCCESS (0.000s)
[224.957468] Starting dynamic subtest: pipe-D
[224.959927] Dynamic subtest pipe-D: SUCCESS (0.000s)
[224.962201] Subtest basic: SUCCESS (0.050s)
[224.995901] [041/133] (796s left) perf (buffer-fill)
[225.115325] Starting subtest: buffer-fill
[225.117409] Starting dynamic subtest: 0-rcs0
[227.360642] Dynamic subtest 0-rcs0: SUCCESS (2.243s)
[227.369317] Starting dynamic subtest: 1-vecs0
[231.756746] Dynamic subtest 1-vecs0: SUCCESS (4.395s)
[231.759211] Subtest buffer-fill: SUCCESS (6.641s)
[231.801771] [042/133] (789s left) core_getversion (all-cards)
[231.836307] Starting subtest: all-cards
[231.840289] Subtest all-cards: SUCCESS (0.008s)
[231.878921] [043/133] (789s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[231.970438] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[231.972791] Starting dynamic subtest: pipe-A-eDP-1
[231.995545] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.004025] Starting dynamic subtest: pipe-B-eDP-1
[232.025068] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.032516] Starting dynamic subtest: pipe-C-eDP-1
[232.054530] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.062307] Starting dynamic subtest: pipe-D-eDP-1
[232.084393] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.088495] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[234.175297] [044/133] (787s left) api_intel_allocator (simple-allocator)
[234.227080] Starting subtest: simple-allocator
[234.229350] Starting dynamic subtest: basic
[234.231565] Dynamic subtest basic: SUCCESS (0.003s)
[234.247248] Starting dynamic subtest: parallel-one
[234.419885] Dynamic subtest parallel-one: SUCCESS (0.190s)
[234.430824] Starting dynamic subtest: print
[234.432954] Dynamic subtest print: SUCCESS (0.000s)
[234.440688] Starting dynamic subtest: reuse
[234.442633] Dynamic subtest reuse: SUCCESS (0.000s)
[234.449767] Starting dynamic subtest: reserve
[234.451730] Dynamic subtest reserve: SUCCESS (0.000s)
[234.458831] Starting dynamic subtest: fork-reopen-allocator
[234.460822] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[234.462798] Subtest simple-allocator: SUCCESS (0.209s)
[234.572707] [045/133] (787s left) prime_mmap (test_correct_cpu_write)
[234.624920] Starting subtest: test_correct_cpu_write
[234.627310] Starting dynamic subtest: test_correct_cpu_write-smem
[234.629489] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[234.631676] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[234.721495] [046/133] (787s left) kms_psr (pr-cursor-render)
[234.810070] Starting subtest: pr-cursor-render
[234.814509] Subtest pr-cursor-render: SKIP (0.000s)
[234.883254] [047/133] (786s left) gem_exec_balancer (parallel)
[235.136694] Starting subtest: parallel
[236.084211] Subtest parallel: SUCCESS (0.948s)
[237.007888] [048/133] (784s left) perf_pmu (busy-idle-no-semaphores)
[237.062681] Starting subtest: busy-idle-no-semaphores
[237.065069] Starting dynamic subtest: rcs0
[237.717930] Dynamic subtest rcs0: SUCCESS (0.653s)
[237.729034] Starting dynamic subtest: bcs0
[238.372372] Dynamic subtest bcs0: SUCCESS (0.652s)
[238.383585] Starting dynamic subtest: vcs0
[239.028344] Dynamic subtest vcs0: SUCCESS (0.653s)
[239.037522] Starting dynamic subtest: vcs1
[240.512577] Dynamic subtest vcs1: SUCCESS (1.481s)
[240.521586] Starting dynamic subtest: vecs0
[242.496776] Dynamic subtest vecs0: SUCCESS (1.981s)
[242.507533] Starting dynamic subtest: ccs0
[244.479951] Dynamic subtest ccs0: SUCCESS (1.981s)
[244.482747] Subtest busy-idle-no-semaphores: SUCCESS (7.418s)
[244.601435] [049/133] (777s left) gem_exec_store (dword)
[244.665568] Starting subtest: dword
[244.667821] Starting dynamic subtest: rcs0
[244.759305] Dynamic subtest rcs0: SUCCESS (0.093s)
[244.770942] Starting dynamic subtest: bcs0
[244.803246] Dynamic subtest bcs0: SUCCESS (0.042s)
[244.812835] Starting dynamic subtest: vcs0
[244.847984] Dynamic subtest vcs0: SUCCESS (0.042s)
[244.857567] Starting dynamic subtest: vcs1
[244.889185] Dynamic subtest vcs1: SUCCESS (0.039s)
[244.898417] Starting dynamic subtest: vecs0
[244.934257] Dynamic subtest vecs0: SUCCESS (0.042s)
[244.943840] Starting dynamic subtest: ccs0
[244.980955] Dynamic subtest ccs0: SUCCESS (0.044s)
[244.983762] Subtest dword: SUCCESS (0.316s)
[245.165693] [050/133] (776s left) gem_ctx_shared (q-promotion)
[245.233342] Starting subtest: Q-promotion
[245.235307] Starting dynamic subtest: rcs0
[245.433045] Dynamic subtest rcs0: SUCCESS (0.200s)
[245.448930] Starting dynamic subtest: vcs0
[245.547294] Dynamic subtest vcs0: SUCCESS (0.115s)
[245.564194] Starting dynamic subtest: vcs1
[245.658047] Dynamic subtest vcs1: SUCCESS (0.108s)
[245.673116] Starting dynamic subtest: vecs0
[245.768105] Dynamic subtest vecs0: SUCCESS (0.109s)
[245.782568] Starting dynamic subtest: ccs0
[245.886696] Dynamic subtest ccs0: SUCCESS (0.118s)
[245.889533] Subtest Q-promotion: SUCCESS (0.655s)
[247.024825] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[247.030336] [051/133] (774s left) prime_mmap (test_aperture_limit)
[247.096626] Starting subtest: test_aperture_limit
[247.098551] Starting dynamic subtest: test_aperture_limit-smem
[247.106282] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[247.110501] Subtest test_aperture_limit: SKIP (0.009s)
[247.189723] [052/133] (774s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[247.290126] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[247.294543] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[247.399972] [053/133] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[247.494700] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[254.789228] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.298s)
[254.890633] [054/133] (767s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[254.982236] Starting subtest: random-ccs-data-yf-tiled-ccs
[254.984527] Starting dynamic subtest: pipe-A-eDP-1
[255.009886] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[255.020141] Starting dynamic subtest: pipe-B-eDP-1
[255.043487] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[255.051574] Starting dynamic subtest: pipe-C-eDP-1
[255.075286] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[255.083369] Starting dynamic subtest: pipe-D-eDP-1
[255.107604] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[255.111724] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[257.244455] [055/133] (764s left) i915_drm_fdinfo (virtual-busy-hang-all)
[257.287022] Starting subtest: virtual-busy-hang-all
[257.291389] Subtest virtual-busy-hang-all: SKIP (0.000s)
[257.357411] [056/133] (764s left) gen9_exec_parse (basic-rejected-ctx-param)
[257.419273] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[257.496541] [057/133] (764s left) gem_ctx_engines (invalid-engines)
[257.560615] Starting subtest: invalid-engines
[257.568663] Subtest invalid-engines: SUCCESS (0.008s)
[257.804833] [058/133] (764s left) kms_chamelium_frames (hdmi-crc-multiple)
[258.197575] Subtest hdmi-crc-multiple: SKIP (0.000s)
[259.048311] [059/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[259.147388] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[259.151996] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[259.234532] [060/133] (763s left) i915_drm_fdinfo (busy-idle-check-all)
[259.279274] Starting subtest: busy-idle-check-all
[259.281548] Starting dynamic subtest: rcs0
[259.286214] Dynamic subtest rcs0: SKIP (0.004s)
[259.296305] Starting dynamic subtest: bcs0
[259.300472] Dynamic subtest bcs0: SKIP (0.000s)
[259.308574] Starting dynamic subtest: vcs0
[259.313061] Dynamic subtest vcs0: SKIP (0.000s)
[259.320838] Starting dynamic subtest: vcs1
[259.324902] Dynamic subtest vcs1: SKIP (0.000s)
[259.332730] Starting dynamic subtest: vecs0
[259.336797] Dynamic subtest vecs0: SKIP (0.000s)
[259.344479] Starting dynamic subtest: ccs0
[259.348533] Dynamic subtest ccs0: SKIP (0.000s)
[259.352570] Subtest busy-idle-check-all: SKIP (0.009s)
[259.388826] [061/133] (762s left) kms_universal_plane (disable-primary-vs-flip)
[259.486226] Starting subtest: disable-primary-vs-flip
[259.488421] Starting dynamic subtest: pipe-A-eDP-1
[261.039981] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.554s)
[261.049191] Starting dynamic subtest: pipe-B-eDP-1
[263.220826] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.180s)
[263.231430] Starting dynamic subtest: pipe-C-eDP-1
[265.457312] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.233s)
[265.467105] Starting dynamic subtest: pipe-D-eDP-1
[267.617162] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.160s)
[267.619460] Subtest disable-primary-vs-flip: SUCCESS (8.133s)
[268.423718] [062/133] (753s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[268.481908] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[268.587084] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[268.662258] [063/133] (753s left) gem_eio (in-flight-internal-1us)
[268.903704] Starting subtest: in-flight-internal-1us
[269.985331] Subtest in-flight-internal-1us: SUCCESS (1.081s)
[270.113307] [064/133] (752s left) gem_spin_batch (engines)
[270.177292] Starting subtest: engines
[270.179524] Starting dynamic subtest: rcs0
[273.417360] Dynamic subtest rcs0: SUCCESS (3.235s)
[273.428594] Starting dynamic subtest: bcs0
[276.657434] Dynamic subtest bcs0: SUCCESS (3.236s)
[276.668598] Starting dynamic subtest: vcs0
[279.895039] Dynamic subtest vcs0: SUCCESS (3.235s)
[279.909463] Starting dynamic subtest: vcs1
[283.133182] Dynamic subtest vcs1: SUCCESS (3.235s)
[283.144288] Starting dynamic subtest: vecs0
[286.370582] Dynamic subtest vecs0: SUCCESS (3.233s)
[286.380479] Starting dynamic subtest: ccs0
[289.610342] Dynamic subtest ccs0: SUCCESS (3.237s)
[289.612850] Subtest engines: SUCCESS (19.429s)
[289.819108] [065/133] (732s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[289.924554] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[296.482262] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.562s)
[296.620903] [066/133] (725s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[296.787268] Starting subtest: cursor-rapid-movement-32x10
[296.833381] Subtest cursor-rapid-movement-32x10: SKIP (0.040s)
[297.087364] [067/133] (725s left) gem_exec_nop (basic-parallel)
[297.155180] Starting subtest: basic-parallel
[312.856073] Subtest basic-parallel: SUCCESS (15.708s)
[313.076093] [068/133] (709s left) kms_async_flips (test-time-stamp-atomic)
[313.168927] Starting subtest: test-time-stamp-atomic
[313.541980] Starting dynamic subtest: pipe-A-eDP-1
[314.356742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s)
[314.739632] Starting dynamic subtest: pipe-B-eDP-1
[315.494418] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[315.869254] Starting dynamic subtest: pipe-C-eDP-1
[316.620158] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[316.981997] Starting dynamic subtest: pipe-D-eDP-1
[317.742452] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[317.744936] Subtest test-time-stamp-atomic: SUCCESS (4.573s)
[318.895998] [069/133] (703s left) gem_exec_whisper (basic-sync)
[318.960861] Starting subtest: basic-sync
[327.553531] Subtest basic-sync: SUCCESS (8.590s)
[327.753709] [070/133] (694s left) gem_partial_pwrite_pread (writes-after-reads)
[327.815193] Subtest writes-after-reads: SKIP (0.000s)
[327.888282] [071/133] (694s left) gem_exec_balancer (waits)
[327.953477] Starting subtest: waits
[334.437747] Subtest waits: SUCCESS (6.485s)
[334.732480] [072/133] (688s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[334.829285] Starting subtest: async-flip-with-page-flip-events-tiled
[335.208508] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[337.966079] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.756s)
[337.977450] Starting dynamic subtest: pipe-A-eDP-1-4
[340.139371] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[340.148363] Starting dynamic subtest: pipe-A-eDP-1-4
[342.149985] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[342.158628] Starting dynamic subtest: pipe-A-eDP-1-x
[344.339950] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[344.732854] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[347.506062] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[347.515057] Starting dynamic subtest: pipe-B-eDP-1-4
[349.690741] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[349.702177] Starting dynamic subtest: pipe-B-eDP-1-4
[351.701403] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[351.710880] Starting dynamic subtest: pipe-B-eDP-1-x
[353.902059] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[354.285248] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[357.035092] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[357.047184] Starting dynamic subtest: pipe-C-eDP-1-4
[359.219428] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.183s)
[359.231036] Starting dynamic subtest: pipe-C-eDP-1-4
[361.229526] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[361.238400] Starting dynamic subtest: pipe-C-eDP-1-x
[363.408129] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[363.777438] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[366.561982] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[366.573881] Starting dynamic subtest: pipe-D-eDP-1-4
[368.736120] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[368.744293] Starting dynamic subtest: pipe-D-eDP-1-4
[370.746916] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[370.755676] Starting dynamic subtest: pipe-D-eDP-1-x
[372.925170] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[372.927539] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.097s)
[374.142985] [073/133] (648s left) kms_plane_alpha_blend (alpha-basic)
[374.262915] Starting subtest: alpha-basic
[374.538673] Starting dynamic subtest: pipe-A-eDP-1
[376.463497] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.924s)
[376.488897] Starting dynamic subtest: pipe-D-eDP-1
[379.134246] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.650s)
[379.136610] Subtest alpha-basic: SUCCESS (4.872s)
[380.007938] [074/133] (642s left) gem_exec_params (invalid-fence-in-submit)
[380.077017] Starting subtest: invalid-fence-in-submit
[380.079389] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[380.197365] [075/133] (642s left) gem_exec_params (sol-reset-not-gen7)
[380.251999] Starting subtest: sol-reset-not-gen7
[380.254488] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[380.358101] [076/133] (642s left) i915_power (sanity)
[380.414491] Starting subtest: sanity
[384.468652] Subtest sanity: SUCCESS (4.049s)
[385.974647] [077/133] (637s left) kms_flip (plain-flip-ts-check)
[386.057407] Starting subtest: plain-flip-ts-check
[386.059950] Starting dynamic subtest: A-eDP1
[394.884997] Dynamic subtest A-eDP1: SUCCESS (8.828s)
[394.893467] Starting dynamic subtest: B-eDP1
[403.719573] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[403.734765] Starting dynamic subtest: C-eDP1
[412.560875] Dynamic subtest C-eDP1: SUCCESS (8.839s)
[412.570976] Starting dynamic subtest: D-eDP1
[421.396151] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[421.398428] Subtest plain-flip-ts-check: SUCCESS (35.343s)
[422.573424] [078/133] (600s left) kms_vblank (crtc-id)
[422.658733] Starting subtest: crtc-id
[422.661112] Starting dynamic subtest: pipe-A-eDP-1
[423.117475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[423.131804] Starting dynamic subtest: pipe-D-eDP-1
[424.214976] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.096s)
[424.217253] Subtest crtc-id: SUCCESS (1.561s)
[425.046984] [079/133] (598s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[425.155580] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[425.158207] Starting dynamic subtest: pipe-A-default-mode
[427.884391] Dynamic subtest pipe-A-default-mode: SUCCESS (2.729s)
[427.886812] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.731s)
[428.723591] [080/133] (594s left) kms_fence_pin_leak
[428.881120] [081/133] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[428.977615] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[435.687321] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.712s)
[435.849884] [082/133] (587s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[435.960329] Starting subtest: 2x-flip-vs-cursor-atomic
[435.964776] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[436.101710] [083/133] (587s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[436.189188] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[436.191478] Starting dynamic subtest: pipe-A-eDP-1
[436.200068] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[436.210414] Starting dynamic subtest: pipe-B-eDP-1
[436.218965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[436.227322] Starting dynamic subtest: pipe-C-eDP-1
[436.235620] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[436.243627] Starting dynamic subtest: pipe-D-eDP-1
[436.251770] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[436.255972] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[438.512214] [084/133] (584s left) gem_exec_reloc (basic-gtt-cpu-active)
[438.568806] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[438.642436] [085/133] (584s left) kms_cursor_crc (cursor-onscreen-32x32)
[438.794624] Starting subtest: cursor-onscreen-32x32
[438.840793] Subtest cursor-onscreen-32x32: SKIP (0.041s)
[439.121364] [086/133] (584s left) gem_pxp (fail-invalid-protected-context)
[439.260072] Starting subtest: fail-invalid-protected-context
[439.262568] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[439.368984] [087/133] (584s left) kms_pm_rpm (pm-caching)
[441.097331] Starting subtest: pm-caching
[441.102638] Subtest pm-caching: SKIP (0.000s)
[441.644102] [088/133] (581s left) gem_mmap_gtt (flink-race)
[441.706317] Subtest flink-race: SKIP (0.000s)
[441.765151] [089/133] (581s left) kms_psr (psr2-cursor-mmap-gtt)
[441.849124] Starting subtest: psr2-cursor-mmap-gtt
[441.851215] Starting dynamic subtest: eDP-1
[443.520512] Dynamic subtest eDP-1: SUCCESS (1.671s)
[443.522683] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.672s)
[444.317060] [090/133] (579s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[444.704634] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[445.530197] [091/133] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[445.634419] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[445.638705] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[445.733590] [092/133] (577s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[445.856295] Starting subtest: basic-flip-before-cursor-varying-size
[446.793572] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.934s)
[447.591559] [093/133] (576s left) gem_exec_schedule (thriceslice)
[447.674733] Starting subtest: thriceslice
[447.676732] Starting dynamic subtest: rcs0
[447.691138] Dynamic subtest rcs0: SUCCESS (0.028s)
[447.701153] Starting dynamic subtest: bcs0
[447.739769] Dynamic subtest bcs0: SUCCESS (0.048s)
[447.751997] Starting dynamic subtest: vcs0
[447.770245] Dynamic subtest vcs0: SUCCESS (0.029s)
[447.778686] Starting dynamic subtest: vcs1
[447.820975] Dynamic subtest vcs1: SUCCESS (0.049s)
[447.833094] Starting dynamic subtest: vecs0
[447.850341] Dynamic subtest vecs0: SUCCESS (0.028s)
[447.858773] Starting dynamic subtest: ccs0
[447.904297] Dynamic subtest ccs0: SUCCESS (0.053s)
[447.907027] Subtest thriceslice: SUCCESS (0.243s)
[448.960311] [094/133] (574s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[449.058468] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[449.062515] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[449.165956] [095/133] (574s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[449.256860] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[449.259689] Starting dynamic subtest: pipe-A-eDP-1
[449.318302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[449.332102] Starting dynamic subtest: pipe-B-eDP-1
[449.379304] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[449.388120] Starting dynamic subtest: pipe-C-eDP-1
[449.438642] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[449.448380] Starting dynamic subtest: pipe-D-eDP-1
[449.499187] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[449.501389] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.246s)
[451.694728] [096/133] (572s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[451.751779] Starting subtest: multi-wait-available-unsubmitted-signaled
[451.754066] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[451.863288] [097/133] (571s left) gem_exec_fence (long-history)
[452.299563] Starting subtest: long-history
[459.640596] Subtest long-history: SUCCESS (7.342s)
[460.051220] [098/133] (563s left) kms_dp_link_training (uhbr-sst)
[460.146019] Starting subtest: uhbr-sst
[460.154866] Subtest uhbr-sst: SKIP (0.000s)
[460.215939] [099/133] (563s left) prime_vgem (basic-gtt)
[460.285293] Starting subtest: basic-gtt
[460.289730] Subtest basic-gtt: SKIP (0.000s)
[460.398108] [100/133] (563s left) gem_exec_schedule (preempt)
[460.464917] Starting subtest: preempt
[460.467115] Starting dynamic subtest: rcs0
[460.482860] Dynamic subtest rcs0: SUCCESS (0.027s)
[460.495772] Starting dynamic subtest: bcs0
[460.500475] Dynamic subtest bcs0: SUCCESS (0.017s)
[460.509451] Starting dynamic subtest: vcs0
[460.531106] Dynamic subtest vcs0: SUCCESS (0.030s)
[460.539623] Starting dynamic subtest: vcs1
[460.550983] Dynamic subtest vcs1: SUCCESS (0.019s)
[460.559668] Starting dynamic subtest: vecs0
[460.569886] Dynamic subtest vecs0: SUCCESS (0.018s)
[460.578670] Starting dynamic subtest: ccs0
[460.593867] Dynamic subtest ccs0: SUCCESS (0.023s)
[460.596102] Subtest preempt: SUCCESS (0.139s)
[461.990042] [101/133] (561s left) gem_exec_create (madvise)
[462.049465] Starting subtest: madvise
[462.051816] Starting dynamic subtest: smem
[483.986908] Dynamic subtest smem: SUCCESS (21.935s)
[483.989641] Subtest madvise: SUCCESS (21.936s)
[484.811071] [102/133] (539s left) kms_psr (psr-no-drrs)
[484.931271] Starting subtest: psr-no-drrs
[484.933960] Starting dynamic subtest: eDP-1
[486.570661] Dynamic subtest eDP-1: SUCCESS (1.638s)
[486.572612] Subtest psr-no-drrs: SUCCESS (1.639s)
[487.458729] [103/133] (536s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[487.551614] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[487.579952] Starting dynamic subtest: pipe-A-plane-0
[487.868451] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[487.879134] Starting dynamic subtest: pipe-A-plane-3
[488.125703] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[489.226764] Starting dynamic subtest: pipe-B-plane-0
[489.517934] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[489.529815] Starting dynamic subtest: pipe-B-plane-3
[489.750754] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[490.065375] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.515s)
[490.910311] [104/133] (533s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[490.975401] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[490.980075] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[491.159314] [105/133] (532s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[491.254387] Starting subtest: fbc-rgb101010-draw-mmap-wc
[495.904983] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.653s)
[497.020154] [106/133] (527s left) fbdev (read)
[497.063220] Starting subtest: read
[497.940531] Subtest read: SUCCESS (0.875s)
[498.001843] [107/133] (526s left) kms_concurrent (multi-plane-atomic-lowres)
[498.093495] Starting subtest: multi-plane-atomic-lowres
[498.095716] Starting dynamic subtest: pipe-A-eDP-1
[498.618446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.524s)
[498.628073] Starting dynamic subtest: pipe-B-eDP-1
[499.881843] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[499.891749] Starting dynamic subtest: pipe-C-eDP-1
[501.093770] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[501.103553] Starting dynamic subtest: pipe-D-eDP-1
[502.303520] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[502.305899] Subtest multi-plane-atomic-lowres: SUCCESS (4.211s)
[503.162441] [108/133] (521s left) vgem_slow (nohang)
[503.215167] Starting subtest: nohang
[513.652855] Subtest nohang: SUCCESS (10.438s)
[513.731208] [109/133] (510s left) gem_mmap_gtt (cpuset-basic-small-copy)
[513.794775] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[513.855435] [110/133] (510s left) kms_prop_blob (invalid-get-prop-any)
[513.913190] Starting subtest: invalid-get-prop-any
[513.915541] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[514.019994] [111/133] (510s left) tools_test (sysfs_l3_parity)
[514.074606] Starting subtest: sysfs_l3_parity
[514.171812] Subtest sysfs_l3_parity: SKIP (0.107s)
[514.226707] [112/133] (510s left) syncobj_timeline (single-wait-for-submit-signaled)
[514.289329] Starting subtest: single-wait-for-submit-signaled
[514.291698] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[514.383641] [113/133] (510s left) kms_psr (fbc-psr2-sprite-blt)
[514.489622] Starting subtest: fbc-psr2-sprite-blt
[514.492026] Starting dynamic subtest: eDP-1
[514.496213] Dynamic subtest eDP-1: SKIP (0.000s)
[514.500339] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[514.577082] [114/133] (509s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[514.681382] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[515.350457] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[515.533704] [115/133] (509s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[515.635752] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[520.061610] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.430s)
[521.240704] [116/133] (503s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[521.354735] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[525.478318] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.129s)
[526.630582] [117/133] (498s left) sysfs_heartbeat_interval (idempotent)
[526.699252] Starting subtest: idempotent
[526.701696] Starting dynamic subtest: vecs0
[526.704080] Dynamic subtest vecs0: SUCCESS (0.001s)
[526.714565] Starting dynamic subtest: ccs0
[526.716841] Dynamic subtest ccs0: SUCCESS (0.001s)
[526.725415] Starting dynamic subtest: vcs0
[526.727384] Dynamic subtest vcs0: SUCCESS (0.000s)
[526.735954] Starting dynamic subtest: bcs0
[526.738226] Dynamic subtest bcs0: SUCCESS (0.001s)
[526.746673] Starting dynamic subtest: rcs0
[526.748921] Dynamic subtest rcs0: SUCCESS (0.001s)
[526.757254] Starting dynamic subtest: vcs1
[526.759517] Dynamic subtest vcs1: SUCCESS (0.000s)
[526.761822] Subtest idempotent: SUCCESS (0.008s)
[526.799457] [118/133] (497s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[526.892820] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[534.216275] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.327s)
[534.354323] [119/133] (490s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[534.456865] Starting subtest: 2x-flip-vs-rmfb-interruptible
[534.468435] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[534.545123] [120/133] (490s left) prime_busy (hang)
[534.617257] Starting subtest: hang
[534.619617] Starting dynamic subtest: rcs0
[560.432351] Dynamic subtest rcs0: SUCCESS (25.808s)
[560.442992] Starting dynamic subtest: bcs0
[567.583497] Dynamic subtest bcs0: SUCCESS (7.150s)
[567.591730] Starting dynamic subtest: vcs0
[574.558731] Dynamic subtest vcs0: SUCCESS (6.977s)
[574.570032] Starting dynamic subtest: vcs1
[581.537932] Dynamic subtest vcs1: SUCCESS (6.975s)
[581.547991] Starting dynamic subtest: vecs0
[588.571767] Dynamic subtest vecs0: SUCCESS (7.034s)
[588.580223] Starting dynamic subtest: ccs0
[602.411870] Dynamic subtest ccs0: SUCCESS (13.840s)
[602.414849] Subtest hang: SUCCESS (67.790s)
[602.543613] [121/133] (422s left) gem_softpin (softpin)
[602.613515] Starting subtest: softpin
[634.849889] Subtest softpin: SUCCESS (32.230s)
[634.965280] [122/133] (389s left) kms_invalid_mode (bad-hsync-end)
[635.065152] Starting subtest: bad-hsync-end
[635.067609] Starting dynamic subtest: pipe-A-eDP-1
[635.348494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[635.361969] Starting dynamic subtest: pipe-B-eDP-1
[635.364560] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[635.373271] Starting dynamic subtest: pipe-C-eDP-1
[635.375197] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[635.383073] Starting dynamic subtest: pipe-D-eDP-1
[635.385021] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[635.386996] Subtest bad-hsync-end: SUCCESS (0.291s)
[636.194015] [123/133] (388s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[636.293831] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[636.298235] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[636.389481] [124/133] (388s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[636.491458] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[636.495594] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[636.601855] [125/133] (388s left) vgem_basic (dmabuf-export)
[636.651986] Starting subtest: dmabuf-export
[636.694605] Subtest dmabuf-export: SUCCESS (0.044s)
[636.806994] [126/133] (388s left) gem_shrink (reclaim)
[636.860949] Starting subtest: reclaim
[639.359189] Subtest reclaim: SUCCESS (2.498s)
[639.504447] [127/133] (385s left) kms_big_fb (linear-8bpp-rotate-0)
[639.615113] Starting subtest: linear-8bpp-rotate-0
[640.827293] Subtest linear-8bpp-rotate-0: SUCCESS (1.212s)
[640.951586] [128/133] (384s left) kms_plane_scaling (planes-upscale-20x20)
[641.050216] Starting subtest: planes-upscale-20x20
[641.052129] Starting dynamic subtest: pipe-A
[641.110614] Dynamic subtest pipe-A: SUCCESS (0.062s)
[641.119655] Starting dynamic subtest: pipe-B
[642.216101] Dynamic subtest pipe-B: SUCCESS (1.104s)
[642.227296] Starting dynamic subtest: pipe-C
[643.325648] Dynamic subtest pipe-C: SUCCESS (1.108s)
[643.335093] Starting dynamic subtest: pipe-D
[644.467716] Dynamic subtest pipe-D: SUCCESS (1.141s)
[644.470070] Subtest planes-upscale-20x20: SUCCESS (3.419s)
[645.619310] [129/133] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[645.715898] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[645.720035] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[645.810824] [130/133] (379s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[645.872098] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[645.979403] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[646.058848] [131/133] (379s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[646.152454] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[646.154750] Starting dynamic subtest: pipe-A
[646.489373] Dynamic subtest pipe-A: SUCCESS (0.339s)
[646.498690] Starting dynamic subtest: pipe-B
[647.935810] Dynamic subtest pipe-B: SUCCESS (1.446s)
[647.945210] Starting dynamic subtest: pipe-C
[649.332336] Dynamic subtest pipe-C: SUCCESS (1.396s)
[649.342587] Starting dynamic subtest: pipe-D
[650.784545] Dynamic subtest pipe-D: SUCCESS (1.451s)
[650.787082] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.636s)
[651.939401] [132/133] (373s left) gem_pxp (reject-modify-context-protection-on)
[652.040883] Starting subtest: reject-modify-context-protection-on
[652.043268] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[652.161339] [133/133] (373s left) kms_addfb_basic (unused-handle)
[652.212597] Starting subtest: unused-handle
[652.214549] Subtest unused-handle: SUCCESS (0.000s)
[652.331947] Closing watchdogs
results: parsing output: 0/ for test: kms_vrr
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: syncobj_basic
results: parsing output: 6/ for test: gem_wait
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane_cursor
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: gem_flink_basic
results: parsing output: 12/ for test: i915_pm_rc6_residency
results: parsing output: 13/ for test: gem_exec_flush
results: parsing output: 14/ for test: kms_vrr
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_color
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_pm_lpsp
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_cursor_edge_walk
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_rotation_crc
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_legacy_colorkey
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: core_getversion
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: api_intel_allocator
results: parsing output: 44/ for test: prime_mmap
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: gem_exec_store
results: parsing output: 49/ for test: gem_ctx_shared
results: parsing output: 50/ for test: prime_mmap
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: gem_ctx_engines
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: kms_universal_plane
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: gem_exec_nop
results: parsing output: 67/ for test: kms_async_flips
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: gem_partial_pwrite_pread
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: kms_plane_alpha_blend
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: gem_exec_params
results: parsing output: 75/ for test: i915_power
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: kms_fence_pin_leak
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_pxp
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_chamelium_hpd
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_dp_link_training
results: parsing output: 98/ for test: prime_vgem
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: gem_exec_create
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: fbdev
results: parsing output: 106/ for test: kms_concurrent
results: parsing output: 107/ for test: vgem_slow
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_prop_blob
results: parsing output: 110/ for test: tools_test
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: sysfs_heartbeat_interval
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: prime_busy
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: kms_invalid_mode
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: vgem_basic
results: parsing output: 125/ for test: gem_shrink
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: kms_addfb_basic
Done.