[92.854321] Initializing watchdogs
[92.854492]   /dev/watchdog0
[92.894174] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[92.908740] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[92.916103] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[92.924251] [001/133] (960s left) kms_psr (psr2-primary-mmap-gtt)
[93.130151] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[93.224915] [002/133] (960s left) i915_drm_fdinfo (most-busy-idle-check-all)
[93.355259] Starting subtest: most-busy-idle-check-all
[93.361967] Starting dynamic subtest: rcs0
[93.986562] Dynamic subtest rcs0: SUCCESS (0.630s)
[94.006144] Starting dynamic subtest: bcs0
[94.607434] Dynamic subtest bcs0: SUCCESS (0.622s)
[94.625966] Starting dynamic subtest: vcs0
[95.236559] Dynamic subtest vcs0: SUCCESS (0.627s)
[95.255448] Starting dynamic subtest: vecs0
[95.860508] Dynamic subtest vecs0: SUCCESS (0.623s)
[95.864144] Subtest most-busy-idle-check-all: SUCCESS (2.506s)
[96.015136] [003/133] (957s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[96.221234] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[98.737114] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.521s)
[99.017156] [004/133] (954s left) gem_exec_schedule (pi-shared-iova)
[99.294536] Starting subtest: pi-shared-iova
[99.299305] Starting dynamic subtest: rcs0
[99.361632] Dynamic subtest rcs0: SUCCESS (0.062s)
[99.397173] Starting dynamic subtest: bcs0
[99.427896] Dynamic subtest bcs0: SUCCESS (0.071s)
[99.467182] Starting dynamic subtest: vcs0
[99.486798] Dynamic subtest vcs0: SUCCESS (0.052s)
[99.509441] Starting dynamic subtest: vecs0
[99.546146] Dynamic subtest vecs0: SUCCESS (0.059s)
[99.550248] Subtest pi-shared-iova: SUCCESS (0.252s)
[99.832724] [005/133] (953s left) syncobj_timeline (multi-wait-all-available-signaled)
[99.941878] Starting subtest: multi-wait-all-available-signaled
[99.946971] Subtest multi-wait-all-available-signaled: SUCCESS (0.004s)
[100.080701] [006/133] (953s left) gem_exec_balancer (parallel)
[100.326472] Subtest parallel: SKIP (0.000s)
[100.467790] [007/133] (953s left) kms_lease (master-vs-lease)
[100.647935] Starting subtest: master-vs-lease
[100.652931] Subtest master-vs-lease: SUCCESS (0.003s)
[100.818585] [008/133] (953s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[101.036135] Starting subtest: cursor-rapid-movement-max-size
[101.049051] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[101.171070] [009/133] (952s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[101.376129] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[103.753385] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SUCCESS (2.383s)
[103.967166] [010/133] (950s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[104.158683] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[104.262257] [011/133] (950s left) device_reset (unbind-cold-reset-rebind)
[104.412419] Starting subtest: unbind-cold-reset-rebind
[104.423316] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[104.537068] [012/133] (949s left) kms_content_protection (suspend-resume)
[104.738369] Starting subtest: suspend-resume
[104.775355] Subtest suspend-resume: SKIP (0.032s)
[104.905201] [013/133] (949s left) kms_dp_link_training (uhbr-mst)
[105.091879] Starting subtest: uhbr-mst
[105.099579] Subtest uhbr-mst: SKIP (0.000s)
[105.252733] [014/133] (949s left) api_intel_bb (intel-bb-blit-y)
[105.365110] Starting subtest: intel-bb-blit-y
[108.601694] Subtest intel-bb-blit-y: SUCCESS (3.240s)
[108.754884] [015/133] (945s left) i915_drm_fdinfo (virtual-idle)
[108.884586] Starting subtest: virtual-idle
[110.915589] Subtest virtual-idle: SUCCESS (2.030s)
[111.052228] [016/133] (943s left) i915_pm_sseu (full-enable)
[111.616224] Starting subtest: full-enable
[111.634201] Subtest full-enable: SUCCESS (0.018s)
[111.772086] [017/133] (943s left) api_intel_allocator (gem-pool)
[111.882205] Starting subtest: gem-pool
[111.894526] Subtest gem-pool: SUCCESS (0.015s)
[112.039949] [018/133] (942s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[112.212147] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[112.216943] Starting dynamic subtest: pipe-A
[112.517818] Dynamic subtest pipe-A: SUCCESS (0.305s)
[112.558694] Starting dynamic subtest: pipe-B
[112.935357] Dynamic subtest pipe-B: SUCCESS (0.417s)
[112.974954] Starting dynamic subtest: pipe-C
[113.022664] Dynamic subtest pipe-C: SUCCESS (0.085s)
[113.027234] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.810s)
[113.499742] [019/133] (941s left) gem_exec_balancer (persistence)
[113.752179] Starting subtest: persistence
[118.114770] Subtest persistence: SUCCESS (4.362s)
[118.254832] [020/133] (936s left) gem_exec_schedule (u-submit-early-slice)
[118.405136] Starting subtest: u-submit-early-slice
[118.408427] Starting dynamic subtest: rcs0
[118.463096] Dynamic subtest rcs0: SUCCESS (0.065s)
[118.487993] Starting dynamic subtest: bcs0
[118.522315] Dynamic subtest bcs0: SUCCESS (0.056s)
[118.547182] Starting dynamic subtest: vcs0
[118.577407] Dynamic subtest vcs0: SUCCESS (0.054s)
[118.601633] Starting dynamic subtest: vecs0
[118.624147] Dynamic subtest vecs0: SUCCESS (0.053s)
[118.628433] Subtest u-submit-early-slice: SUCCESS (0.231s)
[119.022808] [021/133] (936s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[119.131638] Starting subtest: single-wait-all-for-submit-unsubmitted
[119.235603] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[119.369617] [022/133] (935s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[119.570122] Starting subtest: yf-tiled-32bpp-rotate-270
[125.067979] Subtest yf-tiled-32bpp-rotate-270: SUCCESS (5.496s)
[125.454500] [023/133] (929s left) kms_psr (fbc-psr2-cursor-render)
[125.647109] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[125.749591] [024/133] (929s left) perf (whitelisted-registers-userspace-config)
[125.963088] Starting subtest: whitelisted-registers-userspace-config
[125.968017] Subtest whitelisted-registers-userspace-config: SUCCESS (0.002s)
[126.069214] [025/133] (929s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[126.272701] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[126.279436] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[126.405824] [026/133] (929s left) fbdev (eof)
[126.521308] Starting subtest: eof
[126.525244] Subtest eof: SUCCESS (0.000s)
[126.668924] [027/133] (929s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[126.861385] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[126.865700] Starting dynamic subtest: pipe-A
[127.934410] Dynamic subtest pipe-A: SUCCESS (1.073s)
[127.956120] Starting dynamic subtest: pipe-B
[129.126030] Dynamic subtest pipe-B: SUCCESS (1.193s)
[129.165068] Starting dynamic subtest: pipe-C
[129.688439] Dynamic subtest pipe-C: SUCCESS (0.560s)
[129.692885] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (2.828s)
[130.239096] [028/133] (925s left) syncobj_basic (bad-create-flags)
[130.353472] Starting subtest: bad-create-flags
[130.356752] Subtest bad-create-flags: SUCCESS (0.000s)
[130.487262] [029/133] (925s left) sw_sync (sync_busy)
[130.589664] Starting subtest: sync_busy
[130.598905] Subtest sync_busy: SUCCESS (0.011s)
[130.721916] [030/133] (925s left) gem_wait (busy)
[130.869535] Starting subtest: busy
[130.876778] Starting dynamic subtest: all-engines
[131.397795] Dynamic subtest all-engines: SUCCESS (0.527s)
[131.416961] Starting dynamic subtest: rcs0
[131.909138] Dynamic subtest rcs0: SUCCESS (0.515s)
[131.932390] Starting dynamic subtest: bcs0
[132.425604] Dynamic subtest bcs0: SUCCESS (0.515s)
[132.447124] Starting dynamic subtest: vcs0
[132.945967] Dynamic subtest vcs0: SUCCESS (0.510s)
[132.964870] Starting dynamic subtest: vecs0
[133.458136] Dynamic subtest vecs0: SUCCESS (0.512s)
[133.461865] Subtest busy: SUCCESS (2.584s)
[133.738646] [031/133] (922s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[133.942397] Starting subtest: pipe-fbc-rte
[133.960185] Subtest pipe-fbc-rte: SKIP (0.002s)
[134.092374] [032/133] (922s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[134.298104] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[137.150158] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.859s)
[137.337076] [033/133] (918s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[137.527518] Starting subtest: short-flip-after-cursor-atomic-transitions
[138.872944] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.344s)
[139.198744] [034/133] (917s left) kms_psr (pr-cursor-blt)
[139.405061] Subtest pr-cursor-blt: SKIP (0.000s)
[139.507928] [035/133] (916s left) kms_color (ctm-red-to-blue)
[139.702214] Starting subtest: ctm-red-to-blue
[139.705774] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.662712] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.957s)
[140.701594] Starting dynamic subtest: pipe-A-HDMI-A-2
[141.331371] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.667s)
[141.357464] Starting dynamic subtest: pipe-B-HDMI-A-1
[142.013509] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.684s)
[142.056175] Starting dynamic subtest: pipe-B-HDMI-A-2
[142.676185] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.661s)
[142.705445] Starting dynamic subtest: pipe-C-HDMI-A-1
[143.333324] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.650s)
[143.359214] Starting dynamic subtest: pipe-C-HDMI-A-2
[144.027089] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.693s)
[144.032039] Subtest ctm-red-to-blue: SUCCESS (4.323s)
[144.331393] [036/133] (912s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[144.451228] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[144.556213] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[144.744317] [037/133] (911s left) gem_exec_reloc (basic-wc-gtt-active)
[144.862478] Starting subtest: basic-wc-gtt-active
[145.003108] Subtest basic-wc-gtt-active: SUCCESS (0.140s)
[145.218451] [038/133] (911s left) gem_ctx_exec (basic-norecovery)
[145.328564] Starting subtest: basic-norecovery
[145.364881] Subtest basic-norecovery: SUCCESS (0.033s)
[145.517314] [039/133] (911s left) gem_userptr_blits (process-exit)
[145.651139] Starting subtest: process-exit
[145.674782] Subtest process-exit: SUCCESS (0.025s)
[145.833128] [040/133] (911s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[146.574603] Starting subtest: syncobj-backward-timeline-chain-engines
[146.698760] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.120s)
[146.952757] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[146.959352] [041/133] (910s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[147.153077] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[147.273316] [042/133] (909s left) kms_joiner (basic-max-non-joiner)
[147.463091] Starting subtest: basic-max-non-joiner
[147.469761] Subtest basic-max-non-joiner: SKIP (0.000s)
[147.612374] [043/133] (909s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[147.718480] Starting subtest: wait-all-for-submit-delayed-submit
[147.891083] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.106s)
[148.368162] [044/133] (909s left) gem_mmap_gtt (hang-user)
[148.856979] Starting subtest: hang-user
[164.046156] Subtest hang-user: SUCCESS (15.458s)
[164.229915] [045/133] (893s left) sw_sync (alloc_timeline)
[164.340903] Starting subtest: alloc_timeline
[164.344905] Subtest alloc_timeline: SUCCESS (0.000s)
[164.475966] [046/133] (893s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[164.686086] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[167.612905] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.933s)
[167.895361] [047/133] (890s left) kms_pm_dc (dc3co-vpb-simulation)
[169.090985] Starting subtest: dc3co-vpb-simulation
[169.097899] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[169.246445] [048/133] (888s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[169.367471] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[169.374669] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[169.657417] [049/133] (888s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[169.841497] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[169.845062] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.886071] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[169.926416] Starting dynamic subtest: pipe-A-HDMI-A-2
[170.013768] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[170.042100] Starting dynamic subtest: pipe-B-HDMI-A-1
[170.075252] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[170.097088] Starting dynamic subtest: pipe-B-HDMI-A-2
[170.131379] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[170.151877] Starting dynamic subtest: pipe-C-HDMI-A-1
[170.184460] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[170.205314] Starting dynamic subtest: pipe-C-HDMI-A-2
[170.237512] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[170.243863] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.037s)
[170.923044] [050/133] (887s left) gem_exec_flush (basic-uc-pro-default)
[171.062101] Starting subtest: basic-uc-pro-default
[176.478702] Subtest basic-uc-pro-default: SUCCESS (5.417s)
[176.739329] [051/133] (881s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[176.844780] Starting subtest: cpuset-basic-small-copy-odd
[182.107092] Subtest cpuset-basic-small-copy-odd: SUCCESS (5.267s)
[182.276313] [052/133] (876s left) kms_addfb_basic (bad-pitch-1024)
[182.539601] Starting subtest: bad-pitch-1024
[182.544458] Subtest bad-pitch-1024: SUCCESS (0.000s)
[182.850919] [053/133] (875s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[183.049725] Starting subtest: primary-yf-tiled-reflect-x-90
[183.058260] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.003s)
[183.202443] [054/133] (875s left) kms_universal_plane (universal-plane-sanity)
[183.400578] Starting subtest: universal-plane-sanity
[183.404792] Starting dynamic subtest: pipe-A-HDMI-A-1
[184.277183] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.871s)
[184.305696] Starting dynamic subtest: pipe-B-HDMI-A-2
[184.830255] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.555s)
[184.872042] Starting dynamic subtest: pipe-C-HDMI-A-1
[185.397127] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.559s)
[185.403300] Subtest universal-plane-sanity: SUCCESS (2.002s)
[185.692583] [055/133] (873s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[185.877085] Starting subtest: cursor-vs-flip-toggle
[231.455394] Subtest cursor-vs-flip-toggle: SUCCESS (45.575s)
[231.789275] [056/133] (827s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[232.368969] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[232.670095] [057/133] (826s left) gem_exec_async (forked-writes)
[232.816179] Starting subtest: forked-writes
[232.822221] Starting dynamic subtest: rcs0
[232.878206] Dynamic subtest rcs0: SUCCESS (0.061s)
[232.910038] Starting dynamic subtest: bcs0
[232.942441] Dynamic subtest bcs0: SUCCESS (0.064s)
[232.970060] Starting dynamic subtest: vcs0
[233.004194] Dynamic subtest vcs0: SUCCESS (0.058s)
[233.037054] Starting dynamic subtest: vecs0
[233.063399] Dynamic subtest vecs0: SUCCESS (0.056s)
[233.067621] Subtest forked-writes: SUCCESS (0.252s)
[233.348695] [058/133] (825s left) kms_chamelium_audio (hdmi-audio)
[233.961654] Subtest hdmi-audio: SKIP (0.000s)
[234.274894] [059/133] (825s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[234.499086] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[235.832159] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.333s)
[236.151214] [060/133] (823s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[236.343180] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[236.347200] Starting dynamic subtest: pipe-A-HDMI-A-1
[236.391558] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[236.434463] Starting dynamic subtest: pipe-A-HDMI-A-2
[236.484290] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[236.524820] Starting dynamic subtest: pipe-B-HDMI-A-1
[236.553311] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[236.575798] Starting dynamic subtest: pipe-B-HDMI-A-2
[236.604882] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[236.626717] Starting dynamic subtest: pipe-C-HDMI-A-1
[236.655858] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[236.677435] Starting dynamic subtest: pipe-C-HDMI-A-2
[236.707022] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[236.712864] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.029s)
[237.419944] [061/133] (822s left) vgem_basic (create)
[237.547459] Starting subtest: create
[237.550810] Subtest create: SUCCESS (0.001s)
[237.683139] [062/133] (821s left) gem_create (create-valid-nonaligned)
[237.786242] Starting subtest: create-valid-nonaligned
[237.790287] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[238.055187] [063/133] (821s left) kms_cursor_edge_walk (128x128-right-edge)
[238.241157] Starting subtest: 128x128-right-edge
[238.244383] Starting dynamic subtest: pipe-A-HDMI-A-1
[242.126105] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.877s)
[242.150064] Starting dynamic subtest: pipe-C-HDMI-A-1
[245.547637] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.415s)
[245.552225] Subtest 128x128-right-edge: SUCCESS (7.303s)
[245.898910] [064/133] (813s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[246.028858] Starting subtest: etime-single-wait-for-submit-unsubmitted
[246.130992] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[246.306714] [065/133] (813s left) kms_vrr (max-min)
[246.489106] Starting subtest: max-min
[246.504252] Subtest max-min: SKIP (0.000s)
[246.643388] [066/133] (813s left) gem_exec_params (no-blt)
[246.768315] Starting subtest: no-blt
[246.772511] Subtest no-blt: SUCCESS (0.004s)
[246.927808] [067/133] (813s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[247.131973] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[247.139517] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[247.296089] [068/133] (812s left) kms_prime (basic-crc-vgem)
[247.522076] Starting subtest: basic-crc-vgem
[247.526066] Starting dynamic subtest: second-to-first
[249.180300] Dynamic subtest second-to-first: SUCCESS (1.656s)
[249.187394] Subtest basic-crc-vgem: SUCCESS (1.660s)
[249.486595] [069/133] (810s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[249.702047] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[251.730186] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.032s)
[251.960487] [070/133] (808s left) perf_pmu (busy-no-semaphores)
[252.080075] Starting subtest: busy-no-semaphores
[252.084323] Starting dynamic subtest: rcs0
[252.607226] Dynamic subtest rcs0: SUCCESS (0.528s)
[252.634754] Starting dynamic subtest: bcs0
[253.141505] Dynamic subtest bcs0: SUCCESS (0.529s)
[253.165652] Starting dynamic subtest: vcs0
[253.679459] Dynamic subtest vcs0: SUCCESS (0.534s)
[253.704293] Starting dynamic subtest: vecs0
[254.207612] Dynamic subtest vecs0: SUCCESS (0.526s)
[254.213514] Subtest busy-no-semaphores: SUCCESS (2.134s)
[254.361778] [071/133] (806s left) gem_partial_pwrite_pread (reads-snoop)
[254.482725] Starting subtest: reads-snoop
[260.861913] Subtest reads-snoop: SUCCESS (6.374s)
[261.058190] [072/133] (799s left) gem_flink_basic (basic)
[261.169742] Starting subtest: basic
[261.173696] Subtest basic: SUCCESS (0.000s)
[261.311906] [073/133] (799s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[261.525106] Starting subtest: fbc-rgb101010-draw-mmap-wc
[264.545615] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.022s)
[264.812846] [074/133] (796s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[265.016757] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[265.026720] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[265.168700] [075/133] (795s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[265.370231] Starting subtest: x-tiled-8bpp-rotate-270
[265.726531] Subtest x-tiled-8bpp-rotate-270: SKIP (0.350s)
[265.982434] [076/133] (795s left) syncobj_timeline (multi-wait-signaled)
[266.097432] Starting subtest: multi-wait-signaled
[266.101627] Subtest multi-wait-signaled: SUCCESS (0.003s)
[266.244152] [077/133] (794s left) syncobj_timeline (wait-for-submit-snapshot)
[266.356591] Starting subtest: wait-for-submit-snapshot
[266.445071] Subtest wait-for-submit-snapshot: SUCCESS (0.088s)
[266.594399] [078/133] (794s left) kms_chamelium_frames (hdmi-crc-fast)
[267.153130] Subtest hdmi-crc-fast: SKIP (0.000s)
[267.466539] [079/133] (793s left) gem_eio (in-flight-immediate)
[267.612091] Starting subtest: in-flight-immediate
[268.582163] Subtest in-flight-immediate: SUCCESS (0.969s)
[268.828836] [080/133] (792s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[269.025156] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[269.029274] Starting dynamic subtest: A-HDMI-A1
[270.544045] Dynamic subtest A-HDMI-A1: SUCCESS (1.506s)
[270.568984] Starting dynamic subtest: B-HDMI-A1
[271.471166] Dynamic subtest B-HDMI-A1: SUCCESS (0.931s)
[271.522889] Starting dynamic subtest: C-HDMI-A1
[272.512702] Dynamic subtest C-HDMI-A1: SUCCESS (1.034s)
[272.550245] Starting dynamic subtest: A-HDMI-A2
[273.491097] Dynamic subtest A-HDMI-A2: SUCCESS (0.977s)
[273.518084] Starting dynamic subtest: B-HDMI-A2
[274.456212] Dynamic subtest B-HDMI-A2: SUCCESS (0.960s)
[274.493295] Starting dynamic subtest: C-HDMI-A2
[275.389106] Dynamic subtest C-HDMI-A2: SUCCESS (0.925s)
[275.395072] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (6.368s)
[275.711564] [081/133] (785s left) kms_addfb_basic (basic-y-tiled-legacy)
[275.838994] Starting subtest: basic-y-tiled-legacy
[275.842875] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[276.093793] [082/133] (785s left) i915_query (query-topology-known-pci-ids)
[276.208519] Starting subtest: query-topology-known-pci-ids
[276.216340] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[276.355648] [083/133] (785s left) gem_partial_pwrite_pread (write)
[276.468520] Starting subtest: write
[290.832709] Subtest write: SUCCESS (14.364s)
[291.037922] [084/133] (770s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[291.241142] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[291.247640] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[291.392544] [085/133] (770s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[291.598456] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[291.602266] Starting dynamic subtest: pipe-A-valid-mode
[292.794560] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.190s)
[292.803282] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (1.198s)
[293.347054] [086/133] (768s left) gem_exec_suspend (basic-s4-devices)
[294.014878] Starting subtest: basic-S4-devices
[294.084200] Starting dynamic subtest: smem
[305.981599] Dynamic subtest smem: SUCCESS (12.203s)
[305.985959] Subtest basic-S4-devices: SUCCESS (12.207s)
[316.294175] [087/133] (756s left) kms_cursor_crc (cursor-offscreen-256x256)
[316.529681] Starting subtest: cursor-offscreen-256x256
[316.597841] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.450597] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.847s)
[319.568877] Starting dynamic subtest: pipe-C-HDMI-A-1
[322.062082] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.550s)
[322.068092] Subtest cursor-offscreen-256x256: SUCCESS (5.529s)
[322.396903] [088/133] (750s left) syncobj_basic (bad-destroy-pad)
[322.517081] Starting subtest: bad-destroy-pad
[322.520442] Subtest bad-destroy-pad: SUCCESS (0.000s)
[322.688879] [089/133] (749s left) syncobj_timeline (single-wait-available-submitted)
[322.799097] Starting subtest: single-wait-available-submitted
[322.802537] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[322.975481] [090/133] (749s left) kms_pipe_crc_basic (suspend-read-crc)
[323.161975] Starting subtest: suspend-read-crc
[323.166086] Starting dynamic subtest: pipe-A-HDMI-A-1