[59.427465] Initializing watchdogs
[59.427510]   /dev/watchdog0
[59.441147] [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]
[59.445469] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.447801] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.451480] [001/131] (960s left) gem_busy (busy)
[59.542965] Starting subtest: busy
[59.545256] Starting dynamic subtest: all-engines
[59.612751] Dynamic subtest all-engines: SUCCESS (0.072s)
[59.623307] Starting dynamic subtest: rcs0
[61.262162] Dynamic subtest rcs0: SUCCESS (1.649s)
[61.271949] Starting dynamic subtest: bcs0
[61.319590] Dynamic subtest bcs0: SUCCESS (0.057s)
[61.328453] Starting dynamic subtest: vcs0
[61.359928] Dynamic subtest vcs0: SUCCESS (0.039s)
[61.368183] Starting dynamic subtest: vcs1
[63.303721] Dynamic subtest vcs1: SUCCESS (1.942s)
[63.313113] Starting dynamic subtest: vecs0
[65.291788] Dynamic subtest vecs0: SUCCESS (1.987s)
[65.301184] Starting dynamic subtest: ccs0
[67.336480] Dynamic subtest ccs0: SUCCESS (2.046s)
[67.339065] Subtest busy: SUCCESS (7.795s)
[67.694606] [002/131] (952s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[67.791661] Starting subtest: psr-rgb565-draw-pwrite
[74.972151] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.183s)
[75.074995] [003/131] (944s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[75.204299] Starting subtest: flip-vs-cursor-busy-crc-atomic
[76.045633] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.841s)
[76.849217] [004/131] (943s left) kms_flip (absolute-wf_vblank-interruptible)
[76.948082] Starting subtest: absolute-wf_vblank-interruptible
[76.950549] Starting dynamic subtest: A-eDP1
[85.705896] Dynamic subtest A-eDP1: SUCCESS (8.758s)
[85.715955] Starting dynamic subtest: B-eDP1
[94.435463] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[94.446813] Starting dynamic subtest: C-eDP1
[103.153679] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[103.161832] Starting dynamic subtest: D-eDP1
[111.900897] Dynamic subtest D-eDP1: SUCCESS (8.746s)
[111.905451] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.958s)
[113.106958] [005/131] (907s left) kms_cursor_edge_walk (128x128-right-edge)
[113.207415] Starting subtest: 128x128-right-edge
[113.209682] Starting dynamic subtest: pipe-A-eDP-1
[116.687881] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[116.696804] Starting dynamic subtest: pipe-D-eDP-1
[119.799806] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[119.802322] Subtest 128x128-right-edge: SUCCESS (6.593s)
[120.602445] [006/131] (899s left) kms_plane_multiple (tiling-x)
[120.695223] Starting subtest: tiling-x
[120.697615] Starting dynamic subtest: pipe-A-eDP-1
[124.339521] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.644s)
[124.349191] Starting dynamic subtest: pipe-B-eDP-1
[128.778445] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.438s)
[128.787306] Starting dynamic subtest: pipe-C-eDP-1
[133.115986] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.336s)
[133.130935] Starting dynamic subtest: pipe-D-eDP-1
[137.442171] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.325s)
[137.444062] Subtest tiling-x: SUCCESS (16.747s)
[138.253596] [007/131] (881s left) kms_cursor_crc (cursor-offscreen-256x85)
[138.505434] Starting subtest: cursor-offscreen-256x85
[138.550283] Subtest cursor-offscreen-256x85: SKIP (0.040s)
[138.715806] [008/131] (881s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[138.811718] Starting subtest: async-flip-with-page-flip-events-linear
[139.196395] Starting dynamic subtest: pipe-A-eDP-1
[141.928630] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.731s)
[142.292551] Starting dynamic subtest: pipe-B-eDP-1
[145.053101] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[145.413773] Starting dynamic subtest: pipe-C-eDP-1
[148.176633] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[148.551729] Starting dynamic subtest: pipe-D-eDP-1
[151.307577] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[151.310723] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.495s)
[152.501708] [009/131] (867s left) gem_exec_schedule (manyslice)
[152.573465] Starting subtest: manyslice
[152.575714] Starting dynamic subtest: rcs0
[157.703629] Dynamic subtest rcs0: SUCCESS (5.138s)
[157.715340] Starting dynamic subtest: bcs0
[164.324765] Dynamic subtest bcs0: SUCCESS (6.620s)
[164.337875] Starting dynamic subtest: vcs0
[170.411590] Dynamic subtest vcs0: SUCCESS (6.084s)
[170.420138] Starting dynamic subtest: vcs1
[176.484898] Dynamic subtest vcs1: SUCCESS (6.071s)
[176.495691] Starting dynamic subtest: vecs0
[183.061633] Dynamic subtest vecs0: SUCCESS (6.575s)
[183.071636] Starting dynamic subtest: ccs0
[189.754384] Dynamic subtest ccs0: SUCCESS (6.692s)
[189.756997] Subtest manyslice: SUCCESS (37.188s)
[190.053504] [010/131] (830s left) syncobj_wait (reset-during-wait-for-submit)
[190.111590] Starting subtest: reset-during-wait-for-submit
[190.215801] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[190.291076] [011/131] (830s left) gem_ctx_param (invalid-set-no-zeromap)
[190.350742] Starting subtest: invalid-set-no-zeromap
[190.353106] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[190.425359] [012/131] (829s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[190.476104] Starting subtest: rel-constants-invalid-rel-gen5
[190.478559] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[190.577112] [013/131] (829s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[190.689896] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[190.692225] Starting dynamic subtest: pipe-A-default-mode
[193.454933] Dynamic subtest pipe-A-default-mode: SUCCESS (2.764s)
[193.457417] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.765s)
[194.291258] [014/131] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[194.390090] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[194.394307] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[194.497369] [015/131] (825s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[194.549926] Starting subtest: mixed-tiled-to-y-tiled-ccs
[194.554492] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[194.735907] [016/131] (825s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[194.822461] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[194.826871] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[194.903777] [017/131] (825s left) kms_flip (2x-plain-flip-interruptible)
[194.995593] Starting subtest: 2x-plain-flip-interruptible
[195.006331] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[195.080194] [018/131] (825s left) gem_exec_schedule (submit-late-slice)
[195.149044] Starting subtest: submit-late-slice
[195.150935] Starting dynamic subtest: rcs0
[195.183364] Dynamic subtest rcs0: SUCCESS (0.042s)
[195.191570] Starting dynamic subtest: bcs0
[195.211385] Dynamic subtest bcs0: SUCCESS (0.028s)
[195.222293] Starting dynamic subtest: vcs0
[195.240586] Dynamic subtest vcs0: SUCCESS (0.029s)
[195.248774] Starting dynamic subtest: vcs1
[195.268992] Dynamic subtest vcs1: SUCCESS (0.028s)
[195.277048] Starting dynamic subtest: vecs0
[195.297959] Dynamic subtest vecs0: SUCCESS (0.029s)
[195.306278] Starting dynamic subtest: ccs0
[195.331263] Dynamic subtest ccs0: SUCCESS (0.033s)
[195.333542] Subtest submit-late-slice: SUCCESS (0.191s)
[196.377734] [019/131] (824s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[196.473800] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[196.485297] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[196.588485] [020/131] (824s left) kms_vrr (flip-basic)
[196.684765] Starting subtest: flip-basic
[196.690737] Subtest flip-basic: SKIP (0.000s)
[196.765448] [021/131] (823s left) gem_exec_fence (syncobj-import)
[197.291350] Starting subtest: syncobj-import
[197.296640] Subtest syncobj-import: SUCCESS (0.005s)
[198.421170] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[198.424799] [022/131] (822s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[198.487435] Starting subtest: invalid-signal-one-illegal-handle
[198.489445] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[198.608383] [023/131] (822s left) gem_gpgpu_fill (offset-16x16)
[198.659249] Starting subtest: offset-16x16
[198.665570] Subtest offset-16x16: SUCCESS (0.008s)
[198.800070] [024/131] (822s left) kms_dp_linktrain_fallback (dp-fallback)
[198.916229] Starting subtest: dp-fallback
[198.922803] Subtest dp-fallback: SKIP (0.000s)
[198.983621] [025/131] (821s left) gem_mmap_gtt (basic-read-write)
[199.043879] Subtest basic-read-write: SKIP (0.000s)
[199.102212] [026/131] (821s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[199.230676] Starting subtest: 2x-cursor-vs-flip-atomic
[199.235547] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[199.375763] [027/131] (821s left) gem_close (many-handles-one-vma)
[199.429567] Starting subtest: many-handles-one-vma
[199.451468] Subtest many-handles-one-vma: SUCCESS (0.024s)
[199.561901] [028/131] (821s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[199.681468] Starting subtest: cursorA-vs-flipA-toggle
[210.802730] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.118s)
[211.623988] [029/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[211.736915] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[211.741186] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[211.827347] [030/131] (809s left) api_intel_bb (crc32)
[211.894455] Starting subtest: crc32
[211.896327] Starting dynamic subtest: rcs0-smem0
[212.227335] Dynamic subtest rcs0-smem0: SUCCESS (0.332s)
[212.237686] Starting dynamic subtest: bcs0-smem0
[212.545996] Dynamic subtest bcs0-smem0: SUCCESS (0.315s)
[212.556441] Starting dynamic subtest: vcs0-smem0
[212.926741] Dynamic subtest vcs0-smem0: SUCCESS (0.378s)
[212.936681] Starting dynamic subtest: vcs1-smem0
[213.311080] Dynamic subtest vcs1-smem0: SUCCESS (0.382s)
[213.322501] Starting dynamic subtest: vecs0-smem0
[213.666232] Dynamic subtest vecs0-smem0: SUCCESS (0.353s)
[213.677417] Starting dynamic subtest: ccs0-smem0
[214.022055] Dynamic subtest ccs0-smem0: SUCCESS (0.353s)
[214.024876] Subtest crc32: SUCCESS (2.129s)
[214.139929] [031/131] (806s left) gem_eio (in-flight-immediate)
[214.367844] Starting subtest: in-flight-immediate
[222.960570] Subtest in-flight-immediate: SUCCESS (8.590s)
[223.076137] [032/131] (798s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[223.170507] Starting subtest: basic-max-pipe-crc-check
[223.175102] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[223.223228] [033/131] (797s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[223.323754] Starting subtest: 4-tiled-64bpp-rotate-0
[224.819497] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.496s)
[225.009478] [034/131] (796s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[225.107047] Starting subtest: x-tiled-64bpp-rotate-90
[225.128914] Subtest x-tiled-64bpp-rotate-90: SKIP (0.021s)
[225.240335] [035/131] (796s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[225.347775] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[225.351913] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[225.459392] [036/131] (795s left) gem_softpin (evict-active-interruptible)
[225.532053] Starting subtest: evict-active-interruptible
[225.539963] Subtest evict-active-interruptible: SUCCESS (0.008s)
[225.658939] [037/131] (795s left) gem_wait (write-busy)
[225.731487] Starting subtest: write-busy
[225.733932] Starting dynamic subtest: all-engines
[226.318422] Dynamic subtest all-engines: SUCCESS (0.586s)
[226.336887] Starting dynamic subtest: rcs0
[226.877975] Dynamic subtest rcs0: SUCCESS (0.559s)
[226.893751] Starting dynamic subtest: bcs0
[227.433771] Dynamic subtest bcs0: SUCCESS (0.555s)
[227.449430] Starting dynamic subtest: vcs0
[229.315889] Dynamic subtest vcs0: SUCCESS (1.879s)
[229.326841] Starting dynamic subtest: vcs1
[231.299283] Dynamic subtest vcs1: SUCCESS (1.981s)
[231.310269] Starting dynamic subtest: vecs0
[233.283264] Dynamic subtest vecs0: SUCCESS (1.981s)
[233.293635] Starting dynamic subtest: ccs0
[233.843652] Dynamic subtest ccs0: SUCCESS (0.558s)
[233.845988] Subtest write-busy: SUCCESS (8.112s)
[234.042292] [038/131] (787s left) i915_pm_rc6_residency (rc6-idle)
[234.099300] Starting subtest: rc6-idle
[234.122350] Starting dynamic subtest: gt0-rcs0
[258.404907] Dynamic subtest gt0-rcs0: SUCCESS (24.282s)
[258.415406] Starting dynamic subtest: gt0-bcs0
[282.757843] Dynamic subtest gt0-bcs0: SUCCESS (24.351s)
[282.767497] Starting dynamic subtest: gt0-ccs0
[307.193834] Dynamic subtest gt0-ccs0: SUCCESS (24.432s)
[307.203199] Starting dynamic subtest: gt1-vcs0
[313.368610] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[313.381045] Starting dynamic subtest: gt1-vecs0
[319.540686] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[319.543812] Subtest rc6-idle: SUCCESS (85.442s)
[319.635510] [039/131] (701s left) kms_addfb_basic (bo-too-small)
[319.731971] Starting subtest: bo-too-small
[319.734188] Subtest bo-too-small: SUCCESS (0.000s)
[319.822423] [040/131] (701s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[319.922749] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[319.927038] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[319.994365] [041/131] (701s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[320.048172] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[320.050562] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[320.154249] [042/131] (701s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[320.257194] Starting subtest: fbc-psr2-cursor-plane-update-sf
[320.259539] Starting dynamic subtest: pipe-A-eDP-1
[320.330125] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[320.340093] Starting dynamic subtest: pipe-B-eDP-1
[321.484174] Dynamic subtest pipe-B-eDP-1: SKIP (1.153s)
[321.488598] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.232s)
[322.678720] [043/131] (698s left) gem_compute (compute-square)
[322.735552] Starting subtest: compute-square
[322.737904] Subtest compute-square: SUCCESS (0.005s)
[322.860830] [044/131] (698s left) kms_addfb_basic (bad-pitch-1024)
[322.923085] Starting subtest: bad-pitch-1024
[322.925414] Subtest bad-pitch-1024: SUCCESS (0.000s)
[323.053104] [045/131] (698s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[323.151822] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[323.155767] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[323.252968] [046/131] (698s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[323.346052] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[324.314016] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.968s)
[324.437521] [047/131] (697s left) kms_invalid_mode (bad-vtotal)
[324.525423] Starting subtest: bad-vtotal
[324.527775] Starting dynamic subtest: pipe-A-eDP-1
[324.810560] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[324.819997] Starting dynamic subtest: pipe-B-eDP-1
[324.822406] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[324.831079] Starting dynamic subtest: pipe-C-eDP-1
[324.833512] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[324.841877] Starting dynamic subtest: pipe-D-eDP-1
[324.844259] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[324.846636] Subtest bad-vtotal: SUCCESS (0.291s)
[325.617430] [048/131] (696s left) kms_atomic (crtc-invalid-params)
[325.717169] Starting subtest: crtc-invalid-params
[325.719381] Starting dynamic subtest: pipe-A-eDP-1
[326.069843] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.353s)
[326.072330] Subtest crtc-invalid-params: SUCCESS (0.354s)
[326.933912] [049/131] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[327.033327] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[327.037118] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[327.149093] [050/131] (694s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[327.269325] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[334.167292] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.898s)
[334.310047] [051/131] (687s left) gen9_exec_parse (bb-start-cmd)
[334.372971] Subtest bb-start-cmd: SKIP (0.000s)
[334.456998] [052/131] (687s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[334.553244] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[334.555542] Starting dynamic subtest: pipe-A-eDP-1
[334.613485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[334.931720] Starting dynamic subtest: pipe-B-eDP-1
[335.699126] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.777s)
[335.985957] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.431s)
[336.861420] [053/131] (685s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[336.959172] Starting subtest: fbcpsr-shrfb-scaledprimary
[342.749195] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.794s)
[342.882964] [054/131] (679s left) i915_query (hwconfig_table)
[342.945813] Starting subtest: hwconfig_table
[343.248510] Subtest hwconfig_table: SUCCESS (0.001s)
[343.291012] [055/131] (678s left) kms_psr (pr-primary-page-flip)
[343.379078] Starting subtest: pr-primary-page-flip
[343.383566] Subtest pr-primary-page-flip: SKIP (0.000s)
[343.451388] [056/131] (678s left) gem_exec_reloc (basic-write-cpu)
[343.510294] Subtest basic-write-cpu: SKIP (0.000s)
[343.592044] [057/131] (678s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[343.660620] Starting subtest: etime-multi-wait-all-available-unsubmitted
[343.768774] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.106s)
[343.856802] [058/131] (678s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[344.265889] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[345.109845] [059/131] (677s left) gem_exec_endless (dispatch)
[345.181310] Starting subtest: dispatch
[345.183678] Starting dynamic subtest: rcs0
[345.191468] Dynamic subtest rcs0: SUCCESS (0.005s)
[345.201973] Starting dynamic subtest: bcs0
[345.206446] Dynamic subtest bcs0: SUCCESS (0.004s)
[345.215495] Starting dynamic subtest: vcs0
[345.220163] Dynamic subtest vcs0: SUCCESS (0.005s)
[345.230186] Starting dynamic subtest: vcs1
[345.234298] Dynamic subtest vcs1: SUCCESS (0.006s)
[345.242129] Starting dynamic subtest: vecs0
[345.246771] Dynamic subtest vecs0: SUCCESS (0.007s)
[345.261788] Starting dynamic subtest: ccs0
[345.266502] Dynamic subtest ccs0: SUCCESS (0.010s)
[345.268481] Subtest dispatch: SUCCESS (0.044s)
[346.362303] [060/131] (675s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[346.471035] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[347.361346] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.892s)
[347.521249] [061/131] (674s left) gem_pxp (create-protected-buffer)
[347.642598] Starting subtest: create-protected-buffer
[347.644984] Subtest create-protected-buffer: SUCCESS (0.000s)
[347.745381] [062/131] (674s left) prime_vgem (wait)
[347.828392] Starting subtest: wait
[347.830615] Starting dynamic subtest: rcs0
[347.886230] Dynamic subtest rcs0: SUCCESS (0.060s)
[347.895846] Starting dynamic subtest: bcs0
[347.955490] Dynamic subtest bcs0: SUCCESS (0.068s)
[347.964839] Starting dynamic subtest: vcs0
[348.000657] Dynamic subtest vcs0: SUCCESS (0.044s)
[348.009611] Starting dynamic subtest: vcs1
[348.048254] Dynamic subtest vcs1: SUCCESS (0.047s)
[348.057072] Starting dynamic subtest: vecs0
[348.092423] Dynamic subtest vecs0: SUCCESS (0.043s)
[348.101351] Starting dynamic subtest: ccs0
[348.136311] Dynamic subtest ccs0: SUCCESS (0.043s)
[348.138621] Subtest wait: SUCCESS (0.312s)
[348.253659] [063/131] (674s left) perf_pmu (rc6)
[348.288229] Starting subtest: rc6
[348.289840] Starting dynamic subtest: gt0
[354.663774] Dynamic subtest gt0: SUCCESS (6.374s)
[354.676494] Starting dynamic subtest: runtime-pm-gt0
[362.432781] Dynamic subtest runtime-pm-gt0: SUCCESS (7.765s)
[362.442965] Starting dynamic subtest: runtime-pm-long-gt0
[374.932894] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.499s)
[374.945052] Starting dynamic subtest: other-idle-gt0
[381.275997] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[381.287123] Starting dynamic subtest: gt1
[387.616608] Dynamic subtest gt1: SUCCESS (6.339s)
[387.628936] Starting dynamic subtest: runtime-pm-gt1
[395.066398] Dynamic subtest runtime-pm-gt1: SUCCESS (7.446s)
[395.078782] Starting dynamic subtest: runtime-pm-long-gt1
[407.531427] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.462s)
[407.543908] Starting dynamic subtest: other-idle-gt1
[413.879848] Dynamic subtest other-idle-gt1: SUCCESS (6.345s)
[413.882800] Subtest rc6: SUCCESS (65.589s)
[415.018067] [064/131] (607s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[415.115421] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[418.749833] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.637s)
[419.917710] [065/131] (602s left) gem_exec_reloc (basic-wc)
[419.981413] Subtest basic-wc: SKIP (0.000s)
[420.053355] [066/131] (602s left) kms_plane (pixel-format-y-tiled-modifier)
[420.144092] Starting subtest: pixel-format-y-tiled-modifier
[420.148284] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[420.190638] [067/131] (602s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[420.289834] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[420.293977] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[420.352687] [068/131] (602s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[420.411059] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[420.480801] [069/131] (602s left) kms_pm_rpm (modeset-lpsp-stress)
[422.400961] Starting subtest: modeset-lpsp-stress
[438.255980] Subtest modeset-lpsp-stress: SUCCESS (15.854s)
[438.349588] [070/131] (584s left) drm_buddy (drm_buddy)
[438.391928] Starting subtest: drm_buddy
[438.396332] Subtest drm_buddy: SKIP (0.001s)
[438.438261] [071/131] (584s left) gem_exec_schedule (deep)
[438.607382] Starting subtest: deep
[438.610079] Starting dynamic subtest: rcs0
[444.133056] Dynamic subtest rcs0: SKIP (5.523s)
[444.145274] Starting dynamic subtest: vcs0
[454.746180] Dynamic subtest vcs0: SUCCESS (10.613s)
[454.758145] Starting dynamic subtest: vcs1
[466.210485] Dynamic subtest vcs1: SUCCESS (11.463s)
[466.227552] Starting dynamic subtest: vecs0
[478.090540] Dynamic subtest vecs0: SUCCESS (11.880s)
[478.107295] Starting dynamic subtest: ccs0
[490.428763] Dynamic subtest ccs0: SUCCESS (12.335s)
[490.431902] Subtest deep: SUCCESS (51.819s)
[491.420835] [072/131] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[491.517207] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[498.650974] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.137s)
[498.753989] [073/131] (524s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[498.813032] Subtest no-spare-fences-busy: SKIP (0.000s)
[498.894280] [074/131] (524s left) perf_pmu (busy-accuracy-50)
[498.931318] Starting subtest: busy-accuracy-50
[498.933163] Starting dynamic subtest: rcs0
[500.469118] Dynamic subtest rcs0: SUCCESS (1.537s)
[500.478311] Starting dynamic subtest: bcs0
[502.006747] Dynamic subtest bcs0: SUCCESS (1.536s)
[502.017680] Starting dynamic subtest: vcs0
[503.552565] Dynamic subtest vcs0: SUCCESS (1.543s)
[503.562201] Starting dynamic subtest: vcs1
[505.098204] Dynamic subtest vcs1: SUCCESS (1.543s)
[505.109380] Starting dynamic subtest: vecs0
[506.641068] Dynamic subtest vecs0: SUCCESS (1.541s)
[506.652572] Starting dynamic subtest: ccs0
[508.190706] Dynamic subtest ccs0: SUCCESS (1.547s)
[508.193248] Subtest busy-accuracy-50: SUCCESS (9.258s)
[508.290855] [075/131] (514s left) gem_exec_params (batch-first)
[508.366659] Starting subtest: batch-first
[508.377600] Subtest batch-first: SUCCESS (0.011s)
[508.476869] [076/131] (514s left) kms_lease (master-vs-lease)
[508.571269] Starting subtest: master-vs-lease
[508.573582] Subtest master-vs-lease: SUCCESS (0.002s)
[508.657625] [077/131] (514s left) kms_pm_dc (dc6-dpms)
[509.754718] Starting subtest: dc6-dpms
[511.799566] Subtest dc6-dpms: SUCCESS (2.044s)
[511.855698] [078/131] (511s left) gem_userptr_blits (create-destroy-sync)
[511.920396] Starting subtest: create-destroy-sync
[516.937461] Subtest create-destroy-sync: SUCCESS (5.016s)
[517.040359] [079/131] (506s left) syncobj_timeline (wait-for-submit-delayed-submit)
[517.101092] Starting subtest: wait-for-submit-delayed-submit
[517.201719] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[517.259696] [080/131] (505s left) gem_exec_params (no-vebox)
[517.321817] Starting subtest: no-vebox
[517.326708] Subtest no-vebox: SUCCESS (0.004s)
[519.348435] [081/131] (503s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[519.451434] Starting subtest: psr2-overlay-plane-move-continuous-sf
[519.453863] Starting dynamic subtest: pipe-A-eDP-1
[525.446790] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.998s)
[525.456531] Starting dynamic subtest: pipe-B-eDP-1
[532.140392] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.690s)
[532.142666] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.690s)
[532.917320] [082/131] (490s left) gem_exec_store (basic)
[532.992353] Starting subtest: basic
[533.091517] Subtest basic: SUCCESS (0.102s)
[533.251291] [083/131] (490s left) perf_pmu (event-wait)
[533.301095] Starting subtest: event-wait
[533.303279] Starting dynamic subtest: rcs0
[533.307336] Dynamic subtest rcs0: SKIP (0.000s)
[533.311597] Subtest event-wait: SKIP (0.002s)
[533.382635] [084/131] (489s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[533.483409] Starting subtest: psr-farfromfence-mmap-gtt
[533.487712] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[533.560624] [085/131] (489s left) gem_exec_balancer (hog)
[533.630649] Starting subtest: hog
[533.635261] Subtest hog: SKIP (0.000s)
[533.911396] [086/131] (489s left) kms_psr (fbc-psr2-cursor-plane-move)
[534.005056] Starting subtest: fbc-psr2-cursor-plane-move
[534.007344] Starting dynamic subtest: eDP-1
[534.011339] Dynamic subtest eDP-1: SKIP (0.000s)
[534.015354] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[534.075411] [087/131] (489s left) i915_hangman (gt-error-state-capture)
[534.133382] Starting subtest: gt-error-state-capture
[534.135641] Starting dynamic subtest: rcs0
[545.250561] Dynamic subtest rcs0: SUCCESS (11.116s)
[545.264014] Starting dynamic subtest: bcs0
[557.283916] Dynamic subtest bcs0: SUCCESS (12.030s)
[557.295895] Starting dynamic subtest: vcs0
[569.186710] Dynamic subtest vcs0: SUCCESS (11.899s)
[569.199703] Starting dynamic subtest: vcs1
[580.194786] Dynamic subtest vcs1: SUCCESS (11.004s)
[580.207736] Starting dynamic subtest: vecs0
[591.201823] Dynamic subtest vecs0: SUCCESS (11.004s)
[591.214144] Starting dynamic subtest: ccs0
[602.274751] Dynamic subtest ccs0: SUCCESS (11.069s)
[602.277800] Subtest gt-error-state-capture: SUCCESS (68.140s)
[602.334643] [088/131] (421s left) syncobj_wait (invalid-reset-zero-handles)
[602.394234] Starting subtest: invalid-reset-zero-handles
[602.396558] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[602.466400] [089/131] (421s left) kms_draw_crc (draw-method-mmap-wc)
[602.559807] Starting subtest: draw-method-mmap-wc
[602.561964] Starting dynamic subtest: xrgb8888-untiled
[602.780143] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[602.792155] Starting dynamic subtest: rgb565-untiled
[602.990997] Dynamic subtest rgb565-untiled: SUCCESS (0.209s)
[603.000097] Starting dynamic subtest: xrgb2101010-untiled
[603.190843] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[603.201122] Starting dynamic subtest: xbgr16161616f-untiled
[603.401858] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[603.411204] Starting dynamic subtest: xrgb8888-xtiled
[603.524701] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[603.535177] Starting dynamic subtest: rgb565-xtiled
[603.646376] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[603.655175] Starting dynamic subtest: xrgb2101010-xtiled
[603.757442] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[603.766787] Starting dynamic subtest: xbgr16161616f-xtiled
[603.890883] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[603.900374] Starting dynamic subtest: xrgb8888-4tiled
[604.035096] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.143s)
[604.043614] Starting dynamic subtest: rgb565-4tiled
[604.179773] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[604.189160] Starting dynamic subtest: xrgb2101010-4tiled
[604.313108] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[604.322515] Starting dynamic subtest: xbgr16161616f-4tiled
[604.479579] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.165s)
[604.481351] Subtest draw-method-mmap-wc: SUCCESS (1.922s)
[604.537843] [090/131] (419s left) syncobj_wait (invalid-signal-one-illegal-handle)
[604.587613] Starting subtest: invalid-signal-one-illegal-handle
[604.589607] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[604.651913] [091/131] (418s left) api_intel_bb (render-ccs)
[604.695113] Starting subtest: render-ccs
[605.278466] Subtest render-ccs: SUCCESS (0.582s)
[605.359439] [092/131] (418s left) syncobj_timeline (wait-all-snapshot)
[605.418067] Starting subtest: wait-all-snapshot
[605.499063] Subtest wait-all-snapshot: SUCCESS (0.082s)
[605.554379] [093/131] (418s left) kms_color (ctm-negative)
[605.645945] Starting subtest: ctm-negative
[605.648064] Starting dynamic subtest: pipe-A-eDP-1
[606.342177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[606.352317] Starting dynamic subtest: pipe-B-eDP-1
[607.736673] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[607.748143] Starting dynamic subtest: pipe-C-eDP-1
[609.106043] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s)
[609.116121] Starting dynamic subtest: pipe-D-eDP-1
[610.435862] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[610.438595] Subtest ctm-negative: SUCCESS (4.791s)
[611.217384] [094/131] (412s left) gem_mmap_offset (mmap-boundaries)
[611.273345] Starting subtest: mmap-boundaries
[611.275685] Starting dynamic subtest: smem0
[611.548859] Dynamic subtest smem0: SUCCESS (0.276s)
[611.551807] Subtest mmap-boundaries: SUCCESS (0.277s)
[611.652730] [095/131] (412s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[611.758517] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[611.762750] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[611.836978] [096/131] (411s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[611.937716] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[616.553198] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.621s)
[617.717196] [097/131] (406s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[617.817889] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[622.092916] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.278s)
[623.201095] [098/131] (400s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[623.294935] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[623.297092] Starting dynamic subtest: pipe-A-eDP-1
[623.321424] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[623.331641] Starting dynamic subtest: pipe-B-eDP-1
[623.354543] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[623.363652] Starting dynamic subtest: pipe-C-eDP-1
[623.386819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[623.395589] Starting dynamic subtest: pipe-D-eDP-1
[623.420513] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[623.425225] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[625.556170] [099/131] (398s left) gem_lmem_swapping (verify)
[625.601081] Subtest verify: SKIP (0.000s)
[625.640934] [100/131] (398s left) gem_spin_batch (resubmit-new)
[625.701249] Starting subtest: resubmit-new
[625.703728] Starting dynamic subtest: rcs0
[625.709079] Dynamic subtest rcs0: SUCCESS (0.007s)
[625.720205] Starting dynamic subtest: bcs0
[625.722433] Dynamic subtest bcs0: SUCCESS (0.003s)
[625.731924] Starting dynamic subtest: vcs0
[625.734261] Dynamic subtest vcs0: SUCCESS (0.004s)
[625.742897] Starting dynamic subtest: vcs1
[625.744718] Dynamic subtest vcs1: SUCCESS (0.004s)
[625.753329] Starting dynamic subtest: vecs0
[625.755260] Dynamic subtest vecs0: SUCCESS (0.006s)
[625.763862] Starting dynamic subtest: ccs0
[625.765860] Dynamic subtest ccs0: SUCCESS (0.004s)
[625.767811] Subtest resubmit-new: SUCCESS (0.033s)
[627.351284] [101/131] (396s left) kms_scaling_modes (scaling-mode-center)
[627.448473] Starting subtest: scaling-mode-center
[627.450635] Starting dynamic subtest: pipe-A-eDP-1
[627.552473] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[627.565073] Starting dynamic subtest: pipe-B-eDP-1
[628.702120] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[628.714136] Starting dynamic subtest: pipe-C-eDP-1
[629.815950] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[629.826696] Starting dynamic subtest: pipe-D-eDP-1
[630.947436] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[630.949745] Subtest scaling-mode-center: SUCCESS (3.502s)
[632.094067] [102/131] (391s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[632.190038] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[632.192328] Starting dynamic subtest: pipe-A-eDP-1
[632.212778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[632.224561] Starting dynamic subtest: pipe-B-eDP-1
[632.243821] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[632.253473] Starting dynamic subtest: pipe-C-eDP-1
[632.272805] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[632.283616] Starting dynamic subtest: pipe-D-eDP-1
[632.302786] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[632.304974] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[634.358393] [103/131] (389s left) perf (short-reads)
[634.447559] Starting subtest: short-reads
[634.460032] Subtest short-reads: SUCCESS (0.015s)
[634.511234] [104/131] (389s left) kms_content_protection (suspend-resume)
[634.672445] Starting subtest: suspend-resume
[634.677056] Subtest suspend-resume: SKIP (0.000s)
[634.765051] [105/131] (389s left) gem_ctx_persistence (heartbeat-many)
[634.839689] Starting subtest: heartbeat-many
[634.844098] Subtest heartbeat-many: SKIP (0.000s)
[634.914312] [106/131] (389s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[635.012440] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[635.016760] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[635.091585] [107/131] (389s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[635.184357] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[635.188589] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[635.256390] [108/131] (389s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[635.347237] Starting subtest: psr-1p-pri-indfb-multidraw
[657.861758] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.516s)
[657.954119] [109/131] (366s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[658.059232] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[658.061018] Starting dynamic subtest: pipe-A-eDP-1
[658.079322] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[658.088687] Starting dynamic subtest: pipe-B-eDP-1
[658.107169] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[658.118257] Starting dynamic subtest: pipe-C-eDP-1
[658.135259] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[658.145117] Starting dynamic subtest: pipe-D-eDP-1
[658.163525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[658.166861] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[660.240133] [110/131] (364s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[660.338088] Starting subtest: y-tiled-8bpp-rotate-90
[660.342333] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[660.408765] [111/131] (364s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[660.497120] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[660.499267] Starting dynamic subtest: pipe-A
[660.516995] Dynamic subtest pipe-A: SKIP (0.016s)
[660.531176] Starting dynamic subtest: pipe-B
[660.546933] Dynamic subtest pipe-B: SKIP (0.029s)
[660.561385] Starting dynamic subtest: pipe-C
[660.575666] Dynamic subtest pipe-C: SKIP (0.029s)
[660.584907] Starting dynamic subtest: pipe-D
[660.604443] Dynamic subtest pipe-D: SKIP (0.029s)
[660.608166] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.106s)
[660.679603] [112/131] (363s left) kms_selftest (drm_dp_mst_helper)
[660.719075] Starting subtest: drm_dp_mst_helper
[660.778957] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[660.868418] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.089s)
[660.877288] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[660.971586] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.103s)
[660.980282] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[661.076719] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.105s)
[661.078853] Subtest drm_dp_mst_helper: SUCCESS (0.358s)
[661.211041] [113/131] (363s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[661.590905] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[662.368514] [114/131] (362s left) i915_drm_fdinfo (busy)
[662.406823] Starting subtest: busy
[662.409205] Starting dynamic subtest: rcs0
[662.439830] Dynamic subtest rcs0: SKIP (0.031s)
[662.452286] Starting dynamic subtest: bcs0
[662.456991] Dynamic subtest bcs0: SKIP (0.001s)
[662.467746] Starting dynamic subtest: vcs0
[662.471747] Dynamic subtest vcs0: SKIP (0.000s)
[662.480409] Starting dynamic subtest: vcs1
[662.484522] Dynamic subtest vcs1: SKIP (0.000s)
[662.493542] Starting dynamic subtest: vecs0
[662.497636] Dynamic subtest vecs0: SKIP (0.000s)
[662.506024] Starting dynamic subtest: ccs0
[662.510193] Dynamic subtest ccs0: SKIP (0.000s)
[662.514289] Subtest busy: SKIP (0.036s)
[662.551876] [115/131] (362s left) kms_properties (get_properties-sanity-non-atomic)
[662.641105] Starting subtest: get_properties-sanity-non-atomic
[662.643303] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[662.690453] [116/131] (361s left) kms_prop_blob (blob-multiple)
[662.758536] Starting subtest: blob-multiple
[662.760919] Subtest blob-multiple: SUCCESS (0.002s)
[662.832907] [117/131] (361s left) kms_psr (fbc-psr-primary-mmap-cpu)
[662.919119] Starting subtest: fbc-psr-primary-mmap-cpu
[662.921340] Starting dynamic subtest: eDP-1
[662.925389] Dynamic subtest eDP-1: SKIP (0.000s)
[662.929442] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[662.968502] [118/131] (361s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[663.070318] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[663.072580] Starting dynamic subtest: pipe-A-eDP-1
[663.095481] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[663.106929] Starting dynamic subtest: pipe-B-eDP-1
[663.129346] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[663.140784] Starting dynamic subtest: pipe-C-eDP-1
[663.162940] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[663.173704] Starting dynamic subtest: pipe-D-eDP-1
[663.195750] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[663.199810] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[665.334371] [119/131] (359s left) kms_busy (extended-pageflip-hang-newfb)
[665.445227] Starting subtest: extended-pageflip-hang-newfb
[665.447174] Starting dynamic subtest: pipe-A
[692.122312] Dynamic subtest pipe-A: SUCCESS (26.677s)
[692.133477] Starting dynamic subtest: pipe-D
[717.097636] Dynamic subtest pipe-D: SUCCESS (24.969s)
[717.100078] Subtest extended-pageflip-hang-newfb: SUCCESS (51.650s)
[717.899745] [120/131] (306s left) gem_tiled_swapping (non-threaded)
[717.961927] Subtest non-threaded: SKIP (0.000s)
[718.030701] [121/131] (306s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[718.139283] Starting subtest: flip-vs-cursor-atomic
[725.552436] Subtest flip-vs-cursor-atomic: SUCCESS (7.412s)
[726.318534] [122/131] (298s left) gem_exec_flush (basic-uc-set-default)
[726.397694] Starting subtest: basic-uc-set-default
[731.878039] Subtest basic-uc-set-default: SUCCESS (5.485s)
[732.036931] [123/131] (292s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[732.093243] Starting subtest: etime-single-wait-all-for-submit-submitted
[732.199056] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[732.253876] [124/131] (292s left) vgem_basic (sysfs)
[732.290302] Starting subtest: sysfs
[732.292283] Subtest sysfs: SUCCESS (0.000s)
[732.335132] [125/131] (292s left) kms_psr (psr2-cursor-mmap-gtt)
[732.430032] Starting subtest: psr2-cursor-mmap-gtt
[732.432282] Starting dynamic subtest: eDP-1
[734.129430] Dynamic subtest eDP-1: SUCCESS (1.699s)
[734.131659] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.700s)
[734.907252] [126/131] (290s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[734.997205] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[734.999410] Starting dynamic subtest: pipe-A-eDP-1
[735.025117] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[735.034429] Starting dynamic subtest: pipe-B-eDP-1
[735.057643] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[735.067071] Starting dynamic subtest: pipe-C-eDP-1
[735.090157] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[735.098720] Starting dynamic subtest: pipe-D-eDP-1
[735.122950] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[735.127343] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[737.270625] [127/131] (287s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[737.332423] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[737.336960] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[737.494878] [128/131] (287s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[737.594753] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[737.606188] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[737.664378] [129/131] (287s left) kms_cursor_crc (cursor-random-64x64)
[737.829146] Starting subtest: cursor-random-64x64
[737.834514] Starting dynamic subtest: pipe-A-eDP-1
[741.208629] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.373s)
[741.247359] Starting dynamic subtest: pipe-D-eDP-1
[745.201101] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.963s)
[745.203363] Subtest cursor-random-64x64: SUCCESS (7.371s)
[746.041959] [130/131] (279s left) kms_properties (plane-properties-atomic)
[746.130334] Starting subtest: plane-properties-atomic
[746.132540] Starting dynamic subtest: pipe-A-eDP-1
[746.690088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s)
[746.700640] Starting dynamic subtest: pipe-B-eDP-1
[747.934433] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s)
[747.944471] Starting dynamic subtest: pipe-C-eDP-1
[749.169745] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[749.180900] Starting dynamic subtest: pipe-D-eDP-1
[750.396364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[750.398645] Subtest plane-properties-atomic: SUCCESS (4.268s)
[751.176761] [131/131] (274s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[751.286168] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[755.301813] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.021s)
[756.483595] Closing watchdogs
results: parsing output: 0/ for test: gem_busy
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_cursor_edge_walk
results: parsing output: 5/ for test: kms_plane_multiple
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_vrr
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_gpgpu_fill
results: parsing output: 23/ for test: kms_dp_linktrain_fallback
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: gem_close
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_multipipe_modeset
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: gem_wait
results: parsing output: 37/ for test: i915_pm_rc6_residency
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: gem_compute
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_invalid_mode
results: parsing output: 47/ for test: kms_atomic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_atomic_transition
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: gem_exec_endless
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_plane
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: drm_buddy
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_fenced_exec_thrash
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: gem_exec_params
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_pm_dc
results: parsing output: 77/ for test: gem_userptr_blits
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: gem_exec_store
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_draw_crc
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: api_intel_bb
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: gem_mmap_offset
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_lmem_swapping
results: parsing output: 99/ for test: gem_spin_batch
results: parsing output: 100/ for test: kms_scaling_modes
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: kms_content_protection
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: kms_selftest
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: kms_properties
results: parsing output: 115/ for test: kms_prop_blob
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: gem_tiled_swapping
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: vgem_basic
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.