[60.630119] Initializing watchdogs
[60.630250]   /dev/watchdog0
[60.644715] [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]
[60.648831] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.651120] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.654634] [001/131] (960s left) kms_feature_discovery (chamelium)
[60.812860] Starting subtest: chamelium
[60.816982] Subtest chamelium: SKIP (0.000s)
[60.882110] [002/131] (960s left) kms_psr (fbc-pr-primary-blt)
[60.991460] Starting subtest: fbc-pr-primary-blt
[60.996128] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[61.058665] [003/131] (960s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[61.115391] Starting subtest: etime-single-wait-for-submit-unsubmitted
[61.223399] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[61.288481] [004/131] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[61.400124] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[66.085502] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.691s)
[66.230494] [005/131] (955s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[66.364180] Starting subtest: short-flip-after-cursor-toggle
[67.318342] Subtest short-flip-after-cursor-toggle: SUCCESS (0.956s)
[68.110195] [006/131] (953s left) fbdev (eof)
[68.154614] Starting subtest: eof
[68.157090] Subtest eof: SUCCESS (0.000s)
[68.203640] [007/131] (953s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[68.287663] Starting subtest: bad-aux-stride-y-tiled-ccs
[68.290044] Starting dynamic subtest: pipe-A-eDP-1
[68.312400] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.319939] Starting dynamic subtest: pipe-B-eDP-1
[68.340133] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.346059] Starting dynamic subtest: pipe-C-eDP-1
[68.366612] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.372668] Starting dynamic subtest: pipe-D-eDP-1
[68.393655] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.397759] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.002s)
[70.460933] [008/131] (950s left) gem_exec_schedule (semaphore-user)
[70.540630] Starting subtest: semaphore-user
[70.593924] Subtest semaphore-user: SUCCESS (0.057s)
[71.946781] [009/131] (949s left) i915_pm_rpm (gem-pread)
[74.093383] Starting subtest: gem-pread
[76.110107] Subtest gem-pread: SUCCESS (2.016s)
[76.187862] [010/131] (945s left) kms_dirtyfb (default-dirtyfb-ioctl)
[76.297405] Starting subtest: default-dirtyfb-ioctl
[76.300021] Starting dynamic subtest: A-eDP-1
[77.975545] Dynamic subtest A-eDP-1: SUCCESS (1.677s)
[77.978062] Subtest default-dirtyfb-ioctl: SUCCESS (1.678s)
[78.789357] [011/131] (942s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[78.902261] Starting subtest: x-tiled-64bpp-rotate-0
[81.264896] Subtest x-tiled-64bpp-rotate-0: SUCCESS (2.364s)
[81.489331] [012/131] (940s left) gem_mmap_gtt (big-copy)
[81.549369] Subtest big-copy: SKIP (0.000s)
[81.604099] [013/131] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[81.702259] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[81.706546] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[81.801297] [014/131] (939s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[81.906333] Starting subtest: fbc-rgb101010-draw-blt
[85.501442] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.598s)
[85.641617] [015/131] (935s left) gem_mmap_gtt (isolation)
[85.692407] Subtest isolation: SKIP (0.000s)
[85.744324] [016/131] (935s left) gem_exec_params (larger-than-life-batch)
[85.804097] Starting subtest: larger-than-life-batch
[89.424801] Subtest larger-than-life-batch: SUCCESS (3.619s)
[90.003518] [017/131] (931s left) gem_exec_capture (capture-invisible)
[90.117076] Starting subtest: capture-invisible
[90.119392] Starting dynamic subtest: smem0
[90.123427] Dynamic subtest smem0: SKIP (0.000s)
[90.127458] Subtest capture-invisible: SKIP (0.000s)
[90.235889] [018/131] (931s left) kms_psr (pr-primary-render)
[90.335930] Starting subtest: pr-primary-render
[90.340613] Subtest pr-primary-render: SKIP (0.000s)
[90.400713] [019/131] (931s left) gen3_render_mixed_blits
[90.516027] [020/131] (931s left) gem_exec_flush (basic-uc-set-default)
[90.574962] Starting subtest: basic-uc-set-default
[96.056398] Subtest basic-uc-set-default: SUCCESS (5.481s)
[96.234347] [021/131] (925s left) sysfs_heartbeat_interval (invalid)
[96.295866] Starting subtest: invalid
[96.298277] Starting dynamic subtest: vecs0
[96.300607] Dynamic subtest vecs0: SUCCESS (0.000s)
[96.307446] Starting dynamic subtest: ccs0
[96.309405] Dynamic subtest ccs0: SUCCESS (0.000s)
[96.316056] Starting dynamic subtest: vcs0
[96.318109] Dynamic subtest vcs0: SUCCESS (0.000s)
[96.324646] Starting dynamic subtest: bcs0
[96.326642] Dynamic subtest bcs0: SUCCESS (0.000s)
[96.333707] Starting dynamic subtest: rcs0
[96.336067] Dynamic subtest rcs0: SUCCESS (0.000s)
[96.343077] Starting dynamic subtest: vcs1
[96.345404] Dynamic subtest vcs1: SUCCESS (0.000s)
[96.347372] Subtest invalid: SUCCESS (0.002s)
[96.393535] [022/131] (925s left) i915_query (test-query-geometry-subslices)
[96.442992] Starting subtest: test-query-geometry-subslices
[96.445316] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[96.552215] [023/131] (925s left) kms_pm_rpm (modeset-lpsp)
[98.119343] Starting subtest: modeset-lpsp
[99.560081] Subtest modeset-lpsp: SUCCESS (1.441s)
[99.655917] [024/131] (922s left) kms_cdclk (mode-transition)
[99.765050] Starting subtest: mode-transition
[99.767512] Starting dynamic subtest: pipe-A-eDP-1
[100.055396] Dynamic subtest pipe-A-eDP-1: SKIP (0.285s)
[100.064889] Starting dynamic subtest: pipe-B-eDP-1
[100.069805] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[100.076957] Starting dynamic subtest: pipe-C-eDP-1
[100.081654] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[100.088562] Starting dynamic subtest: pipe-D-eDP-1
[100.093180] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[100.097721] Subtest mode-transition: SKIP (0.290s)
[100.836599] [025/131] (921s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[105.879349] Starting subtest: pr-cursor-plane-update-sf
[105.884262] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[106.730951] [026/131] (915s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[106.831859] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[106.834154] Starting dynamic subtest: pipe-A-default-mode
[107.146325] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[107.151132] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.315s)
[107.956716] [027/131] (914s left) kms_color (degamma)
[108.058947] Starting subtest: degamma
[108.061233] Starting dynamic subtest: pipe-A-eDP-1
[108.780693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[108.792085] Starting dynamic subtest: pipe-B-eDP-1
[110.142823] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.363s)
[110.152424] Starting dynamic subtest: pipe-C-eDP-1
[111.524945] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[111.533788] Starting dynamic subtest: pipe-D-eDP-1
[112.858946] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[112.861539] Subtest degamma: SUCCESS (4.799s)
[113.654336] [028/131] (908s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[113.760261] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[113.764589] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[113.835238] [029/131] (908s left) kms_draw_crc (draw-method-pwrite)
[113.947223] Starting subtest: draw-method-pwrite
[113.949156] Starting dynamic subtest: xrgb8888-untiled
[114.529644] Dynamic subtest xrgb8888-untiled: SUCCESS (0.585s)
[114.537158] Starting dynamic subtest: rgb565-untiled
[114.996165] Dynamic subtest rgb565-untiled: SUCCESS (0.467s)
[115.004489] Starting dynamic subtest: xrgb2101010-untiled
[115.529763] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.533s)
[115.538721] Starting dynamic subtest: xbgr16161616f-untiled
[116.353579] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.822s)
[116.361232] Starting dynamic subtest: xrgb8888-xtiled
[118.196520] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.844s)
[118.205754] Starting dynamic subtest: rgb565-xtiled
[119.362943] Dynamic subtest rgb565-xtiled: SUCCESS (1.166s)
[119.372500] Starting dynamic subtest: xrgb2101010-xtiled
[121.285381] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.921s)
[121.295270] Starting dynamic subtest: xbgr16161616f-xtiled
[124.829954] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.544s)
[124.838200] Starting dynamic subtest: xrgb8888-4tiled
[126.030301] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.200s)
[126.038144] Starting dynamic subtest: rgb565-4tiled
[126.618747] Dynamic subtest rgb565-4tiled: SUCCESS (0.588s)
[126.626070] Starting dynamic subtest: xrgb2101010-4tiled
[127.763302] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.144s)
[127.770720] Starting dynamic subtest: xbgr16161616f-4tiled
[130.896647] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.132s)
[130.899089] Subtest draw-method-pwrite: SUCCESS (16.952s)
[131.004256] [030/131] (891s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[131.102143] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[131.104560] Starting dynamic subtest: pipe-A-eDP-1
[131.127672] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[131.137136] Starting dynamic subtest: pipe-B-eDP-1
[131.159016] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[131.168219] Starting dynamic subtest: pipe-C-eDP-1
[131.189646] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[131.197142] Starting dynamic subtest: pipe-D-eDP-1
[131.219826] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[131.224070] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[133.207571] [031/131] (888s left) gem_fence_thrash (bo-copy)
[133.245749] Starting subtest: bo-copy
[133.277026] Subtest bo-copy: SKIP (0.027s)
[133.338890] [032/131] (888s left) kms_plane_scaling (planes-downscale-factor-0-5)
[133.446049] Starting subtest: planes-downscale-factor-0-5
[133.448214] Starting dynamic subtest: pipe-A
[133.457285] Dynamic subtest pipe-A: SKIP (0.005s)
[133.466358] Starting dynamic subtest: pipe-B
[133.475670] Dynamic subtest pipe-B: SKIP (0.019s)
[133.482920] Starting dynamic subtest: pipe-C
[133.495818] Dynamic subtest pipe-C: SKIP (0.017s)
[133.502888] Starting dynamic subtest: pipe-D
[133.511248] Dynamic subtest pipe-D: SKIP (0.017s)
[133.514846] Subtest planes-downscale-factor-0-5: SKIP (0.059s)
[133.612673] [033/131] (888s left) prime_vgem (basic-read)
[133.768686] Starting subtest: basic-read
[133.777691] Subtest basic-read: SKIP (0.007s)
[133.876053] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[133.879181] [034/131] (888s left) kms_async_flips (async-flip-with-page-flip-events)
[133.979248] Starting subtest: async-flip-with-page-flip-events
[134.352226] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs
[135.090330] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.736s)
[135.098214] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[137.335677] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.246s)
[137.345681] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc
[137.612165] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.273s)
[137.619816] Starting dynamic subtest: pipe-A-eDP-1-4
[139.891688] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.282s)
[139.901156] Starting dynamic subtest: pipe-A-eDP-1-x
[142.190850] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.299s)
[142.198301] Starting dynamic subtest: pipe-A-eDP-1-linear
[144.502086] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.311s)
[144.865229] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs
[145.614469] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.753s)
[145.621912] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[147.892089] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.279s)
[147.902125] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc
[148.167419] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.274s)
[148.175095] Starting dynamic subtest: pipe-B-eDP-1-4
[150.448802] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.281s)
[150.459184] Starting dynamic subtest: pipe-B-eDP-1-x
[152.759739] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.310s)
[152.770207] Starting dynamic subtest: pipe-B-eDP-1-linear
[155.073763] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.288s)
[155.410063] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs
[156.139239] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.735s)
[156.147281] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[158.373717] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.235s)
[158.381460] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc
[158.657748] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.281s)
[158.667305] Starting dynamic subtest: pipe-C-eDP-1-4
[160.929530] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.274s)
[160.939323] Starting dynamic subtest: pipe-C-eDP-1-x
[163.218274] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.288s)
[163.225850] Starting dynamic subtest: pipe-C-eDP-1-linear
[165.519071] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.300s)
[165.888892] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs
[166.671833] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.785s)
[166.681048] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[168.925082] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.256s)
[168.932684] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc
[169.191192] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.265s)
[169.198599] Starting dynamic subtest: pipe-D-eDP-1-4
[171.480969] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.289s)
[171.491273] Starting dynamic subtest: pipe-D-eDP-1-x
[173.792418] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.311s)
[173.800400] Starting dynamic subtest: pipe-D-eDP-1-linear
[176.091857] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.299s)
[176.094299] Subtest async-flip-with-page-flip-events: SUCCESS (42.109s)
[177.233510] [035/131] (845s left) perf_pmu (multi-client)
[177.276852] Starting subtest: multi-client
[177.279304] Starting dynamic subtest: rcs0
[178.343947] Dynamic subtest rcs0: SUCCESS (1.065s)
[178.354703] Starting dynamic subtest: bcs0
[179.393693] Dynamic subtest bcs0: SUCCESS (1.047s)
[179.404061] Starting dynamic subtest: vcs0
[180.442283] Dynamic subtest vcs0: SUCCESS (1.047s)
[180.453064] Starting dynamic subtest: vcs1
[181.924388] Dynamic subtest vcs1: SUCCESS (1.480s)
[181.935082] Starting dynamic subtest: vecs0
[183.971290] Dynamic subtest vecs0: SUCCESS (2.046s)
[183.982025] Starting dynamic subtest: ccs0
[185.956550] Dynamic subtest ccs0: SUCCESS (1.984s)
[185.959463] Subtest multi-client: SUCCESS (8.678s)
[186.087600] [036/131] (836s left) gem_readwrite (beyond-eob)
[186.147435] Subtest beyond-EOB: SKIP (0.000s)
[186.207890] [037/131] (836s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[186.309520] Starting subtest: fbcpsr-rgb565-draw-pwrite
[191.192063] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (4.885s)
[191.308860] [038/131] (831s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[191.416649] Starting subtest: stress-xrgb8888-ytiled
[191.421208] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[191.479961] [039/131] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[191.592422] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[191.596585] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[191.671927] [040/131] (830s left) api_intel_bb (blit-reloc-keep-cache)
[191.724784] Starting subtest: blit-reloc-keep-cache
[191.729073] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[191.855169] [041/131] (830s left) gem_exec_reloc (basic-wc-gtt-active)
[191.921746] Subtest basic-wc-gtt-active: SKIP (0.000s)
[191.999170] [042/131] (830s left) gem_ctx_persistence (engines-mixed)
[192.060573] Starting subtest: engines-mixed
[192.063085] Starting dynamic subtest: rcs0
[192.168787] Dynamic subtest rcs0: SUCCESS (0.108s)
[192.179328] Starting dynamic subtest: bcs0
[192.229342] Dynamic subtest bcs0: SUCCESS (0.059s)
[192.239122] Starting dynamic subtest: vcs0
[192.299847] Dynamic subtest vcs0: SUCCESS (0.068s)
[192.310017] Starting dynamic subtest: vcs1
[192.374753] Dynamic subtest vcs1: SUCCESS (0.074s)
[192.383256] Starting dynamic subtest: vecs0
[192.444747] Dynamic subtest vecs0: SUCCESS (0.069s)
[192.455566] Starting dynamic subtest: ccs0
[192.533615] Dynamic subtest ccs0: SUCCESS (0.088s)
[192.535864] Subtest engines-mixed: SUCCESS (0.474s)
[192.613340] [043/131] (829s left) vgem_basic (dmabuf-export)
[192.653799] Starting subtest: dmabuf-export
[192.677634] Subtest dmabuf-export: SUCCESS (0.025s)
[192.773330] [044/131] (829s left) syncobj_timeline (device-submit-unordered)
[192.825774] Starting subtest: device-submit-unordered
[192.827830] Subtest device-submit-unordered: SUCCESS (0.000s)
[192.907689] [045/131] (829s left) gem_ctx_engines (none)
[192.971748] Starting subtest: none
[192.973882] Subtest none: SUCCESS (0.002s)
[193.151402] [046/131] (829s left) gem_exec_whisper (basic-sync-all)
[193.216075] Starting subtest: basic-sync-all
[199.315526] Subtest basic-sync-all: SUCCESS (6.099s)
[199.494775] [047/131] (823s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[199.609323] Starting subtest: 4-tiled-64bpp-rotate-90
[199.629767] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[199.762950] [048/131] (822s left) gem_ppgtt (shrink-vs-evict-pinned)
[199.812682] Starting subtest: shrink-vs-evict-pinned
[205.900324] Subtest shrink-vs-evict-pinned: SUCCESS (6.086s)
[205.994989] [049/131] (816s left) kms_psr (psr-primary-blt)
[206.101337] Starting subtest: psr-primary-blt
[206.103651] Starting dynamic subtest: eDP-1
[207.863073] Dynamic subtest eDP-1: SUCCESS (1.761s)
[207.865441] Subtest psr-primary-blt: SUCCESS (1.762s)
[208.726313] [050/131] (814s left) gem_ctx_persistence (process)
[208.791635] Starting subtest: process
[209.041950] Subtest process: SUCCESS (0.250s)
[209.117502] [051/131] (813s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[209.223569] Starting subtest: plane-all-modeset-transition-fencing
[209.227842] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[209.294309] [052/131] (813s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[209.414673] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[209.418717] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[209.524427] [053/131] (813s left) kms_cursor_crc (cursor-random-128x128)
[209.710742] Starting subtest: cursor-random-128x128
[209.715326] Starting dynamic subtest: pipe-A-eDP-1
[213.476939] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.762s)
[213.506470] Starting dynamic subtest: pipe-D-eDP-1
[217.868970] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.369s)
[217.871062] Subtest cursor-random-128x128: SUCCESS (8.156s)
[218.675918] [054/131] (804s left) gem_mmap_offset (close-race)
[218.728933] Starting subtest: close-race
[238.869986] Subtest close-race: SUCCESS (20.141s)
[239.002337] [055/131] (783s left) gem_lmem_swapping (verify-random)
[239.044055] Subtest verify-random: SKIP (0.000s)
[239.086283] [056/131] (783s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[239.198598] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[239.211991] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[239.312824] [057/131] (783s left) gem_exec_await (wide-all)
[239.533547] Starting subtest: wide-all
[262.644899] Subtest wide-all: SUCCESS (23.109s)
[262.831247] [058/131] (760s left) kms_properties (invalid-properties-legacy)
[262.972057] Starting subtest: invalid-properties-legacy
[263.082205] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[263.149317] [059/131] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[263.259074] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[263.263185] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[263.351743] [060/131] (759s left) gem_ctx_param (invalid-size-get)
[263.413711] Starting subtest: invalid-size-get
[263.416088] Subtest invalid-size-get: SUCCESS (0.001s)
[263.514567] [061/131] (759s left) i915_pm_freq_api (freq-reset-multiple)
[263.580352] Starting subtest: freq-reset-multiple
[263.582753] Starting dynamic subtest: gt0
[273.082928] Dynamic subtest gt0: SUCCESS (9.500s)
[273.091081] Starting dynamic subtest: gt1
[281.370255] Dynamic subtest gt1: SUCCESS (8.287s)
[281.373067] Subtest freq-reset-multiple: SUCCESS (17.788s)
[281.443885] [062/131] (741s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[286.411968] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[286.416879] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[287.265158] [063/131] (736s left) gem_create (busy-create)
[287.342107] Starting subtest: busy-create
[287.344554] Starting dynamic subtest: smem0
[320.955493] Dynamic subtest smem0: SUCCESS (33.609s)
[320.958078] Subtest busy-create: SUCCESS (33.610s)
[321.139893] [064/131] (702s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[321.720628] Starting subtest: syncobj-timeline-invalid-wait
[321.725574] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.007s)
[323.001179] [065/131] (700s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[323.106087] Starting subtest: crc-primary-basic-yf-tiled-ccs
[323.108387] Starting dynamic subtest: pipe-A-eDP-1
[323.131295] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[323.140893] Starting dynamic subtest: pipe-B-eDP-1
[323.162678] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[323.171384] Starting dynamic subtest: pipe-C-eDP-1
[323.193905] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[323.203315] Starting dynamic subtest: pipe-D-eDP-1
[323.226611] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[323.230720] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[325.207871] [066/131] (698s left) kms_psr (fbc-psr-cursor-render)
[325.306044] Starting subtest: fbc-psr-cursor-render
[325.308286] Starting dynamic subtest: eDP-1
[325.312505] Dynamic subtest eDP-1: SKIP (0.000s)
[325.316724] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[325.370412] [067/131] (698s left) kms_prop_blob (invalid-get-prop-any)
[325.433860] Starting subtest: invalid-get-prop-any
[325.435968] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[325.530092] [068/131] (697s left) gem_exec_balancer (bonded-sync)
[325.592969] Starting subtest: bonded-sync
[325.597698] Subtest bonded-sync: SKIP (0.000s)
[325.889241] [069/131] (697s left) gen7_exec_parse (load-register-reg)
[325.949279] Subtest load-register-reg: SKIP (0.000s)
[326.012184] [070/131] (697s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[326.107782] Starting subtest: fbcpsr-indfb-scaledprimary
[331.811327] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.707s)
[331.954285] [071/131] (691s left) perf (short-reads)
[332.096796] Starting subtest: short-reads
[332.116062] Subtest short-reads: SUCCESS (0.021s)
[332.160485] [072/131] (691s left) gem_exec_params (secure-non-root)
[332.219353] Starting subtest: secure-non-root
[332.224275] Subtest secure-non-root: SKIP (0.000s)
[332.323834] [073/131] (691s left) gem_exec_reloc (basic-range)
[332.386355] Subtest basic-range: SKIP (0.000s)
[332.446594] [074/131] (691s left) kms_invalid_mode (int-max-clock)
[332.557236] Starting subtest: int-max-clock
[332.559248] Starting dynamic subtest: pipe-A-eDP-1
[332.849923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[332.859084] Starting dynamic subtest: pipe-B-eDP-1
[332.861153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[332.868953] Starting dynamic subtest: pipe-C-eDP-1
[332.871395] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[332.879321] Starting dynamic subtest: pipe-D-eDP-1
[332.881630] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[332.883957] Subtest int-max-clock: SUCCESS (0.296s)
[333.693785] [075/131] (690s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[333.798194] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[333.800463] Starting dynamic subtest: pipe-A-eDP-1
[334.226067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[334.235609] Starting dynamic subtest: pipe-B-eDP-1
[335.588829] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.363s)
[335.598595] Starting dynamic subtest: pipe-C-eDP-1
[337.001669] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.411s)
[337.012061] Starting dynamic subtest: pipe-D-eDP-1
[338.323947] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[338.326072] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.497s)
[339.498670] [076/131] (684s left) kms_lease (master-vs-lease)
[339.611861] Starting subtest: master-vs-lease
[339.614227] Subtest master-vs-lease: SUCCESS (0.001s)
[339.730888] [077/131] (684s left) dmabuf_sync_file (import-multiple-read-write)
[339.775160] Starting subtest: import-multiple-read-write
[339.777081] Subtest import-multiple-read-write: SUCCESS (0.004s)
[339.829980] [078/131] (683s left) syncobj_wait (wait-all-for-submit-complex)
[339.886172] Starting subtest: wait-all-for-submit-complex
[340.098040] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[340.169019] [079/131] (683s left) perf (non-system-wide-paranoid)
[340.250519] Starting subtest: non-system-wide-paranoid
[340.290592] Subtest non-system-wide-paranoid: SUCCESS (0.040s)
[340.341438] [080/131] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[340.451936] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[340.456348] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[340.566047] [081/131] (683s left) kms_flip (2x-plain-flip)
[340.668213] Starting subtest: 2x-plain-flip
[340.680275] Subtest 2x-plain-flip: SKIP (0.011s)
[340.755480] [082/131] (683s left) kms_scaling_modes (scaling-mode-full)
[340.863117] Starting subtest: scaling-mode-full
[340.865426] Starting dynamic subtest: pipe-A-eDP-1
[340.976532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.113s)
[340.985663] Starting dynamic subtest: pipe-B-eDP-1
[342.127089] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[342.135364] Starting dynamic subtest: pipe-C-eDP-1
[343.323298] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s)
[343.331882] Starting dynamic subtest: pipe-D-eDP-1
[344.447756] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[344.450129] Subtest scaling-mode-full: SUCCESS (3.585s)
[345.591605] [083/131] (678s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[345.696278] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[345.698632] Starting dynamic subtest: pipe-A-default-mode
[348.405148] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[348.407070] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.706s)
[349.271945] [084/131] (674s left) gem_eio (wait-10ms)
[349.506442] Starting subtest: wait-10ms
[349.869991] Subtest wait-10ms: SUCCESS (0.363s)
[349.988186] [085/131] (674s left) kms_cursor_crc (cursor-sliding-max-size)
[350.286921] Starting subtest: cursor-sliding-max-size
[350.292363] Subtest cursor-sliding-max-size: SKIP (0.000s)
[350.418822] [086/131] (673s left) kms_chamelium_edid (dp-edid-resolution-list)
[350.798082] Subtest dp-edid-resolution-list: SKIP (0.000s)
[351.573431] [087/131] (672s left) perf_pmu (busy-idle)
[351.622782] Starting subtest: busy-idle
[351.625328] Starting dynamic subtest: rcs0
[352.312550] Dynamic subtest rcs0: SUCCESS (0.691s)
[352.323705] Starting dynamic subtest: bcs0
[352.976252] Dynamic subtest bcs0: SUCCESS (0.662s)
[352.986416] Starting dynamic subtest: vcs0
[354.924430] Dynamic subtest vcs0: SUCCESS (1.944s)
[354.935629] Starting dynamic subtest: vcs1
[356.907815] Dynamic subtest vcs1: SUCCESS (1.981s)
[356.919056] Starting dynamic subtest: vecs0
[358.956172] Dynamic subtest vecs0: SUCCESS (2.046s)
[358.966891] Starting dynamic subtest: ccs0
[359.633402] Dynamic subtest ccs0: SUCCESS (0.676s)
[359.635961] Subtest busy-idle: SUCCESS (8.013s)
[359.750602] [088/131] (664s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[359.802955] Starting subtest: multi-wait-all-for-submit-submitted
[359.910964] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[359.982835] [089/131] (664s left) gem_tiled_partial_pwrite_pread (writes)
[360.039305] Subtest writes: SKIP (0.000s)
[360.111752] [090/131] (664s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[360.231068] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[360.235497] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[360.315796] [091/131] (663s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[360.416095] Starting subtest: fbc-psr2-sprite-mmap-gtt
[360.418353] Starting dynamic subtest: eDP-1
[360.422656] Dynamic subtest eDP-1: SKIP (0.000s)
[360.426847] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[360.481263] [092/131] (663s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[360.572214] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[360.583444] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[360.702191] [093/131] (663s left) syncobj_timeline (reset-multiple-signaled)
[360.767250] Starting subtest: reset-multiple-signaled
[360.769547] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[360.872419] [094/131] (663s left) api_intel_bb (object-reloc-purge-cache)
[360.937114] Starting subtest: object-reloc-purge-cache
[360.940786] Subtest object-reloc-purge-cache: SKIP (0.003s)
[361.070852] [095/131] (663s left) syncobj_timeline (wait-for-submit-complex)
[361.135068] Starting subtest: wait-for-submit-complex
[361.196718] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[361.268731] [096/131] (663s left) kms_cursor_crc (cursor-dpms)
[361.373894] Starting subtest: cursor-dpms
[361.375907] Starting dynamic subtest: pipe-A-eDP-1
[364.362506] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.985s)
[364.372733] Starting dynamic subtest: pipe-D-eDP-1
[367.925981] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.562s)
[367.928343] Subtest cursor-dpms: SUCCESS (6.549s)
[368.752425] [097/131] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[368.848557] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[368.852930] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[368.944269] [098/131] (655s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[369.052514] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[369.056951] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[369.158039] [099/131] (655s left) gem_softpin (evict-prime)
[369.230866] Starting subtest: evict-prime
[369.233555] Starting dynamic subtest: rcs0
[370.418036] Dynamic subtest rcs0: SUCCESS (1.187s)
[370.431605] Starting dynamic subtest: bcs0
[371.552246] Dynamic subtest bcs0: SUCCESS (1.133s)
[371.566215] Starting dynamic subtest: vcs0
[372.939371] Dynamic subtest vcs0: SUCCESS (1.384s)
[372.951162] Starting dynamic subtest: vcs1
[374.979409] Dynamic subtest vcs1: SUCCESS (2.038s)
[374.991760] Starting dynamic subtest: vecs0
[376.969902] Dynamic subtest vecs0: SUCCESS (1.988s)
[376.979559] Starting dynamic subtest: ccs0
[378.121128] Dynamic subtest ccs0: SUCCESS (1.151s)
[378.132180] Starting dynamic subtest: all
[379.914583] Dynamic subtest all: SUCCESS (1.790s)
[379.917216] Subtest evict-prime: SUCCESS (10.683s)
[379.991101] [100/131] (644s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[380.121119] Starting subtest: 2x-flip-vs-cursor-legacy
[380.125230] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[380.251302] [101/131] (644s left) gem_mmap_gtt (basic-read-write-distinct)
[380.302609] Subtest basic-read-write-distinct: SKIP (0.000s)
[380.365174] [102/131] (644s left) kms_flip (nonexisting-fb)
[380.458013] Starting subtest: nonexisting-fb
[380.460232] Starting dynamic subtest: A-eDP1
[381.639307] Dynamic subtest A-eDP1: SUCCESS (1.180s)
[381.648395] Starting dynamic subtest: B-eDP1
[382.861047] Dynamic subtest B-eDP1: SUCCESS (1.219s)
[382.870339] Starting dynamic subtest: C-eDP1
[384.091742] Dynamic subtest C-eDP1: SUCCESS (1.230s)
[384.100495] Starting dynamic subtest: D-eDP1
[385.313905] Dynamic subtest D-eDP1: SUCCESS (1.220s)
[385.316244] Subtest nonexisting-fb: SUCCESS (4.859s)
[386.481248] [103/131] (638s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[386.586743] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[390.091040] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.509s)
[390.243847] [104/131] (634s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[390.351702] Starting subtest: primary-y-tiled-reflect-x-270
[390.355459] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[390.420415] [105/131] (634s left) gem_exec_reloc (basic-cpu-read-active)
[390.487382] Subtest basic-cpu-read-active: SKIP (0.000s)
[390.572674] [106/131] (634s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[390.678738] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[390.682196] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[390.791084] [107/131] (634s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[390.856255] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[390.911201] [108/131] (633s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[390.970120] Starting subtest: multi-wait-all-for-submit-signaled
[390.972114] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[391.078738] [109/131] (633s left) prime_busy (after-wait)
[391.147098] Starting subtest: after-wait
[391.151733] Starting dynamic subtest: rcs0
[391.193196] Dynamic subtest rcs0: SUCCESS (0.042s)
[391.203568] Starting dynamic subtest: bcs0
[391.251670] Dynamic subtest bcs0: SUCCESS (0.058s)
[391.261459] Starting dynamic subtest: vcs0
[391.292392] Dynamic subtest vcs0: SUCCESS (0.040s)
[391.300768] Starting dynamic subtest: vcs1
[391.333103] Dynamic subtest vcs1: SUCCESS (0.040s)
[391.341627] Starting dynamic subtest: vecs0
[391.373426] Dynamic subtest vecs0: SUCCESS (0.040s)
[391.381890] Starting dynamic subtest: ccs0
[391.413800] Dynamic subtest ccs0: SUCCESS (0.040s)
[391.521947] Subtest after-wait: SUCCESS (0.373s)
[391.593851] [110/131] (633s left) gen9_exec_parse (batch-invalid-length)
[391.656961] Subtest batch-invalid-length: SKIP (0.000s)
[391.730291] [111/131] (633s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[391.854180] Starting subtest: cursorB-vs-flipB-legacy
[391.858576] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[391.982636] [112/131] (633s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[392.085590] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[393.084754] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.000s)
[393.257898] [113/131] (631s left) vgem_basic (setversion)
[393.307881] Starting subtest: setversion
[393.312464] Subtest setversion: SUCCESS (0.000s)
[393.358611] [114/131] (631s left) gem_exec_balancer (parallel-bb-first)
[393.599056] Starting subtest: parallel-bb-first
[394.409421] Subtest parallel-bb-first: SUCCESS (0.811s)
[394.962453] [115/131] (630s left) kms_vblank (query-forked-hang)
[395.064126] Starting subtest: query-forked-hang
[395.066477] Starting dynamic subtest: pipe-A-eDP-1
[421.665177] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.598s)
[421.678679] Starting dynamic subtest: pipe-D-eDP-1
[446.684851] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[446.687233] Subtest query-forked-hang: SUCCESS (51.619s)
[447.552492] [116/131] (577s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[447.667858] Starting subtest: psr-rgb101010-draw-mmap-wc
[452.525527] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.860s)
[452.620088] [117/131] (572s left) kms_chamelium_hpd (hdmi-hpd-fast)
[453.019190] Subtest hdmi-hpd-fast: SKIP (0.000s)
[453.789428] [118/131] (571s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[453.904953] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[453.907392] Starting dynamic subtest: pipe-A
[453.920157] Dynamic subtest pipe-A: SKIP (0.012s)
[453.929387] Starting dynamic subtest: pipe-B
[453.942058] Dynamic subtest pipe-B: SKIP (0.022s)
[453.950452] Starting dynamic subtest: pipe-C
[453.965712] Dynamic subtest pipe-C: SKIP (0.022s)
[453.974134] Starting dynamic subtest: pipe-D
[453.988940] Dynamic subtest pipe-D: SKIP (0.022s)
[453.992662] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.080s)
[454.099106] [119/131] (571s left) gem_spin_batch (engines)
[454.159122] Starting subtest: engines
[454.161608] Starting dynamic subtest: rcs0
[457.401171] Dynamic subtest rcs0: SUCCESS (3.237s)
[457.412078] Starting dynamic subtest: bcs0
[460.639439] Dynamic subtest bcs0: SUCCESS (3.236s)
[460.649081] Starting dynamic subtest: vcs0
[463.877539] Dynamic subtest vcs0: SUCCESS (3.236s)
[463.886071] Starting dynamic subtest: vcs1
[467.113854] Dynamic subtest vcs1: SUCCESS (3.233s)
[467.122186] Starting dynamic subtest: vecs0
[470.351113] Dynamic subtest vecs0: SUCCESS (3.234s)
[470.366698] Starting dynamic subtest: ccs0
[473.584817] Dynamic subtest ccs0: SUCCESS (3.232s)
[473.586971] Subtest engines: SUCCESS (19.422s)
[473.843334] [120/131] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[473.961693] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[473.965796] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[474.072300] [121/131] (551s left) gem_mmap_gtt (basic)
[474.138521] Subtest basic: SKIP (0.000s)
[474.201967] [122/131] (551s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[474.270710] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[474.274937] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[474.452405] [123/131] (550s left) kms_vblank (wait-forked-busy-hang)
[474.563434] Starting subtest: wait-forked-busy-hang
[474.565630] Starting dynamic subtest: pipe-A-eDP-1
[500.706318] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.140s)
[500.722581] Starting dynamic subtest: pipe-D-eDP-1
[525.666597] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.956s)
[525.668599] Subtest wait-forked-busy-hang: SUCCESS (51.100s)
[526.451533] [124/131] (499s left) kms_plane_lowres (tiling-4)
[526.542323] Starting subtest: tiling-4
[526.544687] Starting dynamic subtest: pipe-A-eDP-1
[526.549759] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[526.843206] Starting dynamic subtest: pipe-B-eDP-1
[526.847908] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[526.858546] Starting dynamic subtest: pipe-C-eDP-1
[526.862676] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[526.870370] Starting dynamic subtest: pipe-D-eDP-1
[526.874292] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[526.878239] Subtest tiling-4: SKIP (0.295s)
[527.679294] [125/131] (497s left) gem_exec_schedule (preempt-user)
[527.751064] Starting subtest: preempt-user
[527.753202] Starting dynamic subtest: rcs0
[527.769608] Dynamic subtest rcs0: SUCCESS (0.023s)
[527.778389] Starting dynamic subtest: bcs0
[527.787469] Dynamic subtest bcs0: SUCCESS (0.017s)
[527.795859] Starting dynamic subtest: vcs0
[527.806459] Dynamic subtest vcs0: SUCCESS (0.018s)
[527.817876] Starting dynamic subtest: vcs1
[527.827296] Dynamic subtest vcs1: SUCCESS (0.020s)
[527.838563] Starting dynamic subtest: vecs0
[527.845537] Dynamic subtest vecs0: SUCCESS (0.018s)
[527.854503] Starting dynamic subtest: ccs0
[527.865130] Dynamic subtest ccs0: SUCCESS (0.019s)
[527.867421] Subtest preempt-user: SUCCESS (0.119s)
[529.016412] [126/131] (496s left) kms_flip (flip-vs-expired-vblank)
[529.115075] Starting subtest: flip-vs-expired-vblank
[529.117288] Starting dynamic subtest: A-eDP1
[537.783663] Dynamic subtest A-eDP1: SUCCESS (8.667s)
[537.792461] Starting dynamic subtest: B-eDP1
[546.504788] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[546.513651] Starting dynamic subtest: C-eDP1
[555.216426] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[555.225077] Starting dynamic subtest: D-eDP1
[563.937922] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[563.940315] Subtest flip-vs-expired-vblank: SUCCESS (34.824s)
[565.102670] [127/131] (460s left) gem_exec_reloc (basic-wc-cpu)
[565.168173] Subtest basic-wc-cpu: SKIP (0.000s)
[565.232178] [128/131] (460s left) gem_readwrite (write-bad-handle)
[565.299293] Subtest write-bad-handle: SKIP (0.000s)
[565.354018] [129/131] (460s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[565.465285] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[565.469148] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[565.562619] [130/131] (460s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[565.669477] Starting subtest: y-tiled-8bpp-rotate-0
[565.673820] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[565.763372] [131/131] (459s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[565.874623] Starting subtest: x-tiled-8bpp-rotate-90
[565.895182] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[566.027411] Closing watchdogs
Done.