[57.388322] Initializing watchdogs
[57.388370]   /dev/watchdog0
[57.405321] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.409843] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.412225] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.415698] [001/133] (960s left) kms_rotation_crc (primary-rotation-90)
[57.555237] Starting subtest: primary-rotation-90
[57.559953] Subtest primary-rotation-90: SKIP (0.001s)
[57.646513] [002/133] (960s left) gem_exec_schedule (semaphore-power)
[57.842219] Subtest semaphore-power: SKIP (0.000s)
[58.040280] [003/133] (959s left) gem_exec_balancer (hang)
[58.301836] Starting subtest: hang
[59.957068] Subtest hang: SUCCESS (1.656s)
[60.132767] [004/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[60.236519] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[60.241072] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[60.344895] [005/133] (957s left) kms_vrr (flipline)
[60.428623] Starting subtest: flipline
[60.434803] Subtest flipline: SKIP (0.000s)
[60.519351] [006/133] (957s left) syncobj_wait (invalid-reset-zero-handles)
[60.574748] Starting subtest: invalid-reset-zero-handles
[60.576621] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[60.682390] [007/133] (957s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[60.786085] Starting subtest: 4-tiled-16bpp-rotate-270
[60.818133] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.032s)
[60.960403] [008/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[61.084250] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[61.098695] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.217932] [009/133] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[61.351514] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[68.106868] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.779s)
[68.248368] [010/133] (950s left) i915_pm_rpm (reg-read-ioctl)
[70.120494] Starting subtest: reg-read-ioctl
[72.405534] Subtest reg-read-ioctl: SUCCESS (2.289s)
[72.799245] [011/133] (945s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[72.897344] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[72.899662] Starting dynamic subtest: pipe-A-default-mode
[73.192152] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[73.196749] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.291s)
[74.016894] [012/133] (944s left) kms_async_flips (async-flip-dpms)
[74.117592] Starting subtest: async-flip-dpms
[74.509490] Starting dynamic subtest: pipe-A-eDP-1
[78.333662] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.824s)
[78.702574] Starting dynamic subtest: pipe-B-eDP-1
[81.517178] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.820s)
[81.905567] Starting dynamic subtest: pipe-C-eDP-1
[84.687533] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.788s)
[85.064446] Starting dynamic subtest: pipe-D-eDP-1
[87.851896] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[87.854291] Subtest async-flip-dpms: SUCCESS (13.736s)
[89.057879] [013/133] (929s left) kms_addfb_basic (bad-pitch-65536)
[89.117300] Starting subtest: bad-pitch-65536
[89.119606] Subtest bad-pitch-65536: SUCCESS (0.000s)
[89.291290] [014/133] (929s left) kms_psr (psr2-cursor-render)
[89.389160] Starting subtest: psr2-cursor-render
[89.391450] Starting dynamic subtest: eDP-1
[91.116707] Dynamic subtest eDP-1: SUCCESS (1.729s)
[91.119182] Subtest psr2-cursor-render: SUCCESS (1.730s)
[91.943664] [015/133] (926s left) gen9_exec_parse (bb-start-cmd)
[92.005846] Subtest bb-start-cmd: SKIP (0.000s)
[92.075239] [016/133] (926s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[92.194843] Starting subtest: modeset-atomic-cursor-hotspot
[92.199389] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[92.369672] [017/133] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[92.467534] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[92.472020] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[92.613303] [018/133] (925s left) kms_flip (modeset-vs-vblank-race-interruptible)
[92.707410] Starting subtest: modeset-vs-vblank-race-interruptible
[92.709830] Starting dynamic subtest: A-eDP1
[97.378295] Dynamic subtest A-eDP1: SUCCESS (4.670s)
[97.388740] Starting dynamic subtest: B-eDP1
[102.007917] Dynamic subtest B-eDP1: SUCCESS (4.628s)
[102.019083] Starting dynamic subtest: C-eDP1
[106.623196] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[106.632850] Starting dynamic subtest: D-eDP1
[111.166500] Dynamic subtest D-eDP1: SUCCESS (4.541s)
[111.171774] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.464s)
[112.344833] [019/133] (906s left) kms_vblank (query-busy-hang)
[112.448228] Starting subtest: query-busy-hang
[112.450407] Starting dynamic subtest: pipe-A-eDP-1
[138.707515] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.258s)
[138.720625] Starting dynamic subtest: pipe-D-eDP-1
[153.695211] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.986s)
[153.697517] Subtest query-busy-hang: SUCCESS (41.249s)
[154.518764] [020/133] (864s left) kms_pm_lpsp (kms-lpsp)
[155.627114] Starting subtest: kms-lpsp
[155.629212] Starting dynamic subtest: pipe-A-eDP-1
[155.773827] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[156.069729] Subtest kms-lpsp: SUCCESS (0.445s)
[156.945229] [021/133] (861s left) gem_workarounds (reset)
[157.013399] Starting subtest: reset
[157.142222] Subtest reset: SUCCESS (0.129s)
[157.286759] [022/133] (861s left) i915_hangman (gt-error-state-capture)
[157.356700] Starting subtest: gt-error-state-capture
[157.358930] Starting dynamic subtest: rcs0
[168.885898] Dynamic subtest rcs0: SUCCESS (11.528s)
[168.896618] Starting dynamic subtest: bcs0
[179.892146] Dynamic subtest bcs0: SUCCESS (11.003s)
[179.902196] Starting dynamic subtest: vcs0
[190.836723] Dynamic subtest vcs0: SUCCESS (10.942s)
[190.847911] Starting dynamic subtest: vcs1
[201.846211] Dynamic subtest vcs1: SUCCESS (11.008s)
[201.857655] Starting dynamic subtest: vecs0
[213.812584] Dynamic subtest vecs0: SUCCESS (11.963s)
[213.823996] Starting dynamic subtest: ccs0
[224.886075] Dynamic subtest ccs0: SUCCESS (11.071s)
[224.888686] Subtest gt-error-state-capture: SUCCESS (67.528s)
[224.988051] [023/133] (793s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[225.122389] Starting subtest: extended-modeset-hang-oldfb-with-reset
[225.124689] Starting dynamic subtest: pipe-A
[236.997306] Dynamic subtest pipe-A: SUCCESS (11.874s)
[237.006499] Starting dynamic subtest: pipe-D
[249.256445] Dynamic subtest pipe-D: SUCCESS (12.254s)
[249.258740] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.131s)
[250.080087] [024/133] (768s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[250.181041] Starting subtest: fbc-psr2-primary-mmap-cpu
[250.183197] Starting dynamic subtest: eDP-1
[250.187150] Dynamic subtest eDP-1: SKIP (0.000s)
[250.191177] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[250.275328] [025/133] (768s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[250.372741] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[250.375116] Starting dynamic subtest: pipe-A-eDP-1
[251.200277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s)
[251.208535] Starting dynamic subtest: pipe-B-eDP-1
[252.799168] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.595s)
[252.808420] Starting dynamic subtest: pipe-C-eDP-1
[254.302081] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s)
[254.311542] Starting dynamic subtest: pipe-D-eDP-1
[255.807048] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.503s)
[255.809300] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.427s)
[257.017912] [026/133] (761s left) kms_hdr (invalid-hdr)
[257.117245] Starting subtest: invalid-hdr
[259.204156] Starting dynamic subtest: pipe-A-eDP-1
[262.053473] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.850s)
[262.055736] Subtest invalid-hdr: SUCCESS (4.939s)
[262.214114] [027/133] (756s left) gem_create (hog-create)
[262.280383] Starting subtest: hog-create
[262.282382] Starting dynamic subtest: smem0
[295.917097] Dynamic subtest smem0: SUCCESS (33.636s)
[295.919733] Subtest hog-create: SUCCESS (33.637s)
[296.128894] [028/133] (722s left) kms_plane_cursor (viewport)
[296.234692] Starting subtest: viewport
[296.238940] Starting dynamic subtest: pipe-A-eDP-1-size-64
[299.744316] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (3.509s)
[299.805924] Starting dynamic subtest: pipe-A-eDP-1-size-128
[302.290931] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s)
[302.352610] Starting dynamic subtest: pipe-A-eDP-1-size-256
[304.847517] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.504s)
[305.195713] Starting dynamic subtest: pipe-B-eDP-1-size-64
[308.353479] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.166s)
[308.412995] Starting dynamic subtest: pipe-B-eDP-1-size-128
[310.911219] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s)
[310.975197] Starting dynamic subtest: pipe-B-eDP-1-size-256
[313.433366] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.470s)
[313.782570] Starting dynamic subtest: pipe-C-eDP-1-size-64
[316.682135] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.910s)
[316.719061] Starting dynamic subtest: pipe-C-eDP-1-size-128
[318.793997] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.080s)
[318.834584] Starting dynamic subtest: pipe-C-eDP-1-size-256
[320.960537] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.135s)
[321.287060] Starting dynamic subtest: pipe-D-eDP-1-size-64
[324.163278] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.884s)
[324.199692] Starting dynamic subtest: pipe-D-eDP-1-size-128
[326.341472] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.148s)
[326.377779] Starting dynamic subtest: pipe-D-eDP-1-size-256
[328.473318] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[328.803225] Subtest viewport: SUCCESS (32.567s)
[329.621957] [029/133] (689s left) dumb_buffer (invalid-bpp)
[329.690529] Starting subtest: invalid-bpp
[329.692720] Subtest invalid-bpp: SUCCESS (0.000s)
[329.827170] [030/133] (689s left) kms_addfb_basic (too-wide)
[329.926184] Starting subtest: too-wide
[329.928398] Subtest too-wide: SUCCESS (0.000s)
[330.064423] [031/133] (689s left) kms_pipe_crc_basic (hang-read-crc)
[330.168238] Starting subtest: hang-read-crc
[330.170158] Starting dynamic subtest: pipe-A-eDP-1
[332.282262] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[332.294561] Starting dynamic subtest: pipe-B-eDP-1
[334.990764] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.710s)
[334.999235] Starting dynamic subtest: pipe-C-eDP-1
[337.673357] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.680s)
[337.681817] Starting dynamic subtest: pipe-D-eDP-1
[340.345946] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.673s)
[340.348331] Subtest hang-read-crc: SUCCESS (10.179s)
[341.197790] [032/133] (677s left) gem_mmap (bad-offset)
[341.260047] Subtest bad-offset: SKIP (0.000s)
[341.350529] [033/133] (677s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-cpu)
[341.456248] Starting subtest: psr-abgr161616f-draw-mmap-cpu
[341.460483] Subtest psr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[341.575961] [034/133] (677s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[341.756415] Starting subtest: cursor-rapid-movement-64x64
[341.762370] Starting dynamic subtest: pipe-A-eDP-1
[342.291440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[342.316804] Starting dynamic subtest: pipe-D-eDP-1
[343.492464] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.180s)
[343.494641] Subtest cursor-rapid-movement-64x64: SUCCESS (1.734s)
[344.376137] [035/133] (674s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[344.500976] Starting subtest: cursor-tearing-framebuffer-change
[344.503120] Starting dynamic subtest: pipe-A-eDP-1
[345.062137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[345.071062] Starting dynamic subtest: pipe-D-eDP-1
[346.297902] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[346.300460] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.799s)
[347.141941] [036/133] (672s left) kms_psr (pr-cursor-render)
[347.244246] Starting subtest: pr-cursor-render
[347.248408] Subtest pr-cursor-render: SKIP (0.000s)
[347.342539] [037/133] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[347.443623] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[347.447749] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[347.557013] [038/133] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[347.668615] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[347.673051] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[347.786855] [039/133] (671s left) kms_psr (psr-cursor-mmap-gtt)
[347.893287] Starting subtest: psr-cursor-mmap-gtt
[347.895599] Starting dynamic subtest: eDP-1
[349.604294] Dynamic subtest eDP-1: SUCCESS (1.712s)
[349.606139] Subtest psr-cursor-mmap-gtt: SUCCESS (1.714s)
[350.499741] [040/133] (668s left) kms_selftest (drm_damage_helper)
[350.547658] Starting subtest: drm_damage_helper
[350.584503] Starting dynamic subtest: drm_test_damage_iter_no_damage
[350.707322] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.123s)
[350.714759] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[350.857124] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.148s)
[350.866287] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[351.010876] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.153s)
[351.018751] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[351.162520] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.151s)
[351.169881] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[351.322435] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.159s)
[351.329831] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[351.466065] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.142s)
[351.475221] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[351.610424] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.144s)
[351.618228] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[351.753271] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.141s)
[351.763102] Starting dynamic subtest: drm_test_damage_iter_single_damage
[351.908155] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.154s)
[351.916301] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[352.041953] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.134s)
[352.051825] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[352.189330] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.145s)
[352.199101] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[352.350970] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.161s)
[352.359738] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[352.483699] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.131s)
[352.493430] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[352.635882] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.153s)
[352.645367] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[352.770046] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.132s)
[352.779682] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[352.922825] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.152s)
[352.930878] Starting dynamic subtest: drm_test_damage_iter_damage
[353.091438] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.168s)
[353.098880] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[353.251533] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.160s)
[353.258924] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[353.388849] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.136s)
[353.398080] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[353.544431] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.156s)
[353.552171] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[353.691887] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.146s)
[353.693815] Subtest drm_damage_helper: SUCCESS (3.142s)
[353.920037] [041/133] (665s left) gem_render_copy_redux (normal)
[353.992112] Starting subtest: normal
[354.385901] Subtest normal: SUCCESS (0.393s)
[354.559471] [042/133] (664s left) kms_setmode (invalid-clone-exclusive-crtc)
[354.617896] Starting subtest: invalid-clone-exclusive-crtc
[354.624425] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[354.738012] [043/133] (664s left) gem_pxp (create-regular-buffer)
[354.864672] Starting subtest: create-regular-buffer
[354.866898] Subtest create-regular-buffer: SUCCESS (0.000s)
[354.992234] [044/133] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[355.105376] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[361.687977] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.583s)
[361.884881] [045/133] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[361.994360] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[361.998475] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[362.110631] [046/133] (657s left) kms_draw_crc (draw-method-mmap-gtt)
[362.216422] Starting subtest: draw-method-mmap-gtt
[362.220491] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[362.356393] [047/133] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[362.468646] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[362.473066] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[362.613482] [048/133] (657s left) gem_softpin (noreloc-interruptible)
[362.682480] Starting subtest: noreloc-interruptible
[368.091783] Subtest noreloc-interruptible: SUCCESS (5.408s)
[368.265816] [049/133] (651s left) gem_exec_schedule (independent)
[368.342788] Starting subtest: independent
[368.345130] Starting dynamic subtest: rcs0
[369.941378] Dynamic subtest rcs0: SUCCESS (1.608s)
[369.958496] Starting dynamic subtest: vcs0
[371.925468] Dynamic subtest vcs0: SUCCESS (1.981s)
[371.939829] Starting dynamic subtest: vcs1
[373.935678] Dynamic subtest vcs1: SUCCESS (2.008s)
[373.947100] Starting dynamic subtest: vecs0
[375.933580] Dynamic subtest vecs0: SUCCESS (1.995s)
[375.944091] Starting dynamic subtest: ccs0
[377.941885] Dynamic subtest ccs0: SUCCESS (2.006s)
[377.944721] Subtest independent: SUCCESS (9.610s)
[378.256821] [050/133] (641s left) sriov_basic (bind-unbind-vf)
[378.321531] Starting subtest: bind-unbind-vf
[378.323771] Starting dynamic subtest: vf-1
[378.395618] Dynamic subtest vf-1: FAIL (0.014s)
[378.405078] Starting dynamic subtest: vf-2
[378.475049] Dynamic subtest vf-2: FAIL (0.003s)
[378.484528] Starting dynamic subtest: vf-3
[378.553578] Dynamic subtest vf-3: FAIL (0.004s)
[378.561670] Starting dynamic subtest: vf-4
[378.630254] Dynamic subtest vf-4: FAIL (0.003s)
[378.638268] Starting dynamic subtest: vf-5
[378.706744] Dynamic subtest vf-5: FAIL (0.003s)
[378.716077] Starting dynamic subtest: vf-6
[378.785291] Dynamic subtest vf-6: FAIL (0.003s)
[378.793275] Starting dynamic subtest: vf-7
[378.868251] Dynamic subtest vf-7: FAIL (0.003s)
[378.878060] Starting dynamic subtest: vf-random
[378.950621] Dynamic subtest vf-random: FAIL (0.003s)
[378.959968] Starting dynamic subtest: vf-last
[379.033921] Dynamic subtest vf-last: FAIL (0.483s)
[379.036142] Subtest bind-unbind-vf: FAIL (0.528s)
[379.072221] [051/133] (640s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[379.177170] Starting subtest: flip-vs-dpms-off-vs-modeset
[379.179352] Starting dynamic subtest: A-eDP1
[382.829532] Dynamic subtest A-eDP1: SUCCESS (3.651s)
[382.839129] Starting dynamic subtest: B-eDP1
[386.038631] Dynamic subtest B-eDP1: SUCCESS (3.211s)
[386.047830] Starting dynamic subtest: C-eDP1
[389.124834] Dynamic subtest C-eDP1: SUCCESS (3.084s)
[389.134274] Starting dynamic subtest: D-eDP1
[392.214147] Dynamic subtest D-eDP1: SUCCESS (3.088s)
[392.216389] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.041s)
[393.035038] [052/133] (626s left) kms_properties (colorop-properties-legacy)
[393.150091] Starting subtest: colorop-properties-legacy
[393.151950] Starting dynamic subtest: pipe-A-eDP-1
[393.518057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.366s)
[393.527200] Starting dynamic subtest: pipe-B-eDP-1
[394.589515] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.070s)
[394.599535] Starting dynamic subtest: pipe-C-eDP-1
[395.621736] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.034s)
[395.631192] Starting dynamic subtest: pipe-D-eDP-1
[396.642777] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.019s)
[396.645270] Subtest colorop-properties-legacy: SUCCESS (3.495s)
[397.469880] [053/133] (622s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[397.525955] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[397.528289] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[397.636174] [054/133] (622s left) kms_flip (plain-flip-fb-recreate)
[397.727726] Starting subtest: plain-flip-fb-recreate
[397.729721] Starting dynamic subtest: A-eDP1
[406.636348] Dynamic subtest A-eDP1: SUCCESS (8.911s)
[406.646092] Starting dynamic subtest: B-eDP1
[415.467148] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[415.475733] Starting dynamic subtest: C-eDP1
[424.287187] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[424.297151] Starting dynamic subtest: D-eDP1
[433.111892] Dynamic subtest D-eDP1: SUCCESS (8.822s)
[433.116301] Subtest plain-flip-fb-recreate: SUCCESS (35.390s)
[434.317166] [055/133] (585s left) i915_drm_fdinfo (memory-info-shared)
[434.361809] Starting subtest: memory-info-shared
[434.364292] Starting dynamic subtest: smem0
[434.420724] Dynamic subtest smem0: SUCCESS (0.061s)
[434.423562] Subtest memory-info-shared: SUCCESS (0.061s)
[434.514301] [056/133] (585s left) gem_exec_capture (capture-recoverable)
[434.577386] Starting subtest: capture-recoverable
[434.582828] Subtest capture-recoverable: SUCCESS (0.003s)
[434.738608] [057/133] (585s left) vgem_basic (create)
[434.845589] Starting subtest: create
[434.847450] Subtest create: SUCCESS (0.000s)
[434.922031] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[434.925171] [058/133] (585s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[437.049952] Starting subtest: dpms-mode-unset-lpsp
[441.055663] Subtest dpms-mode-unset-lpsp: SUCCESS (4.010s)
[441.444696] [059/133] (578s left) kms_invalid_mode (zero-vdisplay)
[441.542649] Starting subtest: zero-vdisplay
[441.545065] Starting dynamic subtest: pipe-A-eDP-1
[441.831082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[441.839818] Starting dynamic subtest: pipe-B-eDP-1
[441.842123] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[441.849724] Starting dynamic subtest: pipe-C-eDP-1
[441.852079] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[441.859841] Starting dynamic subtest: pipe-D-eDP-1
[441.862125] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[441.864398] Subtest zero-vdisplay: SUCCESS (0.296s)
[442.657088] [060/133] (577s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[442.784089] Starting subtest: cursorB-vs-flipA-varying-size
[442.788706] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[442.950333] [061/133] (577s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[443.059799] Starting subtest: y-tiled-16bpp-rotate-270
[443.064328] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[443.192842] [062/133] (577s left) gem_exec_flush (basic-uc-set-default)
[443.264130] Starting subtest: basic-uc-set-default
[448.720074] Subtest basic-uc-set-default: SUCCESS (5.457s)
[448.931620] [063/133] (571s left) kms_async_flips (test-time-stamp-atomic)
[449.031394] Starting subtest: test-time-stamp-atomic
[449.410631] Starting dynamic subtest: pipe-A-eDP-1
[450.239327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[450.629488] Starting dynamic subtest: pipe-B-eDP-1
[451.371609] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.749s)
[451.734112] Starting dynamic subtest: pipe-C-eDP-1
[452.498848] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[452.857871] Starting dynamic subtest: pipe-D-eDP-1
[453.621972] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[453.624287] Subtest test-time-stamp-atomic: SUCCESS (4.590s)
[454.802134] [064/133] (565s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[454.935986] Starting subtest: basic-flip-before-cursor-atomic
[455.864352] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.925s)
[456.734035] [065/133] (563s left) kms_chamelium_hpd (hdmi-hpd-fast)
[457.117866] Subtest hdmi-hpd-fast: SKIP (0.000s)
[457.922254] [066/133] (562s left) i915_suspend (forcewake)
[457.999431] Starting subtest: forcewake
[489.625767] Subtest forcewake: SUCCESS (2.407s)
[489.719881] [067/133] (530s left) gem_ctx_persistence (engines-mixed-process)
[489.803510] Starting subtest: engines-mixed-process
[489.806026] Starting dynamic subtest: rcs0
[491.137156] Dynamic subtest rcs0: SUCCESS (1.332s)
[491.148545] Starting dynamic subtest: bcs0
[493.106845] Dynamic subtest bcs0: SUCCESS (1.965s)
[493.118214] Starting dynamic subtest: vcs0
[495.095981] Dynamic subtest vcs0: SUCCESS (1.986s)
[495.107145] Starting dynamic subtest: vcs1
[497.121669] Dynamic subtest vcs1: SUCCESS (2.020s)
[497.131784] Starting dynamic subtest: vecs0
[499.133269] Dynamic subtest vecs0: SUCCESS (2.011s)
[499.144548] Starting dynamic subtest: ccs0
[501.131840] Dynamic subtest ccs0: SUCCESS (1.996s)
[501.134352] Subtest engines-mixed-process: SUCCESS (11.320s)
[501.236782] [068/133] (519s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[501.347251] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[501.993717] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[502.189838] [069/133] (518s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[502.295028] Starting subtest: psr-rgb565-draw-pwrite
[509.247199] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.953s)
[509.394029] [070/133] (511s left) kms_color (ctm-0-75)
[509.502460] Starting subtest: ctm-0-75
[509.504642] Starting dynamic subtest: pipe-A-eDP-1
[514.356486] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.852s)
[514.366642] Starting dynamic subtest: pipe-B-eDP-1
[519.897502] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.540s)
[519.907507] Starting dynamic subtest: pipe-C-eDP-1
[525.179022] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.281s)
[525.191350] Starting dynamic subtest: pipe-D-eDP-1
[530.518276] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.336s)
[530.520623] Subtest ctm-0-75: SUCCESS (21.012s)
[531.368463] [071/133] (489s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[531.469723] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[531.473834] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[531.609593] [072/133] (489s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[531.708787] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[531.712839] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[531.847398] [073/133] (488s left) gem_tiling_max_stride
[531.964318] [074/133] (488s left) kms_big_fb (linear-64bpp-rotate-180)
[532.076291] Starting subtest: linear-64bpp-rotate-180
[533.748394] Subtest linear-64bpp-rotate-180: SUCCESS (1.673s)
[533.984498] [075/133] (486s left) gem_partial_pwrite_pread (writes-after-reads)
[534.049449] Subtest writes-after-reads: SKIP (0.000s)
[534.134985] [076/133] (486s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[534.231930] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[534.234174] Starting dynamic subtest: pipe-A-eDP-1
[534.257999] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[534.269498] Starting dynamic subtest: pipe-B-eDP-1
[534.292167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[534.300741] Starting dynamic subtest: pipe-C-eDP-1
[534.323243] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[534.332189] Starting dynamic subtest: pipe-D-eDP-1
[534.355405] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[534.359331] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[536.516758] [077/133] (484s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[536.614171] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[536.616300] Starting dynamic subtest: pipe-A-default-mode
[536.903054] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[536.907488] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.289s)
[537.746821] [078/133] (483s left) kms_cursor_crc (cursor-onscreen-512x512)
[538.025838] Starting subtest: cursor-onscreen-512x512
[538.030449] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[538.237189] [079/133] (482s left) kms_addfb_basic (clobberred-modifier)
[538.302779] Starting subtest: clobberred-modifier
[538.306994] Subtest clobberred-modifier: SKIP (0.000s)
[538.473179] [080/133] (482s left) gem_ctx_bad_destroy (invalid-pad)
[538.536986] Starting subtest: invalid-pad
[538.539367] Subtest invalid-pad: SUCCESS (0.000s)
[538.639652] [081/133] (482s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[538.731557] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[538.733479] Starting dynamic subtest: pipe-A-default-mode
[539.888800] Dynamic subtest pipe-A-default-mode: SKIP (1.153s)
[539.893262] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.154s)
[540.099842] [082/133] (481s left) kms_psr (fbc-pr-no-drrs)
[540.199329] Starting subtest: fbc-pr-no-drrs
[540.203532] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[540.291827] [083/133] (480s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[540.395258] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[540.399582] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[540.539111] [084/133] (480s left) kms_pwrite_crc
[542.121795] [085/133] (479s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[542.229789] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[542.233828] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[542.367898] [086/133] (478s left) gem_spin_batch (engines)
[542.421816] Starting subtest: engines
[542.424316] Starting dynamic subtest: rcs0
[545.670269] Dynamic subtest rcs0: SUCCESS (3.242s)
[545.682477] Starting dynamic subtest: bcs0
[548.906965] Dynamic subtest bcs0: SUCCESS (3.233s)
[548.918380] Starting dynamic subtest: vcs0
[552.144058] Dynamic subtest vcs0: SUCCESS (3.235s)
[552.155604] Starting dynamic subtest: vcs1
[555.381851] Dynamic subtest vcs1: SUCCESS (3.233s)
[555.393843] Starting dynamic subtest: vecs0
[558.619197] Dynamic subtest vecs0: SUCCESS (3.233s)
[558.631173] Starting dynamic subtest: ccs0
[561.856903] Dynamic subtest ccs0: SUCCESS (3.235s)
[561.859078] Subtest engines: SUCCESS (19.428s)
[562.130887] [087/133] (459s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[562.236520] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[562.240925] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[562.362693] [088/133] (459s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[562.471330] Starting subtest: verify-pxp-key-change-after-suspend-resume
[569.628329] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.158s)
[569.786314] [089/133] (451s left) perf_pmu (frequency)
[569.837303] Starting subtest: frequency
[569.841951] Starting dynamic subtest: gt0
[572.010982] Dynamic subtest gt0: SUCCESS (2.165s)
[572.021970] Starting dynamic subtest: idle-gt0
[572.517064] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[572.526905] Starting dynamic subtest: gt1
[577.156551] Dynamic subtest gt1: SUCCESS (4.635s)
[577.165811] Starting dynamic subtest: idle-gt1
[577.661838] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[577.664914] Subtest frequency: SUCCESS (7.827s)
[577.809861] [090/133] (443s left) perf_pmu (busy-check-all)
[577.859865] Starting subtest: busy-check-all
[577.862164] Starting dynamic subtest: rcs0
[578.437961] Dynamic subtest rcs0: SUCCESS (0.580s)
[578.452628] Starting dynamic subtest: bcs0
[578.993221] Dynamic subtest bcs0: SUCCESS (0.553s)
[579.005915] Starting dynamic subtest: vcs0
[580.145991] Dynamic subtest vcs0: SUCCESS (1.149s)
[580.160704] Starting dynamic subtest: vcs1
[582.066088] Dynamic subtest vcs1: SUCCESS (1.917s)
[582.080833] Starting dynamic subtest: vecs0
[584.113944] Dynamic subtest vecs0: SUCCESS (2.045s)
[584.130768] Starting dynamic subtest: ccs0
[584.673789] Dynamic subtest ccs0: SUCCESS (0.558s)
[584.676243] Subtest busy-check-all: SUCCESS (6.817s)
[584.799623] [091/133] (436s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[584.904691] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[584.909184] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[585.040532] [092/133] (436s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[585.600014] Starting subtest: syncobj-timeline-invalid-flags
[585.602292] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[587.245779] [093/133] (434s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[587.314932] Starting subtest: map-fixed-invalidate-overlap
[587.319528] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[587.473503] [094/133] (434s left) gem_wait (await)
[587.541856] Starting subtest: await
[587.544142] Starting dynamic subtest: all-engines
[588.660203] Dynamic subtest all-engines: SUCCESS (1.121s)
[588.678426] Starting dynamic subtest: rcs0
[589.717560] Dynamic subtest rcs0: SUCCESS (1.055s)
[589.735716] Starting dynamic subtest: bcs0
[590.777198] Dynamic subtest bcs0: SUCCESS (1.058s)
[590.795516] Starting dynamic subtest: vcs0
[591.832219] Dynamic subtest vcs0: SUCCESS (1.053s)
[591.849191] Starting dynamic subtest: vcs1
[592.886316] Dynamic subtest vcs1: SUCCESS (1.052s)
[592.903563] Starting dynamic subtest: vecs0
[593.939179] Dynamic subtest vecs0: SUCCESS (1.051s)
[593.955968] Starting dynamic subtest: ccs0
[594.997575] Dynamic subtest ccs0: SUCCESS (1.056s)
[595.000142] Subtest await: SUCCESS (7.460s)
[595.223289] [095/133] (426s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[595.319158] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[595.321400] Starting dynamic subtest: pipe-A-eDP-1
[597.397974] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.078s)
[597.407753] Starting dynamic subtest: pipe-B-eDP-1
[599.516645] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.119s)
[599.526719] Starting dynamic subtest: pipe-C-eDP-1
[601.561127] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.041s)
[601.572283] Starting dynamic subtest: pipe-D-eDP-1
[603.634530] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.073s)
[603.636404] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.317s)
[604.842935] [096/133] (416s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[604.959398] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[604.961567] Starting dynamic subtest: pipe-A-eDP-1
[604.982161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[604.994639] Starting dynamic subtest: pipe-B-eDP-1
[605.013063] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[605.022058] Starting dynamic subtest: pipe-C-eDP-1
[605.040535] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[605.049608] Starting dynamic subtest: pipe-D-eDP-1
[605.068248] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[605.070091] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[607.207238] [097/133] (414s left) kms_content_protection (lic-type-0)
[607.358907] Starting subtest: lic-type-0
[607.363391] Subtest lic-type-0: SKIP (0.000s)
[607.528501] [098/133] (414s left) gem_partial_pwrite_pread (write-snoop)
[607.599898] Subtest write-snoop: SKIP (0.000s)
[607.704191] [099/133] (414s left) api_intel_bb (reset-bb)
[607.762259] Starting subtest: reset-bb
[607.764562] Subtest reset-bb: SUCCESS (0.003s)
[607.925655] [100/133] (413s left) gem_exec_suspend (basic)
[607.989866] Starting subtest: basic
[607.992196] Starting dynamic subtest: smem
[609.137864] Dynamic subtest smem: SUCCESS (1.146s)
[609.140652] Subtest basic: SUCCESS (1.148s)
[609.351106] [101/133] (412s left) kms_chamelium_frames (hdmi-crc-single)
[609.726922] Subtest hdmi-crc-single: SKIP (0.000s)
[610.506216] [102/133] (411s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[610.607017] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[617.792027] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.187s)
[617.952490] [103/133] (404s left) gem_userptr_blits (relocations)
[618.029912] Starting subtest: relocations
[618.034116] Subtest relocations: SKIP (0.000s)
[618.192592] [104/133] (403s left) prime_busy (after)
[618.251312] Starting subtest: after
[618.255950] Starting dynamic subtest: rcs0
[618.294164] Dynamic subtest rcs0: SUCCESS (0.040s)
[618.304707] Starting dynamic subtest: bcs0
[618.353228] Dynamic subtest bcs0: SUCCESS (0.059s)
[618.362702] Starting dynamic subtest: vcs0
[618.395795] Dynamic subtest vcs0: SUCCESS (0.042s)
[618.405694] Starting dynamic subtest: vcs1
[618.435541] Dynamic subtest vcs1: SUCCESS (0.039s)
[618.444737] Starting dynamic subtest: vecs0
[618.478324] Dynamic subtest vecs0: SUCCESS (0.042s)
[618.488383] Starting dynamic subtest: ccs0
[618.518273] Dynamic subtest ccs0: SUCCESS (0.039s)
[618.627145] Subtest after: SUCCESS (0.374s)
[618.728735] [105/133] (403s left) gem_flink_basic (double-flink)
[618.779256] Starting subtest: double-flink
[618.781206] Subtest double-flink: SUCCESS (0.000s)
[618.922907] [106/133] (403s left) kms_flip (2x-flip-vs-panning)
[619.023634] Starting subtest: 2x-flip-vs-panning
[619.031692] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[619.135854] [107/133] (403s left) prime_mmap (test_reprime)
[619.201269] Starting subtest: test_reprime
[619.203178] Starting dynamic subtest: test_reprime-smem
[619.232028] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[619.234309] Subtest test_reprime: SUCCESS (0.033s)
[619.353490] [108/133] (402s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[619.461465] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[619.463733] Starting dynamic subtest: pipe-A-eDP-1
[619.486547] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[619.502390] Starting dynamic subtest: pipe-B-eDP-1
[619.524951] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[619.534585] Starting dynamic subtest: pipe-C-eDP-1
[619.556150] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[619.565704] Starting dynamic subtest: pipe-D-eDP-1
[619.587513] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[619.591542] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.005s)
[621.643614] [109/133] (400s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[621.747597] Starting subtest: x-tiled-8bpp-rotate-0
[622.961697] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.214s)
[623.132731] [110/133] (399s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[623.187920] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[623.191708] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[623.393606] [111/133] (398s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[623.494006] Starting subtest: fbcpsr-tiling-4
[630.635843] Subtest fbcpsr-tiling-4: SUCCESS (7.143s)
[630.807005] [112/133] (391s left) syncobj_timeline (single-wait-available-submitted)
[630.860788] Starting subtest: single-wait-available-submitted
[630.863032] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[630.979705] [113/133] (391s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[631.081552] Starting subtest: plane-scaler-unity-scaling-with-rotation
[631.083695] Starting dynamic subtest: pipe-A
[631.318490] Dynamic subtest pipe-A: SUCCESS (0.239s)
[631.328578] Starting dynamic subtest: pipe-B
[632.628249] Dynamic subtest pipe-B: SUCCESS (1.309s)
[632.638377] Starting dynamic subtest: pipe-C
[633.981263] Dynamic subtest pipe-C: SUCCESS (1.352s)
[633.991423] Starting dynamic subtest: pipe-D
[635.314174] Dynamic subtest pipe-D: SUCCESS (1.331s)
[635.316435] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.236s)
[636.496833] [114/133] (385s left) gem_eio (in-flight-immediate)
[636.740726] Starting subtest: in-flight-immediate
[645.227721] Subtest in-flight-immediate: SUCCESS (8.486s)
[645.414226] [115/133] (377s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[650.463522] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[650.465865] Starting dynamic subtest: pipe-A-eDP-1
[662.467359] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.004s)
[662.480433] Starting dynamic subtest: pipe-B-eDP-1
[674.522593] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.050s)
[674.524947] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.058s)
[675.388690] [116/133] (347s left) gem_exec_reloc (basic-scanout)
[675.456082] Subtest basic-scanout: SKIP (0.000s)
[675.538115] [117/133] (347s left) syncobj_timeline (invalid-query-zero-handles)
[675.607179] Starting subtest: invalid-query-zero-handles
[675.609629] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[675.742015] [118/133] (346s left) gen3_mixed_blits
[675.866414] [119/133] (346s left) gem_lmem_swapping (heavy-multi)
[675.910867] Subtest heavy-multi: SKIP (0.000s)
[675.952702] [120/133] (346s left) gem_ctx_shared (q-smoketest-all)
[676.017431] Starting subtest: Q-smoketest-all
[708.421608] Subtest Q-smoketest-all: SUCCESS (32.351s)
[710.202631] [121/133] (312s left) gem_ccs (block-multicopy-compressed)
[710.260071] Starting subtest: block-multicopy-compressed
[710.264932] Subtest block-multicopy-compressed: SKIP (0.000s)
[710.400720] [122/133] (312s left) gem_ctx_persistence (hostile)
[710.458634] Starting subtest: hostile
[720.619023] Subtest hostile: SUCCESS (10.153s)
[720.789926] [123/133] (302s left) gem_partial_pwrite_pread (reads)
[720.858690] Subtest reads: SKIP (0.000s)
[720.961151] [124/133] (301s left) vgem_basic (dmabuf-fence-before)
[721.001911] Starting subtest: dmabuf-fence-before
[721.003734] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[721.083311] [125/133] (301s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[726.044156] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[726.048796] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.003s)
[726.899258] [126/133] (296s left) kms_atomic_transition (plane-all-modeset-transition)
[727.003313] Starting subtest: plane-all-modeset-transition
[727.007699] Subtest plane-all-modeset-transition: SKIP (0.000s)
[727.103339] [127/133] (295s left) kms_plane (plane-position-hole-dpms)
[727.200924] Starting subtest: plane-position-hole-dpms
[727.723886] Starting dynamic subtest: pipe-A-plane-1
[730.151787] Dynamic subtest pipe-A-plane-1: SUCCESS (2.428s)
[730.163034] Starting dynamic subtest: pipe-A-plane-2
[732.564960] Dynamic subtest pipe-A-plane-2: SUCCESS (2.410s)
[732.576166] Starting dynamic subtest: pipe-A-plane-3
[734.985247] Dynamic subtest pipe-A-plane-3: SUCCESS (2.419s)
[734.996330] Starting dynamic subtest: pipe-A-plane-4
[737.324753] Dynamic subtest pipe-A-plane-4: SUCCESS (2.340s)
[737.336045] Starting dynamic subtest: pipe-A-plane-5
[737.350350] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[738.500345] Starting dynamic subtest: pipe-B-plane-1
[740.867154] Dynamic subtest pipe-B-plane-1: SUCCESS (2.376s)
[740.877565] Starting dynamic subtest: pipe-B-plane-2
[743.279628] Dynamic subtest pipe-B-plane-2: SUCCESS (2.412s)
[743.290982] Starting dynamic subtest: pipe-B-plane-3
[745.642977] Dynamic subtest pipe-B-plane-3: SUCCESS (2.362s)
[745.654265] Starting dynamic subtest: pipe-B-plane-4
[748.042737] Dynamic subtest pipe-B-plane-4: SUCCESS (2.396s)
[748.054371] Starting dynamic subtest: pipe-B-plane-5
[748.066612] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[748.068979] Subtest plane-position-hole-dpms: SUCCESS (20.863s)
[748.946710] [128/133] (274s left) api_intel_bb (blit-noreloc-purge-cache)
[749.008772] Starting subtest: blit-noreloc-purge-cache
[749.017428] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[749.134693] [129/133] (273s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[749.185074] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[749.294499] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[749.391769] [130/133] (273s left) gem_exec_whisper (basic-normal-all)
[749.457775] Starting subtest: basic-normal-all
[753.041767] Subtest basic-normal-all: SUCCESS (3.581s)
[753.251412] [131/133] (269s left) syncobj_timeline (wait-for-submit-delayed-submit)
[753.316592] Starting subtest: wait-for-submit-delayed-submit
[753.420427] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[753.535034] [132/133] (269s left) gem_exec_reloc (basic-gtt)
[753.603329] Subtest basic-gtt: SKIP (0.000s)
[753.688158] [133/133] (269s left) gem_mmap_gtt (fault-concurrent-y)
[753.742670] Subtest fault-concurrent-Y: SKIP (0.000s)
[753.798434] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_vrr
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: i915_pm_rpm
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: kms_async_flips
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gen9_exec_parse
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: kms_pm_lpsp
results: parsing output: 20/ for test: gem_workarounds
results: parsing output: 21/ for test: i915_hangman
results: parsing output: 22/ for test: kms_busy
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_hdr
results: parsing output: 26/ for test: gem_create
results: parsing output: 27/ for test: kms_plane_cursor
results: parsing output: 28/ for test: dumb_buffer
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: gem_mmap
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_selftest
results: parsing output: 40/ for test: gem_render_copy_redux
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: gem_pxp
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_draw_crc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: sriov_basic
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_properties
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: gem_exec_capture
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: kms_invalid_mode
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_exec_flush
results: parsing output: 62/ for test: kms_async_flips
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_chamelium_hpd
results: parsing output: 65/ for test: i915_suspend
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_color
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_tiling_max_stride
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_partial_pwrite_pread
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: gem_ctx_bad_destroy
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_pwrite_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_spin_batch
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: gem_wait
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: gem_partial_pwrite_pread
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: gem_exec_suspend
results: parsing output: 100/ for test: kms_chamelium_frames
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: prime_busy
results: parsing output: 104/ for test: gem_flink_basic
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: prime_mmap
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gen3_mixed_blits
results: parsing output: 118/ for test: gem_lmem_swapping
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: gem_ccs
results: parsing output: 121/ for test: gem_ctx_persistence
results: parsing output: 122/ for test: gem_partial_pwrite_pread
results: parsing output: 123/ for test: vgem_basic
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_atomic_transition
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: api_intel_bb
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: gem_mmap_gtt
Done.