[60.048391] Initializing watchdogs
[60.048445]   /dev/watchdog0
[60.063551] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.068080] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.070294] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.072500] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-max-size)
[60.381066] Starting subtest: cursor-offscreen-max-size
[60.383853] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[60.503774] [002/133] (960s left) kms_flip (dpms-vs-vblank-race)
[60.604425] Starting subtest: dpms-vs-vblank-race
[60.606470] Starting dynamic subtest: A-eDP1
[64.595716] Dynamic subtest A-eDP1: SUCCESS (3.985s)
[64.602755] Starting dynamic subtest: B-eDP1
[69.230838] Dynamic subtest B-eDP1: SUCCESS (4.632s)
[69.237354] Starting dynamic subtest: C-eDP1
[73.860459] Dynamic subtest C-eDP1: SUCCESS (4.626s)
[73.867409] Starting dynamic subtest: D-eDP1
[78.476353] Dynamic subtest D-eDP1: SUCCESS (4.616s)
[78.478380] Subtest dpms-vs-vblank-race: SUCCESS (17.865s)
[79.372504] [003/133] (941s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[79.471776] Starting subtest: yf-tiled-8bpp-rotate-0
[79.473864] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[79.548901] [004/133] (941s left) kms_flip (flip-vs-dpms-on-nop)
[79.640017] Starting subtest: flip-vs-dpms-on-nop
[79.640997] Starting dynamic subtest: A-eDP1
[81.564054] Dynamic subtest A-eDP1: SUCCESS (1.923s)
[81.573226] Starting dynamic subtest: B-eDP1
[83.394676] Dynamic subtest B-eDP1: SUCCESS (1.829s)
[83.403747] Starting dynamic subtest: C-eDP1
[85.228117] Dynamic subtest C-eDP1: SUCCESS (1.829s)
[85.240199] Starting dynamic subtest: D-eDP1
[87.045286] Dynamic subtest D-eDP1: SUCCESS (1.818s)
[87.048904] Subtest flip-vs-dpms-on-nop: SUCCESS (7.408s)
[88.224064] [005/133] (932s left) gem_exec_whisper (basic-queues-forked-all)
[88.289455] Starting subtest: basic-queues-forked-all
[106.246483] Subtest basic-queues-forked-all: SUCCESS (17.948s)
[106.415261] [006/133] (914s left) gem_exec_schedule (manyslice)
[106.472056] Starting subtest: manyslice
[106.472829] Starting dynamic subtest: rcs0
[112.665507] Dynamic subtest rcs0: SUCCESS (6.184s)
[112.673683] Starting dynamic subtest: bcs0
[119.343043] Dynamic subtest bcs0: SUCCESS (6.641s)
[119.351586] Starting dynamic subtest: vcs0
[124.920463] Dynamic subtest vcs0: SUCCESS (5.578s)
[124.927581] Starting dynamic subtest: vcs1
[130.499482] Dynamic subtest vcs1: SUCCESS (5.578s)
[130.506382] Starting dynamic subtest: vecs0
[136.073073] Dynamic subtest vecs0: SUCCESS (5.572s)
[136.083234] Starting dynamic subtest: ccs0
[142.764668] Dynamic subtest ccs0: SUCCESS (6.689s)
[142.766462] Subtest manyslice: SUCCESS (36.248s)
[143.036832] [007/133] (877s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[143.088868] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[143.205326] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[143.263529] [008/133] (877s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[143.365975] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[143.367085] Starting dynamic subtest: pipe-A
[143.715834] Dynamic subtest pipe-A: SUCCESS (0.350s)
[143.724292] Starting dynamic subtest: pipe-B
[145.131356] Dynamic subtest pipe-B: SUCCESS (1.414s)
[145.139490] Starting dynamic subtest: pipe-C
[146.578106] Dynamic subtest pipe-C: SUCCESS (1.446s)
[146.585952] Starting dynamic subtest: pipe-D
[148.011111] Dynamic subtest pipe-D: SUCCESS (1.432s)
[148.012223] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.646s)
[149.154677] [009/133] (871s left) kms_draw_crc (fill-fb)
[149.238393] Starting subtest: fill-fb
[149.713595] Subtest fill-fb: SUCCESS (0.476s)
[149.800246] [010/133] (871s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[149.891688] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[149.901802] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[149.989536] [011/133] (870s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[150.076981] Starting subtest: y-tiled-8bpp-rotate-0
[150.078922] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[150.172345] [012/133] (870s left) kms_flip (basic-flip-vs-wf_vblank)
[150.265642] Starting subtest: basic-flip-vs-wf_vblank
[150.266571] Starting dynamic subtest: A-eDP1
[152.209928] Dynamic subtest A-eDP1: SUCCESS (1.944s)
[152.219624] Starting dynamic subtest: B-eDP1
[154.140466] Dynamic subtest B-eDP1: SUCCESS (1.928s)
[154.149647] Starting dynamic subtest: C-eDP1
[156.069617] Dynamic subtest C-eDP1: SUCCESS (1.927s)
[156.078573] Starting dynamic subtest: D-eDP1
[157.993751] Dynamic subtest D-eDP1: SUCCESS (1.922s)
[157.996905] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.731s)
[159.219493] [013/133] (861s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[159.323795] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[159.326188] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[159.424915] [014/133] (861s left) gem_exec_parallel (contexts)
[159.472024] Starting subtest: contexts
[159.473075] Starting dynamic subtest: rcs0
[162.553214] Dynamic subtest rcs0: SUCCESS (3.071s)
[162.560211] Starting dynamic subtest: bcs0
[165.982638] Dynamic subtest bcs0: SUCCESS (3.428s)
[165.991799] Starting dynamic subtest: vcs0
[170.288233] Dynamic subtest vcs0: SUCCESS (4.304s)
[170.298800] Starting dynamic subtest: vcs1
[174.318866] Dynamic subtest vcs1: SUCCESS (4.028s)
[174.326163] Starting dynamic subtest: vecs0
[178.320265] Dynamic subtest vecs0: SUCCESS (4.000s)
[178.326724] Starting dynamic subtest: ccs0
[182.124830] Dynamic subtest ccs0: SUCCESS (3.803s)
[182.125751] Subtest contexts: SUCCESS (22.642s)
[182.300372] [015/133] (838s left) gem_ctx_persistence (legacy-engines-hang)
[182.353983] Starting subtest: legacy-engines-hang
[182.355045] Starting dynamic subtest: render
[182.443884] Dynamic subtest render: SUCCESS (0.089s)
[182.454681] Starting dynamic subtest: bsd1
[182.546953] Dynamic subtest bsd1: SUCCESS (0.101s)
[182.557603] Starting dynamic subtest: bsd2
[182.643266] Dynamic subtest bsd2: SUCCESS (0.095s)
[182.653373] Starting dynamic subtest: blt
[182.747523] Dynamic subtest blt: SUCCESS (0.102s)
[182.758996] Starting dynamic subtest: vebox
[182.843536] Dynamic subtest vebox: SUCCESS (0.094s)
[182.844737] Subtest legacy-engines-hang: SUCCESS (0.490s)
[182.931889] [016/133] (838s left) kms_psr2_su (page_flip-xrgb8888)
[182.986911] Subtest page_flip-XRGB8888: SKIP (0.000s)
[183.037618] [017/133] (838s left) gem_exec_schedule (semaphore-user)
[183.103808] Starting subtest: semaphore-user
[183.165272] Subtest semaphore-user: SUCCESS (0.061s)
[184.950755] [018/133] (836s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[185.322696] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[186.126775] [019/133] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[186.223548] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[186.225191] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[186.311511] [020/133] (834s left) kms_plane_scaling (planes-scaler-unity-scaling)
[186.397763] Starting subtest: planes-scaler-unity-scaling
[186.398613] Starting dynamic subtest: pipe-A
[186.464751] Dynamic subtest pipe-A: SUCCESS (0.067s)
[186.472877] Starting dynamic subtest: pipe-B
[187.586038] Dynamic subtest pipe-B: SUCCESS (1.121s)
[187.595381] Starting dynamic subtest: pipe-C
[188.691046] Dynamic subtest pipe-C: SUCCESS (1.104s)
[188.699832] Starting dynamic subtest: pipe-D
[189.835420] Dynamic subtest pipe-D: SUCCESS (1.144s)
[189.836374] Subtest planes-scaler-unity-scaling: SUCCESS (3.438s)
[190.975803] [021/133] (830s left) gem_ppgtt (blt-vs-render-ctxn)
[191.038846] Starting subtest: blt-vs-render-ctxN
[223.997369] Subtest blt-vs-render-ctxN: SUCCESS (32.946s)
[224.097945] [022/133] (797s left) api_intel_allocator (reloc-allocator)
[224.200512] Starting subtest: reloc-allocator
[224.201444] Starting dynamic subtest: basic
[224.204355] Dynamic subtest basic: SUCCESS (0.004s)
[224.214810] Starting dynamic subtest: parallel-one
[224.216052] Dynamic subtest parallel-one: SUCCESS (0.007s)
[224.223175] Starting dynamic subtest: print
[224.224209] Dynamic subtest print: SUCCESS (0.000s)
[224.231219] Starting dynamic subtest: reuse
[224.232167] Dynamic subtest reuse: SUCCESS (0.000s)
[224.239823] Starting dynamic subtest: fork-reopen-allocator
[224.240855] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[224.241717] Subtest reloc-allocator: SUCCESS (0.026s)
[224.359262] [023/133] (796s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[224.455720] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[228.528899] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.073s)
[229.703692] [024/133] (791s left) gem_fenced_exec_thrash (too-many-fences)
[229.755149] Subtest too-many-fences: SKIP (0.000s)
[229.814952] [025/133] (791s left) kms_color (invalid-gamma-lut-sizes)
[229.903348] Starting subtest: invalid-gamma-lut-sizes
[229.904358] Starting dynamic subtest: pipe-A
[230.190108] Dynamic subtest pipe-A: SUCCESS (0.287s)
[230.205895] Starting dynamic subtest: pipe-B
[230.206917] Dynamic subtest pipe-B: SUCCESS (0.000s)
[230.224517] Starting dynamic subtest: pipe-C
[230.225438] Dynamic subtest pipe-C: SUCCESS (0.000s)
[230.232142] Starting dynamic subtest: pipe-D
[230.232986] Dynamic subtest pipe-D: SUCCESS (0.000s)
[230.233886] Subtest invalid-gamma-lut-sizes: SUCCESS (0.290s)
[230.996096] [026/133] (790s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[231.047339] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[231.101504] [027/133] (790s left) gen7_exec_parse (basic-allocation)
[231.147964] Subtest basic-allocation: SKIP (0.000s)
[231.207607] [028/133] (790s left) kms_content_protection (dp-mst-lic-type-1)
[231.344481] Starting subtest: dp-mst-lic-type-1
[231.346400] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[231.468728] [029/133] (790s left) kms_pipe_crc_basic (suspend-read-crc)
[231.552366] Starting subtest: suspend-read-crc
[231.553294] Starting dynamic subtest: pipe-A-eDP-1
[249.818684] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.085s)
[249.826576] Starting dynamic subtest: pipe-B-eDP-1
[268.830992] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.470s)
[268.839279] Starting dynamic subtest: pipe-C-eDP-1
[287.800945] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.498s)
[287.811242] Starting dynamic subtest: pipe-D-eDP-1
[306.789296] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.441s)
[306.790221] Subtest suspend-read-crc: SUCCESS (13.500s)
[311.641506] [030/133] (713s left) gem_exec_balancer (nohangcheck)
[311.922727] Starting subtest: nohangcheck
[312.997396] Subtest nohangcheck: SUCCESS (1.063s)
[313.105215] [031/133] (712s left) prime_self_import (basic-with_one_bo_two_files)
[313.140066] Starting subtest: basic-with_one_bo_two_files
[313.154307] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[313.243914] [032/133] (712s left) gem_tiled_fence_blits (basic)
[313.290068] Subtest basic: SKIP (0.000s)
[313.343945] [033/133] (712s left) gem_userptr_blits (sync-unmap-after-close)
[313.402431] Starting subtest: sync-unmap-after-close
[313.419434] Subtest sync-unmap-after-close: SUCCESS (0.017s)
[313.558937] [034/133] (712s left) gem_exec_whisper (basic-queues)
[313.619060] Starting subtest: basic-queues
[320.270230] Subtest basic-queues: SUCCESS (6.613s)
[320.454370] [035/133] (705s left) gem_mmap_gtt (big-bo)
[320.507296] Subtest big-bo: SKIP (0.000s)
[320.583020] [036/133] (705s left) kms_flip (flip-vs-fences)
[320.668715] Starting subtest: flip-vs-fences
[320.670490] Subtest flip-vs-fences: SKIP (0.000s)
[320.771986] [037/133] (705s left) perf (i915-ref-count)
[320.862184] Starting subtest: i915-ref-count
[320.922645] Subtest i915-ref-count: SUCCESS (0.060s)
[320.973341] [038/133] (704s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[321.074165] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[321.077128] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[321.158197] [039/133] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[321.259158] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[328.344802] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.070s)
[328.485239] [040/133] (697s left) i915_module_load (resize-bar)
[328.518768] Starting subtest: resize-bar
[328.524218] Subtest resize-bar: SKIP (0.005s)
[328.560244] [041/133] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[328.646185] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[328.647907] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[328.737819] [042/133] (697s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[328.828774] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[328.829597] Starting dynamic subtest: pipe-A-default-mode
[331.565874] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[331.566709] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.734s)
[332.390101] [043/133] (693s left) kms_chamelium_frames (dp-frame-dump)
[332.777904] Subtest dp-frame-dump: SKIP (0.000s)
[333.606053] [044/133] (692s left) kms_vblank (ts-continuation-idle-hang)
[333.694833] Starting subtest: ts-continuation-idle-hang
[333.695709] Starting dynamic subtest: pipe-A-eDP-1
[360.439250] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.736s)
[360.449061] Starting dynamic subtest: pipe-D-eDP-1
[375.487980] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.043s)
[375.488876] Subtest ts-continuation-idle-hang: SUCCESS (41.784s)
[376.295540] [045/133] (649s left) gem_exec_balancer (parallel-ordering)
[376.556915] Starting subtest: parallel-ordering
[377.561214] Subtest parallel-ordering: SUCCESS (1.006s)
[377.675708] [046/133] (648s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[377.774151] Starting subtest: pipe-fbc-rte
[377.776917] Starting dynamic subtest: pipe-B-eDP-1
[383.273556] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.498s)
[383.279734] Subtest pipe-fbc-rte: SUCCESS (5.501s)
[385.510465] [047/133] (640s left) i915_pm_rps (min-max-config-idle)
[385.565083] Starting subtest: min-max-config-idle
[385.566675] Subtest min-max-config-idle: SKIP (0.000s)
[385.653287] [048/133] (640s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[385.743528] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[385.745031] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[386.845302] [049/133] (639s left) drm_read (short-buffer-wakeup)
[386.994468] Starting subtest: short-buffer-wakeup
[419.222765] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[419.372550] [050/133] (606s left) gem_exec_reloc (basic-cpu-gtt-active)
[419.440917] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[419.517409] [051/133] (606s left) kms_pm_rpm (modeset-lpsp-stress)
[421.737975] Starting subtest: modeset-lpsp-stress
[438.229966] Subtest modeset-lpsp-stress: SUCCESS (16.494s)
[438.334644] [052/133] (587s left) kms_sequence (get-busy)
[438.424554] Starting subtest: get-busy
[438.425537] Starting dynamic subtest: pipe-A-eDP-1
[440.350289] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.924s)
[440.358542] Starting dynamic subtest: pipe-B-eDP-1
[442.991349] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.639s)
[443.000979] Starting dynamic subtest: pipe-C-eDP-1
[445.587311] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.596s)
[445.595840] Starting dynamic subtest: pipe-D-eDP-1
[448.137192] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[448.137962] Subtest get-busy: SUCCESS (9.712s)
[448.930067] [053/133] (577s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[449.028864] Starting subtest: random-ccs-data-y-tiled-ccs
[449.029753] Starting dynamic subtest: pipe-A-eDP-1
[449.039010] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[449.053888] Starting dynamic subtest: pipe-B-eDP-1
[449.063386] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[449.071801] Starting dynamic subtest: pipe-C-eDP-1
[449.080625] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[449.088158] Starting dynamic subtest: pipe-D-eDP-1
[449.097275] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[449.098962] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[451.289865] [054/133] (575s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[451.384722] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[451.386667] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[451.480893] [055/133] (574s left) kms_flip (flip-vs-panning-interruptible)
[451.569994] Starting subtest: flip-vs-panning-interruptible
[451.572282] Starting dynamic subtest: A-eDP1
[460.314181] Dynamic subtest A-eDP1: SUCCESS (8.741s)
[460.324279] Starting dynamic subtest: B-eDP1
[469.064559] Dynamic subtest B-eDP1: SUCCESS (8.746s)
[469.075210] Starting dynamic subtest: C-eDP1
[477.775981] Dynamic subtest C-eDP1: SUCCESS (8.707s)
[477.787321] Starting dynamic subtest: D-eDP1
[486.515069] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[486.519739] Subtest flip-vs-panning-interruptible: SUCCESS (34.943s)
[487.679529] [056/133] (538s left) sysfs_heartbeat_interval (mixed)
[487.741307] Starting subtest: mixed
[487.742452] Starting dynamic subtest: vecs0
[492.996271] Dynamic subtest vecs0: SUCCESS (5.253s)
[493.007995] Starting dynamic subtest: ccs0
[498.162494] Dynamic subtest ccs0: SUCCESS (5.162s)
[498.173192] Starting dynamic subtest: vcs0
[503.363080] Dynamic subtest vcs0: SUCCESS (5.198s)
[503.373706] Starting dynamic subtest: bcs0
[508.545325] Dynamic subtest bcs0: SUCCESS (5.179s)
[508.555943] Starting dynamic subtest: rcs0
[513.749411] Dynamic subtest rcs0: SUCCESS (5.201s)
[513.761767] Starting dynamic subtest: vcs1
[518.995452] Dynamic subtest vcs1: SUCCESS (5.243s)
[518.998396] Subtest mixed: SUCCESS (31.247s)
[519.082581] [057/133] (507s left) kms_cursor_edge_walk (256x256-right-edge)
[519.170155] Starting subtest: 256x256-right-edge
[519.171029] Starting dynamic subtest: pipe-A-eDP-1
[522.652212] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s)
[522.660546] Starting dynamic subtest: pipe-D-eDP-1
[525.773323] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[525.774264] Subtest 256x256-right-edge: SUCCESS (6.602s)
[526.583114] [058/133] (499s left) fbdev (read)
[526.613708] Starting subtest: read
[527.160142] Subtest read: SUCCESS (0.536s)
[527.210106] [059/133] (499s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[527.272702] Starting subtest: etime-single-wait-for-submit-unsubmitted
[527.379111] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[527.452201] [060/133] (499s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[527.529002] Starting subtest: plane-all-modeset-transition-internal-panels
[527.529915] Starting dynamic subtest: pipe-A-eDP-1
[528.843124] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.303s)
[529.112548] Starting dynamic subtest: pipe-B-eDP-1
[530.172654] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.061s)
[530.431843] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.900s)
[531.270703] [061/133] (495s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[531.321621] Starting subtest: multi-wait-all-for-submit-available-submitted
[531.322590] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[531.406812] [062/133] (495s left) kms_psr (psr-sprite-mmap-cpu)
[531.512984] Starting subtest: psr-sprite-mmap-cpu
[531.513909] Starting dynamic subtest: eDP-1
[533.286605] Dynamic subtest eDP-1: SUCCESS (1.773s)
[533.287429] Subtest psr-sprite-mmap-cpu: SUCCESS (1.774s)
[534.120882] [063/133] (492s left) gem_exec_async (forked-writes)
[534.180032] Starting subtest: forked-writes
[534.181018] Starting dynamic subtest: rcs0
[534.206928] Dynamic subtest rcs0: SUCCESS (0.027s)
[534.226587] Starting dynamic subtest: bcs0
[534.231371] Dynamic subtest bcs0: SUCCESS (0.024s)
[534.240170] Starting dynamic subtest: vcs0
[534.254077] Dynamic subtest vcs0: SUCCESS (0.022s)
[534.262974] Starting dynamic subtest: vcs1
[534.281898] Dynamic subtest vcs1: SUCCESS (0.026s)
[534.294244] Starting dynamic subtest: vecs0
[534.307405] Dynamic subtest vecs0: SUCCESS (0.024s)
[534.316308] Starting dynamic subtest: ccs0
[534.341615] Dynamic subtest ccs0: SUCCESS (0.033s)
[534.342608] Subtest forked-writes: SUCCESS (0.162s)
[534.557609] [064/133] (492s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[534.654840] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[534.655671] Starting dynamic subtest: pipe-A-eDP-1
[534.675225] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[534.683869] Starting dynamic subtest: pipe-B-eDP-1
[534.706293] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[534.715563] Starting dynamic subtest: pipe-C-eDP-1
[534.735958] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[534.744368] Starting dynamic subtest: pipe-D-eDP-1
[534.766648] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[534.768373] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[536.908435] [065/133] (489s left) i915_drm_fdinfo (memory-info-active)
[536.945633] Starting subtest: memory-info-active
[536.946562] Starting dynamic subtest: smem0
[539.530812] Dynamic subtest smem0: SUCCESS (2.586s)
[539.532155] Subtest memory-info-active: SUCCESS (2.587s)
[539.601628] [066/133] (487s left) gem_pread (self)
[539.655998] Subtest self: SKIP (0.000s)
[539.712160] [067/133] (487s left) gem_pipe_control_store_loop (fresh-buffer)
[539.772681] Starting subtest: fresh-buffer
[541.972802] Subtest fresh-buffer: SUCCESS (2.154s)
[542.052133] [068/133] (484s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[542.164205] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[542.165910] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[542.259714] [069/133] (484s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[542.350257] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[542.352067] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[542.446386] [070/133] (484s left) gem_ctx_param (invalid-ctx-get)
[542.497839] Starting subtest: invalid-ctx-get
[542.498702] Subtest invalid-ctx-get: SUCCESS (0.000s)
[542.572674] [071/133] (484s left) gem_ctx_persistence (engines-cleanup)
[542.636637] Starting subtest: engines-cleanup
[542.637580] Starting dynamic subtest: rcs0
[542.717142] Dynamic subtest rcs0: SUCCESS (0.080s)
[542.729835] Starting dynamic subtest: bcs0
[542.757751] Dynamic subtest bcs0: SUCCESS (0.039s)
[542.767794] Starting dynamic subtest: vcs0
[542.794564] Dynamic subtest vcs0: SUCCESS (0.035s)
[542.804411] Starting dynamic subtest: vcs1
[542.833534] Dynamic subtest vcs1: SUCCESS (0.037s)
[542.843548] Starting dynamic subtest: vecs0
[542.868699] Dynamic subtest vecs0: SUCCESS (0.033s)
[542.879544] Starting dynamic subtest: ccs0
[542.908107] Dynamic subtest ccs0: SUCCESS (0.037s)
[542.909632] Subtest engines-cleanup: SUCCESS (0.272s)
[542.993384] [072/133] (483s left) gem_exec_params (readonly)
[543.049387] Starting subtest: readonly
[543.050919] Subtest readonly: SUCCESS (0.003s)
[543.164024] [073/133] (483s left) gem_spin_batch (spin-each)
[543.219955] Starting subtest: spin-each
[546.488473] Subtest spin-each: SUCCESS (3.263s)
[546.699472] [074/133] (480s left) gem_readwrite (beyond-eob)
[546.753380] Subtest beyond-EOB: SKIP (0.000s)
[546.805331] [075/133] (480s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[546.896183] Starting subtest: 4-tiled-8bpp-rotate-90
[546.917163] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[547.012926] [076/133] (480s left) gem_create (create-ext-placement-each)
[547.170263] Starting subtest: create-ext-placement-each
[547.171439] Subtest create-ext-placement-each: SUCCESS (0.000s)
[547.270503] [077/133] (479s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[547.367823] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[547.380191] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.012s)
[547.449119] [078/133] (479s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[547.537985] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[547.539673] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[547.627969] [079/133] (479s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[547.673135] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[547.673981] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[547.763143] [080/133] (479s left) gem_set_tiling_vs_gtt
[547.864308] [081/133] (479s left) kms_cursor_crc (cursor-random-32x32)
[548.001237] Starting subtest: cursor-random-32x32
[548.046547] Subtest cursor-random-32x32: SKIP (0.044s)
[548.316400] [082/133] (478s left) kms_pm_backlight (fade)
[548.401912] Starting subtest: fade
[548.451031] Starting dynamic subtest: eDP-1
[550.935554] Dynamic subtest eDP-1: SUCCESS (2.485s)
[550.936552] Subtest fade: SUCCESS (2.535s)
[551.733142] [083/133] (475s left) perf_pmu (semaphore-wait-idle)
[551.775039] Starting subtest: semaphore-wait-idle
[551.776001] Starting dynamic subtest: rcs0
[552.297164] Dynamic subtest rcs0: SUCCESS (0.512s)
[552.307917] Starting dynamic subtest: bcs0
[552.810188] Dynamic subtest bcs0: SUCCESS (0.510s)
[552.821001] Starting dynamic subtest: vcs0
[553.323176] Dynamic subtest vcs0: SUCCESS (0.510s)
[553.332122] Starting dynamic subtest: vcs1
[553.836866] Dynamic subtest vcs1: SUCCESS (0.510s)
[553.847759] Starting dynamic subtest: vecs0
[554.351183] Dynamic subtest vecs0: SUCCESS (0.512s)
[554.361763] Starting dynamic subtest: ccs0
[554.866913] Dynamic subtest ccs0: SUCCESS (0.512s)
[554.868078] Subtest semaphore-wait-idle: SUCCESS (3.085s)
[554.982653] [084/133] (472s left) kms_psr (fbc-psr2-cursor-blt)
[555.072772] Starting subtest: fbc-psr2-cursor-blt
[555.073602] Starting dynamic subtest: eDP-1
[555.075320] Dynamic subtest eDP-1: SKIP (0.000s)
[555.077018] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[555.139847] [085/133] (472s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[555.234360] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[561.837264] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.605s)
[561.933140] [086/133] (465s left) kms_async_flips (test-time-stamp)
[562.022930] Starting subtest: test-time-stamp
[562.409432] Starting dynamic subtest: pipe-A-eDP-1
[563.193080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s)
[563.585235] Starting dynamic subtest: pipe-B-eDP-1
[564.343020] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[564.708886] Starting dynamic subtest: pipe-C-eDP-1
[565.468533] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[565.843450] Starting dynamic subtest: pipe-D-eDP-1
[566.601045] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[566.602077] Subtest test-time-stamp: SUCCESS (4.579s)
[567.751859] [087/133] (459s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[567.862735] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[567.863566] Starting dynamic subtest: pipe-A-eDP-1
[578.565980] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.703s)
[578.574719] Starting dynamic subtest: pipe-B-eDP-1
[589.974417] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.407s)
[589.975312] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.113s)
[590.870453] [088/133] (436s left) gem_tiled_partial_pwrite_pread (reads)
[590.930001] Subtest reads: SKIP (0.000s)
[590.996688] [089/133] (436s left) gem_mmap_gtt (flink-race)
[591.053841] Subtest flink-race: SKIP (0.000s)
[591.111241] [090/133] (436s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[591.200574] Starting subtest: yf-tiled-16bpp-rotate-180
[591.202450] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[591.286563] [091/133] (436s left) kms_addfb_basic (unused-handle)
[591.339028] Starting subtest: unused-handle
[591.339923] Subtest unused-handle: SUCCESS (0.000s)
[591.485569] [092/133] (436s left) kms_fb_coherency (memset-crc)
[591.574818] Starting subtest: memset-crc
[591.575700] Starting dynamic subtest: mmap-offset-wc
[591.977984] Dynamic subtest mmap-offset-wc: SUCCESS (0.403s)
[592.270811] Starting dynamic subtest: mmap-offset-uc
[598.313107] Dynamic subtest mmap-offset-uc: SUCCESS (6.054s)
[598.607496] Subtest memset-crc: SUCCESS (7.032s)
[599.495058] [093/133] (428s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[599.584999] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[606.223004] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.639s)
[606.316289] [094/133] (421s left) gen7_exec_parse (bitmasks)
[606.371052] Subtest bitmasks: SKIP (0.000s)
[606.428424] [095/133] (421s left) kms_atomic_interruptible (universal-setplane-cursor)
[606.520733] Starting subtest: universal-setplane-cursor
[606.521564] Starting dynamic subtest: pipe-A-eDP-1
[613.948601] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.425s)
[613.949554] Subtest universal-setplane-cursor: SUCCESS (7.427s)
[614.789707] [096/133] (412s left) kms_psr (psr2-primary-mmap-gtt)
[614.868868] Starting subtest: psr2-primary-mmap-gtt
[614.869777] Starting dynamic subtest: eDP-1
[616.303196] Dynamic subtest eDP-1: SKIP (1.423s)
[616.305273] Subtest psr2-primary-mmap-gtt: SKIP (1.426s)
[616.445392] [097/133] (411s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[616.533834] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[616.535683] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[616.614302] [098/133] (411s left) kms_psr (fbc-psr-primary-mmap-cpu)
[616.693157] Starting subtest: fbc-psr-primary-mmap-cpu
[616.694073] Starting dynamic subtest: eDP-1
[616.695820] Dynamic subtest eDP-1: SKIP (0.000s)
[616.697553] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[616.759936] [099/133] (411s left) i915_pm_sseu (full-enable)
[616.809890] Subtest full-enable: SKIP (0.000s)
[616.895119] [100/133] (411s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[616.995656] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[616.997298] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[617.109676] [101/133] (410s left) perf_pmu (busy-accuracy-50)
[617.150141] Starting subtest: busy-accuracy-50
[617.151310] Starting dynamic subtest: rcs0
[618.690735] Dynamic subtest rcs0: SUCCESS (1.534s)
[618.701373] Starting dynamic subtest: bcs0
[620.235950] Dynamic subtest bcs0: SUCCESS (1.542s)
[620.246529] Starting dynamic subtest: vcs0
[621.779852] Dynamic subtest vcs0: SUCCESS (1.541s)
[621.790436] Starting dynamic subtest: vcs1
[623.321598] Dynamic subtest vcs1: SUCCESS (1.539s)
[623.332339] Starting dynamic subtest: vecs0
[624.862947] Dynamic subtest vecs0: SUCCESS (1.539s)
[624.873696] Starting dynamic subtest: ccs0
[626.411969] Dynamic subtest ccs0: SUCCESS (1.546s)
[626.412828] Subtest busy-accuracy-50: SUCCESS (9.256s)
[626.518324] [102/133] (401s left) gem_mmap_gtt (basic-read-write-distinct)
[626.571864] Subtest basic-read-write-distinct: SKIP (0.000s)
[626.625676] [103/133] (401s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[626.760362] Starting subtest: cursor-vs-flip-atomic-transitions
[656.825122] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.061s)
[657.664928] [104/133] (370s left) gem_exec_reloc (basic-write-wc)
[657.715226] Subtest basic-write-wc: SKIP (0.000s)
[657.770771] [105/133] (370s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[657.844429] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[657.846425] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[658.022715] [106/133] (370s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[658.124241] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[658.127795] Starting dynamic subtest: A-eDP1
[661.703030] Dynamic subtest A-eDP1: SUCCESS (3.575s)
[661.712776] Starting dynamic subtest: B-eDP1
[664.888113] Dynamic subtest B-eDP1: SUCCESS (3.182s)
[664.896797] Starting dynamic subtest: C-eDP1
[668.004886] Dynamic subtest C-eDP1: SUCCESS (3.114s)
[668.013990] Starting dynamic subtest: D-eDP1
[671.101943] Dynamic subtest D-eDP1: SUCCESS (3.096s)
[671.103968] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.978s)
[671.902231] [107/133] (356s left) kms_lease (page-flip-implicit-plane)
[671.997208] Starting subtest: page-flip-implicit-plane
[671.998065] Starting dynamic subtest: pipe-A-eDP-1
[672.476851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[672.486726] Starting dynamic subtest: pipe-B-eDP-1
[673.637147] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[673.646038] Starting dynamic subtest: pipe-C-eDP-1
[674.748535] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[674.757006] Starting dynamic subtest: pipe-D-eDP-1
[675.879236] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[675.880235] Subtest page-flip-implicit-plane: SUCCESS (3.881s)
[676.716327] [108/133] (351s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[676.776891] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[676.835216] [109/133] (351s left) gem_ctx_bad_destroy (invalid-ctx)
[676.885532] Starting subtest: invalid-ctx
[676.887299] Subtest invalid-ctx: SUCCESS (0.000s)
[676.964723] [110/133] (351s left) kms_plane_multiple (tiling-y)
[677.048467] Starting subtest: tiling-y
[677.050229] Subtest tiling-y: SKIP (0.000s)
[677.124255] [111/133] (351s left) gem_exec_params (invalid-ring)
[677.179999] Starting subtest: invalid-ring
[677.181146] Subtest invalid-ring: SUCCESS (0.000s)
[677.273051] [112/133] (351s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[677.362532] Starting subtest: plane-use-after-nonblocking-unbind
[677.363360] Starting dynamic subtest: pipe-A-eDP-1
[677.427037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[677.734416] Starting dynamic subtest: pipe-B-eDP-1
[678.524441] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.798s)
[678.821429] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.457s)
[679.680419] [113/133] (348s left) kms_async_flips (async-flip-suspend-resume)
[679.773122] Starting subtest: async-flip-suspend-resume
[680.161084] Starting dynamic subtest: pipe-A-eDP-1
[697.919579] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.345s)
[698.300061] Starting dynamic subtest: pipe-B-eDP-1
[716.923522] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.281s)
[717.306305] Starting dynamic subtest: pipe-C-eDP-1
[735.914293] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.280s)
[736.292443] Starting dynamic subtest: pipe-D-eDP-1
[754.932730] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.335s)
[754.934312] Subtest async-flip-suspend-resume: SUCCESS (14.752s)
[761.172110] [114/133] (272s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[761.275073] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[761.276892] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[761.357366] [115/133] (272s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[761.437556] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[761.438757] Starting dynamic subtest: pipe-A-eDP-1
[761.448945] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[761.459732] Starting dynamic subtest: pipe-B-eDP-1
[761.468612] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[761.477366] Starting dynamic subtest: pipe-C-eDP-1
[761.485159] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[761.493872] Starting dynamic subtest: pipe-D-eDP-1
[761.502350] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[761.503994] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[763.589170] [116/133] (269s left) kms_psr (pr-sprite-mmap-cpu)
[763.674174] Starting subtest: pr-sprite-mmap-cpu
[763.675807] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[763.745166] [117/133] (269s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[763.832298] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[763.834089] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[763.901080] [118/133] (269s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[763.998435] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[764.786174] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[764.954913] [119/133] (268s left) kms_cursor_legacy (single-move)
[765.068858] Starting subtest: single-move
[765.070132] Starting dynamic subtest: pipe-A
[770.526522] Dynamic subtest pipe-A: SUCCESS (5.379s)
[770.537568] Starting dynamic subtest: pipe-B
[775.922463] Dynamic subtest pipe-B: SUCCESS (5.379s)
[775.933601] Starting dynamic subtest: pipe-C
[781.273794] Dynamic subtest pipe-C: SUCCESS (5.378s)
[781.284762] Starting dynamic subtest: pipe-D
[786.695672] Dynamic subtest pipe-D: SUCCESS (5.378s)
[786.706782] Starting dynamic subtest: all-pipes
[792.086219] Dynamic subtest all-pipes: SUCCESS (5.385s)
[792.087413] Subtest single-move: SUCCESS (26.904s)
[792.180441] [120/133] (241s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[792.310068] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[792.313038] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[792.447856] [121/133] (241s left) kms_rotation_crc (cursor-rotation-180)
[792.553259] Starting subtest: cursor-rotation-180
[794.047707] Subtest cursor-rotation-180: SUCCESS (1.494s)
[795.241417] [122/133] (238s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[795.340555] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[795.342328] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[795.427707] [123/133] (238s left) gem_pxp (regular-baseline-src-copy-readible)
[795.543197] Starting subtest: regular-baseline-src-copy-readible
[795.606500] Subtest regular-baseline-src-copy-readible: SUCCESS (0.064s)
[795.708575] [124/133] (238s left) gem_ctx_param (set-priority-invalid-size)
[795.762829] Starting subtest: set-priority-invalid-size
[795.763819] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[795.831690] [125/133] (237s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[795.923076] Starting subtest: crc-primary-basic-yf-tiled-ccs
[795.923973] Starting dynamic subtest: pipe-A-eDP-1
[795.932367] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[795.941160] Starting dynamic subtest: pipe-B-eDP-1
[795.949323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[795.958059] Starting dynamic subtest: pipe-C-eDP-1
[795.966120] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[795.974429] Starting dynamic subtest: pipe-D-eDP-1
[795.982550] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[795.984119] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[798.198670] [126/133] (235s left) gem_exec_fence (nb-await)
[798.379527] Starting subtest: nb-await
[798.380611] Starting dynamic subtest: rcs0
[798.437540] Dynamic subtest rcs0: SUCCESS (0.065s)
[798.452002] Starting dynamic subtest: bcs0
[798.497104] Dynamic subtest bcs0: SUCCESS (0.057s)
[798.509835] Starting dynamic subtest: vcs0
[798.556730] Dynamic subtest vcs0: SUCCESS (0.057s)
[798.568703] Starting dynamic subtest: vcs1
[798.616678] Dynamic subtest vcs1: SUCCESS (0.058s)
[798.629403] Starting dynamic subtest: vecs0
[798.675968] Dynamic subtest vecs0: SUCCESS (0.057s)
[798.690093] Starting dynamic subtest: ccs0
[798.734508] Dynamic subtest ccs0: SUCCESS (0.056s)
[798.736637] Subtest nb-await: SUCCESS (0.364s)
[800.127428] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[800.129519] [127/133] (233s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[800.217352] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[800.219051] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[800.305275] [128/133] (233s left) perf_pmu (pmu-read)
[800.338960] Starting subtest: pmu-read
[800.341353] Subtest pmu-read: SUCCESS (0.003s)
[800.446821] [129/133] (233s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[800.539862] Starting subtest: x-tiled-32bpp-rotate-180
[801.953310] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.414s)
[802.070517] [130/133] (231s left) kms_fence_pin_leak
[802.232590] [131/133] (231s left) api_intel_bb (destroy-bb)
[802.286837] Starting subtest: destroy-bb
[802.294528] Subtest destroy-bb: SUCCESS (0.008s)
[802.403400] [132/133] (231s left) syncobj_timeline (wait-all-snapshot)
[802.457303] Starting subtest: wait-all-snapshot
[802.541214] Subtest wait-all-snapshot: SUCCESS (0.083s)
[802.615606] [133/133] (231s left) kms_invalid_mode (bad-vtotal)
[802.699486] Starting subtest: bad-vtotal
[802.700527] Starting dynamic subtest: pipe-A-eDP-1
[803.005724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.305s)
[803.016128] Starting dynamic subtest: pipe-B-eDP-1
[803.017046] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[803.025840] Starting dynamic subtest: pipe-C-eDP-1
[803.026680] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[803.034755] Starting dynamic subtest: pipe-D-eDP-1
[803.035648] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[803.036561] Subtest bad-vtotal: SUCCESS (0.322s)
[803.824641] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_exec_whisper
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_draw_crc
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_parallel
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_psr2_su
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: gem_ppgtt
results: parsing output: 21/ for test: api_intel_allocator
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_fenced_exec_thrash
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gen7_exec_parse
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: kms_pipe_crc_basic
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: prime_self_import
results: parsing output: 31/ for test: gem_tiled_fence_blits
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: i915_module_load
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_chamelium_frames
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_pm_rps
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: drm_read
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_sequence
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: sysfs_heartbeat_interval
results: parsing output: 56/ for test: kms_cursor_edge_walk
results: parsing output: 57/ for test: fbdev
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_atomic_transition
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_exec_async
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: gem_pread
results: parsing output: 66/ for test: gem_pipe_control_store_loop
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: gem_exec_params
results: parsing output: 72/ for test: gem_spin_batch
results: parsing output: 73/ for test: gem_readwrite
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_create
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_set_tiling_vs_gtt
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: kms_pm_backlight
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_fb_coherency
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gen7_exec_parse
results: parsing output: 94/ for test: kms_atomic_interruptible
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: i915_pm_sseu
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: kms_pipe_b_c_ivb
results: parsing output: 108/ for test: gem_ctx_bad_destroy
results: parsing output: 109/ for test: kms_plane_multiple
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_atomic_transition
results: parsing output: 112/ for test: kms_async_flips
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_rotation_crc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: gem_ctx_param
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_fence_pin_leak
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_invalid_mode
Done.