[148.762516] Initializing watchdogs
[148.762558]   /dev/watchdog0
[148.780340] [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]
[148.784784] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[148.787306] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[148.790765] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[148.916091] Starting subtest: x-tiled-8bpp-rotate-270
[148.950308] Subtest x-tiled-8bpp-rotate-270: SKIP (0.034s)
[149.080433] [002/133] (960s left) kms_prop_blob (basic)
[149.139855] Starting subtest: basic
[149.141820] Subtest basic: SUCCESS (0.000s)
[149.225231] [003/133] (960s left) gen9_exec_parse (bb-large)
[149.285085] Subtest bb-large: SKIP (0.000s)
[149.354985] [004/133] (960s left) prime_vgem (fence-read-hang)
[149.459126] Subtest fence-read-hang: SKIP (0.000s)
[149.560469] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[149.563763] [005/133] (959s left) gem_userptr_blits (readonly-unsync)
[149.644022] Subtest readonly-unsync: SKIP (0.000s)
[149.772959] [006/133] (959s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[149.860720] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[149.862586] Starting dynamic subtest: pipe-A
[151.056360] Dynamic subtest pipe-A: SUCCESS (1.196s)
[151.062751] Starting dynamic subtest: pipe-B
[153.320091] Dynamic subtest pipe-B: SUCCESS (2.263s)
[153.326706] Starting dynamic subtest: pipe-C
[154.466479] Dynamic subtest pipe-C: SUCCESS (1.144s)
[154.475558] Starting dynamic subtest: pipe-D
[155.707329] Dynamic subtest pipe-D: SUCCESS (1.240s)
[155.709790] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.846s)
[156.904436] [007/133] (952s left) kms_psr (fbc-pr-sprite-blt)
[156.990893] Starting subtest: fbc-pr-sprite-blt
[156.995426] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[157.065218] [008/133] (952s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[157.172209] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[157.174473] Starting dynamic subtest: pipe-A-eDP-1
[157.246049] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[157.253432] Starting dynamic subtest: pipe-B-eDP-1
[158.382173] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[158.386569] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.213s)
[159.561084] [009/133] (950s left) kms_flip (2x-plain-flip-ts-check)
[159.653624] Starting subtest: 2x-plain-flip-ts-check
[159.662401] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[159.738908] [010/133] (949s left) gem_spin_batch (engines)
[159.820140] Starting subtest: engines
[159.822576] Starting dynamic subtest: rcs0
[163.057491] Dynamic subtest rcs0: SUCCESS (3.232s)
[163.066558] Starting dynamic subtest: bcs0
[166.290835] Dynamic subtest bcs0: SUCCESS (3.232s)
[166.300334] Starting dynamic subtest: vcs0
[169.529117] Dynamic subtest vcs0: SUCCESS (3.237s)
[169.538370] Starting dynamic subtest: vcs1
[172.763873] Dynamic subtest vcs1: SUCCESS (3.233s)
[172.772999] Starting dynamic subtest: vecs0
[175.999247] Dynamic subtest vecs0: SUCCESS (3.235s)
[176.007270] Starting dynamic subtest: ccs0
[179.236186] Dynamic subtest ccs0: SUCCESS (3.235s)
[179.238724] Subtest engines: SUCCESS (19.411s)
[179.452427] [011/133] (930s left) syncobj_timeline (wait-zero-handles)
[179.509799] Starting subtest: wait-zero-handles
[179.512175] Subtest wait-zero-handles: SUCCESS (0.000s)
[179.602093] [012/133] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[179.699250] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[183.276047] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.580s)
[184.474378] [013/133] (925s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[184.583164] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[185.584542] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.002s)
[185.704638] [014/133] (924s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[185.795514] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[192.665970] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.872s)
[192.818343] [015/133] (917s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[192.878190] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[192.880593] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[192.978645] [016/133] (916s left) kms_big_fb (linear-16bpp-rotate-90)
[193.096891] Starting subtest: linear-16bpp-rotate-90
[193.115610] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[193.229773] [017/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[193.336975] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[200.955191] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.622s)
[201.069142] [018/133] (908s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[201.158284] Starting subtest: yf-tiled-64bpp-rotate-270
[201.162491] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[201.265850] [019/133] (908s left) perf (stress-open-close)
[201.400648] Starting subtest: stress-open-close
[201.402522] Starting dynamic subtest: 0-rcs0
[203.563605] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[203.572997] Starting dynamic subtest: 1-vecs0
[205.733321] Dynamic subtest 1-vecs0: SUCCESS (2.169s)
[205.735525] Subtest stress-open-close: SUCCESS (4.336s)
[205.770969] [020/133] (904s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[205.865639] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[205.869385] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[205.973254] [021/133] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[206.076092] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[206.079730] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[206.170611] [022/133] (903s left) kms_psr (psr2-cursor-mmap-gtt)
[206.265266] Starting subtest: psr2-cursor-mmap-gtt
[206.267309] Starting dynamic subtest: eDP-1
[207.938880] Dynamic subtest eDP-1: SUCCESS (1.673s)
[207.941222] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.674s)
[208.828224] [023/133] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[208.918417] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[208.922303] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[209.001853] [024/133] (901s left) kms_addfb_basic (bo-too-small)
[209.092600] Starting subtest: bo-too-small
[209.094730] Subtest bo-too-small: SUCCESS (0.000s)
[209.196052] [025/133] (901s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[209.286686] Starting subtest: bad-aux-stride-y-tiled-ccs
[209.288986] Starting dynamic subtest: pipe-A-eDP-1
[209.311066] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[209.319459] Starting dynamic subtest: pipe-B-eDP-1
[209.339869] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.346393] Starting dynamic subtest: pipe-C-eDP-1
[209.366851] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.373407] Starting dynamic subtest: pipe-D-eDP-1
[209.394581] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.398683] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[211.577799] [026/133] (898s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[211.685088] Starting subtest: pr-primary-plane-update-sf-dmg-area
[211.689277] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[211.749169] [027/133] (898s left) gem_exec_whisper (basic-contexts-priority-all)
[211.806320] Starting subtest: basic-contexts-priority-all
[234.779557] Subtest basic-contexts-priority-all: SUCCESS (22.969s)
[234.958040] [028/133] (875s left) kms_cursor_crc (cursor-random-64x64)
[235.131661] Starting subtest: cursor-random-64x64
[235.133840] Starting dynamic subtest: pipe-A-eDP-1
[238.498496] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.363s)
[238.524066] Starting dynamic subtest: pipe-D-eDP-1
[242.458100] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.936s)
[242.460125] Subtest cursor-random-64x64: SUCCESS (7.324s)
[243.363955] [029/133] (867s left) kms_flip (2x-plain-flip-interruptible)
[243.452983] Starting subtest: 2x-plain-flip-interruptible
[243.464972] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[243.538404] [030/133] (866s left) kms_busy (extended-modeset-hang-oldfb)
[243.636061] Starting subtest: extended-modeset-hang-oldfb
[243.638394] Starting dynamic subtest: pipe-A
[255.427502] Dynamic subtest pipe-A: SUCCESS (11.791s)
[255.436389] Starting dynamic subtest: pipe-D
[267.711543] Dynamic subtest pipe-D: SUCCESS (12.280s)
[267.713868] Subtest extended-modeset-hang-oldfb: SUCCESS (24.075s)
[268.494599] [031/133] (841s left) gem_exec_flush (basic-wb-rw-default)
[268.558302] Starting subtest: basic-wb-rw-default
[274.008207] Subtest basic-wb-rw-default: SUCCESS (5.449s)
[274.194725] [032/133] (836s left) gem_exec_reloc (basic-scanout)
[274.253331] Subtest basic-scanout: SKIP (0.000s)
[274.331768] [033/133] (836s left) gem_partial_pwrite_pread (reads-uncached)
[274.397260] Subtest reads-uncached: SKIP (0.000s)
[274.473233] [034/133] (836s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[274.564902] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[274.568805] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[274.651346] [035/133] (836s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[276.170965] Starting subtest: gem-execbuf-stress-pc8
[276.207344] Subtest gem-execbuf-stress-pc8: SKIP (0.037s)
[276.935546] [036/133] (833s left) syncobj_wait (reset-during-wait-for-submit)
[276.984799] Starting subtest: reset-during-wait-for-submit
[277.089422] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[277.167481] [037/133] (833s left) syncobj_wait (invalid-signal-zero-handles)
[277.222907] Starting subtest: invalid-signal-zero-handles
[277.224776] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[277.319038] [038/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[277.408396] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[277.412584] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[277.499331] [039/133] (833s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[277.588319] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[284.276105] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.691s)
[284.408960] [040/133] (826s left) kms_feature_discovery (dp-mst)
[284.493778] Starting subtest: dp-mst
[284.498143] Subtest dp-mst: SKIP (0.000s)
[284.565049] [041/133] (826s left) syncobj_timeline (reset-unsignaled)
[284.620484] Starting subtest: reset-unsignaled
[284.622467] Subtest reset-unsignaled: SUCCESS (0.000s)
[284.717393] [042/133] (826s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[284.803901] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[284.806065] Starting dynamic subtest: pipe-A-eDP-1
[284.828471] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.838581] Starting dynamic subtest: pipe-B-eDP-1
[284.860173] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.868326] Starting dynamic subtest: pipe-C-eDP-1
[284.889357] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.897375] Starting dynamic subtest: pipe-D-eDP-1
[284.919536] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.923634] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[287.115295] [043/133] (823s left) kms_hdmi_inject (inject-4k)
[287.475574] Starting subtest: inject-4k
[287.788820] Subtest inject-4k: SUCCESS (0.314s)
[288.381489] [044/133] (822s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[288.481726] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[288.485638] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[288.550752] [045/133] (822s left) gem_mmap_gtt (fault-concurrent-y)
[288.606171] Subtest fault-concurrent-Y: SKIP (0.000s)
[288.678197] [046/133] (822s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[288.776984] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[288.781239] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[288.862616] [047/133] (822s left) gem_exec_balancer (parallel-contexts)
[289.125944] Starting subtest: parallel-contexts
[291.816584] Subtest parallel-contexts: SUCCESS (2.690s)
[292.926041] [048/133] (818s left) gem_exec_schedule (semaphore-resolve)
[293.007865] Starting subtest: semaphore-resolve
[293.073108] Subtest semaphore-resolve: SUCCESS (0.072s)
[293.420189] [049/133] (817s left) gem_ctx_engines (independent)
[293.484657] Starting subtest: independent
[293.487115] Starting dynamic subtest: rcs0
[293.702010] Dynamic subtest rcs0: SUCCESS (0.207s)
[293.712576] Starting dynamic subtest: bcs0
[293.911662] Dynamic subtest bcs0: SUCCESS (0.217s)
[293.920848] Starting dynamic subtest: vcs0
[294.129152] Dynamic subtest vcs0: SUCCESS (0.217s)
[294.139249] Starting dynamic subtest: vcs1
[294.354652] Dynamic subtest vcs1: SUCCESS (0.225s)
[294.364035] Starting dynamic subtest: vecs0
[294.578413] Dynamic subtest vecs0: SUCCESS (0.223s)
[294.587911] Starting dynamic subtest: ccs0
[294.820307] Dynamic subtest ccs0: SUCCESS (0.241s)
[294.828850] Starting dynamic subtest: all-engines
[295.744847] Dynamic subtest all-engines: SUCCESS (0.924s)
[295.747507] Subtest independent: SUCCESS (2.259s)
[296.067639] [050/133] (815s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[296.189647] Starting subtest: y-tiled-32bpp-rotate-0
[296.194138] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[296.289644] [051/133] (815s left) kms_async_flips (test-time-stamp)
[296.391084] Starting subtest: test-time-stamp
[296.766418] Starting dynamic subtest: pipe-A-eDP-1
[297.519503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.751s)
[297.890101] Starting dynamic subtest: pipe-B-eDP-1
[298.710845] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.825s)
[299.097255] Starting dynamic subtest: pipe-C-eDP-1
[299.917074] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.825s)
[300.284282] Starting dynamic subtest: pipe-D-eDP-1
[301.115055] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.836s)
[301.117521] Subtest test-time-stamp: SUCCESS (4.724s)
[302.350895] [052/133] (808s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[302.448090] Starting subtest: plane-upscale-20x20-with-modifiers
[302.450380] Starting dynamic subtest: pipe-A
[302.783800] Dynamic subtest pipe-A: SUCCESS (0.338s)
[302.792693] Starting dynamic subtest: pipe-B
[304.200597] Dynamic subtest pipe-B: SUCCESS (1.416s)
[304.209895] Starting dynamic subtest: pipe-C
[305.607827] Dynamic subtest pipe-C: SUCCESS (1.406s)
[305.615850] Starting dynamic subtest: pipe-D
[307.013910] Dynamic subtest pipe-D: SUCCESS (1.405s)
[307.016210] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.568s)
[308.163914] [053/133] (803s left) gem_mmap (bad-object)
[308.227815] Subtest bad-object: SKIP (0.000s)
[308.289637] [054/133] (803s left) gem_exec_params (no-vebox)
[308.347091] Starting subtest: no-vebox
[308.349486] Subtest no-vebox: SUCCESS (0.002s)
[309.968710] [055/133] (801s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[310.070409] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[310.072762] Starting dynamic subtest: pipe-A-eDP-1
[310.098184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[310.115933] Starting dynamic subtest: pipe-B-eDP-1
[310.140886] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[310.154237] Starting dynamic subtest: pipe-C-eDP-1
[310.178810] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[310.188471] Starting dynamic subtest: pipe-D-eDP-1
[310.212636] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[310.216722] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[312.337037] [056/133] (799s left) gem_workarounds (reset)
[312.404691] Starting subtest: reset
[312.582194] Subtest reset: SUCCESS (0.177s)
[312.705312] [057/133] (798s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[312.795090] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[312.799404] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[312.870198] [058/133] (798s left) kms_lease (page-flip-implicit-plane)
[312.968204] Starting subtest: page-flip-implicit-plane
[312.970112] Starting dynamic subtest: pipe-A-eDP-1
[313.441222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[313.451639] Starting dynamic subtest: pipe-B-eDP-1
[314.545741] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.104s)
[314.555857] Starting dynamic subtest: pipe-C-eDP-1
[315.651972] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[315.663046] Starting dynamic subtest: pipe-D-eDP-1
[316.736073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.085s)
[316.738409] Subtest page-flip-implicit-plane: SUCCESS (3.770s)
[317.546636] [059/133] (794s left) gem_exec_fence (syncobj-signal)
[318.028740] Starting subtest: syncobj-signal
[318.031095] Subtest syncobj-signal: SUCCESS (0.006s)
[319.979585] [060/133] (791s left) kms_async_flips (alternate-sync-async-flip)
[320.068485] Starting subtest: alternate-sync-async-flip
[320.452585] Starting dynamic subtest: pipe-A-eDP-1
[323.204633] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.753s)
[323.601913] Starting dynamic subtest: pipe-B-eDP-1
[326.404227] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.810s)
[326.777096] Starting dynamic subtest: pipe-C-eDP-1
[329.603347] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.833s)
[329.968761] Starting dynamic subtest: pipe-D-eDP-1
[332.792119] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.831s)
[332.794194] Subtest alternate-sync-async-flip: SUCCESS (12.726s)
[333.949055] [061/133] (777s left) gem_exec_params (invalid-ring2)
[334.001523] Starting subtest: invalid-ring2
[334.003782] Subtest invalid-ring2: SUCCESS (0.000s)
[334.117627] [062/133] (777s left) kms_plane_alpha_blend (coverage-7efc)
[334.209782] Starting subtest: coverage-7efc
[334.496854] Starting dynamic subtest: pipe-A-eDP-1
[335.066659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[335.093108] Starting dynamic subtest: pipe-D-eDP-1
[336.423749] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[336.426185] Subtest coverage-7efc: SUCCESS (2.214s)
[337.239306] [063/133] (774s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[337.342681] Starting subtest: psr-rgb101010-draw-mmap-gtt
[337.347097] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[337.455960] [064/133] (774s left) kms_flip (flip-vs-rmfb-interruptible)
[337.543205] Starting subtest: flip-vs-rmfb-interruptible
[337.545496] Starting dynamic subtest: A-eDP1
[346.202463] Dynamic subtest A-eDP1: SUCCESS (8.658s)
[346.212735] Starting dynamic subtest: B-eDP1
[354.800430] Dynamic subtest B-eDP1: SUCCESS (8.596s)
[354.811095] Starting dynamic subtest: C-eDP1
[363.407778] Dynamic subtest C-eDP1: SUCCESS (8.605s)
[363.417783] Starting dynamic subtest: D-eDP1
[371.996800] Dynamic subtest D-eDP1: SUCCESS (8.587s)
[372.001046] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.457s)
[373.136783] [065/133] (738s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[373.228377] Starting subtest: primary-4-tiled-reflect-x-0
[380.251345] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.024s)
[381.430338] [066/133] (730s left) i915_hangman (engine-error-state-capture)
[381.483234] Starting subtest: engine-error-state-capture
[381.485102] Starting dynamic subtest: rcs0
[384.883479] Dynamic subtest rcs0: SUCCESS (3.399s)
[384.896404] Starting dynamic subtest: bcs0
[390.900576] Dynamic subtest bcs0: SUCCESS (6.014s)
[390.912896] Starting dynamic subtest: vcs0
[396.852082] Dynamic subtest vcs0: SUCCESS (5.948s)
[396.864593] Starting dynamic subtest: vcs1
[401.843770] Dynamic subtest vcs1: SUCCESS (4.988s)
[401.863375] Starting dynamic subtest: vecs0
[407.795338] Dynamic subtest vecs0: SUCCESS (5.948s)
[407.807294] Starting dynamic subtest: ccs0
[413.874210] Dynamic subtest ccs0: SUCCESS (6.075s)
[413.877799] Subtest engine-error-state-capture: SUCCESS (32.391s)
[413.995799] [067/133] (697s left) kms_color (gamma)
[414.091937] Starting subtest: gamma
[414.093875] Starting dynamic subtest: pipe-A-eDP-1
[414.792924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[414.802281] Starting dynamic subtest: pipe-B-eDP-1
[416.224622] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s)
[416.234024] Starting dynamic subtest: pipe-C-eDP-1
[417.557843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.335s)
[417.567194] Starting dynamic subtest: pipe-D-eDP-1
[418.967370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.405s)
[418.969649] Subtest gamma: SUCCESS (4.875s)
[419.831528] [068/133] (692s left) template (b)
[419.882753] Starting subtest: B
[419.884813] Subtest B: SUCCESS (0.000s)
[419.980541] [069/133] (692s left) gem_ctx_isolation (nonpriv-switch)
[420.033044] Starting subtest: nonpriv-switch
[420.035322] Starting dynamic subtest: rcs0
[420.303646] Dynamic subtest rcs0: SUCCESS (0.270s)
[420.315326] Starting dynamic subtest: bcs0
[420.571471] Dynamic subtest bcs0: SUCCESS (0.267s)
[420.580641] Starting dynamic subtest: vcs0
[420.839667] Dynamic subtest vcs0: SUCCESS (0.267s)
[420.850256] Starting dynamic subtest: vcs1
[422.164270] Dynamic subtest vcs1: SUCCESS (1.323s)
[422.175264] Starting dynamic subtest: vecs0
[424.182856] Dynamic subtest vecs0: SUCCESS (2.018s)
[424.192058] Starting dynamic subtest: ccs0
[426.191827] Dynamic subtest ccs0: SUCCESS (2.008s)
[426.194228] Subtest nonpriv-switch: SUCCESS (6.159s)
[426.424940] [070/133] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[426.523336] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[426.527726] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[426.615362] [071/133] (685s left) gem_lmem_swapping (massive)
[426.653617] Subtest massive: SKIP (0.000s)
[426.702275] [072/133] (685s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[427.079245] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[427.908308] [073/133] (684s left) kms_content_protection (content-type-change)
[428.048780] Starting subtest: content-type-change
[428.053449] Subtest content-type-change: SKIP (0.000s)
[428.196428] [074/133] (684s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[428.255299] Subtest untiled-to-tiled: SKIP (0.000s)
[428.327460] [075/133] (683s left) kms_rotation_crc (primary-rotation-90)
[428.433287] Starting subtest: primary-rotation-90
[428.437193] Subtest primary-rotation-90: SKIP (0.001s)
[428.503819] [076/133] (683s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[428.619651] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[435.327777] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.715s)
[435.460795] [077/133] (676s left) kms_vblank (query-forked-hang)
[435.564219] Starting subtest: query-forked-hang
[435.566642] Starting dynamic subtest: pipe-A-eDP-1
[461.654867] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.086s)
[461.668851] Starting dynamic subtest: pipe-D-eDP-1
[486.671978] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.016s)
[486.674381] Subtest query-forked-hang: SUCCESS (51.108s)
[487.524392] [078/133] (624s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[487.608604] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[487.613040] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[487.699441] [079/133] (624s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[487.753809] Starting subtest: y-tiled-to-vebox-yf-tiled
[487.758888] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[487.938636] [080/133] (624s left) gem_ctx_shared (exec-shared-gtt)
[487.997482] Starting subtest: exec-shared-gtt
[487.999885] Starting dynamic subtest: rcs0
[488.004912] Dynamic subtest rcs0: SUCCESS (0.007s)
[488.014482] Starting dynamic subtest: bcs0
[488.016785] Dynamic subtest bcs0: SUCCESS (0.008s)
[488.025986] Starting dynamic subtest: vcs0
[488.027974] Dynamic subtest vcs0: SUCCESS (0.009s)
[488.036935] Starting dynamic subtest: vcs1
[488.039222] Dynamic subtest vcs1: SUCCESS (0.008s)
[488.047616] Starting dynamic subtest: vecs0
[488.049883] Dynamic subtest vecs0: SUCCESS (0.009s)
[488.058404] Starting dynamic subtest: ccs0
[488.060568] Dynamic subtest ccs0: SUCCESS (0.006s)
[488.062738] Subtest exec-shared-gtt: SUCCESS (0.051s)
[488.236385] [081/133] (624s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[488.334945] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[488.339074] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[488.451756] [082/133] (624s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[488.556108] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[489.224438] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[489.395719] [083/133] (623s left) gem_exec_flush (basic-wb-prw-default)
[489.469689] Starting subtest: basic-wb-prw-default
[494.944190] Subtest basic-wb-prw-default: SUCCESS (5.476s)
[495.135689] [084/133] (617s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[495.256969] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[495.261735] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[495.413185] [085/133] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[495.516216] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[495.520574] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[495.621005] [086/133] (617s left) kms_atomic_interruptible (legacy-pageflip)
[495.709956] Starting subtest: legacy-pageflip
[495.712226] Starting dynamic subtest: pipe-A-eDP-1
[503.106705] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.397s)
[503.109078] Subtest legacy-pageflip: SUCCESS (7.398s)
[503.934406] [087/133] (608s left) kms_pipe_crc_basic (bad-source)
[504.031728] Starting subtest: bad-source
[504.033878] Subtest bad-source: SUCCESS (0.000s)
[504.104883] [088/133] (608s left) kms_pm_rpm (cursor)
[506.130750] Starting subtest: cursor
[506.136331] Subtest cursor: SKIP (0.000s)
[506.524605] [089/133] (606s left) perf_pmu (init-busy)
[506.569206] Starting subtest: init-busy
[506.571443] Starting dynamic subtest: rcs0
[506.573729] Dynamic subtest rcs0: SUCCESS (0.001s)
[506.583769] Starting dynamic subtest: bcs0
[506.585697] Dynamic subtest bcs0: SUCCESS (0.000s)
[506.593793] Starting dynamic subtest: vcs0
[506.595674] Dynamic subtest vcs0: SUCCESS (0.001s)
[506.603990] Starting dynamic subtest: vcs1
[506.605945] Dynamic subtest vcs1: SUCCESS (0.001s)
[506.613942] Starting dynamic subtest: vecs0
[506.615936] Dynamic subtest vecs0: SUCCESS (0.001s)
[506.623868] Starting dynamic subtest: ccs0
[506.625777] Dynamic subtest ccs0: SUCCESS (0.000s)
[506.627664] Subtest init-busy: SUCCESS (0.007s)
[506.687804] [090/133] (606s left) kms_cursor_edge_walk (128x128-right-edge)
[506.774738] Starting subtest: 128x128-right-edge
[506.777071] Starting dynamic subtest: pipe-A-eDP-1
[510.263495] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[510.274096] Starting dynamic subtest: pipe-D-eDP-1
[513.445187] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.180s)
[513.447537] Subtest 128x128-right-edge: SUCCESS (6.671s)
[514.334937] [091/133] (598s left) gem_ctx_param (non-root-set)
[514.378756] Starting subtest: non-root-set
[514.392963] Subtest non-root-set: SUCCESS (0.014s)
[514.486153] [092/133] (598s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[514.546643] Starting subtest: etime-single-wait-for-submit-unsubmitted
[514.648391] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[514.736614] [093/133] (598s left) gem_pxp (create-protected-buffer)
[514.859805] Starting subtest: create-protected-buffer
[514.862275] Subtest create-protected-buffer: SUCCESS (0.000s)
[514.984760] [094/133] (598s left) kms_psr (fbc-pr-no-drrs)
[515.092495] Starting subtest: fbc-pr-no-drrs
[515.097026] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[515.164046] [095/133] (597s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[515.228510] Starting subtest: invalid-single-wait-all-unsubmitted
[515.230894] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[515.349610] [096/133] (597s left) kms_psr (fbc-psr-sprite-plane-onoff)
[515.449420] Starting subtest: fbc-psr-sprite-plane-onoff
[515.451345] Starting dynamic subtest: eDP-1
[515.454932] Dynamic subtest eDP-1: SKIP (0.000s)
[515.458501] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[515.540215] [097/133] (597s left) kms_addfb_basic (no-handle)
[515.587020] Starting subtest: no-handle
[515.588687] Subtest no-handle: SUCCESS (0.000s)
[515.718756] [098/133] (597s left) kms_sequence (get-idle)
[515.807074] Starting subtest: get-idle
[515.808853] Starting dynamic subtest: pipe-A-eDP-1
[517.601259] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.795s)
[517.610564] Starting dynamic subtest: pipe-B-eDP-1
[520.078837] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.474s)
[520.088707] Starting dynamic subtest: pipe-C-eDP-1
[522.532906] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.452s)
[522.542922] Starting dynamic subtest: pipe-D-eDP-1
[524.956906] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.425s)
[524.959164] Subtest get-idle: SUCCESS (9.151s)
[525.821973] [099/133] (587s left) gem_exec_schedule (preempt-hang)
[525.999038] Starting subtest: preempt-hang
[526.001940] Starting dynamic subtest: rcs0
[526.258782] Dynamic subtest rcs0: SUCCESS (0.259s)
[526.268337] Starting dynamic subtest: bcs0
[526.495721] Dynamic subtest bcs0: SUCCESS (0.232s)
[526.506853] Starting dynamic subtest: vcs0
[526.720123] Dynamic subtest vcs0: SUCCESS (0.223s)
[526.731161] Starting dynamic subtest: vcs1
[526.946464] Dynamic subtest vcs1: SUCCESS (0.225s)
[526.957319] Starting dynamic subtest: vecs0
[527.184436] Dynamic subtest vecs0: SUCCESS (0.238s)
[527.196397] Starting dynamic subtest: ccs0
[527.418375] Dynamic subtest ccs0: SUCCESS (0.232s)
[527.420612] Subtest preempt-hang: SUCCESS (1.420s)
[527.983388] [100/133] (585s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[528.369951] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[529.199756] [101/133] (584s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[529.257535] Starting subtest: multi-wait-all-for-submit-submitted
[529.360483] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[529.438766] [102/133] (583s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[529.527699] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[536.088679] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.563s)
[536.216249] [103/133] (577s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[536.278675] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[536.385343] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[536.480553] [104/133] (576s left) i915_suspend (basic-s2idle-without-i915)
[536.512405] Starting subtest: basic-s2idle-without-i915
[557.443501] Subtest basic-s2idle-without-i915: SUCCESS (5.666s)
[557.562740] [105/133] (555s left) gem_lmem_swapping (random-engines)
[557.619980] Subtest random-engines: SKIP (0.000s)
[557.665065] [106/133] (555s left) syncobj_timeline (signal-array)
[557.721149] Starting subtest: signal-array
[557.723435] Subtest signal-array: SUCCESS (0.000s)
[557.821063] [107/133] (555s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[557.917001] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[557.920902] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[558.010927] [108/133] (555s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[558.106513] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[558.110852] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[558.175332] [109/133] (555s left) gem_userptr_blits (sync-unmap)
[558.232908] Starting subtest: sync-unmap
[558.247011] Subtest sync-unmap: SUCCESS (0.016s)
[558.368112] [110/133] (555s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[558.457082] Starting subtest: blocking-absolute-wf_vblank-interruptible
[558.458829] Starting dynamic subtest: A-eDP1
[567.134202] Dynamic subtest A-eDP1: SUCCESS (8.828s)
[567.149861] Starting dynamic subtest: B-eDP1
[575.802183] Dynamic subtest B-eDP1: SUCCESS (8.715s)
[575.813603] Starting dynamic subtest: C-eDP1
[584.491705] Dynamic subtest C-eDP1: SUCCESS (8.706s)
[584.503330] Starting dynamic subtest: D-eDP1
[593.218533] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[593.220724] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.985s)
[594.440559] [111/133] (519s left) gem_exec_balancer (parallel-balancer)
[594.714980] Starting subtest: parallel-balancer
[595.585758] Subtest parallel-balancer: SUCCESS (0.871s)
[595.684013] [112/133] (518s left) gem_mmap_gtt (basic-read)
[595.733194] Subtest basic-read: SKIP (0.000s)
[595.792205] [113/133] (518s left) gem_userptr_blits (stress-mm-invalidate-close)
[595.852259] Starting subtest: stress-mm-invalidate-close
[598.001460] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[598.115872] [114/133] (515s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[598.208779] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[598.213381] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[598.397747] [115/133] (515s left) kms_dirtyfb (default-dirtyfb-ioctl)
[598.495877] Starting subtest: default-dirtyfb-ioctl
[598.497850] Starting dynamic subtest: A-eDP-1
[600.097057] Dynamic subtest A-eDP-1: SUCCESS (1.600s)
[600.099404] Subtest default-dirtyfb-ioctl: SUCCESS (1.602s)
[600.973228] [116/133] (512s left) core_getclient (basic)
[601.038489] Starting subtest: basic
[601.040535] Subtest basic: SUCCESS (0.000s)
[601.145276] [117/133] (512s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[601.238093] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[601.240430] Starting dynamic subtest: pipe-A-eDP-1
[601.261553] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[601.276090] Starting dynamic subtest: pipe-B-eDP-1
[601.295175] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[601.307888] Starting dynamic subtest: pipe-C-eDP-1
[601.326532] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[601.335706] Starting dynamic subtest: pipe-D-eDP-1
[601.355094] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[601.357299] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[603.527432] [118/133] (510s left) gem_userptr_blits (map-fixed-invalidate)
[603.600862] Starting subtest: map-fixed-invalidate
[603.605191] Subtest map-fixed-invalidate: SKIP (0.000s)
[603.737243] [119/133] (510s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[603.836745] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[603.847647] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[603.963055] [120/133] (510s left) syncobj_timeline (invalid-signal-illegal-handle)
[604.015500] Starting subtest: invalid-signal-illegal-handle
[604.017833] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[604.113198] [121/133] (510s left) kms_joiner (basic-big-joiner)
[604.216532] Starting subtest: basic-big-joiner
[604.221416] Subtest basic-big-joiner: SKIP (0.000s)
[604.302977] [122/133] (509s left) gem_tiled_pread_basic (basic)
[604.352057] Subtest basic: SKIP (0.000s)
[604.407193] [123/133] (509s left) kms_cursor_crc (cursor-offscreen-512x512)
[604.672074] Starting subtest: cursor-offscreen-512x512
[604.675509] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[604.837187] [124/133] (509s left) perf (global-sseu-config-invalid)
[604.953848] Starting subtest: global-sseu-config-invalid
[604.957679] Subtest global-sseu-config-invalid: SKIP (0.000s)
[604.995258] [125/133] (509s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[605.079353] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[612.343248] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.267s)
[612.451792] [126/133] (501s left) gem_ctx_persistence (smoketest)
[612.532145] Starting subtest: smoketest
[651.361547] Subtest smoketest: SUCCESS (38.842s)
[651.437675] [127/133] (462s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[651.536420] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[651.540514] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[651.635965] [128/133] (462s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[651.723495] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[651.725762] Starting dynamic subtest: pipe-A-eDP-1
[668.236968] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.395s)
[668.247790] Starting dynamic subtest: pipe-B-eDP-1
[685.193733] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[685.206130] Starting dynamic subtest: pipe-C-eDP-1
[702.147101] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.426s)
[702.158905] Starting dynamic subtest: pipe-D-eDP-1
[719.175147] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.370s)
[719.177352] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.654s)
[720.379432] [129/133] (394s left) gem_busy (busy)
[720.447198] Starting subtest: busy
[720.449478] Starting dynamic subtest: all-engines
[720.500454] Dynamic subtest all-engines: SUCCESS (0.055s)
[720.510379] Starting dynamic subtest: rcs0
[722.212421] Dynamic subtest rcs0: SUCCESS (1.757s)
[722.222843] Starting dynamic subtest: bcs0
[722.261212] Dynamic subtest bcs0: SUCCESS (0.047s)
[722.270824] Starting dynamic subtest: vcs0
[722.300240] Dynamic subtest vcs0: SUCCESS (0.039s)
[722.308991] Starting dynamic subtest: vcs1
[724.197551] Dynamic subtest vcs1: SUCCESS (1.934s)
[724.208159] Starting dynamic subtest: vecs0
[726.242854] Dynamic subtest vecs0: SUCCESS (2.078s)
[726.251805] Starting dynamic subtest: ccs0
[728.227823] Dynamic subtest ccs0: SUCCESS (2.008s)
[728.230032] Subtest busy: SUCCESS (7.926s)
[728.569487] [130/133] (385s left) kms_psr (pr-primary-mmap-gtt)
[728.663996] Starting subtest: pr-primary-mmap-gtt
[728.672443] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[728.730738] [131/133] (385s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[728.826322] Starting subtest: psr-shrfb-scaledprimary
[734.543382] Subtest psr-shrfb-scaledprimary: SUCCESS (5.760s)
[734.667809] [132/133] (379s left) dmabuf_sync_file (export-multiwait)
[734.710686] Starting subtest: export-multiwait
[734.712959] Subtest export-multiwait: SUCCESS (0.000s)
[734.768781] [133/133] (379s left) i915_drm_fdinfo (basics)
[734.808575] Starting subtest: basics
[734.810478] Subtest basics: SUCCESS (0.000s)
[734.906498] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_prop_blob
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: prime_vgem
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_spin_batch
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: gem_exec_whisper
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_busy
results: parsing output: 30/ for test: gem_exec_flush
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: i915_pm_rpm
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_feature_discovery
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_hdmi_inject
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gem_ctx_engines
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_mmap
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_workarounds
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: kms_plane_alpha_blend
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: i915_hangman
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: template
results: parsing output: 68/ for test: gem_ctx_isolation
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_chamelium_edid
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: gem_set_tiling_vs_blt
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_atomic_interruptible
results: parsing output: 86/ for test: kms_pipe_crc_basic
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_sequence
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: i915_suspend
results: parsing output: 104/ for test: gem_lmem_swapping
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_dirtyfb
results: parsing output: 115/ for test: core_getclient
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_joiner
results: parsing output: 121/ for test: gem_tiled_pread_basic
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_busy
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: dmabuf_sync_file
results: parsing output: 132/ for test: i915_drm_fdinfo
Done.