[115.387722] Initializing watchdogs
[115.387767]   /dev/watchdog0
[115.403699] [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]
[115.408541] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[115.411140] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[115.413217] [001/156] (960s left) kms_universal_plane (universal-plane-pageflip-windowed)
[115.513994] Starting subtest: universal-plane-pageflip-windowed
[115.514929] Starting dynamic subtest: pipe-A-eDP-1
[116.092518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[116.100461] Starting dynamic subtest: pipe-B-eDP-1
[117.313790] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.220s)
[117.322261] Starting dynamic subtest: pipe-C-eDP-1
[118.523096] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[118.531873] Starting dynamic subtest: pipe-D-eDP-1
[119.748749] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[119.749670] Subtest universal-plane-pageflip-windowed: SUCCESS (4.234s)
[120.627520] [002/156] (955s left) gem_ppgtt (shrink-vs-evict-any)
[120.678680] Starting subtest: shrink-vs-evict-any
[128.314026] Subtest shrink-vs-evict-any: SUCCESS (7.589s)
[128.360572] [003/156] (947s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[128.451694] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[128.453454] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[128.549095] [004/156] (947s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[128.642199] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[128.644133] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[128.701881] [005/156] (947s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[128.805814] Starting subtest: yf-tiled-8bpp-rotate-90
[128.807874] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[128.911195] [006/156] (947s left) kms_psr (fbc-psr-cursor-render)
[128.995343] Starting subtest: fbc-psr-cursor-render
[128.996217] Starting dynamic subtest: eDP-1
[128.997878] Dynamic subtest eDP-1: SKIP (0.000s)
[128.999758] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[129.058480] [007/156] (947s left) gem_exec_fence (invalid-fence-array)
[129.493255] Starting subtest: invalid-fence-array
[129.494477] Subtest invalid-fence-array: SUCCESS (0.002s)
[131.337699] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[131.339751] [008/156] (944s left) gem_close_race (basic-process)
[131.398473] Starting subtest: basic-process
[131.451707] Subtest basic-process: SUCCESS (0.053s)
[131.639861] [009/156] (944s left) perf (invalid-create-userspace-config)
[131.757995] Starting subtest: invalid-create-userspace-config
[131.758976] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[131.816811] [010/156] (944s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[131.919134] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[131.920732] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[132.048831] [011/156] (944s left) kms_chamelium_color (ctm-limited-range)
[132.144331] Subtest ctm-limited-range: SKIP (0.000s)
[132.183560] [012/156] (944s left) gem_mmap_gtt (fault-concurrent-x)
[132.226910] Subtest fault-concurrent-X: SKIP (0.000s)
[132.273757] [013/156] (944s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[132.324100] Starting subtest: etime-single-wait-for-submit-unsubmitted
[132.442482] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[132.508345] [014/156] (943s left) prime_self_import (export-vs-gem_close-race)
[132.537365] Starting subtest: export-vs-gem_close-race
[137.639111] Subtest export-vs-gem_close-race: SUCCESS (5.096s)
[137.705669] [015/156] (938s left) kms_getfb (getfb-handle-protection)
[137.813062] Starting subtest: getfb-handle-protection
[137.835029] Subtest getfb-handle-protection: SUCCESS (0.022s)
[137.955198] [016/156] (938s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[138.048441] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[138.050339] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[138.142698] [017/156] (938s left) vgem_basic (dmabuf-mmap)
[138.186403] Starting subtest: dmabuf-mmap
[138.194415] Subtest dmabuf-mmap: SUCCESS (0.009s)
[138.239893] [018/156] (938s left) core_sysfs (read-all-entries)
[138.285971] Starting subtest: read-all-entries
[138.297175] Subtest read-all-entries: SUCCESS (0.011s)
[138.366542] [019/156] (938s left) kms_properties (connector-properties-atomic)
[138.456998] Starting subtest: connector-properties-atomic
[138.457937] Starting dynamic subtest: pipe-A-eDP-1
[146.530209] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.071s)
[146.538276] Starting dynamic subtest: pipe-None-DP-1
[146.540138] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[146.547125] Starting dynamic subtest: pipe-None-HDMI-A-1
[146.548858] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[146.555653] Starting dynamic subtest: pipe-None-DP-2
[146.557624] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[146.564223] Starting dynamic subtest: pipe-None-HDMI-A-2
[146.565961] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[146.572947] Starting dynamic subtest: pipe-None-DP-3
[146.574799] Dynamic subtest pipe-None-DP-3: SUCCESS (0.002s)
[146.581585] Starting dynamic subtest: pipe-None-DP-4
[146.583363] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s)
[146.584334] Subtest connector-properties-atomic: SUCCESS (8.082s)
[147.409245] [020/156] (929s left) syncobj_timeline (invalid-query-one-illegal-handle)
[147.454189] Starting subtest: invalid-query-one-illegal-handle
[147.455381] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[147.554922] [021/156] (929s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[147.637408] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[147.639166] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[147.721741] [022/156] (928s left) gem_tiled_swapping (non-threaded)
[147.771987] Subtest non-threaded: SKIP (0.000s)
[147.836136] [023/156] (928s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[147.926951] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[151.691221] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.767s)
[152.822118] [024/156] (923s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[152.907954] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[152.910110] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[153.003323] [025/156] (923s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc)
[153.092625] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc
[153.094883] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[153.198179] [026/156] (923s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[153.298712] Starting subtest: 4-tiled-16bpp-rotate-270
[153.318081] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[153.449765] [027/156] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[153.542352] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[153.544084] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[153.644551] [028/156] (923s left) kms_psr (fbc-psr2-sprite-render)
[153.745358] Starting subtest: fbc-psr2-sprite-render
[153.746251] Starting dynamic subtest: eDP-1
[153.748041] Dynamic subtest eDP-1: SKIP (0.000s)
[153.749657] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[153.823393] [029/156] (923s left) i915_pm_freq_api (freq-reset)
[153.885986] Starting subtest: freq-reset
[153.886924] Starting dynamic subtest: gt0
[154.070247] Dynamic subtest gt0: SUCCESS (0.184s)
[154.078946] Starting dynamic subtest: gt1
[154.232347] Dynamic subtest gt1: SUCCESS (0.153s)
[154.234032] Subtest freq-reset: SUCCESS (0.338s)
[154.297575] [030/156] (922s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[154.399485] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[154.401238] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[154.492031] [031/156] (922s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[154.590410] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[154.592376] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[154.658274] [032/156] (922s left) kms_flip (dpms-off-confusion-interruptible)
[154.760335] Starting subtest: dpms-off-confusion-interruptible
[154.762600] Starting dynamic subtest: A-eDP1
[163.446059] Dynamic subtest A-eDP1: SUCCESS (8.657s)
[163.453465] Starting dynamic subtest: B-eDP1
[172.084275] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[172.093955] Starting dynamic subtest: C-eDP1
[180.730528] Dynamic subtest C-eDP1: SUCCESS (8.632s)
[180.740980] Starting dynamic subtest: D-eDP1
[189.357024] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[189.358085] Subtest dpms-off-confusion-interruptible: SUCCESS (34.560s)
[190.487777] [033/156] (886s left) sysfs_timeslice_duration (invalid)
[190.540466] Starting subtest: invalid
[190.541591] Starting dynamic subtest: vecs0
[190.542729] Dynamic subtest vecs0: SUCCESS (0.000s)
[190.550959] Starting dynamic subtest: ccs0
[190.551893] Dynamic subtest ccs0: SUCCESS (0.000s)
[190.559488] Starting dynamic subtest: vcs0
[190.560400] Dynamic subtest vcs0: SUCCESS (0.000s)
[190.567638] Starting dynamic subtest: bcs0
[190.568527] Dynamic subtest bcs0: SUCCESS (0.000s)
[190.575610] Starting dynamic subtest: rcs0
[190.576713] Dynamic subtest rcs0: SUCCESS (0.000s)
[190.584026] Starting dynamic subtest: vcs1
[190.585077] Dynamic subtest vcs1: SUCCESS (0.000s)
[190.585962] Subtest invalid: SUCCESS (0.003s)
[190.653407] [034/156] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[190.753291] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[190.754756] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[190.846946] [035/156] (886s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[190.888459] Starting subtest: multi-wait-for-submit-unsubmitted
[190.991722] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[191.075889] [036/156] (886s left) gem_exec_whisper (basic-contexts)
[191.140275] Starting subtest: basic-contexts
[197.824975] Subtest basic-contexts: SUCCESS (6.683s)
[198.004265] [037/156] (879s left) api_intel_bb (intel-bb-blit-x)
[198.046089] Starting subtest: intel-bb-blit-x
[201.640700] Subtest intel-bb-blit-x: SUCCESS (3.586s)
[201.731841] [038/156] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[201.824802] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[201.826596] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[201.919118] [039/156] (875s left) gem_ringfill (legacy-basic)
[207.335009] Starting subtest: legacy-basic
[207.336223] Starting dynamic subtest: default
[207.374988] Dynamic subtest default: SUCCESS (0.048s)
[207.386166] Starting dynamic subtest: render
[207.416870] Dynamic subtest render: SUCCESS (0.041s)
[207.426056] Starting dynamic subtest: bsd
[207.461345] Dynamic subtest bsd: SUCCESS (0.042s)
[207.472408] Starting dynamic subtest: bsd1
[207.506579] Dynamic subtest bsd1: SUCCESS (0.043s)
[207.516057] Starting dynamic subtest: bsd2
[207.545998] Dynamic subtest bsd2: SUCCESS (0.039s)
[207.555945] Starting dynamic subtest: blt
[207.591025] Dynamic subtest blt: SUCCESS (0.043s)
[207.601075] Starting dynamic subtest: vebox
[207.635632] Dynamic subtest vebox: SUCCESS (0.042s)
[207.637020] Subtest legacy-basic: SUCCESS (0.310s)
[207.708893] [040/156] (869s left) kms_flip (blocking-absolute-wf_vblank)
[207.797249] Starting subtest: blocking-absolute-wf_vblank
[207.798216] Starting dynamic subtest: A-eDP1
[216.579468] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[216.589050] Starting dynamic subtest: B-eDP1
[225.307668] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[225.318275] Starting dynamic subtest: C-eDP1
[234.040451] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[234.051182] Starting dynamic subtest: D-eDP1
[242.770276] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[242.771524] Subtest blocking-absolute-wf_vblank: SUCCESS (34.939s)
[243.944457] [041/156] (833s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[244.038185] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[244.039868] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[244.148562] [042/156] (833s left) sw_sync (sync_multi_consumer)
[244.178348] Starting subtest: sync_multi_consumer
[244.588279] Subtest sync_multi_consumer: SUCCESS (0.402s)
[244.648262] [043/156] (832s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[244.736221] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[244.737518] Starting dynamic subtest: pipe-A
[244.757221] Dynamic subtest pipe-A: SKIP (0.019s)
[244.765119] Starting dynamic subtest: pipe-B
[244.788565] Dynamic subtest pipe-B: SKIP (0.032s)
[244.796057] Starting dynamic subtest: pipe-C
[244.821059] Dynamic subtest pipe-C: SKIP (0.032s)
[244.828660] Starting dynamic subtest: pipe-D
[244.853335] Dynamic subtest pipe-D: SKIP (0.032s)
[244.855080] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.117s)
[244.939609] [044/156] (832s left) kms_color (ctm-negative)
[245.029265] Starting subtest: ctm-negative
[245.030241] Starting dynamic subtest: pipe-A-eDP-1
[245.740711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[245.749237] Starting dynamic subtest: pipe-B-eDP-1
[247.156342] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s)
[247.164709] Starting dynamic subtest: pipe-C-eDP-1
[248.533958] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[248.541960] Starting dynamic subtest: pipe-D-eDP-1
[249.874937] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[249.875872] Subtest ctm-negative: SUCCESS (4.846s)
[250.677946] [045/156] (826s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[250.765059] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[251.855740] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.091s)
[251.983316] [046/156] (825s left) kms_invalid_mode (int-max-clock)
[252.071283] Starting subtest: int-max-clock
[252.072170] Starting dynamic subtest: pipe-A-eDP-1
[252.355931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[252.364395] Starting dynamic subtest: pipe-B-eDP-1
[252.365217] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[252.372503] Starting dynamic subtest: pipe-C-eDP-1
[252.373399] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[252.380950] Starting dynamic subtest: pipe-D-eDP-1
[252.381868] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[252.382769] Subtest int-max-clock: SUCCESS (0.290s)
[253.211397] [047/156] (824s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[253.304157] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[253.304930] Starting dynamic subtest: pipe-A-eDP-1
[253.314337] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[253.326287] Starting dynamic subtest: pipe-B-eDP-1
[253.334884] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[253.342775] Starting dynamic subtest: pipe-C-eDP-1
[253.350801] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[253.359065] Starting dynamic subtest: pipe-D-eDP-1
[253.368021] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[253.369713] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[255.567502] [048/156] (821s left) syncobj_timeline (reset-during-wait-for-submit)
[255.623618] Starting subtest: reset-during-wait-for-submit
[255.727838] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[255.809978] [049/156] (821s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[255.911031] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[255.911840] Starting dynamic subtest: pipe-A
[257.106999] Dynamic subtest pipe-A: SUCCESS (1.196s)
[257.121757] Starting dynamic subtest: pipe-B
[259.420147] Dynamic subtest pipe-B: SUCCESS (2.311s)
[259.428870] Starting dynamic subtest: pipe-C
[260.582800] Dynamic subtest pipe-C: SUCCESS (1.161s)
[260.592054] Starting dynamic subtest: pipe-D
[261.802500] Dynamic subtest pipe-D: SUCCESS (1.219s)
[261.803446] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.892s)
[262.990826] [050/156] (814s left) gem_exec_balancer (hang)
[263.262239] Starting subtest: hang
[265.330466] Subtest hang: SUCCESS (2.068s)
[265.432437] [051/156] (812s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[265.547651] Starting subtest: cursorB-vs-flipB-atomic-transitions
[265.549570] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[265.690860] [052/156] (811s left) kms_plane_lowres (tiling-4)
[265.769932] Starting subtest: tiling-4
[265.770905] Starting dynamic subtest: pipe-A-eDP-1
[265.772691] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.085611] Starting dynamic subtest: pipe-B-eDP-1
[266.087359] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.095670] Starting dynamic subtest: pipe-C-eDP-1
[266.097298] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.104938] Starting dynamic subtest: pipe-D-eDP-1
[266.106723] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.108449] Subtest tiling-4: SKIP (0.312s)
[266.958376] [053/156] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[267.055305] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[267.056970] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[267.151125] [054/156] (810s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[267.249047] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[267.251056] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[267.363884] [055/156] (810s left) gem_softpin (noreloc-interruptible)
[267.421571] Starting subtest: noreloc-interruptible
[272.863936] Subtest noreloc-interruptible: SUCCESS (5.397s)
[272.933432] [056/156] (804s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[273.020482] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[273.022164] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[273.111651] [057/156] (804s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[273.207495] Starting subtest: psr-1p-primscrn-cur-indfb-move
[280.636458] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.430s)
[280.780414] [058/156] (797s left) gem_ctx_exec (basic-close-race)
[280.837710] Starting subtest: basic-close-race
[286.822469] Subtest basic-close-race: SUCCESS (5.939s)
[286.910684] [059/156] (791s left) kms_dsc (dsc-with-bpc-formats)
[287.000223] Starting subtest: dsc-with-bpc-formats
[287.041168] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[287.072138] [060/156] (790s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[287.159920] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[287.161566] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[287.262993] [061/156] (790s left) kms_cursor_crc (cursor-onscreen-128x42)
[287.487397] Starting subtest: cursor-onscreen-128x42
[287.532614] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[287.743567] [062/156] (790s left) perf_pmu (busy-double-start)
[287.778859] Starting subtest: busy-double-start
[287.780542] Starting dynamic subtest: rcs0
[291.383213] Dynamic subtest rcs0: FAIL (3.585s)
[291.393057] Starting dynamic subtest: bcs0
[294.932709] Dynamic subtest bcs0: SUCCESS (3.565s)
[294.942402] Starting dynamic subtest: vcs0
[298.873373] Dynamic subtest vcs0: SUCCESS (3.941s)
[298.885704] Starting dynamic subtest: vcs1
[302.834251] Dynamic subtest vcs1: SUCCESS (3.959s)
[302.846079] Starting dynamic subtest: vecs0
[306.863238] Dynamic subtest vecs0: SUCCESS (4.027s)
[306.875055] Starting dynamic subtest: ccs0
[310.462881] Dynamic subtest ccs0: FAIL (3.565s)
[310.463738] Subtest busy-double-start: FAIL (22.651s)
[310.569912] [063/156] (767s left) perf_pmu (init-sema)
[310.606647] Starting subtest: init-sema
[310.607755] Starting dynamic subtest: rcs0
[310.608793] Dynamic subtest rcs0: SUCCESS (0.001s)
[310.618589] Starting dynamic subtest: bcs0
[310.619477] Dynamic subtest bcs0: SUCCESS (0.000s)
[310.627356] Starting dynamic subtest: vcs0
[310.628259] Dynamic subtest vcs0: SUCCESS (0.000s)
[310.635931] Starting dynamic subtest: vcs1
[310.636833] Dynamic subtest vcs1: SUCCESS (0.001s)
[310.644462] Starting dynamic subtest: vecs0
[310.645364] Dynamic subtest vecs0: SUCCESS (0.000s)
[310.652972] Starting dynamic subtest: ccs0
[310.654040] Dynamic subtest ccs0: SUCCESS (0.000s)
[310.654885] Subtest init-sema: SUCCESS (0.007s)
[310.729569] [064/156] (767s left) gem_watchdog (default-physical)
[310.773267] Starting subtest: default-physical
[312.547365] Subtest default-physical: SUCCESS (1.774s)
[312.630183] [065/156] (765s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[312.724903] Starting subtest: 4-tiled-64bpp-rotate-180
[314.348038] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.623s)
[314.534847] [066/156] (763s left) gem_workarounds (suspend-resume-fd)
[314.600018] Starting subtest: suspend-resume-fd
[331.604980] Subtest suspend-resume-fd: SUCCESS (2.461s)
[338.743728] [067/156] (746s left) kms_debugfs (display-on-read-all)
[338.828577] Starting subtest: display-on-read-all
[338.992554] Subtest display-on-read-all: SUCCESS (0.170s)
[339.097628] [068/156] (746s left) gem_exec_reloc (basic-write-gtt)
[339.146722] Subtest basic-write-gtt: SKIP (0.000s)
[339.211089] [069/156] (746s left) fbdev (eof)
[339.243892] Starting subtest: eof
[339.244816] Subtest eof: SUCCESS (0.000s)
[339.334099] [070/156] (745s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[340.951310] Starting subtest: modeset-lpsp-stress-no-wait
[351.148596] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.351s)
[351.220218] [071/156] (734s left) gem_eio (in-flight-1us)
[351.434419] Starting subtest: in-flight-1us
[359.650230] Subtest in-flight-1us: SUCCESS (8.254s)
[359.817832] [072/156] (725s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[359.906297] Starting subtest: x-tiled-8bpp-rotate-270
[359.928241] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[360.037385] [073/156] (725s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[360.123370] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[360.125154] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[360.237792] [074/156] (725s left) kms_vblank (wait-busy-hang)
[360.319039] Starting subtest: wait-busy-hang
[360.320225] Starting dynamic subtest: pipe-A-eDP-1
[362.203158] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s)
[362.216583] Starting dynamic subtest: pipe-D-eDP-1
[364.833835] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.632s)
[364.835051] Subtest wait-busy-hang: SUCCESS (4.523s)
[365.636178] [075/156] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[365.728164] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[372.340705] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.619s)
[372.469915] [076/156] (713s left) kms_addfb_basic (addfb25-bad-modifier)
[372.567021] Starting subtest: addfb25-bad-modifier
[372.567942] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[372.657767] [077/156] (712s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[372.745712] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[372.747708] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[372.829305] [078/156] (712s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[372.924038] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[380.345091] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.425s)
[380.488398] [079/156] (705s left) prime_vgem (fence-write-hang)
[380.552257] Subtest fence-write-hang: SKIP (0.000s)
[380.654187] [080/156] (705s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[380.753367] Starting subtest: y-tiled-64bpp-rotate-90
[380.755327] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[380.846248] [081/156] (704s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[380.941014] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[380.942567] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[381.009093] [082/156] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[381.107906] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[381.109503] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[381.221399] [083/156] (704s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[381.318414] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[381.320446] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[381.415737] [084/156] (704s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[381.510935] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[381.512762] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[381.588726] [085/156] (704s left) sriov_basic (enable-vfs-autoprobe-off)
[381.632195] Starting subtest: enable-vfs-autoprobe-off
[381.633028] Starting dynamic subtest: numvfs-1
[381.634600] Dynamic subtest numvfs-1: SKIP (0.001s)
[381.646520] Starting dynamic subtest: numvfs-2
[381.648345] Dynamic subtest numvfs-2: SKIP (0.001s)
[381.657567] Starting dynamic subtest: numvfs-3
[381.659232] Dynamic subtest numvfs-3: SKIP (0.001s)
[381.668869] Starting dynamic subtest: numvfs-4
[381.670754] Dynamic subtest numvfs-4: SKIP (0.001s)
[381.679785] Starting dynamic subtest: numvfs-5
[381.681534] Dynamic subtest numvfs-5: SKIP (0.001s)
[381.690580] Starting dynamic subtest: numvfs-6
[381.692281] Dynamic subtest numvfs-6: SKIP (0.001s)
[381.701246] Starting dynamic subtest: numvfs-7
[381.703154] Dynamic subtest numvfs-7: SKIP (0.001s)
[381.711795] Starting dynamic subtest: numvfs-random
[381.713466] Dynamic subtest numvfs-random: SKIP (0.001s)
[381.722109] Starting dynamic subtest: numvfs-all
[381.723839] Dynamic subtest numvfs-all: SKIP (0.001s)
[381.725542] Subtest enable-vfs-autoprobe-off: SKIP (0.012s)
[381.757260] [086/156] (704s left) kms_chamelium_color (degamma)
[381.837828] Subtest degamma: SKIP (0.000s)
[381.880228] [087/156] (704s left) kms_plane (planar-pixel-format-settings)
[381.978386] Starting subtest: planar-pixel-format-settings
[382.046140] Subtest planar-pixel-format-settings: SUCCESS (0.068s)
[382.162020] [088/156] (703s left) gem_lmem_swapping (parallel-multi)
[382.196589] Subtest parallel-multi: SKIP (0.000s)
[382.245090] [089/156] (703s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[382.328464] Starting subtest: psrhdr-farfromfence-mmap-gtt
[382.330151] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[382.420357] [090/156] (703s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[382.527101] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[382.528987] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[382.639986] [091/156] (703s left) gen7_exec_parse (load-register-reg)
[382.689540] Subtest load-register-reg: SKIP (0.000s)
[382.742835] [092/156] (703s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[382.830860] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[382.831708] Starting dynamic subtest: pipe-A-eDP-1
[416.851996] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.700s)
[416.862794] Starting dynamic subtest: pipe-B-eDP-1
[451.774289] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.492s)
[451.785076] Starting dynamic subtest: pipe-C-eDP-1
[486.764719] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.568s)
[486.776587] Starting dynamic subtest: pipe-D-eDP-1
[521.756208] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.454s)
[521.757095] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.220s)
[528.041514] [093/156] (563s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[528.132763] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[528.134561] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[528.235795] [094/156] (562s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[528.609890] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[529.435760] [095/156] (561s left) gem_ctx_persistence (idempotent)
[529.481959] Starting subtest: idempotent
[529.482880] Subtest idempotent: SUCCESS (0.000s)
[529.576777] [096/156] (561s left) prime_mmap (test_userptr)
[529.623451] Starting subtest: test_userptr
[529.624590] Starting dynamic subtest: test_userptr-smem
[529.625628] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[529.626619] Subtest test_userptr: SUCCESS (0.001s)
[529.714620] [097/156] (561s left) gem_exec_schedule (reorder-wide)
[529.874520] Subtest reorder-wide: SKIP (0.000s)
[530.062686] [098/156] (561s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[530.157987] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[533.703215] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.620s)
[534.883220] [099/156] (556s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[534.980812] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[534.982764] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[535.087018] [100/156] (556s left) gem_eio (context-create)
[535.291924] Starting subtest: context-create
[535.601557] Subtest context-create: SUCCESS (0.313s)
[535.749996] [101/156] (555s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[535.848762] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[535.850596] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[535.942325] [102/156] (555s left) gem_ctx_param (set-priority-invalid-size)
[535.991431] Starting subtest: set-priority-invalid-size
[535.992362] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[536.052765] [103/156] (555s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[536.143182] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[542.701913] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.614s)
[544.129446] [104/156] (547s left) gem_exec_fence (submit67)
[544.311316] Starting subtest: submit67
[544.313679] Subtest submit67: SKIP (0.000s)
[545.636252] [105/156] (545s left) kms_pm_dc (dc5-psr)
[546.739189] Starting subtest: dc5-psr
[549.621653] Subtest dc5-psr: SUCCESS (2.890s)
[550.425094] [106/156] (541s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[550.517938] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[550.519702] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[550.617743] [107/156] (541s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[550.708721] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[550.710376] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[550.805067] [108/156] (540s left) gem_softpin (evict-prime)
[550.859264] Starting subtest: evict-prime
[550.860550] Starting dynamic subtest: rcs0
[552.027638] Dynamic subtest rcs0: SUCCESS (1.170s)
[552.043196] Starting dynamic subtest: bcs0
[553.148096] Dynamic subtest bcs0: SUCCESS (1.119s)
[553.161554] Starting dynamic subtest: vcs0
[554.607586] Dynamic subtest vcs0: SUCCESS (1.451s)
[554.619084] Starting dynamic subtest: vcs1
[556.587705] Dynamic subtest vcs1: SUCCESS (1.980s)
[556.599406] Starting dynamic subtest: vecs0
[558.566777] Dynamic subtest vecs0: SUCCESS (1.979s)
[558.580940] Starting dynamic subtest: ccs0
[559.689229] Dynamic subtest ccs0: SUCCESS (1.130s)
[559.701355] Starting dynamic subtest: all
[561.576737] Dynamic subtest all: SUCCESS (1.875s)
[561.578291] Subtest evict-prime: SUCCESS (10.721s)
[561.646972] [109/156] (530s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[561.746961] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[561.748756] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[561.854953] [110/156] (529s left) i915_pm_rpm (sysfs-read)
[563.676069] Starting subtest: sysfs-read
[564.832681] Subtest sysfs-read: SUCCESS (1.157s)
[565.230260] [111/156] (526s left) i915_query (query-topology-kernel-writes)
[565.285120] Starting subtest: query-topology-kernel-writes
[565.285935] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[565.399678] [112/156] (526s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[565.496734] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[565.498517] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[565.601286] [113/156] (526s left) kms_psr (pr-sprite-blt)
[565.692280] Starting subtest: pr-sprite-blt
[565.693890] Subtest pr-sprite-blt: SKIP (0.000s)
[565.761554] [114/156] (526s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[565.816250] Starting subtest: single-wait-all-for-submit-available-submitted
[565.817632] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[565.917853] [115/156] (526s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[566.000353] Starting subtest: psr2-plane-move-sf-dmg-area
[566.001243] Starting dynamic subtest: pipe-A-eDP-1
[570.589791] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.586s)
[570.600944] Starting dynamic subtest: pipe-B-eDP-1
[575.933807] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.341s)
[575.934945] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.930s)
[576.808841] [116/156] (515s left) gem_ctx_isolation (clean)
[576.862287] Starting subtest: clean
[576.863239] Starting dynamic subtest: rcs0
[576.908813] Dynamic subtest rcs0: SUCCESS (0.046s)
[576.918644] Starting dynamic subtest: bcs0
[576.986338] Dynamic subtest bcs0: SUCCESS (0.077s)
[576.999183] Starting dynamic subtest: vcs0
[577.062116] Dynamic subtest vcs0: SUCCESS (0.075s)
[577.074456] Starting dynamic subtest: vcs1
[578.587600] Dynamic subtest vcs1: SUCCESS (1.525s)
[578.598759] Starting dynamic subtest: vecs0
[580.604432] Dynamic subtest vecs0: SUCCESS (2.015s)
[580.614400] Starting dynamic subtest: ccs0
[582.566361] Dynamic subtest ccs0: SUCCESS (1.962s)
[582.567536] Subtest clean: SUCCESS (5.705s)
[582.796002] [117/156] (509s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[582.885908] Starting subtest: fbc-rgb565-draw-pwrite
[587.586535] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.702s)
[588.793018] [118/156] (503s left) kms_content_protection (uevent-hdcp14)
[588.927299] Starting subtest: uevent-hdcp14
[588.929089] Subtest uevent-hdcp14: SKIP (0.000s)
[589.030479] [119/156] (503s left) i915_drm_fdinfo (virtual-busy-hang-all)
[589.063699] Starting subtest: virtual-busy-hang-all
[589.065318] Subtest virtual-busy-hang-all: SKIP (0.000s)
[589.125205] [120/156] (503s left) i915_query (query-regions-sanity-check)
[589.167372] Starting subtest: query-regions-sanity-check
[589.176193] Subtest query-regions-sanity-check: SUCCESS (0.011s)
[589.299470] [121/156] (502s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[589.346478] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[589.348439] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[589.528416] [122/156] (502s left) gem_exec_params (rsvd2-dirt)
[589.581318] Starting subtest: rsvd2-dirt
[589.583397] Subtest rsvd2-dirt: SKIP (0.000s)
[589.709911] [123/156] (502s left) kms_flip (2x-flip-vs-panning)
[589.791392] Starting subtest: 2x-flip-vs-panning
[589.802662] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[589.880666] [124/156] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[589.979165] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[589.980774] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[590.059029] [125/156] (502s left) gem_mmap_offset (isolation)
[590.110217] Starting subtest: isolation
[590.117580] Subtest isolation: SUCCESS (0.006s)
[590.218635] [126/156] (502s left) syncobj_wait (wait-all-snapshot)
[590.263712] Starting subtest: wait-all-snapshot
[590.345378] Subtest wait-all-snapshot: SUCCESS (0.082s)
[590.430707] [127/156] (502s left) gem_exec_schedule (preempt-hang)
[590.604915] Starting subtest: preempt-hang
[590.606546] Starting dynamic subtest: rcs0
[590.842441] Dynamic subtest rcs0: SUCCESS (0.240s)
[590.854485] Starting dynamic subtest: bcs0
[591.075912] Dynamic subtest bcs0: SUCCESS (0.232s)
[591.086606] Starting dynamic subtest: vcs0
[591.306049] Dynamic subtest vcs0: SUCCESS (0.229s)
[591.317472] Starting dynamic subtest: vcs1
[591.535154] Dynamic subtest vcs1: SUCCESS (0.228s)
[591.547474] Starting dynamic subtest: vecs0
[591.772629] Dynamic subtest vecs0: SUCCESS (0.236s)
[591.782532] Starting dynamic subtest: ccs0
[592.003844] Dynamic subtest ccs0: SUCCESS (0.229s)
[592.005113] Subtest preempt-hang: SUCCESS (1.403s)
[592.715839] [128/156] (499s left) gem_exec_fence (syncobj-unused-fence)
[593.188896] Starting subtest: syncobj-unused-fence
[593.198104] Subtest syncobj-unused-fence: SUCCESS (0.010s)
[594.672517] [129/156] (497s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[594.775613] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[594.777281] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[594.872638] [130/156] (497s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[595.104836] Starting subtest: cursor-rapid-movement-128x42
[595.148011] Subtest cursor-rapid-movement-128x42: SKIP (0.042s)
[595.377065] [131/156] (497s left) kms_getfb (getfb-handle-valid)
[595.461140] Starting subtest: getfb-handle-valid
[595.462006] Subtest getfb-handle-valid: SUCCESS (0.000s)
[595.557100] [132/156] (497s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[595.652524] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[595.654172] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[595.742174] [133/156] (496s left) prime_vgem (coherency-gtt)
[595.793299] Starting subtest: coherency-gtt
[595.794980] Subtest coherency-gtt: SKIP (0.000s)
[595.876340] [134/156] (496s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[595.964576] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[595.966309] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[596.056085] [135/156] (496s left) gem_eio (in-flight-internal-10ms)
[596.283624] Starting subtest: in-flight-internal-10ms
[597.670907] Subtest in-flight-internal-10ms: SUCCESS (1.387s)
[597.789198] [136/156] (494s left) kms_addfb_basic (addfb25-modifier-no-flag)
[597.885380] Starting subtest: addfb25-modifier-no-flag
[597.886304] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[597.987834] [137/156] (494s left) kms_rotation_crc (multiplane-rotation)
[598.077290] Starting subtest: multiplane-rotation
[615.579612] Subtest multiplane-rotation: SUCCESS (17.504s)
[615.703646] [138/156] (477s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[615.833779] Starting subtest: short-flip-before-cursor-atomic-transitions
[616.793101] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.961s)
[617.617569] [139/156] (475s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[617.708345] Starting subtest: primary-y-tiled-reflect-x-180
[617.767849] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[617.869027] [140/156] (475s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[617.966180] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[617.967127] Starting dynamic subtest: pipe-A-eDP-1
[618.241458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.263s)
[618.251810] Starting dynamic subtest: pipe-B-eDP-1
[619.496978] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s)
[619.507133] Starting dynamic subtest: pipe-C-eDP-1
[620.716185] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[620.726084] Starting dynamic subtest: pipe-D-eDP-1
[621.965989] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[621.966995] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.989s)
[623.189919] [141/156] (469s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[623.289178] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[624.116129] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[624.262062] [142/156] (468s left) syncobj_wait (single-wait-all-for-submit-signaled)
[624.322000] Starting subtest: single-wait-all-for-submit-signaled
[624.322960] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[624.420219] [143/156] (468s left) kms_addfb_basic (basic-x-tiled-legacy)
[624.474794] Starting subtest: basic-x-tiled-legacy
[624.476639] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[624.610528] [144/156] (468s left) gem_exec_fence (basic-busy-all)
[624.666324] Starting subtest: basic-busy-all
[624.752217] Subtest basic-busy-all: SUCCESS (0.085s)
[626.680772] [145/156] (466s left) kms_flip (2x-modeset-vs-vblank-race)
[626.767125] Starting subtest: 2x-modeset-vs-vblank-race
[626.781324] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[626.856851] [146/156] (466s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[626.951275] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[626.953258] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[627.020716] [147/156] (466s left) kms_psr (psr-cursor-blt)
[627.100459] Starting subtest: psr-cursor-blt
[627.101404] Starting dynamic subtest: eDP-1
[628.793499] Dynamic subtest eDP-1: SUCCESS (1.692s)
[628.794710] Subtest psr-cursor-blt: SUCCESS (1.693s)
[629.665390] [148/156] (463s left) syncobj_timeline (device-submit-unordered)
[629.708692] Starting subtest: device-submit-unordered
[629.709589] Subtest device-submit-unordered: SUCCESS (0.001s)
[629.804894] [149/156] (463s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[629.896485] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[636.690788] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.796s)
[636.810259] [150/156] (456s left) kms_cursor_crc (cursor-sliding-512x170)
[637.111147] Starting subtest: cursor-sliding-512x170
[637.112656] Subtest cursor-sliding-512x170: SKIP (0.001s)
[637.257419] [151/156] (456s left) kms_atomic_transition (plane-all-modeset-transition)
[637.336360] Starting subtest: plane-all-modeset-transition
[637.338206] Subtest plane-all-modeset-transition: SKIP (0.000s)
[637.421325] [152/156] (455s left) gem_exec_reloc (basic-wc-gtt)
[637.477479] Subtest basic-wc-gtt: SKIP (0.000s)
[637.546204] [153/156] (455s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[637.627629] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[637.628520] Starting dynamic subtest: pipe-A-eDP-1
[637.728995] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[637.743779] Starting dynamic subtest: pipe-B-eDP-1
[638.888391] Dynamic subtest pipe-B-eDP-1: SKIP (1.158s)
[638.890448] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.261s)
[640.180379] [154/156] (453s left) kms_lease (invalid-create-leases)
[640.287320] Starting subtest: invalid-create-leases
[640.292500] Subtest invalid-create-leases: SUCCESS (0.006s)
[640.421897] [155/156] (453s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[640.513207] Starting subtest: fbchdr-rgb565-draw-blt
[640.514852] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[640.625826] [156/156] (452s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[640.723158] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[640.724831] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[641.809706] Closing watchdogs
results: parsing output: 0/ for test: kms_universal_plane
results: parsing output: 1/ for test: gem_ppgtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: gem_close_race
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: core_sysfs
results: parsing output: 18/ for test: kms_properties
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_tiled_swapping
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: i915_pm_freq_api
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: sysfs_timeslice_duration
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ringfill
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: sw_sync
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_invalid_mode
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_plane_lowres
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_ctx_exec
results: parsing output: 58/ for test: kms_dsc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: gem_watchdog
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_workarounds
results: parsing output: 66/ for test: kms_debugfs
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: fbdev
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: prime_vgem
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: sriov_basic
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gen7_exec_parse
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: prime_mmap
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_pm_dc
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_pm_rpm
results: parsing output: 110/ for test: i915_query
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: gem_ctx_isolation
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: i915_drm_fdinfo
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_offset
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_getfb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: prime_vgem
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_eio
results: parsing output: 135/ for test: kms_addfb_basic
results: parsing output: 136/ for test: kms_rotation_crc
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: kms_rotation_crc
results: parsing output: 139/ for test: kms_ccs
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: syncobj_wait
results: parsing output: 142/ for test: kms_addfb_basic
results: parsing output: 143/ for test: gem_exec_fence
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: kms_plane
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: syncobj_timeline
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: kms_atomic_transition
results: parsing output: 151/ for test: gem_exec_reloc
results: parsing output: 152/ for test: kms_psr2_sf
results: parsing output: 153/ for test: kms_lease
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_ccs
Done.