[59.417160] Initializing watchdogs
[59.417204]   /dev/watchdog0
[59.431875] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[59.435997] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.437999] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.441358] [001/155] (960s left) kms_flip (2x-flip-vs-suspend-interruptible)
[59.555740] Starting subtest: 2x-flip-vs-suspend-interruptible
[59.560596] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.001s)
[59.661611] [002/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[59.746284] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[59.750346] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[59.845218] [003/155] (960s left) kms_plane_multiple (tiling-none)
[59.921438] Starting subtest: tiling-none
[59.923909] Starting dynamic subtest: pipe-A-eDP-1
[63.805170] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.915s)
[63.814147] Starting dynamic subtest: pipe-B-eDP-1
[68.307668] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.524s)
[68.316313] Starting dynamic subtest: pipe-C-eDP-1
[72.650103] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.353s)
[72.660161] Starting dynamic subtest: pipe-D-eDP-1
[77.072330] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.427s)
[77.074651] Subtest tiling-none: SUCCESS (17.222s)
[77.872583] [004/155] (942s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[77.966535] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[77.971196] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[78.065223] [005/155] (942s left) gem_exec_whisper (basic-queues-priority-all)
[78.138038] Starting subtest: basic-queues-priority-all
[98.542054] Subtest basic-queues-priority-all: SUCCESS (20.406s)
[98.722228] [006/155] (921s left) kms_invalid_mode (clock-too-high)
[98.809388] Starting subtest: clock-too-high
[98.811631] Starting dynamic subtest: pipe-A-eDP-1
[99.092515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[99.101872] Starting dynamic subtest: pipe-B-eDP-1
[99.106143] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[99.114916] Starting dynamic subtest: pipe-C-eDP-1
[99.119990] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[99.127936] Starting dynamic subtest: pipe-D-eDP-1
[99.132783] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[99.135196] Subtest clock-too-high: SUCCESS (0.290s)
[99.902579] [007/155] (920s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[99.976268] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[99.978567] Starting dynamic subtest: pipe-A-eDP-1
[100.036113] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[100.044196] Starting dynamic subtest: pipe-B-eDP-1
[100.101172] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[100.109162] Starting dynamic subtest: pipe-C-eDP-1
[100.163188] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[100.170681] Starting dynamic subtest: pipe-D-eDP-1
[100.227205] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[100.232059] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[102.279425] [008/155] (917s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[102.357126] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[102.361420] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[102.459352] [009/155] (917s left) sysfs_preempt_timeout (invalid)
[102.514045] Starting subtest: invalid
[102.516510] Starting dynamic subtest: vecs0
[102.518730] Dynamic subtest vecs0: SUCCESS (0.000s)
[102.529081] Starting dynamic subtest: ccs0
[102.531221] Dynamic subtest ccs0: SUCCESS (0.000s)
[102.540400] Starting dynamic subtest: vcs0
[102.542540] Dynamic subtest vcs0: SUCCESS (0.000s)
[102.550116] Starting dynamic subtest: bcs0
[102.552249] Dynamic subtest bcs0: SUCCESS (0.000s)
[102.559519] Starting dynamic subtest: rcs0
[102.561404] Dynamic subtest rcs0: SUCCESS (0.000s)
[102.569075] Starting dynamic subtest: vcs1
[102.571101] Dynamic subtest vcs1: SUCCESS (0.000s)
[102.573173] Subtest invalid: SUCCESS (0.003s)
[102.605839] [010/155] (917s left) kms_color_pipeline (plane-lut1d)
[102.681553] Starting subtest: plane-lut1d
[102.826710] Starting dynamic subtest: pipe-A-plane-0
[102.982956] Dynamic subtest pipe-A-plane-0: SUCCESS (0.156s)
[102.993727] Starting dynamic subtest: pipe-A-plane-1
[103.137837] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[103.151264] Starting dynamic subtest: pipe-A-plane-2
[103.304401] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[104.492644] Starting dynamic subtest: pipe-B-plane-0
[104.660184] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[104.670037] Starting dynamic subtest: pipe-B-plane-1
[104.816554] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[104.827763] Starting dynamic subtest: pipe-B-plane-2
[104.971873] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[106.213908] Starting dynamic subtest: pipe-C-plane-0
[106.341504] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[106.352833] Starting dynamic subtest: pipe-C-plane-1
[106.496692] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[106.505628] Starting dynamic subtest: pipe-C-plane-2
[106.663258] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[107.846301] Starting dynamic subtest: pipe-D-plane-0
[108.004078] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[108.013771] Starting dynamic subtest: pipe-D-plane-1
[108.159510] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[108.170666] Starting dynamic subtest: pipe-D-plane-2
[108.326279] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[108.612177] Subtest plane-lut1d: SUCCESS (5.931s)
[109.500248] [011/155] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[109.583739] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[114.138496] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.560s)
[115.305375] [012/155] (905s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[115.390868] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[115.393204] Starting dynamic subtest: pipe-A-eDP-1
[122.144645] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.759s)
[122.156298] Starting dynamic subtest: pipe-B-eDP-1
[129.284979] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.139s)
[129.287293] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.902s)
[130.133064] [013/155] (890s left) i915_pm_rps (min-max-config-idle)
[130.198081] Starting subtest: min-max-config-idle
[130.202386] Subtest min-max-config-idle: SKIP (0.001s)
[130.300622] [014/155] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[130.376558] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[130.381080] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[130.460152] [015/155] (890s left) gem_exec_params (dr4-dirt)
[130.525707] Starting subtest: DR4-dirt
[130.528177] Subtest DR4-dirt: SUCCESS (0.000s)
[130.642386] [016/155] (889s left) perf_pmu (all-busy-idle-check-all)
[130.685250] Starting subtest: all-busy-idle-check-all
[132.225260] Subtest all-busy-idle-check-all: SUCCESS (1.537s)
[132.331330] [017/155] (888s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[132.386084] Starting subtest: invalid-single-wait-all-unsubmitted
[132.388041] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[132.480415] [018/155] (888s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[132.554850] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[136.992797] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.444s)
[138.136264] [019/155] (882s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[138.205040] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[138.207359] Starting dynamic subtest: pipe-A-eDP-1
[138.230878] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[138.242053] Starting dynamic subtest: pipe-B-eDP-1
[138.263608] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[138.272745] Starting dynamic subtest: pipe-C-eDP-1
[138.294257] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.305299] Starting dynamic subtest: pipe-D-eDP-1
[138.327556] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.331795] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[140.489262] [020/155] (880s left) syncobj_wait (single-wait-signaled)
[140.546523] Starting subtest: single-wait-signaled
[140.548901] Subtest single-wait-signaled: SUCCESS (0.000s)
[140.643345] [021/155] (880s left) gem_exec_schedule (fairslice)
[140.711211] Starting subtest: fairslice
[140.713277] Starting dynamic subtest: rcs0
[142.732329] Dynamic subtest rcs0: SUCCESS (2.024s)
[142.741089] Starting dynamic subtest: bcs0
[144.749691] Dynamic subtest bcs0: SUCCESS (2.017s)
[144.760825] Starting dynamic subtest: vcs0
[146.766410] Dynamic subtest vcs0: SUCCESS (2.017s)
[146.776501] Starting dynamic subtest: vcs1
[148.786026] Dynamic subtest vcs1: SUCCESS (2.016s)
[148.797257] Starting dynamic subtest: vecs0
[150.802140] Dynamic subtest vecs0: SUCCESS (2.016s)
[150.811258] Starting dynamic subtest: ccs0
[152.819421] Dynamic subtest ccs0: SUCCESS (2.018s)
[152.821629] Subtest fairslice: SUCCESS (12.112s)
[153.115126] [022/155] (867s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[153.197250] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[153.201424] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[153.306188] [023/155] (867s left) sw_sync (sync_busy_fork_unixsocket)
[153.342173] Starting subtest: sync_busy_fork_unixsocket
[153.344662] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[153.393621] [024/155] (867s left) gem_exec_schedule (semaphore-resolve)
[153.463832] Starting subtest: semaphore-resolve
[153.491288] Subtest semaphore-resolve: SUCCESS (0.036s)
[153.821458] [025/155] (867s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[153.892919] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[153.895158] Starting dynamic subtest: pipe-A
[153.915511] Dynamic subtest pipe-A: SKIP (0.018s)
[153.925173] Starting dynamic subtest: pipe-B
[153.948192] Dynamic subtest pipe-B: SKIP (0.032s)
[153.957990] Starting dynamic subtest: pipe-C
[153.981314] Dynamic subtest pipe-C: SKIP (0.033s)
[153.990379] Starting dynamic subtest: pipe-D
[154.012134] Dynamic subtest pipe-D: SKIP (0.032s)
[154.016177] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.116s)
[154.119353] [026/155] (866s left) perf (gen12-group-exclusive-stream-sample-oa)
[154.230601] Starting subtest: gen12-group-exclusive-stream-sample-oa
[154.250940] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[154.298183] [027/155] (866s left) kms_psr (fbc-psr-sprite-plane-onoff)
[154.376039] Starting subtest: fbc-psr-sprite-plane-onoff
[154.378345] Starting dynamic subtest: eDP-1
[154.382815] Dynamic subtest eDP-1: SKIP (0.000s)
[154.387403] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[154.456140] [028/155] (866s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[154.530412] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[154.534766] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[154.621248] [029/155] (866s left) gem_mmap_offset (partial-unmap)
[154.672311] Starting subtest: partial-unmap
[154.674236] Starting dynamic subtest: smem0
[155.154260] Dynamic subtest smem0: SUCCESS (0.482s)
[155.156825] Subtest partial-unmap: SUCCESS (0.483s)
[155.264090] [030/155] (865s left) gem_exec_params (sol-reset-not-gen7)
[155.314417] Starting subtest: sol-reset-not-gen7
[155.319928] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[155.417907] [031/155] (865s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[155.495055] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[155.498904] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[155.580290] [032/155] (865s left) prime_mmap (test_invalid_sync_flags)
[155.623800] Starting subtest: test_invalid_sync_flags
[155.626111] Starting dynamic subtest: test_invalid_sync_flags-smem
[155.628246] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[155.630387] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[155.728329] [033/155] (865s left) kms_psr (fbc-psr2-primary-page-flip)
[155.793397] Starting subtest: fbc-psr2-primary-page-flip
[155.795767] Starting dynamic subtest: eDP-1
[155.800219] Dynamic subtest eDP-1: SKIP (0.000s)
[155.804616] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[155.871554] [034/155] (865s left) prime_mmap (test_reprime)
[155.924406] Starting subtest: test_reprime
[155.926621] Starting dynamic subtest: test_reprime-smem
[155.952868] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[155.955199] Subtest test_reprime: SUCCESS (0.032s)
[156.056891] [035/155] (865s left) gem_exec_flush (basic-wb-ro-default)
[156.118202] Starting subtest: basic-wb-ro-default
[161.568563] Subtest basic-wb-ro-default: SUCCESS (5.452s)
[161.755869] [036/155] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[161.844198] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[161.848144] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[161.937596] [037/155] (859s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[162.036276] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[162.040464] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[162.149577] [038/155] (859s left) i915_drm_fdinfo (memory-info-shared)
[162.190116] Starting subtest: memory-info-shared
[162.192472] Starting dynamic subtest: smem0
[162.246719] Dynamic subtest smem0: SUCCESS (0.055s)
[162.249334] Subtest memory-info-shared: SUCCESS (0.056s)
[162.316138] [039/155] (859s left) gem_lmem_swapping (random-engines)
[162.360300] Subtest random-engines: SKIP (0.000s)
[162.404349] [040/155] (859s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[162.493102] Starting subtest: y-tiled-32bpp-rotate-270
[162.497496] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[162.585596] [041/155] (858s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[162.667911] Starting subtest: pixel-format-linear-modifier-source-clamping
[162.694287] Starting dynamic subtest: pipe-A-plane-0
[163.249506] Dynamic subtest pipe-A-plane-0: SUCCESS (0.555s)
[163.258258] Starting dynamic subtest: pipe-A-plane-3
[163.660529] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[164.784607] Starting dynamic subtest: pipe-B-plane-0
[165.353699] Dynamic subtest pipe-B-plane-0: SUCCESS (0.577s)
[165.363437] Starting dynamic subtest: pipe-B-plane-3
[165.775149] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[166.091020] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.422s)
[166.956484] [042/155] (854s left) perf_pmu (render-node-busy)
[167.033222] Starting subtest: render-node-busy
[167.035720] Starting dynamic subtest: rcs0
[167.620712] Dynamic subtest rcs0: SUCCESS (0.587s)
[167.633020] Starting dynamic subtest: bcs0
[168.191343] Dynamic subtest bcs0: SUCCESS (0.569s)
[168.203646] Starting dynamic subtest: vcs0
[170.238771] Dynamic subtest vcs0: SUCCESS (2.043s)
[170.250223] Starting dynamic subtest: vcs1
[172.222762] Dynamic subtest vcs1: SUCCESS (1.982s)
[172.235555] Starting dynamic subtest: vecs0
[174.206506] Dynamic subtest vecs0: SUCCESS (1.981s)
[174.219034] Starting dynamic subtest: ccs0
[174.769549] Dynamic subtest ccs0: SUCCESS (0.562s)
[174.772223] Subtest render-node-busy: SUCCESS (7.737s)
[174.842454] [043/155] (846s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[174.926971] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[174.931249] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[175.032885] [044/155] (846s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[175.118931] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[175.123014] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[175.221505] [045/155] (846s left) dmabuf_sync_file (import-multiple-read-write)
[175.306173] Starting subtest: import-multiple-read-write
[175.308482] Subtest import-multiple-read-write: SUCCESS (0.003s)
[175.358096] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[175.361414] [046/155] (846s left) gem_exec_flush (basic-wb-set-default)
[175.428547] Starting subtest: basic-wb-set-default
[180.876903] Subtest basic-wb-set-default: SUCCESS (5.449s)
[181.074356] [047/155] (840s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[181.180504] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[181.185112] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[181.324662] [048/155] (840s left) fbdev (eof)
[181.364137] Starting subtest: eof
[181.366609] Subtest eof: SUCCESS (0.000s)
[181.437110] [049/155] (840s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[181.501587] Starting subtest: y-tiled-ccs-to-yf-tiled
[181.506064] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[181.680387] [050/155] (840s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[181.757268] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[181.759539] Starting dynamic subtest: pipe-A
[182.895154] Dynamic subtest pipe-A: SUCCESS (1.140s)
[182.904280] Starting dynamic subtest: pipe-B
[185.155268] Dynamic subtest pipe-B: SUCCESS (2.259s)
[185.164830] Starting dynamic subtest: pipe-C
[186.346175] Dynamic subtest pipe-C: SUCCESS (1.190s)
[186.357889] Starting dynamic subtest: pipe-D
[187.571575] Dynamic subtest pipe-D: SUCCESS (1.225s)
[187.573921] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.817s)
[188.768913] [051/155] (833s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[188.849416] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[188.853864] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[188.938508] [052/155] (832s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[189.019171] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[189.021360] Starting dynamic subtest: pipe-A-eDP-1
[189.042241] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[189.052904] Starting dynamic subtest: pipe-B-eDP-1
[189.072215] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[189.081479] Starting dynamic subtest: pipe-C-eDP-1
[189.100973] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[189.110206] Starting dynamic subtest: pipe-D-eDP-1
[189.129607] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[189.131540] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[191.344635] [053/155] (830s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[191.429988] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[191.434372] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[191.537976] [054/155] (830s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render)
[191.634293] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render
[191.638379] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[191.730897] [055/155] (830s left) kms_cursor_edge_walk (64x64-right-edge)
[191.807327] Starting subtest: 64x64-right-edge
[191.809676] Starting dynamic subtest: pipe-A-eDP-1
[195.287528] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[195.297536] Starting dynamic subtest: pipe-D-eDP-1
[198.417212] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[198.419524] Subtest 64x64-right-edge: SUCCESS (6.611s)
[199.227215] [056/155] (822s left) gem_exec_create (basic)
[199.289948] Starting subtest: basic
[199.292263] Starting dynamic subtest: smem
[203.262248] Dynamic subtest smem: SUCCESS (3.970s)
[203.265062] Subtest basic: SUCCESS (3.972s)
[203.449210] [057/155] (818s left) gem_exec_fence (syncobj-timeline-export)
[204.028367] Starting subtest: syncobj-timeline-export
[204.038362] Subtest syncobj-timeline-export: SUCCESS (0.011s)
[205.331242] [058/155] (816s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[205.702600] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[206.534628] [059/155] (815s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[206.589275] Starting subtest: saturated-hostile-nopreempt
[206.591714] Starting dynamic subtest: rcs0
[206.644256] Dynamic subtest rcs0: SKIP (0.052s)
[206.655702] Starting dynamic subtest: bcs0
[206.660408] Dynamic subtest bcs0: SKIP (0.012s)
[206.669295] Starting dynamic subtest: vcs0
[206.673886] Dynamic subtest vcs0: SKIP (0.012s)
[206.682852] Starting dynamic subtest: vcs1
[206.687250] Dynamic subtest vcs1: SKIP (0.012s)
[206.695761] Starting dynamic subtest: vecs0
[206.700272] Dynamic subtest vecs0: SKIP (0.013s)
[206.709081] Starting dynamic subtest: ccs0
[206.713578] Dynamic subtest ccs0: SKIP (0.010s)
[206.717674] Subtest saturated-hostile-nopreempt: SKIP (0.118s)
[206.794575] [060/155] (815s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[206.848845] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[206.955126] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[207.030475] [061/155] (815s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[207.111540] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[207.201135] [062/155] (815s left) gem_exec_capture (capture)
[207.267052] Starting subtest: capture
[207.269219] Starting dynamic subtest: rcs0-smem
[208.095846] Dynamic subtest rcs0-smem: SUCCESS (0.830s)
[208.104748] Starting dynamic subtest: bcs0-smem
[208.911834] Dynamic subtest bcs0-smem: SUCCESS (0.814s)
[208.922269] Starting dynamic subtest: vcs0-smem
[209.737743] Dynamic subtest vcs0-smem: SUCCESS (0.823s)
[209.748891] Starting dynamic subtest: vcs1-smem
[211.054041] Dynamic subtest vcs1-smem: SUCCESS (1.319s)
[211.065623] Starting dynamic subtest: vecs0-smem
[211.948351] Dynamic subtest vecs0-smem: FAIL (0.820s)
[211.960208] Starting dynamic subtest: ccs0-smem
[213.203550] Dynamic subtest ccs0-smem: SUCCESS (1.325s)
[213.205661] Subtest capture: FAIL (5.936s)
[213.315387] [063/155] (809s left) kms_vrr (max-min)
[213.399850] Starting subtest: max-min
[213.406254] Subtest max-min: SKIP (0.000s)
[213.480481] [064/155] (808s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[213.565097] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[213.569110] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[213.657365] [065/155] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[213.745780] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[213.749681] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[213.833820] [066/155] (808s left) gem_exec_reloc (basic-gtt-cpu-active)
[213.889888] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[213.958064] [067/155] (808s left) gem_ppgtt (shrink-vs-evict-pinned)
[214.015960] Starting subtest: shrink-vs-evict-pinned
[219.218732] Subtest shrink-vs-evict-pinned: SUCCESS (5.201s)
[219.296730] [068/155] (803s left) kms_flip (dpms-off-confusion-interruptible)
[219.374468] Starting subtest: dpms-off-confusion-interruptible
[219.376816] Starting dynamic subtest: A-eDP1
[228.056700] Dynamic subtest A-eDP1: SUCCESS (8.681s)
[228.066200] Starting dynamic subtest: B-eDP1
[236.691333] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[236.702694] Starting dynamic subtest: C-eDP1
[245.317035] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[245.326743] Starting dynamic subtest: D-eDP1
[253.955332] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[253.960675] Subtest dpms-off-confusion-interruptible: SUCCESS (34.585s)
[255.165509] [069/155] (767s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[255.246817] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[255.249209] Starting dynamic subtest: pipe-A-eDP-1
[255.270059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[255.282202] Starting dynamic subtest: pipe-B-eDP-1
[255.301863] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[255.311426] Starting dynamic subtest: pipe-C-eDP-1
[255.331075] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[255.342737] Starting dynamic subtest: pipe-D-eDP-1
[255.362846] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[255.365109] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[257.494934] [070/155] (765s left) api_intel_allocator (reloc-allocator)
[257.542014] Starting subtest: reloc-allocator
[257.544314] Starting dynamic subtest: basic
[257.546643] Dynamic subtest basic: SUCCESS (0.004s)
[257.557708] Starting dynamic subtest: parallel-one
[257.560042] Dynamic subtest parallel-one: SUCCESS (0.007s)
[257.569783] Starting dynamic subtest: print
[257.572073] Dynamic subtest print: SUCCESS (0.000s)
[257.580570] Starting dynamic subtest: reuse
[257.582462] Dynamic subtest reuse: SUCCESS (0.000s)
[257.590886] Starting dynamic subtest: fork-reopen-allocator
[257.592799] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[257.594666] Subtest reloc-allocator: SUCCESS (0.024s)
[257.685371] [071/155] (765s left) gem_mmap (basic-small-bo)
[257.731597] Subtest basic-small-bo: SKIP (0.000s)
[257.795570] [072/155] (764s left) perf (enable-disable)
[257.893353] Starting subtest: enable-disable
[257.895796] Starting dynamic subtest: 0-rcs0
[260.150048] Dynamic subtest 0-rcs0: SUCCESS (2.255s)
[260.160545] Starting dynamic subtest: 1-vcs1
[264.608841] Dynamic subtest 1-vcs1: SUCCESS (4.457s)
[264.611455] Subtest enable-disable: SUCCESS (6.714s)
[264.660843] [073/155] (758s left) gem_workarounds (suspend-resume-context)
[264.725171] Starting subtest: suspend-resume-context
[281.185484] Subtest suspend-resume-context: SUCCESS (2.047s)
[282.330939] [074/155] (741s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[282.417672] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[282.421716] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[282.505670] [075/155] (741s left) kms_rotation_crc (sprite-rotation-270)
[282.572662] Starting subtest: sprite-rotation-270
[282.576985] Subtest sprite-rotation-270: SKIP (0.001s)
[282.645060] [076/155] (741s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[282.721306] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[289.496812] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.921s)
[289.618830] [077/155] (734s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[289.702059] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[289.706046] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[289.806482] [078/155] (734s left) prime_self_import (basic-with_fd_dup)
[289.843129] Starting subtest: basic-with_fd_dup
[289.856446] Subtest basic-with_fd_dup: SUCCESS (0.018s)
[289.959526] [079/155] (734s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[290.002902] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[290.108675] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[290.184203] [080/155] (733s left) gem_exec_whisper (basic-normal-all)
[290.245155] Starting subtest: basic-normal-all
[292.517468] Subtest basic-normal-all: SUCCESS (2.295s)
[292.696158] [081/155] (731s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[292.792157] Starting subtest: x-tiled-8bpp-rotate-0
[293.974129] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.191s)
[294.104959] [082/155] (730s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[294.195078] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[294.198467] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[294.292720] [083/155] (729s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[294.370696] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[294.372586] Starting dynamic subtest: pipe-A-default-mode
[295.572365] Dynamic subtest pipe-A-default-mode: SKIP (1.204s)
[295.577069] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.205s)
[295.713632] [084/155] (728s left) kms_psr (pr-sprite-plane-move)
[295.784353] Starting subtest: pr-sprite-plane-move
[295.788695] Subtest pr-sprite-plane-move: SKIP (0.000s)
[295.855739] [085/155] (728s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[295.942039] Starting subtest: yf-tiled-32bpp-rotate-90
[295.946429] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[296.031077] [086/155] (728s left) gem_softpin (allocator-nopin)
[296.098741] Starting subtest: allocator-nopin
[296.188934] Subtest allocator-nopin: SUCCESS (0.093s)
[296.333377] [087/155] (728s left) kms_big_fb (linear-16bpp-rotate-180)
[296.408664] Starting subtest: linear-16bpp-rotate-180
[297.725217] Subtest linear-16bpp-rotate-180: SUCCESS (1.322s)
[297.871670] [088/155] (726s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[297.955730] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[297.959260] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[298.057172] [089/155] (726s left) kms_rotation_crc (bad-tiling)
[298.128715] Starting subtest: bad-tiling
[298.132385] Subtest bad-tiling: SKIP (0.001s)
[298.204060] [090/155] (726s left) kms_scaling_modes (scaling-mode-none)
[298.285165] Starting subtest: scaling-mode-none
[298.286805] Starting dynamic subtest: pipe-A-eDP-1
[298.381871] Dynamic subtest pipe-A-eDP-1: SKIP (0.096s)
[298.394054] Starting dynamic subtest: pipe-B-eDP-1
[298.416156] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[298.426989] Starting dynamic subtest: pipe-C-eDP-1
[298.447997] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s)
[298.458236] Starting dynamic subtest: pipe-D-eDP-1
[298.480711] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[298.484685] Subtest scaling-mode-none: SKIP (0.197s)
[298.604173] [091/155] (725s left) gem_render_copy (yf-tiled-ccs-to-linear)
[298.661841] Starting subtest: yf-tiled-ccs-to-linear
[298.665477] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[298.843319] [092/155] (725s left) kms_atomic (plane-immutable-zpos)
[298.925659] Starting subtest: plane-immutable-zpos
[298.928063] Starting dynamic subtest: pipe-A-eDP-1
[299.546147] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[299.548571] Subtest plane-immutable-zpos: SUCCESS (0.624s)
[300.347075] [093/155] (724s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[300.450084] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[332.035864] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.604s)
[332.850772] [094/155] (691s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[332.941745] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[332.946020] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[333.054672] [095/155] (691s left) kms_pm_rpm (cursor-dpms)
[334.851404] Starting subtest: cursor-dpms
[334.857084] Subtest cursor-dpms: SKIP (0.000s)
[335.310935] [096/155] (689s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[335.396367] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[335.400701] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[335.501249] [097/155] (689s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[335.582771] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite
[335.586935] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[335.704469] [098/155] (689s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[335.770428] Starting subtest: primary-x-tiled-reflect-x-180
[342.697083] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.929s)
[343.864699] [099/155] (680s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[343.940169] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[343.942542] Starting dynamic subtest: pipe-A-eDP-1
[343.966551] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[343.979054] Starting dynamic subtest: pipe-B-eDP-1
[344.000759] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[344.011658] Starting dynamic subtest: pipe-C-eDP-1
[344.032327] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[344.041649] Starting dynamic subtest: pipe-D-eDP-1
[344.062297] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[344.066393] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[346.234830] [100/155] (678s left) api_intel_bb (purge-bb)
[346.282566] Starting subtest: purge-bb
[346.287407] Subtest purge-bb: SUCCESS (0.005s)
[346.409941] [101/155] (678s left) gem_wait (await)
[346.467528] Starting subtest: await
[346.469724] Starting dynamic subtest: all-engines
[347.578417] Dynamic subtest all-engines: SUCCESS (1.111s)
[347.597826] Starting dynamic subtest: rcs0
[348.648584] Dynamic subtest rcs0: SUCCESS (1.061s)
[348.670528] Starting dynamic subtest: bcs0
[349.709345] Dynamic subtest bcs0: SUCCESS (1.060s)
[349.727179] Starting dynamic subtest: vcs0
[350.768354] Dynamic subtest vcs0: SUCCESS (1.057s)
[350.786668] Starting dynamic subtest: vcs1
[351.823140] Dynamic subtest vcs1: SUCCESS (1.053s)
[351.842896] Starting dynamic subtest: vecs0
[352.877321] Dynamic subtest vecs0: SUCCESS (1.052s)
[352.896507] Starting dynamic subtest: ccs0
[353.935999] Dynamic subtest ccs0: SUCCESS (1.057s)
[353.938495] Subtest await: SUCCESS (7.472s)
[354.139912] [102/155] (670s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[354.223813] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[354.227902] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[354.323725] [103/155] (670s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[354.406740] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[354.410963] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[354.500931] [104/155] (670s left) kms_plane_lowres (tiling-x)
[354.566543] Starting subtest: tiling-x
[354.568912] Starting dynamic subtest: pipe-A-eDP-1
[354.573491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.882009] Starting dynamic subtest: pipe-B-eDP-1
[354.886679] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[354.896895] Starting dynamic subtest: pipe-C-eDP-1
[354.901581] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[354.911549] Starting dynamic subtest: pipe-D-eDP-1
[354.915957] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[354.920415] Subtest tiling-x: SKIP (0.312s)
[355.754991] [105/155] (669s left) gem_ctx_persistence (engines-cleanup)
[355.816012] Starting subtest: engines-cleanup
[355.818487] Starting dynamic subtest: rcs0
[355.887397] Dynamic subtest rcs0: SUCCESS (0.071s)
[355.899691] Starting dynamic subtest: bcs0
[355.945274] Dynamic subtest bcs0: SUCCESS (0.055s)
[355.956988] Starting dynamic subtest: vcs0
[356.003619] Dynamic subtest vcs0: SUCCESS (0.056s)
[356.017531] Starting dynamic subtest: vcs1
[356.067212] Dynamic subtest vcs1: SUCCESS (0.062s)
[356.079426] Starting dynamic subtest: vecs0
[356.115091] Dynamic subtest vecs0: SUCCESS (0.046s)
[356.126301] Starting dynamic subtest: ccs0
[356.163090] Dynamic subtest ccs0: SUCCESS (0.046s)
[356.165465] Subtest engines-cleanup: SUCCESS (0.349s)
[356.243266] [106/155] (668s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[356.302566] Starting subtest: map-fixed-invalidate-overlap
[356.307432] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[356.434213] [107/155] (668s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[356.505230] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[356.509268] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[356.606067] [108/155] (668s left) gem_mmap_gtt (basic-read)
[356.662201] Subtest basic-read: SKIP (0.000s)
[356.730967] [109/155] (668s left) kms_chamelium_audio (dp-audio-edid)
[357.086263] Subtest dp-audio-edid: SKIP (0.000s)
[357.877297] [110/155] (667s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[357.967670] Starting subtest: yf-tiled-64bpp-rotate-0
[357.972197] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[358.054160] [111/155] (667s left) kms_frontbuffer_tracking (fbchdr-shrfb-scaledprimary)
[358.135193] Starting subtest: fbchdr-shrfb-scaledprimary
[358.139561] Subtest fbchdr-shrfb-scaledprimary: SKIP (0.000s)
[358.245311] [112/155] (667s left) kms_flip (2x-plain-flip-interruptible)
[358.321439] Starting subtest: 2x-plain-flip-interruptible
[358.331814] Subtest 2x-plain-flip-interruptible: SKIP (0.008s)
[358.410670] [113/155] (667s left) gem_exec_balancer (bonded-true-hang)
[358.679468] Starting subtest: bonded-true-hang
[358.684343] Subtest bonded-true-hang: SKIP (0.000s)
[358.776495] [114/155] (666s left) gen9_exec_parse (bb-start-out)
[358.837270] Subtest bb-start-out: SKIP (0.000s)
[358.907852] [115/155] (666s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[358.999053] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[359.003172] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[359.102020] [116/155] (666s left) gem_ccs (suspend-resume)
[359.173433] Starting subtest: suspend-resume
[359.177563] Subtest suspend-resume: SKIP (0.000s)
[359.287488] [117/155] (666s left) gem_readwrite (beyond-eob)
[359.339748] Subtest beyond-EOB: SKIP (0.000s)
[359.407710] [118/155] (666s left) syncobj_timeline (single-wait-available-signaled)
[359.462320] Starting subtest: single-wait-available-signaled
[359.464657] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[359.569112] [119/155] (666s left) prime_busy (before-wait)
[359.617261] Starting subtest: before-wait
[359.623070] Starting dynamic subtest: rcs0
[359.649180] Dynamic subtest rcs0: SUCCESS (0.029s)
[359.662234] Starting dynamic subtest: bcs0
[359.703083] Dynamic subtest bcs0: SUCCESS (0.053s)
[359.714606] Starting dynamic subtest: vcs0
[359.745029] Dynamic subtest vcs0: SUCCESS (0.041s)
[359.755056] Starting dynamic subtest: vcs1
[359.783482] Dynamic subtest vcs1: SUCCESS (0.037s)
[359.795475] Starting dynamic subtest: vecs0
[359.824307] Dynamic subtest vecs0: SUCCESS (0.040s)
[359.834455] Starting dynamic subtest: ccs0
[359.864111] Dynamic subtest ccs0: SUCCESS (0.039s)
[359.973218] Subtest before-wait: SUCCESS (0.354s)
[360.048518] [120/155] (665s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[360.124823] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[360.129169] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[360.208152] [121/155] (665s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[360.274261] Starting subtest: etime-single-wait-available-unsubmitted
[360.381247] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[360.460362] [122/155] (665s left) gem_ppgtt (blt-vs-render-ctx0)
[360.517086] Starting subtest: blt-vs-render-ctx0
[393.475468] Subtest blt-vs-render-ctx0: SUCCESS (32.956s)
[393.608549] [123/155] (632s left) gem_exec_schedule (out-order)
[393.734912] Starting subtest: out-order
[393.736969] Starting dynamic subtest: rcs0
[393.887657] Dynamic subtest rcs0: SUCCESS (0.157s)
[393.901022] Starting dynamic subtest: vcs0
[394.002309] Dynamic subtest vcs0: SUCCESS (0.113s)
[394.015229] Starting dynamic subtest: vcs1
[394.117632] Dynamic subtest vcs1: SUCCESS (0.114s)
[394.131192] Starting dynamic subtest: vecs0
[394.220170] Dynamic subtest vecs0: SUCCESS (0.101s)
[394.233309] Starting dynamic subtest: ccs0
[394.344974] Dynamic subtest ccs0: SUCCESS (0.123s)
[394.347355] Subtest out-order: SUCCESS (0.616s)
[395.736207] [124/155] (630s left) gem_madvise (dontneed-before-exec)
[395.782224] Starting subtest: dontneed-before-exec
[395.799530] Subtest dontneed-before-exec: SKIP (0.013s)
[395.873244] [125/155] (630s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[395.973198] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[395.977795] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[396.078469] [126/155] (629s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[396.342164] Starting subtest: cursor-rapid-movement-512x170
[396.346575] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[396.478089] [127/155] (629s left) i915_module_load (reload)
[396.511570] Starting subtest: reload
[401.441524] Subtest reload: SUCCESS (4.931s)
[401.481581] [128/155] (624s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[402.637174] Starting subtest: psrhdr-rgb565-draw-render
[402.641204] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[402.727821] [129/155] (623s left) kms_lease (lease-invalid-plane)
[402.797720] Starting subtest: lease-invalid-plane
[402.800254] Starting dynamic subtest: pipe-A-eDP-1
[402.802693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[402.815177] Starting dynamic subtest: pipe-B-eDP-1
[402.817384] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[402.826905] Starting dynamic subtest: pipe-C-eDP-1
[402.828755] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[402.837751] Starting dynamic subtest: pipe-D-eDP-1
[402.839642] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[402.841788] Subtest lease-invalid-plane: SUCCESS (0.004s)
[402.893713] [130/155] (623s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[403.276904] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[404.074921] [131/155] (622s left) kms_content_protection (atomic-hdcp14)
[404.208144] Starting subtest: atomic-hdcp14
[404.212591] Subtest atomic-hdcp14: SKIP (0.000s)
[404.345847] [132/155] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[404.428029] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[404.432721] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[404.526200] [133/155] (621s left) kms_dsc (dsc-with-bpc-formats)
[404.603443] Starting subtest: dsc-with-bpc-formats
[404.712882] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[404.752427] [134/155] (621s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[404.836681] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[408.806308] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.976s)
[410.009186] [135/155] (616s left) tools_test (sysfs_l3_parity)
[410.064484] Starting subtest: sysfs_l3_parity
[410.130662] Subtest sysfs_l3_parity: SKIP (0.077s)
[410.195368] [136/155] (616s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[410.287174] Starting subtest: pr-overlay-plane-move-continuous-sf
[410.291508] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[410.350667] [137/155] (616s left) kms_cursor_crc (cursor-offscreen-128x42)
[410.547419] Starting subtest: cursor-offscreen-128x42
[410.607889] Subtest cursor-offscreen-128x42: SKIP (0.055s)
[410.784410] [138/155] (615s left) kms_selftest (drm_plane_helper)
[410.826033] Starting subtest: drm_plane_helper
[410.834717] Starting dynamic subtest: drm_test_check_plane_state
[410.962807] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.126s)
[410.973092] Starting dynamic subtest: drm_test_check_invalid_plane_state
[411.046532] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.085s)
[411.048736] Subtest drm_plane_helper: SUCCESS (0.222s)
[411.208098] [139/155] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[411.293377] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[411.297792] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[411.371501] [140/155] (615s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[411.452725] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[412.498427] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.047s)
[412.655863] [141/155] (613s left) kms_pm_rpm (package-g7)
[414.860264] Starting subtest: package-g7
[414.865882] Subtest package-g7: SKIP (0.001s)
[415.234314] [142/155] (611s left) kms_psr (psr-no-drrs)
[415.312011] Starting subtest: psr-no-drrs
[415.314394] Starting dynamic subtest: eDP-1
[416.908667] Dynamic subtest eDP-1: SUCCESS (1.596s)
[416.911185] Subtest psr-no-drrs: SUCCESS (1.597s)
[417.783394] [143/155] (608s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[417.875116] Starting subtest: psr-rgb101010-draw-pwrite
[425.563710] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.696s)
[425.679188] [144/155] (601s left) kms_flip (modeset-vs-vblank-race)
[425.768959] Starting subtest: modeset-vs-vblank-race
[425.771208] Starting dynamic subtest: A-eDP1
[430.554305] Dynamic subtest A-eDP1: SUCCESS (4.787s)
[430.567810] Starting dynamic subtest: B-eDP1
[435.364816] Dynamic subtest B-eDP1: SUCCESS (4.808s)
[435.375849] Starting dynamic subtest: C-eDP1
[440.073669] Dynamic subtest C-eDP1: SUCCESS (4.708s)
[440.085753] Starting dynamic subtest: D-eDP1
[444.716881] Dynamic subtest D-eDP1: SUCCESS (4.643s)
[444.719277] Subtest modeset-vs-vblank-race: SUCCESS (18.956s)
[445.884063] [145/155] (580s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[445.974438] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[445.978686] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[446.084112] [146/155] (580s left) prime_self_import (basic-llseek-size)
[446.119217] Starting subtest: basic-llseek-size
[446.133253] Subtest basic-llseek-size: SUCCESS (0.014s)
[446.237441] [147/155] (580s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[446.316952] Starting subtest: fbcpsr-rgb565-draw-render
[453.437755] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.129s)
[453.575448] [148/155] (573s left) i915_pm_rps (thresholds-park)
[453.642625] Starting subtest: thresholds-park
[453.646752] Subtest thresholds-park: SKIP (0.001s)
[453.736817] [149/155] (573s left) gem_exec_reloc (basic-cpu)
[453.791867] Subtest basic-cpu: SKIP (0.000s)
[453.862096] [150/155] (573s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[453.951989] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[453.956084] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[454.062371] [151/155] (572s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[454.148360] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[454.152722] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[454.245545] [152/155] (572s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[454.297246] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[454.299511] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[454.410749] [153/155] (572s left) gem_exec_reloc (basic-wc-read-active)
[454.466729] Subtest basic-wc-read-active: SKIP (0.000s)
[454.526870] [154/155] (572s left) gem_workarounds (reset-context)
[454.587813] Starting subtest: reset-context
[454.750114] Subtest reset-context: SUCCESS (0.162s)
[454.863017] [155/155] (572s left) gem_render_copy_redux (normal)
[454.914606] Starting subtest: normal
[455.191387] Subtest normal: SUCCESS (0.277s)
[455.307558] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_plane_multiple
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_whisper
results: parsing output: 5/ for test: kms_invalid_mode
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: sysfs_preempt_timeout
results: parsing output: 9/ for test: kms_color_pipeline
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: i915_pm_rps
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_mmap_offset
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: prime_mmap
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: gem_exec_flush
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: dmabuf_sync_file
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_cursor_edge_walk
results: parsing output: 55/ for test: gem_exec_create
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: gem_exec_capture
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_ppgtt
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: api_intel_allocator
results: parsing output: 70/ for test: gem_mmap
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: prime_self_import
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_softpin
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: kms_scaling_modes
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: kms_atomic
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: gem_wait
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_plane_lowres
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_chamelium_audio
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_ccs
results: parsing output: 116/ for test: gem_readwrite
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: prime_busy
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_ppgtt
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: gem_madvise
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: i915_module_load
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_dsc
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: tools_test
results: parsing output: 135/ for test: kms_psr2_sf
results: parsing output: 136/ for test: kms_cursor_crc
results: parsing output: 137/ for test: kms_selftest
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_big_fb
results: parsing output: 140/ for test: kms_pm_rpm
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_flip
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: prime_self_import
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: i915_pm_rps
results: parsing output: 148/ for test: gem_exec_reloc
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: syncobj_timeline
results: parsing output: 152/ for test: gem_exec_reloc
results: parsing output: 153/ for test: gem_workarounds
results: parsing output: 154/ for test: gem_render_copy_redux
Done.