[56.594250] Initializing watchdogs
[56.594295]   /dev/watchdog0
[56.609397] [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]
[56.613778] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.616142] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.619640] [001/155] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[56.696321] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[56.698710] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[56.813603] [002/155] (960s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[56.930614] Starting subtest: basic-flip-before-cursor-varying-size
[57.913631] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.984s)
[58.782121] [003/155] (958s left) kms_content_protection (lic-type-0-hdcp14)
[58.922951] Starting subtest: lic-type-0-hdcp14
[58.927643] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[59.032142] [004/155] (958s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[59.141055] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[59.145470] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[59.247886] [005/155] (958s left) gem_exec_reloc (basic-gtt)
[59.308972] Subtest basic-gtt: SKIP (0.000s)
[59.380068] [006/155] (957s left) kms_lease (lease-unleased-crtc)
[59.466491] Starting subtest: lease-unleased-crtc
[59.468965] Starting dynamic subtest: pipe-A-eDP-1
[59.769369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[59.778141] Starting dynamic subtest: pipe-B-eDP-1
[60.538636] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.769s)
[60.550914] Starting dynamic subtest: pipe-C-eDP-1
[60.552883] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[60.560044] Starting dynamic subtest: pipe-D-eDP-1
[60.562109] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[60.564087] Subtest lease-unleased-crtc: SUCCESS (1.083s)
[60.923709] [007/155] (956s left) gem_sync (basic-store-each)
[60.990426] Starting subtest: basic-store-each
[63.398366] Subtest basic-store-each: SUCCESS (2.421s)
[63.592647] [008/155] (953s left) kms_cursor_crc (cursor-onscreen-128x128)
[63.810632] Starting subtest: cursor-onscreen-128x128
[63.816196] Starting dynamic subtest: pipe-A-eDP-1
[65.912321] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.100s)
[65.946247] Starting dynamic subtest: pipe-D-eDP-1
[68.709822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[68.712323] Subtest cursor-onscreen-128x128: SUCCESS (4.901s)
[69.586649] [009/155] (947s left) kms_psr (fbc-pr-cursor-blt)
[69.684244] Starting subtest: fbc-pr-cursor-blt
[69.688111] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[69.758502] [010/155] (947s left) gem_exec_reloc (basic-wc-read-active)
[69.822420] Subtest basic-wc-read-active: SKIP (0.000s)
[69.898139] [011/155] (947s left) kms_sequence (get-forked-busy)
[69.985568] Starting subtest: get-forked-busy
[69.987725] Starting dynamic subtest: pipe-A-eDP-1
[71.920702] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[71.930559] Starting dynamic subtest: pipe-B-eDP-1
[74.504869] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.586s)
[74.514481] Starting dynamic subtest: pipe-C-eDP-1
[77.116516] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[77.126303] Starting dynamic subtest: pipe-D-eDP-1
[79.737167] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[79.739614] Subtest get-forked-busy: SUCCESS (9.756s)
[80.632581] [012/155] (936s left) gem_exec_store (dword)
[80.690935] Starting subtest: dword
[80.693441] Starting dynamic subtest: rcs0
[80.751949] Dynamic subtest rcs0: SUCCESS (0.063s)
[80.763523] Starting dynamic subtest: bcs0
[80.793962] Dynamic subtest bcs0: SUCCESS (0.041s)
[80.805711] Starting dynamic subtest: vcs0
[80.836380] Dynamic subtest vcs0: SUCCESS (0.042s)
[80.845267] Starting dynamic subtest: vcs1
[80.881515] Dynamic subtest vcs1: SUCCESS (0.044s)
[80.892447] Starting dynamic subtest: vecs0
[80.924387] Dynamic subtest vecs0: SUCCESS (0.042s)
[80.934967] Starting dynamic subtest: ccs0
[80.967836] Dynamic subtest ccs0: SUCCESS (0.042s)
[80.970563] Subtest dword: SUCCESS (0.280s)
[81.152743] [013/155] (936s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[83.482549] Starting subtest: dpms-mode-unset-lpsp
[87.563545] Subtest dpms-mode-unset-lpsp: SUCCESS (4.085s)
[87.947633] [014/155] (929s left) gem_softpin (allocator-nopin-reserve)
[88.001797] Starting subtest: allocator-nopin-reserve
[88.114760] Subtest allocator-nopin-reserve: SUCCESS (0.114s)
[88.245968] [015/155] (929s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[88.346334] Starting subtest: psr-2p-primscrn-cur-indfb-move
[88.350940] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[88.426830] [016/155] (929s left) gem_lmem_swapping (heavy-random)
[88.465630] Subtest heavy-random: SKIP (0.000s)
[88.504309] [017/155] (929s left) kms_psr (psr-cursor-plane-move)
[88.592572] Starting subtest: psr-cursor-plane-move
[88.595069] Starting dynamic subtest: eDP-1
[90.324410] Dynamic subtest eDP-1: SUCCESS (1.734s)
[90.326815] Subtest psr-cursor-plane-move: SUCCESS (1.734s)
[91.193431] [018/155] (926s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[91.585186] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[92.404352] [019/155] (925s left) syncobj_timeline (wait-all-snapshot)
[92.456916] Starting subtest: wait-all-snapshot
[92.538611] Subtest wait-all-snapshot: SUCCESS (0.082s)
[92.614771] [020/155] (925s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[92.716679] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[92.721100] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.817167] [021/155] (925s left) kms_plane_alpha_blend (constant-alpha-mid)
[92.914925] Starting subtest: constant-alpha-mid
[93.213917] Starting dynamic subtest: pipe-A-eDP-1
[94.017726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.800s)
[94.027409] Starting dynamic subtest: pipe-D-eDP-1
[95.513993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.497s)
[95.517228] Subtest constant-alpha-mid: SUCCESS (2.600s)
[96.394869] [022/155] (921s left) gem_ctx_shared (create-shared-gtt)
[96.457667] Starting subtest: create-shared-gtt
[98.610674] Subtest create-shared-gtt: SUCCESS (2.151s)
[98.956705] [023/155] (918s left) kms_draw_crc (draw-method-blt)
[99.051571] Starting subtest: draw-method-blt
[99.053698] Starting dynamic subtest: xrgb8888-untiled
[99.293747] Dynamic subtest xrgb8888-untiled: SUCCESS (0.243s)
[99.301668] Starting dynamic subtest: rgb565-untiled
[99.515772] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[99.524841] Starting dynamic subtest: xrgb2101010-untiled
[99.738112] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[99.752191] Starting dynamic subtest: xbgr16161616f-untiled
[99.959580] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[99.968594] Starting dynamic subtest: xrgb8888-xtiled
[100.071099] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[100.082337] Starting dynamic subtest: rgb565-xtiled
[100.181888] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[100.191083] Starting dynamic subtest: xrgb2101010-xtiled
[100.282054] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.100s)
[100.290216] Starting dynamic subtest: xbgr16161616f-xtiled
[100.392938] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[100.401229] Starting dynamic subtest: xrgb8888-4tiled
[100.504959] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[100.516472] Starting dynamic subtest: rgb565-4tiled
[100.615091] Dynamic subtest rgb565-4tiled: SUCCESS (0.109s)
[100.623866] Starting dynamic subtest: xrgb2101010-4tiled
[100.726097] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[100.738120] Starting dynamic subtest: xbgr16161616f-4tiled
[100.838963] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s)
[100.840756] Subtest draw-method-blt: SUCCESS (1.788s)
[100.948475] [024/155] (917s left) gem_userptr_blits (map-fixed-invalidate)
[101.017976] Starting subtest: map-fixed-invalidate
[101.021648] Subtest map-fixed-invalidate: SKIP (0.000s)
[101.140613] [025/155] (916s left) dmabuf_sync_file (export-before-signal)
[101.241777] Starting subtest: export-before-signal
[101.243612] Subtest export-before-signal: SUCCESS (0.002s)
[101.302269] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[101.304839] [026/155] (916s left) gem_userptr_blits (huge-split)
[101.373105] Starting subtest: huge-split
[101.381603] Subtest huge-split: SUCCESS (0.009s)
[101.507116] [027/155] (916s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[101.618734] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[101.622338] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.719611] [028/155] (916s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[101.806285] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[101.809714] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[101.903251] [029/155] (916s left) gem_ctx_shared (exec-single-timeline)
[101.969479] Starting subtest: exec-single-timeline
[101.971333] Starting dynamic subtest: rcs0
[103.004856] Dynamic subtest rcs0: SUCCESS (1.035s)
[103.018162] Starting dynamic subtest: bcs0
[104.093278] Dynamic subtest bcs0: SUCCESS (1.086s)
[104.105095] Starting dynamic subtest: vcs0
[105.183337] Dynamic subtest vcs0: SUCCESS (1.087s)
[105.193878] Starting dynamic subtest: vcs1
[106.271310] Dynamic subtest vcs1: SUCCESS (1.086s)
[106.282049] Starting dynamic subtest: vecs0
[107.358040] Dynamic subtest vecs0: SUCCESS (1.085s)
[107.370452] Starting dynamic subtest: ccs0
[108.446024] Dynamic subtest ccs0: SUCCESS (1.086s)
[108.448707] Subtest exec-single-timeline: SUCCESS (6.478s)
[108.632553] [030/155] (909s left) kms_big_fb (linear-32bpp-rotate-180)
[108.737422] Starting subtest: linear-32bpp-rotate-180
[109.381743] Subtest linear-32bpp-rotate-180: FAIL (0.038s)
[109.421405] [031/155] (908s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[109.510819] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[109.513055] Starting dynamic subtest: pipe-A-eDP-1
[111.691823] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.181s)
[111.701174] Starting dynamic subtest: pipe-B-eDP-1
[114.001044] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.310s)
[114.009124] Starting dynamic subtest: pipe-C-eDP-1
[116.149212] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.147s)
[116.158945] Starting dynamic subtest: pipe-D-eDP-1
[118.290504] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.140s)
[118.292526] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.782s)
[119.527118] [032/155] (898s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[119.627124] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[119.631365] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[119.741504] [033/155] (898s left) syncobj_timeline (multi-wait-signaled)
[119.802257] Starting subtest: multi-wait-signaled
[119.804628] Subtest multi-wait-signaled: SUCCESS (0.001s)
[119.901331] [034/155] (898s left) gem_ctx_exec (basic-nohangcheck)
[119.954124] Starting subtest: basic-nohangcheck
[120.218955] Subtest basic-nohangcheck: SUCCESS (0.266s)
[120.346433] [035/155] (898s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[120.437654] Starting subtest: psr-rgb101010-draw-mmap-gtt
[120.441765] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[120.541496] [036/155] (897s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[120.650319] Starting subtest: fbc-rgb565-draw-mmap-wc
[124.684399] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.041s)
[125.850342] [037/155] (892s left) gem_exec_reloc (basic-write-read)
[125.910489] Subtest basic-write-read: SKIP (0.000s)
[125.974668] [038/155] (892s left) perf (global-sseu-config-invalid)
[126.085548] Starting subtest: global-sseu-config-invalid
[126.089117] Subtest global-sseu-config-invalid: SKIP (0.000s)
[126.131163] [039/155] (892s left) gem_mmap_wc (read-write)
[126.179552] Subtest read-write: SKIP (0.000s)
[126.234195] [040/155] (892s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[126.332151] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[126.336258] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[126.425859] [041/155] (892s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-blt)
[126.516363] Starting subtest: psrhdr-rgb101010-draw-blt
[126.520722] Subtest psrhdr-rgb101010-draw-blt: SKIP (0.000s)
[126.605746] [042/155] (892s left) gem_workarounds (reset-context)
[126.669208] Starting subtest: reset-context
[126.841368] Subtest reset-context: SUCCESS (0.172s)
[126.969280] [043/155] (891s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-pgflip-blt)
[127.063186] Starting subtest: fbchdr-2p-scndscrn-indfb-pgflip-blt
[127.066689] Subtest fbchdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[127.159273] [044/155] (891s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[127.261044] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[127.264873] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[127.366632] [045/155] (891s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[127.469381] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[127.472838] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[127.567487] [046/155] (891s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[127.659284] Starting subtest: fbc-psr-sprite-mmap-gtt
[127.661075] Starting dynamic subtest: eDP-1
[127.664504] Dynamic subtest eDP-1: SKIP (0.000s)
[127.668061] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[127.730635] [047/155] (891s left) sysfs_timeslice_duration (idempotent)
[127.780900] Starting subtest: idempotent
[127.782896] Starting dynamic subtest: vecs0
[127.784872] Dynamic subtest vecs0: SUCCESS (0.000s)
[127.793290] Starting dynamic subtest: ccs0
[127.794859] Dynamic subtest ccs0: SUCCESS (0.000s)
[127.803252] Starting dynamic subtest: vcs0
[127.805039] Dynamic subtest vcs0: SUCCESS (0.000s)
[127.813237] Starting dynamic subtest: bcs0
[127.814814] Dynamic subtest bcs0: SUCCESS (0.000s)
[127.822654] Starting dynamic subtest: rcs0
[127.824281] Dynamic subtest rcs0: SUCCESS (0.000s)
[127.832123] Starting dynamic subtest: vcs1
[127.833707] Dynamic subtest vcs1: SUCCESS (0.000s)
[127.835314] Subtest idempotent: SUCCESS (0.005s)
[127.870428] [048/155] (891s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[127.956193] Starting subtest: 2x-absolute-wf_vblank-interruptible
[127.967422] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[128.052541] [049/155] (890s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[128.180522] Starting subtest: 2x-long-flip-vs-cursor-legacy
[128.184382] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[128.336055] [050/155] (890s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[128.444176] Starting subtest: 4-tiled-16bpp-rotate-0
[129.734248] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.289s)
[129.854747] [051/155] (889s left) kms_chamelium_color (ctm-negative)
[129.941916] Subtest ctm-negative: SKIP (0.000s)
[129.985024] [052/155] (889s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[130.102211] Starting subtest: cursor-vs-flip-atomic-transitions
[160.384132] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.284s)
[161.258411] [053/155] (857s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[161.364042] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[161.368214] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[161.475190] [054/155] (857s left) kms_vblank (ts-continuation-dpms-rpm)
[161.571015] Starting subtest: ts-continuation-dpms-rpm
[161.572899] Starting dynamic subtest: pipe-A-eDP-1
[164.056932] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.486s)
[164.072583] Starting dynamic subtest: pipe-D-eDP-1
[166.310311] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.252s)
[166.312686] Subtest ts-continuation-dpms-rpm: SUCCESS (4.741s)
[167.190396] [055/155] (852s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[167.283050] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[167.287543] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[167.354487] [056/155] (851s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[167.458697] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[167.463165] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[167.543282] [057/155] (851s left) kms_cursor_crc (cursor-size-hints)
[167.671090] Starting subtest: cursor-size-hints
[167.673328] Starting dynamic subtest: pipe-A-eDP-1
[168.281987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[168.293908] Starting dynamic subtest: pipe-D-eDP-1
[169.574682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.290s)
[169.577091] Subtest cursor-size-hints: SUCCESS (1.903s)
[170.456759] [058/155] (848s left) kms_psr (pr-cursor-plane-onoff)
[170.557234] Starting subtest: pr-cursor-plane-onoff
[170.561204] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[170.630099] [059/155] (848s left) kms_flip (flip-vs-panning)
[170.724275] Starting subtest: flip-vs-panning
[170.726169] Starting dynamic subtest: A-eDP1
[179.470327] Dynamic subtest A-eDP1: SUCCESS (8.748s)
[179.482485] Starting dynamic subtest: B-eDP1
[188.205518] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[188.216125] Starting dynamic subtest: C-eDP1
[196.922958] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[196.935497] Starting dynamic subtest: D-eDP1
[205.649510] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[205.653911] Subtest flip-vs-panning: SUCCESS (34.932s)
[206.820914] [060/155] (812s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[206.923997] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[206.926388] Starting dynamic subtest: pipe-A-eDP-1
[207.827301] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.899s)
[207.836205] Starting dynamic subtest: pipe-B-eDP-1
[209.372860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.542s)
[209.383049] Starting dynamic subtest: pipe-C-eDP-1
[210.825378] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.454s)
[210.834821] Starting dynamic subtest: pipe-D-eDP-1
[212.374328] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s)
[212.376685] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.445s)
[213.544057] [061/155] (805s left) syncobj_wait (single-wait-signaled)
[213.604301] Starting subtest: single-wait-signaled
[213.606244] Subtest single-wait-signaled: SUCCESS (0.000s)
[213.704160] [062/155] (805s left) vgem_basic (unload)
[213.737948] Starting subtest: unload
[242.775054] Subtest unload: SUCCESS (29.038s)
[242.869665] [063/155] (776s left) gem_exec_balancer (parallel-out-fence)
[243.126508] Starting subtest: parallel-out-fence
[244.354942] Subtest parallel-out-fence: SUCCESS (1.232s)
[244.460064] [064/155] (775s left) gem_mmap_wc (pf-nonblock)
[244.510070] Subtest pf-nonblock: SKIP (0.000s)
[244.571057] [065/155] (775s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[244.684924] Starting subtest: fbcpsr-tiling-4
[251.790127] Subtest fbcpsr-tiling-4: SUCCESS (7.110s)
[251.916175] [066/155] (767s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[251.985916] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[252.059431] [067/155] (767s left) kms_big_fb (4-tiled-addfb-size-overflow)
[252.149232] Starting subtest: 4-tiled-addfb-size-overflow
[252.151159] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[252.235430] [068/155] (767s left) vgem_basic (dmabuf-fence)
[252.279196] Starting subtest: dmabuf-fence
[252.281084] Subtest dmabuf-fence: SUCCESS (0.000s)
[252.333656] [069/155] (767s left) perf_pmu (render-node-busy)
[252.384694] Starting subtest: render-node-busy
[252.387117] Starting dynamic subtest: rcs0
[252.974466] Dynamic subtest rcs0: SUCCESS (0.588s)
[252.987842] Starting dynamic subtest: bcs0
[253.548028] Dynamic subtest bcs0: SUCCESS (0.572s)
[253.560761] Starting dynamic subtest: vcs0
[255.297516] Dynamic subtest vcs0: SUCCESS (1.745s)
[255.310985] Starting dynamic subtest: vcs1
[257.281807] Dynamic subtest vcs1: SUCCESS (1.981s)
[257.292228] Starting dynamic subtest: vecs0
[259.266538] Dynamic subtest vecs0: SUCCESS (1.981s)
[259.277559] Starting dynamic subtest: ccs0
[259.832771] Dynamic subtest ccs0: SUCCESS (0.565s)
[259.836058] Subtest render-node-busy: SUCCESS (7.448s)
[259.922455] [070/155] (759s left) syncobj_timeline (device-submit-unordered)
[259.981592] Starting subtest: device-submit-unordered
[259.983788] Subtest device-submit-unordered: SUCCESS (0.001s)
[260.075822] [071/155] (759s left) kms_pm_rpm (pm-tiling)
[261.603387] Starting subtest: pm-tiling
[261.608739] Subtest pm-tiling: SKIP (0.000s)
[262.338601] [072/155] (757s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[262.438459] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[262.440759] Starting dynamic subtest: pipe-A-default-mode
[263.599501] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[263.603989] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.159s)
[263.744471] [073/155] (756s left) gem_exec_schedule (semaphore-codependency)
[263.814049] Starting subtest: semaphore-codependency
[263.821476] Subtest semaphore-codependency: SUCCESS (0.014s)
[264.181427] [074/155] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[264.279790] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[264.283967] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[264.371445] [075/155] (755s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[264.479548] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[264.483539] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[264.575402] [076/155] (755s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[264.679185] Starting subtest: yf-tiled-32bpp-rotate-90
[264.683776] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[264.793471] [077/155] (755s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[264.896037] Starting subtest: primary-y-tiled-reflect-x-180
[264.955991] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[265.059826] [078/155] (755s left) gem_partial_pwrite_pread (write-snoop)
[265.113270] Subtest write-snoop: SKIP (0.000s)
[265.200873] [079/155] (755s left) gem_ringfill (engines-basic)
[271.301056] Starting subtest: engines-basic
[271.303778] Starting dynamic subtest: rcs0
[271.370774] Dynamic subtest rcs0: SUCCESS (0.070s)
[271.383773] Starting dynamic subtest: bcs0
[271.419067] Dynamic subtest bcs0: SUCCESS (0.046s)
[271.429262] Starting dynamic subtest: vcs0
[271.462606] Dynamic subtest vcs0: SUCCESS (0.042s)
[271.475884] Starting dynamic subtest: vcs1
[271.507540] Dynamic subtest vcs1: SUCCESS (0.042s)
[271.518426] Starting dynamic subtest: vecs0
[271.551426] Dynamic subtest vecs0: SUCCESS (0.042s)
[271.562094] Starting dynamic subtest: ccs0
[271.597059] Dynamic subtest ccs0: SUCCESS (0.044s)
[271.599575] Subtest engines-basic: SUCCESS (0.299s)
[271.687478] [080/155] (748s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[271.787730] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[275.915937] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.133s)
[277.062436] [081/155] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[277.170225] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[283.719606] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.554s)
[283.836793] [082/155] (736s left) kms_pm_backlight (bad-brightness)
[283.925026] Starting subtest: bad-brightness
[283.977919] Starting dynamic subtest: eDP-1
[284.287702] Dynamic subtest eDP-1: SUCCESS (0.311s)
[284.290322] Subtest bad-brightness: SUCCESS (0.363s)
[285.131414] [083/155] (735s left) syncobj_eventfd (binary-wait)
[285.182073] Starting subtest: binary-wait
[285.191590] Subtest binary-wait: SUCCESS (0.010s)
[285.265272] [084/155] (735s left) gem_render_copy_redux (flink)
[285.321349] Starting subtest: flink
[286.162048] Subtest flink: SUCCESS (0.840s)
[286.282927] [085/155] (734s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[286.334617] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[286.426252] [086/155] (734s left) gem_userptr_blits (coherency-unsync)
[286.493119] Subtest coherency-unsync: SKIP (0.000s)
[286.611857] [087/155] (733s left) prime_vgem (basic-write)
[286.691100] Starting subtest: basic-write
[286.696746] Subtest basic-write: SKIP (0.009s)
[286.808884] [088/155] (733s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[286.906624] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[286.908582] Starting dynamic subtest: pipe-A-eDP-1
[286.926052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[286.937410] Starting dynamic subtest: pipe-B-eDP-1
[286.953779] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[286.962782] Starting dynamic subtest: pipe-C-eDP-1
[286.978602] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[286.987660] Starting dynamic subtest: pipe-D-eDP-1
[287.003424] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[287.005222] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[289.166467] [089/155] (731s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[289.275327] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[289.279857] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[289.383999] [090/155] (731s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[289.487305] Starting subtest: fbchdr-rgb101010-draw-render
[289.491764] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[289.590619] [091/155] (731s left) gem_ctx_persistence (engines-queued)
[289.658730] Starting subtest: engines-queued
[289.661100] Starting dynamic subtest: rcs0
[289.747990] Dynamic subtest rcs0: SUCCESS (0.088s)
[289.760714] Starting dynamic subtest: bcs0
[289.779311] Dynamic subtest bcs0: SUCCESS (0.029s)
[289.789175] Starting dynamic subtest: vcs0
[291.233016] Dynamic subtest vcs0: SUCCESS (1.450s)
[291.243616] Starting dynamic subtest: vcs1
[293.279677] Dynamic subtest vcs1: SUCCESS (2.044s)
[293.292763] Starting dynamic subtest: vecs0
[295.262092] Dynamic subtest vecs0: SUCCESS (1.979s)
[295.273394] Starting dynamic subtest: ccs0
[295.444486] Dynamic subtest ccs0: SUCCESS (0.181s)
[295.447088] Subtest engines-queued: SUCCESS (5.786s)
[295.559655] [092/155] (725s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[295.658178] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[295.662088] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[295.763884] [093/155] (725s left) kms_scaling_modes (scaling-mode-center)
[295.860382] Starting subtest: scaling-mode-center
[295.862825] Starting dynamic subtest: pipe-A-eDP-1
[295.976939] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.118s)
[295.988064] Starting dynamic subtest: pipe-B-eDP-1
[297.184135] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s)
[297.195030] Starting dynamic subtest: pipe-C-eDP-1
[298.389373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.204s)
[298.399889] Starting dynamic subtest: pipe-D-eDP-1
[299.527177] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[299.529523] Subtest scaling-mode-center: SUCCESS (3.670s)
[300.691919] [094/155] (720s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[300.790114] Starting subtest: async-flip-with-page-flip-events-linear
[301.153718] Starting dynamic subtest: pipe-A-eDP-1
[303.965060] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.810s)
[304.330817] Starting dynamic subtest: pipe-B-eDP-1
[307.101438] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.776s)
[307.485445] Starting dynamic subtest: pipe-C-eDP-1
[310.236280] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s)
[310.613342] Starting dynamic subtest: pipe-D-eDP-1
[313.372610] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[313.375181] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.584s)
[314.568972] [095/155] (706s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[314.678862] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[314.683342] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[314.778350] [096/155] (706s left) gen7_exec_parse (basic-rejected)
[314.837673] Subtest basic-rejected: SKIP (0.000s)
[314.917316] [097/155] (706s left) tools_test (tools_test)
[314.972239] Starting subtest: tools_test
[315.017737] Subtest tools_test: SUCCESS (0.059s)
[315.078897] [098/155] (705s left) i915_hangman (engine-engine-error)
[315.146054] Starting subtest: engine-engine-error
[315.148308] Starting dynamic subtest: rcs0
[316.256197] Dynamic subtest rcs0: SUCCESS (1.109s)
[316.268658] Starting dynamic subtest: bcs0
[318.239533] Dynamic subtest bcs0: SUCCESS (1.980s)
[318.253316] Starting dynamic subtest: vcs0
[320.224094] Dynamic subtest vcs0: SUCCESS (1.981s)
[320.237527] Starting dynamic subtest: vcs1
[322.271948] Dynamic subtest vcs1: SUCCESS (2.045s)
[322.284680] Starting dynamic subtest: vecs0
[324.255470] Dynamic subtest vecs0: SUCCESS (1.981s)
[324.270680] Starting dynamic subtest: ccs0
[326.239048] Dynamic subtest ccs0: SUCCESS (1.980s)
[326.241941] Subtest engine-engine-error: SUCCESS (11.093s)
[326.321433] [099/155] (694s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[326.438835] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[326.443399] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[326.525094] [100/155] (694s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[326.624523] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[326.628746] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[326.719481] [101/155] (694s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[326.811414] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[326.815746] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[326.901332] [102/155] (694s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[326.986613] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc
[326.990744] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[327.092071] [103/155] (694s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[327.185113] Starting subtest: plane-all-modeset-transition-fencing
[327.189622] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[327.259409] [104/155] (693s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[327.356516] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[327.360118] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[327.437503] [105/155] (693s left) kms_plane (plane-position-covered)
[327.533040] Starting subtest: plane-position-covered
[328.053734] Starting dynamic subtest: pipe-A-plane-1
[329.349233] Dynamic subtest pipe-A-plane-1: SUCCESS (1.293s)
[329.360554] Starting dynamic subtest: pipe-A-plane-2
[330.649347] Dynamic subtest pipe-A-plane-2: SUCCESS (1.302s)
[330.663293] Starting dynamic subtest: pipe-A-plane-3
[331.879045] Dynamic subtest pipe-A-plane-3: SUCCESS (1.229s)
[331.890562] Starting dynamic subtest: pipe-A-plane-4
[333.140689] Dynamic subtest pipe-A-plane-4: SUCCESS (1.261s)
[333.151866] Starting dynamic subtest: pipe-A-plane-5
[333.168194] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[334.390495] Starting dynamic subtest: pipe-B-plane-1
[335.674608] Dynamic subtest pipe-B-plane-1: SUCCESS (1.295s)
[335.687386] Starting dynamic subtest: pipe-B-plane-2
[336.925797] Dynamic subtest pipe-B-plane-2: SUCCESS (1.249s)
[336.935862] Starting dynamic subtest: pipe-B-plane-3
[338.234523] Dynamic subtest pipe-B-plane-3: SUCCESS (1.309s)
[338.246251] Starting dynamic subtest: pipe-B-plane-4
[339.485599] Dynamic subtest pipe-B-plane-4: SUCCESS (1.249s)
[339.495904] Starting dynamic subtest: pipe-B-plane-5
[339.509826] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[339.512083] Subtest plane-position-covered: SUCCESS (11.977s)
[340.300206] [106/155] (681s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[340.415717] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[340.419791] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[340.523185] [107/155] (680s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[340.628490] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[340.632939] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[340.751953] [108/155] (680s left) i915_pm_rps (min-max-config-loaded)
[340.804589] Starting subtest: min-max-config-loaded
[340.809069] Subtest min-max-config-loaded: SKIP (0.001s)
[340.910660] [109/155] (680s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[341.006022] Starting subtest: fbc-psr2-cursor-mmap-cpu
[341.008284] Starting dynamic subtest: eDP-1
[341.012556] Dynamic subtest eDP-1: SKIP (0.000s)
[341.016767] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[341.080097] [110/155] (680s left) gem_exec_balancer (bonded-false-hang)
[341.333737] Starting subtest: bonded-false-hang
[341.338973] Subtest bonded-false-hang: SKIP (0.000s)
[341.428334] [111/155] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[341.517874] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[345.221753] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.709s)
[346.400104] [112/155] (675s left) kms_cursor_crc (cursor-sliding-512x512)
[346.688494] Starting subtest: cursor-sliding-512x512
[346.697322] Subtest cursor-sliding-512x512: SKIP (0.001s)
[346.846328] [113/155] (674s left) gem_userptr_blits (create-destroy-sync)
[346.920331] Starting subtest: create-destroy-sync
[351.937765] Subtest create-destroy-sync: SUCCESS (5.018s)
[352.056547] [114/155] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[352.163457] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[352.167620] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[352.253383] [115/155] (669s left) gem_mmap_gtt (basic-small-bo)
[352.307877] Subtest basic-small-bo: SKIP (0.000s)
[352.364379] [116/155] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[352.468697] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[352.473161] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[352.570082] [117/155] (669s left) gem_exec_schedule (noreorder-corked)
[352.746772] Starting subtest: noreorder-corked
[352.749096] Starting dynamic subtest: rcs0
[353.879984] Dynamic subtest rcs0: SUCCESS (1.133s)
[353.894177] Starting dynamic subtest: vcs0
[355.324197] Dynamic subtest vcs0: SUCCESS (1.441s)
[355.337066] Starting dynamic subtest: vcs1
[357.307472] Dynamic subtest vcs1: SUCCESS (1.980s)
[357.320315] Starting dynamic subtest: vecs0
[359.284612] Dynamic subtest vecs0: SUCCESS (1.974s)
[359.298338] Starting dynamic subtest: ccs0
[360.436492] Dynamic subtest ccs0: SUCCESS (1.151s)
[360.438890] Subtest noreorder-corked: SUCCESS (7.692s)
[360.630215] [118/155] (661s left) gem_pxp (verify-pxp-stale-buf-execution)
[360.757241] Starting subtest: verify-pxp-stale-buf-execution
[361.824173] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.069s)
[361.939308] [119/155] (659s left) gem_mmap_gtt (basic-small-bo-tiledy)
[362.004611] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[362.070465] [120/155] (659s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[362.165524] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[362.169591] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[362.256093] [121/155] (659s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[362.358356] Starting subtest: x-tiled-32bpp-rotate-180
[363.838504] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.482s)
[363.984238] [122/155] (658s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[364.548718] Starting subtest: syncobj-timeline-multiple-ext-nodes
[364.551079] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[366.347499] [123/155] (655s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[366.435027] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[366.437520] Starting dynamic subtest: pipe-A-eDP-1
[366.496311] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[366.506201] Starting dynamic subtest: pipe-B-eDP-1
[366.564772] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[366.574990] Starting dynamic subtest: pipe-C-eDP-1
[366.629202] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[366.638651] Starting dynamic subtest: pipe-D-eDP-1
[366.692234] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[366.696291] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[368.752973] [124/155] (653s left) kms_addfb_basic (unused-pitches)
[368.811109] Starting subtest: unused-pitches
[368.813475] Subtest unused-pitches: SUCCESS (0.000s)
[368.950736] [125/155] (653s left) gem_mmap_offset (basic-uaf)
[369.008739] Starting subtest: basic-uaf
[369.011055] Subtest basic-uaf: SUCCESS (0.001s)
[369.116666] [126/155] (653s left) syncobj_basic (bad-fd-to-handle)
[369.172938] Starting subtest: bad-fd-to-handle
[369.175181] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[369.291722] [127/155] (652s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[369.381137] Starting subtest: fbcpsr-rgb565-draw-render
[376.496867] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.121s)
[376.635480] [128/155] (645s left) kms_dp_linktrain_fallback (dsc-fallback)
[376.737571] Starting subtest: dsc-fallback
[376.743915] Subtest dsc-fallback: SKIP (0.000s)
[376.820911] [129/155] (645s left) syncobj_timeline (invalid-signal-zero-handles)
[376.883101] Starting subtest: invalid-signal-zero-handles
[376.885562] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[376.992534] [130/155] (645s left) prime_self_import (basic-with_one_bo_two_files)
[377.022129] Starting subtest: basic-with_one_bo_two_files
[377.048523] Subtest basic-with_one_bo_two_files: SUCCESS (0.027s)
[377.143739] [131/155] (645s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[377.250781] Starting subtest: psr2-overlay-plane-update-continuous-sf
[377.253078] Starting dynamic subtest: pipe-A-eDP-1
[378.364086] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.118s)
[378.376544] Starting dynamic subtest: pipe-B-eDP-1
[380.143271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.777s)
[380.145556] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.898s)
[380.972708] [132/155] (641s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[381.064648] Starting subtest: invalid-modeset-force-ultra-joiner
[381.069332] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[381.148038] [133/155] (641s left) kms_rotation_crc (cursor-rotation-180)
[381.232765] Starting subtest: cursor-rotation-180
[382.711892] Subtest cursor-rotation-180: SUCCESS (1.482s)
[383.911579] [134/155] (638s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[384.288433] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[385.115764] [135/155] (637s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[385.222722] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[385.227171] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[385.350464] [136/155] (637s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[385.440873] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[385.445373] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[385.549934] [137/155] (637s left) api_intel_bb (blit-noreloc-purge-cache)
[385.610553] Starting subtest: blit-noreloc-purge-cache
[385.617620] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[385.749243] [138/155] (636s left) kms_flip (2x-flip-vs-wf_vblank)
[385.847945] Starting subtest: 2x-flip-vs-wf_vblank
[385.856219] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[385.960383] [139/155] (636s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[386.056899] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[386.060715] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[386.163719] [140/155] (636s left) fbdev (eof)
[386.201216] Starting subtest: eof
[386.203190] Subtest eof: SUCCESS (0.000s)
[386.294700] [141/155] (636s left) kms_plane_multiple (tiling-x)
[386.386714] Starting subtest: tiling-x
[386.388356] Starting dynamic subtest: pipe-A-eDP-1
[390.086895] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.699s)
[390.101201] Starting dynamic subtest: pipe-B-eDP-1
[394.636949] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.547s)
[394.647057] Starting dynamic subtest: pipe-C-eDP-1
[398.979221] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.341s)
[398.990025] Starting dynamic subtest: pipe-D-eDP-1
[403.423188] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.445s)
[403.425574] Subtest tiling-x: SUCCESS (17.037s)
[404.229446] [142/155] (618s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[404.330346] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[404.334325] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[404.410271] [143/155] (618s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[404.503349] Starting subtest: plane-lut1d-pre-ctm3x4
[404.629663] Starting dynamic subtest: pipe-A-plane-0
[404.816511] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[404.827189] Starting dynamic subtest: pipe-A-plane-1
[404.951349] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[404.962037] Starting dynamic subtest: pipe-A-plane-2
[405.142434] Dynamic subtest pipe-A-plane-2: SUCCESS (0.189s)
[406.331323] Starting dynamic subtest: pipe-B-plane-0
[406.498908] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[406.512089] Starting dynamic subtest: pipe-B-plane-1
[406.675859] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[406.688175] Starting dynamic subtest: pipe-B-plane-2
[406.842287] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[408.067998] Starting dynamic subtest: pipe-C-plane-0
[408.214393] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[408.224596] Starting dynamic subtest: pipe-C-plane-1
[408.370461] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[408.380587] Starting dynamic subtest: pipe-C-plane-2
[408.526430] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[409.721910] Starting dynamic subtest: pipe-D-plane-0
[409.866533] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[409.877245] Starting dynamic subtest: pipe-D-plane-1
[410.044335] Dynamic subtest pipe-D-plane-1: SUCCESS (0.177s)
[410.054915] Starting dynamic subtest: pipe-D-plane-2
[410.199981] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[410.490205] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.987s)
[411.367606] [144/155] (611s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[411.466843] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[411.471379] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[411.580497] [145/155] (611s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[411.682563] Starting subtest: flip-vs-dpms-on-nop-interruptible
[411.684842] Starting dynamic subtest: A-eDP1
[413.558297] Dynamic subtest A-eDP1: SUCCESS (1.874s)
[413.570778] Starting dynamic subtest: B-eDP1
[415.398746] Dynamic subtest B-eDP1: SUCCESS (1.838s)
[415.411478] Starting dynamic subtest: C-eDP1
[417.210621] Dynamic subtest C-eDP1: SUCCESS (1.811s)
[417.224539] Starting dynamic subtest: D-eDP1
[419.047710] Dynamic subtest D-eDP1: SUCCESS (1.834s)
[419.050094] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.368s)
[420.236079] [146/155] (602s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[420.331943] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[420.336426] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[420.432502] [147/155] (602s left) i915_drm_fdinfo (memory-info-shared)
[420.473446] Starting subtest: memory-info-shared
[420.475662] Starting dynamic subtest: smem0
[420.532599] Dynamic subtest smem0: SUCCESS (0.058s)
[420.535181] Subtest memory-info-shared: SUCCESS (0.060s)
[420.610714] [148/155] (602s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[420.720094] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[420.724223] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[420.825191] [149/155] (602s left) perf (disabled-read-error)
[420.913299] Starting subtest: disabled-read-error
[420.931243] Subtest disabled-read-error: SUCCESS (0.017s)
[420.979070] [150/155] (602s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite)
[421.077673] Starting subtest: psrhdr-rgb565-draw-pwrite
[421.082137] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[421.178737] [151/155] (602s left) api_intel_bb (lot-of-buffers)
[421.232810] Starting subtest: lot-of-buffers
[422.267930] Subtest lot-of-buffers: SUCCESS (1.036s)
[422.669868] [152/155] (600s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[422.765876] Starting subtest: hdr-shrfb-scaledprimary
[422.770242] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s)
[422.869463] [153/155] (600s left) gem_exec_reloc (basic-concurrent16)
[422.932323] Subtest basic-concurrent16: SKIP (0.000s)
[423.001945] [154/155] (600s left) gem_mmap (bad-offset)
[423.054479] Subtest bad-offset: SKIP (0.000s)
[423.124482] [155/155] (600s left) i915_pm_rps (thresholds-park)
[423.181709] Starting subtest: thresholds-park
[423.185760] Subtest thresholds-park: SKIP (0.000s)
[423.298698] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_lease
results: parsing output: 6/ for test: gem_sync
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_sequence
results: parsing output: 11/ for test: gem_exec_store
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_plane_alpha_blend
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: kms_draw_crc
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: dmabuf_sync_file
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_ctx_exec
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_workarounds
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: sysfs_timeslice_duration
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_chamelium_color
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_pm_rpm
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: gem_ringfill
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_pm_backlight
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: gem_render_copy_redux
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: prime_vgem
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_scaling_modes
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gen7_exec_parse
results: parsing output: 96/ for test: tools_test
results: parsing output: 97/ for test: i915_hangman
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_pm_rps
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: gem_mmap_offset
results: parsing output: 125/ for test: syncobj_basic
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_dp_linktrain_fallback
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: prime_self_import
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_joiner
results: parsing output: 132/ for test: kms_rotation_crc
results: parsing output: 133/ for test: kms_chamelium_frames
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: api_intel_bb
results: parsing output: 137/ for test: kms_flip
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: fbdev
results: parsing output: 140/ for test: kms_plane_multiple
results: parsing output: 141/ for test: kms_psr2_sf
results: parsing output: 142/ for test: kms_color_pipeline
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: i915_drm_fdinfo
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: perf
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: api_intel_bb
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_exec_reloc
results: parsing output: 153/ for test: gem_mmap
results: parsing output: 154/ for test: i915_pm_rps
Done.