[57.754433] Initializing watchdogs
[57.754479]   /dev/watchdog0
[57.768751] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.773288] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.775283] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.778927] [001/133] (960s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[57.845160] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[57.888402] [002/133] (960s left) prime_mmap (test_userptr)
[57.941467] Starting subtest: test_userptr
[57.943651] Starting dynamic subtest: test_userptr-smem
[57.945991] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[57.948236] Subtest test_userptr: SUCCESS (0.001s)
[58.050993] [003/133] (960s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[58.137520] Starting subtest: yf-tiled-64bpp-rotate-270
[58.142472] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.002s)
[58.228767] [004/133] (960s left) gem_exec_schedule (noreorder)
[58.401959] Starting subtest: noreorder
[58.404717] Starting dynamic subtest: rcs0
[58.462063] Dynamic subtest rcs0: SUCCESS (0.061s)
[58.471978] Starting dynamic subtest: vcs0
[59.861631] Dynamic subtest vcs0: SUCCESS (1.397s)
[59.870800] Starting dynamic subtest: vcs1
[61.852345] Dynamic subtest vcs1: SUCCESS (1.990s)
[61.861687] Starting dynamic subtest: vecs0
[63.836255] Dynamic subtest vecs0: SUCCESS (1.983s)
[63.845731] Starting dynamic subtest: ccs0
[63.920262] Dynamic subtest ccs0: SUCCESS (0.084s)
[63.922760] Subtest noreorder: SUCCESS (5.520s)
[64.107218] [005/133] (954s left) syncobj_eventfd (binary-wait-signaled)
[64.164245] Starting subtest: binary-wait-signaled
[64.166511] Subtest binary-wait-signaled: SUCCESS (0.000s)
[64.263615] [006/133] (954s left) gem_mmap_gtt (basic-read-write-distinct)
[64.317740] Subtest basic-read-write-distinct: SKIP (0.000s)
[64.368164] [007/133] (954s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[64.457982] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[64.462376] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[64.552739] [008/133] (953s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[64.616602] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[64.618763] Starting dynamic subtest: pipe-A-default-mode
[65.755148] Dynamic subtest pipe-A-default-mode: SKIP (1.135s)
[65.759614] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.136s)
[65.905313] [009/133] (952s left) sw_sync (alloc_timeline)
[65.943937] Starting subtest: alloc_timeline
[65.945945] Subtest alloc_timeline: SUCCESS (0.000s)
[65.995806] [010/133] (952s left) kms_prime (d3hot)
[66.061924] Subtest D3hot: SKIP (0.000s)
[66.163690] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[66.167171] [011/133] (952s left) gem_exec_schedule (u-submit-early-slice)
[66.234240] Starting subtest: u-submit-early-slice
[66.236545] Starting dynamic subtest: rcs0
[66.271585] Dynamic subtest rcs0: SUCCESS (0.045s)
[66.282887] Starting dynamic subtest: bcs0
[66.311847] Dynamic subtest bcs0: SUCCESS (0.040s)
[66.320755] Starting dynamic subtest: vcs0
[66.350594] Dynamic subtest vcs0: SUCCESS (0.038s)
[66.359305] Starting dynamic subtest: vcs1
[66.386802] Dynamic subtest vcs1: SUCCESS (0.036s)
[66.395664] Starting dynamic subtest: vecs0
[66.423576] Dynamic subtest vecs0: SUCCESS (0.036s)
[66.433863] Starting dynamic subtest: ccs0
[66.459549] Dynamic subtest ccs0: SUCCESS (0.036s)
[66.461933] Subtest u-submit-early-slice: SUCCESS (0.234s)
[67.974681] [012/133] (950s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[68.053938] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[68.056229] Starting dynamic subtest: pipe-A
[69.148054] Dynamic subtest pipe-A: SUCCESS (1.096s)
[69.156140] Starting dynamic subtest: pipe-B
[71.380565] Dynamic subtest pipe-B: SUCCESS (2.232s)
[71.387818] Starting dynamic subtest: pipe-C
[72.607559] Dynamic subtest pipe-C: SUCCESS (1.226s)
[72.616398] Starting dynamic subtest: pipe-D
[73.756458] Dynamic subtest pipe-D: SUCCESS (1.149s)
[73.758837] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.705s)
[74.929239] [013/133] (943s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[75.013571] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[75.019904] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.007s)
[75.128856] [014/133] (943s left) kms_flip (2x-flip-vs-dpms-on-nop)
[75.205328] Starting subtest: 2x-flip-vs-dpms-on-nop
[75.213619] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.007s)
[75.321429] [015/133] (943s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[75.409328] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[75.413426] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[75.522987] [016/133] (943s left) kms_vblank (wait-idle-hang)
[75.605815] Starting subtest: wait-idle-hang
[75.607709] Starting dynamic subtest: pipe-A-eDP-1
[101.661328] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.052s)
[101.674589] Starting dynamic subtest: pipe-D-eDP-1
[116.645538] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.983s)
[116.647964] Subtest wait-idle-hang: SUCCESS (41.039s)
[117.487225] [017/133] (901s left) gem_exec_schedule (fifo)
[117.550958] Starting subtest: fifo
[117.553398] Starting dynamic subtest: rcs0
[117.644450] Dynamic subtest rcs0: SUCCESS (0.103s)
[117.654865] Starting dynamic subtest: vcs0
[117.723523] Dynamic subtest vcs0: SUCCESS (0.080s)
[117.733597] Starting dynamic subtest: vcs1
[117.819116] Dynamic subtest vcs1: SUCCESS (0.095s)
[117.830474] Starting dynamic subtest: vecs0
[117.891336] Dynamic subtest vecs0: SUCCESS (0.072s)
[117.901773] Starting dynamic subtest: ccs0
[117.968753] Dynamic subtest ccs0: SUCCESS (0.077s)
[117.971732] Subtest fifo: SUCCESS (0.429s)
[118.957183] [018/133] (899s left) gem_mmap (bad-offset)
[119.015174] Subtest bad-offset: SKIP (0.000s)
[119.073528] [019/133] (899s left) syncobj_wait (wait-any-snapshot)
[119.129910] Starting subtest: wait-any-snapshot
[119.210546] Subtest wait-any-snapshot: SUCCESS (0.081s)
[119.295228] [020/133] (899s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[119.369329] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[119.373473] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[119.465553] [021/133] (899s left) sw_sync (sync_merge)
[119.508131] Starting subtest: sync_merge
[119.510407] Subtest sync_merge: SUCCESS (0.000s)
[119.563442] [022/133] (899s left) kms_feature_discovery (display)
[119.627443] Starting subtest: display
[119.629675] Subtest display: SUCCESS (0.000s)
[119.696055] [023/133] (899s left) kms_flip (flip-vs-absolute-wf_vblank)
[119.768928] Starting subtest: flip-vs-absolute-wf_vblank
[119.771253] Starting dynamic subtest: A-eDP1
[128.739633] Dynamic subtest A-eDP1: SUCCESS (8.969s)
[128.749390] Starting dynamic subtest: B-eDP1
[137.668072] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[137.677755] Starting dynamic subtest: C-eDP1
[146.586329] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[146.594048] Starting dynamic subtest: D-eDP1
[155.509661] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[155.514430] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.746s)
[156.744342] [024/133] (862s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[157.000991] Starting subtest: cursor-rapid-movement-max-size
[157.007683] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[157.127368] [025/133] (862s left) gem_exec_fence (syncobj-export)
[157.569054] Starting subtest: syncobj-export
[157.574310] Subtest syncobj-export: SUCCESS (0.005s)
[158.955924] [026/133] (860s left) gem_exec_reloc (basic-cpu-gtt-active)
[159.011757] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[159.068150] [027/133] (860s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[159.145924] Starting subtest: x-tiled-16bpp-rotate-270
[159.167083] Subtest x-tiled-16bpp-rotate-270: SKIP (0.021s)
[159.281660] [028/133] (860s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[159.374425] Starting subtest: 4-tiled-addfb-size-offset-overflow
[159.376299] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[159.478463] [029/133] (859s left) gem_ctx_shared (q-out-order)
[159.544935] Starting subtest: Q-out-order
[159.547336] Starting dynamic subtest: rcs0
[159.645316] Dynamic subtest rcs0: SUCCESS (0.100s)
[159.660055] Starting dynamic subtest: vcs0
[159.723033] Dynamic subtest vcs0: SUCCESS (0.077s)
[159.738059] Starting dynamic subtest: vcs1
[159.796911] Dynamic subtest vcs1: SUCCESS (0.074s)
[159.810509] Starting dynamic subtest: vecs0
[159.864183] Dynamic subtest vecs0: SUCCESS (0.067s)
[159.876950] Starting dynamic subtest: ccs0
[159.943094] Dynamic subtest ccs0: SUCCESS (0.078s)
[159.945350] Subtest Q-out-order: SUCCESS (0.398s)
[160.954227] [030/133] (858s left) gem_exec_balancer (sliced)
[161.018515] Starting subtest: sliced
[161.022618] Subtest sliced: SKIP (0.000s)
[161.314996] [031/133] (858s left) gem_ctx_persistence (heartbeat-hang)
[161.370535] Starting subtest: heartbeat-hang
[161.375059] Subtest heartbeat-hang: SKIP (0.000s)
[161.474858] [032/133] (857s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[161.557611] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[161.561782] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[161.655884] [033/133] (857s left) i915_pm_rpm (gem-mmap-type)
[163.171465] Starting subtest: gem-mmap-type
[163.174303] Starting dynamic subtest: wb-smem0
[166.931163] Dynamic subtest wb-smem0: SUCCESS (3.759s)
[166.939827] Starting dynamic subtest: wc-smem0
[169.800197] Dynamic subtest wc-smem0: SUCCESS (2.869s)
[169.809181] Starting dynamic subtest: uc-smem0
[172.662839] Dynamic subtest uc-smem0: SUCCESS (2.862s)
[172.665320] Subtest gem-mmap-type: SUCCESS (9.492s)
[172.763679] [034/133] (846s left) prime_vgem (basic-read)
[172.833542] Starting subtest: basic-read
[172.840861] Subtest basic-read: SKIP (0.005s)
[172.937755] [035/133] (846s left) gem_exec_balancer (bonded-sync)
[172.997574] Starting subtest: bonded-sync
[173.002045] Subtest bonded-sync: SKIP (0.000s)
[173.297550] [036/133] (846s left) gem_wait (invalid-buf)
[173.357369] Starting subtest: invalid-buf
[173.359411] Subtest invalid-buf: SUCCESS (0.000s)
[173.583874] [037/133] (846s left) kms_plane (pixel-format-4-tiled-modifier)
[173.649925] Starting subtest: pixel-format-4-tiled-modifier
[173.676531] Starting dynamic subtest: pipe-A-plane-0
[174.320806] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[174.330195] Starting dynamic subtest: pipe-A-plane-3
[174.720519] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[174.729210] Starting dynamic subtest: pipe-A-plane-5
[174.732744] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[175.807350] Starting dynamic subtest: pipe-B-plane-0
[176.422973] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[176.430743] Starting dynamic subtest: pipe-B-plane-3
[176.822627] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[176.831571] Starting dynamic subtest: pipe-B-plane-5
[176.835338] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[177.147636] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.499s)
[177.988889] [038/133] (841s left) gem_userptr_blits (sync-overlap)
[178.052682] Starting subtest: sync-overlap
[178.054996] Subtest sync-overlap: SUCCESS (0.000s)
[178.199461] [039/133] (841s left) kms_universal_plane (cursor-fb-leak)
[178.292845] Starting subtest: cursor-fb-leak
[178.295299] Starting dynamic subtest: pipe-A-eDP-1
[178.621954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.329s)
[178.632874] Starting dynamic subtest: pipe-B-eDP-1
[179.993620] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[180.005056] Starting dynamic subtest: pipe-C-eDP-1
[181.306921] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.311s)
[181.318547] Starting dynamic subtest: pipe-D-eDP-1
[182.659880] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s)
[182.662468] Subtest cursor-fb-leak: SUCCESS (4.369s)
[183.821274] [040/133] (835s left) syncobj_wait (wait-all-delayed-signal)
[183.880854] Starting subtest: wait-all-delayed-signal
[183.983224] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[184.060913] [041/133] (835s left) gem_render_copy (linear-to-vebox-yf-tiled)
[184.130512] Starting subtest: linear-to-vebox-yf-tiled
[184.134600] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[184.319897] [042/133] (835s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[184.384783] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[184.386989] Starting dynamic subtest: pipe-A-eDP-1
[184.409187] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[184.419636] Starting dynamic subtest: pipe-B-eDP-1
[184.440164] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[184.447609] Starting dynamic subtest: pipe-C-eDP-1
[184.468085] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[184.475257] Starting dynamic subtest: pipe-D-eDP-1
[184.496278] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[184.500069] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[186.683282] [043/133] (833s left) gem_softpin (evict-active-interruptible)
[186.748776] Starting subtest: evict-active-interruptible
[186.755228] Subtest evict-active-interruptible: SUCCESS (0.006s)
[186.866804] [044/133] (833s left) gem_partial_pwrite_pread (writes-after-reads)
[186.922424] Subtest writes-after-reads: SKIP (0.000s)
[186.985822] [045/133] (833s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[187.077490] Starting subtest: cursorA-vs-flipB-atomic
[187.081995] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[187.227605] [046/133] (832s left) gen7_exec_parse (basic-allowed)
[187.286605] Subtest basic-allowed: SKIP (0.000s)
[187.344071] [047/133] (832s left) kms_chamelium_frames (hdmi-crc-fast)
[187.709664] Subtest hdmi-crc-fast: SKIP (0.000s)
[188.500497] [048/133] (831s left) kms_chamelium_frames (vga-frame-dump)
[188.859608] Subtest vga-frame-dump: SKIP (0.000s)
[189.630847] [049/133] (830s left) gem_caching (reads)
[189.682398] Subtest reads: SKIP (0.000s)
[189.740498] [050/133] (830s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[189.816022] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[189.818241] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[189.910837] [051/133] (830s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[189.990699] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[189.992609] Starting dynamic subtest: pipe-A-eDP-1
[190.011924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[190.020959] Starting dynamic subtest: pipe-B-eDP-1
[190.039771] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[190.047946] Starting dynamic subtest: pipe-C-eDP-1
[190.066393] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[190.074524] Starting dynamic subtest: pipe-D-eDP-1
[190.093585] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[190.095802] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s)
[192.307875] [052/133] (827s left) kms_async_flips (invalid-async-flip-atomic)
[192.397852] Starting subtest: invalid-async-flip-atomic
[192.775998] Starting dynamic subtest: pipe-A-eDP-1
[193.628617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s)
[193.987419] Starting dynamic subtest: pipe-B-eDP-1
[194.755336] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.775s)
[195.114095] Starting dynamic subtest: pipe-C-eDP-1
[195.874220] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[196.225740] Starting dynamic subtest: pipe-D-eDP-1
[197.006496] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.785s)
[197.008613] Subtest invalid-async-flip-atomic: SUCCESS (4.609s)
[198.180314] [053/133] (822s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[198.245244] Starting subtest: y-tiled-to-vebox-yf-tiled
[198.249743] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[198.423878] [054/133] (821s left) gem_create (create-ext-set-pat)
[198.590731] Starting subtest: create-ext-set-pat
[198.593103] Subtest create-ext-set-pat: SUCCESS (0.001s)
[198.676282] [055/133] (821s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[198.756064] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[198.760343] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[198.850769] [056/133] (821s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[198.912060] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[199.012163] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[199.084046] [057/133] (821s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[199.164383] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[199.168777] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[199.260851] [058/133] (821s left) gem_pread (self)
[199.316551] Subtest self: SKIP (0.000s)
[199.376055] [059/133] (821s left) gem_exec_reloc (basic-softpin)
[199.430625] Subtest basic-softpin: SKIP (0.000s)
[199.500918] [060/133] (821s left) prime_vgem (fence-read-hang)
[199.572354] Subtest fence-read-hang: SKIP (0.000s)
[199.681928] [061/133] (820s left) kms_plane_alpha_blend (alpha-transparent-fb)
[199.751096] Starting subtest: alpha-transparent-fb
[200.034517] Starting dynamic subtest: pipe-A-eDP-1
[200.644237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[200.652626] Starting dynamic subtest: pipe-D-eDP-1
[202.005920] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.358s)
[202.008246] Subtest alpha-transparent-fb: SUCCESS (2.254s)
[202.835472] [062/133] (817s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[202.915397] Starting subtest: fbc-rgb565-draw-pwrite
[207.444031] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.534s)
[208.619846] [063/133] (812s left) kms_joiner (basic-max-non-joiner)
[208.701330] Starting subtest: basic-max-non-joiner
[208.705606] Subtest basic-max-non-joiner: SKIP (0.000s)
[208.762709] [064/133] (811s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[208.837909] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[208.840289] Starting dynamic subtest: pipe-A-eDP-1
[208.860620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[208.870860] Starting dynamic subtest: pipe-B-eDP-1
[208.889569] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[208.897460] Starting dynamic subtest: pipe-C-eDP-1
[208.916496] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[208.924407] Starting dynamic subtest: pipe-D-eDP-1
[208.943703] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[208.945890] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[211.073772] [065/133] (809s left) kms_cursor_edge_walk (256x256-top-edge)
[211.158102] Starting subtest: 256x256-top-edge
[211.160375] Starting dynamic subtest: pipe-A-eDP-1
[214.645377] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[214.654760] Starting dynamic subtest: pipe-D-eDP-1
[217.769500] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[217.771835] Subtest 256x256-top-edge: SUCCESS (6.614s)
[218.567788] [066/133] (802s left) kms_content_protection (atomic-dpms-hdcp14)
[218.707179] Starting subtest: atomic-dpms-hdcp14
[218.711794] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[218.824852] [067/133] (802s left) perf_pmu (gt-awake)
[218.860837] Starting subtest: gt-awake
[227.867070] Subtest gt-awake: SUCCESS (9.004s)
[227.959050] [068/133] (792s left) kms_getfb (getfb2-handle-not-fb)
[228.046107] Starting subtest: getfb2-handle-not-fb
[228.048430] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[228.141225] [069/133] (792s left) gen9_exec_parse (batch-invalid-length)
[228.209345] Subtest batch-invalid-length: SKIP (0.000s)
[228.272893] [070/133] (792s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[228.342116] Starting subtest: plane-upscale-20x20-with-pixel-format
[228.344421] Starting dynamic subtest: pipe-A
[229.390412] Dynamic subtest pipe-A: SUCCESS (1.050s)
[229.401159] Starting dynamic subtest: pipe-B
[231.562689] Dynamic subtest pipe-B: SUCCESS (2.170s)
[231.570439] Starting dynamic subtest: pipe-C
[232.780322] Dynamic subtest pipe-C: SUCCESS (1.216s)
[232.789219] Starting dynamic subtest: pipe-D
[233.997945] Dynamic subtest pipe-D: SUCCESS (1.217s)
[234.000122] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.658s)
[235.184295] [071/133] (785s left) kms_rotation_crc (primary-rotation-180)
[235.271708] Starting subtest: primary-rotation-180
[242.162473] Subtest primary-rotation-180: SUCCESS (6.892s)
[243.369778] [072/133] (777s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[243.457259] Starting subtest: yf-tiled-32bpp-rotate-0
[243.461442] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[243.562844] [073/133] (777s left) device_reset (unbind-cold-reset-rebind)
[243.611650] Starting subtest: unbind-cold-reset-rebind
[243.616383] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[243.674336] [074/133] (777s left) kms_psr (psr2-no-drrs)
[243.743420] Starting subtest: psr2-no-drrs
[243.745682] Starting dynamic subtest: eDP-1
[245.337204] Dynamic subtest eDP-1: SUCCESS (1.594s)
[245.339473] Subtest psr2-no-drrs: SUCCESS (1.595s)
[246.129248] [075/133] (775s left) gem_fence_thrash (bo-write-verify-threaded-y)
[246.169607] Starting subtest: bo-write-verify-threaded-y
[246.186502] Subtest bo-write-verify-threaded-y: SKIP (0.017s)
[246.250070] [076/133] (774s left) kms_lease (master-vs-lease)
[246.314239] Starting subtest: master-vs-lease
[246.316480] Subtest master-vs-lease: SUCCESS (0.002s)
[246.419874] [077/133] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[246.505355] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[253.248302] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.747s)
[253.395499] [078/133] (767s left) kms_big_fb (linear-8bpp-rotate-270)
[253.483954] Starting subtest: linear-8bpp-rotate-270
[253.506063] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[253.605018] [079/133] (767s left) kms_cursor_crc (cursor-offscreen-512x170)
[253.848883] Starting subtest: cursor-offscreen-512x170
[253.853305] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[254.001409] [080/133] (767s left) gem_exec_reloc (basic-write-wc-active)
[254.068558] Subtest basic-write-wc-active: SKIP (0.000s)
[254.131999] [081/133] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[254.211991] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[254.215424] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[254.324487] [082/133] (767s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[254.414917] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[254.418301] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[254.509688] [083/133] (767s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[254.588170] Starting subtest: primary-4-tiled-reflect-x-0
[261.529879] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.942s)
[262.713863] [084/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[262.799704] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[266.426327] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.632s)
[267.611213] [085/133] (753s left) prime_mmap_coherency (ioctl-errors)
[267.675605] Starting subtest: ioctl-errors
[281.502883] Subtest ioctl-errors: SUCCESS (13.827s)
[281.695334] [086/133] (739s left) kms_pm_dc (dc5-dpms)
[282.816252] Starting subtest: dc5-dpms
[284.875969] Subtest dc5-dpms: SUCCESS (2.057s)
[284.951913] [087/133] (736s left) gem_busy (extended)
[285.132565] Starting subtest: extended
[285.134476] Starting dynamic subtest: rcs0
[285.214059] Dynamic subtest rcs0: SUCCESS (0.085s)
[285.226126] Starting dynamic subtest: bcs0
[285.255680] Dynamic subtest bcs0: SUCCESS (0.039s)
[285.267184] Starting dynamic subtest: vcs0
[286.873952] Dynamic subtest vcs0: SUCCESS (1.614s)
[286.887093] Starting dynamic subtest: vcs1
[288.857914] Dynamic subtest vcs1: SUCCESS (1.981s)
[288.869717] Starting dynamic subtest: vecs0
[290.841775] Dynamic subtest vecs0: SUCCESS (1.982s)
[290.855348] Starting dynamic subtest: ccs0
[290.888768] Dynamic subtest ccs0: SUCCESS (0.045s)
[290.891075] Subtest extended: SUCCESS (5.759s)
[291.127562] [088/133] (730s left) kms_cursor_legacy (torture-move)
[291.233559] Starting subtest: torture-move
[291.235708] Starting dynamic subtest: pipe-A
[297.049429] Dynamic subtest pipe-A: SUCCESS (5.811s)
[297.068913] Starting dynamic subtest: pipe-B
[304.133262] Dynamic subtest pipe-B: SUCCESS (7.082s)
[304.144049] Starting dynamic subtest: pipe-C
[312.142054] Dynamic subtest pipe-C: SUCCESS (8.005s)
[312.153433] Starting dynamic subtest: pipe-D
[319.146577] Dynamic subtest pipe-D: SUCCESS (7.004s)
[319.156046] Starting dynamic subtest: all-pipes
[326.164042] Dynamic subtest all-pipes: SUCCESS (7.017s)
[326.166194] Subtest torture-move: SUCCESS (34.929s)
[326.317412] [089/133] (695s left) prime_mmap (test_refcounting)
[326.397604] Starting subtest: test_refcounting
[326.399881] Starting dynamic subtest: test_refcounting-smem
[326.427556] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[326.429980] Subtest test_refcounting: SUCCESS (0.032s)
[326.520427] [090/133] (695s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[326.591442] Starting subtest: pr-cursor-plane-move-continuous-sf
[326.595602] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[326.659738] [091/133] (695s left) syncobj_timeline (invalid-signal-zero-handles)
[326.712785] Starting subtest: invalid-signal-zero-handles
[326.715340] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[326.800748] [092/133] (695s left) kms_big_fb (y-tiled-addfb)
[326.895789] Starting subtest: y-tiled-addfb
[326.900270] Subtest y-tiled-addfb: SKIP (0.000s)
[326.999020] [093/133] (694s left) i915_drm_fdinfo (busy)
[327.047311] Starting subtest: busy
[327.049452] Starting dynamic subtest: rcs0
[327.068588] Dynamic subtest rcs0: SKIP (0.021s)
[327.079374] Starting dynamic subtest: bcs0
[327.083594] Dynamic subtest bcs0: SKIP (0.000s)
[327.092077] Starting dynamic subtest: vcs0
[327.096134] Dynamic subtest vcs0: SKIP (0.000s)
[327.104565] Starting dynamic subtest: vcs1
[327.108736] Dynamic subtest vcs1: SKIP (0.000s)
[327.117110] Starting dynamic subtest: vecs0
[327.121252] Dynamic subtest vecs0: SKIP (0.000s)
[327.129621] Starting dynamic subtest: ccs0
[327.133849] Dynamic subtest ccs0: SKIP (0.000s)
[327.138115] Subtest busy: SKIP (0.025s)
[327.173584] [094/133] (694s left) i915_drm_fdinfo (virtual-busy-idle-all)
[327.215716] Starting subtest: virtual-busy-idle-all
[327.219504] Subtest virtual-busy-idle-all: SKIP (0.000s)
[327.304496] [095/133] (694s left) gem_close (many-handles-one-vma)
[327.349629] Starting subtest: many-handles-one-vma
[327.374193] Subtest many-handles-one-vma: SUCCESS (0.025s)
[327.478318] [096/133] (694s left) api_intel_bb (reset-bb)
[327.534303] Starting subtest: reset-bb
[327.538512] Subtest reset-bb: SUCCESS (0.004s)
[327.667780] [097/133] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[327.741813] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[327.745218] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[327.829947] [098/133] (694s left) prime_mmap (test_invalid_sync_flags)
[327.885572] Starting subtest: test_invalid_sync_flags
[327.887367] Starting dynamic subtest: test_invalid_sync_flags-smem
[327.888898] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[327.890482] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[327.968586] [099/133] (694s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[328.041067] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[328.044536] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[328.110369] [100/133] (694s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[328.204136] Starting subtest: flip-vs-cursor-atomic-transitions
[336.095841] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.887s)
[336.966170] [101/133] (685s left) kms_psr (fbc-psr2-cursor-render)
[337.046650] Starting subtest: fbc-psr2-cursor-render
[337.048917] Starting dynamic subtest: eDP-1
[337.053072] Dynamic subtest eDP-1: SKIP (0.000s)
[337.057176] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[337.156502] [102/133] (685s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[337.235457] Starting subtest: plane-lut1d-ctm3x4
[337.358647] Starting dynamic subtest: pipe-A-plane-0
[337.503105] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[337.512853] Starting dynamic subtest: pipe-A-plane-1
[337.647468] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[337.657064] Starting dynamic subtest: pipe-A-plane-2
[337.780419] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[338.941210] Starting dynamic subtest: pipe-B-plane-0
[339.078209] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[339.087740] Starting dynamic subtest: pipe-B-plane-1
[339.222384] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[339.231630] Starting dynamic subtest: pipe-B-plane-2
[339.355515] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[340.572520] Starting dynamic subtest: pipe-C-plane-0
[340.708866] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[340.717941] Starting dynamic subtest: pipe-C-plane-1
[340.853377] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[340.862964] Starting dynamic subtest: pipe-C-plane-2
[340.998113] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[342.200471] Starting dynamic subtest: pipe-D-plane-0
[342.327841] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[342.337250] Starting dynamic subtest: pipe-D-plane-1
[342.470306] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[342.481908] Starting dynamic subtest: pipe-D-plane-2
[342.615097] Dynamic subtest pipe-D-plane-2: SUCCESS (0.142s)
[342.902133] Subtest plane-lut1d-ctm3x4: SUCCESS (5.666s)
[343.775441] [103/133] (678s left) gem_mmap_gtt (hang-busy)
[343.833620] Subtest hang-busy: SKIP (0.000s)
[343.891717] [104/133] (678s left) kms_plane_lowres (tiling-none)
[343.962018] Starting subtest: tiling-none
[343.964358] Starting dynamic subtest: pipe-A-eDP-1
[343.968943] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[344.255588] Starting dynamic subtest: pipe-B-eDP-1
[344.260315] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[344.269450] Starting dynamic subtest: pipe-C-eDP-1
[344.274245] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[344.283338] Starting dynamic subtest: pipe-D-eDP-1
[344.287887] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[344.292371] Subtest tiling-none: SKIP (0.294s)
[345.103372] [105/133] (677s left) gem_ctx_isolation (nonpriv)
[345.158073] Starting subtest: nonpriv
[345.160509] Starting dynamic subtest: rcs0
[345.395032] Dynamic subtest rcs0: SUCCESS (0.237s)
[345.407194] Starting dynamic subtest: bcs0
[345.639838] Dynamic subtest bcs0: SUCCESS (0.244s)
[345.651236] Starting dynamic subtest: vcs0
[345.873274] Dynamic subtest vcs0: SUCCESS (0.232s)
[345.884734] Starting dynamic subtest: vcs1
[347.041231] Dynamic subtest vcs1: SUCCESS (1.167s)
[347.052746] Starting dynamic subtest: vecs0
[349.049856] Dynamic subtest vecs0: SUCCESS (2.008s)
[349.061404] Starting dynamic subtest: ccs0
[351.132138] Dynamic subtest ccs0: SUCCESS (2.081s)
[351.134534] Subtest nonpriv: SUCCESS (5.975s)
[351.360608] [106/133] (671s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[351.448135] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[351.542994] [107/133] (670s left) prime_busy (before)
[351.611179] Starting subtest: before
[351.616120] Starting dynamic subtest: rcs0
[351.656588] Dynamic subtest rcs0: SUCCESS (0.041s)
[351.666211] Starting dynamic subtest: bcs0
[351.703070] Dynamic subtest bcs0: SUCCESS (0.046s)
[351.712800] Starting dynamic subtest: vcs0
[351.743495] Dynamic subtest vcs0: SUCCESS (0.040s)
[351.752741] Starting dynamic subtest: vcs1
[351.784864] Dynamic subtest vcs1: SUCCESS (0.041s)
[351.794197] Starting dynamic subtest: vecs0
[351.826112] Dynamic subtest vecs0: SUCCESS (0.040s)
[351.835455] Starting dynamic subtest: ccs0
[351.865672] Dynamic subtest ccs0: SUCCESS (0.039s)
[351.974861] Subtest before: SUCCESS (0.362s)
[352.050108] [108/133] (670s left) kms_cdclk (plane-scaling)
[352.122786] Starting subtest: plane-scaling
[352.125187] Starting dynamic subtest: pipe-A-eDP-1
[352.413166] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[352.422633] Starting dynamic subtest: pipe-B-eDP-1
[352.426992] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[352.436060] Starting dynamic subtest: pipe-C-eDP-1
[352.440347] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[352.449298] Starting dynamic subtest: pipe-D-eDP-1
[352.453486] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[352.457849] Subtest plane-scaling: SKIP (0.296s)
[353.230603] [109/133] (669s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[353.307129] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[353.311310] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[353.397155] [110/133] (669s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[353.482132] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[353.486306] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[353.587850] [111/133] (669s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[353.681473] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[361.029139] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.352s)
[361.155458] [112/133] (661s left) gem_softpin (allocator-nopin-reserve)
[361.215917] Starting subtest: allocator-nopin-reserve
[361.319518] Subtest allocator-nopin-reserve: SUCCESS (0.101s)
[361.457176] [113/133] (661s left) perf (gen12-unprivileged-single-ctx-counters)
[361.606076] Starting subtest: gen12-unprivileged-single-ctx-counters
[361.608271] Starting dynamic subtest: rcs0
[361.646219] Dynamic subtest rcs0: SUCCESS (0.041s)
[361.648422] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.042s)
[361.699677] [114/133] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[361.804225] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[361.808734] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[361.906415] [115/133] (660s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[361.980613] Starting subtest: primary-x-tiled-reflect-x-180
[368.817309] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.838s)
[370.034486] [116/133] (652s left) sysfs_heartbeat_interval (mixed)
[370.092402] Starting subtest: mixed
[370.094768] Starting dynamic subtest: vecs0
[375.298147] Dynamic subtest vecs0: SUCCESS (5.205s)
[375.309847] Starting dynamic subtest: ccs0
[380.466088] Dynamic subtest ccs0: SUCCESS (5.166s)
[380.477797] Starting dynamic subtest: vcs0
[385.717908] Dynamic subtest vcs0: SUCCESS (5.250s)
[385.727851] Starting dynamic subtest: bcs0
[390.916277] Dynamic subtest bcs0: SUCCESS (5.197s)
[390.927897] Starting dynamic subtest: rcs0
[396.113140] Dynamic subtest rcs0: SUCCESS (5.194s)
[396.125106] Starting dynamic subtest: vcs1
[401.372321] Dynamic subtest vcs1: SUCCESS (5.258s)
[401.374866] Subtest mixed: SUCCESS (31.282s)
[401.460208] [117/133] (621s left) i915_selftest (live)
[403.228198] Starting subtest: live
[403.230768] Starting dynamic subtest: sanitycheck
[407.553557] Dynamic subtest sanitycheck: SUCCESS (4.323s)
[407.562076] Starting dynamic subtest: uncore
[411.845143] Dynamic subtest uncore: SUCCESS (4.290s)
[411.854713] Starting dynamic subtest: workarounds
[429.713651] Dynamic subtest workarounds: FAIL (17.378s)
[429.722907] Starting dynamic subtest: gt_engines
[432.286224] Dynamic subtest gt_engines: SUCCESS (3.062s)
[432.295722] Starting dynamic subtest: gt_timelines
[447.204927] Dynamic subtest gt_timelines: SUCCESS (14.915s)
[447.214098] Starting dynamic subtest: gt_contexts
[449.941280] Dynamic subtest gt_contexts: SUCCESS (2.734s)
[449.951023] Starting dynamic subtest: gt_lrc
[455.912467] Dynamic subtest gt_lrc: SUCCESS (5.969s)
[455.922360] Starting dynamic subtest: gt_mocs
[458.905629] Dynamic subtest gt_mocs: SUCCESS (2.991s)
[458.915311] Starting dynamic subtest: gt_pm
[465.626995] Dynamic subtest gt_pm: SUCCESS (6.719s)
[465.636136] Starting dynamic subtest: gt_heartbeat
[469.915057] Dynamic subtest gt_heartbeat: SUCCESS (4.286s)
[469.924984] Starting dynamic subtest: gt_tlb
[479.195299] Dynamic subtest gt_tlb: SUCCESS (9.278s)
[479.205664] Starting dynamic subtest: requests
[492.954228] Dynamic subtest requests: SUCCESS (13.757s)
[492.964670] Starting dynamic subtest: migrate
[498.775116] Dynamic subtest migrate: SUCCESS (5.819s)
[498.785264] Starting dynamic subtest: active
[503.126345] Dynamic subtest active: SUCCESS (4.349s)
[503.135553] Starting dynamic subtest: objects
[507.778395] Dynamic subtest objects: SUCCESS (4.650s)
[507.787107] Starting dynamic subtest: mman
[512.559774] Dynamic subtest mman: SUCCESS (4.780s)
[512.569079] Starting dynamic subtest: dmabuf
[516.880214] Dynamic subtest dmabuf: SUCCESS (4.319s)
[516.895590] Starting dynamic subtest: vma
[521.222034] Dynamic subtest vma: SUCCESS (4.339s)
[521.232200] Starting dynamic subtest: coherency
[526.229357] Dynamic subtest coherency: SUCCESS (5.005s)
[526.239678] Starting dynamic subtest: gtt
[535.447478] Dynamic subtest gtt: SUCCESS (9.215s)
[535.457400] Starting dynamic subtest: gem
[543.572827] Dynamic subtest gem: SUCCESS (8.123s)
[543.602431] Starting dynamic subtest: evict
[547.445112] Dynamic subtest evict: SUCCESS (3.869s)
[547.455325] Starting dynamic subtest: hugepages
[556.269190] Dynamic subtest hugepages: SUCCESS (8.820s)
[556.278886] Starting dynamic subtest: gem_contexts
[584.669527] Dynamic subtest gem_contexts: SUCCESS (28.397s)
[584.682626] Starting dynamic subtest: client
[587.421578] Dynamic subtest client: SUCCESS (2.751s)
[587.431141] Starting dynamic subtest: gem_migrate
[591.750986] Dynamic subtest gem_migrate: SUCCESS (4.327s)
[591.760990] Starting dynamic subtest: reset
[594.433609] Dynamic subtest reset: SUCCESS (2.680s)
[594.442670] Starting dynamic subtest: memory_region
[597.094752] Dynamic subtest memory_region: SUCCESS (2.658s)
[597.104813] Starting dynamic subtest: hangcheck
[610.703422] Dynamic subtest hangcheck: SUCCESS (13.606s)
[610.711740] Starting dynamic subtest: execlists
[615.030750] Dynamic subtest execlists: SUCCESS (4.326s)
[615.040479] Starting dynamic subtest: ring_submission
[619.342137] Dynamic subtest ring_submission: SUCCESS (4.309s)
[619.352057] Starting dynamic subtest: perf
[622.073538] Dynamic subtest perf: SUCCESS (2.729s)
[622.084087] Starting dynamic subtest: slpc
[633.762686] Dynamic subtest slpc: SUCCESS (11.686s)
[633.772321] Starting dynamic subtest: guc
[637.598547] Dynamic subtest guc: SUCCESS (3.834s)
[637.612191] Starting dynamic subtest: guc_multi_lrc
[641.952396] Dynamic subtest guc_multi_lrc: SUCCESS (4.352s)
[641.962275] Starting dynamic subtest: guc_hang
[646.777339] Dynamic subtest guc_hang: SUCCESS (4.822s)
[646.787637] Starting dynamic subtest: late_gt_pm
[651.049071] Dynamic subtest late_gt_pm: SUCCESS (4.270s)
[651.051917] Subtest live: FAIL (247.807s)
[651.084115] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[651.084782] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[651.088102] [118/133] (371s left) gem_exec_flush (basic-uc-set-default)
[652.582336] Starting subtest: basic-uc-set-default
[658.051494] Subtest basic-uc-set-default: SUCCESS (5.469s)
[658.213910] [FACT gem_exec_flush (basic-uc-set-default)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[658.215316] [FACT gem_exec_flush (basic-uc-set-default)] new: kernel.kmod_is_loaded.i915: true
[658.218956] [119/133] (364s left) gem_exec_schedule (u-submit-late-slice)
[658.289375] Starting subtest: u-submit-late-slice
[658.293094] Starting dynamic subtest: rcs0
[658.347532] Dynamic subtest rcs0: SUCCESS (0.065s)
[658.364040] Starting dynamic subtest: bcs0
[658.394052] Dynamic subtest bcs0: SUCCESS (0.047s)
[658.406982] Starting dynamic subtest: vcs0
[658.437129] Dynamic subtest vcs0: SUCCESS (0.042s)
[658.448188] Starting dynamic subtest: vcs1
[658.483562] Dynamic subtest vcs1: SUCCESS (0.045s)
[658.495788] Starting dynamic subtest: vecs0
[658.523573] Dynamic subtest vecs0: SUCCESS (0.040s)
[658.537260] Starting dynamic subtest: ccs0
[658.575618] Dynamic subtest ccs0: SUCCESS (0.050s)
[658.578227] Subtest u-submit-late-slice: SUCCESS (0.294s)
[659.955816] [120/133] (363s left) gem_ctx_bad_destroy (invalid-pad)
[660.004107] Starting subtest: invalid-pad
[660.006613] Subtest invalid-pad: SUCCESS (0.000s)
[660.076603] [121/133] (362s left) kms_psr2_su (page_flip-xrgb8888)
[660.137360] Subtest page_flip-XRGB8888: SKIP (0.000s)
[660.204703] [122/133] (362s left) kms_flip (2x-busy-flip)
[660.279871] Starting subtest: 2x-busy-flip
[660.286483] Subtest 2x-busy-flip: SKIP (0.007s)
[660.366751] [123/133] (362s left) syncobj_timeline (multi-wait-for-submit-signaled)
[660.419382] Starting subtest: multi-wait-for-submit-signaled
[660.422047] Subtest multi-wait-for-submit-signaled: SUCCESS (0.002s)
[660.535498] [124/133] (362s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[660.608874] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[660.611203] Starting dynamic subtest: pipe-A-eDP-1
[660.633985] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[660.646259] Starting dynamic subtest: pipe-B-eDP-1
[660.667563] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[660.675713] Starting dynamic subtest: pipe-C-eDP-1
[660.696224] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[660.704246] Starting dynamic subtest: pipe-D-eDP-1
[660.726589] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[660.730684] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[662.920848] [125/133] (360s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[663.000351] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[663.004924] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[663.119798] [126/133] (360s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[663.212277] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[670.516079] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.309s)
[670.640166] [127/133] (352s left) kms_properties (colorop-properties-atomic)
[670.708693] Starting subtest: colorop-properties-atomic
[670.710853] Starting dynamic subtest: pipe-A-eDP-1
[671.046695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.336s)
[671.056632] Starting dynamic subtest: pipe-B-eDP-1
[672.097015] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[672.113171] Starting dynamic subtest: pipe-C-eDP-1
[673.128489] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.032s)
[673.137711] Starting dynamic subtest: pipe-D-eDP-1
[674.154258] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.024s)
[674.156729] Subtest colorop-properties-atomic: SUCCESS (3.445s)
[674.972979] [128/133] (348s left) syncobj_wait (multi-wait-submitted)
[675.026580] Starting subtest: multi-wait-submitted
[675.133780] Subtest multi-wait-submitted: SUCCESS (0.107s)
[675.210835] [129/133] (348s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[675.295017] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[675.299227] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[675.396618] [130/133] (348s left) kms_psr (pr-cursor-mmap-gtt)
[675.470086] Starting subtest: pr-cursor-mmap-gtt
[675.474539] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[675.544125] [131/133] (347s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[675.609065] Starting subtest: single-wait-all-for-submit-signaled
[675.611241] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[675.701425] [132/133] (347s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[675.752190] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[675.852839] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[675.929367] [133/133] (347s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[676.000179] Starting subtest: fbc-psr-cursor-mmap-cpu
[676.002310] Starting dynamic subtest: eDP-1
[676.005946] Dynamic subtest eDP-1: SKIP (0.000s)
[676.009991] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[676.081983] Closing watchdogs
results: parsing output: 0/ for test: gem_lmem_swapping
results: parsing output: 1/ for test: prime_mmap
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_prime
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: gem_mmap
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: sw_sync
results: parsing output: 21/ for test: kms_feature_discovery
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: kms_universal_plane
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: gem_partial_pwrite_pread
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gen7_exec_parse
results: parsing output: 46/ for test: kms_chamelium_frames
results: parsing output: 47/ for test: kms_chamelium_frames
results: parsing output: 48/ for test: gem_caching
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_async_flips
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_pread
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: kms_plane_alpha_blend
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_joiner
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_cursor_edge_walk
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: gen9_exec_parse
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: device_reset
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_fence_thrash
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: prime_mmap_coherency
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: gem_busy
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: prime_mmap
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: gem_close
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: prime_mmap
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_plane_lowres
results: parsing output: 104/ for test: gem_ctx_isolation
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: prime_busy
results: parsing output: 107/ for test: kms_cdclk
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: sysfs_heartbeat_interval
results: parsing output: 116/ for test: i915_selftest
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: gem_ctx_bad_destroy
results: parsing output: 120/ for test: kms_psr2_su
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: kms_psr
Done.