[59.424833] Initializing watchdogs
[59.424878]   /dev/watchdog0
[59.438142] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.442565] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.445117] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.448437] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[59.584518] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[59.588615] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[59.685314] [002/131] (960s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[59.797595] Starting subtest: 4-tiled-32bpp-rotate-90
[59.830189] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.032s)
[59.934861] [003/131] (960s left) kms_plane (plane-position-covered)
[60.039812] Starting subtest: plane-position-covered
[60.557774] Starting dynamic subtest: pipe-A-plane-1
[61.802057] Dynamic subtest pipe-A-plane-1: SUCCESS (1.246s)
[61.811410] Starting dynamic subtest: pipe-A-plane-2
[63.084313] Dynamic subtest pipe-A-plane-2: SUCCESS (1.282s)
[63.091159] Starting dynamic subtest: pipe-A-plane-3
[64.406560] Dynamic subtest pipe-A-plane-3: SUCCESS (1.324s)
[64.415271] Starting dynamic subtest: pipe-A-plane-4
[65.718700] Dynamic subtest pipe-A-plane-4: SUCCESS (1.311s)
[65.726985] Starting dynamic subtest: pipe-A-plane-5
[65.746979] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s)
[66.969269] Starting dynamic subtest: pipe-B-plane-1
[68.298706] Dynamic subtest pipe-B-plane-1: SUCCESS (1.336s)
[68.307604] Starting dynamic subtest: pipe-B-plane-2
[69.579186] Dynamic subtest pipe-B-plane-2: SUCCESS (1.280s)
[69.588309] Starting dynamic subtest: pipe-B-plane-3
[70.798337] Dynamic subtest pipe-B-plane-3: SUCCESS (1.219s)
[70.806906] Starting dynamic subtest: pipe-B-plane-4
[72.018062] Dynamic subtest pipe-B-plane-4: SUCCESS (1.220s)
[72.027163] Starting dynamic subtest: pipe-B-plane-5
[72.042544] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[72.044919] Subtest plane-position-covered: SUCCESS (12.012s)
[72.823592] [004/131] (947s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[72.912066] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[72.914418] Starting dynamic subtest: pipe-A
[72.977700] Dynamic subtest pipe-A: SUCCESS (0.067s)
[72.986344] Starting dynamic subtest: pipe-B
[74.140546] Dynamic subtest pipe-B: SUCCESS (1.162s)
[74.150331] Starting dynamic subtest: pipe-C
[75.254980] Dynamic subtest pipe-C: SUCCESS (1.114s)
[75.263577] Starting dynamic subtest: pipe-D
[76.385479] Dynamic subtest pipe-D: SUCCESS (1.130s)
[76.387842] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.476s)
[77.568837] [005/131] (942s left) gem_partial_pwrite_pread (writes-after-reads)
[77.639664] Subtest writes-after-reads: SKIP (0.000s)
[77.715569] [006/131] (942s left) gem_mmap_gtt (basic-small-copy)
[77.776574] Subtest basic-small-copy: SKIP (0.000s)
[77.829842] [007/131] (942s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[77.903522] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[78.008963] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[78.088066] [008/131] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[78.199506] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[85.775611] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.579s)
[85.921083] [009/131] (934s left) gem_exec_fence (syncobj-wait)
[86.375291] Starting subtest: syncobj-wait
[87.922729] Subtest syncobj-wait: SUCCESS (1.549s)
[88.264042] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[88.267064] [010/131] (932s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[88.381668] Starting subtest: flip-vs-dpms-on-nop-interruptible
[88.384040] Starting dynamic subtest: A-eDP1
[90.233428] Dynamic subtest A-eDP1: SUCCESS (1.851s)
[90.242252] Starting dynamic subtest: B-eDP1
[92.074625] Dynamic subtest B-eDP1: SUCCESS (1.840s)
[92.083218] Starting dynamic subtest: C-eDP1
[93.883700] Dynamic subtest C-eDP1: SUCCESS (1.808s)
[93.893039] Starting dynamic subtest: D-eDP1
[95.720331] Dynamic subtest D-eDP1: SUCCESS (1.835s)
[95.725353] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.345s)
[96.895699] [011/131] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[96.991554] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[96.996052] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[97.131670] [012/131] (923s left) prime_vgem (fence-write-hang)
[97.211069] Subtest fence-write-hang: SKIP (0.000s)
[97.299654] [013/131] (923s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[97.401128] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[97.405462] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[97.487017] [014/131] (923s left) i915_query (hwconfig_table)
[97.555102] Starting subtest: hwconfig_table
[97.843038] Subtest hwconfig_table: SUCCESS (0.001s)
[97.877757] [015/131] (922s left) kms_psr (psr2-no-drrs)
[97.959282] Starting subtest: psr2-no-drrs
[97.961181] Starting dynamic subtest: eDP-1
[99.556786] Dynamic subtest eDP-1: SUCCESS (1.598s)
[99.559053] Subtest psr2-no-drrs: SUCCESS (1.598s)
[100.368461] [016/131] (920s left) gem_exec_whisper (basic-contexts-forked)
[100.443658] Starting subtest: basic-contexts-forked
[125.382978] Subtest basic-contexts-forked: SUCCESS (24.937s)
[125.564728] [017/131] (895s left) perf_pmu (most-busy-idle-check-all)
[125.607852] Starting subtest: most-busy-idle-check-all
[125.610274] Starting dynamic subtest: rcs0
[126.933829] Dynamic subtest rcs0: SUCCESS (1.324s)
[126.944526] Starting dynamic subtest: bcs0
[128.917857] Dynamic subtest bcs0: SUCCESS (1.981s)
[128.929367] Starting dynamic subtest: vcs0
[130.901460] Dynamic subtest vcs0: SUCCESS (1.981s)
[130.912152] Starting dynamic subtest: vcs1
[132.885993] Dynamic subtest vcs1: SUCCESS (1.983s)
[132.897055] Starting dynamic subtest: vecs0
[134.933312] Dynamic subtest vecs0: SUCCESS (2.046s)
[134.943321] Starting dynamic subtest: ccs0
[136.916784] Dynamic subtest ccs0: SUCCESS (1.982s)
[136.919808] Subtest most-busy-idle-check-all: SUCCESS (11.309s)
[137.033805] [018/131] (883s left) kms_force_connector_basic (force-connector-state)
[137.124588] Starting subtest: force-connector-state
[137.751346] Subtest force-connector-state: SUCCESS (0.629s)
[138.703716] [019/131] (881s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[138.798990] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[145.680348] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.885s)
[145.789202] [020/131] (874s left) kms_chamelium_color (ctm-0-25)
[145.888261] Subtest ctm-0-25: SKIP (0.000s)
[145.929808] [021/131] (874s left) gem_exec_balancer (waits)
[145.995396] Starting subtest: waits
[152.491389] Subtest waits: SUCCESS (6.493s)
[152.808263] [022/131] (867s left) gem_mmap_gtt (isolation)
[152.861842] Subtest isolation: SKIP (0.000s)
[152.928301] [023/131] (867s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[153.028328] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[153.032434] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[153.137399] [024/131] (867s left) perf_pmu (all-busy-check-all)
[153.184559] Starting subtest: all-busy-check-all
[154.838363] Subtest all-busy-check-all: SUCCESS (1.654s)
[154.931922] [025/131] (865s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[155.028956] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[155.031302] Starting dynamic subtest: pipe-A-eDP-1
[171.488750] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.465s)
[171.496916] Starting dynamic subtest: pipe-B-eDP-1
[188.630027] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.138s)
[188.632404] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.606s)
[189.508012] [026/131] (831s left) gem_exec_reloc (basic-cpu-read-noreloc)
[189.582427] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[189.671756] [027/131] (831s left) gem_spin_batch (resubmit)
[189.740102] Starting subtest: resubmit
[189.742427] Starting dynamic subtest: rcs0
[189.747043] Dynamic subtest rcs0: SUCCESS (0.005s)
[189.758060] Starting dynamic subtest: bcs0
[189.760423] Dynamic subtest bcs0: SUCCESS (0.002s)
[189.768421] Starting dynamic subtest: vcs0
[189.770577] Dynamic subtest vcs0: SUCCESS (0.002s)
[189.778262] Starting dynamic subtest: vcs1
[189.780441] Dynamic subtest vcs1: SUCCESS (0.003s)
[189.787936] Starting dynamic subtest: vecs0
[189.790156] Dynamic subtest vecs0: SUCCESS (0.002s)
[189.797720] Starting dynamic subtest: ccs0
[189.799905] Dynamic subtest ccs0: SUCCESS (0.002s)
[189.802123] Subtest resubmit: SUCCESS (0.019s)
[189.990172] [028/131] (831s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[190.089773] Starting subtest: x-tiled-64bpp-rotate-90
[190.109480] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[190.225270] [029/131] (830s left) kms_cursor_edge_walk (128x128-left-edge)
[190.302989] Starting subtest: 128x128-left-edge
[190.305343] Starting dynamic subtest: pipe-A-eDP-1
[193.731330] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[193.740339] Starting dynamic subtest: pipe-D-eDP-1
[196.907553] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.176s)
[196.909853] Subtest 128x128-left-edge: SUCCESS (6.605s)
[197.804368] [030/131] (823s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[197.902218] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[197.904162] Starting dynamic subtest: pipe-A-eDP-1
[198.696224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s)
[198.705044] Starting dynamic subtest: pipe-B-eDP-1
[200.181118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s)
[200.190146] Starting dynamic subtest: pipe-C-eDP-1
[201.669516] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.486s)
[201.677845] Starting dynamic subtest: pipe-D-eDP-1
[203.211864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.542s)
[203.213706] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.303s)
[204.384390] [031/131] (816s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[204.516206] Starting subtest: cursor-vs-flip-legacy
[234.167163] Subtest cursor-vs-flip-legacy: SUCCESS (29.650s)
[234.985653] [032/131] (786s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[235.043886] Starting subtest: single-wait-all-for-submit-available-submitted
[235.046047] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[235.153129] [033/131] (786s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[235.248552] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[235.253036] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[235.349523] [034/131] (785s left) kms_content_protection (atomic-dpms-hdcp14)
[235.476662] Starting subtest: atomic-dpms-hdcp14
[235.481221] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[235.604909] [035/131] (785s left) kms_draw_crc (draw-method-blt)
[235.705383] Starting subtest: draw-method-blt
[235.707357] Starting dynamic subtest: xrgb8888-untiled
[235.924993] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[235.933149] Starting dynamic subtest: rgb565-untiled
[236.147106] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[236.157530] Starting dynamic subtest: xrgb2101010-untiled
[236.347385] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[236.354932] Starting dynamic subtest: xbgr16161616f-untiled
[236.547209] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[236.557169] Starting dynamic subtest: xrgb8888-xtiled
[236.658070] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.109s)
[236.666632] Starting dynamic subtest: rgb565-xtiled
[236.769381] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[236.777296] Starting dynamic subtest: xrgb2101010-xtiled
[236.881704] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[236.889405] Starting dynamic subtest: xbgr16161616f-xtiled
[236.980663] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[236.990851] Starting dynamic subtest: xrgb8888-4tiled
[237.091821] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.108s)
[237.099661] Starting dynamic subtest: rgb565-4tiled
[237.202710] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[237.210320] Starting dynamic subtest: xrgb2101010-4tiled
[237.302672] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[237.312260] Starting dynamic subtest: xbgr16161616f-4tiled
[237.402852] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[237.404825] Subtest draw-method-blt: SUCCESS (1.701s)
[237.508660] [036/131] (783s left) kms_getfb (getfb2-into-addfb2)
[237.597137] Starting subtest: getfb2-into-addfb2
[237.598952] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[237.692007] [037/131] (783s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[237.816069] Starting subtest: cursorB-vs-flipA-toggle
[237.819851] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[237.959887] [038/131] (783s left) gem_exec_schedule (preempt-queue-contexts-chain)
[238.034364] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[238.324326] [039/131] (783s left) gem_eio (in-flight-1us)
[238.533984] Starting subtest: in-flight-1us
[246.618847] Subtest in-flight-1us: SUCCESS (8.084s)
[246.737999] [040/131] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[246.834620] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[246.838803] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.929415] [041/131] (774s left) kms_properties (get_properties-sanity-atomic)
[247.015216] Starting subtest: get_properties-sanity-atomic
[247.017533] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[247.095633] [042/131] (774s left) kms_pm_rpm (dpms-lpsp)
[249.126778] Starting subtest: dpms-lpsp
[249.439089] Subtest dpms-lpsp: SUCCESS (0.317s)
[249.530395] [043/131] (772s left) syncobj_wait (invalid-reset-bad-pad)
[249.588126] Starting subtest: invalid-reset-bad-pad
[249.590487] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[249.681423] [044/131] (772s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[249.778602] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[249.869714] [045/131] (771s left) kms_plane_cursor (primary)
[249.977075] Starting subtest: primary
[249.981466] Starting dynamic subtest: pipe-A-eDP-1-size-64
[252.560051] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.582s)
[252.582841] Starting dynamic subtest: pipe-A-eDP-1-size-128
[255.116249] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[255.140111] Starting dynamic subtest: pipe-A-eDP-1-size-256
[257.673406] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.539s)
[257.985992] Starting dynamic subtest: pipe-B-eDP-1-size-64
[261.187081] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.211s)
[261.211027] Starting dynamic subtest: pipe-B-eDP-1-size-128
[263.754070] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[263.777401] Starting dynamic subtest: pipe-B-eDP-1-size-256
[266.355084] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[266.670343] Starting dynamic subtest: pipe-C-eDP-1-size-64
[269.577466] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.919s)
[269.604130] Starting dynamic subtest: pipe-C-eDP-1-size-128
[271.777781] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.181s)
[271.804802] Starting dynamic subtest: pipe-C-eDP-1-size-256
[274.000762] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[274.318724] Starting dynamic subtest: pipe-D-eDP-1-size-64
[277.258217] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.952s)
[277.285632] Starting dynamic subtest: pipe-D-eDP-1-size-128
[279.469652] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.192s)
[279.496562] Starting dynamic subtest: pipe-D-eDP-1-size-256
[281.658488] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.170s)
[281.972048] Subtest primary: SUCCESS (31.994s)
[282.774744] [046/131] (739s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[282.867959] Starting subtest: primary-4-tiled-reflect-x-0
[289.846677] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.980s)
[291.087276] [047/131] (730s left) kms_cursor_crc (cursor-onscreen-256x256)
[291.339761] Starting subtest: cursor-onscreen-256x256
[291.341902] Starting dynamic subtest: pipe-A-eDP-1
[293.432517] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.090s)
[293.458577] Starting dynamic subtest: pipe-D-eDP-1
[296.217273] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s)
[296.219136] Subtest cursor-onscreen-256x256: SUCCESS (4.877s)
[297.076868] [048/131] (724s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[297.135232] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[297.194427] [049/131] (724s left) gem_lmem_swapping (verify-random-ccs)
[297.242693] Subtest verify-random-ccs: SKIP (0.000s)
[297.291251] [050/131] (724s left) gem_ctx_bad_destroy (invalid-default-ctx)
[297.348878] Starting subtest: invalid-default-ctx
[297.351362] Subtest invalid-default-ctx: SUCCESS (0.000s)
[297.433440] [051/131] (724s left) gem_exec_fence (syncobj-import)
[297.889059] Starting subtest: syncobj-import
[297.894402] Subtest syncobj-import: SUCCESS (0.005s)
[299.009549] [052/131] (723s left) sw_sync (timeline_closed)
[299.048585] Starting subtest: timeline_closed
[299.050991] Subtest timeline_closed: SUCCESS (0.000s)
[299.103241] [053/131] (722s left) kms_joiner (invalid-modeset-force-big-joiner)
[299.199741] Starting subtest: invalid-modeset-force-big-joiner
[299.204035] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[299.270205] [054/131] (722s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[299.367228] Starting subtest: fbcpsr-suspend
[339.799157] Subtest fbcpsr-suspend: SUCCESS (10.051s)
[339.934928] [055/131] (682s left) kms_plane_alpha_blend (alpha-7efc)
[340.034864] Starting subtest: alpha-7efc
[340.328270] Starting dynamic subtest: pipe-A-eDP-1
[340.939909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.614s)
[340.970281] Starting dynamic subtest: pipe-D-eDP-1
[342.255295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s)
[342.258382] Subtest alpha-7efc: SUCCESS (2.232s)
[343.093463] [056/131] (679s left) gem_exec_reloc (basic-softpin)
[343.163107] Subtest basic-softpin: SKIP (0.000s)
[343.230094] [057/131] (679s left) gem_exec_balancer (noheartbeat)
[343.503244] Starting subtest: noheartbeat
[343.509239] Subtest noheartbeat: SKIP (0.000s)
[343.609348] [058/131] (678s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[343.710375] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[343.713168] Starting dynamic subtest: pipe-A-eDP-1
[343.736823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[343.746977] Starting dynamic subtest: pipe-B-eDP-1
[343.766335] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[343.775384] Starting dynamic subtest: pipe-C-eDP-1
[343.795895] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[343.804828] Starting dynamic subtest: pipe-D-eDP-1
[343.824788] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[343.827019] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[345.993699] [059/131] (676s left) gem_mmap (pf-nonblock)
[346.042403] Subtest pf-nonblock: SKIP (0.000s)
[346.106237] [060/131] (676s left) syncobj_timeline (invalid-query-zero-handles)
[346.159882] Starting subtest: invalid-query-zero-handles
[346.162391] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[346.255301] [061/131] (676s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[346.351738] Starting subtest: fbc-rgb565-draw-pwrite
[350.887336] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.548s)
[352.088249] [062/131] (670s left) gem_exec_reloc (basic-gtt-cpu)
[352.156326] Subtest basic-gtt-cpu: SKIP (0.000s)
[352.231981] [063/131] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[352.325615] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[352.330329] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[352.422177] [064/131] (670s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[352.821040] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[353.699530] [065/131] (668s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[353.794764] Starting subtest: drrs-dirtyfb-ioctl
[353.809991] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[353.898294] [066/131] (668s left) i915_drm_fdinfo (virtual-busy-all)
[353.940537] Starting subtest: virtual-busy-all
[353.945314] Subtest virtual-busy-all: SKIP (0.000s)
[354.006961] [067/131] (668s left) gem_softpin (32b-excludes-last-page)
[354.068327] Starting subtest: 32b-excludes-last-page
[354.074097] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[354.187333] [068/131] (668s left) kms_sequence (get-forked-busy)
[354.279174] Starting subtest: get-forked-busy
[354.282003] Starting dynamic subtest: pipe-A-eDP-1
[356.225981] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.950s)
[356.238368] Starting dynamic subtest: pipe-B-eDP-1
[358.837318] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.610s)
[358.848395] Starting dynamic subtest: pipe-C-eDP-1
[361.430391] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.592s)
[361.441412] Starting dynamic subtest: pipe-D-eDP-1
[364.008325] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.582s)
[364.011235] Subtest get-forked-busy: SUCCESS (9.740s)
[364.857163] [069/131] (657s left) gem_ctx_param (basic-default)
[364.921175] Starting subtest: basic-default
[364.924209] Subtest basic-default: SUCCESS (0.000s)
[364.997208] [070/131] (657s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[365.092893] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[365.104235] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[365.183643] [071/131] (657s left) gem_watchdog (default-virtual)
[365.258816] Starting subtest: default-virtual
[371.531993] Subtest default-virtual: SUCCESS (6.289s)
[371.655902] [072/131] (651s left) gem_eio (throttle)
[371.843139] Starting subtest: throttle
[372.113840] Subtest throttle: SUCCESS (0.269s)
[372.255005] [073/131] (650s left) kms_psr (fbc-psr-cursor-blt)
[372.355792] Starting subtest: fbc-psr-cursor-blt
[372.358143] Starting dynamic subtest: eDP-1
[372.362592] Dynamic subtest eDP-1: SKIP (0.000s)
[372.367138] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[372.429701] [074/131] (650s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[372.537239] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[373.549391] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.013s)
[373.660545] [075/131] (649s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[373.723158] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[373.782300] [076/131] (649s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[373.886585] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[373.891766] Starting dynamic subtest: A-eDP1
[377.570951] Dynamic subtest A-eDP1: SUCCESS (3.678s)
[377.580915] Starting dynamic subtest: B-eDP1
[380.789184] Dynamic subtest B-eDP1: SUCCESS (3.214s)
[380.799978] Starting dynamic subtest: C-eDP1
[384.108293] Dynamic subtest C-eDP1: SUCCESS (3.319s)
[384.119182] Starting dynamic subtest: D-eDP1
[387.392263] Dynamic subtest D-eDP1: SUCCESS (3.282s)
[387.395208] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.504s)
[388.264282] [077/131] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[388.370900] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[388.376126] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[388.462756] [078/131] (634s left) perf_pmu (busy-check-all)
[388.507327] Starting subtest: busy-check-all
[388.509957] Starting dynamic subtest: rcs0
[389.070642] Dynamic subtest rcs0: SUCCESS (0.565s)
[389.084002] Starting dynamic subtest: bcs0
[389.623719] Dynamic subtest bcs0: SUCCESS (0.550s)
[389.636829] Starting dynamic subtest: vcs0
[391.324638] Dynamic subtest vcs0: SUCCESS (1.697s)
[391.338007] Starting dynamic subtest: vcs1
[393.308827] Dynamic subtest vcs1: SUCCESS (1.981s)
[393.322439] Starting dynamic subtest: vecs0
[395.292547] Dynamic subtest vecs0: SUCCESS (1.980s)
[395.305361] Starting dynamic subtest: ccs0
[395.848773] Dynamic subtest ccs0: SUCCESS (0.554s)
[395.851734] Subtest busy-check-all: SUCCESS (7.343s)
[395.964897] [079/131] (627s left) kms_addfb_basic (legacy-format)
[396.025533] Starting subtest: legacy-format
[396.053915] Subtest legacy-format: SUCCESS (0.027s)
[396.198697] [080/131] (627s left) api_intel_bb (intel-bb-blit-none)
[396.261245] Starting subtest: intel-bb-blit-none
[400.140280] Subtest intel-bb-blit-none: SUCCESS (3.879s)
[400.269750] [081/131] (623s left) kms_atomic_transition (plane-all-transition)
[400.371142] Starting subtest: plane-all-transition
[400.373713] Starting dynamic subtest: pipe-A-eDP-1
[402.864009] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[403.183689] Starting dynamic subtest: pipe-B-eDP-1
[406.373301] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.198s)
[406.683448] Subtest plane-all-transition: SUCCESS (6.315s)
[407.567447] [082/131] (615s left) fbdev (unaligned-read)
[407.628968] Starting subtest: unaligned-read
[407.644021] Subtest unaligned-read: SUCCESS (0.015s)
[407.715788] [083/131] (615s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[407.808224] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[407.834298] Starting dynamic subtest: pipe-A-plane-0
[408.489237] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[408.501663] Starting dynamic subtest: pipe-A-plane-3
[408.933184] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[410.019874] Starting dynamic subtest: pipe-B-plane-0
[410.707195] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[410.717256] Starting dynamic subtest: pipe-B-plane-3
[411.163161] Dynamic subtest pipe-B-plane-3: SUCCESS (0.454s)
[411.482586] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.676s)
[412.355653] [084/131] (611s left) perf (short-reads)
[412.478118] Starting subtest: short-reads
[412.493044] Subtest short-reads: SUCCESS (0.016s)
[412.539558] [085/131] (610s left) prime_mmap (test_refcounting)
[412.592798] Starting subtest: test_refcounting
[412.595014] Starting dynamic subtest: test_refcounting-smem
[412.621217] Dynamic subtest test_refcounting-smem: SUCCESS (0.030s)
[412.624057] Subtest test_refcounting: SUCCESS (0.031s)
[412.728608] [086/131] (610s left) kms_psr (pr-sprite-mmap-gtt)
[412.820153] Starting subtest: pr-sprite-mmap-gtt
[412.824660] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[412.907674] [087/131] (610s left) gem_exec_flush (basic-uc-rw-default)
[412.973732] Starting subtest: basic-uc-rw-default
[418.439418] Subtest basic-uc-rw-default: SUCCESS (5.458s)
[418.629444] [088/131] (605s left) gem_exec_schedule (independent)
[418.714302] Starting subtest: independent
[418.717814] Starting dynamic subtest: rcs0
[420.316434] Dynamic subtest rcs0: SUCCESS (1.616s)
[420.329204] Starting dynamic subtest: vcs0
[422.316421] Dynamic subtest vcs0: SUCCESS (1.998s)
[422.328306] Starting dynamic subtest: vcs1
[424.296901] Dynamic subtest vcs1: SUCCESS (1.978s)
[424.320568] Starting dynamic subtest: vecs0
[426.283767] Dynamic subtest vecs0: SUCCESS (1.984s)
[426.298213] Starting dynamic subtest: ccs0
[428.252695] Dynamic subtest ccs0: SUCCESS (1.966s)
[428.255690] Subtest independent: SUCCESS (9.556s)
[428.573149] [089/131] (595s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[428.638200] Starting subtest: yf-tiled-ccs-to-yf-tiled
[428.643966] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[428.823478] [090/131] (594s left) kms_flip (wf_vblank-ts-check)
[428.911177] Starting subtest: wf_vblank-ts-check
[428.913923] Starting dynamic subtest: A-eDP1
[437.862840] Dynamic subtest A-eDP1: SUCCESS (8.954s)
[437.874283] Starting dynamic subtest: B-eDP1
[446.768671] Dynamic subtest B-eDP1: SUCCESS (8.904s)
[446.781064] Starting dynamic subtest: C-eDP1
[455.651088] Dynamic subtest C-eDP1: SUCCESS (8.876s)
[455.665172] Starting dynamic subtest: D-eDP1
[464.553301] Dynamic subtest D-eDP1: SUCCESS (8.901s)
[464.559837] Subtest wf_vblank-ts-check: SUCCESS (35.644s)
[465.774009] [091/131] (557s left) kms_atomic_transition (modeset-transition-fencing)
[465.865939] Starting subtest: modeset-transition-fencing
[465.868199] Starting dynamic subtest: 1x-outputs
[476.708771] Dynamic subtest 1x-outputs: SUCCESS (10.843s)
[476.711312] Subtest modeset-transition-fencing: SUCCESS (10.844s)
[477.545896] [092/131] (546s left) kms_big_fb (linear-64bpp-rotate-270)
[477.647146] Starting subtest: linear-64bpp-rotate-270
[477.665299] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[477.781794] [093/131] (546s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[477.877179] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[477.882301] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[477.981882] [094/131] (545s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[478.071453] Starting subtest: y-tiled-addfb-size-offset-overflow
[478.076512] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[478.171909] [095/131] (545s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[478.367583] Starting subtest: cursor-rapid-movement-64x21
[478.414932] Subtest cursor-rapid-movement-64x21: SKIP (0.041s)
[478.651615] [096/131] (545s left) gem_exec_reloc (basic-gtt-cpu-active)
[478.715282] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[478.782510] [097/131] (545s left) kms_addfb_basic (tile-pitch-mismatch)
[478.834207] Starting subtest: tile-pitch-mismatch
[478.838165] Subtest tile-pitch-mismatch: SKIP (0.000s)
[478.968842] [098/131] (545s left) perf_pmu (frequency)
[479.009051] Starting subtest: frequency
[479.014445] Starting dynamic subtest: gt0
[481.135303] Dynamic subtest gt0: SUCCESS (2.117s)
[481.147882] Starting dynamic subtest: idle-gt0
[481.641430] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[481.653431] Starting dynamic subtest: gt1
[486.301280] Dynamic subtest gt1: SUCCESS (4.654s)
[486.314399] Starting dynamic subtest: idle-gt1
[486.806050] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[486.809045] Subtest frequency: SUCCESS (7.799s)
[486.908759] [099/131] (537s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[487.013065] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[487.015509] Starting dynamic subtest: pipe-A-eDP-1
[487.110403] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[487.122143] Starting dynamic subtest: pipe-B-eDP-1
[488.297386] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s)
[488.302450] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.290s)
[489.441758] [100/131] (534s left) kms_lease (cursor-implicit-plane)
[489.526008] Starting subtest: cursor-implicit-plane
[489.528423] Starting dynamic subtest: pipe-A-eDP-1
[489.985192] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[489.996178] Starting dynamic subtest: pipe-B-eDP-1
[491.145264] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[491.156189] Starting dynamic subtest: pipe-C-eDP-1
[492.210939] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.064s)
[492.222441] Starting dynamic subtest: pipe-D-eDP-1
[493.322619] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.109s)
[493.325431] Subtest cursor-implicit-plane: SUCCESS (3.798s)
[494.150723] [101/131] (530s left) gem_ccs (large-ctrl-surf-copy)
[494.207545] Starting subtest: large-ctrl-surf-copy
[494.213418] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[494.299881] [102/131] (529s left) i915_pm_rps (engine-order)
[494.361393] Starting subtest: engine-order
[499.381998] Subtest engine-order: SUCCESS (5.019s)
[499.518790] [103/131] (524s left) kms_psr (fbc-psr2-no-drrs)
[499.628320] Starting subtest: fbc-psr2-no-drrs
[499.631015] Starting dynamic subtest: eDP-1
[499.636198] Dynamic subtest eDP-1: SKIP (0.000s)
[499.641390] Subtest fbc-psr2-no-drrs: SKIP (0.002s)
[499.708079] [104/131] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[499.804252] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[499.809275] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[499.902094] [105/131] (524s left) kms_color_pipeline (plane-ctm3x4)
[500.012292] Starting subtest: plane-ctm3x4
[500.147096] Starting dynamic subtest: pipe-A-plane-0
[500.269801] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s)
[500.280516] Starting dynamic subtest: pipe-A-plane-1
[500.379613] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[500.389793] Starting dynamic subtest: pipe-A-plane-2
[500.490589] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[501.696260] Starting dynamic subtest: pipe-B-plane-0
[501.810437] Dynamic subtest pipe-B-plane-0: SUCCESS (0.122s)
[501.823059] Starting dynamic subtest: pipe-B-plane-1
[501.932948] Dynamic subtest pipe-B-plane-1: SUCCESS (0.121s)
[501.943448] Starting dynamic subtest: pipe-B-plane-2
[502.043461] Dynamic subtest pipe-B-plane-2: SUCCESS (0.110s)
[503.200106] Starting dynamic subtest: pipe-C-plane-0
[503.303751] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[503.313415] Starting dynamic subtest: pipe-C-plane-1
[503.427110] Dynamic subtest pipe-C-plane-1: SUCCESS (0.122s)
[503.436639] Starting dynamic subtest: pipe-C-plane-2
[503.536992] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[504.773496] Starting dynamic subtest: pipe-D-plane-0
[504.886586] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[504.897013] Starting dynamic subtest: pipe-D-plane-1
[504.998459] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[505.010429] Starting dynamic subtest: pipe-D-plane-2
[505.120412] Dynamic subtest pipe-D-plane-2: SUCCESS (0.122s)
[505.415257] Subtest plane-ctm3x4: SUCCESS (5.406s)
[506.251404] [106/131] (518s left) i915_pm_freq_api (freq-basic-api)
[506.309407] Starting subtest: freq-basic-api
[506.312313] Starting dynamic subtest: gt0
[506.315417] Dynamic subtest gt0: SUCCESS (0.003s)
[506.327520] Starting dynamic subtest: gt1
[506.330664] Dynamic subtest gt1: SUCCESS (0.003s)
[506.333394] Subtest freq-basic-api: SUCCESS (0.007s)
[506.427693] [107/131] (518s left) gem_ctx_persistence (heartbeat-many)
[506.486729] Starting subtest: heartbeat-many
[506.491868] Subtest heartbeat-many: SKIP (0.000s)
[506.582325] [108/131] (517s left) kms_pm_rpm (pm-tiling)
[508.522948] Starting subtest: pm-tiling
[508.528597] Subtest pm-tiling: SKIP (0.000s)
[508.896252] [109/131] (515s left) gen9_exec_parse (cmd-crossing-page)
[508.952288] Subtest cmd-crossing-page: SKIP (0.000s)
[509.024926] [110/131] (515s left) core_setmaster (master-drop-set-root)
[509.091215] Starting subtest: master-drop-set-root
[509.116157] Subtest master-drop-set-root: SUCCESS (0.025s)
[509.163473] [111/131] (515s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[509.531647] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[510.333180] [112/131] (514s left) gem_render_copy_redux (interruptible)
[510.391975] Starting subtest: interruptible
[510.700680] Subtest interruptible: SUCCESS (0.308s)
[510.817621] [113/131] (513s left) gem_ctx_param (invalid-get-engines)
[510.871989] Starting subtest: invalid-get-engines
[510.874788] Subtest invalid-get-engines: SUCCESS (0.001s)
[510.959091] [114/131] (513s left) sysfs_heartbeat_interval (idempotent)
[511.028829] Starting subtest: idempotent
[511.031227] Starting dynamic subtest: vecs0
[511.034113] Dynamic subtest vecs0: SUCCESS (0.001s)
[511.045371] Starting dynamic subtest: ccs0
[511.048147] Dynamic subtest ccs0: SUCCESS (0.001s)
[511.058236] Starting dynamic subtest: vcs0
[511.061150] Dynamic subtest vcs0: SUCCESS (0.000s)
[511.071450] Starting dynamic subtest: bcs0
[511.074153] Dynamic subtest bcs0: SUCCESS (0.001s)
[511.085404] Starting dynamic subtest: rcs0
[511.088386] Dynamic subtest rcs0: SUCCESS (0.000s)
[511.098161] Starting dynamic subtest: vcs1
[511.100904] Dynamic subtest vcs1: SUCCESS (0.000s)
[511.103451] Subtest idempotent: SUCCESS (0.007s)
[511.148203] [115/131] (513s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[511.198143] Starting subtest: multi-wait-all-for-submit-signaled
[511.200705] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[511.295590] [116/131] (513s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[511.394125] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[511.399074] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[511.500834] [117/131] (513s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[511.615126] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[511.619866] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[511.709846] [118/131] (513s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[511.820169] Starting subtest: yf-tiled-8bpp-rotate-270
[511.825286] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[511.908280] [119/131] (513s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[511.995726] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[511.998045] Starting dynamic subtest: pipe-A-eDP-1
[512.019889] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[512.030658] Starting dynamic subtest: pipe-B-eDP-1
[512.052391] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[512.062209] Starting dynamic subtest: pipe-C-eDP-1
[512.084313] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[512.093373] Starting dynamic subtest: pipe-D-eDP-1
[512.116477] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[512.121162] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[514.258898] [120/131] (510s left) gem_wait (invalid-buf)
[514.326288] Starting subtest: invalid-buf
[514.329283] Subtest invalid-buf: SUCCESS (0.000s)
[514.540909] [121/131] (510s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[514.636466] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[514.641437] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[514.738912] [122/131] (510s left) prime_vgem (busy)
[514.825359] Starting subtest: busy
[514.827913] Starting dynamic subtest: rcs0
[514.869281] Dynamic subtest rcs0: SUCCESS (0.045s)
[514.879290] Starting dynamic subtest: bcs0
[514.938815] Dynamic subtest bcs0: SUCCESS (0.068s)
[514.948934] Starting dynamic subtest: vcs0
[514.982212] Dynamic subtest vcs0: SUCCESS (0.042s)
[514.992412] Starting dynamic subtest: vcs1
[515.033158] Dynamic subtest vcs1: SUCCESS (0.050s)
[515.042777] Starting dynamic subtest: vecs0
[515.081436] Dynamic subtest vecs0: SUCCESS (0.047s)
[515.091532] Starting dynamic subtest: ccs0
[515.130196] Dynamic subtest ccs0: SUCCESS (0.048s)
[515.132856] Subtest busy: SUCCESS (0.306s)
[515.248149] [123/131] (509s left) kms_vblank (wait-busy)
[515.335843] Starting subtest: wait-busy
[515.338378] Starting dynamic subtest: pipe-A-eDP-1
[517.208288] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[517.225526] Starting dynamic subtest: pipe-D-eDP-1
[519.768285] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[519.770756] Subtest wait-busy: SUCCESS (4.433s)
[520.632784] [124/131] (504s left) prime_mmap (test_aperture_limit)
[520.692002] Starting subtest: test_aperture_limit
[520.694992] Starting dynamic subtest: test_aperture_limit-smem
[520.715236] Dynamic subtest test_aperture_limit-smem: SKIP (0.021s)
[520.720843] Subtest test_aperture_limit: SKIP (0.023s)
[520.802730] [125/131] (504s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[520.895379] Starting subtest: fbc-1p-pri-indfb-multidraw
[533.850573] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.963s)
[535.265236] [126/131] (490s left) gem_lmem_swapping (parallel-random)
[535.317949] Subtest parallel-random: SKIP (0.000s)
[535.366780] [127/131] (489s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[535.426407] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[535.527870] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[535.609529] [128/131] (489s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[535.698518] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[535.701272] Starting dynamic subtest: pipe-A-eDP-1
[535.727304] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[535.743363] Starting dynamic subtest: pipe-B-eDP-1
[535.769222] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[535.784159] Starting dynamic subtest: pipe-C-eDP-1
[535.811319] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[535.822318] Starting dynamic subtest: pipe-D-eDP-1
[535.849008] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[535.853681] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[537.932198] [129/131] (487s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[538.025863] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[538.030527] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[538.096770] [130/131] (487s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[538.195192] Starting subtest: fbcpsr-tiling-y
[538.200063] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[538.287674] [131/131] (487s left) prime_vgem (basic-fence-read)
[538.344849] Starting subtest: basic-fence-read
[538.374727] Subtest basic-fence-read: SKIP (0.029s)
[538.462922] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: gem_partial_pwrite_pread
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: prime_vgem
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: i915_query
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_exec_whisper
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_force_connector_basic
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_color
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: gem_spin_batch
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_cursor_edge_walk
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_content_protection
results: parsing output: 34/ for test: kms_draw_crc
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_properties
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: kms_plane_cursor
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_pipe_b_c_ivb
results: parsing output: 48/ for test: gem_lmem_swapping
results: parsing output: 49/ for test: gem_ctx_bad_destroy
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: kms_joiner
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_plane_alpha_blend
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_mmap
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: kms_dirtyfb
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: kms_sequence
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_watchdog
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_atomic_transition
results: parsing output: 81/ for test: fbdev
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: prime_mmap
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_psr2_sf
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: gem_ccs
results: parsing output: 101/ for test: i915_pm_rps
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_color_pipeline
results: parsing output: 105/ for test: i915_pm_freq_api
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: kms_pm_rpm
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: core_setmaster
results: parsing output: 110/ for test: kms_chamelium_frames
results: parsing output: 111/ for test: gem_render_copy_redux
results: parsing output: 112/ for test: gem_ctx_param
results: parsing output: 113/ for test: sysfs_heartbeat_interval
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_wait
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: kms_vblank
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: prime_vgem
Done.