[59.426399] Initializing watchdogs
[59.426446]   /dev/watchdog0
[59.441773] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.446988] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.449520] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.451432] [001/156] (960s left) kms_big_fb (x-tiled-addfb-size-overflow)
[59.572660] Starting subtest: x-tiled-addfb-size-overflow
[59.573713] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[59.660510] [002/156] (960s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[59.758779] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[59.760605] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[59.853223] [003/156] (960s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[59.946836] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[59.948565] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[60.052082] [004/156] (959s left) gem_flink_basic (bad-open)
[60.094322] Starting subtest: bad-open
[60.095249] Subtest bad-open: SUCCESS (0.000s)
[60.184145] [005/156] (959s left) kms_chamelium_frames (vga-frame-dump)
[60.566224] Subtest vga-frame-dump: SKIP (0.000s)
[61.338608] [006/156] (958s left) kms_draw_crc (draw-method-pwrite)
[61.437893] Starting subtest: draw-method-pwrite
[61.438877] Starting dynamic subtest: xrgb8888-untiled
[62.049908] Dynamic subtest xrgb8888-untiled: SUCCESS (0.612s)
[62.062551] Starting dynamic subtest: rgb565-untiled
[62.538224] Dynamic subtest rgb565-untiled: SUCCESS (0.488s)
[62.544841] Starting dynamic subtest: xrgb2101010-untiled
[63.127212] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.588s)
[63.134919] Starting dynamic subtest: xbgr16161616f-untiled
[63.949045] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.821s)
[63.956099] Starting dynamic subtest: xrgb8888-xtiled
[65.904534] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.955s)
[65.912112] Starting dynamic subtest: rgb565-xtiled
[67.104271] Dynamic subtest rgb565-xtiled: SUCCESS (1.200s)
[67.111771] Starting dynamic subtest: xrgb2101010-xtiled
[69.059708] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.955s)
[69.067051] Starting dynamic subtest: xbgr16161616f-xtiled
[72.737380] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.677s)
[72.744199] Starting dynamic subtest: xrgb8888-4tiled
[74.181946] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.444s)
[74.190009] Starting dynamic subtest: rgb565-4tiled
[74.781894] Dynamic subtest rgb565-4tiled: SUCCESS (0.599s)
[74.790707] Starting dynamic subtest: xrgb2101010-4tiled
[75.993393] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.211s)
[76.002468] Starting dynamic subtest: xbgr16161616f-4tiled
[79.259531] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.266s)
[79.260430] Subtest draw-method-pwrite: SUCCESS (17.823s)
[79.347364] [007/156] (940s left) gem_flink_basic (basic)
[79.395795] Starting subtest: basic
[79.396592] Subtest basic: SUCCESS (0.000s)
[79.492102] [008/156] (940s left) kms_cursor_crc (cursor-offscreen-32x32)
[79.626350] Starting subtest: cursor-offscreen-32x32
[79.675250] Subtest cursor-offscreen-32x32: SKIP (0.047s)
[79.937188] [009/156] (940s left) kms_getfb (getfb-handle-valid)
[80.016594] Starting subtest: getfb-handle-valid
[80.017725] Subtest getfb-handle-valid: SUCCESS (0.000s)
[80.107298] [010/156] (940s left) kms_psr (pr-primary-blt)
[80.190278] Starting subtest: pr-primary-blt
[80.192432] Subtest pr-primary-blt: SKIP (0.000s)
[80.257702] [011/156] (939s left) kms_color_pipeline (plane-lut1d)
[80.342046] Starting subtest: plane-lut1d
[80.500801] Starting dynamic subtest: pipe-A-plane-0
[80.689673] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[80.696958] Starting dynamic subtest: pipe-A-plane-1
[80.845348] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[80.852169] Starting dynamic subtest: pipe-A-plane-2
[81.011955] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[82.188257] Starting dynamic subtest: pipe-B-plane-0
[82.348137] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[82.357611] Starting dynamic subtest: pipe-B-plane-1
[82.514871] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[82.523313] Starting dynamic subtest: pipe-B-plane-2
[82.703680] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[84.153180] Starting dynamic subtest: pipe-C-plane-0
[84.290929] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[84.297800] Starting dynamic subtest: pipe-C-plane-1
[84.435440] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[84.442516] Starting dynamic subtest: pipe-C-plane-2
[84.579904] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[85.788599] Starting dynamic subtest: pipe-D-plane-0
[85.938149] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[85.945753] Starting dynamic subtest: pipe-D-plane-1
[86.104955] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[86.112665] Starting dynamic subtest: pipe-D-plane-2
[86.238227] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[86.524343] Subtest plane-lut1d: SUCCESS (6.181s)
[87.341624] [012/156] (932s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[87.446946] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[87.448848] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[87.559609] [013/156] (932s left) gem_exec_reloc (basic-cpu-active)
[87.617164] Subtest basic-cpu-active: SKIP (0.000s)
[87.691512] [014/156] (932s left) gem_exec_reloc (basic-wc-cpu)
[87.745928] Subtest basic-wc-cpu: SKIP (0.000s)
[87.795648] [015/156] (932s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[87.881847] Starting subtest: primary-y-tiled-reflect-x-270
[87.883868] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[87.945597] [016/156] (932s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[88.033360] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[88.034969] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[88.119899] [017/156] (932s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[88.217829] Starting subtest: addfb25-y-tiled-small-legacy
[88.219324] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[88.318587] [018/156] (932s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[88.422783] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc
[88.424525] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[88.497942] [019/156] (932s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[88.599941] Starting subtest: hdr-1p-pri-indfb-multidraw
[88.602112] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[88.691991] [020/156] (931s left) kms_chamelium_hpd (common-hpd-after-suspend)
[89.086196] Subtest common-hpd-after-suspend: SKIP (0.000s)
[89.862889] [021/156] (930s left) kms_pm_backlight (fade)
[89.967173] Starting subtest: fade
[90.038657] Starting dynamic subtest: eDP-1
[93.035769] Dynamic subtest eDP-1: SUCCESS (2.996s)
[93.036854] Subtest fade: SUCCESS (3.068s)
[93.915312] [022/156] (926s left) gem_exec_params (secure-non-root)
[93.973071] Starting subtest: secure-non-root
[93.974738] Subtest secure-non-root: SKIP (0.000s)
[94.065336] [023/156] (926s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[94.150926] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[97.736905] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.586s)
[98.942099] [024/156] (921s left) kms_plane (pixel-format-y-tiled-modifier)
[99.029326] Starting subtest: pixel-format-y-tiled-modifier
[99.030983] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[99.094838] [025/156] (921s left) kms_getfb (getfb-handle-not-fb)
[99.182475] Starting subtest: getfb-handle-not-fb
[99.183634] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[99.272080] [026/156] (921s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[99.363538] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[99.365270] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[99.456245] [027/156] (921s left) gem_exec_schedule (u-independent)
[99.508193] Starting subtest: u-independent
[99.509141] Starting dynamic subtest: rcs0
[101.351056] Dynamic subtest rcs0: SUCCESS (1.833s)
[101.360576] Starting dynamic subtest: vcs0
[103.343226] Dynamic subtest vcs0: SUCCESS (1.991s)
[103.356601] Starting dynamic subtest: vcs1
[105.324532] Dynamic subtest vcs1: SUCCESS (1.980s)
[105.333160] Starting dynamic subtest: vecs0
[107.375888] Dynamic subtest vecs0: SUCCESS (2.050s)
[107.387983] Starting dynamic subtest: ccs0
[109.349367] Dynamic subtest ccs0: SUCCESS (1.971s)
[109.350810] Subtest u-independent: SUCCESS (9.832s)
[109.639680] [028/156] (911s left) i915_module_load (resize-bar)
[109.668728] Starting subtest: resize-bar
[109.678275] Subtest resize-bar: SKIP (0.009s)
[109.718995] [029/156] (911s left) gem_pwrite (basic-self)
[109.771329] Subtest basic-self: SKIP (0.000s)
[109.821829] [030/156] (911s left) gem_ctx_freq (sysfs)
[109.874214] Starting subtest: sysfs
[109.875175] Starting dynamic subtest: gt0
[115.398998] Dynamic subtest gt0: SUCCESS (5.526s)
[115.409152] Starting dynamic subtest: gt1
[157.348061] Dynamic subtest gt1: SUCCESS (41.939s)
[157.349352] Subtest sysfs: SUCCESS (47.467s)
[157.467096] [031/156] (863s left) gem_ccs (large-ctrl-surf-copy)
[157.527501] Starting subtest: large-ctrl-surf-copy
[157.529613] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[157.641609] [032/156] (863s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[157.740180] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[161.756072] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.017s)
[162.958126] [033/156] (857s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[163.050143] Starting subtest: fbcpsr-rgb565-draw-pwrite
[170.157764] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.108s)
[170.263651] [034/156] (850s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[170.349429] Starting subtest: fbc-psr2-cursor-mmap-cpu
[170.350366] Starting dynamic subtest: eDP-1
[170.352036] Dynamic subtest eDP-1: SKIP (0.000s)
[170.353719] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[170.414645] [035/156] (850s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[172.439385] Starting subtest: gem-execbuf-stress-pc8
[172.478699] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[172.826665] [036/156] (848s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[172.911586] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[172.913103] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[173.017343] [037/156] (848s left) kms_flip (2x-flip-vs-panning-interruptible)
[173.101942] Starting subtest: 2x-flip-vs-panning-interruptible
[173.114287] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[173.185465] [038/156] (847s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt)
[173.283022] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt
[173.284937] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[173.366658] [039/156] (847s left) kms_big_fb (linear-32bpp-rotate-270)
[173.472747] Starting subtest: linear-32bpp-rotate-270
[173.492078] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[173.601959] [040/156] (847s left) gem_mmap_gtt (big-copy-xy)
[173.651514] Subtest big-copy-XY: SKIP (0.000s)
[173.700330] [041/156] (847s left) kms_flip (2x-flip-vs-fences-interruptible)
[173.796984] Starting subtest: 2x-flip-vs-fences-interruptible
[173.798995] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[173.897446] [042/156] (847s left) gem_exec_balancer (hog)
[173.959454] Starting subtest: hog
[173.961501] Subtest hog: SKIP (0.000s)
[174.254434] [043/156] (847s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[174.350924] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[174.351780] Starting dynamic subtest: pipe-A-eDP-1
[174.355184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.362411] Starting dynamic subtest: pipe-B-eDP-1
[174.365581] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[174.372463] Starting dynamic subtest: pipe-C-eDP-1
[174.375920] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[174.382607] Starting dynamic subtest: pipe-D-eDP-1
[174.385978] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[174.387663] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[176.679080] [044/156] (844s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[176.776408] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[176.778370] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[176.840714] [045/156] (844s left) kms_content_protection (legacy-hdcp14)
[176.991592] Starting subtest: legacy-hdcp14
[176.993547] Subtest legacy-hdcp14: SKIP (0.000s)
[177.131814] [046/156] (844s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[177.189077] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[177.189936] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[177.276429] [047/156] (844s left) kms_cursor_crc (cursor-sliding-64x64)
[177.456950] Starting subtest: cursor-sliding-64x64
[177.459701] Starting dynamic subtest: pipe-A-eDP-1
[180.694349] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.234s)
[180.723429] Starting dynamic subtest: pipe-D-eDP-1
[185.366863] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.640s)
[185.367896] Subtest cursor-sliding-64x64: SUCCESS (7.902s)
[185.882035] [048/156] (835s left) dumb_buffer (create-clear)
[185.931639] Starting subtest: create-clear
[220.203191] Subtest create-clear: SUCCESS (34.260s)
[220.273883] [049/156] (801s left) i915_drm_fdinfo (all-busy-idle-check-all)
[220.306435] Starting subtest: all-busy-idle-check-all
[220.311301] Subtest all-busy-idle-check-all: SKIP (0.004s)
[220.369939] [050/156] (801s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[220.497468] Starting subtest: 2x-long-flip-vs-cursor-legacy
[220.500436] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[220.641263] [051/156] (800s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[220.758432] Starting subtest: flip-vs-cursor-atomic-transitions
[228.813914] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (8.055s)
[229.624197] [052/156] (791s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[229.709453] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[229.710341] Starting dynamic subtest: pipe-A-eDP-1
[229.732305] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[229.740376] Starting dynamic subtest: pipe-B-eDP-1
[229.761399] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[229.768748] Starting dynamic subtest: pipe-C-eDP-1
[229.789246] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[229.797825] Starting dynamic subtest: pipe-D-eDP-1
[229.819652] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[229.821239] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[231.983782] [053/156] (789s left) kms_prop_blob (blob-prop-lifetime)
[232.030265] Starting subtest: blob-prop-lifetime
[232.031121] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[232.116845] [054/156] (789s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[232.225627] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[232.227413] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[232.362181] [055/156] (789s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[232.457962] Starting subtest: yf-tiled-8bpp-rotate-0
[232.459916] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[232.542751] [056/156] (789s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[232.643585] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[232.645153] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[232.746546] [057/156] (788s left) gem_spin_batch (spin-all-new)
[232.808434] Starting subtest: spin-all-new
[232.821262] Subtest spin-all-new: SUCCESS (0.014s)
[234.378789] [058/156] (787s left) gem_mmap_gtt (cpuset-basic-small-copy)
[234.426805] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[234.487421] [059/156] (787s left) gem_exec_whisper (basic-contexts-all)
[234.549752] Starting subtest: basic-contexts-all
[244.291292] Subtest basic-contexts-all: SUCCESS (9.732s)
[244.470737] [060/156] (777s left) gem_mmap_offset (blt-coherency)
[244.526103] Starting subtest: blt-coherency
[244.538912] Subtest blt-coherency: SUCCESS (0.013s)
[244.665999] [061/156] (777s left) kms_pipe_crc_basic (read-crc)
[244.759460] Starting subtest: read-crc
[244.760542] Starting dynamic subtest: pipe-A-eDP-1
[245.464924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[245.472289] Starting dynamic subtest: pipe-B-eDP-1
[246.869208] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[246.877450] Starting dynamic subtest: pipe-C-eDP-1
[248.270129] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[248.278750] Starting dynamic subtest: pipe-D-eDP-1
[249.593655] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[249.594426] Subtest read-crc: SUCCESS (4.834s)
[250.423101] [062/156] (771s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[250.522044] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[259.470266] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.950s)
[259.573686] [063/156] (762s left) kms_getfb (getfb2-handle-not-fb)
[259.660797] Starting subtest: getfb2-handle-not-fb
[259.661638] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[259.757476] [064/156] (762s left) gem_exec_fence (syncobj-timeline-chain-engines)
[260.340452] Starting subtest: syncobj-timeline-chain-engines
[260.426844] Subtest syncobj-timeline-chain-engines: SUCCESS (0.096s)
[261.438754] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[261.441311] [065/156] (760s left) api_intel_allocator (default-alignment)
[261.484470] Starting subtest: default-alignment
[261.486807] Subtest default-alignment: SUCCESS (0.003s)
[261.631161] [066/156] (760s left) kms_flip (2x-blocking-wf_vblank)
[261.713966] Starting subtest: 2x-blocking-wf_vblank
[261.724353] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[261.798734] [067/156] (760s left) kms_lease (lease-again)
[261.884022] Starting subtest: lease-again
[261.885017] Starting dynamic subtest: pipe-A-eDP-1
[261.885958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[261.897726] Starting dynamic subtest: pipe-B-eDP-1
[261.898658] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[261.906566] Starting dynamic subtest: pipe-C-eDP-1
[261.907365] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[261.914445] Starting dynamic subtest: pipe-D-eDP-1
[261.915263] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[261.915994] Subtest lease-again: SUCCESS (0.012s)
[261.989236] [068/156] (760s left) syncobj_timeline (wait-delayed-signal)
[262.043603] Starting subtest: wait-delayed-signal
[262.146325] Subtest wait-delayed-signal: SUCCESS (0.103s)
[262.221903] [069/156] (759s left) gem_mmap_gtt (basic-write-read-distinct)
[262.271299] Subtest basic-write-read-distinct: SKIP (0.000s)
[262.324316] [070/156] (759s left) kms_force_connector_basic (force-edid)
[262.394070] Starting subtest: force-edid
[262.762584] Subtest force-edid: SUCCESS (0.368s)
[262.907109] [071/156] (759s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[262.998315] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[262.999935] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[263.094041] [072/156] (759s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[263.180607] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[263.182285] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[263.274798] [073/156] (758s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-render)
[263.359396] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-render
[263.361146] Subtest psrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[263.461104] [074/156] (758s left) gem_ringfill (engines-basic)
[269.350340] Starting subtest: engines-basic
[269.351851] Starting dynamic subtest: rcs0
[269.407593] Dynamic subtest rcs0: SUCCESS (0.063s)
[269.419558] Starting dynamic subtest: bcs0
[269.454930] Dynamic subtest bcs0: SUCCESS (0.045s)
[269.464992] Starting dynamic subtest: vcs0
[269.500251] Dynamic subtest vcs0: SUCCESS (0.043s)
[269.510543] Starting dynamic subtest: vcs1
[269.545303] Dynamic subtest vcs1: SUCCESS (0.043s)
[269.555418] Starting dynamic subtest: vecs0
[269.589049] Dynamic subtest vecs0: SUCCESS (0.042s)
[269.598768] Starting dynamic subtest: ccs0
[269.635029] Dynamic subtest ccs0: SUCCESS (0.044s)
[269.637677] Subtest engines-basic: SUCCESS (0.293s)
[269.708451] [075/156] (752s left) prime_vgem (basic-gtt)
[269.781925] Starting subtest: basic-gtt
[269.783776] Subtest basic-gtt: SKIP (0.000s)
[269.866313] [076/156] (752s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[269.915463] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[270.016803] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.101s)
[270.092814] [077/156] (752s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[270.202043] Starting subtest: y-tiled-32bpp-rotate-90
[270.203727] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[270.288793] [078/156] (752s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[270.377345] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[270.378976] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[270.476915] [079/156] (751s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[270.561189] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[270.562214] Starting dynamic subtest: pipe-A-eDP-1
[270.639357] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[270.649481] Starting dynamic subtest: pipe-B-eDP-1
[271.748800] Dynamic subtest pipe-B-eDP-1: SKIP (1.107s)
[271.750934] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.188s)
[272.999546] [080/156] (749s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[273.115121] Starting subtest: 2x-long-cursor-vs-flip-legacy
[273.118502] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[273.254212] [081/156] (749s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[273.344583] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[273.345522] Starting dynamic subtest: pipe-A-eDP-1
[273.356387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[273.366057] Starting dynamic subtest: pipe-B-eDP-1
[273.373921] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[273.382089] Starting dynamic subtest: pipe-C-eDP-1
[273.389736] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[273.396986] Starting dynamic subtest: pipe-D-eDP-1
[273.404386] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[273.405250] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[275.603794] [082/156] (746s left) kms_flip (flip-vs-panning-vs-hang)
[275.689350] Starting subtest: flip-vs-panning-vs-hang
[275.690269] Starting dynamic subtest: A-eDP1
[326.862575] Dynamic subtest A-eDP1: SUCCESS (51.170s)
[326.873228] Starting dynamic subtest: D-eDP1
[366.792275] Dynamic subtest D-eDP1: SUCCESS (39.927s)
[366.794905] Subtest flip-vs-panning-vs-hang: SUCCESS (91.102s)
[368.005010] [083/156] (654s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[368.113982] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[369.126339] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.012s)
[369.255379] [084/156] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[369.348424] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[369.350937] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[369.445495] [085/156] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[369.537615] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[369.539406] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[369.630544] [086/156] (653s left) gem_ctx_param (basic)
[369.676725] Starting subtest: basic
[369.677698] Subtest basic: SUCCESS (0.001s)
[369.765125] [087/156] (652s left) kms_vblank (query-busy-hang)
[369.845078] Starting subtest: query-busy-hang
[369.845886] Starting dynamic subtest: pipe-A-eDP-1
[396.126521] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.279s)
[396.139465] Starting dynamic subtest: pipe-D-eDP-1
[421.100338] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.970s)
[421.101678] Subtest query-busy-hang: SUCCESS (51.254s)
[421.987017] [088/156] (600s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[422.085630] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[422.087410] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[422.181267] [089/156] (600s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[422.267432] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[422.269524] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[422.349383] [090/156] (600s left) gem_ccs (suspend-resume)
[422.410253] Starting subtest: suspend-resume
[422.412793] Subtest suspend-resume: SKIP (0.000s)
[422.509831] [091/156] (600s left) gem_lmem_swapping (parallel-random-verify)
[422.547507] Subtest parallel-random-verify: SKIP (0.000s)
[422.581214] [092/156] (600s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[422.624400] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[422.625551] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[422.729912] [093/156] (600s left) syncobj_basic (bad-destroy-pad)
[422.777553] Starting subtest: bad-destroy-pad
[422.778653] Subtest bad-destroy-pad: SUCCESS (0.000s)
[422.888328] [094/156] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[422.993892] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[422.995832] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[423.093821] [095/156] (599s left) prime_mmap (test_map_unmap)
[423.143960] Starting subtest: test_map_unmap
[423.144949] Starting dynamic subtest: test_map_unmap-smem
[423.176073] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[423.177232] Subtest test_map_unmap: SUCCESS (0.034s)
[423.275133] [096/156] (599s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[423.360180] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite
[423.362519] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[423.442963] [097/156] (599s left) gem_eio (create-ext)
[423.635442] Starting subtest: create-ext
[423.916255] Subtest create-ext: SUCCESS (0.280s)
[424.027252] [098/156] (599s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[424.149204] Starting subtest: short-flip-after-cursor-atomic-transitions
[425.108838] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.959s)
[425.986446] [099/156] (597s left) i915_query (engine-info)
[426.033735] Starting subtest: engine-info
[426.038429] Subtest engine-info: SUCCESS (0.005s)
[426.141617] [100/156] (597s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[426.252154] Starting subtest: short-flip-before-cursor-toggle
[427.166557] Subtest short-flip-before-cursor-toggle: SUCCESS (0.914s)
[427.986176] [101/156] (595s left) gem_pxp (reject-modify-context-protection-on)
[428.092467] Starting subtest: reject-modify-context-protection-on
[428.093587] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[428.190292] [102/156] (595s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt)
[428.277703] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt
[428.279513] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[428.374276] [103/156] (594s left) gem_exec_schedule (implicit-read-write)
[428.425258] Starting subtest: implicit-read-write
[428.426206] Starting dynamic subtest: rcs0
[428.534802] Dynamic subtest rcs0: SUCCESS (0.108s)
[428.546170] Starting dynamic subtest: vcs0
[428.613529] Dynamic subtest vcs0: SUCCESS (0.078s)
[428.624612] Starting dynamic subtest: vcs1
[428.692608] Dynamic subtest vcs1: SUCCESS (0.078s)
[428.703356] Starting dynamic subtest: vecs0
[428.772879] Dynamic subtest vecs0: SUCCESS (0.080s)
[428.782660] Starting dynamic subtest: ccs0
[428.868736] Dynamic subtest ccs0: SUCCESS (0.095s)
[428.870089] Subtest implicit-read-write: SUCCESS (0.444s)
[430.387620] [104/156] (592s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[430.502347] Starting subtest: flip-vs-cursor-crc-legacy
[431.173185] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.671s)
[431.983134] [105/156] (591s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[432.082599] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[432.084287] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[432.162687] [106/156] (591s left) kms_psr (psr2-sprite-plane-move)
[432.243787] Starting subtest: psr2-sprite-plane-move
[432.244697] Starting dynamic subtest: eDP-1
[433.983058] Dynamic subtest eDP-1: SUCCESS (1.738s)
[433.984030] Subtest psr2-sprite-plane-move: SUCCESS (1.739s)
[434.780811] [107/156] (588s left) syncobj_timeline (invalid-signal-zero-handles)
[434.832807] Starting subtest: invalid-signal-zero-handles
[434.833869] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[434.932639] [108/156] (588s left) sysfs_preempt_timeout (timeout)
[434.988910] Starting subtest: timeout
[434.989963] Starting dynamic subtest: vecs0
[444.312675] Dynamic subtest vecs0: SUCCESS (9.313s)
[444.322225] Starting dynamic subtest: ccs0
[445.603421] Dynamic subtest ccs0: SUCCESS (1.298s)
[445.614388] Starting dynamic subtest: vcs0
[455.327637] Dynamic subtest vcs0: SUCCESS (9.712s)
[455.337593] Starting dynamic subtest: bcs0
[456.597418] Dynamic subtest bcs0: SUCCESS (1.277s)
[456.609265] Starting dynamic subtest: rcs0
[457.847827] Dynamic subtest rcs0: SUCCESS (1.247s)
[457.858086] Starting dynamic subtest: vcs1
[467.357234] Dynamic subtest vcs1: SUCCESS (9.500s)
[467.358243] Subtest timeout: SUCCESS (32.358s)
[467.417320] [109/156] (556s left) kms_psr (psr-sprite-mmap-cpu)
[467.515128] Starting subtest: psr-sprite-mmap-cpu
[467.516056] Starting dynamic subtest: eDP-1
[469.248639] Dynamic subtest eDP-1: SUCCESS (1.732s)
[469.249632] Subtest psr-sprite-mmap-cpu: SUCCESS (1.733s)
[470.084567] [110/156] (553s left) perf (buffer-fill)
[470.206412] Starting subtest: buffer-fill
[470.207315] Starting dynamic subtest: 0-rcs0
[472.482116] Dynamic subtest 0-rcs0: SUCCESS (2.266s)
[472.492478] Starting dynamic subtest: 1-vcs0
[476.942694] Dynamic subtest 1-vcs0: SUCCESS (4.459s)
[476.943607] Subtest buffer-fill: SUCCESS (6.727s)
[476.979199] [111/156] (546s left) gem_readwrite (beyond-eob)
[477.029057] Subtest beyond-EOB: SKIP (0.000s)
[477.085098] [112/156] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[477.183396] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[486.944811] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.760s)
[487.063777] [113/156] (536s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[487.160897] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[487.841370] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[487.998918] [114/156] (535s left) gem_ctx_persistence (hang)
[488.047218] Starting subtest: hang
[488.049403] Subtest hang: SKIP (0.000s)
[488.145248] [115/156] (535s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[488.238871] Starting subtest: psr-rgb101010-draw-pwrite
[496.101198] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.865s)
[496.198286] [116/156] (527s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[496.285675] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[496.287421] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[496.375620] [117/156] (527s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt)
[496.475394] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt
[496.477271] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[496.575742] [118/156] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[496.659072] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[503.355153] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.697s)
[503.497120] [119/156] (520s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[503.587185] Starting subtest: hdr-rgb565-draw-pwrite
[503.588986] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[503.673447] [120/156] (520s left) kms_vrr (flip-suspend)
[503.761361] Starting subtest: flip-suspend
[503.763865] Subtest flip-suspend: SKIP (0.000s)
[503.835744] [121/156] (520s left) kms_cursor_crc (cursor-sliding-256x256)
[504.073264] Starting subtest: cursor-sliding-256x256
[504.075448] Starting dynamic subtest: pipe-A-eDP-1
[507.306848] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.231s)
[507.339039] Starting dynamic subtest: pipe-D-eDP-1
[511.243271] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.912s)
[511.244621] Subtest cursor-sliding-256x256: SUCCESS (7.171s)
[512.078423] [122/156] (511s left) perf_pmu (idle)
[512.111271] Starting subtest: idle
[512.112237] Starting dynamic subtest: rcs0
[512.677379] Dynamic subtest rcs0: SUCCESS (0.555s)
[512.692390] Starting dynamic subtest: bcs0
[513.199780] Dynamic subtest bcs0: SUCCESS (0.520s)
[513.213592] Starting dynamic subtest: vcs0
[513.720705] Dynamic subtest vcs0: SUCCESS (0.518s)
[513.728666] Starting dynamic subtest: vcs1
[514.238533] Dynamic subtest vcs1: SUCCESS (0.515s)
[514.249789] Starting dynamic subtest: vecs0
[514.755490] Dynamic subtest vecs0: SUCCESS (0.515s)
[514.765472] Starting dynamic subtest: ccs0
[515.271226] Dynamic subtest ccs0: SUCCESS (0.513s)
[515.272661] Subtest idle: SUCCESS (3.152s)
[515.356579] [123/156] (508s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[515.473787] Starting subtest: flip-vs-cursor-legacy
[523.135356] Subtest flip-vs-cursor-legacy: SUCCESS (7.660s)
[523.966350] [124/156] (500s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[524.052398] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[524.053272] Starting dynamic subtest: pipe-A-eDP-1
[524.061409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[524.070107] Starting dynamic subtest: pipe-B-eDP-1
[524.078264] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[524.086214] Starting dynamic subtest: pipe-C-eDP-1
[524.094231] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[524.102447] Starting dynamic subtest: pipe-D-eDP-1
[524.111367] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[524.113023] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[526.262455] [125/156] (497s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[526.364430] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[531.010344] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.647s)
[532.197902] [126/156] (491s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[532.293930] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[532.295796] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[532.374312] [127/156] (491s left) gem_exec_balancer (smoke)
[532.442461] Starting subtest: smoke
[555.113333] Subtest smoke: SUCCESS (22.660s)
[556.091104] [128/156] (468s left) kms_pm_dc (dc9-dpms)
[557.188445] Starting subtest: dc9-dpms
[558.652156] Subtest dc9-dpms: SUCCESS (1.465s)
[558.722524] [129/156] (465s left) kms_atomic (atomic-invalid-params)
[558.816441] Starting subtest: atomic-invalid-params
[558.817401] Starting dynamic subtest: pipe-A-eDP-1
[559.212233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[559.213081] Subtest atomic-invalid-params: SUCCESS (0.396s)
[560.071571] [130/156] (464s left) kms_properties (invalid-properties-legacy)
[560.153186] Starting subtest: invalid-properties-legacy
[560.272837] Subtest invalid-properties-legacy: SUCCESS (0.112s)
[560.347562] [131/156] (463s left) kms_cdclk (mode-transition)
[560.429169] Starting subtest: mode-transition
[560.429953] Starting dynamic subtest: pipe-A-eDP-1
[560.721873] Dynamic subtest pipe-A-eDP-1: SKIP (0.291s)
[560.730296] Starting dynamic subtest: pipe-B-eDP-1
[560.731856] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[560.744042] Starting dynamic subtest: pipe-C-eDP-1
[560.745881] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[560.754197] Starting dynamic subtest: pipe-D-eDP-1
[560.755870] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[560.757591] Subtest mode-transition: SKIP (0.301s)
[561.562641] [132/156] (462s left) gem_wait (invalid-buf)
[561.611809] Starting subtest: invalid-buf
[561.612768] Subtest invalid-buf: SUCCESS (0.000s)
[561.804207] [133/156] (462s left) gen9_exec_parse (basic-rejected)
[561.854027] Subtest basic-rejected: SKIP (0.000s)
[561.919227] [134/156] (462s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[562.012178] Starting subtest: psr2-plane-move-sf-dmg-area
[562.013052] Starting dynamic subtest: pipe-A-eDP-1
[566.539577] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.527s)
[566.549326] Starting dynamic subtest: pipe-B-eDP-1
[571.721384] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.179s)
[571.722486] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.710s)
[572.572694] [135/156] (451s left) gem_wait (busy)
[572.633209] Starting subtest: busy
[572.634136] Starting dynamic subtest: all-engines
[574.309353] Dynamic subtest all-engines: SUCCESS (1.666s)
[574.320500] Starting dynamic subtest: rcs0
[574.842361] Dynamic subtest rcs0: SUCCESS (0.540s)
[574.853034] Starting dynamic subtest: bcs0
[575.382395] Dynamic subtest bcs0: SUCCESS (0.539s)
[575.393832] Starting dynamic subtest: vcs0
[577.316915] Dynamic subtest vcs0: SUCCESS (1.924s)
[577.327668] Starting dynamic subtest: vcs1
[579.300912] Dynamic subtest vcs1: SUCCESS (1.981s)
[579.311179] Starting dynamic subtest: vecs0
[581.348922] Dynamic subtest vecs0: SUCCESS (2.045s)
[581.358876] Starting dynamic subtest: ccs0
[581.884814] Dynamic subtest ccs0: SUCCESS (0.543s)
[581.886469] Subtest busy: SUCCESS (9.252s)
[582.091825] [136/156] (442s left) prime_busy (after-wait)
[582.145439] Starting subtest: after-wait
[582.149475] Starting dynamic subtest: rcs0
[582.182341] Dynamic subtest rcs0: SUCCESS (0.033s)
[582.192058] Starting dynamic subtest: bcs0
[582.236779] Dynamic subtest bcs0: SUCCESS (0.054s)
[582.245620] Starting dynamic subtest: vcs0
[582.278859] Dynamic subtest vcs0: SUCCESS (0.042s)
[582.286806] Starting dynamic subtest: vcs1
[582.319629] Dynamic subtest vcs1: SUCCESS (0.040s)
[582.328153] Starting dynamic subtest: vecs0
[582.360357] Dynamic subtest vecs0: SUCCESS (0.040s)
[582.369020] Starting dynamic subtest: ccs0
[582.401490] Dynamic subtest ccs0: SUCCESS (0.040s)
[582.508894] Subtest after-wait: SUCCESS (0.363s)
[582.595893] [137/156] (441s left) syncobj_timeline (host-signal-points)
[582.638355] Starting subtest: host-signal-points
[582.642664] Subtest host-signal-points: SUCCESS (0.004s)
[582.751200] [138/156] (441s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[582.841996] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[582.843836] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[582.933111] [139/156] (441s left) kms_psr (fbc-psr-sprite-render)
[583.021720] Starting subtest: fbc-psr-sprite-render
[583.022767] Starting dynamic subtest: eDP-1
[583.024766] Dynamic subtest eDP-1: SKIP (0.000s)
[583.026553] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[583.092988] [140/156] (441s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[583.182459] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[583.184538] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[583.264304] [141/156] (441s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[583.351264] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[583.353286] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[583.450240] [142/156] (441s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[583.532463] Starting subtest: plane-downscale-factor-0-75-with-rotation
[583.533422] Starting dynamic subtest: pipe-A
[583.761675] Dynamic subtest pipe-A: SUCCESS (0.230s)
[583.770074] Starting dynamic subtest: pipe-B
[585.029454] Dynamic subtest pipe-B: SUCCESS (1.267s)
[585.038083] Starting dynamic subtest: pipe-C
[586.336708] Dynamic subtest pipe-C: SUCCESS (1.306s)
[586.349944] Starting dynamic subtest: pipe-D
[587.642882] Dynamic subtest pipe-D: SUCCESS (1.304s)
[587.643911] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.112s)
[588.792285] [143/156] (435s left) syncobj_wait (multi-wait-submitted-signaled)
[588.841687] Starting subtest: multi-wait-submitted-signaled
[588.842868] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[588.944656] [144/156] (435s left) gem_exec_reloc (basic-write-cpu-noreloc)
[589.001677] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[589.088421] [145/156] (435s left) kms_plane_multiple (tiling-4)
[589.182468] Starting subtest: tiling-4
[589.183448] Starting dynamic subtest: pipe-A-eDP-1
[593.024538] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.841s)
[593.032598] Starting dynamic subtest: pipe-B-eDP-1
[597.606643] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.581s)
[597.616944] Starting dynamic subtest: pipe-C-eDP-1
[602.193951] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.586s)
[602.202323] Starting dynamic subtest: pipe-D-eDP-1
[606.794871] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.599s)
[606.795693] Subtest tiling-4: SUCCESS (17.612s)
[607.669211] [146/156] (417s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[607.760081] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[607.761660] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[607.859494] [147/156] (416s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[607.959642] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[614.663042] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.704s)
[614.783799] [148/156] (410s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[614.894954] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[619.470891] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.577s)
[620.671779] [149/156] (404s left) vgem_basic (sysfs)
[620.709272] Starting subtest: sysfs
[620.710098] Subtest sysfs: SUCCESS (0.000s)
[620.762816] [150/156] (404s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[620.846744] Starting subtest: fbchdr-rgb101010-draw-render
[620.848628] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[620.934443] [151/156] (403s left) gem_exec_schedule (independent)
[620.986471] Starting subtest: independent
[620.987690] Starting dynamic subtest: rcs0
[622.309829] Dynamic subtest rcs0: SUCCESS (1.313s)
[622.321787] Starting dynamic subtest: vcs0
[624.373549] Dynamic subtest vcs0: SUCCESS (2.063s)
[624.388164] Starting dynamic subtest: vcs1
[626.340409] Dynamic subtest vcs1: SUCCESS (1.964s)
[626.351736] Starting dynamic subtest: vecs0
[628.332920] Dynamic subtest vecs0: SUCCESS (1.991s)
[628.342663] Starting dynamic subtest: ccs0
[630.309476] Dynamic subtest ccs0: SUCCESS (1.973s)
[630.311053] Subtest independent: SUCCESS (9.316s)
[630.599043] [152/156] (394s left) perf (non-zero-reason)
[630.694951] Starting subtest: non-zero-reason
[630.696509] Starting dynamic subtest: 0-rcs0
[636.958976] Dynamic subtest 0-rcs0: SUCCESS (6.255s)
[636.970476] Starting dynamic subtest: 1-vcs1
[641.311050] Dynamic subtest 1-vcs1: SUCCESS (4.315s)
[641.312285] Subtest non-zero-reason: SUCCESS (10.571s)
[641.344421] [153/156] (383s left) api_intel_bb (intel-bb-blit-y)
[641.393114] Starting subtest: intel-bb-blit-y
[645.074463] Subtest intel-bb-blit-y: SUCCESS (3.672s)
[645.172780] [154/156] (379s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[645.270923] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[645.272545] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[645.368803] [155/156] (379s left) kms_busy (extended-modeset-hang-newfb)
[645.456103] Starting subtest: extended-modeset-hang-newfb
[645.458412] Starting dynamic subtest: pipe-A
[680.256490] Dynamic subtest pipe-A: SUCCESS (34.798s)
[680.266245] Starting dynamic subtest: pipe-D
[703.286493] Dynamic subtest pipe-D: SUCCESS (23.027s)
[703.287372] Subtest extended-modeset-hang-newfb: SUCCESS (57.829s)
[704.155555] [156/156] (320s left) kms_invalid_mode (bad-vsync-start)
[704.239396] Starting subtest: bad-vsync-start
[704.240168] Starting dynamic subtest: pipe-A-eDP-1
[704.534675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[704.543151] Starting dynamic subtest: pipe-B-eDP-1
[704.544047] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[704.551995] Starting dynamic subtest: pipe-C-eDP-1
[704.552918] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[704.560762] Starting dynamic subtest: pipe-D-eDP-1
[704.561509] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[704.562306] Subtest bad-vsync-start: SUCCESS (0.301s)
[705.347650] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_flink_basic
results: parsing output: 4/ for test: kms_chamelium_frames
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: gem_flink_basic
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_getfb
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_color_pipeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: kms_pm_backlight
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: i915_module_load
results: parsing output: 28/ for test: gem_pwrite
results: parsing output: 29/ for test: gem_ctx_freq
results: parsing output: 30/ for test: gem_ccs
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: i915_pm_rpm
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: dumb_buffer
results: parsing output: 48/ for test: i915_drm_fdinfo
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_prop_blob
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: kms_pipe_crc_basic
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_getfb
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_force_connector_basic
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_ringfill
results: parsing output: 74/ for test: prime_vgem
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_ctx_param
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ccs
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: syncobj_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: i915_query
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_pxp
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: sysfs_preempt_timeout
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: gem_readwrite
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_vrr
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_pm_dc
results: parsing output: 128/ for test: kms_atomic
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: kms_cdclk
results: parsing output: 131/ for test: gem_wait
results: parsing output: 132/ for test: gen9_exec_parse
results: parsing output: 133/ for test: kms_psr2_sf
results: parsing output: 134/ for test: gem_wait
results: parsing output: 135/ for test: prime_busy
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_flip_scaled_crc
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_plane_scaling
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: gem_exec_reloc
results: parsing output: 144/ for test: kms_plane_multiple
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: vgem_basic
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_schedule
results: parsing output: 151/ for test: perf
results: parsing output: 152/ for test: api_intel_bb
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_busy
results: parsing output: 155/ for test: kms_invalid_mode
Done.