[59.676650] Initializing watchdogs
[59.676701]   /dev/watchdog0
[59.693017] [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.700128] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.703870] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.706515] [001/133] (960s left) gem_busy (extended)
[59.905227] Starting subtest: extended
[59.906374] Starting dynamic subtest: rcs0
[60.011961] Dynamic subtest rcs0: SUCCESS (0.108s)
[60.021544] Starting dynamic subtest: bcs0
[60.056559] Dynamic subtest bcs0: SUCCESS (0.043s)
[60.065542] Starting dynamic subtest: vcs0
[61.349919] Dynamic subtest vcs0: SUCCESS (1.266s)
[61.356090] Starting dynamic subtest: vcs1
[63.333485] Dynamic subtest vcs1: SUCCESS (1.961s)
[63.340469] Starting dynamic subtest: vecs0
[65.317072] Dynamic subtest vecs0: SUCCESS (1.966s)
[65.323205] Starting dynamic subtest: ccs0
[65.354458] Dynamic subtest ccs0: SUCCESS (0.045s)
[65.356042] Subtest extended: SUCCESS (5.395s)
[65.581659] [002/133] (954s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[65.673926] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[65.674865] Starting dynamic subtest: pipe-A-eDP-1
[65.683532] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[65.689839] Starting dynamic subtest: pipe-B-eDP-1
[65.698652] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[65.704608] Starting dynamic subtest: pipe-C-eDP-1
[65.714504] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[65.722240] Starting dynamic subtest: pipe-D-eDP-1
[65.731027] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[65.732570] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[67.939363] [003/133] (952s left) kms_frontbuffer_tracking (psr-2p-rte)
[68.031386] Starting subtest: psr-2p-rte
[68.033461] Subtest psr-2p-rte: SKIP (0.000s)
[68.146130] [004/133] (952s left) syncobj_wait (reset-during-wait-for-submit)
[68.194841] Starting subtest: reset-during-wait-for-submit
[68.298956] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[68.381948] [005/133] (951s left) gem_fenced_exec_thrash (too-many-fences)
[68.441197] Subtest too-many-fences: SKIP (0.000s)
[68.488560] [006/133] (951s left) gem_tiled_fence_blits (basic)
[68.543864] Subtest basic: SKIP (0.000s)
[68.611100] [007/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[68.705274] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[76.155590] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.430s)
[76.296575] [008/133] (944s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[76.394767] Starting subtest: psr-rgb101010-draw-render
[83.800239] Subtest psr-rgb101010-draw-render: SUCCESS (7.399s)
[83.904173] [009/133] (936s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[84.008449] Starting subtest: x-tiled-64bpp-rotate-90
[84.027733] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[84.136422] [010/133] (936s left) gem_eio (wait-1us)
[84.301174] Starting subtest: wait-1us
[84.519840] Subtest wait-1us: SUCCESS (0.219s)
[84.663081] [011/133] (935s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[84.754430] Starting subtest: fbc-psr-sprite-mmap-cpu
[84.755472] Starting dynamic subtest: eDP-1
[84.757331] Dynamic subtest eDP-1: SKIP (0.000s)
[84.759092] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[84.829812] [012/133] (935s left) gem_exec_schedule (manyslice)
[84.879608] Starting subtest: manyslice
[84.880702] Starting dynamic subtest: rcs0
[90.080986] Dynamic subtest rcs0: SUCCESS (5.151s)
[90.093770] Starting dynamic subtest: bcs0
[96.732670] Dynamic subtest bcs0: SUCCESS (6.646s)
[96.742075] Starting dynamic subtest: vcs0
[102.777107] Dynamic subtest vcs0: SUCCESS (6.077s)
[102.787938] Starting dynamic subtest: vcs1
[108.382595] Dynamic subtest vcs1: SUCCESS (5.566s)
[108.391809] Starting dynamic subtest: vecs0
[114.460530] Dynamic subtest vecs0: SUCCESS (6.076s)
[114.472701] Starting dynamic subtest: ccs0
[121.163603] Dynamic subtest ccs0: SUCCESS (6.702s)
[121.165208] Subtest manyslice: SUCCESS (36.221s)
[121.408822] [013/133] (899s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[121.469041] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[121.470095] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[121.559348] [014/133] (899s left) gem_exec_schedule (wide)
[121.746034] Starting subtest: wide
[121.747272] Starting dynamic subtest: rcs0
[133.137604] Dynamic subtest rcs0: SUCCESS (11.352s)
[133.147862] Starting dynamic subtest: vcs0
[144.468291] Dynamic subtest vcs0: SUCCESS (11.365s)
[144.478608] Starting dynamic subtest: vcs1
[154.659461] Dynamic subtest vcs1: SUCCESS (10.190s)
[154.668568] Starting dynamic subtest: vecs0
[167.174548] Dynamic subtest vecs0: SUCCESS (12.515s)
[167.185157] Starting dynamic subtest: ccs0
[181.927706] Dynamic subtest ccs0: SUCCESS (14.716s)
[181.929150] Subtest wide: SUCCESS (60.142s)
[183.505538] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[183.507329] [015/133] (837s left) kms_addfb_basic (small-bo)
[183.610233] Starting subtest: small-bo
[183.611079] Subtest small-bo: SUCCESS (0.000s)
[183.704292] [016/133] (836s left) gem_exec_balancer (full-late)
[183.759646] Starting subtest: full-late
[188.274330] Subtest full-late: SUCCESS (4.514s)
[188.588219] [017/133] (832s left) kms_pm_backlight (brightness-with-dpms)
[188.669114] Starting subtest: brightness-with-dpms
[188.748923] Starting dynamic subtest: eDP-1
[191.179148] Dynamic subtest eDP-1: SUCCESS (2.431s)
[191.180145] Subtest brightness-with-dpms: SUCCESS (2.511s)
[192.040293] [018/133] (828s left) api_intel_allocator (fork-simple-once)
[192.089964] Starting subtest: fork-simple-once
[192.105093] Subtest fork-simple-once: SUCCESS (0.015s)
[192.226943] [019/133] (828s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[192.312711] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[192.314601] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[192.390223] [020/133] (828s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[192.484398] Starting subtest: psr2-plane-move-sf-dmg-area
[192.485329] Starting dynamic subtest: pipe-A-eDP-1
[196.990429] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.507s)
[197.000363] Starting dynamic subtest: pipe-B-eDP-1
[202.336934] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.344s)
[202.337797] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.854s)
[203.213099] [021/133] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[203.305397] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[206.853545] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.548s)
[208.005789] [022/133] (812s left) kms_frontbuffer_tracking (fbc-2p-rte)
[208.098950] Starting subtest: fbc-2p-rte
[208.100756] Subtest fbc-2p-rte: SKIP (0.000s)
[208.209196] [023/133] (812s left) gem_exec_reloc (basic-cpu-wc)
[208.256882] Subtest basic-cpu-wc: SKIP (0.000s)
[208.341564] [024/133] (812s left) gem_tiled_blits (normal)
[208.391339] Subtest normal: SKIP (0.000s)
[208.450301] [025/133] (812s left) syncobj_timeline (wait-all-for-submit-complex)
[208.510950] Starting subtest: wait-all-for-submit-complex
[208.734649] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[208.822649] [026/133] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[208.912698] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[208.914862] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[208.994472] [027/133] (812s left) kms_dsc (dsc-with-output-formats-with-bpc)
[209.085149] Starting subtest: dsc-with-output-formats-with-bpc
[209.107046] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[209.155239] [028/133] (811s left) gem_exec_flush (basic-wb-rw-default)
[209.207313] Starting subtest: basic-wb-rw-default
[214.663510] Subtest basic-wb-rw-default: SUCCESS (5.456s)
[214.844941] [029/133] (806s left) kms_joiner (basic-big-joiner)
[214.936386] Starting subtest: basic-big-joiner
[214.938445] Subtest basic-big-joiner: SKIP (0.000s)
[214.999234] [030/133] (806s left) perf_pmu (render-node-busy-idle)
[215.053939] Starting subtest: render-node-busy-idle
[215.055043] Starting dynamic subtest: rcs0
[215.732761] Dynamic subtest rcs0: SUCCESS (0.679s)
[215.743485] Starting dynamic subtest: bcs0
[216.394749] Dynamic subtest bcs0: SUCCESS (0.661s)
[216.406521] Starting dynamic subtest: vcs0
[218.341209] Dynamic subtest vcs0: SUCCESS (1.936s)
[218.352279] Starting dynamic subtest: vcs1
[220.325437] Dynamic subtest vcs1: SUCCESS (1.982s)
[220.337417] Starting dynamic subtest: vecs0
[222.309656] Dynamic subtest vecs0: SUCCESS (1.983s)
[222.322243] Starting dynamic subtest: ccs0
[222.979711] Dynamic subtest ccs0: SUCCESS (0.676s)
[222.982043] Subtest render-node-busy-idle: SUCCESS (7.925s)
[223.051568] [031/133] (798s left) kms_addfb_basic (invalid-get-prop)
[223.103507] Starting subtest: invalid-get-prop
[223.104499] Subtest invalid-get-prop: SUCCESS (0.000s)
[223.245538] [032/133] (797s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[223.338917] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[223.340745] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[223.445951] [033/133] (797s left) i915_pm_rps (thresholds)
[223.505232] Starting subtest: thresholds
[223.507349] Subtest thresholds: SKIP (0.001s)
[223.606808] [034/133] (797s left) gem_mmap_wc (bad-offset)
[223.664363] Subtest bad-offset: SKIP (0.000s)
[223.730973] [035/133] (797s left) kms_rotation_crc (multiplane-rotation)
[223.810058] Starting subtest: multiplane-rotation
[241.327967] Subtest multiplane-rotation: SUCCESS (17.516s)
[241.435830] [036/133] (779s left) gem_softpin (evict-prime-sanity-check)
[241.487680] Starting subtest: evict-prime-sanity-check
[241.488633] Starting dynamic subtest: rcs0
[242.630706] Dynamic subtest rcs0: SUCCESS (1.142s)
[242.643614] Starting dynamic subtest: bcs0
[243.748302] Dynamic subtest bcs0: SUCCESS (1.115s)
[243.758736] Starting dynamic subtest: vcs0
[245.261282] Dynamic subtest vcs0: SUCCESS (1.500s)
[245.270111] Starting dynamic subtest: vcs1
[247.334030] Dynamic subtest vcs1: SUCCESS (2.071s)
[247.342867] Starting dynamic subtest: vecs0
[249.292844] Dynamic subtest vecs0: SUCCESS (1.956s)
[249.303604] Starting dynamic subtest: ccs0
[250.432462] Dynamic subtest ccs0: SUCCESS (1.146s)
[250.443478] Starting dynamic subtest: all
[251.550669] Dynamic subtest all: SUCCESS (1.116s)
[251.551852] Subtest evict-prime-sanity-check: SUCCESS (10.063s)
[251.639580] [037/133] (769s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[251.730922] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[251.732794] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[251.809849] [038/133] (769s left) kms_flip (flip-vs-expired-vblank-interruptible)
[251.897341] Starting subtest: flip-vs-expired-vblank-interruptible
[251.899792] Starting dynamic subtest: A-eDP1
[260.608388] Dynamic subtest A-eDP1: SUCCESS (8.682s)
[260.619751] Starting dynamic subtest: B-eDP1
[269.242774] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[269.254546] Starting dynamic subtest: C-eDP1
[277.878795] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[277.887140] Starting dynamic subtest: D-eDP1
[286.509858] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[286.511142] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.576s)
[287.623901] [039/133] (733s left) gem_ctx_shared (disjoint-timelines)
[287.677790] Starting subtest: disjoint-timelines
[287.708973] Subtest disjoint-timelines: SUCCESS (0.031s)
[287.928618] [040/133] (733s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[288.017333] Starting subtest: fbcpsr-rgb101010-draw-render
[294.795011] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.778s)
[294.913785] [041/133] (726s left) gem_exec_parallel (fds)
[294.974875] Starting subtest: fds
[294.975814] Starting dynamic subtest: rcs0
[298.500421] Dynamic subtest rcs0: SUCCESS (3.517s)
[298.510293] Starting dynamic subtest: bcs0
[302.451927] Dynamic subtest bcs0: SUCCESS (3.948s)
[302.462791] Starting dynamic subtest: vcs0
[306.591498] Dynamic subtest vcs0: SUCCESS (4.137s)
[306.605759] Starting dynamic subtest: vcs1
[310.587940] Dynamic subtest vcs1: SUCCESS (3.994s)
[310.598994] Starting dynamic subtest: vecs0
[314.617037] Dynamic subtest vecs0: SUCCESS (4.028s)
[314.625245] Starting dynamic subtest: ccs0
[318.503425] Dynamic subtest ccs0: SUCCESS (3.885s)
[318.504708] Subtest fds: SUCCESS (23.521s)
[318.687378] [042/133] (702s left) gem_readwrite (new-obj)
[318.736260] Subtest new-obj: SKIP (0.000s)
[318.789155] [043/133] (702s left) gem_mmap_wc (fault-concurrent)
[318.845289] Subtest fault-concurrent: SKIP (0.000s)
[318.892973] [044/133] (702s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[318.995229] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[320.062501] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.067s)
[320.180709] [045/133] (701s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[320.226764] Starting subtest: multi-wait-for-submit-available-signaled
[320.227638] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[320.318871] [046/133] (701s left) gem_exec_fence (basic-busy-all)
[320.371867] Starting subtest: basic-busy-all
[320.451753] Subtest basic-busy-all: SUCCESS (0.079s)
[322.438708] [047/133] (699s left) gem_lmem_swapping (parallel-random-verify-ccs)
[322.473614] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[322.507416] [048/133] (699s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[322.599399] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[322.600438] Starting dynamic subtest: pipe-A-eDP-1
[322.609777] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[322.618649] Starting dynamic subtest: pipe-B-eDP-1
[322.626916] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[322.635187] Starting dynamic subtest: pipe-C-eDP-1
[322.643165] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.651041] Starting dynamic subtest: pipe-D-eDP-1
[322.659378] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.661098] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[324.929625] [049/133] (696s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[325.011725] Starting subtest: pr-plane-move-sf-dmg-area
[325.013634] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[325.077988] [050/133] (696s left) kms_psr (fbc-psr2-sprite-blt)
[325.165731] Starting subtest: fbc-psr2-sprite-blt
[325.166739] Starting dynamic subtest: eDP-1
[325.168821] Dynamic subtest eDP-1: SKIP (0.000s)
[325.170474] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[325.234222] [051/133] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[325.318485] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[332.137899] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.819s)
[332.256823] [052/133] (689s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[332.346618] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[332.348615] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[332.443979] [053/133] (689s left) gem_eio (wait-10ms)
[332.650825] Starting subtest: wait-10ms
[333.005960] Subtest wait-10ms: SUCCESS (0.355s)
[333.158812] [054/133] (688s left) kms_prime (basic-crc-vgem)
[333.234283] Starting subtest: basic-crc-vgem
[333.235160] Starting dynamic subtest: second-to-first
[334.237678] Dynamic subtest second-to-first: SUCCESS (1.004s)
[334.238611] Subtest basic-crc-vgem: SUCCESS (1.005s)
[334.348834] [055/133] (687s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[334.482345] Starting subtest: extended-modeset-hang-newfb-with-reset
[334.484247] Starting dynamic subtest: pipe-A
[348.608717] Dynamic subtest pipe-A: SUCCESS (14.124s)
[348.618486] Starting dynamic subtest: pipe-D
[364.090563] Dynamic subtest pipe-D: SUCCESS (15.479s)
[364.091435] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.607s)
[364.879269] [056/133] (657s left) kms_hdr (static-swap)
[364.960554] Starting subtest: static-swap
[364.963342] Subtest static-swap: SKIP (0.000s)
[365.030859] [057/133] (657s left) kms_content_protection (type1)
[365.159352] Starting subtest: type1
[365.161563] Subtest type1: SKIP (0.000s)
[365.275458] [058/133] (656s left) gem_flink_basic (double-flink)
[365.324094] Starting subtest: double-flink
[365.324880] Subtest double-flink: SUCCESS (0.000s)
[365.424989] [059/133] (656s left) gem_tiled_swapping (non-threaded)
[365.472343] Subtest non-threaded: SKIP (0.000s)
[365.522372] [060/133] (656s left) gem_render_copy (yf-tiled)
[365.567684] Starting subtest: yf-tiled
[365.570130] Subtest yf-tiled: SKIP (0.000s)
[365.758160] [061/133] (656s left) gem_exec_balancer (semaphore)
[365.805528] Starting subtest: semaphore
[367.355134] Subtest semaphore: SUCCESS (1.541s)
[367.651387] [062/133] (654s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[367.707565] Starting subtest: y-tiled-to-vebox-x-tiled
[367.709503] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[367.889930] [063/133] (654s left) gem_exec_fence (syncobj-timeline-wait)
[368.442596] Starting subtest: syncobj-timeline-wait
[369.340160] Subtest syncobj-timeline-wait: SUCCESS (0.898s)
[371.333174] [064/133] (650s left) kms_flip (dpms-vs-vblank-race)
[371.429349] Starting subtest: dpms-vs-vblank-race
[371.431463] Starting dynamic subtest: A-eDP1
[376.398763] Dynamic subtest A-eDP1: SUCCESS (4.966s)
[376.407233] Starting dynamic subtest: B-eDP1
[381.042718] Dynamic subtest B-eDP1: SUCCESS (4.642s)
[381.051140] Starting dynamic subtest: C-eDP1
[385.686633] Dynamic subtest C-eDP1: SUCCESS (4.644s)
[385.696284] Starting dynamic subtest: D-eDP1
[390.306870] Dynamic subtest D-eDP1: SUCCESS (4.617s)
[390.310053] Subtest dpms-vs-vblank-race: SUCCESS (18.878s)
[391.189362] [065/133] (631s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[391.233214] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[391.338366] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[391.422142] [066/133] (630s left) syncobj_timeline (invalid-transfer-bad-pad)
[391.472189] Starting subtest: invalid-transfer-bad-pad
[391.473223] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[391.563142] [067/133] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[391.655874] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[398.313514] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.657s)
[398.445453] [068/133] (624s left) kms_color (ctm-max)
[398.538277] Starting subtest: ctm-max
[398.539178] Starting dynamic subtest: pipe-A-eDP-1
[399.270191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[399.279835] Starting dynamic subtest: pipe-B-eDP-1
[400.650618] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[400.659210] Starting dynamic subtest: pipe-C-eDP-1
[402.028893] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[402.037561] Starting dynamic subtest: pipe-D-eDP-1
[403.353766] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[403.354822] Subtest ctm-max: SUCCESS (4.815s)
[404.154326] [069/133] (618s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[404.237028] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[404.238668] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[404.302884] [070/133] (618s left) gem_eio (hibernate)
[404.523311] Starting subtest: hibernate
[419.506875] Subtest hibernate: SUCCESS (14.982s)
[426.656818] [071/133] (602s left) gem_wait (write-wait)
[426.718648] Starting subtest: write-wait
[426.719518] Starting dynamic subtest: all-engines
[427.816062] Dynamic subtest all-engines: SUCCESS (1.096s)
[427.834503] Starting dynamic subtest: rcs0
[428.875353] Dynamic subtest rcs0: SUCCESS (1.057s)
[428.896261] Starting dynamic subtest: bcs0
[429.934951] Dynamic subtest bcs0: SUCCESS (1.058s)
[429.953722] Starting dynamic subtest: vcs0
[430.988755] Dynamic subtest vcs0: SUCCESS (1.051s)
[431.007373] Starting dynamic subtest: vcs1
[432.044975] Dynamic subtest vcs1: SUCCESS (1.054s)
[432.064219] Starting dynamic subtest: vecs0
[433.102112] Dynamic subtest vecs0: SUCCESS (1.055s)
[433.119870] Starting dynamic subtest: ccs0
[434.159120] Dynamic subtest ccs0: SUCCESS (1.054s)
[434.160460] Subtest write-wait: SUCCESS (7.441s)
[434.355011] [072/133] (595s left) kms_async_flips (async-flip-dpms)
[434.437892] Starting subtest: async-flip-dpms
[434.811929] Starting dynamic subtest: pipe-A-eDP-1
[438.725269] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.914s)
[439.115403] Starting dynamic subtest: pipe-B-eDP-1
[441.903393] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.797s)
[442.288302] Starting dynamic subtest: pipe-C-eDP-1
[445.059997] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.782s)
[445.448716] Starting dynamic subtest: pipe-D-eDP-1
[448.229845] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.789s)
[448.230873] Subtest async-flip-dpms: SUCCESS (13.792s)
[449.412026] [073/133] (580s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[449.505617] Starting subtest: primary-yf-tiled-reflect-x-270
[449.507758] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[449.592319] [074/133] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[449.678869] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[449.680630] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[449.793628] [075/133] (579s left) gem_exec_fence (syncobj-invalid-flags)
[450.208559] Starting subtest: syncobj-invalid-flags
[450.209754] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[451.368672] [076/133] (578s left) perf (non-zero-reason)
[451.497945] Starting subtest: non-zero-reason
[451.498788] Starting dynamic subtest: 0-rcs0
[457.140932] Dynamic subtest 0-rcs0: SUCCESS (5.616s)
[457.153919] Starting dynamic subtest: 1-vcs1
[461.143295] Dynamic subtest 1-vcs1: SUCCESS (4.019s)
[461.144430] Subtest non-zero-reason: SUCCESS (9.637s)
[461.181650] [077/133] (568s left) i915_pm_freq_api (freq-basic-api)
[461.247088] Starting subtest: freq-basic-api
[461.248134] Starting dynamic subtest: gt0
[461.250898] Dynamic subtest gt0: SUCCESS (0.003s)
[461.261480] Starting dynamic subtest: gt1
[461.262351] Dynamic subtest gt1: SUCCESS (0.003s)
[461.263185] Subtest freq-basic-api: SUCCESS (0.007s)
[461.341414] [078/133] (568s left) gem_mmap_gtt (ptrace)
[461.392970] Subtest ptrace: SKIP (0.000s)
[461.456446] [079/133] (568s left) kms_pipe_crc_basic (suspend-read-crc)
[461.543236] Starting subtest: suspend-read-crc
[461.544121] Starting dynamic subtest: pipe-A-eDP-1
[479.519521] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.971s)
[479.529287] Starting dynamic subtest: pipe-B-eDP-1
[498.511031] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.563s)
[498.522151] Starting dynamic subtest: pipe-C-eDP-1
[517.475893] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.482s)
[517.488421] Starting dynamic subtest: pipe-D-eDP-1
[536.500018] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.434s)
[536.500938] Subtest suspend-read-crc: SUCCESS (13.456s)
[541.365959] [080/133] (492s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[541.463631] Starting subtest: 4-tiled-64bpp-rotate-90
[541.486996] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[541.586336] [081/133] (492s left) gem_partial_pwrite_pread (reads-uncached)
[541.631559] Subtest reads-uncached: SKIP (0.000s)
[541.693841] [082/133] (492s left) sysfs_heartbeat_interval (precise)
[541.742254] Starting subtest: precise
[541.743970] Starting dynamic subtest: vecs0
[549.851385] Dynamic subtest vecs0: SUCCESS (8.108s)
[549.865554] Starting dynamic subtest: ccs0
[552.770492] Dynamic subtest ccs0: SUCCESS (2.916s)
[552.782241] Starting dynamic subtest: vcs0
[560.794447] Dynamic subtest vcs0: SUCCESS (8.023s)
[560.808130] Starting dynamic subtest: bcs0
[561.905136] Dynamic subtest bcs0: SUCCESS (1.095s)
[561.918996] Starting dynamic subtest: rcs0
[563.022871] Dynamic subtest rcs0: SUCCESS (1.070s)
[563.034986] Starting dynamic subtest: vcs1
[570.853476] Dynamic subtest vcs1: SUCCESS (7.622s)
[570.855090] Subtest precise: SUCCESS (28.846s)
[570.930641] [083/133] (463s left) gem_ctx_exec (basic-close-race)
[570.982455] Starting subtest: basic-close-race
[576.720534] Subtest basic-close-race: SUCCESS (5.633s)
[576.808077] [084/133] (457s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[577.135072] Starting subtest: cursor-rapid-movement-max-size
[577.138057] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[577.255981] [085/133] (456s left) kms_psr (pr-no-drrs)
[577.345424] Starting subtest: pr-no-drrs
[577.347830] Subtest pr-no-drrs: SKIP (0.000s)
[577.415361] [086/133] (456s left) gem_userptr_blits (process-exit-busy)
[577.479192] Starting subtest: process-exit-busy
[577.490694] Subtest process-exit-busy: SUCCESS (0.012s)
[577.609292] [087/133] (456s left) gem_ctx_persistence (engines-mixed-process)
[577.667691] Starting subtest: engines-mixed-process
[577.668947] Starting dynamic subtest: rcs0
[578.834097] Dynamic subtest rcs0: SUCCESS (1.161s)
[578.845718] Starting dynamic subtest: bcs0
[580.823522] Dynamic subtest bcs0: SUCCESS (1.979s)
[580.834702] Starting dynamic subtest: vcs0
[582.814952] Dynamic subtest vcs0: SUCCESS (1.983s)
[582.827699] Starting dynamic subtest: vcs1
[584.804444] Dynamic subtest vcs1: SUCCESS (1.982s)
[584.815406] Starting dynamic subtest: vecs0
[586.849913] Dynamic subtest vecs0: SUCCESS (2.039s)
[586.861514] Starting dynamic subtest: ccs0
[588.822701] Dynamic subtest ccs0: SUCCESS (1.968s)
[588.823883] Subtest engines-mixed-process: SUCCESS (11.118s)
[588.897321] [088/133] (445s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[588.987980] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[588.989899] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[589.078489] [089/133] (445s left) kms_psr (psr-cursor-mmap-cpu)
[589.166471] Starting subtest: psr-cursor-mmap-cpu
[589.167641] Starting dynamic subtest: eDP-1
[590.878389] Dynamic subtest eDP-1: SUCCESS (1.708s)
[590.879475] Subtest psr-cursor-mmap-cpu: SUCCESS (1.709s)
[591.734278] [090/133] (442s left) gem_exec_schedule (preempt-self)
[591.803437] Starting subtest: preempt-self
[591.804419] Starting dynamic subtest: rcs0
[591.823684] Dynamic subtest rcs0: SUCCESS (0.022s)
[591.836401] Starting dynamic subtest: bcs0
[591.842851] Dynamic subtest bcs0: SUCCESS (0.018s)
[591.852694] Starting dynamic subtest: vcs0
[591.866613] Dynamic subtest vcs0: SUCCESS (0.023s)
[591.876966] Starting dynamic subtest: vcs1
[591.885915] Dynamic subtest vcs1: SUCCESS (0.019s)
[591.895898] Starting dynamic subtest: vecs0
[591.907476] Dynamic subtest vecs0: SUCCESS (0.021s)
[591.917378] Starting dynamic subtest: ccs0
[591.926959] Dynamic subtest ccs0: SUCCESS (0.019s)
[591.927912] Subtest preempt-self: SUCCESS (0.126s)
[593.899623] [091/133] (440s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[593.957643] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[594.061710] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[594.136048] [092/133] (440s left) kms_flip (flip-vs-absolute-wf_vblank)
[594.220899] Starting subtest: flip-vs-absolute-wf_vblank
[594.223331] Starting dynamic subtest: A-eDP1
[603.195230] Dynamic subtest A-eDP1: SUCCESS (8.969s)
[603.208512] Starting dynamic subtest: B-eDP1
[612.125368] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[612.138342] Starting dynamic subtest: C-eDP1
[621.078163] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[621.090619] Starting dynamic subtest: D-eDP1
[630.016700] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[630.017985] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.744s)
[631.210600] [093/133] (403s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[631.292533] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[631.294084] Starting dynamic subtest: pipe-A
[632.544419] Dynamic subtest pipe-A: SUCCESS (1.252s)
[632.554442] Starting dynamic subtest: pipe-B
[634.847642] Dynamic subtest pipe-B: SUCCESS (2.301s)
[634.858486] Starting dynamic subtest: pipe-C
[636.028037] Dynamic subtest pipe-C: SUCCESS (1.178s)
[636.038406] Starting dynamic subtest: pipe-D
[637.259007] Dynamic subtest pipe-D: SUCCESS (1.230s)
[637.260010] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.966s)
[638.453223] [094/133] (396s left) sw_sync (sync_multi_consumer_producer)
[638.490471] Starting subtest: sync_multi_consumer_producer
[638.887550] Subtest sync_multi_consumer_producer: SUCCESS (0.387s)
[638.940862] [095/133] (395s left) gem_readwrite (write-bad-handle)
[638.999346] Subtest write-bad-handle: SKIP (0.000s)
[639.060496] [096/133] (395s left) kms_chamelium_color (ctm-limited-range)
[639.141336] Subtest ctm-limited-range: SKIP (0.000s)
[639.184539] [097/133] (395s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[639.274480] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[639.276729] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[639.361188] [098/133] (395s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[639.442365] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[639.443358] Starting dynamic subtest: pipe-A-eDP-1
[639.463677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[639.475596] Starting dynamic subtest: pipe-B-eDP-1
[639.485240] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[639.496703] Starting dynamic subtest: pipe-C-eDP-1
[639.515088] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[639.524970] Starting dynamic subtest: pipe-D-eDP-1
[639.533151] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[639.534077] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[641.820882] [099/133] (392s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[642.197049] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[643.033687] [100/133] (391s left) kms_sequence (get-forked)
[643.113144] Starting subtest: get-forked
[643.114259] Starting dynamic subtest: pipe-A-eDP-1
[645.011130] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.896s)
[645.021430] Starting dynamic subtest: pipe-B-eDP-1
[647.526347] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.513s)
[647.536910] Starting dynamic subtest: pipe-C-eDP-1
[650.076010] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.548s)
[650.087460] Starting dynamic subtest: pipe-D-eDP-1
[652.562571] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.483s)
[652.563621] Subtest get-forked: SUCCESS (9.445s)
[653.395408] [101/133] (381s left) gem_lmem_swapping (heavy-verify-multi)
[653.436335] Subtest heavy-verify-multi: SKIP (0.000s)
[653.484746] [102/133] (381s left) api_intel_bb (intel-bb-blit-y)
[653.531269] Starting subtest: intel-bb-blit-y
[657.099535] Subtest intel-bb-blit-y: SUCCESS (3.555s)
[657.200492] [103/133] (377s left) kms_cursor_crc (cursor-tearing-position-change)
[657.317958] Starting subtest: cursor-tearing-position-change
[657.319376] Starting dynamic subtest: pipe-A-eDP-1
[657.892306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[657.903090] Starting dynamic subtest: pipe-D-eDP-1
[659.137435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[659.138632] Subtest cursor-tearing-position-change: SUCCESS (1.821s)
[659.958107] [104/133] (374s left) i915_suspend (fence-restore-untiled)
[660.008282] Starting subtest: fence-restore-untiled
[660.011029] Subtest fence-restore-untiled: SKIP (0.000s)
[660.098418] [105/133] (374s left) kms_addfb_basic (addfb25-modifier-no-flag)
[660.187566] Starting subtest: addfb25-modifier-no-flag
[660.189235] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[660.285978] [106/133] (374s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[660.381908] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[660.383962] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[660.470159] [107/133] (374s left) kms_chamelium_hpd (vga-hpd)
[660.850539] Subtest vga-hpd: SKIP (0.000s)
[661.671189] [108/133] (373s left) drm_read (short-buffer-wakeup)
[661.808965] Starting subtest: short-buffer-wakeup
[694.029867] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[694.190004] [109/133] (340s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[694.286251] Starting subtest: y-tiled-32bpp-rotate-90
[694.288534] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[694.373882] [110/133] (340s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[694.466052] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[694.468267] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[694.563222] [111/133] (340s left) i915_drm_fdinfo (most-busy-check-all)
[694.597030] Starting subtest: most-busy-check-all
[694.598318] Starting dynamic subtest: rcs0
[694.602014] Dynamic subtest rcs0: SKIP (0.004s)
[694.613532] Starting dynamic subtest: bcs0
[694.615974] Dynamic subtest bcs0: SKIP (0.000s)
[694.625852] Starting dynamic subtest: vcs0
[694.628072] Dynamic subtest vcs0: SKIP (0.000s)
[694.637870] Starting dynamic subtest: vcs1
[694.640372] Dynamic subtest vcs1: SKIP (0.000s)
[694.650150] Starting dynamic subtest: vecs0
[694.652453] Dynamic subtest vecs0: SKIP (0.000s)
[694.662190] Starting dynamic subtest: ccs0
[694.664615] Dynamic subtest ccs0: SKIP (0.000s)
[694.667140] Subtest most-busy-check-all: SKIP (0.010s)
[694.699275] [112/133] (340s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[694.816416] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[701.676197] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.860s)
[701.798044] [113/133] (333s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[701.898130] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[701.901156] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[701.979947] [114/133] (333s left) perf (polling-small-buf)
[702.071076] Starting subtest: polling-small-buf
[702.160138] Subtest polling-small-buf: SUCCESS (0.089s)
[702.208803] [115/133] (333s left) kms_plane_multiple (tiling-x)
[702.293593] Starting subtest: tiling-x
[702.295056] Starting dynamic subtest: pipe-A-eDP-1
[705.955437] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.661s)
[705.966156] Starting dynamic subtest: pipe-B-eDP-1
[710.493004] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.534s)
[710.503450] Starting dynamic subtest: pipe-C-eDP-1
[714.826283] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.332s)
[714.836410] Starting dynamic subtest: pipe-D-eDP-1
[719.176192] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.348s)
[719.177526] Subtest tiling-x: SUCCESS (16.879s)
[719.976473] [116/133] (315s left) gen9_exec_parse (bb-start-cmd)
[720.031903] Subtest bb-start-cmd: SKIP (0.000s)
[720.093071] [117/133] (315s left) kms_cursor_crc (cursor-offscreen-512x512)
[720.377634] Starting subtest: cursor-offscreen-512x512
[720.380113] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[720.530357] [118/133] (314s left) gem_ctx_shared (create-shared-gtt)
[720.585541] Starting subtest: create-shared-gtt
[722.736741] Subtest create-shared-gtt: SUCCESS (2.152s)
[723.072137] [119/133] (312s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[723.168965] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[723.182185] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[723.258247] [120/133] (312s left) kms_dp_linktrain_fallback (dsc-fallback)
[723.340286] Starting subtest: dsc-fallback
[723.343185] Subtest dsc-fallback: SKIP (0.000s)
[723.413988] [121/133] (312s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[723.511390] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[723.512440] Starting dynamic subtest: pipe-A-eDP-1
[723.521820] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[723.533233] Starting dynamic subtest: pipe-B-eDP-1
[723.542698] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[723.552839] Starting dynamic subtest: pipe-C-eDP-1
[723.561939] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[723.572462] Starting dynamic subtest: pipe-D-eDP-1
[723.582964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[723.584644] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[725.749767] [122/133] (309s left) syncobj_wait (single-wait-all-submitted)
[725.802480] Starting subtest: single-wait-all-submitted
[725.909370] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[725.994527] [123/133] (309s left) kms_atomic (atomic-invalid-params)
[726.076471] Starting subtest: atomic-invalid-params
[726.077579] Starting dynamic subtest: pipe-A-eDP-1
[726.472836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[726.473612] Subtest atomic-invalid-params: SUCCESS (0.397s)
[727.289182] [124/133] (308s left) perf_pmu (all-busy-check-all)
[727.326840] Starting subtest: all-busy-check-all
[728.865528] Subtest all-busy-check-all: SUCCESS (1.530s)
[728.945448] [125/133] (306s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[729.039445] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[729.042081] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[729.124134] [126/133] (306s left) kms_lease (lease-invalid-connector)
[729.202298] Starting subtest: lease-invalid-connector
[729.203938] Starting dynamic subtest: pipe-A-eDP-1
[729.205273] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[729.218056] Starting dynamic subtest: pipe-B-eDP-1
[729.219009] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[729.228462] Starting dynamic subtest: pipe-C-eDP-1
[729.229445] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[729.239367] Starting dynamic subtest: pipe-D-eDP-1
[729.240180] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[729.241629] Subtest lease-invalid-connector: SUCCESS (0.005s)
[729.317315] [127/133] (306s left) gem_madvise (dontneed-after-mmap)
[729.350157] Starting subtest: dontneed-after-mmap
[729.376336] Subtest dontneed-after-mmap: SUCCESS (0.026s)
[729.484285] [128/133] (306s left) kms_flip (flip-vs-suspend-interruptible)
[729.564437] Starting subtest: flip-vs-suspend-interruptible
[729.565645] Starting dynamic subtest: A-eDP1
[843.618008] Dynamic subtest A-eDP1: SUCCESS (11.675s)
[843.618859] Subtest flip-vs-suspend-interruptible: SUCCESS (11.677s)
[850.800693] [129/133] (192s left) kms_vblank (wait-forked-busy)
[850.897773] Starting subtest: wait-forked-busy
[850.898591] Starting dynamic subtest: pipe-A-eDP-1
[852.780747] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[852.793053] Starting dynamic subtest: pipe-D-eDP-1
[855.326097] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[855.327043] Subtest wait-forked-busy: SUCCESS (4.440s)
[856.125714] [130/133] (186s left) kms_big_fb (linear-32bpp-rotate-180)
[856.215795] Starting subtest: linear-32bpp-rotate-180
[857.827121] Subtest linear-32bpp-rotate-180: SUCCESS (1.614s)
[857.958269] [131/133] (184s left) gen3_render_tiledx_blits
[858.081698] [132/133] (184s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[858.173137] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[865.239977] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.073s)
[865.339533] [133/133] (177s left) kms_plane_scaling (planes-scaler-unity-scaling)
[865.438143] Starting subtest: planes-scaler-unity-scaling
[865.439084] Starting dynamic subtest: pipe-A
[865.501327] Dynamic subtest pipe-A: SUCCESS (0.064s)
[865.513899] Starting dynamic subtest: pipe-B
[866.680379] Dynamic subtest pipe-B: SUCCESS (1.178s)
[866.693931] Starting dynamic subtest: pipe-C
[867.792372] Dynamic subtest pipe-C: SUCCESS (1.111s)
[867.803284] Starting dynamic subtest: pipe-D
[868.920488] Dynamic subtest pipe-D: SUCCESS (1.128s)
[868.921430] Subtest planes-scaler-unity-scaling: SUCCESS (3.485s)
[870.083633] Closing watchdogs
results: parsing output: 0/ for test: gem_busy
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_fenced_exec_thrash
results: parsing output: 5/ for test: gem_tiled_fence_blits
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_pm_backlight
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: gem_tiled_blits
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_dsc
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_joiner
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rps
results: parsing output: 33/ for test: gem_mmap_wc
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_ctx_shared
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_parallel
results: parsing output: 41/ for test: gem_readwrite
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: kms_prime
results: parsing output: 54/ for test: kms_busy
results: parsing output: 55/ for test: kms_hdr
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: gem_flink_basic
results: parsing output: 58/ for test: gem_tiled_swapping
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_color
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: gem_wait
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: kms_rotation_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: i915_pm_freq_api
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_pipe_crc_basic
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: gem_ctx_exec
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_readwrite
results: parsing output: 95/ for test: kms_chamelium_color
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: kms_sequence
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: i915_suspend
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: i915_drm_fdinfo
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_plane_multiple
results: parsing output: 115/ for test: gen9_exec_parse
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: gem_ctx_shared
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_dp_linktrain_fallback
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_atomic
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: gem_madvise
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gen3_render_tiledx_blits
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
Done.