[56.662120] Initializing watchdogs
[56.662169]   /dev/watchdog0
[56.675229] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.679092] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.681193] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.684281] [001/131] (960s left) kms_flip (2x-busy-flip)
[56.848081] Starting subtest: 2x-busy-flip
[56.858811] Subtest 2x-busy-flip: SKIP (0.010s)
[56.974555] [002/131] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[57.075865] Starting subtest: primary-yf-tiled-reflect-x-90
[57.080330] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[57.139449] [003/131] (960s left) gen9_exec_parse (basic-rejected-ctx-param)
[57.201219] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[57.261181] [004/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[57.355394] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[60.641841] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (3.286s)
[60.745554] [005/131] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[60.848738] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[60.852178] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[60.954427] [006/131] (956s left) kms_cursor_edge_walk (128x128-top-bottom)
[61.044514] Starting subtest: 128x128-top-bottom
[61.046521] Starting dynamic subtest: pipe-A-eDP-1
[64.469835] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[64.477935] Starting dynamic subtest: pipe-D-eDP-1
[67.599190] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[67.601484] Subtest 128x128-top-bottom: SUCCESS (6.546s)
[68.390675] [007/131] (948s left) gem_exec_params (rel-constants-invalid-ring)
[68.458228] Starting subtest: rel-constants-invalid-ring
[68.460497] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[68.553739] [008/131] (948s left) kms_flip (dpms-vs-vblank-race)
[68.657469] Starting subtest: dpms-vs-vblank-race
[68.659824] Starting dynamic subtest: A-eDP1
[73.653740] Dynamic subtest A-eDP1: SUCCESS (4.992s)
[73.661839] Starting dynamic subtest: B-eDP1
[78.264445] Dynamic subtest B-eDP1: SUCCESS (4.606s)
[78.272710] Starting dynamic subtest: C-eDP1
[82.845050] Dynamic subtest C-eDP1: SUCCESS (4.580s)
[82.855035] Starting dynamic subtest: D-eDP1
[87.440505] Dynamic subtest D-eDP1: SUCCESS (4.594s)
[87.442695] Subtest dpms-vs-vblank-race: SUCCESS (18.778s)
[88.313079] [009/131] (929s left) kms_addfb_basic (basic-x-tiled-legacy)
[88.372121] Starting subtest: basic-x-tiled-legacy
[88.376430] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[88.520152] [010/131] (928s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[88.633693] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[88.637964] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[88.738732] [011/131] (928s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[88.837576] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[88.842072] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[88.930580] [012/131] (928s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[88.987294] Starting subtest: yf-tiled-to-vebox-yf-tiled
[88.991938] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[89.162418] [013/131] (928s left) gem_mmap_wc (set-cache-level)
[89.217414] Subtest set-cache-level: SKIP (0.000s)
[89.265191] [014/131] (928s left) gem_exec_schedule (submit-golden-slice)
[89.329084] Starting subtest: submit-golden-slice
[89.331114] Starting dynamic subtest: rcs0
[89.352077] Dynamic subtest rcs0: SUCCESS (0.031s)
[89.361136] Starting dynamic subtest: bcs0
[89.377464] Dynamic subtest bcs0: SUCCESS (0.025s)
[89.384293] Starting dynamic subtest: vcs0
[89.405975] Dynamic subtest vcs0: SUCCESS (0.028s)
[89.413085] Starting dynamic subtest: vcs1
[89.432664] Dynamic subtest vcs1: SUCCESS (0.027s)
[89.439656] Starting dynamic subtest: vecs0
[89.461204] Dynamic subtest vecs0: SUCCESS (0.028s)
[89.468713] Starting dynamic subtest: ccs0
[89.489852] Dynamic subtest ccs0: SUCCESS (0.029s)
[89.492179] Subtest submit-golden-slice: SUCCESS (0.169s)
[91.018425] [015/131] (926s left) gem_exec_fence (syncobj-signal)
[91.464878] Starting subtest: syncobj-signal
[91.472829] Subtest syncobj-signal: SUCCESS (0.008s)
[92.962680] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[92.965721] [016/131] (924s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[93.032922] Starting subtest: basic-batch-kernel-default-cmd
[93.037199] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[93.213860] [017/131] (924s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[93.328820] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[93.333153] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[93.429998] [018/131] (924s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[93.531795] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[97.850547] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.321s)
[97.964620] [019/131] (919s left) kms_psr (psr-sprite-mmap-gtt)
[98.071150] Starting subtest: psr-sprite-mmap-gtt
[98.073476] Starting dynamic subtest: eDP-1
[99.490058] Dynamic subtest eDP-1: SKIP (1.413s)
[99.495236] Subtest psr-sprite-mmap-gtt: SKIP (1.414s)
[99.659345] [020/131] (918s left) gem_mmap_wc (write-cpu-read-wc)
[99.716481] Subtest write-cpu-read-wc: SKIP (0.000s)
[99.767316] [021/131] (918s left) kms_cursor_crc (cursor-random-256x85)
[100.015971] Starting subtest: cursor-random-256x85
[100.058823] Subtest cursor-random-256x85: SKIP (0.038s)
[100.207312] [022/131] (917s left) api_intel_bb (blit-noreloc-purge-cache)
[100.265323] Starting subtest: blit-noreloc-purge-cache
[100.273523] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[100.407573] [023/131] (917s left) kms_pipe_crc_basic (hang-read-crc)
[100.505361] Starting subtest: hang-read-crc
[100.507294] Starting dynamic subtest: pipe-A-eDP-1
[102.543158] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.035s)
[102.551221] Starting dynamic subtest: pipe-B-eDP-1
[105.197430] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.652s)
[105.206153] Starting dynamic subtest: pipe-C-eDP-1
[107.813101] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.615s)
[107.821417] Starting dynamic subtest: pipe-D-eDP-1
[110.493947] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.682s)
[110.496377] Subtest hang-read-crc: SUCCESS (9.987s)
[111.314316] [024/131] (906s left) gem_ctx_persistence (legacy-engines-mixed)
[111.385179] Starting subtest: legacy-engines-mixed
[111.387341] Starting dynamic subtest: render
[111.500225] Dynamic subtest render: SUCCESS (0.117s)
[111.511512] Starting dynamic subtest: bsd1
[111.582697] Dynamic subtest bsd1: SUCCESS (0.080s)
[111.592667] Starting dynamic subtest: bsd2
[111.672957] Dynamic subtest bsd2: SUCCESS (0.089s)
[111.682988] Starting dynamic subtest: blt
[111.725922] Dynamic subtest blt: SUCCESS (0.052s)
[111.736111] Starting dynamic subtest: vebox
[111.798282] Dynamic subtest vebox: SUCCESS (0.070s)
[111.801102] Subtest legacy-engines-mixed: SUCCESS (0.416s)
[111.868088] [025/131] (906s left) gem_exec_schedule (preempt-queue-chain)
[111.943230] Subtest preempt-queue-chain: SKIP (0.000s)
[112.223335] [026/131] (905s left) gem_exec_capture (capture-invisible)
[112.290891] Starting subtest: capture-invisible
[112.293393] Starting dynamic subtest: smem0
[112.297787] Dynamic subtest smem0: SKIP (0.000s)
[112.302304] Subtest capture-invisible: SKIP (0.000s)
[112.398834] [027/131] (905s left) kms_dsc (dsc-with-output-formats)
[112.498088] Starting subtest: dsc-with-output-formats
[112.520253] Subtest dsc-with-output-formats: SKIP (0.001s)
[112.563382] [028/131] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[112.664277] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[117.106750] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.445s)
[117.236087] [029/131] (900s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[117.336589] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[117.339111] Starting dynamic subtest: pipe-A
[117.422886] Dynamic subtest pipe-A: SUCCESS (0.087s)
[117.431163] Starting dynamic subtest: pipe-B
[118.597046] Dynamic subtest pipe-B: SUCCESS (1.173s)
[118.606665] Starting dynamic subtest: pipe-C
[119.703253] Dynamic subtest pipe-C: SUCCESS (1.106s)
[119.711588] Starting dynamic subtest: pipe-D
[120.825385] Dynamic subtest pipe-D: SUCCESS (1.122s)
[120.827695] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.489s)
[121.978251] [030/131] (896s left) syncobj_wait (invalid-reset-illegal-handle)
[122.035326] Starting subtest: invalid-reset-illegal-handle
[122.037669] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[122.143909] [031/131] (895s left) gem_pwrite (basic-self)
[122.205497] Subtest basic-self: SKIP (0.000s)
[122.263409] [032/131] (895s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[122.659791] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[123.478490] [033/131] (894s left) kms_chamelium_edid (dp-edid-resolution-list)
[123.864394] Subtest dp-edid-resolution-list: SKIP (0.000s)
[124.703761] [034/131] (893s left) kms_invalid_mode (overflow-vrefresh)
[124.809405] Starting subtest: overflow-vrefresh
[124.811704] Starting dynamic subtest: pipe-A-eDP-1
[125.099917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[125.108685] Starting dynamic subtest: pipe-B-eDP-1
[125.111053] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[125.118064] Starting dynamic subtest: pipe-C-eDP-1
[125.120323] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[125.127371] Starting dynamic subtest: pipe-D-eDP-1
[125.129365] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[125.131362] Subtest overflow-vrefresh: SUCCESS (0.297s)
[125.952973] [035/131] (892s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[126.050194] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[126.052568] Starting dynamic subtest: pipe-A-eDP-1
[142.631593] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.458s)
[142.640247] Starting dynamic subtest: pipe-B-eDP-1
[159.492065] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.291s)
[159.501082] Starting dynamic subtest: pipe-C-eDP-1
[176.471064] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.300s)
[176.480638] Starting dynamic subtest: pipe-D-eDP-1
[193.463989] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.192s)
[193.466369] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.244s)
[194.681317] [036/131] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[194.794444] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[194.799056] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[194.882507] [037/131] (882s left) kms_cdclk (plane-scaling)
[194.979352] Starting subtest: plane-scaling
[194.981681] Starting dynamic subtest: pipe-A-eDP-1
[195.266991] Dynamic subtest pipe-A-eDP-1: SKIP (0.281s)
[195.275389] Starting dynamic subtest: pipe-B-eDP-1
[195.280120] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[195.288031] Starting dynamic subtest: pipe-C-eDP-1
[195.292760] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[195.300530] Starting dynamic subtest: pipe-D-eDP-1
[195.305159] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[195.309674] Subtest plane-scaling: SKIP (0.288s)
[196.113123] [038/131] (881s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[196.223253] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[200.779574] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.544s)
[200.929928] [039/131] (876s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[201.045320] Starting subtest: x-tiled-8bpp-rotate-90
[201.066155] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[201.186672] [040/131] (876s left) kms_psr (pr-cursor-render)
[201.283710] Starting subtest: pr-cursor-render
[201.287710] Subtest pr-cursor-render: SKIP (0.000s)
[201.349607] [041/131] (876s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[201.452931] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[201.457151] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[201.541038] [042/131] (876s left) gem_userptr_blits (stress-mm)
[201.614644] Starting subtest: stress-mm
[206.994963] Subtest stress-mm: SUCCESS (5.370s)
[207.124667] [043/131] (870s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[207.223770] Starting subtest: plane-upscale-20x20-with-modifiers
[207.226136] Starting dynamic subtest: pipe-A
[207.562300] Dynamic subtest pipe-A: SUCCESS (0.338s)
[207.569974] Starting dynamic subtest: pipe-B
[208.990556] Dynamic subtest pipe-B: SUCCESS (1.426s)
[208.998258] Starting dynamic subtest: pipe-C
[210.422044] Dynamic subtest pipe-C: SUCCESS (1.429s)
[210.429791] Starting dynamic subtest: pipe-D
[211.851668] Dynamic subtest pipe-D: SUCCESS (1.428s)
[211.853942] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.623s)
[213.012788] [044/131] (864s left) perf (gen12-group-concurrent-oa-buffer-read)
[213.126403] Starting subtest: gen12-group-concurrent-oa-buffer-read
[223.160724] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.027s)
[223.202875] [045/131] (854s left) kms_sequence (queue-idle)
[223.295736] Starting subtest: queue-idle
[223.297982] Starting dynamic subtest: pipe-A-eDP-1
[225.111128] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[225.124636] Starting dynamic subtest: pipe-B-eDP-1
[227.593721] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.484s)
[227.602965] Starting dynamic subtest: pipe-C-eDP-1
[230.006982] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.414s)
[230.015358] Starting dynamic subtest: pipe-D-eDP-1
[232.435482] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.426s)
[232.437882] Subtest queue-idle: SUCCESS (9.142s)
[233.231965] [046/131] (844s left) syncobj_timeline (multi-wait-all-signaled)
[233.296360] Starting subtest: multi-wait-all-signaled
[233.298759] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[233.388441] [047/131] (844s left) kms_atomic (plane-invalid-params)
[233.491338] Starting subtest: plane-invalid-params
[233.493635] Starting dynamic subtest: pipe-A-eDP-1
[233.896099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.403s)
[233.898646] Subtest plane-invalid-params: SUCCESS (0.405s)
[234.752074] [048/131] (843s left) gem_exec_reloc (basic-gtt-active)
[234.812346] Subtest basic-gtt-active: SKIP (0.000s)
[234.883671] [049/131] (843s left) gem_readwrite (write-bad-handle)
[234.947347] Subtest write-bad-handle: SKIP (0.000s)
[235.000861] [050/131] (842s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[235.101051] Starting subtest: 2x-absolute-wf_vblank-interruptible
[235.113722] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[235.191304] [051/131] (842s left) kms_frontbuffer_tracking (psr-suspend)
[235.299231] Starting subtest: psr-suspend
[271.597593] Subtest psr-suspend: SUCCESS (5.482s)
[271.718313] [052/131] (837s left) gem_mmap_gtt (big-copy-odd)
[271.772907] Subtest big-copy-odd: SKIP (0.000s)
[271.845399] [053/131] (837s left) gem_exec_parallel (userptr)
[271.903763] Starting subtest: userptr
[271.906251] Starting dynamic subtest: rcs0
[273.354781] Dynamic subtest rcs0: SUCCESS (1.441s)
[273.363497] Starting dynamic subtest: bcs0
[274.827626] Dynamic subtest bcs0: SUCCESS (1.463s)
[274.838624] Starting dynamic subtest: vcs0
[276.873328] Dynamic subtest vcs0: SUCCESS (2.035s)
[276.884265] Starting dynamic subtest: vcs1
[278.856385] Dynamic subtest vcs1: SUCCESS (1.974s)
[278.866587] Starting dynamic subtest: vecs0
[280.904837] Dynamic subtest vecs0: SUCCESS (2.041s)
[280.914838] Starting dynamic subtest: ccs0
[282.435635] Dynamic subtest ccs0: SUCCESS (1.526s)
[282.438368] Subtest userptr: SUCCESS (10.489s)
[282.626503] [054/131] (826s left) prime_vgem (wait)
[282.690393] Starting subtest: wait
[282.692828] Starting dynamic subtest: rcs0
[282.782631] Dynamic subtest rcs0: SUCCESS (0.092s)
[282.793057] Starting dynamic subtest: bcs0
[282.852374] Dynamic subtest bcs0: SUCCESS (0.069s)
[282.860620] Starting dynamic subtest: vcs0
[282.903984] Dynamic subtest vcs0: SUCCESS (0.051s)
[282.912331] Starting dynamic subtest: vcs1
[282.948355] Dynamic subtest vcs1: SUCCESS (0.043s)
[282.956418] Starting dynamic subtest: vecs0
[282.997147] Dynamic subtest vecs0: SUCCESS (0.048s)
[283.005114] Starting dynamic subtest: ccs0
[283.047250] Dynamic subtest ccs0: SUCCESS (0.049s)
[283.049463] Subtest wait: SUCCESS (0.357s)
[283.171253] [055/131] (825s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[288.229450] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[288.233608] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[289.086663] [056/131] (819s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[289.150942] Starting subtest: multi-wait-all-for-submit-signaled
[289.153156] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[289.261230] [057/131] (819s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[289.364933] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[294.143394] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.777s)
[294.242275] [058/131] (814s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[294.346349] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[298.878846] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.530s)
[299.007255] [059/131] (810s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[299.099951] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[299.102300] Starting dynamic subtest: A-eDP1
[308.051466] Dynamic subtest A-eDP1: SUCCESS (8.949s)
[308.059407] Starting dynamic subtest: B-eDP1
[316.972636] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[316.980340] Starting dynamic subtest: C-eDP1
[325.890415] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[325.898394] Starting dynamic subtest: D-eDP1
[334.814400] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[334.816880] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.713s)
[336.023828] [060/131] (773s left) prime_mmap (test_userptr)
[336.079401] Starting subtest: test_userptr
[336.081525] Starting dynamic subtest: test_userptr-smem
[336.083682] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[336.085827] Subtest test_userptr: SUCCESS (0.001s)
[336.168601] [061/131] (773s left) gem_ccs (block-copy-compressed)
[336.235026] Starting subtest: block-copy-compressed
[336.239434] Subtest block-copy-compressed: SKIP (0.000s)
[336.355276] [062/131] (772s left) gem_spin_batch (legacy-resubmit)
[336.405892] Starting subtest: legacy-resubmit
[336.408293] Starting dynamic subtest: default
[336.413566] Dynamic subtest default: SUCCESS (0.006s)
[336.423563] Starting dynamic subtest: render
[336.425811] Dynamic subtest render: SUCCESS (0.001s)
[336.433859] Starting dynamic subtest: bsd
[336.436123] Dynamic subtest bsd: SUCCESS (0.002s)
[336.443759] Starting dynamic subtest: bsd1
[336.446075] Dynamic subtest bsd1: SUCCESS (0.001s)
[336.453608] Starting dynamic subtest: bsd2
[336.455827] Dynamic subtest bsd2: SUCCESS (0.002s)
[336.463355] Starting dynamic subtest: blt
[336.465537] Dynamic subtest blt: SUCCESS (0.002s)
[336.472819] Starting dynamic subtest: vebox
[336.475136] Dynamic subtest vebox: SUCCESS (0.003s)
[336.477380] Subtest legacy-resubmit: SUCCESS (0.021s)
[336.655548] [063/131] (772s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[336.750881] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[336.754964] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[336.852263] [064/131] (772s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[336.914860] Starting subtest: single-wait-all-for-submit-available-submitted
[336.917218] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[337.022068] [065/131] (772s left) gem_exec_balancer (bonded-dual)
[337.083638] Starting subtest: bonded-dual
[337.087795] Subtest bonded-dual: SKIP (0.000s)
[337.373291] [066/131] (772s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[337.476331] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[337.478735] Starting dynamic subtest: pipe-A-eDP-1
[337.502027] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[337.512149] Starting dynamic subtest: pipe-B-eDP-1
[337.534318] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[337.541711] Starting dynamic subtest: pipe-C-eDP-1
[337.563598] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[337.570982] Starting dynamic subtest: pipe-D-eDP-1
[337.593023] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[337.597499] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[339.670172] [067/131] (769s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[339.772921] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[339.775316] Starting dynamic subtest: pipe-A-default-mode
[340.058649] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[340.063327] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.284s)
[340.892460] [068/131] (768s left) gen7_exec_parse (basic-rejected)
[340.964532] Subtest basic-rejected: SKIP (0.000s)
[341.051380] [069/131] (768s left) gem_exec_suspend (basic-s3)
[341.113645] Starting subtest: basic-S3
[341.116058] Starting dynamic subtest: smem
[361.301875] Dynamic subtest smem: SUCCESS (6.722s)
[361.305080] Subtest basic-S3: SUCCESS (6.723s)
[361.480736] [070/131] (761s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[361.599200] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[361.604675] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[361.676172] [071/131] (761s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[361.730805] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[361.841711] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[361.915127] [072/131] (761s left) kms_vblank (query-forked-busy-hang)
[362.012572] Starting subtest: query-forked-busy-hang
[362.015210] Starting dynamic subtest: pipe-A-eDP-1
[388.115382] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.049s)
[388.130039] Starting dynamic subtest: pipe-D-eDP-1
[412.126294] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.007s)
[412.128679] Subtest query-forked-busy-hang: SUCCESS (50.060s)
[412.976606] [073/131] (710s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[413.069775] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[413.072156] Starting dynamic subtest: pipe-A-eDP-1
[413.124378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.054s)
[413.133569] Starting dynamic subtest: pipe-B-eDP-1
[413.174320] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.049s)
[413.183133] Starting dynamic subtest: pipe-C-eDP-1
[413.224937] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.049s)
[413.234130] Starting dynamic subtest: pipe-D-eDP-1
[413.278435] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.053s)
[413.281397] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.208s)
[415.430149] [074/131] (707s left) sysfs_preempt_timeout (idempotent)
[415.500056] Starting subtest: idempotent
[415.503111] Starting dynamic subtest: vecs0
[415.506188] Dynamic subtest vecs0: SUCCESS (0.000s)
[415.515422] Starting dynamic subtest: ccs0
[415.518432] Dynamic subtest ccs0: SUCCESS (0.000s)
[415.526705] Starting dynamic subtest: vcs0
[415.529314] Dynamic subtest vcs0: SUCCESS (0.000s)
[415.538054] Starting dynamic subtest: bcs0
[415.540680] Dynamic subtest bcs0: SUCCESS (0.000s)
[415.548838] Starting dynamic subtest: rcs0
[415.551236] Dynamic subtest rcs0: SUCCESS (0.000s)
[415.559701] Starting dynamic subtest: vcs1
[415.562353] Dynamic subtest vcs1: SUCCESS (0.000s)
[415.565155] Subtest idempotent: SUCCESS (0.005s)
[415.598780] [075/131] (707s left) gem_ctx_isolation (preservation-s3)
[415.664286] Starting subtest: preservation-S3
[415.669390] Starting dynamic subtest: rcs0
[431.641107] Dynamic subtest rcs0: SUCCESS (1.593s)
[431.650208] Starting dynamic subtest: bcs0
[448.425816] Dynamic subtest bcs0: SUCCESS (1.366s)
[448.434765] Starting dynamic subtest: vcs0
[464.422942] Dynamic subtest vcs0: SUCCESS (2.728s)
[464.439098] Starting dynamic subtest: vcs1
[482.504400] Dynamic subtest vcs1: SUCCESS (5.075s)
[482.513722] Starting dynamic subtest: vecs0
[500.507813] Dynamic subtest vecs0: SUCCESS (5.002s)
[500.516713] Starting dynamic subtest: ccs0
[518.427058] Dynamic subtest ccs0: SUCCESS (3.137s)
[518.430249] Subtest preservation-S3: SUCCESS (18.906s)
[518.686737] [076/131] (688s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[518.798766] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[523.711307] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (4.886s)
[523.806888] [077/131] (683s left) kms_big_fb (4-tiled-addfb)
[523.921024] Starting subtest: 4-tiled-addfb
[523.923339] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[524.020356] [078/131] (683s left) drm_fdinfo (virtual-busy-idle)
[524.071765] Starting subtest: virtual-busy-idle
[524.076847] Subtest virtual-busy-idle: SKIP (0.000s)
[524.136298] [079/131] (683s left) gem_exec_reloc (basic-cpu)
[524.203809] Subtest basic-cpu: SKIP (0.000s)
[524.272389] [080/131] (683s left) syncobj_wait (wait-for-submit-complex)
[524.332862] Starting subtest: wait-for-submit-complex
[524.393762] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[524.466004] [081/131] (682s left) gem_mmap_offset (pf-nonblock)
[524.533437] Starting subtest: pf-nonblock
[524.538860] Subtest pf-nonblock: SUCCESS (0.008s)
[524.677370] [082/131] (682s left) gem_ctx_isolation (nonpriv)
[524.733804] Starting subtest: nonpriv
[524.736319] Starting dynamic subtest: rcs0
[525.249694] Dynamic subtest rcs0: SUCCESS (0.514s)
[525.260759] Starting dynamic subtest: bcs0
[525.847084] Dynamic subtest bcs0: SUCCESS (0.595s)
[525.858293] Starting dynamic subtest: vcs0
[526.421950] Dynamic subtest vcs0: SUCCESS (0.573s)
[526.433452] Starting dynamic subtest: vcs1
[527.703401] Dynamic subtest vcs1: SUCCESS (1.276s)
[527.714727] Starting dynamic subtest: vecs0
[529.668780] Dynamic subtest vecs0: SUCCESS (1.960s)
[529.680335] Starting dynamic subtest: ccs0
[531.708778] Dynamic subtest ccs0: SUCCESS (2.035s)
[531.711874] Subtest nonpriv: SUCCESS (6.957s)
[531.958493] [083/131] (675s left) kms_color (gamma)
[532.066877] Starting subtest: gamma
[532.069736] Starting dynamic subtest: pipe-A-eDP-1
[532.774146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[532.784990] Starting dynamic subtest: pipe-B-eDP-1
[534.125069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.350s)
[534.135270] Starting dynamic subtest: pipe-C-eDP-1
[535.425708] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[535.436015] Starting dynamic subtest: pipe-D-eDP-1
[536.744888] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[536.747468] Subtest gamma: SUCCESS (4.676s)
[537.562544] [084/131] (669s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[537.657846] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[537.660913] Starting dynamic subtest: pipe-A-default-mode
[537.945936] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[537.951646] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.283s)
[538.791484] [085/131] (668s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[538.915415] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[539.886893] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.971s)
[540.713704] [086/131] (666s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[540.816619] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[540.819263] Starting dynamic subtest: pipe-A-eDP-1
[540.847043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[540.856954] Starting dynamic subtest: pipe-B-eDP-1
[540.883531] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[540.892004] Starting dynamic subtest: pipe-C-eDP-1
[540.917387] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[540.925810] Starting dynamic subtest: pipe-D-eDP-1
[540.952545] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[540.957779] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[542.962278] [087/131] (664s left) gem_ctx_param (root-set)
[543.015759] Starting subtest: root-set
[543.018743] Subtest root-set: SUCCESS (0.001s)
[543.107020] [088/131] (664s left) kms_cursor_edge_walk (128x128-left-edge)
[543.197696] Starting subtest: 128x128-left-edge
[543.200057] Starting dynamic subtest: pipe-A-eDP-1
[546.629778] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[546.639028] Starting dynamic subtest: pipe-D-eDP-1
[549.728001] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.097s)
[549.730937] Subtest 128x128-left-edge: SUCCESS (6.525s)
[550.546603] [089/131] (657s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[550.659646] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[550.664317] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.013s)
[550.738461] [090/131] (656s left) gem_shrink (reclaim)
[550.806028] Starting subtest: reclaim
[553.336671] Subtest reclaim: SUCCESS (2.528s)
[553.479312] [091/131] (654s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[553.587803] Starting subtest: psr-farfromfence-mmap-gtt
[553.592779] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[553.688809] [092/131] (654s left) syncobj_timeline (host-signal-ordered)
[553.747758] Starting subtest: host-signal-ordered
[553.750026] Subtest host-signal-ordered: SUCCESS (0.000s)
[553.853041] [093/131] (653s left) gem_mmap_gtt (cpuset-big-copy)
[553.906688] Subtest cpuset-big-copy: SKIP (0.000s)
[553.968592] [094/131] (653s left) gem_userptr_blits (sync-overlap)
[554.039067] Starting subtest: sync-overlap
[554.041436] Subtest sync-overlap: SUCCESS (0.000s)
[554.168493] [095/131] (653s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[554.236796] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[554.312369] [096/131] (653s left) kms_psr (pr-suspend)
[554.408401] Starting subtest: pr-suspend
[554.412853] Subtest pr-suspend: SKIP (0.000s)
[554.474431] [097/131] (653s left) i915_pm_rpm (gem-evict-pwrite)
[556.208018] Starting subtest: gem-evict-pwrite
[556.213458] Subtest gem-evict-pwrite: SKIP (0.000s)
[556.780021] [098/131] (651s left) api_intel_bb (object-reloc-purge-cache)
[556.834933] Starting subtest: object-reloc-purge-cache
[556.840930] Subtest object-reloc-purge-cache: SKIP (0.003s)
[556.959735] [099/131] (651s left) kms_big_fb (linear-64bpp-rotate-180)
[557.069357] Starting subtest: linear-64bpp-rotate-180
[559.313510] Subtest linear-64bpp-rotate-180: SUCCESS (2.244s)
[559.565088] [100/131] (648s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[559.672944] Starting subtest: fbc-psr2-cursor-mmap-gtt
[559.675745] Starting dynamic subtest: eDP-1
[559.680775] Dynamic subtest eDP-1: SKIP (0.000s)
[559.686012] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[559.739001] [101/131] (648s left) gem_exec_reloc (basic-wc-cpu)
[559.806022] Subtest basic-wc-cpu: SKIP (0.000s)
[559.872782] [102/131] (648s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[559.929995] Starting subtest: framebuffer-vs-set-tiling
[559.934902] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[560.062027] [103/131] (648s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[560.170170] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[560.175653] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[560.273952] [104/131] (647s left) drm_fdinfo (memory-info-purgeable)
[560.317787] Starting subtest: memory-info-purgeable
[560.320379] Starting dynamic subtest: smem0
[562.972683] Dynamic subtest smem0: SUCCESS (2.654s)
[562.975497] Subtest memory-info-purgeable: SUCCESS (2.655s)
[563.044281] [105/131] (645s left) gem_pread (uncached)
[563.105611] Subtest uncached: SKIP (0.000s)
[563.157549] [106/131] (645s left) i915_pm_rpm (reg-read-ioctl)
[565.201301] Starting subtest: reg-read-ioctl
[567.486425] Subtest reg-read-ioctl: SUCCESS (2.284s)
[567.850706] [107/131] (640s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[567.976820] Starting subtest: cursor-vs-flip-toggle
[598.277015] Subtest cursor-vs-flip-toggle: SUCCESS (30.286s)
[599.067552] [108/131] (609s left) kms_legacy_colorkey (basic)
[599.157779] Starting subtest: basic
[599.160455] Starting dynamic subtest: pipe-A
[599.203882] Dynamic subtest pipe-A: SUCCESS (0.045s)
[599.213563] Starting dynamic subtest: pipe-B
[599.216762] Dynamic subtest pipe-B: SUCCESS (0.000s)
[599.235309] Starting dynamic subtest: pipe-C
[599.237754] Dynamic subtest pipe-C: SUCCESS (0.000s)
[599.246492] Starting dynamic subtest: pipe-D
[599.248925] Dynamic subtest pipe-D: SUCCESS (0.000s)
[599.251299] Subtest basic: SUCCESS (0.050s)
[599.282338] [109/131] (609s left) gem_exec_balancer (parallel-keep-in-fence)
[599.527709] Starting subtest: parallel-keep-in-fence
[600.713455] Subtest parallel-keep-in-fence: SUCCESS (1.187s)
[600.813723] [110/131] (607s left) kms_psr2_su (frontbuffer-xrgb8888)
[600.882706] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[600.937826] [111/131] (607s left) kms_cursor_crc (cursor-alpha-transparent)
[601.043855] Starting subtest: cursor-alpha-transparent
[601.046604] Starting dynamic subtest: pipe-A-eDP-1
[601.684980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[601.694797] Starting dynamic subtest: pipe-D-eDP-1
[602.945791] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.261s)
[602.948673] Subtest cursor-alpha-transparent: SUCCESS (1.905s)
[603.807823] [112/131] (604s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[603.909841] Starting subtest: fbc-psr2-primary-mmap-gtt
[603.912459] Starting dynamic subtest: eDP-1
[603.917754] Dynamic subtest eDP-1: SKIP (0.000s)
[603.922806] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[603.976077] [113/131] (604s left) gem_exec_whisper (basic-normal-all)
[604.049883] Starting subtest: basic-normal-all
[606.329184] Subtest basic-normal-all: SUCCESS (2.280s)
[606.515005] [114/131] (602s left) prime_self_import (basic-with_two_bos)
[606.551558] Starting subtest: basic-with_two_bos
[606.574998] Subtest basic-with_two_bos: SUCCESS (0.024s)
[606.666189] [115/131] (601s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[606.727232] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[606.733000] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[606.910864] [116/131] (601s left) perf_pmu (idle-no-semaphores)
[606.952001] Starting subtest: idle-no-semaphores
[606.954603] Starting dynamic subtest: rcs0
[607.537831] Dynamic subtest rcs0: SUCCESS (0.586s)
[607.549290] Starting dynamic subtest: bcs0
[608.066578] Dynamic subtest bcs0: SUCCESS (0.527s)
[608.076550] Starting dynamic subtest: vcs0
[608.589037] Dynamic subtest vcs0: SUCCESS (0.518s)
[608.599703] Starting dynamic subtest: vcs1
[609.105822] Dynamic subtest vcs1: SUCCESS (0.516s)
[609.117881] Starting dynamic subtest: vecs0
[609.624574] Dynamic subtest vecs0: SUCCESS (0.515s)
[609.645076] Starting dynamic subtest: ccs0
[610.146008] Dynamic subtest ccs0: SUCCESS (0.520s)
[610.149464] Subtest idle-no-semaphores: SUCCESS (3.197s)
[610.253534] [117/131] (598s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[610.372860] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[610.377860] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[610.472482] [118/131] (598s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[610.576751] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[611.632788] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.056s)
[611.796038] [119/131] (596s left) gem_exec_params (invalid-ring2)
[611.861777] Starting subtest: invalid-ring2
[611.864846] Subtest invalid-ring2: SUCCESS (0.000s)
[611.976335] [120/131] (596s left) kms_pm_dc (dc6-psr)
[613.088632] Starting subtest: dc6-psr
[620.376599] Subtest dc6-psr: FAIL (6.627s)
[620.409283] [121/131] (588s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[620.511467] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[623.314258] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.808s)
[623.478457] [122/131] (585s left) gem_softpin (evict-snoop)
[623.532888] Starting subtest: evict-snoop
[623.537699] Subtest evict-snoop: SKIP (0.000s)
[623.599925] [123/131] (585s left) gem_lmem_swapping (heavy-random)
[623.645524] Subtest heavy-random: SKIP (0.000s)
[623.687418] [124/131] (585s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[623.789502] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[627.040063] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (3.253s)
[627.170418] [125/131] (581s left) tools_test (sysfs_l3_parity)
[627.222671] Starting subtest: sysfs_l3_parity
[627.279265] Subtest sysfs_l3_parity: SKIP (0.070s)
[627.328380] [126/131] (581s left) syncobj_timeline (wait-zero-handles)
[627.384873] Starting subtest: wait-zero-handles
[627.387258] Subtest wait-zero-handles: SUCCESS (0.000s)
[627.478498] [127/131] (581s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[627.573810] Starting subtest: yf-tiled-64bpp-rotate-180
[627.578569] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[627.663846] [128/131] (581s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[632.708411] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[632.711017] Starting dynamic subtest: pipe-A-eDP-1
[633.502042] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s)
[633.511734] Starting dynamic subtest: pipe-B-eDP-1
[634.628741] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[634.633904] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.919s)
[635.806536] [129/131] (573s left) kms_vblank (wait-forked)
[635.897615] Starting subtest: wait-forked
[635.899975] Starting dynamic subtest: pipe-A-eDP-1
[637.738794] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.838s)
[637.754034] Starting dynamic subtest: pipe-D-eDP-1
[640.212592] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.473s)
[640.215244] Subtest wait-forked: SUCCESS (4.314s)
[641.058129] [130/131] (568s left) kms_plane (plane-position-covered)
[641.156794] Starting subtest: plane-position-covered
[641.671660] Starting dynamic subtest: pipe-A-plane-1
[642.937400] Dynamic subtest pipe-A-plane-1: SUCCESS (1.268s)
[642.947989] Starting dynamic subtest: pipe-A-plane-2
[644.226647] Dynamic subtest pipe-A-plane-2: SUCCESS (1.289s)
[644.237029] Starting dynamic subtest: pipe-A-plane-3
[645.465172] Dynamic subtest pipe-A-plane-3: SUCCESS (1.238s)
[645.475801] Starting dynamic subtest: pipe-A-plane-4
[646.691885] Dynamic subtest pipe-A-plane-4: SUCCESS (1.225s)
[646.702801] Starting dynamic subtest: pipe-A-plane-5
[646.731201] Dynamic subtest pipe-A-plane-5: SUCCESS (0.038s)
[647.838616] Starting dynamic subtest: pipe-B-plane-1
[649.044262] Dynamic subtest pipe-B-plane-1: SUCCESS (1.213s)
[649.054846] Starting dynamic subtest: pipe-B-plane-2
[650.271035] Dynamic subtest pipe-B-plane-2: SUCCESS (1.227s)
[650.280406] Starting dynamic subtest: pipe-B-plane-3
[651.494368] Dynamic subtest pipe-B-plane-3: SUCCESS (1.224s)
[651.503785] Starting dynamic subtest: pipe-B-plane-4
[652.723838] Dynamic subtest pipe-B-plane-4: SUCCESS (1.228s)
[652.739440] Starting dynamic subtest: pipe-B-plane-5
[652.765392] Dynamic subtest pipe-B-plane-5: SUCCESS (0.040s)
[652.767506] Subtest plane-position-covered: SUCCESS (11.604s)
[653.519673] [131/131] (555s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-dirtyfb-tests)
[653.993639] Subtest fbc-dirty-rectangle-dirtyfb-tests: SKIP (0.000s)
[654.039640] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-dirtyfb-tests)] new: kernel.kmod_is_loaded.xe: true
[654.039792] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_rotation_crc
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_cursor_edge_walk
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: gem_mmap_wc
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: gem_exec_flush
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: api_intel_bb
results: parsing output: 22/ for test: kms_pipe_crc_basic
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: gem_exec_capture
results: parsing output: 26/ for test: kms_dsc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_pwrite
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: kms_chamelium_edid
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_cdclk
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_sequence
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_atomic
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: gem_readwrite
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: gem_exec_parallel
results: parsing output: 53/ for test: prime_vgem
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: prime_mmap
results: parsing output: 60/ for test: gem_ccs
results: parsing output: 61/ for test: gem_spin_batch
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: gen7_exec_parse
results: parsing output: 68/ for test: gem_exec_suspend
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_vblank
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: sysfs_preempt_timeout
results: parsing output: 74/ for test: gem_ctx_isolation
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: drm_fdinfo
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: gem_ctx_isolation
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: kms_cursor_edge_walk
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_shrink
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: gem_fenced_exec_thrash
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: i915_pm_rpm
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: drm_fdinfo
results: parsing output: 104/ for test: gem_pread
results: parsing output: 105/ for test: i915_pm_rpm
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_legacy_colorkey
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_psr2_su
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: prime_self_import
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_exec_params
results: parsing output: 119/ for test: kms_pm_dc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: gem_lmem_swapping
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: tools_test
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: kms_fbc_dirty_rect
Done.