[57.430314] Initializing watchdogs
[57.430450]   /dev/watchdog0
[57.447676] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.452332] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.454672] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.457945] [001/156] (960s left) gem_tiled_blits (basic)
[57.545147] Subtest basic: SKIP (0.000s)
[57.600937] [002/156] (960s left) kms_cursor_edge_walk (64x64-right-edge)
[57.699838] Starting subtest: 64x64-right-edge
[57.702525] Starting dynamic subtest: pipe-A-eDP-1
[61.595231] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.856s)
[61.603617] Starting dynamic subtest: pipe-D-eDP-1
[65.546147] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.927s)
[65.548633] Subtest 64x64-right-edge: SUCCESS (7.786s)
[65.938167] [003/156] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[66.047724] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[66.051883] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[66.143671] [004/156] (951s left) gem_ctx_shared (exec-single-timeline)
[66.196675] Starting subtest: exec-single-timeline
[66.198979] Starting dynamic subtest: rcs0
[67.228365] Dynamic subtest rcs0: SUCCESS (1.026s)
[67.238970] Starting dynamic subtest: bcs0
[68.316369] Dynamic subtest bcs0: SUCCESS (1.084s)
[68.325915] Starting dynamic subtest: vcs0
[69.409991] Dynamic subtest vcs0: SUCCESS (1.089s)
[69.421428] Starting dynamic subtest: vcs1
[70.493048] Dynamic subtest vcs1: SUCCESS (1.080s)
[70.503642] Starting dynamic subtest: vecs0
[71.581085] Dynamic subtest vecs0: SUCCESS (1.084s)
[71.592379] Starting dynamic subtest: ccs0
[72.668268] Dynamic subtest ccs0: SUCCESS (1.085s)
[72.670809] Subtest exec-single-timeline: SUCCESS (6.454s)
[73.112707] [005/156] (945s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[73.246073] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[73.250618] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[73.381937] [006/156] (944s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[73.508985] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[73.511443] Starting dynamic subtest: pipe-A-eDP-1
[73.533753] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.544252] Starting dynamic subtest: pipe-B-eDP-1
[73.565499] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.573314] Starting dynamic subtest: pipe-C-eDP-1
[73.594220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.601809] Starting dynamic subtest: pipe-D-eDP-1
[73.625389] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.629718] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[75.812903] [007/156] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[75.906645] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[84.770982] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.864s)
[84.883887] [008/156] (933s left) gem_softpin (evict-prime-sanity-check)
[84.946505] Starting subtest: evict-prime-sanity-check
[84.948977] Starting dynamic subtest: rcs0
[86.087305] Dynamic subtest rcs0: SUCCESS (1.140s)
[86.099347] Starting dynamic subtest: bcs0
[87.194329] Dynamic subtest bcs0: SUCCESS (1.105s)
[87.207797] Starting dynamic subtest: vcs0
[88.321296] Dynamic subtest vcs0: SUCCESS (1.125s)
[88.331730] Starting dynamic subtest: vcs1
[90.278427] Dynamic subtest vcs1: SUCCESS (1.954s)
[90.292325] Starting dynamic subtest: vecs0
[92.287878] Dynamic subtest vecs0: SUCCESS (2.008s)
[92.299685] Starting dynamic subtest: ccs0
[93.414886] Dynamic subtest ccs0: SUCCESS (1.127s)
[93.425425] Starting dynamic subtest: all
[94.539817] Dynamic subtest all: SUCCESS (1.124s)
[94.542269] Subtest evict-prime-sanity-check: SUCCESS (9.590s)
[94.619818] [009/156] (923s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[94.726501] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[94.730949] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[94.812268] [010/156] (923s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt)
[94.912637] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt
[94.917189] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[95.018860] [011/156] (923s left) syncobj_timeline (multi-wait-signaled)
[95.069040] Starting subtest: multi-wait-signaled
[95.071459] Subtest multi-wait-signaled: SUCCESS (0.001s)
[95.180440] [012/156] (923s left) perf_pmu (enable-race)
[95.219281] Starting subtest: enable-race
[95.221686] Starting dynamic subtest: rcs0
[107.993639] Dynamic subtest rcs0: SUCCESS (12.771s)
[108.002914] Starting dynamic subtest: bcs0
[120.735752] Dynamic subtest bcs0: SUCCESS (12.740s)
[120.743952] Starting dynamic subtest: vcs0
[136.319869] Dynamic subtest vcs0: SUCCESS (15.580s)
[136.329635] Starting dynamic subtest: vcs1
[152.320242] Dynamic subtest vcs1: SUCCESS (15.998s)
[152.331885] Starting dynamic subtest: vecs0
[168.256908] Dynamic subtest vecs0: SUCCESS (15.935s)
[168.267553] Starting dynamic subtest: ccs0
[180.996644] Dynamic subtest ccs0: SUCCESS (12.739s)
[180.999430] Subtest enable-race: SUCCESS (85.770s)
[181.091637] [013/156] (837s left) perf (short-reads)
[181.215146] Starting subtest: short-reads
[181.229209] Subtest short-reads: SUCCESS (0.016s)
[181.266641] [014/156] (837s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[181.332726] Starting subtest: yf-tiled-to-vebox-yf-tiled
[181.337341] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[181.515819] [015/156] (837s left) kms_prime (basic-crc-hybrid)
[181.599745] Subtest basic-crc-hybrid: SKIP (0.000s)
[181.754351] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[181.757620] [016/156] (836s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[181.815478] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[181.817448] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[181.900965] [017/156] (836s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[181.996163] Starting subtest: extended-modeset-hang-oldfb-with-reset
[181.998427] Starting dynamic subtest: pipe-A
[193.894844] Dynamic subtest pipe-A: SUCCESS (11.898s)
[193.904332] Starting dynamic subtest: pipe-D
[206.672592] Dynamic subtest pipe-D: SUCCESS (12.775s)
[206.674850] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.677s)
[207.567518] [018/156] (811s left) gem_exec_fence (syncobj-timeline-unused-fence)
[208.100023] Starting subtest: syncobj-timeline-unused-fence
[208.106498] Subtest syncobj-timeline-unused-fence: SUCCESS (0.008s)
[209.354654] [019/156] (809s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[209.452406] Starting subtest: plane-lut1d-ctm3x4-lut1d
[209.606865] Starting dynamic subtest: pipe-A-plane-0
[209.807114] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[209.818471] Starting dynamic subtest: pipe-A-plane-1
[209.998054] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[210.007832] Starting dynamic subtest: pipe-A-plane-2
[210.184976] Dynamic subtest pipe-A-plane-2: SUCCESS (0.189s)
[211.392141] Starting dynamic subtest: pipe-B-plane-0
[211.585078] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[211.594321] Starting dynamic subtest: pipe-B-plane-1
[211.783318] Dynamic subtest pipe-B-plane-1: SUCCESS (0.200s)
[211.794682] Starting dynamic subtest: pipe-B-plane-2
[211.972375] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[213.211619] Starting dynamic subtest: pipe-C-plane-0
[213.371176] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[213.381982] Starting dynamic subtest: pipe-C-plane-1
[213.537505] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[213.547069] Starting dynamic subtest: pipe-C-plane-2
[213.704669] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[214.938652] Starting dynamic subtest: pipe-D-plane-0
[215.085944] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[215.097141] Starting dynamic subtest: pipe-D-plane-1
[215.252326] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[215.264860] Starting dynamic subtest: pipe-D-plane-2
[215.407874] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[215.709523] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.261s)
[216.588444] [020/156] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[216.694184] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[216.698387] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[216.790402] [021/156] (801s left) vgem_basic (bad-fence)
[216.828651] Starting subtest: bad-fence
[216.830583] Subtest bad-fence: SUCCESS (0.000s)
[216.885192] [022/156] (801s left) gem_exercise_blt (fast-copy)
[216.935969] Starting subtest: fast-copy
[216.938260] Starting dynamic subtest: linear-smem-smem
[216.960824] Dynamic subtest linear-smem-smem: SUCCESS (0.025s)
[216.971638] Starting dynamic subtest: xmajor-smem-smem
[216.981507] Dynamic subtest xmajor-smem-smem: SUCCESS (0.021s)
[216.990832] Starting dynamic subtest: tile4-smem-smem
[217.000373] Dynamic subtest tile4-smem-smem: SUCCESS (0.019s)
[217.009320] Starting dynamic subtest: tile64-smem-smem
[217.020227] Dynamic subtest tile64-smem-smem: SUCCESS (0.019s)
[217.022821] Subtest fast-copy: SUCCESS (0.085s)
[217.124240] [023/156] (801s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[217.178068] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[217.284908] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[217.374679] [024/156] (801s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[217.435729] Starting subtest: framebuffer-vs-set-tiling
[217.440107] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[217.565202] [025/156] (801s left) gem_exec_flush (basic-wb-rw-before-default)
[217.621065] Starting subtest: basic-wb-rw-before-default
[223.080696] Subtest basic-wb-rw-before-default: SUCCESS (5.461s)
[223.281025] [026/156] (795s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[223.377750] Starting subtest: stress-xrgb8888-ytiled
[223.382559] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[223.459763] [027/156] (795s left) gem_exec_whisper (basic-contexts)
[223.524894] Starting subtest: basic-contexts
[231.262417] Subtest basic-contexts: SUCCESS (7.737s)
[231.449774] [028/156] (787s left) kms_lease (atomic-implicit-crtc)
[231.547137] Starting subtest: atomic-implicit-crtc
[231.549812] Starting dynamic subtest: pipe-A-eDP-1
[231.561330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[231.571375] Starting dynamic subtest: pipe-B-eDP-1
[231.582623] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[231.592178] Starting dynamic subtest: pipe-C-eDP-1
[231.602336] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[231.611412] Starting dynamic subtest: pipe-D-eDP-1
[231.622176] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[231.624313] Subtest atomic-implicit-crtc: SUCCESS (0.039s)
[231.691142] [029/156] (787s left) kms_psr (fbc-psr-sprite-plane-onoff)
[231.783054] Starting subtest: fbc-psr-sprite-plane-onoff
[231.785427] Starting dynamic subtest: eDP-1
[231.789875] Dynamic subtest eDP-1: SKIP (0.000s)
[231.794340] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[231.871439] [030/156] (787s left) gem_ccs (block-multicopy-inplace)
[231.925072] Starting subtest: block-multicopy-inplace
[231.929635] Subtest block-multicopy-inplace: SKIP (0.000s)
[232.029413] [031/156] (787s left) kms_hdr (bpc-switch-dpms)
[232.125056] Starting subtest: bpc-switch-dpms
[232.127432] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[237.771663] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.647s)
[237.783600] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[243.445324] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.673s)
[243.447772] Subtest bpc-switch-dpms: SUCCESS (11.322s)
[243.556427] [032/156] (775s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[243.662989] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[247.411607] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.755s)
[248.608777] [033/156] (770s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[248.704168] Starting subtest: fbc-pr-cursor-mmap-cpu
[248.708673] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[248.776214] [034/156] (770s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[248.898129] Starting subtest: cursorA-vs-flipA-varying-size
[260.049118] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.149s)
[260.924820] [035/156] (758s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt)
[261.040266] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt
[261.044812] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[261.128166] [036/156] (758s left) core_getversion (basic)
[261.169454] Starting subtest: basic
[261.173569] Subtest basic: SUCCESS (0.000s)
[261.232700] [037/156] (758s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[261.340611] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[261.344931] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[261.456767] [038/156] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[261.563968] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[261.568989] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[261.666571] [039/156] (757s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[261.769655] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[261.773959] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[261.896297] [040/156] (757s left) gem_mmap_wc (read)
[261.953721] Subtest read: SKIP (0.000s)
[262.012820] [041/156] (757s left) gen7_exec_parse (cmd-crossing-page)
[262.064212] Subtest cmd-crossing-page: SKIP (0.000s)
[262.144878] [042/156] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[262.236747] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[262.240267] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[262.341682] [043/156] (757s left) kms_plane_multiple (2x-tiling-y)
[262.434961] Starting subtest: 2x-tiling-y
[262.438588] Subtest 2x-tiling-y: SKIP (0.000s)
[262.506118] [044/156] (757s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[262.605297] Starting subtest: x-tiled-64bpp-rotate-180
[264.318683] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.713s)
[264.505418] [045/156] (755s left) syncobj_wait (single-wait-submitted)
[264.555523] Starting subtest: single-wait-submitted
[264.660793] Subtest single-wait-submitted: SUCCESS (0.104s)
[264.739270] [046/156] (755s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[264.833683] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[264.837944] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[264.929885] [047/156] (754s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[265.029573] Starting subtest: pixel-format-linear-modifier-source-clamping
[265.055661] Starting dynamic subtest: pipe-A-plane-0
[265.622144] Dynamic subtest pipe-A-plane-0: SUCCESS (0.566s)
[265.632294] Starting dynamic subtest: pipe-A-plane-3
[266.066636] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[267.212342] Starting dynamic subtest: pipe-B-plane-0
[267.793370] Dynamic subtest pipe-B-plane-0: SUCCESS (0.589s)
[267.803157] Starting dynamic subtest: pipe-B-plane-3
[268.227019] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[268.558800] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.531s)
[269.393417] [048/156] (750s left) kms_frontbuffer_tracking (fbc-1p-rte)
[269.501371] Starting subtest: fbc-1p-rte
[274.941385] Subtest fbc-1p-rte: SUCCESS (5.447s)
[276.104967] [049/156] (743s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[276.205304] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[276.209512] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[276.277216] [050/156] (743s left) kms_setmode (basic)
[276.330673] Starting subtest: basic
[276.657468] Starting dynamic subtest: pipe-A-eDP-1
[278.717266] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.055s)
[279.065064] Starting dynamic subtest: pipe-B-eDP-1
[281.144892] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.085s)
[281.455445] Subtest basic: SUCCESS (5.123s)
[282.313922] [051/156] (737s left) kms_pm_dc (dc5-dpms-negative)
[283.421734] Starting subtest: dc5-dpms-negative
[283.426303] Subtest dc5-dpms-negative: SKIP (0.000s)
[283.494652] [052/156] (736s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[283.597027] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[283.601566] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[283.716986] [053/156] (736s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[283.829619] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[283.834301] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[283.928435] [054/156] (736s left) gem_exec_params (secure-non-root)
[283.972442] Starting subtest: secure-non-root
[283.977127] Subtest secure-non-root: SKIP (0.000s)
[284.085354] [055/156] (736s left) gem_render_copy (yf-tiled-ccs-to-linear)
[284.147906] Starting subtest: yf-tiled-ccs-to-linear
[284.152404] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[284.345550] [056/156] (735s left) prime_vgem (fence-read-hang)
[284.426782] Subtest fence-read-hang: SKIP (0.000s)
[284.543846] [057/156] (735s left) kms_lease (lease-invalid-plane)
[284.633731] Starting subtest: lease-invalid-plane
[284.636071] Starting dynamic subtest: pipe-A-eDP-1
[284.638315] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[284.647605] Starting dynamic subtest: pipe-B-eDP-1
[284.649992] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[284.663095] Starting dynamic subtest: pipe-C-eDP-1
[284.665189] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[284.674151] Starting dynamic subtest: pipe-D-eDP-1
[284.676288] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[284.678417] Subtest lease-invalid-plane: SUCCESS (0.004s)
[284.715916] [058/156] (735s left) api_intel_bb (blit-reloc-purge-cache)
[284.774181] Starting subtest: blit-reloc-purge-cache
[284.778454] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[284.888765] [059/156] (735s left) gem_exec_create (basic)
[284.952690] Starting subtest: basic
[284.955151] Starting dynamic subtest: smem
[288.259038] Dynamic subtest smem: SUCCESS (3.307s)
[288.261978] Subtest basic: SUCCESS (3.309s)
[288.444558] [060/156] (731s left) i915_hangman (gt-engine-hang)
[288.516793] Starting subtest: gt-engine-hang
[288.519140] Starting dynamic subtest: rcs0
[290.272527] Dynamic subtest rcs0: SUCCESS (1.755s)
[290.284796] Starting dynamic subtest: bcs0
[292.255213] Dynamic subtest bcs0: SUCCESS (1.980s)
[292.267570] Starting dynamic subtest: vcs0
[294.238813] Dynamic subtest vcs0: SUCCESS (1.980s)
[294.252160] Starting dynamic subtest: vcs1
[296.222318] Dynamic subtest vcs1: SUCCESS (1.981s)
[296.236037] Starting dynamic subtest: vecs0
[298.271702] Dynamic subtest vecs0: SUCCESS (2.047s)
[298.283033] Starting dynamic subtest: ccs0
[300.253889] Dynamic subtest ccs0: SUCCESS (1.979s)
[300.256819] Subtest gt-engine-hang: SUCCESS (11.739s)
[300.347012] [061/156] (720s left) kms_psr (fbc-psr2-cursor-render)
[300.448060] Starting subtest: fbc-psr2-cursor-render
[300.450387] Starting dynamic subtest: eDP-1
[300.454895] Dynamic subtest eDP-1: SKIP (0.000s)
[300.459445] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[300.534963] [062/156] (719s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[300.636921] Starting subtest: flip-primary-invalidate-overlay
[312.268071] Subtest flip-primary-invalidate-overlay: SUCCESS (11.632s)
[312.394251] [063/156] (708s left) i915_suspend (fence-restore-tiled2untiled)
[312.454875] Starting subtest: fence-restore-tiled2untiled
[312.458966] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[312.565483] [064/156] (708s left) i915_pm_rc6_residency (rc6-fence)
[312.626957] Starting subtest: rc6-fence
[312.666342] Starting dynamic subtest: gt0
[324.986496] Dynamic subtest gt0: SUCCESS (12.318s)
[325.000795] Starting dynamic subtest: gt1
[339.264157] Dynamic subtest gt1: SUCCESS (14.274s)
[339.267091] Subtest rc6-fence: SUCCESS (26.638s)
[339.385102] [065/156] (681s left) gem_create (create-massive)
[339.443996] Starting subtest: create-massive
[339.446310] Subtest create-massive: SUCCESS (0.000s)
[339.658314] [066/156] (681s left) api_intel_bb (render-ccs)
[339.718486] Starting subtest: render-ccs
[340.301393] Subtest render-ccs: SUCCESS (0.583s)
[340.418457] [067/156] (680s left) gem_userptr_blits (vma-merge)
[340.480704] Starting subtest: vma-merge
[340.527619] Subtest vma-merge: SUCCESS (0.047s)
[340.663277] [068/156] (680s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[340.759925] Starting subtest: 4-tiled-32bpp-rotate-90
[340.780057] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[340.894496] [069/156] (679s left) kms_hdmi_inject (inject-audio)
[341.253910] Starting subtest: inject-audio
[341.551359] Subtest inject-audio: SUCCESS (0.298s)
[342.172397] [070/156] (678s left) i915_drm_fdinfo (most-busy-idle-check-all)
[342.210737] Starting subtest: most-busy-idle-check-all
[342.214269] Starting dynamic subtest: rcs0
[342.218611] Dynamic subtest rcs0: SKIP (0.004s)
[342.228180] Starting dynamic subtest: bcs0
[342.232376] Dynamic subtest bcs0: SKIP (0.000s)
[342.242247] Starting dynamic subtest: vcs0
[342.246689] Dynamic subtest vcs0: SKIP (0.000s)
[342.256192] Starting dynamic subtest: vcs1
[342.260306] Dynamic subtest vcs1: SKIP (0.001s)
[342.270165] Starting dynamic subtest: vecs0
[342.274346] Dynamic subtest vecs0: SKIP (0.000s)
[342.283877] Starting dynamic subtest: ccs0
[342.288112] Dynamic subtest ccs0: SKIP (0.000s)
[342.292382] Subtest most-busy-idle-check-all: SKIP (0.011s)
[342.332465] [071/156] (678s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[342.480584] Starting subtest: flip-vs-cursor-atomic
[350.017423] Subtest flip-vs-cursor-atomic: SUCCESS (7.536s)
[350.828439] [072/156] (670s left) gem_userptr_blits (coherency-unsync)
[350.887246] Subtest coherency-unsync: SKIP (0.000s)
[351.017805] [073/156] (669s left) gem_softpin (invalid)
[351.076845] Starting subtest: invalid
[351.084305] Subtest invalid: SUCCESS (0.006s)
[351.215451] [074/156] (669s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[351.322363] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[351.326319] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[351.444320] [075/156] (669s left) gem_render_copy (y-tiled)
[351.498790] Starting subtest: y-tiled
[351.502951] Subtest y-tiled: SKIP (0.000s)
[351.682180] [076/156] (669s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[351.779425] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[351.783772] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[351.874276] [077/156] (669s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[351.968144] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[351.972362] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[352.069675] [078/156] (669s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[352.179844] Starting subtest: pr-overlay-plane-update-continuous-sf
[352.184260] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[352.264741] [079/156] (668s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[352.369822] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[353.415583] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[353.571542] [080/156] (667s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[353.695411] Starting subtest: 2x-flip-vs-cursor-atomic
[353.699167] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[353.841236] [081/156] (667s left) kms_content_protection (lic-type-0)
[353.984693] Starting subtest: lic-type-0
[353.988454] Subtest lic-type-0: SKIP (0.000s)
[354.120605] [082/156] (667s left) kms_flip (modeset-vs-vblank-race)
[354.212096] Starting subtest: modeset-vs-vblank-race
[354.213672] Starting dynamic subtest: A-eDP1
[358.928815] Dynamic subtest A-eDP1: SUCCESS (4.716s)
[358.943483] Starting dynamic subtest: B-eDP1
[363.624181] Dynamic subtest B-eDP1: SUCCESS (4.693s)
[363.640536] Starting dynamic subtest: C-eDP1
[368.295874] Dynamic subtest C-eDP1: SUCCESS (4.669s)
[368.310636] Starting dynamic subtest: D-eDP1
[373.005127] Dynamic subtest D-eDP1: SUCCESS (4.706s)
[373.010483] Subtest modeset-vs-vblank-race: SUCCESS (18.800s)
[374.226269] [083/156] (647s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[374.335522] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[381.313259] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.985s)
[381.426115] [084/156] (640s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[381.493056] Subtest writes-after-reads: SKIP (0.000s)
[381.568495] [085/156] (639s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[381.662059] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[389.195273] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.538s)
[389.344105] [086/156] (632s left) prime_self_import (basic-with_fd_dup)
[389.382853] Starting subtest: basic-with_fd_dup
[389.397363] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[389.519516] [087/156] (632s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-render)
[389.619894] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-render
[389.624295] Subtest psrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[389.717635] [088/156] (631s left) syncobj_wait (invalid-single-wait-unsubmitted)
[389.788673] Starting subtest: invalid-single-wait-unsubmitted
[389.790692] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[389.907966] [089/156] (631s left) kms_async_flips (async-flip-dpms)
[390.004100] Starting subtest: async-flip-dpms
[390.378814] Starting dynamic subtest: pipe-A-eDP-1
[394.274467] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.895s)
[394.642330] Starting dynamic subtest: pipe-B-eDP-1
[397.474182] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.837s)
[397.866101] Starting dynamic subtest: pipe-C-eDP-1
[400.778444] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.918s)
[401.153843] Starting dynamic subtest: pipe-D-eDP-1
[404.076707] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.929s)
[404.079170] Subtest async-flip-dpms: SUCCESS (14.071s)
[405.247080] [090/156] (616s left) gem_ctx_isolation (preservation-reset)
[405.425735] Starting subtest: preservation-reset
[405.429035] Starting dynamic subtest: rcs0
[405.714959] Dynamic subtest rcs0: SUCCESS (0.290s)
[405.726094] Starting dynamic subtest: bcs0
[406.036714] Dynamic subtest bcs0: SUCCESS (0.321s)
[406.049864] Starting dynamic subtest: vcs0
[406.343826] Dynamic subtest vcs0: SUCCESS (0.306s)
[406.355761] Starting dynamic subtest: vcs1
[407.584898] Dynamic subtest vcs1: SUCCESS (1.240s)
[407.598285] Starting dynamic subtest: vecs0
[409.583964] Dynamic subtest vecs0: SUCCESS (1.997s)
[409.596124] Starting dynamic subtest: ccs0
[411.570074] Dynamic subtest ccs0: SUCCESS (1.985s)
[411.572999] Subtest preservation-reset: SUCCESS (6.147s)
[411.727222] [091/156] (610s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[411.848370] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[411.853817] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[411.994652] [092/156] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[412.092810] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[415.669429] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.582s)
[416.827480] [093/156] (605s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[416.926647] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[416.930673] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[417.021116] [094/156] (604s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[417.071184] Starting subtest: single-wait-for-submit-available-submitted
[417.073364] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[417.172288] [095/156] (604s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[417.279527] Starting subtest: hdr-1p-pri-indfb-multidraw
[417.283551] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[417.372738] [096/156] (604s left) kms_psr (psr-no-drrs)
[417.475061] Starting subtest: psr-no-drrs
[417.477248] Starting dynamic subtest: eDP-1
[419.085607] Dynamic subtest eDP-1: SUCCESS (1.611s)
[419.087905] Subtest psr-no-drrs: SUCCESS (1.612s)
[419.934576] [097/156] (602s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[420.030524] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[420.034591] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[420.129962] [098/156] (601s left) kms_psr (pr-suspend)
[420.233204] Starting subtest: pr-suspend
[420.237189] Subtest pr-suspend: SKIP (0.000s)
[420.308069] [099/156] (601s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[420.402989] Starting subtest: y-tiled-8bpp-rotate-90
[420.407158] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[420.505624] [100/156] (601s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[420.601746] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[420.604140] Starting dynamic subtest: pipe-A
[421.749963] Dynamic subtest pipe-A: SUCCESS (1.151s)
[421.760587] Starting dynamic subtest: pipe-B
[423.988154] Dynamic subtest pipe-B: SUCCESS (2.237s)
[423.998460] Starting dynamic subtest: pipe-C
[425.164494] Dynamic subtest pipe-C: SUCCESS (1.175s)
[425.174918] Starting dynamic subtest: pipe-D
[426.354921] Dynamic subtest pipe-D: SUCCESS (1.188s)
[426.357220] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.757s)
[427.528290] [101/156] (594s left) gem_exec_balancer (full)
[427.601847] Starting subtest: full
[432.148799] Subtest full: SUCCESS (4.547s)
[432.500964] [102/156] (589s left) gem_exec_schedule (u-semaphore-user)
[432.571958] Starting subtest: u-semaphore-user
[432.626949] Subtest u-semaphore-user: SUCCESS (0.061s)
[434.348313] [103/156] (587s left) kms_sequence (queue-idle)
[434.448721] Starting subtest: queue-idle
[434.451056] Starting dynamic subtest: pipe-A-eDP-1
[436.265408] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[436.275972] Starting dynamic subtest: pipe-B-eDP-1
[438.749384] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.482s)
[438.759612] Starting dynamic subtest: pipe-C-eDP-1
[441.246852] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.497s)
[441.259789] Starting dynamic subtest: pipe-D-eDP-1
[443.751855] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.504s)
[443.754153] Subtest queue-idle: SUCCESS (9.303s)
[444.638678] [104/156] (577s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[444.740621] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[451.940433] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.202s)
[452.067709] [105/156] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[452.180142] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[452.184289] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[452.265946] [106/156] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[452.360468] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[452.364496] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[452.451623] [107/156] (570s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[452.546838] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[452.549090] Starting dynamic subtest: pipe-A
[452.611285] Dynamic subtest pipe-A: SUCCESS (0.066s)
[452.623541] Starting dynamic subtest: pipe-B
[453.817030] Dynamic subtest pipe-B: SUCCESS (1.205s)
[453.828772] Starting dynamic subtest: pipe-C
[455.003375] Dynamic subtest pipe-C: SUCCESS (1.186s)
[455.014043] Starting dynamic subtest: pipe-D
[456.115522] Dynamic subtest pipe-D: SUCCESS (1.111s)
[456.117960] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.571s)
[457.325083] [108/156] (565s left) kms_chamelium_color (ctm-green-to-red)
[457.423314] Subtest ctm-green-to-red: SKIP (0.000s)
[457.474253] [109/156] (565s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[457.559915] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[457.562206] Starting dynamic subtest: pipe-A-eDP-1
[457.586099] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[457.598490] Starting dynamic subtest: pipe-B-eDP-1
[457.620198] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[457.631282] Starting dynamic subtest: pipe-C-eDP-1
[457.652853] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[457.663093] Starting dynamic subtest: pipe-D-eDP-1
[457.685095] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[457.689695] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[459.828108] [110/156] (562s left) gem_linear_blits (normal)
[460.294497] Starting subtest: normal
[464.086544] Subtest normal: SUCCESS (3.791s)
[464.212868] [111/156] (558s left) kms_big_fb (linear-16bpp-rotate-270)
[464.359586] Starting subtest: linear-16bpp-rotate-270
[464.379125] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[464.519808] [112/156] (558s left) kms_flip (flip-vs-dpms-on-nop)
[464.618110] Starting subtest: flip-vs-dpms-on-nop
[464.620490] Starting dynamic subtest: A-eDP1
[466.584774] Dynamic subtest A-eDP1: SUCCESS (1.968s)
[466.601097] Starting dynamic subtest: B-eDP1
[468.479381] Dynamic subtest B-eDP1: SUCCESS (1.892s)
[468.490058] Starting dynamic subtest: C-eDP1
[470.371073] Dynamic subtest C-eDP1: SUCCESS (1.889s)
[470.381476] Starting dynamic subtest: D-eDP1
[472.281677] Dynamic subtest D-eDP1: SUCCESS (1.909s)
[472.287529] Subtest flip-vs-dpms-on-nop: SUCCESS (7.670s)
[473.532285] [113/156] (549s left) gem_exec_capture (pi)
[473.588550] Starting subtest: pi
[473.590911] Starting dynamic subtest: rcs0
[477.775193] Dynamic subtest rcs0: SUCCESS (4.186s)
[477.786909] Starting dynamic subtest: bcs0
[481.848486] Dynamic subtest bcs0: SUCCESS (4.072s)
[481.861790] Starting dynamic subtest: vcs0
[485.947955] Dynamic subtest vcs0: SUCCESS (4.098s)
[485.958601] Starting dynamic subtest: vcs1
[490.028327] Dynamic subtest vcs1: SUCCESS (4.078s)
[490.040150] Starting dynamic subtest: vecs0
[494.113023] Dynamic subtest vecs0: SUCCESS (4.082s)
[494.127905] Starting dynamic subtest: ccs0
[498.196070] Dynamic subtest ccs0: SUCCESS (4.081s)
[498.198903] Subtest pi: SUCCESS (24.607s)
[498.280258] [114/156] (524s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt)
[498.444674] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt
[498.448910] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[498.531789] [115/156] (524s left) kms_async_flips (test-time-stamp-atomic)
[498.619494] Starting subtest: test-time-stamp-atomic
[498.996115] Starting dynamic subtest: pipe-A-eDP-1
[499.784580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[500.182813] Starting dynamic subtest: pipe-B-eDP-1
[500.999037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.822s)
[501.382297] Starting dynamic subtest: pipe-C-eDP-1
[502.187191] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.811s)
[502.549900] Starting dynamic subtest: pipe-D-eDP-1
[503.388940] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.845s)
[503.391465] Subtest test-time-stamp-atomic: SUCCESS (4.769s)
[504.619966] [116/156] (518s left) perf (blocking-parameterized)
[504.736339] Starting subtest: blocking-parameterized
[524.754357] Subtest blocking-parameterized: SUCCESS (20.015s)
[524.806426] [117/156] (498s left) kms_flip (wf_vblank-ts-check-interruptible)
[524.918139] Starting subtest: wf_vblank-ts-check-interruptible
[524.920432] Starting dynamic subtest: A-eDP1
[533.829257] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[533.843049] Starting dynamic subtest: B-eDP1
[542.732196] Dynamic subtest B-eDP1: SUCCESS (8.901s)
[542.745786] Starting dynamic subtest: C-eDP1
[551.618567] Dynamic subtest C-eDP1: SUCCESS (8.883s)
[551.630364] Starting dynamic subtest: D-eDP1
[560.519156] Dynamic subtest D-eDP1: SUCCESS (8.898s)
[560.524677] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.605s)
[561.708905] [118/156] (461s left) gem_exec_params (rsvd2-dirt)
[561.774062] Starting subtest: rsvd2-dirt
[561.778040] Subtest rsvd2-dirt: SKIP (0.000s)
[561.893203] [119/156] (461s left) gem_eio (wait-wedge-10ms)
[562.089816] Starting subtest: wait-wedge-10ms
[563.398351] Subtest wait-wedge-10ms: SUCCESS (1.308s)
[563.556793] [120/156] (459s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[563.665611] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[563.669923] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[563.747791] [121/156] (459s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[563.842714] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[563.847207] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[563.940417] [122/156] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[564.037710] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[571.120438] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.086s)
[571.264102] [123/156] (451s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[571.365283] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[571.367537] Starting dynamic subtest: pipe-A-eDP-1
[571.389542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.401238] Starting dynamic subtest: pipe-B-eDP-1
[571.421997] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.432411] Starting dynamic subtest: pipe-C-eDP-1
[571.453361] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.464086] Starting dynamic subtest: pipe-D-eDP-1
[571.486185] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.490635] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[573.612396] [124/156] (449s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[573.705531] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[573.709854] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[573.795551] [125/156] (449s left) gem_mmap_gtt (cpuset-big-copy-odd)
[573.851775] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[573.907173] [126/156] (449s left) gem_mmap_gtt (basic-write-gtt)
[573.961728] Subtest basic-write-gtt: SKIP (0.000s)
[574.024995] [127/156] (449s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[574.135576] Starting subtest: fbchdr-rgb101010-draw-render
[574.139585] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[574.243378] [128/156] (449s left) gem_mmap_offset (oob-read)
[574.300836] Starting subtest: oob-read
[574.303064] Subtest oob-read: SUCCESS (0.000s)
[574.396590] [129/156] (449s left) gem_pxp (create-regular-context-1)
[574.508789] Starting subtest: create-regular-context-1
[574.511208] Subtest create-regular-context-1: SUCCESS (0.002s)
[574.641484] [130/156] (448s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[574.749658] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[574.753348] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[574.864076] [131/156] (448s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[574.960480] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[574.963789] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[575.057528] [132/156] (448s left) kms_flip (2x-dpms-vs-vblank-race)
[575.151730] Starting subtest: 2x-dpms-vs-vblank-race
[575.163182] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[575.242801] [133/156] (448s left) kms_prop_blob (invalid-set-prop)
[575.302137] Starting subtest: invalid-set-prop
[575.304041] Subtest invalid-set-prop: SUCCESS (0.000s)
[575.418786] [134/156] (448s left) kms_cursor_crc (cursor-random-max-size)
[575.737361] Starting subtest: cursor-random-max-size
[575.742787] Subtest cursor-random-max-size: SKIP (0.000s)
[575.877478] [135/156] (447s left) gem_exec_schedule (implicit-write-read)
[575.952798] Starting subtest: implicit-write-read
[575.954578] Starting dynamic subtest: rcs0
[576.064411] Dynamic subtest rcs0: SUCCESS (0.114s)
[576.079027] Starting dynamic subtest: vcs0
[576.163121] Dynamic subtest vcs0: SUCCESS (0.098s)
[576.176848] Starting dynamic subtest: vcs1
[576.244336] Dynamic subtest vcs1: SUCCESS (0.080s)
[576.257598] Starting dynamic subtest: vecs0
[576.327086] Dynamic subtest vecs0: SUCCESS (0.082s)
[576.339712] Starting dynamic subtest: ccs0
[576.425462] Dynamic subtest ccs0: SUCCESS (0.096s)
[576.427747] Subtest implicit-write-read: SUCCESS (0.476s)
[577.383645] [136/156] (446s left) kms_addfb_basic (invalid-get-prop)
[577.451535] Starting subtest: invalid-get-prop
[577.453575] Subtest invalid-get-prop: SUCCESS (0.000s)
[577.586805] [137/156] (446s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[577.697448] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[577.702045] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[577.814386] [138/156] (446s left) gem_exec_fence (syncobj-export)
[578.264281] Starting subtest: syncobj-export
[578.270217] Subtest syncobj-export: SUCCESS (0.005s)
[579.352426] [139/156] (444s left) prime_vgem (basic-fence-blt)
[579.420627] Starting subtest: basic-fence-blt
[579.501846] Subtest basic-fence-blt: SUCCESS (0.081s)
[579.662122] [140/156] (444s left) syncobj_timeline (invalid-transfer-non-existent-point)
[579.722554] Starting subtest: invalid-transfer-non-existent-point
[579.724861] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[579.843546] [141/156] (444s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[579.945598] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite
[579.949762] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[580.038274] [142/156] (443s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[580.144987] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[580.149167] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[580.241492] [143/156] (443s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[580.626470] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[581.500577] [144/156] (442s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[581.565844] Starting subtest: invalid-bsd1-flag-on-blt
[581.568179] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[581.684678] [145/156] (442s left) kms_cursor_crc (cursor-onscreen-64x21)
[581.890942] Starting subtest: cursor-onscreen-64x21
[581.939726] Subtest cursor-onscreen-64x21: SKIP (0.046s)
[582.182009] [146/156] (441s left) kms_feature_discovery (psr1)
[582.279847] Starting subtest: psr1
[582.281919] Subtest psr1: SUCCESS (0.000s)
[582.352337] [147/156] (441s left) kms_vrr (flip-suspend)
[582.445651] Starting subtest: flip-suspend
[582.451040] Subtest flip-suspend: SKIP (0.000s)
[582.518490] [148/156] (441s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[582.605066] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[582.608971] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[583.740564] [149/156] (440s left) kms_chamelium_edid (dp-mode-timings)
[584.137394] Subtest dp-mode-timings: SKIP (0.000s)
[584.989719] [150/156] (439s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[585.093096] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[585.097680] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[585.193088] [151/156] (439s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[585.243967] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[585.246752] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[585.350932] [152/156] (439s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[585.451529] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[585.455740] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[585.548443] [153/156] (438s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[585.610614] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[585.715838] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[585.795021] [154/156] (438s left) gem_ctx_bad_destroy (invalid-default-ctx)
[585.851936] Starting subtest: invalid-default-ctx
[585.854407] Subtest invalid-default-ctx: SUCCESS (0.000s)
[585.929642] [155/156] (438s left) gem_ctx_persistence (process)
[585.974952] Starting subtest: process
[586.129578] Subtest process: SUCCESS (0.155s)
[586.235558] [156/156] (438s left) kms_flip (2x-plain-flip-ts-check)
[586.334341] Starting subtest: 2x-plain-flip-ts-check
[586.345075] Subtest 2x-plain-flip-ts-check: SKIP (0.012s)
[586.425529] Closing watchdogs
results: parsing output: 0/ for test: gem_tiled_blits
results: parsing output: 1/ for test: kms_cursor_edge_walk
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ctx_shared
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_prime
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_busy
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: kms_color_pipeline
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: vgem_basic
results: parsing output: 21/ for test: gem_exercise_blt
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: kms_pipe_stress
results: parsing output: 26/ for test: gem_exec_whisper
results: parsing output: 27/ for test: kms_lease
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: kms_hdr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: core_getversion
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: gen7_exec_parse
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_plane_multiple
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_setmode
results: parsing output: 50/ for test: kms_pm_dc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: gem_exec_create
results: parsing output: 59/ for test: i915_hangman
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_psr_stress_test
results: parsing output: 62/ for test: i915_suspend
results: parsing output: 63/ for test: i915_pm_rc6_residency
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: api_intel_bb
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_hdmi_inject
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_content_protection
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: prime_self_import
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: gem_ctx_isolation
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: kms_sequence
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_chamelium_color
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_linear_blits
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_exec_capture
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_async_flips
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_prop_blob
results: parsing output: 133/ for test: kms_cursor_crc
results: parsing output: 134/ for test: gem_exec_schedule
results: parsing output: 135/ for test: kms_addfb_basic
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_exec_fence
results: parsing output: 138/ for test: prime_vgem
results: parsing output: 139/ for test: syncobj_timeline
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_chamelium_hpd
results: parsing output: 143/ for test: gem_exec_params
results: parsing output: 144/ for test: kms_cursor_crc
results: parsing output: 145/ for test: kms_feature_discovery
results: parsing output: 146/ for test: kms_vrr
results: parsing output: 147/ for test: kms_ccs
results: parsing output: 148/ for test: kms_chamelium_edid
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: syncobj_wait
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: syncobj_timeline
results: parsing output: 153/ for test: gem_ctx_bad_destroy
results: parsing output: 154/ for test: gem_ctx_persistence
results: parsing output: 155/ for test: kms_flip
Done.