[59.719262] Initializing watchdogs
[59.719311]   /dev/watchdog0
[59.733498] [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]
[59.737904] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.740191] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.743529] [001/133] (960s left) perf (whitelisted-registers-userspace-config)
[59.895463] Starting subtest: whitelisted-registers-userspace-config
[59.897673] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[59.940417] [002/133] (960s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[60.034692] Starting subtest: fbc-psr2-cursor-mmap-gtt
[60.037032] Starting dynamic subtest: eDP-1
[60.041434] Dynamic subtest eDP-1: SKIP (0.000s)
[60.045831] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[60.102851] [003/133] (960s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[60.208513] Starting subtest: x-tiled-32bpp-rotate-0
[61.720626] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.513s)
[61.863438] [004/133] (958s left) syncobj_eventfd (timeline-wait-before-signal)
[61.921210] Starting subtest: timeline-wait-before-signal
[61.950255] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[62.021998] [005/133] (958s left) gem_mmap_gtt (cpuset-basic-small-copy)
[62.078804] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[62.136419] [006/133] (958s left) i915_drm_fdinfo (idle)
[62.182944] Starting subtest: idle
[62.185019] Starting dynamic subtest: rcs0
[62.720950] Dynamic subtest rcs0: SUCCESS (0.532s)
[62.730826] Starting dynamic subtest: bcs0
[63.241184] Dynamic subtest bcs0: SUCCESS (0.521s)
[63.249066] Starting dynamic subtest: vcs0
[63.745304] Dynamic subtest vcs0: SUCCESS (0.504s)
[63.754145] Starting dynamic subtest: vcs1
[64.251771] Dynamic subtest vcs1: SUCCESS (0.504s)
[64.260578] Starting dynamic subtest: vecs0
[64.758241] Dynamic subtest vecs0: SUCCESS (0.505s)
[64.769050] Starting dynamic subtest: ccs0
[65.262591] Dynamic subtest ccs0: SUCCESS (0.503s)
[65.265592] Subtest idle: SUCCESS (3.078s)
[65.336188] [007/133] (955s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[65.436989] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[65.439607] Starting dynamic subtest: pipe-A-eDP-1
[65.588793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[65.600108] Starting dynamic subtest: pipe-B-eDP-1
[65.619773] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[65.629205] Starting dynamic subtest: pipe-C-eDP-1
[65.648696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[65.655572] Starting dynamic subtest: pipe-D-eDP-1
[65.674110] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[65.675846] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.177s)
[67.882157] [008/133] (952s left) vgem_slow (nohang)
[67.989119] Starting subtest: nohang
[78.453427] Subtest nohang: SUCCESS (10.464s)
[78.514231] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[78.517378] [009/133] (942s left) kms_cursor_crc (cursor-onscreen-512x170)
[78.800515] Starting subtest: cursor-onscreen-512x170
[78.805183] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[78.937237] [010/133] (941s left) gen7_exec_parse (cmd-crossing-page)
[79.000657] Subtest cmd-crossing-page: SKIP (0.000s)
[79.068103] [011/133] (941s left) kms_plane_multiple (tiling-4)
[79.160381] Starting subtest: tiling-4
[79.162756] Starting dynamic subtest: pipe-A-eDP-1
[82.913141] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.751s)
[82.921285] Starting dynamic subtest: pipe-B-eDP-1
[87.465316] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.550s)
[87.478045] Starting dynamic subtest: pipe-C-eDP-1
[91.797873] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.332s)
[91.806812] Starting dynamic subtest: pipe-D-eDP-1
[96.164860] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.365s)
[96.166839] Subtest tiling-4: SUCCESS (17.002s)
[96.973237] [012/133] (923s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[97.073528] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[98.072362] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.000s)
[98.215703] [013/133] (922s left) testdisplay
[98.514261] [014/133] (922s left) kms_flip (flip-vs-blocking-wf-vblank)
[98.600622] Starting subtest: flip-vs-blocking-wf-vblank
[98.602663] Starting dynamic subtest: A-eDP1
[107.516492] Dynamic subtest A-eDP1: SUCCESS (8.915s)
[107.524160] Starting dynamic subtest: B-eDP1
[116.450291] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[116.462358] Starting dynamic subtest: C-eDP1
[125.365757] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[125.373569] Starting dynamic subtest: D-eDP1
[134.301711] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[134.306563] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.705s)
[135.538629] [015/133] (885s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[135.607364] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[135.609832] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[135.704886] [016/133] (885s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[135.811595] Starting subtest: psr-rgb565-draw-pwrite
[142.978723] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.172s)
[143.120899] [017/133] (877s left) gem_ctx_param (invalid-get-engines)
[143.180737] Starting subtest: invalid-get-engines
[143.183099] Subtest invalid-get-engines: SUCCESS (0.001s)
[143.272282] [018/133] (877s left) gem_exec_balancer (bonded-sync)
[143.330490] Starting subtest: bonded-sync
[143.335175] Subtest bonded-sync: SKIP (0.000s)
[143.634092] [019/133] (877s left) kms_psr (fbc-pr-primary-blt)
[143.728301] Starting subtest: fbc-pr-primary-blt
[143.732499] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[143.801571] [020/133] (877s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[143.898568] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[151.049138] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.153s)
[151.161793] [021/133] (869s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[151.269653] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[152.339564] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.070s)
[152.447343] [022/133] (868s left) gem_exec_suspend (basic-s3-devices)
[152.513759] Starting subtest: basic-S3-devices
[152.516066] Starting dynamic subtest: smem
[163.930330] Dynamic subtest smem: SUCCESS (11.413s)
[163.932979] Subtest basic-S3-devices: SUCCESS (11.415s)
[164.116635] [023/133] (857s left) gem_exec_params (dr4-dirt)
[164.188079] Starting subtest: DR4-dirt
[164.190472] Subtest DR4-dirt: SUCCESS (0.000s)
[164.293764] [024/133] (856s left) kms_addfb_basic (unused-modifier)
[164.359425] Starting subtest: unused-modifier
[164.361412] Subtest unused-modifier: SUCCESS (0.000s)
[164.500104] [025/133] (856s left) gem_spin_batch (resubmit-new)
[164.572321] Starting subtest: resubmit-new
[164.574586] Starting dynamic subtest: rcs0
[164.579410] Dynamic subtest rcs0: SUCCESS (0.008s)
[164.589121] Starting dynamic subtest: bcs0
[164.591398] Dynamic subtest bcs0: SUCCESS (0.004s)
[164.601519] Starting dynamic subtest: vcs0
[164.604227] Dynamic subtest vcs0: SUCCESS (0.005s)
[164.613225] Starting dynamic subtest: vcs1
[164.615431] Dynamic subtest vcs1: SUCCESS (0.004s)
[164.623079] Starting dynamic subtest: vecs0
[164.625255] Dynamic subtest vecs0: SUCCESS (0.004s)
[164.632724] Starting dynamic subtest: ccs0
[164.635000] Dynamic subtest ccs0: SUCCESS (0.004s)
[164.637221] Subtest resubmit-new: SUCCESS (0.033s)
[165.949651] [026/133] (855s left) syncobj_wait (invalid-signal-illegal-handle)
[166.007065] Starting subtest: invalid-signal-illegal-handle
[166.008988] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[166.108278] [027/133] (855s left) kms_cdclk (plane-scaling)
[166.194837] Starting subtest: plane-scaling
[166.197137] Starting dynamic subtest: pipe-A-eDP-1
[166.484990] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[166.497527] Starting dynamic subtest: pipe-B-eDP-1
[166.502054] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[166.513899] Starting dynamic subtest: pipe-C-eDP-1
[166.518282] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[166.525793] Starting dynamic subtest: pipe-D-eDP-1
[166.529783] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[166.533676] Subtest plane-scaling: SKIP (0.295s)
[167.310558] [028/133] (854s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[167.397080] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[167.422566] Starting dynamic subtest: pipe-A-plane-0
[167.844887] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[167.856784] Starting dynamic subtest: pipe-A-plane-3
[168.100569] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[168.112149] Starting dynamic subtest: pipe-A-plane-5
[168.116397] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[169.185179] Starting dynamic subtest: pipe-B-plane-0
[169.611790] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[169.622433] Starting dynamic subtest: pipe-B-plane-3
[169.867228] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[169.875970] Starting dynamic subtest: pipe-B-plane-5
[169.880137] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[170.183271] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.786s)
[171.058900] [029/133] (850s left) syncobj_wait (invalid-reset-bad-pad)
[171.123234] Starting subtest: invalid-reset-bad-pad
[171.125178] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[171.209386] [030/133] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[171.313968] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[171.318127] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[171.418145] [031/133] (850s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[171.512487] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[171.514578] Starting dynamic subtest: pipe-A-eDP-1
[171.523207] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[171.531956] Starting dynamic subtest: pipe-B-eDP-1
[171.540586] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[171.548820] Starting dynamic subtest: pipe-C-eDP-1
[171.556972] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[171.564529] Starting dynamic subtest: pipe-D-eDP-1
[171.572626] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[171.576582] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[173.829754] [032/133] (847s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[173.922749] Starting subtest: plane-lut1d-pre-ctm3x4
[174.071694] Starting dynamic subtest: pipe-A-plane-0
[174.451208] Dynamic subtest pipe-A-plane-0: FAIL (0.213s)
[174.461619] Starting dynamic subtest: pipe-A-plane-1
[174.671685] Dynamic subtest pipe-A-plane-1: FAIL (0.182s)
[174.679590] Starting dynamic subtest: pipe-A-plane-2
[174.898866] Dynamic subtest pipe-A-plane-2: FAIL (0.179s)
[175.837508] Starting dynamic subtest: pipe-B-plane-0
[176.285193] Dynamic subtest pipe-B-plane-0: FAIL (0.185s)
[176.293290] Starting dynamic subtest: pipe-B-plane-1
[176.599033] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[176.608822] Starting dynamic subtest: pipe-B-plane-2
[176.903960] Dynamic subtest pipe-B-plane-2: FAIL (0.188s)
[177.630926] Starting dynamic subtest: pipe-C-plane-0
[178.127505] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[178.137464] Starting dynamic subtest: pipe-C-plane-1
[178.534429] Dynamic subtest pipe-C-plane-1: FAIL (0.600s)
[178.544161] Starting dynamic subtest: pipe-C-plane-2
[178.889212] Dynamic subtest pipe-C-plane-2: FAIL (0.172s)
[179.793459] Starting dynamic subtest: pipe-D-plane-0
[180.413928] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[180.423991] Starting dynamic subtest: pipe-D-plane-1
[180.884285] Dynamic subtest pipe-D-plane-1: FAIL (0.633s)
[180.894106] Starting dynamic subtest: pipe-D-plane-2
[181.336791] Dynamic subtest pipe-D-plane-2: FAIL (0.568s)
[181.460272] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.539s)
[182.331387] [033/133] (839s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[182.417371] Starting subtest: fb-8bpc-vs-panel-6bpc
[182.419676] Starting dynamic subtest: pipe-A-eDP-1
[183.825391] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.405s)
[183.827367] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.406s)
[184.696486] [034/133] (836s left) perf_pmu (busy-double-start)
[184.745669] Starting subtest: busy-double-start
[184.747939] Starting dynamic subtest: rcs0
[188.387813] Dynamic subtest rcs0: FAIL (3.574s)
[188.399459] Starting dynamic subtest: bcs0
[191.916682] Dynamic subtest bcs0: SUCCESS (3.597s)
[191.927731] Starting dynamic subtest: vcs0
[196.439958] Dynamic subtest vcs0: SUCCESS (4.521s)
[196.450822] Starting dynamic subtest: vcs1
[200.424744] Dynamic subtest vcs1: SUCCESS (3.983s)
[200.435803] Starting dynamic subtest: vecs0
[204.460737] Dynamic subtest vecs0: SUCCESS (4.034s)
[204.471459] Starting dynamic subtest: ccs0
[208.100355] Dynamic subtest ccs0: FAIL (3.565s)
[208.102736] Subtest busy-double-start: FAIL (23.283s)
[208.145730] [035/133] (813s left) gem_mmap_wc (bad-size)
[208.205289] Subtest bad-size: SKIP (0.000s)
[208.274530] [036/133] (813s left) gem_mmap_gtt (big-copy-odd)
[208.328223] Subtest big-copy-odd: SKIP (0.000s)
[208.388842] [037/133] (813s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[208.443384] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[208.516935] [038/133] (813s left) kms_sequence (get-idle)
[208.617879] Starting subtest: get-idle
[208.620189] Starting dynamic subtest: pipe-A-eDP-1
[210.432427] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[210.441724] Starting dynamic subtest: pipe-B-eDP-1
[212.879838] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.447s)
[212.892724] Starting dynamic subtest: pipe-C-eDP-1
[215.382055] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.501s)
[215.391977] Starting dynamic subtest: pipe-D-eDP-1
[217.823640] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[217.825690] Subtest get-idle: SUCCESS (9.204s)
[218.629452] [039/133] (803s left) kms_lease (atomic-implicit-crtc)
[218.716464] Starting subtest: atomic-implicit-crtc
[218.718707] Starting dynamic subtest: pipe-A-eDP-1
[218.729573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[218.743685] Starting dynamic subtest: pipe-B-eDP-1
[218.754889] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[218.763646] Starting dynamic subtest: pipe-C-eDP-1
[218.774703] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[218.783089] Starting dynamic subtest: pipe-D-eDP-1
[218.793917] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[218.796079] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[218.883769] [040/133] (802s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[218.987996] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[218.992427] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[219.062743] [041/133] (802s left) kms_getfb (getfb-handle-zero)
[219.147189] Starting subtest: getfb-handle-zero
[219.149473] Subtest getfb-handle-zero: SUCCESS (0.000s)
[219.244507] [042/133] (802s left) kms_atomic (plane-invalid-params-fence)
[219.354143] Starting subtest: plane-invalid-params-fence
[219.356415] Starting dynamic subtest: pipe-A-eDP-1
[219.706941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.352s)
[219.709318] Subtest plane-invalid-params-fence: SUCCESS (0.354s)
[220.571547] [043/133] (801s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[220.670099] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[220.674592] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[221.780385] [044/133] (800s left) gem_tiled_pread_basic (basic)
[221.832818] Subtest basic: SKIP (0.000s)
[221.899559] [045/133] (800s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[221.996592] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[222.001125] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[222.103860] [046/133] (799s left) gem_eio (in-flight-10ms)
[222.321557] Starting subtest: in-flight-10ms
[230.666259] Subtest in-flight-10ms: SUCCESS (8.346s)
[230.798125] [047/133] (791s left) gem_userptr_blits (invalid-null-pointer)
[230.872865] Starting subtest: invalid-null-pointer
[230.875216] Subtest invalid-null-pointer: SUCCESS (0.001s)
[230.997998] [048/133] (791s left) gem_softpin (overlap)
[231.063787] Starting subtest: overlap
[232.062963] Subtest overlap: SUCCESS (0.997s)
[232.187489] [049/133] (790s left) gem_render_copy (linear-to-vebox-y-tiled)
[232.242892] Starting subtest: linear-to-vebox-y-tiled
[232.247412] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[232.426970] [050/133] (789s left) gem_exec_schedule (fairslice-all)
[232.502496] Starting subtest: fairslice-all
[234.554849] Subtest fairslice-all: SUCCESS (2.062s)
[234.878254] [051/133] (787s left) gem_exec_fence (keep-in-fence)
[235.062359] Starting subtest: keep-in-fence
[235.064760] Starting dynamic subtest: rcs0
[235.140029] Dynamic subtest rcs0: SUCCESS (0.077s)
[235.152488] Starting dynamic subtest: bcs0
[235.197071] Dynamic subtest bcs0: SUCCESS (0.055s)
[235.208982] Starting dynamic subtest: vcs0
[236.888902] Dynamic subtest vcs0: SUCCESS (1.688s)
[236.900482] Starting dynamic subtest: vcs1
[238.936069] Dynamic subtest vcs1: SUCCESS (2.045s)
[238.951946] Starting dynamic subtest: vecs0
[240.921464] Dynamic subtest vecs0: SUCCESS (1.983s)
[240.932989] Starting dynamic subtest: ccs0
[241.163909] Dynamic subtest ccs0: SUCCESS (0.241s)
[241.166862] Subtest keep-in-fence: SUCCESS (6.102s)
[242.991296] [052/133] (779s left) syncobj_timeline (single-wait-available-submitted)
[243.055156] Starting subtest: single-wait-available-submitted
[243.057726] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[243.159720] [053/133] (779s left) kms_flip (basic-flip-vs-wf_vblank)
[243.254563] Starting subtest: basic-flip-vs-wf_vblank
[243.256903] Starting dynamic subtest: A-eDP1
[245.231838] Dynamic subtest A-eDP1: SUCCESS (1.977s)
[245.248472] Starting dynamic subtest: B-eDP1
[247.161897] Dynamic subtest B-eDP1: SUCCESS (1.927s)
[247.178174] Starting dynamic subtest: C-eDP1
[249.079819] Dynamic subtest C-eDP1: SUCCESS (1.916s)
[249.090367] Starting dynamic subtest: D-eDP1
[251.013419] Dynamic subtest D-eDP1: SUCCESS (1.930s)
[251.015851] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.761s)
[252.242915] [054/133] (770s left) kms_chamelium_frames (hdmi-frame-dump)
[252.655307] Subtest hdmi-frame-dump: SKIP (0.000s)
[253.454181] [055/133] (769s left) gem_ctx_shared (q-in-order)
[253.530118] Starting subtest: Q-in-order
[253.532443] Starting dynamic subtest: rcs0
[253.628393] Dynamic subtest rcs0: SUCCESS (0.100s)
[253.644761] Starting dynamic subtest: vcs0
[253.707862] Dynamic subtest vcs0: SUCCESS (0.079s)
[253.724270] Starting dynamic subtest: vcs1
[253.785422] Dynamic subtest vcs1: SUCCESS (0.075s)
[253.801571] Starting dynamic subtest: vecs0
[253.862923] Dynamic subtest vecs0: SUCCESS (0.077s)
[253.878858] Starting dynamic subtest: ccs0
[253.952969] Dynamic subtest ccs0: SUCCESS (0.089s)
[253.955905] Subtest Q-in-order: SUCCESS (0.425s)
[255.034305] [056/133] (767s left) syncobj_wait (single-wait-all-signaled)
[255.088657] Starting subtest: single-wait-all-signaled
[255.091018] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[255.184484] [057/133] (767s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[255.288060] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[262.671029] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.385s)
[262.787382] [058/133] (759s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[262.892813] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[262.897234] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[262.991199] [059/133] (759s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[263.047331] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[263.049820] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[263.149456] [060/133] (759s left) gem_pwrite_snooped
[263.288127] [061/133] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[263.382096] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[263.386188] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[263.482513] [062/133] (759s left) syncobj_timeline (multi-wait-all-available-submitted)
[263.531085] Starting subtest: multi-wait-all-available-submitted
[263.533417] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[263.625272] [063/133] (759s left) kms_pm_dc (dc9-dpms)
[264.726637] Starting subtest: dc9-dpms
[266.160753] Subtest dc9-dpms: SUCCESS (1.435s)
[266.228359] [064/133] (756s left) i915_drm_fdinfo (virtual-busy-idle-all)
[266.270106] Starting subtest: virtual-busy-idle-all
[266.274484] Subtest virtual-busy-idle-all: SKIP (0.000s)
[266.336401] [065/133] (756s left) i915_pm_rps (engine-order)
[266.393043] Starting subtest: engine-order
[271.384087] Subtest engine-order: SUCCESS (4.992s)
[271.507906] [066/133] (751s left) kms_psr (fbc-psr-sprite-render)
[271.605197] Starting subtest: fbc-psr-sprite-render
[271.607510] Starting dynamic subtest: eDP-1
[271.611705] Dynamic subtest eDP-1: SKIP (0.000s)
[271.615978] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[271.679889] [067/133] (751s left) kms_chamelium_hpd (vga-hpd-fast)
[272.086445] Subtest vga-hpd-fast: SKIP (0.000s)
[272.910799] [068/133] (750s left) api_intel_allocator (execbuf-with-allocator)
[272.968214] Starting subtest: execbuf-with-allocator
[272.971056] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[273.092510] [069/133] (749s left) i915_pm_rps (thresholds-idle)
[273.158477] Starting subtest: thresholds-idle
[273.162537] Subtest thresholds-idle: SKIP (0.000s)
[273.279156] [070/133] (749s left) dmabuf_sync_file (export-before-signal)
[273.319859] Starting subtest: export-before-signal
[273.322251] Subtest export-before-signal: SUCCESS (0.001s)
[273.383535] [071/133] (749s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[273.459268] Starting subtest: y-tiled-ccs-to-y-tiled
[273.463740] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[273.644456] [072/133] (749s left) prime_busy (hang-wait)
[273.705471] Starting subtest: hang-wait
[273.707948] Starting dynamic subtest: rcs0
[299.450541] Dynamic subtest rcs0: SUCCESS (25.740s)
[299.461607] Starting dynamic subtest: bcs0
[306.538073] Dynamic subtest bcs0: SUCCESS (7.088s)
[306.547082] Starting dynamic subtest: vcs0
[313.511111] Dynamic subtest vcs0: SUCCESS (6.971s)
[313.520352] Starting dynamic subtest: vcs1
[320.490066] Dynamic subtest vcs1: SUCCESS (6.974s)
[320.499145] Starting dynamic subtest: vecs0
[327.526566] Dynamic subtest vecs0: SUCCESS (7.033s)
[327.536935] Starting dynamic subtest: ccs0
[341.427165] Dynamic subtest ccs0: SUCCESS (13.901s)
[341.429609] Subtest hang-wait: SUCCESS (67.720s)
[341.559981] [073/133] (681s left) gem_exec_schedule (u-lateslice)
[341.638070] Starting subtest: u-lateslice
[341.640084] Starting dynamic subtest: rcs0
[341.657500] Dynamic subtest rcs0: SUCCESS (0.029s)
[341.672849] Starting dynamic subtest: bcs0
[341.686238] Dynamic subtest bcs0: SUCCESS (0.027s)
[341.697731] Starting dynamic subtest: vcs0
[341.707972] Dynamic subtest vcs0: SUCCESS (0.021s)
[341.717722] Starting dynamic subtest: vcs1
[341.731361] Dynamic subtest vcs1: SUCCESS (0.022s)
[341.740557] Starting dynamic subtest: vecs0
[341.753899] Dynamic subtest vecs0: SUCCESS (0.022s)
[341.763218] Starting dynamic subtest: ccs0
[341.776803] Dynamic subtest ccs0: SUCCESS (0.022s)
[341.779066] Subtest u-lateslice: SUCCESS (0.149s)
[342.956162] [074/133] (680s left) drm_read (fault-buffer)
[343.098238] Starting subtest: fault-buffer
[343.100576] Subtest fault-buffer: SUCCESS (0.000s)
[343.213937] [075/133] (680s left) gem_ctx_persistence (process)
[343.277626] Starting subtest: process
[343.414186] Subtest process: SUCCESS (0.137s)
[343.520975] [076/133] (679s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[343.615099] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[343.619111] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[343.699079] [077/133] (679s left) kms_hdr (static-toggle)
[343.799063] Starting subtest: static-toggle
[343.805423] Subtest static-toggle: SKIP (0.000s)
[343.871386] [078/133] (679s left) fbdev (write)
[343.911634] Starting subtest: write
[344.272917] Subtest write: SUCCESS (0.359s)
[344.337467] [079/133] (679s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[344.555067] Starting subtest: cursor-rapid-movement-128x42
[344.605346] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[344.809173] [080/133] (678s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[344.907765] Starting subtest: fbc-rgb565-draw-mmap-gtt
[344.911890] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[345.008665] [081/133] (678s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[345.108148] Starting subtest: fbcpsr-tiling-4
[352.260333] Subtest fbcpsr-tiling-4: SUCCESS (7.154s)
[352.400660] [082/133] (671s left) gem_exec_reloc (basic-write-read-active)
[352.460694] Subtest basic-write-read-active: SKIP (0.000s)
[352.532377] [083/133] (671s left) kms_vblank (ts-continuation-dpms-rpm)
[352.623274] Starting subtest: ts-continuation-dpms-rpm
[352.625161] Starting dynamic subtest: pipe-A-eDP-1
[355.142051] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.520s)
[355.157566] Starting dynamic subtest: pipe-D-eDP-1
[357.379682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.233s)
[357.381854] Subtest ts-continuation-dpms-rpm: SUCCESS (4.757s)
[358.178199] [084/133] (665s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[358.269052] Starting subtest: plane-use-after-nonblocking-unbind
[358.271269] Starting dynamic subtest: pipe-A-eDP-1
[358.330362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[358.634380] Starting dynamic subtest: pipe-B-eDP-1
[359.393242] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.767s)
[359.700886] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.433s)
[360.562243] [085/133] (663s left) gem_exec_whisper (basic-fds-priority-all)
[360.629566] Starting subtest: basic-fds-priority-all
[383.868796] Subtest basic-fds-priority-all: SUCCESS (23.237s)
[384.052287] [086/133] (639s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[384.160545] Starting subtest: fbc-shrfb-scaledprimary
[387.159329] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.002s)
[388.355059] [087/133] (635s left) kms_content_protection (lic-type-1)
[388.501696] Starting subtest: lic-type-1
[388.506252] Subtest lic-type-1: SKIP (0.000s)
[388.623332] [088/133] (635s left) gem_mmap_gtt (basic-wc)
[388.681120] Subtest basic-wc: SKIP (0.000s)
[388.738477] [089/133] (635s left) kms_plane (plane-position-hole)
[388.831567] Starting subtest: plane-position-hole
[389.353460] Starting dynamic subtest: pipe-A-plane-1
[390.659134] Dynamic subtest pipe-A-plane-1: SUCCESS (1.304s)
[390.670109] Starting dynamic subtest: pipe-A-plane-2
[391.963232] Dynamic subtest pipe-A-plane-2: SUCCESS (1.304s)
[391.973303] Starting dynamic subtest: pipe-A-plane-3
[393.267367] Dynamic subtest pipe-A-plane-3: SUCCESS (1.304s)
[393.278107] Starting dynamic subtest: pipe-A-plane-4
[394.522836] Dynamic subtest pipe-A-plane-4: SUCCESS (1.252s)
[394.533348] Starting dynamic subtest: pipe-A-plane-5
[394.547453] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[395.778601] Starting dynamic subtest: pipe-B-plane-1
[397.113512] Dynamic subtest pipe-B-plane-1: SUCCESS (1.342s)
[397.123184] Starting dynamic subtest: pipe-B-plane-2
[398.424036] Dynamic subtest pipe-B-plane-2: SUCCESS (1.310s)
[398.434071] Starting dynamic subtest: pipe-B-plane-3
[399.739710] Dynamic subtest pipe-B-plane-3: SUCCESS (1.317s)
[399.750913] Starting dynamic subtest: pipe-B-plane-4
[401.071649] Dynamic subtest pipe-B-plane-4: SUCCESS (1.332s)
[401.083616] Starting dynamic subtest: pipe-B-plane-5
[401.097736] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[401.100106] Subtest plane-position-hole: SUCCESS (12.268s)
[401.959163] [090/133] (622s left) kms_fbcon_fbt (fbc-suspend)
[402.020724] Starting subtest: fbc-suspend
[451.777989] Subtest fbc-suspend: SUCCESS (19.009s)
[453.103537] [091/133] (570s left) gem_mmap (basic-small-bo)
[453.159938] Subtest basic-small-bo: SKIP (0.000s)
[453.216534] [092/133] (570s left) gem_ringfill (engines-basic)
[458.666901] Starting subtest: engines-basic
[458.669846] Starting dynamic subtest: rcs0
[458.725366] Dynamic subtest rcs0: SUCCESS (0.059s)
[458.738027] Starting dynamic subtest: bcs0
[458.772357] Dynamic subtest bcs0: SUCCESS (0.045s)
[458.783818] Starting dynamic subtest: vcs0
[458.816359] Dynamic subtest vcs0: SUCCESS (0.042s)
[458.827503] Starting dynamic subtest: vcs1
[458.860987] Dynamic subtest vcs1: SUCCESS (0.042s)
[458.876889] Starting dynamic subtest: vecs0
[458.904284] Dynamic subtest vecs0: SUCCESS (0.041s)
[458.914870] Starting dynamic subtest: ccs0
[458.951297] Dynamic subtest ccs0: SUCCESS (0.045s)
[458.954262] Subtest engines-basic: SUCCESS (0.287s)
[459.031805] [093/133] (565s left) kms_pm_rpm (universal-planes)
[460.784037] Starting subtest: universal-planes
[460.786770] Starting dynamic subtest: plane-34
[469.119507] Dynamic subtest plane-34: SUCCESS (8.335s)
[469.132417] Starting dynamic subtest: plane-64
[477.408945] Dynamic subtest plane-64: SUCCESS (8.284s)
[477.421130] Starting dynamic subtest: plane-94
[485.700981] Dynamic subtest plane-94: SUCCESS (8.290s)
[485.714656] Starting dynamic subtest: plane-124
[494.018644] Dynamic subtest plane-124: SUCCESS (8.316s)
[494.030374] Starting dynamic subtest: plane-134
[502.334392] Dynamic subtest plane-134: SUCCESS (8.312s)
[502.351067] Starting dynamic subtest: plane-144
[510.653684] Dynamic subtest plane-144: SUCCESS (8.314s)
[510.656713] Subtest universal-planes: SUCCESS (49.870s)
[511.066525] [094/133] (513s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[511.339116] Starting subtest: parallel-dmabuf-import-out-fence
[512.753601] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.414s)
[512.844936] [095/133] (511s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[512.944139] Starting subtest: 4-tiled-addfb-size-offset-overflow
[512.946631] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[513.042337] [096/133] (511s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[513.150177] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[513.155152] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[513.235152] [097/133] (511s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[513.333303] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[536.315616] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.982s)
[536.443195] [098/133] (487s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[536.553610] Starting subtest: fbc-rgb101010-draw-blt
[541.179480] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.627s)
[542.363052] [099/133] (482s left) kms_psr (psr-sprite-plane-move)
[542.456949] Starting subtest: psr-sprite-plane-move
[542.459122] Starting dynamic subtest: eDP-1
[544.206067] Dynamic subtest eDP-1: SUCCESS (1.749s)
[544.209019] Subtest psr-sprite-plane-move: SUCCESS (1.750s)
[545.036522] [100/133] (479s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[545.159011] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[545.164364] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[545.302643] [101/133] (479s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[545.396779] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[545.401755] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[545.489037] [102/133] (479s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[545.587040] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[545.592154] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[545.689036] [103/133] (478s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[545.789065] Starting subtest: yf-tiled-8bpp-rotate-90
[545.794520] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[545.884318] [104/133] (478s left) gem_exec_params (invalid-bsd-ring)
[545.944778] Starting subtest: invalid-bsd-ring
[545.947651] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[546.051515] [105/133] (478s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[546.142836] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[546.144916] Starting dynamic subtest: pipe-A
[546.169380] Dynamic subtest pipe-A: SKIP (0.022s)
[546.179137] Starting dynamic subtest: pipe-B
[546.201833] Dynamic subtest pipe-B: SKIP (0.033s)
[546.211766] Starting dynamic subtest: pipe-C
[546.234678] Dynamic subtest pipe-C: SKIP (0.031s)
[546.244165] Starting dynamic subtest: pipe-D
[546.265708] Dynamic subtest pipe-D: SKIP (0.031s)
[546.269290] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.119s)
[546.364431] [106/133] (478s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[546.457100] Starting subtest: flip-vs-dpms-off-vs-modeset
[546.459431] Starting dynamic subtest: A-eDP1
[550.077363] Dynamic subtest A-eDP1: SUCCESS (3.619s)
[550.089027] Starting dynamic subtest: B-eDP1
[553.291355] Dynamic subtest B-eDP1: SUCCESS (3.213s)
[553.302179] Starting dynamic subtest: C-eDP1
[556.395336] Dynamic subtest C-eDP1: SUCCESS (3.101s)
[556.406197] Starting dynamic subtest: D-eDP1
[559.477549] Dynamic subtest D-eDP1: SUCCESS (3.081s)
[559.480045] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.022s)
[560.274036] [107/133] (464s left) gem_exec_schedule (manyslice)
[560.350943] Starting subtest: manyslice
[560.353715] Starting dynamic subtest: rcs0
[565.481632] Dynamic subtest rcs0: SUCCESS (5.145s)
[565.499201] Starting dynamic subtest: bcs0
[573.159241] Dynamic subtest bcs0: SUCCESS (7.676s)
[573.174069] Starting dynamic subtest: vcs0
[579.257614] Dynamic subtest vcs0: SUCCESS (6.097s)
[579.271273] Starting dynamic subtest: vcs1
[585.368833] Dynamic subtest vcs1: SUCCESS (6.109s)
[585.384236] Starting dynamic subtest: vecs0
[591.979790] Dynamic subtest vecs0: SUCCESS (6.609s)
[591.994471] Starting dynamic subtest: ccs0
[598.675262] Dynamic subtest ccs0: SUCCESS (6.692s)
[598.677899] Subtest manyslice: SUCCESS (38.338s)
[598.981497] [108/133] (425s left) gem_create (create-ext-cpu-access-sanity-check)
[599.164843] Starting subtest: create-ext-cpu-access-sanity-check
[599.170671] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[599.247248] [109/133] (425s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[599.376568] Starting subtest: 2x-flip-vs-cursor-atomic
[599.381465] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[599.524522] [110/133] (425s left) prime_vgem (basic-gtt)
[599.576898] Starting subtest: basic-gtt
[599.581878] Subtest basic-gtt: SKIP (0.000s)
[599.670069] [111/133] (425s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[599.724729] Starting subtest: invalid-bsd1-flag-on-blt
[599.727435] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[599.823501] [112/133] (425s left) kms_psr (fbc-psr-dpms)
[599.908840] Starting subtest: fbc-psr-dpms
[599.911394] Starting dynamic subtest: eDP-1
[599.915945] Dynamic subtest eDP-1: SKIP (0.000s)
[599.920938] Subtest fbc-psr-dpms: SKIP (0.001s)
[599.985148] [113/133] (425s left) kms_flip (flip-vs-expired-vblank)
[600.089292] Starting subtest: flip-vs-expired-vblank
[600.092113] Starting dynamic subtest: A-eDP1
[608.776440] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[608.788514] Starting dynamic subtest: B-eDP1
[617.414676] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[617.426481] Starting dynamic subtest: C-eDP1
[626.046005] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[626.056833] Starting dynamic subtest: D-eDP1
[634.680614] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[634.683277] Subtest flip-vs-expired-vblank: SUCCESS (34.591s)
[635.856567] [114/133] (389s left) gem_exec_params (cliprects-invalid)
[635.912870] Starting subtest: cliprects-invalid
[635.915365] Subtest cliprects-invalid: SUCCESS (0.000s)
[636.015453] [115/133] (389s left) kms_psr (psr2-primary-mmap-gtt)
[636.109144] Starting subtest: psr2-primary-mmap-gtt
[636.111407] Starting dynamic subtest: eDP-1
[637.546511] Dynamic subtest eDP-1: SKIP (1.434s)
[637.551401] Subtest psr2-primary-mmap-gtt: SKIP (1.436s)
[637.689011] [116/133] (387s left) gem_mmap_offset (bad-flags)
[637.745728] Starting subtest: bad-flags
[637.747844] Subtest bad-flags: SUCCESS (0.000s)
[637.844300] [117/133] (387s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[637.940981] Starting subtest: psr-2p-primscrn-spr-indfb-move
[637.945955] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[638.040769] [118/133] (387s left) kms_feature_discovery (display)
[638.137258] Starting subtest: display
[638.139946] Subtest display: SUCCESS (0.000s)
[638.213318] [119/133] (387s left) kms_pipe_stress (stress-xrgb8888-untiled)
[638.311148] Starting subtest: stress-xrgb8888-untiled
[644.299364] Subtest stress-xrgb8888-untiled: SUCCESS (5.987s)
[644.358615] [120/133] (380s left) kms_cursor_edge_walk (256x256-top-edge)
[644.443973] Starting subtest: 256x256-top-edge
[644.446408] Starting dynamic subtest: pipe-A-eDP-1
[647.947652] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[647.959111] Starting dynamic subtest: pipe-D-eDP-1
[651.074822] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[651.077121] Subtest 256x256-top-edge: SUCCESS (6.628s)
[651.876398] [121/133] (373s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[651.968660] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[651.973717] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[652.061467] [122/133] (373s left) vgem_basic (bad-flag)
[652.101969] Starting subtest: bad-flag
[652.104413] Subtest bad-flag: SUCCESS (0.000s)
[652.157834] [123/133] (373s left) gem_sync (basic-many-each)
[652.228831] Starting subtest: basic-many-each
[654.511065] Subtest basic-many-each: SUCCESS (2.293s)
[654.700513] [124/133] (370s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[654.800135] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[654.805878] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[654.893696] [125/133] (370s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[654.986951] Starting subtest: pr-primary-plane-update-sf-dmg-area
[654.992304] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[655.057649] [126/133] (370s left) gem_exercise_blt (fast-copy)
[655.116073] Starting subtest: fast-copy
[655.118491] Starting dynamic subtest: linear-smem-smem
[655.141044] Dynamic subtest linear-smem-smem: SUCCESS (0.026s)
[655.151829] Starting dynamic subtest: xmajor-smem-smem
[655.161373] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[655.171617] Starting dynamic subtest: tile4-smem-smem
[655.178514] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[655.188722] Starting dynamic subtest: tile64-smem-smem
[655.195493] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[655.198074] Subtest fast-copy: SUCCESS (0.081s)
[655.311730] [127/133] (370s left) perf_pmu (event-wait)
[655.348924] Starting subtest: event-wait
[655.351118] Starting dynamic subtest: rcs0
[655.356231] Dynamic subtest rcs0: SKIP (0.000s)
[655.361303] Subtest event-wait: SKIP (0.001s)
[655.451923] [128/133] (370s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[655.538778] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[655.914058] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[658.646436] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.731s)
[658.658774] Starting dynamic subtest: pipe-A-eDP-1-4
[660.833185] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[660.845164] Starting dynamic subtest: pipe-A-eDP-1-4
[662.843089] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[662.853929] Starting dynamic subtest: pipe-A-eDP-1-x
[665.045144] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[665.424048] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[668.177200] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[668.188912] Starting dynamic subtest: pipe-B-eDP-1-4
[670.374381] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[670.386561] Starting dynamic subtest: pipe-B-eDP-1-4
[672.385053] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[672.395825] Starting dynamic subtest: pipe-B-eDP-1-x
[674.587288] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[674.982340] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[677.728546] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.737s)
[677.740662] Starting dynamic subtest: pipe-C-eDP-1-4
[679.886980] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[679.898208] Starting dynamic subtest: pipe-C-eDP-1-4
[681.897167] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[681.910155] Starting dynamic subtest: pipe-C-eDP-1-x
[684.075581] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[684.455128] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[687.247827] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[687.261837] Starting dynamic subtest: pipe-D-eDP-1-4
[689.421406] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[689.436171] Starting dynamic subtest: pipe-D-eDP-1-4
[691.431606] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[691.443072] Starting dynamic subtest: pipe-D-eDP-1-x
[693.621566] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[693.624669] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.083s)
[694.827209] [129/133] (330s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[694.924321] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[698.901828] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.981s)
[700.038733] [130/133] (325s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[700.157541] Starting subtest: 2x-long-cursor-vs-flip-atomic
[700.162837] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[700.305626] [131/133] (325s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[700.388125] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[700.390510] Starting dynamic subtest: pipe-A-eDP-1
[700.415822] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[700.427715] Starting dynamic subtest: pipe-B-eDP-1
[700.451020] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[700.460844] Starting dynamic subtest: pipe-C-eDP-1
[700.486122] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[700.495917] Starting dynamic subtest: pipe-D-eDP-1
[700.521619] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[700.526677] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[702.687502] [132/133] (323s left) api_intel_bb (object-noreloc-keep-cache-simple)
[702.739108] Starting subtest: object-noreloc-keep-cache-simple
[702.745754] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.009s)
[702.854217] [133/133] (323s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[702.945829] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[709.777038] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.834s)
[709.913197] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: syncobj_eventfd
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: vgem_slow
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: gen7_exec_parse
results: parsing output: 10/ for test: kms_plane_multiple
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: testdisplay
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_exec_suspend
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: gem_spin_batch
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_cdclk
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_color_pipeline
results: parsing output: 32/ for test: kms_dither
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: kms_sequence
results: parsing output: 38/ for test: kms_lease
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_getfb
results: parsing output: 41/ for test: kms_atomic
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_tiled_pread_basic
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_chamelium_frames
results: parsing output: 54/ for test: gem_ctx_shared
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_pwrite_snooped
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_pm_dc
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: i915_pm_rps
results: parsing output: 69/ for test: dmabuf_sync_file
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: prime_busy
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: drm_read
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: fbdev
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: kms_atomic_transition
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: kms_fbcon_fbt
results: parsing output: 90/ for test: gem_mmap
results: parsing output: 91/ for test: gem_ringfill
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_exec_params
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_create
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_feature_discovery
results: parsing output: 118/ for test: kms_pipe_stress
results: parsing output: 119/ for test: kms_cursor_edge_walk
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: vgem_basic
results: parsing output: 122/ for test: gem_sync
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_exercise_blt
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_async_flips
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: api_intel_bb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.