[60.293510] Initializing watchdogs
[60.293554]   /dev/watchdog0
[60.309786] [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]
[60.314405] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.316815] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.318773] [001/133] (960s left) gem_busy (extended)
[60.508744] Starting subtest: extended
[60.509643] Starting dynamic subtest: rcs0
[60.604640] Dynamic subtest rcs0: SUCCESS (0.097s)
[60.615041] Starting dynamic subtest: bcs0
[60.649595] Dynamic subtest bcs0: SUCCESS (0.044s)
[60.658560] Starting dynamic subtest: vcs0
[62.308702] Dynamic subtest vcs0: SUCCESS (1.635s)
[62.315244] Starting dynamic subtest: vcs1
[64.356618] Dynamic subtest vcs1: SUCCESS (2.032s)
[64.363466] Starting dynamic subtest: vecs0
[66.340263] Dynamic subtest vecs0: SUCCESS (1.973s)
[66.348288] Starting dynamic subtest: ccs0
[66.380172] Dynamic subtest ccs0: SUCCESS (0.047s)
[66.381202] Subtest extended: SUCCESS (5.836s)
[66.581099] [002/133] (954s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[66.673106] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[66.674145] Starting dynamic subtest: pipe-A-eDP-1
[66.683910] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.692198] Starting dynamic subtest: pipe-B-eDP-1
[66.701166] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.713230] Starting dynamic subtest: pipe-C-eDP-1
[66.721874] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.727730] Starting dynamic subtest: pipe-D-eDP-1
[66.737104] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.738915] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[69.203816] [003/133] (951s left) kms_frontbuffer_tracking (psr-2p-rte)
[69.289688] Starting subtest: psr-2p-rte
[69.291775] Subtest psr-2p-rte: SKIP (0.000s)
[69.377036] [004/133] (951s left) syncobj_wait (reset-during-wait-for-submit)
[69.420474] Starting subtest: reset-during-wait-for-submit
[69.525062] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[69.594526] [005/133] (951s left) gem_fenced_exec_thrash (too-many-fences)
[69.644224] Subtest too-many-fences: SKIP (0.000s)
[69.703103] [006/133] (951s left) gem_tiled_fence_blits (basic)
[69.748617] Subtest basic: SKIP (0.000s)
[69.809301] [007/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[69.889969] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[77.713617] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.812s)
[77.842170] [008/133] (943s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[77.936507] Starting subtest: psr-rgb101010-draw-render
[85.404842] Subtest psr-rgb101010-draw-render: SUCCESS (7.465s)
[85.521530] [009/133] (935s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[85.627736] Starting subtest: x-tiled-64bpp-rotate-90
[85.648350] Subtest x-tiled-64bpp-rotate-90: SKIP (0.021s)
[85.756520] [010/133] (935s left) gem_eio (wait-1us)
[85.914236] Starting subtest: wait-1us
[86.136894] Subtest wait-1us: SUCCESS (0.224s)
[86.257047] [011/133] (934s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[86.336367] Starting subtest: fbc-psr-sprite-mmap-cpu
[86.337398] Starting dynamic subtest: eDP-1
[86.339288] Dynamic subtest eDP-1: SKIP (0.000s)
[86.341182] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[86.405222] [012/133] (934s left) gem_exec_schedule (manyslice)
[86.465034] Starting subtest: manyslice
[86.465966] Starting dynamic subtest: rcs0
[92.142967] Dynamic subtest rcs0: SUCCESS (5.667s)
[92.153341] Starting dynamic subtest: bcs0
[98.831129] Dynamic subtest bcs0: SUCCESS (6.649s)
[98.838899] Starting dynamic subtest: vcs0
[104.914571] Dynamic subtest vcs0: SUCCESS (6.081s)
[104.922395] Starting dynamic subtest: vcs1
[110.487364] Dynamic subtest vcs1: SUCCESS (5.571s)
[110.495907] Starting dynamic subtest: vecs0
[117.039118] Dynamic subtest vecs0: SUCCESS (6.589s)
[117.053093] Starting dynamic subtest: ccs0
[124.270331] Dynamic subtest ccs0: SUCCESS (7.229s)
[124.271843] Subtest manyslice: SUCCESS (37.789s)
[124.558775] [013/133] (896s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[124.607740] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[124.608757] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[124.695288] [014/133] (896s left) gem_exec_schedule (wide)
[124.867080] Starting subtest: wide
[124.868364] Starting dynamic subtest: rcs0
[136.664050] Dynamic subtest rcs0: SUCCESS (11.750s)
[136.677594] Starting dynamic subtest: vcs0
[146.955096] Dynamic subtest vcs0: SUCCESS (10.327s)
[146.965460] Starting dynamic subtest: vcs1
[157.655020] Dynamic subtest vcs1: SUCCESS (10.699s)
[157.666196] Starting dynamic subtest: vecs0
[170.767510] Dynamic subtest vecs0: SUCCESS (13.113s)
[170.775369] Starting dynamic subtest: ccs0
[185.351717] Dynamic subtest ccs0: SUCCESS (14.547s)
[185.354048] Subtest wide: SUCCESS (60.438s)
[186.570579] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[186.572636] [015/133] (834s left) kms_addfb_basic (small-bo)
[186.668955] Starting subtest: small-bo
[186.670404] Subtest small-bo: SUCCESS (0.000s)
[186.762388] [016/133] (834s left) gem_exec_balancer (full-late)
[186.824623] Starting subtest: full-late
[191.217772] Subtest full-late: SUCCESS (4.392s)
[191.532175] [017/133] (829s left) kms_pm_backlight (brightness-with-dpms)
[191.621383] Starting subtest: brightness-with-dpms
[191.703774] Starting dynamic subtest: eDP-1
[194.087356] Dynamic subtest eDP-1: SUCCESS (2.384s)
[194.088441] Subtest brightness-with-dpms: SUCCESS (2.466s)
[194.952848] [018/133] (826s left) api_intel_allocator (fork-simple-once)
[195.004244] Starting subtest: fork-simple-once
[195.018845] Subtest fork-simple-once: SUCCESS (0.016s)
[195.141717] [019/133] (826s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[195.235354] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[195.237075] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[195.312577] [020/133] (826s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[195.396990] Starting subtest: psr2-plane-move-sf-dmg-area
[195.398048] Starting dynamic subtest: pipe-A-eDP-1
[199.908493] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.510s)
[199.917784] Starting dynamic subtest: pipe-B-eDP-1
[205.269665] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.361s)
[205.270883] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.873s)
[206.127396] [021/133] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[206.212818] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[209.825198] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.613s)
[210.948840] [022/133] (810s left) kms_frontbuffer_tracking (fbc-2p-rte)
[211.041095] Starting subtest: fbc-2p-rte
[211.043058] Subtest fbc-2p-rte: SKIP (0.000s)
[211.127712] [023/133] (810s left) gem_exec_reloc (basic-cpu-wc)
[211.180182] Subtest basic-cpu-wc: SKIP (0.000s)
[211.229164] [024/133] (810s left) gem_tiled_blits (normal)
[211.273758] Subtest normal: SKIP (0.000s)
[211.331684] [025/133] (810s left) syncobj_timeline (wait-all-for-submit-complex)
[211.372296] Starting subtest: wait-all-for-submit-complex
[211.595885] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[211.660221] [026/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[211.742083] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[211.743902] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[211.833385] [027/133] (809s left) kms_dsc (dsc-with-output-formats-with-bpc)
[211.924544] Starting subtest: dsc-with-output-formats-with-bpc
[211.948741] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[211.994943] [028/133] (809s left) gem_exec_flush (basic-wb-rw-default)
[212.049510] Starting subtest: basic-wb-rw-default
[217.501234] Subtest basic-wb-rw-default: SUCCESS (5.451s)
[217.707049] [029/133] (804s left) kms_joiner (basic-big-joiner)
[217.797065] Starting subtest: basic-big-joiner
[217.798919] Subtest basic-big-joiner: SKIP (0.000s)
[217.875924] [030/133] (803s left) perf_pmu (render-node-busy-idle)
[217.937887] Starting subtest: render-node-busy-idle
[217.939187] Starting dynamic subtest: rcs0
[218.626970] Dynamic subtest rcs0: SUCCESS (0.689s)
[218.637988] Starting dynamic subtest: bcs0
[219.294703] Dynamic subtest bcs0: SUCCESS (0.667s)
[219.306846] Starting dynamic subtest: vcs0
[221.348221] Dynamic subtest vcs0: SUCCESS (2.043s)
[221.358727] Starting dynamic subtest: vcs1
[223.333105] Dynamic subtest vcs1: SUCCESS (1.984s)
[223.343306] Starting dynamic subtest: vecs0
[225.316188] Dynamic subtest vecs0: SUCCESS (1.982s)
[225.327200] Starting dynamic subtest: ccs0
[225.978052] Dynamic subtest ccs0: SUCCESS (0.669s)
[225.979343] Subtest render-node-busy-idle: SUCCESS (8.041s)
[226.049811] [031/133] (795s left) kms_addfb_basic (invalid-get-prop)
[226.101828] Starting subtest: invalid-get-prop
[226.102781] Subtest invalid-get-prop: SUCCESS (0.000s)
[226.238765] [032/133] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[226.325759] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[226.327742] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[226.441948] [033/133] (795s left) i915_pm_rps (thresholds)
[226.502329] Starting subtest: thresholds
[226.504286] Subtest thresholds: SKIP (0.001s)
[226.597390] [034/133] (795s left) gem_mmap_wc (bad-offset)
[226.646539] Subtest bad-offset: SKIP (0.000s)
[226.702855] [035/133] (795s left) kms_rotation_crc (multiplane-rotation)
[226.797404] Starting subtest: multiplane-rotation
[244.269557] Subtest multiplane-rotation: SUCCESS (17.471s)
[244.378987] [036/133] (777s left) gem_softpin (evict-prime-sanity-check)
[244.429962] Starting subtest: evict-prime-sanity-check
[244.430907] Starting dynamic subtest: rcs0
[245.563267] Dynamic subtest rcs0: SUCCESS (1.133s)
[245.572383] Starting dynamic subtest: bcs0
[246.670771] Dynamic subtest bcs0: SUCCESS (1.106s)
[246.683976] Starting dynamic subtest: vcs0
[248.332435] Dynamic subtest vcs0: SUCCESS (1.649s)
[248.341216] Starting dynamic subtest: vcs1
[250.315220] Dynamic subtest vcs1: SUCCESS (1.980s)
[250.325699] Starting dynamic subtest: vecs0
[252.320081] Dynamic subtest vecs0: SUCCESS (2.003s)
[252.330935] Starting dynamic subtest: ccs0
[253.414051] Dynamic subtest ccs0: SUCCESS (1.102s)
[253.422085] Starting dynamic subtest: all
[254.571769] Dynamic subtest all: SUCCESS (1.157s)
[254.573056] Subtest evict-prime-sanity-check: SUCCESS (10.143s)
[254.649745] [037/133] (767s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[254.743343] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[254.745368] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[254.812028] [038/133] (767s left) kms_flip (flip-vs-expired-vblank-interruptible)
[254.897173] Starting subtest: flip-vs-expired-vblank-interruptible
[254.899526] Starting dynamic subtest: A-eDP1
[263.583257] Dynamic subtest A-eDP1: SUCCESS (8.656s)
[263.594496] Starting dynamic subtest: B-eDP1
[272.201311] Dynamic subtest B-eDP1: SUCCESS (8.617s)
[272.212196] Starting dynamic subtest: C-eDP1
[280.837581] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[280.847738] Starting dynamic subtest: D-eDP1
[289.470178] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[289.471060] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.538s)
[290.598457] [039/133] (731s left) gem_ctx_shared (disjoint-timelines)
[290.656678] Starting subtest: disjoint-timelines
[290.691202] Subtest disjoint-timelines: SUCCESS (0.036s)
[290.931638] [040/133] (731s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[291.016160] Starting subtest: fbcpsr-rgb101010-draw-render
[297.782411] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.767s)
[297.901766] [041/133] (724s left) gem_exec_parallel (fds)
[297.957329] Starting subtest: fds
[297.958117] Starting dynamic subtest: rcs0
[300.899930] Dynamic subtest rcs0: SUCCESS (2.933s)
[300.910646] Starting dynamic subtest: bcs0
[304.857998] Dynamic subtest bcs0: SUCCESS (3.955s)
[304.868953] Starting dynamic subtest: vcs0
[308.659696] Dynamic subtest vcs0: SUCCESS (3.801s)
[308.669244] Starting dynamic subtest: vcs1
[312.667053] Dynamic subtest vcs1: SUCCESS (4.005s)
[312.679930] Starting dynamic subtest: vecs0
[316.623969] Dynamic subtest vecs0: SUCCESS (3.956s)
[316.632314] Starting dynamic subtest: ccs0
[320.522120] Dynamic subtest ccs0: SUCCESS (3.896s)
[320.523502] Subtest fds: SUCCESS (22.556s)
[320.713740] [042/133] (701s left) gem_readwrite (new-obj)
[320.768786] Subtest new-obj: SKIP (0.000s)
[320.829154] [043/133] (701s left) gem_mmap_wc (fault-concurrent)
[320.870491] Subtest fault-concurrent: SKIP (0.000s)
[320.931644] [044/133] (701s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[321.022951] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[322.135954] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.113s)
[322.252138] [045/133] (700s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[322.300393] Starting subtest: multi-wait-for-submit-available-signaled
[322.301338] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[322.417987] [046/133] (699s left) gem_exec_fence (basic-busy-all)
[322.474486] Starting subtest: basic-busy-all
[322.557242] Subtest basic-busy-all: SUCCESS (0.083s)
[324.396262] [047/133] (697s left) gem_lmem_swapping (parallel-random-verify-ccs)
[324.431632] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[324.480962] [048/133] (697s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[324.562301] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[324.563153] Starting dynamic subtest: pipe-A-eDP-1
[324.571465] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[324.580244] Starting dynamic subtest: pipe-B-eDP-1
[324.588813] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[324.597354] Starting dynamic subtest: pipe-C-eDP-1
[324.605414] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[324.613553] Starting dynamic subtest: pipe-D-eDP-1
[324.621830] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[324.623507] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[326.902054] [049/133] (695s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[326.998453] Starting subtest: pr-plane-move-sf-dmg-area
[327.000310] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[327.069581] [050/133] (695s left) kms_psr (fbc-psr2-sprite-blt)
[327.165846] Starting subtest: fbc-psr2-sprite-blt
[327.166644] Starting dynamic subtest: eDP-1
[327.168266] Dynamic subtest eDP-1: SKIP (0.000s)
[327.169933] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[327.238828] [051/133] (695s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[327.338984] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[334.128878] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.789s)
[334.273458] [052/133] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[334.365730] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[334.367721] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[334.470337] [053/133] (688s left) gem_eio (wait-10ms)
[334.686976] Starting subtest: wait-10ms
[335.040524] Subtest wait-10ms: SUCCESS (0.353s)
[335.177541] [054/133] (687s left) kms_prime (basic-crc-vgem)
[335.254264] Starting subtest: basic-crc-vgem
[335.255057] Starting dynamic subtest: second-to-first
[336.259132] Dynamic subtest second-to-first: SUCCESS (1.006s)
[336.260192] Subtest basic-crc-vgem: SUCCESS (1.006s)
[336.362215] [055/133] (686s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[336.483772] Starting subtest: extended-modeset-hang-newfb-with-reset
[336.484726] Starting dynamic subtest: pipe-A
[350.650151] Dynamic subtest pipe-A: SUCCESS (14.164s)
[350.662566] Starting dynamic subtest: pipe-D
[366.125615] Dynamic subtest pipe-D: SUCCESS (15.470s)
[366.126598] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.641s)
[366.919595] [056/133] (655s left) kms_hdr (static-swap)
[367.003351] Starting subtest: static-swap
[367.006079] Subtest static-swap: SKIP (0.000s)
[367.086409] [057/133] (655s left) kms_content_protection (type1)
[367.219429] Starting subtest: type1
[367.221958] Subtest type1: SKIP (0.000s)
[367.349305] [058/133] (655s left) gem_flink_basic (double-flink)
[367.401078] Starting subtest: double-flink
[367.402152] Subtest double-flink: SUCCESS (0.000s)
[367.495539] [059/133] (655s left) gem_tiled_swapping (non-threaded)
[367.537274] Subtest non-threaded: SKIP (0.000s)
[367.602524] [060/133] (655s left) gem_render_copy (yf-tiled)
[367.648725] Starting subtest: yf-tiled
[367.650708] Subtest yf-tiled: SKIP (0.000s)
[367.826863] [061/133] (655s left) gem_exec_balancer (semaphore)
[367.879604] Starting subtest: semaphore
[369.293870] Subtest semaphore: SUCCESS (1.403s)
[369.624139] [062/133] (653s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[369.677566] Starting subtest: y-tiled-to-vebox-x-tiled
[369.679394] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[369.875248] [063/133] (653s left) gem_exec_fence (syncobj-timeline-wait)
[370.426128] Starting subtest: syncobj-timeline-wait
[371.311707] Subtest syncobj-timeline-wait: SUCCESS (0.886s)
[373.430152] [064/133] (649s left) kms_flip (dpms-vs-vblank-race)
[373.515257] Starting subtest: dpms-vs-vblank-race
[373.517445] Starting dynamic subtest: A-eDP1
[377.403423] Dynamic subtest A-eDP1: SUCCESS (3.886s)
[377.412523] Starting dynamic subtest: B-eDP1
[382.042243] Dynamic subtest B-eDP1: SUCCESS (4.637s)
[382.052812] Starting dynamic subtest: C-eDP1
[386.661596] Dynamic subtest C-eDP1: SUCCESS (4.618s)
[386.670501] Starting dynamic subtest: D-eDP1
[391.307780] Dynamic subtest D-eDP1: SUCCESS (4.643s)
[391.310398] Subtest dpms-vs-vblank-race: SUCCESS (17.795s)
[392.177877] [065/133] (630s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[392.228409] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[392.347198] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[392.413023] [066/133] (630s left) syncobj_timeline (invalid-transfer-bad-pad)
[392.452657] Starting subtest: invalid-transfer-bad-pad
[392.453627] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[392.535686] [067/133] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[392.627624] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[399.219409] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.592s)
[399.350452] [068/133] (623s left) kms_color (ctm-max)
[399.443132] Starting subtest: ctm-max
[399.443902] Starting dynamic subtest: pipe-A-eDP-1
[400.152574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[400.161203] Starting dynamic subtest: pipe-B-eDP-1
[401.537311] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[401.545888] Starting dynamic subtest: pipe-C-eDP-1
[402.905130] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[402.913724] Starting dynamic subtest: pipe-D-eDP-1
[404.247443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[404.248387] Subtest ctm-max: SUCCESS (4.804s)
[405.036877] [069/133] (618s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[405.131509] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[405.133365] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[405.197549] [070/133] (617s left) gem_eio (hibernate)
[405.414875] Starting subtest: hibernate
[420.348810] Subtest hibernate: SUCCESS (14.934s)
[429.531857] [071/133] (602s left) gem_wait (write-wait)
[429.601030] Starting subtest: write-wait
[429.602454] Starting dynamic subtest: all-engines
[430.683495] Dynamic subtest all-engines: SUCCESS (1.082s)
[430.701896] Starting dynamic subtest: rcs0
[431.739255] Dynamic subtest rcs0: SUCCESS (1.053s)
[431.758645] Starting dynamic subtest: bcs0
[432.797996] Dynamic subtest bcs0: SUCCESS (1.057s)
[432.816064] Starting dynamic subtest: vcs0
[433.852152] Dynamic subtest vcs0: SUCCESS (1.052s)
[433.871642] Starting dynamic subtest: vcs1
[434.905631] Dynamic subtest vcs1: SUCCESS (1.051s)
[434.923829] Starting dynamic subtest: vecs0
[435.958322] Dynamic subtest vecs0: SUCCESS (1.050s)
[435.977370] Starting dynamic subtest: ccs0
[437.015067] Dynamic subtest ccs0: SUCCESS (1.055s)
[437.017753] Subtest write-wait: SUCCESS (7.415s)
[437.208871] [072/133] (595s left) kms_async_flips (async-flip-dpms)
[437.302346] Starting subtest: async-flip-dpms
[437.677977] Starting dynamic subtest: pipe-A-eDP-1
[441.562577] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.884s)
[441.956205] Starting dynamic subtest: pipe-B-eDP-1
[444.838990] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.891s)
[445.239951] Starting dynamic subtest: pipe-C-eDP-1
[448.009949] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.781s)
[448.393956] Starting dynamic subtest: pipe-D-eDP-1
[451.177596] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.792s)
[451.178560] Subtest async-flip-dpms: SUCCESS (13.875s)
[452.346179] [073/133] (579s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[452.437329] Starting subtest: primary-yf-tiled-reflect-x-270
[452.439019] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[452.507140] [074/133] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[452.602115] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[452.603866] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[452.724438] [075/133] (579s left) gem_exec_fence (syncobj-invalid-flags)
[453.128213] Starting subtest: syncobj-invalid-flags
[453.129450] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[454.400759] [076/133] (578s left) perf (non-zero-reason)
[454.529526] Starting subtest: non-zero-reason
[454.530845] Starting dynamic subtest: 0-rcs0
[460.226606] Dynamic subtest 0-rcs0: SUCCESS (5.659s)
[460.239980] Starting dynamic subtest: 1-vecs0
[464.237777] Dynamic subtest 1-vecs0: SUCCESS (4.046s)
[464.239137] Subtest non-zero-reason: SUCCESS (9.707s)
[464.277068] [077/133] (568s left) i915_pm_freq_api (freq-basic-api)
[464.340502] Starting subtest: freq-basic-api
[464.341628] Starting dynamic subtest: gt0
[464.346265] Dynamic subtest gt0: SUCCESS (0.005s)
[464.357496] Starting dynamic subtest: gt1
[464.358450] Dynamic subtest gt1: SUCCESS (0.003s)
[464.359365] Subtest freq-basic-api: SUCCESS (0.010s)
[464.462304] [078/133] (568s left) gem_mmap_gtt (ptrace)
[464.516836] Subtest ptrace: SKIP (0.000s)
[464.578548] [079/133] (567s left) kms_pipe_crc_basic (suspend-read-crc)
[464.670199] Starting subtest: suspend-read-crc
[464.671086] Starting dynamic subtest: pipe-A-eDP-1
[482.937383] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.979s)
[482.951484] Starting dynamic subtest: pipe-B-eDP-1
[501.942219] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.472s)
[501.955050] Starting dynamic subtest: pipe-C-eDP-1
[520.905178] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.478s)
[520.916232] Starting dynamic subtest: pipe-D-eDP-1
[539.905145] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.421s)
[539.906524] Subtest suspend-read-crc: SUCCESS (13.357s)
[546.745864] [080/133] (491s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[546.858027] Starting subtest: 4-tiled-64bpp-rotate-90
[546.879303] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[546.991631] [081/133] (491s left) gem_partial_pwrite_pread (reads-uncached)
[547.040429] Subtest reads-uncached: SKIP (0.000s)
[547.111109] [082/133] (491s left) sysfs_heartbeat_interval (precise)
[547.159883] Starting subtest: precise
[547.161077] Starting dynamic subtest: vecs0
[555.152197] Dynamic subtest vecs0: SUCCESS (7.868s)
[555.165945] Starting dynamic subtest: ccs0
[556.269679] Dynamic subtest ccs0: SUCCESS (1.103s)
[556.282067] Starting dynamic subtest: vcs0
[564.185825] Dynamic subtest vcs0: SUCCESS (7.868s)
[564.198075] Starting dynamic subtest: bcs0
[565.282315] Dynamic subtest bcs0: SUCCESS (1.100s)
[565.296180] Starting dynamic subtest: rcs0
[566.370230] Dynamic subtest rcs0: SUCCESS (1.084s)
[566.381658] Starting dynamic subtest: vcs1
[574.225906] Dynamic subtest vcs1: SUCCESS (7.842s)
[574.227188] Subtest precise: SUCCESS (26.876s)
[574.301152] [083/133] (464s left) gem_ctx_exec (basic-close-race)
[574.351961] Starting subtest: basic-close-race
[580.420551] Subtest basic-close-race: SUCCESS (6.017s)
[580.498446] [084/133] (458s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[580.820213] Starting subtest: cursor-rapid-movement-max-size
[580.823947] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[580.939439] [085/133] (457s left) kms_psr (pr-no-drrs)
[581.034488] Starting subtest: pr-no-drrs
[581.037170] Subtest pr-no-drrs: SKIP (0.000s)
[581.102833] [086/133] (457s left) gem_userptr_blits (process-exit-busy)
[581.160431] Starting subtest: process-exit-busy
[581.172066] Subtest process-exit-busy: SUCCESS (0.011s)
[581.294957] [087/133] (457s left) gem_ctx_persistence (engines-mixed-process)
[581.355523] Starting subtest: engines-mixed-process
[581.357067] Starting dynamic subtest: rcs0
[583.178337] Dynamic subtest rcs0: SUCCESS (1.823s)
[583.191526] Starting dynamic subtest: bcs0
[585.169884] Dynamic subtest bcs0: SUCCESS (1.990s)
[585.181341] Starting dynamic subtest: vcs0
[587.227632] Dynamic subtest vcs0: SUCCESS (2.057s)
[587.241390] Starting dynamic subtest: vcs1
[589.209346] Dynamic subtest vcs1: SUCCESS (1.980s)
[589.223347] Starting dynamic subtest: vecs0
[591.188538] Dynamic subtest vecs0: SUCCESS (1.977s)
[591.201094] Starting dynamic subtest: ccs0
[593.231567] Dynamic subtest ccs0: SUCCESS (2.043s)
[593.232963] Subtest engines-mixed-process: SUCCESS (11.876s)
[593.308174] [088/133] (445s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[593.412888] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[593.415236] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[593.512445] [089/133] (445s left) kms_psr (psr-cursor-mmap-cpu)
[593.599350] Starting subtest: psr-cursor-mmap-cpu
[593.600562] Starting dynamic subtest: eDP-1
[595.313313] Dynamic subtest eDP-1: SUCCESS (1.712s)
[595.314665] Subtest psr-cursor-mmap-cpu: SUCCESS (1.713s)
[596.179352] [090/133] (442s left) gem_exec_schedule (preempt-self)
[596.244008] Starting subtest: preempt-self
[596.245238] Starting dynamic subtest: rcs0
[596.268409] Dynamic subtest rcs0: SUCCESS (0.024s)
[596.281061] Starting dynamic subtest: bcs0
[596.288620] Dynamic subtest bcs0: SUCCESS (0.019s)
[596.298518] Starting dynamic subtest: vcs0
[596.309224] Dynamic subtest vcs0: SUCCESS (0.020s)
[596.319190] Starting dynamic subtest: vcs1
[596.329627] Dynamic subtest vcs1: SUCCESS (0.020s)
[596.339583] Starting dynamic subtest: vecs0
[596.348411] Dynamic subtest vecs0: SUCCESS (0.018s)
[596.358438] Starting dynamic subtest: ccs0
[596.370145] Dynamic subtest ccs0: SUCCESS (0.021s)
[596.371614] Subtest preempt-self: SUCCESS (0.127s)
[598.312040] [091/133] (440s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[598.356204] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[598.461389] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[598.539986] [092/133] (440s left) kms_flip (flip-vs-absolute-wf_vblank)
[598.619510] Starting subtest: flip-vs-absolute-wf_vblank
[598.620993] Starting dynamic subtest: A-eDP1
[607.531419] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[607.545148] Starting dynamic subtest: B-eDP1
[616.456880] Dynamic subtest B-eDP1: SUCCESS (8.920s)
[616.468930] Starting dynamic subtest: C-eDP1
[625.419550] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[625.430170] Starting dynamic subtest: D-eDP1
[634.358521] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[634.359951] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.696s)
[635.543477] [093/133] (403s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[635.626870] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[635.628080] Starting dynamic subtest: pipe-A
[636.878937] Dynamic subtest pipe-A: SUCCESS (1.252s)
[636.889289] Starting dynamic subtest: pipe-B
[639.200139] Dynamic subtest pipe-B: SUCCESS (2.319s)
[639.210408] Starting dynamic subtest: pipe-C
[640.370630] Dynamic subtest pipe-C: SUCCESS (1.169s)
[640.380632] Starting dynamic subtest: pipe-D
[641.596971] Dynamic subtest pipe-D: SUCCESS (1.225s)
[641.598018] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.969s)
[642.799052] [094/133] (396s left) sw_sync (sync_multi_consumer_producer)
[642.837947] Starting subtest: sync_multi_consumer_producer
[643.291638] Subtest sync_multi_consumer_producer: SUCCESS (0.445s)
[643.345218] [095/133] (395s left) gem_readwrite (write-bad-handle)
[643.390452] Subtest write-bad-handle: SKIP (0.000s)
[643.447130] [096/133] (395s left) kms_chamelium_color (ctm-limited-range)
[643.527630] Subtest ctm-limited-range: SKIP (0.000s)
[643.568997] [097/133] (395s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[643.649711] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[643.651482] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[643.741960] [098/133] (395s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[643.834944] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[643.836019] Starting dynamic subtest: pipe-A-eDP-1
[643.855349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[643.865527] Starting dynamic subtest: pipe-B-eDP-1
[643.876211] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[643.887116] Starting dynamic subtest: pipe-C-eDP-1
[643.897914] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[643.907922] Starting dynamic subtest: pipe-D-eDP-1
[643.919506] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[643.920931] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[646.144152] [099/133] (393s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[646.531537] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[647.357301] [100/133] (392s left) kms_sequence (get-forked)
[647.447910] Starting subtest: get-forked
[647.448817] Starting dynamic subtest: pipe-A-eDP-1
[649.315981] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.868s)
[649.326370] Starting dynamic subtest: pipe-B-eDP-1
[651.826555] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.511s)
[651.837966] Starting dynamic subtest: pipe-C-eDP-1
[654.382616] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.554s)
[654.395169] Starting dynamic subtest: pipe-D-eDP-1
[656.855246] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.472s)
[656.856413] Subtest get-forked: SUCCESS (9.412s)
[657.699707] [101/133] (381s left) gem_lmem_swapping (heavy-verify-multi)
[657.740633] Subtest heavy-verify-multi: SKIP (0.000s)
[657.787606] [102/133] (381s left) api_intel_bb (intel-bb-blit-y)
[657.830576] Starting subtest: intel-bb-blit-y
[661.381200] Subtest intel-bb-blit-y: SUCCESS (3.542s)
[661.507107] [103/133] (377s left) kms_cursor_crc (cursor-tearing-position-change)
[661.630121] Starting subtest: cursor-tearing-position-change
[661.631252] Starting dynamic subtest: pipe-A-eDP-1
[662.212918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s)
[662.223615] Starting dynamic subtest: pipe-D-eDP-1
[663.449315] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[663.450649] Subtest cursor-tearing-position-change: SUCCESS (1.818s)
[664.279024] [104/133] (375s left) i915_suspend (fence-restore-untiled)
[664.335210] Starting subtest: fence-restore-untiled
[664.337306] Subtest fence-restore-untiled: SKIP (0.000s)
[664.435338] [105/133] (375s left) kms_addfb_basic (addfb25-modifier-no-flag)
[664.524403] Starting subtest: addfb25-modifier-no-flag
[664.525670] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[664.614244] [106/133] (374s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[664.700236] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[664.705144] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[664.806190] [107/133] (374s left) kms_chamelium_hpd (vga-hpd)
[665.182129] Subtest vga-hpd: SKIP (0.000s)
[665.983882] [108/133] (373s left) drm_read (short-buffer-wakeup)
[666.121252] Starting subtest: short-buffer-wakeup
[698.347888] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[698.482666] [109/133] (341s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[698.577209] Starting subtest: y-tiled-32bpp-rotate-90
[698.579077] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[698.667798] [110/133] (341s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[698.761927] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[698.764256] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[698.859331] [111/133] (340s left) i915_drm_fdinfo (most-busy-check-all)
[698.895436] Starting subtest: most-busy-check-all
[698.896847] Starting dynamic subtest: rcs0
[698.900076] Dynamic subtest rcs0: SKIP (0.004s)
[698.913885] Starting dynamic subtest: bcs0
[698.915499] Dynamic subtest bcs0: SKIP (0.000s)
[698.925859] Starting dynamic subtest: vcs0
[698.928077] Dynamic subtest vcs0: SKIP (0.000s)
[698.939036] Starting dynamic subtest: vcs1
[698.941237] Dynamic subtest vcs1: SKIP (0.000s)
[698.951098] Starting dynamic subtest: vecs0
[698.953243] Dynamic subtest vecs0: SKIP (0.000s)
[698.962999] Starting dynamic subtest: ccs0
[698.965185] Dynamic subtest ccs0: SKIP (0.001s)
[698.967076] Subtest most-busy-check-all: SKIP (0.011s)
[699.001877] [112/133] (340s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[699.112280] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[705.965160] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.852s)
[706.097035] [113/133] (333s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[706.184418] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[706.186198] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[706.278631] [114/133] (333s left) perf (polling-small-buf)
[706.361311] Starting subtest: polling-small-buf
[706.449448] Subtest polling-small-buf: SUCCESS (0.087s)
[706.495833] [115/133] (333s left) kms_plane_multiple (tiling-x)
[706.581970] Starting subtest: tiling-x
[706.582911] Starting dynamic subtest: pipe-A-eDP-1
[710.294038] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.711s)
[710.304161] Starting dynamic subtest: pipe-B-eDP-1
[714.830252] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.534s)
[714.842365] Starting dynamic subtest: pipe-C-eDP-1
[719.145366] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.312s)
[719.155836] Starting dynamic subtest: pipe-D-eDP-1
[723.513907] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.366s)
[723.514965] Subtest tiling-x: SUCCESS (16.928s)
[724.328814] [116/133] (315s left) gen9_exec_parse (bb-start-cmd)
[724.380856] Subtest bb-start-cmd: SKIP (0.000s)
[724.441279] [117/133] (315s left) kms_cursor_crc (cursor-offscreen-512x512)
[724.708605] Starting subtest: cursor-offscreen-512x512
[724.710990] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[724.857758] [118/133] (315s left) gem_ctx_shared (create-shared-gtt)
[724.914619] Starting subtest: create-shared-gtt
[727.066965] Subtest create-shared-gtt: SUCCESS (2.151s)
[727.397993] [119/133] (312s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[727.493291] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[727.504111] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[727.578404] [120/133] (312s left) kms_dp_linktrain_fallback (dsc-fallback)
[727.667933] Starting subtest: dsc-fallback
[727.670763] Subtest dsc-fallback: SKIP (0.000s)
[727.740460] [121/133] (312s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[727.827459] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[727.828469] Starting dynamic subtest: pipe-A-eDP-1
[727.838087] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[727.848347] Starting dynamic subtest: pipe-B-eDP-1
[727.858780] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[727.869368] Starting dynamic subtest: pipe-C-eDP-1
[727.879148] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[727.890091] Starting dynamic subtest: pipe-D-eDP-1
[727.899863] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[727.901493] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[730.109395] [122/133] (310s left) syncobj_wait (single-wait-all-submitted)
[730.161921] Starting subtest: single-wait-all-submitted
[730.269818] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[730.358176] [123/133] (309s left) kms_atomic (atomic-invalid-params)
[730.446178] Starting subtest: atomic-invalid-params
[730.447419] Starting dynamic subtest: pipe-A-eDP-1
[730.844699] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[730.846119] Subtest atomic-invalid-params: SUCCESS (0.400s)
[731.639581] [124/133] (308s left) perf_pmu (all-busy-check-all)
[731.684830] Starting subtest: all-busy-check-all
[733.211115] Subtest all-busy-check-all: SUCCESS (1.523s)
[733.304474] [125/133] (306s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[733.387926] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[733.389617] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[733.479146] [126/133] (306s left) kms_lease (lease-invalid-connector)
[733.562984] Starting subtest: lease-invalid-connector
[733.564150] Starting dynamic subtest: pipe-A-eDP-1
[733.565184] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[733.575648] Starting dynamic subtest: pipe-B-eDP-1
[733.576907] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[733.587439] Starting dynamic subtest: pipe-C-eDP-1
[733.588653] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[733.598645] Starting dynamic subtest: pipe-D-eDP-1
[733.600049] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[733.601150] Subtest lease-invalid-connector: SUCCESS (0.005s)
[733.637878] [127/133] (306s left) gem_madvise (dontneed-after-mmap)
[733.676457] Starting subtest: dontneed-after-mmap
[733.694474] Subtest dontneed-after-mmap: SUCCESS (0.018s)
[733.804468] [128/133] (306s left) kms_flip (flip-vs-suspend-interruptible)
[733.895673] Starting subtest: flip-vs-suspend-interruptible
[733.896903] Starting dynamic subtest: A-eDP1
[847.052076] Dynamic subtest A-eDP1: SUCCESS (11.631s)
[847.053672] Subtest flip-vs-suspend-interruptible: SUCCESS (11.633s)
[853.177801] [129/133] (193s left) kms_vblank (wait-forked-busy)
[853.263209] Starting subtest: wait-forked-busy
[853.264523] Starting dynamic subtest: pipe-A-eDP-1
[855.141868] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[855.154497] Starting dynamic subtest: pipe-D-eDP-1
[857.672518] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.530s)
[857.673879] Subtest wait-forked-busy: SUCCESS (4.416s)
[858.473851] [130/133] (188s left) kms_big_fb (linear-32bpp-rotate-180)
[858.664712] Starting subtest: linear-32bpp-rotate-180
[860.366848] Subtest linear-32bpp-rotate-180: SUCCESS (1.705s)
[860.487285] [131/133] (186s left) gen3_render_tiledx_blits
[860.597671] [132/133] (185s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[860.676844] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[867.889777] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.216s)
[868.010735] [133/133] (178s left) kms_plane_scaling (planes-scaler-unity-scaling)
[868.101609] Starting subtest: planes-scaler-unity-scaling
[868.102950] Starting dynamic subtest: pipe-A
[868.165141] Dynamic subtest pipe-A: SUCCESS (0.064s)
[868.181597] Starting dynamic subtest: pipe-B
[869.315551] Dynamic subtest pipe-B: SUCCESS (1.150s)
[869.326001] Starting dynamic subtest: pipe-C
[870.441257] Dynamic subtest pipe-C: SUCCESS (1.125s)
[870.452516] Starting dynamic subtest: pipe-D
[871.573894] Dynamic subtest pipe-D: SUCCESS (1.132s)
[871.575029] Subtest planes-scaler-unity-scaling: SUCCESS (3.474s)
[872.728015] 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.