[57.058496] Initializing watchdogs
[57.058543]   /dev/watchdog0
[57.072092] [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]
[57.076472] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.078778] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.081939] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[57.213212] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[57.217121] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[57.319784] [002/133] (960s left) kms_chamelium_audio (hdmi-audio-edid)
[57.707401] Subtest hdmi-audio-edid: SKIP (0.000s)
[58.527700] [003/133] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[58.615838] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[58.619843] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[58.718998] [004/133] (958s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[58.813653] Starting subtest: x-tiled-64bpp-rotate-0
[60.321031] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.526s)
[60.471126] [005/133] (957s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[60.572191] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[60.576422] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[60.668364] [006/133] (957s left) syncobj_wait (single-wait-all-submitted)
[60.723663] Starting subtest: single-wait-all-submitted
[60.834398] Subtest single-wait-all-submitted: SUCCESS (0.109s)
[60.907250] [007/133] (956s left) kms_flip (nonexisting-fb-interruptible)
[60.994386] Starting subtest: nonexisting-fb-interruptible
[60.996822] Starting dynamic subtest: A-eDP1
[62.104370] Dynamic subtest A-eDP1: SUCCESS (1.119s)
[62.115100] Starting dynamic subtest: B-eDP1
[63.229015] Dynamic subtest B-eDP1: SUCCESS (1.132s)
[63.237163] Starting dynamic subtest: C-eDP1
[64.361838] Dynamic subtest C-eDP1: SUCCESS (1.139s)
[64.370272] Starting dynamic subtest: D-eDP1
[65.489319] Dynamic subtest D-eDP1: SUCCESS (1.133s)
[65.494117] Subtest nonexisting-fb-interruptible: SUCCESS (4.533s)
[66.668356] [008/133] (951s left) kms_async_flips (test-time-stamp)
[66.761954] Starting subtest: test-time-stamp
[67.137039] Starting dynamic subtest: pipe-A-eDP-1
[67.956800] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s)
[68.320941] Starting dynamic subtest: pipe-B-eDP-1
[69.076941] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[69.444243] Starting dynamic subtest: pipe-C-eDP-1
[70.205116] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[70.565210] Starting dynamic subtest: pipe-D-eDP-1
[71.324511] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[71.326810] Subtest test-time-stamp: SUCCESS (4.578s)
[72.538783] [009/133] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[72.780077] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[72.784862] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[73.250146] [010/133] (944s left) api_intel_bb (misplaced-blitter)
[73.441838] Starting subtest: misplaced-blitter
[73.453409] Subtest misplaced-blitter: SUCCESS (0.012s)
[73.626006] [011/133] (944s left) gem_tiled_pread_pwrite
[73.731855] [012/133] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[73.831396] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[73.835877] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[73.927733] [013/133] (944s left) gem_create (create-ext-placement-each)
[74.099844] Starting subtest: create-ext-placement-each
[74.102568] Subtest create-ext-placement-each: SUCCESS (0.000s)
[74.191500] [014/133] (943s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[74.305445] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[75.749800] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.444s)
[76.623724] [015/133] (941s left) kms_force_connector_basic (prune-stale-modes)
[76.696937] Starting subtest: prune-stale-modes
[77.014696] Subtest prune-stale-modes: SUCCESS (0.318s)
[77.146701] [016/133] (941s left) kms_vblank (query-forked-busy)
[77.243365] Starting subtest: query-forked-busy
[77.245835] Starting dynamic subtest: pipe-A-eDP-1
[79.137029] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.893s)
[79.150716] Starting dynamic subtest: pipe-D-eDP-1
[81.666250] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s)
[81.668708] Subtest query-forked-busy: SUCCESS (4.426s)
[82.548252] [017/133] (935s left) gem_lmem_swapping (heavy-random)
[82.589799] Subtest heavy-random: SKIP (0.000s)
[82.637356] [018/133] (935s left) api_intel_allocator (simple-allocator)
[82.690140] Starting subtest: simple-allocator
[82.692663] Starting dynamic subtest: basic
[82.695032] Dynamic subtest basic: SUCCESS (0.003s)
[82.706015] Starting dynamic subtest: parallel-one
[82.870643] Dynamic subtest parallel-one: SUCCESS (0.178s)
[82.878706] Starting dynamic subtest: print
[82.880660] Dynamic subtest print: SUCCESS (0.000s)
[82.888783] Starting dynamic subtest: reuse
[82.891097] Dynamic subtest reuse: SUCCESS (0.000s)
[82.898489] Starting dynamic subtest: reserve
[82.900779] Dynamic subtest reserve: SUCCESS (0.000s)
[82.908131] Starting dynamic subtest: fork-reopen-allocator
[82.910394] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[82.912682] Subtest simple-allocator: SUCCESS (0.197s)
[82.989897] [019/133] (935s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[83.112257] Starting subtest: 2x-long-flip-vs-cursor-atomic
[83.116934] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[83.252458] [020/133] (935s left) gem_exec_suspend (basic)
[83.313812] Starting subtest: basic
[83.315782] Starting dynamic subtest: smem
[85.312594] Dynamic subtest smem: SUCCESS (1.999s)
[85.315554] Subtest basic: SUCCESS (2.000s)
[85.507453] [021/133] (932s left) gem_exec_parallel (basic)
[85.573732] Starting subtest: basic
[85.575777] Starting dynamic subtest: rcs0
[87.088648] Dynamic subtest rcs0: SUCCESS (1.517s)
[87.097504] Starting dynamic subtest: bcs0
[88.594123] Dynamic subtest bcs0: SUCCESS (1.504s)
[88.601829] Starting dynamic subtest: vcs0
[90.301565] Dynamic subtest vcs0: SUCCESS (1.705s)
[90.309994] Starting dynamic subtest: vcs1
[92.288035] Dynamic subtest vcs1: SUCCESS (1.985s)
[92.299232] Starting dynamic subtest: vecs0
[94.269282] Dynamic subtest vecs0: SUCCESS (1.979s)
[94.280143] Starting dynamic subtest: ccs0
[95.754686] Dynamic subtest ccs0: SUCCESS (1.485s)
[95.757069] Subtest basic: SUCCESS (10.182s)
[95.938720] [022/133] (922s left) kms_flip (flip-vs-fences)
[96.035233] Starting subtest: flip-vs-fences
[96.039305] Subtest flip-vs-fences: SKIP (0.000s)
[96.132687] [023/133] (922s left) gem_exec_schedule (out-order)
[96.196718] Starting subtest: out-order
[96.198699] Starting dynamic subtest: rcs0
[96.301163] Dynamic subtest rcs0: SUCCESS (0.110s)
[96.311790] Starting dynamic subtest: vcs0
[96.383021] Dynamic subtest vcs0: SUCCESS (0.082s)
[96.396775] Starting dynamic subtest: vcs1
[96.459529] Dynamic subtest vcs1: SUCCESS (0.076s)
[96.471898] Starting dynamic subtest: vecs0
[96.551964] Dynamic subtest vecs0: SUCCESS (0.092s)
[96.561934] Starting dynamic subtest: ccs0
[96.645938] Dynamic subtest ccs0: SUCCESS (0.094s)
[96.648634] Subtest out-order: SUCCESS (0.455s)
[98.394418] [024/133] (920s left) gem_busy (close-race)
[98.447525] Starting subtest: close-race
[122.301706] Subtest close-race: SUCCESS (23.853s)
[122.674195] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[122.678722] [025/133] (895s left) gem_eio (throttle)
[122.933213] Starting subtest: throttle
[123.246185] Subtest throttle: SUCCESS (0.311s)
[123.396323] [026/133] (895s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[123.491838] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[123.494235] Starting dynamic subtest: pipe-A-default-mode
[124.671400] Dynamic subtest pipe-A-default-mode: SKIP (1.174s)
[124.675502] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.177s)
[124.819142] [027/133] (893s left) i915_hangman (error-state-basic)
[124.876882] Starting subtest: error-state-basic
[125.003897] Subtest error-state-basic: SUCCESS (0.129s)
[125.081759] [028/133] (893s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[125.168614] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[125.170762] Starting dynamic subtest: pipe-A-eDP-1
[125.196594] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[125.208126] Starting dynamic subtest: pipe-B-eDP-1
[125.231394] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[125.240086] Starting dynamic subtest: pipe-C-eDP-1
[125.263395] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[125.274154] Starting dynamic subtest: pipe-D-eDP-1
[125.299041] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[125.303413] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[127.443607] [029/133] (891s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[127.536122] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[127.538615] Starting dynamic subtest: pipe-A
[127.873075] Dynamic subtest pipe-A: SUCCESS (0.340s)
[127.883421] Starting dynamic subtest: pipe-B
[129.294231] Dynamic subtest pipe-B: SUCCESS (1.421s)
[129.303622] Starting dynamic subtest: pipe-C
[130.715728] Dynamic subtest pipe-C: SUCCESS (1.421s)
[130.725632] Starting dynamic subtest: pipe-D
[132.103220] Dynamic subtest pipe-D: SUCCESS (1.387s)
[132.105468] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.571s)
[133.242904] [030/133] (885s left) gem_ccs (block-multicopy-inplace)
[133.293587] Starting subtest: block-multicopy-inplace
[133.297778] Subtest block-multicopy-inplace: SKIP (0.000s)
[133.405252] [031/133] (885s left) sysfs_heartbeat_interval (precise)
[133.468269] Starting subtest: precise
[133.470609] Starting dynamic subtest: vecs0
[141.318472] Dynamic subtest vecs0: SUCCESS (7.849s)
[141.328591] Starting dynamic subtest: ccs0
[144.270658] Dynamic subtest ccs0: SUCCESS (2.951s)
[144.280738] Starting dynamic subtest: vcs0
[152.309884] Dynamic subtest vcs0: SUCCESS (8.035s)
[152.321364] Starting dynamic subtest: bcs0
[153.409515] Dynamic subtest bcs0: SUCCESS (1.101s)
[153.417925] Starting dynamic subtest: rcs0
[154.487948] Dynamic subtest rcs0: SUCCESS (1.077s)
[154.496782] Starting dynamic subtest: vcs1
[162.299336] Dynamic subtest vcs1: SUCCESS (7.810s)
[162.301842] Subtest precise: SUCCESS (28.831s)
[162.382032] [032/133] (856s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[162.445575] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[162.450400] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[162.630715] [033/133] (856s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[162.709339] Starting subtest: single-wait-for-submit-unsubmitted
[162.818570] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[162.894258] [034/133] (856s left) gen9_exec_parse (allowed-single)
[162.961687] Subtest allowed-single: SKIP (0.000s)
[163.036989] [035/133] (855s left) gem_exec_schedule (submit-late-slice)
[163.118545] Starting subtest: submit-late-slice
[163.120510] Starting dynamic subtest: rcs0
[163.184669] Dynamic subtest rcs0: SUCCESS (0.068s)
[163.193168] Starting dynamic subtest: bcs0
[163.246712] Dynamic subtest bcs0: SUCCESS (0.062s)
[163.255591] Starting dynamic subtest: vcs0
[163.294643] Dynamic subtest vcs0: SUCCESS (0.047s)
[163.303269] Starting dynamic subtest: vcs1
[163.351778] Dynamic subtest vcs1: SUCCESS (0.056s)
[163.363241] Starting dynamic subtest: vecs0
[163.402705] Dynamic subtest vecs0: SUCCESS (0.050s)
[163.413384] Starting dynamic subtest: ccs0
[163.458096] Dynamic subtest ccs0: SUCCESS (0.055s)
[163.460430] Subtest submit-late-slice: SUCCESS (0.342s)
[164.374229] [036/133] (854s left) gem_exec_flush (basic-wb-set-default)
[164.443505] Starting subtest: basic-wb-set-default
[169.913661] Subtest basic-wb-set-default: SUCCESS (5.470s)
[170.113500] [037/133] (848s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[170.211891] Starting subtest: pixel-format-linear-modifier-source-clamping
[170.237894] Starting dynamic subtest: pipe-A-plane-0
[173.959807] Dynamic subtest pipe-A-plane-0: SUCCESS (3.722s)
[173.969052] Starting dynamic subtest: pipe-A-plane-3
[175.670796] Dynamic subtest pipe-A-plane-3: SUCCESS (1.711s)
[176.793143] Starting dynamic subtest: pipe-B-plane-0
[180.340904] Dynamic subtest pipe-B-plane-0: SUCCESS (3.556s)
[180.351453] Starting dynamic subtest: pipe-B-plane-3
[182.040788] Dynamic subtest pipe-B-plane-3: SUCCESS (1.700s)
[182.363244] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.152s)
[183.235790] [038/133] (835s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[183.341404] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[183.345493] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[183.414765] [039/133] (835s left) gem_exec_big (single)
[183.490493] Starting subtest: single
[186.801073] Subtest single: FAIL (3.251s)
[186.842344] [040/133] (832s left) gem_pread (bench)
[186.935721] Subtest bench: SKIP (0.000s)
[186.992805] [041/133] (832s left) kms_sequence (get-forked)
[187.099279] Starting subtest: get-forked
[187.101441] Starting dynamic subtest: pipe-A-eDP-1
[188.997269] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.897s)
[189.007429] Starting dynamic subtest: pipe-B-eDP-1
[191.533073] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.534s)
[191.543358] Starting dynamic subtest: pipe-C-eDP-1
[194.038253] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.502s)
[194.053343] Starting dynamic subtest: pipe-D-eDP-1
[196.614419] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.574s)
[196.616404] Subtest get-forked: SUCCESS (9.512s)
[197.431534] [042/133] (821s left) kms_psr (fbc-psr-basic)
[197.526774] Starting subtest: fbc-psr-basic
[197.529030] Starting dynamic subtest: eDP-1
[197.533173] Dynamic subtest eDP-1: SKIP (0.000s)
[197.537253] Subtest fbc-psr-basic: SKIP (0.001s)
[197.602037] [043/133] (821s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[197.706396] Starting subtest: yf-tiled-8bpp-rotate-90
[197.710830] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[197.803127] [044/133] (821s left) gem_softpin (allocator-basic)
[197.851491] Starting subtest: allocator-basic
[197.920635] Subtest allocator-basic: SUCCESS (0.069s)
[198.057725] [045/133] (821s left) kms_properties (plane-properties-legacy)
[198.148966] Starting subtest: plane-properties-legacy
[198.151321] Starting dynamic subtest: pipe-A-eDP-1
[198.719304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[198.730694] Starting dynamic subtest: pipe-B-eDP-1
[199.983756] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[199.993904] Starting dynamic subtest: pipe-C-eDP-1
[201.270186] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.286s)
[201.280441] Starting dynamic subtest: pipe-D-eDP-1
[202.580786] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[202.582714] Subtest plane-properties-legacy: SUCCESS (4.431s)
[203.436279] [046/133] (816s left) kms_cursor_crc (cursor-offscreen-256x256)
[203.703856] Starting subtest: cursor-offscreen-256x256
[203.709076] Starting dynamic subtest: pipe-A-eDP-1
[205.636371] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.928s)
[205.664067] Starting dynamic subtest: pipe-D-eDP-1
[208.230956] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.576s)
[208.233326] Subtest cursor-offscreen-256x256: SUCCESS (4.527s)
[209.028338] [047/133] (810s left) kms_flip (2x-flip-vs-panning)
[209.130165] Starting subtest: 2x-flip-vs-panning
[209.141287] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[209.257980] [048/133] (810s left) prime_mmap_kms (buffer-sharing)
[209.358901] Starting subtest: buffer-sharing
[209.789583] Subtest buffer-sharing: SUCCESS (0.431s)
[210.624179] [049/133] (808s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[210.688296] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[210.793756] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[210.870341] [050/133] (808s left) kms_content_protection (atomic-dpms)
[211.009379] Starting subtest: atomic-dpms
[211.013944] Subtest atomic-dpms: SKIP (0.000s)
[211.135462] [051/133] (808s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[211.237552] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[211.241633] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[211.302366] [052/133] (808s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[211.406093] Starting subtest: fbc-rgb565-draw-mmap-wc
[215.426614] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.024s)
[216.571638] [053/133] (803s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[216.671288] Starting subtest: fbc-pr-sprite-mmap-cpu
[216.675926] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[216.745183] [054/133] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[216.838240] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[216.842527] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.953294] [055/133] (802s left) gem_exec_fence (syncobj-export)
[217.401934] Starting subtest: syncobj-export
[217.407432] Subtest syncobj-export: SUCCESS (0.005s)
[219.384260] [056/133] (800s left) gem_ctx_sseu (invalid-sseu)
[219.458873] Subtest invalid-sseu: SKIP (0.000s)
[219.522016] [057/133] (800s left) kms_psr (pr-sprite-plane-move)
[219.615489] Starting subtest: pr-sprite-plane-move
[219.619708] Subtest pr-sprite-plane-move: SKIP (0.000s)
[219.708327] [058/133] (800s left) gem_eio (wait-immediate)
[219.930539] Starting subtest: wait-immediate
[220.293177] Subtest wait-immediate: SUCCESS (0.363s)
[220.446832] [059/133] (799s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[220.542234] Starting subtest: async-flip-with-page-flip-events-tiled
[220.917204] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[223.672252] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.753s)
[223.682472] Starting dynamic subtest: pipe-A-eDP-1-4
[225.847347] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[225.859363] Starting dynamic subtest: pipe-A-eDP-1-4
[227.857480] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[227.867048] Starting dynamic subtest: pipe-A-eDP-1-x
[230.035767] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[230.404685] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[233.170691] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[233.179959] Starting dynamic subtest: pipe-B-eDP-1-4
[235.345350] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s)
[235.356899] Starting dynamic subtest: pipe-B-eDP-1-4
[237.355712] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[237.365047] Starting dynamic subtest: pipe-B-eDP-1-x
[239.546255] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[239.911085] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[242.668461] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.763s)
[242.680742] Starting dynamic subtest: pipe-C-eDP-1-4
[244.842978] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[244.852502] Starting dynamic subtest: pipe-C-eDP-1-4
[246.853596] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[246.863044] Starting dynamic subtest: pipe-C-eDP-1-x
[249.032116] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[249.400343] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[252.167047] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[252.177408] Starting dynamic subtest: pipe-D-eDP-1-4
[254.351355] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[254.360492] Starting dynamic subtest: pipe-D-eDP-1-4
[256.361086] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[256.370831] Starting dynamic subtest: pipe-D-eDP-1-x
[258.550709] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[258.553054] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.008s)
[259.737987] [060/133] (760s left) gem_exec_balancer (full-pulse)
[259.820572] Starting subtest: full-pulse
[264.125903] Subtest full-pulse: SUCCESS (4.305s)
[264.464550] [061/133] (755s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[264.567880] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[264.570186] Starting dynamic subtest: pipe-A
[264.587641] Dynamic subtest pipe-A: SKIP (0.016s)
[264.602367] Starting dynamic subtest: pipe-B
[264.618522] Dynamic subtest pipe-B: SKIP (0.029s)
[264.632538] Starting dynamic subtest: pipe-C
[264.648055] Dynamic subtest pipe-C: SKIP (0.029s)
[264.661765] Starting dynamic subtest: pipe-D
[264.678120] Dynamic subtest pipe-D: SKIP (0.029s)
[264.682418] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.105s)
[264.781192] [062/133] (755s left) gem_exec_params (no-blt)
[264.838988] Starting subtest: no-blt
[264.845124] Subtest no-blt: SUCCESS (0.003s)
[264.954398] [063/133] (755s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[265.046999] Starting subtest: coverage-vs-premult-vs-constant
[265.354976] Starting dynamic subtest: pipe-A-eDP-1
[265.897678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[265.907988] Starting dynamic subtest: pipe-D-eDP-1
[267.220810] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[267.223603] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.172s)
[268.036538] [064/133] (752s left) syncobj_wait (single-wait-for-submit-submitted)
[268.091341] Starting subtest: single-wait-for-submit-submitted
[268.194582] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[268.269378] [065/133] (751s left) kms_pm_backlight (fade-with-dpms)
[268.363615] Starting subtest: fade-with-dpms
[270.713610] Starting dynamic subtest: eDP-1
[273.411360] Dynamic subtest eDP-1: SUCCESS (2.698s)
[273.413780] Subtest fade-with-dpms: SUCCESS (5.049s)
[274.217975] [066/133] (746s left) kms_psr (psr-cursor-plane-move)
[274.303986] Starting subtest: psr-cursor-plane-move
[274.306149] Starting dynamic subtest: eDP-1
[275.990651] Dynamic subtest eDP-1: SUCCESS (1.687s)
[275.992957] Subtest psr-cursor-plane-move: SUCCESS (1.688s)
[276.837974] [067/133] (743s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[276.943571] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[276.948182] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[277.047769] [068/133] (743s left) gem_exec_flush (basic-batch-kernel-default-wb)
[277.105860] Starting subtest: basic-batch-kernel-default-wb
[284.233373] Subtest basic-batch-kernel-default-wb: SUCCESS (7.127s)
[284.418829] [069/133] (736s left) syncobj_basic (bad-destroy-pad)
[284.468120] Starting subtest: bad-destroy-pad
[284.470442] Subtest bad-destroy-pad: SUCCESS (0.000s)
[284.558905] [070/133] (735s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[284.944984] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[285.793788] [071/133] (734s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[285.894140] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[286.708297] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[286.865943] [072/133] (733s left) i915_drm_fdinfo (memory-info-resident)
[286.905155] Starting subtest: memory-info-resident
[286.907329] Starting dynamic subtest: smem0
[289.841659] Dynamic subtest smem0: SUCCESS (2.939s)
[289.843581] Subtest memory-info-resident: SUCCESS (2.940s)
[289.919364] [073/133] (730s left) gem_userptr_blits (invalid-null-pointer)
[289.971889] Starting subtest: invalid-null-pointer
[289.973667] Subtest invalid-null-pointer: SUCCESS (0.001s)
[290.109019] [074/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[290.198845] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[290.202142] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[290.296469] [075/133] (730s left) gem_exec_reloc (basic-scanout)
[290.354096] Subtest basic-scanout: SKIP (0.000s)
[290.436613] [076/133] (730s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[290.526238] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[290.529482] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[290.629804] [077/133] (730s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[290.682105] Starting subtest: multi-wait-available-unsubmitted-signaled
[290.683894] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[290.762193] [078/133] (730s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[290.848496] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[290.850456] Starting dynamic subtest: pipe-A-eDP-1
[290.866803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[290.877216] Starting dynamic subtest: pipe-B-eDP-1
[290.892802] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[290.902421] Starting dynamic subtest: pipe-C-eDP-1
[290.917558] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[290.928390] Starting dynamic subtest: pipe-D-eDP-1
[290.944221] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[290.945961] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[293.124945] [079/133] (727s left) kms_getfb (getfb2-handle-zero)
[293.223232] Starting subtest: getfb2-handle-zero
[293.225575] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[293.318854] [080/133] (727s left) kms_psr (fbc-pr-cursor-plane-move)
[293.423029] Starting subtest: fbc-pr-cursor-plane-move
[293.427710] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[293.537693] [081/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[293.651265] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[293.655262] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[293.761324] [082/133] (727s left) i915_pm_rpm (system-suspend)
[295.490923] Starting subtest: system-suspend
[313.895482] Subtest system-suspend: SUCCESS (2.983s)
[314.281028] [083/133] (706s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[314.383870] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[315.152974] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.792s)
[315.326695] [084/133] (705s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[315.413178] Starting subtest: primary-y-tiled-reflect-x-270
[315.417295] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[315.490550] [085/133] (705s left) gem_ctx_param (invalid-get-ringsize)
[315.536235] Starting subtest: invalid-get-ringsize
[315.538408] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[315.635040] [086/133] (705s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[315.727931] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[315.729989] Starting dynamic subtest: pipe-A-eDP-1
[315.738417] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.748574] Starting dynamic subtest: pipe-B-eDP-1
[315.757023] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.766811] Starting dynamic subtest: pipe-C-eDP-1
[315.774719] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.783694] Starting dynamic subtest: pipe-D-eDP-1
[315.791381] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[315.795228] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[317.947105] [087/133] (703s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[318.035071] Starting subtest: bad-pixel-format-y-tiled-ccs
[318.037290] Starting dynamic subtest: pipe-A-eDP-1
[318.059694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[318.071882] Starting dynamic subtest: pipe-B-eDP-1
[318.092843] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[318.103017] Starting dynamic subtest: pipe-C-eDP-1
[318.124283] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[318.134338] Starting dynamic subtest: pipe-D-eDP-1
[318.155887] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[318.159877] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[320.206430] [088/133] (701s left) gem_exec_whisper (basic-fds-all)
[320.270971] Starting subtest: basic-fds-all
[331.694854] Subtest basic-fds-all: SUCCESS (11.501s)
[331.878964] [089/133] (689s left) core_setmaster (master-drop-set-shared-fd)
[331.951556] Starting subtest: master-drop-set-shared-fd
[331.971056] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[332.015325] [090/133] (689s left) sw_sync (sync_multi_consumer)
[332.055903] Starting subtest: sync_multi_consumer
[332.483346] Subtest sync_multi_consumer: SUCCESS (0.428s)
[332.546638] [091/133] (688s left) prime_busy (before-wait)
[332.603843] Starting subtest: before-wait
[332.609214] Starting dynamic subtest: rcs0
[332.642873] Dynamic subtest rcs0: SUCCESS (0.033s)
[332.653828] Starting dynamic subtest: bcs0
[332.693390] Dynamic subtest bcs0: SUCCESS (0.051s)
[332.703527] Starting dynamic subtest: vcs0
[332.735617] Dynamic subtest vcs0: SUCCESS (0.042s)
[332.745699] Starting dynamic subtest: vcs1
[332.777726] Dynamic subtest vcs1: SUCCESS (0.041s)
[332.787950] Starting dynamic subtest: vecs0
[332.820090] Dynamic subtest vecs0: SUCCESS (0.042s)
[332.832883] Starting dynamic subtest: ccs0
[332.862538] Dynamic subtest ccs0: SUCCESS (0.042s)
[332.970723] Subtest before-wait: SUCCESS (0.367s)
[333.048889] [092/133] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[333.155188] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[333.159270] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[333.253678] [093/133] (688s left) kms_cursor_crc (cursor-random-128x42)
[333.457244] Starting subtest: cursor-random-128x42
[333.505974] Subtest cursor-random-128x42: SKIP (0.043s)
[333.703504] [094/133] (687s left) kms_lease (lease-unleased-connector)
[333.787817] Starting subtest: lease-unleased-connector
[333.790490] Starting dynamic subtest: pipe-A-eDP-1
[333.793123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[333.807336] Starting dynamic subtest: pipe-B-eDP-1
[333.809726] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[333.821352] Starting dynamic subtest: pipe-C-eDP-1
[333.823685] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[333.834199] Starting dynamic subtest: pipe-D-eDP-1
[333.836006] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[333.837858] Subtest lease-unleased-connector: SUCCESS (0.035s)
[333.967690] [095/133] (687s left) gem_exec_reloc (basic-write-wc-active)
[334.033602] Subtest basic-write-wc-active: SKIP (0.000s)
[334.111378] [096/133] (687s left) gem_userptr_blits (access-control)
[334.181911] Starting subtest: access-control
[334.185662] Subtest access-control: SKIP (0.000s)
[334.292227] [097/133] (687s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[334.387178] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[334.388940] Starting dynamic subtest: pipe-A-eDP-1
[334.463143] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[334.476896] Starting dynamic subtest: pipe-B-eDP-1
[335.557694] Dynamic subtest pipe-B-eDP-1: SKIP (1.095s)
[335.562303] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.175s)
[336.812733] [098/133] (684s left) kms_flip (dpms-off-confusion)
[336.915557] Starting subtest: dpms-off-confusion
[336.917413] Starting dynamic subtest: A-eDP1
[345.595108] Dynamic subtest A-eDP1: SUCCESS (8.687s)
[345.610453] Starting dynamic subtest: B-eDP1
[354.280806] Dynamic subtest B-eDP1: SUCCESS (8.675s)
[354.295647] Starting dynamic subtest: C-eDP1
[362.963239] Dynamic subtest C-eDP1: SUCCESS (8.677s)
[362.978462] Starting dynamic subtest: D-eDP1
[371.668272] Dynamic subtest D-eDP1: SUCCESS (8.702s)
[371.673414] Subtest dpms-off-confusion: SUCCESS (34.756s)
[372.904649] [099/133] (648s left) kms_dp_link_training (uhbr-mst)
[373.008715] Starting subtest: uhbr-mst
[373.017329] Subtest uhbr-mst: SKIP (0.000s)
[373.094069] [100/133] (648s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[373.205730] Starting subtest: y-tiled-16bpp-rotate-270
[373.210068] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[373.320968] [101/133] (648s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[373.434687] Starting subtest: 4-tiled-32bpp-rotate-180
[374.779083] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.345s)
[374.917816] [102/133] (646s left) perf_pmu (multi-client)
[374.961612] Starting subtest: multi-client
[374.963578] Starting dynamic subtest: rcs0
[376.015726] Dynamic subtest rcs0: SUCCESS (1.052s)
[376.026940] Starting dynamic subtest: bcs0
[377.063927] Dynamic subtest bcs0: SUCCESS (1.046s)
[377.077355] Starting dynamic subtest: vcs0
[378.116202] Dynamic subtest vcs0: SUCCESS (1.049s)
[378.129657] Starting dynamic subtest: vcs1
[379.716204] Dynamic subtest vcs1: SUCCESS (1.597s)
[379.729220] Starting dynamic subtest: vecs0
[381.763176] Dynamic subtest vecs0: SUCCESS (2.044s)
[381.776095] Starting dynamic subtest: ccs0
[383.755705] Dynamic subtest ccs0: SUCCESS (1.990s)
[383.758566] Subtest multi-client: SUCCESS (8.796s)
[383.876244] [103/133] (638s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[383.978422] Starting subtest: plane-lut1d-pre-ctm3x4
[384.112678] Starting dynamic subtest: pipe-A-plane-0
[384.257277] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[384.270501] Starting dynamic subtest: pipe-A-plane-1
[384.390455] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[384.401205] Starting dynamic subtest: pipe-A-plane-2
[384.523875] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[385.709978] Starting dynamic subtest: pipe-B-plane-0
[385.845184] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[385.856316] Starting dynamic subtest: pipe-B-plane-1
[385.978226] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[385.989261] Starting dynamic subtest: pipe-B-plane-2
[386.111578] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[387.265069] Starting dynamic subtest: pipe-C-plane-0
[387.400576] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[387.411156] Starting dynamic subtest: pipe-C-plane-1
[387.566785] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[387.578067] Starting dynamic subtest: pipe-C-plane-2
[387.722324] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[388.958554] Starting dynamic subtest: pipe-D-plane-0
[389.101193] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[389.112803] Starting dynamic subtest: pipe-D-plane-1
[389.234662] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[389.245466] Starting dynamic subtest: pipe-D-plane-2
[389.389948] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[389.675436] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.699s)
[390.501226] [104/133] (631s left) kms_invalid_mode (overflow-vrefresh)
[390.598056] Starting subtest: overflow-vrefresh
[390.600175] Starting dynamic subtest: pipe-A-eDP-1
[390.888623] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[390.898845] Starting dynamic subtest: pipe-B-eDP-1
[390.900654] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[390.910402] Starting dynamic subtest: pipe-C-eDP-1
[390.912543] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[390.922402] Starting dynamic subtest: pipe-D-eDP-1
[390.924552] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[390.926852] Subtest overflow-vrefresh: SUCCESS (0.296s)
[391.706951] [105/133] (630s left) syncobj_wait (invalid-signal-illegal-handle)
[391.787380] Starting subtest: invalid-signal-illegal-handle
[391.789754] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[391.880211] [106/133] (630s left) syncobj_timeline (single-wait-all-signaled)
[391.938687] Starting subtest: single-wait-all-signaled
[391.940914] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[392.024974] [107/133] (630s left) kms_dsc (dsc-with-formats)
[392.126601] Starting subtest: dsc-with-formats
[392.165364] Subtest dsc-with-formats: SKIP (0.001s)
[392.211358] [108/133] (629s left) gem_lmem_swapping (random)
[392.258395] Subtest random: SKIP (0.000s)
[392.299537] [109/133] (629s left) kms_chamelium_frames (dp-crc-multiple)
[392.694134] Subtest dp-crc-multiple: SKIP (0.000s)
[393.484942] [110/133] (628s left) kms_plane_multiple (tiling-y)
[393.575852] Starting subtest: tiling-y
[393.580386] Subtest tiling-y: SKIP (0.000s)
[393.654242] [111/133] (628s left) gem_readwrite (new-obj)
[393.713044] Subtest new-obj: SKIP (0.000s)
[393.778549] [112/133] (628s left) kms_addfb_basic (small-bo)
[393.863897] Starting subtest: small-bo
[393.865934] Subtest small-bo: SUCCESS (0.000s)
[393.955359] [113/133] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[394.072833] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[394.076945] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[394.187842] [114/133] (628s left) gem_tiled_wb
[394.307206] [115/133] (628s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[394.393656] Starting subtest: fbcpsr-slowdraw
[419.453853] Subtest fbcpsr-slowdraw: SUCCESS (25.063s)
[419.577001] [116/133] (602s left) gem_exec_params (dr4-dirt)
[419.647193] Starting subtest: DR4-dirt
[419.649586] Subtest DR4-dirt: SUCCESS (0.000s)
[419.757463] [117/133] (602s left) gem_mmap_wc (read-write-distinct)
[419.810863] Subtest read-write-distinct: SKIP (0.000s)
[419.869702] [118/133] (602s left) i915_selftest (perf)
[421.626365] Starting subtest: perf
[421.629822] Starting dynamic subtest: engine_cs
[426.011031] Dynamic subtest engine_cs: SUCCESS (4.383s)
[426.021467] Starting dynamic subtest: request
[433.282009] Dynamic subtest request: SUCCESS (7.267s)
[433.292609] Starting dynamic subtest: migrate
[437.595757] Dynamic subtest migrate: SUCCESS (4.312s)
[437.609591] Starting dynamic subtest: region
[443.272809] Dynamic subtest region: SUCCESS (5.675s)
[443.275618] Subtest perf: SUCCESS (21.644s)
[443.303940] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[443.304684] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[443.307842] [119/133] (579s left) perf (gen12-mi-rpc)
[444.885643] Starting subtest: gen12-mi-rpc
[444.887981] Starting dynamic subtest: rcs0
[444.907611] Dynamic subtest rcs0: SUCCESS (0.022s)
[444.910059] Subtest gen12-mi-rpc: SUCCESS (0.023s)
[444.959089] [FACT perf (gen12-mi-rpc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[444.960395] [FACT perf (gen12-mi-rpc)] new: kernel.kmod_is_loaded.i915: true
[444.964016] [120/133] (577s left) gem_pxp (hw-rejects-pxp-buffer)
[445.119428] Starting subtest: hw-rejects-pxp-buffer
[445.124004] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[445.250752] [121/133] (577s left) kms_psr (psr-suspend)
[445.360673] Starting subtest: psr-suspend
[445.362912] Starting dynamic subtest: eDP-1
[463.522130] Dynamic subtest eDP-1: SUCCESS (2.920s)
[463.524494] Subtest psr-suspend: SUCCESS (2.921s)
[464.364929] [122/133] (558s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[464.469460] Starting subtest: fbc-rgb101010-draw-pwrite
[469.746258] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.384s)
[470.866086] [123/133] (551s left) kms_pm_rpm (system-suspend-modeset)
[473.189522] Starting subtest: system-suspend-modeset
[493.626043] Subtest system-suspend-modeset: SUCCESS (4.651s)
[493.991118] [124/133] (528s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[494.100052] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[494.104066] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[494.193742] [125/133] (528s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[494.288103] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[494.292025] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[494.378065] [126/133] (528s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[494.433287] Starting subtest: etime-multi-wait-all-for-submit-submitted
[494.536686] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[494.612674] [127/133] (528s left) gem_ctx_persistence (smoketest)
[494.673987] Starting subtest: smoketest
[534.763278] Subtest smoketest: SUCCESS (40.238s)
[534.850297] [128/133] (488s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[534.971757] Starting subtest: cursor-tearing-framebuffer-change
[534.974097] Starting dynamic subtest: pipe-A-eDP-1
[535.516264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[535.526485] Starting dynamic subtest: pipe-D-eDP-1
[536.748532] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[536.750692] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.774s)
[537.586856] [129/133] (485s left) gem_mmap_offset (open-flood)
[537.641960] Starting subtest: open-flood
[559.130145] Subtest open-flood: SUCCESS (21.490s)
[559.234497] [130/133] (463s left) syncobj_timeline (invalid-transfer-bad-pad)
[559.294956] Starting subtest: invalid-transfer-bad-pad
[559.296922] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[559.386422] [131/133] (463s left) kms_flip (2x-plain-flip)
[559.482673] Starting subtest: 2x-plain-flip
[559.494342] Subtest 2x-plain-flip: SKIP (0.011s)
[559.573249] [132/133] (463s left) kms_addfb_basic (unused-modifier)
[559.630740] Starting subtest: unused-modifier
[559.632346] Subtest unused-modifier: SUCCESS (0.000s)
[559.770084] [133/133] (463s left) gem_userptr_blits (nohangcheck)
[559.845957] Starting subtest: nohangcheck
[560.088996] Subtest nohangcheck: SUCCESS (0.240s)
[560.210855] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_chamelium_audio
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: gem_tiled_pread_pwrite
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_force_connector_basic
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: gem_exec_suspend
results: parsing output: 20/ for test: gem_exec_parallel
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: gem_busy
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: i915_hangman
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: sysfs_heartbeat_interval
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_exec_flush
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: gem_exec_big
results: parsing output: 39/ for test: gem_pread
results: parsing output: 40/ for test: kms_sequence
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: kms_properties
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: prime_mmap_kms
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: gem_ctx_sseu
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_plane_alpha_blend
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_pm_backlight
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_flush
results: parsing output: 68/ for test: syncobj_basic
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_getfb
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: i915_pm_rpm
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_exec_whisper
results: parsing output: 88/ for test: core_setmaster
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: prime_busy
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_lease
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_dp_link_training
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: kms_color_pipeline
results: parsing output: 103/ for test: kms_invalid_mode
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_dsc
results: parsing output: 107/ for test: gem_lmem_swapping
results: parsing output: 108/ for test: kms_chamelium_frames
results: parsing output: 109/ for test: kms_plane_multiple
results: parsing output: 110/ for test: gem_readwrite
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_tiled_wb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: i915_selftest
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: gem_pxp
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: gem_mmap_offset
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_addfb_basic
results: parsing output: 132/ for test: gem_userptr_blits
Done.