[56.339537] Initializing watchdogs
[56.339579]   /dev/watchdog0
[56.353747] [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.358214] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.360429] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.363989] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[56.486237] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[56.490341] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[56.586823] [002/133] (960s left) kms_feature_discovery (display-1x)
[56.683887] Starting subtest: display-1x
[56.686168] Subtest display-1x: SUCCESS (0.000s)
[56.756978] [003/133] (960s left) kms_vrr (flipline)
[56.853315] Starting subtest: flipline
[56.859527] Subtest flipline: SKIP (0.000s)
[56.921290] [004/133] (960s left) sw_sync (sync_busy_fork_unixsocket)
[56.954582] Starting subtest: sync_busy_fork_unixsocket
[56.961375] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[57.009757] [005/133] (960s left) kms_rotation_crc (bad-tiling)
[57.090373] Starting subtest: bad-tiling
[57.095040] Subtest bad-tiling: SKIP (0.001s)
[57.173900] [006/133] (959s left) gem_exec_reloc (basic-cpu-active)
[57.243551] Subtest basic-cpu-active: SKIP (0.000s)
[57.303770] [007/133] (959s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[57.360076] Starting subtest: y-tiled-ccs-to-yf-tiled
[57.363799] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[57.553256] [008/133] (959s left) gem_exec_fence (basic-busy)
[57.734738] Starting subtest: basic-busy
[57.737249] Starting dynamic subtest: rcs0
[57.811805] Dynamic subtest rcs0: SUCCESS (0.077s)
[57.821793] Starting dynamic subtest: bcs0
[57.867635] Dynamic subtest bcs0: SUCCESS (0.055s)
[57.876084] Starting dynamic subtest: vcs0
[57.925218] Dynamic subtest vcs0: SUCCESS (0.056s)
[57.933234] Starting dynamic subtest: vcs1
[57.976965] Dynamic subtest vcs1: SUCCESS (0.052s)
[57.986778] Starting dynamic subtest: vecs0
[58.036862] Dynamic subtest vecs0: SUCCESS (0.059s)
[58.046063] Starting dynamic subtest: ccs0
[58.089468] Dynamic subtest ccs0: SUCCESS (0.051s)
[58.091909] Subtest basic-busy: SUCCESS (0.356s)
[60.368446] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[60.372219] [009/133] (956s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[60.477697] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[60.481996] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[60.574748] [010/133] (956s left) gem_caching (writes)
[60.640202] Subtest writes: SKIP (0.000s)
[60.707215] [011/133] (956s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[60.758654] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[60.760878] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[60.859942] [012/133] (956s left) syncobj_timeline (wait-all-for-submit-snapshot)
[60.909530] Starting subtest: wait-all-for-submit-snapshot
[60.991345] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[61.089385] [013/133] (956s left) kms_sequence (queue-busy)
[61.176869] Starting subtest: queue-busy
[61.179173] Starting dynamic subtest: pipe-A-eDP-1
[63.910820] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.729s)
[63.920724] Starting dynamic subtest: pipe-B-eDP-1
[66.044400] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.134s)
[66.052738] Starting dynamic subtest: pipe-C-eDP-1
[68.649158] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.603s)
[68.661897] Starting dynamic subtest: pipe-D-eDP-1
[71.195531] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[71.197853] Subtest queue-busy: SUCCESS (10.015s)
[72.068055] [014/133] (945s left) core_getstats (basic)
[72.132557] Starting subtest: basic
[72.134789] Subtest basic: SUCCESS (0.000s)
[72.222738] [015/133] (945s left) gem_exec_schedule (timeslicing)
[72.316223] Starting subtest: timeslicing
[72.318582] Starting dynamic subtest: rcs0
[72.330543] Dynamic subtest rcs0: SUCCESS (0.023s)
[72.341888] Starting dynamic subtest: bcs0
[72.351870] Dynamic subtest bcs0: SUCCESS (0.021s)
[72.359940] Starting dynamic subtest: vcs0
[72.375905] Dynamic subtest vcs0: SUCCESS (0.023s)
[72.386691] Starting dynamic subtest: vcs1
[72.401479] Dynamic subtest vcs1: SUCCESS (0.026s)
[72.410006] Starting dynamic subtest: vecs0
[72.425729] Dynamic subtest vecs0: SUCCESS (0.023s)
[72.434177] Starting dynamic subtest: ccs0
[72.448666] Dynamic subtest ccs0: SUCCESS (0.022s)
[72.451406] Subtest timeslicing: SUCCESS (0.142s)
[74.363859] [016/133] (943s left) kms_plane_alpha_blend (constant-alpha-min)
[74.450658] Starting subtest: constant-alpha-min
[74.734360] Starting dynamic subtest: pipe-A-eDP-1
[75.451284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[75.459985] Starting dynamic subtest: pipe-D-eDP-1
[76.972802] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.519s)
[76.975066] Subtest constant-alpha-min: SUCCESS (2.521s)
[77.844750] [017/133] (939s left) kms_addfb_basic (unused-modifier)
[77.908284] Starting subtest: unused-modifier
[77.910463] Subtest unused-modifier: SUCCESS (0.000s)
[78.055358] [018/133] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[78.162101] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[78.166601] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[78.277801] [019/133] (939s left) dmabuf (all-tests)
[78.312970] Starting subtest: all-tests
[78.318205] Subtest all-tests: SKIP (0.000s)
[78.362033] [020/133] (939s left) gem_ctx_engines (execute-oneforall)
[78.425092] Starting subtest: execute-oneforall
[78.896907] Subtest execute-oneforall: SUCCESS (0.472s)
[80.437085] [021/133] (937s left) kms_properties (crtc-properties-legacy)
[80.521255] Starting subtest: crtc-properties-legacy
[80.523586] Starting dynamic subtest: pipe-A-eDP-1
[80.989290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.469s)
[80.998242] Starting dynamic subtest: pipe-B-eDP-1
[82.839738] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.846s)
[82.849753] Starting dynamic subtest: pipe-C-eDP-1
[83.512426] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.673s)
[83.520367] Starting dynamic subtest: pipe-D-eDP-1
[84.633229] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[84.635679] Subtest crtc-properties-legacy: SUCCESS (4.112s)
[85.445351] [022/133] (932s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[85.538125] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[85.542763] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[85.632893] [023/133] (932s left) kms_addfb_basic (bad-pitch-256)
[85.684564] Starting subtest: bad-pitch-256
[85.686847] Subtest bad-pitch-256: SUCCESS (0.000s)
[85.800911] [024/133] (931s left) kms_big_fb (x-tiled-addfb-size-overflow)
[85.902726] Starting subtest: x-tiled-addfb-size-overflow
[85.905081] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[86.009960] [025/133] (931s left) gem_ctx_persistence (hang)
[86.079772] Starting subtest: hang
[86.084501] Subtest hang: SKIP (0.000s)
[86.187220] [026/133] (931s left) gem_mmap_wc (close)
[86.244123] Subtest close: SKIP (0.000s)
[86.305349] [027/133] (931s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[86.396843] Starting subtest: bad-rotation-90-yf-tiled-ccs
[86.398923] Starting dynamic subtest: pipe-A-eDP-1
[86.418752] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[86.426872] Starting dynamic subtest: pipe-B-eDP-1
[86.445198] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[86.452297] Starting dynamic subtest: pipe-C-eDP-1
[86.470064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[86.477138] Starting dynamic subtest: pipe-D-eDP-1
[86.495273] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[86.498652] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[88.718962] [028/133] (929s left) sw_sync (alloc_fence)
[88.755386] Starting subtest: alloc_fence
[88.757383] Subtest alloc_fence: SUCCESS (0.000s)
[88.816054] [029/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[88.906568] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[88.911146] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[89.014492] [030/133] (929s left) i915_suspend (fence-restore-tiled2untiled)
[89.069866] Starting subtest: fence-restore-tiled2untiled
[89.074569] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[89.157672] [031/133] (928s left) i915_hangman (gt-engine-error)
[89.228198] Starting subtest: gt-engine-error
[89.230536] Starting dynamic subtest: rcs0
[90.276396] Dynamic subtest rcs0: SUCCESS (1.046s)
[90.289813] Starting dynamic subtest: bcs0
[92.263867] Dynamic subtest bcs0: SUCCESS (1.980s)
[92.273961] Starting dynamic subtest: vcs0
[94.241920] Dynamic subtest vcs0: SUCCESS (1.983s)
[94.252718] Starting dynamic subtest: vcs1
[96.290563] Dynamic subtest vcs1: SUCCESS (2.047s)
[96.302166] Starting dynamic subtest: vecs0
[98.279585] Dynamic subtest vecs0: SUCCESS (1.988s)
[98.290364] Starting dynamic subtest: ccs0
[100.258036] Dynamic subtest ccs0: SUCCESS (1.977s)
[100.260538] Subtest gt-engine-error: SUCCESS (11.029s)
[100.338966] [032/133] (917s left) kms_content_protection (dp-mst-type-1)
[100.497115] Starting subtest: dp-mst-type-1
[100.501739] Subtest dp-mst-type-1: SKIP (0.000s)
[100.632746] [033/133] (917s left) kms_big_fb (linear-32bpp-rotate-90)
[100.737079] Starting subtest: linear-32bpp-rotate-90
[100.755992] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[100.882039] [034/133] (917s left) kms_plane_cursor (primary)
[100.978210] Starting subtest: primary
[100.982839] Starting dynamic subtest: pipe-A-eDP-1-size-64
[103.570403] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.595s)
[103.595706] Starting dynamic subtest: pipe-A-eDP-1-size-128
[106.205640] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.617s)
[106.230488] Starting dynamic subtest: pipe-A-eDP-1-size-256
[108.785214] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.561s)
[109.105637] Starting dynamic subtest: pipe-B-eDP-1-size-64
[112.439278] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.345s)
[112.462107] Starting dynamic subtest: pipe-B-eDP-1-size-128
[115.050637] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[115.074552] Starting dynamic subtest: pipe-B-eDP-1-size-256
[117.673931] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.605s)
[117.990917] Starting dynamic subtest: pipe-C-eDP-1-size-64
[120.882058] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.902s)
[120.912253] Starting dynamic subtest: pipe-C-eDP-1-size-128
[123.137513] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[123.162507] Starting dynamic subtest: pipe-C-eDP-1-size-256
[125.336980] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[125.654357] Starting dynamic subtest: pipe-D-eDP-1-size-64
[128.644230] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.000s)
[128.669608] Starting dynamic subtest: pipe-D-eDP-1-size-128
[130.876523] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[130.901844] Starting dynamic subtest: pipe-D-eDP-1-size-256
[133.109654] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[133.417974] Subtest primary: SUCCESS (32.441s)
[134.240166] [035/133] (883s left) kms_psr (fbc-pr-primary-render)
[134.338431] Starting subtest: fbc-pr-primary-render
[134.342688] Subtest fbc-pr-primary-render: SKIP (0.000s)
[134.409796] [036/133] (883s left) gem_lmem_swapping (parallel-random)
[134.457186] Subtest parallel-random: SKIP (0.000s)
[134.495160] [037/133] (883s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[134.549166] Starting subtest: invalid-multi-wait-unsubmitted
[134.551476] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[134.638663] [038/133] (883s left) kms_cursor_crc (cursor-random-64x21)
[134.839250] Starting subtest: cursor-random-64x21
[134.887041] Subtest cursor-random-64x21: SKIP (0.045s)
[135.137503] [039/133] (883s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[135.233255] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[135.234979] Starting dynamic subtest: pipe-A-eDP-1
[137.525466] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.293s)
[137.533888] Starting dynamic subtest: pipe-B-eDP-1
[139.903472] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.374s)
[139.915141] Starting dynamic subtest: pipe-C-eDP-1
[142.159920] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.258s)
[142.169756] Starting dynamic subtest: pipe-D-eDP-1
[144.341729] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.181s)
[144.343597] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.112s)
[145.580537] [040/133] (872s left) gem_caching (read-writes)
[145.651959] Subtest read-writes: SKIP (0.000s)
[145.730182] [041/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[145.819478] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[145.823536] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[145.919884] [042/133] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[146.015414] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[150.384817] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.373s)
[151.569725] [043/133] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[151.670473] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[158.938207] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.274s)
[159.064126] [044/133] (859s left) gem_ctx_persistence (engines-mixed)
[159.128249] Starting subtest: engines-mixed
[159.130543] Starting dynamic subtest: rcs0
[159.236306] Dynamic subtest rcs0: SUCCESS (0.107s)
[159.247678] Starting dynamic subtest: bcs0
[159.296823] Dynamic subtest bcs0: SUCCESS (0.058s)
[159.307669] Starting dynamic subtest: vcs0
[159.343844] Dynamic subtest vcs0: SUCCESS (0.045s)
[159.353643] Starting dynamic subtest: vcs1
[159.390499] Dynamic subtest vcs1: SUCCESS (0.045s)
[159.399814] Starting dynamic subtest: vecs0
[159.451621] Dynamic subtest vecs0: SUCCESS (0.059s)
[159.461667] Starting dynamic subtest: ccs0
[159.515869] Dynamic subtest ccs0: SUCCESS (0.062s)
[159.518566] Subtest engines-mixed: SUCCESS (0.389s)
[159.593490] [045/133] (859s left) gen7_exec_parse (basic-offset)
[159.651597] Subtest basic-offset: SKIP (0.000s)
[159.713916] [046/133] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[159.805769] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[159.809766] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[159.909883] [047/133] (858s left) gem_exec_whisper (basic-fds-forked-all)
[159.961478] Starting subtest: basic-fds-forked-all
[179.660838] Subtest basic-fds-forked-all: SUCCESS (19.697s)
[179.851084] [048/133] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[179.943494] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[179.947511] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[180.032970] [049/133] (838s left) kms_joiner (invalid-modeset-force-big-joiner)
[180.130702] Starting subtest: invalid-modeset-force-big-joiner
[180.135228] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[180.195483] [050/133] (838s left) gem_mmap_gtt (big-bo)
[180.256024] Subtest big-bo: SKIP (0.000s)
[180.314454] [051/133] (838s left) gem_exec_alignment (many)
[180.377635] Starting subtest: many
[202.887073] Subtest many: SUCCESS (22.510s)
[205.514843] [052/133] (813s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[205.616321] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[205.720130] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[205.814369] [053/133] (813s left) gem_render_copy (y-tiled)
[205.881482] Starting subtest: y-tiled
[205.886296] Subtest y-tiled: SKIP (0.000s)
[206.065967] [054/133] (812s left) gem_mmap_wc (write-wc-read-gtt)
[206.124095] Subtest write-wc-read-gtt: SKIP (0.000s)
[206.179909] [055/133] (812s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[206.281861] Starting subtest: fb-8bpc-vs-panel-6bpc
[206.284220] Starting dynamic subtest: pipe-A-eDP-1
[207.647697] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.366s)
[207.650249] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.367s)
[208.443092] [056/133] (810s left) kms_vblank (wait-forked-hang)
[208.537047] Starting subtest: wait-forked-hang
[208.539358] Starting dynamic subtest: pipe-A-eDP-1
[236.039281] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.501s)
[236.053214] Starting dynamic subtest: pipe-D-eDP-1
[260.033361] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.987s)
[260.035572] Subtest wait-forked-hang: SUCCESS (51.492s)
[260.905619] [057/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[260.996487] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[265.398787] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.406s)
[266.613752] [058/133] (752s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[266.709878] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[267.334390] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s)
[267.507157] [059/133] (751s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[267.602574] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[271.762752] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.162s)
[272.916590] [060/133] (746s left) sw_sync (sync_merge_same)
[272.952436] Starting subtest: sync_merge_same
[272.954680] Subtest sync_merge_same: SUCCESS (0.000s)
[273.005179] [061/133] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[273.094873] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[273.098743] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[273.195286] [062/133] (746s left) kms_busy (basic)
[273.292864] Starting subtest: basic
[273.295223] Starting dynamic subtest: flip
[273.895240] Dynamic subtest flip: SUCCESS (0.601s)
[273.904666] Starting dynamic subtest: modeset
[277.360634] Dynamic subtest modeset: SUCCESS (3.464s)
[277.363049] Subtest basic: SUCCESS (4.067s)
[278.179169] [063/133] (741s left) gem_lmem_swapping (verify-random-ccs)
[278.219909] Subtest verify-random-ccs: SKIP (0.000s)
[278.261250] [064/133] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[278.363122] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[278.367112] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[278.462696] [065/133] (740s left) kms_prop_blob (blob-multiple)
[278.535442] Starting subtest: blob-multiple
[278.537866] Subtest blob-multiple: SUCCESS (0.002s)
[278.645230] [066/133] (740s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[278.750952] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[278.755335] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[278.819945] [067/133] (740s left) kms_psr (fbc-pr-primary-mmap-cpu)
[278.913479] Starting subtest: fbc-pr-primary-mmap-cpu
[278.917857] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[278.983865] [068/133] (740s left) gem_mmap_gtt (zero-extend)
[279.037678] Subtest zero-extend: SKIP (0.000s)
[279.103317] [069/133] (740s left) gem_exec_fence (syncobj-timeline-export)
[279.663984] Starting subtest: syncobj-timeline-export
[279.670105] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[281.381961] [070/133] (738s left) kms_psr (fbc-psr-sprite-plane-onoff)
[281.482142] Starting subtest: fbc-psr-sprite-plane-onoff
[281.484465] Starting dynamic subtest: eDP-1
[281.488772] Dynamic subtest eDP-1: SKIP (0.000s)
[281.493186] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[281.552912] [071/133] (738s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[281.638326] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[281.640670] Starting dynamic subtest: pipe-A-eDP-1
[281.663807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.674752] Starting dynamic subtest: pipe-B-eDP-1
[281.696563] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.705675] Starting dynamic subtest: pipe-C-eDP-1
[281.727405] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.738994] Starting dynamic subtest: pipe-D-eDP-1
[281.760997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.765189] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[283.924551] [072/133] (735s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[284.039455] Starting subtest: cursorA-vs-flipA-legacy
[295.169101] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.127s)
[295.963441] [073/133] (723s left) kms_atomic_interruptible (legacy-setmode)
[296.053215] Starting subtest: legacy-setmode
[296.055471] Starting dynamic subtest: pipe-A-eDP-1
[302.914929] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.859s)
[302.922279] Subtest legacy-setmode: SUCCESS (6.861s)
[303.714117] [074/133] (716s left) i915_pm_rps (reset)
[303.781655] Starting subtest: reset
[312.225141] Subtest reset: SUCCESS (8.442s)
[312.342217] [075/133] (707s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[312.447979] Starting subtest: crc-primary-suspend-y-tiled-ccs
[312.450304] Starting dynamic subtest: pipe-A-eDP-1
[312.459473] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[312.470598] Starting dynamic subtest: pipe-B-eDP-1
[312.479272] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[312.488545] Starting dynamic subtest: pipe-C-eDP-1
[312.496903] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[312.505349] Starting dynamic subtest: pipe-D-eDP-1
[312.514138] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[312.518146] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[314.669933] [076/133] (705s left) kms_addfb_basic (small-bo)
[314.761042] Starting subtest: small-bo
[314.763271] Subtest small-bo: SUCCESS (0.000s)
[314.863344] [077/133] (705s left) kms_addfb_basic (invalid-get-prop-any)
[314.908809] Starting subtest: invalid-get-prop-any
[314.911074] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[315.069218] [078/133] (704s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[315.169333] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[315.179768] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[315.258077] [079/133] (704s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[315.357457] Starting subtest: psr-indfb-scaledprimary
[321.126378] Subtest psr-indfb-scaledprimary: SUCCESS (5.771s)
[321.243390] [080/133] (698s left) gem_close (many-handles-one-vma)
[321.312814] Starting subtest: many-handles-one-vma
[321.338020] Subtest many-handles-one-vma: SUCCESS (0.025s)
[321.462306] [081/133] (698s left) kms_plane (plane-panning-bottom-right)
[321.574378] Starting subtest: plane-panning-bottom-right
[321.576314] Starting dynamic subtest: pipe-A
[323.273115] Dynamic subtest pipe-A: SUCCESS (1.698s)
[323.284103] Starting dynamic subtest: pipe-B
[325.701596] Dynamic subtest pipe-B: SUCCESS (2.426s)
[325.704087] Subtest plane-panning-bottom-right: SUCCESS (4.129s)
[326.493094] [082/133] (693s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[326.619705] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[326.624338] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[326.759397] [083/133] (693s left) kms_cursor_edge_walk (128x128-top-edge)
[326.851914] Starting subtest: 128x128-top-edge
[326.854214] Starting dynamic subtest: pipe-A-eDP-1
[330.356068] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.504s)
[330.366037] Starting dynamic subtest: pipe-D-eDP-1
[333.487433] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[333.489597] Subtest 128x128-top-edge: SUCCESS (6.635s)
[334.281689] [084/133] (685s left) gen7_exec_parse (chained-batch)
[334.343254] Subtest chained-batch: SKIP (0.000s)
[334.425632] [085/133] (685s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[334.517100] Starting subtest: primary-yf-tiled-reflect-x-180
[334.577065] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[334.691341] [086/133] (685s left) kms_frontbuffer_tracking (fbc-tiling-y)
[334.795059] Starting subtest: fbc-tiling-y
[334.799254] Subtest fbc-tiling-y: SKIP (0.000s)
[334.892231] [087/133] (685s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[334.947470] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[335.056246] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[335.131905] [088/133] (685s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[335.228629] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[335.233137] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[335.333289] [089/133] (685s left) kms_cursor_crc (cursor-onscreen-64x21)
[335.521343] Starting subtest: cursor-onscreen-64x21
[335.573129] Subtest cursor-onscreen-64x21: SKIP (0.045s)
[335.826951] [090/133] (684s left) kms_rmfb (close-fd)
[335.913360] Starting subtest: close-fd
[335.915260] Starting dynamic subtest: pipe-A-eDP-1
[336.020291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[336.031217] Starting dynamic subtest: pipe-B-eDP-1
[337.242520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.223s)
[337.251878] Starting dynamic subtest: pipe-C-eDP-1
[338.377246] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[338.388818] Starting dynamic subtest: pipe-D-eDP-1
[339.506191] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[339.508333] Subtest close-fd: SUCCESS (3.593s)
[340.725452] [091/133] (679s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[340.834623] Starting subtest: 2x-long-cursor-vs-flip-legacy
[340.839301] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[340.976093] [092/133] (679s left) gem_softpin (evict-prime-sanity-check)
[341.031581] Starting subtest: evict-prime-sanity-check
[341.034079] Starting dynamic subtest: rcs0
[342.179040] Dynamic subtest rcs0: SUCCESS (1.147s)
[342.189463] Starting dynamic subtest: bcs0
[343.285587] Dynamic subtest bcs0: SUCCESS (1.106s)
[343.297325] Starting dynamic subtest: vcs0
[345.282668] Dynamic subtest vcs0: SUCCESS (1.994s)
[345.294716] Starting dynamic subtest: vcs1
[347.259525] Dynamic subtest vcs1: SUCCESS (1.974s)
[347.273271] Starting dynamic subtest: vecs0
[349.305992] Dynamic subtest vecs0: SUCCESS (2.043s)
[349.320433] Starting dynamic subtest: ccs0
[350.443340] Dynamic subtest ccs0: SUCCESS (1.136s)
[350.455499] Starting dynamic subtest: all
[351.580509] Dynamic subtest all: SUCCESS (1.135s)
[351.583251] Subtest evict-prime-sanity-check: SUCCESS (10.549s)
[351.661190] [093/133] (668s left) kms_psr (pr-basic)
[351.752783] Starting subtest: pr-basic
[351.757111] Subtest pr-basic: SKIP (0.000s)
[351.824935] [094/133] (668s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[351.888896] Starting subtest: multi-wait-all-for-submit-signaled
[351.891102] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[351.987751] [095/133] (668s left) i915_drm_fdinfo (busy-idle)
[352.024360] Starting subtest: busy-idle
[352.026317] Starting dynamic subtest: rcs0
[352.054220] Dynamic subtest rcs0: SKIP (0.029s)
[352.065713] Starting dynamic subtest: bcs0
[352.069791] Dynamic subtest bcs0: SKIP (0.000s)
[352.079141] Starting dynamic subtest: vcs0
[352.083442] Dynamic subtest vcs0: SKIP (0.000s)
[352.092274] Starting dynamic subtest: vcs1
[352.096330] Dynamic subtest vcs1: SKIP (0.000s)
[352.105627] Starting dynamic subtest: vecs0
[352.109540] Dynamic subtest vecs0: SKIP (0.000s)
[352.117877] Starting dynamic subtest: ccs0
[352.121766] Dynamic subtest ccs0: SKIP (0.000s)
[352.125683] Subtest busy-idle: SKIP (0.035s)
[352.161377] [096/133] (668s left) kms_plane_scaling (planes-downscale-factor-0-5)
[352.245729] Starting subtest: planes-downscale-factor-0-5
[352.248736] Starting dynamic subtest: pipe-A
[352.269755] Dynamic subtest pipe-A: SKIP (0.019s)
[352.280827] Starting dynamic subtest: pipe-B
[352.301280] Dynamic subtest pipe-B: SKIP (0.033s)
[352.310691] Starting dynamic subtest: pipe-C
[352.335088] Dynamic subtest pipe-C: SKIP (0.033s)
[352.344259] Starting dynamic subtest: pipe-D
[352.367165] Dynamic subtest pipe-D: SKIP (0.032s)
[352.371306] Subtest planes-downscale-factor-0-5: SKIP (0.120s)
[352.457992] [097/133] (668s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[352.555410] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[352.559229] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[352.645154] [098/133] (668s left) gem_ccs (large-ctrl-surf-copy)
[352.709068] Starting subtest: large-ctrl-surf-copy
[352.712746] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[352.831399] [099/133] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[352.926303] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[352.929824] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[353.017857] [100/133] (667s left) perf_pmu (invalid-open)
[353.059080] Starting subtest: invalid-open
[353.061073] Subtest invalid-open: SUCCESS (0.000s)
[353.179723] [101/133] (667s left) gem_exec_balancer (nop)
[353.239785] Starting subtest: nop
[399.969906] Subtest nop: SUCCESS (46.729s)
[400.265187] [102/133] (620s left) vgem_basic (bad-pad)
[400.307201] Starting subtest: bad-pad
[400.309360] Subtest bad-pad: SUCCESS (0.000s)
[400.361241] [103/133] (620s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[400.451995] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[400.454189] Starting dynamic subtest: pipe-A-eDP-1
[401.752564] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.300s)
[402.040563] Starting dynamic subtest: pipe-B-eDP-1
[403.075630] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.046s)
[403.344723] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.891s)
[404.188665] [104/133] (616s left) kms_atomic_transition (modeset-transition)
[404.279204] Starting subtest: modeset-transition
[404.281489] Starting dynamic subtest: 1x-outputs
[415.087461] Dynamic subtest 1x-outputs: SUCCESS (10.809s)
[415.089734] Subtest modeset-transition: SUCCESS (10.811s)
[415.948533] [105/133] (605s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[416.336514] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[417.159209] [106/133] (603s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[417.212152] Starting subtest: multi-wait-available-unsubmitted-submitted
[417.214444] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[417.301095] [107/133] (603s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[417.359422] Starting subtest: yf-tiled-ccs-to-x-tiled
[417.363787] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[417.556647] [108/133] (603s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[417.651248] Starting subtest: addfb25-y-tiled-legacy
[417.653403] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[417.752590] [109/133] (603s left) sw_sync (timeline_closed_signaled)
[417.788800] Starting subtest: timeline_closed_signaled
[417.791078] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[417.849550] [110/133] (603s left) kms_cdclk (mode-transition)
[417.938147] Starting subtest: mode-transition
[417.940368] Starting dynamic subtest: pipe-A-eDP-1
[418.229083] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[418.239396] Starting dynamic subtest: pipe-B-eDP-1
[418.243998] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[418.253576] Starting dynamic subtest: pipe-C-eDP-1
[418.258216] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[418.267395] Starting dynamic subtest: pipe-D-eDP-1
[418.271506] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[418.275622] Subtest mode-transition: SKIP (0.298s)
[419.018676] [111/133] (602s left) gem_exec_reloc (basic-wc-read)
[419.085172] Subtest basic-wc-read: SKIP (0.000s)
[419.157605] [112/133] (602s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[419.237157] Starting subtest: plane-lut1d-ctm3x4
[419.408834] Starting dynamic subtest: pipe-A-plane-0
[419.594487] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[419.606399] Starting dynamic subtest: pipe-A-plane-1
[419.772300] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[419.782315] Starting dynamic subtest: pipe-A-plane-2
[419.941332] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[421.132227] Starting dynamic subtest: pipe-B-plane-0
[421.290154] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[421.300303] Starting dynamic subtest: pipe-B-plane-1
[421.447333] Dynamic subtest pipe-B-plane-1: SUCCESS (0.154s)
[421.456970] Starting dynamic subtest: pipe-B-plane-2
[421.601079] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[422.751276] Starting dynamic subtest: pipe-C-plane-0
[422.896393] Dynamic subtest pipe-C-plane-0: SUCCESS (0.154s)
[422.906153] Starting dynamic subtest: pipe-C-plane-1
[423.040733] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[423.050355] Starting dynamic subtest: pipe-C-plane-2
[423.185179] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[424.405143] Starting dynamic subtest: pipe-D-plane-0
[424.541997] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[424.551800] Starting dynamic subtest: pipe-D-plane-1
[424.675071] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[424.684768] Starting dynamic subtest: pipe-D-plane-2
[424.819743] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[425.105215] Subtest plane-lut1d-ctm3x4: SUCCESS (5.869s)
[425.946611] [113/133] (595s left) kms_pm_rpm (drm-resources-equal)
[427.477883] Starting subtest: drm-resources-equal
[432.821405] Subtest drm-resources-equal: SUCCESS (5.348s)
[432.908455] [114/133] (588s left) perf (i915-ref-count)
[432.984591] Starting subtest: i915-ref-count
[433.053407] Subtest i915-ref-count: SUCCESS (0.069s)
[433.109619] [115/133] (588s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[433.204433] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[440.100125] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.899s)
[440.221757] [116/133] (581s left) api_intel_bb (bb-with-allocator)
[440.272296] Starting subtest: bb-with-allocator
[440.275587] Subtest bb-with-allocator: SUCCESS (0.006s)
[440.417478] [117/133] (581s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[440.510355] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[440.514805] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[440.582956] [118/133] (580s left) gem_tiled_blits (normal)
[440.639067] Subtest normal: SKIP (0.000s)
[440.720074] [119/133] (580s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[440.807066] Starting subtest: pixel-format-y-tiled-ccs-modifier
[440.811579] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[440.877010] [120/133] (580s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[441.001509] Starting subtest: cursorA-vs-flipB-varying-size
[441.006109] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[441.145867] [121/133] (580s left) gem_mmap_wc (write-cpu-read-wc)
[441.203376] Subtest write-cpu-read-wc: SKIP (0.000s)
[441.260989] [122/133] (580s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[441.350477] Starting subtest: pr-plane-move-sf-dmg-area
[441.353886] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[441.421609] [123/133] (580s left) kms_legacy_colorkey (invalid-plane)
[441.517587] Starting subtest: invalid-plane
[441.519399] Starting dynamic subtest: zero-id
[441.521030] Dynamic subtest zero-id: SUCCESS (0.000s)
[441.529603] Starting dynamic subtest: outrange-id
[441.531553] Dynamic subtest outrange-id: SUCCESS (0.000s)
[441.533279] Subtest invalid-plane: SUCCESS (0.001s)
[441.587336] [124/133] (580s left) kms_properties (colorop-properties-legacy)
[441.674857] Starting subtest: colorop-properties-legacy
[441.676853] Starting dynamic subtest: pipe-A-eDP-1
[442.052542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[442.062698] Starting dynamic subtest: pipe-B-eDP-1
[443.138050] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.087s)
[443.151011] Starting dynamic subtest: pipe-C-eDP-1
[444.180680] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.039s)
[444.190281] Starting dynamic subtest: pipe-D-eDP-1
[445.204888] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.025s)
[445.207383] Subtest colorop-properties-legacy: SUCCESS (3.532s)
[446.000219] [125/133] (575s left) gem_create (create-valid-nonaligned)
[446.043201] Starting subtest: create-valid-nonaligned
[446.045393] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[446.222390] [126/133] (575s left) gem_render_copy_redux (flink-interruptible)
[446.284751] Starting subtest: flink-interruptible
[447.070208] Subtest flink-interruptible: SUCCESS (0.786s)
[447.202790] [127/133] (574s left) kms_psr (psr-basic)
[447.298423] Starting subtest: psr-basic
[447.300233] Starting dynamic subtest: eDP-1
[448.889816] Dynamic subtest eDP-1: SUCCESS (1.590s)
[448.892096] Subtest psr-basic: SUCCESS (1.591s)
[449.769406] [128/133] (572s left) kms_psr (psr-primary-render)
[449.859103] Starting subtest: psr-primary-render
[449.861351] Starting dynamic subtest: eDP-1
[451.585355] Dynamic subtest eDP-1: SUCCESS (1.725s)
[451.587643] Subtest psr-primary-render: SUCCESS (1.726s)
[452.436198] [129/133] (569s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[452.536981] Starting subtest: yf-tiled-64bpp-rotate-90
[452.541429] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[452.640576] [130/133] (569s left) gem_exec_schedule (pi-shared-iova)
[452.828680] Starting subtest: pi-shared-iova
[452.830994] Starting dynamic subtest: rcs0
[452.901869] Dynamic subtest rcs0: SUCCESS (0.077s)
[452.914931] Starting dynamic subtest: vcs0
[452.957676] Dynamic subtest vcs0: SUCCESS (0.054s)
[452.972012] Starting dynamic subtest: vcs1
[453.017346] Dynamic subtest vcs1: SUCCESS (0.060s)
[453.031744] Starting dynamic subtest: vecs0
[453.073405] Dynamic subtest vecs0: SUCCESS (0.055s)
[453.085559] Starting dynamic subtest: ccs0
[453.144278] Dynamic subtest ccs0: SUCCESS (0.070s)
[453.147065] Subtest pi-shared-iova: SUCCESS (0.321s)
[454.401041] [131/133] (567s left) gem_exec_reloc (basic-active)
[454.463777] Subtest basic-active: SKIP (0.000s)
[454.530160] [132/133] (567s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[454.905626] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[455.744443] [133/133] (566s left) prime_busy (hang-wait)
[455.803383] Starting subtest: hang-wait
[455.805691] Starting dynamic subtest: rcs0
[481.759689] Dynamic subtest rcs0: SUCCESS (25.954s)
[481.771045] Starting dynamic subtest: bcs0
[488.913284] Dynamic subtest bcs0: SUCCESS (7.152s)
[488.922845] Starting dynamic subtest: vcs0
[495.888706] Dynamic subtest vcs0: SUCCESS (6.972s)
[495.900247] Starting dynamic subtest: vcs1
[502.930350] Dynamic subtest vcs1: SUCCESS (7.039s)
[502.939865] Starting dynamic subtest: vecs0
[509.898791] Dynamic subtest vecs0: SUCCESS (6.969s)
[509.911261] Starting dynamic subtest: ccs0
[523.744599] Dynamic subtest ccs0: SUCCESS (13.841s)
[523.746962] Subtest hang-wait: SUCCESS (67.940s)
[523.873533] 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.