[57.722676] Initializing watchdogs
[57.722725]   /dev/watchdog0
[57.738227] [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]
[57.742944] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.745418] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.748846] [001/133] (960s left) gem_busy (extended)
[57.964457] Starting subtest: extended
[57.966871] Starting dynamic subtest: rcs0
[58.055786] Dynamic subtest rcs0: SUCCESS (0.090s)
[58.065649] Starting dynamic subtest: bcs0
[58.100977] Dynamic subtest bcs0: SUCCESS (0.043s)
[58.111496] Starting dynamic subtest: vcs0
[59.274488] Dynamic subtest vcs0: SUCCESS (1.156s)
[59.285785] Starting dynamic subtest: vcs1
[61.318636] Dynamic subtest vcs1: SUCCESS (2.021s)
[61.329771] Starting dynamic subtest: vecs0
[63.305925] Dynamic subtest vecs0: SUCCESS (1.970s)
[63.317356] Starting dynamic subtest: ccs0
[63.349846] Dynamic subtest ccs0: SUCCESS (0.045s)
[63.352434] Subtest extended: SUCCESS (5.331s)
[63.590459] [002/133] (954s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[63.692475] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[63.694871] Starting dynamic subtest: pipe-A-eDP-1
[63.718435] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.728030] Starting dynamic subtest: pipe-B-eDP-1
[63.749215] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.756845] Starting dynamic subtest: pipe-C-eDP-1
[63.777390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.787161] Starting dynamic subtest: pipe-D-eDP-1
[63.809686] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.813809] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[65.982196] [003/133] (952s left) kms_frontbuffer_tracking (psr-2p-rte)
[66.080435] Starting subtest: psr-2p-rte
[66.084701] Subtest psr-2p-rte: SKIP (0.000s)
[66.175033] [004/133] (952s left) syncobj_wait (reset-during-wait-for-submit)
[66.235794] Starting subtest: reset-during-wait-for-submit
[66.341886] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[66.424879] [005/133] (951s left) gem_fenced_exec_thrash (too-many-fences)
[66.490675] Subtest too-many-fences: SKIP (0.000s)
[66.571582] [006/133] (951s left) gem_tiled_fence_blits (basic)
[66.631936] Subtest basic: SKIP (0.000s)
[66.708263] [007/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[66.804222] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[74.446041] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.625s)
[74.567845] [008/133] (943s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[74.664514] Starting subtest: psr-rgb101010-draw-render
[81.991053] Subtest psr-rgb101010-draw-render: SUCCESS (7.322s)
[82.126047] [009/133] (936s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[82.236425] Starting subtest: x-tiled-64bpp-rotate-90
[82.255212] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s)
[82.368993] [010/133] (936s left) gem_eio (wait-1us)
[82.533040] Starting subtest: wait-1us
[82.752976] Subtest wait-1us: SUCCESS (0.221s)
[82.865056] [011/133] (935s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[82.963373] Starting subtest: fbc-psr-sprite-mmap-cpu
[82.965231] Starting dynamic subtest: eDP-1
[82.968841] Dynamic subtest eDP-1: SKIP (0.000s)
[82.972453] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[83.035611] [012/133] (935s left) gem_exec_schedule (manyslice)
[83.102896] Starting subtest: manyslice
[83.104865] Starting dynamic subtest: rcs0
[88.237081] Dynamic subtest rcs0: SUCCESS (5.137s)
[88.245710] Starting dynamic subtest: bcs0
[95.367774] Dynamic subtest bcs0: SUCCESS (7.127s)
[95.376936] Starting dynamic subtest: vcs0
[101.462946] Dynamic subtest vcs0: SUCCESS (6.092s)
[101.476174] Starting dynamic subtest: vcs1
[107.539326] Dynamic subtest vcs1: SUCCESS (6.074s)
[107.552992] Starting dynamic subtest: vecs0
[113.617642] Dynamic subtest vecs0: SUCCESS (6.076s)
[113.628337] Starting dynamic subtest: ccs0
[119.814359] Dynamic subtest ccs0: SUCCESS (6.195s)
[119.816992] Subtest manyslice: SUCCESS (36.705s)
[120.128476] [013/133] (898s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[120.195365] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[120.197298] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[120.290290] [014/133] (898s left) gem_exec_schedule (wide)
[120.476755] Starting subtest: wide
[120.479526] Starting dynamic subtest: rcs0
[131.985067] Dynamic subtest rcs0: SUCCESS (11.506s)
[131.997298] Starting dynamic subtest: vcs0
[143.027612] Dynamic subtest vcs0: SUCCESS (11.042s)
[143.040102] Starting dynamic subtest: vcs1
[153.527551] Dynamic subtest vcs1: SUCCESS (10.499s)
[153.541311] Starting dynamic subtest: vecs0
[163.390799] Dynamic subtest vecs0: SUCCESS (9.863s)
[163.402770] Starting dynamic subtest: ccs0
[178.078795] Dynamic subtest ccs0: SUCCESS (14.687s)
[178.081406] Subtest wide: SUCCESS (57.599s)
[179.354376] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[179.357635] [015/133] (839s left) kms_addfb_basic (small-bo)
[179.461045] Starting subtest: small-bo
[179.463343] Subtest small-bo: SUCCESS (0.000s)
[179.564671] [016/133] (839s left) gem_exec_balancer (full-late)
[179.620556] Starting subtest: full-late
[184.202636] Subtest full-late: SUCCESS (4.567s)
[184.515710] [017/133] (834s left) kms_pm_backlight (brightness-with-dpms)
[184.617646] Starting subtest: brightness-with-dpms
[184.702116] Starting dynamic subtest: eDP-1
[187.158763] Dynamic subtest eDP-1: SUCCESS (2.453s)
[187.161013] Subtest brightness-with-dpms: SUCCESS (2.540s)
[188.025619] [018/133] (830s left) api_intel_allocator (fork-simple-once)
[188.086035] Starting subtest: fork-simple-once
[188.100068] Subtest fork-simple-once: SUCCESS (0.016s)
[188.212300] [019/133] (830s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[188.321652] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[188.325787] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[188.388528] [020/133] (830s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[188.487318] Starting subtest: psr2-plane-move-sf-dmg-area
[188.489609] Starting dynamic subtest: pipe-A-eDP-1
[193.060801] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.578s)
[193.070314] Starting dynamic subtest: pipe-B-eDP-1
[198.404795] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.343s)
[198.407280] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.924s)
[199.286577] [021/133] (819s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[199.381316] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[202.958890] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.580s)
[204.095842] [022/133] (814s left) kms_frontbuffer_tracking (fbc-2p-rte)
[204.191737] Starting subtest: fbc-2p-rte
[204.195816] Subtest fbc-2p-rte: SKIP (0.000s)
[204.290794] [023/133] (814s left) gem_exec_reloc (basic-cpu-wc)
[204.345298] Subtest basic-cpu-wc: SKIP (0.000s)
[204.419130] [024/133] (814s left) gem_tiled_blits (normal)
[204.477632] Subtest normal: SKIP (0.000s)
[204.565371] [025/133] (814s left) syncobj_timeline (wait-all-for-submit-complex)
[204.620019] Starting subtest: wait-all-for-submit-complex
[204.833833] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[204.925619] [026/133] (814s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[205.036353] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[205.040772] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[205.127228] [027/133] (814s left) kms_dsc (dsc-with-output-formats-with-bpc)
[205.238065] Starting subtest: dsc-with-output-formats-with-bpc
[205.296448] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[205.341820] [028/133] (814s left) gem_exec_flush (basic-wb-rw-default)
[205.411405] Starting subtest: basic-wb-rw-default
[210.865914] Subtest basic-wb-rw-default: SUCCESS (5.455s)
[211.051746] [029/133] (808s left) kms_joiner (basic-big-joiner)
[211.165676] Starting subtest: basic-big-joiner
[211.170081] Subtest basic-big-joiner: SKIP (0.000s)
[211.232086] [030/133] (808s left) perf_pmu (render-node-busy-idle)
[211.333802] Starting subtest: render-node-busy-idle
[211.336448] Starting dynamic subtest: rcs0
[212.027837] Dynamic subtest rcs0: SUCCESS (0.694s)
[212.039762] Starting dynamic subtest: bcs0
[212.697318] Dynamic subtest bcs0: SUCCESS (0.668s)
[212.708928] Starting dynamic subtest: vcs0
[214.279054] Dynamic subtest vcs0: SUCCESS (1.579s)
[214.288211] Starting dynamic subtest: vcs1
[216.327021] Dynamic subtest vcs1: SUCCESS (2.046s)
[216.338700] Starting dynamic subtest: vecs0
[218.311749] Dynamic subtest vecs0: SUCCESS (1.983s)
[218.323653] Starting dynamic subtest: ccs0
[218.980303] Dynamic subtest ccs0: SUCCESS (0.669s)
[218.982780] Subtest render-node-busy-idle: SUCCESS (7.647s)
[219.056027] [031/133] (800s left) kms_addfb_basic (invalid-get-prop)
[219.105283] Starting subtest: invalid-get-prop
[219.107662] Subtest invalid-get-prop: SUCCESS (0.000s)
[219.249985] [032/133] (800s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[219.350753] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[219.355223] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[219.456780] [033/133] (800s left) i915_pm_rps (thresholds)
[219.515268] Starting subtest: thresholds
[219.519906] Subtest thresholds: SKIP (0.001s)
[219.620655] [034/133] (799s left) gem_mmap_wc (bad-offset)
[219.688587] Subtest bad-offset: SKIP (0.000s)
[219.754072] [035/133] (799s left) kms_rotation_crc (multiplane-rotation)
[219.851109] Starting subtest: multiplane-rotation
[237.311475] Subtest multiplane-rotation: SUCCESS (17.461s)
[237.425799] [036/133] (782s left) gem_softpin (evict-prime-sanity-check)
[237.480178] Starting subtest: evict-prime-sanity-check
[237.481974] Starting dynamic subtest: rcs0
[238.625944] Dynamic subtest rcs0: SUCCESS (1.145s)
[238.637448] Starting dynamic subtest: bcs0
[239.747652] Dynamic subtest bcs0: SUCCESS (1.120s)
[239.760066] Starting dynamic subtest: vcs0
[241.266416] Dynamic subtest vcs0: SUCCESS (1.515s)
[241.280806] Starting dynamic subtest: vcs1
[243.327760] Dynamic subtest vcs1: SUCCESS (2.059s)
[243.340041] Starting dynamic subtest: vecs0
[245.249497] Dynamic subtest vecs0: SUCCESS (1.920s)
[245.259671] Starting dynamic subtest: ccs0
[246.364582] Dynamic subtest ccs0: SUCCESS (1.115s)
[246.375239] Starting dynamic subtest: all
[247.500065] Dynamic subtest all: SUCCESS (1.134s)
[247.502546] Subtest evict-prime-sanity-check: SUCCESS (10.020s)
[247.583092] [037/133] (772s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[247.677414] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[247.681613] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[247.747685] [038/133] (771s left) kms_flip (flip-vs-expired-vblank-interruptible)
[247.839808] Starting subtest: flip-vs-expired-vblank-interruptible
[247.842170] Starting dynamic subtest: A-eDP1
[256.482579] Dynamic subtest A-eDP1: SUCCESS (8.640s)
[256.495818] Starting dynamic subtest: B-eDP1
[265.113037] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[265.123688] Starting dynamic subtest: C-eDP1
[273.735445] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[273.745544] Starting dynamic subtest: D-eDP1
[282.358732] Dynamic subtest D-eDP1: SUCCESS (8.622s)
[282.363596] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.523s)
[283.537613] [039/133] (736s left) gem_ctx_shared (disjoint-timelines)
[283.594840] Starting subtest: disjoint-timelines
[283.629561] Subtest disjoint-timelines: SUCCESS (0.034s)
[283.875837] [040/133] (735s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[283.978791] Starting subtest: fbcpsr-rgb101010-draw-render
[290.724154] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.748s)
[290.858242] [041/133] (729s left) gem_exec_parallel (fds)
[290.923496] Starting subtest: fds
[290.925885] Starting dynamic subtest: rcs0
[294.107043] Dynamic subtest rcs0: SUCCESS (3.184s)
[294.117049] Starting dynamic subtest: bcs0
[298.548873] Dynamic subtest bcs0: SUCCESS (4.439s)
[298.559920] Starting dynamic subtest: vcs0
[302.568748] Dynamic subtest vcs0: SUCCESS (4.018s)
[302.578299] Starting dynamic subtest: vcs1
[308.286511] Dynamic subtest vcs1: SUCCESS (5.715s)
[308.297823] Starting dynamic subtest: vecs0
[312.504487] Dynamic subtest vecs0: SUCCESS (4.216s)
[312.515687] Starting dynamic subtest: ccs0
[316.406281] Dynamic subtest ccs0: SUCCESS (3.899s)
[316.408939] Subtest fds: SUCCESS (25.485s)
[316.606846] [042/133] (703s left) gem_readwrite (new-obj)
[316.661038] Subtest new-obj: SKIP (0.000s)
[316.723471] [043/133] (703s left) gem_mmap_wc (fault-concurrent)
[316.782588] Subtest fault-concurrent: SKIP (0.000s)
[316.855694] [044/133] (703s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[316.957865] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[318.029560] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.071s)
[318.173265] [045/133] (701s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[318.230836] Starting subtest: multi-wait-for-submit-available-signaled
[318.233886] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[318.348384] [046/133] (701s left) gem_exec_fence (basic-busy-all)
[318.416321] Starting subtest: basic-busy-all
[318.510263] Subtest basic-busy-all: SUCCESS (0.094s)
[320.403926] [047/133] (699s left) gem_lmem_swapping (parallel-random-verify-ccs)
[320.450889] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[320.498241] [048/133] (699s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[320.592090] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[320.594249] Starting dynamic subtest: pipe-A-eDP-1
[320.615938] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[320.626258] Starting dynamic subtest: pipe-B-eDP-1
[320.647087] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[320.656555] Starting dynamic subtest: pipe-C-eDP-1
[320.677879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[320.687827] Starting dynamic subtest: pipe-D-eDP-1
[320.709787] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[320.713915] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[322.840803] [049/133] (697s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[322.943767] Starting subtest: pr-plane-move-sf-dmg-area
[322.947713] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[323.011297] [050/133] (697s left) kms_psr (fbc-psr2-sprite-blt)
[323.103902] Starting subtest: fbc-psr2-sprite-blt
[323.106116] Starting dynamic subtest: eDP-1
[323.110062] Dynamic subtest eDP-1: SKIP (0.000s)
[323.114116] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[323.180153] [051/133] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[323.270213] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[329.952935] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.683s)
[330.077253] [052/133] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[330.184946] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[330.189469] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[330.301933] [053/133] (690s left) gem_eio (wait-10ms)
[330.520514] Starting subtest: wait-10ms
[330.873049] Subtest wait-10ms: SUCCESS (0.354s)
[331.054064] [054/133] (689s left) kms_prime (basic-crc-vgem)
[331.138827] Starting subtest: basic-crc-vgem
[331.140497] Starting dynamic subtest: second-to-first
[332.154210] Dynamic subtest second-to-first: SUCCESS (1.018s)
[332.156050] Subtest basic-crc-vgem: SUCCESS (1.019s)
[332.272859] [055/133] (688s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[332.400084] Starting subtest: extended-modeset-hang-newfb-with-reset
[332.401670] Starting dynamic subtest: pipe-A
[346.233062] Dynamic subtest pipe-A: SUCCESS (13.829s)
[346.243706] Starting dynamic subtest: pipe-D
[362.028397] Dynamic subtest pipe-D: SUCCESS (15.794s)
[362.030723] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.627s)
[362.850832] [056/133] (657s left) kms_hdr (static-swap)
[362.954191] Starting subtest: static-swap
[362.960129] Subtest static-swap: SKIP (0.000s)
[363.025726] [057/133] (657s left) kms_content_protection (type1)
[363.161326] Starting subtest: type1
[363.165625] Subtest type1: SKIP (0.000s)
[363.310752] [058/133] (657s left) gem_flink_basic (double-flink)
[363.364149] Starting subtest: double-flink
[363.366493] Subtest double-flink: SUCCESS (0.000s)
[363.474118] [059/133] (657s left) gem_tiled_swapping (non-threaded)
[363.523917] Subtest non-threaded: SKIP (0.000s)
[363.591011] [060/133] (657s left) gem_render_copy (yf-tiled)
[363.651409] Starting subtest: yf-tiled
[363.655592] Subtest yf-tiled: SKIP (0.000s)
[363.845495] [061/133] (656s left) gem_exec_balancer (semaphore)
[363.905855] Starting subtest: semaphore
[365.315519] Subtest semaphore: SUCCESS (1.408s)
[365.637921] [062/133] (655s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[365.689211] Starting subtest: y-tiled-to-vebox-x-tiled
[365.693680] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[365.871083] [063/133] (654s left) gem_exec_fence (syncobj-timeline-wait)
[366.414366] Starting subtest: syncobj-timeline-wait
[367.306248] Subtest syncobj-timeline-wait: SUCCESS (0.892s)
[369.367836] [064/133] (651s left) kms_flip (dpms-vs-vblank-race)
[369.459754] Starting subtest: dpms-vs-vblank-race
[369.462028] Starting dynamic subtest: A-eDP1
[374.420948] Dynamic subtest A-eDP1: SUCCESS (4.958s)
[374.431067] Starting dynamic subtest: B-eDP1
[377.959158] Dynamic subtest B-eDP1: SUCCESS (3.536s)
[377.969044] Starting dynamic subtest: C-eDP1
[382.599975] Dynamic subtest C-eDP1: SUCCESS (4.637s)
[382.610084] Starting dynamic subtest: D-eDP1
[387.241797] Dynamic subtest D-eDP1: SUCCESS (4.643s)
[387.244283] Subtest dpms-vs-vblank-race: SUCCESS (17.785s)
[388.112893] [065/133] (632s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[388.170266] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[388.276111] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[388.359313] [066/133] (632s left) syncobj_timeline (invalid-transfer-bad-pad)
[388.410559] Starting subtest: invalid-transfer-bad-pad
[388.412729] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[388.524361] [067/133] (632s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[388.613546] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[395.231447] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.620s)
[395.391291] [068/133] (625s left) kms_color (ctm-max)
[395.486821] Starting subtest: ctm-max
[395.488744] Starting dynamic subtest: pipe-A-eDP-1
[396.231882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[396.243268] Starting dynamic subtest: pipe-B-eDP-1
[397.678212] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.446s)
[397.688202] Starting dynamic subtest: pipe-C-eDP-1
[399.030209] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s)
[399.041649] Starting dynamic subtest: pipe-D-eDP-1
[400.365510] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[400.367653] Subtest ctm-max: SUCCESS (4.880s)
[401.163539] [069/133] (619s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[401.257490] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[401.261743] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[401.333635] [070/133] (619s left) gem_eio (hibernate)
[401.558269] Starting subtest: hibernate
[416.444740] Subtest hibernate: SUCCESS (14.884s)
[423.597537] [071/133] (604s left) gem_wait (write-wait)
[423.670922] Starting subtest: write-wait
[423.673328] Starting dynamic subtest: all-engines
[424.771731] Dynamic subtest all-engines: SUCCESS (1.100s)
[424.791905] Starting dynamic subtest: rcs0
[425.835062] Dynamic subtest rcs0: SUCCESS (1.060s)
[425.853518] Starting dynamic subtest: bcs0
[426.892831] Dynamic subtest bcs0: SUCCESS (1.055s)
[426.910849] Starting dynamic subtest: vcs0
[427.947983] Dynamic subtest vcs0: SUCCESS (1.053s)
[427.965912] Starting dynamic subtest: vcs1
[429.000415] Dynamic subtest vcs1: SUCCESS (1.050s)
[429.019036] Starting dynamic subtest: vecs0
[430.053649] Dynamic subtest vecs0: SUCCESS (1.051s)
[430.072093] Starting dynamic subtest: ccs0
[431.111065] Dynamic subtest ccs0: SUCCESS (1.055s)
[431.113902] Subtest write-wait: SUCCESS (7.441s)
[431.325382] [072/133] (596s left) kms_async_flips (async-flip-dpms)
[431.427231] Starting subtest: async-flip-dpms
[431.800312] Starting dynamic subtest: pipe-A-eDP-1
[435.639448] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.838s)
[436.018789] Starting dynamic subtest: pipe-B-eDP-1
[438.888565] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.881s)
[439.278360] Starting dynamic subtest: pipe-C-eDP-1
[442.047507] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.779s)
[442.445528] Starting dynamic subtest: pipe-D-eDP-1
[445.212107] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[445.214434] Subtest async-flip-dpms: SUCCESS (13.787s)
[446.400681] [073/133] (581s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[446.501986] Starting subtest: primary-yf-tiled-reflect-x-270
[446.506162] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[446.585723] [074/133] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[446.684553] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[446.688593] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[446.810612] [075/133] (581s left) gem_exec_fence (syncobj-invalid-flags)
[447.216314] Starting subtest: syncobj-invalid-flags
[447.218825] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[448.404026] [076/133] (579s left) perf (non-zero-reason)
[448.530203] Starting subtest: non-zero-reason
[448.532445] Starting dynamic subtest: 0-rcs0
[453.971853] Dynamic subtest 0-rcs0: SUCCESS (5.441s)
[453.986424] Starting dynamic subtest: 1-vcs1
[457.894913] Dynamic subtest 1-vcs1: SUCCESS (3.922s)
[457.898301] Subtest non-zero-reason: SUCCESS (9.364s)
[457.940318] [077/133] (570s left) i915_pm_freq_api (freq-basic-api)
[458.012707] Starting subtest: freq-basic-api
[458.015304] Starting dynamic subtest: gt0
[458.020491] Dynamic subtest gt0: SUCCESS (0.005s)
[458.033119] Starting dynamic subtest: gt1
[458.034945] Dynamic subtest gt1: SUCCESS (0.003s)
[458.036865] Subtest freq-basic-api: SUCCESS (0.010s)
[458.144186] [078/133] (570s left) gem_mmap_gtt (ptrace)
[458.209832] Subtest ptrace: SKIP (0.000s)
[458.277788] [079/133] (570s left) kms_pipe_crc_basic (suspend-read-crc)
[458.380013] Starting subtest: suspend-read-crc
[458.382250] Starting dynamic subtest: pipe-A-eDP-1
[475.676885] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.565s)
[475.689307] Starting dynamic subtest: pipe-B-eDP-1
[493.683681] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.106s)
[493.695882] Starting dynamic subtest: pipe-C-eDP-1
[511.640244] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.000s)
[511.651630] Starting dynamic subtest: pipe-D-eDP-1
[529.647892] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.077s)
[529.650430] Subtest suspend-read-crc: SUCCESS (11.754s)
[530.509490] [080/133] (498s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[530.615216] Starting subtest: 4-tiled-64bpp-rotate-90
[530.635469] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[530.752673] [081/133] (497s left) gem_partial_pwrite_pread (reads-uncached)
[530.810734] Subtest reads-uncached: SKIP (0.000s)
[530.887722] [082/133] (497s left) sysfs_heartbeat_interval (precise)
[530.941849] Starting subtest: precise
[530.944199] Starting dynamic subtest: vecs0
[538.604338] Dynamic subtest vecs0: SUCCESS (7.558s)
[538.617048] Starting dynamic subtest: ccs0
[539.780148] Dynamic subtest ccs0: SUCCESS (1.166s)
[539.793746] Starting dynamic subtest: vcs0
[547.623791] Dynamic subtest vcs0: SUCCESS (7.807s)
[547.637930] Starting dynamic subtest: bcs0
[548.770914] Dynamic subtest bcs0: SUCCESS (1.140s)
[548.784835] Starting dynamic subtest: rcs0
[551.507215] Dynamic subtest rcs0: SUCCESS (2.728s)
[551.521811] Starting dynamic subtest: vcs1
[558.567864] Dynamic subtest vcs1: SUCCESS (7.052s)
[558.572291] Subtest precise: SUCCESS (27.464s)
[558.655720] [083/133] (470s left) gem_ctx_exec (basic-close-race)
[558.716938] Starting subtest: basic-close-race
[564.599291] Subtest basic-close-race: SUCCESS (5.886s)
[564.732785] [084/133] (464s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[565.054775] Starting subtest: cursor-rapid-movement-max-size
[565.061361] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[565.185145] [085/133] (463s left) kms_psr (pr-no-drrs)
[565.274183] Starting subtest: pr-no-drrs
[565.278585] Subtest pr-no-drrs: SKIP (0.000s)
[565.360985] [086/133] (463s left) gem_userptr_blits (process-exit-busy)
[565.419869] Starting subtest: process-exit-busy
[565.429765] Subtest process-exit-busy: SUCCESS (0.011s)
[565.581856] [087/133] (463s left) gem_ctx_persistence (engines-mixed-process)
[565.633215] Starting subtest: engines-mixed-process
[565.634964] Starting dynamic subtest: rcs0
[567.587759] Dynamic subtest rcs0: SUCCESS (1.959s)
[567.601140] Starting dynamic subtest: bcs0
[569.580087] Dynamic subtest bcs0: SUCCESS (1.993s)
[569.593346] Starting dynamic subtest: vcs0
[571.611755] Dynamic subtest vcs0: SUCCESS (2.032s)
[571.623671] Starting dynamic subtest: vcs1
[573.618952] Dynamic subtest vcs1: SUCCESS (2.009s)
[573.632239] Starting dynamic subtest: vecs0
[575.595386] Dynamic subtest vecs0: SUCCESS (1.976s)
[575.608886] Starting dynamic subtest: ccs0
[577.579870] Dynamic subtest ccs0: SUCCESS (1.985s)
[577.582305] Subtest engines-mixed-process: SUCCESS (11.961s)
[577.661666] [088/133] (451s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[577.784336] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[577.789050] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[577.891952] [089/133] (451s left) kms_psr (psr-cursor-mmap-cpu)
[577.996499] Starting subtest: psr-cursor-mmap-cpu
[577.998787] Starting dynamic subtest: eDP-1
[579.731871] Dynamic subtest eDP-1: SUCCESS (1.736s)
[579.734294] Subtest psr-cursor-mmap-cpu: SUCCESS (1.737s)
[580.623662] [090/133] (448s left) gem_exec_schedule (preempt-self)
[580.695649] Starting subtest: preempt-self
[580.697581] Starting dynamic subtest: rcs0
[580.710439] Dynamic subtest rcs0: SUCCESS (0.021s)
[580.722464] Starting dynamic subtest: bcs0
[580.731178] Dynamic subtest bcs0: SUCCESS (0.020s)
[580.746388] Starting dynamic subtest: vcs0
[580.755114] Dynamic subtest vcs0: SUCCESS (0.023s)
[580.767178] Starting dynamic subtest: vcs1
[580.775662] Dynamic subtest vcs1: SUCCESS (0.020s)
[580.788009] Starting dynamic subtest: vecs0
[580.797750] Dynamic subtest vecs0: SUCCESS (0.021s)
[580.809018] Starting dynamic subtest: ccs0
[580.822584] Dynamic subtest ccs0: SUCCESS (0.024s)
[580.824875] Subtest preempt-self: SUCCESS (0.133s)
[582.655304] [091/133] (446s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[582.705533] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[582.813885] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[582.916323] [092/133] (446s left) kms_flip (flip-vs-absolute-wf_vblank)
[583.011465] Starting subtest: flip-vs-absolute-wf_vblank
[583.013825] Starting dynamic subtest: A-eDP1
[591.941871] Dynamic subtest A-eDP1: SUCCESS (8.932s)
[591.954903] Starting dynamic subtest: B-eDP1
[600.869562] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[600.881554] Starting dynamic subtest: C-eDP1
[609.783809] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[609.797429] Starting dynamic subtest: D-eDP1
[618.718488] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[618.723922] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.714s)
[619.947622] [093/133] (409s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[620.044925] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[620.047349] Starting dynamic subtest: pipe-A
[621.193806] Dynamic subtest pipe-A: SUCCESS (1.152s)
[621.205175] Starting dynamic subtest: pipe-B
[623.477516] Dynamic subtest pipe-B: SUCCESS (2.283s)
[623.490080] Starting dynamic subtest: pipe-C
[624.623912] Dynamic subtest pipe-C: SUCCESS (1.145s)
[624.637199] Starting dynamic subtest: pipe-D
[625.862616] Dynamic subtest pipe-D: SUCCESS (1.237s)
[625.864848] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.821s)
[627.073334] [094/133] (402s left) sw_sync (sync_multi_consumer_producer)
[627.112344] Starting subtest: sync_multi_consumer_producer
[627.410581] Subtest sync_multi_consumer_producer: SUCCESS (0.298s)
[627.486334] [095/133] (401s left) gem_readwrite (write-bad-handle)
[627.538777] Subtest write-bad-handle: SKIP (0.000s)
[627.600835] [096/133] (401s left) kms_chamelium_color (ctm-limited-range)
[627.688373] Subtest ctm-limited-range: SKIP (0.000s)
[627.736077] [097/133] (401s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[627.829105] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[627.833622] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[627.925955] [098/133] (401s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[628.020219] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[628.022082] Starting dynamic subtest: pipe-A-eDP-1
[628.042452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[628.054550] Starting dynamic subtest: pipe-B-eDP-1
[628.074537] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[628.086428] Starting dynamic subtest: pipe-C-eDP-1
[628.106055] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[628.117842] Starting dynamic subtest: pipe-D-eDP-1
[628.138425] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[628.140558] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[630.431909] [099/133] (398s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[630.822627] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[631.641588] [100/133] (397s left) kms_sequence (get-forked)
[631.744227] Starting subtest: get-forked
[631.746165] Starting dynamic subtest: pipe-A-eDP-1
[633.690604] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[633.703151] Starting dynamic subtest: pipe-B-eDP-1
[636.205326] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.514s)
[636.218174] Starting dynamic subtest: pipe-C-eDP-1
[638.714945] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.507s)
[638.727156] Starting dynamic subtest: pipe-D-eDP-1
[641.258580] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[641.260486] Subtest get-forked: SUCCESS (9.513s)
[642.096589] [101/133] (387s left) gem_lmem_swapping (heavy-verify-multi)
[642.141677] Subtest heavy-verify-multi: SKIP (0.000s)
[642.185746] [102/133] (387s left) api_intel_bb (intel-bb-blit-y)
[642.233513] Starting subtest: intel-bb-blit-y
[645.676531] Subtest intel-bb-blit-y: SUCCESS (3.443s)
[645.798859] [103/133] (383s left) kms_cursor_crc (cursor-tearing-position-change)
[645.915588] Starting subtest: cursor-tearing-position-change
[645.917893] Starting dynamic subtest: pipe-A-eDP-1
[646.497945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[646.510193] Starting dynamic subtest: pipe-D-eDP-1
[647.721104] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[647.723614] Subtest cursor-tearing-position-change: SUCCESS (1.804s)
[648.570071] [104/133] (381s left) i915_suspend (fence-restore-untiled)
[648.633997] Starting subtest: fence-restore-untiled
[648.638059] Subtest fence-restore-untiled: SKIP (0.000s)
[648.726799] [105/133] (380s left) kms_addfb_basic (addfb25-modifier-no-flag)
[648.829207] Starting subtest: addfb25-modifier-no-flag
[648.831495] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[648.931755] [106/133] (380s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[649.030948] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[649.035225] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[649.134357] [107/133] (380s left) kms_chamelium_hpd (vga-hpd)
[649.514906] Subtest vga-hpd: SKIP (0.000s)
[650.364678] [108/133] (379s left) drm_read (short-buffer-wakeup)
[650.511210] Starting subtest: short-buffer-wakeup
[682.738229] Subtest short-buffer-wakeup: SUCCESS (32.219s)
[682.884085] [109/133] (346s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[682.987777] Starting subtest: y-tiled-32bpp-rotate-90
[682.992388] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[683.096648] [110/133] (346s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[683.194917] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[683.199478] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[683.296400] [111/133] (346s left) i915_drm_fdinfo (most-busy-check-all)
[683.339266] Starting subtest: most-busy-check-all
[683.341768] Starting dynamic subtest: rcs0
[683.346564] Dynamic subtest rcs0: SKIP (0.004s)
[683.360654] Starting dynamic subtest: bcs0
[683.364700] Dynamic subtest bcs0: SKIP (0.000s)
[683.375951] Starting dynamic subtest: vcs0
[683.380378] Dynamic subtest vcs0: SKIP (0.000s)
[683.391400] Starting dynamic subtest: vcs1
[683.395758] Dynamic subtest vcs1: SKIP (0.000s)
[683.406807] Starting dynamic subtest: vecs0
[683.411199] Dynamic subtest vecs0: SKIP (0.000s)
[683.422213] Starting dynamic subtest: ccs0
[683.426585] Dynamic subtest ccs0: SKIP (0.000s)
[683.430990] Subtest most-busy-check-all: SKIP (0.010s)
[683.470277] [112/133] (346s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[683.595770] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[690.454632] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.860s)
[690.593313] [113/133] (339s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[690.701330] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[690.705322] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[690.782318] [114/133] (339s left) perf (polling-small-buf)
[690.882578] Starting subtest: polling-small-buf
[690.972028] Subtest polling-small-buf: SUCCESS (0.087s)
[691.022203] [115/133] (339s left) kms_plane_multiple (tiling-x)
[691.110733] Starting subtest: tiling-x
[691.113062] Starting dynamic subtest: pipe-A-eDP-1
[694.944570] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.834s)
[694.956528] Starting dynamic subtest: pipe-B-eDP-1
[699.472844] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.523s)
[699.485078] Starting dynamic subtest: pipe-C-eDP-1
[703.797885] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.324s)
[703.812205] Starting dynamic subtest: pipe-D-eDP-1
[708.126183] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.327s)
[708.128636] Subtest tiling-x: SUCCESS (17.014s)
[708.942769] [116/133] (321s left) gen9_exec_parse (bb-start-cmd)
[709.008035] Subtest bb-start-cmd: SKIP (0.000s)
[709.083085] [117/133] (321s left) kms_cursor_crc (cursor-offscreen-512x512)
[709.374372] Starting subtest: cursor-offscreen-512x512
[709.378831] Subtest cursor-offscreen-512x512: SKIP (0.002s)
[709.552395] [118/133] (320s left) gem_ctx_shared (create-shared-gtt)
[709.606749] Starting subtest: create-shared-gtt
[711.761200] Subtest create-shared-gtt: SUCCESS (2.153s)
[712.107319] [119/133] (318s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[712.208959] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[712.221694] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[712.303878] [120/133] (318s left) kms_dp_linktrain_fallback (dsc-fallback)
[712.399317] Starting subtest: dsc-fallback
[712.406013] Subtest dsc-fallback: SKIP (0.000s)
[712.475908] [121/133] (317s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[712.563110] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[712.565389] Starting dynamic subtest: pipe-A-eDP-1
[712.588402] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[712.601967] Starting dynamic subtest: pipe-B-eDP-1
[712.624093] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[712.635768] Starting dynamic subtest: pipe-C-eDP-1
[712.657523] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[712.668643] Starting dynamic subtest: pipe-D-eDP-1
[712.690826] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[712.694881] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[714.822639] [122/133] (315s left) syncobj_wait (single-wait-all-submitted)
[714.867942] Starting subtest: single-wait-all-submitted
[714.973947] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[715.053852] [123/133] (315s left) kms_atomic (atomic-invalid-params)
[715.145030] Starting subtest: atomic-invalid-params
[715.147320] Starting dynamic subtest: pipe-A-eDP-1
[715.546846] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[715.549083] Subtest atomic-invalid-params: SUCCESS (0.402s)
[716.353888] [124/133] (314s left) perf_pmu (all-busy-check-all)
[716.396056] Starting subtest: all-busy-check-all
[717.611219] Subtest all-busy-check-all: SUCCESS (1.214s)
[717.733079] [125/133] (312s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[717.825442] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[717.829701] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[717.925388] [126/133] (312s left) kms_lease (lease-invalid-connector)
[718.016984] Starting subtest: lease-invalid-connector
[718.019329] Starting dynamic subtest: pipe-A-eDP-1
[718.021706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[718.034500] Starting dynamic subtest: pipe-B-eDP-1
[718.036403] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[718.048089] Starting dynamic subtest: pipe-C-eDP-1
[718.050405] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[718.061160] Starting dynamic subtest: pipe-D-eDP-1
[718.063423] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[718.065609] Subtest lease-invalid-connector: SUCCESS (0.005s)
[718.105278] [127/133] (312s left) gem_madvise (dontneed-after-mmap)
[718.138454] Starting subtest: dontneed-after-mmap
[718.157037] Subtest dontneed-after-mmap: SUCCESS (0.020s)
[718.266282] [128/133] (312s left) kms_flip (flip-vs-suspend-interruptible)
[718.356602] Starting subtest: flip-vs-suspend-interruptible
[718.358991] Starting dynamic subtest: A-eDP1
[879.754068] Dynamic subtest A-eDP1: SUCCESS (12.212s)
[879.757328] Subtest flip-vs-suspend-interruptible: SUCCESS (12.214s)
[879.886328] [129/133] (150s left) kms_vblank (wait-forked-busy)
[879.988278] Starting subtest: wait-forked-busy
[879.990936] Starting dynamic subtest: pipe-A-eDP-1
[881.863569] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[881.884835] Starting dynamic subtest: pipe-D-eDP-1
[884.445714] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.574s)
[884.448371] Subtest wait-forked-busy: SUCCESS (4.455s)
[885.247760] [130/133] (145s left) kms_big_fb (linear-32bpp-rotate-180)
[885.351291] Starting subtest: linear-32bpp-rotate-180
[886.895695] Subtest linear-32bpp-rotate-180: SUCCESS (1.545s)
[887.023062] [131/133] (143s left) gen3_render_tiledx_blits
[887.130627] [132/133] (143s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[887.225268] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[894.381236] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.158s)
[894.486270] [133/133] (136s left) kms_plane_scaling (planes-scaler-unity-scaling)
[894.578091] Starting subtest: planes-scaler-unity-scaling
[894.580740] Starting dynamic subtest: pipe-A
[894.640154] Dynamic subtest pipe-A: SUCCESS (0.064s)
[894.654195] Starting dynamic subtest: pipe-B
[895.816884] Dynamic subtest pipe-B: SUCCESS (1.175s)
[895.831510] Starting dynamic subtest: pipe-C
[896.938264] Dynamic subtest pipe-C: SUCCESS (1.119s)
[896.950854] Starting dynamic subtest: pipe-D
[898.058851] Dynamic subtest pipe-D: SUCCESS (1.119s)
[898.061271] Subtest planes-scaler-unity-scaling: SUCCESS (3.483s)
[899.227687] 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.