[65.339215] Initializing watchdogs
[65.339293]   /dev/watchdog0
[65.365791] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[65.379169] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.383899] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.386337] [001/131] (960s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[67.500553] Starting subtest: x-tiled-32bpp-rotate-90
[67.719169] Subtest x-tiled-32bpp-rotate-90: SKIP (0.218s)
[67.855656] [002/131] (958s left) kms_cursor_crc (cursor-size-hints)
[69.889272] Starting subtest: cursor-size-hints
[69.890207] Starting dynamic subtest: pipe-A-HDMI-A-3
[70.473148] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.585s)
[70.480671] Starting dynamic subtest: pipe-D-HDMI-A-3
[70.867561] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.394s)
[70.868427] Subtest cursor-size-hints: SUCCESS (0.982s)
[72.015483] [003/131] (953s left) kms_pm_rpm (fences)
[77.014968] Starting subtest: fences
[77.019432] Subtest fences: SKIP (0.000s)
[78.237837] [004/131] (947s left) gem_mmap_wc (write-read)
[78.301776] Subtest write-read: SKIP (0.000s)
[78.367448] [005/131] (947s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[80.365430] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[80.367130] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[80.564821] [006/131] (945s left) gem_mmap_gtt (cpuset-big-copy-odd)
[80.617200] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[80.681127] [007/131] (945s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[80.732156] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[80.733101] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[80.859036] [008/131] (945s left) gem_exercise_blt (fast-copy-emit)
[80.915507] Starting subtest: fast-copy-emit
[80.916407] Starting dynamic subtest: linear-smem-smem-emit
[80.949597] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.034s)
[80.956491] Starting dynamic subtest: linear-smem-lmem0-emit
[80.965405] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.016s)
[80.972296] Starting dynamic subtest: linear-lmem0-smem-emit
[81.025604] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.060s)
[81.032516] Starting dynamic subtest: linear-lmem0-lmem0-emit
[81.083746] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.058s)
[81.090612] Starting dynamic subtest: ymajor-smem-smem-emit
[81.098543] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.015s)
[81.105479] Starting dynamic subtest: ymajor-smem-lmem0-emit
[81.113079] Dynamic subtest ymajor-smem-lmem0-emit: SUCCESS (0.014s)
[81.119998] Starting dynamic subtest: ymajor-lmem0-smem-emit
[81.173237] Dynamic subtest ymajor-lmem0-smem-emit: SUCCESS (0.060s)
[81.179909] Starting dynamic subtest: ymajor-lmem0-lmem0-emit
[81.231143] Dynamic subtest ymajor-lmem0-lmem0-emit: SUCCESS (0.058s)
[81.237888] Starting dynamic subtest: tile4-smem-smem-emit
[81.245681] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.014s)
[81.252612] Starting dynamic subtest: tile4-smem-lmem0-emit
[81.260268] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s)
[81.267181] Starting dynamic subtest: tile4-lmem0-smem-emit
[81.320378] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.060s)
[81.327284] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[81.379248] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.059s)
[81.386154] Starting dynamic subtest: tile64-smem-smem-emit
[81.394710] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[81.401600] Starting dynamic subtest: tile64-smem-lmem0-emit
[81.409186] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s)
[81.416142] Starting dynamic subtest: tile64-lmem0-smem-emit
[81.468891] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.060s)
[81.475815] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[81.527890] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.059s)
[81.528900] Subtest fast-copy-emit: SUCCESS (0.613s)
[81.722956] [009/131] (944s left) gem_tiled_fence_blits (basic)
[81.778366] Subtest basic: SKIP (0.000s)
[81.846870] [010/131] (944s left) kms_lease (implicit-plane-lease)
[83.842204] Starting subtest: implicit-plane-lease
[83.845183] Subtest implicit-plane-lease: SUCCESS (0.002s)
[83.958487] [011/131] (942s left) syncobj_wait (invalid-reset-bad-pad)
[84.031113] Starting subtest: invalid-reset-bad-pad
[84.032025] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[84.186537] [012/131] (942s left) gem_wait (write-wait)
[84.254536] Starting subtest: write-wait
[84.255519] Starting dynamic subtest: all-engines
[85.405809] Dynamic subtest all-engines: SUCCESS (1.151s)
[85.416626] Starting dynamic subtest: rcs0
[86.470069] Dynamic subtest rcs0: SUCCESS (1.063s)
[86.482228] Starting dynamic subtest: bcs0
[87.532068] Dynamic subtest bcs0: SUCCESS (1.061s)
[87.544242] Starting dynamic subtest: vcs0
[88.591900] Dynamic subtest vcs0: SUCCESS (1.059s)
[88.603542] Starting dynamic subtest: vcs1
[89.652000] Dynamic subtest vcs1: SUCCESS (1.059s)
[89.661925] Starting dynamic subtest: vecs0
[90.712895] Dynamic subtest vecs0: SUCCESS (1.060s)
[90.715235] Subtest write-wait: SUCCESS (6.457s)
[91.061487] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[91.064653] [013/131] (935s left) gem_ctx_persistence (userptr)
[91.120599] Starting subtest: userptr
[91.305033] Subtest userptr: SUCCESS (0.183s)
[91.469299] [014/131] (935s left) perf_pmu (busy-accuracy-2)
[91.523916] Starting subtest: busy-accuracy-2
[91.524903] Starting dynamic subtest: rcs0
[94.579716] Dynamic subtest rcs0: SUCCESS (3.055s)
[94.587974] Starting dynamic subtest: bcs0
[97.640905] Dynamic subtest bcs0: SUCCESS (3.061s)
[97.649333] Starting dynamic subtest: vcs0
[100.695961] Dynamic subtest vcs0: SUCCESS (3.055s)
[100.704259] Starting dynamic subtest: vcs1
[103.751153] Dynamic subtest vcs1: SUCCESS (3.055s)
[103.759540] Starting dynamic subtest: vecs0
[106.808297] Dynamic subtest vecs0: SUCCESS (3.057s)
[106.809418] Subtest busy-accuracy-2: SUCCESS (15.283s)
[106.957941] [015/131] (919s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[107.486196] Starting subtest: syncobj-timeline-invalid-flags
[107.487364] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[107.778632] [016/131] (919s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[109.777280] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[109.851164] [017/131] (917s left) kms_plane_cursor (viewport)
[111.849342] Starting subtest: viewport
[111.852229] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64
[115.395410] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.545s)
[115.474477] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128
[118.961745] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.499s)
[119.041279] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256
[122.544661] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.515s)
[122.643591] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64
[126.156060] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.520s)
[126.216583] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128
[129.688993] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.483s)
[129.749953] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256
[133.238213] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.499s)
[133.321391] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64
[136.838444] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.525s)
[136.910752] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128
[140.421536] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.532s)
[140.483197] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256
[144.004618] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.532s)
[144.108829] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64
[147.661205] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.562s)
[147.722200] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128
[151.210577] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.499s)
[151.270408] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256
[154.726879] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.466s)
[154.835525] Subtest viewport: SUCCESS (42.986s)
[155.017049] [018/131] (872s left) kms_fence_pin_leak
[157.090561] [019/131] (870s left) debugfs_test (read_all_entries_display_on)
[159.092379] Starting subtest: read_all_entries_display_on
[159.636217] Subtest read_all_entries_display_on: SUCCESS (0.544s)
[159.889083] [020/131] (867s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[161.882385] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[161.884352] Starting dynamic subtest: pipe-A-HDMI-A-3
[162.470063] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.583s)
[162.478382] Starting dynamic subtest: pipe-B-HDMI-A-3
[163.060895] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.589s)
[163.069399] Starting dynamic subtest: pipe-C-HDMI-A-3
[163.650893] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.588s)
[163.659276] Starting dynamic subtest: pipe-D-HDMI-A-3
[164.242403] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.589s)
[164.243604] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.356s)
[164.418384] [021/131] (862s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[166.418030] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[166.419904] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[166.599153] [022/131] (860s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[168.597325] Starting subtest: primary-4-tiled-reflect-x-180
[168.693965] Subtest primary-4-tiled-reflect-x-180: SKIP (0.095s)
[168.916950] [023/131] (858s left) gem_render_copy (yf-tiled-to-vebox-linear)
[168.975466] Starting subtest: yf-tiled-to-vebox-linear
[168.976352] Starting dynamic subtest: smem
[169.050738] Dynamic subtest smem: SUCCESS (0.075s)
[169.059136] Starting dynamic subtest: lmem0
[169.183821] Dynamic subtest lmem0: SUCCESS (0.128s)
[169.184981] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.204s)
[169.453944] [024/131] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[171.456269] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[171.458142] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[171.671496] [025/131] (856s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[173.664378] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[173.666349] Starting dynamic subtest: pipe-A-HDMI-A-3
[173.674455] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[173.682748] Starting dynamic subtest: pipe-B-HDMI-A-3
[173.690890] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[173.698907] Starting dynamic subtest: pipe-C-HDMI-A-3
[173.707449] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[173.715487] Starting dynamic subtest: pipe-D-HDMI-A-3
[173.724184] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[173.725947] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[173.898099] [026/131] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[175.902371] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[175.904323] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[176.113102] [027/131] (851s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[178.109450] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[178.111190] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[178.312658] [028/131] (849s left) gem_exec_schedule (manyslice)
[178.378931] Starting subtest: manyslice
[178.379919] Starting dynamic subtest: rcs0
[182.910113] Dynamic subtest rcs0: SUCCESS (4.527s)
[182.918891] Starting dynamic subtest: bcs0
[187.815314] Dynamic subtest bcs0: SUCCESS (4.904s)
[187.824136] Starting dynamic subtest: vcs0
[192.313693] Dynamic subtest vcs0: SUCCESS (4.497s)
[192.324763] Starting dynamic subtest: vcs1
[197.308172] Dynamic subtest vcs1: SUCCESS (4.994s)
[197.316923] Starting dynamic subtest: vecs0
[202.294309] Dynamic subtest vecs0: SUCCESS (4.985s)
[202.295321] Subtest manyslice: SUCCESS (23.912s)
[202.684219] [029/131] (825s left) syncobj_timeline (invalid-wait-bad-flags)
[202.734230] Starting subtest: invalid-wait-bad-flags
[202.735238] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[202.872419] [030/131] (825s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[204.870808] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[207.393305] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (2.521s)
[207.600274] [031/131] (820s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[209.594696] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[209.596949] Starting dynamic subtest: pipe-A-valid-mode
[212.087216] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.491s)
[212.088106] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SUCCESS (2.493s)
[212.275479] [032/131] (816s left) gem_exec_reloc (basic-range-active)
[212.331217] Subtest basic-range-active: SKIP (0.000s)
[212.421510] [033/131] (816s left) kms_cursor_crc (cursor-offscreen-512x512)
[214.617880] Starting subtest: cursor-offscreen-512x512
[214.621024] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[214.902717] [034/131] (813s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[216.916428] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[216.918271] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[217.112743] [035/131] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[219.114032] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[219.115797] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[219.317894] [036/131] (809s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[219.368901] Starting subtest: single-wait-for-submit-available-signaled
[219.369886] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[219.489961] [037/131] (809s left) gem_exec_fence (basic-busy)
[219.671430] Starting subtest: basic-busy
[219.672409] Starting dynamic subtest: rcs0
[219.763152] Dynamic subtest rcs0: SUCCESS (0.091s)
[219.778584] Starting dynamic subtest: bcs0
[219.819611] Dynamic subtest bcs0: SUCCESS (0.054s)
[219.859586] Starting dynamic subtest: vcs0
[219.877282] Dynamic subtest vcs0: SUCCESS (0.055s)
[219.891748] Starting dynamic subtest: vcs1
[219.931649] Dynamic subtest vcs1: SUCCESS (0.053s)
[219.962530] Starting dynamic subtest: vecs0
[219.990292] Dynamic subtest vecs0: SUCCESS (0.057s)
[219.991578] Subtest basic-busy: SUCCESS (0.319s)
[220.656717] [038/131] (808s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[222.654637] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[222.657150] Starting dynamic subtest: pipe-A-HDMI-A-3
[222.661233] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[222.669936] Starting dynamic subtest: pipe-B-HDMI-A-3
[222.674177] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[222.682735] Starting dynamic subtest: pipe-C-HDMI-A-3
[222.686508] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[222.694648] Starting dynamic subtest: pipe-D-HDMI-A-3
[222.698518] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[222.700530] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[222.884638] [039/131] (806s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[222.937307] Starting subtest: invalid-single-wait-all-unsubmitted
[222.938261] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[223.049028] [040/131] (806s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[225.049420] Starting subtest: fbcpsr-rgb565-draw-pwrite
[225.051130] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[225.284232] [041/131] (804s left) gem_softpin (full)
[225.339386] Starting subtest: full
[225.356955] Subtest full: SUCCESS (0.017s)
[225.555311] [042/131] (803s left) gem_exec_reloc (basic-gtt-cpu-active)
[225.611157] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[225.715895] [043/131] (803s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[227.714261] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[227.716339] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[227.902243] [044/131] (801s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[229.915602] Starting subtest: y-tiled-16bpp-rotate-180
[231.646435] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.726s)
[231.836725] [045/131] (797s left) prime_self_import (export-vs-gem_close-race)
[231.886435] Starting subtest: export-vs-gem_close-race
[236.922309] Subtest export-vs-gem_close-race: SUCCESS (5.035s)
[237.088298] [046/131] (792s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[237.153538] Starting subtest: single-wait-all-for-submit-available-submitted
[237.154457] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[237.300997] [047/131] (792s left) sysfs_timeslice_duration (duration)
[237.357242] Starting subtest: duration
[237.358118] Starting dynamic subtest: vecs0
[250.490358] Dynamic subtest vecs0: SUCCESS (13.132s)
[250.502622] Starting dynamic subtest: vcs0
[263.650320] Dynamic subtest vcs0: SUCCESS (13.155s)
[263.662584] Starting dynamic subtest: bcs0
[276.778422] Dynamic subtest bcs0: SUCCESS (13.125s)
[276.790142] Starting dynamic subtest: rcs0
[289.942874] Dynamic subtest rcs0: SUCCESS (13.162s)
[289.955210] Starting dynamic subtest: vcs1
[303.087698] Dynamic subtest vcs1: SUCCESS (13.141s)
[303.088980] Subtest duration: SUCCESS (65.732s)
[303.202042] [048/131] (726s left) kms_cursor_crc (cursor-random-64x64)
[305.286747] Starting subtest: cursor-random-64x64
[305.293176] Starting dynamic subtest: pipe-A-HDMI-A-3
[309.720599] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.427s)
[309.753334] Starting dynamic subtest: pipe-D-HDMI-A-3
[314.182416] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.437s)
[314.183360] Subtest cursor-random-64x64: SUCCESS (8.895s)
[314.659636] [049/131] (715s left) kms_psr (psr2-suspend)
[316.657274] Subtest psr2-suspend: SKIP (0.000s)
[316.743215] [050/131] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[318.752968] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[318.754963] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[318.950510] [051/131] (711s left) kms_writeback (writeback-pixel-formats)
[320.945160] Subtest writeback-pixel-formats: SKIP (0.000s)
[321.022466] [052/131] (709s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[323.015988] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[323.020135] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[323.162073] [053/131] (707s left) kms_chamelium_color (ctm-green-to-red)
[325.180043] Subtest ctm-green-to-red: SKIP (0.000s)
[325.252675] [054/131] (705s left) gem_exec_suspend (basic-s3)
[325.316928] Starting subtest: basic-S3
[325.317955] Starting dynamic subtest: smem
[353.976500] Dynamic subtest smem: SUCCESS (12.834s)
[353.986659] Starting dynamic subtest: lmem0
[382.867183] Dynamic subtest lmem0: SUCCESS (12.374s)
[382.868320] Subtest basic-S3: SUCCESS (25.210s)
[388.136392] [055/131] (679s left) gem_exec_nop (basic-sequential)
[388.202765] Starting subtest: basic-sequential
[391.948664] Subtest basic-sequential: SUCCESS (3.745s)
[392.196818] [056/131] (675s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[394.012192] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[394.014602] Starting dynamic subtest: pipe-A-HDMI-A-3
[394.023729] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[394.034493] Starting dynamic subtest: pipe-B-HDMI-A-3
[394.043494] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[394.053827] Starting dynamic subtest: pipe-C-HDMI-A-3
[394.063205] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[394.073216] Starting dynamic subtest: pipe-D-HDMI-A-3
[394.082522] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[394.084573] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.012s)
[394.255775] [057/131] (673s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[396.007256] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[396.008949] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[396.170036] [058/131] (672s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[396.242103] Starting subtest: y-tiled-to-vebox-yf-tiled
[396.243221] Starting dynamic subtest: smem
[396.330384] Dynamic subtest smem: SUCCESS (0.085s)
[396.340985] Starting dynamic subtest: lmem0
[397.114290] Dynamic subtest lmem0: SUCCESS (0.755s)
[397.115471] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.842s)
[397.393765] [059/131] (670s left) gem_mmap_offset (clear)
[397.445933] Starting subtest: clear
[397.446859] Starting dynamic subtest: lmem0
[419.390089] Dynamic subtest lmem0: SUCCESS (21.733s)
[419.400568] Starting dynamic subtest: smem0
[445.722870] Dynamic subtest smem0: SUCCESS (26.312s)
[445.725576] Subtest clear: SUCCESS (48.047s)
[445.951760] [060/131] (622s left) api_intel_allocator (alloc-simple)
[446.055124] Starting subtest: alloc-simple
[446.067931] Subtest alloc-simple: SUCCESS (0.013s)
[446.269897] [061/131] (622s left) i915_pm_freq_api (freq-suspend)
[446.333110] Starting subtest: freq-suspend
[446.334075] Starting dynamic subtest: gt0
[462.505678] Dynamic subtest gt0: SUCCESS (1.612s)
[462.506859] Subtest freq-suspend: SUCCESS (1.613s)
[470.131688] [062/131] (620s left) gem_workarounds (basic-read-context)
[470.205526] Starting subtest: basic-read-context
[470.229457] Subtest basic-read-context: SUCCESS (0.024s)
[470.428186] [063/131] (620s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[472.423249] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[472.425002] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[472.578361] [064/131] (617s left) kms_dsc (dsc-with-bpc-formats)
[474.589064] Starting subtest: dsc-with-bpc-formats
[474.636796] Subtest dsc-with-bpc-formats: SKIP (0.004s)
[474.743974] [065/131] (615s left) kms_atomic_interruptible (atomic-setmode)
[476.906417] Starting subtest: atomic-setmode
[476.911877] Starting dynamic subtest: pipe-A-HDMI-A-3
[483.205777] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.354s)
[483.206619] Subtest atomic-setmode: SUCCESS (6.364s)
[483.455992] [066/131] (607s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[485.505557] Starting subtest: yf-tiled-16bpp-rotate-0
[485.507443] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[485.741020] [067/131] (604s left) gem_exec_schedule (u-semaphore-resolve)
[485.811032] Starting subtest: u-semaphore-resolve
[485.861177] Subtest u-semaphore-resolve: SUCCESS (0.050s)
[486.348817] [068/131] (604s left) kms_pm_dc (dc5-dpms-negative)
[489.351675] Starting subtest: dc5-dpms-negative
[493.579783] Subtest dc5-dpms-negative: SUCCESS (4.234s)
[493.688470] [069/131] (597s left) kms_prop_blob (invalid-get-prop-any)
[493.742381] Starting subtest: invalid-get-prop-any
[493.743379] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[493.848486] [070/131] (597s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[495.847731] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[495.849543] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[495.999657] [071/131] (595s left) kms_chamelium_hpd (common-hpd-after-suspend)
[498.083119] Subtest common-hpd-after-suspend: SKIP (0.000s)
[498.194048] [072/131] (592s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[500.194312] Starting subtest: psr-rgb101010-draw-pwrite
[500.196308] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[500.412078] [073/131] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[502.415583] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[502.417570] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[502.637289] [074/131] (588s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[504.638298] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[504.640229] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[504.828426] [075/131] (586s left) kms_vblank (query-idle)
[506.825148] Starting subtest: query-idle
[506.827694] Starting dynamic subtest: pipe-A-HDMI-A-3
[509.173686] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.346s)
[509.188738] Starting dynamic subtest: pipe-D-HDMI-A-3
[511.349344] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.170s)
[511.350324] Subtest query-idle: SUCCESS (4.523s)
[511.514583] [076/131] (580s left) prime_self_import (basic-with_two_bos)
[511.563413] Starting subtest: basic-with_two_bos
[511.566834] Subtest basic-with_two_bos: SUCCESS (0.004s)
[511.718857] [077/131] (579s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[513.721655] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[513.723621] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[513.910716] [078/131] (577s left) gem_exec_balancer (persistence)
[514.298363] Starting subtest: persistence
[515.893685] Subtest persistence: SUCCESS (1.591s)
[516.052751] [079/131] (575s left) kms_fbcon_fbt (psr-suspend)
[516.106694] Starting subtest: psr-suspend
[516.108297] Subtest psr-suspend: SKIP (0.000s)
[516.297144] [080/131] (575s left) kms_addfb_basic (basic-x-tiled-legacy)
[516.348386] Starting subtest: basic-x-tiled-legacy
[516.350105] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[518.497156] [081/131] (573s left) api_intel_allocator (reserve-simple)
[518.548316] Starting subtest: reserve-simple
[518.561434] Subtest reserve-simple: SUCCESS (0.014s)
[518.764324] [082/131] (573s left) kms_flip (2x-modeset-vs-vblank-race)
[520.762682] Starting subtest: 2x-modeset-vs-vblank-race
[520.782979] Subtest 2x-modeset-vs-vblank-race: SKIP (0.019s)
[520.924173] [083/131] (571s left) kms_async_flips (async-flip-with-page-flip-events-atomic)
[522.924440] Starting subtest: async-flip-with-page-flip-events-atomic
[523.173437] Starting dynamic subtest: pipe-A-HDMI-A-3-y-rc-ccs
[525.461226] Dynamic subtest pipe-A-HDMI-A-3-y-rc-ccs: SUCCESS (2.284s)
[525.475688] Starting dynamic subtest: pipe-A-HDMI-A-3-y-rc-ccs-cc
[525.645019] Dynamic subtest pipe-A-HDMI-A-3-y-rc-ccs-cc: SKIP (0.184s)
[525.656586] Starting dynamic subtest: pipe-A-HDMI-A-3-y
[527.825906] Dynamic subtest pipe-A-HDMI-A-3-y: SUCCESS (2.177s)
[527.840261] Starting dynamic subtest: pipe-A-HDMI-A-3-x
[530.023667] Dynamic subtest pipe-A-HDMI-A-3-x: SUCCESS (2.194s)
[530.035216] Starting dynamic subtest: pipe-A-HDMI-A-3-linear
[532.207103] Dynamic subtest pipe-A-HDMI-A-3-linear: SUCCESS (2.182s)
[532.392479] Starting dynamic subtest: pipe-B-HDMI-A-3-y-rc-ccs
[534.605306] Dynamic subtest pipe-B-HDMI-A-3-y-rc-ccs: SUCCESS (2.219s)
[534.619503] Starting dynamic subtest: pipe-B-HDMI-A-3-y-rc-ccs-cc
[534.771755] Dynamic subtest pipe-B-HDMI-A-3-y-rc-ccs-cc: SKIP (0.167s)
[534.783296] Starting dynamic subtest: pipe-B-HDMI-A-3-y
[536.936284] Dynamic subtest pipe-B-HDMI-A-3-y: SUCCESS (2.160s)
[536.947696] Starting dynamic subtest: pipe-B-HDMI-A-3-x
[539.117589] Dynamic subtest pipe-B-HDMI-A-3-x: SUCCESS (2.177s)
[539.129471] Starting dynamic subtest: pipe-B-HDMI-A-3-linear
[541.283075] Dynamic subtest pipe-B-HDMI-A-3-linear: SUCCESS (2.164s)
[541.446951] Starting dynamic subtest: pipe-C-HDMI-A-3-y-rc-ccs
[543.674731] Dynamic subtest pipe-C-HDMI-A-3-y-rc-ccs: SUCCESS (2.234s)
[543.687973] Starting dynamic subtest: pipe-C-HDMI-A-3-y-rc-ccs-cc
[543.842666] Dynamic subtest pipe-C-HDMI-A-3-y-rc-ccs-cc: SKIP (0.167s)
[543.854017] Starting dynamic subtest: pipe-C-HDMI-A-3-y
[546.006546] Dynamic subtest pipe-C-HDMI-A-3-y: SUCCESS (2.160s)
[546.022894] Starting dynamic subtest: pipe-C-HDMI-A-3-x
[548.186966] Dynamic subtest pipe-C-HDMI-A-3-x: SUCCESS (2.176s)
[548.198807] Starting dynamic subtest: pipe-C-HDMI-A-3-linear
[550.352552] Dynamic subtest pipe-C-HDMI-A-3-linear: SUCCESS (2.165s)
[550.527510] Starting dynamic subtest: pipe-D-HDMI-A-3-y-rc-ccs
[552.750053] Dynamic subtest pipe-D-HDMI-A-3-y-rc-ccs: SUCCESS (2.229s)
[552.762492] Starting dynamic subtest: pipe-D-HDMI-A-3-y-rc-ccs-cc
[552.917398] Dynamic subtest pipe-D-HDMI-A-3-y-rc-ccs-cc: SKIP (0.167s)
[552.928529] Starting dynamic subtest: pipe-D-HDMI-A-3-y
[555.080883] Dynamic subtest pipe-D-HDMI-A-3-y: SUCCESS (2.160s)
[555.094940] Starting dynamic subtest: pipe-D-HDMI-A-3-x
[557.262045] Dynamic subtest pipe-D-HDMI-A-3-x: SUCCESS (2.179s)
[557.273505] Starting dynamic subtest: pipe-D-HDMI-A-3-linear
[559.427870] Dynamic subtest pipe-D-HDMI-A-3-linear: SUCCESS (2.165s)
[559.428946] Subtest async-flip-with-page-flip-events-atomic: SUCCESS (36.511s)
[559.756401] [084/131] (532s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[561.751749] Starting subtest: cursor-vs-flip-legacy
[592.631330] Subtest cursor-vs-flip-legacy: SUCCESS (30.873s)
[592.815410] [085/131] (499s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[594.829135] Starting subtest: 4-tiled-16bpp-rotate-90
[594.831346] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[595.044979] [086/131] (497s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[595.096886] Starting subtest: multi-wait-all-for-submit-submitted
[595.201549] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[595.364837] [087/131] (497s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[597.358169] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[597.359053] Starting dynamic subtest: pipe-A
[600.051302] Dynamic subtest pipe-A: SUCCESS (2.692s)
[600.071111] Starting dynamic subtest: pipe-B
[602.657494] Dynamic subtest pipe-B: SUCCESS (2.605s)
[602.676502] Starting dynamic subtest: pipe-C
[602.947707] Dynamic subtest pipe-C: SUCCESS (0.288s)
[602.966269] Starting dynamic subtest: pipe-D
[603.237616] Dynamic subtest pipe-D: SUCCESS (0.288s)
[603.238850] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.881s)
[603.456326] [088/131] (489s left) gem_ctx_param (basic)
[603.511038] Starting subtest: basic
[603.512230] Subtest basic: SUCCESS (0.001s)
[603.645389] [089/131] (489s left) syncobj_eventfd (timeline-wait-signaled)
[603.697645] Starting subtest: timeline-wait-signaled
[603.703045] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[603.825896] [090/131] (488s left) sw_sync (sync_random_merge)
[603.875747] Starting subtest: sync_random_merge
[603.959203] Subtest sync_random_merge: SUCCESS (0.084s)
[604.054994] [091/131] (488s left) syncobj_wait (wait-all-delayed-signal)
[604.106746] Starting subtest: wait-all-delayed-signal
[604.216086] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[604.330354] [092/131] (488s left) perf_pmu (init-sema)
[604.385602] Starting subtest: init-sema
[604.386520] Starting dynamic subtest: rcs0
[604.388860] Dynamic subtest rcs0: SUCCESS (0.001s)
[604.400316] Starting dynamic subtest: bcs0
[604.401572] Dynamic subtest bcs0: SUCCESS (0.001s)
[604.412954] Starting dynamic subtest: vcs0
[604.414015] Dynamic subtest vcs0: SUCCESS (0.001s)
[604.425111] Starting dynamic subtest: vcs1
[604.425994] Dynamic subtest vcs1: SUCCESS (0.001s)
[604.437176] Starting dynamic subtest: vecs0
[604.438292] Dynamic subtest vecs0: SUCCESS (0.001s)
[604.439557] Subtest init-sema: SUCCESS (0.010s)
[604.505953] [093/131] (488s left) gem_exec_whisper (basic-contexts-forked-all)
[604.569625] Starting subtest: basic-contexts-forked-all
[617.735656] Subtest basic-contexts-forked-all: SUCCESS (13.162s)
[618.019904] [094/131] (475s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[620.025614] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[620.100964] [095/131] (473s left) kms_color (degamma)
[622.104140] Starting subtest: degamma
[622.104984] Starting dynamic subtest: pipe-A-HDMI-A-3
[622.844079] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.739s)
[622.855595] Starting dynamic subtest: pipe-B-HDMI-A-3
[623.353643] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.508s)
[623.365036] Starting dynamic subtest: pipe-C-HDMI-A-3
[623.840548] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.486s)
[623.852318] Starting dynamic subtest: pipe-D-HDMI-A-3
[624.363689] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.523s)
[624.364593] Subtest degamma: SUCCESS (2.261s)
[624.540364] [096/131] (468s left) gem_ctx_persistence (heartbeat-close)
[624.599022] Starting subtest: heartbeat-close
[624.600759] Subtest heartbeat-close: SKIP (0.000s)
[624.722971] [097/131] (468s left) gem_pxp (display-protected-crc)
[627.298012] Starting subtest: display-protected-crc
[627.300242] Subtest display-protected-crc: SKIP (0.000s)
[627.419434] [098/131] (465s left) kms_psr (psr2-sprite-blt)
[629.414622] Subtest psr2-sprite-blt: SKIP (0.000s)
[629.483734] [099/131] (463s left) gem_eio (wait-immediate)
[629.697956] Starting subtest: wait-immediate
[630.150120] Subtest wait-immediate: SUCCESS (0.452s)
[632.248696] [100/131] (461s left) fbdev (read)
[632.310170] Starting subtest: read
[633.798355] Subtest read: SUCCESS (1.484s)
[633.887027] [101/131] (459s left) prime_vgem (fence-wait)
[633.973301] Starting subtest: fence-wait
[633.974316] Starting dynamic subtest: rcs0
[635.077492] Dynamic subtest rcs0: SUCCESS (1.099s)
[635.089802] Starting dynamic subtest: bcs0
[636.147094] Dynamic subtest bcs0: SUCCESS (1.064s)
[636.159585] Starting dynamic subtest: vcs0
[637.199988] Dynamic subtest vcs0: SUCCESS (1.048s)
[637.211988] Starting dynamic subtest: vcs1
[638.251594] Dynamic subtest vcs1: SUCCESS (1.046s)
[638.264038] Starting dynamic subtest: vecs0
[639.299316] Dynamic subtest vecs0: SUCCESS (1.042s)
[639.300608] Subtest fence-wait: SUCCESS (5.326s)
[639.454206] [102/131] (454s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[641.456429] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[643.522998] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.067s)
[643.756328] [103/131] (450s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[645.762306] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[645.764253] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[645.986689] [104/131] (447s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[647.983970] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[647.985970] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s)
[648.145957] [105/131] (445s left) kms_flip (flip-vs-suspend)
[650.146919] Starting subtest: flip-vs-suspend
[650.152978] Starting dynamic subtest: A-HDMI-A3
[701.932951] Dynamic subtest A-HDMI-A3: SUCCESS (19.036s)
[701.945575] Starting dynamic subtest: B-HDMI-A3
[753.851510] Dynamic subtest B-HDMI-A3: SUCCESS (18.809s)
[753.872908] Starting dynamic subtest: C-HDMI-A3
[805.944599] Dynamic subtest C-HDMI-A3: SUCCESS (19.192s)
[806.027641] Starting dynamic subtest: D-HDMI-A3
[857.894098] Dynamic subtest D-HDMI-A3: SUCCESS (19.067s)
[857.896719] Subtest flip-vs-suspend: SUCCESS (76.163s)
[864.111417] [106/131] (367s left) kms_fbcon_fbt (fbc-suspend)
[864.166979] Starting subtest: fbc-suspend
[929.454622] Subtest fbc-suspend: SUCCESS (33.053s)
[931.607215] [107/131] (334s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[933.612800] Starting subtest: pipe-fbc-rte
[933.619364] Subtest pipe-fbc-rte: SKIP (0.000s)
[933.825340] [108/131] (332s left) kms_psr (fbc-psr-sprite-blt)
[935.821105] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[935.910804] [109/131] (330s left) gem_exec_reloc (basic-wc-noreloc)
[935.972641] Subtest basic-wc-noreloc: SKIP (0.000s)
[936.084747] [110/131] (330s left) gem_eio (create-ext)
[936.284772] Starting subtest: create-ext
[936.590373] Subtest create-ext: SUCCESS (0.306s)
[938.667665] [111/131] (327s left) fbdev (write)
[938.745773] Starting subtest: write
[939.471048] Subtest write: SUCCESS (0.721s)
[939.557991] [112/131] (326s left) i915_pm_rps (waitboost)
[939.617043] Starting subtest: waitboost
[942.178925] Subtest waitboost: SUCCESS (2.563s)
[942.356528] [113/131] (324s left) gem_partial_pwrite_pread (reads-snoop)
[942.410975] Subtest reads-snoop: SKIP (0.000s)
[942.530476] [114/131] (324s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[944.531091] Starting subtest: fbc-rgb101010-draw-render
[947.509288] Subtest fbc-rgb101010-draw-render: SUCCESS (2.979s)
[947.666559] [115/131] (319s left) sw_sync (sync_busy)
[947.715296] Starting subtest: sync_busy
[947.718746] Subtest sync_busy: SUCCESS (0.004s)
[947.804372] [116/131] (319s left) kms_flip (flip-vs-absolute-wf_vblank)
[949.801059] Starting subtest: flip-vs-absolute-wf_vblank
[949.808376] Starting dynamic subtest: A-HDMI-A3
[957.999777] Dynamic subtest A-HDMI-A3: SUCCESS (8.194s)
[958.015220] Starting dynamic subtest: B-HDMI-A3
[966.108178] Dynamic subtest B-HDMI-A3: SUCCESS (8.109s)
[966.123195] Starting dynamic subtest: C-HDMI-A3
[974.224153] Dynamic subtest C-HDMI-A3: SUCCESS (8.114s)
[974.238783] Starting dynamic subtest: D-HDMI-A3
[982.340139] Dynamic subtest D-HDMI-A3: SUCCESS (8.114s)
[982.342779] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.545s)
[982.560064] [117/131] (284s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[984.563916] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[984.639460] [118/131] (282s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[986.644700] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[986.664689] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.019s)
[986.816089] [119/131] (280s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[986.872946] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[986.974984] [120/131] (280s left) kms_plane_multiple (tiling-yf)
[988.973434] Starting subtest: tiling-yf
[988.975088] Subtest tiling-yf: SKIP (0.000s)
[989.103439] [121/131] (278s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[991.138210] Starting subtest: yf-tiled-16bpp-rotate-90
[991.140033] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[991.366706] [122/131] (275s left) kms_psr (fbc-psr-basic)
[993.364063] Subtest fbc-psr-basic: SKIP (0.000s)
[993.438622] [123/131] (273s left) gem_exec_capture (userptr)
[993.497142] Starting subtest: userptr
[994.396465] Subtest userptr: SUCCESS (0.901s)
[994.547977] [124/131] (272s left) gen9_exec_parse (batch-invalid-length)
[994.602638] Subtest batch-invalid-length: SKIP (0.000s)
[994.684385] [125/131] (272s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[994.735527] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[994.736358] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[994.856065] [126/131] (272s left) gem_ctx_isolation (clean)
[994.919433] Starting subtest: clean
[994.920370] Starting dynamic subtest: rcs0
[995.031486] Dynamic subtest rcs0: SUCCESS (0.111s)
[995.045941] Starting dynamic subtest: bcs0
[995.155612] Dynamic subtest bcs0: SUCCESS (0.123s)
[995.169931] Starting dynamic subtest: vcs0
[995.277350] Dynamic subtest vcs0: SUCCESS (0.120s)
[995.291488] Starting dynamic subtest: vcs1
[995.406317] Dynamic subtest vcs1: SUCCESS (0.128s)
[995.420730] Starting dynamic subtest: vecs0
[995.541262] Dynamic subtest vecs0: SUCCESS (0.134s)
[995.542315] Subtest clean: SUCCESS (0.623s)
[995.853129] [127/131] (271s left) gem_exec_schedule (preempt-other-chain)
[995.920215] Starting subtest: preempt-other-chain
[995.921212] Starting dynamic subtest: rcs0
[996.065365] Dynamic subtest rcs0: SUCCESS (0.140s)
[996.078138] Starting dynamic subtest: bcs0
[996.191354] Dynamic subtest bcs0: SUCCESS (0.125s)
[996.204110] Starting dynamic subtest: vcs0
[996.317102] Dynamic subtest vcs0: SUCCESS (0.125s)
[996.329929] Starting dynamic subtest: vcs1
[996.442967] Dynamic subtest vcs1: SUCCESS (0.125s)
[996.455955] Starting dynamic subtest: vecs0
[996.569022] Dynamic subtest vecs0: SUCCESS (0.125s)
[996.570211] Subtest preempt-other-chain: SUCCESS (0.645s)
[996.959328] [128/131] (270s left) dmabuf_sync_file (export-basic)
[997.025952] Starting subtest: export-basic
[997.026967] Subtest export-basic: SUCCESS (0.001s)
[997.136375] [129/131] (270s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[999.138292] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[999.139851] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[999.361447] [130/131] (268s left) kms_busy (extended-modeset-hang-newfb)
[1001.364673] Starting subtest: extended-modeset-hang-newfb
[1001.367125] Starting dynamic subtest: pipe-A
[1016.890751] Dynamic subtest pipe-A: SUCCESS (15.527s)
[1016.906951] Starting dynamic subtest: pipe-D
[1032.373797] Dynamic subtest pipe-D: SUCCESS (15.482s)
[1032.374665] Subtest extended-modeset-hang-newfb: SUCCESS (31.018s)
[1032.592281] [131/131] (235s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[1034.595565] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[1034.597224] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[1034.795698] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: gem_mmap_wc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_exercise_blt
results: parsing output: 8/ for test: gem_tiled_fence_blits
results: parsing output: 9/ for test: kms_lease
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: gem_wait
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_plane_cursor
results: parsing output: 17/ for test: kms_fence_pin_leak
results: parsing output: 18/ for test: debugfs_test
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: prime_self_import
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: sysfs_timeslice_duration
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_writeback
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_chamelium_color
results: parsing output: 53/ for test: gem_exec_suspend
results: parsing output: 54/ for test: gem_exec_nop
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: i915_pm_freq_api
results: parsing output: 61/ for test: gem_workarounds
results: parsing output: 62/ for test: kms_joiner
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: kms_atomic_interruptible
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_pm_dc
results: parsing output: 68/ for test: kms_prop_blob
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_vblank
results: parsing output: 75/ for test: prime_self_import
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_fbcon_fbt
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_async_flips
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: gem_ctx_param
results: parsing output: 88/ for test: syncobj_eventfd
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: gem_exec_whisper
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_eio
results: parsing output: 99/ for test: fbdev
results: parsing output: 100/ for test: prime_vgem
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_fbcon_fbt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: i915_pm_rps
results: parsing output: 112/ for test: gem_partial_pwrite_pread
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: sw_sync
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_plane_multiple
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_exec_capture
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: gem_ctx_isolation
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: dmabuf_sync_file
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_busy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.