[56.401365] Initializing watchdogs
[56.401412]   /dev/watchdog0
[56.416501] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.420812] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.423605] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.426824] [001/155] (960s left) kms_feature_discovery (display-1x)
[56.561765] Starting subtest: display-1x
[56.564083] Subtest display-1x: SUCCESS (0.000s)
[56.641586] [002/155] (960s left) prime_vgem (busy)
[56.736075] Starting subtest: busy
[56.738382] Starting dynamic subtest: rcs0
[56.780041] Dynamic subtest rcs0: SUCCESS (0.044s)
[56.788634] Starting dynamic subtest: bcs0
[56.832362] Dynamic subtest bcs0: SUCCESS (0.052s)
[56.839994] Starting dynamic subtest: vcs0
[56.878035] Dynamic subtest vcs0: SUCCESS (0.045s)
[56.885637] Starting dynamic subtest: vcs1
[56.925557] Dynamic subtest vcs1: SUCCESS (0.047s)
[56.933108] Starting dynamic subtest: vecs0
[56.970824] Dynamic subtest vecs0: SUCCESS (0.045s)
[56.978255] Starting dynamic subtest: ccs0
[57.016787] Dynamic subtest ccs0: SUCCESS (0.046s)
[57.019083] Subtest busy: SUCCESS (0.281s)
[57.134751] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[57.138494] [003/155] (959s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[57.256804] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[57.261277] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[57.347795] [004/155] (959s left) kms_psr (psr2-primary-blt)
[57.448076] Starting subtest: psr2-primary-blt
[57.450062] Starting dynamic subtest: eDP-1
[59.167280] Dynamic subtest eDP-1: SUCCESS (1.718s)
[59.169722] Subtest psr2-primary-blt: SUCCESS (1.718s)
[60.046505] [005/155] (957s left) gem_exec_whisper (basic-queues)
[60.113538] Starting subtest: basic-queues
[67.240525] Subtest basic-queues: SUCCESS (7.122s)
[67.448821] [006/155] (949s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[67.553367] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[67.557729] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[67.654793] [007/155] (949s left) api_intel_bb (blit-noreloc-keep-cache)
[67.704692] Starting subtest: blit-noreloc-keep-cache
[67.714665] Subtest blit-noreloc-keep-cache: SUCCESS (0.012s)
[67.849144] [008/155] (949s left) gen9_exec_parse (bb-start-param)
[67.902607] Subtest bb-start-param: SKIP (0.000s)
[67.969448] [009/155] (949s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[68.053121] Starting subtest: plane-lut1d-ctm3x4
[68.224631] Starting dynamic subtest: pipe-A-plane-0
[68.409917] Dynamic subtest pipe-A-plane-0: SUCCESS (0.188s)
[68.420231] Starting dynamic subtest: pipe-A-plane-1
[68.565478] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[68.577231] Starting dynamic subtest: pipe-A-plane-2
[68.733508] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[69.966695] Starting dynamic subtest: pipe-B-plane-0
[70.136806] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[70.152771] Starting dynamic subtest: pipe-B-plane-1
[70.325657] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[70.335401] Starting dynamic subtest: pipe-B-plane-2
[70.493044] Dynamic subtest pipe-B-plane-2: SUCCESS (0.167s)
[71.685721] Starting dynamic subtest: pipe-C-plane-0
[71.843978] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[71.853810] Starting dynamic subtest: pipe-C-plane-1
[72.011079] Dynamic subtest pipe-C-plane-1: SUCCESS (0.167s)
[72.020680] Starting dynamic subtest: pipe-C-plane-2
[72.166339] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[73.431373] Starting dynamic subtest: pipe-D-plane-0
[73.590067] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[73.598555] Starting dynamic subtest: pipe-D-plane-1
[73.756140] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[73.766885] Starting dynamic subtest: pipe-D-plane-2
[73.911782] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[74.204150] Subtest plane-lut1d-ctm3x4: SUCCESS (6.152s)
[75.084934] [010/155] (942s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[75.197905] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[75.202239] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[75.291200] [011/155] (942s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[75.395129] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[75.399481] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[75.497992] [012/155] (941s left) gem_busy (semaphore)
[75.690180] Subtest semaphore: SKIP (0.000s)
[75.920540] [013/155] (941s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[76.045704] Starting subtest: cursorA-vs-flipB-toggle
[76.050186] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[76.216550] [014/155] (941s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[76.274732] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[76.277051] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[76.364135] [015/155] (941s left) gem_mmap_gtt (flink-race)
[76.420160] Subtest flink-race: SKIP (0.000s)
[76.489198] [016/155] (941s left) gem_eio (context-create)
[76.724250] Starting subtest: context-create
[77.065150] Subtest context-create: SUCCESS (0.341s)
[77.205282] [017/155] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[77.299609] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[83.867210] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.571s)
[84.013908] [018/155] (933s left) kms_atomic_interruptible (universal-setplane-cursor)
[84.116141] Starting subtest: universal-setplane-cursor
[84.118405] Starting dynamic subtest: pipe-A-eDP-1
[91.533924] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.418s)
[91.536290] Subtest universal-setplane-cursor: SUCCESS (7.419s)
[92.378695] [019/155] (925s left) kms_selftest (drm_format)
[92.416753] Starting subtest: drm_format
[92.427330] Starting dynamic subtest: drm_test_format_block_width_invalid
[92.547453] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.118s)
[92.558162] Starting dynamic subtest: drm_test_format_block_width_one_plane
[92.655470] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.109s)
[92.665830] Starting dynamic subtest: drm_test_format_block_width_two_plane
[92.754545] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.098s)
[92.764609] Starting dynamic subtest: drm_test_format_block_width_three_plane
[92.863234] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.108s)
[92.871393] Starting dynamic subtest: drm_test_format_block_width_tiled
[92.990080] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.125s)
[93.000352] Starting dynamic subtest: drm_test_format_block_height_invalid
[93.091673] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.102s)
[93.101131] Starting dynamic subtest: drm_test_format_block_height_one_plane
[93.190789] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.099s)
[93.200727] Starting dynamic subtest: drm_test_format_block_height_two_plane
[93.283829] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.092s)
[93.292444] Starting dynamic subtest: drm_test_format_block_height_three_plane
[93.390729] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.106s)
[93.400664] Starting dynamic subtest: drm_test_format_block_height_tiled
[93.492477] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.102s)
[93.502167] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[93.600838] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.107s)
[93.610650] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[93.707753] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.107s)
[93.722419] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[93.809617] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.100s)
[93.819343] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[93.916502] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.106s)
[93.925110] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[94.008837] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.092s)
[94.017065] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[94.106850] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.097s)
[94.115188] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[94.204908] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.097s)
[94.214754] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[94.297491] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.092s)
[94.299096] Subtest drm_format: SUCCESS (1.883s)
[94.444878] [020/155] (923s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[94.549202] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[95.262997] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.715s)
[95.413231] [021/155] (922s left) kms_psr (fbc-psr2-primary-page-flip)
[95.508235] Starting subtest: fbc-psr2-primary-page-flip
[95.510600] Starting dynamic subtest: eDP-1
[95.515028] Dynamic subtest eDP-1: SKIP (0.000s)
[95.519407] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[95.595639] [022/155] (922s left) kms_flip (plain-flip-ts-check-interruptible)
[95.686402] Starting subtest: plain-flip-ts-check-interruptible
[95.688796] Starting dynamic subtest: A-eDP1
[104.563205] Dynamic subtest A-eDP1: SUCCESS (8.876s)
[104.576074] Starting dynamic subtest: B-eDP1
[113.396714] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[113.406093] Starting dynamic subtest: C-eDP1
[122.213347] Dynamic subtest C-eDP1: SUCCESS (8.814s)
[122.224764] Starting dynamic subtest: D-eDP1
[131.040856] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[131.046143] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.358s)
[132.224299] [023/155] (885s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[132.326215] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[132.330825] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[132.422268] [024/155] (885s left) gem_lmem_swapping (verify)
[132.465418] Subtest verify: SKIP (0.000s)
[132.519674] [025/155] (885s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[132.615648] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[132.620079] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[132.686381] [026/155] (885s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[132.791479] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[132.795776] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[132.888588] [027/155] (885s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[132.998920] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[133.003231] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[133.096737] [028/155] (884s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[133.191407] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[133.195096] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[133.280920] [029/155] (884s left) kms_async_flips (alternate-sync-async-flip)
[133.375299] Starting subtest: alternate-sync-async-flip
[133.748809] Starting dynamic subtest: pipe-A-eDP-1
[136.507992] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.761s)
[136.900310] Starting dynamic subtest: pipe-B-eDP-1
[139.646218] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s)
[140.027417] Starting dynamic subtest: pipe-C-eDP-1
[142.780590] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[143.145296] Starting dynamic subtest: pipe-D-eDP-1
[145.906936] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[145.909094] Subtest alternate-sync-async-flip: SUCCESS (12.534s)
[147.073990] [030/155] (871s left) kms_pm_backlight (fade)
[147.185210] Starting subtest: fade
[147.233712] Starting dynamic subtest: eDP-1
[150.245511] Dynamic subtest eDP-1: SUCCESS (3.010s)
[150.247813] Subtest fade: SUCCESS (3.062s)
[151.102625] [031/155] (867s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[151.205589] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[151.209641] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[151.311252] [032/155] (866s left) i915_query (engine-info)
[151.366466] Starting subtest: engine-info
[151.368950] Subtest engine-info: SUCCESS (0.005s)
[151.502495] [033/155] (866s left) gem_mmap_gtt (basic-short)
[151.557448] Subtest basic-short: SKIP (0.000s)
[151.615091] [034/155] (866s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[151.713569] Starting subtest: fbc-rgb101010-draw-render
[154.219342] Subtest fbc-rgb101010-draw-render: SUCCESS (2.510s)
[155.400883] [035/155] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[155.516215] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[155.520742] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[155.612948] [036/155] (862s left) kms_psr (fbc-pr-primary-mmap-gtt)
[155.710150] Starting subtest: fbc-pr-primary-mmap-gtt
[155.714429] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[155.794813] [037/155] (862s left) api_intel_bb (render-ccs)
[155.848867] Starting subtest: render-ccs
[156.205032] Subtest render-ccs: SUCCESS (0.355s)
[156.329163] [038/155] (862s left) gem_exec_reloc (basic-write-read)
[156.385715] Subtest basic-write-read: SKIP (0.000s)
[156.459536] [039/155] (862s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-render)
[156.561839] Starting subtest: psrhdr-rgb101010-draw-render
[156.566217] Subtest psrhdr-rgb101010-draw-render: SKIP (0.000s)
[156.664707] [040/155] (861s left) gem_exec_flush (basic-wb-rw-before-default)
[156.719150] Starting subtest: basic-wb-rw-before-default
[162.172329] Subtest basic-wb-rw-before-default: SUCCESS (5.453s)
[162.358988] [041/155] (856s left) gem_userptr_blits (coherency-unsync)
[162.424207] Subtest coherency-unsync: SKIP (0.000s)
[162.560506] [042/155] (856s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[162.685697] Starting subtest: short-busy-flip-before-cursor-toggle
[162.690047] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[162.832313] [043/155] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[162.929086] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[162.933415] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[163.032734] [044/155] (855s left) gem_eio (wait-wedge-1us)
[163.259589] Starting subtest: wait-wedge-1us
[164.370537] Subtest wait-wedge-1us: SUCCESS (1.110s)
[164.512564] [045/155] (854s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[164.602208] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[164.606615] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[164.674906] [046/155] (854s left) gem_readwrite (new-obj)
[164.724661] Subtest new-obj: SKIP (0.000s)
[164.791630] [047/155] (854s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[165.165085] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[165.985118] [048/155] (852s left) syncobj_wait (single-wait-all-for-submit-signaled)
[166.033057] Starting subtest: single-wait-all-for-submit-signaled
[166.035253] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[166.127394] [049/155] (852s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[166.223882] Starting subtest: y-tiled-64bpp-rotate-0
[166.228225] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[166.345912] [050/155] (852s left) gem_ctx_persistence (heartbeat-hostile)
[166.399201] Starting subtest: heartbeat-hostile
[166.403579] Subtest heartbeat-hostile: SKIP (0.000s)
[166.519859] [051/155] (852s left) gen9_exec_parse (unaligned-jump)
[166.585967] Subtest unaligned-jump: SKIP (0.000s)
[166.664801] [052/155] (852s left) kms_universal_plane (universal-plane-functional)
[166.767832] Starting subtest: universal-plane-functional
[166.770093] Starting dynamic subtest: pipe-A-eDP-1
[170.746844] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.983s)
[170.757845] Starting dynamic subtest: pipe-B-eDP-1
[175.252605] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.502s)
[175.262388] Starting dynamic subtest: pipe-C-eDP-1
[179.637450] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.382s)
[179.647478] Starting dynamic subtest: pipe-D-eDP-1
[183.830345] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.193s)
[183.832647] Subtest universal-plane-functional: SUCCESS (17.066s)
[184.728448] [053/155] (834s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[184.836181] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[188.896592] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.065s)
[190.036931] [054/155] (829s left) gem_exec_reloc (basic-write-gtt-active)
[190.092306] Subtest basic-write-gtt-active: SKIP (0.000s)
[190.166563] [055/155] (829s left) kms_frontbuffer_tracking (psr-suspend)
[190.266470] Starting subtest: psr-suspend
[229.111345] Subtest psr-suspend: SUCCESS (8.871s)
[229.227986] [056/155] (790s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[229.332519] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[229.335240] Starting dynamic subtest: pipe-A-eDP-1
[229.852584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.485s)
[229.863364] Starting dynamic subtest: pipe-B-eDP-1
[231.289441] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.433s)
[231.300741] Starting dynamic subtest: pipe-C-eDP-1
[232.665950] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[232.676748] Starting dynamic subtest: pipe-D-eDP-1
[234.112260] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.441s)
[234.114362] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.742s)
[235.261130] [057/155] (784s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[235.358567] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[235.363568] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[235.450293] [058/155] (783s left) gem_mmap_gtt (big-copy-odd)
[235.513571] Subtest big-copy-odd: SKIP (0.000s)
[235.576099] [059/155] (783s left) kms_invalid_mode (bad-vsync-start)
[235.661072] Starting subtest: bad-vsync-start
[235.663549] Starting dynamic subtest: pipe-A-eDP-1
[235.959053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.300s)
[235.969979] Starting dynamic subtest: pipe-B-eDP-1
[235.972097] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[235.985719] Starting dynamic subtest: pipe-C-eDP-1
[235.988457] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[235.998770] Starting dynamic subtest: pipe-D-eDP-1
[236.001747] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[236.004543] Subtest bad-vsync-start: SUCCESS (0.306s)
[236.800333] [060/155] (782s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[236.894308] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[236.896609] Starting dynamic subtest: pipe-A-default-mode
[238.076898] Dynamic subtest pipe-A-default-mode: SKIP (1.177s)
[238.082550] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.180s)
[238.217147] [061/155] (781s left) gem_tiled_partial_pwrite_pread (writes)
[238.268653] Subtest writes: SKIP (0.000s)
[238.337095] [062/155] (781s left) gem_userptr_blits (process-exit-busy)
[238.400462] Starting subtest: process-exit-busy
[238.411228] Subtest process-exit-busy: SUCCESS (0.012s)
[238.538111] [063/155] (781s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[238.583244] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[238.585811] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[238.677306] [064/155] (780s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite)
[238.772740] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite
[238.778245] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[238.878301] [065/155] (780s left) gem_huc_copy (huc-copy)
[238.933630] Starting subtest: huc-copy
[238.938723] Subtest huc-copy: SUCCESS (0.004s)
[239.087145] [066/155] (780s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[239.197117] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[239.201139] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[239.280111] [067/155] (780s left) gem_userptr_blits (invalid-null-pointer)
[239.345308] Starting subtest: invalid-null-pointer
[239.347411] Subtest invalid-null-pointer: SUCCESS (0.001s)
[239.458112] [068/155] (780s left) kms_pipe_crc_basic (suspend-read-crc)
[239.555352] Starting subtest: suspend-read-crc
[239.557417] Starting dynamic subtest: pipe-A-eDP-1
[257.448266] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.565s)
[257.461180] Starting dynamic subtest: pipe-B-eDP-1
[275.456830] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.212s)
[275.467562] Starting dynamic subtest: pipe-C-eDP-1
[293.405078] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.134s)
[293.416617] Starting dynamic subtest: pipe-D-eDP-1
[311.399728] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.049s)
[311.402000] Subtest suspend-read-crc: SUCCESS (11.966s)
[312.218831] [069/155] (707s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[312.325264] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[312.329742] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[312.440111] [070/155] (707s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[312.543156] Starting subtest: 4-tiled-64bpp-rotate-270
[312.563074] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[312.682810] [071/155] (707s left) kms_setmode (invalid-clone-single-crtc-stealing)
[312.742264] Starting subtest: invalid-clone-single-crtc-stealing
[312.748680] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[312.837001] [072/155] (707s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-plflip-blt)
[312.931887] Starting subtest: psrhdr-1p-primscrn-shrfb-plflip-blt
[312.935931] Subtest psrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[313.035445] [073/155] (706s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[313.132073] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[313.136508] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[313.215062] [074/155] (706s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render)
[313.315762] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render
[313.319355] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[313.421314] [075/155] (706s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[313.516007] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[313.519646] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[313.605728] [076/155] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[313.706584] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[313.709963] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[313.806993] [077/155] (706s left) gem_exec_params (invalid-bsd-ring)
[313.867898] Starting subtest: invalid-bsd-ring
[313.869622] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[313.970181] [078/155] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[314.069801] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[314.073219] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[314.152563] [079/155] (706s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[314.249004] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[314.252652] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[314.331993] [080/155] (705s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[314.424288] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[315.239503] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s)
[315.393982] [081/155] (704s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[315.507473] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[315.511460] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[315.623190] [082/155] (704s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[315.725240] Starting subtest: psrhdr-shrfb-scaledprimary
[315.729525] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[315.832766] [083/155] (704s left) kms_psr (fbc-psr-primary-mmap-cpu)
[315.924007] Starting subtest: fbc-psr-primary-mmap-cpu
[315.926245] Starting dynamic subtest: eDP-1
[315.930485] Dynamic subtest eDP-1: SKIP (0.000s)
[315.934854] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[315.999753] [084/155] (704s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[316.094208] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[316.096516] Starting dynamic subtest: pipe-A
[316.117512] Dynamic subtest pipe-A: SKIP (0.019s)
[316.127960] Starting dynamic subtest: pipe-B
[316.150842] Dynamic subtest pipe-B: SKIP (0.033s)
[316.161333] Starting dynamic subtest: pipe-C
[316.184010] Dynamic subtest pipe-C: SKIP (0.033s)
[316.193943] Starting dynamic subtest: pipe-D
[316.218590] Dynamic subtest pipe-D: SKIP (0.033s)
[316.222098] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.121s)
[316.320828] [085/155] (704s left) kms_vblank (ts-continuation-modeset-hang)
[316.411369] Starting subtest: ts-continuation-modeset-hang
[316.413259] Starting dynamic subtest: pipe-A-eDP-1
[342.910279] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.481s)
[342.925884] Starting dynamic subtest: pipe-D-eDP-1
[367.928555] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.008s)
[367.930984] Subtest ts-continuation-modeset-hang: SUCCESS (51.494s)
[368.765308] [086/155] (651s left) syncobj_timeline (invalid-transfer-non-existent-point)
[368.818651] Starting subtest: invalid-transfer-non-existent-point
[368.821009] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[368.935866] [087/155] (651s left) kms_pm_rpm (modeset-pc8-residency-stress)
[370.462119] Starting subtest: modeset-pc8-residency-stress
[370.466823] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[371.205517] [088/155] (649s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[371.306998] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[371.311284] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[371.407542] [089/155] (649s left) syncobj_wait (multi-wait-for-submit-signaled)
[371.478518] Starting subtest: multi-wait-for-submit-signaled
[371.480820] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[371.568654] [090/155] (649s left) gen7_exec_parse (basic-offset)
[371.623050] Subtest basic-offset: SKIP (0.000s)
[371.707305] [091/155] (649s left) kms_cursor_crc (cursor-onscreen-512x170)
[371.989971] Starting subtest: cursor-onscreen-512x170
[371.994442] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[372.143638] [092/155] (648s left) kms_pipe_crc_basic (hang-read-crc)
[372.239282] Starting subtest: hang-read-crc
[372.241209] Starting dynamic subtest: pipe-A-eDP-1
[374.372093] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s)
[374.383370] Starting dynamic subtest: pipe-B-eDP-1
[377.236123] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.862s)
[377.246838] Starting dynamic subtest: pipe-C-eDP-1
[379.950151] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.712s)
[379.964851] Starting dynamic subtest: pipe-D-eDP-1
[382.612455] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.659s)
[382.614572] Subtest hang-read-crc: SUCCESS (10.369s)
[383.439318] [093/155] (637s left) gem_create (hog-create)
[383.487328] Starting subtest: hog-create
[383.489790] Starting dynamic subtest: smem0
[417.090593] Dynamic subtest smem0: SUCCESS (33.597s)
[417.093570] Subtest hog-create: SUCCESS (33.598s)
[417.292515] [094/155] (603s left) core_sysfs (read-all-entries)
[417.368390] Starting subtest: read-all-entries
[417.370983] Subtest read-all-entries: SUCCESS (0.004s)
[417.459604] [095/155] (603s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[417.580368] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[418.541324] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.961s)
[419.380876] [096/155] (601s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-fullscreen)
[419.487550] Starting subtest: fbchdr-2p-primscrn-spr-indfb-fullscreen
[419.491600] Subtest fbchdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[419.593348] [097/155] (601s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[419.646338] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[419.648552] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[419.751455] [098/155] (601s left) kms_rotation_crc (cursor-rotation-180)
[419.848677] Starting subtest: cursor-rotation-180
[421.350480] Subtest cursor-rotation-180: SUCCESS (1.504s)
[422.546817] [099/155] (598s left) gem_userptr_blits (stress-mm-invalidate-close)
[422.603593] Starting subtest: stress-mm-invalidate-close
[424.752422] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[424.873250] [100/155] (596s left) kms_psr (pr-sprite-mmap-gtt)
[424.969148] Starting subtest: pr-sprite-mmap-gtt
[424.973755] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[425.042480] [101/155] (596s left) gem_exec_schedule (submit-late-slice)
[425.114517] Starting subtest: submit-late-slice
[425.116807] Starting dynamic subtest: rcs0
[425.143554] Dynamic subtest rcs0: SUCCESS (0.036s)
[425.160636] Starting dynamic subtest: bcs0
[425.189521] Dynamic subtest bcs0: SUCCESS (0.045s)
[425.202979] Starting dynamic subtest: vcs0
[425.227085] Dynamic subtest vcs0: SUCCESS (0.037s)
[425.239426] Starting dynamic subtest: vcs1
[425.261611] Dynamic subtest vcs1: SUCCESS (0.033s)
[425.273300] Starting dynamic subtest: vecs0
[425.302468] Dynamic subtest vecs0: SUCCESS (0.040s)
[425.314210] Starting dynamic subtest: ccs0
[425.347788] Dynamic subtest ccs0: SUCCESS (0.045s)
[425.350201] Subtest submit-late-slice: SUCCESS (0.242s)
[427.238511] [102/155] (593s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[427.341452] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[434.701571] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.366s)
[434.832394] [103/155] (586s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[434.920158] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[434.922391] Starting dynamic subtest: pipe-A-eDP-1
[434.942952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[434.954123] Starting dynamic subtest: pipe-B-eDP-1
[434.974726] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[434.985756] Starting dynamic subtest: pipe-C-eDP-1
[435.006110] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[435.018033] Starting dynamic subtest: pipe-D-eDP-1
[435.037312] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[435.039457] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[437.348321] [104/155] (583s left) kms_flip (dpms-off-confusion)
[437.442176] Starting subtest: dpms-off-confusion
[437.444549] Starting dynamic subtest: A-eDP1
[446.143330] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[446.156768] Starting dynamic subtest: B-eDP1
[454.784421] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[454.797450] Starting dynamic subtest: C-eDP1
[463.500758] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[463.511420] Starting dynamic subtest: D-eDP1
[472.131043] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[472.133356] Subtest dpms-off-confusion: SUCCESS (34.688s)
[473.320808] [105/155] (548s left) i915_pm_rpm (gem-execbuf)
[475.258410] Starting subtest: gem-execbuf
[475.260490] Starting dynamic subtest: smem0
[477.021433] Dynamic subtest smem0: SUCCESS (1.765s)
[477.023871] Subtest gem-execbuf: SUCCESS (1.766s)
[477.144814] [106/155] (544s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[477.254129] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[477.258058] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[477.348775] [107/155] (544s left) i915_pm_freq_api (freq-suspend)
[477.406656] Starting subtest: freq-suspend
[477.409121] Starting dynamic subtest: gt0
[493.551348] Dynamic subtest gt0: SUCCESS (1.258s)
[493.563175] Starting dynamic subtest: gt1
[509.538237] Dynamic subtest gt1: SUCCESS (1.203s)
[509.540476] Subtest freq-suspend: SUCCESS (2.464s)
[509.604342] [108/155] (511s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[509.711593] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[516.899093] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.182s)
[517.033082] [109/155] (504s left) kms_frontbuffer_tracking (hdr-1p-rte)
[517.139398] Starting subtest: hdr-1p-rte
[517.144196] Subtest hdr-1p-rte: SKIP (0.000s)
[517.235354] [110/155] (504s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[517.331856] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[517.336582] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[517.422404] [111/155] (504s left) gem_ctx_persistence (engines-hostile-preempt)
[517.475471] Starting subtest: engines-hostile-preempt
[517.478025] Starting dynamic subtest: rcs0
[517.541798] Dynamic subtest rcs0: SUCCESS (0.066s)
[517.554992] Starting dynamic subtest: bcs0
[517.591714] Dynamic subtest bcs0: SUCCESS (0.048s)
[517.604356] Starting dynamic subtest: vcs0
[518.781104] Dynamic subtest vcs0: SUCCESS (1.185s)
[518.797623] Starting dynamic subtest: vcs1
[520.752476] Dynamic subtest vcs1: SUCCESS (1.966s)
[520.765746] Starting dynamic subtest: vecs0
[522.815310] Dynamic subtest vecs0: SUCCESS (2.059s)
[522.827912] Starting dynamic subtest: ccs0
[522.848688] Dynamic subtest ccs0: SUCCESS (0.032s)
[522.851551] Subtest engines-hostile-preempt: SUCCESS (5.368s)
[522.971125] [112/155] (498s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[523.067005] Starting subtest: psr2-cursor-plane-update-sf
[523.069407] Starting dynamic subtest: pipe-A-eDP-1
[523.638749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[523.651071] Starting dynamic subtest: pipe-B-eDP-1
[524.969146] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.328s)
[524.971816] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.904s)
[525.850768] [113/155] (495s left) kms_properties (connector-properties-atomic)
[525.949953] Starting subtest: connector-properties-atomic
[525.952352] Starting dynamic subtest: pipe-A-eDP-1
[534.087295] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.131s)
[534.098829] Starting dynamic subtest: pipe-None-DP-1
[534.103597] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[534.114084] Starting dynamic subtest: pipe-None-HDMI-A-1
[534.119411] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[534.129712] Starting dynamic subtest: pipe-None-DP-2
[534.135093] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[534.145797] Starting dynamic subtest: pipe-None-HDMI-A-2
[534.151332] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[534.162616] Starting dynamic subtest: pipe-None-DP-3
[534.167593] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[534.178264] Starting dynamic subtest: pipe-None-DP-4
[534.183385] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[534.185879] Subtest connector-properties-atomic: SUCCESS (8.142s)
[534.965372] [114/155] (486s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[535.064802] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[535.069735] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[535.159130] [115/155] (486s left) gem_render_linear_blits (basic)
[535.223452] Starting subtest: basic
[535.245816] Subtest basic: SUCCESS (0.022s)
[535.333717] [116/155] (486s left) gem_exec_balancer (full-pulse)
[535.383885] Starting subtest: full-pulse
[539.710138] Subtest full-pulse: SUCCESS (4.325s)
[540.027090] [117/155] (481s left) perf_pmu (all-busy-check-all)
[540.071390] Starting subtest: all-busy-check-all
[541.766226] Subtest all-busy-check-all: SUCCESS (1.695s)
[541.890728] [118/155] (480s left) kms_cursor_crc (cursor-sliding-128x128)
[542.104345] Starting subtest: cursor-sliding-128x128
[542.111410] Starting dynamic subtest: pipe-A-eDP-1
[545.338694] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.231s)
[545.373226] Starting dynamic subtest: pipe-D-eDP-1
[549.272165] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.910s)
[549.274849] Subtest cursor-sliding-128x128: SUCCESS (7.170s)
[550.127447] [119/155] (471s left) gem_pxp (create-protected-buffer)
[550.243975] Starting subtest: create-protected-buffer
[550.246344] Subtest create-protected-buffer: SUCCESS (0.000s)
[550.352155] [120/155] (471s left) gem_softpin (evict-single-offset)
[550.402326] Starting subtest: evict-single-offset
[576.774921] Subtest evict-single-offset: SUCCESS (26.366s)
[576.880229] [121/155] (445s left) gem_exec_reloc (basic-cpu)
[576.999449] Subtest basic-cpu: SKIP (0.000s)
[577.071972] [122/155] (445s left) kms_getfb (getfb-handle-valid)
[577.175081] Starting subtest: getfb-handle-valid
[577.177697] Subtest getfb-handle-valid: SUCCESS (0.000s)
[577.280223] [123/155] (444s left) gem_exec_fence (syncobj-timeline-wait)
[577.843309] Starting subtest: syncobj-timeline-wait
[578.841867] Subtest syncobj-timeline-wait: SUCCESS (0.998s)
[580.858785] [124/155] (441s left) kms_pm_rpm (basic-rte)
[580.900433] Starting subtest: basic-rte
[584.417390] Subtest basic-rte: SUCCESS (3.517s)
[586.259632] [125/155] (435s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt)
[586.362164] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt
[586.367422] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[586.473451] [126/155] (435s left) gem_ppgtt (flink-and-close-vma-leak)
[586.529183] Starting subtest: flink-and-close-vma-leak
[586.572106] Subtest flink-and-close-vma-leak: SUCCESS (0.043s)
[586.690153] [127/155] (435s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[586.795103] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[586.799403] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[586.896843] [128/155] (435s left) gem_exec_fence (nb-await)
[587.073800] Starting subtest: nb-await
[587.076328] Starting dynamic subtest: rcs0
[587.140560] Dynamic subtest rcs0: SUCCESS (0.066s)
[587.155806] Starting dynamic subtest: bcs0
[587.199109] Dynamic subtest bcs0: SUCCESS (0.056s)
[587.212425] Starting dynamic subtest: vcs0
[587.258477] Dynamic subtest vcs0: SUCCESS (0.057s)
[587.273075] Starting dynamic subtest: vcs1
[587.316962] Dynamic subtest vcs1: SUCCESS (0.057s)
[587.333966] Starting dynamic subtest: vecs0
[587.377320] Dynamic subtest vecs0: SUCCESS (0.058s)
[587.390761] Starting dynamic subtest: ccs0
[587.435841] Dynamic subtest ccs0: SUCCESS (0.057s)
[587.438585] Subtest nb-await: SUCCESS (0.363s)
[588.887941] [129/155] (433s left) gem_exec_schedule (preempt-queue)
[588.981446] Subtest preempt-queue: SKIP (0.000s)
[589.264222] [130/155] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[589.384471] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[589.389597] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[589.474155] [131/155] (433s left) kms_content_protection (type1)
[589.616099] Starting subtest: type1
[589.621622] Subtest type1: SKIP (0.000s)
[589.730261] [132/155] (432s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[589.830410] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[597.349273] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.522s)
[597.487704] [133/155] (425s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[597.593452] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[601.279968] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.692s)
[602.507329] [134/155] (420s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[602.566344] Subtest writes-after-reads-snoop: SKIP (0.000s)
[602.639628] [135/155] (420s left) kms_plane_multiple (2x-tiling-4)
[602.742259] Starting subtest: 2x-tiling-4
[602.747051] Subtest 2x-tiling-4: SKIP (0.000s)
[602.829199] [136/155] (419s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[602.879431] Starting subtest: single-wait-all-for-submit-available-submitted
[602.882166] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[602.993821] [137/155] (419s left) gem_exec_capture (capture)
[603.051343] Starting subtest: capture
[603.054355] Starting dynamic subtest: rcs0-smem
[603.882563] Dynamic subtest rcs0-smem: SUCCESS (0.831s)
[603.895011] Starting dynamic subtest: bcs0-smem
[604.697071] Dynamic subtest bcs0-smem: SUCCESS (0.815s)
[604.715358] Starting dynamic subtest: vcs0-smem
[605.524666] Dynamic subtest vcs0-smem: SUCCESS (0.824s)
[605.536979] Starting dynamic subtest: vcs1-smem
[606.848693] Dynamic subtest vcs1-smem: SUCCESS (1.327s)
[606.862918] Starting dynamic subtest: vecs0-smem
[607.758072] Dynamic subtest vecs0-smem: FAIL (0.833s)
[607.773351] Starting dynamic subtest: ccs0-smem
[609.010993] Dynamic subtest ccs0-smem: SUCCESS (1.324s)
[609.013716] Subtest capture: FAIL (5.960s)
[609.126946] [138/155] (413s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[609.231594] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[609.236335] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[609.321253] [139/155] (413s left) gem_linear_blits (normal)
[609.468968] Starting subtest: normal
[613.444838] Subtest normal: SUCCESS (3.979s)
[613.601100] [140/155] (409s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[614.022421] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[614.876773] [141/155] (408s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[614.980330] Starting subtest: 4-tiled-16bpp-rotate-0
[616.371693] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.392s)
[616.485349] [142/155] (406s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[616.584958] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[616.587141] Starting dynamic subtest: pipe-A-eDP-1
[616.596155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[616.607242] Starting dynamic subtest: pipe-B-eDP-1
[616.616187] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[616.627132] Starting dynamic subtest: pipe-C-eDP-1
[616.636085] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[616.647176] Starting dynamic subtest: pipe-D-eDP-1
[616.655815] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[616.660243] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[618.894910] [143/155] (404s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[618.989458] Starting subtest: x-tiled-64bpp-rotate-180
[620.602738] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.612s)
[620.782158] [144/155] (402s left) gem_eio (wait-1us)
[620.991311] Starting subtest: wait-1us
[621.301247] Subtest wait-1us: SUCCESS (0.312s)
[621.427805] [145/155] (401s left) gem_exec_params (cliprects_ptr-dirt)
[621.487187] Starting subtest: cliprects_ptr-dirt
[621.490084] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[621.585584] [146/155] (401s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[621.678245] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[621.680399] Starting dynamic subtest: pipe-A-eDP-1
[622.924550] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.248s)
[622.936547] Starting dynamic subtest: pipe-B-eDP-1
[625.211616] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.286s)
[625.225550] Starting dynamic subtest: pipe-C-eDP-1
[627.526187] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.313s)
[627.538277] Starting dynamic subtest: pipe-D-eDP-1
[629.857232] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.330s)
[629.860238] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.182s)
[630.990886] [147/155] (392s left) kms_cursor_edge_walk (128x128-left-edge)
[631.081554] Starting subtest: 128x128-left-edge
[631.084148] Starting dynamic subtest: pipe-A-eDP-1
[634.548188] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.468s)
[634.561148] Starting dynamic subtest: pipe-D-eDP-1
[637.790890] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.238s)
[637.793391] Subtest 128x128-left-edge: SUCCESS (6.709s)
[638.599737] [148/155] (384s left) perf_pmu (init-busy)
[638.642877] Starting subtest: init-busy
[638.645458] Starting dynamic subtest: rcs0
[638.648045] Dynamic subtest rcs0: SUCCESS (0.001s)
[638.660199] Starting dynamic subtest: bcs0
[638.662463] Dynamic subtest bcs0: SUCCESS (0.001s)
[638.673240] Starting dynamic subtest: vcs0
[638.675611] Dynamic subtest vcs0: SUCCESS (0.001s)
[638.686180] Starting dynamic subtest: vcs1
[638.688416] Dynamic subtest vcs1: SUCCESS (0.001s)
[638.699606] Starting dynamic subtest: vecs0
[638.702321] Dynamic subtest vecs0: SUCCESS (0.001s)
[638.713568] Starting dynamic subtest: ccs0
[638.715816] Dynamic subtest ccs0: SUCCESS (0.001s)
[638.717705] Subtest init-busy: SUCCESS (0.009s)
[638.761357] [149/155] (384s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[638.844360] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[638.846971] Starting dynamic subtest: pipe-A-eDP-1
[638.870591] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[638.882675] Starting dynamic subtest: pipe-B-eDP-1
[638.908418] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[638.919549] Starting dynamic subtest: pipe-C-eDP-1
[638.945154] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[638.955817] Starting dynamic subtest: pipe-D-eDP-1
[638.981300] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[638.986507] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[641.151969] [150/155] (382s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt)
[641.247399] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt
[641.252710] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[641.348195] [151/155] (382s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[641.406422] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[641.412120] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[641.592347] [152/155] (381s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[641.648553] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[641.654144] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[641.832836] [153/155] (381s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[641.888839] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[641.994227] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[642.077496] [154/155] (381s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[642.175086] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[642.179201] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[642.264127] [155/155] (381s left) perf_pmu (busy-idle)
[642.310087] Starting subtest: busy-idle
[642.312320] Starting dynamic subtest: rcs0
[642.996280] Dynamic subtest rcs0: SUCCESS (0.687s)
[643.010502] Starting dynamic subtest: bcs0
[643.663573] Dynamic subtest bcs0: SUCCESS (0.664s)
[643.678724] Starting dynamic subtest: vcs0
[644.805723] Dynamic subtest vcs0: SUCCESS (1.139s)
[644.818462] Starting dynamic subtest: vcs1
[646.789611] Dynamic subtest vcs1: SUCCESS (1.980s)
[646.803894] Starting dynamic subtest: vecs0
[648.774309] Dynamic subtest vecs0: SUCCESS (1.984s)
[648.789686] Starting dynamic subtest: ccs0
[649.441780] Dynamic subtest ccs0: SUCCESS (0.665s)
[649.444622] Subtest busy-idle: SUCCESS (7.133s)
[649.546858] Closing watchdogs
results: parsing output: 0/ for test: kms_feature_discovery
results: parsing output: 1/ for test: prime_vgem
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_exec_whisper
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: kms_color_pipeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_busy
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_atomic_interruptible
results: parsing output: 18/ for test: kms_selftest
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_flush
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: gem_readwrite
results: parsing output: 46/ for test: kms_chamelium_edid
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_universal_plane
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_invalid_mode
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_huc_copy
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_pipe_crc_basic
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_setmode
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: gen7_exec_parse
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_pipe_crc_basic
results: parsing output: 92/ for test: gem_create
results: parsing output: 93/ for test: core_sysfs
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: i915_pm_rpm
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_pm_freq_api
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_render_linear_blits
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_getfb
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ppgtt
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_partial_pwrite_pread
results: parsing output: 134/ for test: kms_plane_multiple
results: parsing output: 135/ for test: syncobj_timeline
results: parsing output: 136/ for test: gem_exec_capture
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_linear_blits
results: parsing output: 139/ for test: kms_chamelium_hpd
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: kms_ccs
results: parsing output: 142/ for test: kms_big_fb
results: parsing output: 143/ for test: gem_eio
results: parsing output: 144/ for test: gem_exec_params
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_cursor_edge_walk
results: parsing output: 147/ for test: perf_pmu
results: parsing output: 148/ for test: kms_ccs
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_render_copy
results: parsing output: 151/ for test: gem_render_copy
results: parsing output: 152/ for test: syncobj_timeline
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: perf_pmu
Done.