[55.765099] Initializing watchdogs
[55.765145]   /dev/watchdog0
[55.779613] [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]
[55.783908] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.786181] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.789586] [001/133] (960s left) gem_busy (extended)
[56.006897] Starting subtest: extended
[56.009411] Starting dynamic subtest: rcs0
[56.100941] Dynamic subtest rcs0: SUCCESS (0.093s)
[56.111711] Starting dynamic subtest: bcs0
[56.145773] Dynamic subtest bcs0: SUCCESS (0.043s)
[56.155876] Starting dynamic subtest: vcs0
[57.278457] Dynamic subtest vcs0: SUCCESS (1.115s)
[57.289983] Starting dynamic subtest: vcs1
[59.325245] Dynamic subtest vcs1: SUCCESS (2.023s)
[59.335925] Starting dynamic subtest: vecs0
[61.307631] Dynamic subtest vecs0: SUCCESS (1.966s)
[61.316360] Starting dynamic subtest: ccs0
[61.353825] Dynamic subtest ccs0: SUCCESS (0.046s)
[61.356938] Subtest extended: SUCCESS (5.295s)
[61.593782] [002/133] (954s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[61.697811] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[61.700136] Starting dynamic subtest: pipe-A-eDP-1
[61.723102] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.732179] Starting dynamic subtest: pipe-B-eDP-1
[61.754047] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.761085] Starting dynamic subtest: pipe-C-eDP-1
[61.782306] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.789222] Starting dynamic subtest: pipe-D-eDP-1
[61.810142] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.814101] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[64.170921] [003/133] (952s left) kms_frontbuffer_tracking (psr-2p-rte)
[64.268908] Starting subtest: psr-2p-rte
[64.272968] Subtest psr-2p-rte: SKIP (0.000s)
[64.370903] [004/133] (952s left) syncobj_wait (reset-during-wait-for-submit)
[64.431657] Starting subtest: reset-during-wait-for-submit
[64.536384] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[64.622173] [005/133] (951s left) gem_fenced_exec_thrash (too-many-fences)
[64.686993] Subtest too-many-fences: SKIP (0.000s)
[64.749827] [006/133] (951s left) gem_tiled_fence_blits (basic)
[64.815790] Subtest basic: SKIP (0.000s)
[64.901909] [007/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[64.999278] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[72.381620] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.367s)
[72.729734] [008/133] (943s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[72.930486] Starting subtest: psr-rgb101010-draw-render
[80.227840] Subtest psr-rgb101010-draw-render: SUCCESS (7.296s)
[80.351715] [009/133] (936s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[80.462182] Starting subtest: x-tiled-64bpp-rotate-90
[80.482926] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[80.592441] [010/133] (936s left) gem_eio (wait-1us)
[80.742952] Starting subtest: wait-1us
[80.951594] Subtest wait-1us: SUCCESS (0.209s)
[81.086666] [011/133] (935s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[81.166829] Starting subtest: fbc-psr-sprite-mmap-cpu
[81.168876] Starting dynamic subtest: eDP-1
[81.172545] Dynamic subtest eDP-1: SKIP (0.000s)
[81.176253] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[81.237369] [012/133] (935s left) gem_exec_schedule (manyslice)
[81.302893] Starting subtest: manyslice
[81.304623] Starting dynamic subtest: rcs0
[86.947026] Dynamic subtest rcs0: SUCCESS (5.647s)
[86.959604] Starting dynamic subtest: bcs0
[93.588220] Dynamic subtest bcs0: SUCCESS (6.639s)
[93.603184] Starting dynamic subtest: vcs0
[99.672122] Dynamic subtest vcs0: SUCCESS (6.081s)
[99.684679] Starting dynamic subtest: vcs1
[105.250790] Dynamic subtest vcs1: SUCCESS (5.577s)
[105.262010] Starting dynamic subtest: vecs0
[110.823360] Dynamic subtest vecs0: SUCCESS (5.570s)
[110.838450] Starting dynamic subtest: ccs0
[117.524676] Dynamic subtest ccs0: SUCCESS (6.698s)
[117.526857] Subtest manyslice: SUCCESS (36.217s)
[117.835138] [013/133] (898s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[117.896190] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[117.898541] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[118.001710] [014/133] (898s left) gem_exec_schedule (wide)
[118.182304] Starting subtest: wide
[118.184910] Starting dynamic subtest: rcs0
[129.269837] Dynamic subtest rcs0: SUCCESS (11.086s)
[129.281938] Starting dynamic subtest: vcs0
[142.148931] Dynamic subtest vcs0: SUCCESS (12.878s)
[142.159883] Starting dynamic subtest: vcs1
[153.622339] Dynamic subtest vcs1: SUCCESS (11.472s)
[153.634558] Starting dynamic subtest: vecs0
[164.481322] Dynamic subtest vecs0: SUCCESS (10.857s)
[164.493723] Starting dynamic subtest: ccs0
[177.519662] Dynamic subtest ccs0: SUCCESS (13.035s)
[177.523270] Subtest wide: SUCCESS (59.331s)
[178.712132] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[178.716512] [015/133] (838s left) kms_addfb_basic (small-bo)
[178.816071] Starting subtest: small-bo
[178.818150] Subtest small-bo: SUCCESS (0.000s)
[178.919938] [016/133] (837s left) gem_exec_balancer (full-late)
[178.978020] Starting subtest: full-late
[184.149210] Subtest full-late: SUCCESS (5.171s)
[184.466389] [017/133] (832s left) kms_pm_backlight (brightness-with-dpms)
[184.557951] Starting subtest: brightness-with-dpms
[184.636596] Starting dynamic subtest: eDP-1
[187.064083] Dynamic subtest eDP-1: SUCCESS (2.427s)
[187.066527] Subtest brightness-with-dpms: SUCCESS (2.508s)
[187.930881] [018/133] (829s left) api_intel_allocator (fork-simple-once)
[187.983891] Starting subtest: fork-simple-once
[187.999457] Subtest fork-simple-once: SUCCESS (0.016s)
[188.134574] [019/133] (828s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[188.244228] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[188.248190] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[188.322672] [020/133] (828s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[188.409461] Starting subtest: psr2-plane-move-sf-dmg-area
[188.411713] Starting dynamic subtest: pipe-A-eDP-1
[192.988444] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.581s)
[192.999059] Starting dynamic subtest: pipe-B-eDP-1
[198.330334] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.339s)
[198.332322] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.923s)
[199.206120] [021/133] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[199.310605] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[202.880863] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.574s)
[204.020759] [022/133] (813s left) kms_frontbuffer_tracking (fbc-2p-rte)
[204.114466] Starting subtest: fbc-2p-rte
[204.119084] Subtest fbc-2p-rte: SKIP (0.000s)
[204.199687] [023/133] (812s left) gem_exec_reloc (basic-cpu-wc)
[204.261248] Subtest basic-cpu-wc: SKIP (0.000s)
[204.328282] [024/133] (812s left) gem_tiled_blits (normal)
[204.396062] Subtest normal: SKIP (0.000s)
[204.475986] [025/133] (812s left) syncobj_timeline (wait-all-for-submit-complex)
[204.521737] Starting subtest: wait-all-for-submit-complex
[204.737782] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[204.811027] [026/133] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[204.916896] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[204.921836] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[205.021190] [027/133] (812s left) kms_dsc (dsc-with-output-formats-with-bpc)
[205.118079] Starting subtest: dsc-with-output-formats-with-bpc
[205.176236] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[205.215185] [028/133] (812s left) gem_exec_flush (basic-wb-rw-default)
[205.283276] Starting subtest: basic-wb-rw-default
[210.736125] Subtest basic-wb-rw-default: SUCCESS (5.454s)
[210.931141] [029/133] (806s left) kms_joiner (basic-big-joiner)
[211.026302] Starting subtest: basic-big-joiner
[211.030398] Subtest basic-big-joiner: SKIP (0.000s)
[211.119275] [030/133] (806s left) perf_pmu (render-node-busy-idle)
[211.186316] Starting subtest: render-node-busy-idle
[211.188671] Starting dynamic subtest: rcs0
[211.870793] Dynamic subtest rcs0: SUCCESS (0.687s)
[211.880743] Starting dynamic subtest: bcs0
[212.537749] Dynamic subtest bcs0: SUCCESS (0.666s)
[212.549910] Starting dynamic subtest: vcs0
[214.267724] Dynamic subtest vcs0: SUCCESS (1.726s)
[214.280945] Starting dynamic subtest: vcs1
[216.314605] Dynamic subtest vcs1: SUCCESS (2.045s)
[216.324960] Starting dynamic subtest: vecs0
[218.299428] Dynamic subtest vecs0: SUCCESS (1.982s)
[218.313781] Starting dynamic subtest: ccs0
[218.972784] Dynamic subtest ccs0: SUCCESS (0.673s)
[218.975830] Subtest render-node-busy-idle: SUCCESS (7.789s)
[219.050806] [031/133] (798s left) kms_addfb_basic (invalid-get-prop)
[219.099393] Starting subtest: invalid-get-prop
[219.101758] Subtest invalid-get-prop: SUCCESS (0.000s)
[219.229827] [032/133] (798s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[219.319487] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[219.323700] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[219.448190] [033/133] (798s left) i915_pm_rps (thresholds)
[219.502814] Starting subtest: thresholds
[219.507114] Subtest thresholds: SKIP (0.001s)
[219.574834] [034/133] (798s left) gem_mmap_wc (bad-offset)
[219.625375] Subtest bad-offset: SKIP (0.000s)
[219.684972] [035/133] (797s left) kms_rotation_crc (multiplane-rotation)
[219.767880] Starting subtest: multiplane-rotation
[237.271464] Subtest multiplane-rotation: SUCCESS (17.504s)
[237.390993] [036/133] (780s left) gem_softpin (evict-prime-sanity-check)
[237.441064] Starting subtest: evict-prime-sanity-check
[237.443064] Starting dynamic subtest: rcs0
[238.584692] Dynamic subtest rcs0: SUCCESS (1.143s)
[238.594704] Starting dynamic subtest: bcs0
[239.689574] Dynamic subtest bcs0: SUCCESS (1.104s)
[239.699740] Starting dynamic subtest: vcs0
[241.249450] Dynamic subtest vcs0: SUCCESS (1.557s)
[241.261133] Starting dynamic subtest: vcs1
[243.252501] Dynamic subtest vcs1: SUCCESS (2.001s)
[243.264145] Starting dynamic subtest: vecs0
[245.217489] Dynamic subtest vecs0: SUCCESS (1.963s)
[245.228106] Starting dynamic subtest: ccs0
[246.387068] Dynamic subtest ccs0: SUCCESS (1.169s)
[246.399508] Starting dynamic subtest: all
[247.527317] Dynamic subtest all: SUCCESS (1.138s)
[247.529856] Subtest evict-prime-sanity-check: SUCCESS (10.086s)
[247.609554] [037/133] (770s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[247.714346] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[247.718360] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[247.795920] [038/133] (770s left) kms_flip (flip-vs-expired-vblank-interruptible)
[247.902480] Starting subtest: flip-vs-expired-vblank-interruptible
[247.904372] Starting dynamic subtest: A-eDP1
[256.603439] Dynamic subtest A-eDP1: SUCCESS (8.699s)
[256.614280] Starting dynamic subtest: B-eDP1
[265.231728] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[265.242631] Starting dynamic subtest: C-eDP1
[273.856711] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[273.866408] Starting dynamic subtest: D-eDP1
[282.478961] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[282.481514] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.577s)
[283.652130] [039/133] (734s left) gem_ctx_shared (disjoint-timelines)
[283.714654] Starting subtest: disjoint-timelines
[283.745186] Subtest disjoint-timelines: SUCCESS (0.030s)
[283.984742] [040/133] (733s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[284.080931] Starting subtest: fbcpsr-rgb101010-draw-render
[290.819303] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.742s)
[290.941304] [041/133] (726s left) gem_exec_parallel (fds)
[291.001935] Starting subtest: fds
[291.004373] Starting dynamic subtest: rcs0
[293.870371] Dynamic subtest rcs0: SUCCESS (2.866s)
[293.882751] Starting dynamic subtest: bcs0
[297.929110] Dynamic subtest bcs0: SUCCESS (4.057s)
[297.942973] Starting dynamic subtest: vcs0
[303.370506] Dynamic subtest vcs0: SUCCESS (5.438s)
[303.381337] Starting dynamic subtest: vcs1
[307.600353] Dynamic subtest vcs1: SUCCESS (4.227s)
[307.613245] Starting dynamic subtest: vecs0
[311.528367] Dynamic subtest vecs0: SUCCESS (3.925s)
[311.538213] Starting dynamic subtest: ccs0
[315.512571] Dynamic subtest ccs0: SUCCESS (3.981s)
[315.515319] Subtest fds: SUCCESS (24.510s)
[315.711047] [042/133] (702s left) gem_readwrite (new-obj)
[315.776057] Subtest new-obj: SKIP (0.000s)
[315.842814] [043/133] (702s left) gem_mmap_wc (fault-concurrent)
[315.902428] Subtest fault-concurrent: SKIP (0.000s)
[315.964732] [044/133] (702s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[316.066073] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[317.189960] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.124s)
[317.327549] [045/133] (700s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[317.376969] Starting subtest: multi-wait-for-submit-available-signaled
[317.379758] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[317.464646] [046/133] (700s left) gem_exec_fence (basic-busy-all)
[317.520677] Starting subtest: basic-busy-all
[317.610639] Subtest basic-busy-all: SUCCESS (0.090s)
[319.370094] [047/133] (698s left) gem_lmem_swapping (parallel-random-verify-ccs)
[319.410092] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[319.452119] [048/133] (698s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[319.554275] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[319.556606] Starting dynamic subtest: pipe-A-eDP-1
[319.581413] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.592646] Starting dynamic subtest: pipe-B-eDP-1
[319.614276] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.624287] Starting dynamic subtest: pipe-C-eDP-1
[319.646607] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.656825] Starting dynamic subtest: pipe-D-eDP-1
[319.679370] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.683752] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[321.766535] [049/133] (696s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[321.856958] Starting subtest: pr-plane-move-sf-dmg-area
[321.861185] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[321.924390] [050/133] (696s left) kms_psr (fbc-psr2-sprite-blt)
[322.011394] Starting subtest: fbc-psr2-sprite-blt
[322.013689] Starting dynamic subtest: eDP-1
[322.017793] Dynamic subtest eDP-1: SKIP (0.000s)
[322.021972] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[322.085178] [051/133] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[322.187522] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[329.090234] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.904s)
[329.252151] [052/133] (689s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[329.368868] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[329.373253] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[329.469989] [053/133] (688s left) gem_eio (wait-10ms)
[329.687672] Starting subtest: wait-10ms
[330.029680] Subtest wait-10ms: SUCCESS (0.342s)
[330.171721] [054/133] (688s left) kms_prime (basic-crc-vgem)
[330.250318] Starting subtest: basic-crc-vgem
[330.252260] Starting dynamic subtest: second-to-first
[331.225061] Dynamic subtest second-to-first: SUCCESS (0.978s)
[331.226964] Subtest basic-crc-vgem: SUCCESS (0.979s)
[331.320850] [055/133] (687s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[331.468131] Starting subtest: extended-modeset-hang-newfb-with-reset
[331.470107] Starting dynamic subtest: pipe-A
[345.401568] Dynamic subtest pipe-A: SUCCESS (13.931s)
[345.413490] Starting dynamic subtest: pipe-D
[360.982336] Dynamic subtest pipe-D: SUCCESS (15.579s)
[360.984795] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.515s)
[361.808439] [056/133] (656s left) kms_hdr (static-swap)
[361.897298] Starting subtest: static-swap
[361.903987] Subtest static-swap: SKIP (0.000s)
[361.988059] [057/133] (656s left) kms_content_protection (type1)
[362.124887] Starting subtest: type1
[362.129590] Subtest type1: SKIP (0.000s)
[362.239631] [058/133] (656s left) gem_flink_basic (double-flink)
[362.299473] Starting subtest: double-flink
[362.301374] Subtest double-flink: SUCCESS (0.000s)
[362.406945] [059/133] (656s left) gem_tiled_swapping (non-threaded)
[362.463560] Subtest non-threaded: SKIP (0.000s)
[362.525271] [060/133] (656s left) gem_render_copy (yf-tiled)
[362.581282] Starting subtest: yf-tiled
[362.585485] Subtest yf-tiled: SKIP (0.000s)
[362.761676] [061/133] (655s left) gem_exec_balancer (semaphore)
[362.821499] Starting subtest: semaphore
[364.277786] Subtest semaphore: SUCCESS (1.457s)
[364.612513] [062/133] (654s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[364.664171] Starting subtest: y-tiled-to-vebox-x-tiled
[364.669277] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[364.848351] [063/133] (653s left) gem_exec_fence (syncobj-timeline-wait)
[365.381204] Starting subtest: syncobj-timeline-wait
[366.290901] Subtest syncobj-timeline-wait: SUCCESS (0.909s)
[368.391121] [064/133] (650s left) kms_flip (dpms-vs-vblank-race)
[368.483490] Starting subtest: dpms-vs-vblank-race
[368.485804] Starting dynamic subtest: A-eDP1
[373.480051] Dynamic subtest A-eDP1: SUCCESS (4.996s)
[373.489990] Starting dynamic subtest: B-eDP1
[377.007857] Dynamic subtest B-eDP1: SUCCESS (3.526s)
[377.017971] Starting dynamic subtest: C-eDP1
[381.645905] Dynamic subtest C-eDP1: SUCCESS (4.637s)
[381.656518] Starting dynamic subtest: D-eDP1
[386.267661] Dynamic subtest D-eDP1: SUCCESS (4.619s)
[386.269650] Subtest dpms-vs-vblank-race: SUCCESS (17.787s)
[387.158842] [065/133] (631s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[387.219323] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[387.327835] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[387.415348] [066/133] (631s left) syncobj_timeline (invalid-transfer-bad-pad)
[387.470071] Starting subtest: invalid-transfer-bad-pad
[387.472344] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[387.576108] [067/133] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[387.671239] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[394.246372] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.577s)
[394.383412] [068/133] (624s left) kms_color (ctm-max)
[394.475070] Starting subtest: ctm-max
[394.477247] Starting dynamic subtest: pipe-A-eDP-1
[395.187362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[395.198173] Starting dynamic subtest: pipe-B-eDP-1
[396.607245] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[396.617804] Starting dynamic subtest: pipe-C-eDP-1
[397.991501] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[398.001740] Starting dynamic subtest: pipe-D-eDP-1
[399.318250] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[399.320629] Subtest ctm-max: SUCCESS (4.845s)
[400.126179] [069/133] (618s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[400.215078] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[400.219327] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[400.284799] [070/133] (618s left) gem_eio (hibernate)
[400.500280] Starting subtest: hibernate
[416.067650] Subtest hibernate: SUCCESS (15.568s)
[423.195934] [071/133] (602s left) gem_wait (write-wait)
[423.261792] Starting subtest: write-wait
[423.264039] Starting dynamic subtest: all-engines
[424.364424] Dynamic subtest all-engines: SUCCESS (1.102s)
[424.381928] Starting dynamic subtest: rcs0
[425.423666] Dynamic subtest rcs0: SUCCESS (1.056s)
[425.442777] Starting dynamic subtest: bcs0
[426.480839] Dynamic subtest bcs0: SUCCESS (1.055s)
[426.499450] Starting dynamic subtest: vcs0
[427.533529] Dynamic subtest vcs0: SUCCESS (1.050s)
[427.550866] Starting dynamic subtest: vcs1
[428.590726] Dynamic subtest vcs1: SUCCESS (1.054s)
[428.609075] Starting dynamic subtest: vecs0
[429.643683] Dynamic subtest vecs0: SUCCESS (1.051s)
[429.662078] Starting dynamic subtest: ccs0
[430.700592] Dynamic subtest ccs0: SUCCESS (1.054s)
[430.703531] Subtest write-wait: SUCCESS (7.439s)
[430.904150] [072/133] (595s left) kms_async_flips (async-flip-dpms)
[430.996527] Starting subtest: async-flip-dpms
[431.369474] Starting dynamic subtest: pipe-A-eDP-1
[435.156307] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.785s)
[435.552143] Starting dynamic subtest: pipe-B-eDP-1
[438.330222] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.789s)
[438.715685] Starting dynamic subtest: pipe-C-eDP-1
[441.495624] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.791s)
[441.873325] Starting dynamic subtest: pipe-D-eDP-1
[444.656130] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.791s)
[444.658655] Subtest async-flip-dpms: SUCCESS (13.661s)
[445.834533] [073/133] (580s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[445.929385] Starting subtest: primary-yf-tiled-reflect-x-270
[445.934129] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.002s)
[446.009059] [074/133] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[446.113567] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[446.117758] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[446.223519] [075/133] (580s left) gem_exec_fence (syncobj-invalid-flags)
[446.631066] Starting subtest: syncobj-invalid-flags
[446.633570] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[448.375338] [076/133] (578s left) perf (non-zero-reason)
[448.497505] Starting subtest: non-zero-reason
[448.499420] Starting dynamic subtest: 0-rcs0
[453.843229] Dynamic subtest 0-rcs0: SUCCESS (5.345s)
[453.861910] Starting dynamic subtest: 1-vcs1
[457.747069] Dynamic subtest 1-vcs1: SUCCESS (3.889s)
[457.749837] Subtest non-zero-reason: SUCCESS (9.236s)
[457.791657] [077/133] (568s left) i915_pm_freq_api (freq-basic-api)
[457.855433] Starting subtest: freq-basic-api
[457.857740] Starting dynamic subtest: gt0
[457.859633] Dynamic subtest gt0: SUCCESS (0.003s)
[457.870380] Starting dynamic subtest: gt1
[457.872627] Dynamic subtest gt1: SUCCESS (0.003s)
[457.874783] Subtest freq-basic-api: SUCCESS (0.008s)
[457.960072] [078/133] (568s left) gem_mmap_gtt (ptrace)
[458.011675] Subtest ptrace: SKIP (0.000s)
[458.085348] [079/133] (568s left) kms_pipe_crc_basic (suspend-read-crc)
[458.181041] Starting subtest: suspend-read-crc
[458.183184] Starting dynamic subtest: pipe-A-eDP-1
[475.804659] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.516s)
[475.817700] Starting dynamic subtest: pipe-B-eDP-1
[493.842002] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.210s)
[493.855850] Starting dynamic subtest: pipe-C-eDP-1
[511.788720] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.030s)
[511.800918] Starting dynamic subtest: pipe-D-eDP-1
[529.786541] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.076s)
[529.788732] Subtest suspend-read-crc: SUCCESS (11.837s)
[530.636700] [080/133] (495s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[530.763035] Starting subtest: 4-tiled-64bpp-rotate-90
[530.786091] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[530.911930] [081/133] (495s left) gem_partial_pwrite_pread (reads-uncached)
[530.976392] Subtest reads-uncached: SKIP (0.000s)
[531.045454] [082/133] (495s left) sysfs_heartbeat_interval (precise)
[531.098359] Starting subtest: precise
[531.100839] Starting dynamic subtest: vecs0
[538.898912] Dynamic subtest vecs0: SUCCESS (7.710s)
[538.914196] Starting dynamic subtest: ccs0
[539.990821] Dynamic subtest ccs0: SUCCESS (1.085s)
[540.005412] Starting dynamic subtest: vcs0
[547.850805] Dynamic subtest vcs0: SUCCESS (7.824s)
[547.864132] Starting dynamic subtest: bcs0
[548.949836] Dynamic subtest bcs0: SUCCESS (1.098s)
[548.964702] Starting dynamic subtest: rcs0
[550.082624] Dynamic subtest rcs0: SUCCESS (1.129s)
[550.093660] Starting dynamic subtest: vcs1
[557.901573] Dynamic subtest vcs1: SUCCESS (7.804s)
[557.904536] Subtest precise: SUCCESS (26.663s)
[558.004603] [083/133] (468s left) gem_ctx_exec (basic-close-race)
[558.071401] Starting subtest: basic-close-race
[564.139158] Subtest basic-close-race: SUCCESS (6.069s)
[564.268564] [084/133] (462s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[564.576005] Starting subtest: cursor-rapid-movement-max-size
[564.582662] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[564.710347] [085/133] (462s left) kms_psr (pr-no-drrs)
[564.799331] Starting subtest: pr-no-drrs
[564.803548] Subtest pr-no-drrs: SKIP (0.000s)
[564.875711] [086/133] (461s left) gem_userptr_blits (process-exit-busy)
[564.934094] Starting subtest: process-exit-busy
[564.947488] Subtest process-exit-busy: SUCCESS (0.015s)
[565.082433] [087/133] (461s left) gem_ctx_persistence (engines-mixed-process)
[565.145842] Starting subtest: engines-mixed-process
[565.148377] Starting dynamic subtest: rcs0
[566.881626] Dynamic subtest rcs0: SUCCESS (1.736s)
[566.897957] Starting dynamic subtest: bcs0
[568.897532] Dynamic subtest bcs0: SUCCESS (2.012s)
[568.912250] Starting dynamic subtest: vcs0
[570.895711] Dynamic subtest vcs0: SUCCESS (2.000s)
[570.907762] Starting dynamic subtest: vcs1
[572.882836] Dynamic subtest vcs1: SUCCESS (1.987s)
[572.896877] Starting dynamic subtest: vecs0
[574.941548] Dynamic subtest vecs0: SUCCESS (2.057s)
[574.955060] Starting dynamic subtest: ccs0
[576.910486] Dynamic subtest ccs0: SUCCESS (1.967s)
[576.912889] Subtest engines-mixed-process: SUCCESS (11.767s)
[576.993182] [088/133] (449s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[577.089207] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[577.093405] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[577.188389] [089/133] (449s left) kms_psr (psr-cursor-mmap-cpu)
[577.286849] Starting subtest: psr-cursor-mmap-cpu
[577.289066] Starting dynamic subtest: eDP-1
[578.969422] Dynamic subtest eDP-1: SUCCESS (1.681s)
[578.971721] Subtest psr-cursor-mmap-cpu: SUCCESS (1.682s)
[579.856390] [090/133] (447s left) gem_exec_schedule (preempt-self)
[579.933615] Starting subtest: preempt-self
[579.935678] Starting dynamic subtest: rcs0
[579.945384] Dynamic subtest rcs0: SUCCESS (0.019s)
[579.957786] Starting dynamic subtest: bcs0
[579.968355] Dynamic subtest bcs0: SUCCESS (0.022s)
[579.981970] Starting dynamic subtest: vcs0
[579.988674] Dynamic subtest vcs0: SUCCESS (0.020s)
[580.000932] Starting dynamic subtest: vcs1
[580.013915] Dynamic subtest vcs1: SUCCESS (0.024s)
[580.025293] Starting dynamic subtest: vecs0
[580.037629] Dynamic subtest vecs0: SUCCESS (0.023s)
[580.049384] Starting dynamic subtest: ccs0
[580.060516] Dynamic subtest ccs0: SUCCESS (0.022s)
[580.062704] Subtest preempt-self: SUCCESS (0.135s)
[581.999592] [091/133] (445s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[582.058271] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[582.164300] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[582.281702] [092/133] (444s left) kms_flip (flip-vs-absolute-wf_vblank)
[582.377598] Starting subtest: flip-vs-absolute-wf_vblank
[582.380103] Starting dynamic subtest: A-eDP1
[591.286722] Dynamic subtest A-eDP1: SUCCESS (8.907s)
[591.299954] Starting dynamic subtest: B-eDP1
[600.218513] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[600.232303] Starting dynamic subtest: C-eDP1
[609.141179] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[609.154718] Starting dynamic subtest: D-eDP1
[618.078027] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[618.080466] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.693s)
[619.301020] [093/133] (407s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[619.409257] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[619.411548] Starting dynamic subtest: pipe-A
[620.569532] Dynamic subtest pipe-A: SUCCESS (1.163s)
[620.583799] Starting dynamic subtest: pipe-B
[622.757274] Dynamic subtest pipe-B: SUCCESS (2.186s)
[622.770183] Starting dynamic subtest: pipe-C
[623.898904] Dynamic subtest pipe-C: SUCCESS (1.140s)
[623.911072] Starting dynamic subtest: pipe-D
[625.125861] Dynamic subtest pipe-D: SUCCESS (1.226s)
[625.128152] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.719s)
[626.329438] [094/133] (400s left) sw_sync (sync_multi_consumer_producer)
[626.370476] Starting subtest: sync_multi_consumer_producer
[626.658521] Subtest sync_multi_consumer_producer: SUCCESS (0.288s)
[626.726197] [095/133] (400s left) gem_readwrite (write-bad-handle)
[626.784587] Subtest write-bad-handle: SKIP (0.000s)
[626.843660] [096/133] (400s left) kms_chamelium_color (ctm-limited-range)
[626.922129] Subtest ctm-limited-range: SKIP (0.000s)
[626.968033] [097/133] (400s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[627.077130] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[627.081397] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[627.165169] [098/133] (400s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[627.250978] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[627.252893] Starting dynamic subtest: pipe-A-eDP-1
[627.273103] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[627.291891] Starting dynamic subtest: pipe-B-eDP-1
[627.311166] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[627.323145] Starting dynamic subtest: pipe-C-eDP-1
[627.343935] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[627.358597] Starting dynamic subtest: pipe-D-eDP-1
[627.378447] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[627.380377] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s)
[629.595377] [099/133] (397s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[629.992450] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[630.810396] [100/133] (396s left) kms_sequence (get-forked)
[630.904987] Starting subtest: get-forked
[630.907350] Starting dynamic subtest: pipe-A-eDP-1
[632.783052] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[632.796231] Starting dynamic subtest: pipe-B-eDP-1
[635.376347] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.593s)
[635.388648] Starting dynamic subtest: pipe-C-eDP-1
[637.898671] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.521s)
[637.911242] Starting dynamic subtest: pipe-D-eDP-1
[640.406429] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.507s)
[640.408813] Subtest get-forked: SUCCESS (9.505s)
[641.255553] [101/133] (386s left) gem_lmem_swapping (heavy-verify-multi)
[641.300202] Subtest heavy-verify-multi: SKIP (0.000s)
[641.339955] [102/133] (386s left) api_intel_bb (intel-bb-blit-y)
[641.389950] Starting subtest: intel-bb-blit-y
[644.769586] Subtest intel-bb-blit-y: SUCCESS (3.380s)
[644.888878] [103/133] (382s left) kms_cursor_crc (cursor-tearing-position-change)
[645.000670] Starting subtest: cursor-tearing-position-change
[645.003024] Starting dynamic subtest: pipe-A-eDP-1
[645.568001] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[645.579836] Starting dynamic subtest: pipe-D-eDP-1
[646.805833] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[646.808002] Subtest cursor-tearing-position-change: SUCCESS (1.803s)
[647.631229] [104/133] (380s left) i915_suspend (fence-restore-untiled)
[647.681917] Starting subtest: fence-restore-untiled
[647.686335] Subtest fence-restore-untiled: SKIP (0.000s)
[647.780869] [105/133] (379s left) kms_addfb_basic (addfb25-modifier-no-flag)
[647.881706] Starting subtest: addfb25-modifier-no-flag
[647.884207] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[648.005919] [106/133] (379s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[648.099418] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[648.103509] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[648.201593] [107/133] (379s left) kms_chamelium_hpd (vga-hpd)
[648.594651] Subtest vga-hpd: SKIP (0.000s)
[649.452166] [108/133] (378s left) drm_read (short-buffer-wakeup)
[649.589710] Starting subtest: short-buffer-wakeup
[681.808220] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[681.923583] [109/133] (345s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[682.025386] Starting subtest: y-tiled-32bpp-rotate-90
[682.029512] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[682.143547] [110/133] (345s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[682.236853] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[682.241290] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[682.342647] [111/133] (345s left) i915_drm_fdinfo (most-busy-check-all)
[682.378145] Starting subtest: most-busy-check-all
[682.380084] Starting dynamic subtest: rcs0
[682.384645] Dynamic subtest rcs0: SKIP (0.004s)
[682.397238] Starting dynamic subtest: bcs0
[682.401398] Dynamic subtest bcs0: SKIP (0.000s)
[682.413285] Starting dynamic subtest: vcs0
[682.417501] Dynamic subtest vcs0: SKIP (0.000s)
[682.429237] Starting dynamic subtest: vcs1
[682.434362] Dynamic subtest vcs1: SKIP (0.000s)
[682.445452] Starting dynamic subtest: vecs0
[682.449841] Dynamic subtest vecs0: SKIP (0.000s)
[682.461149] Starting dynamic subtest: ccs0
[682.465621] Dynamic subtest ccs0: SKIP (0.000s)
[682.470035] Subtest most-busy-check-all: SKIP (0.009s)
[682.510331] [112/133] (345s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[682.649806] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[689.530502] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.882s)
[689.636248] [113/133] (338s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[689.738337] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[689.742400] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[689.834281] [114/133] (338s left) perf (polling-small-buf)
[689.932791] Starting subtest: polling-small-buf
[690.021874] Subtest polling-small-buf: SUCCESS (0.087s)
[690.074002] [115/133] (338s left) kms_plane_multiple (tiling-x)
[690.159276] Starting subtest: tiling-x
[690.161711] Starting dynamic subtest: pipe-A-eDP-1
[693.891131] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.728s)
[693.903649] Starting dynamic subtest: pipe-B-eDP-1
[698.350485] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.458s)
[698.362827] Starting dynamic subtest: pipe-C-eDP-1
[702.726036] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.372s)
[702.738470] Starting dynamic subtest: pipe-D-eDP-1
[707.082857] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.354s)
[707.085138] Subtest tiling-x: SUCCESS (16.918s)
[707.898944] [116/133] (320s left) gen9_exec_parse (bb-start-cmd)
[707.965859] Subtest bb-start-cmd: SKIP (0.000s)
[708.025406] [117/133] (320s left) kms_cursor_crc (cursor-offscreen-512x512)
[708.308304] Starting subtest: cursor-offscreen-512x512
[708.312297] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[708.476663] [118/133] (319s left) gem_ctx_shared (create-shared-gtt)
[708.538512] Starting subtest: create-shared-gtt
[710.692288] Subtest create-shared-gtt: SUCCESS (2.153s)
[711.235232] [119/133] (317s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[711.323019] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[711.335198] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[711.414736] [120/133] (316s left) kms_dp_linktrain_fallback (dsc-fallback)
[711.501841] Starting subtest: dsc-fallback
[711.508374] Subtest dsc-fallback: SKIP (0.000s)
[711.577022] [121/133] (316s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[711.660066] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[711.662365] Starting dynamic subtest: pipe-A-eDP-1
[711.685195] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[711.699766] Starting dynamic subtest: pipe-B-eDP-1
[711.722126] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[711.733379] Starting dynamic subtest: pipe-C-eDP-1
[711.753959] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[711.764820] Starting dynamic subtest: pipe-D-eDP-1
[711.785754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[711.789892] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[713.962368] [122/133] (314s left) syncobj_wait (single-wait-all-submitted)
[714.015155] Starting subtest: single-wait-all-submitted
[714.115511] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[714.205300] [123/133] (314s left) kms_atomic (atomic-invalid-params)
[714.298161] Starting subtest: atomic-invalid-params
[714.300449] Starting dynamic subtest: pipe-A-eDP-1
[714.699387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[714.701800] Subtest atomic-invalid-params: SUCCESS (0.404s)
[715.499620] [124/133] (313s left) perf_pmu (all-busy-check-all)
[715.536938] Starting subtest: all-busy-check-all
[716.881300] Subtest all-busy-check-all: SUCCESS (1.344s)
[716.974995] [125/133] (311s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[717.061418] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[717.065424] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[717.171039] [126/133] (311s left) kms_lease (lease-invalid-connector)
[717.262954] Starting subtest: lease-invalid-connector
[717.265239] Starting dynamic subtest: pipe-A-eDP-1
[717.267467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[717.279073] Starting dynamic subtest: pipe-B-eDP-1
[717.281242] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[717.292829] Starting dynamic subtest: pipe-C-eDP-1
[717.294761] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[717.305842] Starting dynamic subtest: pipe-D-eDP-1
[717.307730] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[717.309662] Subtest lease-invalid-connector: SUCCESS (0.004s)
[717.350484] [127/133] (311s left) gem_madvise (dontneed-after-mmap)
[717.385918] Starting subtest: dontneed-after-mmap
[717.420302] Subtest dontneed-after-mmap: SUCCESS (0.033s)
[717.523568] [128/133] (311s left) kms_flip (flip-vs-suspend-interruptible)
[717.621757] Starting subtest: flip-vs-suspend-interruptible
[717.624023] Starting dynamic subtest: A-eDP1
[878.897636] Dynamic subtest A-eDP1: SUCCESS (12.255s)
[878.902302] Subtest flip-vs-suspend-interruptible: SUCCESS (12.258s)
[879.045094] [129/133] (149s left) kms_vblank (wait-forked-busy)
[879.137710] Starting subtest: wait-forked-busy
[879.139758] Starting dynamic subtest: pipe-A-eDP-1
[881.022832] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s)
[881.042958] Starting dynamic subtest: pipe-D-eDP-1
[883.603558] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.585s)
[883.606281] Subtest wait-forked-busy: SUCCESS (4.476s)
[884.409621] [130/133] (144s left) kms_big_fb (linear-32bpp-rotate-180)
[884.513279] Starting subtest: linear-32bpp-rotate-180
[886.078900] Subtest linear-32bpp-rotate-180: SUCCESS (1.568s)
[886.204200] [131/133] (142s left) gen3_render_tiledx_blits
[886.328095] [132/133] (142s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[886.417861] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[893.469303] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.058s)
[893.585415] [133/133] (135s left) kms_plane_scaling (planes-scaler-unity-scaling)
[893.680000] Starting subtest: planes-scaler-unity-scaling
[893.682173] Starting dynamic subtest: pipe-A
[893.743971] Dynamic subtest pipe-A: SUCCESS (0.064s)
[893.757290] Starting dynamic subtest: pipe-B
[894.863280] Dynamic subtest pipe-B: SUCCESS (1.119s)
[894.875222] Starting dynamic subtest: pipe-C
[895.980510] Dynamic subtest pipe-C: SUCCESS (1.116s)
[895.993264] Starting dynamic subtest: pipe-D
[897.126285] Dynamic subtest pipe-D: SUCCESS (1.145s)
[897.129146] Subtest planes-scaler-unity-scaling: SUCCESS (3.448s)
[898.270970] 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.