[57.837713] Initializing watchdogs
[57.837766]   /dev/watchdog0
[57.851725] [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]
[57.856397] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.858548] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.861897] [001/132] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[57.987027] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[57.991644] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[58.109027] [002/132] (960s left) gem_eio (banned)
[58.241748] Starting subtest: banned
[58.606869] Subtest banned: SUCCESS (0.367s)
[58.750531] [003/132] (959s left) prime_vgem (fence-flip-hang)
[58.841368] Subtest fence-flip-hang: SKIP (0.000s)
[58.936518] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[58.939182] [004/132] (959s left) kms_flip (2x-flip-vs-wf_vblank)
[59.028865] Starting subtest: 2x-flip-vs-wf_vblank
[59.037646] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[59.121570] [005/132] (959s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[59.213596] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[59.217363] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[59.322676] [006/132] (959s left) gem_linear_blits (interruptible)
[59.669807] Starting subtest: interruptible
[63.978987] Subtest interruptible: SUCCESS (4.324s)
[64.140012] [007/132] (954s left) kms_cursor_legacy (torture-bo)
[64.300650] Starting subtest: torture-bo
[64.303033] Starting dynamic subtest: pipe-A
[70.191968] Dynamic subtest pipe-A: SUCCESS (5.897s)
[70.201693] Starting dynamic subtest: pipe-B
[78.190640] Dynamic subtest pipe-B: SUCCESS (8.003s)
[78.200663] Starting dynamic subtest: pipe-C
[84.715194] Dynamic subtest pipe-C: SUCCESS (6.523s)
[84.730282] Starting dynamic subtest: pipe-D
[91.405700] Dynamic subtest pipe-D: SUCCESS (6.689s)
[91.415997] Starting dynamic subtest: all-pipes
[97.147750] Dynamic subtest all-pipes: SUCCESS (5.741s)
[97.150359] Subtest torture-bo: SUCCESS (32.858s)
[97.302327] [008/132] (921s left) gem_ctx_exec (basic-invalid-context)
[97.355761] Starting subtest: basic-invalid-context
[97.360210] Subtest basic-invalid-context: SUCCESS (0.005s)
[97.469974] [009/132] (921s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[97.590376] Starting subtest: verify-pxp-key-change-after-suspend-resume
[105.666644] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.076s)
[105.769204] [010/132] (912s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[105.839356] Starting subtest: y-tiled-ccs-to-yf-tiled
[105.843817] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[106.023327] [011/132] (912s left) gem_pxp (create-regular-buffer)
[106.081058] Starting subtest: create-regular-buffer
[106.083568] Subtest create-regular-buffer: SUCCESS (0.000s)
[106.201451] [012/132] (912s left) gen9_exec_parse (bb-start-cmd)
[106.270373] Subtest bb-start-cmd: SKIP (0.000s)
[106.356878] [013/132] (912s left) prime_mmap (test_errors)
[106.418250] Starting subtest: test_errors
[106.420700] Starting dynamic subtest: test_errors-smem
[106.515631] Dynamic subtest test_errors-smem: SUCCESS (0.099s)
[106.518110] Subtest test_errors: SUCCESS (0.099s)
[106.626214] [014/132] (912s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[106.724274] Starting subtest: plane-scaler-unity-scaling-with-rotation
[106.726521] Starting dynamic subtest: pipe-A
[106.965205] Dynamic subtest pipe-A: SUCCESS (0.243s)
[106.972798] Starting dynamic subtest: pipe-B
[108.266761] Dynamic subtest pipe-B: SUCCESS (1.301s)
[108.275174] Starting dynamic subtest: pipe-C
[109.562373] Dynamic subtest pipe-C: SUCCESS (1.295s)
[109.571636] Starting dynamic subtest: pipe-D
[110.931214] Dynamic subtest pipe-D: SUCCESS (1.368s)
[110.933589] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.209s)
[112.095806] [015/132] (906s left) gem_softpin (allocator-evict)
[112.170812] Starting subtest: allocator-evict
[112.173242] Starting dynamic subtest: rcs0
[135.531709] Dynamic subtest rcs0: SUCCESS (23.361s)
[135.539885] Starting dynamic subtest: bcs0
[159.302517] Dynamic subtest bcs0: SUCCESS (23.765s)
[159.317897] Starting dynamic subtest: vcs0
[182.837586] Dynamic subtest vcs0: SUCCESS (23.537s)
[182.848935] Starting dynamic subtest: vcs1
[206.703257] Dynamic subtest vcs1: SUCCESS (23.865s)
[206.712190] Starting dynamic subtest: vecs0
[230.699064] Dynamic subtest vecs0: SUCCESS (23.994s)
[230.708899] Starting dynamic subtest: ccs0
[254.361676] Dynamic subtest ccs0: SUCCESS (23.662s)
[254.363926] Subtest allocator-evict: SUCCESS (142.188s)
[254.442077] [016/132] (764s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[254.604321] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[254.608741] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[254.708325] [017/132] (764s left) syncobj_wait (wait-for-submit-snapshot)
[254.771400] Starting subtest: wait-for-submit-snapshot
[254.853369] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[254.941178] [018/132] (764s left) gem_workarounds (reset-context)
[255.009290] Starting subtest: reset-context
[255.192635] Subtest reset-context: SUCCESS (0.183s)
[255.310407] [019/132] (763s left) gem_mmap_wc (write-gtt-read-wc)
[255.363751] Subtest write-gtt-read-wc: SKIP (0.000s)
[255.424861] [020/132] (763s left) kms_psr (pr-primary-mmap-cpu)
[255.514082] Starting subtest: pr-primary-mmap-cpu
[255.517794] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[255.585254] [021/132] (763s left) kms_properties (get_properties-sanity-non-atomic)
[255.667953] Starting subtest: get_properties-sanity-non-atomic
[255.669829] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[255.738637] [022/132] (763s left) kms_psr (fbc-psr2-dpms)
[255.826077] Starting subtest: fbc-psr2-dpms
[255.827910] Starting dynamic subtest: eDP-1
[255.831540] Dynamic subtest eDP-1: SKIP (0.000s)
[255.835194] Subtest fbc-psr2-dpms: SKIP (0.000s)
[255.910764] [023/132] (763s left) prime_busy (hang)
[255.971087] Starting subtest: hang
[255.973064] Starting dynamic subtest: rcs0
[282.421078] Dynamic subtest rcs0: SUCCESS (26.446s)
[282.429584] Starting dynamic subtest: bcs0
[289.569038] Dynamic subtest bcs0: SUCCESS (7.149s)
[289.577345] Starting dynamic subtest: vcs0
[296.543292] Dynamic subtest vcs0: SUCCESS (6.974s)
[296.551949] Starting dynamic subtest: vcs1
[303.581277] Dynamic subtest vcs1: SUCCESS (7.037s)
[303.589934] Starting dynamic subtest: vecs0
[310.561107] Dynamic subtest vecs0: SUCCESS (6.976s)
[310.569858] Starting dynamic subtest: ccs0
[324.396478] Dynamic subtest ccs0: SUCCESS (13.837s)
[324.398797] Subtest hang: SUCCESS (68.423s)
[324.499494] [024/132] (694s left) kms_getfb (getfb2-handle-closed)
[324.594821] Starting subtest: getfb2-handle-closed
[324.597153] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[324.700746] [025/132] (694s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[324.749648] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[324.858876] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[324.932256] [026/132] (694s left) gem_eio (hibernate)
[325.111608] Starting subtest: hibernate
[339.669856] Subtest hibernate: SUCCESS (14.557s)
[346.830763] [027/132] (679s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[347.045709] Starting subtest: cursor-vs-flip-atomic
[376.455817] Subtest cursor-vs-flip-atomic: SUCCESS (29.407s)
[377.315806] [028/132] (649s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[377.437736] Starting subtest: cursorB-vs-flipB-legacy
[377.442175] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[377.581491] [029/132] (648s left) kms_rotation_crc (sprite-rotation-180)
[377.672126] Starting subtest: sprite-rotation-180
[384.477219] Subtest sprite-rotation-180: SUCCESS (6.807s)
[385.702758] [030/132] (640s left) gem_eio (context-create)
[385.937298] Starting subtest: context-create
[386.295638] Subtest context-create: SUCCESS (0.358s)
[386.411961] [031/132] (640s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[386.498131] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[386.502512] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[386.599032] [032/132] (640s left) kms_flip (nonexisting-fb-interruptible)
[386.686642] Starting subtest: nonexisting-fb-interruptible
[386.688497] Starting dynamic subtest: A-eDP1
[387.867708] Dynamic subtest A-eDP1: SUCCESS (1.180s)
[387.878503] Starting dynamic subtest: B-eDP1
[389.001505] Dynamic subtest B-eDP1: SUCCESS (1.133s)
[389.010411] Starting dynamic subtest: C-eDP1
[390.137867] Dynamic subtest C-eDP1: SUCCESS (1.136s)
[390.149876] Starting dynamic subtest: D-eDP1
[391.271438] Dynamic subtest D-eDP1: SUCCESS (1.133s)
[391.273902] Subtest nonexisting-fb-interruptible: SUCCESS (4.586s)
[392.451029] [033/132] (634s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[392.523827] Starting subtest: multi-wait-for-submit-available-submitted
[392.526260] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[392.618273] [034/132] (634s left) kms_cursor_crc (cursor-offscreen-512x512)
[392.927696] Starting subtest: cursor-offscreen-512x512
[392.932190] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[393.088170] [035/132] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[393.175528] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[393.179558] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[393.269474] [036/132] (633s left) gem_exec_balancer (invalid-balancer)
[393.328292] Starting subtest: invalid-balancer
[394.212804] Subtest invalid-balancer: SUCCESS (0.883s)
[394.520850] [037/132] (632s left) gem_exec_big (single)
[394.583391] Starting subtest: single
[397.860389] Subtest single: FAIL (3.218s)
[397.898963] [038/132] (628s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[398.335437] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[399.154741] [039/132] (627s left) kms_joiner (invalid-modeset-ultra-joiner)
[399.251246] Starting subtest: invalid-modeset-ultra-joiner
[399.255214] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[399.340653] [040/132] (627s left) kms_addfb_basic (unused-modifier)
[399.392832] Starting subtest: unused-modifier
[399.394758] Subtest unused-modifier: SUCCESS (0.000s)
[399.552166] [041/132] (627s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[399.924467] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[400.781963] [042/132] (626s left) fbdev (info)
[400.824508] Starting subtest: info
[400.826672] Subtest info: SUCCESS (0.000s)
[400.890424] [043/132] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[400.992074] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[400.996070] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[401.096407] [044/132] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[401.187684] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[408.538719] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.355s)
[408.671640] [045/132] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[408.775287] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[408.779573] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[408.867027] [046/132] (618s left) gem_exec_schedule (semaphore-power)
[409.067287] Subtest semaphore-power: SKIP (0.000s)
[409.246205] [047/132] (618s left) gem_exec_schedule (implicit-boths)
[409.318488] Starting subtest: implicit-boths
[409.320430] Starting dynamic subtest: rcs0
[409.423324] Dynamic subtest rcs0: SUCCESS (0.114s)
[409.435800] Starting dynamic subtest: vcs0
[409.525640] Dynamic subtest vcs0: SUCCESS (0.102s)
[409.538088] Starting dynamic subtest: vcs1
[409.608097] Dynamic subtest vcs1: SUCCESS (0.081s)
[409.619137] Starting dynamic subtest: vecs0
[409.706683] Dynamic subtest vecs0: SUCCESS (0.098s)
[409.717820] Starting dynamic subtest: ccs0
[409.804838] Dynamic subtest ccs0: SUCCESS (0.098s)
[409.807219] Subtest implicit-boths: SUCCESS (0.497s)
[410.989311] [048/132] (616s left) i915_query (query-topology-kernel-writes)
[411.038295] Starting subtest: query-topology-kernel-writes
[411.040650] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[411.154850] [049/132] (616s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[411.250066] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[411.252399] Starting dynamic subtest: pipe-A-default-mode
[412.391666] Dynamic subtest pipe-A-default-mode: SKIP (1.139s)
[412.395860] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.140s)
[412.543889] [050/132] (614s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[412.642742] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[416.846960] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.207s)
[417.972811] [051/132] (609s left) kms_plane_scaling (planes-upscale-20x20)
[418.064072] Starting subtest: planes-upscale-20x20
[418.066342] Starting dynamic subtest: pipe-A
[418.123795] Dynamic subtest pipe-A: SUCCESS (0.062s)
[418.135997] Starting dynamic subtest: pipe-B
[419.283613] Dynamic subtest pipe-B: SUCCESS (1.159s)
[419.295750] Starting dynamic subtest: pipe-C
[420.392240] Dynamic subtest pipe-C: SUCCESS (1.108s)
[420.403161] Starting dynamic subtest: pipe-D
[421.514985] Dynamic subtest pipe-D: SUCCESS (1.122s)
[421.517416] Subtest planes-upscale-20x20: SUCCESS (3.454s)
[422.685260] [052/132] (604s left) gem_eio (in-flight-10ms)
[422.896192] Starting subtest: in-flight-10ms
[431.799308] Subtest in-flight-10ms: SUCCESS (8.902s)
[431.938230] [053/132] (595s left) kms_atomic_interruptible (universal-setplane-primary)
[432.018753] Starting subtest: universal-setplane-primary
[432.020986] Starting dynamic subtest: pipe-A-eDP-1
[439.405515] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.387s)
[439.407956] Subtest universal-setplane-primary: SUCCESS (7.388s)
[440.245227] [054/132] (587s left) kms_chamelium_color (ctm-max)
[440.350223] Subtest ctm-max: SKIP (0.000s)
[440.394625] [055/132] (587s left) perf_pmu (all-busy-idle-check-all)
[440.436411] Starting subtest: all-busy-idle-check-all
[441.879608] Subtest all-busy-idle-check-all: SUCCESS (1.444s)
[441.981702] [056/132] (585s left) gem_exec_parallel (contexts)
[442.040878] Starting subtest: contexts
[442.043269] Starting dynamic subtest: rcs0
[446.061739] Dynamic subtest rcs0: SUCCESS (4.019s)
[446.072666] Starting dynamic subtest: bcs0
[449.833774] Dynamic subtest bcs0: SUCCESS (3.769s)
[449.846917] Starting dynamic subtest: vcs0
[454.412445] Dynamic subtest vcs0: SUCCESS (4.577s)
[454.425632] Starting dynamic subtest: vcs1
[458.466360] Dynamic subtest vcs1: SUCCESS (4.052s)
[458.476979] Starting dynamic subtest: vecs0
[464.270718] Dynamic subtest vecs0: SUCCESS (5.803s)
[464.282732] Starting dynamic subtest: ccs0
[468.364686] Dynamic subtest ccs0: SUCCESS (4.091s)
[468.367260] Subtest contexts: SUCCESS (26.322s)
[468.565180] [057/132] (559s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[468.680853] Starting subtest: x-tiled-8bpp-rotate-90
[468.701616] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[468.841827] [058/132] (558s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[468.937060] Starting subtest: plane-lut1d-ctm3x4-lut1d
[469.116093] Starting dynamic subtest: pipe-A-plane-0
[469.474075] Dynamic subtest pipe-A-plane-0: FAIL (0.176s)
[469.484780] Starting dynamic subtest: pipe-A-plane-1
[469.664161] Dynamic subtest pipe-A-plane-1: FAIL (0.175s)
[469.673879] Starting dynamic subtest: pipe-A-plane-2
[469.884700] Dynamic subtest pipe-A-plane-2: FAIL (0.168s)
[470.839098] Starting dynamic subtest: pipe-B-plane-0
[471.281804] Dynamic subtest pipe-B-plane-0: FAIL (0.164s)
[471.294420] Starting dynamic subtest: pipe-B-plane-1
[471.614944] Dynamic subtest pipe-B-plane-1: FAIL (0.188s)
[471.627568] Starting dynamic subtest: pipe-B-plane-2
[471.936213] Dynamic subtest pipe-B-plane-2: FAIL (0.176s)
[472.562826] Starting dynamic subtest: pipe-C-plane-0
[473.102154] Dynamic subtest pipe-C-plane-0: FAIL (0.162s)
[473.113267] Starting dynamic subtest: pipe-C-plane-1
[473.535110] Dynamic subtest pipe-C-plane-1: FAIL (0.611s)
[473.544272] Starting dynamic subtest: pipe-C-plane-2
[473.916451] Dynamic subtest pipe-C-plane-2: FAIL (0.160s)
[474.701190] Starting dynamic subtest: pipe-D-plane-0
[475.324850] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[475.336805] Starting dynamic subtest: pipe-D-plane-1
[475.823564] Dynamic subtest pipe-D-plane-1: FAIL (0.609s)
[475.836068] Starting dynamic subtest: pipe-D-plane-2
[476.300099] Dynamic subtest pipe-D-plane-2: FAIL (0.564s)
[476.315648] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (7.380s)
[477.174065] [059/132] (550s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[477.289059] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[477.293583] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[477.370211] [060/132] (550s left) gem_lmem_swapping (heavy-verify-random)
[477.423017] Subtest heavy-verify-random: SKIP (0.000s)
[477.465215] [061/132] (550s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[477.563285] Starting subtest: crc-primary-basic-yf-tiled-ccs
[477.565436] Starting dynamic subtest: pipe-A-eDP-1
[477.588596] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[477.600736] Starting dynamic subtest: pipe-B-eDP-1
[477.622388] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[477.632414] Starting dynamic subtest: pipe-C-eDP-1
[477.654810] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[477.664765] Starting dynamic subtest: pipe-D-eDP-1
[477.687024] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[477.691095] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[479.835325] [062/132] (548s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[479.941063] Starting subtest: yf-tiled-addfb-size-overflow
[479.945578] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[480.042584] [063/132] (547s left) kms_psr (fbc-psr-dpms)
[480.136585] Starting subtest: fbc-psr-dpms
[480.139085] Starting dynamic subtest: eDP-1
[480.143566] Dynamic subtest eDP-1: SKIP (0.000s)
[480.147650] Subtest fbc-psr-dpms: SKIP (0.001s)
[480.216555] [064/132] (547s left) gem_watchdog (default-physical)
[480.292249] Starting subtest: default-physical
[482.054912] Subtest default-physical: SUCCESS (1.772s)
[482.136977] [065/132] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[482.236089] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[485.868501] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.637s)
[487.057496] [066/132] (540s left) gem_exec_whisper (basic-contexts-forked)
[487.119127] Starting subtest: basic-contexts-forked
[510.487797] Subtest basic-contexts-forked: SUCCESS (23.367s)
[510.670628] [067/132] (517s left) gem_ctx_persistence (many-contexts)
[510.764592] Starting subtest: many-contexts
[548.487027] Subtest many-contexts: SUCCESS (37.721s)
[548.571691] [068/132] (479s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[548.687978] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[549.734084] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.046s)
[549.857978] [069/132] (478s left) gem_ctx_freq (sysfs)
[549.928052] Starting subtest: sysfs
[549.930143] Starting dynamic subtest: gt0
[555.432884] Dynamic subtest gt0: SUCCESS (5.503s)
[555.445829] Starting dynamic subtest: gt1
[596.885389] Dynamic subtest gt1: SUCCESS (41.449s)
[596.888150] Subtest sysfs: SUCCESS (46.955s)
[597.019404] [070/132] (431s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[597.120990] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[597.122905] Starting dynamic subtest: pipe-A-eDP-1
[597.370610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.218s)
[597.383107] Starting dynamic subtest: pipe-B-eDP-1
[598.615997] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[598.627441] Starting dynamic subtest: pipe-C-eDP-1
[599.824993] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[599.836642] Starting dynamic subtest: pipe-D-eDP-1
[601.070232] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[601.072276] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.921s)
[602.296803] [071/132] (425s left) kms_pm_backlight (fade-with-dpms)
[602.401257] Starting subtest: fade-with-dpms
[604.549643] Starting dynamic subtest: eDP-1
[607.035305] Dynamic subtest eDP-1: SUCCESS (2.484s)
[607.037509] Subtest fade-with-dpms: SUCCESS (4.634s)
[607.854490] [072/132] (420s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[607.948077] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[612.350222] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.405s)
[613.771467] [073/132] (414s left) kms_pipe_crc_basic (read-crc)
[613.871601] Starting subtest: read-crc
[613.873845] Starting dynamic subtest: pipe-A-eDP-1
[614.573537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[614.585244] Starting dynamic subtest: pipe-B-eDP-1
[615.944295] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s)
[615.956836] Starting dynamic subtest: pipe-C-eDP-1
[617.302944] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s)
[617.313152] Starting dynamic subtest: pipe-D-eDP-1
[618.633254] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[618.635488] Subtest read-crc: SUCCESS (4.762s)
[619.481189] [074/132] (408s left) kms_content_protection (mei-interface)
[619.616717] Starting subtest: mei-interface
[619.621199] Subtest mei-interface: SKIP (0.001s)
[619.735577] [075/132] (408s left) kms_cursor_crc (cursor-random-256x85)
[620.008605] Starting subtest: cursor-random-256x85
[620.055025] Subtest cursor-random-256x85: SKIP (0.042s)
[620.244483] [076/132] (408s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[620.321478] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[620.391715] [077/132] (408s left) kms_force_connector_basic (force-load-detect)
[620.466634] Starting subtest: force-load-detect
[620.470609] Subtest force-load-detect: SKIP (0.000s)
[620.579722] [078/132] (407s left) gem_mmap_gtt (basic-small-copy-xy)
[620.644467] Subtest basic-small-copy-XY: SKIP (0.000s)
[620.704072] [079/132] (407s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[620.752833] Starting subtest: invalid-smem-bo-on-discrete
[620.756360] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[620.870621] [080/132] (407s left) kms_invalid_mode (clock-too-high)
[620.970357] Starting subtest: clock-too-high
[620.972204] Starting dynamic subtest: pipe-A-eDP-1
[620.975524] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[620.985865] Starting dynamic subtest: pipe-B-eDP-1
[620.989432] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[620.998937] Starting dynamic subtest: pipe-C-eDP-1
[621.002364] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[621.011616] Starting dynamic subtest: pipe-D-eDP-1
[621.014955] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[621.018307] Subtest clock-too-high: SKIP (0.004s)
[621.053189] [081/132] (407s left) perf (gen8-unprivileged-single-ctx-counters)
[621.182652] Starting subtest: gen8-unprivileged-single-ctx-counters
[621.186338] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[621.225327] [082/132] (407s left) gem_mmap_gtt (basic-read)
[621.283429] Subtest basic-read: SKIP (0.000s)
[621.348917] [083/132] (407s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[621.407697] Starting subtest: etime-multi-wait-all-submitted-signaled
[621.513430] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[621.602900] [084/132] (407s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[621.704307] Starting subtest: fbc-rgb565-draw-mmap-wc
[625.655240] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.954s)
[626.781731] [085/132] (402s left) dumb_buffer (invalid-bpp)
[626.835462] Starting subtest: invalid-bpp
[626.837559] Subtest invalid-bpp: SUCCESS (0.000s)
[626.959957] [086/132] (401s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[627.060047] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[627.064234] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[627.143692] [087/132] (401s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[627.199992] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[627.202251] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[627.318013] [088/132] (401s left) vgem_basic (busy-fence)
[627.358941] Starting subtest: busy-fence
[627.360854] Subtest busy-fence: SUCCESS (0.000s)
[627.417065] [089/132] (401s left) gem_exec_fence (long-history)
[627.868556] Starting subtest: long-history
[634.640699] Subtest long-history: SUCCESS (6.772s)
[635.371756] [090/132] (393s left) i915_pm_rc6_residency (rc6-accuracy)
[635.419041] Starting subtest: rc6-accuracy
[635.421240] Starting dynamic subtest: gt0
[638.591835] Dynamic subtest gt0: SUCCESS (3.169s)
[638.604818] Starting dynamic subtest: gt1
[641.763034] Dynamic subtest gt1: SUCCESS (3.169s)
[641.765620] Subtest rc6-accuracy: SUCCESS (6.344s)
[641.850923] [091/132] (387s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[641.972705] Starting subtest: plane-all-modeset-transition-internal-panels
[641.974556] Starting dynamic subtest: pipe-A-eDP-1
[642.863785] Dynamic subtest pipe-A-eDP-1: FAIL (0.285s)
[642.875793] Starting dynamic subtest: pipe-B-eDP-1
[643.302413] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.042s)
[643.588280] Subtest plane-all-modeset-transition-internal-panels: FAIL (1.616s)
[644.420934] [092/132] (384s left) i915_query (query-regions-unallocated)
[644.484020] Starting subtest: query-regions-unallocated
[644.486097] Subtest query-regions-unallocated: SUCCESS (0.000s)
[644.579362] [093/132] (384s left) gem_exec_schedule (preempt-other)
[644.644540] Starting subtest: preempt-other
[644.646897] Starting dynamic subtest: rcs0
[644.704519] Dynamic subtest rcs0: SUCCESS (0.069s)
[644.718767] Starting dynamic subtest: bcs0
[644.769845] Dynamic subtest bcs0: SUCCESS (0.064s)
[644.782953] Starting dynamic subtest: vcs0
[644.843796] Dynamic subtest vcs0: SUCCESS (0.072s)
[644.856681] Starting dynamic subtest: vcs1
[644.913580] Dynamic subtest vcs1: SUCCESS (0.069s)
[644.923782] Starting dynamic subtest: vecs0
[644.982741] Dynamic subtest vecs0: SUCCESS (0.069s)
[644.993259] Starting dynamic subtest: ccs0
[645.063398] Dynamic subtest ccs0: SUCCESS (0.079s)
[645.066027] Subtest preempt-other: SUCCESS (0.428s)
[645.990643] [094/132] (383s left) api_intel_bb (offset-control)
[646.051139] Starting subtest: offset-control
[646.058063] Subtest offset-control: SUCCESS (0.008s)
[646.199008] [095/132] (383s left) kms_vblank (accuracy-idle)
[646.303389] Starting subtest: accuracy-idle
[646.305299] Starting dynamic subtest: pipe-A-eDP-1
[648.074534] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.771s)
[648.089584] Starting dynamic subtest: pipe-D-eDP-1
[650.481423] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.406s)
[650.483785] Subtest accuracy-idle: SUCCESS (4.181s)
[651.314227] [096/132] (378s left) kms_atomic_transition (modeset-transition)
[651.408984] Starting subtest: modeset-transition
[651.411204] Starting dynamic subtest: 1x-outputs
[662.261733] Dynamic subtest 1x-outputs: SUCCESS (10.852s)
[662.264132] Subtest modeset-transition: SUCCESS (10.854s)
[663.126737] [097/132] (366s left) kms_flip (absolute-wf_vblank-interruptible)
[663.218996] Starting subtest: absolute-wf_vblank-interruptible
[663.221321] Starting dynamic subtest: A-eDP1
[671.991289] Dynamic subtest A-eDP1: SUCCESS (8.771s)
[672.006949] Starting dynamic subtest: B-eDP1
[680.722941] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[680.735256] Starting dynamic subtest: C-eDP1
[689.437354] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[689.449854] Starting dynamic subtest: D-eDP1
[698.183292] Dynamic subtest D-eDP1: SUCCESS (8.739s)
[698.187793] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.964s)
[699.425972] [098/132] (329s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[699.492109] Starting subtest: single-wait-all-for-submit-signaled
[699.494344] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[699.608769] [099/132] (329s left) prime_mmap (test_map_unmap)
[699.656889] Starting subtest: test_map_unmap
[699.659061] Starting dynamic subtest: test_map_unmap-smem
[699.685456] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s)
[699.687841] Subtest test_map_unmap: SUCCESS (0.031s)
[699.785332] [100/132] (329s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[699.888384] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[699.892689] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[699.998575] [101/132] (329s left) perf_pmu (busy-hang)
[700.034841] Starting subtest: busy-hang
[700.037200] Starting dynamic subtest: rcs0
[701.295801] Dynamic subtest rcs0: SUCCESS (1.258s)
[701.307078] Starting dynamic subtest: bcs0
[702.549726] Dynamic subtest bcs0: SUCCESS (1.251s)
[702.561135] Starting dynamic subtest: vcs0
[704.408732] Dynamic subtest vcs0: SUCCESS (1.858s)
[704.421076] Starting dynamic subtest: vcs1
[706.459100] Dynamic subtest vcs1: SUCCESS (2.045s)
[706.470485] Starting dynamic subtest: vecs0
[708.377754] Dynamic subtest vecs0: SUCCESS (1.919s)
[708.388926] Starting dynamic subtest: ccs0
[709.604343] Dynamic subtest ccs0: SUCCESS (1.225s)
[709.606937] Subtest busy-hang: SUCCESS (9.570s)
[709.709226] [102/132] (319s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[709.823948] Starting subtest: multiplane-rotation-cropping-bottom
[727.338850] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.515s)
[727.444744] [103/132] (302s left) gem_render_copy (linear)
[727.512018] Starting subtest: linear
[727.514042] Starting dynamic subtest: smem
[727.551721] Dynamic subtest smem: SUCCESS (0.039s)
[727.554245] Subtest linear: SUCCESS (0.040s)
[727.738114] [104/132] (301s left) api_intel_allocator (gem-pool)
[727.793676] Starting subtest: gem-pool
[727.798909] Subtest gem-pool: SUCCESS (0.006s)
[727.922240] [105/132] (301s left) kms_vblank (ts-continuation-idle-hang)
[728.008253] Starting subtest: ts-continuation-idle-hang
[728.010426] Starting dynamic subtest: pipe-A-eDP-1
[754.655424] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.645s)
[754.671487] Starting dynamic subtest: pipe-D-eDP-1
[779.677506] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.020s)
[779.680016] Subtest ts-continuation-idle-hang: SUCCESS (51.670s)
[780.550395] [106/132] (249s left) kms_cursor_edge_walk (128x128-top-edge)
[780.645891] Starting subtest: 128x128-top-edge
[780.648204] Starting dynamic subtest: pipe-A-eDP-1
[784.097921] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[784.109070] Starting dynamic subtest: pipe-D-eDP-1
[787.233854] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[787.236225] Subtest 128x128-top-edge: SUCCESS (6.587s)
[788.051069] [107/132] (241s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[788.147085] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[788.149256] Starting dynamic subtest: pipe-A-default-mode
[790.865282] Dynamic subtest pipe-A-default-mode: SUCCESS (2.716s)
[790.867449] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.717s)
[791.745425] [108/132] (238s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[791.839752] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[791.841944] Starting dynamic subtest: pipe-A-eDP-1
[791.864101] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[791.875097] Starting dynamic subtest: pipe-B-eDP-1
[791.896664] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[791.912839] Starting dynamic subtest: pipe-C-eDP-1
[791.936043] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[791.949048] Starting dynamic subtest: pipe-D-eDP-1
[791.971707] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[791.975743] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.012s)
[794.018649] [109/132] (235s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[794.140128] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[794.144490] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[794.243062] [110/132] (235s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[794.341831] Starting subtest: fbc-indfb-scaledprimary
[797.240989] Subtest fbc-indfb-scaledprimary: SUCCESS (2.903s)
[798.403886] [111/132] (231s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[798.500260] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[798.504259] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[798.582740] [112/132] (231s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[798.680415] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[798.684635] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[798.800361] [113/132] (231s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[798.912409] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[798.916453] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[799.015950] [114/132] (231s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[799.112548] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[800.203025] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[800.334281] [115/132] (229s left) gem_readwrite (beyond-eob)
[800.388289] Subtest beyond-EOB: SKIP (0.000s)
[800.469713] [116/132] (229s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[800.586650] Starting subtest: cursorB-vs-flipA-atomic
[800.590473] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[800.731946] [117/132] (229s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[800.837843] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[807.537826] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.702s)
[807.686337] [118/132] (222s left) perf_pmu (busy-accuracy-98)
[807.732482] Starting subtest: busy-accuracy-98
[807.734374] Starting dynamic subtest: rcs0
[810.775397] Dynamic subtest rcs0: SUCCESS (3.041s)
[810.788297] Starting dynamic subtest: bcs0
[813.834765] Dynamic subtest bcs0: SUCCESS (3.056s)
[813.847941] Starting dynamic subtest: vcs0
[816.879768] Dynamic subtest vcs0: SUCCESS (3.043s)
[816.892103] Starting dynamic subtest: vcs1
[819.920405] Dynamic subtest vcs1: SUCCESS (3.040s)
[819.931025] Starting dynamic subtest: vecs0
[822.963731] Dynamic subtest vecs0: SUCCESS (3.040s)
[822.973975] Starting dynamic subtest: ccs0
[826.018921] Dynamic subtest ccs0: SUCCESS (3.052s)
[826.021231] Subtest busy-accuracy-98: SUCCESS (18.287s)
[826.136893] [119/132] (204s left) kms_psr (fbc-pr-dpms)
[826.245062] Starting subtest: fbc-pr-dpms
[826.249297] Subtest fbc-pr-dpms: SKIP (0.001s)
[826.319456] [120/132] (204s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[826.417533] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[827.407018] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.989s)
[827.554956] [121/132] (202s left) gem_ctx_bad_destroy (invalid-ctx)
[827.619955] Starting subtest: invalid-ctx
[827.622012] Subtest invalid-ctx: SUCCESS (0.000s)
[827.713255] [122/132] (202s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[827.810951] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[827.812829] Starting dynamic subtest: pipe-A-eDP-1
[827.831727] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[827.842728] Starting dynamic subtest: pipe-B-eDP-1
[827.860146] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[827.869506] Starting dynamic subtest: pipe-C-eDP-1
[827.887026] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[827.898049] Starting dynamic subtest: pipe-D-eDP-1
[827.916208] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[827.919808] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[830.061418] [123/132] (200s left) i915_hangman (gt-engine-error)
[830.123106] Starting subtest: gt-engine-error
[830.125208] Starting dynamic subtest: rcs0
[831.861060] Dynamic subtest rcs0: SUCCESS (1.738s)
[831.876224] Starting dynamic subtest: bcs0
[833.908430] Dynamic subtest bcs0: SUCCESS (2.044s)
[833.922847] Starting dynamic subtest: vcs0
[835.892600] Dynamic subtest vcs0: SUCCESS (1.981s)
[835.906633] Starting dynamic subtest: vcs1
[837.876513] Dynamic subtest vcs1: SUCCESS (1.981s)
[837.890098] Starting dynamic subtest: vecs0
[839.859955] Dynamic subtest vecs0: SUCCESS (1.981s)
[839.876926] Starting dynamic subtest: ccs0
[841.845187] Dynamic subtest ccs0: SUCCESS (1.982s)
[841.847892] Subtest gt-engine-error: SUCCESS (11.723s)
[841.978439] [124/132] (188s left) kms_plane_cursor (primary)
[842.082930] Starting subtest: primary
[842.087154] Starting dynamic subtest: pipe-A-eDP-1-size-64
[844.634618] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.552s)
[844.661350] Starting dynamic subtest: pipe-A-eDP-1-size-128
[847.225045] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[847.250468] Starting dynamic subtest: pipe-A-eDP-1-size-256
[849.781853] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[850.097908] Starting dynamic subtest: pipe-B-eDP-1-size-64
[853.353487] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.265s)
[853.379493] Starting dynamic subtest: pipe-B-eDP-1-size-128
[855.921338] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[855.947328] Starting dynamic subtest: pipe-B-eDP-1-size-256
[858.500056] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[858.821941] Starting dynamic subtest: pipe-C-eDP-1-size-64
[861.703171] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.892s)
[861.731213] Starting dynamic subtest: pipe-C-eDP-1-size-128
[863.914061] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[863.942212] Starting dynamic subtest: pipe-C-eDP-1-size-256
[866.136442] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.202s)
[866.455527] Starting dynamic subtest: pipe-D-eDP-1-size-64
[869.312128] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.869s)
[869.339161] Starting dynamic subtest: pipe-D-eDP-1-size-128
[871.511201] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[871.540322] Starting dynamic subtest: pipe-D-eDP-1-size-256
[873.689091] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[874.003485] Subtest primary: SUCCESS (31.920s)
[874.863769] [125/132] (155s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[874.962549] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[881.671924] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.712s)
[881.795911] [126/132] (148s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[881.898421] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[888.683844] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.788s)
[888.789461] [127/132] (141s left) gen9_exec_parse (shadow-peek)
[888.861331] Subtest shadow-peek: SKIP (0.000s)
[888.932852] [128/132] (141s left) gem_mmap_offset (partial-remap)
[888.996251] Starting subtest: partial-remap
[888.998451] Starting dynamic subtest: smem0
[889.006939] Dynamic subtest smem0: SUCCESS (0.003s)
[889.009155] Subtest partial-remap: SUCCESS (0.004s)
[889.107449] [129/132] (141s left) kms_psr (psr2-sprite-plane-onoff)
[889.201759] Starting subtest: psr2-sprite-plane-onoff
[889.204060] Starting dynamic subtest: eDP-1
[890.964081] Dynamic subtest eDP-1: SUCCESS (1.761s)
[890.966479] Subtest psr2-sprite-plane-onoff: SUCCESS (1.762s)
[891.821602] [130/132] (139s left) syncobj_wait (wait-any-snapshot)
[891.881715] Starting subtest: wait-any-snapshot
[891.961857] Subtest wait-any-snapshot: SUCCESS (0.081s)
[892.050580] [131/132] (138s left) kms_getfb (getfb-handle-zero)
[892.147800] Starting subtest: getfb-handle-zero
[892.150055] Subtest getfb-handle-zero: SUCCESS (0.000s)
[892.247495] [132/132] (138s left) kms_dsc (dsc-with-bpc-formats)
[892.340987] Starting subtest: dsc-with-bpc-formats
[892.451644] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[892.488921] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: prime_vgem
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_linear_blits
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_ctx_exec
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: gem_render_copy
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: gen9_exec_parse
results: parsing output: 12/ for test: prime_mmap
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: gem_workarounds
results: parsing output: 18/ for test: gem_mmap_wc
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_properties
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: prime_busy
results: parsing output: 23/ for test: kms_getfb
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_balancer
results: parsing output: 36/ for test: gem_exec_big
results: parsing output: 37/ for test: kms_chamelium_edid
results: parsing output: 38/ for test: kms_joiner
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: fbdev
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: i915_query
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: gem_exec_parallel
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_color_pipeline
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_watchdog
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_freq
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_pm_backlight
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_pipe_crc_basic
results: parsing output: 73/ for test: kms_content_protection
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_force_connector_basic
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: kms_invalid_mode
results: parsing output: 80/ for test: perf
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: dumb_buffer
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: vgem_basic
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: i915_pm_rc6_residency
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: api_intel_allocator
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: kms_cursor_edge_walk
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_readwrite
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_ctx_bad_destroy
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: i915_hangman
results: parsing output: 123/ for test: kms_plane_cursor
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_getfb
results: parsing output: 131/ for test: kms_dsc
Done.