[60.416236] Initializing watchdogs
[60.416283]   /dev/watchdog0
[60.430554] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.434707] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.437382] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.440698] [001/131] (960s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[60.571793] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[60.574112] Starting dynamic subtest: pipe-A-eDP-1
[60.594300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[60.602645] Starting dynamic subtest: pipe-B-eDP-1
[60.620757] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[60.627158] Starting dynamic subtest: pipe-C-eDP-1
[60.649539] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[60.656262] Starting dynamic subtest: pipe-D-eDP-1
[60.675698] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[60.677586] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[62.834701] [002/131] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[62.944331] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[70.010386] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.082s)
[70.182686] [003/131] (950s left) kms_pipe_crc_basic (nonblocking-crc)
[70.287544] Starting subtest: nonblocking-crc
[70.289776] Starting dynamic subtest: pipe-A-eDP-1
[71.043510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.757s)
[71.052562] Starting dynamic subtest: pipe-B-eDP-1
[72.472141] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.428s)
[72.480740] Starting dynamic subtest: pipe-C-eDP-1
[73.850072] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[73.857608] Starting dynamic subtest: pipe-D-eDP-1
[75.182053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[75.184357] Subtest nonblocking-crc: SUCCESS (4.899s)
[76.002878] [004/131] (945s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[76.106854] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[76.110851] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[76.225135] [005/131] (944s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[76.341165] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[76.345423] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[76.480895] [006/131] (944s left) i915_drm_fdinfo (virtual-busy-all)
[76.519850] Starting subtest: virtual-busy-all
[76.524157] Subtest virtual-busy-all: SKIP (0.000s)
[76.608596] [007/131] (944s left) gem_gpgpu_fill (offset-16x16)
[76.668943] Starting subtest: offset-16x16
[76.676741] Subtest offset-16x16: SUCCESS (0.009s)
[76.853912] [008/131] (944s left) perf_pmu (busy-accuracy-98)
[76.894596] Starting subtest: busy-accuracy-98
[76.896891] Starting dynamic subtest: rcs0
[79.929314] Dynamic subtest rcs0: SUCCESS (3.034s)
[79.938604] Starting dynamic subtest: bcs0
[82.977526] Dynamic subtest bcs0: SUCCESS (3.047s)
[82.987323] Starting dynamic subtest: vcs0
[86.017511] Dynamic subtest vcs0: SUCCESS (3.039s)
[86.027051] Starting dynamic subtest: vcs1
[89.061360] Dynamic subtest vcs1: SUCCESS (3.043s)
[89.071114] Starting dynamic subtest: vecs0
[92.104233] Dynamic subtest vecs0: SUCCESS (3.041s)
[92.114591] Starting dynamic subtest: ccs0
[95.156524] Dynamic subtest ccs0: SUCCESS (3.051s)
[95.158968] Subtest busy-accuracy-98: SUCCESS (18.261s)
[95.312009] [009/131] (925s left) gem_exec_flush (basic-wb-pro-default)
[95.381908] Starting subtest: basic-wb-pro-default
[100.848494] Subtest basic-wb-pro-default: SUCCESS (5.467s)
[101.061313] [010/131] (920s left) kms_rotation_crc (primary-rotation-90)
[101.163035] Starting subtest: primary-rotation-90
[101.167543] Subtest primary-rotation-90: SKIP (0.001s)
[101.260270] [011/131] (920s left) gem_exec_schedule (fifo)
[101.344193] Starting subtest: fifo
[101.346172] Starting dynamic subtest: rcs0
[101.451269] Dynamic subtest rcs0: SUCCESS (0.115s)
[101.462535] Starting dynamic subtest: vcs0
[101.525063] Dynamic subtest vcs0: SUCCESS (0.074s)
[101.535206] Starting dynamic subtest: vcs1
[101.603611] Dynamic subtest vcs1: SUCCESS (0.078s)
[101.614693] Starting dynamic subtest: vecs0
[101.680890] Dynamic subtest vecs0: SUCCESS (0.077s)
[101.695059] Starting dynamic subtest: ccs0
[101.770537] Dynamic subtest ccs0: SUCCESS (0.089s)
[101.773081] Subtest fifo: SUCCESS (0.436s)
[103.063682] [012/131] (918s left) kms_plane_scaling (invalid-parameters)
[103.168860] Starting subtest: invalid-parameters
[103.171217] Starting dynamic subtest: less-than-1-height-src
[103.183413] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[103.193172] Starting dynamic subtest: less-than-1-width-src
[103.195710] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[103.198246] Subtest invalid-parameters: SUCCESS (0.028s)
[103.325460] [013/131] (918s left) kms_pm_rpm (universal-planes-dpms)
[105.077511] Starting subtest: universal-planes-dpms
[105.080290] Starting dynamic subtest: plane-33
[113.650211] Dynamic subtest plane-33: SUCCESS (8.572s)
[113.661060] Starting dynamic subtest: plane-63
[121.993435] Dynamic subtest plane-63: SUCCESS (8.342s)
[122.003139] Starting dynamic subtest: plane-93
[130.594349] Dynamic subtest plane-93: SUCCESS (8.599s)
[130.604955] Starting dynamic subtest: plane-123
[138.911649] Dynamic subtest plane-123: SUCCESS (8.316s)
[138.921925] Starting dynamic subtest: plane-133
[147.513509] Dynamic subtest plane-133: SUCCESS (8.599s)
[147.523748] Starting dynamic subtest: plane-143
[156.106492] Dynamic subtest plane-143: SUCCESS (8.590s)
[156.109374] Subtest universal-planes-dpms: SUCCESS (51.027s)
[156.488698] [014/131] (864s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[156.577194] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[156.579532] Starting dynamic subtest: pipe-A-default-mode
[156.890730] Dynamic subtest pipe-A-default-mode: SKIP (0.311s)
[156.895168] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.312s)
[157.724895] [015/131] (863s left) gem_tiled_partial_pwrite_pread (writes)
[157.791288] Subtest writes: SKIP (0.000s)
[157.876667] [016/131] (863s left) gem_userptr_blits (create-destroy-sync)
[157.952065] Starting subtest: create-destroy-sync
[162.967129] Subtest create-destroy-sync: SUCCESS (5.014s)
[163.130860] [017/131] (858s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[163.241845] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[167.854799] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.618s)
[169.000034] [018/131] (852s left) i915_pm_rpm (reg-read-ioctl)
[171.041951] Starting subtest: reg-read-ioctl
[173.322472] Subtest reg-read-ioctl: SUCCESS (2.282s)
[173.728254] [019/131] (847s left) drm_buddy (drm_buddy)
[173.763051] Starting subtest: drm_buddy
[173.777920] Starting dynamic subtest: drm_test_buddy_alloc_limit
[173.914283] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.136s)
[173.923712] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[174.049197] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.134s)
[174.058674] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[174.190505] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.140s)
[174.199938] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[174.337577] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.146s)
[174.347175] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[174.469511] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.133s)
[174.479060] Starting dynamic subtest: drm_test_buddy_alloc_clear
[174.652183] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.182s)
[174.662106] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[174.794594] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.143s)
[174.802458] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[179.046835] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.250s)
[179.048866] Subtest drm_buddy: SUCCESS (5.283s)
[179.274727] [020/131] (842s left) kms_psr2_su (frontbuffer-xrgb8888)
[179.332333] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[179.391752] [021/131] (842s left) prime_busy (hang)
[179.452894] Starting subtest: hang
[179.455196] Starting dynamic subtest: rcs0
[205.426043] Dynamic subtest rcs0: SUCCESS (25.968s)
[205.439711] Starting dynamic subtest: bcs0
[212.585041] Dynamic subtest bcs0: SUCCESS (7.157s)
[212.594823] Starting dynamic subtest: vcs0
[219.556066] Dynamic subtest vcs0: SUCCESS (6.970s)
[219.566413] Starting dynamic subtest: vcs1
[226.597374] Dynamic subtest vcs1: SUCCESS (7.040s)
[226.607294] Starting dynamic subtest: vecs0
[233.577467] Dynamic subtest vecs0: SUCCESS (6.982s)
[233.587692] Starting dynamic subtest: ccs0
[247.406569] Dynamic subtest ccs0: SUCCESS (13.826s)
[247.408971] Subtest hang: SUCCESS (67.949s)
[247.551807] [022/131] (774s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[247.667783] Starting subtest: addfb25-y-tiled-legacy
[247.669774] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[247.790880] [023/131] (773s left) gen3_render_mixed_blits
[247.921998] [024/131] (773s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[247.968979] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[247.970931] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[248.089377] [025/131] (773s left) kms_cursor_legacy (single-bo)
[248.217603] Starting subtest: single-bo
[248.219737] Starting dynamic subtest: pipe-A
[253.599410] Dynamic subtest pipe-A: SUCCESS (5.380s)
[253.609673] Starting dynamic subtest: pipe-B
[258.982028] Dynamic subtest pipe-B: SUCCESS (5.380s)
[258.992308] Starting dynamic subtest: pipe-C
[264.363949] Dynamic subtest pipe-C: SUCCESS (5.380s)
[264.374050] Starting dynamic subtest: pipe-D
[269.746027] Dynamic subtest pipe-D: SUCCESS (5.381s)
[269.756669] Starting dynamic subtest: all-pipes
[275.135249] Dynamic subtest all-pipes: SUCCESS (5.386s)
[275.137701] Subtest single-bo: SUCCESS (26.914s)
[275.311524] [026/131] (746s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[275.416561] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[275.420699] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[275.538819] [027/131] (746s left) gem_exec_schedule (preempt)
[275.632536] Starting subtest: preempt
[275.634487] Starting dynamic subtest: rcs0
[275.652729] Dynamic subtest rcs0: SUCCESS (0.023s)
[275.663732] Starting dynamic subtest: bcs0
[275.672261] Dynamic subtest bcs0: SUCCESS (0.019s)
[275.679905] Starting dynamic subtest: vcs0
[275.695417] Dynamic subtest vcs0: SUCCESS (0.023s)
[275.703254] Starting dynamic subtest: vcs1
[275.715313] Dynamic subtest vcs1: SUCCESS (0.019s)
[275.723252] Starting dynamic subtest: vecs0
[275.734407] Dynamic subtest vecs0: SUCCESS (0.019s)
[275.744846] Starting dynamic subtest: ccs0
[275.754185] Dynamic subtest ccs0: SUCCESS (0.019s)
[275.756435] Subtest preempt: SUCCESS (0.125s)
[277.020219] [028/131] (744s left) kms_cursor_edge_walk (128x128-top-edge)
[277.115807] Starting subtest: 128x128-top-edge
[277.118124] Starting dynamic subtest: pipe-A-eDP-1
[280.556857] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s)
[280.565188] Starting dynamic subtest: pipe-D-eDP-1
[283.685433] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[283.687749] Subtest 128x128-top-edge: SUCCESS (6.570s)
[284.508716] [029/131] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[284.617272] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[292.123304] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.508s)
[292.304103] [030/131] (729s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[292.402680] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[292.404887] Starting dynamic subtest: pipe-A-eDP-1
[292.426618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[292.436517] Starting dynamic subtest: pipe-B-eDP-1
[292.457175] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[292.465040] Starting dynamic subtest: pipe-C-eDP-1
[292.485186] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[292.493542] Starting dynamic subtest: pipe-D-eDP-1
[292.516737] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[292.521017] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[294.721256] [031/131] (727s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[294.829204] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[295.874511] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.045s)
[296.021332] [032/131] (726s left) kms_cursor_crc (cursor-random-64x21)
[296.202415] Starting subtest: cursor-random-64x21
[296.248906] Subtest cursor-random-64x21: SKIP (0.042s)
[296.514847] [033/131] (725s left) gem_exec_big (single)
[296.572983] Starting subtest: single
[298.905394] Subtest single: FAIL (2.272s)
[298.956271] [034/131] (723s left) kms_hdmi_inject (inject-4k)
[299.334081] Starting subtest: inject-4k
[299.652101] Subtest inject-4k: SUCCESS (0.319s)
[300.255809] [035/131] (722s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[300.365016] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[300.367387] Starting dynamic subtest: pipe-A-eDP-1
[300.389936] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[300.407312] Starting dynamic subtest: pipe-B-eDP-1
[300.431952] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[300.440233] Starting dynamic subtest: pipe-C-eDP-1
[300.461618] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[300.469166] Starting dynamic subtest: pipe-D-eDP-1
[300.491029] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[300.495380] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[302.626741] [036/131] (719s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[302.737811] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[303.428754] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.693s)
[303.639486] [037/131] (718s left) kms_big_fb (linear-8bpp-rotate-270)
[303.743964] Starting subtest: linear-8bpp-rotate-270
[303.764638] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[303.923693] [038/131] (718s left) kms_cursor_crc (cursor-offscreen-128x42)
[304.139367] Starting subtest: cursor-offscreen-128x42
[304.188096] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[304.420287] [039/131] (718s left) gem_mmap_wc (write-gtt-read-wc)
[304.473826] Subtest write-gtt-read-wc: SKIP (0.000s)
[304.551877] [040/131] (717s left) i915_query (hwconfig_table)
[304.611570] Starting subtest: hwconfig_table
[304.861482] Subtest hwconfig_table: SUCCESS (0.001s)
[304.897822] [041/131] (717s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[305.004418] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[305.006336] Starting dynamic subtest: pipe-A-default-mode
[306.133590] Dynamic subtest pipe-A-default-mode: SKIP (1.127s)
[306.138046] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.129s)
[306.325236] [042/131] (716s left) gem_exec_balancer (bonded-true-hang)
[306.590174] Starting subtest: bonded-true-hang
[306.594855] Subtest bonded-true-hang: SKIP (0.000s)
[306.737901] [043/131] (715s left) kms_getfb (getfb2-handle-not-fb)
[306.833645] Starting subtest: getfb2-handle-not-fb
[306.835956] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[306.962768] [044/131] (715s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[307.073998] Starting subtest: invalid-modeset-force-ultra-joiner
[307.078212] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[307.164764] [045/131] (715s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[307.252776] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[307.254975] Starting dynamic subtest: pipe-A-default-mode
[307.539186] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[307.543436] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.286s)
[308.439680] [046/131] (714s left) kms_draw_crc (draw-method-pwrite)
[308.531746] Starting subtest: draw-method-pwrite
[308.533974] Starting dynamic subtest: xrgb8888-untiled
[309.097455] Dynamic subtest xrgb8888-untiled: SUCCESS (0.567s)
[309.106321] Starting dynamic subtest: rgb565-untiled
[309.541847] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[309.550558] Starting dynamic subtest: xrgb2101010-untiled
[310.097447] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[310.106065] Starting dynamic subtest: xbgr16161616f-untiled
[310.875343] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[310.884050] Starting dynamic subtest: xrgb8888-xtiled
[312.776219] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.899s)
[312.784389] Starting dynamic subtest: rgb565-xtiled
[313.908593] Dynamic subtest rgb565-xtiled: SUCCESS (1.132s)
[313.917246] Starting dynamic subtest: xrgb2101010-xtiled
[315.786628] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.877s)
[315.797566] Starting dynamic subtest: xbgr16161616f-xtiled
[319.142423] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.355s)
[319.150700] Starting dynamic subtest: xrgb8888-4tiled
[320.331252] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.188s)
[320.339505] Starting dynamic subtest: rgb565-4tiled
[320.909184] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s)
[320.918086] Starting dynamic subtest: xrgb2101010-4tiled
[322.031342] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.120s)
[322.040166] Starting dynamic subtest: xbgr16161616f-4tiled
[325.131128] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.099s)
[325.133373] Subtest draw-method-pwrite: SUCCESS (16.601s)
[325.282639] [047/131] (697s left) perf (non-sampling-read-error)
[325.450362] Starting subtest: non-sampling-read-error
[325.461792] Subtest non-sampling-read-error: SUCCESS (0.010s)
[325.501530] [048/131] (697s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[325.564581] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[325.666172] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[325.768373] [049/131] (697s left) syncobj_timeline (invalid-query-zero-handles)
[325.837635] Starting subtest: invalid-query-zero-handles
[325.839662] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[325.961306] [050/131] (696s left) syncobj_wait (multi-wait-for-submit-signaled)
[326.025726] Starting subtest: multi-wait-for-submit-signaled
[326.028174] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[326.167102] [051/131] (696s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[326.278834] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[326.282971] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[326.417441] [052/131] (696s left) gem_exec_params (invalid-fence-in)
[326.481327] Starting subtest: invalid-fence-in
[326.483812] Subtest invalid-fence-in: SUCCESS (0.000s)
[326.621863] [053/131] (696s left) gem_render_copy (yf-tiled-ccs-to-linear)
[326.691488] Starting subtest: yf-tiled-ccs-to-linear
[326.695321] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[326.899057] [054/131] (696s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[326.970701] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[327.073471] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[327.172831] [055/131] (695s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[327.282476] Starting subtest: fbc-indfb-scaledprimary
[330.251443] Subtest fbc-indfb-scaledprimary: SUCCESS (2.972s)
[331.438412] [056/131] (691s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[331.534116] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[331.536411] Starting dynamic subtest: pipe-A
[331.556124] Dynamic subtest pipe-A: SKIP (0.018s)
[331.564818] Starting dynamic subtest: pipe-B
[331.586535] Dynamic subtest pipe-B: SKIP (0.031s)
[331.595346] Starting dynamic subtest: pipe-C
[331.619403] Dynamic subtest pipe-C: SKIP (0.031s)
[331.627907] Starting dynamic subtest: pipe-D
[331.651107] Dynamic subtest pipe-D: SKIP (0.031s)
[331.655420] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.114s)
[331.765451] [057/131] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[331.881799] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[338.573160] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.694s)
[338.764415] [058/131] (684s left) gem_eio (in-flight-10ms)
[339.019289] Starting subtest: in-flight-10ms
[348.246563] Subtest in-flight-10ms: SUCCESS (9.226s)
[348.450157] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[348.453387] [059/131] (674s left) kms_plane_lowres (tiling-4)
[348.570106] Starting subtest: tiling-4
[348.572404] Starting dynamic subtest: pipe-A-eDP-1
[348.576962] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[348.861494] Starting dynamic subtest: pipe-B-eDP-1
[348.865830] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[348.874112] Starting dynamic subtest: pipe-C-eDP-1
[348.878472] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.886642] Starting dynamic subtest: pipe-D-eDP-1
[348.891054] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.895015] Subtest tiling-4: SKIP (0.292s)
[349.723158] [060/131] (673s left) gen9_exec_parse (bb-start-cmd)
[349.795068] Subtest bb-start-cmd: SKIP (0.000s)
[349.881437] [061/131] (673s left) kms_selftest (drm_cmdline_parser)
[349.915812] Starting subtest: drm_cmdline_parser
[349.927932] Starting dynamic subtest: drm_test_cmdline_force_d_only
[350.049000] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.121s)
[350.057331] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[350.191052] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.140s)
[350.199567] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[350.324991] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.134s)
[350.333710] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[350.463183] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.138s)
[350.471609] Starting dynamic subtest: drm_test_cmdline_force_e_only
[350.595880] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.129s)
[350.604670] Starting dynamic subtest: drm_test_cmdline_res
[350.726965] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.130s)
[350.735419] Starting dynamic subtest: drm_test_cmdline_res_vesa
[350.858893] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.131s)
[350.867618] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[350.987874] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.128s)
[350.997484] Starting dynamic subtest: drm_test_cmdline_res_rblank
[351.121097] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.133s)
[351.130920] Starting dynamic subtest: drm_test_cmdline_res_bpp
[351.228177] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.106s)
[351.238194] Starting dynamic subtest: drm_test_cmdline_res_refresh
[351.346125] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.115s)
[351.355419] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[351.475177] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.128s)
[351.484562] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[351.610563] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.134s)
[351.619442] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[351.748838] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.136s)
[351.758275] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[351.889062] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.141s)
[351.897267] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[352.003181] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.112s)
[352.013089] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[352.081284] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.080s)
[352.089816] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[352.186997] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.103s)
[352.195078] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[352.304256] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.116s)
[352.312733] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[352.430905] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.125s)
[352.439535] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[352.556904] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.125s)
[352.565767] Starting dynamic subtest: drm_test_cmdline_name
[352.687229] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.130s)
[352.695543] Starting dynamic subtest: drm_test_cmdline_name_bpp
[352.807105] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.117s)
[352.824798] Starting dynamic subtest: drm_test_cmdline_name_option
[352.929141] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.120s)
[352.947077] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[353.068751] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.139s)
[353.079079] Starting dynamic subtest: drm_test_cmdline_rotate_0
[353.191316] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.122s)
[353.199560] Starting dynamic subtest: drm_test_cmdline_rotate_90
[353.315056] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.123s)
[353.324397] Starting dynamic subtest: drm_test_cmdline_rotate_180
[353.465514] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.150s)
[353.474098] Starting dynamic subtest: drm_test_cmdline_rotate_270
[353.580914] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.115s)
[353.589118] Starting dynamic subtest: drm_test_cmdline_hmirror
[353.688856] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.107s)
[353.697135] Starting dynamic subtest: drm_test_cmdline_vmirror
[353.811902] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.121s)
[353.820195] Starting dynamic subtest: drm_test_cmdline_margin_options
[353.917147] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.105s)
[353.925401] Starting dynamic subtest: drm_test_cmdline_multiple_options
[354.055922] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.137s)
[354.064642] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[354.183484] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.128s)
[354.192234] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[354.310030] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.125s)
[354.318369] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[354.429322] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.119s)
[354.437314] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[354.547406] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.117s)
[354.555914] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[354.664453] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.116s)
[354.672869] Starting dynamic subtest: drm_test_cmdline_invalid
[354.810785] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.146s)
[354.819334] Starting dynamic subtest: drm_test_cmdline_tv_options
[354.940481] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.130s)
[354.942746] Subtest drm_cmdline_parser: SUCCESS (5.023s)
[355.149019] [062/131] (668s left) kms_content_protection (content-type-change)
[355.299849] Starting subtest: content-type-change
[355.304475] Subtest content-type-change: SKIP (0.000s)
[355.441876] [063/131] (667s left) api_intel_bb (delta-check)
[355.499888] Starting subtest: delta-check
[355.504307] Subtest delta-check: SUCCESS (0.006s)
[355.658676] [064/131] (667s left) gem_render_copy (y-tiled-ccs-to-linear)
[355.726804] Starting subtest: y-tiled-ccs-to-linear
[355.731368] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[355.934304] [065/131] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[356.035576] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[356.039861] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[356.167158] [066/131] (667s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[356.260845] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[356.265202] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[356.399839] [067/131] (667s left) kms_psr (psr2-cursor-plane-onoff)
[356.501493] Starting subtest: psr2-cursor-plane-onoff
[356.503939] Starting dynamic subtest: eDP-1
[358.234488] Dynamic subtest eDP-1: SUCCESS (1.734s)
[358.236673] Subtest psr2-cursor-plane-onoff: SUCCESS (1.735s)
[359.122887] [068/131] (664s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[359.230806] Starting subtest: extended-pageflip-modeset-hang-oldfb
[359.232968] Starting dynamic subtest: pipe-A
[367.135872] Dynamic subtest pipe-A: SUCCESS (7.903s)
[367.149807] Starting dynamic subtest: pipe-D
[375.782388] Dynamic subtest pipe-D: SUCCESS (8.643s)
[375.784751] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.550s)
[376.623406] [069/131] (647s left) gem_ctx_param (get-priority-new-ctx)
[376.685133] Starting subtest: get-priority-new-ctx
[376.687561] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[376.819186] [070/131] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[376.916785] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[376.920970] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[377.056430] [071/131] (646s left) gem_ctx_param (invalid-set-ringsize)
[377.104829] Starting subtest: invalid-set-ringsize
[377.107102] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[377.207902] [072/131] (646s left) kms_frontbuffer_tracking (fbc-stridechange)
[377.318661] Starting subtest: fbc-stridechange
[380.554397] Subtest fbc-stridechange: SUCCESS (3.237s)
[381.736649] [073/131] (642s left) i915_hangman (gt-error-state-capture)
[381.818026] Starting subtest: gt-error-state-capture
[381.820349] Starting dynamic subtest: rcs0
[392.884538] Dynamic subtest rcs0: SUCCESS (11.066s)
[392.895911] Starting dynamic subtest: bcs0
[404.852030] Dynamic subtest bcs0: SUCCESS (11.964s)
[404.864448] Starting dynamic subtest: vcs0
[415.860030] Dynamic subtest vcs0: SUCCESS (11.005s)
[415.872267] Starting dynamic subtest: vcs1
[426.868357] Dynamic subtest vcs1: SUCCESS (11.005s)
[426.879923] Starting dynamic subtest: vecs0
[437.875977] Dynamic subtest vecs0: SUCCESS (11.005s)
[437.887801] Starting dynamic subtest: ccs0
[449.907914] Dynamic subtest ccs0: SUCCESS (12.029s)
[449.910821] Subtest gt-error-state-capture: SUCCESS (68.090s)
[450.013809] [074/131] (573s left) kms_psr (psr2-sprite-blt)
[450.127075] Starting subtest: psr2-sprite-blt
[450.129430] Starting dynamic subtest: eDP-1
[451.855738] Dynamic subtest eDP-1: SUCCESS (1.726s)
[451.858105] Subtest psr2-sprite-blt: SUCCESS (1.729s)
[452.714452] [075/131] (571s left) gem_exec_reloc (basic-cpu)
[452.778344] Subtest basic-cpu: SKIP (0.000s)
[452.868637] [076/131] (571s left) gem_mmap_gtt (hang)
[452.939762] Subtest hang: SKIP (0.000s)
[453.011206] [077/131] (570s left) kms_frontbuffer_tracking (fbc-2p-rte)
[453.109521] Starting subtest: fbc-2p-rte
[453.113599] Subtest fbc-2p-rte: SKIP (0.000s)
[453.238082] [078/131] (570s left) gem_exec_reloc (basic-gtt-read-active)
[453.301324] Subtest basic-gtt-read-active: SKIP (0.000s)
[453.387495] [079/131] (570s left) gem_mmap_offset (mmap-unmap)
[453.448627] Starting subtest: mmap-unmap
[453.450646] Starting dynamic subtest: smem0
[476.964588] Dynamic subtest smem0: SUCCESS (23.514s)
[476.967458] Subtest mmap-unmap: SUCCESS (23.516s)
[477.104471] [080/131] (547s left) gem_exec_whisper (basic-contexts-priority-all)
[477.174177] Starting subtest: basic-contexts-priority-all
[500.182948] Subtest basic-contexts-priority-all: SUCCESS (23.003s)
[500.387360] [081/131] (523s left) gem_barrier_race (remote-request)
[500.454691] Starting subtest: remote-request
[500.456812] Starting dynamic subtest: rcs0
[505.617988] Dynamic subtest rcs0: SUCCESS (5.164s)
[505.620313] Subtest remote-request: SUCCESS (5.165s)
[505.801390] [082/131] (518s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[505.887143] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[505.889076] Starting dynamic subtest: pipe-A-eDP-1
[505.908325] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[505.918937] Starting dynamic subtest: pipe-B-eDP-1
[505.936933] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[505.945145] Starting dynamic subtest: pipe-C-eDP-1
[505.962685] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[505.970686] Starting dynamic subtest: pipe-D-eDP-1
[505.990266] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[505.993795] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[508.107062] [083/131] (516s left) gem_exec_reloc (basic-write-read)
[508.174462] Subtest basic-write-read: SKIP (0.000s)
[508.263527] [084/131] (516s left) api_intel_bb (blit-reloc-purge-cache)
[508.331349] Starting subtest: blit-reloc-purge-cache
[508.335821] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[508.498986] [085/131] (515s left) kms_chamelium_edid (hdmi-edid-read)
[508.897804] Subtest hdmi-edid-read: SKIP (0.000s)
[509.680800] [086/131] (514s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[514.650368] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[514.655053] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[515.511090] [087/131] (508s left) gem_ctx_engines (independent)
[515.580446] Starting subtest: independent
[515.582642] Starting dynamic subtest: rcs0
[515.725673] Dynamic subtest rcs0: SUCCESS (0.143s)
[515.737876] Starting dynamic subtest: bcs0
[515.862056] Dynamic subtest bcs0: SUCCESS (0.136s)
[515.874495] Starting dynamic subtest: vcs0
[516.014435] Dynamic subtest vcs0: SUCCESS (0.151s)
[516.026512] Starting dynamic subtest: vcs1
[516.187469] Dynamic subtest vcs1: SUCCESS (0.172s)
[516.198941] Starting dynamic subtest: vecs0
[516.355846] Dynamic subtest vecs0: SUCCESS (0.168s)
[516.367834] Starting dynamic subtest: ccs0
[516.526535] Dynamic subtest ccs0: SUCCESS (0.170s)
[516.537145] Starting dynamic subtest: all-engines
[517.124156] Dynamic subtest all-engines: SUCCESS (0.597s)
[517.126457] Subtest independent: SUCCESS (1.544s)
[518.004499] [088/131] (506s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[518.122620] Starting subtest: basic-flip-after-cursor-varying-size
[519.056787] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.933s)
[519.912413] [089/131] (504s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[520.027143] Starting subtest: yf-tiled-8bpp-rotate-0
[520.032184] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[520.162018] [090/131] (504s left) gem_eio (in-flight-internal-1us)
[520.398443] Starting subtest: in-flight-internal-1us
[521.957397] Subtest in-flight-internal-1us: SUCCESS (1.558s)
[522.093476] [091/131] (502s left) gem_spin_batch (legacy-resubmit-new)
[522.159147] Starting subtest: legacy-resubmit-new
[522.161509] Starting dynamic subtest: default
[522.166981] Dynamic subtest default: SUCCESS (0.007s)
[522.177388] Starting dynamic subtest: render
[522.179289] Dynamic subtest render: SUCCESS (0.003s)
[522.188122] Starting dynamic subtest: bsd
[522.190329] Dynamic subtest bsd: SUCCESS (0.005s)
[522.198963] Starting dynamic subtest: bsd1
[522.201116] Dynamic subtest bsd1: SUCCESS (0.004s)
[522.210056] Starting dynamic subtest: bsd2
[522.212147] Dynamic subtest bsd2: SUCCESS (0.002s)
[522.220610] Starting dynamic subtest: blt
[522.222743] Dynamic subtest blt: SUCCESS (0.004s)
[522.231238] Starting dynamic subtest: vebox
[522.233418] Dynamic subtest vebox: SUCCESS (0.004s)
[522.235580] Subtest legacy-resubmit-new: SUCCESS (0.034s)
[523.923676] [092/131] (500s left) gem_exec_params (dr1-dirt)
[523.992664] Starting subtest: DR1-dirt
[523.994946] Subtest DR1-dirt: SUCCESS (0.000s)
[524.124300] [093/131] (500s left) kms_getfb (getfb-repeated-different-handles)
[524.228742] Starting subtest: getfb-repeated-different-handles
[524.230858] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[524.361652] [094/131] (500s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[524.462446] Starting subtest: primary-x-tiled-reflect-x-180
[531.610250] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.148s)
[532.817411] [095/131] (491s left) kms_hdr (invalid-hdr)
[532.923157] Starting subtest: invalid-hdr
[535.124075] Starting dynamic subtest: pipe-A-eDP-1
[538.037385] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.915s)
[538.039652] Subtest invalid-hdr: SUCCESS (5.116s)
[538.180774] [096/131] (486s left) gem_exec_fence (syncobj-channel)
[538.626167] Starting subtest: syncobj-channel
[539.643591] Subtest syncobj-channel: SUCCESS (1.015s)
[540.057779] [097/131] (484s left) gem_ctx_persistence (processes)
[540.119809] Starting subtest: processes
[541.858611] Subtest processes: SUCCESS (1.738s)
[541.961325] [098/131] (482s left) perf_pmu (semaphore-busy)
[542.004645] Starting subtest: semaphore-busy
[542.006484] Starting dynamic subtest: rcs0
[543.661407] Dynamic subtest rcs0: SUCCESS (1.652s)
[543.673336] Starting dynamic subtest: bcs0
[545.294366] Dynamic subtest bcs0: SUCCESS (1.631s)
[545.303971] Starting dynamic subtest: vcs0
[549.392488] Dynamic subtest vcs0: SUCCESS (4.095s)
[549.403890] Starting dynamic subtest: vcs1
[555.409020] Dynamic subtest vcs1: SUCCESS (6.013s)
[555.420584] Starting dynamic subtest: vecs0
[561.424421] Dynamic subtest vecs0: SUCCESS (6.012s)
[561.436232] Starting dynamic subtest: ccs0
[564.498472] Dynamic subtest ccs0: SUCCESS (3.071s)
[564.501093] Subtest semaphore-busy: SUCCESS (22.491s)
[564.652326] [099/131] (460s left) kms_pm_lpsp (screens-disabled)
[565.765545] Starting subtest: screens-disabled
[565.770120] Subtest screens-disabled: SKIP (0.000s)
[565.867854] [100/131] (459s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[565.964066] Starting subtest: fbc-psr2-cursor-plane-onoff
[565.966303] Starting dynamic subtest: eDP-1
[565.970362] Dynamic subtest eDP-1: SKIP (0.000s)
[565.974593] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[566.065685] [101/131] (458s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[566.173756] Starting subtest: y-tiled-32bpp-rotate-180
[566.178185] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[566.319576] [102/131] (458s left) gem_exec_async (concurrent-writes)
[566.388079] Starting subtest: concurrent-writes
[566.390389] Starting dynamic subtest: rcs0
[566.403717] Dynamic subtest rcs0: SUCCESS (0.015s)
[566.415425] Starting dynamic subtest: bcs0
[566.417580] Dynamic subtest bcs0: SUCCESS (0.006s)
[566.426857] Starting dynamic subtest: vcs0
[566.429140] Dynamic subtest vcs0: SUCCESS (0.005s)
[566.438084] Starting dynamic subtest: vcs1
[566.440186] Dynamic subtest vcs1: SUCCESS (0.005s)
[566.448813] Starting dynamic subtest: vecs0
[566.450939] Dynamic subtest vecs0: SUCCESS (0.005s)
[566.459613] Starting dynamic subtest: ccs0
[566.461725] Dynamic subtest ccs0: SUCCESS (0.005s)
[566.463912] Subtest concurrent-writes: SUCCESS (0.046s)
[566.706107] [103/131] (458s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[566.768613] Starting subtest: single-wait-all-for-submit-signaled
[566.770513] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[566.903571] [104/131] (458s left) syncobj_timeline (signal)
[566.969634] Starting subtest: signal
[566.971481] Subtest signal: SUCCESS (0.000s)
[567.105148] [105/131] (458s left) kms_vrr (max-min)
[567.209761] Starting subtest: max-min
[567.215170] Subtest max-min: SKIP (0.000s)
[567.304827] [106/131] (457s left) sysfs_heartbeat_interval (idempotent)
[567.378012] Starting subtest: idempotent
[567.379957] Starting dynamic subtest: vecs0
[567.381756] Dynamic subtest vecs0: SUCCESS (0.001s)
[567.392079] Starting dynamic subtest: ccs0
[567.394062] Dynamic subtest ccs0: SUCCESS (0.001s)
[567.402209] Starting dynamic subtest: vcs0
[567.403948] Dynamic subtest vcs0: SUCCESS (0.000s)
[567.412178] Starting dynamic subtest: bcs0
[567.413933] Dynamic subtest bcs0: SUCCESS (0.001s)
[567.422094] Starting dynamic subtest: rcs0
[567.423913] Dynamic subtest rcs0: SUCCESS (0.001s)
[567.434167] Starting dynamic subtest: vcs1
[567.435885] Dynamic subtest vcs1: SUCCESS (0.001s)
[567.437548] Subtest idempotent: SUCCESS (0.009s)
[567.535849] [107/131] (457s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[567.629348] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[567.641698] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[567.778840] [108/131] (457s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[567.891992] Starting subtest: 4-tiled-16bpp-rotate-0
[570.238988] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (2.346s)
[570.408703] [109/131] (454s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[570.826809] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[571.666282] [110/131] (453s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[576.674119] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[576.676416] Starting dynamic subtest: pipe-A-eDP-1
[577.430667] Dynamic subtest pipe-A-eDP-1: SKIP (0.751s)
[577.440511] Starting dynamic subtest: pipe-B-eDP-1
[578.623820] Dynamic subtest pipe-B-eDP-1: SKIP (1.192s)
[578.628116] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.949s)
[579.904996] [111/131] (445s left) gem_fence_thrash (bo-write-verify-threaded-y)
[579.943525] Starting subtest: bo-write-verify-threaded-y
[579.977114] Subtest bo-write-verify-threaded-y: SKIP (0.029s)
[580.045152] [112/131] (445s left) kms_flip (basic-flip-vs-wf_vblank)
[580.143634] Starting subtest: basic-flip-vs-wf_vblank
[580.145794] Starting dynamic subtest: A-eDP1
[582.099703] Dynamic subtest A-eDP1: SUCCESS (1.955s)
[582.110688] Starting dynamic subtest: B-eDP1
[583.998281] Dynamic subtest B-eDP1: SUCCESS (1.897s)
[584.010743] Starting dynamic subtest: C-eDP1
[585.879806] Dynamic subtest C-eDP1: SUCCESS (1.877s)
[585.891714] Starting dynamic subtest: D-eDP1
[587.786171] Dynamic subtest D-eDP1: SUCCESS (1.906s)
[587.791528] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.648s)
[589.019847] [113/131] (436s left) kms_chamelium_color (ctm-green-to-red)
[589.129293] Subtest ctm-green-to-red: SKIP (0.000s)
[589.178458] [114/131] (436s left) gem_media_vme
[589.336447] [115/131] (436s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[589.457779] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[590.293773] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s)
[590.505204] [116/131] (435s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[590.574179] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[590.578747] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[590.778689] [117/131] (434s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[590.892753] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[597.838329] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.955s)
[597.975874] [118/131] (427s left) kms_flip (busy-flip)
[598.082196] Starting subtest: busy-flip
[598.084440] Starting dynamic subtest: A-eDP1
[599.770932] Dynamic subtest A-eDP1: SUCCESS (1.687s)
[599.782247] Starting dynamic subtest: B-eDP1
[601.456787] Dynamic subtest B-eDP1: SUCCESS (1.684s)
[601.472023] Starting dynamic subtest: C-eDP1
[603.148398] Dynamic subtest C-eDP1: SUCCESS (1.688s)
[603.160659] Starting dynamic subtest: D-eDP1
[604.855661] Dynamic subtest D-eDP1: SUCCESS (1.705s)
[604.860944] Subtest busy-flip: SUCCESS (6.777s)
[606.093785] [119/131] (419s left) gem_exec_schedule (preempt-queue-contexts-chain)
[606.179930] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[606.491154] [120/131] (419s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[606.595262] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[629.483305] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.889s)
[629.654981] [121/131] (396s left) syncobj_basic (bad-destroy)
[629.739410] Starting subtest: bad-destroy
[629.741780] Subtest bad-destroy: SUCCESS (0.000s)
[629.878586] [122/131] (396s left) gem_mmap (basic)
[629.947959] Subtest basic: SKIP (0.000s)
[630.008425] [123/131] (395s left) kms_flip (wf_vblank-ts-check)
[630.107498] Starting subtest: wf_vblank-ts-check
[630.109700] Starting dynamic subtest: A-eDP1
[639.003461] Dynamic subtest A-eDP1: SUCCESS (8.896s)
[639.014076] Starting dynamic subtest: B-eDP1
[647.894152] Dynamic subtest B-eDP1: SUCCESS (8.889s)
[647.904650] Starting dynamic subtest: C-eDP1
[656.778634] Dynamic subtest C-eDP1: SUCCESS (8.883s)
[656.788566] Starting dynamic subtest: D-eDP1
[665.679089] Dynamic subtest D-eDP1: SUCCESS (8.899s)
[665.681403] Subtest wf_vblank-ts-check: SUCCESS (35.575s)
[666.899361] [124/131] (359s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[666.998386] Starting subtest: fbc-psr-cursor-mmap-gtt
[667.000773] Starting dynamic subtest: eDP-1
[667.005393] Dynamic subtest eDP-1: SKIP (0.000s)
[667.009787] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.003s)
[667.104712] [125/131] (358s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[667.202553] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[667.206947] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[667.333779] [126/131] (358s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[667.434767] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[667.438888] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[667.565857] [127/131] (358s left) kms_vblank (query-busy)
[667.665044] Starting subtest: query-busy
[667.666846] Starting dynamic subtest: pipe-A-eDP-1
[669.539738] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[669.553385] Starting dynamic subtest: pipe-D-eDP-1
[672.110508] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[672.112506] Subtest query-busy: SUCCESS (4.445s)
[673.000116] [128/131] (353s left) gem_pwrite (basic-random)
[673.070251] Subtest basic-random: SKIP (0.000s)
[673.143425] [129/131] (353s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[673.242964] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[673.247070] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[673.348103] [130/131] (352s left) gem_userptr_blits (huge-split)
[673.419705] Starting subtest: huge-split
[673.424429] Subtest huge-split: SUCCESS (0.007s)
[673.586422] [131/131] (352s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[673.683973] Starting subtest: psr-rgb101010-draw-blt
[680.894275] Subtest psr-rgb101010-draw-blt: SUCCESS (7.213s)
[681.054298] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_pipe_crc_basic
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: gem_gpgpu_fill
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: gem_exec_flush
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: i915_pm_rpm
results: parsing output: 18/ for test: drm_buddy
results: parsing output: 19/ for test: kms_psr2_su
results: parsing output: 20/ for test: prime_busy
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gen3_render_mixed_blits
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: gem_exec_big
results: parsing output: 33/ for test: kms_hdmi_inject
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: i915_query
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_getfb
results: parsing output: 43/ for test: kms_joiner
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_draw_crc
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_plane_lowres
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: kms_selftest
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_busy
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_ctx_param
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_hangman
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: gem_mmap_offset
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: gem_barrier_race
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_chamelium_edid
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: gem_ctx_engines
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_getfb
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_hdr
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_pm_lpsp
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_exec_async
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_vrr
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: gem_fence_thrash
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: gem_media_vme
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: syncobj_basic
results: parsing output: 121/ for test: gem_mmap
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: gem_pwrite
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.