[59.663866] Initializing watchdogs
[59.663914]   /dev/watchdog0
[59.678483] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.682941] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.685303] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.689102] [001/133] (960s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[59.812739] Starting subtest: primary-y-tiled-reflect-x-90
[59.817130] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[59.891665] [002/133] (960s left) syncobj_timeline (device-signal-unordered)
[59.943917] Starting subtest: device-signal-unordered
[59.946341] Subtest device-signal-unordered: SUCCESS (0.001s)
[60.041374] [003/133] (960s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[60.101798] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[60.104210] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[60.214475] [004/133] (960s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[60.300900] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[60.303171] Starting dynamic subtest: pipe-A-eDP-1
[60.408854] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[60.704817] Starting dynamic subtest: pipe-B-eDP-1
[61.522368] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.825s)
[61.821511] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.521s)
[62.686231] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[62.797799] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[62.802275] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[62.896827] [006/133] (957s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[62.985246] Starting subtest: blocking-absolute-wf_vblank-interruptible
[62.987506] Starting dynamic subtest: A-eDP1
[71.742255] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[71.752082] Starting dynamic subtest: B-eDP1
[80.460986] Dynamic subtest B-eDP1: SUCCESS (8.717s)
[80.471692] Starting dynamic subtest: C-eDP1
[89.172480] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[89.181130] Starting dynamic subtest: D-eDP1
[97.898387] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[97.908425] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.919s)
[99.114510] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[99.228739] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[103.234988] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.010s)
[104.424071] [008/133] (916s left) gen9_exec_parse (bb-start-cmd)
[104.491625] Subtest bb-start-cmd: SKIP (0.000s)
[104.563736] [009/133] (915s left) kms_vblank (wait-forked-busy)
[104.662602] Starting subtest: wait-forked-busy
[104.664922] Starting dynamic subtest: pipe-A-eDP-1
[106.540503] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[106.554432] Starting dynamic subtest: pipe-D-eDP-1
[109.070330] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s)
[109.072728] Subtest wait-forked-busy: SUCCESS (4.409s)
[109.871192] [010/133] (910s left) gem_exec_parallel (userptr)
[109.931763] Starting subtest: userptr
[109.934231] Starting dynamic subtest: rcs0
[111.394604] Dynamic subtest rcs0: SUCCESS (1.463s)
[111.406297] Starting dynamic subtest: bcs0
[112.858043] Dynamic subtest bcs0: SUCCESS (1.463s)
[112.868096] Starting dynamic subtest: vcs0
[114.900816] Dynamic subtest vcs0: SUCCESS (2.040s)
[114.911313] Starting dynamic subtest: vcs1
[116.885407] Dynamic subtest vcs1: SUCCESS (1.983s)
[116.895823] Starting dynamic subtest: vecs0
[118.868382] Dynamic subtest vecs0: SUCCESS (1.983s)
[118.878866] Starting dynamic subtest: ccs0
[120.369785] Dynamic subtest ccs0: SUCCESS (1.502s)
[120.372724] Subtest userptr: SUCCESS (10.438s)
[120.556905] [011/133] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[120.666612] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[120.670899] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[120.755712] [012/133] (899s left) gem_busy (semaphore)
[120.949438] Subtest semaphore: SKIP (0.000s)
[121.162296] [013/133] (899s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[121.275822] Starting subtest: fbc-psr2-sprite-plane-onoff
[121.278068] Starting dynamic subtest: eDP-1
[121.282162] Dynamic subtest eDP-1: SKIP (0.000s)
[121.286318] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[121.345156] [014/133] (899s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[121.428743] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[121.431114] Starting dynamic subtest: pipe-A-eDP-1
[121.454080] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[121.463292] Starting dynamic subtest: pipe-B-eDP-1
[121.484413] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[121.491385] Starting dynamic subtest: pipe-C-eDP-1
[121.512719] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[121.524752] Starting dynamic subtest: pipe-D-eDP-1
[121.546242] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[121.550581] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[123.734923] [015/133] (896s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[123.837596] Starting subtest: fb-8bpc-vs-panel-6bpc
[123.839803] Starting dynamic subtest: pipe-A-eDP-1
[125.210209] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.373s)
[125.212473] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.374s)
[126.086898] [016/133] (894s left) gem_reg_read (timestamp-monotonic)
[126.148816] Starting subtest: timestamp-monotonic
[130.270888] Subtest timestamp-monotonic: SUCCESS (4.121s)
[130.339944] [017/133] (890s left) gem_pipe_control_store_loop (fresh-buffer)
[130.390729] Starting subtest: fresh-buffer
[132.545607] Subtest fresh-buffer: SUCCESS (2.153s)
[132.666958] [018/133] (888s left) kms_flip (basic-plain-flip)
[132.767944] Starting subtest: basic-plain-flip
[132.770433] Starting dynamic subtest: A-eDP1
[134.481027] Dynamic subtest A-eDP1: SUCCESS (1.715s)
[134.490462] Starting dynamic subtest: B-eDP1
[136.121197] Dynamic subtest B-eDP1: SUCCESS (1.638s)
[136.130692] Starting dynamic subtest: C-eDP1
[137.757564] Dynamic subtest C-eDP1: SUCCESS (1.634s)
[137.770539] Starting dynamic subtest: D-eDP1
[139.390241] Dynamic subtest D-eDP1: SUCCESS (1.631s)
[139.395242] Subtest basic-plain-flip: SUCCESS (6.630s)
[140.569572] [019/133] (880s left) kms_universal_plane (universal-plane-functional)
[140.665647] Starting subtest: universal-plane-functional
[140.667844] Starting dynamic subtest: pipe-A-eDP-1
[144.733276] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.066s)
[144.742464] Starting dynamic subtest: pipe-B-eDP-1
[149.252901] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.519s)
[149.262228] Starting dynamic subtest: pipe-C-eDP-1
[153.602788] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.347s)
[153.611262] Starting dynamic subtest: pipe-D-eDP-1
[157.997586] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.394s)
[157.999924] Subtest universal-plane-functional: SUCCESS (17.331s)
[158.849797] [020/133] (862s left) gem_create (create-ext-placement-each)
[159.029610] Starting subtest: create-ext-placement-each
[159.032234] Subtest create-ext-placement-each: SUCCESS (0.000s)
[159.119213] [021/133] (861s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[159.212569] Starting subtest: random-ccs-data-y-tiled-ccs
[159.214838] Starting dynamic subtest: pipe-A-eDP-1
[159.240344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.249156] Starting dynamic subtest: pipe-B-eDP-1
[159.273088] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.279992] Starting dynamic subtest: pipe-C-eDP-1
[159.303874] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.311305] Starting dynamic subtest: pipe-D-eDP-1
[159.336767] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.341401] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[161.431381] [022/133] (859s left) syncobj_timeline (multi-wait-all-available-submitted)
[161.503253] Starting subtest: multi-wait-all-available-submitted
[161.505679] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[161.617678] [023/133] (859s left) gem_userptr_blits (coherency-sync)
[161.688248] Starting subtest: coherency-sync
[162.044698] Subtest coherency-sync: SKIP (0.318s)
[162.148876] [024/133] (858s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[162.782903] Starting subtest: syncobj-stationary-timeline-chain-engines
[162.888599] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.106s)
[164.001055] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[164.004416] [025/133] (857s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[164.119596] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[164.121951] Starting dynamic subtest: pipe-A-eDP-1
[164.196060] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[164.204755] Starting dynamic subtest: pipe-B-eDP-1
[165.308775] Dynamic subtest pipe-B-eDP-1: SKIP (1.114s)
[165.313416] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.194s)
[166.491962] [026/133] (854s left) gem_eio (in-flight-internal-10ms)
[166.718740] Starting subtest: in-flight-internal-10ms
[167.972331] Subtest in-flight-internal-10ms: SUCCESS (1.252s)
[168.110178] [027/133] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[168.202389] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[168.206794] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[168.298804] [028/133] (852s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[168.395126] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[168.399167] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[168.467133] [029/133] (852s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[168.562757] Starting subtest: plane-primary-overlay-mutable-zpos
[172.038401] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.475s)
[173.235763] [030/133] (848s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[173.323109] Starting subtest: pixel-format-y-tiled-ccs-modifier
[173.327518] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[173.395850] [031/133] (847s left) gem_mmap_gtt (hang-busy)
[173.466434] Subtest hang-busy: SKIP (0.000s)
[173.525731] [032/133] (847s left) kms_psr2_su (page_flip-p010)
[173.590076] Subtest page_flip-P010: SKIP (0.000s)
[173.659850] [033/133] (847s left) kms_busy (extended-modeset-hang-newfb)
[173.752321] Starting subtest: extended-modeset-hang-newfb
[173.754541] Starting dynamic subtest: pipe-A
[207.832585] Dynamic subtest pipe-A: SUCCESS (34.077s)
[207.851108] Starting dynamic subtest: pipe-D
[230.805725] Dynamic subtest pipe-D: SUCCESS (22.966s)
[230.808123] Subtest extended-modeset-hang-newfb: SUCCESS (57.049s)
[231.591161] [034/133] (789s left) api_intel_bb (crc32)
[231.653121] Starting subtest: crc32
[231.655326] Starting dynamic subtest: rcs0-smem0
[231.939489] Dynamic subtest rcs0-smem0: SUCCESS (0.286s)
[231.950805] Starting dynamic subtest: bcs0-smem0
[232.267879] Dynamic subtest bcs0-smem0: SUCCESS (0.325s)
[232.278989] Starting dynamic subtest: vcs0-smem0
[232.655113] Dynamic subtest vcs0-smem0: SUCCESS (0.385s)
[232.665419] Starting dynamic subtest: vcs1-smem0
[232.981560] Dynamic subtest vcs1-smem0: SUCCESS (0.323s)
[232.997691] Starting dynamic subtest: vecs0-smem0
[233.339427] Dynamic subtest vecs0-smem0: SUCCESS (0.356s)
[233.348965] Starting dynamic subtest: ccs0-smem0
[233.680377] Dynamic subtest ccs0-smem0: SUCCESS (0.338s)
[233.683261] Subtest crc32: SUCCESS (2.029s)
[233.809082] [035/133] (787s left) kms_invalid_mode (overflow-vrefresh)
[233.907057] Starting subtest: overflow-vrefresh
[233.909302] Starting dynamic subtest: pipe-A-eDP-1
[234.191407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[234.203788] Starting dynamic subtest: pipe-B-eDP-1
[234.206113] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[234.219669] Starting dynamic subtest: pipe-C-eDP-1
[234.222771] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[234.231643] Starting dynamic subtest: pipe-D-eDP-1
[234.233962] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[234.236631] Subtest overflow-vrefresh: SUCCESS (0.290s)
[235.011961] [036/133] (786s left) syncobj_timeline (single-wait-all-available-signaled)
[235.068759] Starting subtest: single-wait-all-available-signaled
[235.071149] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[235.181535] [037/133] (786s left) kms_flip (dpms-vs-vblank-race-interruptible)
[235.281717] Starting subtest: dpms-vs-vblank-race-interruptible
[235.284011] Starting dynamic subtest: A-eDP1
[239.085414] Dynamic subtest A-eDP1: SUCCESS (3.801s)
[239.094242] Starting dynamic subtest: B-eDP1
[242.600202] Dynamic subtest B-eDP1: SUCCESS (3.513s)
[242.609406] Starting dynamic subtest: C-eDP1
[247.192203] Dynamic subtest C-eDP1: SUCCESS (4.589s)
[247.200896] Starting dynamic subtest: D-eDP1
[251.808540] Dynamic subtest D-eDP1: SUCCESS (4.614s)
[251.810481] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.526s)
[252.686104] [038/133] (768s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[252.765724] Starting subtest: invalid-bsd1-flag-on-vebox
[252.768078] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[252.877897] [039/133] (768s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[252.964174] Starting subtest: addfb25-y-tiled-small-legacy
[252.968493] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[253.059428] [040/133] (768s left) core_hotunplug (unbind-rebind)
[253.161587] Starting subtest: unbind-rebind
[257.548643] Subtest unbind-rebind: SUCCESS (4.389s)
[257.585156] [041/133] (764s left) syncobj_timeline (multi-wait-submitted-signaled)
[258.872700] Starting subtest: multi-wait-submitted-signaled
[258.875038] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[258.982646] [042/133] (762s left) gem_wait (write-busy)
[259.047048] Starting subtest: write-busy
[259.049517] Starting dynamic subtest: all-engines
[259.668670] Dynamic subtest all-engines: SUCCESS (0.621s)
[259.685481] Starting dynamic subtest: rcs0
[260.221298] Dynamic subtest rcs0: SUCCESS (0.550s)
[260.236898] Starting dynamic subtest: bcs0
[260.770689] Dynamic subtest bcs0: SUCCESS (0.548s)
[260.786910] Starting dynamic subtest: vcs0
[261.909061] Dynamic subtest vcs0: SUCCESS (1.136s)
[261.925896] Starting dynamic subtest: vcs1
[263.891834] Dynamic subtest vcs1: SUCCESS (1.981s)
[263.908845] Starting dynamic subtest: vecs0
[265.876607] Dynamic subtest vecs0: SUCCESS (1.981s)
[265.897877] Starting dynamic subtest: ccs0
[266.426961] Dynamic subtest ccs0: SUCCESS (0.549s)
[266.430027] Subtest write-busy: SUCCESS (7.379s)
[266.629639] [043/133] (755s left) gem_exec_reloc (basic-write-cpu-active)
[266.692063] Subtest basic-write-cpu-active: SKIP (0.000s)
[266.760217] [044/133] (755s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[266.862536] Starting subtest: fbc-rgb565-draw-pwrite
[271.512320] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.653s)
[272.650092] [045/133] (749s left) gem_softpin (allocator-evict)
[272.721252] Starting subtest: allocator-evict
[272.723651] Starting dynamic subtest: rcs0
[295.551030] Dynamic subtest rcs0: SUCCESS (22.830s)
[295.562817] Starting dynamic subtest: bcs0
[319.676966] Dynamic subtest bcs0: SUCCESS (24.122s)
[319.686605] Starting dynamic subtest: vcs0
[343.186749] Dynamic subtest vcs0: SUCCESS (23.508s)
[343.195440] Starting dynamic subtest: vcs1
[368.918627] Dynamic subtest vcs1: SUCCESS (25.728s)
[368.928618] Starting dynamic subtest: vecs0
[392.523315] Dynamic subtest vecs0: SUCCESS (23.603s)
[392.535114] Starting dynamic subtest: ccs0
[415.968941] Dynamic subtest ccs0: SUCCESS (23.444s)
[415.971504] Subtest allocator-evict: SUCCESS (143.245s)
[416.052937] [046/133] (605s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[416.206410] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[423.310985] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.108s)
[423.419757] [047/133] (598s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[423.489648] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[423.492043] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[423.576429] [048/133] (598s left) perf (polling-small-buf)
[423.723921] Starting subtest: polling-small-buf
[423.814291] Subtest polling-small-buf: SUCCESS (0.089s)
[423.866713] [049/133] (598s left) perf (disabled-read-error)
[423.964963] Starting subtest: disabled-read-error
[423.977545] Subtest disabled-read-error: SUCCESS (0.012s)
[424.018529] [050/133] (598s left) gem_exec_params (invalid-fence-in)
[424.075691] Starting subtest: invalid-fence-in
[424.077822] Subtest invalid-fence-in: SUCCESS (0.000s)
[424.176381] [051/133] (597s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[424.275107] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[424.276868] Starting dynamic subtest: pipe-A
[424.299202] Dynamic subtest pipe-A: SKIP (0.020s)
[424.307857] Starting dynamic subtest: pipe-B
[424.338457] Dynamic subtest pipe-B: SKIP (0.038s)
[424.347258] Starting dynamic subtest: pipe-C
[424.376177] Dynamic subtest pipe-C: SKIP (0.038s)
[424.384608] Starting dynamic subtest: pipe-D
[424.413794] Dynamic subtest pipe-D: SKIP (0.038s)
[424.416970] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.136s)
[424.517032] [052/133] (597s left) kms_prop_blob (blob-multiple)
[424.573863] Starting subtest: blob-multiple
[424.575950] Subtest blob-multiple: SUCCESS (0.002s)
[424.667060] [053/133] (597s left) i915_suspend (fence-restore-tiled2untiled)
[424.718181] Starting subtest: fence-restore-tiled2untiled
[424.721729] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[424.812414] [054/133] (597s left) kms_cursor_crc (cursor-random-max-size)
[425.144684] Starting subtest: cursor-random-max-size
[425.150112] Subtest cursor-random-max-size: SKIP (0.000s)
[425.259462] [055/133] (597s left) kms_plane_alpha_blend (coverage-7efc)
[425.344185] Starting subtest: coverage-7efc
[425.639272] Starting dynamic subtest: pipe-A-eDP-1
[426.224103] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s)
[426.258240] Starting dynamic subtest: pipe-D-eDP-1
[427.587642] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[427.589961] Subtest coverage-7efc: SUCCESS (2.244s)
[428.410757] [056/133] (593s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[428.519393] Starting subtest: yf-tiled-64bpp-rotate-270
[428.523621] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[428.618722] [057/133] (593s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[428.683270] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[428.687712] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[428.879996] [058/133] (593s left) kms_psr (psr-sprite-render)
[428.980622] Starting subtest: psr-sprite-render
[428.982962] Starting dynamic subtest: eDP-1
[430.738054] Dynamic subtest eDP-1: SUCCESS (1.758s)
[430.740202] Subtest psr-sprite-render: SUCCESS (1.759s)
[431.567745] [059/133] (590s left) gem_exec_balancer (bonded-true-hang)
[431.835300] Starting subtest: bonded-true-hang
[431.840397] Subtest bonded-true-hang: SKIP (0.000s)
[431.962328] [060/133] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[432.061522] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[432.065734] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[432.158385] [061/133] (590s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[432.256823] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[433.348293] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.090s)
[433.471573] [062/133] (589s left) gem_userptr_blits (unsync-unmap)
[433.546147] Subtest unsync-unmap: SKIP (0.000s)
[433.683915] [063/133] (588s left) gem_userptr_blits (map-fixed-invalidate-busy)
[433.754897] Starting subtest: map-fixed-invalidate-busy
[433.758521] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[433.871521] [064/133] (588s left) gem_exec_params (rsvd2-dirt)
[433.928970] Starting subtest: rsvd2-dirt
[433.932766] Subtest rsvd2-dirt: SKIP (0.000s)
[434.032481] [065/133] (588s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[434.135134] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[434.137042] Starting dynamic subtest: pipe-A-eDP-1
[434.422106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.262s)
[434.431403] Starting dynamic subtest: pipe-B-eDP-1
[435.766462] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s)
[435.778367] Starting dynamic subtest: pipe-C-eDP-1
[437.060496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.295s)
[437.070040] Starting dynamic subtest: pipe-D-eDP-1
[438.311939] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[438.314302] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.148s)
[439.421498] [066/133] (583s left) kms_cursor_crc (cursor-alpha-opaque)
[439.515740] Starting subtest: cursor-alpha-opaque
[439.517561] Starting dynamic subtest: pipe-A-eDP-1
[440.143053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.628s)
[440.151808] Starting dynamic subtest: pipe-D-eDP-1
[441.401989] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[441.404436] Subtest cursor-alpha-opaque: SUCCESS (1.888s)
[442.194725] [067/133] (580s left) syncobj_wait (multi-wait-submitted-signaled)
[442.249452] Starting subtest: multi-wait-submitted-signaled
[442.251618] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[442.363081] [068/133] (580s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[442.471909] Starting subtest: x-tiled-32bpp-rotate-180
[443.939289] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.467s)
[444.079397] [069/133] (578s left) syncobj_basic (bad-pad-handle-to-fd)
[444.143050] Starting subtest: bad-pad-handle-to-fd
[444.144718] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[444.240414] [070/133] (578s left) gem_ctx_persistence (engines-mixed-process)
[444.297276] Starting subtest: engines-mixed-process
[444.299374] Starting dynamic subtest: rcs0
[445.914977] Dynamic subtest rcs0: SUCCESS (1.617s)
[445.925203] Starting dynamic subtest: bcs0
[447.878526] Dynamic subtest bcs0: SUCCESS (1.959s)
[447.889153] Starting dynamic subtest: vcs0
[449.948702] Dynamic subtest vcs0: SUCCESS (2.072s)
[449.959840] Starting dynamic subtest: vcs1
[451.935935] Dynamic subtest vcs1: SUCCESS (1.985s)
[451.947334] Starting dynamic subtest: vecs0
[453.918719] Dynamic subtest vecs0: SUCCESS (1.981s)
[453.928702] Starting dynamic subtest: ccs0
[455.877599] Dynamic subtest ccs0: SUCCESS (1.955s)
[455.879781] Subtest engines-mixed-process: SUCCESS (11.578s)
[455.978196] [071/133] (567s left) kms_big_fb (linear-8bpp-rotate-0)
[456.083595] Starting subtest: linear-8bpp-rotate-0
[457.352459] Subtest linear-8bpp-rotate-0: SUCCESS (1.269s)
[457.478224] [072/133] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[457.574847] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[457.578277] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[457.667552] [073/133] (565s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[457.757058] Starting subtest: psr-rgb101010-draw-mmap-gtt
[457.760666] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[457.863780] [074/133] (565s left) perf_pmu (init-sema)
[457.902692] Starting subtest: init-sema
[457.904712] Starting dynamic subtest: rcs0
[457.906646] Dynamic subtest rcs0: SUCCESS (0.002s)
[457.917562] Starting dynamic subtest: bcs0
[457.919382] Dynamic subtest bcs0: SUCCESS (0.001s)
[457.927712] Starting dynamic subtest: vcs0
[457.929371] Dynamic subtest vcs0: SUCCESS (0.001s)
[457.938437] Starting dynamic subtest: vcs1
[457.940258] Dynamic subtest vcs1: SUCCESS (0.001s)
[457.948901] Starting dynamic subtest: vecs0
[457.950893] Dynamic subtest vecs0: SUCCESS (0.001s)
[457.959387] Starting dynamic subtest: ccs0
[457.961220] Dynamic subtest ccs0: SUCCESS (0.000s)
[457.963032] Subtest init-sema: SUCCESS (0.009s)
[458.001867] [075/133] (565s left) gem_exec_reloc (basic-write-read)
[458.062962] Subtest basic-write-read: SKIP (0.000s)
[458.130635] [076/133] (565s left) gem_mmap_gtt (big-copy)
[458.195732] Subtest big-copy: SKIP (0.000s)
[458.257033] [077/133] (564s left) gem_lmem_swapping (random-engines)
[458.298849] Subtest random-engines: SKIP (0.000s)
[458.345199] [078/133] (564s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[458.435224] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[458.438469] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[458.512831] [079/133] (564s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[458.637325] Starting subtest: cursorB-vs-flipA-legacy
[458.640918] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[458.790921] [080/133] (564s left) gem_mmap_offset (ptrace)
[458.854959] Starting subtest: ptrace
[458.860270] Starting dynamic subtest: smem0-wb
[458.880091] Dynamic subtest smem0-wb: SUCCESS (0.020s)
[458.889829] Starting dynamic subtest: smem0-wc
[458.905822] Dynamic subtest smem0-wc: SUCCESS (0.025s)
[458.919339] Starting dynamic subtest: smem0-uc
[458.930482] Dynamic subtest smem0-uc: SUCCESS (0.024s)
[458.932537] Subtest ptrace: SUCCESS (0.078s)
[459.055010] [081/133] (564s left) i915_drm_fdinfo (busy-hang)
[459.093363] Starting subtest: busy-hang
[459.095213] Starting dynamic subtest: rcs0
[459.125070] Dynamic subtest rcs0: SKIP (0.030s)
[459.134908] Starting dynamic subtest: bcs0
[459.138284] Dynamic subtest bcs0: SKIP (0.001s)
[459.146742] Starting dynamic subtest: vcs0
[459.150254] Dynamic subtest vcs0: SKIP (0.000s)
[459.162352] Starting dynamic subtest: vcs1
[459.165994] Dynamic subtest vcs1: SKIP (0.000s)
[459.174187] Starting dynamic subtest: vecs0
[459.177545] Dynamic subtest vecs0: SKIP (0.000s)
[459.185847] Starting dynamic subtest: ccs0
[459.189290] Dynamic subtest ccs0: SKIP (0.001s)
[459.192616] Subtest busy-hang: SKIP (0.036s)
[459.230497] [082/133] (564s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[459.322565] Starting subtest: fbc-psr2-cursor-plane-onoff
[459.324475] Starting dynamic subtest: eDP-1
[459.327958] Dynamic subtest eDP-1: SKIP (0.000s)
[459.331485] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[459.408884] [083/133] (564s left) gem_eio (create)
[459.660246] Starting subtest: create
[459.994187] Subtest create: SUCCESS (0.333s)
[460.116469] [084/133] (563s left) vgem_basic (second-client)
[460.160019] Starting subtest: second-client
[460.181932] Subtest second-client: SUCCESS (0.022s)
[460.235317] [085/133] (563s left) kms_chamelium_edid (dp-edid-resolution-list)
[460.635053] Subtest dp-edid-resolution-list: SKIP (0.000s)
[461.411712] [086/133] (562s left) gem_exec_schedule (submit-late-slice)
[461.481904] Starting subtest: submit-late-slice
[461.484286] Starting dynamic subtest: rcs0
[461.512874] Dynamic subtest rcs0: SUCCESS (0.041s)
[461.522199] Starting dynamic subtest: bcs0
[461.552074] Dynamic subtest bcs0: SUCCESS (0.038s)
[461.561164] Starting dynamic subtest: vcs0
[461.584570] Dynamic subtest vcs0: SUCCESS (0.032s)
[461.593207] Starting dynamic subtest: vcs1
[461.615161] Dynamic subtest vcs1: SUCCESS (0.030s)
[461.624516] Starting dynamic subtest: vecs0
[461.646662] Dynamic subtest vecs0: SUCCESS (0.031s)
[461.655496] Starting dynamic subtest: ccs0
[461.683561] Dynamic subtest ccs0: SUCCESS (0.036s)
[461.686173] Subtest submit-late-slice: SUCCESS (0.213s)
[463.021872] [087/133] (560s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[463.121726] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[463.124065] Starting dynamic subtest: pipe-A-eDP-1
[463.146755] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[463.157074] Starting dynamic subtest: pipe-B-eDP-1
[463.177499] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[463.186317] Starting dynamic subtest: pipe-C-eDP-1
[463.206832] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[463.215246] Starting dynamic subtest: pipe-D-eDP-1
[463.236800] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[463.241170] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[465.398307] [088/133] (558s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[465.456990] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[465.527379] [089/133] (558s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[465.614078] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[465.618525] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[465.702322] [090/133] (558s left) kms_fb_coherency (memset-crc)
[465.803279] Starting subtest: memset-crc
[465.805599] Starting dynamic subtest: mmap-offset-wc
[466.202326] Dynamic subtest mmap-offset-wc: SUCCESS (0.399s)
[466.490863] Starting dynamic subtest: mmap-offset-uc
[472.636053] Dynamic subtest mmap-offset-uc: SUCCESS (6.153s)
[472.928663] Subtest memset-crc: SUCCESS (7.125s)
[473.773300] [091/133] (550s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[473.872091] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[473.876622] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[473.969700] [092/133] (549s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[474.025899] Starting subtest: x-tiled-to-vebox-yf-tiled
[474.030132] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[474.207576] [093/133] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[474.319175] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[474.323211] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[474.435290] [094/133] (549s left) kms_flip (2x-nonexisting-fb-interruptible)
[474.536803] Starting subtest: 2x-nonexisting-fb-interruptible
[474.550081] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[474.625102] [095/133] (549s left) sysfs_timeslice_duration (idempotent)
[474.690064] Starting subtest: idempotent
[474.692332] Starting dynamic subtest: vecs0
[474.694548] Dynamic subtest vecs0: SUCCESS (0.000s)
[474.707878] Starting dynamic subtest: ccs0
[474.710355] Dynamic subtest ccs0: SUCCESS (0.000s)
[474.720398] Starting dynamic subtest: vcs0
[474.722624] Dynamic subtest vcs0: SUCCESS (0.000s)
[474.731346] Starting dynamic subtest: bcs0
[474.733580] Dynamic subtest bcs0: SUCCESS (0.000s)
[474.743117] Starting dynamic subtest: rcs0
[474.744963] Dynamic subtest rcs0: SUCCESS (0.000s)
[474.756124] Starting dynamic subtest: vcs1
[474.758208] Dynamic subtest vcs1: SUCCESS (0.000s)
[474.760345] Subtest idempotent: SUCCESS (0.007s)
[474.797980] [096/133] (549s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[474.897230] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[474.901484] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[474.993101] [097/133] (549s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[475.091776] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[475.096071] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[475.158867] [098/133] (548s left) gem_workarounds (basic-read-fd)
[475.228711] Starting subtest: basic-read-fd
[475.241767] Subtest basic-read-fd: SUCCESS (0.013s)
[475.351118] [099/133] (548s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[475.742914] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[476.579178] [100/133] (547s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[478.109261] Starting subtest: gem-execbuf-stress-pc8
[478.151156] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[478.841990] [101/133] (545s left) api_intel_bb (destroy-bb)
[478.908086] Starting subtest: destroy-bb
[478.915044] Subtest destroy-bb: SUCCESS (0.008s)
[479.057156] [102/133] (545s left) kms_pm_dc (dc5-retention-flops)
[480.159897] Starting subtest: dc5-retention-flops
[480.164271] Subtest dc5-retention-flops: SKIP (0.000s)
[480.235074] [103/133] (544s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[480.326662] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[480.328903] Starting dynamic subtest: pipe-A-eDP-1
[513.104862] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.058s)
[513.115182] Starting dynamic subtest: pipe-B-eDP-1
[546.034809] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.702s)
[546.059764] Starting dynamic subtest: pipe-C-eDP-1
[578.995659] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.710s)
[579.007184] Starting dynamic subtest: pipe-D-eDP-1
[612.007893] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.704s)
[612.010513] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.183s)
[613.233475] [104/133] (411s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[613.348593] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[613.352991] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[613.435002] [105/133] (410s left) kms_atomic_transition (plane-all-transition-nonblocking)
[613.523826] Starting subtest: plane-all-transition-nonblocking
[613.526509] Starting dynamic subtest: pipe-A-eDP-1
[616.022279] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[616.343697] Starting dynamic subtest: pipe-B-eDP-1
[619.591642] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.255s)
[619.901110] Subtest plane-all-transition-nonblocking: SUCCESS (6.369s)
[620.714350] [106/133] (403s left) kms_mmap_write_crc (main)
[620.813499] Starting subtest: main
[620.815689] Starting dynamic subtest: pipe-A-eDP-1
[624.298878] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s)
[624.301206] Subtest main: SUCCESS (3.482s)
[625.148083] [107/133] (399s left) gem_exec_whisper (basic-queues-all)
[625.203380] Starting subtest: basic-queues-all
[637.335168] Subtest basic-queues-all: SUCCESS (12.119s)
[637.527741] [108/133] (386s left) gem_exec_flush (basic-uc-pro-default)
[637.598053] Starting subtest: basic-uc-pro-default
[643.061126] Subtest basic-uc-pro-default: SUCCESS (5.463s)
[643.251687] [109/133] (381s left) perf_pmu (busy-accuracy-98)
[643.294157] Starting subtest: busy-accuracy-98
[643.296671] Starting dynamic subtest: rcs0
[646.339008] Dynamic subtest rcs0: SUCCESS (3.043s)
[646.350646] Starting dynamic subtest: bcs0
[649.392504] Dynamic subtest bcs0: SUCCESS (3.049s)
[649.405222] Starting dynamic subtest: vcs0
[652.438658] Dynamic subtest vcs0: SUCCESS (3.042s)
[652.451030] Starting dynamic subtest: vcs1
[655.479545] Dynamic subtest vcs1: SUCCESS (3.036s)
[655.490242] Starting dynamic subtest: vecs0
[658.525220] Dynamic subtest vecs0: SUCCESS (3.042s)
[658.540097] Starting dynamic subtest: ccs0
[661.574625] Dynamic subtest ccs0: SUCCESS (3.044s)
[661.577727] Subtest busy-accuracy-98: SUCCESS (18.272s)
[661.689213] [110/133] (362s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[661.798718] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[661.803055] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[661.871075] [111/133] (362s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[661.926445] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[662.033905] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[662.114163] [112/133] (362s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[662.214985] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[663.228956] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.013s)
[663.350383] [113/133] (361s left) kms_flip (flip-vs-expired-vblank-interruptible)
[663.442973] Starting subtest: flip-vs-expired-vblank-interruptible
[663.447007] Starting dynamic subtest: A-eDP1
[672.069521] Dynamic subtest A-eDP1: SUCCESS (8.619s)
[672.080299] Starting dynamic subtest: B-eDP1
[680.704541] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[680.715475] Starting dynamic subtest: C-eDP1
[689.331250] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[689.345703] Starting dynamic subtest: D-eDP1
[697.974145] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[697.980135] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.516s)
[699.149108] [114/133] (325s left) gem_exec_whisper (basic-normal)
[699.228990] Starting subtest: basic-normal
[702.772787] Subtest basic-normal: SUCCESS (3.542s)
[702.974993] [115/133] (321s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[703.073760] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[710.397033] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.330s)
[710.524619] [116/133] (314s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[710.616500] Starting subtest: plane-lut1d-post-ctm3x4
[710.796207] Starting dynamic subtest: pipe-A-plane-0
[711.159584] Dynamic subtest pipe-A-plane-0: FAIL (0.193s)
[711.171588] Starting dynamic subtest: pipe-A-plane-1
[711.384444] Dynamic subtest pipe-A-plane-1: FAIL (0.191s)
[711.397212] Starting dynamic subtest: pipe-A-plane-2
[711.607598] Dynamic subtest pipe-A-plane-2: FAIL (0.204s)
[712.585698] Starting dynamic subtest: pipe-B-plane-0
[713.028075] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[713.040320] Starting dynamic subtest: pipe-B-plane-1
[713.354626] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[713.368396] Starting dynamic subtest: pipe-B-plane-2
[713.670824] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[714.294494] Starting dynamic subtest: pipe-C-plane-0
[714.815233] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[714.828317] Starting dynamic subtest: pipe-C-plane-1
[715.224939] Dynamic subtest pipe-C-plane-1: FAIL (0.626s)
[715.235877] Starting dynamic subtest: pipe-C-plane-2
[715.593342] Dynamic subtest pipe-C-plane-2: FAIL (0.171s)
[716.449254] Starting dynamic subtest: pipe-D-plane-0
[717.051318] Dynamic subtest pipe-D-plane-0: FAIL (0.152s)
[717.062122] Starting dynamic subtest: pipe-D-plane-1
[717.504907] Dynamic subtest pipe-D-plane-1: FAIL (0.615s)
[717.517039] Starting dynamic subtest: pipe-D-plane-2
[717.950767] Dynamic subtest pipe-D-plane-2: FAIL (0.582s)
[718.087897] Subtest plane-lut1d-post-ctm3x4: FAIL (7.479s)
[718.906095] [117/133] (305s left) kms_getfb (getfb2-accept-nv12)
[719.002079] Starting subtest: getfb2-accept-nv12
[719.004367] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[719.127321] [118/133] (305s left) gem_exec_fence (basic-busy)
[719.294937] Starting subtest: basic-busy
[719.297422] Starting dynamic subtest: rcs0
[719.372782] Dynamic subtest rcs0: SUCCESS (0.078s)
[719.387045] Starting dynamic subtest: bcs0
[719.437367] Dynamic subtest bcs0: SUCCESS (0.063s)
[719.449953] Starting dynamic subtest: vcs0
[719.499037] Dynamic subtest vcs0: SUCCESS (0.060s)
[719.510419] Starting dynamic subtest: vcs1
[719.556117] Dynamic subtest vcs1: SUCCESS (0.055s)
[719.568507] Starting dynamic subtest: vecs0
[719.615887] Dynamic subtest vecs0: SUCCESS (0.057s)
[719.628559] Starting dynamic subtest: ccs0
[719.673153] Dynamic subtest ccs0: SUCCESS (0.056s)
[719.675636] Subtest basic-busy: SUCCESS (0.380s)
[721.483641] [119/133] (303s left) kms_content_protection (uevent-hdcp14)
[721.637973] Starting subtest: uevent-hdcp14
[721.642095] Subtest uevent-hdcp14: SKIP (0.000s)
[721.754265] [120/133] (303s left) kms_psr (psr2-basic)
[721.844622] Starting subtest: psr2-basic
[721.846857] Starting dynamic subtest: eDP-1
[723.467292] Dynamic subtest eDP-1: SUCCESS (1.623s)
[723.469521] Subtest psr2-basic: SUCCESS (1.624s)
[724.264089] [121/133] (300s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[724.368519] Starting subtest: pipe-fbc-rte
[724.375390] Starting dynamic subtest: pipe-B-eDP-1
[729.828830] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.466s)
[729.836318] Subtest pipe-fbc-rte: SUCCESS (5.469s)
[732.080015] [122/133] (293s left) gem_exec_schedule (implicit-read-write)
[732.151700] Starting subtest: implicit-read-write
[732.153985] Starting dynamic subtest: rcs0
[732.250759] Dynamic subtest rcs0: SUCCESS (0.110s)
[732.263749] Starting dynamic subtest: vcs0
[732.333032] Dynamic subtest vcs0: SUCCESS (0.081s)
[732.346939] Starting dynamic subtest: vcs1
[732.413889] Dynamic subtest vcs1: SUCCESS (0.080s)
[732.428123] Starting dynamic subtest: vecs0
[732.491276] Dynamic subtest vecs0: SUCCESS (0.076s)
[732.503995] Starting dynamic subtest: ccs0
[732.580964] Dynamic subtest ccs0: SUCCESS (0.088s)
[732.583509] Subtest implicit-read-write: SUCCESS (0.440s)
[733.468249] [123/133] (291s left) kms_addfb_basic (addfb25-modifier-no-flag)
[733.573203] Starting subtest: addfb25-modifier-no-flag
[733.575058] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[733.673443] [124/133] (291s left) kms_cursor_crc (cursor-sliding-max-size)
[733.999563] Starting subtest: cursor-sliding-max-size
[734.006256] Subtest cursor-sliding-max-size: SKIP (0.000s)
[734.123022] [125/133] (291s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[734.223696] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[737.832227] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.610s)
[739.008014] [126/133] (286s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[739.098668] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[746.509044] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.415s)
[746.671349] [127/133] (278s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[746.779599] Starting subtest: fbcpsr-rgb101010-draw-blt
[753.610158] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.834s)
[753.760353] [128/133] (271s left) kms_psr (psr-cursor-render)
[753.866018] Starting subtest: psr-cursor-render
[753.868254] Starting dynamic subtest: eDP-1
[755.547933] Dynamic subtest eDP-1: SUCCESS (1.682s)
[755.550235] Subtest psr-cursor-render: SUCCESS (1.683s)
[756.436489] [129/133] (268s left) i915_hangman (gt-error-state-capture)
[756.506094] Starting subtest: gt-error-state-capture
[756.508355] Starting dynamic subtest: rcs0
[767.379768] Dynamic subtest rcs0: SUCCESS (10.873s)
[767.396354] Starting dynamic subtest: bcs0
[779.348214] Dynamic subtest bcs0: SUCCESS (11.963s)
[779.362051] Starting dynamic subtest: vcs0
[790.291507] Dynamic subtest vcs0: SUCCESS (10.939s)
[790.309537] Starting dynamic subtest: vcs1
[801.300326] Dynamic subtest vcs1: SUCCESS (11.004s)
[801.313941] Starting dynamic subtest: vecs0
[812.308348] Dynamic subtest vecs0: SUCCESS (11.002s)
[812.322348] Starting dynamic subtest: ccs0
[824.341161] Dynamic subtest ccs0: SUCCESS (12.026s)
[824.344242] Subtest gt-error-state-capture: SUCCESS (67.824s)
[824.468353] [130/133] (200s left) gem_ctx_shared (create-shared-gtt)
[824.542168] Starting subtest: create-shared-gtt
[826.696058] Subtest create-shared-gtt: SUCCESS (2.153s)
[827.156132] [131/133] (198s left) gem_flink_basic (basic)
[827.212865] Starting subtest: basic
[827.215224] Subtest basic: SUCCESS (0.000s)
[827.322786] [132/133] (198s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[827.423878] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[827.428029] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[827.513088] [133/133] (198s left) syncobj_basic (create-signaled)
[827.578294] Starting subtest: create-signaled
[827.580591] Subtest create-signaled: SUCCESS (0.000s)
[827.673470] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_atomic_transition
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: kms_vblank
results: parsing output: 9/ for test: gem_exec_parallel
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_busy
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_dither
results: parsing output: 15/ for test: gem_reg_read
results: parsing output: 16/ for test: gem_pipe_control_store_loop
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_universal_plane
results: parsing output: 19/ for test: gem_create
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_atomic
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: kms_psr2_su
results: parsing output: 32/ for test: kms_busy
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_invalid_mode
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: core_hotunplug
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_wait
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_exec_params
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_prop_blob
results: parsing output: 52/ for test: i915_suspend
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_plane_alpha_blend
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: syncobj_basic
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: gem_lmem_swapping
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_mmap_offset
results: parsing output: 80/ for test: i915_drm_fdinfo
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: vgem_basic
results: parsing output: 84/ for test: kms_chamelium_edid
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: kms_fb_coherency
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: sysfs_timeslice_duration
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: gem_workarounds
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: kms_pm_dc
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_atomic_transition
results: parsing output: 105/ for test: kms_mmap_write_crc
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_exec_whisper
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_color_pipeline
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: gem_exec_fence
results: parsing output: 118/ for test: kms_content_protection
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: gem_ctx_shared
results: parsing output: 130/ for test: gem_flink_basic
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_basic
Done.