[64.211542] Initializing watchdogs
[64.211587]   /dev/watchdog0
[64.226360] [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]
[64.231024] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.233203] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.235083] [001/133] (960s left) kms_psr (psr-primary-render)
[64.339156] Starting subtest: psr-primary-render
[64.340136] Starting dynamic subtest: eDP-1
[66.138122] Dynamic subtest eDP-1: SUCCESS (1.798s)
[66.139085] Subtest psr-primary-render: SUCCESS (1.799s)
[67.036272] [002/133] (957s left) gem_exec_schedule (noreorder-corked)
[67.432648] Starting subtest: noreorder-corked
[67.434044] Starting dynamic subtest: rcs0
[68.575584] Dynamic subtest rcs0: SUCCESS (1.145s)
[68.585610] Starting dynamic subtest: vcs0
[69.911418] Dynamic subtest vcs0: SUCCESS (1.326s)
[69.918368] Starting dynamic subtest: vcs1
[71.900511] Dynamic subtest vcs1: SUCCESS (1.988s)
[71.908700] Starting dynamic subtest: vecs0
[73.883564] Dynamic subtest vecs0: SUCCESS (1.982s)
[73.891379] Starting dynamic subtest: ccs0
[75.030434] Dynamic subtest ccs0: SUCCESS (1.155s)
[75.031475] Subtest noreorder-corked: SUCCESS (7.601s)
[75.207424] [003/133] (949s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[75.311159] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[75.312015] Starting dynamic subtest: pipe-A-eDP-1
[75.320861] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.336670] Starting dynamic subtest: pipe-B-eDP-1
[75.345356] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.352312] Starting dynamic subtest: pipe-C-eDP-1
[75.360494] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.365692] Starting dynamic subtest: pipe-D-eDP-1
[75.373741] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.375340] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[77.452645] [004/133] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[77.538027] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[81.882380] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.345s)
[83.046522] [005/133] (941s left) syncobj_wait (invalid-reset-illegal-handle)
[83.109896] Starting subtest: invalid-reset-illegal-handle
[83.111234] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[83.195720] [006/133] (941s left) kms_vrr (lobf)
[83.288478] Starting subtest: lobf
[83.290249] Subtest lobf: SKIP (0.000s)
[83.359777] [007/133] (941s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[83.483924] Starting subtest: 2x-long-flip-vs-cursor-atomic
[83.486436] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[83.651686] [008/133] (941s left) kms_draw_crc (draw-method-render)
[83.754168] Starting subtest: draw-method-render
[83.755114] Starting dynamic subtest: xrgb8888-untiled
[83.997310] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[84.003155] Starting dynamic subtest: rgb565-untiled
[84.231218] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[84.242288] Starting dynamic subtest: xrgb2101010-untiled
[84.475516] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.243s)
[84.488506] Starting dynamic subtest: xbgr16161616f-untiled
[84.730725] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.255s)
[84.737093] Starting dynamic subtest: xrgb8888-xtiled
[84.853024] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[84.859061] Starting dynamic subtest: rgb565-xtiled
[84.964064] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[84.972404] Starting dynamic subtest: xrgb2101010-xtiled
[85.086570] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[85.092817] Starting dynamic subtest: xbgr16161616f-xtiled
[85.219759] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[85.225815] Starting dynamic subtest: xrgb8888-4tiled
[85.341890] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[85.347955] Starting dynamic subtest: rgb565-4tiled
[85.464397] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[85.472276] Starting dynamic subtest: xrgb2101010-4tiled
[85.586337] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[85.592384] Starting dynamic subtest: xbgr16161616f-4tiled
[85.719717] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[85.720773] Subtest draw-method-render: SUCCESS (1.966s)
[85.816183] [009/133] (939s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[85.925078] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[85.926950] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[86.026642] [010/133] (939s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[86.115933] Starting subtest: basic-modeset-with-all-modifiers-formats
[86.493451] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[87.236904] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.743s)
[87.243931] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[87.258569] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[87.266519] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[87.280697] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[87.287986] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[87.447455] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[87.453470] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[87.469707] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[87.475872] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[87.491904] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[87.498427] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[87.514527] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[87.522403] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[87.536506] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[87.542308] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[87.558554] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[87.564594] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[87.581230] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[87.588763] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[87.603131] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[87.610744] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[87.625070] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[87.630971] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[87.780901] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[87.788208] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[87.802880] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[87.808596] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[87.825242] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[87.842066] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[87.847481] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[87.854526] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[87.869652] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[87.875613] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[87.891934] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[87.897807] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[87.914032] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[87.920385] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[87.936457] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[87.942063] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[87.958791] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[87.966174] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[88.114592] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[88.121154] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[88.137090] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[88.151273] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[88.159109] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[88.166902] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[88.181210] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[88.187125] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[88.203430] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[88.209274] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[88.225703] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[88.231669] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[88.248034] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[88.254551] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[88.270290] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[88.277805] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[88.292714] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[88.674828] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.559s)
[89.510902] [011/133] (935s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[89.607921] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[96.422881] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.816s)
[96.570575] [012/133] (928s left) kms_color (ctm-signed)
[96.659603] Starting subtest: ctm-signed
[96.660577] Starting dynamic subtest: pipe-A-eDP-1
[98.722849] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.063s)
[98.729380] Starting dynamic subtest: pipe-B-eDP-1
[101.499722] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.777s)
[101.506308] Starting dynamic subtest: pipe-C-eDP-1
[104.220708] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.720s)
[104.227484] Starting dynamic subtest: pipe-D-eDP-1
[106.882303] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.661s)
[106.883156] Subtest ctm-signed: SUCCESS (10.223s)
[107.703127] [013/133] (917s left) gem_render_copy_redux (interruptible)
[107.761564] Starting subtest: interruptible
[108.036529] Subtest interruptible: SUCCESS (0.275s)
[108.141320] [014/133] (917s left) syncobj_eventfd (timeline-wait-before-signal)
[108.185359] Starting subtest: timeline-wait-before-signal
[108.215708] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[108.302779] [015/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[108.389843] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[108.391555] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[108.477907] [016/133] (916s left) kms_atomic_interruptible (legacy-cursor)
[108.572865] Starting subtest: legacy-cursor
[108.573843] Starting dynamic subtest: pipe-A-eDP-1
[116.010988] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.436s)
[116.012312] Subtest legacy-cursor: SUCCESS (7.438s)
[116.863371] [017/133] (908s left) vgem_basic (bad-flag)
[116.934840] Starting subtest: bad-flag
[116.935669] Subtest bad-flag: SUCCESS (0.000s)
[116.994080] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true
[116.995882] [018/133] (908s left) kms_cursor_crc (cursor-random-512x512)
[117.251793] Starting subtest: cursor-random-512x512
[117.253598] Subtest cursor-random-512x512: SKIP (0.001s)
[117.400725] [019/133] (908s left) kms_plane_multiple (tiling-4)
[117.486131] Starting subtest: tiling-4
[117.487025] Starting dynamic subtest: pipe-A-eDP-1
[121.206952] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.720s)
[121.215541] Starting dynamic subtest: pipe-B-eDP-1
[125.547806] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.340s)
[125.554997] Starting dynamic subtest: pipe-C-eDP-1
[129.850576] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.302s)
[129.857788] Starting dynamic subtest: pipe-D-eDP-1
[134.286849] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.435s)
[134.287566] Subtest tiling-4: SUCCESS (16.801s)
[135.094370] [020/133] (890s left) gem_userptr_blits (usage-restrictions)
[135.160992] Starting subtest: usage-restrictions
[135.161867] Subtest usage-restrictions: SUCCESS (0.000s)
[135.296770] [021/133] (890s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[135.406438] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[135.408092] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[135.485038] [022/133] (890s left) syncobj_wait (wait-any-snapshot)
[135.545754] Starting subtest: wait-any-snapshot
[135.628417] Subtest wait-any-snapshot: SUCCESS (0.082s)
[135.697540] [023/133] (889s left) syncobj_wait (multi-wait-for-submit-submitted)
[135.748080] Starting subtest: multi-wait-for-submit-submitted
[135.849866] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[135.921532] [024/133] (889s left) kms_psr (psr2-cursor-plane-onoff)
[136.014886] Starting subtest: psr2-cursor-plane-onoff
[136.015799] Starting dynamic subtest: eDP-1
[137.679076] Dynamic subtest eDP-1: SUCCESS (1.664s)
[137.679981] Subtest psr2-cursor-plane-onoff: SUCCESS (1.665s)
[138.558371] [025/133] (887s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[138.646445] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[138.656491] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[138.711443] [026/133] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[138.800597] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[138.802374] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[138.924692] [027/133] (886s left) gem_wait (write-wait)
[138.984160] Starting subtest: write-wait
[138.985400] Starting dynamic subtest: all-engines
[140.054411] Dynamic subtest all-engines: SUCCESS (1.070s)
[140.072035] Starting dynamic subtest: rcs0
[141.111583] Dynamic subtest rcs0: SUCCESS (1.055s)
[141.127487] Starting dynamic subtest: bcs0
[142.168984] Dynamic subtest bcs0: SUCCESS (1.055s)
[142.186528] Starting dynamic subtest: vcs0
[143.223942] Dynamic subtest vcs0: SUCCESS (1.053s)
[143.240148] Starting dynamic subtest: vcs1
[144.278564] Dynamic subtest vcs1: SUCCESS (1.052s)
[144.293464] Starting dynamic subtest: vecs0
[145.332408] Dynamic subtest vecs0: SUCCESS (1.052s)
[145.347359] Starting dynamic subtest: ccs0
[146.389098] Dynamic subtest ccs0: SUCCESS (1.055s)
[146.390529] Subtest write-wait: SUCCESS (7.406s)
[146.598192] [028/133] (879s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[146.681996] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[146.682859] Starting dynamic subtest: pipe-A-eDP-1
[146.691206] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.697783] Starting dynamic subtest: pipe-B-eDP-1
[146.706296] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.712353] Starting dynamic subtest: pipe-C-eDP-1
[146.720547] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[146.727051] Starting dynamic subtest: pipe-D-eDP-1
[146.736418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[146.738068] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[148.924470] [029/133] (876s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[149.016067] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[149.017682] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[149.112715] [030/133] (876s left) syncobj_timeline (reset-signaled)
[149.158298] Starting subtest: reset-signaled
[149.159276] Subtest reset-signaled: SUCCESS (0.000s)
[149.249808] [031/133] (876s left) kms_cursor_crc (cursor-offscreen-128x42)
[149.453516] Starting subtest: cursor-offscreen-128x42
[149.500759] Subtest cursor-offscreen-128x42: SKIP (0.045s)
[149.691556] [032/133] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[149.781833] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[149.783575] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[149.875487] [033/133] (876s left) prime_vgem (basic-gtt)
[149.932457] Starting subtest: basic-gtt
[149.934457] Subtest basic-gtt: SKIP (0.000s)
[150.035382] [034/133] (875s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[150.161295] Starting subtest: flip-vs-cursor-atomic-transitions
[157.827801] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.664s)
[158.643963] [035/133] (867s left) fbdev (nullptr)
[158.690540] Starting subtest: nullptr
[158.691371] Subtest nullptr: SUCCESS (0.000s)
[158.746895] [036/133] (867s left) gem_linear_blits (interruptible)
[159.165299] Starting subtest: interruptible
[163.375379] Subtest interruptible: SUCCESS (4.201s)
[163.496890] [037/133] (862s left) kms_chamelium_hpd (dp-hpd-storm)
[163.933028] Subtest dp-hpd-storm: SKIP (0.000s)
[164.753412] [038/133] (861s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[164.857875] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[165.971709] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.114s)
[166.078320] [039/133] (860s left) syncobj_basic (bad-destroy)
[166.128061] Starting subtest: bad-destroy
[166.129100] Subtest bad-destroy: SUCCESS (0.000s)
[166.213151] [040/133] (859s left) kms_lease (lease-again)
[166.299347] Starting subtest: lease-again
[166.300259] Starting dynamic subtest: pipe-A-eDP-1
[166.301082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[166.309073] Starting dynamic subtest: pipe-B-eDP-1
[166.310310] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[166.316967] Starting dynamic subtest: pipe-C-eDP-1
[166.317957] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[166.324492] Starting dynamic subtest: pipe-D-eDP-1
[166.325408] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[166.326301] Subtest lease-again: SUCCESS (0.012s)
[166.412111] [041/133] (859s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[166.492499] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[166.493466] Starting dynamic subtest: pipe-A-eDP-1
[166.517650] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[166.525798] Starting dynamic subtest: pipe-B-eDP-1
[166.547466] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[166.556824] Starting dynamic subtest: pipe-C-eDP-1
[166.576533] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[166.583061] Starting dynamic subtest: pipe-D-eDP-1
[166.603927] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[166.605690] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[168.745607] [042/133] (857s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[168.795541] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[168.850770] [043/133] (857s left) syncobj_basic (create-signaled)
[168.902548] Starting subtest: create-signaled
[168.903997] Subtest create-signaled: SUCCESS (0.000s)
[169.004109] [044/133] (857s left) gem_madvise (dontneed-before-pwrite)
[169.033686] Starting subtest: dontneed-before-pwrite
[169.045888] Subtest dontneed-before-pwrite: SKIP (0.011s)
[169.095652] [045/133] (857s left) gem_eio (kms)
[169.344651] Starting subtest: kms
[189.126573] Subtest kms: SUCCESS (19.772s)
[190.298649] [046/133] (836s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[190.391151] Starting subtest: y-tiled-16bpp-rotate-270
[190.392851] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[190.498413] [047/133] (835s left) syncobj_wait (invalid-signal-zero-handles)
[190.561349] Starting subtest: invalid-signal-zero-handles
[190.562442] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[190.658268] [048/133] (835s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[190.746889] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[190.748494] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[190.841120] [049/133] (835s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[190.929160] Starting subtest: plane-use-after-nonblocking-unbind
[190.929949] Starting dynamic subtest: pipe-A-eDP-1
[190.991811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[191.305724] Starting dynamic subtest: pipe-B-eDP-1
[192.106497] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.808s)
[192.409252] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.480s)
[193.272314] [050/133] (833s left) api_intel_allocator (fork-simple-stress-signal)
[193.326633] Starting subtest: fork-simple-stress-signal
[198.775615] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[198.828327] [051/133] (827s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[198.927423] Starting subtest: fbc-rgb101010-draw-render
[203.586816] Subtest fbc-rgb101010-draw-render: SUCCESS (4.659s)
[204.753486] [052/133] (821s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[204.810565] Starting subtest: single-wait-all-for-submit-available-submitted
[204.811433] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[204.898061] [053/133] (821s left) gem_pxp (protected-raw-src-copy-not-readible)
[205.016336] Starting subtest: protected-raw-src-copy-not-readible
[205.074922] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[205.191581] [054/133] (821s left) kms_pm_rpm (modeset-lpsp)
[207.113188] Starting subtest: modeset-lpsp
[208.575027] Subtest modeset-lpsp: SUCCESS (1.462s)
[208.657171] [055/133] (817s left) gem_pxp (create-regular-context-1)
[208.765302] Starting subtest: create-regular-context-1
[208.766093] Subtest create-regular-context-1: SUCCESS (0.002s)
[208.868157] [056/133] (817s left) gem_ctx_persistence (engines-cleanup)
[208.924046] Starting subtest: engines-cleanup
[208.924929] Starting dynamic subtest: rcs0
[209.002386] Dynamic subtest rcs0: SUCCESS (0.078s)
[209.014537] Starting dynamic subtest: bcs0
[209.049267] Dynamic subtest bcs0: SUCCESS (0.045s)
[209.059679] Starting dynamic subtest: vcs0
[209.103438] Dynamic subtest vcs0: SUCCESS (0.052s)
[209.113406] Starting dynamic subtest: vcs1
[209.125385] Dynamic subtest vcs1: SUCCESS (0.020s)
[209.134289] Starting dynamic subtest: vecs0
[209.187235] Dynamic subtest vecs0: SUCCESS (0.061s)
[209.198095] Starting dynamic subtest: ccs0
[209.230672] Dynamic subtest ccs0: SUCCESS (0.041s)
[209.232324] Subtest engines-cleanup: SUCCESS (0.307s)
[209.302890] [057/133] (817s left) kms_vblank (wait-forked)
[209.392769] Starting subtest: wait-forked
[209.393733] Starting dynamic subtest: pipe-A-eDP-1
[211.211562] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[211.220567] Starting dynamic subtest: pipe-D-eDP-1
[213.747502] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[213.748594] Subtest wait-forked: SUCCESS (4.352s)
[214.598470] [058/133] (812s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[214.686357] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[214.687857] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[214.775653] [059/133] (812s left) gem_exec_schedule (preempt-self)
[214.829134] Starting subtest: preempt-self
[214.830077] Starting dynamic subtest: rcs0
[214.849599] Dynamic subtest rcs0: SUCCESS (0.020s)
[214.859148] Starting dynamic subtest: bcs0
[214.867227] Dynamic subtest bcs0: SUCCESS (0.017s)
[214.874853] Starting dynamic subtest: vcs0
[214.888431] Dynamic subtest vcs0: SUCCESS (0.020s)
[214.895596] Starting dynamic subtest: vcs1
[214.907960] Dynamic subtest vcs1: SUCCESS (0.019s)
[214.915357] Starting dynamic subtest: vecs0
[214.928498] Dynamic subtest vecs0: SUCCESS (0.020s)
[214.936697] Starting dynamic subtest: ccs0
[214.945479] Dynamic subtest ccs0: SUCCESS (0.016s)
[214.946477] Subtest preempt-self: SUCCESS (0.117s)
[215.975684] [060/133] (810s left) gem_ctx_persistence (legacy-engines-persistence)
[216.025250] Starting subtest: legacy-engines-persistence
[216.026117] Starting dynamic subtest: render
[216.850771] Dynamic subtest render: SUCCESS (0.824s)
[216.861524] Starting dynamic subtest: bsd1
[217.620698] Dynamic subtest bsd1: SUCCESS (0.767s)
[217.634618] Starting dynamic subtest: bsd2
[218.394556] Dynamic subtest bsd2: SUCCESS (0.770s)
[218.405818] Starting dynamic subtest: blt
[219.136272] Dynamic subtest blt: SUCCESS (0.737s)
[219.145404] Starting dynamic subtest: vebox
[219.923374] Dynamic subtest vebox: SUCCESS (0.787s)
[219.926461] Subtest legacy-engines-persistence: SUCCESS (3.899s)
[220.027613] [061/133] (806s left) gem_mmap (big-bo)
[220.086380] Subtest big-bo: SKIP (0.000s)
[220.155486] [062/133] (806s left) gem_softpin (invalid)
[220.204291] Starting subtest: invalid
[220.212041] Subtest invalid: SUCCESS (0.006s)
[220.328544] [063/133] (806s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[220.380185] Subtest writes-after-reads-snoop: SKIP (0.000s)
[220.433215] [064/133] (806s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[220.551981] Starting subtest: cursor-vs-flip-atomic
[250.024524] Subtest cursor-vs-flip-atomic: SUCCESS (29.472s)
[250.828736] [065/133] (776s left) kms_pipe_crc_basic (suspend-read-crc)
[250.912608] Starting subtest: suspend-read-crc
[250.913517] Starting dynamic subtest: pipe-A-eDP-1
[269.355293] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.079s)
[269.363695] Starting dynamic subtest: pipe-B-eDP-1
[288.364587] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.461s)
[288.372901] Starting dynamic subtest: pipe-C-eDP-1
[307.308730] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.561s)
[307.318888] Starting dynamic subtest: pipe-D-eDP-1
[326.326215] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.434s)
[326.327119] Subtest suspend-read-crc: SUCCESS (13.541s)
[333.172021] [066/133] (699s left) gem_exec_balancer (parallel)
[333.444627] Starting subtest: parallel
[334.445592] Subtest parallel: SUCCESS (0.999s)
[334.841027] [067/133] (698s left) i915_hangman (gt-engine-hang)
[334.912680] Starting subtest: gt-engine-hang
[334.913570] Starting dynamic subtest: rcs0
[336.751338] Dynamic subtest rcs0: SUCCESS (1.826s)
[336.762015] Starting dynamic subtest: bcs0
[338.736021] Dynamic subtest bcs0: SUCCESS (1.979s)
[338.747232] Starting dynamic subtest: vcs0
[340.782817] Dynamic subtest vcs0: SUCCESS (2.043s)
[340.793589] Starting dynamic subtest: vcs1
[342.767596] Dynamic subtest vcs1: SUCCESS (1.980s)
[342.782683] Starting dynamic subtest: vecs0
[344.750982] Dynamic subtest vecs0: SUCCESS (1.980s)
[344.761608] Starting dynamic subtest: ccs0
[346.735917] Dynamic subtest ccs0: SUCCESS (1.981s)
[346.737171] Subtest gt-engine-hang: SUCCESS (11.807s)
[346.871513] [068/133] (686s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[346.972555] Starting subtest: 2x-plain-flip-ts-check-interruptible
[346.985558] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[347.055824] [069/133] (686s left) kms_psr (fbc-psr2-cursor-render)
[347.136031] Starting subtest: fbc-psr2-cursor-render
[347.136906] Starting dynamic subtest: eDP-1
[347.138550] Dynamic subtest eDP-1: SKIP (0.000s)
[347.140181] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[347.204880] [070/133] (685s left) kms_async_flips (test-cursor-atomic)
[347.290078] Starting subtest: test-cursor-atomic
[347.662526] Starting dynamic subtest: pipe-A-eDP-1
[348.442525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.780s)
[348.828139] Starting dynamic subtest: pipe-B-eDP-1
[349.570911] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s)
[349.957898] Starting dynamic subtest: pipe-C-eDP-1
[350.703993] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.753s)
[351.069910] Starting dynamic subtest: pipe-D-eDP-1
[351.833475] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[351.834424] Subtest test-cursor-atomic: SUCCESS (4.543s)
[353.006440] [071/133] (680s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[353.096612] Starting subtest: x-tiled-8bpp-rotate-270
[353.118220] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[353.228887] [072/133] (680s left) kms_pm_rpm (cursor)
[354.950265] Starting subtest: cursor
[354.952484] Subtest cursor: SKIP (0.000s)
[355.432255] [073/133] (677s left) kms_psr (fbc-pr-primary-mmap-cpu)
[355.511955] Starting subtest: fbc-pr-primary-mmap-cpu
[355.513797] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[355.594023] [074/133] (677s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[355.690726] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[355.692398] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[355.759046] [075/133] (677s left) dmabuf_sync_file (import-multiple-read-only)
[355.805308] Starting subtest: import-multiple-read-only
[355.808101] Subtest import-multiple-read-only: SUCCESS (0.003s)
[355.858493] [076/133] (677s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[355.949505] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[355.951340] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[356.056916] [077/133] (677s left) gem_create (create-ext-placement-all)
[356.237331] Starting subtest: create-ext-placement-all
[356.238390] Subtest create-ext-placement-all: SUCCESS (0.000s)
[356.331566] [078/133] (677s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[356.415354] Starting subtest: fbcpsr-tiling-linear
[363.050479] Subtest fbcpsr-tiling-linear: SUCCESS (6.634s)
[363.186588] [079/133] (670s left) gem_exec_whisper (basic-queues)
[363.245720] Starting subtest: basic-queues
[368.492939] Subtest basic-queues: SUCCESS (5.244s)
[368.676068] [080/133] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[368.784678] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[368.786454] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[368.874102] [081/133] (664s left) kms_psr (fbc-psr-cursor-plane-onoff)
[368.968206] Starting subtest: fbc-psr-cursor-plane-onoff
[368.969135] Starting dynamic subtest: eDP-1
[368.970996] Dynamic subtest eDP-1: SKIP (0.000s)
[368.972667] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[369.049292] [082/133] (664s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[369.084828] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[369.123322] [083/133] (664s left) gen9_exec_parse (allowed-all)
[369.176942] Subtest allowed-all: SKIP (0.000s)
[369.244573] [084/133] (664s left) gem_render_copy (linear)
[369.303796] Starting subtest: linear
[369.304901] Starting dynamic subtest: smem
[369.348110] Dynamic subtest smem: SUCCESS (0.044s)
[369.349370] Subtest linear: SUCCESS (0.045s)
[369.542423] [085/133] (664s left) kms_addfb_basic (unused-handle)
[369.593728] Starting subtest: unused-handle
[369.594624] Subtest unused-handle: SUCCESS (0.000s)
[369.729622] [086/133] (664s left) kms_sequence (get-forked)
[369.822137] Starting subtest: get-forked
[369.823056] Starting dynamic subtest: pipe-A-eDP-1
[371.692150] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.869s)
[371.700830] Starting dynamic subtest: pipe-B-eDP-1
[374.229513] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.537s)
[374.242293] Starting dynamic subtest: pipe-C-eDP-1
[376.725406] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.494s)
[376.735299] Starting dynamic subtest: pipe-D-eDP-1
[379.264328] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[379.265177] Subtest get-forked: SUCCESS (9.442s)
[380.102467] [087/133] (653s left) kms_plane (plane-position-covered)
[380.189906] Starting subtest: plane-position-covered
[380.749448] Starting dynamic subtest: pipe-A-plane-1
[382.056232] Dynamic subtest pipe-A-plane-1: SUCCESS (1.306s)
[382.065541] Starting dynamic subtest: pipe-A-plane-2
[383.325405] Dynamic subtest pipe-A-plane-2: SUCCESS (1.268s)
[383.334717] Starting dynamic subtest: pipe-A-plane-3
[384.665197] Dynamic subtest pipe-A-plane-3: SUCCESS (1.340s)
[384.673918] Starting dynamic subtest: pipe-A-plane-4
[385.980083] Dynamic subtest pipe-A-plane-4: SUCCESS (1.314s)
[385.990938] Starting dynamic subtest: pipe-A-plane-5
[386.004985] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[387.155619] Starting dynamic subtest: pipe-B-plane-1
[388.499302] Dynamic subtest pipe-B-plane-1: SUCCESS (1.351s)
[388.508083] Starting dynamic subtest: pipe-B-plane-2
[389.771291] Dynamic subtest pipe-B-plane-2: SUCCESS (1.272s)
[389.780239] Starting dynamic subtest: pipe-B-plane-3
[391.029332] Dynamic subtest pipe-B-plane-3: SUCCESS (1.256s)
[391.040338] Starting dynamic subtest: pipe-B-plane-4
[392.384630] Dynamic subtest pipe-B-plane-4: SUCCESS (1.355s)
[392.393985] Starting dynamic subtest: pipe-B-plane-5
[392.409597] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[392.410439] Subtest plane-position-covered: SUCCESS (12.218s)
[393.230626] [088/133] (640s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[393.327961] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[393.329817] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[393.419048] [089/133] (640s left) gem_mmap_wc (copy)
[393.472709] Subtest copy: SKIP (0.000s)
[393.525289] [090/133] (640s left) kms_cursor_edge_walk (128x128-left-edge)
[393.619960] Starting subtest: 128x128-left-edge
[393.620786] Starting dynamic subtest: pipe-A-eDP-1
[397.110790] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.490s)
[397.120672] Starting dynamic subtest: pipe-D-eDP-1
[400.237077] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[400.237853] Subtest 128x128-left-edge: SUCCESS (6.617s)
[401.043581] [091/133] (632s left) kms_psr (pr-sprite-blt)
[401.125976] Starting subtest: pr-sprite-blt
[401.127903] Subtest pr-sprite-blt: SKIP (0.000s)
[401.194144] [092/133] (632s left) syncobj_basic (bad-handle-to-fd)
[401.246712] Starting subtest: bad-handle-to-fd
[401.247681] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[401.323171] [093/133] (632s left) perf_pmu (init-sema)
[401.358058] Starting subtest: init-sema
[401.358972] Starting dynamic subtest: rcs0
[401.361840] Dynamic subtest rcs0: SUCCESS (0.002s)
[401.372485] Starting dynamic subtest: bcs0
[401.373347] Dynamic subtest bcs0: SUCCESS (0.000s)
[401.381975] Starting dynamic subtest: vcs0
[401.382759] Dynamic subtest vcs0: SUCCESS (0.001s)
[401.390696] Starting dynamic subtest: vcs1
[401.391436] Dynamic subtest vcs1: SUCCESS (0.000s)
[401.399277] Starting dynamic subtest: vecs0
[401.400073] Dynamic subtest vecs0: SUCCESS (0.001s)
[401.408473] Starting dynamic subtest: ccs0
[401.409234] Dynamic subtest ccs0: SUCCESS (0.000s)
[401.409996] Subtest init-sema: SUCCESS (0.008s)
[401.454029] [094/133] (632s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[401.504951] Subtest writes-after-reads-uncached: SKIP (0.000s)
[401.571662] [095/133] (632s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[401.648195] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[401.649120] Starting dynamic subtest: pipe-A
[401.668320] Dynamic subtest pipe-A: SKIP (0.019s)
[401.677195] Starting dynamic subtest: pipe-B
[401.700974] Dynamic subtest pipe-B: SKIP (0.032s)
[401.709865] Starting dynamic subtest: pipe-C
[401.734055] Dynamic subtest pipe-C: SKIP (0.033s)
[401.742811] Starting dynamic subtest: pipe-D
[401.768576] Dynamic subtest pipe-D: SKIP (0.033s)
[401.770338] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.119s)
[401.857528] [096/133] (632s left) gem_mmap_wc (write-gtt-read-wc)
[401.904600] Subtest write-gtt-read-wc: SKIP (0.000s)
[401.960819] [097/133] (632s left) prime_vgem (sync)
[402.049190] Starting subtest: sync
[402.050083] Starting dynamic subtest: rcs0
[402.082361] Dynamic subtest rcs0: SUCCESS (0.032s)
[402.091100] Starting dynamic subtest: bcs0
[402.138245] Dynamic subtest bcs0: SUCCESS (0.055s)
[402.146835] Starting dynamic subtest: vcs0
[402.188563] Dynamic subtest vcs0: SUCCESS (0.050s)
[402.197813] Starting dynamic subtest: vcs1
[402.234114] Dynamic subtest vcs1: SUCCESS (0.045s)
[402.242844] Starting dynamic subtest: vecs0
[402.280974] Dynamic subtest vecs0: SUCCESS (0.046s)
[402.289562] Starting dynamic subtest: ccs0
[402.327488] Dynamic subtest ccs0: SUCCESS (0.045s)
[402.328292] Subtest sync: SUCCESS (0.279s)
[402.433840] [098/133] (631s left) gem_exec_fence (submit3)
[402.623670] Starting subtest: submit3
[402.625825] Subtest submit3: SKIP (0.000s)
[404.860474] [099/133] (629s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[404.918107] Starting subtest: etime-multi-wait-for-submit-submitted
[405.027492] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[405.100390] [100/133] (629s left) i915_drm_fdinfo (all-busy-check-all)
[405.137676] Starting subtest: all-busy-check-all
[405.142506] Subtest all-busy-check-all: SKIP (0.005s)
[405.210022] [101/133] (629s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[405.343540] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[405.345182] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[405.440235] [102/133] (628s left) gem_exec_params (invalid-batch-start-offset)
[405.502893] Starting subtest: invalid-batch-start-offset
[405.503809] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[405.612999] [103/133] (628s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[405.716662] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[409.789233] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.073s)
[410.933677] [104/133] (623s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[411.036680] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[411.038498] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[411.116156] [105/133] (623s left) kms_getfb (getfb-addfb-different-handles)
[411.201116] Starting subtest: getfb-addfb-different-handles
[411.202006] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[411.290270] [106/133] (623s left) kms_dp_linktrain_fallback (dp-fallback)
[411.375003] Starting subtest: dp-fallback
[411.377476] Subtest dp-fallback: SKIP (0.000s)
[411.445476] [107/133] (623s left) api_intel_bb (offset-control)
[411.502940] Starting subtest: offset-control
[411.509202] Subtest offset-control: SUCCESS (0.008s)
[411.628998] [108/133] (622s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[411.719897] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[411.721776] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[412.855295] [109/133] (621s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[412.925271] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[412.926234] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[413.036162] [110/133] (621s left) sw_sync (sync_busy)
[413.071956] Starting subtest: sync_busy
[413.073184] Subtest sync_busy: SUCCESS (0.002s)
[413.121775] [111/133] (621s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[413.211030] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[413.212525] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[413.295105] [112/133] (621s left) i915_pm_rps (reset)
[413.360846] Starting subtest: reset
[421.851692] Subtest reset: SUCCESS (8.481s)
[421.974410] [113/133] (612s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[422.075196] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[429.583872] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.508s)
[429.703176] [114/133] (605s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[429.766250] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[429.867425] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[429.953079] [115/133] (604s left) kms_joiner (basic-force-ultra-joiner)
[430.036684] Starting subtest: basic-force-ultra-joiner
[430.038161] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[430.118764] [116/133] (604s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[430.226696] Starting subtest: extended-modeset-hang-newfb-with-reset
[430.227536] Starting dynamic subtest: pipe-A
[444.098041] Dynamic subtest pipe-A: SUCCESS (13.873s)
[444.107925] Starting dynamic subtest: pipe-D
[459.852160] Dynamic subtest pipe-D: SUCCESS (15.753s)
[459.852965] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.631s)
[460.642407] [117/133] (574s left) i915_suspend (basic-s3-without-i915)
[460.684304] Starting subtest: basic-s3-without-i915
[462.462040] Subtest basic-s3-without-i915: SKIP (1.765s)
[464.090292] [118/133] (570s left) kms_chamelium_frames (hdmi-aspect-ratio)
[464.495699] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[465.280938] [119/133] (569s left) gem_mmap_offset (partial-remap)
[465.334450] Starting subtest: partial-remap
[465.335411] Starting dynamic subtest: smem0
[465.341508] Dynamic subtest smem0: SUCCESS (0.006s)
[465.342385] Subtest partial-remap: SUCCESS (0.006s)
[465.447930] [120/133] (569s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[465.551474] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[466.355536] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[466.524402] [121/133] (568s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[466.577890] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[466.638692] [122/133] (568s left) gem_exec_suspend (basic-s3-devices)
[466.696753] Starting subtest: basic-S3-devices
[466.697704] Starting dynamic subtest: smem
[478.737552] Dynamic subtest smem: SUCCESS (12.029s)
[478.738742] Subtest basic-S3-devices: SUCCESS (12.032s)
[484.974691] [123/133] (556s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[485.037325] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[485.039413] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[485.215142] [124/133] (555s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[485.312032] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[485.313841] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[485.380083] [125/133] (555s left) kms_chamelium_color (ctm-negative)
[485.470951] Subtest ctm-negative: SKIP (0.000s)
[485.511306] [126/133] (555s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[485.614070] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[486.727442] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.113s)
[486.822401] [127/133] (554s left) kms_content_protection (suspend-resume)
[486.964334] Starting subtest: suspend-resume
[486.966002] Subtest suspend-resume: SKIP (0.000s)
[487.078389] [128/133] (554s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[487.173512] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[487.202161] Starting dynamic subtest: pipe-A-plane-0
[487.656306] Dynamic subtest pipe-A-plane-0: SUCCESS (0.454s)
[487.665465] Starting dynamic subtest: pipe-A-plane-3
[487.945104] Dynamic subtest pipe-A-plane-3: SUCCESS (0.287s)
[489.026017] Starting dynamic subtest: pipe-B-plane-0
[489.496581] Dynamic subtest pipe-B-plane-0: SUCCESS (0.477s)
[489.505842] Starting dynamic subtest: pipe-B-plane-3
[489.752329] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[490.064578] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.890s)
[490.891183] [129/133] (550s left) gem_exec_await (wide-all)
[491.106706] Starting subtest: wide-all
[514.526525] Subtest wide-all: SUCCESS (23.411s)
[514.711791] [130/133] (526s left) gem_exec_balancer (persistence)
[515.018356] Starting subtest: persistence
[516.040139] Subtest persistence: SUCCESS (1.020s)
[516.146831] [131/133] (525s left) gem_softpin (evict-prime)
[516.198325] Starting subtest: evict-prime
[516.199299] Starting dynamic subtest: rcs0
[517.338448] Dynamic subtest rcs0: SUCCESS (1.139s)
[517.349165] Starting dynamic subtest: bcs0
[518.466056] Dynamic subtest bcs0: SUCCESS (1.125s)
[518.477990] Starting dynamic subtest: vcs0
[519.766342] Dynamic subtest vcs0: SUCCESS (1.288s)
[519.780083] Starting dynamic subtest: vcs1
[521.742608] Dynamic subtest vcs1: SUCCESS (1.974s)
[521.753621] Starting dynamic subtest: vecs0
[523.740102] Dynamic subtest vecs0: SUCCESS (1.995s)
[523.752090] Starting dynamic subtest: ccs0
[524.860168] Dynamic subtest ccs0: SUCCESS (1.127s)
[524.871705] Starting dynamic subtest: all
[526.734421] Dynamic subtest all: SUCCESS (1.862s)
[526.735821] Subtest evict-prime: SUCCESS (10.526s)
[526.805590] [132/133] (514s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[526.904547] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[526.906147] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[526.997961] [133/133] (514s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[527.086406] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[533.919383] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.833s)
[534.056378] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_vrr
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_draw_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_async_flips
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: gem_render_copy_redux
results: parsing output: 13/ for test: syncobj_eventfd
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_atomic_interruptible
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_plane_multiple
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: prime_vgem
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: fbdev
results: parsing output: 35/ for test: gem_linear_blits
results: parsing output: 36/ for test: kms_chamelium_hpd
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: syncobj_basic
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_pipe_b_c_ivb
results: parsing output: 42/ for test: syncobj_basic
results: parsing output: 43/ for test: gem_madvise
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_atomic_transition
results: parsing output: 49/ for test: api_intel_allocator
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_pxp
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: gem_mmap
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: gem_partial_pwrite_pread
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: i915_hangman
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_async_flips
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: dmabuf_sync_file
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_create
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_whisper
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gem_lmem_swapping
results: parsing output: 82/ for test: gen9_exec_parse
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_sequence
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: syncobj_basic
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: gem_partial_pwrite_pread
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: gem_mmap_wc
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: kms_dp_linktrain_fallback
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: i915_pm_rps
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: kms_joiner
results: parsing output: 115/ for test: kms_busy
results: parsing output: 116/ for test: i915_suspend
results: parsing output: 117/ for test: kms_chamelium_frames
results: parsing output: 118/ for test: gem_mmap_offset
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: gem_exec_suspend
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_content_protection
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: gem_exec_await
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.