[59.485391] Initializing watchdogs
[59.485439]   /dev/watchdog0
[59.499112] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.503324] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.505540] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.508961] [001/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[59.624950] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[59.627381] Starting dynamic subtest: pipe-A-eDP-1
[59.686467] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[59.693695] Starting dynamic subtest: pipe-B-eDP-1
[59.750925] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[59.760061] Starting dynamic subtest: pipe-C-eDP-1
[59.818072] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[59.825823] Starting dynamic subtest: pipe-D-eDP-1
[59.883589] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[59.887850] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[61.953123] [002/133] (958s left) gem_mmap_wc (bad-size)
[62.005761] Subtest bad-size: SKIP (0.000s)
[62.063490] [003/133] (958s left) i915_query (engine-info)
[62.107885] Starting subtest: engine-info
[62.112585] Subtest engine-info: SUCCESS (0.006s)
[62.216946] [004/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[62.307989] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[62.312811] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[62.439365] [005/133] (957s left) kms_psr (fbc-psr2-primary-blt)
[62.538689] Starting subtest: fbc-psr2-primary-blt
[62.540958] Starting dynamic subtest: eDP-1
[62.545054] Dynamic subtest eDP-1: SKIP (0.000s)
[62.549034] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[62.605868] [006/133] (957s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[62.728197] Starting subtest: basic-flip-after-cursor-varying-size
[63.687120] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.958s)
[64.474372] [007/133] (955s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[64.571996] Starting subtest: plane-lut1d-post-ctm3x4
[64.717646] Starting dynamic subtest: pipe-A-plane-0
[65.054987] Dynamic subtest pipe-A-plane-0: FAIL (0.165s)
[65.062531] Starting dynamic subtest: pipe-A-plane-1
[65.278067] Dynamic subtest pipe-A-plane-1: FAIL (0.164s)
[65.286824] Starting dynamic subtest: pipe-A-plane-2
[65.517690] Dynamic subtest pipe-A-plane-2: FAIL (0.167s)
[66.473623] Starting dynamic subtest: pipe-B-plane-0
[66.932855] Dynamic subtest pipe-B-plane-0: FAIL (0.186s)
[66.939967] Starting dynamic subtest: pipe-B-plane-1
[67.273497] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[67.282568] Starting dynamic subtest: pipe-B-plane-2
[67.603977] Dynamic subtest pipe-B-plane-2: FAIL (0.189s)
[68.222427] Starting dynamic subtest: pipe-C-plane-0
[68.711669] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[68.720105] Starting dynamic subtest: pipe-C-plane-1
[69.120448] Dynamic subtest pipe-C-plane-1: FAIL (0.619s)
[69.128053] Starting dynamic subtest: pipe-C-plane-2
[69.496374] Dynamic subtest pipe-C-plane-2: FAIL (0.159s)
[70.328220] Starting dynamic subtest: pipe-D-plane-0
[70.937194] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[70.946608] Starting dynamic subtest: pipe-D-plane-1
[71.421868] Dynamic subtest pipe-D-plane-1: FAIL (0.609s)
[71.430381] Starting dynamic subtest: pipe-D-plane-2
[71.864897] Dynamic subtest pipe-D-plane-2: FAIL (0.550s)
[71.947610] Subtest plane-lut1d-post-ctm3x4: FAIL (7.377s)
[72.810576] [008/133] (947s left) gem_mmap_wc (invalid-flags)
[72.869893] Subtest invalid-flags: SKIP (0.000s)
[72.923430] [009/133] (947s left) perf_pmu (frequency)
[72.965637] Starting subtest: frequency
[72.970303] Starting dynamic subtest: gt0
[75.121887] Dynamic subtest gt0: SUCCESS (2.148s)
[75.131087] Starting dynamic subtest: idle-gt0
[75.626871] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[75.637072] Starting dynamic subtest: gt1
[79.895424] Dynamic subtest gt1: SUCCESS (4.265s)
[79.905065] Starting dynamic subtest: idle-gt1
[80.398685] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[80.401244] Subtest frequency: SUCCESS (7.434s)
[80.489542] [010/133] (939s left) kms_cursor_crc (cursor-onscreen-max-size)
[80.801804] Starting subtest: cursor-onscreen-max-size
[80.808208] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[80.926436] [011/133] (939s left) syncobj_basic (bad-flags-fd-to-handle)
[80.982896] Starting subtest: bad-flags-fd-to-handle
[80.985282] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[81.079811] [012/133] (939s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[81.173643] Starting subtest: fbc-rgb565-draw-mmap-gtt
[81.178045] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[81.272214] [013/133] (939s left) gem_ctx_param (non-root-set)
[81.330221] Starting subtest: non-root-set
[81.365636] Subtest non-root-set: SUCCESS (0.035s)
[81.447830] [014/133] (939s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[81.563016] Starting subtest: cursorA-vs-flipA-atomic
[92.691829] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.129s)
[93.534322] [015/133] (927s left) gem_exec_schedule (independent)
[93.624458] Starting subtest: independent
[93.626454] Starting dynamic subtest: rcs0
[94.933670] Dynamic subtest rcs0: SUCCESS (1.318s)
[94.943994] Starting dynamic subtest: vcs0
[96.931901] Dynamic subtest vcs0: SUCCESS (1.997s)
[96.943431] Starting dynamic subtest: vcs1
[98.913222] Dynamic subtest vcs1: SUCCESS (1.980s)
[98.925162] Starting dynamic subtest: vecs0
[100.907968] Dynamic subtest vecs0: SUCCESS (1.994s)
[100.918650] Starting dynamic subtest: ccs0
[102.932866] Dynamic subtest ccs0: SUCCESS (2.024s)
[102.935676] Subtest independent: SUCCESS (9.318s)
[103.246610] [016/133] (917s left) gem_ccs (large-ctrl-surf-copy)
[103.309930] Starting subtest: large-ctrl-surf-copy
[103.314599] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[103.421640] [017/133] (917s left) gem_madvise (dontneed-after-mmap)
[103.459311] Starting subtest: dontneed-after-mmap
[103.477691] Subtest dontneed-after-mmap: SUCCESS (0.019s)
[103.568899] [018/133] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[103.668827] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[110.355027] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.689s)
[110.499950] [019/133] (910s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[110.559809] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[110.562087] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[110.650109] [020/133] (910s left) kms_chamelium_color (ctm-red-to-blue)
[110.751353] Subtest ctm-red-to-blue: SKIP (0.000s)
[110.795021] [021/133] (909s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[110.891175] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[110.893586] Starting dynamic subtest: A-eDP1
[114.478622] Dynamic subtest A-eDP1: SUCCESS (3.587s)
[114.489671] Starting dynamic subtest: B-eDP1
[117.695864] Dynamic subtest B-eDP1: SUCCESS (3.214s)
[117.704737] Starting dynamic subtest: C-eDP1
[120.783275] Dynamic subtest C-eDP1: SUCCESS (3.087s)
[120.792462] Starting dynamic subtest: D-eDP1
[123.885802] Dynamic subtest D-eDP1: SUCCESS (3.102s)
[123.887812] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.996s)
[124.682102] [022/133] (896s left) syncobj_wait (invalid-reset-bad-pad)
[124.744096] Starting subtest: invalid-reset-bad-pad
[124.746482] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[124.835599] [023/133] (896s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[124.957029] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[124.961392] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[125.095998] [024/133] (895s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[125.180469] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[125.184560] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[125.268175] [025/133] (895s left) gem_exec_fence (syncobj-export)
[125.743577] Starting subtest: syncobj-export
[125.748452] Subtest syncobj-export: SUCCESS (0.006s)
[127.017172] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[127.020759] [026/133] (893s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[127.131709] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[128.076697] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.945s)
[128.207016] [027/133] (892s left) kms_plane_lowres (tiling-x)
[128.299134] Starting subtest: tiling-x
[128.301421] Starting dynamic subtest: pipe-A-eDP-1
[128.306043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[128.607727] Starting dynamic subtest: pipe-B-eDP-1
[128.612157] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[128.619768] Starting dynamic subtest: pipe-C-eDP-1
[128.624227] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[128.631840] Starting dynamic subtest: pipe-D-eDP-1
[128.636256] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[128.640291] Subtest tiling-x: SKIP (0.307s)
[129.415040] [028/133] (891s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[129.506332] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[129.508669] Starting dynamic subtest: pipe-A-default-mode
[132.248222] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[132.250589] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.742s)
[133.098817] [029/133] (888s left) kms_psr (psr-sprite-plane-move)
[133.200105] Starting subtest: psr-sprite-plane-move
[133.202424] Starting dynamic subtest: eDP-1
[134.936504] Dynamic subtest eDP-1: SUCCESS (1.736s)
[134.938769] Subtest psr-sprite-plane-move: SUCCESS (1.737s)
[135.754413] [030/133] (885s left) core_setmaster (master-drop-set-root)
[135.834419] Starting subtest: master-drop-set-root
[135.847047] Subtest master-drop-set-root: SUCCESS (0.012s)
[135.895108] [031/133] (885s left) syncobj_timeline (wait-any-interrupted)
[135.958094] Starting subtest: wait-any-interrupted
[136.064155] Subtest wait-any-interrupted: SUCCESS (0.106s)
[136.137902] [032/133] (885s left) prime_vgem (fence-wait)
[136.229371] Starting subtest: fence-wait
[136.231399] Starting dynamic subtest: rcs0
[137.268100] Dynamic subtest rcs0: SUCCESS (1.038s)
[137.278200] Starting dynamic subtest: bcs0
[138.320973] Dynamic subtest bcs0: SUCCESS (1.053s)
[138.333423] Starting dynamic subtest: vcs0
[139.371299] Dynamic subtest vcs0: SUCCESS (1.048s)
[139.381067] Starting dynamic subtest: vcs1
[140.412253] Dynamic subtest vcs1: SUCCESS (1.040s)
[140.422643] Starting dynamic subtest: vecs0
[141.456880] Dynamic subtest vecs0: SUCCESS (1.042s)
[141.467893] Starting dynamic subtest: ccs0
[142.502692] Dynamic subtest ccs0: SUCCESS (1.044s)
[142.505702] Subtest fence-wait: SUCCESS (6.274s)
[142.624566] [033/133] (878s left) gem_exec_alignment (many)
[142.696838] Starting subtest: many
[164.897521] Subtest many: SUCCESS (22.198s)
[166.962488] [034/133] (854s left) gem_userptr_blits (process-exit-busy)
[167.074256] Starting subtest: process-exit-busy
[167.092501] Subtest process-exit-busy: SUCCESS (0.014s)
[167.223562] [035/133] (854s left) kms_invalid_mode (int-max-clock)
[167.319293] Starting subtest: int-max-clock
[167.321643] Starting dynamic subtest: pipe-A-eDP-1
[167.611213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[167.620647] Starting dynamic subtest: pipe-B-eDP-1
[167.623040] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[167.630788] Starting dynamic subtest: pipe-C-eDP-1
[167.633091] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[167.640838] Starting dynamic subtest: pipe-D-eDP-1
[167.642844] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[167.644843] Subtest int-max-clock: SUCCESS (0.300s)
[168.480868] [036/133] (852s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[170.029976] Starting subtest: modeset-non-lpsp-stress-no-wait
[170.087234] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.055s)
[170.731200] [037/133] (850s left) gem_render_copy (x-tiled)
[170.791080] Starting subtest: x-tiled
[170.793563] Starting dynamic subtest: smem
[170.858313] Dynamic subtest smem: SUCCESS (0.066s)
[170.861052] Subtest x-tiled: SUCCESS (0.067s)
[171.072818] [038/133] (850s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[171.163301] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[171.167338] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[171.250201] [039/133] (850s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[171.342500] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[171.346824] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[171.441799] [040/133] (850s left) syncobj_wait (reset-unsignaled)
[171.502467] Starting subtest: reset-unsignaled
[171.504724] Subtest reset-unsignaled: SUCCESS (0.000s)
[171.596359] [041/133] (850s left) kms_psr (fbc-pr-cursor-render)
[171.704403] Starting subtest: fbc-pr-cursor-render
[171.708722] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[171.790239] [042/133] (849s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[171.916850] Starting subtest: extended-modeset-hang-oldfb-with-reset
[171.919017] Starting dynamic subtest: pipe-A
[183.734820] Dynamic subtest pipe-A: SUCCESS (11.815s)
[183.747804] Starting dynamic subtest: pipe-D
[196.010036] Dynamic subtest pipe-D: SUCCESS (12.271s)
[196.012857] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.091s)
[196.803360] [043/133] (824s left) gem_reg_read (timestamp-monotonic)
[196.875161] Starting subtest: timestamp-monotonic
[200.911403] Subtest timestamp-monotonic: SUCCESS (4.036s)
[200.988079] [044/133] (820s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[201.086247] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[207.839227] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.756s)
[207.977198] [045/133] (813s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[208.086681] Starting subtest: yf-tiled-16bpp-rotate-270
[208.091063] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[208.195037] [046/133] (813s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[208.255790] Starting subtest: multi-wait-for-submit-available-submitted
[208.257942] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[208.353531] [047/133] (813s left) gem_pwrite_snooped
[208.467841] [048/133] (813s left) kms_fbcon_fbt (fbc-suspend)
[208.531251] Starting subtest: fbc-suspend
[257.546445] Subtest fbc-suspend: SUCCESS (19.857s)
[258.883629] [049/133] (763s left) gem_ccs (ctrl-surf-copy-new-ctx)
[258.951487] Starting subtest: ctrl-surf-copy-new-ctx
[258.955931] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[259.071896] [050/133] (762s left) syncobj_wait (signal)
[259.131088] Starting subtest: signal
[259.133414] Subtest signal: SUCCESS (0.000s)
[259.235513] [051/133] (762s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[259.330372] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[259.332806] Starting dynamic subtest: pipe-A-eDP-1
[260.151809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.812s)
[260.162368] Starting dynamic subtest: pipe-B-eDP-1
[261.819247] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.663s)
[261.830121] Starting dynamic subtest: pipe-C-eDP-1
[263.308009] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s)
[263.319143] Starting dynamic subtest: pipe-D-eDP-1
[264.841219] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s)
[264.843292] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.501s)
[266.002959] [052/133] (756s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[266.063624] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[266.169844] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[266.245479] [053/133] (755s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[266.341350] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[266.343615] Starting dynamic subtest: pipe-A
[266.703147] Dynamic subtest pipe-A: SUCCESS (0.364s)
[266.712916] Starting dynamic subtest: pipe-B
[268.078983] Dynamic subtest pipe-B: SUCCESS (1.375s)
[268.088596] Starting dynamic subtest: pipe-C
[269.535323] Dynamic subtest pipe-C: SUCCESS (1.455s)
[269.544356] Starting dynamic subtest: pipe-D
[270.962893] Dynamic subtest pipe-D: SUCCESS (1.426s)
[270.965218] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.624s)
[272.128232] [054/133] (750s left) kms_cursor_crc (cursor-random-32x32)
[272.282725] Starting subtest: cursor-random-32x32
[272.329423] Subtest cursor-random-32x32: SKIP (0.042s)
[272.618303] [055/133] (749s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[272.712202] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[272.716338] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[272.815482] [056/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[272.907491] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[272.911886] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[272.992736] [057/133] (749s left) gem_mmap_offset (open-flood)
[273.036045] Starting subtest: open-flood
[294.522746] Subtest open-flood: SUCCESS (21.488s)
[294.627720] [058/133] (727s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[294.730685] Starting subtest: fbcpsr-rgb101010-draw-blt
[301.467162] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.739s)
[301.579429] [059/133] (720s left) perf_pmu (busy-accuracy-98)
[301.627790] Starting subtest: busy-accuracy-98
[301.629626] Starting dynamic subtest: rcs0
[304.660916] Dynamic subtest rcs0: SUCCESS (3.032s)
[304.679829] Starting dynamic subtest: bcs0
[307.716378] Dynamic subtest bcs0: SUCCESS (3.053s)
[307.726120] Starting dynamic subtest: vcs0
[310.759338] Dynamic subtest vcs0: SUCCESS (3.041s)
[310.774131] Starting dynamic subtest: vcs1
[313.801300] Dynamic subtest vcs1: SUCCESS (3.040s)
[313.815910] Starting dynamic subtest: vecs0
[316.842523] Dynamic subtest vecs0: SUCCESS (3.039s)
[316.855010] Starting dynamic subtest: ccs0
[319.892106] Dynamic subtest ccs0: SUCCESS (3.047s)
[319.895351] Subtest busy-accuracy-98: SUCCESS (18.263s)
[320.003282] [060/133] (702s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[320.109346] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[320.113657] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[320.176700] [061/133] (702s left) gem_exec_schedule (smoketest)
[320.350946] Starting subtest: smoketest
[320.353673] Starting dynamic subtest: rcs0
[325.889185] Dynamic subtest rcs0: SUCCESS (5.492s)
[325.900205] Starting dynamic subtest: bcs0
[331.410545] Dynamic subtest bcs0: SUCCESS (5.514s)
[331.429441] Starting dynamic subtest: vcs0
[336.906570] Dynamic subtest vcs0: SUCCESS (5.494s)
[336.919379] Starting dynamic subtest: vcs1
[342.400280] Dynamic subtest vcs1: SUCCESS (5.495s)
[342.411962] Starting dynamic subtest: vecs0
[347.904575] Dynamic subtest vecs0: SUCCESS (5.496s)
[347.919433] Starting dynamic subtest: ccs0
[353.388644] Dynamic subtest ccs0: SUCCESS (5.484s)
[353.390726] Subtest smoketest: SUCCESS (32.984s)
[353.525772] [062/133] (668s left) gen9_exec_parse (bb-start-cmd)
[353.576820] Subtest bb-start-cmd: SKIP (0.000s)
[353.637685] [063/133] (668s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[353.685890] Starting subtest: invalid-single-wait-unsubmitted
[353.688057] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[353.796607] [064/133] (668s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[353.912463] Starting subtest: modeset-atomic-cursor-hotspot
[353.916904] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[354.069397] [065/133] (668s left) gem_exec_fence (concurrent)
[354.260479] Starting subtest: concurrent
[354.264812] Subtest concurrent: SKIP (0.000s)
[356.137846] [066/133] (666s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[356.232336] Starting subtest: plane-primary-toggle-with-vblank-wait
[356.234657] Starting dynamic subtest: pipe-A-eDP-1
[356.405528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[356.722007] Starting dynamic subtest: pipe-B-eDP-1
[357.637430] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.930s)
[357.936496] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.704s)
[358.796017] [067/133] (663s left) syncobj_wait (wait-all-interrupted)
[358.865471] Starting subtest: wait-all-interrupted
[358.966103] Subtest wait-all-interrupted: SUCCESS (0.101s)
[359.043244] [068/133] (663s left) kms_pm_dc (dc3co-vpb-simulation)
[360.153576] Starting subtest: dc3co-vpb-simulation
[369.193565] Subtest dc3co-vpb-simulation: SKIP (9.038s)
[369.323773] [069/133] (653s left) kms_draw_crc (draw-method-blt)
[369.420098] Starting subtest: draw-method-blt
[369.421973] Starting dynamic subtest: xrgb8888-untiled
[369.652078] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[369.663196] Starting dynamic subtest: rgb565-untiled
[369.885645] Dynamic subtest rgb565-untiled: SUCCESS (0.231s)
[369.897807] Starting dynamic subtest: xrgb2101010-untiled
[370.107723] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[370.117552] Starting dynamic subtest: xbgr16161616f-untiled
[370.329999] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[370.339689] Starting dynamic subtest: xrgb8888-xtiled
[370.440617] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[370.449603] Starting dynamic subtest: rgb565-xtiled
[370.551634] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[370.560840] Starting dynamic subtest: xrgb2101010-xtiled
[370.662756] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[370.677622] Starting dynamic subtest: xbgr16161616f-xtiled
[370.773815] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[370.782796] Starting dynamic subtest: xrgb8888-4tiled
[370.885340] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[370.896976] Starting dynamic subtest: rgb565-4tiled
[371.007296] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[371.017222] Starting dynamic subtest: xrgb2101010-4tiled
[371.118317] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[371.129620] Starting dynamic subtest: xbgr16161616f-4tiled
[371.218608] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.098s)
[371.220430] Subtest draw-method-blt: SUCCESS (1.802s)
[371.375838] [070/133] (651s left) kms_frontbuffer_tracking (fbc-tiling-y)
[371.494405] Starting subtest: fbc-tiling-y
[371.497905] Subtest fbc-tiling-y: SKIP (0.000s)
[371.580161] [071/133] (651s left) kms_plane_scaling (planes-scaler-unity-scaling)
[371.674745] Starting subtest: planes-scaler-unity-scaling
[371.676705] Starting dynamic subtest: pipe-A
[371.737373] Dynamic subtest pipe-A: SUCCESS (0.064s)
[371.748367] Starting dynamic subtest: pipe-B
[372.930970] Dynamic subtest pipe-B: SUCCESS (1.192s)
[372.942944] Starting dynamic subtest: pipe-C
[374.032413] Dynamic subtest pipe-C: SUCCESS (1.100s)
[374.042757] Starting dynamic subtest: pipe-D
[375.176621] Dynamic subtest pipe-D: SUCCESS (1.143s)
[375.179027] Subtest planes-scaler-unity-scaling: SUCCESS (3.504s)
[376.312161] [072/133] (646s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[376.402050] Starting subtest: bad-pixel-format-y-tiled-ccs
[376.404324] Starting dynamic subtest: pipe-A-eDP-1
[376.427318] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[376.438906] Starting dynamic subtest: pipe-B-eDP-1
[376.460048] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[376.468839] Starting dynamic subtest: pipe-C-eDP-1
[376.489738] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[376.498495] Starting dynamic subtest: pipe-D-eDP-1
[376.519964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[376.524304] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[378.582219] [073/133] (644s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[378.697588] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[379.688715] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.990s)
[379.798889] [074/133] (643s left) gem_mmap (bad-size)
[379.854966] Subtest bad-size: SKIP (0.000s)
[379.927010] [075/133] (643s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[380.024236] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[380.026125] Starting dynamic subtest: pipe-A-default-mode
[382.711942] Dynamic subtest pipe-A-default-mode: SUCCESS (2.688s)
[382.714276] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.689s)
[383.581626] [076/133] (639s left) sw_sync (sync_multi_producer_single_consumer)
[383.621922] Starting subtest: sync_multi_producer_single_consumer
[384.695617] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[384.759502] [077/133] (638s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[384.845206] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[384.847313] Starting dynamic subtest: pipe-A-eDP-1
[385.753194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.901s)
[385.765417] Starting dynamic subtest: pipe-B-eDP-1
[387.279129] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.523s)
[387.288318] Starting dynamic subtest: pipe-C-eDP-1
[388.787134] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s)
[388.796989] Starting dynamic subtest: pipe-D-eDP-1
[390.284076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.500s)
[390.286278] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.434s)
[391.419013] [078/133] (631s left) gem_mmap (big-bo)
[391.484050] Subtest big-bo: SKIP (0.000s)
[391.555026] [079/133] (631s left) gem_userptr_blits (set-cache-level)
[391.622143] Starting subtest: set-cache-level
[391.626703] Subtest set-cache-level: SKIP (0.000s)
[391.766698] [080/133] (631s left) i915_drm_fdinfo (virtual-busy)
[391.805402] Starting subtest: virtual-busy
[391.809796] Subtest virtual-busy: SKIP (0.000s)
[391.890928] [081/133] (631s left) kms_cursor_edge_walk (128x128-right-edge)
[391.988290] Starting subtest: 128x128-right-edge
[391.990477] Starting dynamic subtest: pipe-A-eDP-1
[395.474105] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[395.494280] Starting dynamic subtest: pipe-D-eDP-1
[398.599640] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[398.601579] Subtest 128x128-right-edge: SUCCESS (6.608s)
[399.398140] [082/133] (623s left) gem_exec_parallel (engines)
[399.467260] Starting subtest: engines
[399.469673] Starting dynamic subtest: basic
[401.078514] Dynamic subtest basic: SUCCESS (1.609s)
[401.092127] Starting dynamic subtest: contexts
[405.292463] Dynamic subtest contexts: SUCCESS (4.211s)
[405.305382] Starting dynamic subtest: fds
[409.208539] Dynamic subtest fds: SUCCESS (3.914s)
[409.221156] Starting dynamic subtest: userptr
[411.061464] Dynamic subtest userptr: SUCCESS (1.848s)
[411.064445] Subtest engines: SUCCESS (11.593s)
[411.302544] [083/133] (612s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[411.407406] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[411.411663] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[411.512510] [084/133] (611s left) gem_exec_whisper (basic-queues)
[411.584691] Starting subtest: basic-queues
[417.089135] Subtest basic-queues: SUCCESS (5.499s)
[417.270043] [085/133] (606s left) api_intel_allocator (reloc-allocator)
[417.337985] Starting subtest: reloc-allocator
[417.340820] Starting dynamic subtest: basic
[417.345805] Dynamic subtest basic: SUCCESS (0.007s)
[417.358608] Starting dynamic subtest: parallel-one
[417.360800] Dynamic subtest parallel-one: SUCCESS (0.008s)
[417.369823] Starting dynamic subtest: print
[417.372149] Dynamic subtest print: SUCCESS (0.000s)
[417.381292] Starting dynamic subtest: reuse
[417.383449] Dynamic subtest reuse: SUCCESS (0.000s)
[417.392707] Starting dynamic subtest: fork-reopen-allocator
[417.394908] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[417.397162] Subtest reloc-allocator: SUCCESS (0.030s)
[417.489773] [086/133] (606s left) kms_psr (psr-basic)
[417.583911] Starting subtest: psr-basic
[417.586124] Starting dynamic subtest: eDP-1
[419.181341] Dynamic subtest eDP-1: SUCCESS (1.596s)
[419.183654] Subtest psr-basic: SUCCESS (1.597s)
[420.059450] [087/133] (603s left) kms_flip (2x-absolute-wf_vblank)
[420.161244] Starting subtest: 2x-absolute-wf_vblank
[420.169890] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[420.310832] [088/133] (603s left) kms_atomic (atomic-plane-damage)
[420.403466] Starting subtest: atomic-plane-damage
[420.454092] Starting dynamic subtest: pipe-A-eDP-1
[421.029038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[421.031383] Subtest atomic-plane-damage: SUCCESS (0.628s)
[421.897937] [089/133] (601s left) gem_spin_batch (resubmit)
[421.961309] Starting subtest: resubmit
[421.963830] Starting dynamic subtest: rcs0
[421.969224] Dynamic subtest rcs0: SUCCESS (0.008s)
[421.980883] Starting dynamic subtest: bcs0
[421.983012] Dynamic subtest bcs0: SUCCESS (0.003s)
[421.992859] Starting dynamic subtest: vcs0
[421.994998] Dynamic subtest vcs0: SUCCESS (0.003s)
[422.004986] Starting dynamic subtest: vcs1
[422.007177] Dynamic subtest vcs1: SUCCESS (0.003s)
[422.016368] Starting dynamic subtest: vecs0
[422.018521] Dynamic subtest vecs0: SUCCESS (0.004s)
[422.027637] Starting dynamic subtest: ccs0
[422.029795] Dynamic subtest ccs0: SUCCESS (0.003s)
[422.031963] Subtest resubmit: SUCCESS (0.026s)
[422.209000] [090/133] (601s left) kms_psr (pr-sprite-plane-move)
[422.303860] Starting subtest: pr-sprite-plane-move
[422.307705] Subtest pr-sprite-plane-move: SKIP (0.000s)
[422.376126] [091/133] (601s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[422.477762] Starting subtest: async-flip-with-page-flip-events-linear
[422.852351] Starting dynamic subtest: pipe-A-eDP-1
[425.665694] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.812s)
[426.063140] Starting dynamic subtest: pipe-B-eDP-1
[428.805105] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.748s)
[429.171706] Starting dynamic subtest: pipe-C-eDP-1
[431.944414] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.782s)
[432.311572] Starting dynamic subtest: pipe-D-eDP-1
[435.068759] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[435.071349] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.591s)
[436.248103] [092/133] (587s left) api_intel_bb (object-noreloc-keep-cache-simple)
[436.306451] Starting subtest: object-noreloc-keep-cache-simple
[436.312968] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.008s)
[436.424722] [093/133] (587s left) perf_pmu (interrupts-sync)
[436.469994] Starting subtest: interrupts-sync
[437.589353] Subtest interrupts-sync: SUCCESS (1.118s)
[437.712865] [094/133] (586s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[437.777654] Starting subtest: etime-multi-wait-for-submit-submitted
[437.882080] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[437.957809] [095/133] (585s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[438.052349] Starting subtest: fbc-psr-sprite-mmap-gtt
[438.054528] Starting dynamic subtest: eDP-1
[438.058504] Dynamic subtest eDP-1: SKIP (0.000s)
[438.062542] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[438.148979] [096/133] (585s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[438.247206] Starting subtest: x-tiled-64bpp-rotate-0
[439.850944] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.603s)
[440.019461] [097/133] (584s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[440.070317] Starting subtest: multi-wait-all-for-submit-submitted
[440.179924] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[440.255497] [098/133] (583s left) gem_pxp (protected-raw-src-copy-not-readible)
[440.376053] Starting subtest: protected-raw-src-copy-not-readible
[440.433818] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[440.543486] [099/133] (583s left) kms_content_protection (uevent-hdcp14)
[440.676699] Starting subtest: uevent-hdcp14
[440.681246] Subtest uevent-hdcp14: SKIP (0.000s)
[440.790197] [100/133] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[440.908766] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[440.913190] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[441.012082] [101/133] (583s left) kms_plane (pixel-format-yf-tiled-modifier)
[441.103424] Starting subtest: pixel-format-yf-tiled-modifier
[441.107831] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[441.175393] [102/133] (583s left) kms_chamelium_audio (dp-audio)
[441.547745] Subtest dp-audio: SKIP (0.000s)
[442.362417] [103/133] (581s left) kms_frontbuffer_tracking (psr-suspend)
[442.463591] Starting subtest: psr-suspend
[481.016749] Subtest psr-suspend: SUCCESS (8.003s)
[481.163914] [104/133] (543s left) kms_vblank (ts-continuation-modeset-hang)
[481.261914] Starting subtest: ts-continuation-modeset-hang
[481.264147] Starting dynamic subtest: pipe-A-eDP-1
[507.338831] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.061s)
[507.354644] Starting dynamic subtest: pipe-D-eDP-1
[522.446743] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.103s)
[522.449460] Subtest ts-continuation-modeset-hang: SUCCESS (41.169s)
[523.260017] [105/133] (501s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[523.322008] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[523.327697] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[523.529778] [106/133] (500s left) gem_wait (invalid-buf)
[523.583774] Starting subtest: invalid-buf
[523.586448] Subtest invalid-buf: SUCCESS (0.000s)
[523.785654] [107/133] (500s left) kms_prop_blob (blob-prop-core)
[523.846363] Starting subtest: blob-prop-core
[523.849061] Subtest blob-prop-core: SUCCESS (0.000s)
[523.946611] [108/133] (500s left) syncobj_timeline (wait-delayed-signal)
[524.016150] Starting subtest: wait-delayed-signal
[524.117289] Subtest wait-delayed-signal: SUCCESS (0.102s)
[524.210454] [109/133] (500s left) kms_addfb_basic (no-handle)
[524.281392] Starting subtest: no-handle
[524.284034] Subtest no-handle: SUCCESS (0.000s)
[524.416042] [110/133] (500s left) gem_ctx_persistence (engines-hostile)
[524.482624] Starting subtest: engines-hostile
[524.485172] Starting dynamic subtest: rcs0
[524.571412] Dynamic subtest rcs0: SUCCESS (0.089s)
[524.584127] Starting dynamic subtest: bcs0
[524.666406] Dynamic subtest bcs0: SUCCESS (0.093s)
[524.678902] Starting dynamic subtest: vcs0
[524.765396] Dynamic subtest vcs0: SUCCESS (0.097s)
[524.778626] Starting dynamic subtest: vcs1
[524.864328] Dynamic subtest vcs1: SUCCESS (0.096s)
[524.877120] Starting dynamic subtest: vecs0
[524.936095] Dynamic subtest vecs0: SUCCESS (0.070s)
[524.947685] Starting dynamic subtest: ccs0
[525.058523] Dynamic subtest ccs0: SUCCESS (0.120s)
[525.061410] Subtest engines-hostile: SUCCESS (0.578s)
[525.143321] [111/133] (499s left) kms_chamelium_hpd (dp-hpd-storm)
[525.521393] Subtest dp-hpd-storm: SKIP (0.000s)
[526.353623] [112/133] (498s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[526.474181] Starting subtest: cursorB-vs-flipB-atomic-transitions
[526.479650] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[526.621967] [113/133] (498s left) perf_pmu (rc6-all-gts)
[526.662871] Starting subtest: rc6-all-gts
[533.026969] Subtest rc6-all-gts: SUCCESS (6.365s)
[534.062042] [114/133] (490s left) i915_pm_rpm (debugfs-forcewake-user)
[535.705643] Starting subtest: debugfs-forcewake-user
[547.092169] Subtest debugfs-forcewake-user: SUCCESS (11.388s)
[547.478610] [115/133] (477s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[547.576919] Starting subtest: coverage-vs-premult-vs-constant
[547.862125] Starting dynamic subtest: pipe-A-eDP-1
[548.428610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[548.439935] Starting dynamic subtest: pipe-D-eDP-1
[549.771587] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[549.774328] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.196s)
[550.632730] [116/133] (474s left) kms_getfb (getfb2-handle-protection)
[550.724126] Starting subtest: getfb2-handle-protection
[550.738158] Subtest getfb2-handle-protection: SUCCESS (0.016s)
[550.868363] [117/133] (474s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[550.985692] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[550.990551] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[551.095740] [118/133] (473s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[551.190199] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[551.195920] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[551.289155] [119/133] (473s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[551.380049] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[551.385243] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[551.474616] [120/133] (473s left) kms_atomic_interruptible (legacy-setmode)
[551.573532] Starting subtest: legacy-setmode
[551.575550] Starting dynamic subtest: pipe-A-eDP-1
[558.440644] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.865s)
[558.443387] Subtest legacy-setmode: SUCCESS (6.866s)
[559.242201] [121/133] (465s left) gem_lmem_swapping (parallel-multi)
[559.290921] Subtest parallel-multi: SKIP (0.000s)
[559.347455] [122/133] (465s left) gem_exec_balancer (bonded-sync)
[559.404792] Starting subtest: bonded-sync
[559.409311] Subtest bonded-sync: SKIP (0.000s)
[559.701958] [123/133] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[559.796126] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[559.801030] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[559.880980] [124/133] (465s left) gem_eio (in-flight-internal-immediate)
[560.097155] Starting subtest: in-flight-internal-immediate
[561.685381] Subtest in-flight-internal-immediate: SUCCESS (1.586s)
[561.809308] [125/133] (463s left) gem_mmap_wc (read-write-distinct)
[561.856506] Subtest read-write-distinct: SKIP (0.000s)
[561.918408] [126/133] (463s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[562.015175] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[562.020181] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[562.120206] [127/133] (463s left) gem_ctx_persistence (saturated-hostile)
[562.183016] Starting subtest: saturated-hostile
[562.186002] Starting dynamic subtest: rcs0
[563.010422] Dynamic subtest rcs0: SUCCESS (0.826s)
[563.024319] Starting dynamic subtest: bcs0
[563.798676] Dynamic subtest bcs0: SUCCESS (0.786s)
[563.812853] Starting dynamic subtest: vcs0
[564.591477] Dynamic subtest vcs0: SUCCESS (0.790s)
[564.605051] Starting dynamic subtest: vcs1
[565.391472] Dynamic subtest vcs1: SUCCESS (0.798s)
[565.405334] Starting dynamic subtest: vecs0
[566.192455] Dynamic subtest vecs0: SUCCESS (0.798s)
[566.205580] Starting dynamic subtest: ccs0
[567.037715] Dynamic subtest ccs0: SUCCESS (0.844s)
[567.040533] Subtest saturated-hostile: SUCCESS (4.855s)
[567.172834] [128/133] (458s left) kms_selftest (drm_cmdline_parser)
[567.215762] Starting subtest: drm_cmdline_parser
[567.278391] Starting dynamic subtest: drm_test_cmdline_force_d_only
[567.356036] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.078s)
[567.367436] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[567.445865] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.089s)
[567.457178] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[567.537319] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.090s)
[567.550198] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[567.629854] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.089s)
[567.640181] Starting dynamic subtest: drm_test_cmdline_force_e_only
[567.717192] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.088s)
[567.727948] Starting dynamic subtest: drm_test_cmdline_res
[567.812458] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.093s)
[567.822895] Starting dynamic subtest: drm_test_cmdline_res_vesa
[567.905286] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.092s)
[567.915697] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[568.002471] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.096s)
[568.013721] Starting dynamic subtest: drm_test_cmdline_res_rblank
[568.087946] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.083s)
[568.097416] Starting dynamic subtest: drm_test_cmdline_res_bpp
[568.169841] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.082s)
[568.180782] Starting dynamic subtest: drm_test_cmdline_res_refresh
[568.250485] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.081s)
[568.260142] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[568.331945] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.080s)
[568.342996] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[568.421657] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.089s)
[568.431035] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[568.507518] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.085s)
[568.518689] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[568.594763] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.086s)
[568.605629] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[568.677900] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.082s)
[568.688744] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[568.771870] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.094s)
[568.782182] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[568.864488] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.090s)
[568.873918] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[568.945605] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.080s)
[568.956915] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[569.031822] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.086s)
[569.042839] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[569.112836] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.077s)
[569.123788] Starting dynamic subtest: drm_test_cmdline_name
[569.201404] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.088s)
[569.212153] Starting dynamic subtest: drm_test_cmdline_name_bpp
[569.287006] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.084s)
[569.297945] Starting dynamic subtest: drm_test_cmdline_name_option
[569.372647] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.084s)
[569.383013] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[569.457395] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.083s)
[569.468041] Starting dynamic subtest: drm_test_cmdline_rotate_0
[569.542669] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.085s)
[569.552974] Starting dynamic subtest: drm_test_cmdline_rotate_90
[569.629512] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.086s)
[569.641372] Starting dynamic subtest: drm_test_cmdline_rotate_180
[569.714307] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.082s)
[569.725908] Starting dynamic subtest: drm_test_cmdline_rotate_270
[569.799460] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.085s)
[569.810143] Starting dynamic subtest: drm_test_cmdline_hmirror
[569.891972] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.091s)
[569.901757] Starting dynamic subtest: drm_test_cmdline_vmirror
[569.973785] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.082s)
[569.986022] Starting dynamic subtest: drm_test_cmdline_margin_options
[570.054296] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.079s)
[570.065639] Starting dynamic subtest: drm_test_cmdline_multiple_options
[570.147047] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.092s)
[570.157915] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[570.244801] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.097s)
[570.254976] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[570.336434] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.090s)
[570.347778] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[570.411596] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.074s)
[570.422865] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[570.497025] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.085s)
[570.506912] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[570.581793] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.083s)
[570.592179] Starting dynamic subtest: drm_test_cmdline_invalid
[570.690929] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.107s)
[570.700504] Starting dynamic subtest: drm_test_cmdline_tv_options
[570.792034] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.102s)
[570.793994] Subtest drm_cmdline_parser: SUCCESS (3.576s)
[570.946256] [129/133] (454s left) kms_flip (flip-vs-panning)
[571.041868] Starting subtest: flip-vs-panning
[571.044482] Starting dynamic subtest: A-eDP1
[579.762076] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[579.774074] Starting dynamic subtest: B-eDP1
[588.490932] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[588.503553] Starting dynamic subtest: C-eDP1
[597.203944] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[597.217422] Starting dynamic subtest: D-eDP1
[605.951740] Dynamic subtest D-eDP1: SUCCESS (8.745s)
[605.956686] Subtest flip-vs-panning: SUCCESS (34.917s)
[607.121513] [130/133] (418s left) kms_lease (lease-get)
[607.216698] Starting subtest: lease-get
[607.218947] Starting dynamic subtest: pipe-A-eDP-1
[607.221493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[607.232649] Starting dynamic subtest: pipe-B-eDP-1
[607.234819] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[607.244505] Starting dynamic subtest: pipe-C-eDP-1
[607.246800] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[607.256138] Starting dynamic subtest: pipe-D-eDP-1
[607.258447] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[607.260397] Subtest lease-get: SUCCESS (0.009s)
[607.334892] [131/133] (418s left) i915_pm_freq_api (freq-reset)
[607.406165] Starting subtest: freq-reset
[607.408978] Starting dynamic subtest: gt0
[607.582216] Dynamic subtest gt0: SUCCESS (0.172s)
[607.591898] Starting dynamic subtest: gt1
[607.730343] Dynamic subtest gt1: SUCCESS (0.150s)
[607.733130] Subtest freq-reset: SUCCESS (0.324s)
[607.814547] [132/133] (417s left) kms_flip (flip-vs-panning-vs-hang)
[607.907869] Starting subtest: flip-vs-panning-vs-hang
[607.910129] Starting dynamic subtest: A-eDP1
[659.061135] Dynamic subtest A-eDP1: SUCCESS (51.148s)
[659.071165] Starting dynamic subtest: D-eDP1
[699.064181] Dynamic subtest D-eDP1: SUCCESS (39.994s)
[699.066927] Subtest flip-vs-panning-vs-hang: SUCCESS (91.146s)
[700.225523] [133/133] (325s left) kms_flip (basic-flip-vs-dpms)
[700.328935] Starting subtest: basic-flip-vs-dpms
[700.331645] Starting dynamic subtest: A-eDP1
[702.913194] Dynamic subtest A-eDP1: SUCCESS (2.583s)
[702.925324] Starting dynamic subtest: B-eDP1
[705.074126] Dynamic subtest B-eDP1: SUCCESS (2.160s)
[705.085466] Starting dynamic subtest: C-eDP1
[707.155850] Dynamic subtest C-eDP1: SUCCESS (2.080s)
[707.166734] Starting dynamic subtest: D-eDP1
[709.233813] Dynamic subtest D-eDP1: SUCCESS (2.077s)
[709.236182] Subtest basic-flip-vs-dpms: SUCCESS (8.909s)
[710.030494] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: i915_query
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_color_pipeline
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: syncobj_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_param
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: gem_madvise
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_chamelium_color
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_plane_lowres
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: core_setmaster
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: prime_vgem
results: parsing output: 32/ for test: gem_exec_alignment
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_invalid_mode
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_busy
results: parsing output: 42/ for test: gem_reg_read
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_pwrite_snooped
results: parsing output: 47/ for test: kms_fbcon_fbt
results: parsing output: 48/ for test: gem_ccs
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_atomic_transition
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_pm_dc
results: parsing output: 68/ for test: kms_draw_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_mmap
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: sw_sync
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_mmap
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: i915_drm_fdinfo
results: parsing output: 80/ for test: kms_cursor_edge_walk
results: parsing output: 81/ for test: gem_exec_parallel
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_whisper
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: api_intel_bb
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_pxp
results: parsing output: 98/ for test: kms_content_protection
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: kms_chamelium_audio
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_wait
results: parsing output: 106/ for test: kms_prop_blob
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_chamelium_hpd
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: i915_pm_rpm
results: parsing output: 114/ for test: kms_plane_alpha_blend
results: parsing output: 115/ for test: kms_getfb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_atomic_interruptible
results: parsing output: 120/ for test: gem_lmem_swapping
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_selftest
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: i915_pm_freq_api
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_flip
Done.