[61.512541] Initializing watchdogs
[61.512589]   /dev/watchdog0
[61.528478] [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]
[61.533219] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.535603] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.537602] [001/155] (960s left) perf (non-system-wide-paranoid)
[61.672944] Starting subtest: non-system-wide-paranoid
[61.705603] Subtest non-system-wide-paranoid: SUCCESS (0.033s)
[61.746816] [002/155] (960s left) syncobj_eventfd (binary-wait)
[61.797455] Starting subtest: binary-wait
[61.808200] Subtest binary-wait: SUCCESS (0.010s)
[61.907732] [003/155] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[62.009018] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[66.192590] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.154s)
[67.325211] [004/155] (954s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[67.418098] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[67.418948] Starting dynamic subtest: pipe-A-eDP-1
[67.427729] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[67.435503] Starting dynamic subtest: pipe-B-eDP-1
[67.444838] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[67.451138] Starting dynamic subtest: pipe-C-eDP-1
[67.459310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[67.465112] Starting dynamic subtest: pipe-D-eDP-1
[67.473332] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[67.474979] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[69.678776] [005/155] (952s left) gem_exec_schedule (fairslice-all)
[69.742298] Starting subtest: fairslice-all
[71.806428] Subtest fairslice-all: SUCCESS (2.058s)
[73.461727] [006/155] (948s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[73.623529] Starting subtest: wait-all-for-submit-delayed-submit
[73.718887] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[73.803204] [007/155] (948s left) api_intel_allocator (gem-pool)
[73.860583] Starting subtest: gem-pool
[73.874158] Subtest gem-pool: SUCCESS (0.013s)
[74.010344] [008/155] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[74.109666] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[74.111407] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[74.224396] [009/155] (948s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[74.307488] Starting subtest: bo-too-small-due-to-tiling
[74.309581] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[74.385204] [010/155] (947s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[74.431521] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[74.492436] [011/155] (947s left) kms_flip (2x-plain-flip-fb-recreate)
[74.571988] Starting subtest: 2x-plain-flip-fb-recreate
[74.583381] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[74.688179] [012/155] (947s left) gem_create (create-size-update)
[74.736827] Starting subtest: create-size-update
[74.737691] Subtest create-size-update: SUCCESS (0.000s)
[74.956325] [013/155] (947s left) kms_plane_lowres (tiling-none)
[75.038618] Starting subtest: tiling-none
[75.039678] Starting dynamic subtest: pipe-A-eDP-1
[75.041537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.333057] Starting dynamic subtest: pipe-B-eDP-1
[75.334939] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.345958] Starting dynamic subtest: pipe-C-eDP-1
[75.347834] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.355066] Starting dynamic subtest: pipe-D-eDP-1
[75.356899] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.358909] Subtest tiling-none: SKIP (0.292s)
[76.127815] [014/155] (946s left) kms_flip (2x-flip-vs-panning)
[76.223854] Starting subtest: 2x-flip-vs-panning
[76.235095] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[76.320149] [015/155] (946s left) i915_pm_rps (reset)
[76.378570] Starting subtest: reset
[84.826753] Subtest reset: SUCCESS (8.437s)
[84.948203] [016/155] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[85.047925] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[85.049911] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[85.140690] [017/155] (937s left) kms_async_flips (crc-atomic)
[85.226201] Starting subtest: crc-atomic
[85.611607] Starting dynamic subtest: pipe-A-eDP-1
[88.562659] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.949s)
[88.946528] Starting dynamic subtest: pipe-B-eDP-1
[91.910374] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.970s)
[92.296353] Starting dynamic subtest: pipe-C-eDP-1
[95.228621] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.939s)
[95.599824] Starting dynamic subtest: pipe-D-eDP-1
[98.462200] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.868s)
[98.463302] Subtest crc-atomic: SUCCESS (13.230s)
[99.629685] [018/155] (922s left) gem_pxp (reject-modify-context-protection-off-3)
[99.745983] Starting subtest: reject-modify-context-protection-off-3
[99.747381] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[99.847104] [019/155] (922s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[99.945274] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[100.968924] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.024s)
[101.085786] [020/155] (921s left) gem_eio (in-flight-contexts-1us)
[101.308218] Starting subtest: in-flight-contexts-1us
[115.366436] Subtest in-flight-contexts-1us: SUCCESS (14.055s)
[115.502992] [021/155] (907s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[115.598061] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[115.599930] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[115.693356] [022/155] (907s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[115.784460] Starting subtest: 4-tiled-64bpp-rotate-0
[117.398390] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.614s)
[117.584023] [023/155] (905s left) kms_addfb_basic (bad-pitch-63)
[117.626629] Starting subtest: bad-pitch-63
[117.627913] Subtest bad-pitch-63: SUCCESS (0.000s)
[117.773292] [024/155] (905s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[117.861161] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[117.863069] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[117.955237] [025/155] (904s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[118.056186] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[118.057896] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[118.155072] [026/155] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[118.241595] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[122.390604] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.150s)
[123.558085] [027/155] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[123.656860] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[123.658613] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[123.753723] [028/155] (899s left) kms_cursor_crc (cursor-offscreen-max-size)
[124.057009] Starting subtest: cursor-offscreen-max-size
[124.060371] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[124.183966] [029/155] (898s left) gem_ctx_persistence (legacy-engines-mixed)
[124.234577] Starting subtest: legacy-engines-mixed
[124.235648] Starting dynamic subtest: render
[124.301639] Dynamic subtest render: SUCCESS (0.066s)
[124.311465] Starting dynamic subtest: bsd1
[124.353636] Dynamic subtest bsd1: SUCCESS (0.050s)
[124.363374] Starting dynamic subtest: bsd2
[124.409914] Dynamic subtest bsd2: SUCCESS (0.054s)
[124.421405] Starting dynamic subtest: blt
[124.464306] Dynamic subtest blt: SUCCESS (0.052s)
[124.473791] Starting dynamic subtest: vebox
[124.503465] Dynamic subtest vebox: SUCCESS (0.038s)
[124.504561] Subtest legacy-engines-mixed: SUCCESS (0.269s)
[124.588348] [030/155] (898s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[124.675594] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[124.677458] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[124.777499] [031/155] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[124.865057] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[132.307841] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.443s)
[132.433274] [032/155] (890s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[132.520425] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[132.521384] Starting dynamic subtest: pipe-A-eDP-1
[132.530525] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[132.538736] Starting dynamic subtest: pipe-B-eDP-1
[132.547767] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[132.555359] Starting dynamic subtest: pipe-C-eDP-1
[132.563951] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[132.571414] Starting dynamic subtest: pipe-D-eDP-1
[132.579838] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[132.581491] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[134.755274] [033/155] (888s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[134.852436] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[134.853872] Starting dynamic subtest: pipe-A
[134.916124] Dynamic subtest pipe-A: SUCCESS (0.065s)
[134.925878] Starting dynamic subtest: pipe-B
[136.084506] Dynamic subtest pipe-B: SUCCESS (1.168s)
[136.092908] Starting dynamic subtest: pipe-C
[137.196208] Dynamic subtest pipe-C: SUCCESS (1.111s)
[137.204821] Starting dynamic subtest: pipe-D
[138.337570] Dynamic subtest pipe-D: SUCCESS (1.141s)
[138.338609] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.487s)
[139.477460] [034/155] (883s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[139.570419] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[139.572910] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[139.677653] [035/155] (883s left) kms_chamelium_edid (dp-mode-timings)
[140.062117] Subtest dp-mode-timings: SKIP (0.000s)
[140.890902] [036/155] (882s left) kms_psr (psr2-no-drrs)
[140.982105] Starting subtest: psr2-no-drrs
[140.982949] Starting dynamic subtest: eDP-1
[142.586519] Dynamic subtest eDP-1: SUCCESS (1.603s)
[142.587443] Subtest psr2-no-drrs: SUCCESS (1.604s)
[143.471990] [037/155] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[143.559498] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[143.561184] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[143.650444] [038/155] (879s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[143.744174] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[144.956126] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.212s)
[145.061324] [039/155] (878s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[145.160040] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[145.161786] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[145.258115] [040/155] (878s left) gem_ctx_shared (q-promotion)
[145.314259] Starting subtest: Q-promotion
[145.315207] Starting dynamic subtest: rcs0
[145.471150] Dynamic subtest rcs0: SUCCESS (0.156s)
[145.486511] Starting dynamic subtest: vcs0
[145.555270] Dynamic subtest vcs0: SUCCESS (0.083s)
[145.568665] Starting dynamic subtest: vcs1
[145.639467] Dynamic subtest vcs1: SUCCESS (0.083s)
[145.654929] Starting dynamic subtest: vecs0
[145.729889] Dynamic subtest vecs0: SUCCESS (0.078s)
[145.737791] Starting dynamic subtest: ccs0
[145.811407] Dynamic subtest ccs0: SUCCESS (0.093s)
[145.812958] Subtest Q-promotion: SUCCESS (0.497s)
[147.453730] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[147.455770] [041/155] (875s left) gem_exec_schedule (manyslice)
[147.516676] Starting subtest: manyslice
[147.517664] Starting dynamic subtest: rcs0
[152.711780] Dynamic subtest rcs0: SUCCESS (5.150s)
[152.721723] Starting dynamic subtest: bcs0
[159.827423] Dynamic subtest bcs0: SUCCESS (7.151s)
[159.839199] Starting dynamic subtest: vcs0
[165.949010] Dynamic subtest vcs0: SUCCESS (6.084s)
[165.959589] Starting dynamic subtest: vcs1
[171.523649] Dynamic subtest vcs1: SUCCESS (5.573s)
[171.535250] Starting dynamic subtest: vecs0
[177.602654] Dynamic subtest vecs0: SUCCESS (6.079s)
[177.612466] Starting dynamic subtest: ccs0
[183.765819] Dynamic subtest ccs0: SUCCESS (6.197s)
[183.767286] Subtest manyslice: SUCCESS (36.242s)
[184.071672] [042/155] (839s left) gem_exec_params (invalid-flag)
[184.123569] Starting subtest: invalid-flag
[184.124779] Subtest invalid-flag: SUCCESS (0.000s)
[184.219805] [043/155] (839s left) syncobj_timeline (invalid-signal-bad-pad)
[184.270376] Starting subtest: invalid-signal-bad-pad
[184.271479] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[184.356677] [044/155] (839s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[184.460957] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[184.462833] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[184.571215] [045/155] (838s left) kms_invalid_mode (bad-vsync-start)
[184.671209] Starting subtest: bad-vsync-start
[184.672075] Starting dynamic subtest: pipe-A-eDP-1
[184.959835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[184.967112] Starting dynamic subtest: pipe-B-eDP-1
[184.967942] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[184.974898] Starting dynamic subtest: pipe-C-eDP-1
[184.975738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[184.982938] Starting dynamic subtest: pipe-D-eDP-1
[184.983852] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[184.984732] Subtest bad-vsync-start: SUCCESS (0.294s)
[185.814478] [046/155] (837s left) kms_mmap_write_crc (main)
[185.912704] Starting subtest: main
[185.913955] Starting dynamic subtest: pipe-A-eDP-1
[189.404757] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.490s)
[189.405813] Subtest main: SUCCESS (3.491s)
[190.231698] [047/155] (833s left) kms_pm_rpm (fences-dpms)
[192.468775] Starting subtest: fences-dpms
[192.471635] Subtest fences-dpms: SKIP (0.000s)
[192.861158] [048/155] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[192.956106] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[192.957728] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[193.040649] [049/155] (830s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[193.139413] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[193.141179] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[193.235782] [050/155] (830s left) gem_exec_reloc (basic-wc-cpu-active)
[193.297916] Subtest basic-wc-cpu-active: SKIP (0.000s)
[193.379511] [051/155] (830s left) gem_linear_blits (basic)
[193.764996] Starting subtest: basic
[193.772056] Subtest basic: SUCCESS (0.009s)
[193.895379] [052/155] (829s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[194.044498] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[194.046342] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[194.148626] [053/155] (829s left) kms_cursor_crc (cursor-size-change)
[194.236181] Starting subtest: cursor-size-change
[194.237153] Starting dynamic subtest: pipe-A-eDP-1
[195.072693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.837s)
[195.080944] Starting dynamic subtest: pipe-D-eDP-1
[196.554142] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.480s)
[196.555095] Subtest cursor-size-change: SUCCESS (2.319s)
[197.424012] [054/155] (826s left) kms_flip (flip-vs-blocking-wf-vblank)
[197.511929] Starting subtest: flip-vs-blocking-wf-vblank
[197.513826] Starting dynamic subtest: A-eDP1
[206.479401] Dynamic subtest A-eDP1: SUCCESS (8.965s)
[206.488543] Starting dynamic subtest: B-eDP1
[215.409027] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[215.420241] Starting dynamic subtest: C-eDP1
[224.369019] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[224.379236] Starting dynamic subtest: D-eDP1
[233.308265] Dynamic subtest D-eDP1: SUCCESS (8.938s)
[233.309691] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.763s)
[234.507075] [055/155] (789s left) sysfs_timeslice_duration (timeout)
[234.570423] Starting subtest: timeout
[234.571418] Starting dynamic subtest: vecs0
[244.314835] Dynamic subtest vecs0: SUCCESS (9.734s)
[244.326144] Starting dynamic subtest: ccs0
[245.573839] Dynamic subtest ccs0: SUCCESS (1.265s)
[245.582114] Starting dynamic subtest: vcs0
[255.322748] Dynamic subtest vcs0: SUCCESS (9.738s)
[255.334494] Starting dynamic subtest: bcs0
[255.927784] Dynamic subtest bcs0: SUCCESS (0.613s)
[255.937341] Starting dynamic subtest: rcs0
[257.123826] Dynamic subtest rcs0: SUCCESS (1.193s)
[257.134981] Starting dynamic subtest: vcs1
[266.334689] Dynamic subtest vcs1: SUCCESS (9.199s)
[266.335853] Subtest timeout: SUCCESS (31.753s)
[266.398153] [056/155] (757s left) i915_drm_fdinfo (virtual-idle)
[266.432116] Starting subtest: virtual-idle
[269.476757] Subtest virtual-idle: SUCCESS (3.035s)
[269.537682] [057/155] (754s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[269.634570] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[269.636259] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[269.718864] [058/155] (754s left) prime_self_import (basic-llseek-size)
[269.750376] Starting subtest: basic-llseek-size
[269.768037] Subtest basic-llseek-size: SUCCESS (0.018s)
[269.860827] [059/155] (754s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[269.950577] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[273.877898] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.928s)
[275.017377] [060/155] (748s left) kms_vblank (query-forked-busy-hang)
[275.112065] Starting subtest: query-forked-busy-hang
[275.112986] Starting dynamic subtest: pipe-A-eDP-1
[301.093064] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.979s)
[301.103461] Starting dynamic subtest: pipe-D-eDP-1
[316.134912] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s)
[316.135991] Subtest query-forked-busy-hang: SUCCESS (41.022s)
[316.969563] [061/155] (707s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[317.062495] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc
[317.064486] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[317.198276] [062/155] (706s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[317.302586] Starting subtest: x-tiled-8bpp-rotate-0
[318.572046] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.269s)
[318.659753] [063/155] (705s left) kms_setmode (basic-clone-single-crtc)
[318.709048] Starting subtest: basic-clone-single-crtc
[318.712933] Subtest basic-clone-single-crtc: SKIP (0.000s)
[318.801166] [064/155] (705s left) kms_feature_discovery (psr2)
[318.883412] Starting subtest: psr2
[318.884425] Subtest psr2: SUCCESS (0.000s)
[318.963321] [065/155] (705s left) gem_exec_schedule (thriceslice)
[319.030945] Starting subtest: thriceslice
[319.031918] Starting dynamic subtest: rcs0
[319.081824] Dynamic subtest rcs0: SUCCESS (0.051s)
[319.096055] Starting dynamic subtest: bcs0
[319.135766] Dynamic subtest bcs0: SUCCESS (0.052s)
[319.148567] Starting dynamic subtest: vcs0
[319.187494] Dynamic subtest vcs0: SUCCESS (0.050s)
[319.199312] Starting dynamic subtest: vcs1
[319.217583] Dynamic subtest vcs1: SUCCESS (0.029s)
[319.226948] Starting dynamic subtest: vecs0
[319.248528] Dynamic subtest vecs0: SUCCESS (0.030s)
[319.256338] Starting dynamic subtest: ccs0
[319.279878] Dynamic subtest ccs0: SUCCESS (0.030s)
[319.280944] Subtest thriceslice: SUCCESS (0.250s)
[319.575865] [066/155] (704s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[319.672785] Starting subtest: psr2-overlay-plane-update-continuous-sf
[319.673953] Starting dynamic subtest: pipe-A-eDP-1
[320.800743] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.127s)
[320.809535] Starting dynamic subtest: pipe-B-eDP-1
[322.532481] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.730s)
[322.533566] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.860s)
[323.347246] [067/155] (700s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[323.446261] Starting subtest: fbcpsrhdr-tiling-4
[323.448056] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[323.553378] [068/155] (700s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[323.657272] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[323.658971] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[323.755262] [069/155] (700s left) gem_exec_whisper (basic-queues-all)
[323.805903] Starting subtest: basic-queues-all
[334.484565] Subtest basic-queues-all: SUCCESS (10.675s)
[334.675362] [070/155] (689s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[334.771134] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[334.772872] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[334.876291] [071/155] (689s left) i915_suspend (basic-s3-without-i915)
[334.908370] Starting subtest: basic-s3-without-i915
[337.480503] Subtest basic-s3-without-i915: SKIP (2.562s)
[339.124684] [072/155] (685s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[339.220121] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[339.221339] Starting dynamic subtest: pipe-A-default-mode
[340.394187] Dynamic subtest pipe-A-default-mode: SKIP (1.174s)
[340.396017] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.176s)
[340.555123] [073/155] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[340.641224] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[340.642926] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[340.744148] [074/155] (683s left) kms_color (gamma)
[340.833059] Starting subtest: gamma
[340.833908] Starting dynamic subtest: pipe-A-eDP-1
[341.544199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[341.554301] Starting dynamic subtest: pipe-B-eDP-1
[342.984662] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[342.992531] Starting dynamic subtest: pipe-C-eDP-1
[344.368724] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[344.377023] Starting dynamic subtest: pipe-D-eDP-1
[345.697217] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[345.698163] Subtest gamma: SUCCESS (4.864s)
[346.491508] [075/155] (678s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[346.589529] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[346.591194] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[346.674209] [076/155] (677s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render)
[346.763824] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render
[346.765623] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[346.859125] [077/155] (677s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[346.951414] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[346.953383] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[347.057564] [078/155] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[347.160122] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[347.162032] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[347.248072] [079/155] (677s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[347.290805] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[347.292768] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[347.468864] [080/155] (677s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[347.514338] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[347.567056] [081/155] (677s left) gem_exec_basic (basic)
[347.617502] Starting subtest: basic
[347.618717] Starting dynamic subtest: rcs0-smem
[347.621597] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[347.634521] Starting dynamic subtest: bcs0-smem
[347.635564] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[347.643567] Starting dynamic subtest: vcs0-smem
[347.644538] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[347.652248] Starting dynamic subtest: vcs1-smem
[347.653163] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[347.660653] Starting dynamic subtest: vecs0-smem
[347.661751] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[347.669410] Starting dynamic subtest: ccs0-smem
[347.670431] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[347.671409] Subtest basic: SUCCESS (0.019s)
[349.313566] [082/155] (675s left) kms_psr (psr-sprite-mmap-gtt)
[349.407988] Starting subtest: psr-sprite-mmap-gtt
[349.409030] Starting dynamic subtest: eDP-1
[350.818209] Dynamic subtest eDP-1: SKIP (1.400s)
[350.820183] Subtest psr-sprite-mmap-gtt: SKIP (1.402s)
[351.007442] [083/155] (673s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render)
[351.095929] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render
[351.097770] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[351.195564] [084/155] (673s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[351.247581] Starting subtest: etime-multi-wait-all-for-submit-submitted
[351.350890] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[351.423976] [085/155] (673s left) i915_drm_fdinfo (busy-hang)
[351.463167] Starting subtest: busy-hang
[351.464550] Starting dynamic subtest: rcs0
[351.494519] Dynamic subtest rcs0: SKIP (0.031s)
[351.504661] Starting dynamic subtest: bcs0
[351.506604] Dynamic subtest bcs0: SKIP (0.001s)
[351.514367] Starting dynamic subtest: vcs0
[351.516322] Dynamic subtest vcs0: SKIP (0.000s)
[351.523686] Starting dynamic subtest: vcs1
[351.525278] Dynamic subtest vcs1: SKIP (0.000s)
[351.532635] Starting dynamic subtest: vecs0
[351.534200] Dynamic subtest vecs0: SKIP (0.000s)
[351.541270] Starting dynamic subtest: ccs0
[351.543178] Dynamic subtest ccs0: SKIP (0.000s)
[351.545331] Subtest busy-hang: SKIP (0.037s)
[351.577354] [086/155] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[351.667831] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[351.669482] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[351.788148] [087/155] (673s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[351.875700] Starting subtest: fbc-psr-cursor-mmap-gtt
[351.876789] Starting dynamic subtest: eDP-1
[351.878956] Dynamic subtest eDP-1: SKIP (0.000s)
[351.880754] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[351.953213] [088/155] (673s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[352.058673] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[352.060462] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[352.148385] [089/155] (672s left) gem_softpin (safe-alignment)
[352.208556] Starting subtest: safe-alignment
[352.235505] Subtest safe-alignment: SUCCESS (0.027s)
[353.338993] [090/155] (671s left) syncobj_wait (invalid-signal-illegal-handle)
[353.387852] Starting subtest: invalid-signal-illegal-handle
[353.388927] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[353.486725] [091/155] (671s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[353.584935] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[353.586586] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[353.676857] [092/155] (671s left) gem_tiled_blits (basic)
[353.728119] Subtest basic: SKIP (0.000s)
[353.789900] [093/155] (671s left) perf (polling-small-buf)
[353.936383] Starting subtest: polling-small-buf
[354.024925] Subtest polling-small-buf: SUCCESS (0.089s)
[354.069689] [094/155] (671s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[354.161206] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[354.162936] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[354.262447] [095/155] (670s left) gem_exec_balancer (bonded-false-hang)
[354.526177] Starting subtest: bonded-false-hang
[354.528233] Subtest bonded-false-hang: SKIP (0.000s)
[354.609943] [096/155] (670s left) gem_mmap_offset (partial-unmap)
[354.669270] Starting subtest: partial-unmap
[354.670344] Starting dynamic subtest: smem0
[355.185885] Dynamic subtest smem0: SUCCESS (0.507s)
[355.187337] Subtest partial-unmap: SUCCESS (0.508s)
[355.282854] [097/155] (670s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[355.340273] Starting subtest: multi-wait-available-unsubmitted-signaled
[355.341358] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[355.431775] [098/155] (669s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[355.523452] Starting subtest: bad-pixel-format-yf-tiled-ccs
[355.524416] Starting dynamic subtest: pipe-A-eDP-1
[355.533346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.541243] Starting dynamic subtest: pipe-B-eDP-1
[355.549884] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.557831] Starting dynamic subtest: pipe-C-eDP-1
[355.565798] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.573836] Starting dynamic subtest: pipe-D-eDP-1
[355.582154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.583733] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[357.808676] [099/155] (667s left) gen9_exec_parse (shadow-peek)
[357.864778] Subtest shadow-peek: SKIP (0.000s)
[357.935587] [100/155] (667s left) dumb_buffer (invalid-bpp)
[357.983592] Starting subtest: invalid-bpp
[357.984527] Subtest invalid-bpp: SUCCESS (0.000s)
[358.072685] [101/155] (667s left) kms_prop_blob (invalid-get-prop-any)
[358.127916] Starting subtest: invalid-get-prop-any
[358.128875] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[358.240221] [102/155] (667s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[358.345720] Starting subtest: yf-tiled-8bpp-rotate-180
[358.347779] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[358.433708] [103/155] (667s left) gem_exec_whisper (basic-queues-priority)
[358.493190] Starting subtest: basic-queues-priority
[381.544663] Subtest basic-queues-priority: SUCCESS (23.039s)
[381.714606] [104/155] (643s left) gen3_render_tiledy_blits
[381.822497] [105/155] (643s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[381.924643] Starting subtest: 4-tiled-16bpp-rotate-0
[383.281844] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.357s)
[383.411226] [106/155] (642s left) kms_chamelium_color (ctm-max)
[383.510034] Subtest ctm-max: SKIP (0.000s)
[383.550582] [107/155] (642s left) kms_psr (pr-primary-blt)
[383.629310] Starting subtest: pr-primary-blt
[383.630975] Subtest pr-primary-blt: SKIP (0.000s)
[383.698017] [108/155] (641s left) kms_content_protection (content-type-change)
[383.832284] Starting subtest: content-type-change
[383.834118] Subtest content-type-change: SKIP (0.000s)
[383.958754] [109/155] (641s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[384.057498] Starting subtest: psr-rgb101010-draw-blt
[391.534792] Subtest psr-rgb101010-draw-blt: SUCCESS (7.479s)
[391.646620] [110/155] (634s left) kms_psr (fbc-pr-dpms)
[391.734024] Starting subtest: fbc-pr-dpms
[391.735746] Subtest fbc-pr-dpms: SKIP (0.000s)
[391.804379] [111/155] (633s left) gem_ctx_isolation (dirty-create)
[391.858363] Starting subtest: dirty-create
[391.859516] Starting dynamic subtest: rcs0
[392.059943] Dynamic subtest rcs0: SUCCESS (0.201s)
[392.069210] Starting dynamic subtest: bcs0
[392.261054] Dynamic subtest bcs0: SUCCESS (0.200s)
[392.272572] Starting dynamic subtest: vcs0
[392.483452] Dynamic subtest vcs0: SUCCESS (0.222s)
[392.492113] Starting dynamic subtest: vcs1
[394.531719] Dynamic subtest vcs1: SUCCESS (2.047s)
[394.540622] Starting dynamic subtest: vecs0
[396.518849] Dynamic subtest vecs0: SUCCESS (1.985s)
[396.529598] Starting dynamic subtest: ccs0
[398.528573] Dynamic subtest ccs0: SUCCESS (2.010s)
[398.529629] Subtest dirty-create: SUCCESS (6.670s)
[398.749876] [112/155] (627s left) gem_exec_fence (submit67)
[398.927571] Starting subtest: submit67
[398.929742] Subtest submit67: SKIP (0.000s)
[400.426094] [113/155] (625s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[400.552983] Starting subtest: cursor-vs-flip-varying-size
[432.009636] Subtest cursor-vs-flip-varying-size: SUCCESS (31.454s)
[432.873545] [114/155] (593s left) perf (rc6-disable)
[432.955251] Starting subtest: rc6-disable
[433.137479] Subtest rc6-disable: SUCCESS (0.181s)
[433.176255] [115/155] (592s left) perf (global-sseu-config-invalid)
[433.247399] Starting subtest: global-sseu-config-invalid
[433.249214] Subtest global-sseu-config-invalid: SKIP (0.000s)
[433.285644] [116/155] (592s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[433.383201] Starting subtest: plane-scaler-unity-scaling-with-rotation
[433.384057] Starting dynamic subtest: pipe-A
[433.611183] Dynamic subtest pipe-A: SUCCESS (0.228s)
[433.620058] Starting dynamic subtest: pipe-B
[434.956174] Dynamic subtest pipe-B: SUCCESS (1.344s)
[434.966370] Starting dynamic subtest: pipe-C
[436.271585] Dynamic subtest pipe-C: SUCCESS (1.314s)
[436.280437] Starting dynamic subtest: pipe-D
[437.611164] Dynamic subtest pipe-D: SUCCESS (1.338s)
[437.612173] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.229s)
[438.777692] [117/155] (587s left) vgem_basic (sysfs)
[438.811233] Starting subtest: sysfs
[438.812507] Subtest sysfs: SUCCESS (0.000s)
[438.878179] [118/155] (587s left) kms_frontbuffer_tracking (hdr-1p-rte)
[438.973534] Starting subtest: hdr-1p-rte
[438.975210] Subtest hdr-1p-rte: SKIP (0.000s)
[439.058925] [119/155] (587s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[439.140819] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[439.142376] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[439.233984] [120/155] (586s left) kms_cursor_legacy (torture-move)
[439.345502] Starting subtest: torture-move
[439.346317] Starting dynamic subtest: pipe-A
[445.703433] Dynamic subtest pipe-A: SUCCESS (6.311s)
[445.714563] Starting dynamic subtest: pipe-B
[452.713443] Dynamic subtest pipe-B: SUCCESS (7.042s)
[452.734618] Starting dynamic subtest: pipe-C
[459.060364] Dynamic subtest pipe-C: SUCCESS (6.344s)
[459.078668] Starting dynamic subtest: pipe-D
[466.316989] Dynamic subtest pipe-D: SUCCESS (7.253s)
[466.327506] Starting dynamic subtest: all-pipes
[472.673013] Dynamic subtest all-pipes: SUCCESS (6.353s)
[472.674016] Subtest torture-move: SUCCESS (33.317s)
[472.819638] [121/155] (553s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[472.916168] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[472.917748] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[473.013941] [122/155] (553s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[473.105216] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[480.274763] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.171s)
[480.386260] [123/155] (545s left) gem_mmap_gtt (cpuset-big-copy-xy)
[480.442714] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[480.494233] [124/155] (545s left) prime_mmap (test_forked)
[480.552282] Starting subtest: test_forked
[480.553436] Starting dynamic subtest: test_forked-smem
[480.596581] Dynamic subtest test_forked-smem: SUCCESS (0.045s)
[480.597767] Subtest test_forked: SUCCESS (0.045s)
[480.689831] [125/155] (545s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[480.786582] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[480.788480] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[480.880289] [126/155] (545s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[480.968660] Starting subtest: hdr-modesetfrombusy
[480.970521] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[481.050090] [127/155] (545s left) gem_ctx_param (get-priority-new-ctx)
[481.099497] Starting subtest: get-priority-new-ctx
[481.101582] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[481.204910] [128/155] (545s left) gem_exec_flush (basic-wb-rw-before-default)
[481.272346] Starting subtest: basic-wb-rw-before-default
[486.729206] Subtest basic-wb-rw-before-default: SUCCESS (5.457s)
[486.924243] [129/155] (539s left) kms_busy (extended-modeset-hang-oldfb)
[487.021099] Starting subtest: extended-modeset-hang-oldfb
[487.022089] Starting dynamic subtest: pipe-A
[498.763439] Dynamic subtest pipe-A: SUCCESS (11.738s)
[498.772205] Starting dynamic subtest: pipe-D
[511.351191] Dynamic subtest pipe-D: SUCCESS (12.587s)
[511.352183] Subtest extended-modeset-hang-oldfb: SUCCESS (24.329s)
[512.224137] [130/155] (514s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[512.315067] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[512.315859] Starting dynamic subtest: pipe-A-eDP-1
[512.336512] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[512.345538] Starting dynamic subtest: pipe-B-eDP-1
[512.366810] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[512.375279] Starting dynamic subtest: pipe-C-eDP-1
[512.396035] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[512.404745] Starting dynamic subtest: pipe-D-eDP-1
[512.424971] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[512.426536] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[514.573270] [131/155] (511s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[514.623192] Starting subtest: framebuffer-vs-set-tiling
[514.624918] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[514.741204] [132/155] (511s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[514.829866] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[514.831788] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[514.915981] [133/155] (511s left) kms_hdr (invalid-hdr)
[515.004174] Starting subtest: invalid-hdr
[515.004988] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[520.236152] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.229s)
[520.258050] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[524.422054] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.162s)
[524.426202] Subtest invalid-hdr: SUCCESS (9.422s)
[524.538543] [134/155] (502s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[524.643611] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[524.645489] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[524.732640] [135/155] (501s left) kms_vblank (ts-continuation-modeset-hang)
[524.824168] Starting subtest: ts-continuation-modeset-hang
[524.824962] Starting dynamic subtest: pipe-A-eDP-1
[552.090871] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.264s)
[552.102218] Starting dynamic subtest: pipe-D-eDP-1
[567.142395] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.049s)
[567.143318] Subtest ts-continuation-modeset-hang: SUCCESS (42.317s)
[567.963431] [136/155] (458s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[568.054588] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[568.056259] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[568.154568] [137/155] (458s left) gem_workarounds (basic-read-fd)
[568.218412] Starting subtest: basic-read-fd
[568.229937] Subtest basic-read-fd: SUCCESS (0.012s)
[568.347683] [138/155] (458s left) gem_pxp (create-valid-protected-context)
[568.461468] Starting subtest: create-valid-protected-context
[568.462804] Subtest create-valid-protected-context: SUCCESS (0.002s)
[568.584285] [139/155] (458s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[568.672201] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[568.674823] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[568.761852] [140/155] (458s left) kms_chamelium_hpd (common-hpd-after-suspend)
[569.145519] Subtest common-hpd-after-suspend: SKIP (0.000s)
[569.979598] [141/155] (456s left) syncobj_timeline (etime-single-wait-submitted)
[570.033035] Starting subtest: etime-single-wait-submitted
[570.134518] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[570.220312] [142/155] (456s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[570.379608] Starting subtest: cursor-rapid-movement-32x10
[570.424617] Subtest cursor-rapid-movement-32x10: SKIP (0.043s)
[570.665374] [143/155] (456s left) kms_fbcon_fbt (fbc)
[570.717171] Starting subtest: fbc
[577.060944] Subtest fbc: SUCCESS (6.336s)
[578.144761] [144/155] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[578.239095] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[587.248068] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (9.011s)
[587.356212] [145/155] (439s left) gem_mmap (short-mmap)
[587.400609] Subtest short-mmap: SKIP (0.000s)
[587.453753] [146/155] (439s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[587.535432] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[587.537422] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[587.617150] [147/155] (439s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[587.712311] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[587.713792] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[587.793254] [148/155] (439s left) kms_cursor_edge_walk (64x64-right-edge)
[587.879226] Starting subtest: 64x64-right-edge
[587.880086] Starting dynamic subtest: pipe-A-eDP-1
[591.319505] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s)
[591.331042] Starting dynamic subtest: pipe-D-eDP-1
[594.539703] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.219s)
[594.540874] Subtest 64x64-right-edge: SUCCESS (6.659s)
[595.337255] [149/155] (431s left) api_intel_bb (lot-of-buffers)
[595.387867] Starting subtest: lot-of-buffers
[596.496085] Subtest lot-of-buffers: SUCCESS (1.100s)
[596.827548] [150/155] (430s left) kms_psr (fbc-psr2-cursor-blt)
[596.923564] Starting subtest: fbc-psr2-cursor-blt
[596.924444] Starting dynamic subtest: eDP-1
[596.926190] Dynamic subtest eDP-1: SKIP (0.000s)
[596.927796] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[596.995011] [151/155] (430s left) gem_partial_pwrite_pread (write-snoop)
[597.040315] Subtest write-snoop: SKIP (0.000s)
[597.103125] [152/155] (430s left) gen7_exec_parse (basic-offset)
[597.156517] Subtest basic-offset: SKIP (0.000s)
[597.227109] [153/155] (430s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[597.279479] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[597.280262] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[597.395271] [154/155] (429s left) gem_ccs (block-multicopy-inplace)
[597.441369] Starting subtest: block-multicopy-inplace
[597.443096] Subtest block-multicopy-inplace: SKIP (0.000s)
[597.536414] [155/155] (429s left) kms_plane_multiple (2x-tiling-yf)
[597.631108] Starting subtest: 2x-tiling-yf
[597.633287] Subtest 2x-tiling-yf: SKIP (0.000s)
[597.698974] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: syncobj_eventfd
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_create
results: parsing output: 12/ for test: kms_plane_lowres
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: i915_pm_rps
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_async_flips
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_chamelium_edid
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_ctx_shared
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: kms_mmap_write_crc
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: gem_linear_blits
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: sysfs_timeslice_duration
results: parsing output: 55/ for test: i915_drm_fdinfo
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: prime_self_import
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_setmode
results: parsing output: 63/ for test: kms_feature_discovery
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: i915_suspend
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_color
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_pipe_b_c_ivb
results: parsing output: 80/ for test: gem_exec_basic
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_tiled_blits
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: gem_mmap_offset
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: dumb_buffer
results: parsing output: 100/ for test: kms_prop_blob
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_whisper
results: parsing output: 103/ for test: gen3_render_tiledy_blits
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_chamelium_color
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_ctx_isolation
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: vgem_basic
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_cursor_legacy
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: gem_exec_flush
results: parsing output: 128/ for test: kms_busy
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_hdr
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_vblank
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_workarounds
results: parsing output: 137/ for test: gem_pxp
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_chamelium_hpd
results: parsing output: 140/ for test: syncobj_timeline
results: parsing output: 141/ for test: kms_cursor_crc
results: parsing output: 142/ for test: kms_fbcon_fbt
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: gem_mmap
results: parsing output: 145/ for test: kms_flip_scaled_crc
results: parsing output: 146/ for test: kms_psr2_sf
results: parsing output: 147/ for test: kms_cursor_edge_walk
results: parsing output: 148/ for test: api_intel_bb
results: parsing output: 149/ for test: kms_psr
results: parsing output: 150/ for test: gem_partial_pwrite_pread
results: parsing output: 151/ for test: gen7_exec_parse
results: parsing output: 152/ for test: syncobj_wait
results: parsing output: 153/ for test: gem_ccs
results: parsing output: 154/ for test: kms_plane_multiple
Done.