[56.611231] Initializing watchdogs
[56.611276]   /dev/watchdog0
[56.628807] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.633708] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.635961] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.639037] [001/156] (960s left) syncobj_wait (wait-all-snapshot)
[56.715186] Starting subtest: wait-all-snapshot
[56.798496] Subtest wait-all-snapshot: SUCCESS (0.084s)
[56.880602] [002/156] (960s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[56.987279] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[56.991556] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[57.060743] [003/156] (960s left) gem_ctx_isolation (clean)
[57.127576] Starting subtest: clean
[57.130076] Starting dynamic subtest: rcs0
[57.176483] Dynamic subtest rcs0: SUCCESS (0.053s)
[57.186069] Starting dynamic subtest: bcs0
[57.233260] Dynamic subtest bcs0: SUCCESS (0.057s)
[57.242084] Starting dynamic subtest: vcs0
[57.288445] Dynamic subtest vcs0: SUCCESS (0.055s)
[57.296290] Starting dynamic subtest: vcs1
[59.326930] Dynamic subtest vcs1: SUCCESS (2.064s)
[59.335265] Starting dynamic subtest: vecs0
[61.345261] Dynamic subtest vecs0: SUCCESS (2.037s)
[61.352808] Starting dynamic subtest: ccs0
[63.303358] Dynamic subtest ccs0: SUCCESS (1.972s)
[63.305912] Subtest clean: SUCCESS (6.242s)
[63.527403] [004/156] (953s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[63.637460] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[63.641933] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[63.725785] [005/156] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[63.833552] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[63.837978] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[63.927202] [006/156] (953s left) kms_feature_discovery (display-3x)
[64.032583] Starting subtest: display-3x
[64.036801] Subtest display-3x: SKIP (0.000s)
[64.101817] [007/156] (953s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[64.199639] Starting subtest: yf-tiled-16bpp-rotate-270
[64.204261] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[64.290986] [008/156] (953s left) vgem_basic (bad-handle)
[64.355109] Starting subtest: bad-handle
[64.357214] Subtest bad-handle: SUCCESS (0.000s)
[64.405628] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[64.408577] [009/156] (953s left) kms_plane_alpha_blend (constant-alpha-max)
[64.509075] Starting subtest: constant-alpha-max
[64.799128] Starting dynamic subtest: pipe-A-eDP-1
[65.945589] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.149s)
[65.954504] Starting dynamic subtest: pipe-D-eDP-1
[67.659799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.721s)
[67.662668] Subtest constant-alpha-max: SUCCESS (3.165s)
[68.525687] [010/156] (948s left) kms_frontbuffer_tracking (hdr-1p-rte)
[68.637891] Starting subtest: hdr-1p-rte
[68.642273] Subtest hdr-1p-rte: SKIP (0.000s)
[68.728718] [011/156] (948s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[68.829470] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[68.833978] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[68.909424] [012/156] (948s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[69.002945] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[69.005174] Starting dynamic subtest: pipe-A-eDP-1
[69.013935] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[69.022603] Starting dynamic subtest: pipe-B-eDP-1
[69.031400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[69.039221] Starting dynamic subtest: pipe-C-eDP-1
[69.047349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[69.054159] Starting dynamic subtest: pipe-D-eDP-1
[69.062539] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[69.066631] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[71.291512] [013/156] (946s left) perf_pmu (frequency)
[71.331971] Starting subtest: frequency
[71.336424] Starting dynamic subtest: gt0
[73.531170] Dynamic subtest gt0: SUCCESS (2.195s)
[73.541333] Starting dynamic subtest: idle-gt0
[74.035147] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[74.045647] Starting dynamic subtest: gt1
[78.278048] Dynamic subtest gt1: SUCCESS (4.244s)
[78.287517] Starting dynamic subtest: idle-gt1
[78.781810] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[78.784622] Subtest frequency: SUCCESS (7.461s)
[78.882209] [014/156] (938s left) device_reset (unbind-cold-reset-rebind)
[78.924389] Starting subtest: unbind-cold-reset-rebind
[78.928802] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[79.006965] [015/156] (938s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[79.112768] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite
[79.117257] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[79.191982] [016/156] (938s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[79.288750] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[79.293153] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[79.400916] [017/156] (938s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[79.494303] Starting subtest: yf-tiled-64bpp-rotate-180
[79.498846] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[79.586928] [018/156] (938s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[79.679568] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[79.683590] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[79.792603] [019/156] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[79.895525] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[79.898835] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[79.997320] [020/156] (937s left) kms_color (ctm-blue-to-red)
[80.097229] Starting subtest: ctm-blue-to-red
[80.099223] Starting dynamic subtest: pipe-A-eDP-1
[80.820310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[80.831157] Starting dynamic subtest: pipe-B-eDP-1
[82.271291] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.452s)
[82.280629] Starting dynamic subtest: pipe-C-eDP-1
[83.656324] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[83.665224] Starting dynamic subtest: pipe-D-eDP-1
[84.978791] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[84.981109] Subtest ctm-blue-to-red: SUCCESS (4.884s)
[85.801160] [021/156] (932s left) syncobj_wait (wait-for-submit-delayed-submit)
[85.866035] Starting subtest: wait-for-submit-delayed-submit
[85.970035] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[86.059813] [022/156] (931s left) gem_exec_reloc (basic-write-read)
[86.113508] Subtest basic-write-read: SKIP (0.000s)
[86.186698] [023/156] (931s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu)
[86.282919] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu
[86.287468] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[86.367083] [024/156] (931s left) gem_ctx_engines (execute-allforone)
[86.436382] Starting subtest: execute-allforone
[86.449173] Subtest execute-allforone: SUCCESS (0.015s)
[88.397690] [025/156] (929s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[88.485179] Starting subtest: fbc-psr2-cursor-plane-onoff
[88.487139] Starting dynamic subtest: eDP-1
[88.491263] Dynamic subtest eDP-1: SKIP (0.000s)
[88.495342] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[88.555788] [026/156] (929s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[88.682815] Starting subtest: cursor-vs-flip-atomic
[118.344290] Subtest cursor-vs-flip-atomic: SUCCESS (29.661s)
[119.231083] [027/156] (898s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[119.330085] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[119.334294] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[119.420569] [028/156] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[119.518023] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[127.225078] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.712s)
[127.339529] [029/156] (890s left) syncobj_basic (bad-destroy)
[127.397252] Starting subtest: bad-destroy
[127.399727] Subtest bad-destroy: SUCCESS (0.000s)
[127.492917] [030/156] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[127.597995] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[127.602563] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[127.690846] [031/156] (890s left) kms_color (ctm-0-25)
[127.780799] Starting subtest: ctm-0-25
[127.783069] Starting dynamic subtest: pipe-A-eDP-1
[131.403263] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.622s)
[131.419574] Starting dynamic subtest: pipe-B-eDP-1
[135.718047] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.313s)
[135.731456] Starting dynamic subtest: pipe-C-eDP-1
[139.751650] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.036s)
[139.761109] Starting dynamic subtest: pipe-D-eDP-1
[143.750628] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s)
[143.752941] Subtest ctm-0-25: SUCCESS (15.971s)
[144.583325] [032/156] (873s left) gem_exec_flush (basic-wb-prw-default)
[144.649893] Starting subtest: basic-wb-prw-default
[150.115409] Subtest basic-wb-prw-default: SUCCESS (5.466s)
[150.298725] [033/156] (868s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-onoff)
[150.398660] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-onoff
[150.403178] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[150.486743] [034/156] (867s left) kms_flip (2x-flip-vs-expired-vblank)
[150.583514] Starting subtest: 2x-flip-vs-expired-vblank
[150.594285] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[150.677063] [035/156] (867s left) kms_addfb_basic (basic-y-tiled-legacy)
[150.741282] Starting subtest: basic-y-tiled-legacy
[150.745526] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[150.898973] [036/156] (867s left) gem_pread (self)
[150.952865] Subtest self: SKIP (0.000s)
[151.027129] [037/156] (867s left) kms_psr (fbc-psr-suspend)
[151.128884] Starting subtest: fbc-psr-suspend
[151.131099] Starting dynamic subtest: eDP-1
[151.135171] Dynamic subtest eDP-1: SKIP (0.000s)
[151.139198] Subtest fbc-psr-suspend: SKIP (0.001s)
[151.202748] [038/156] (867s left) syncobj_timeline (wait-any-snapshot)
[151.255470] Starting subtest: wait-any-snapshot
[151.336396] Subtest wait-any-snapshot: SUCCESS (0.082s)
[151.409994] [039/156] (867s left) gem_exec_fence (submit)
[151.593342] Starting subtest: submit
[151.597968] Subtest submit: SKIP (0.000s)
[153.366882] [040/156] (865s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt)
[153.481471] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt
[153.485629] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[153.583199] [041/156] (865s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[153.679105] Starting subtest: 4-tiled-addfb-size-offset-overflow
[153.681326] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[153.779748] [042/156] (864s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[153.882993] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[153.887458] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[153.995362] [043/156] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[154.106288] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[154.110419] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[154.231066] [044/156] (864s left) kms_psr (psr2-sprite-render)
[154.328194] Starting subtest: psr2-sprite-render
[154.330113] Starting dynamic subtest: eDP-1
[156.075056] Dynamic subtest eDP-1: SUCCESS (1.745s)
[156.077320] Subtest psr2-sprite-render: SUCCESS (1.746s)
[156.938205] [045/156] (861s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[157.024323] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[157.026599] Starting dynamic subtest: pipe-A-eDP-1
[157.085270] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[157.094897] Starting dynamic subtest: pipe-B-eDP-1
[157.152997] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[157.163153] Starting dynamic subtest: pipe-C-eDP-1
[157.221087] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[157.230892] Starting dynamic subtest: pipe-D-eDP-1
[157.288736] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[157.293212] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[159.300154] [046/156] (859s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[159.402128] Starting subtest: fbc-dirtyfb-ioctl
[159.404424] Starting dynamic subtest: A-eDP-1
[161.972573] Dynamic subtest A-eDP-1: SUCCESS (2.569s)
[161.974773] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.570s)
[162.859727] [047/156] (856s left) gem_basic (multigpu-create-close)
[162.912099] Starting subtest: multigpu-create-close
[162.916581] Subtest multigpu-create-close: SKIP (0.000s)
[163.023148] [048/156] (855s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[163.075188] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[163.077216] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[163.178360] [049/156] (855s left) gem_ctx_persistence (smoketest)
[163.235867] Starting subtest: smoketest
[203.234935] Subtest smoketest: SUCCESS (39.996s)
[203.324923] [050/156] (815s left) gem_mmap_wc (set-cache-level)
[203.386410] Subtest set-cache-level: SKIP (0.000s)
[203.440031] [051/156] (815s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[203.558442] Starting subtest: cursorA-vs-flipA-legacy
[214.683886] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.125s)
[215.496831] [052/156] (803s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[215.589121] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[215.593442] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[215.659485] [053/156] (803s left) api_intel_allocator (reloc-allocator)
[215.714075] Starting subtest: reloc-allocator
[215.716322] Starting dynamic subtest: basic
[215.718628] Dynamic subtest basic: SUCCESS (0.004s)
[215.727702] Starting dynamic subtest: parallel-one
[215.730046] Dynamic subtest parallel-one: SUCCESS (0.008s)
[215.738489] Starting dynamic subtest: print
[215.740316] Dynamic subtest print: SUCCESS (0.000s)
[215.748836] Starting dynamic subtest: reuse
[215.750986] Dynamic subtest reuse: SUCCESS (0.000s)
[215.759329] Starting dynamic subtest: fork-reopen-allocator
[215.761505] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[215.763683] Subtest reloc-allocator: SUCCESS (0.030s)
[215.888828] [054/156] (803s left) gem_softpin (evict-active)
[215.940817] Starting subtest: evict-active
[215.947328] Subtest evict-active: SUCCESS (0.006s)
[216.076051] [055/156] (803s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[216.169061] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-pwrite
[216.173328] Subtest psrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[216.268370] [056/156] (803s left) syncobj_timeline (reset-unsignaled)
[216.332312] Starting subtest: reset-unsignaled
[216.334222] Subtest reset-unsignaled: SUCCESS (0.000s)
[216.439347] [057/156] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[216.534953] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[216.538415] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.613818] [058/156] (802s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[216.665825] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[216.667853] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[216.764738] [059/156] (802s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt)
[216.849963] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt
[216.853848] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[216.943923] [060/156] (802s left) gem_exec_fence (expired-history)
[217.369162] Starting subtest: expired-history
[225.043760] Subtest expired-history: SUCCESS (7.673s)
[225.586701] [061/156] (793s left) kms_addfb_basic (too-high)
[225.685075] Starting subtest: too-high
[225.687257] Subtest too-high: SUCCESS (0.001s)
[225.804496] [062/156] (793s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[225.863960] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[225.947761] [063/156] (793s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[226.056455] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[226.060849] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[226.144534] [064/156] (793s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[226.238828] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[226.243142] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[226.323218] [065/156] (793s left) kms_content_protection (dp-mst-type-1)
[226.468497] Starting subtest: dp-mst-type-1
[226.473213] Subtest dp-mst-type-1: SKIP (0.000s)
[226.582698] [066/156] (793s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[226.672159] Starting subtest: fbcpsr-indfb-scaledprimary
[232.444462] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.776s)
[232.577231] [067/156] (787s left) kms_flip (nonexisting-fb-interruptible)
[232.671278] Starting subtest: nonexisting-fb-interruptible
[232.673641] Starting dynamic subtest: A-eDP1
[233.814781] Dynamic subtest A-eDP1: SUCCESS (1.143s)
[233.825439] Starting dynamic subtest: B-eDP1
[234.947844] Dynamic subtest B-eDP1: SUCCESS (1.132s)
[234.959748] Starting dynamic subtest: C-eDP1
[236.072707] Dynamic subtest C-eDP1: SUCCESS (1.122s)
[236.085062] Starting dynamic subtest: D-eDP1
[237.200108] Dynamic subtest D-eDP1: SUCCESS (1.127s)
[237.202294] Subtest nonexisting-fb-interruptible: SUCCESS (4.532s)
[238.382374] [068/156] (781s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[238.481750] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[242.509269] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.033s)
[243.675886] [069/156] (776s left) gem_lmem_swapping (heavy-verify-random)
[243.717762] Subtest heavy-verify-random: SKIP (0.000s)
[243.764996] [070/156] (776s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[243.858338] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[243.862754] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[243.943176] [071/156] (775s left) prime_vgem (basic-fence-mmap)
[244.016458] Starting subtest: basic-fence-mmap
[244.021118] Subtest basic-fence-mmap: SKIP (0.000s)
[244.123294] [072/156] (775s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[244.225573] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[244.229622] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[244.309523] [073/156] (775s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[244.411359] Starting subtest: primary-x-tiled-reflect-x-0
[251.395168] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.986s)
[252.639156] [074/156] (767s left) kms_flip (plain-flip-ts-check-interruptible)
[252.733573] Starting subtest: plain-flip-ts-check-interruptible
[252.735869] Starting dynamic subtest: A-eDP1
[261.627058] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[261.636821] Starting dynamic subtest: B-eDP1
[270.453547] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[270.464167] Starting dynamic subtest: C-eDP1
[279.275614] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[279.286769] Starting dynamic subtest: D-eDP1
[288.112248] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[288.114547] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.379s)
[289.289500] [075/156] (730s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[289.381102] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[297.141786] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.767s)
[297.264787] [076/156] (722s left) syncobj_wait (invalid-wait-bad-flags)
[297.323678] Starting subtest: invalid-wait-bad-flags
[297.326064] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[297.436289] [077/156] (722s left) kms_async_flips (invalid-async-flip-atomic)
[297.524955] Starting subtest: invalid-async-flip-atomic
[297.898052] Starting dynamic subtest: pipe-A-eDP-1
[298.690850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.793s)
[299.048821] Starting dynamic subtest: pipe-B-eDP-1
[299.931970] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.891s)
[300.293972] Starting dynamic subtest: pipe-C-eDP-1
[301.139066] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.852s)
[301.494291] Starting dynamic subtest: pipe-D-eDP-1
[302.271414] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.787s)
[302.273761] Subtest invalid-async-flip-atomic: SUCCESS (4.749s)
[303.424365] [078/156] (716s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[303.520399] Starting subtest: plane-upscale-20x20-with-pixel-format
[303.522720] Starting dynamic subtest: pipe-A
[304.578742] Dynamic subtest pipe-A: SUCCESS (1.061s)
[304.587431] Starting dynamic subtest: pipe-B
[306.741578] Dynamic subtest pipe-B: SUCCESS (2.162s)
[306.750691] Starting dynamic subtest: pipe-C
[307.931418] Dynamic subtest pipe-C: SUCCESS (1.188s)
[307.941286] Starting dynamic subtest: pipe-D
[309.169324] Dynamic subtest pipe-D: SUCCESS (1.237s)
[309.171651] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.652s)
[310.369308] [079/156] (709s left) kms_selftest (drm_dp_mst_helper)
[310.407781] Starting subtest: drm_dp_mst_helper
[310.431599] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[310.533185] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.103s)
[310.543404] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[310.649122] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.114s)
[310.658514] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[310.764348] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.114s)
[310.766516] Subtest drm_dp_mst_helper: SUCCESS (0.357s)
[310.913430] [080/156] (709s left) prime_vgem (coherency-blt)
[310.983299] Starting subtest: coherency-blt
[312.090022] Subtest coherency-blt: SUCCESS (1.108s)
[312.211394] [081/156] (708s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[312.303045] Starting subtest: psrhdr-farfromfence-mmap-gtt
[312.307411] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[312.410770] [082/156] (707s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[312.498678] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[312.501023] Starting dynamic subtest: pipe-A-eDP-1
[312.525811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[312.536850] Starting dynamic subtest: pipe-B-eDP-1
[312.559832] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[312.568831] Starting dynamic subtest: pipe-C-eDP-1
[312.592844] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[312.601509] Starting dynamic subtest: pipe-D-eDP-1
[312.626711] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[312.631036] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[314.759446] [083/156] (705s left) kms_chamelium_frames (dp-frame-dump)
[315.165894] Subtest dp-frame-dump: SKIP (0.000s)
[315.956256] [084/156] (704s left) kms_vrr (max-min)
[316.057198] Starting subtest: max-min
[316.063630] Subtest max-min: SKIP (0.000s)
[316.126583] [085/156] (704s left) i915_selftest (mock)
[320.751586] Starting subtest: mock
[320.754045] Starting dynamic subtest: sanitycheck
[321.463068] Dynamic subtest sanitycheck: SUCCESS (0.714s)
[321.472903] Starting dynamic subtest: shmem
[322.123817] Dynamic subtest shmem: SUCCESS (0.659s)
[322.133591] Starting dynamic subtest: fence
[329.391073] Dynamic subtest fence: SUCCESS (7.265s)
[329.400981] Starting dynamic subtest: scatterlist
[331.097183] Dynamic subtest scatterlist: SUCCESS (1.705s)
[331.107468] Starting dynamic subtest: syncmap
[334.240037] Dynamic subtest syncmap: SUCCESS (3.141s)
[334.250528] Starting dynamic subtest: uncore
[334.937495] Dynamic subtest uncore: SUCCESS (0.696s)
[334.947607] Starting dynamic subtest: ring
[335.638447] Dynamic subtest ring: SUCCESS (0.699s)
[335.647856] Starting dynamic subtest: engine
[336.342698] Dynamic subtest engine: SUCCESS (0.702s)
[336.352651] Starting dynamic subtest: timelines
[340.144031] Dynamic subtest timelines: SUCCESS (3.799s)
[340.153394] Starting dynamic subtest: requests
[343.507727] Dynamic subtest requests: SUCCESS (3.362s)
[343.517621] Starting dynamic subtest: objects
[344.276951] Dynamic subtest objects: SUCCESS (0.768s)
[344.289502] Starting dynamic subtest: phys
[345.066103] Dynamic subtest phys: SUCCESS (0.787s)
[345.075705] Starting dynamic subtest: dmabuf
[345.862066] Dynamic subtest dmabuf: SUCCESS (0.794s)
[345.873068] Starting dynamic subtest: vma
[351.559383] Dynamic subtest vma: SUCCESS (5.695s)
[351.569056] Starting dynamic subtest: evict
[352.982755] Dynamic subtest evict: SUCCESS (1.422s)
[352.992649] Starting dynamic subtest: gtt
[356.266519] Dynamic subtest gtt: SUCCESS (3.283s)
[356.276596] Starting dynamic subtest: hugepages
[357.169597] Dynamic subtest hugepages: SUCCESS (0.902s)
[357.180075] Starting dynamic subtest: memory_region
[359.651955] Dynamic subtest memory_region: SUCCESS (2.479s)
[359.655182] Subtest mock: SUCCESS (38.903s)
[359.683390] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[359.684087] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[359.687285] [086/156] (660s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[361.288568] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[365.774064] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.491s)
[366.947225] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[366.948394] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[366.952157] [087/156] (653s left) gem_watchdog (default-physical)
[367.044607] Starting subtest: default-physical
[368.803738] Subtest default-physical: SUCCESS (1.767s)
[368.896810] [088/156] (651s left) gem_exec_balancer (bonded-pair)
[368.961740] Starting subtest: bonded-pair
[368.966163] Subtest bonded-pair: SKIP (0.000s)
[369.255797] [089/156] (651s left) kms_getfb (getfb-handle-valid)
[369.351273] Starting subtest: getfb-handle-valid
[369.353791] Subtest getfb-handle-valid: SUCCESS (0.000s)
[369.479492] [090/156] (651s left) gem_exec_flush (basic-batch-kernel-default-uc)
[369.541150] Starting subtest: basic-batch-kernel-default-uc
[377.121065] Subtest basic-batch-kernel-default-uc: SUCCESS (7.580s)
[377.323801] [091/156] (643s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[377.434801] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[377.438838] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[377.532329] [092/156] (643s left) kms_pm_rpm (modeset-non-lpsp-stress)
[379.465268] Starting subtest: modeset-non-lpsp-stress
[380.618848] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[381.016973] [093/156] (639s left) api_intel_bb (purge-bb)
[381.078037] Starting subtest: purge-bb
[381.083188] Subtest purge-bb: SUCCESS (0.004s)
[381.208493] [094/156] (639s left) gen9_exec_parse (bb-chained)
[381.272628] Subtest bb-chained: SKIP (0.000s)
[381.353009] [095/156] (639s left) gem_exec_schedule (u-submit-late-slice)
[381.414409] Starting subtest: u-submit-late-slice
[381.416672] Starting dynamic subtest: rcs0
[381.445707] Dynamic subtest rcs0: SUCCESS (0.036s)
[381.459718] Starting dynamic subtest: bcs0
[381.479465] Dynamic subtest bcs0: SUCCESS (0.033s)
[381.488816] Starting dynamic subtest: vcs0
[381.507050] Dynamic subtest vcs0: SUCCESS (0.027s)
[381.516667] Starting dynamic subtest: vcs1
[381.536364] Dynamic subtest vcs1: SUCCESS (0.029s)
[381.545847] Starting dynamic subtest: vecs0
[381.562947] Dynamic subtest vecs0: SUCCESS (0.026s)
[381.573100] Starting dynamic subtest: ccs0
[381.594534] Dynamic subtest ccs0: SUCCESS (0.031s)
[381.596831] Subtest u-submit-late-slice: SUCCESS (0.186s)
[383.393929] [096/156] (637s left) kms_cursor_crc (cursor-offscreen-256x256)
[383.638902] Starting subtest: cursor-offscreen-256x256
[383.641281] Starting dynamic subtest: pipe-A-eDP-1
[385.576625] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[385.610750] Starting dynamic subtest: pipe-D-eDP-1
[388.221653] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[388.224042] Subtest cursor-offscreen-256x256: SUCCESS (4.585s)
[389.074183] [097/156] (631s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[389.168055] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[389.172895] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[389.269096] [098/156] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[389.379327] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[389.383820] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[389.484146] [099/156] (631s left) perf (polling-parameterized)
[389.610451] Starting subtest: polling-parameterized
[409.640976] Subtest polling-parameterized: SUCCESS (20.028s)
[409.691141] [100/156] (611s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[409.811470] Starting subtest: x-tiled-8bpp-rotate-0
[411.025572] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.215s)
[411.158194] [101/156] (609s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[411.251356] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[411.253354] Starting dynamic subtest: pipe-A-eDP-1
[411.272280] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.282462] Starting dynamic subtest: pipe-B-eDP-1
[411.300112] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.309133] Starting dynamic subtest: pipe-C-eDP-1
[411.327213] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.335426] Starting dynamic subtest: pipe-D-eDP-1
[411.353640] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.357032] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[413.545257] [102/156] (607s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[413.643155] Starting subtest: compare-crc-sanitycheck-xr24
[413.645080] Starting dynamic subtest: pipe-A-eDP-1
[414.293589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[414.302907] Starting dynamic subtest: pipe-B-eDP-1
[415.675349] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[415.685238] Starting dynamic subtest: pipe-C-eDP-1
[416.909645] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s)
[416.919975] Starting dynamic subtest: pipe-D-eDP-1
[418.154595] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[418.156873] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.512s)
[418.989597] [103/156] (602s left) gem_exec_schedule (pi-shared-iova)
[419.166030] Starting subtest: pi-shared-iova
[419.168173] Starting dynamic subtest: rcs0
[419.245754] Dynamic subtest rcs0: SUCCESS (0.083s)
[419.259971] Starting dynamic subtest: vcs0
[419.305156] Dynamic subtest vcs0: SUCCESS (0.058s)
[419.316854] Starting dynamic subtest: vcs1
[419.364781] Dynamic subtest vcs1: SUCCESS (0.059s)
[419.374419] Starting dynamic subtest: vecs0
[419.423767] Dynamic subtest vecs0: SUCCESS (0.057s)
[419.434390] Starting dynamic subtest: ccs0
[419.483451] Dynamic subtest ccs0: SUCCESS (0.059s)
[419.486045] Subtest pi-shared-iova: SUCCESS (0.322s)
[421.412990] [104/156] (599s left) kms_busy (extended-pageflip-hang-oldfb)
[421.512047] Starting subtest: extended-pageflip-hang-oldfb
[421.514060] Starting dynamic subtest: pipe-A
[421.915146] Dynamic subtest pipe-A: SUCCESS (0.403s)
[421.927688] Starting dynamic subtest: pipe-D
[423.005980] Dynamic subtest pipe-D: SUCCESS (1.088s)
[423.008319] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.495s)
[423.852278] [105/156] (597s left) kms_vblank (accuracy-idle)
[423.950415] Starting subtest: accuracy-idle
[423.952582] Starting dynamic subtest: pipe-A-eDP-1
[425.718495] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.767s)
[425.735560] Starting dynamic subtest: pipe-D-eDP-1
[428.211106] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.492s)
[428.213394] Subtest accuracy-idle: SUCCESS (4.263s)
[429.020604] [106/156] (592s left) gem_gtt_cpu_tlb
[429.130286] [107/156] (592s left) kms_flip (2x-plain-flip-ts-check)
[429.230234] Starting subtest: 2x-plain-flip-ts-check
[429.241215] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[429.352845] [108/156] (592s left) gem_ctx_bad_destroy (double-destroy)
[429.412019] Starting subtest: double-destroy
[429.414435] Subtest double-destroy: SUCCESS (0.000s)
[429.491207] [109/156] (591s left) gem_workarounds (basic-read-fd)
[429.560430] Starting subtest: basic-read-fd
[429.568373] Subtest basic-read-fd: SUCCESS (0.011s)
[429.696158] [110/156] (591s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[429.759057] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[429.763449] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[429.952110] [111/156] (591s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[430.041902] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[430.044124] Starting dynamic subtest: pipe-A-eDP-1
[430.068142] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[430.078367] Starting dynamic subtest: pipe-B-eDP-1
[430.099186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[430.108101] Starting dynamic subtest: pipe-C-eDP-1
[430.128435] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[430.137018] Starting dynamic subtest: pipe-D-eDP-1
[430.159264] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[430.163413] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[432.315119] [112/156] (589s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[432.419427] Starting subtest: psr-rgb565-draw-mmap-cpu
[439.227580] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.814s)
[439.340415] [113/156] (582s left) kms_cursor_crc (cursor-random-512x512)
[439.628891] Starting subtest: cursor-random-512x512
[439.633577] Subtest cursor-random-512x512: SKIP (0.001s)
[439.798093] [114/156] (581s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[439.849210] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[439.951815] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[440.030030] [115/156] (581s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[440.123850] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[440.126227] Starting dynamic subtest: pipe-A-default-mode
[441.305280] Dynamic subtest pipe-A-default-mode: SKIP (1.181s)
[441.309875] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.183s)
[441.459032] [116/156] (580s left) gem_softpin (allocator-evict)
[441.515430] Starting subtest: allocator-evict
[441.517837] Starting dynamic subtest: rcs0
[464.728529] Dynamic subtest rcs0: SUCCESS (23.212s)
[464.739233] Starting dynamic subtest: bcs0
[488.482780] Dynamic subtest bcs0: SUCCESS (23.752s)
[488.494552] Starting dynamic subtest: vcs0
[511.932895] Dynamic subtest vcs0: SUCCESS (23.448s)
[511.943611] Starting dynamic subtest: vcs1
[535.686816] Dynamic subtest vcs1: SUCCESS (23.753s)
[535.697264] Starting dynamic subtest: vecs0
[559.388480] Dynamic subtest vecs0: SUCCESS (23.698s)
[559.401035] Starting dynamic subtest: ccs0
[583.344558] Dynamic subtest ccs0: SUCCESS (23.954s)
[583.347084] Subtest allocator-evict: SUCCESS (141.824s)
[583.429164] [117/156] (438s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[583.592820] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[583.597054] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[583.710224] [118/156] (438s left) gem_exec_parallel (userptr)
[583.778094] Starting subtest: userptr
[583.780534] Starting dynamic subtest: rcs0
[585.353461] Dynamic subtest rcs0: SUCCESS (1.575s)
[585.363598] Starting dynamic subtest: bcs0
[586.816155] Dynamic subtest bcs0: SUCCESS (1.462s)
[586.827028] Starting dynamic subtest: vcs0
[588.257009] Dynamic subtest vcs0: SUCCESS (1.438s)
[588.268120] Starting dynamic subtest: vcs1
[590.275510] Dynamic subtest vcs1: SUCCESS (2.016s)
[590.288547] Starting dynamic subtest: vecs0
[592.260620] Dynamic subtest vecs0: SUCCESS (1.983s)
[592.273585] Starting dynamic subtest: ccs0
[593.753160] Dynamic subtest ccs0: SUCCESS (1.492s)
[593.755629] Subtest userptr: SUCCESS (9.975s)
[593.945477] [119/156] (427s left) kms_plane_multiple (2x-tiling-y)
[594.047263] Starting subtest: 2x-tiling-y
[594.051775] Subtest 2x-tiling-y: SKIP (0.000s)
[594.130894] [120/156] (427s left) kms_invalid_mode (zero-clock)
[594.220507] Starting subtest: zero-clock
[594.222831] Starting dynamic subtest: pipe-A-eDP-1
[594.519439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[594.529956] Starting dynamic subtest: pipe-B-eDP-1
[594.531901] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[594.541312] Starting dynamic subtest: pipe-C-eDP-1
[594.543623] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[594.552588] Starting dynamic subtest: pipe-D-eDP-1
[594.554474] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[594.556318] Subtest zero-clock: SUCCESS (0.306s)
[595.389525] [121/156] (426s left) kms_setmode (invalid-clone-exclusive-crtc)
[595.443556] Starting subtest: invalid-clone-exclusive-crtc
[595.449881] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[595.543413] [122/156] (426s left) kms_flip (flip-vs-panning-vs-hang)
[595.638633] Starting subtest: flip-vs-panning-vs-hang
[595.641137] Starting dynamic subtest: A-eDP1
[646.828304] Dynamic subtest A-eDP1: SUCCESS (51.187s)
[646.840441] Starting dynamic subtest: D-eDP1
[686.764632] Dynamic subtest D-eDP1: SUCCESS (39.933s)
[686.767107] Subtest flip-vs-panning-vs-hang: SUCCESS (91.125s)
[687.995122] [123/156] (334s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[688.097882] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[688.102377] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[688.203031] [124/156] (333s left) i915_drm_fdinfo (virtual-busy-hang)
[688.248582] Starting subtest: virtual-busy-hang
[688.252977] Subtest virtual-busy-hang: SKIP (0.000s)
[688.311569] [125/156] (333s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[688.417941] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[688.422345] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[688.510723] [126/156] (333s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[688.600196] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[688.602493] Starting dynamic subtest: A-eDP1
[692.248491] Dynamic subtest A-eDP1: SUCCESS (3.644s)
[692.259329] Starting dynamic subtest: B-eDP1
[695.445841] Dynamic subtest B-eDP1: SUCCESS (3.199s)
[695.461182] Starting dynamic subtest: C-eDP1
[698.669083] Dynamic subtest C-eDP1: SUCCESS (3.219s)
[698.679242] Starting dynamic subtest: D-eDP1
[701.897086] Dynamic subtest D-eDP1: SUCCESS (3.229s)
[701.899425] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.298s)
[702.709820] [127/156] (319s left) kms_plane (plane-panning-bottom-right-suspend)
[702.827114] Starting subtest: plane-panning-bottom-right-suspend
[702.829567] Starting dynamic subtest: pipe-A
[720.592439] Dynamic subtest pipe-A: SUCCESS (3.797s)
[720.603677] Starting dynamic subtest: pipe-B
[739.864044] Dynamic subtest pipe-B: SUCCESS (3.909s)
[739.867283] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.709s)
[740.730891] [128/156] (281s left) gem_mmap_offset (clear-via-pagefault)
[740.784300] Starting subtest: clear-via-pagefault
[740.786284] Starting dynamic subtest: smem0
[775.095024] Dynamic subtest smem0: SUCCESS (34.450s)
[775.097391] Subtest clear-via-pagefault: SUCCESS (34.452s)
[775.233129] [129/156] (247s left) gem_ctx_shared (q-out-order)
[775.292806] Starting subtest: Q-out-order
[775.296284] Starting dynamic subtest: rcs0
[775.482224] Dynamic subtest rcs0: SUCCESS (0.187s)
[775.496579] Starting dynamic subtest: vcs0
[775.606631] Dynamic subtest vcs0: SUCCESS (0.123s)
[775.621184] Starting dynamic subtest: vcs1
[775.730589] Dynamic subtest vcs1: SUCCESS (0.124s)
[775.741693] Starting dynamic subtest: vecs0
[775.847023] Dynamic subtest vecs0: SUCCESS (0.115s)
[775.866335] Starting dynamic subtest: ccs0
[775.963100] Dynamic subtest ccs0: SUCCESS (0.114s)
[775.966134] Subtest Q-out-order: SUCCESS (0.669s)
[776.842502] [130/156] (245s left) gem_exec_schedule (u-semaphore-noskip)
[776.932699] Starting subtest: u-semaphore-noskip
[777.376638] Subtest u-semaphore-noskip: SUCCESS (0.446s)
[777.724160] [131/156] (244s left) perf (gen12-oa-tlb-invalidate)
[777.825888] Starting subtest: gen12-oa-tlb-invalidate
[777.828367] Starting dynamic subtest: 0-rcs0
[787.879415] Dynamic subtest 0-rcs0: SUCCESS (10.046s)
[787.892193] Starting dynamic subtest: 1-vcs0
[797.930529] Dynamic subtest 1-vcs0: SUCCESS (10.048s)
[797.933180] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.097s)
[797.985497] [132/156] (224s left) kms_psr (fbc-pr-basic)
[798.080911] Starting subtest: fbc-pr-basic
[798.084886] Subtest fbc-pr-basic: SKIP (0.000s)
[798.155904] [133/156] (224s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[798.246736] Starting subtest: fbchdr-2p-rte
[798.251176] Subtest fbchdr-2p-rte: SKIP (0.000s)
[798.348208] [134/156] (224s left) kms_flip (dpms-vs-vblank-race)
[798.446333] Starting subtest: dpms-vs-vblank-race
[798.448668] Starting dynamic subtest: A-eDP1
[803.392726] Dynamic subtest A-eDP1: SUCCESS (4.945s)
[803.405141] Starting dynamic subtest: B-eDP1
[808.018810] Dynamic subtest B-eDP1: SUCCESS (4.624s)
[808.030217] Starting dynamic subtest: C-eDP1
[811.527108] Dynamic subtest C-eDP1: SUCCESS (3.508s)
[811.538076] Starting dynamic subtest: D-eDP1
[815.138460] Dynamic subtest D-eDP1: SUCCESS (3.612s)
[815.144191] Subtest dpms-vs-vblank-race: SUCCESS (16.701s)
[816.022123] [135/156] (206s left) syncobj_timeline (multi-wait-available-signaled)
[816.067611] Starting subtest: multi-wait-available-signaled
[816.069763] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[816.169938] [136/156] (206s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[816.269498] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[816.273596] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[816.391970] [137/156] (206s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[816.495176] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[816.497471] Starting dynamic subtest: pipe-A-eDP-1
[816.591595] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[816.602816] Starting dynamic subtest: pipe-B-eDP-1
[817.790293] Dynamic subtest pipe-B-eDP-1: SKIP (1.194s)
[817.795008] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.299s)
[818.995070] [138/156] (203s left) i915_pm_rpm (system-suspend)
[820.833973] Starting subtest: system-suspend
[839.096283] Subtest system-suspend: SUCCESS (3.021s)
[839.484010] [139/156] (183s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[839.591328] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[839.595667] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[839.690522] [140/156] (183s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[839.753892] Starting subtest: single-wait-all-for-submit-unsubmitted
[839.855861] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[839.934787] [141/156] (182s left) i915_hangman (engine-engine-error)
[839.995493] Starting subtest: engine-engine-error
[839.997394] Starting dynamic subtest: rcs0
[841.940664] Dynamic subtest rcs0: SUCCESS (1.975s)
[841.952413] Starting dynamic subtest: bcs0
[843.922406] Dynamic subtest bcs0: SUCCESS (2.003s)
[843.937169] Starting dynamic subtest: vcs0
[845.905403] Dynamic subtest vcs0: SUCCESS (1.999s)
[845.918591] Starting dynamic subtest: vcs1
[847.889414] Dynamic subtest vcs1: SUCCESS (1.996s)
[847.903671] Starting dynamic subtest: vecs0
[849.938333] Dynamic subtest vecs0: SUCCESS (2.057s)
[849.952571] Starting dynamic subtest: ccs0
[851.922369] Dynamic subtest ccs0: SUCCESS (1.990s)
[851.925404] Subtest engine-engine-error: SUCCESS (12.038s)
[852.049764] [142/156] (170s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[852.147011] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[852.151128] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[852.247012] [143/156] (170s left) kms_pm_dc (dc5-psr)
[853.340390] Starting subtest: dc5-psr
[856.207545] Subtest dc5-psr: SUCCESS (2.876s)
[857.075969] [144/156] (165s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[857.172666] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[857.176909] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[857.242265] [145/156] (165s left) kms_cursor_edge_walk (256x256-top-edge)
[857.339882] Starting subtest: 256x256-top-edge
[857.342221] Starting dynamic subtest: pipe-A-eDP-1
[860.818461] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s)
[860.830551] Starting dynamic subtest: pipe-D-eDP-1
[863.955987] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.141s)
[863.958327] Subtest 256x256-top-edge: SUCCESS (6.629s)
[864.773925] [146/156] (158s left) kms_hdr (static-toggle-dpms)
[864.878738] Starting subtest: static-toggle-dpms
[864.880930] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[864.884891] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[864.896856] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[864.901207] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[864.905641] Subtest static-toggle-dpms: SKIP (0.003s)
[864.955381] [147/156] (158s left) gem_lmem_swapping (verify-random)
[864.997278] Subtest verify-random: SKIP (0.000s)
[865.040294] [148/156] (158s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[865.141208] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[865.145218] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[865.245369] [149/156] (157s left) prime_vgem (basic-write)
[865.315248] Starting subtest: basic-write
[865.324865] Subtest basic-write: SKIP (0.008s)
[865.433995] [150/156] (157s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[865.527668] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[865.531667] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[865.637829] [151/156] (157s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[865.750812] Starting subtest: cursorA-vs-flipB-legacy
[865.754545] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[865.900206] [152/156] (157s left) gem_userptr_blits (sync-unmap-cycles)
[865.951122] Starting subtest: sync-unmap-cycles
[871.324166] Subtest sync-unmap-cycles: SUCCESS (5.377s)
[871.440608] [153/156] (151s left) kms_big_fb (linear-8bpp-rotate-270)
[871.543081] Starting subtest: linear-8bpp-rotate-270
[871.562985] Subtest linear-8bpp-rotate-270: SKIP (0.019s)
[871.665257] [154/156] (151s left) kms_psr (pr-suspend)
[871.753998] Starting subtest: pr-suspend
[871.757492] Subtest pr-suspend: SKIP (0.000s)
[871.840794] [155/156] (151s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[871.891970] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[871.895732] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[872.081352] [156/156] (151s left) gen3_mixed_blits
[872.200068] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_ctx_isolation
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_feature_discovery
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: vgem_basic
results: parsing output: 8/ for test: kms_plane_alpha_blend
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: device_reset
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_color
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_engines
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_basic
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_color
results: parsing output: 31/ for test: gem_exec_flush
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: gem_pread
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_dirtyfb
results: parsing output: 46/ for test: gem_basic
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: gem_mmap_wc
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_content_protection
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_lmem_swapping
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_rotation_crc
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_async_flips
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_selftest
results: parsing output: 79/ for test: prime_vgem
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_chamelium_frames
results: parsing output: 83/ for test: kms_vrr
results: parsing output: 84/ for test: i915_selftest
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_watchdog
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: gem_exec_flush
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: api_intel_bb
results: parsing output: 93/ for test: gen9_exec_parse
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_pipe_crc_basic
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: gem_gtt_cpu_tlb
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_ctx_bad_destroy
results: parsing output: 108/ for test: gem_workarounds
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: gem_softpin
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_parallel
results: parsing output: 118/ for test: kms_plane_multiple
results: parsing output: 119/ for test: kms_invalid_mode
results: parsing output: 120/ for test: kms_setmode
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: gem_ctx_shared
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_flip
results: parsing output: 134/ for test: syncobj_timeline
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_psr2_sf
results: parsing output: 137/ for test: i915_pm_rpm
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: syncobj_wait
results: parsing output: 140/ for test: i915_hangman
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_pm_dc
results: parsing output: 143/ for test: kms_psr2_sf
results: parsing output: 144/ for test: kms_cursor_edge_walk
results: parsing output: 145/ for test: kms_hdr
results: parsing output: 146/ for test: gem_lmem_swapping
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: prime_vgem
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_cursor_legacy
results: parsing output: 151/ for test: gem_userptr_blits
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: kms_psr
results: parsing output: 154/ for test: gem_render_copy
results: parsing output: 155/ for test: gen3_mixed_blits
Done.