[57.843048] Initializing watchdogs
[57.843091]   /dev/watchdog0
[57.857175] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.861346] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.863486] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.866886] [001/156] (960s left) syncobj_wait (wait-zero-handles)
[57.945085] Starting subtest: wait-zero-handles
[57.947493] Subtest wait-zero-handles: SUCCESS (0.000s)
[58.039257] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[58.155655] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[58.159982] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[58.265199] [003/156] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[58.367973] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[59.036361] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[59.219072] [004/156] (959s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[59.314927] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[59.319612] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[59.453066] [005/156] (959s left) gem_softpin (allocator-basic-reserve)
[59.506856] Starting subtest: allocator-basic-reserve
[59.581423] Subtest allocator-basic-reserve: SUCCESS (0.074s)
[59.720077] [006/156] (958s left) core_setmaster (master-drop-set-user)
[59.808846] Starting subtest: master-drop-set-user
[59.821516] Subtest master-drop-set-user: SUCCESS (0.013s)
[59.879881] [007/156] (958s left) gem_ctx_isolation (preservation)
[59.930689] Starting subtest: preservation
[59.932818] Starting dynamic subtest: rcs0
[60.062705] Dynamic subtest rcs0: SUCCESS (0.131s)
[60.074434] Starting dynamic subtest: bcs0
[60.206987] Dynamic subtest bcs0: SUCCESS (0.144s)
[60.214518] Starting dynamic subtest: vcs0
[60.361108] Dynamic subtest vcs0: SUCCESS (0.154s)
[60.369084] Starting dynamic subtest: vcs1
[62.398484] Dynamic subtest vcs1: SUCCESS (2.036s)
[62.408154] Starting dynamic subtest: vecs0
[64.461485] Dynamic subtest vecs0: SUCCESS (2.063s)
[64.469422] Starting dynamic subtest: ccs0
[66.458872] Dynamic subtest ccs0: SUCCESS (1.996s)
[66.461314] Subtest preservation: SUCCESS (6.527s)
[66.693969] [008/156] (951s left) gem_exec_params (secure-non-root)
[66.748950] Starting subtest: secure-non-root
[66.753518] Subtest secure-non-root: SKIP (0.000s)
[66.855982] [009/156] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[66.956425] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[74.750104] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.800s)
[74.885618] [010/156] (943s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[74.980982] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[74.992284] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[75.099236] [011/156] (943s left) perf (invalid-oa-exponent)
[75.226621] Starting subtest: invalid-oa-exponent
[75.240264] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[75.274206] [012/156] (943s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[75.365520] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[75.369904] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[75.466131] [013/156] (943s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[75.561704] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[75.566300] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[75.663370] [014/156] (943s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[75.757211] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[75.760906] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[75.826373] [015/156] (943s left) gem_exec_params (rsvd2-dirt)
[75.871138] Starting subtest: rsvd2-dirt
[75.874591] Subtest rsvd2-dirt: SKIP (0.000s)
[75.970775] [016/156] (943s left) perf_pmu (all-busy-check-all)
[76.005268] Starting subtest: all-busy-check-all
[77.320683] Subtest all-busy-check-all: SUCCESS (1.313s)
[77.432889] [017/156] (941s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[77.550861] Starting subtest: 2x-flip-vs-cursor-legacy
[77.555270] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[77.694322] [018/156] (941s left) gem_workarounds (reset-context)
[77.756894] Starting subtest: reset-context
[77.912871] Subtest reset-context: SUCCESS (0.155s)
[78.015719] [019/156] (941s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[78.116662] Starting subtest: fbc-psr-sprite-mmap-cpu
[78.118590] Starting dynamic subtest: eDP-1
[78.122705] Dynamic subtest eDP-1: SKIP (0.000s)
[78.127191] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[78.200058] [020/156] (940s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[78.298300] Starting subtest: flip-vs-dpms-off-vs-modeset
[78.300700] Starting dynamic subtest: A-eDP1
[81.914751] Dynamic subtest A-eDP1: SUCCESS (3.613s)
[81.924543] Starting dynamic subtest: B-eDP1
[85.110297] Dynamic subtest B-eDP1: SUCCESS (3.197s)
[85.120618] Starting dynamic subtest: C-eDP1
[88.321720] Dynamic subtest C-eDP1: SUCCESS (3.212s)
[88.330489] Starting dynamic subtest: D-eDP1
[91.606642] Dynamic subtest D-eDP1: SUCCESS (3.284s)
[91.608994] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.311s)
[92.420711] [021/156] (926s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[92.523937] Starting subtest: fbc-rgb565-draw-pwrite
[97.081586] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.563s)
[98.227367] [022/156] (920s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[98.339973] Starting subtest: 4-tiled-16bpp-rotate-270
[98.363647] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.023s)
[98.473717] [023/156] (920s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[98.566199] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[98.570637] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.651803] [024/156] (920s left) syncobj_timeline (single-wait-for-submit-signaled)
[98.703077] Starting subtest: single-wait-for-submit-signaled
[98.705341] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[98.783653] [025/156] (920s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[98.866068] Starting subtest: fbc-pr-cursor-mmap-cpu
[98.870372] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[98.939548] [026/156] (920s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[99.028145] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[99.032108] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[99.123587] [027/156] (920s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[99.225124] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[99.228817] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[99.316853] [028/156] (920s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[99.418674] Starting subtest: y-tiled-16bpp-rotate-270
[99.422101] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[99.529670] [029/156] (919s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[99.640245] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[99.643721] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[99.778314] [030/156] (919s left) kms_setmode (basic)
[99.825976] Starting subtest: basic
[100.154082] Starting dynamic subtest: pipe-A-eDP-1
[102.217017] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.059s)
[102.568266] Starting dynamic subtest: pipe-B-eDP-1
[104.646955] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.087s)
[104.953679] Subtest basic: SUCCESS (5.125s)
[105.793698] [031/156] (913s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[105.886782] Starting subtest: nonblocking-crc-frame-sequence
[105.889348] Starting dynamic subtest: pipe-A-eDP-1
[106.653643] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.768s)
[106.662759] Starting dynamic subtest: pipe-B-eDP-1
[108.106916] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.451s)
[108.117337] Starting dynamic subtest: pipe-C-eDP-1
[109.519610] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.413s)
[109.530739] Starting dynamic subtest: pipe-D-eDP-1
[110.944582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.422s)
[110.947027] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.058s)
[111.842799] [032/156] (907s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[111.905827] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[111.910654] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[112.084817] [033/156] (907s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[112.167305] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[112.171611] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[112.236894] [034/156] (907s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[112.340415] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[115.076862] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.743s)
[116.258160] [035/156] (903s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[116.302911] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[116.305207] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[116.405720] [036/156] (903s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[116.509354] Starting subtest: hdr-1p-pri-indfb-multidraw
[116.513761] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[116.595845] [037/156] (903s left) api_intel_allocator (open-vm)
[116.648396] Starting subtest: open-vm
[116.653038] Subtest open-vm: SUCCESS (0.004s)
[116.787356] [038/156] (903s left) kms_lease (lease-again)
[116.868116] Starting subtest: lease-again
[116.870419] Starting dynamic subtest: pipe-A-eDP-1
[116.872679] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[116.883314] Starting dynamic subtest: pipe-B-eDP-1
[116.885569] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[116.894313] Starting dynamic subtest: pipe-C-eDP-1
[116.896601] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[116.905615] Starting dynamic subtest: pipe-D-eDP-1
[116.907893] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[116.910165] Subtest lease-again: SUCCESS (0.011s)
[116.984010] [039/156] (902s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[117.080720] Starting subtest: yf-tiled-8bpp-rotate-90
[117.084809] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[117.170683] [040/156] (902s left) kms_vrr (seamless-rr-switch-vrr)
[117.277230] Starting subtest: seamless-rr-switch-vrr
[117.282582] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[117.356975] [041/156] (902s left) kms_psr (psr-cursor-mmap-gtt)
[117.446958] Starting subtest: psr-cursor-mmap-gtt
[117.449162] Starting dynamic subtest: eDP-1
[119.150610] Dynamic subtest eDP-1: SUCCESS (1.703s)
[119.152653] Subtest psr-cursor-mmap-gtt: SUCCESS (1.703s)
[120.023199] [042/156] (899s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[120.115830] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[120.120089] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[120.200496] [043/156] (899s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[120.250061] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[120.355739] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[120.444888] [044/156] (899s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[120.550135] Starting subtest: basic-busy-flip-before-cursor-varying-size
[120.554610] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[120.695504] [045/156] (899s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[120.750093] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[120.813988] [046/156] (899s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[120.904560] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[120.909063] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[121.008951] [047/156] (899s left) gem_ctx_persistence (heartbeat-hostile)
[121.072074] Starting subtest: heartbeat-hostile
[121.076601] Subtest heartbeat-hostile: SKIP (0.000s)
[121.169888] [048/156] (899s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[121.272902] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[121.277377] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[121.367554] [049/156] (898s left) gem_flink_basic (double-flink)
[121.428621] Starting subtest: double-flink
[121.430671] Subtest double-flink: SUCCESS (0.000s)
[121.531062] [050/156] (898s left) perf (invalid-oa-metric-set-id)
[121.631817] Starting subtest: invalid-oa-metric-set-id
[121.643963] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[121.681934] [051/156] (898s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary)
[121.782740] Starting subtest: hdr-indfb-scaledprimary
[121.786349] Subtest hdr-indfb-scaledprimary: SKIP (0.000s)
[121.868737] [052/156] (898s left) kms_cursor_crc (cursor-offscreen-256x256)
[122.111307] Starting subtest: cursor-offscreen-256x256
[122.113249] Starting dynamic subtest: pipe-A-eDP-1
[124.058435] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s)
[124.088882] Starting dynamic subtest: pipe-D-eDP-1
[126.731103] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.649s)
[126.733607] Subtest cursor-offscreen-256x256: SUCCESS (4.620s)
[127.586661] [053/156] (892s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[127.685105] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[128.831321] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.145s)
[128.940323] [054/156] (891s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[128.992727] Starting subtest: invalid-single-wait-unsubmitted
[128.994442] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[129.109858] [055/156] (891s left) gem_linear_blits (basic)
[129.391238] Starting subtest: basic
[129.401677] Subtest basic: SUCCESS (0.013s)
[129.572935] [056/156] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[129.733450] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[129.737692] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[129.834208] [057/156] (890s left) syncobj_wait (reset-during-wait-for-submit)
[129.897715] Starting subtest: reset-during-wait-for-submit
[130.002537] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[130.076635] [058/156] (890s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[130.173434] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[130.175751] Starting dynamic subtest: pipe-A
[131.220921] Dynamic subtest pipe-A: SUCCESS (1.051s)
[131.229889] Starting dynamic subtest: pipe-B
[133.391152] Dynamic subtest pipe-B: SUCCESS (2.170s)
[133.401158] Starting dynamic subtest: pipe-C
[134.596133] Dynamic subtest pipe-C: SUCCESS (1.204s)
[134.607235] Starting dynamic subtest: pipe-D
[135.838665] Dynamic subtest pipe-D: SUCCESS (1.242s)
[135.840914] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.669s)
[137.018534] [059/156] (883s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[137.112822] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[137.115165] Starting dynamic subtest: pipe-A-eDP-1
[137.138786] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[137.148853] Starting dynamic subtest: pipe-B-eDP-1
[137.171112] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[137.179864] Starting dynamic subtest: pipe-C-eDP-1
[137.201389] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[137.210392] Starting dynamic subtest: pipe-D-eDP-1
[137.232415] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[137.236470] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[139.400666] [060/156] (881s left) gem_sync (basic-many-each)
[139.480622] Starting subtest: basic-many-each
[141.745147] Subtest basic-many-each: SUCCESS (2.275s)
[141.923575] [061/156] (878s left) gem_mmap (pf-nonblock)
[141.982715] Subtest pf-nonblock: SKIP (0.000s)
[142.038115] [062/156] (878s left) fbdev (unaligned-write)
[142.072620] Starting subtest: unaligned-write
[142.170696] Subtest unaligned-write: SUCCESS (0.099s)
[142.233396] [063/156] (878s left) kms_color (ctm-signed)
[142.338069] Starting subtest: ctm-signed
[142.339978] Starting dynamic subtest: pipe-A-eDP-1
[144.514249] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.175s)
[144.523499] Starting dynamic subtest: pipe-B-eDP-1
[147.373526] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.859s)
[147.383592] Starting dynamic subtest: pipe-C-eDP-1
[150.062291] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.687s)
[150.072542] Starting dynamic subtest: pipe-D-eDP-1
[152.719659] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.657s)
[152.722048] Subtest ctm-signed: SUCCESS (10.381s)
[153.552759] [064/156] (867s left) gem_ctx_param (invalid-size-set)
[153.605799] Starting subtest: invalid-size-set
[153.608335] Subtest invalid-size-set: SUCCESS (0.001s)
[153.714694] [065/156] (867s left) kms_psr (pr-sprite-blt)
[153.806085] Starting subtest: pr-sprite-blt
[153.810176] Subtest pr-sprite-blt: SKIP (0.000s)
[153.878492] [066/156] (867s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[153.998371] Starting subtest: short-busy-flip-before-cursor-toggle
[154.002892] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[154.140832] [067/156] (866s left) gen9_exec_parse (bb-start-param)
[154.196054] Subtest bb-start-param: SKIP (0.000s)
[154.270223] [068/156] (866s left) kms_addfb_basic (bad-pitch-1024)
[154.314328] Starting subtest: bad-pitch-1024
[154.316581] Subtest bad-pitch-1024: SUCCESS (0.000s)
[154.442570] [069/156] (866s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[154.489079] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[154.596056] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[154.671640] [070/156] (866s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[154.811829] Starting subtest: multiplane-atomic-fence-wait
[155.046124] Subtest multiplane-atomic-fence-wait: SUCCESS (0.233s)
[156.180968] [071/156] (864s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[156.420719] Starting subtest: cursor-rapid-movement-256x256
[156.425973] Starting dynamic subtest: pipe-A-eDP-1
[156.995059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[157.021522] Starting dynamic subtest: pipe-D-eDP-1
[158.198688] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.182s)
[158.200688] Subtest cursor-rapid-movement-256x256: SUCCESS (1.776s)
[159.075579] [072/156] (862s left) i915_query (engine-info-invalid)
[159.138658] Starting subtest: engine-info-invalid
[159.140921] Subtest engine-info-invalid: SUCCESS (0.000s)
[159.236898] [073/156] (861s left) kms_plane_scaling (planes-downscale-factor-0-5)
[159.333757] Starting subtest: planes-downscale-factor-0-5
[159.336044] Starting dynamic subtest: pipe-A
[159.358279] Dynamic subtest pipe-A: SKIP (0.021s)
[159.368521] Starting dynamic subtest: pipe-B
[159.394415] Dynamic subtest pipe-B: SKIP (0.032s)
[159.407074] Starting dynamic subtest: pipe-C
[159.425511] Dynamic subtest pipe-C: SKIP (0.032s)
[159.434963] Starting dynamic subtest: pipe-D
[159.457803] Dynamic subtest pipe-D: SKIP (0.032s)
[159.462244] Subtest planes-downscale-factor-0-5: SKIP (0.120s)
[159.548371] [074/156] (861s left) prime_busy (after)
[159.607804] Starting subtest: after
[159.610094] Starting dynamic subtest: rcs0
[159.648226] Dynamic subtest rcs0: SUCCESS (0.040s)
[159.659472] Starting dynamic subtest: bcs0
[159.706477] Dynamic subtest bcs0: SUCCESS (0.057s)
[159.716049] Starting dynamic subtest: vcs0
[159.746526] Dynamic subtest vcs0: SUCCESS (0.040s)
[159.755623] Starting dynamic subtest: vcs1
[159.787960] Dynamic subtest vcs1: SUCCESS (0.040s)
[159.797096] Starting dynamic subtest: vecs0
[159.828767] Dynamic subtest vecs0: SUCCESS (0.040s)
[159.841781] Starting dynamic subtest: ccs0
[159.869804] Dynamic subtest ccs0: SUCCESS (0.040s)
[159.977156] Subtest after: SUCCESS (0.371s)
[160.057470] [075/156] (861s left) gem_eio (wait-wedge-10ms)
[160.285787] Starting subtest: wait-wedge-10ms
[161.365183] Subtest wait-wedge-10ms: SUCCESS (1.079s)
[161.491654] [076/156] (859s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[161.584035] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[161.588703] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[161.693050] [077/156] (859s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[161.804688] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[161.807033] Starting dynamic subtest: pipe-A-eDP-1
[172.504252] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.700s)
[172.516510] Starting dynamic subtest: pipe-B-eDP-1
[183.973988] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.469s)
[183.976440] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.171s)
[184.843473] [078/156] (836s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[184.913528] Starting subtest: yf-tiled-ccs-to-yf-tiled
[184.918082] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[185.098403] [079/156] (836s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[185.202870] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[185.207225] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[185.305048] [080/156] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[185.397766] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[185.402176] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[185.485618] [081/156] (836s left) kms_prop_blob (invalid-set-prop-any)
[185.533074] Starting subtest: invalid-set-prop-any
[185.535279] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[185.624784] [082/156] (835s left) gem_exec_alignment (forked)
[185.687475] Starting subtest: forked
[224.809390] Subtest forked: SUCCESS (39.118s)
[224.894565] [083/156] (796s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[225.040164] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[225.042426] Starting dynamic subtest: pipe-A-eDP-1
[225.065828] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.076938] Starting dynamic subtest: pipe-B-eDP-1
[225.099189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.109123] Starting dynamic subtest: pipe-C-eDP-1
[225.130269] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.143297] Starting dynamic subtest: pipe-D-eDP-1
[225.165746] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[225.169954] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[227.341603] [084/156] (794s left) gem_mmap_offset (isolation)
[227.405041] Starting subtest: isolation
[227.422783] Subtest isolation: SUCCESS (0.005s)
[227.505517] [085/156] (794s left) gem_exec_fence (syncobj-timeline-signal)
[228.123603] Starting subtest: syncobj-timeline-signal
[228.129967] Subtest syncobj-timeline-signal: SUCCESS (0.007s)
[229.399674] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[229.403830] [086/156] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[229.503767] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[229.508112] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[229.617663] [087/156] (792s left) kms_fbcon_fbt (fbc-suspend)
[229.676429] Starting subtest: fbc-suspend
[278.548537] Subtest fbc-suspend: SUCCESS (19.979s)
[279.895261] [088/156] (741s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[279.998640] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[280.002666] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[280.098203] [089/156] (741s left) api_intel_bb (simple-bb)
[280.152443] Starting subtest: simple-bb
[280.156981] Subtest simple-bb: SUCCESS (0.006s)
[280.283488] [090/156] (741s left) kms_async_flips (async-flip-dpms)
[280.367525] Starting subtest: async-flip-dpms
[280.754256] Starting dynamic subtest: pipe-A-eDP-1
[284.622225] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.868s)
[285.006252] Starting dynamic subtest: pipe-B-eDP-1
[287.892850] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.897s)
[288.273032] Starting dynamic subtest: pipe-C-eDP-1
[291.140513] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.878s)
[291.526208] Starting dynamic subtest: pipe-D-eDP-1
[294.395042] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.880s)
[294.397206] Subtest async-flip-dpms: SUCCESS (14.028s)
[295.587911] [091/156] (726s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[295.684170] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[295.686520] Starting dynamic subtest: pipe-A-eDP-1
[295.709319] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[295.721872] Starting dynamic subtest: pipe-B-eDP-1
[295.743798] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[295.754278] Starting dynamic subtest: pipe-C-eDP-1
[295.776207] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[295.786666] Starting dynamic subtest: pipe-D-eDP-1
[295.810209] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[295.815010] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[297.935910] [092/156] (724s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[298.038994] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[298.043216] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[298.133593] [093/156] (723s left) gem_eio (in-flight-suspend)
[298.350418] Starting subtest: in-flight-suspend
[341.748432] Subtest in-flight-suspend: SUCCESS (13.821s)
[341.887009] [094/156] (680s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[341.996576] Starting subtest: yf-tiled-32bpp-rotate-90
[342.001035] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[342.095974] [095/156] (680s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[342.191256] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[342.195271] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[342.289905] [096/156] (679s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[342.382164] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[342.386591] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[342.462577] [097/156] (679s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[342.558250] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[342.561918] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[342.658145] [098/156] (679s left) i915_drm_fdinfo (isolation)
[342.697054] Starting subtest: isolation
[342.698633] Starting dynamic subtest: rcs0
[342.720555] Dynamic subtest rcs0: SKIP (0.024s)
[342.733509] Starting dynamic subtest: bcs0
[342.736952] Dynamic subtest bcs0: SKIP (0.000s)
[342.750201] Starting dynamic subtest: vcs0
[342.754045] Dynamic subtest vcs0: SKIP (0.000s)
[342.763981] Starting dynamic subtest: vcs1
[342.767597] Dynamic subtest vcs1: SKIP (0.000s)
[342.777523] Starting dynamic subtest: vecs0
[342.781236] Dynamic subtest vecs0: SKIP (0.000s)
[342.791492] Starting dynamic subtest: ccs0
[342.795234] Dynamic subtest ccs0: SKIP (0.000s)
[342.798933] Subtest isolation: SKIP (0.029s)
[342.836079] [099/156] (679s left) kms_selftest (drm_format)
[342.873086] Starting subtest: drm_format
[342.879663] Starting dynamic subtest: drm_test_format_block_width_invalid
[342.975442] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.094s)
[342.985436] Starting dynamic subtest: drm_test_format_block_width_one_plane
[343.076186] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.101s)
[343.087067] Starting dynamic subtest: drm_test_format_block_width_two_plane
[343.163151] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.085s)
[343.173605] Starting dynamic subtest: drm_test_format_block_width_three_plane
[343.257088] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.093s)
[343.267227] Starting dynamic subtest: drm_test_format_block_width_tiled
[343.364423] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.108s)
[343.374636] Starting dynamic subtest: drm_test_format_block_height_invalid
[343.467191] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.098s)
[343.480505] Starting dynamic subtest: drm_test_format_block_height_one_plane
[343.548739] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.079s)
[343.559381] Starting dynamic subtest: drm_test_format_block_height_two_plane
[343.653537] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.103s)
[343.663769] Starting dynamic subtest: drm_test_format_block_height_three_plane
[343.754741] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.097s)
[343.765841] Starting dynamic subtest: drm_test_format_block_height_tiled
[343.867943] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.113s)
[343.878093] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[343.972222] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.104s)
[343.982607] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[344.071626] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.097s)
[344.083099] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[344.170134] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.099s)
[344.181439] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[344.277920] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.107s)
[344.287825] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[344.400860] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.122s)
[344.412174] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[344.507023] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.104s)
[344.519216] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[344.609058] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.100s)
[344.622216] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[344.722507] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.111s)
[344.724370] Subtest drm_format: SUCCESS (1.847s)
[344.897348] [100/156] (677s left) gem_exec_balancer (persistence)
[345.157215] Starting subtest: persistence
[346.059909] Subtest persistence: SUCCESS (0.901s)
[346.169664] [101/156] (676s left) gem_exec_balancer (hang)
[346.430268] Starting subtest: hang
[348.112362] Subtest hang: SUCCESS (1.685s)
[348.250738] [102/156] (674s left) kms_vblank (wait-forked-hang)
[348.341899] Starting subtest: wait-forked-hang
[348.344135] Starting dynamic subtest: pipe-A-eDP-1
[374.502649] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.153s)
[374.518208] Starting dynamic subtest: pipe-D-eDP-1
[399.530184] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.017s)
[399.532592] Subtest wait-forked-hang: SUCCESS (51.175s)
[400.407240] [103/156] (622s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[400.505730] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[400.510250] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[400.598487] [104/156] (621s left) gem_exec_whisper (basic-sync)
[400.659299] Starting subtest: basic-sync
[409.240528] Subtest basic-sync: SUCCESS (8.579s)
[409.427894] [105/156] (613s left) gem_exec_schedule (pi-common)
[409.610981] Starting subtest: pi-common
[409.613420] Starting dynamic subtest: rcs0
[409.639698] Dynamic subtest rcs0: SUCCESS (0.033s)
[409.656657] Starting dynamic subtest: bcs0
[409.671947] Dynamic subtest bcs0: SUCCESS (0.031s)
[409.682637] Starting dynamic subtest: vcs0
[409.705144] Dynamic subtest vcs0: SUCCESS (0.032s)
[409.715532] Starting dynamic subtest: vcs1
[409.738493] Dynamic subtest vcs1: SUCCESS (0.032s)
[409.749191] Starting dynamic subtest: vecs0
[409.770933] Dynamic subtest vecs0: SUCCESS (0.032s)
[409.781408] Starting dynamic subtest: ccs0
[409.804258] Dynamic subtest ccs0: SUCCESS (0.032s)
[409.806435] Subtest pi-common: SUCCESS (0.198s)
[410.065044] [106/156] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[410.160209] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[410.164421] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[410.258118] [107/156] (612s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[410.358412] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[417.245099] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.889s)
[417.387568] [108/156] (605s left) gem_userptr_blits (set-cache-level)
[417.444916] Starting subtest: set-cache-level
[417.449306] Subtest set-cache-level: SKIP (0.000s)
[417.561103] [109/156] (605s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[417.651359] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[425.088864] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.440s)
[425.203632] [110/156] (597s left) kms_rotation_crc (bad-pixel-format)
[425.301516] Starting subtest: bad-pixel-format
[425.305445] Subtest bad-pixel-format: SKIP (0.001s)
[425.386933] [111/156] (597s left) gem_mmap_gtt (basic-copy)
[425.441328] Subtest basic-copy: SKIP (0.000s)
[425.508773] [112/156] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[425.608688] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[448.683467] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.082s)
[448.810811] [113/156] (574s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[448.917344] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[448.921065] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[449.007906] [114/156] (573s left) perf_pmu (interrupts-sync)
[449.048003] Starting subtest: interrupts-sync
[450.126287] Subtest interrupts-sync: SUCCESS (1.077s)
[450.260032] [115/156] (572s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[450.361347] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[450.365805] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[450.464781] [116/156] (572s left) i915_pm_rpm (reg-read-ioctl)
[452.022447] Starting subtest: reg-read-ioctl
[454.402911] Subtest reg-read-ioctl: SUCCESS (2.383s)
[454.793887] [117/156] (568s left) sw_sync (sync_multi_timeline_wait)
[454.830308] Starting subtest: sync_multi_timeline_wait
[454.832818] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[454.886379] [118/156] (568s left) gem_exec_reloc (basic-write-cpu-active)
[454.942303] Subtest basic-write-cpu-active: SKIP (0.000s)
[455.015860] [119/156] (568s left) kms_busy (basic)
[455.101717] Starting subtest: basic
[455.103995] Starting dynamic subtest: flip
[455.688886] Dynamic subtest flip: SUCCESS (0.587s)
[455.700189] Starting dynamic subtest: modeset
[459.357379] Dynamic subtest modeset: SUCCESS (3.668s)
[459.359669] Subtest basic: SUCCESS (4.257s)
[460.160117] [120/156] (563s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[460.264033] Starting subtest: psrhdr-rgb565-draw-render
[460.268201] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[460.360517] [121/156] (562s left) kms_flip (2x-plain-flip-ts-check)
[460.441431] Starting subtest: 2x-plain-flip-ts-check
[460.453304] Subtest 2x-plain-flip-ts-check: SKIP (0.012s)
[460.626522] [122/156] (562s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[460.686182] Starting subtest: etime-single-wait-for-submit-unsubmitted
[460.794795] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[460.888133] [123/156] (562s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[460.984521] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[460.988996] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[461.103063] [124/156] (562s left) gem_close_race (multigpu-basic-process)
[461.162395] Starting subtest: multigpu-basic-process
[461.166961] Subtest multigpu-basic-process: SKIP (0.000s)
[461.399321] [125/156] (562s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[461.487826] Starting subtest: random-ccs-data-y-tiled-ccs
[461.490055] Starting dynamic subtest: pipe-A-eDP-1
[461.514645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[461.527064] Starting dynamic subtest: pipe-B-eDP-1
[461.549573] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[461.560506] Starting dynamic subtest: pipe-C-eDP-1
[461.583731] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[461.594038] Starting dynamic subtest: pipe-D-eDP-1
[461.618002] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[461.622387] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[463.817981] [126/156] (559s left) gem_exec_store (basic)
[463.884620] Starting subtest: basic
[463.988102] Subtest basic: SUCCESS (0.105s)
[464.176881] [127/156] (559s left) gem_exec_schedule (u-fairslice-all)
[464.238016] Starting subtest: u-fairslice-all
[466.292093] Subtest u-fairslice-all: SUCCESS (2.057s)
[466.589756] [128/156] (557s left) kms_psr (psr-sprite-mmap-gtt)
[466.691424] Starting subtest: psr-sprite-mmap-gtt
[466.693786] Starting dynamic subtest: eDP-1
[468.124642] Dynamic subtest eDP-1: SKIP (1.430s)
[468.129689] Subtest psr-sprite-mmap-gtt: SKIP (1.432s)
[468.299332] [129/156] (555s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[468.387562] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[468.389397] Starting dynamic subtest: pipe-A-eDP-1
[468.412185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[468.424105] Starting dynamic subtest: pipe-B-eDP-1
[468.443751] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[468.455602] Starting dynamic subtest: pipe-C-eDP-1
[468.475153] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[468.486065] Starting dynamic subtest: pipe-D-eDP-1
[468.506565] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[468.508845] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[470.718241] [130/156] (552s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[470.810363] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[475.754802] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.949s)
[476.927235] [131/156] (546s left) kms_pm_dc (dc5-dpms)
[478.031595] Starting subtest: dc5-dpms
[480.090064] Subtest dc5-dpms: SUCCESS (2.059s)
[480.173915] [132/156] (543s left) gem_exec_suspend (basic)
[480.231621] Starting subtest: basic
[480.234162] Starting dynamic subtest: smem
[481.766523] Dynamic subtest smem: SUCCESS (1.532s)
[481.769489] Subtest basic: SUCCESS (1.535s)
[481.957398] [133/156] (541s left) gem_partial_pwrite_pread (reads)
[482.003079] Subtest reads: SKIP (0.000s)
[482.064763] [134/156] (541s left) kms_pm_rpm (modeset-pc8-residency-stress)
[483.896228] Starting subtest: modeset-pc8-residency-stress
[483.901604] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[484.402404] [135/156] (539s left) gem_exec_params (invalid-flag)
[484.450891] Starting subtest: invalid-flag
[484.453080] Subtest invalid-flag: SUCCESS (0.000s)
[484.553581] [136/156] (539s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[484.650800] Starting subtest: fbcpsr-rgb101010-draw-blt
[489.452880] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.809s)
[489.570881] [137/156] (534s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen)
[489.680098] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen
[489.684506] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[489.773875] [138/156] (534s left) prime_mmap (test_forked_cpu_write)
[489.832023] Starting subtest: test_forked_cpu_write
[489.834336] Starting dynamic subtest: test_forked_cpu_write-smem
[489.840947] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[489.843226] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[489.949304] [139/156] (534s left) kms_psr (fbc-psr2-no-drrs)
[490.047623] Starting subtest: fbc-psr2-no-drrs
[490.049818] Starting dynamic subtest: eDP-1
[490.054157] Dynamic subtest eDP-1: SKIP (0.000s)
[490.058183] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[490.126178] [140/156] (534s left) kms_invalid_mode (zero-vdisplay)
[490.222301] Starting subtest: zero-vdisplay
[490.224617] Starting dynamic subtest: pipe-A-eDP-1
[490.520375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[490.532179] Starting dynamic subtest: pipe-B-eDP-1
[490.534145] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[490.545098] Starting dynamic subtest: pipe-C-eDP-1
[490.547346] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[490.557915] Starting dynamic subtest: pipe-D-eDP-1
[490.560171] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[490.562342] Subtest zero-vdisplay: SUCCESS (0.306s)
[491.346068] [141/156] (532s left) kms_flip (2x-flip-vs-dpms)
[491.452065] Starting subtest: 2x-flip-vs-dpms
[491.461212] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[491.538283] [142/156] (532s left) gem_tiled_blits (normal)
[491.600381] Subtest normal: SKIP (0.000s)
[491.672419] [143/156] (532s left) gem_exec_flush (basic-batch-kernel-default-wb)
[491.731146] Starting subtest: basic-batch-kernel-default-wb
[499.165528] Subtest basic-batch-kernel-default-wb: SUCCESS (7.434s)
[499.366289] [144/156] (524s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[499.471625] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[503.189341] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.724s)
[504.352627] [145/156] (519s left) kms_tv_load_detect (load-detect)
[504.408192] Subtest load-detect: SKIP (0.000s)
[504.469425] [146/156] (519s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[504.565112] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[504.569339] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[504.661891] [147/156] (519s left) kms_chamelium_hpd (hdmi-hpd)
[505.045928] Subtest hdmi-hpd: SKIP (0.000s)
[505.844225] [148/156] (518s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[505.951412] Starting subtest: psr-rgb101010-draw-blt
[513.306676] Subtest psr-rgb101010-draw-blt: SUCCESS (7.361s)
[513.419132] [149/156] (511s left) perf_pmu (gt-awake)
[513.458902] Starting subtest: gt-awake
[521.768340] Subtest gt-awake: SUCCESS (8.307s)
[521.859704] [150/156] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[521.953488] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[521.957670] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[522.059768] [151/156] (502s left) syncobj_timeline (multi-wait-signaled)
[522.105480] Starting subtest: multi-wait-signaled
[522.107700] Subtest multi-wait-signaled: SUCCESS (0.000s)
[522.203695] [152/156] (502s left) gem_exec_fence (syncobj-wait)
[522.628061] Starting subtest: syncobj-wait
[523.767339] Subtest syncobj-wait: SUCCESS (1.137s)
[525.776211] [153/156] (498s left) kms_content_protection (dp-mst-lic-type-1)
[525.931431] Starting subtest: dp-mst-lic-type-1
[525.935958] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[526.070107] [154/156] (498s left) i915_hangman (engine-engine-hang)
[526.129474] Starting subtest: engine-engine-hang
[526.131669] Starting dynamic subtest: rcs0
[527.768586] Dynamic subtest rcs0: SUCCESS (1.617s)
[527.784182] Starting dynamic subtest: bcs0
[529.731935] Dynamic subtest bcs0: SUCCESS (1.983s)
[529.744717] Starting dynamic subtest: vcs0
[531.715758] Dynamic subtest vcs0: SUCCESS (1.981s)
[531.730407] Starting dynamic subtest: vcs1
[533.700896] Dynamic subtest vcs1: SUCCESS (1.982s)
[533.715174] Starting dynamic subtest: vecs0
[535.748834] Dynamic subtest vecs0: SUCCESS (2.045s)
[535.762072] Starting dynamic subtest: ccs0
[537.731639] Dynamic subtest ccs0: SUCCESS (1.980s)
[537.734655] Subtest engine-engine-hang: SUCCESS (11.603s)
[537.815204] [155/156] (486s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[537.920301] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[544.610354] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.694s)
[544.725854] [156/156] (480s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[545.124591] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[545.935711] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: core_setmaster
results: parsing output: 6/ for test: gem_ctx_isolation
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_workarounds
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_setmode
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_vrr
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_flink_basic
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_linear_blits
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_sync
results: parsing output: 60/ for test: gem_mmap
results: parsing output: 61/ for test: fbdev
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_explicit_fence
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: i915_query
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: prime_busy
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_prop_blob
results: parsing output: 81/ for test: gem_exec_alignment
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_fbcon_fbt
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_async_flips
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: kms_selftest
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_close_race
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_exec_store
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_pm_dc
results: parsing output: 131/ for test: gem_exec_suspend
results: parsing output: 132/ for test: gem_partial_pwrite_pread
results: parsing output: 133/ for test: kms_pm_rpm
results: parsing output: 134/ for test: gem_exec_params
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: prime_mmap
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_invalid_mode
results: parsing output: 140/ for test: kms_flip
results: parsing output: 141/ for test: gem_tiled_blits
results: parsing output: 142/ for test: gem_exec_flush
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_tv_load_detect
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_chamelium_hpd
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: perf_pmu
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: syncobj_timeline
results: parsing output: 151/ for test: gem_exec_fence
results: parsing output: 152/ for test: kms_content_protection
results: parsing output: 153/ for test: i915_hangman
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_chamelium_edid
Done.