[59.584156] Initializing watchdogs
[59.584204]   /dev/watchdog0
[59.598434] [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.602743] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.604864] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.608214] [001/156] (960s left) kms_force_connector_basic (force-edid)
[59.699812] Starting subtest: force-edid
[60.072545] Subtest force-edid: SUCCESS (0.372s)
[60.224350] [002/156] (959s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[60.313044] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[60.314964] Starting dynamic subtest: pipe-A-eDP-1
[62.494581] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.183s)
[62.504318] Starting dynamic subtest: pipe-B-eDP-1
[64.804699] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.308s)
[64.813866] Starting dynamic subtest: pipe-C-eDP-1
[66.892158] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.087s)
[66.899833] Starting dynamic subtest: pipe-D-eDP-1
[69.051254] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.159s)
[69.053323] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.741s)
[70.447989] [003/156] (949s left) kms_psr (fbc-psr2-cursor-plane-move)
[70.549461] Starting subtest: fbc-psr2-cursor-plane-move
[70.551341] Starting dynamic subtest: eDP-1
[70.555285] Dynamic subtest eDP-1: SKIP (0.000s)
[70.559315] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[70.630959] [004/156] (949s left) gem_mmap_wc (set-cache-level)
[70.682145] Subtest set-cache-level: SKIP (0.000s)
[70.738704] [005/156] (949s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[70.835052] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[80.434798] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.604s)
[80.570870] [006/156] (939s left) kms_vblank (query-forked)
[80.654997] Starting subtest: query-forked
[80.657332] Starting dynamic subtest: pipe-A-eDP-1
[82.495104] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.841s)
[82.507702] Starting dynamic subtest: pipe-D-eDP-1
[85.008292] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.509s)
[85.010535] Subtest query-forked: SUCCESS (4.353s)
[85.819898] [007/156] (934s left) gem_exec_reloc (basic-wc-read-active)
[85.886901] Subtest basic-wc-read-active: SKIP (0.000s)
[85.961677] [008/156] (934s left) kms_rotation_crc (bad-tiling)
[86.059077] Starting subtest: bad-tiling
[86.063154] Subtest bad-tiling: SKIP (0.001s)
[86.127753] [009/156] (934s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[86.223092] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[86.227270] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[86.314596] [010/156] (934s left) syncobj_wait (wait-delayed-signal)
[86.364877] Starting subtest: wait-delayed-signal
[86.468393] Subtest wait-delayed-signal: SUCCESS (0.102s)
[86.541199] [011/156] (933s left) gem_exec_suspend (basic-s3)
[86.610143] Starting subtest: basic-S3
[86.612673] Starting dynamic subtest: smem
[107.282649] Dynamic subtest smem: SUCCESS (7.662s)
[107.285928] Subtest basic-S3: SUCCESS (7.664s)
[107.484283] [012/156] (913s left) gem_ctx_sseu (invalid-args)
[107.551055] Subtest invalid-args: SKIP (0.000s)
[107.618435] [013/156] (912s left) syncobj_timeline (multi-wait-all-signaled)
[107.668099] Starting subtest: multi-wait-all-signaled
[107.670488] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[107.756416] [014/156] (912s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[107.868378] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[107.872663] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[107.952318] [015/156] (912s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[108.012144] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[108.014521] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[108.103520] [016/156] (912s left) kms_prop_blob (blob-multiple)
[108.162756] Starting subtest: blob-multiple
[108.165114] Subtest blob-multiple: SUCCESS (0.004s)
[108.286908] [017/156] (912s left) kms_flip (bo-too-big-interruptible)
[108.392941] Starting subtest: bo-too-big-interruptible
[108.395123] Starting dynamic subtest: A-eDP1
[109.653982] Dynamic subtest A-eDP1: SUCCESS (1.258s)
[109.663513] Starting dynamic subtest: B-eDP1
[110.953805] Dynamic subtest B-eDP1: SUCCESS (1.297s)
[110.968762] Starting dynamic subtest: C-eDP1
[112.256045] Dynamic subtest C-eDP1: SUCCESS (1.299s)
[112.267250] Starting dynamic subtest: D-eDP1
[113.554126] Dynamic subtest D-eDP1: SUCCESS (1.297s)
[113.559596] Subtest bo-too-big-interruptible: SUCCESS (5.163s)
[114.731150] [018/156] (906s left) kms_busy (extended-modeset-hang-newfb)
[114.831414] Starting subtest: extended-modeset-hang-newfb
[114.833939] Starting dynamic subtest: pipe-A
[150.170387] Dynamic subtest pipe-A: SUCCESS (35.331s)
[150.180426] Starting dynamic subtest: pipe-D
[173.200216] Dynamic subtest pipe-D: SUCCESS (23.026s)
[173.202632] Subtest extended-modeset-hang-newfb: SUCCESS (58.363s)
[174.034004] [019/156] (846s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[174.621620] Starting subtest: syncobj-timeline-multiple-ext-nodes
[174.624402] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[176.425661] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[176.429096] [020/156] (844s left) syncobj_wait (reset-unsignaled)
[176.482613] Starting subtest: reset-unsignaled
[176.484945] Subtest reset-unsignaled: SUCCESS (0.000s)
[176.583114] [021/156] (844s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[176.695735] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[183.771406] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.080s)
[183.903860] [022/156] (837s left) gem_exec_nop (basic-series)
[183.986720] Starting subtest: basic-series
[200.342097] Subtest basic-series: SUCCESS (16.360s)
[200.578636] [023/156] (820s left) gem_ppgtt (shrink-vs-evict-any)
[200.639789] Starting subtest: shrink-vs-evict-any
[206.247224] Subtest shrink-vs-evict-any: SUCCESS (5.609s)
[206.314865] [024/156] (814s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[206.427484] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[206.432396] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[206.536706] [025/156] (814s left) gen7_exec_parse (chained-batch)
[206.592175] Subtest chained-batch: SKIP (0.000s)
[206.661421] [026/156] (814s left) gem_spin_batch (resubmit-all)
[206.712664] Starting subtest: resubmit-all
[206.715191] Starting dynamic subtest: rcs0
[206.725432] Dynamic subtest rcs0: SUCCESS (0.013s)
[206.736448] Starting dynamic subtest: bcs0
[206.739231] Dynamic subtest bcs0: SUCCESS (0.002s)
[206.748631] Starting dynamic subtest: vcs0
[206.750914] Dynamic subtest vcs0: SUCCESS (0.002s)
[206.759618] Starting dynamic subtest: vcs1
[206.761874] Dynamic subtest vcs1: SUCCESS (0.002s)
[206.770781] Starting dynamic subtest: vecs0
[206.773065] Dynamic subtest vecs0: SUCCESS (0.002s)
[206.781712] Starting dynamic subtest: ccs0
[206.783940] Dynamic subtest ccs0: SUCCESS (0.002s)
[206.786013] Subtest resubmit-all: SUCCESS (0.027s)
[208.311081] [027/156] (812s left) syncobj_timeline (wait-all-delayed-signal)
[208.361071] Starting subtest: wait-all-delayed-signal
[208.462247] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[208.539811] [028/156] (812s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[208.650694] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[208.654937] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[208.754790] [029/156] (812s left) kms_flip (2x-plain-flip-interruptible)
[208.857026] Starting subtest: 2x-plain-flip-interruptible
[208.867785] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[208.941750] [030/156] (812s left) gem_eio (in-flight-contexts-1us)
[209.153780] Starting subtest: in-flight-contexts-1us
[220.336044] Subtest in-flight-contexts-1us: SUCCESS (11.183s)
[220.511000] [031/156] (800s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[220.623567] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[220.628221] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[220.698308] [032/156] (800s left) gem_mmap_gtt (big-bo-tiledx)
[220.756160] Subtest big-bo-tiledX: SKIP (0.000s)
[220.816797] [033/156] (800s left) vgem_basic (create)
[220.861318] Starting subtest: create
[220.863219] Subtest create: SUCCESS (0.000s)
[220.934764] [034/156] (800s left) kms_cursor_crc (cursor-random-256x256)
[221.182548] Starting subtest: cursor-random-256x256
[221.188640] Starting dynamic subtest: pipe-A-eDP-1
[224.578342] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.390s)
[224.605954] Starting dynamic subtest: pipe-D-eDP-1
[228.623510] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.025s)
[228.625990] Subtest cursor-random-256x256: SUCCESS (7.441s)
[229.438123] [035/156] (792s left) kms_frontbuffer_tracking (fbc-stridechange)
[229.534838] Starting subtest: fbc-stridechange
[232.825242] Subtest fbc-stridechange: SUCCESS (3.296s)
[234.042408] [036/156] (787s left) gem_ctx_persistence (saturated-hostile)
[234.095720] Starting subtest: saturated-hostile
[234.098005] Starting dynamic subtest: rcs0
[234.911928] Dynamic subtest rcs0: SUCCESS (0.815s)
[234.923624] Starting dynamic subtest: bcs0
[235.697672] Dynamic subtest bcs0: SUCCESS (0.784s)
[235.710301] Starting dynamic subtest: vcs0
[236.499833] Dynamic subtest vcs0: SUCCESS (0.800s)
[236.512055] Starting dynamic subtest: vcs1
[237.313928] Dynamic subtest vcs1: SUCCESS (0.812s)
[237.324827] Starting dynamic subtest: vecs0
[238.113634] Dynamic subtest vecs0: SUCCESS (0.799s)
[238.126215] Starting dynamic subtest: ccs0
[238.932365] Dynamic subtest ccs0: SUCCESS (0.813s)
[238.934410] Subtest saturated-hostile: SUCCESS (4.834s)
[239.014263] [037/156] (782s left) gem_partial_pwrite_pread (write-display)
[239.077565] Subtest write-display: SKIP (0.000s)
[239.159004] [038/156] (782s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[239.264666] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[239.266939] Starting dynamic subtest: pipe-A-eDP-1
[239.290436] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.302541] Starting dynamic subtest: pipe-B-eDP-1
[239.323737] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.333127] Starting dynamic subtest: pipe-C-eDP-1
[239.353839] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.363479] Starting dynamic subtest: pipe-D-eDP-1
[239.385370] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.389762] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[241.517226] [039/156] (780s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[241.627739] Starting subtest: hdr-rgb565-draw-mmap-wc
[241.632871] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[241.712137] [040/156] (779s left) kms_lease (implicit-plane-lease)
[241.800407] Starting subtest: implicit-plane-lease
[241.802868] Subtest implicit-plane-lease: SUCCESS (0.002s)
[241.904247] [041/156] (779s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[241.987985] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[241.991965] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[242.070699] [042/156] (779s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[242.175742] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[242.179840] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[242.266166] [043/156] (779s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[242.376431] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[242.380596] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[242.496814] [044/156] (779s left) kms_big_fb (linear-16bpp-rotate-90)
[242.591395] Starting subtest: linear-16bpp-rotate-90
[242.610672] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[242.723607] [045/156] (779s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[242.817371] Starting subtest: fbchdr-2p-rte
[242.821067] Subtest fbchdr-2p-rte: SKIP (0.000s)
[242.918218] [046/156] (779s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[243.017852] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[243.021550] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[243.124866] [047/156] (778s left) i915_query (query-topology-garbage-items)
[243.180467] Starting subtest: query-topology-garbage-items
[243.182063] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[243.293721] [048/156] (778s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[243.383755] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[243.387263] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[243.489214] [049/156] (778s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[243.874223] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[244.707253] [050/156] (777s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[244.806668] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[244.809481] Starting dynamic subtest: pipe-A-default-mode
[245.951676] Dynamic subtest pipe-A-default-mode: SKIP (1.142s)
[245.956158] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.143s)
[246.107273] [051/156] (776s left) kms_vblank (query-idle-hang)
[246.200983] Starting subtest: query-idle-hang
[246.203201] Starting dynamic subtest: pipe-A-eDP-1
[273.032740] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.827s)
[273.047635] Starting dynamic subtest: pipe-D-eDP-1
[288.091070] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.056s)
[288.093482] Subtest query-idle-hang: SUCCESS (41.887s)
[288.923467] [052/156] (733s left) gem_mmap_offset (clear)
[288.978786] Starting subtest: clear
[288.981255] Starting dynamic subtest: smem0
[313.754533] Dynamic subtest smem0: SUCCESS (24.770s)
[313.756686] Subtest clear: SUCCESS (24.771s)
[313.880046] [053/156] (708s left) i915_hangman (engine-engine-error)
[313.998903] Starting subtest: engine-engine-error
[314.000909] Starting dynamic subtest: rcs0
[315.248251] Dynamic subtest rcs0: SUCCESS (1.248s)
[315.262815] Starting dynamic subtest: bcs0
[317.295338] Dynamic subtest bcs0: SUCCESS (2.045s)
[317.311083] Starting dynamic subtest: vcs0
[319.278953] Dynamic subtest vcs0: SUCCESS (1.980s)
[319.294041] Starting dynamic subtest: vcs1
[321.263430] Dynamic subtest vcs1: SUCCESS (1.982s)
[321.278647] Starting dynamic subtest: vecs0
[323.246902] Dynamic subtest vecs0: SUCCESS (1.981s)
[323.261823] Starting dynamic subtest: ccs0
[325.298005] Dynamic subtest ccs0: SUCCESS (2.049s)
[325.301506] Subtest engine-engine-error: SUCCESS (11.300s)
[325.430793] [054/156] (696s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[325.554657] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[325.558961] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[325.666684] [055/156] (696s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[325.768605] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[325.772737] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[325.872556] [056/156] (696s left) kms_psr (psr-sprite-plane-onoff)
[325.963218] Starting subtest: psr-sprite-plane-onoff
[325.965957] Starting dynamic subtest: eDP-1
[327.712593] Dynamic subtest eDP-1: SUCCESS (1.748s)
[327.714930] Subtest psr-sprite-plane-onoff: SUCCESS (1.749s)
[328.511580] [057/156] (693s left) kms_psr (fbc-pr-primary-mmap-gtt)
[328.608588] Starting subtest: fbc-pr-primary-mmap-gtt
[328.612945] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[328.684116] [058/156] (693s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[328.785195] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[328.789480] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[328.890612] [059/156] (693s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[328.978288] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[328.982508] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[329.062069] [060/156] (693s left) kms_cursor_crc (cursor-offscreen-32x32)
[329.203744] Starting subtest: cursor-offscreen-32x32
[329.251175] Subtest cursor-offscreen-32x32: SKIP (0.043s)
[329.591372] [061/156] (693s left) gem_exec_schedule (noreorder-corked)
[329.774497] Starting subtest: noreorder-corked
[329.777007] Starting dynamic subtest: rcs0
[330.906152] Dynamic subtest rcs0: SUCCESS (1.131s)
[330.921391] Starting dynamic subtest: vcs0
[332.284632] Dynamic subtest vcs0: SUCCESS (1.376s)
[332.294580] Starting dynamic subtest: vcs1
[334.288310] Dynamic subtest vcs1: SUCCESS (2.001s)
[334.299070] Starting dynamic subtest: vecs0
[336.322937] Dynamic subtest vecs0: SUCCESS (2.032s)
[336.335341] Starting dynamic subtest: ccs0
[337.479121] Dynamic subtest ccs0: SUCCESS (1.154s)
[337.481724] Subtest noreorder-corked: SUCCESS (7.706s)
[337.661716] [062/156] (684s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[337.711517] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[337.713775] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[337.814308] [063/156] (684s left) gem_render_copy_redux (normal)
[337.869875] Starting subtest: normal
[338.290768] Subtest normal: SUCCESS (0.421s)
[338.428402] [064/156] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[338.544866] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[345.900296] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.361s)
[346.026349] [065/156] (676s left) kms_psr (pr-cursor-plane-move)
[346.134242] Starting subtest: pr-cursor-plane-move
[346.138388] Subtest pr-cursor-plane-move: SKIP (0.000s)
[346.209328] [066/156] (676s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[346.309177] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[346.313059] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[346.407063] [067/156] (676s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[346.509808] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[346.520973] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[346.630363] [068/156] (676s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[346.743603] Starting subtest: cursorA-vs-flipA-toggle
[357.927576] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.185s)
[358.818375] [069/156] (664s left) kms_psr (psr-primary-mmap-gtt)
[358.909058] Starting subtest: psr-primary-mmap-gtt
[358.911390] Starting dynamic subtest: eDP-1
[360.384941] Dynamic subtest eDP-1: SKIP (1.473s)
[360.390149] Subtest psr-primary-mmap-gtt: SKIP (1.476s)
[360.540023] [070/156] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[360.633694] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[360.637801] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[360.726366] [071/156] (662s left) gem_exec_reloc (basic-active)
[360.788087] Subtest basic-active: SKIP (0.000s)
[360.864318] [072/156] (662s left) gem_userptr_blits (sync-unmap)
[360.926179] Starting subtest: sync-unmap
[360.939700] Subtest sync-unmap: SUCCESS (0.013s)
[361.062986] [073/156] (662s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[361.167245] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[368.377538] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.216s)
[369.523481] [074/156] (653s left) gem_mmap (basic)
[369.575572] Subtest basic: SKIP (0.000s)
[369.635323] [075/156] (653s left) sw_sync (alloc_merge_fence)
[369.672631] Starting subtest: alloc_merge_fence
[369.675020] Subtest alloc_merge_fence: SUCCESS (0.000s)
[369.728697] [076/156] (653s left) kms_getfb (getfb-handle-not-fb)
[369.823312] Starting subtest: getfb-handle-not-fb
[369.825524] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[369.914685] [077/156] (653s left) kms_cursor_edge_walk (64x64-top-edge)
[370.009628] Starting subtest: 64x64-top-edge
[370.011876] Starting dynamic subtest: pipe-A-eDP-1
[373.443337] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.432s)
[373.454687] Starting dynamic subtest: pipe-D-eDP-1
[376.622450] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.179s)
[376.624701] Subtest 64x64-top-edge: SUCCESS (6.614s)
[377.509489] [078/156] (645s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt)
[377.613659] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt
[377.617637] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[377.737878] [079/156] (645s left) gem_barrier_race (remote-request)
[377.805166] Starting subtest: remote-request
[377.807255] Starting dynamic subtest: rcs0
[383.002638] Dynamic subtest rcs0: SUCCESS (5.196s)
[383.010711] Subtest remote-request: SUCCESS (5.197s)
[383.143850] [080/156] (640s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[383.249645] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[383.252987] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[383.352671] [081/156] (640s left) perf_pmu (most-busy-idle-check-all)
[383.396208] Starting subtest: most-busy-idle-check-all
[383.398333] Starting dynamic subtest: rcs0
[385.298693] Dynamic subtest rcs0: SUCCESS (1.900s)
[385.315177] Starting dynamic subtest: bcs0
[387.281345] Dynamic subtest bcs0: SUCCESS (1.979s)
[387.293628] Starting dynamic subtest: vcs0
[389.330346] Dynamic subtest vcs0: SUCCESS (2.046s)
[389.343244] Starting dynamic subtest: vcs1
[391.313274] Dynamic subtest vcs1: SUCCESS (1.980s)
[391.326822] Starting dynamic subtest: vecs0
[393.298507] Dynamic subtest vecs0: SUCCESS (1.981s)
[393.312834] Starting dynamic subtest: ccs0
[395.281671] Dynamic subtest ccs0: SUCCESS (1.979s)
[395.284611] Subtest most-busy-idle-check-all: SUCCESS (11.885s)
[395.391760] [082/156] (628s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[395.447711] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[395.450155] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[395.546156] [083/156] (627s left) kms_content_protection (legacy)
[395.693003] Starting subtest: legacy
[395.697539] Subtest legacy: SKIP (0.000s)
[395.813619] [084/156] (627s left) api_intel_bb (simple-bb-ctx)
[395.866984] Starting subtest: simple-bb-ctx
[395.874143] Subtest simple-bb-ctx: SUCCESS (0.008s)
[396.005772] [085/156] (627s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt)
[396.095671] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt
[396.099773] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[396.197361] [086/156] (627s left) kms_chamelium_color (ctm-red-to-blue)
[396.291533] Subtest ctm-red-to-blue: SKIP (0.000s)
[396.339891] [087/156] (627s left) gem_exec_whisper (basic-queues)
[396.405282] Starting subtest: basic-queues
[403.382513] Subtest basic-queues: SUCCESS (6.976s)
[403.567990] [088/156] (620s left) kms_async_flips (alternate-sync-async-flip-atomic)
[403.657641] Starting subtest: alternate-sync-async-flip-atomic
[404.041356] Starting dynamic subtest: pipe-A-eDP-1
[406.872564] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.832s)
[407.273080] Starting dynamic subtest: pipe-B-eDP-1
[410.069449] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.810s)
[410.449864] Starting dynamic subtest: pipe-C-eDP-1
[413.268234] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.828s)
[413.635483] Starting dynamic subtest: pipe-D-eDP-1
[416.471341] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.847s)
[416.473406] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.816s)
[417.705338] [089/156] (606s left) gem_exec_params (dr1-dirt)
[417.776529] Starting subtest: DR1-dirt
[417.778768] Subtest DR1-dirt: SUCCESS (0.000s)
[417.883813] [090/156] (605s left) gem_mmap_wc (write-gtt-read-wc)
[417.937223] Subtest write-gtt-read-wc: SKIP (0.000s)
[418.001284] [091/156] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[418.104011] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[418.108033] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[418.215643] [092/156] (605s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[418.308099] Starting subtest: primary-yf-tiled-reflect-x-0
[418.378683] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.070s)
[418.485484] [093/156] (605s left) gem_ctx_param (vm)
[418.533992] Starting subtest: vm
[418.586193] Subtest vm: SUCCESS (0.051s)
[418.737211] [094/156] (605s left) gem_exec_balancer (fairslice)
[418.811137] Starting subtest: fairslice
[421.735274] Subtest fairslice: SUCCESS (2.922s)
[422.063467] [095/156] (602s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[422.163054] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[422.167451] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[422.236379] [096/156] (601s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[422.336756] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[422.340869] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[422.425658] [097/156] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[422.528912] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[422.532837] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[422.643067] [098/156] (601s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[422.704665] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[422.708959] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[422.886736] [099/156] (601s left) vgem_basic (bad-handle)
[422.929168] Starting subtest: bad-handle
[422.931219] Subtest bad-handle: SUCCESS (0.000s)
[422.985103] [100/156] (601s left) syncobj_wait (multi-wait-all-submitted)
[423.048302] Starting subtest: multi-wait-all-submitted
[423.149451] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[423.241981] [101/156] (601s left) kms_cursor_legacy (torture-bo)
[423.360735] Starting subtest: torture-bo
[423.363132] Starting dynamic subtest: pipe-A
[429.643525] Dynamic subtest pipe-A: SUCCESS (6.279s)
[429.654590] Starting dynamic subtest: pipe-B
[436.539219] Dynamic subtest pipe-B: SUCCESS (6.891s)
[436.559843] Starting dynamic subtest: pipe-C
[443.576549] Dynamic subtest pipe-C: SUCCESS (7.037s)
[443.594592] Starting dynamic subtest: pipe-D
[450.029497] Dynamic subtest pipe-D: SUCCESS (6.450s)
[450.046987] Starting dynamic subtest: all-pipes
[456.550939] Dynamic subtest all-pipes: SUCCESS (6.518s)
[456.553613] Subtest torture-bo: SUCCESS (33.186s)
[456.711571] [102/156] (567s left) kms_concurrent (multi-plane-atomic-lowres)
[456.801868] Starting subtest: multi-plane-atomic-lowres
[456.804173] Starting dynamic subtest: pipe-A-eDP-1
[457.304135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.500s)
[457.315341] Starting dynamic subtest: pipe-B-eDP-1
[458.535754] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.232s)
[458.547839] Starting dynamic subtest: pipe-C-eDP-1
[459.829674] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.292s)
[459.841915] Starting dynamic subtest: pipe-D-eDP-1
[461.120596] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.290s)
[461.122991] Subtest multi-plane-atomic-lowres: SUCCESS (4.319s)
[462.011607] [103/156] (562s left) gem_ctx_exec (basic)
[462.060570] Starting subtest: basic
[462.065696] Subtest basic: SUCCESS (0.005s)
[462.191774] [104/156] (562s left) i915_pm_rps (reset)
[462.250027] Starting subtest: reset
[470.697416] Subtest reset: SUCCESS (8.446s)
[470.815064] [105/156] (553s left) prime_vgem (sync)
[470.875680] Starting subtest: sync
[470.877813] Starting dynamic subtest: rcs0
[470.929171] Dynamic subtest rcs0: SUCCESS (0.053s)
[470.939558] Starting dynamic subtest: bcs0
[470.993426] Dynamic subtest bcs0: SUCCESS (0.063s)
[471.004111] Starting dynamic subtest: vcs0
[471.043122] Dynamic subtest vcs0: SUCCESS (0.049s)
[471.053964] Starting dynamic subtest: vcs1
[471.093031] Dynamic subtest vcs1: SUCCESS (0.049s)
[471.104001] Starting dynamic subtest: vecs0
[471.143216] Dynamic subtest vecs0: SUCCESS (0.049s)
[471.153611] Starting dynamic subtest: ccs0
[471.192260] Dynamic subtest ccs0: SUCCESS (0.048s)
[471.194503] Subtest sync: SUCCESS (0.317s)
[471.312643] [106/156] (553s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[471.422904] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[471.427060] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[471.518950] [107/156] (553s left) gem_mmap_wc (coherency)
[471.567722] Subtest coherency: SKIP (0.000s)
[471.621815] [108/156] (553s left) gem_userptr_blits (stress-purge)
[471.689349] Starting subtest: stress-purge
[477.066331] Subtest stress-purge: SUCCESS (5.378s)
[477.211293] [109/156] (547s left) kms_fb_coherency (memset-crc)
[477.348400] Starting subtest: memset-crc
[477.350147] Starting dynamic subtest: mmap-offset-wc
[477.762939] Dynamic subtest mmap-offset-wc: SUCCESS (0.415s)
[478.063690] Starting dynamic subtest: mmap-offset-uc
[484.268914] Dynamic subtest mmap-offset-uc: SUCCESS (6.216s)
[484.563176] Subtest memset-crc: SUCCESS (7.215s)
[485.411090] [110/156] (539s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[485.502053] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[485.504405] Starting dynamic subtest: pipe-A
[485.849556] Dynamic subtest pipe-A: SUCCESS (0.349s)
[485.862942] Starting dynamic subtest: pipe-B
[487.270940] Dynamic subtest pipe-B: SUCCESS (1.420s)
[487.287519] Starting dynamic subtest: pipe-C
[488.677141] Dynamic subtest pipe-C: SUCCESS (1.404s)
[488.688734] Starting dynamic subtest: pipe-D
[490.062757] Dynamic subtest pipe-D: SUCCESS (1.385s)
[490.065087] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.563s)
[491.216423] [111/156] (533s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[491.344273] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[523.116643] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.768s)
[524.003025] [112/156] (500s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[524.106363] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[524.110410] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[524.203910] [113/156] (500s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[524.264280] Starting subtest: yf-tiled-to-vebox-y-tiled
[524.268946] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[524.447211] [114/156] (500s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[524.537059] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[524.541337] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[524.644165] [115/156] (500s left) kms_hdr (static-toggle)
[524.735919] Starting subtest: static-toggle
[524.738214] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[524.742434] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[524.754462] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[524.758473] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[524.762664] Subtest static-toggle: SKIP (0.003s)
[524.813154] [116/156] (500s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[524.897156] Starting subtest: fbc-psr-cursor-mmap-gtt
[524.899401] Starting dynamic subtest: eDP-1
[524.903410] Dynamic subtest eDP-1: SKIP (0.000s)
[524.907477] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[524.976941] [117/156] (500s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[525.079117] Starting subtest: fbc-rgb565-draw-mmap-cpu
[529.030470] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.956s)
[530.212529] [118/156] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[530.313110] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[530.317345] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[530.420133] [119/156] (494s left) kms_plane_cursor (primary)
[530.502134] Starting subtest: primary
[530.506609] Starting dynamic subtest: pipe-A-eDP-1-size-64
[533.065025] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.565s)
[533.090023] Starting dynamic subtest: pipe-A-eDP-1-size-128
[535.665937] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[535.693134] Starting dynamic subtest: pipe-A-eDP-1-size-256
[538.266844] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[538.582702] Starting dynamic subtest: pipe-B-eDP-1-size-64
[541.873032] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.302s)
[541.900156] Starting dynamic subtest: pipe-B-eDP-1-size-128
[544.441070] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.550s)
[544.468016] Starting dynamic subtest: pipe-B-eDP-1-size-256
[547.019935] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[547.335353] Starting dynamic subtest: pipe-C-eDP-1-size-64
[550.326235] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.004s)
[550.356403] Starting dynamic subtest: pipe-C-eDP-1-size-128
[552.581601] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[552.610960] Starting dynamic subtest: pipe-C-eDP-1-size-256
[554.804052] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[555.126657] Starting dynamic subtest: pipe-D-eDP-1-size-64
[558.098289] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.985s)
[558.127227] Starting dynamic subtest: pipe-D-eDP-1-size-128
[560.365260] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.247s)
[560.394679] Starting dynamic subtest: pipe-D-eDP-1-size-256
[562.598206] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[562.912162] Subtest primary: SUCCESS (32.410s)
[563.721814] [120/156] (461s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[563.832516] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[563.840128] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[563.938201] [121/156] (461s left) i915_drm_fdinfo (context-close-stress)
[563.977071] Starting subtest: context-close-stress
[574.722633] Subtest context-close-stress: SUCCESS (10.744s)
[574.799696] [122/156] (450s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[575.030315] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[575.032632] Starting dynamic subtest: pipe-A-eDP-1
[575.055860] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[575.068467] Starting dynamic subtest: pipe-B-eDP-1
[575.090262] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[575.100647] Starting dynamic subtest: pipe-C-eDP-1
[575.122630] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[575.133282] Starting dynamic subtest: pipe-D-eDP-1
[575.155485] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[575.159590] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[577.302217] [123/156] (447s left) gem_exec_balancer (sequential)
[577.363582] Starting subtest: sequential
[580.441678] Subtest sequential: SUCCESS (3.078s)
[580.784525] [124/156] (444s left) gem_eio (in-flight-immediate)
[581.016931] Starting subtest: in-flight-immediate
[589.167475] Subtest in-flight-immediate: SUCCESS (8.150s)
[589.343968] [125/156] (436s left) syncobj_wait (signal)
[589.404953] Starting subtest: signal
[589.407231] Subtest signal: SUCCESS (0.000s)
[589.480938] [126/156] (435s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[589.576486] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[589.580514] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[589.682783] [127/156] (435s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[589.787097] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[589.791480] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[589.883626] [128/156] (435s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[589.990158] Starting subtest: pr-primary-plane-update-sf-dmg-area
[589.993451] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[590.075199] [129/156] (435s left) gem_pread (snoop)
[590.126706] Subtest snoop: SKIP (0.000s)
[590.184707] [130/156] (435s left) gem_cs_tlb (engines)
[590.246182] Starting subtest: engines
[590.248103] Starting dynamic subtest: rcs0
[592.402726] Dynamic subtest rcs0: SUCCESS (2.153s)
[592.416957] Starting dynamic subtest: bcs0
[594.555294] Dynamic subtest bcs0: SUCCESS (2.152s)
[594.569069] Starting dynamic subtest: vcs0
[596.710134] Dynamic subtest vcs0: SUCCESS (2.154s)
[596.725502] Starting dynamic subtest: vcs1
[598.865428] Dynamic subtest vcs1: SUCCESS (2.153s)
[598.878756] Starting dynamic subtest: vecs0
[601.019093] Dynamic subtest vecs0: SUCCESS (2.152s)
[601.030195] Starting dynamic subtest: ccs0
[603.173717] Dynamic subtest ccs0: SUCCESS (2.153s)
[603.175733] Subtest engines: SUCCESS (12.924s)
[603.294516] [131/156] (422s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[603.399536] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[603.404006] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[603.488114] [132/156] (422s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[603.584339] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[603.586505] Starting dynamic subtest: pipe-A-eDP-1
[603.645390] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[603.659820] Starting dynamic subtest: pipe-B-eDP-1
[603.718053] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[603.730103] Starting dynamic subtest: pipe-C-eDP-1
[603.786940] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[603.798914] Starting dynamic subtest: pipe-D-eDP-1
[603.854684] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[603.859108] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[605.799711] [133/156] (419s left) prime_vgem (fence-write-hang)
[605.858900] Subtest fence-write-hang: SKIP (0.000s)
[605.988216] [134/156] (419s left) i915_query (query-topology-kernel-writes)
[606.038929] Starting subtest: query-topology-kernel-writes
[606.040808] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[606.134380] [135/156] (419s left) kms_pm_dc (dc6-dpms)
[607.243516] Starting subtest: dc6-dpms
[609.340929] Subtest dc6-dpms: SUCCESS (2.097s)
[609.420365] [136/156] (416s left) perf_pmu (busy)
[609.460312] Starting subtest: busy
[609.462841] Starting dynamic subtest: rcs0
[610.047377] Dynamic subtest rcs0: SUCCESS (0.588s)
[610.061749] Starting dynamic subtest: bcs0
[610.606955] Dynamic subtest bcs0: SUCCESS (0.558s)
[610.620446] Starting dynamic subtest: vcs0
[612.306310] Dynamic subtest vcs0: SUCCESS (1.695s)
[612.320229] Starting dynamic subtest: vcs1
[614.289183] Dynamic subtest vcs1: SUCCESS (1.981s)
[614.302601] Starting dynamic subtest: vecs0
[616.273958] Dynamic subtest vecs0: SUCCESS (1.982s)
[616.287869] Starting dynamic subtest: ccs0
[616.843084] Dynamic subtest ccs0: SUCCESS (0.567s)
[616.845828] Subtest busy: SUCCESS (7.385s)
[616.937676] [137/156] (408s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[617.039554] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[617.043942] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[617.144297] [138/156] (408s left) syncobj_wait (invalid-signal-bad-pad)
[617.192713] Starting subtest: invalid-signal-bad-pad
[617.194976] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[617.308579] [139/156] (408s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[617.416094] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[618.074471] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.660s)
[618.235569] [140/156] (407s left) gem_exec_schedule (preempt-user)
[618.311580] Starting subtest: preempt-user
[618.314666] Starting dynamic subtest: rcs0
[618.331646] Dynamic subtest rcs0: SUCCESS (0.025s)
[618.344007] Starting dynamic subtest: bcs0
[618.351456] Dynamic subtest bcs0: SUCCESS (0.019s)
[618.362499] Starting dynamic subtest: vcs0
[618.371609] Dynamic subtest vcs0: SUCCESS (0.019s)
[618.385115] Starting dynamic subtest: vcs1
[618.391030] Dynamic subtest vcs1: SUCCESS (0.019s)
[618.401587] Starting dynamic subtest: vecs0
[618.414664] Dynamic subtest vecs0: SUCCESS (0.023s)
[618.425669] Starting dynamic subtest: ccs0
[618.439755] Dynamic subtest ccs0: SUCCESS (0.025s)
[618.442048] Subtest preempt-user: SUCCESS (0.134s)
[620.399082] [141/156] (405s left) gem_sync (basic-store-all)
[620.472950] Starting subtest: basic-store-all
[623.247688] Subtest basic-store-all: SUCCESS (2.785s)
[623.446903] [142/156] (402s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[623.542755] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[624.588323] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.046s)
[624.746970] [143/156] (401s left) gem_lmem_swapping (parallel-random-verify-ccs)
[624.789843] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[624.835728] [144/156] (401s left) syncobj_eventfd (invalid-illegal-eventfd)
[624.885374] Starting subtest: invalid-illegal-eventfd
[624.887410] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[624.978770] [145/156] (401s left) gem_lmem_evict (dontneed-evict-race)
[625.018267] Subtest dontneed-evict-race: SKIP (0.000s)
[625.064520] [146/156] (401s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[625.160124] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[625.163819] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[625.268056] [147/156] (401s left) kms_async_flips (test-cursor-atomic)
[625.369338] Starting subtest: test-cursor-atomic
[625.753939] Starting dynamic subtest: pipe-A-eDP-1
[626.561136] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s)
[626.937289] Starting dynamic subtest: pipe-B-eDP-1
[627.760049] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.837s)
[628.140949] Starting dynamic subtest: pipe-C-eDP-1
[628.959969] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.828s)
[629.330614] Starting dynamic subtest: pipe-D-eDP-1
[630.153544] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.837s)
[630.155868] Subtest test-cursor-atomic: SUCCESS (4.786s)
[631.400417] [148/156] (394s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[631.510639] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[631.514647] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[631.601445] [149/156] (394s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[631.703080] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[631.707381] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[631.802031] [150/156] (394s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[631.914299] Starting subtest: x-tiled-16bpp-rotate-270
[631.933321] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[632.063263] [151/156] (394s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[632.159112] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[632.163550] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[632.264949] [152/156] (394s left) kms_chamelium_frames (dp-crc-fast)
[632.640270] Subtest dp-crc-fast: SKIP (0.000s)
[633.480095] [153/156] (393s left) core_setmaster (master-drop-set-root)
[633.555440] Starting subtest: master-drop-set-root
[633.580701] Subtest master-drop-set-root: SUCCESS (0.025s)
[633.633322] [154/156] (393s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[633.735029] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[633.737207] Starting dynamic subtest: pipe-A
[633.856754] Dynamic subtest pipe-A: SKIP (0.118s)
[633.868781] Starting dynamic subtest: pipe-B
[635.022845] Dynamic subtest pipe-B: SKIP (1.166s)
[635.035016] Starting dynamic subtest: pipe-C
[636.229198] Dynamic subtest pipe-C: SUCCESS (1.210s)
[636.242958] Starting dynamic subtest: pipe-D
[637.440275] Dynamic subtest pipe-D: SUCCESS (1.211s)
[637.442636] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.708s)
[638.606868] [155/156] (388s left) kms_lease (master-vs-lease)
[638.697950] Starting subtest: master-vs-lease
[638.699780] Subtest master-vs-lease: SUCCESS (0.001s)
[638.802156] [156/156] (387s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[638.894551] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[638.898518] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[638.992305] Closing watchdogs
results: parsing output: 0/ for test: kms_force_connector_basic
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_mmap_wc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: gem_exec_suspend
results: parsing output: 11/ for test: gem_ctx_sseu
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_prop_blob
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_busy
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_nop
results: parsing output: 22/ for test: gem_ppgtt
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gen7_exec_parse
results: parsing output: 25/ for test: gem_spin_batch
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: gem_partial_pwrite_pread
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_chamelium_hpd
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: i915_hangman
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_render_copy_redux
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_mmap
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: kms_cursor_edge_walk
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_barrier_race
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_content_protection
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: gem_mmap_wc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: gem_ctx_param
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_concurrent
results: parsing output: 102/ for test: gem_ctx_exec
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: prime_vgem
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_fb_coherency
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_psr
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_plane_cursor
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: gem_pread
results: parsing output: 129/ for test: gem_cs_tlb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: prime_vgem
results: parsing output: 133/ for test: i915_query
results: parsing output: 134/ for test: kms_pm_dc
results: parsing output: 135/ for test: perf_pmu
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: syncobj_wait
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: gem_exec_schedule
results: parsing output: 140/ for test: gem_sync
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: gem_lmem_swapping
results: parsing output: 143/ for test: syncobj_eventfd
results: parsing output: 144/ for test: gem_lmem_evict
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_async_flips
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_chamelium_frames
results: parsing output: 152/ for test: core_setmaster
results: parsing output: 153/ for test: kms_plane_scaling
results: parsing output: 154/ for test: kms_lease
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.