[56.598537] Initializing watchdogs
[56.598581]   /dev/watchdog0
[56.611762] [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]
[56.616096] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.618495] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.621955] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[56.746140] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[56.750384] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[56.843908] [002/133] (960s left) kms_feature_discovery (display-1x)
[56.943671] Starting subtest: display-1x
[56.945602] Subtest display-1x: SUCCESS (0.000s)
[57.036595] [003/133] (960s left) kms_vrr (flipline)
[57.118035] Starting subtest: flipline
[57.124660] Subtest flipline: SKIP (0.000s)
[57.190309] [004/133] (960s left) sw_sync (sync_busy_fork_unixsocket)
[57.228569] Starting subtest: sync_busy_fork_unixsocket
[57.233058] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[57.281814] [005/133] (960s left) kms_rotation_crc (bad-tiling)
[57.363616] Starting subtest: bad-tiling
[57.367759] Subtest bad-tiling: SKIP (0.001s)
[57.434709] [006/133] (959s left) gem_exec_reloc (basic-cpu-active)
[57.485180] Subtest basic-cpu-active: SKIP (0.000s)
[57.548408] [007/133] (959s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[57.601347] Starting subtest: y-tiled-ccs-to-yf-tiled
[57.605107] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[57.778685] [008/133] (959s left) gem_exec_fence (basic-busy)
[57.956074] Starting subtest: basic-busy
[57.958654] Starting dynamic subtest: rcs0
[58.056409] Dynamic subtest rcs0: SUCCESS (0.103s)
[58.066402] Starting dynamic subtest: bcs0
[58.108271] Dynamic subtest bcs0: SUCCESS (0.053s)
[58.117690] Starting dynamic subtest: vcs0
[58.167967] Dynamic subtest vcs0: SUCCESS (0.060s)
[58.177394] Starting dynamic subtest: vcs1
[58.227035] Dynamic subtest vcs1: SUCCESS (0.060s)
[58.236585] Starting dynamic subtest: vecs0
[58.288655] Dynamic subtest vecs0: SUCCESS (0.062s)
[58.298324] Starting dynamic subtest: ccs0
[58.347534] Dynamic subtest ccs0: SUCCESS (0.060s)
[58.350171] Subtest basic-busy: SUCCESS (0.402s)
[60.366730] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[60.370221] [009/133] (957s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[60.471669] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[60.475827] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[60.576293] [010/133] (956s left) gem_caching (writes)
[60.633463] Subtest writes: SKIP (0.000s)
[60.700312] [011/133] (956s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[60.759235] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[60.761235] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[60.849845] [012/133] (956s left) syncobj_timeline (wait-all-for-submit-snapshot)
[60.908581] Starting subtest: wait-all-for-submit-snapshot
[60.989110] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[61.072230] [013/133] (956s left) kms_sequence (queue-busy)
[61.167360] Starting subtest: queue-busy
[61.169686] Starting dynamic subtest: pipe-A-eDP-1
[63.092230] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[63.104284] Starting dynamic subtest: pipe-B-eDP-1
[65.662659] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.596s)
[65.672119] Starting dynamic subtest: pipe-C-eDP-1
[68.256402] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.611s)
[68.266291] Starting dynamic subtest: pipe-D-eDP-1
[70.869051] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.625s)
[70.871425] Subtest queue-busy: SUCCESS (9.788s)
[71.761045] [014/133] (945s left) core_getstats (basic)
[71.821225] Starting subtest: basic
[71.823572] Subtest basic: SUCCESS (0.000s)
[71.932142] [015/133] (945s left) gem_exec_schedule (timeslicing)
[71.997156] Starting subtest: timeslicing
[71.999148] Starting dynamic subtest: rcs0
[72.013068] Dynamic subtest rcs0: SUCCESS (0.023s)
[72.024097] Starting dynamic subtest: bcs0
[72.033660] Dynamic subtest bcs0: SUCCESS (0.021s)
[72.041732] Starting dynamic subtest: vcs0
[72.057274] Dynamic subtest vcs0: SUCCESS (0.023s)
[72.064582] Starting dynamic subtest: vcs1
[72.078417] Dynamic subtest vcs1: SUCCESS (0.021s)
[72.085876] Starting dynamic subtest: vecs0
[72.099454] Dynamic subtest vecs0: SUCCESS (0.021s)
[72.107329] Starting dynamic subtest: ccs0
[72.120437] Dynamic subtest ccs0: SUCCESS (0.021s)
[72.122725] Subtest timeslicing: SUCCESS (0.133s)
[73.336276] [016/133] (944s left) kms_plane_alpha_blend (constant-alpha-min)
[73.490119] Starting subtest: constant-alpha-min
[73.769690] Starting dynamic subtest: pipe-A-eDP-1
[74.492604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[74.501907] Starting dynamic subtest: pipe-D-eDP-1
[76.071468] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.580s)
[76.073514] Subtest constant-alpha-min: SUCCESS (2.586s)
[76.890482] [017/133] (940s left) kms_addfb_basic (unused-modifier)
[76.943613] Starting subtest: unused-modifier
[76.946016] Subtest unused-modifier: SUCCESS (0.000s)
[77.101901] [018/133] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[77.203453] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[77.207521] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[77.314399] [019/133] (940s left) dmabuf (all-tests)
[77.344027] Starting subtest: all-tests
[77.348455] Subtest all-tests: SKIP (0.000s)
[77.399316] [020/133] (940s left) gem_ctx_engines (execute-oneforall)
[77.457910] Starting subtest: execute-oneforall
[77.967620] Subtest execute-oneforall: SUCCESS (0.510s)
[79.410209] [021/133] (938s left) kms_properties (crtc-properties-legacy)
[79.500234] Starting subtest: crtc-properties-legacy
[79.502623] Starting dynamic subtest: pipe-A-eDP-1
[79.969121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.470s)
[79.977122] Starting dynamic subtest: pipe-B-eDP-1
[81.163951] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.195s)
[81.172197] Starting dynamic subtest: pipe-C-eDP-1
[82.280977] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[82.289743] Starting dynamic subtest: pipe-D-eDP-1
[83.423482] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[83.425736] Subtest crtc-properties-legacy: SUCCESS (3.927s)
[84.229836] [022/133] (933s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[84.329496] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[84.333619] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[84.433207] [023/133] (933s left) kms_addfb_basic (bad-pitch-256)
[84.484794] Starting subtest: bad-pitch-256
[84.488695] Subtest bad-pitch-256: SUCCESS (0.000s)
[84.606661] [024/133] (933s left) kms_big_fb (x-tiled-addfb-size-overflow)
[84.699837] Starting subtest: x-tiled-addfb-size-overflow
[84.701997] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[84.781939] [025/133] (933s left) gem_ctx_persistence (hang)
[84.830475] Starting subtest: hang
[84.835288] Subtest hang: SKIP (0.000s)
[84.923848] [026/133] (933s left) gem_mmap_wc (close)
[84.980975] Subtest close: SKIP (0.000s)
[85.035520] [027/133] (933s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[85.126930] Starting subtest: bad-rotation-90-yf-tiled-ccs
[85.129315] Starting dynamic subtest: pipe-A-eDP-1
[85.152207] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[85.161451] Starting dynamic subtest: pipe-B-eDP-1
[85.179561] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[85.186916] Starting dynamic subtest: pipe-C-eDP-1
[85.204834] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.212299] Starting dynamic subtest: pipe-D-eDP-1
[85.230783] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.235030] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[87.392855] [028/133] (930s left) sw_sync (alloc_fence)
[87.430934] Starting subtest: alloc_fence
[87.433079] Subtest alloc_fence: SUCCESS (0.000s)
[87.481024] [029/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[87.575381] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[87.579385] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[87.661211] [030/133] (930s left) i915_suspend (fence-restore-tiled2untiled)
[87.707073] Starting subtest: fence-restore-tiled2untiled
[87.711351] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[87.796165] [031/133] (930s left) i915_hangman (gt-engine-error)
[87.849985] Starting subtest: gt-engine-error
[87.852148] Starting dynamic subtest: rcs0
[89.255203] Dynamic subtest rcs0: SUCCESS (1.402s)
[89.263839] Starting dynamic subtest: bcs0
[91.298546] Dynamic subtest bcs0: SUCCESS (2.042s)
[91.308606] Starting dynamic subtest: vcs0
[93.280078] Dynamic subtest vcs0: SUCCESS (1.980s)
[93.289422] Starting dynamic subtest: vcs1
[95.264841] Dynamic subtest vcs1: SUCCESS (1.982s)
[95.277255] Starting dynamic subtest: vecs0
[97.250240] Dynamic subtest vecs0: SUCCESS (1.984s)
[97.260696] Starting dynamic subtest: ccs0
[99.297866] Dynamic subtest ccs0: SUCCESS (2.045s)
[99.300786] Subtest gt-engine-error: SUCCESS (11.444s)
[99.377842] [032/133] (918s left) kms_content_protection (dp-mst-type-1)
[99.525936] Starting subtest: dp-mst-type-1
[99.530692] Subtest dp-mst-type-1: SKIP (0.000s)
[99.644360] [033/133] (918s left) kms_big_fb (linear-32bpp-rotate-90)
[99.745798] Starting subtest: linear-32bpp-rotate-90
[99.764985] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[99.886808] [034/133] (918s left) kms_plane_cursor (primary)
[99.979288] Starting subtest: primary
[99.983832] Starting dynamic subtest: pipe-A-eDP-1-size-64
[102.523315] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.543s)
[102.546738] Starting dynamic subtest: pipe-A-eDP-1-size-128
[105.147722] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.606s)
[105.170674] Starting dynamic subtest: pipe-A-eDP-1-size-256
[107.771898] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.606s)
[108.086940] Starting dynamic subtest: pipe-B-eDP-1-size-64
[111.369986] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.293s)
[111.394274] Starting dynamic subtest: pipe-B-eDP-1-size-128
[113.961016] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.572s)
[113.984539] Starting dynamic subtest: pipe-B-eDP-1-size-256
[116.517067] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.539s)
[116.831821] Starting dynamic subtest: pipe-C-eDP-1-size-64
[119.765594] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.944s)
[119.793681] Starting dynamic subtest: pipe-C-eDP-1-size-128
[121.999480] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[122.024845] Starting dynamic subtest: pipe-C-eDP-1-size-256
[124.244079] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[124.561316] Starting dynamic subtest: pipe-D-eDP-1-size-64
[127.534574] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.983s)
[127.561975] Starting dynamic subtest: pipe-D-eDP-1-size-128
[129.734285] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[129.759938] Starting dynamic subtest: pipe-D-eDP-1-size-256
[131.935854] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[132.240385] Subtest primary: SUCCESS (32.257s)
[133.116960] [035/133] (885s left) kms_psr (fbc-pr-primary-render)
[133.216192] Starting subtest: fbc-pr-primary-render
[133.220308] Subtest fbc-pr-primary-render: SKIP (0.000s)
[133.299122] [036/133] (885s left) gem_lmem_swapping (parallel-random)
[133.339059] Subtest parallel-random: SKIP (0.000s)
[133.383622] [037/133] (885s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[133.440821] Starting subtest: invalid-multi-wait-unsubmitted
[133.443091] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[133.529429] [038/133] (885s left) kms_cursor_crc (cursor-random-64x21)
[133.716451] Starting subtest: cursor-random-64x21
[133.764069] Subtest cursor-random-64x21: SKIP (0.043s)
[134.006513] [039/133] (884s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[134.099213] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[134.101033] Starting dynamic subtest: pipe-A-eDP-1
[136.290616] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.191s)
[136.298589] Starting dynamic subtest: pipe-B-eDP-1
[138.734498] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.442s)
[138.743440] Starting dynamic subtest: pipe-C-eDP-1
[140.883967] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.149s)
[140.892282] Starting dynamic subtest: pipe-D-eDP-1
[142.965338] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.080s)
[142.967242] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.868s)
[144.163274] [040/133] (874s left) gem_caching (read-writes)
[144.214377] Subtest read-writes: SKIP (0.000s)
[144.283672] [041/133] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[144.383119] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[144.387710] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[144.490580] [042/133] (874s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[144.595072] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[149.002076] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.410s)
[150.170969] [043/133] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[150.267885] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[157.642829] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.378s)
[157.765814] [044/133] (861s left) gem_ctx_persistence (engines-mixed)
[157.815753] Starting subtest: engines-mixed
[157.818043] Starting dynamic subtest: rcs0
[157.859073] Dynamic subtest rcs0: SUCCESS (0.043s)
[157.867839] Starting dynamic subtest: bcs0
[157.942086] Dynamic subtest bcs0: SUCCESS (0.081s)
[157.951283] Starting dynamic subtest: vcs0
[158.011928] Dynamic subtest vcs0: SUCCESS (0.068s)
[158.022110] Starting dynamic subtest: vcs1
[158.065979] Dynamic subtest vcs1: SUCCESS (0.051s)
[158.075516] Starting dynamic subtest: vecs0
[158.112592] Dynamic subtest vecs0: SUCCESS (0.045s)
[158.121928] Starting dynamic subtest: ccs0
[158.170719] Dynamic subtest ccs0: SUCCESS (0.056s)
[158.173699] Subtest engines-mixed: SUCCESS (0.356s)
[158.249386] [045/133] (860s left) gen7_exec_parse (basic-offset)
[158.300719] Subtest basic-offset: SKIP (0.000s)
[158.364308] [046/133] (860s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[158.458163] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[158.462247] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[158.569885] [047/133] (860s left) gem_exec_whisper (basic-fds-forked-all)
[158.626137] Starting subtest: basic-fds-forked-all
[178.633796] Subtest basic-fds-forked-all: SUCCESS (20.004s)
[178.826852] [048/133] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[178.924296] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[178.928605] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[179.014191] [049/133] (840s left) kms_joiner (invalid-modeset-force-big-joiner)
[179.110961] Starting subtest: invalid-modeset-force-big-joiner
[179.115261] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[179.201646] [050/133] (839s left) gem_mmap_gtt (big-bo)
[179.254273] Subtest big-bo: SKIP (0.000s)
[179.310662] [051/133] (839s left) gem_exec_alignment (many)
[179.362907] Starting subtest: many
[202.246301] Subtest many: SUCCESS (22.880s)
[203.887589] [052/133] (815s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[203.999879] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[204.101765] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s)
[204.183278] [053/133] (815s left) gem_render_copy (y-tiled)
[204.251355] Starting subtest: y-tiled
[204.255759] Subtest y-tiled: SKIP (0.000s)
[204.434451] [054/133] (814s left) gem_mmap_wc (write-wc-read-gtt)
[204.490179] Subtest write-wc-read-gtt: SKIP (0.000s)
[204.554829] [055/133] (814s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[204.655780] Starting subtest: fb-8bpc-vs-panel-6bpc
[204.658087] Starting dynamic subtest: pipe-A-eDP-1
[206.044668] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.389s)
[206.046979] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.391s)
[206.832377] [056/133] (812s left) kms_vblank (wait-forked-hang)
[206.922020] Starting subtest: wait-forked-hang
[206.924085] Starting dynamic subtest: pipe-A-eDP-1
[234.044082] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.121s)
[234.062041] Starting dynamic subtest: pipe-D-eDP-1
[249.042234] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.993s)
[249.044292] Subtest wait-forked-hang: SUCCESS (42.119s)
[249.881154] [057/133] (769s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[249.974302] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[254.347471] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.377s)
[255.480092] [058/133] (763s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[255.584421] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[256.208120] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.625s)
[256.370104] [059/133] (763s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[256.464585] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[260.599042] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.137s)
[261.778567] [060/133] (757s left) sw_sync (sync_merge_same)
[261.811648] Starting subtest: sync_merge_same
[261.813543] Subtest sync_merge_same: SUCCESS (0.000s)
[261.861256] [061/133] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[261.954961] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[261.959244] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[262.060210] [062/133] (757s left) kms_busy (basic)
[262.145123] Starting subtest: basic
[262.147466] Starting dynamic subtest: flip
[262.733538] Dynamic subtest flip: SUCCESS (0.586s)
[262.743467] Starting dynamic subtest: modeset
[266.193219] Dynamic subtest modeset: SUCCESS (3.461s)
[266.195537] Subtest basic: SUCCESS (4.050s)
[266.996452] [063/133] (752s left) gem_lmem_swapping (verify-random-ccs)
[267.039879] Subtest verify-random-ccs: SKIP (0.000s)
[267.080974] [064/133] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[267.174616] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[267.178681] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[267.288421] [065/133] (752s left) kms_prop_blob (blob-multiple)
[267.336057] Starting subtest: blob-multiple
[267.338346] Subtest blob-multiple: SUCCESS (0.002s)
[267.454063] [066/133] (752s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[267.550254] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[267.554364] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[267.634432] [067/133] (752s left) kms_psr (fbc-pr-primary-mmap-cpu)
[267.733515] Starting subtest: fbc-pr-primary-mmap-cpu
[267.737705] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[267.804584] [068/133] (752s left) gem_mmap_gtt (zero-extend)
[267.853223] Subtest zero-extend: SKIP (0.000s)
[267.911415] [069/133] (751s left) gem_exec_fence (syncobj-timeline-export)
[268.483843] Starting subtest: syncobj-timeline-export
[268.490088] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[270.368216] [070/133] (749s left) kms_psr (fbc-psr-sprite-plane-onoff)
[270.462109] Starting subtest: fbc-psr-sprite-plane-onoff
[270.464480] Starting dynamic subtest: eDP-1
[270.468948] Dynamic subtest eDP-1: SKIP (0.000s)
[270.473475] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[270.544737] [071/133] (749s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[270.635414] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[270.637620] Starting dynamic subtest: pipe-A-eDP-1
[270.661104] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[270.673149] Starting dynamic subtest: pipe-B-eDP-1
[270.694980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[270.704645] Starting dynamic subtest: pipe-C-eDP-1
[270.726460] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[270.735996] Starting dynamic subtest: pipe-D-eDP-1
[270.757988] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[270.762135] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[272.773554] [072/133] (747s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[272.894221] Starting subtest: cursorA-vs-flipA-legacy
[284.021083] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.124s)
[284.845243] [073/133] (735s left) kms_atomic_interruptible (legacy-setmode)
[284.935383] Starting subtest: legacy-setmode
[284.937737] Starting dynamic subtest: pipe-A-eDP-1
[291.846939] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.912s)
[291.849409] Subtest legacy-setmode: SUCCESS (6.913s)
[292.712399] [074/133] (727s left) i915_pm_rps (reset)
[292.780676] Starting subtest: reset
[301.228815] Subtest reset: SUCCESS (8.445s)
[301.363980] [075/133] (718s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[301.450911] Starting subtest: crc-primary-suspend-y-tiled-ccs
[301.453275] Starting dynamic subtest: pipe-A-eDP-1
[301.462852] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[301.475801] Starting dynamic subtest: pipe-B-eDP-1
[301.485315] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[301.494601] Starting dynamic subtest: pipe-C-eDP-1
[301.503261] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[301.512690] Starting dynamic subtest: pipe-D-eDP-1
[301.521765] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[301.526178] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[303.665912] [076/133] (716s left) kms_addfb_basic (small-bo)
[303.769809] Starting subtest: small-bo
[303.772073] Subtest small-bo: SUCCESS (0.000s)
[303.870348] [077/133] (716s left) kms_addfb_basic (invalid-get-prop-any)
[303.921591] Starting subtest: invalid-get-prop-any
[303.923891] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[304.063613] [078/133] (716s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[304.167423] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[304.179031] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[304.256464] [079/133] (716s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[304.346747] Starting subtest: psr-indfb-scaledprimary
[310.144621] Subtest psr-indfb-scaledprimary: SUCCESS (5.801s)
[310.269018] [080/133] (710s left) gem_close (many-handles-one-vma)
[310.331264] Starting subtest: many-handles-one-vma
[310.355855] Subtest many-handles-one-vma: SUCCESS (0.025s)
[310.484248] [081/133] (709s left) kms_plane (plane-panning-bottom-right)
[310.575479] Starting subtest: plane-panning-bottom-right
[310.577459] Starting dynamic subtest: pipe-A
[312.285430] Dynamic subtest pipe-A: SUCCESS (1.708s)
[312.295155] Starting dynamic subtest: pipe-B
[314.633905] Dynamic subtest pipe-B: SUCCESS (2.346s)
[314.635958] Subtest plane-panning-bottom-right: SUCCESS (4.057s)
[315.454249] [082/133] (704s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[315.569722] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[315.574464] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[315.723900] [083/133] (704s left) kms_cursor_edge_walk (128x128-top-edge)
[315.813078] Starting subtest: 128x128-top-edge
[315.815377] Starting dynamic subtest: pipe-A-eDP-1
[319.315075] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[319.325648] Starting dynamic subtest: pipe-D-eDP-1
[322.440328] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[322.442736] Subtest 128x128-top-edge: SUCCESS (6.629s)
[323.236029] [084/133] (697s left) gen7_exec_parse (chained-batch)
[323.299942] Subtest chained-batch: SKIP (0.000s)
[323.367910] [085/133] (697s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[323.458583] Starting subtest: primary-yf-tiled-reflect-x-180
[323.529703] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.070s)
[323.632966] [086/133] (696s left) kms_frontbuffer_tracking (fbc-tiling-y)
[323.735213] Starting subtest: fbc-tiling-y
[323.739512] Subtest fbc-tiling-y: SKIP (0.000s)
[323.855934] [087/133] (696s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[323.912021] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[324.013741] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[324.121976] [088/133] (696s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[324.206968] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[324.211247] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[324.313074] [089/133] (696s left) kms_cursor_crc (cursor-onscreen-64x21)
[324.517492] Starting subtest: cursor-onscreen-64x21
[324.564695] Subtest cursor-onscreen-64x21: SKIP (0.043s)
[324.817083] [090/133] (695s left) kms_rmfb (close-fd)
[324.920532] Starting subtest: close-fd
[324.922912] Starting dynamic subtest: pipe-A-eDP-1
[325.025727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[325.037301] Starting dynamic subtest: pipe-B-eDP-1
[326.193779] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[326.204597] Starting dynamic subtest: pipe-C-eDP-1
[327.319268] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[327.328946] Starting dynamic subtest: pipe-D-eDP-1
[328.447729] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[328.449658] Subtest close-fd: SUCCESS (3.530s)
[329.659963] [091/133] (691s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[329.772731] Starting subtest: 2x-long-cursor-vs-flip-legacy
[329.777396] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[329.920661] [092/133] (690s left) gem_softpin (evict-prime-sanity-check)
[329.979975] Starting subtest: evict-prime-sanity-check
[329.982158] Starting dynamic subtest: rcs0
[331.142959] Dynamic subtest rcs0: SUCCESS (1.162s)
[331.157587] Starting dynamic subtest: bcs0
[332.258888] Dynamic subtest bcs0: SUCCESS (1.113s)
[332.269424] Starting dynamic subtest: vcs0
[334.250087] Dynamic subtest vcs0: SUCCESS (1.988s)
[334.261925] Starting dynamic subtest: vcs1
[336.320586] Dynamic subtest vcs1: SUCCESS (2.068s)
[336.330682] Starting dynamic subtest: vecs0
[338.300586] Dynamic subtest vecs0: SUCCESS (1.978s)
[338.313990] Starting dynamic subtest: ccs0
[339.415639] Dynamic subtest ccs0: SUCCESS (1.114s)
[339.425344] Starting dynamic subtest: all
[340.552044] Dynamic subtest all: SUCCESS (1.135s)
[340.554612] Subtest evict-prime-sanity-check: SUCCESS (10.573s)
[340.645629] [093/133] (680s left) kms_psr (pr-basic)
[340.739016] Starting subtest: pr-basic
[340.743562] Subtest pr-basic: SKIP (0.000s)
[340.811404] [094/133] (680s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[340.868747] Starting subtest: multi-wait-all-for-submit-signaled
[340.871017] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[340.994635] [095/133] (679s left) i915_drm_fdinfo (busy-idle)
[341.038734] Starting subtest: busy-idle
[341.040626] Starting dynamic subtest: rcs0
[341.064548] Dynamic subtest rcs0: SKIP (0.026s)
[341.076610] Starting dynamic subtest: bcs0
[341.080739] Dynamic subtest bcs0: SKIP (0.000s)
[341.091325] Starting dynamic subtest: vcs0
[341.095798] Dynamic subtest vcs0: SKIP (0.000s)
[341.104668] Starting dynamic subtest: vcs1
[341.108766] Dynamic subtest vcs1: SKIP (0.000s)
[341.117656] Starting dynamic subtest: vecs0
[341.121699] Dynamic subtest vecs0: SKIP (0.000s)
[341.130603] Starting dynamic subtest: ccs0
[341.134709] Dynamic subtest ccs0: SKIP (0.000s)
[341.138780] Subtest busy-idle: SKIP (0.031s)
[341.176653] [096/133] (679s left) kms_plane_scaling (planes-downscale-factor-0-5)
[341.265556] Starting subtest: planes-downscale-factor-0-5
[341.267758] Starting dynamic subtest: pipe-A
[341.286401] Dynamic subtest pipe-A: SKIP (0.018s)
[341.298308] Starting dynamic subtest: pipe-B
[341.318245] Dynamic subtest pipe-B: SKIP (0.031s)
[341.328301] Starting dynamic subtest: pipe-C
[341.348279] Dynamic subtest pipe-C: SKIP (0.031s)
[341.358165] Starting dynamic subtest: pipe-D
[341.378529] Dynamic subtest pipe-D: SKIP (0.030s)
[341.382188] Subtest planes-downscale-factor-0-5: SKIP (0.113s)
[341.490790] [097/133] (679s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[341.587143] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[341.590921] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[341.690196] [098/133] (679s left) gem_ccs (large-ctrl-surf-copy)
[341.754106] Starting subtest: large-ctrl-surf-copy
[341.757617] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[341.878960] [099/133] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[341.972206] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[341.975613] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[342.069394] [100/133] (679s left) perf_pmu (invalid-open)
[342.111370] Starting subtest: invalid-open
[342.113185] Subtest invalid-open: SUCCESS (0.000s)
[342.212982] [101/133] (678s left) gem_exec_balancer (nop)
[342.275280] Starting subtest: nop
[389.006220] Subtest nop: SUCCESS (46.729s)
[389.303106] [102/133] (631s left) vgem_basic (bad-pad)
[389.351680] Starting subtest: bad-pad
[389.353590] Subtest bad-pad: SUCCESS (0.000s)
[389.407014] [103/133] (631s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[389.505855] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[389.507700] Starting dynamic subtest: pipe-A-eDP-1
[390.798401] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.292s)
[391.082779] Starting dynamic subtest: pipe-B-eDP-1
[392.114317] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s)
[392.379982] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.875s)
[393.220691] [104/133] (628s left) kms_atomic_transition (modeset-transition)
[393.307572] Starting subtest: modeset-transition
[393.309558] Starting dynamic subtest: 1x-outputs
[404.167290] Dynamic subtest 1x-outputs: SUCCESS (10.859s)
[404.169782] Subtest modeset-transition: SUCCESS (10.861s)
[405.026291] [105/133] (616s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[405.413240] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[406.235717] [106/133] (615s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[406.279442] Starting subtest: multi-wait-available-unsubmitted-submitted
[406.281421] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[406.366972] [107/133] (615s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[406.409993] Starting subtest: yf-tiled-ccs-to-x-tiled
[406.414309] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[406.604582] [108/133] (614s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[406.692354] Starting subtest: addfb25-y-tiled-legacy
[406.694659] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[406.789594] [109/133] (614s left) sw_sync (timeline_closed_signaled)
[406.821936] Starting subtest: timeline_closed_signaled
[406.824475] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[406.873466] [110/133] (614s left) kms_cdclk (mode-transition)
[406.960181] Starting subtest: mode-transition
[406.962492] Starting dynamic subtest: pipe-A-eDP-1
[407.254186] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[407.267207] Starting dynamic subtest: pipe-B-eDP-1
[407.271769] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[407.281456] Starting dynamic subtest: pipe-C-eDP-1
[407.285824] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[407.295079] Starting dynamic subtest: pipe-D-eDP-1
[407.299225] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[407.303600] Subtest mode-transition: SKIP (0.301s)
[408.091438] [111/133] (613s left) gem_exec_reloc (basic-wc-read)
[408.138546] Subtest basic-wc-read: SKIP (0.000s)
[408.197291] [112/133] (613s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[408.282170] Starting subtest: plane-lut1d-ctm3x4
[408.428022] Starting dynamic subtest: pipe-A-plane-0
[408.616666] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[408.631675] Starting dynamic subtest: pipe-A-plane-1
[408.806092] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[408.815984] Starting dynamic subtest: pipe-A-plane-2
[408.972453] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[410.215100] Starting dynamic subtest: pipe-B-plane-0
[410.373762] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[410.383886] Starting dynamic subtest: pipe-B-plane-1
[410.563360] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[410.573426] Starting dynamic subtest: pipe-B-plane-2
[410.720225] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[411.910288] Starting dynamic subtest: pipe-C-plane-0
[412.046329] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[412.057434] Starting dynamic subtest: pipe-C-plane-1
[412.191123] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[412.201069] Starting dynamic subtest: pipe-C-plane-2
[412.346284] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[413.533568] Starting dynamic subtest: pipe-D-plane-0
[413.680739] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[413.691235] Starting dynamic subtest: pipe-D-plane-1
[413.814415] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[413.828224] Starting dynamic subtest: pipe-D-plane-2
[413.980842] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[414.264937] Subtest plane-lut1d-ctm3x4: SUCCESS (5.985s)
[415.104750] [113/133] (606s left) kms_pm_rpm (drm-resources-equal)
[416.630193] Starting subtest: drm-resources-equal
[421.997932] Subtest drm-resources-equal: SUCCESS (5.366s)
[422.084441] [114/133] (599s left) perf (i915-ref-count)
[422.154774] Starting subtest: i915-ref-count
[422.215947] Subtest i915-ref-count: SUCCESS (0.059s)
[422.276603] [115/133] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[422.377597] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[429.227103] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.852s)
[429.329602] [116/133] (592s left) api_intel_bb (bb-with-allocator)
[429.388451] Starting subtest: bb-with-allocator
[429.390841] Subtest bb-with-allocator: SUCCESS (0.005s)
[429.528759] [117/133] (592s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[429.633227] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[429.637609] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[429.702652] [118/133] (592s left) gem_tiled_blits (normal)
[429.759373] Subtest normal: SKIP (0.000s)
[429.832256] [119/133] (592s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[429.929068] Starting subtest: pixel-format-y-tiled-ccs-modifier
[429.932940] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[430.015022] [120/133] (591s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[430.135462] Starting subtest: cursorA-vs-flipB-varying-size
[430.139967] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[430.275757] [121/133] (591s left) gem_mmap_wc (write-cpu-read-wc)
[430.338880] Subtest write-cpu-read-wc: SKIP (0.000s)
[430.390116] [122/133] (591s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[430.486946] Starting subtest: pr-plane-move-sf-dmg-area
[430.490427] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[430.554444] [123/133] (591s left) kms_legacy_colorkey (invalid-plane)
[430.636739] Starting subtest: invalid-plane
[430.638709] Starting dynamic subtest: zero-id
[430.640494] Dynamic subtest zero-id: SUCCESS (0.000s)
[430.651313] Starting dynamic subtest: outrange-id
[430.652870] Dynamic subtest outrange-id: SUCCESS (0.000s)
[430.654462] Subtest invalid-plane: SUCCESS (0.001s)
[430.709186] [124/133] (591s left) kms_properties (colorop-properties-legacy)
[430.794070] Starting subtest: colorop-properties-legacy
[430.796083] Starting dynamic subtest: pipe-A-eDP-1
[431.152043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s)
[431.162761] Starting dynamic subtest: pipe-B-eDP-1
[432.183706] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.032s)
[432.194594] Starting dynamic subtest: pipe-C-eDP-1
[433.211426] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.025s)
[433.221274] Starting dynamic subtest: pipe-D-eDP-1
[434.252054] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.039s)
[434.254477] Subtest colorop-properties-legacy: SUCCESS (3.459s)
[435.069488] [125/133] (587s left) gem_create (create-valid-nonaligned)
[435.126219] Starting subtest: create-valid-nonaligned
[435.128425] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[435.312198] [126/133] (586s left) gem_render_copy_redux (flink-interruptible)
[435.371804] Starting subtest: flink-interruptible
[436.211743] Subtest flink-interruptible: SUCCESS (0.841s)
[436.354519] [127/133] (585s left) kms_psr (psr-basic)
[436.447548] Starting subtest: psr-basic
[436.449466] Starting dynamic subtest: eDP-1
[438.041418] Dynamic subtest eDP-1: SUCCESS (1.592s)
[438.043634] Subtest psr-basic: SUCCESS (1.593s)
[438.914962] [128/133] (583s left) kms_psr (psr-primary-render)
[439.009154] Starting subtest: psr-primary-render
[439.011434] Starting dynamic subtest: eDP-1
[440.730447] Dynamic subtest eDP-1: SUCCESS (1.721s)
[440.732835] Subtest psr-primary-render: SUCCESS (1.722s)
[441.597975] [129/133] (580s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[441.700242] Starting subtest: yf-tiled-64bpp-rotate-90
[441.704279] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[441.791771] [130/133] (580s left) gem_exec_schedule (pi-shared-iova)
[441.966074] Starting subtest: pi-shared-iova
[441.968434] Starting dynamic subtest: rcs0
[442.043207] Dynamic subtest rcs0: SUCCESS (0.080s)
[442.056865] Starting dynamic subtest: vcs0
[442.107463] Dynamic subtest vcs0: SUCCESS (0.063s)
[442.120546] Starting dynamic subtest: vcs1
[442.168240] Dynamic subtest vcs1: SUCCESS (0.058s)
[442.183427] Starting dynamic subtest: vecs0
[442.231882] Dynamic subtest vecs0: SUCCESS (0.061s)
[442.247972] Starting dynamic subtest: ccs0
[442.298117] Dynamic subtest ccs0: SUCCESS (0.066s)
[442.300760] Subtest pi-shared-iova: SUCCESS (0.337s)
[443.446436] [131/133] (578s left) gem_exec_reloc (basic-active)
[443.501806] Subtest basic-active: SKIP (0.000s)
[443.575305] [132/133] (578s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[443.968577] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[444.806390] [133/133] (577s left) prime_busy (hang-wait)
[444.864525] Starting subtest: hang-wait
[444.866730] Starting dynamic subtest: rcs0
[470.748392] Dynamic subtest rcs0: SUCCESS (25.883s)
[470.757684] Starting dynamic subtest: bcs0
[477.912414] Dynamic subtest bcs0: SUCCESS (7.161s)
[477.922511] Starting dynamic subtest: vcs0
[484.879434] Dynamic subtest vcs0: SUCCESS (6.964s)
[484.891613] Starting dynamic subtest: vcs1
[491.924708] Dynamic subtest vcs1: SUCCESS (7.045s)
[491.936415] Starting dynamic subtest: vecs0
[498.891697] Dynamic subtest vecs0: SUCCESS (6.964s)
[498.903340] Starting dynamic subtest: ccs0
[512.735764] Dynamic subtest ccs0: SUCCESS (13.842s)
[512.739054] Subtest hang-wait: SUCCESS (67.870s)
[512.864179] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_feature_discovery
results: parsing output: 2/ for test: kms_vrr
results: parsing output: 3/ for test: sw_sync
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_caching
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_sequence
results: parsing output: 13/ for test: core_getstats
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_plane_alpha_blend
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: dmabuf
results: parsing output: 19/ for test: gem_ctx_engines
results: parsing output: 20/ for test: kms_properties
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: gem_mmap_wc
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: i915_suspend
results: parsing output: 30/ for test: i915_hangman
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_plane_cursor
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_lmem_swapping
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_caching
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: gen7_exec_parse
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_joiner
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: gem_exec_alignment
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gem_mmap_wc
results: parsing output: 54/ for test: kms_dither
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_busy
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_atomic_interruptible
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_close
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: gen7_exec_parse
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_rmfb
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_softpin
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_ccs
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_atomic_transition
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: sw_sync
results: parsing output: 109/ for test: kms_cdclk
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_color_pipeline
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: gem_tiled_blits
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_legacy_colorkey
results: parsing output: 123/ for test: kms_properties
results: parsing output: 124/ for test: gem_create
results: parsing output: 125/ for test: gem_render_copy_redux
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_chamelium_edid
results: parsing output: 132/ for test: prime_busy
Done.