[60.477457] Initializing watchdogs
[60.477503]   /dev/watchdog0
[60.492193] [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.496534] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.498911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.502822] [001/134] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[60.636562] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[60.640744] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[60.774630] [002/134] (960s left) i915_pm_rps (fence-order)
[60.841860] Starting subtest: fence-order
[63.675320] Subtest fence-order: SUCCESS (2.831s)
[63.797705] [003/134] (957s left) kms_psr (psr-sprite-mmap-cpu)
[63.899709] Starting subtest: psr-sprite-mmap-cpu
[63.901979] Starting dynamic subtest: eDP-1
[65.640978] Dynamic subtest eDP-1: SUCCESS (1.741s)
[65.642981] Subtest psr-sprite-mmap-cpu: SUCCESS (1.742s)
[66.496572] [004/134] (954s left) api_intel_bb (blit-noreloc-purge-cache)
[66.558965] Starting subtest: blit-noreloc-purge-cache
[66.568572] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[66.730070] [005/134] (954s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[66.876568] Starting subtest: x-tiled-64bpp-rotate-270
[66.896764] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[67.356944] [006/134] (953s left) gem_ctx_shared (detached-shared-gtt)
[67.505832] Starting subtest: detached-shared-gtt
[69.657804] Subtest detached-shared-gtt: SUCCESS (2.151s)
[70.058291] [007/134] (951s left) perf (whitelisted-registers-userspace-config)
[70.211262] Starting subtest: whitelisted-registers-userspace-config
[70.213476] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[70.250828] [008/134] (951s left) kms_selftest (drm_damage_helper)
[70.286056] Starting subtest: drm_damage_helper
[70.297895] Starting dynamic subtest: drm_test_damage_iter_no_damage
[70.437244] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.138s)
[70.447616] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[70.552981] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.115s)
[70.560337] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[70.647807] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.096s)
[70.656026] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[70.806072] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.157s)
[70.813641] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[70.921232] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.114s)
[70.929751] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[71.053307] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.132s)
[71.061225] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[71.184432] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.132s)
[71.192213] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[71.320663] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.136s)
[71.328075] Starting dynamic subtest: drm_test_damage_iter_single_damage
[71.455798] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.135s)
[71.463305] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[71.589244] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.133s)
[71.597193] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[71.678267] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.089s)
[71.685824] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[71.808166] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.129s)
[71.816209] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[71.906173] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.099s)
[71.913607] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[72.012574] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.106s)
[72.019882] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[72.147574] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.135s)
[72.156974] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[72.277021] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.128s)
[72.284479] Starting dynamic subtest: drm_test_damage_iter_damage
[72.409320] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.132s)
[72.418183] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[72.549095] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.140s)
[72.556470] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[72.692224] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.142s)
[72.702045] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[72.823105] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.130s)
[72.830645] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[72.958281] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.135s)
[72.960583] Subtest drm_damage_helper: SUCCESS (2.672s)
[73.156836] [009/134] (948s left) gem_exec_flush (basic-wb-rw-default)
[73.226755] Starting subtest: basic-wb-rw-default
[78.687589] Subtest basic-wb-rw-default: SUCCESS (5.461s)
[78.902624] [010/134] (942s left) syncobj_timeline (invalid-transfer-illegal-handle)
[78.960873] Starting subtest: invalid-transfer-illegal-handle
[78.963224] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[79.088053] [011/134] (942s left) perf (oa-formats)
[79.189912] Starting subtest: oa-formats
[79.191999] Starting dynamic subtest: 0-rcs0
[79.203266] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[79.213555] Starting dynamic subtest: 1-vcs1
[79.224455] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[79.226764] Subtest oa-formats: SUCCESS (0.038s)
[79.272669] [012/134] (942s left) perf_pmu (rc6)
[79.314822] Starting subtest: rc6
[79.317118] Starting dynamic subtest: gt0
[85.695908] Dynamic subtest gt0: SUCCESS (6.380s)
[85.706641] Starting dynamic subtest: runtime-pm-gt0
[93.441309] Dynamic subtest runtime-pm-gt0: SUCCESS (7.745s)
[93.450764] Starting dynamic subtest: runtime-pm-long-gt0
[105.865197] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.423s)
[105.876373] Starting dynamic subtest: other-idle-gt0
[112.206738] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[112.216037] Starting dynamic subtest: gt1
[118.547853] Dynamic subtest gt1: SUCCESS (6.339s)
[118.559041] Starting dynamic subtest: runtime-pm-gt1
[126.008041] Dynamic subtest runtime-pm-gt1: SUCCESS (7.459s)
[126.018998] Starting dynamic subtest: runtime-pm-long-gt1
[138.440863] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.432s)
[138.452419] Starting dynamic subtest: other-idle-gt1
[144.783659] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[144.786492] Subtest rc6: SUCCESS (65.469s)
[145.926180] [013/134] (875s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[150.954094] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[150.956539] Starting dynamic subtest: pipe-A-eDP-1
[157.572308] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.616s)
[157.582426] Starting dynamic subtest: pipe-B-eDP-1
[164.239398] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.665s)
[164.241595] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.284s)
[165.087376] [014/134] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[165.204652] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[172.628946] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.429s)
[172.734915] [015/134] (848s left) gem_softpin (allocator-nopin-reserve)
[172.798628] Starting subtest: allocator-nopin-reserve
[172.897278] Subtest allocator-nopin-reserve: SUCCESS (0.098s)
[173.017934] [016/134] (848s left) gem_pxp (fail-invalid-protected-context)
[173.148717] Starting subtest: fail-invalid-protected-context
[173.151214] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[173.251735] [017/134] (848s left) fbdev (read)
[173.303115] Starting subtest: read
[173.832581] Subtest read: SUCCESS (0.527s)
[173.868993] [018/134] (847s left) gem_exec_params (rsvd2-dirt)
[173.937866] Starting subtest: rsvd2-dirt
[173.942088] Subtest rsvd2-dirt: SKIP (0.000s)
[174.018632] [019/134] (847s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[174.136078] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[174.140171] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[174.217260] [020/134] (847s left) gem_exec_fence (invalid-timeline-fence-array)
[174.780325] Starting subtest: invalid-timeline-fence-array
[174.785524] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[175.977841] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[175.980986] [021/134] (845s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[176.080090] Starting subtest: invalid-modeset-force-ultra-joiner
[176.084713] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[176.124258] [022/134] (845s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[176.236616] Starting subtest: fbcpsr-modesetfrombusy
[182.537342] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.305s)
[182.664232] [023/134] (839s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[182.765506] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[182.767368] Starting dynamic subtest: pipe-A-eDP-1
[182.786045] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[182.795952] Starting dynamic subtest: pipe-B-eDP-1
[182.813312] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[182.821380] Starting dynamic subtest: pipe-C-eDP-1
[182.838606] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[182.846815] Starting dynamic subtest: pipe-D-eDP-1
[182.864640] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[182.867945] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[184.972787] [024/134] (836s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[185.076363] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[189.119958] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.048s)
[190.276026] [025/134] (831s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[190.337171] Starting subtest: multi-wait-for-submit-submitted-signaled
[190.339789] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[190.437378] [026/134] (831s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[190.533161] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[190.535373] Starting dynamic subtest: pipe-A-eDP-1
[190.593317] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[190.601839] Starting dynamic subtest: pipe-B-eDP-1
[190.659600] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[190.669329] Starting dynamic subtest: pipe-C-eDP-1
[190.726837] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[190.736398] Starting dynamic subtest: pipe-D-eDP-1
[190.794463] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[190.798759] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[192.826720] [027/134] (829s left) kms_cursor_crc (cursor-random-64x21)
[193.028069] Starting subtest: cursor-random-64x21
[193.075848] Subtest cursor-random-64x21: SKIP (0.044s)
[193.296182] [028/134] (828s left) gem_pread (snoop)
[193.355399] Subtest snoop: SKIP (0.000s)
[193.432985] [029/134] (828s left) drm_read (short-buffer-block)
[193.599823] Starting subtest: short-buffer-block
[193.602189] Subtest short-buffer-block: SUCCESS (0.000s)
[193.724792] [030/134] (828s left) i915_hangman (engine-engine-error)
[193.797090] Starting subtest: engine-engine-error
[193.798953] Starting dynamic subtest: rcs0
[194.868524] Dynamic subtest rcs0: SUCCESS (1.069s)
[194.879718] Starting dynamic subtest: bcs0
[196.852405] Dynamic subtest bcs0: SUCCESS (1.981s)
[196.863778] Starting dynamic subtest: vcs0
[198.834820] Dynamic subtest vcs0: SUCCESS (1.981s)
[198.846846] Starting dynamic subtest: vcs1
[200.883030] Dynamic subtest vcs1: SUCCESS (2.047s)
[200.894915] Starting dynamic subtest: vecs0
[202.868103] Dynamic subtest vecs0: SUCCESS (1.983s)
[202.880111] Starting dynamic subtest: ccs0
[204.852460] Dynamic subtest ccs0: SUCCESS (1.982s)
[204.855423] Subtest engine-engine-error: SUCCESS (11.055s)
[204.911284] [031/134] (817s left) kms_prime (basic-crc-vgem)
[205.007190] Starting subtest: basic-crc-vgem
[205.009985] Starting dynamic subtest: second-to-first
[206.030730] Dynamic subtest second-to-first: SUCCESS (1.028s)
[206.032757] Subtest basic-crc-vgem: SUCCESS (1.029s)
[206.079025] [032/134] (816s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[206.231343] Starting subtest: plane-downscale-factor-0-5-with-rotation
[206.233292] Starting dynamic subtest: pipe-A
[206.250397] Dynamic subtest pipe-A: SKIP (0.017s)
[206.259580] Starting dynamic subtest: pipe-B
[206.280796] Dynamic subtest pipe-B: SKIP (0.030s)
[206.289230] Starting dynamic subtest: pipe-C
[206.310706] Dynamic subtest pipe-C: SKIP (0.030s)
[206.318878] Starting dynamic subtest: pipe-D
[206.341815] Dynamic subtest pipe-D: SKIP (0.030s)
[206.345442] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.108s)
[206.451786] [033/134] (815s left) kms_content_protection (srm)
[206.592084] Starting subtest: srm
[206.598556] Subtest srm: SKIP (0.002s)
[206.699904] [034/134] (815s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[206.807649] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[207.909404] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.505s)
[207.949479] [035/134] (814s left) kms_psr (pr-sprite-plane-onoff)
[208.052983] Starting subtest: pr-sprite-plane-onoff
[208.057118] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[208.102140] [036/134] (814s left) tools_test (sysfs_l3_parity)
[208.144669] Starting subtest: sysfs_l3_parity
[208.227139] Subtest sysfs_l3_parity: SKIP (0.092s)
[208.265554] [037/134] (814s left) kms_plane_cursor (primary)
[208.357595] Starting subtest: primary
[208.361333] Starting dynamic subtest: pipe-A-eDP-1-size-64
[210.931168] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.574s)
[210.955189] Starting dynamic subtest: pipe-A-eDP-1-size-128
[213.554501] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.605s)
[213.583520] Starting dynamic subtest: pipe-A-eDP-1-size-256
[216.166524] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.593s)
[216.480607] Starting dynamic subtest: pipe-B-eDP-1-size-64
[219.704183] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.233s)
[219.728902] Starting dynamic subtest: pipe-B-eDP-1-size-128
[222.305185] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.582s)
[222.329076] Starting dynamic subtest: pipe-B-eDP-1-size-256
[224.873043] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[225.187709] Starting dynamic subtest: pipe-C-eDP-1-size-64
[228.145179] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.969s)
[228.172400] Starting dynamic subtest: pipe-C-eDP-1-size-128
[230.356360] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[230.383679] Starting dynamic subtest: pipe-C-eDP-1-size-256
[232.590338] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.213s)
[232.908791] Starting dynamic subtest: pipe-D-eDP-1-size-64
[235.844447] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.947s)
[235.870385] Starting dynamic subtest: pipe-D-eDP-1-size-128
[238.055347] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[238.082618] Starting dynamic subtest: pipe-D-eDP-1-size-256
[240.267798] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[240.581852] Subtest primary: SUCCESS (32.224s)
[241.372104] [038/134] (781s left) syncobj_timeline (signal)
[241.442301] Starting subtest: signal
[241.444242] Subtest signal: SUCCESS (0.001s)
[241.543024] [039/134] (780s left) gem_ctx_isolation (preservation-reset)
[241.738930] Starting subtest: preservation-reset
[241.741142] Starting dynamic subtest: rcs0
[242.022430] Dynamic subtest rcs0: SUCCESS (0.287s)
[242.034943] Starting dynamic subtest: bcs0
[242.395414] Dynamic subtest bcs0: SUCCESS (0.371s)
[242.407212] Starting dynamic subtest: vcs0
[242.729223] Dynamic subtest vcs0: SUCCESS (0.334s)
[242.740641] Starting dynamic subtest: vcs1
[244.259812] Dynamic subtest vcs1: SUCCESS (1.530s)
[244.270899] Starting dynamic subtest: vecs0
[246.245474] Dynamic subtest vecs0: SUCCESS (1.985s)
[246.257115] Starting dynamic subtest: ccs0
[248.226895] Dynamic subtest ccs0: SUCCESS (1.980s)
[248.229517] Subtest preservation-reset: SUCCESS (6.494s)
[248.363169] [040/134] (774s left) kms_cursor_crc (cursor-offscreen-512x512)
[248.639030] Starting subtest: cursor-offscreen-512x512
[248.643571] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[248.803482] [041/134] (773s left) syncobj_wait (wait-all-interrupted)
[248.862704] Starting subtest: wait-all-interrupted
[248.964332] Subtest wait-all-interrupted: SUCCESS (0.102s)
[249.023980] [042/134] (773s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[249.132505] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[249.136598] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[249.207206] [043/134] (773s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[249.274948] Starting subtest: invalid-multi-wait-unsubmitted
[249.277286] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[249.378373] [044/134] (773s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[249.491069] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[254.064117] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.578s)
[255.169290] [045/134] (767s left) kms_getfb (getfb2-accept-nv12)
[255.265933] Starting subtest: getfb2-accept-nv12
[255.268189] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[255.357562] [046/134] (767s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[255.455474] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[259.047665] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.595s)
[260.160515] [047/134] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[260.267480] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[260.271580] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[260.371930] [048/134] (762s left) i915_drm_fdinfo (isolation)
[260.412125] Starting subtest: isolation
[260.414102] Starting dynamic subtest: rcs0
[260.440145] Dynamic subtest rcs0: SKIP (0.028s)
[260.451453] Starting dynamic subtest: bcs0
[260.455438] Dynamic subtest bcs0: SKIP (0.000s)
[260.464198] Starting dynamic subtest: vcs0
[260.468239] Dynamic subtest vcs0: SKIP (0.000s)
[260.476655] Starting dynamic subtest: vcs1
[260.480851] Dynamic subtest vcs1: SKIP (0.000s)
[260.489585] Starting dynamic subtest: vecs0
[260.494054] Dynamic subtest vecs0: SKIP (0.000s)
[260.503342] Starting dynamic subtest: ccs0
[260.507749] Dynamic subtest ccs0: SKIP (0.000s)
[260.512180] Subtest isolation: SKIP (0.034s)
[260.548576] [049/134] (762s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[260.610037] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[260.692952] [050/134] (762s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[260.795736] Starting subtest: 4-tiled-addfb-size-offset-overflow
[260.797753] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[260.875249] [051/134] (762s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[260.969419] Starting subtest: disable-crc-after-crtc
[260.971742] Starting dynamic subtest: pipe-A-eDP-1
[262.616226] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.647s)
[262.629548] Starting dynamic subtest: pipe-B-eDP-1
[264.878700] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.259s)
[264.887846] Starting dynamic subtest: pipe-C-eDP-1
[267.161151] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.281s)
[267.170534] Starting dynamic subtest: pipe-D-eDP-1
[269.417683] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.256s)
[269.419977] Subtest disable-crc-after-crtc: SUCCESS (8.449s)
[270.223120] [052/134] (752s left) perf_pmu (busy-hang)
[270.267896] Starting subtest: busy-hang
[270.270375] Starting dynamic subtest: rcs0
[271.568749] Dynamic subtest rcs0: SUCCESS (1.298s)
[271.578698] Starting dynamic subtest: bcs0
[272.831078] Dynamic subtest bcs0: SUCCESS (1.263s)
[272.842208] Starting dynamic subtest: vcs0
[275.425126] Dynamic subtest vcs0: SUCCESS (2.589s)
[275.434650] Starting dynamic subtest: vcs1
[277.398144] Dynamic subtest vcs1: SUCCESS (1.974s)
[277.409179] Starting dynamic subtest: vecs0
[279.445342] Dynamic subtest vecs0: SUCCESS (2.043s)
[279.454723] Starting dynamic subtest: ccs0
[280.701789] Dynamic subtest ccs0: SUCCESS (1.254s)
[280.704151] Subtest busy-hang: SUCCESS (10.432s)
[280.789452] [053/134] (742s left) gem_mmap_gtt (basic-short)
[280.849635] Subtest basic-short: SKIP (0.000s)
[280.929268] [054/134] (742s left) gem_exec_whisper (basic-contexts-forked-all)
[281.004080] Starting subtest: basic-contexts-forked-all
[303.854034] Subtest basic-contexts-forked-all: SUCCESS (22.844s)
[304.029506] [055/134] (719s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[304.422785] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[305.242313] [056/134] (718s left) kms_flip (2x-plain-flip-ts-check)
[305.338057] Starting subtest: 2x-plain-flip-ts-check
[305.346752] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[305.437065] [057/134] (717s left) gem_exec_balancer (busy)
[305.494639] Starting subtest: busy
[306.922929] Subtest busy: SUCCESS (1.430s)
[307.223517] [058/134] (716s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[307.314042] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[307.316291] Starting dynamic subtest: pipe-A-default-mode
[307.607494] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[307.612325] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.289s)
[308.374369] [059/134] (715s left) gem_exec_capture (capture-invisible)
[308.443854] Starting subtest: capture-invisible
[308.445856] Starting dynamic subtest: smem0
[308.450088] Dynamic subtest smem0: SKIP (0.000s)
[308.454297] Subtest capture-invisible: SKIP (0.001s)
[308.536550] [060/134] (714s left) kms_vblank (wait-idle)
[308.638175] Starting subtest: wait-idle
[308.640280] Starting dynamic subtest: pipe-A-eDP-1
[310.403974] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s)
[310.418599] Starting dynamic subtest: pipe-D-eDP-1
[312.846998] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.443s)
[312.849459] Subtest wait-idle: SUCCESS (4.211s)
[313.652147] [061/134] (709s left) gem_exec_reloc (basic-range-active)
[313.723204] Subtest basic-range-active: SKIP (0.000s)
[313.817312] [062/134] (709s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[313.906810] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[320.962513] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.058s)
[321.055122] [063/134] (702s left) kms_pm_rpm (fences)
[323.086745] Starting subtest: fences
[323.091547] Subtest fences: SKIP (0.000s)
[323.443238] [064/134] (700s left) perf (short-reads)
[323.497900] Starting subtest: short-reads
[323.510656] Subtest short-reads: SUCCESS (0.013s)
[323.561905] [065/134] (700s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-cpu)
[323.664263] Starting subtest: psr-abgr161616f-draw-mmap-cpu
[323.668430] Subtest psr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[323.752176] [066/134] (699s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[323.846466] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[323.850453] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[323.926775] [067/134] (699s left) kms_psr (fbc-psr-sprite-render)
[324.022237] Starting subtest: fbc-psr-sprite-render
[324.024488] Starting dynamic subtest: eDP-1
[324.028658] Dynamic subtest eDP-1: SKIP (0.000s)
[324.032670] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[324.095652] [068/134] (699s left) kms_pm_dc (dc5-dpms-negative)
[325.189046] Starting subtest: dc5-dpms-negative
[325.193290] Subtest dc5-dpms-negative: SKIP (0.000s)
[325.239053] [069/134] (698s left) syncobj_timeline (wait-zero-handles)
[325.299465] Starting subtest: wait-zero-handles
[325.301319] Subtest wait-zero-handles: SUCCESS (0.000s)
[325.386435] [070/134] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[325.477326] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[325.481526] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[325.566602] [071/134] (698s left) kms_vblank (wait-forked)
[325.661847] Starting subtest: wait-forked
[325.663975] Starting dynamic subtest: pipe-A-eDP-1
[327.457936] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.796s)
[327.472954] Starting dynamic subtest: pipe-D-eDP-1
[329.940840] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.480s)
[329.943243] Subtest wait-forked: SUCCESS (4.280s)
[330.794380] [072/134] (693s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[330.855458] Starting subtest: single-wait-all-for-submit-unsubmitted
[330.961243] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[331.015835] [073/134] (692s left) vgem_basic (bad-fence)
[331.055297] Starting subtest: bad-fence
[331.057540] Subtest bad-fence: SUCCESS (0.000s)
[331.094989] [074/134] (692s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[331.200313] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[331.204180] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[331.274156] [075/134] (692s left) kms_flip (bo-too-big-interruptible)
[331.369843] Starting subtest: bo-too-big-interruptible
[331.372137] Starting dynamic subtest: A-eDP1
[332.663768] Dynamic subtest A-eDP1: SUCCESS (1.292s)
[332.672823] Starting dynamic subtest: B-eDP1
[333.901347] Dynamic subtest B-eDP1: SUCCESS (1.236s)
[333.910840] Starting dynamic subtest: C-eDP1
[335.147599] Dynamic subtest C-eDP1: SUCCESS (1.245s)
[335.158081] Starting dynamic subtest: D-eDP1
[336.404067] Dynamic subtest D-eDP1: SUCCESS (1.256s)
[336.406366] Subtest bo-too-big-interruptible: SUCCESS (5.036s)
[337.596820] [076/134] (686s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[337.708322] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[337.710668] Starting dynamic subtest: pipe-A-default-mode
[340.448758] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[340.451218] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.742s)
[341.289456] [077/134] (682s left) gem_exec_schedule (implicit-write-read)
[341.376699] Starting subtest: implicit-write-read
[341.378709] Starting dynamic subtest: rcs0
[341.476894] Dynamic subtest rcs0: SUCCESS (0.109s)
[341.487686] Starting dynamic subtest: vcs0
[341.560506] Dynamic subtest vcs0: SUCCESS (0.083s)
[341.570850] Starting dynamic subtest: vcs1
[341.643057] Dynamic subtest vcs1: SUCCESS (0.082s)
[341.654198] Starting dynamic subtest: vecs0
[341.721565] Dynamic subtest vecs0: SUCCESS (0.078s)
[341.732616] Starting dynamic subtest: ccs0
[341.812423] Dynamic subtest ccs0: SUCCESS (0.090s)
[341.814973] Subtest implicit-write-read: SUCCESS (0.446s)
[343.026524] [078/134] (681s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[343.124390] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[343.128858] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[343.198163] [079/134] (681s left) kms_psr (fbc-psr-dpms)
[343.302118] Starting subtest: fbc-psr-dpms
[343.304306] Starting dynamic subtest: eDP-1
[343.308440] Dynamic subtest eDP-1: SKIP (0.000s)
[343.312538] Subtest fbc-psr-dpms: SKIP (0.001s)
[343.351413] [080/134] (680s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[343.448424] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[343.452943] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[343.549666] [081/134] (680s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[343.618696] Starting subtest: etime-single-wait-for-submit-submitted
[343.729713] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.110s)
[343.784939] [082/134] (680s left) gem_mmap (bad-offset)
[343.852295] Subtest bad-offset: SKIP (0.000s)
[343.924609] [083/134] (680s left) syncobj_basic (illegal-fd-to-handle)
[343.989756] Starting subtest: illegal-fd-to-handle
[343.991701] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[344.083423] [084/134] (680s left) kms_cursor_legacy (torture-move)
[344.204407] Starting subtest: torture-move
[344.206320] Starting dynamic subtest: pipe-A
[349.912731] Dynamic subtest pipe-A: SUCCESS (5.705s)
[349.925773] Starting dynamic subtest: pipe-B
[355.719079] Dynamic subtest pipe-B: SUCCESS (5.803s)
[355.729532] Starting dynamic subtest: pipe-C
[361.523939] Dynamic subtest pipe-C: SUCCESS (5.802s)
[361.536038] Starting dynamic subtest: pipe-D
[367.121842] Dynamic subtest pipe-D: SUCCESS (5.598s)
[367.136788] Starting dynamic subtest: all-pipes
[372.707134] Dynamic subtest all-pipes: SUCCESS (5.583s)
[372.709622] Subtest torture-move: SUCCESS (28.502s)
[372.854223] [085/134] (651s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[372.971311] Starting subtest: fbc-psr2-cursor-plane-onoff
[372.973624] Starting dynamic subtest: eDP-1
[372.977971] Dynamic subtest eDP-1: SKIP (0.000s)
[372.982307] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[373.019211] [086/134] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[373.125329] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[373.129673] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[373.257952] [087/134] (651s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[373.364273] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[373.366410] Starting dynamic subtest: pipe-A-eDP-1
[374.104224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[374.114793] Starting dynamic subtest: pipe-B-eDP-1
[375.943065] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.837s)
[375.953747] Starting dynamic subtest: pipe-C-eDP-1
[377.765661] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.822s)
[377.776680] Starting dynamic subtest: pipe-D-eDP-1
[379.601601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.834s)
[379.603603] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.231s)
[380.719821] [088/134] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[380.825600] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[380.830197] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[380.914609] [089/134] (643s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[381.003949] Starting subtest: modeset-transition-nonblocking-fencing
[381.005843] Starting dynamic subtest: 1x-outputs
[391.822721] Dynamic subtest 1x-outputs: SUCCESS (10.819s)
[391.825256] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.821s)
[392.655633] [090/134] (632s left) kms_color (ctm-0-25)
[392.754595] Starting subtest: ctm-0-25
[392.756793] Starting dynamic subtest: pipe-A-eDP-1
[396.265720] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.513s)
[396.276181] Starting dynamic subtest: pipe-B-eDP-1
[400.563021] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.294s)
[400.573218] Starting dynamic subtest: pipe-C-eDP-1
[404.622408] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.058s)
[404.633229] Starting dynamic subtest: pipe-D-eDP-1
[408.597927] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.975s)
[408.600316] Subtest ctm-0-25: SUCCESS (15.844s)
[409.403481] [091/134] (615s left) gem_exec_params (batch-first)
[409.475673] Starting subtest: batch-first
[409.480809] Subtest batch-first: SUCCESS (0.005s)
[409.606470] [092/134] (615s left) gem_ppgtt (flink-and-close-vma-leak)
[409.673463] Starting subtest: flink-and-close-vma-leak
[409.715833] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[409.814110] [093/134] (615s left) core_getclient (basic)
[409.860088] Starting subtest: basic
[409.862331] Subtest basic: SUCCESS (0.000s)
[409.952382] [094/134] (614s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[410.077672] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[410.082267] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[410.199247] [095/134] (614s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[410.296061] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[410.298220] Starting dynamic subtest: pipe-A-eDP-1
[410.320274] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.331540] Starting dynamic subtest: pipe-B-eDP-1
[410.352186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.361160] Starting dynamic subtest: pipe-C-eDP-1
[410.378510] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[410.387148] Starting dynamic subtest: pipe-D-eDP-1
[410.404929] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[410.408266] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[412.559855] [096/134] (612s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[412.669693] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[419.690185] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.023s)
[419.781865] [097/134] (605s left) kms_draw_crc (draw-method-mmap-cpu)
[419.888998] Starting subtest: draw-method-mmap-cpu
[419.891285] Starting dynamic subtest: xrgb8888-untiled
[420.133227] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[420.142653] Starting dynamic subtest: rgb565-untiled
[420.355416] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[420.367040] Starting dynamic subtest: xrgb2101010-untiled
[420.577567] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[420.587057] Starting dynamic subtest: xbgr16161616f-untiled
[420.810575] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[420.819624] Starting dynamic subtest: xrgb8888-xtiled
[420.943756] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[420.956544] Starting dynamic subtest: rgb565-xtiled
[421.066418] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[421.075969] Starting dynamic subtest: xrgb2101010-xtiled
[421.188637] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[421.200343] Starting dynamic subtest: xbgr16161616f-xtiled
[421.322694] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[421.331708] Starting dynamic subtest: xrgb8888-4tiled
[421.477298] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s)
[421.488825] Starting dynamic subtest: rgb565-4tiled
[421.621829] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[421.630821] Starting dynamic subtest: xrgb2101010-4tiled
[421.766344] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[421.777960] Starting dynamic subtest: xbgr16161616f-4tiled
[421.921767] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.153s)
[421.923724] Subtest draw-method-mmap-cpu: SUCCESS (2.034s)
[422.013694] [098/134] (603s left) prime_mmap (test_refcounting)
[422.085273] Starting subtest: test_refcounting
[422.087316] Starting dynamic subtest: test_refcounting-smem
[422.118999] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[422.121150] Subtest test_refcounting: SUCCESS (0.035s)
[422.213645] [099/134] (602s left) gem_mmap_wc (copy)
[422.266154] Subtest copy: SKIP (0.000s)
[422.340627] [100/134] (602s left) gem_exec_schedule (fairslice-all)
[422.413041] Starting subtest: fairslice-all
[424.466787] Subtest fairslice-all: SUCCESS (2.058s)
[424.739938] [101/134] (600s left) gem_ctx_persistence (engines-queued)
[424.802673] Starting subtest: engines-queued
[424.805171] Starting dynamic subtest: rcs0
[424.923372] Dynamic subtest rcs0: SUCCESS (0.119s)
[424.935714] Starting dynamic subtest: bcs0
[424.963449] Dynamic subtest bcs0: SUCCESS (0.039s)
[424.973185] Starting dynamic subtest: vcs0
[426.867819] Dynamic subtest vcs0: SUCCESS (1.902s)
[426.880390] Starting dynamic subtest: vcs1
[428.852381] Dynamic subtest vcs1: SUCCESS (1.981s)
[428.864937] Starting dynamic subtest: vecs0
[430.898075] Dynamic subtest vecs0: SUCCESS (2.043s)
[430.908970] Starting dynamic subtest: ccs0
[431.080851] Dynamic subtest ccs0: SUCCESS (0.182s)
[431.083279] Subtest engines-queued: SUCCESS (6.278s)
[431.207429] [102/134] (593s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[431.306073] Starting subtest: plane-all-modeset-transition-fencing
[431.310279] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[431.353615] [103/134] (593s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[431.469763] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[431.473896] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[431.574014] [104/134] (593s left) kms_3d (basic)
[431.636548] Starting subtest: basic
[433.598781] Subtest basic: SUCCESS (1.963s)
[434.083361] [105/134] (591s left) perf_pmu (semaphore-busy)
[434.127889] Starting subtest: semaphore-busy
[434.130076] Starting dynamic subtest: rcs0
[435.771259] Dynamic subtest rcs0: SUCCESS (1.638s)
[435.781265] Starting dynamic subtest: bcs0
[437.400472] Dynamic subtest bcs0: SUCCESS (1.627s)
[437.411513] Starting dynamic subtest: vcs0
[441.424065] Dynamic subtest vcs0: SUCCESS (4.021s)
[441.435695] Starting dynamic subtest: vcs1
[447.439583] Dynamic subtest vcs1: SUCCESS (6.012s)
[447.451677] Starting dynamic subtest: vecs0
[453.391728] Dynamic subtest vecs0: SUCCESS (5.949s)
[453.403835] Starting dynamic subtest: ccs0
[456.528780] Dynamic subtest ccs0: SUCCESS (3.134s)
[456.531387] Subtest semaphore-busy: SUCCESS (22.398s)
[456.621570] [106/134] (568s left) gem_mmap_gtt (hang)
[456.689830] Subtest hang: SKIP (0.000s)
[456.771750] [107/134] (568s left) core_getstats (basic)
[456.828531] Starting subtest: basic
[456.830899] Subtest basic: SUCCESS (0.000s)
[456.932829] [108/134] (568s left) gem_mmap_gtt (zero-extend)
[456.987298] Subtest zero-extend: SKIP (0.000s)
[457.052782] [109/134] (568s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[457.205803] Starting subtest: cursor-vs-flip-legacy
[486.534286] Subtest cursor-vs-flip-legacy: SUCCESS (29.324s)
[487.336482] [110/134] (538s left) gem_fenced_exec_thrash (no-spare-fences)
[487.393422] Subtest no-spare-fences: SKIP (0.000s)
[487.475781] [111/134] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[487.572961] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[487.577456] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[487.665295] [112/134] (537s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[487.726822] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[487.731092] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[487.887504] [113/134] (537s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[487.984745] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[487.988822] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[488.067084] [114/134] (537s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[488.173303] Starting subtest: y-tiled-64bpp-rotate-270
[488.177605] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[488.254622] [115/134] (537s left) syncobj_timeline (multi-wait-all-signaled)
[488.311051] Starting subtest: multi-wait-all-signaled
[488.313243] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[488.406103] [116/134] (537s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[493.438818] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[493.443318] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[494.242047] [117/134] (531s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[494.346213] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[494.350469] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[495.428447] [118/134] (530s left) gem_partial_pwrite_pread (write)
[495.487660] Subtest write: SKIP (0.000s)
[495.565825] [119/134] (530s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[495.619918] Subtest writes-after-reads: SKIP (0.000s)
[495.696587] [120/134] (530s left) gem_lmem_swapping (heavy-random)
[495.736241] Subtest heavy-random: SKIP (0.000s)
[495.774046] [121/134] (530s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[495.884623] Starting subtest: cursorB-vs-flipA-legacy
[495.889244] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[496.010144] [122/134] (530s left) syncobj_eventfd (invalid-bad-pad)
[496.069817] Starting subtest: invalid-bad-pad
[496.071813] Subtest invalid-bad-pad: SUCCESS (0.000s)
[496.139065] [123/134] (529s left) gem_wait (write-wait)
[496.196833] Starting subtest: write-wait
[496.199577] Starting dynamic subtest: all-engines
[497.322292] Dynamic subtest all-engines: SUCCESS (1.125s)
[497.339198] Starting dynamic subtest: rcs0
[498.383821] Dynamic subtest rcs0: SUCCESS (1.060s)
[498.402342] Starting dynamic subtest: bcs0
[499.444064] Dynamic subtest bcs0: SUCCESS (1.058s)
[499.461451] Starting dynamic subtest: vcs0
[500.498343] Dynamic subtest vcs0: SUCCESS (1.052s)
[500.516453] Starting dynamic subtest: vcs1
[501.556322] Dynamic subtest vcs1: SUCCESS (1.056s)
[501.573909] Starting dynamic subtest: vecs0
[502.612151] Dynamic subtest vecs0: SUCCESS (1.053s)
[502.632704] Starting dynamic subtest: ccs0
[503.668920] Dynamic subtest ccs0: SUCCESS (1.055s)
[503.671400] Subtest write-wait: SUCCESS (7.474s)
[503.847423] [124/134] (522s left) kms_cursor_edge_walk (64x64-left-edge)
[503.947665] Starting subtest: 64x64-left-edge
[503.949762] Starting dynamic subtest: pipe-A-eDP-1
[507.375830] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[507.386079] Starting dynamic subtest: pipe-D-eDP-1
[510.581767] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.207s)
[510.584045] Subtest 64x64-left-edge: SUCCESS (6.636s)
[511.430376] [125/134] (514s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[511.534937] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[512.534035] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.000s)
[512.648498] [126/134] (513s left) gem_mmap_gtt (basic-read-write)
[512.713755] Subtest basic-read-write: SKIP (0.000s)
[512.784244] [127/134] (513s left) gen7_exec_parse (batch-without-end)
[512.848898] Subtest batch-without-end: SKIP (0.000s)
[512.938990] [128/134] (513s left) kms_addfb_basic (bad-pitch-256)
[512.992513] Starting subtest: bad-pitch-256
[512.994137] Subtest bad-pitch-256: SUCCESS (0.000s)
[513.105158] [129/134] (513s left) gem_exec_schedule (preempt-self)
[513.184847] Starting subtest: preempt-self
[513.186914] Starting dynamic subtest: rcs0
[513.203848] Dynamic subtest rcs0: SUCCESS (0.021s)
[513.213147] Starting dynamic subtest: bcs0
[513.225480] Dynamic subtest bcs0: SUCCESS (0.021s)
[513.234567] Starting dynamic subtest: vcs0
[513.245291] Dynamic subtest vcs0: SUCCESS (0.019s)
[513.254037] Starting dynamic subtest: vcs1
[513.262845] Dynamic subtest vcs1: SUCCESS (0.017s)
[513.271857] Starting dynamic subtest: vecs0
[513.283640] Dynamic subtest vecs0: SUCCESS (0.020s)
[513.292564] Starting dynamic subtest: ccs0
[513.302934] Dynamic subtest ccs0: SUCCESS (0.019s)
[513.304836] Subtest preempt-self: SUCCESS (0.121s)
[514.993100] [130/134] (511s left) kms_chamelium_edid (dp-edid-resolution-list)
[515.386710] Subtest dp-edid-resolution-list: SKIP (0.000s)
[516.231485] [131/134] (510s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[516.328361] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[516.330620] Starting dynamic subtest: pipe-A
[517.587526] Dynamic subtest pipe-A: SUCCESS (1.262s)
[517.600720] Starting dynamic subtest: pipe-B
[519.818707] Dynamic subtest pipe-B: SUCCESS (2.229s)
[519.827978] Starting dynamic subtest: pipe-C
[520.990798] Dynamic subtest pipe-C: SUCCESS (1.171s)
[521.001274] Starting dynamic subtest: pipe-D
[522.191983] Dynamic subtest pipe-D: SUCCESS (1.200s)
[522.194241] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.867s)
[523.330514] [132/134] (503s left) i915_query (query-regions-garbage-items)
[523.397119] Starting subtest: query-regions-garbage-items
[523.399084] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[523.480256] [133/134] (502s left) gem_pwrite (basic-exhaustion)
[523.541607] Subtest basic-exhaustion: SKIP (0.000s)
[523.609570] [134/134] (502s left) gem_create (hog-create)
[523.675433] Starting subtest: hog-create
[523.677663] Starting dynamic subtest: smem0
[556.871392] Dynamic subtest smem0: SUCCESS (33.191s)
[556.874074] Subtest hog-create: SUCCESS (33.193s)
[557.031612] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_pm_rps
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: api_intel_bb
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_ctx_shared
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_selftest
results: parsing output: 8/ for test: gem_exec_flush
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_pread
results: parsing output: 28/ for test: drm_read
results: parsing output: 29/ for test: i915_hangman
results: parsing output: 30/ for test: kms_prime
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: tools_test
results: parsing output: 36/ for test: kms_plane_cursor
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_ctx_isolation
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_getfb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: kms_pipe_b_c_ivb
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_pipe_crc_basic
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: gem_exec_whisper
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: gem_exec_capture
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_pm_rpm
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_pm_dc
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: vgem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_mmap
results: parsing output: 82/ for test: syncobj_basic
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_atomic_transition
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: gem_ppgtt
results: parsing output: 92/ for test: core_getclient
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_draw_crc
results: parsing output: 97/ for test: prime_mmap
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_3d
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: core_getstats
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_fenced_exec_thrash
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_partial_pwrite_pread
results: parsing output: 118/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 119/ for test: gem_lmem_swapping
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: syncobj_eventfd
results: parsing output: 122/ for test: gem_wait
results: parsing output: 123/ for test: kms_cursor_edge_walk
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gen7_exec_parse
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_chamelium_edid
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: i915_query
results: parsing output: 132/ for test: gem_pwrite
results: parsing output: 133/ for test: gem_create
Done.