[59.679986] Initializing watchdogs
[59.680095]   /dev/watchdog0
[59.693499] [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.697829] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.700255] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.703850] [001/131] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[59.793336] Starting subtest: multi-wait-for-submit-unsubmitted
[59.897990] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[59.993213] [002/131] (960s left) i915_drm_fdinfo (memory-info-active)
[60.034564] Starting subtest: memory-info-active
[60.036916] Starting dynamic subtest: smem0
[62.708651] Dynamic subtest smem0: SUCCESS (2.674s)
[62.711149] Subtest memory-info-active: SUCCESS (2.675s)
[62.801190] [003/131] (957s left) gem_exec_parallel (fds)
[62.859338] Starting subtest: fds
[62.861361] Starting dynamic subtest: rcs0
[66.049844] Dynamic subtest rcs0: SUCCESS (3.188s)
[66.059962] Starting dynamic subtest: bcs0
[69.876129] Dynamic subtest bcs0: SUCCESS (3.826s)
[69.884307] Starting dynamic subtest: vcs0
[74.119874] Dynamic subtest vcs0: SUCCESS (4.242s)
[74.130329] Starting dynamic subtest: vcs1
[78.137502] Dynamic subtest vcs1: SUCCESS (4.017s)
[78.147407] Starting dynamic subtest: vecs0
[82.140752] Dynamic subtest vecs0: SUCCESS (4.002s)
[82.148078] Starting dynamic subtest: ccs0
[85.581735] Dynamic subtest ccs0: SUCCESS (3.440s)
[85.584436] Subtest fds: SUCCESS (22.721s)
[85.792361] [004/131] (934s left) kms_cursor_crc (cursor-sliding-32x10)
[85.974741] Starting subtest: cursor-sliding-32x10
[86.020583] Subtest cursor-sliding-32x10: SKIP (0.043s)
[86.315229] [005/131] (934s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[86.412833] Starting subtest: flip-vs-dpms-off-vs-modeset
[86.414808] Starting dynamic subtest: A-eDP1
[90.082611] Dynamic subtest A-eDP1: SUCCESS (3.670s)
[90.090887] Starting dynamic subtest: B-eDP1
[93.305175] Dynamic subtest B-eDP1: SUCCESS (3.221s)
[93.314377] Starting dynamic subtest: C-eDP1
[96.405307] Dynamic subtest C-eDP1: SUCCESS (3.099s)
[96.414111] Starting dynamic subtest: D-eDP1
[99.523242] Dynamic subtest D-eDP1: SUCCESS (3.117s)
[99.525531] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.113s)
[100.339450] [006/131] (920s left) gem_fenced_exec_thrash (2-spare-fences)
[100.421947] Subtest 2-spare-fences: SKIP (0.000s)
[100.491186] [007/131] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[100.594646] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[100.598789] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[100.724777] [008/131] (919s left) i915_query (query-garbage)
[100.780594] Starting subtest: query-garbage
[100.782441] Subtest query-garbage: SUCCESS (0.000s)
[100.899571] [009/131] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[100.998237] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[101.002253] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[101.120946] [010/131] (919s left) kms_feature_discovery (chamelium)
[101.214154] Starting subtest: chamelium
[101.218720] Subtest chamelium: SKIP (0.000s)
[101.304212] [011/131] (919s left) gem_ctx_create (basic)
[101.375106] Starting subtest: basic
[101.376978] Subtest basic: SUCCESS (0.000s)
[101.574230] [012/131] (919s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[101.679315] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[102.491832] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.814s)
[102.666591] [013/131] (917s left) gem_eio (in-flight-immediate)
[102.900072] Starting subtest: in-flight-immediate
[111.893763] Subtest in-flight-immediate: SUCCESS (8.993s)
[112.062499] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[112.066717] [014/131] (908s left) gem_pxp (hw-rejects-pxp-context)
[112.218685] Starting subtest: hw-rejects-pxp-context
[112.223274] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[112.366403] [015/131] (908s left) i915_pciid
[112.553908] [016/131] (908s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[112.657514] Starting subtest: fbc-rgb565-draw-mmap-cpu
[116.586513] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.932s)
[117.719344] [017/131] (903s left) kms_busy (basic)
[117.820370] Starting subtest: basic
[117.822812] Starting dynamic subtest: flip
[118.419276] Dynamic subtest flip: SUCCESS (0.600s)
[118.428679] Starting dynamic subtest: modeset
[121.813655] Dynamic subtest modeset: SUCCESS (3.393s)
[121.816101] Subtest basic: SUCCESS (3.994s)
[122.635652] [018/131] (898s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[122.764435] Starting subtest: basic-flip-after-cursor-atomic
[123.679031] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.916s)
[124.563627] [019/131] (896s left) kms_content_protection (mei-interface)
[124.708810] Starting subtest: mei-interface
[124.713549] Subtest mei-interface: SKIP (0.001s)
[124.866661] [020/131] (896s left) kms_scaling_modes (scaling-mode-none)
[124.964358] Starting subtest: scaling-mode-none
[124.966678] Starting dynamic subtest: pipe-A-eDP-1
[125.057569] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s)
[125.071020] Starting dynamic subtest: pipe-B-eDP-1
[125.090792] Dynamic subtest pipe-B-eDP-1: SKIP (0.031s)
[125.101489] Starting dynamic subtest: pipe-C-eDP-1
[125.121776] Dynamic subtest pipe-C-eDP-1: SKIP (0.030s)
[125.129889] Starting dynamic subtest: pipe-D-eDP-1
[125.154469] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[125.158666] Subtest scaling-mode-none: SKIP (0.191s)
[125.305467] [021/131] (895s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[125.401495] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[125.405606] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[125.519964] [022/131] (895s left) gem_mmap_gtt (zero-extend)
[125.577557] Subtest zero-extend: SKIP (0.000s)
[125.646209] [023/131] (895s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[125.747147] Starting subtest: fbc-rgb565-draw-mmap-wc
[129.730948] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.986s)
[130.885571] [024/131] (890s left) gem_exec_balancer (parallel)
[131.136810] Starting subtest: parallel
[132.054607] Subtest parallel: SUCCESS (0.920s)
[132.947660] [025/131] (888s left) gem_cs_tlb (engines)
[133.006844] Starting subtest: engines
[133.009281] Starting dynamic subtest: rcs0
[135.162907] Dynamic subtest rcs0: SUCCESS (2.152s)
[135.172612] Starting dynamic subtest: bcs0
[137.318717] Dynamic subtest bcs0: SUCCESS (2.154s)
[137.333877] Starting dynamic subtest: vcs0
[139.473617] Dynamic subtest vcs0: SUCCESS (2.153s)
[139.490520] Starting dynamic subtest: vcs1
[141.627010] Dynamic subtest vcs1: SUCCESS (2.154s)
[141.635642] Starting dynamic subtest: vecs0
[143.780479] Dynamic subtest vecs0: SUCCESS (2.152s)
[143.791674] Starting dynamic subtest: ccs0
[145.933961] Dynamic subtest ccs0: SUCCESS (2.154s)
[145.936058] Subtest engines: SUCCESS (12.923s)
[146.089337] [026/131] (875s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[146.199719] Starting subtest: fbc-psr-cursor-mmap-cpu
[146.201575] Starting dynamic subtest: eDP-1
[146.205588] Dynamic subtest eDP-1: SKIP (0.000s)
[146.209617] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[146.299410] [027/131] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[146.400427] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[146.404583] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[146.532332] [028/131] (874s left) kms_psr2_su (page_flip-nv12)
[146.597095] Subtest page_flip-NV12: SKIP (0.000s)
[146.658665] [029/131] (874s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[151.626208] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[151.628581] Starting dynamic subtest: pipe-A-eDP-1
[152.414997] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[152.424135] Starting dynamic subtest: pipe-B-eDP-1
[153.536645] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[153.541195] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.908s)
[154.743340] [030/131] (866s left) api_intel_bb (intel-bb-blit-none)
[154.810972] Starting subtest: intel-bb-blit-none
[158.793342] Subtest intel-bb-blit-none: SUCCESS (3.982s)
[158.953028] [031/131] (862s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[159.057174] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[159.061133] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[159.200020] [032/131] (862s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[159.297213] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[159.299414] Starting dynamic subtest: pipe-A
[159.316497] Dynamic subtest pipe-A: SKIP (0.014s)
[159.324746] Starting dynamic subtest: pipe-B
[159.344425] Dynamic subtest pipe-B: SKIP (0.028s)
[159.352049] Starting dynamic subtest: pipe-C
[159.371938] Dynamic subtest pipe-C: SKIP (0.027s)
[159.380169] Starting dynamic subtest: pipe-D
[159.399635] Dynamic subtest pipe-D: SKIP (0.027s)
[159.403401] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.098s)
[159.536331] [033/131] (861s left) kms_chamelium_audio (dp-audio)
[159.913494] Subtest dp-audio: SKIP (0.000s)
[160.724368] [034/131] (860s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[160.793536] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[160.898500] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[160.995556] [035/131] (860s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[161.105868] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[161.109862] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[161.216028] [036/131] (860s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[161.318734] Starting subtest: pipe-fbc-rte
[161.325806] Starting dynamic subtest: pipe-B-eDP-1
[166.829209] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.515s)
[166.836480] Subtest pipe-fbc-rte: SUCCESS (5.517s)
[169.179835] [037/131] (852s left) vgem_slow (nohang)
[169.220337] Starting subtest: nohang
[179.315834] Subtest nohang: SUCCESS (10.094s)
[179.410054] [038/131] (842s left) kms_prop_blob (blob-multiple)
[179.473332] Starting subtest: blob-multiple
[179.475674] Subtest blob-multiple: SUCCESS (0.002s)
[179.609933] [039/131] (842s left) gem_exec_schedule (thriceslice)
[179.682482] Starting subtest: thriceslice
[179.684773] Starting dynamic subtest: rcs0
[179.704442] Dynamic subtest rcs0: SUCCESS (0.032s)
[179.715676] Starting dynamic subtest: bcs0
[179.761457] Dynamic subtest bcs0: SUCCESS (0.056s)
[179.773674] Starting dynamic subtest: vcs0
[179.794247] Dynamic subtest vcs0: SUCCESS (0.032s)
[179.803221] Starting dynamic subtest: vcs1
[179.824135] Dynamic subtest vcs1: SUCCESS (0.029s)
[179.833043] Starting dynamic subtest: vecs0
[179.854580] Dynamic subtest vecs0: SUCCESS (0.030s)
[179.863024] Starting dynamic subtest: ccs0
[179.914111] Dynamic subtest ccs0: SUCCESS (0.058s)
[179.917039] Subtest thriceslice: SUCCESS (0.242s)
[180.245725] [040/131] (841s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[180.331587] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[180.333828] Starting dynamic subtest: pipe-A-eDP-1
[180.356501] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[180.365869] Starting dynamic subtest: pipe-B-eDP-1
[180.387202] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.394523] Starting dynamic subtest: pipe-C-eDP-1
[180.416186] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.423980] Starting dynamic subtest: pipe-D-eDP-1
[180.446076] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.450179] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[182.548084] [041/131] (839s left) perf_pmu (busy-start)
[182.590090] Starting subtest: busy-start
[182.592340] Starting dynamic subtest: rcs0
[185.139044] Dynamic subtest rcs0: SUCCESS (2.550s)
[185.147509] Starting dynamic subtest: bcs0
[187.687136] Dynamic subtest bcs0: SUCCESS (2.546s)
[187.698246] Starting dynamic subtest: vcs0
[190.933064] Dynamic subtest vcs0: SUCCESS (3.242s)
[190.943884] Starting dynamic subtest: vcs1
[194.900995] Dynamic subtest vcs1: SUCCESS (3.966s)
[194.912024] Starting dynamic subtest: vecs0
[198.932978] Dynamic subtest vecs0: SUCCESS (4.030s)
[198.943566] Starting dynamic subtest: ccs0
[201.481464] Dynamic subtest ccs0: SUCCESS (2.548s)
[201.483984] Subtest busy-start: SUCCESS (18.893s)
[201.610868] [042/131] (820s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[201.710077] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[201.712358] Starting dynamic subtest: pipe-A-default-mode
[202.002409] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[202.007112] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.290s)
[202.882161] [043/131] (819s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[207.915813] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[207.920727] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[208.809376] [044/131] (813s left) gem_lmem_swapping (verify-random)
[208.852023] Subtest verify-random: SKIP (0.000s)
[208.892110] [045/131] (813s left) kms_cursor_edge_walk (64x64-top-bottom)
[208.992977] Starting subtest: 64x64-top-bottom
[208.995343] Starting dynamic subtest: pipe-A-eDP-1
[212.438123] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[212.448222] Starting dynamic subtest: pipe-D-eDP-1
[215.573650] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[215.575903] Subtest 64x64-top-bottom: SUCCESS (6.581s)
[216.397089] [046/131] (805s left) gem_userptr_blits (unsync-unmap-after-close)
[216.470214] Subtest unsync-unmap-after-close: SKIP (0.000s)
[216.632914] [047/131] (805s left) gem_ctx_persistence (legacy-engines-queued)
[216.696372] Starting subtest: legacy-engines-queued
[216.698653] Starting dynamic subtest: render
[216.809786] Dynamic subtest render: SUCCESS (0.112s)
[216.826027] Starting dynamic subtest: bsd1
[217.907228] Dynamic subtest bsd1: SUCCESS (1.094s)
[217.919357] Starting dynamic subtest: bsd2
[219.892466] Dynamic subtest bsd2: SUCCESS (1.982s)
[219.903242] Starting dynamic subtest: blt
[219.961053] Dynamic subtest blt: SUCCESS (0.068s)
[219.972079] Starting dynamic subtest: vebox
[221.877704] Dynamic subtest vebox: SUCCESS (1.912s)
[221.880669] Subtest legacy-engines-queued: SUCCESS (5.180s)
[221.982099] [048/131] (800s left) kms_chamelium_hpd (hdmi-hpd-fast)
[222.384624] Subtest hdmi-hpd-fast: SKIP (0.000s)
[223.192138] [049/131] (798s left) intel_hwmon (hwmon-read)
[223.255863] Subtest hwmon-read: SKIP (0.000s)
[223.330090] [050/131] (798s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[223.429685] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[223.431975] Starting dynamic subtest: pipe-A-default-mode
[223.736654] Dynamic subtest pipe-A-default-mode: SKIP (0.303s)
[223.741250] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.304s)
[224.567290] [051/131] (797s left) gem_wait (write-wait)
[224.641572] Starting subtest: write-wait
[224.643853] Starting dynamic subtest: all-engines
[225.782646] Dynamic subtest all-engines: SUCCESS (1.144s)
[225.797011] Starting dynamic subtest: rcs0
[226.842502] Dynamic subtest rcs0: SUCCESS (1.058s)
[226.859945] Starting dynamic subtest: bcs0
[227.902579] Dynamic subtest bcs0: SUCCESS (1.057s)
[227.919043] Starting dynamic subtest: vcs0
[228.957738] Dynamic subtest vcs0: SUCCESS (1.053s)
[228.973616] Starting dynamic subtest: vcs1
[230.012212] Dynamic subtest vcs1: SUCCESS (1.053s)
[230.028599] Starting dynamic subtest: vecs0
[231.064701] Dynamic subtest vecs0: SUCCESS (1.050s)
[231.080167] Starting dynamic subtest: ccs0
[232.120215] Dynamic subtest ccs0: SUCCESS (1.054s)
[232.122736] Subtest write-wait: SUCCESS (7.483s)
[232.342443] [052/131] (789s left) perf_pmu (busy-accuracy-98)
[232.380169] Starting subtest: busy-accuracy-98
[232.382307] Starting dynamic subtest: rcs0
[235.430328] Dynamic subtest rcs0: SUCCESS (3.047s)
[235.441347] Starting dynamic subtest: bcs0
[238.483965] Dynamic subtest bcs0: SUCCESS (3.051s)
[238.494865] Starting dynamic subtest: vcs0
[241.530890] Dynamic subtest vcs0: SUCCESS (3.045s)
[241.541179] Starting dynamic subtest: vcs1
[244.577471] Dynamic subtest vcs1: SUCCESS (3.045s)
[244.588093] Starting dynamic subtest: vecs0
[247.620444] Dynamic subtest vecs0: SUCCESS (3.042s)
[247.630697] Starting dynamic subtest: ccs0
[250.674661] Dynamic subtest ccs0: SUCCESS (3.052s)
[250.677094] Subtest busy-accuracy-98: SUCCESS (18.293s)
[250.810402] [053/131] (771s left) gem_exec_endless (dispatch)
[250.878583] Starting subtest: dispatch
[250.880944] Starting dynamic subtest: rcs0
[250.885589] Dynamic subtest rcs0: SUCCESS (0.005s)
[250.901678] Starting dynamic subtest: bcs0
[250.906022] Dynamic subtest bcs0: SUCCESS (0.004s)
[250.915302] Starting dynamic subtest: vcs0
[250.919584] Dynamic subtest vcs0: SUCCESS (0.004s)
[250.927557] Starting dynamic subtest: vcs1
[250.931921] Dynamic subtest vcs1: SUCCESS (0.004s)
[250.939882] Starting dynamic subtest: vecs0
[250.944225] Dynamic subtest vecs0: SUCCESS (0.004s)
[250.952069] Starting dynamic subtest: ccs0
[250.956248] Dynamic subtest ccs0: SUCCESS (0.005s)
[250.958393] Subtest dispatch: SUCCESS (0.030s)
[252.946205] [054/131] (769s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[253.055160] Starting subtest: nonblocking-crc-frame-sequence
[253.057047] Starting dynamic subtest: pipe-A-eDP-1
[253.773931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[253.783787] Starting dynamic subtest: pipe-B-eDP-1
[255.133005] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s)
[255.144709] Starting dynamic subtest: pipe-C-eDP-1
[256.543758] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.407s)
[256.554527] Starting dynamic subtest: pipe-D-eDP-1
[257.857553] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[257.859980] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.804s)
[258.681364] [055/131] (763s left) gem_softpin (allocator-basic-reserve)
[258.747402] Starting subtest: allocator-basic-reserve
[258.812937] Subtest allocator-basic-reserve: SUCCESS (0.065s)
[258.982134] [056/131] (763s left) perf_pmu (all-busy-idle-check-all)
[259.030475] Starting subtest: all-busy-idle-check-all
[260.886465] Subtest all-busy-idle-check-all: SUCCESS (1.857s)
[261.012111] [057/131] (761s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[261.393847] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[262.166951] [058/131] (760s left) perf (invalid-oa-exponent)
[262.292525] Starting subtest: invalid-oa-exponent
[262.304146] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[262.339948] [059/131] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[262.443559] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[262.447958] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[262.580366] [060/131] (759s left) i915_suspend (fence-restore-tiled2untiled)
[262.643156] Starting subtest: fence-restore-tiled2untiled
[262.647126] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[262.767301] [061/131] (759s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[262.827237] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[262.829304] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[262.957765] [062/131] (759s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[263.058998] Starting subtest: plane-primary-toggle-with-vblank-wait
[263.061338] Starting dynamic subtest: pipe-A-eDP-1
[263.230958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[263.547552] Starting dynamic subtest: pipe-B-eDP-1
[264.418374] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.880s)
[264.715580] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.658s)
[265.599255] [063/131] (757s left) kms_properties (plane-properties-legacy)
[265.694270] Starting subtest: plane-properties-legacy
[265.696538] Starting dynamic subtest: pipe-A-eDP-1
[266.244401] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[266.253561] Starting dynamic subtest: pipe-B-eDP-1
[267.550455] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.304s)
[267.559906] Starting dynamic subtest: pipe-C-eDP-1
[268.786403] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[268.796086] Starting dynamic subtest: pipe-D-eDP-1
[270.037064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[270.039324] Subtest plane-properties-legacy: SUCCESS (4.343s)
[270.848640] [064/131] (751s left) kms_flip (plain-flip-ts-check)
[270.952496] Starting subtest: plain-flip-ts-check
[270.954773] Starting dynamic subtest: A-eDP1
[279.820235] Dynamic subtest A-eDP1: SUCCESS (8.866s)
[279.830799] Starting dynamic subtest: B-eDP1
[288.658287] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[288.673484] Starting dynamic subtest: C-eDP1
[297.479776] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[297.490826] Starting dynamic subtest: D-eDP1
[306.309063] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[306.315066] Subtest plain-flip-ts-check: SUCCESS (35.361s)
[307.520950] [065/131] (715s left) kms_plane_multiple (tiling-x)
[307.625226] Starting subtest: tiling-x
[307.627131] Starting dynamic subtest: pipe-A-eDP-1
[311.315191] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.689s)
[311.324757] Starting dynamic subtest: pipe-B-eDP-1
[315.766525] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.449s)
[315.776233] Starting dynamic subtest: pipe-C-eDP-1
[320.077329] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.310s)
[320.086287] Starting dynamic subtest: pipe-D-eDP-1
[324.423146] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.345s)
[324.425481] Subtest tiling-x: SUCCESS (16.799s)
[325.249830] [066/131] (697s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[325.353296] Starting subtest: y-tiled-64bpp-rotate-90
[325.357650] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[325.483483] [067/131] (697s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[325.542687] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[325.612410] [068/131] (697s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[325.695115] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[325.697255] Starting dynamic subtest: pipe-A-eDP-1
[325.719575] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[325.729606] Starting dynamic subtest: pipe-B-eDP-1
[325.751770] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[325.770630] Starting dynamic subtest: pipe-C-eDP-1
[325.793279] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[325.804176] Starting dynamic subtest: pipe-D-eDP-1
[325.826398] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[325.830524] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[327.940501] [069/131] (694s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[328.040846] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[328.042674] Starting dynamic subtest: pipe-A-eDP-1
[329.304268] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.265s)
[329.314523] Starting dynamic subtest: pipe-B-eDP-1
[331.651050] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.345s)
[331.660278] Starting dynamic subtest: pipe-C-eDP-1
[333.941330] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.289s)
[333.950437] Starting dynamic subtest: pipe-D-eDP-1
[336.282496] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.340s)
[336.284895] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.244s)
[337.472025] [070/131] (685s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[337.596853] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[337.601261] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[337.722014] [071/131] (685s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[337.826499] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[337.837236] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[337.980246] [072/131] (685s left) kms_psr (psr2-primary-mmap-gtt)
[338.078316] Starting subtest: psr2-primary-mmap-gtt
[338.080699] Starting dynamic subtest: eDP-1
[339.536453] Dynamic subtest eDP-1: SKIP (1.456s)
[339.540968] Subtest psr2-primary-mmap-gtt: SKIP (1.458s)
[339.734687] [073/131] (683s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[339.859356] Starting subtest: cursorA-vs-flipB-toggle
[339.863660] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[340.026014] [074/131] (683s left) dmabuf_sync_file (export-before-signal)
[340.077653] Starting subtest: export-before-signal
[340.079825] Subtest export-before-signal: SUCCESS (0.001s)
[340.158275] [075/131] (683s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[340.251748] Starting subtest: crc-primary-basic-yf-tiled-ccs
[340.254016] Starting dynamic subtest: pipe-A-eDP-1
[340.277124] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[340.288446] Starting dynamic subtest: pipe-B-eDP-1
[340.310201] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[340.318456] Starting dynamic subtest: pipe-C-eDP-1
[340.340952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[340.349161] Starting dynamic subtest: pipe-D-eDP-1
[340.371331] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[340.375436] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[342.462538] [076/131] (680s left) gem_eio (wait-1us)
[342.705918] Starting subtest: wait-1us
[343.041835] Subtest wait-1us: SUCCESS (0.335s)
[343.220905] [077/131] (680s left) kms_content_protection (lic-type-0)
[343.373707] Starting subtest: lic-type-0
[343.377545] Subtest lic-type-0: SKIP (0.000s)
[343.547502] [078/131] (679s left) api_intel_allocator (open-vm)
[343.613591] Starting subtest: open-vm
[343.615830] Subtest open-vm: SUCCESS (0.006s)
[343.792493] [079/131] (679s left) kms_universal_plane (universal-plane-functional)
[343.883284] Starting subtest: universal-plane-functional
[343.884978] Starting dynamic subtest: pipe-A-eDP-1
[347.698398] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.815s)
[347.707522] Starting dynamic subtest: pipe-B-eDP-1
[352.191477] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.491s)
[352.201181] Starting dynamic subtest: pipe-C-eDP-1
[356.443503] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.251s)
[356.454238] Starting dynamic subtest: pipe-D-eDP-1
[360.759319] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.313s)
[360.761527] Subtest universal-plane-functional: SUCCESS (16.876s)
[361.647832] [080/131] (661s left) gem_exec_schedule (lateslice)
[361.733265] Starting subtest: lateslice
[361.735494] Starting dynamic subtest: rcs0
[361.751057] Dynamic subtest rcs0: SUCCESS (0.021s)
[361.762634] Starting dynamic subtest: bcs0
[361.768313] Dynamic subtest bcs0: SUCCESS (0.016s)
[361.776611] Starting dynamic subtest: vcs0
[361.786230] Dynamic subtest vcs0: SUCCESS (0.017s)
[361.794153] Starting dynamic subtest: vcs1
[361.805618] Dynamic subtest vcs1: SUCCESS (0.019s)
[361.813840] Starting dynamic subtest: vecs0
[361.824782] Dynamic subtest vecs0: SUCCESS (0.018s)
[361.833371] Starting dynamic subtest: ccs0
[361.843292] Dynamic subtest ccs0: SUCCESS (0.018s)
[361.845472] Subtest lateslice: SUCCESS (0.115s)
[363.022586] [081/131] (660s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[363.124264] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[363.126499] Starting dynamic subtest: pipe-A-eDP-1
[363.185881] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[363.481467] Starting dynamic subtest: pipe-B-eDP-1
[364.236327] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[364.522231] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.398s)
[365.410500] [082/131] (658s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[365.514106] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[372.235862] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.725s)
[372.374802] [083/131] (651s left) kms_vrr (lobf)
[372.471031] Starting subtest: lobf
[372.475231] Subtest lobf: SKIP (0.000s)
[372.567676] [084/131] (650s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[372.627128] Starting subtest: invalid-signal-one-illegal-handle
[372.629028] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[372.747988] [085/131] (650s left) gem_close_race (basic-process)
[372.812496] Starting subtest: basic-process
[372.883056] Subtest basic-process: SUCCESS (0.071s)
[373.091888] [086/131] (650s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[373.184196] Starting subtest: fbcpsr-modesetfrombusy
[379.298225] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.117s)
[379.471317] [087/131] (644s left) gem_pxp (create-valid-protected-context)
[379.543264] Starting subtest: create-valid-protected-context
[379.545133] Subtest create-valid-protected-context: SUCCESS (0.001s)
[379.686616] [088/131] (644s left) gen9_exec_parse (bb-chained)
[379.755931] Subtest bb-chained: SKIP (0.000s)
[379.858053] [089/131] (643s left) gem_ctx_exec (basic-nohangcheck)
[379.915132] Starting subtest: basic-nohangcheck
[380.155303] Subtest basic-nohangcheck: SUCCESS (0.242s)
[380.297956] [090/131] (643s left) gem_exec_params (sol-reset-not-gen7)
[380.354013] Starting subtest: sol-reset-not-gen7
[380.359423] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[380.492540] [091/131] (643s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[380.553389] Starting subtest: etime-multi-wait-all-available-unsubmitted
[380.657614] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[380.762306] [092/131] (643s left) gem_bad_reloc (negative-reloc)
[380.834123] Subtest negative-reloc: SKIP (0.000s)
[380.929242] [093/131] (642s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[381.026887] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[381.029099] Starting dynamic subtest: pipe-A-default-mode
[381.381846] Dynamic subtest pipe-A-default-mode: SKIP (0.353s)
[381.386183] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.355s)
[382.151881] [094/131] (641s left) sw_sync (alloc_timeline)
[382.188637] Starting subtest: alloc_timeline
[382.190544] Subtest alloc_timeline: SUCCESS (0.000s)
[382.274130] [095/131] (641s left) gem_partial_pwrite_pread (reads-display)
[382.340308] Subtest reads-display: SKIP (0.000s)
[382.426028] [096/131] (641s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[382.539798] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[382.542176] Starting dynamic subtest: pipe-A
[382.564773] Dynamic subtest pipe-A: SKIP (0.021s)
[382.577981] Starting dynamic subtest: pipe-B
[382.596246] Dynamic subtest pipe-B: SKIP (0.031s)
[382.610850] Starting dynamic subtest: pipe-C
[382.628253] Dynamic subtest pipe-C: SKIP (0.031s)
[382.637666] Starting dynamic subtest: pipe-D
[382.657953] Dynamic subtest pipe-D: SKIP (0.031s)
[382.661686] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.117s)
[382.795876] [097/131] (641s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[382.921016] Starting subtest: flip-vs-cursor-varying-size
[391.302099] Subtest flip-vs-cursor-varying-size: SUCCESS (8.381s)
[392.198693] [098/131] (631s left) i915_pm_rpm (gem-idle)
[394.137477] Starting subtest: gem-idle
[400.343631] Subtest gem-idle: SUCCESS (6.209s)
[400.696037] [099/131] (623s left) gem_ctx_shared (exec-single-timeline)
[401.918769] Starting subtest: exec-single-timeline
[401.921184] Starting dynamic subtest: rcs0
[402.995077] Dynamic subtest rcs0: SUCCESS (1.073s)
[403.007898] Starting dynamic subtest: bcs0
[404.018270] Dynamic subtest bcs0: SUCCESS (1.021s)
[404.030068] Starting dynamic subtest: vcs0
[405.107488] Dynamic subtest vcs0: SUCCESS (1.087s)
[405.120105] Starting dynamic subtest: vcs1
[406.195372] Dynamic subtest vcs1: SUCCESS (1.084s)
[406.208906] Starting dynamic subtest: vecs0
[407.282298] Dynamic subtest vecs0: SUCCESS (1.084s)
[407.311952] Starting dynamic subtest: ccs0
[408.371681] Dynamic subtest ccs0: SUCCESS (1.086s)
[408.374341] Subtest exec-single-timeline: SUCCESS (6.454s)
[408.582819] [100/131] (615s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[408.644832] Starting subtest: multi-wait-for-submit-available-signaled
[408.647186] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[408.781141] [101/131] (615s left) kms_async_flips (crc-atomic)
[408.880760] Starting subtest: crc-atomic
[409.258883] Starting dynamic subtest: pipe-A-eDP-1
[412.177379] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.918s)
[412.551278] Starting dynamic subtest: pipe-B-eDP-1
[415.419078] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.873s)
[415.807657] Starting dynamic subtest: pipe-C-eDP-1
[418.719075] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.919s)
[419.079643] Starting dynamic subtest: pipe-D-eDP-1
[421.956015] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.885s)
[421.958173] Subtest crc-atomic: SUCCESS (13.076s)
[423.146773] [102/131] (601s left) gem_exec_params (invalid-fence-in-submit)
[423.213988] Starting subtest: invalid-fence-in-submit
[423.216434] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[423.366703] [103/131] (600s left) kms_psr (fbc-psr2-sprite-render)
[423.457865] Starting subtest: fbc-psr2-sprite-render
[423.460117] Starting dynamic subtest: eDP-1
[423.464148] Dynamic subtest eDP-1: SKIP (0.000s)
[423.468217] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[423.556145] [104/131] (600s left) kms_rotation_crc (primary-rotation-90)
[423.654705] Starting subtest: primary-rotation-90
[423.658986] Subtest primary-rotation-90: SKIP (0.001s)
[423.753267] [105/131] (600s left) gem_exec_whisper (basic-fds)
[423.816500] Starting subtest: basic-fds
[431.863798] Subtest basic-fds: SUCCESS (8.045s)
[432.073298] [106/131] (592s left) gem_lmem_swapping (heavy-multi)
[432.119132] Subtest heavy-multi: SKIP (0.000s)
[432.173920] [107/131] (592s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[432.240674] Starting subtest: yf-tiled-to-vebox-x-tiled
[432.245745] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[432.452631] [108/131] (592s left) kms_atomic_transition (plane-all-modeset-transition)
[432.546943] Starting subtest: plane-all-modeset-transition
[432.551050] Subtest plane-all-modeset-transition: SKIP (0.000s)
[432.641359] [109/131] (591s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[432.733509] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[439.506430] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.775s)
[439.696443] [110/131] (584s left) kms_hdr (static-toggle-suspend)
[439.801271] Starting subtest: static-toggle-suspend
[439.807337] Subtest static-toggle-suspend: SKIP (0.000s)
[439.893444] [111/131] (584s left) kms_pm_dc (dc5-retention-flops)
[441.000992] Starting subtest: dc5-retention-flops
[441.006098] Subtest dc5-retention-flops: SKIP (0.000s)
[441.102118] [112/131] (583s left) gem_mmap (basic-small-bo)
[441.168644] Subtest basic-small-bo: SKIP (0.000s)
[441.236855] [113/131] (583s left) syncobj_wait (wait-all-interrupted)
[441.297014] Starting subtest: wait-all-interrupted
[441.399987] Subtest wait-all-interrupted: SUCCESS (0.103s)
[441.498190] [114/131] (583s left) kms_big_fb (linear-64bpp-rotate-180)
[441.602235] Starting subtest: linear-64bpp-rotate-180
[443.189653] Subtest linear-64bpp-rotate-180: SUCCESS (1.588s)
[443.393834] [115/131] (581s left) kms_psr (pr-primary-render)
[443.490046] Starting subtest: pr-primary-render
[443.493509] Subtest pr-primary-render: SKIP (0.000s)
[443.584063] [116/131] (581s left) prime_busy (hang)
[443.642323] Starting subtest: hang
[443.644374] Starting dynamic subtest: rcs0
[469.420388] Dynamic subtest rcs0: SUCCESS (25.775s)
[469.428925] Starting dynamic subtest: bcs0
[476.577689] Dynamic subtest bcs0: SUCCESS (7.154s)
[476.586062] Starting dynamic subtest: vcs0
[483.553240] Dynamic subtest vcs0: SUCCESS (6.972s)
[483.564020] Starting dynamic subtest: vcs1
[490.589801] Dynamic subtest vcs1: SUCCESS (7.039s)
[490.598824] Starting dynamic subtest: vecs0
[497.569077] Dynamic subtest vecs0: SUCCESS (6.975s)
[497.577440] Starting dynamic subtest: ccs0
[511.406800] Dynamic subtest ccs0: SUCCESS (13.836s)
[511.408960] Subtest hang: SUCCESS (67.759s)
[511.555384] [117/131] (513s left) gem_ctx_bad_destroy (invalid-default-ctx)
[511.615962] Starting subtest: invalid-default-ctx
[511.618352] Subtest invalid-default-ctx: SUCCESS (0.000s)
[511.717148] [118/131] (513s left) syncobj_timeline (wait-all-delayed-signal)
[511.774581] Starting subtest: wait-all-delayed-signal
[511.876844] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[511.981965] [119/131] (513s left) gem_ctx_param (invalid-size-set)
[512.040948] Starting subtest: invalid-size-set
[512.043346] Subtest invalid-size-set: SUCCESS (0.001s)
[512.185969] [120/131] (512s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[512.289786] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[512.291976] Starting dynamic subtest: pipe-A-eDP-1
[513.606281] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.314s)
[513.901826] Starting dynamic subtest: pipe-B-eDP-1
[514.934528] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s)
[515.218577] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.929s)
[516.083233] [121/131] (509s left) syncobj_wait (wait-all-for-submit-snapshot)
[516.151436] Starting subtest: wait-all-for-submit-snapshot
[516.232595] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[516.333210] [122/131] (508s left) kms_cursor_crc (cursor-random-512x512)
[516.612325] Starting subtest: cursor-random-512x512
[516.616717] Subtest cursor-random-512x512: SKIP (0.001s)
[516.818444] [123/131] (508s left) gem_exec_fence (syncobj-timeline-export)
[517.373621] Starting subtest: syncobj-timeline-export
[517.379059] Subtest syncobj-timeline-export: SUCCESS (0.006s)
[519.063810] [124/131] (506s left) gem_caching (writes)
[519.120681] Subtest writes: SKIP (0.000s)
[519.184701] [125/131] (506s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[519.297888] Starting subtest: 4-tiled-16bpp-rotate-90
[519.317708] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[519.478593] [126/131] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[519.585659] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[526.331205] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.748s)
[526.525297] [127/131] (498s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[526.626987] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[527.284108] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[527.502497] [128/131] (497s left) perf (enable-disable)
[527.612196] Starting subtest: enable-disable
[527.614810] Starting dynamic subtest: 0-rcs0
[529.858317] Dynamic subtest 0-rcs0: SUCCESS (2.244s)
[529.867391] Starting dynamic subtest: 1-vcs1
[534.314085] Dynamic subtest 1-vcs1: SUCCESS (4.454s)
[534.316782] Subtest enable-disable: SUCCESS (6.700s)
[534.363572] [129/131] (491s left) kms_lease (lease-get)
[534.460082] Starting subtest: lease-get
[534.462403] Starting dynamic subtest: pipe-A-eDP-1
[534.464656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[534.473746] Starting dynamic subtest: pipe-B-eDP-1
[534.475847] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[534.484681] Starting dynamic subtest: pipe-C-eDP-1
[534.486772] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[534.495848] Starting dynamic subtest: pipe-D-eDP-1
[534.498827] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[534.501460] Subtest lease-get: SUCCESS (0.009s)
[534.606419] [130/131] (490s left) vgem_basic (busy-fence)
[534.657392] Starting subtest: busy-fence
[534.659367] Subtest busy-fence: SUCCESS (0.000s)
[534.739429] [131/131] (490s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[534.842284] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[534.846171] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[534.978624] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: gem_exec_parallel
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: gem_fenced_exec_thrash
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_query
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_feature_discovery
results: parsing output: 10/ for test: gem_ctx_create
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: gem_pxp
results: parsing output: 14/ for test: i915_pciid
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_busy
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_content_protection
results: parsing output: 19/ for test: kms_scaling_modes
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: gem_cs_tlb
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr2_su
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: vgem_slow
results: parsing output: 37/ for test: kms_prop_blob
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: kms_cursor_edge_walk
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: intel_hwmon
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: gem_wait
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: gem_exec_endless
results: parsing output: 53/ for test: kms_pipe_crc_basic
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_chamelium_edid
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_suspend
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_atomic_transition
results: parsing output: 62/ for test: kms_properties
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_plane_multiple
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_pipe_b_c_ivb
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: dmabuf_sync_file
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: kms_universal_plane
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_atomic_transition
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_vrr
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_close_race
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: gem_ctx_exec
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_bad_reloc
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_partial_pwrite_pread
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: i915_pm_rpm
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_rotation_crc
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_atomic_transition
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_hdr
results: parsing output: 110/ for test: kms_pm_dc
results: parsing output: 111/ for test: gem_mmap
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: prime_busy
results: parsing output: 116/ for test: gem_ctx_bad_destroy
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_ctx_param
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.