[61.339553] Initializing watchdogs
[61.339600]   /dev/watchdog0
[61.353903] [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]
[61.357984] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.360141] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.363303] [001/130] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[61.480532] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[61.482979] Starting dynamic subtest: pipe-A-eDP-1
[61.503348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[61.511772] Starting dynamic subtest: pipe-B-eDP-1
[61.530579] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[61.537458] Starting dynamic subtest: pipe-C-eDP-1
[61.556649] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[61.563092] Starting dynamic subtest: pipe-D-eDP-1
[61.582907] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[61.584933] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[63.808222] [002/130] (958s left) gem_fence_thrash (bo-write-verify-x)
[63.846654] Starting subtest: bo-write-verify-x
[63.875109] Subtest bo-write-verify-x: SKIP (0.028s)
[63.940687] [003/130] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[64.043418] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[71.567356] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.541s)
[71.736396] [004/130] (950s left) gem_exec_parallel (contexts)
[71.798157] Starting subtest: contexts
[71.800553] Starting dynamic subtest: rcs0
[74.541681] Dynamic subtest rcs0: SUCCESS (2.745s)
[74.549322] Starting dynamic subtest: bcs0
[77.907404] Dynamic subtest bcs0: SUCCESS (3.366s)
[77.915802] Starting dynamic subtest: vcs0
[82.311737] Dynamic subtest vcs0: SUCCESS (4.403s)
[82.322290] Starting dynamic subtest: vcs1
[86.373260] Dynamic subtest vcs1: SUCCESS (4.061s)
[86.380953] Starting dynamic subtest: vecs0
[90.332387] Dynamic subtest vecs0: SUCCESS (3.957s)
[90.342965] Starting dynamic subtest: ccs0
[94.371069] Dynamic subtest ccs0: SUCCESS (4.036s)
[94.373698] Subtest contexts: SUCCESS (22.575s)
[94.576390] [005/130] (927s left) gem_wait (invalid-buf)
[94.634391] Starting subtest: invalid-buf
[94.636384] Subtest invalid-buf: SUCCESS (0.000s)
[94.860185] [006/130] (927s left) gem_tiled_wb
[94.988813] [007/130] (927s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[95.100507] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[98.767717] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.672s)
[99.950419] [008/130] (922s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[100.065281] Starting subtest: x-tiled-8bpp-rotate-90
[100.087035] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[100.255116] [009/130] (921s left) i915_drm_fdinfo (most-busy-idle-check-all)
[100.294622] Starting subtest: most-busy-idle-check-all
[100.296755] Starting dynamic subtest: rcs0
[100.301150] Dynamic subtest rcs0: SKIP (0.003s)
[100.312068] Starting dynamic subtest: bcs0
[100.316167] Dynamic subtest bcs0: SKIP (0.000s)
[100.323517] Starting dynamic subtest: vcs0
[100.327513] Dynamic subtest vcs0: SKIP (0.000s)
[100.334451] Starting dynamic subtest: vcs1
[100.338352] Dynamic subtest vcs1: SKIP (0.000s)
[100.345278] Starting dynamic subtest: vecs0
[100.349202] Dynamic subtest vecs0: SKIP (0.000s)
[100.357607] Starting dynamic subtest: ccs0
[100.361540] Dynamic subtest ccs0: SKIP (0.000s)
[100.365421] Subtest most-busy-idle-check-all: SKIP (0.006s)
[100.397469] [010/130] (921s left) gem_exec_reloc (basic-wc-noreloc)
[100.497805] Subtest basic-wc-noreloc: SKIP (0.000s)
[100.582898] [011/130] (921s left) gem_mmap_offset (blt-coherency)
[100.638658] Starting subtest: blt-coherency
[100.645903] Subtest blt-coherency: SUCCESS (0.009s)
[100.794193] [012/130] (921s left) kms_dp_aux_dev
[101.161231] [013/130] (921s left) gem_exec_params (cliprects-invalid)
[101.227961] Starting subtest: cliprects-invalid
[101.230295] Subtest cliprects-invalid: SUCCESS (0.000s)
[101.365307] [014/130] (920s left) vgem_basic (mmap)
[101.473875] Starting subtest: mmap
[101.480052] Subtest mmap: SUCCESS (0.008s)
[101.550595] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[101.553596] [015/130] (920s left) kms_getfb (getfb-handle-closed)
[101.649972] Starting subtest: getfb-handle-closed
[101.652288] Subtest getfb-handle-closed: SUCCESS (0.000s)
[101.795330] [016/130] (920s left) kms_cursor_crc (cursor-offscreen-max-size)
[102.090365] Starting subtest: cursor-offscreen-max-size
[102.096062] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[102.278834] [017/130] (920s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[102.405958] Starting subtest: cursorB-vs-flipB-varying-size
[102.409906] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[102.597349] [018/130] (919s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[102.689497] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[102.693218] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[102.827056] [019/130] (919s left) kms_big_fb (linear-8bpp-rotate-270)
[102.940213] Starting subtest: linear-8bpp-rotate-270
[102.967251] Subtest linear-8bpp-rotate-270: SKIP (0.027s)
[103.134236] [020/130] (919s left) kms_dp_linktrain_fallback (dp-fallback)
[103.237022] Starting subtest: dp-fallback
[103.242223] Subtest dp-fallback: SKIP (0.000s)
[103.339557] [021/130] (919s left) core_debugfs (read-all-entries)
[103.398877] Starting subtest: read-all-entries
[103.496569] Subtest read-all-entries: SUCCESS (0.097s)
[103.643419] [022/130] (919s left) gem_ctx_param (invalid-get-engines)
[103.696243] Starting subtest: invalid-get-engines
[103.698367] Subtest invalid-get-engines: SUCCESS (0.001s)
[103.820889] [023/130] (918s left) vgem_basic (setversion)
[103.865607] Starting subtest: setversion
[103.869134] Subtest setversion: SUCCESS (0.000s)
[103.945295] [024/130] (918s left) kms_psr (psr-primary-render)
[104.036159] Starting subtest: psr-primary-render
[104.038074] Starting dynamic subtest: eDP-1
[105.805595] Dynamic subtest eDP-1: SUCCESS (1.770s)
[105.807814] Subtest psr-primary-render: SUCCESS (1.771s)
[106.682860] [025/130] (916s left) kms_getfb (getfb-handle-zero)
[106.787940] Starting subtest: getfb-handle-zero
[106.790246] Subtest getfb-handle-zero: SUCCESS (0.000s)
[106.926185] [026/130] (915s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[107.026452] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[107.028658] Starting dynamic subtest: pipe-A-default-mode
[107.335719] Dynamic subtest pipe-A-default-mode: SKIP (0.307s)
[107.340113] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.308s)
[108.221926] [027/130] (914s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[108.286945] Starting subtest: basic-batch-kernel-default-cmd
[108.291222] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[108.493193] [028/130] (914s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[108.595548] Starting subtest: fbc-farfromfence-mmap-gtt
[108.599888] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[108.732190] [029/130] (914s left) kms_plane_multiple (2x-tiling-4)
[108.834054] Starting subtest: 2x-tiling-4
[108.838459] Subtest 2x-tiling-4: SKIP (0.000s)
[108.923515] [030/130] (914s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[109.030163] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[109.031990] Starting dynamic subtest: pipe-A-eDP-1
[109.198345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.160s)
[109.208329] Starting dynamic subtest: pipe-B-eDP-1
[109.228492] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[109.239561] Starting dynamic subtest: pipe-C-eDP-1
[109.258681] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[109.267083] Starting dynamic subtest: pipe-D-eDP-1
[109.286451] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[109.288682] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.167s)
[111.478114] [031/130] (911s left) gem_eio (in-flight-suspend)
[111.722915] Starting subtest: in-flight-suspend
[158.561561] Subtest in-flight-suspend: SUCCESS (17.385s)
[158.751348] [032/130] (864s left) gen7_exec_parse (bitmasks)
[158.831010] Subtest bitmasks: SKIP (0.000s)
[158.918034] [033/130] (864s left) gem_mmap_gtt (medium-copy-xy)
[158.976917] Subtest medium-copy-XY: SKIP (0.000s)
[159.044097] [034/130] (864s left) kms_chamelium_frames (hdmi-crc-single)
[159.434457] Subtest hdmi-crc-single: SKIP (0.000s)
[160.250090] [035/130] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[160.351013] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[160.355238] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[160.479365] [036/130] (862s left) gem_exec_schedule (timeslicing)
[160.551695] Starting subtest: timeslicing
[160.553585] Starting dynamic subtest: rcs0
[160.564277] Dynamic subtest rcs0: SUCCESS (0.023s)
[160.575522] Starting dynamic subtest: bcs0
[160.586216] Dynamic subtest bcs0: SUCCESS (0.022s)
[160.595418] Starting dynamic subtest: vcs0
[160.605883] Dynamic subtest vcs0: SUCCESS (0.020s)
[160.616008] Starting dynamic subtest: vcs1
[160.627301] Dynamic subtest vcs1: SUCCESS (0.020s)
[160.639570] Starting dynamic subtest: vecs0
[160.646184] Dynamic subtest vecs0: SUCCESS (0.020s)
[160.655982] Starting dynamic subtest: ccs0
[160.667292] Dynamic subtest ccs0: SUCCESS (0.021s)
[160.669421] Subtest timeslicing: SUCCESS (0.129s)
[162.401017] [037/130] (860s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[167.441578] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[167.443880] Starting dynamic subtest: pipe-A-eDP-1
[184.570783] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.196s)
[184.581757] Starting dynamic subtest: pipe-B-eDP-1
[201.690602] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.123s)
[201.692967] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.322s)
[202.517854] [038/130] (820s left) gem_exec_schedule (deep)
[202.708873] Starting subtest: deep
[202.710773] Starting dynamic subtest: rcs0
[208.057902] Dynamic subtest rcs0: SKIP (5.348s)
[208.070801] Starting dynamic subtest: vcs0
[219.067274] Dynamic subtest vcs0: SUCCESS (11.014s)
[219.080058] Starting dynamic subtest: vcs1
[230.576836] Dynamic subtest vcs1: SUCCESS (11.513s)
[230.589959] Starting dynamic subtest: vecs0
[242.355375] Dynamic subtest vecs0: SUCCESS (11.783s)
[242.370053] Starting dynamic subtest: ccs0
[255.215419] Dynamic subtest ccs0: SUCCESS (12.863s)
[255.217852] Subtest deep: SUCCESS (52.525s)
[256.279034] [039/130] (767s left) kms_color (degamma)
[256.385612] Starting subtest: degamma
[256.387784] Starting dynamic subtest: pipe-A-eDP-1
[257.115247] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.729s)
[257.125188] Starting dynamic subtest: pipe-B-eDP-1
[258.593689] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.476s)
[258.603912] Starting dynamic subtest: pipe-C-eDP-1
[259.994014] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.400s)
[260.003282] Starting dynamic subtest: pipe-D-eDP-1
[261.397554] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[261.399917] Subtest degamma: SUCCESS (5.012s)
[262.219975] [040/130] (761s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[262.321605] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[262.326006] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[262.458795] [041/130] (760s left) gem_eio (banned)
[262.673051] Starting subtest: banned
[263.329350] Subtest banned: SUCCESS (0.656s)
[263.511412] [042/130] (759s left) gem_ppgtt (flink-and-close-vma-leak)
[263.569361] Starting subtest: flink-and-close-vma-leak
[263.612300] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[263.778108] [043/130] (759s left) kms_cursor_crc (cursor-sliding-128x42)
[264.024251] Starting subtest: cursor-sliding-128x42
[264.072686] Subtest cursor-sliding-128x42: SKIP (0.043s)
[264.327048] [044/130] (759s left) kms_atomic_transition (modeset-transition-nonblocking)
[264.424137] Starting subtest: modeset-transition-nonblocking
[264.426016] Starting dynamic subtest: 1x-outputs
[275.447275] Dynamic subtest 1x-outputs: SUCCESS (11.020s)
[275.449598] Subtest modeset-transition-nonblocking: SUCCESS (11.021s)
[276.338123] [045/130] (747s left) kms_plane_alpha_blend (alpha-transparent-fb)
[276.444874] Starting subtest: alpha-transparent-fb
[276.744636] Starting dynamic subtest: pipe-A-eDP-1
[277.387980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[277.397364] Starting dynamic subtest: pipe-D-eDP-1
[278.762806] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.372s)
[278.765148] Subtest alpha-transparent-fb: SUCCESS (2.319s)
[279.602040] [046/130] (744s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[279.693090] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[287.099242] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.408s)
[287.246719] [047/130] (736s left) syncobj_wait (wait-all-complex)
[287.304867] Starting subtest: wait-all-complex
[287.517755] Subtest wait-all-complex: SUCCESS (0.212s)
[287.619264] [048/130] (736s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[287.723095] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[294.486249] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.765s)
[294.645355] [049/130] (729s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[294.735986] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[294.740277] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[295.893136] [050/130] (727s left) gem_exec_whisper (basic-fds-priority)
[295.957423] Starting subtest: basic-fds-priority
[320.391622] Subtest basic-fds-priority: SUCCESS (24.432s)
[320.601740] [051/130] (703s left) gem_wait (await)
[320.670449] Starting subtest: await
[320.672879] Starting dynamic subtest: all-engines
[321.842618] Dynamic subtest all-engines: SUCCESS (1.172s)
[321.857048] Starting dynamic subtest: rcs0
[322.915442] Dynamic subtest rcs0: SUCCESS (1.071s)
[322.934187] Starting dynamic subtest: bcs0
[323.980369] Dynamic subtest bcs0: SUCCESS (1.062s)
[323.997351] Starting dynamic subtest: vcs0
[325.034945] Dynamic subtest vcs0: SUCCESS (1.053s)
[325.051533] Starting dynamic subtest: vcs1
[326.087790] Dynamic subtest vcs1: SUCCESS (1.051s)
[326.104529] Starting dynamic subtest: vecs0
[327.140804] Dynamic subtest vecs0: SUCCESS (1.051s)
[327.156996] Starting dynamic subtest: ccs0
[328.198006] Dynamic subtest ccs0: SUCCESS (1.055s)
[328.200555] Subtest await: SUCCESS (7.530s)
[328.426762] [052/130] (695s left) kms_psr (pr-no-drrs)
[328.536054] Starting subtest: pr-no-drrs
[328.539910] Subtest pr-no-drrs: SKIP (0.000s)
[328.634211] [053/130] (695s left) kms_joiner (basic-max-non-joiner)
[328.747178] Starting subtest: basic-max-non-joiner
[328.751606] Subtest basic-max-non-joiner: SKIP (0.000s)
[328.834119] [054/130] (695s left) kms_vblank (query-idle-hang)
[328.922124] Starting subtest: query-idle-hang
[328.924064] Starting dynamic subtest: pipe-A-eDP-1
[355.102464] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.185s)
[355.117215] Starting dynamic subtest: pipe-D-eDP-1
[370.135270] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.037s)
[370.137582] Subtest query-idle-hang: SUCCESS (41.227s)
[371.021773] [055/130] (652s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[371.081355] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[371.083325] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[371.209844] [056/130] (652s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[371.480403] Starting subtest: cursor-rapid-movement-256x85
[371.527801] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[371.741946] [057/130] (652s left) gem_lmem_swapping (verify-ccs)
[371.788382] Subtest verify-ccs: SKIP (0.000s)
[371.833227] [058/130] (652s left) kms_universal_plane (cursor-fb-leak)
[371.930662] Starting subtest: cursor-fb-leak
[371.933024] Starting dynamic subtest: pipe-A-eDP-1
[372.247515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.317s)
[372.259801] Starting dynamic subtest: pipe-B-eDP-1
[373.607176] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.356s)
[373.617208] Starting dynamic subtest: pipe-C-eDP-1
[374.921744] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.314s)
[374.935435] Starting dynamic subtest: pipe-D-eDP-1
[376.858508] Dynamic subtest pipe-D-eDP-1: FAIL (1.354s)
[376.860915] Subtest cursor-fb-leak: FAIL (4.349s)
[377.449782] [059/130] (646s left) kms_getfb (getfb-reject-nv12)
[377.546168] Starting subtest: getfb-reject-nv12
[377.548486] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[377.690893] [060/130] (646s left) kms_lease (atomic-implicit-crtc)
[377.789036] Starting subtest: atomic-implicit-crtc
[377.791561] Starting dynamic subtest: pipe-A-eDP-1
[377.803368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[377.814280] Starting dynamic subtest: pipe-B-eDP-1
[377.825214] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[377.834554] Starting dynamic subtest: pipe-C-eDP-1
[377.844948] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[377.853952] Starting dynamic subtest: pipe-D-eDP-1
[377.864547] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[377.866773] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[377.973236] [061/130] (646s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[378.060006] Starting subtest: flip-vs-dpms-on-nop-interruptible
[378.062299] Starting dynamic subtest: A-eDP1
[379.934958] Dynamic subtest A-eDP1: SUCCESS (1.874s)
[379.948885] Starting dynamic subtest: B-eDP1
[381.756994] Dynamic subtest B-eDP1: SUCCESS (1.821s)
[381.768257] Starting dynamic subtest: C-eDP1
[383.576370] Dynamic subtest C-eDP1: SUCCESS (1.817s)
[383.587418] Starting dynamic subtest: D-eDP1
[385.408469] Dynamic subtest D-eDP1: SUCCESS (1.831s)
[385.414289] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.354s)
[386.627307] [062/130] (637s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[386.722991] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[386.725238] Starting dynamic subtest: pipe-A-eDP-1
[387.469608] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[387.480281] Starting dynamic subtest: pipe-B-eDP-1
[389.250897] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.780s)
[389.259908] Starting dynamic subtest: pipe-C-eDP-1
[391.058410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.805s)
[391.069546] Starting dynamic subtest: pipe-D-eDP-1
[392.891859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.831s)
[392.894013] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.160s)
[394.038726] [063/130] (630s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[394.144461] Starting subtest: fbc-modesetfrombusy
[397.980523] Subtest fbc-modesetfrombusy: SUCCESS (3.838s)
[399.181163] [064/130] (625s left) gem_create (busy-create)
[399.244973] Starting subtest: busy-create
[399.247235] Starting dynamic subtest: smem0
[432.369228] Dynamic subtest smem0: SUCCESS (33.116s)
[432.372183] Subtest busy-create: SUCCESS (33.118s)
[432.583476] [065/130] (591s left) kms_psr (fbc-pr-sprite-render)
[432.675866] Starting subtest: fbc-pr-sprite-render
[432.680001] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[432.774595] [066/130] (591s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[432.877062] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[432.881102] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[433.019941] [067/130] (591s left) gem_ctx_persistence (engines-queued)
[433.076363] Starting subtest: engines-queued
[433.078733] Starting dynamic subtest: rcs0
[433.177876] Dynamic subtest rcs0: SUCCESS (0.101s)
[433.190796] Starting dynamic subtest: bcs0
[433.204594] Dynamic subtest bcs0: SUCCESS (0.025s)
[433.213914] Starting dynamic subtest: vcs0
[434.306463] Dynamic subtest vcs0: SUCCESS (1.098s)
[434.319176] Starting dynamic subtest: vcs1
[436.352243] Dynamic subtest vcs1: SUCCESS (2.042s)
[436.364615] Starting dynamic subtest: vecs0
[438.336181] Dynamic subtest vecs0: SUCCESS (1.981s)
[438.348690] Starting dynamic subtest: ccs0
[438.530006] Dynamic subtest ccs0: SUCCESS (0.192s)
[438.532450] Subtest engines-queued: SUCCESS (5.453s)
[438.688004] [068/130] (585s left) gem_sync (basic-each)
[438.760170] Starting subtest: basic-each
[441.300512] Subtest basic-each: SUCCESS (2.551s)
[441.515078] [069/130] (583s left) gem_render_copy (x-tiled)
[441.573713] Starting subtest: x-tiled
[441.576065] Starting dynamic subtest: smem
[441.622613] Dynamic subtest smem: SUCCESS (0.048s)
[441.624945] Subtest x-tiled: SUCCESS (0.049s)
[441.919627] [070/130] (582s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[441.988961] Starting subtest: yf-tiled-ccs-to-x-tiled
[441.993627] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[442.197186] [071/130] (582s left) kms_flip (basic-flip-vs-wf_vblank)
[442.302735] Starting subtest: basic-flip-vs-wf_vblank
[442.305015] Starting dynamic subtest: A-eDP1
[444.184290] Dynamic subtest A-eDP1: SUCCESS (1.883s)
[444.195923] Starting dynamic subtest: B-eDP1
[446.118709] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[446.133540] Starting dynamic subtest: C-eDP1
[448.044393] Dynamic subtest C-eDP1: SUCCESS (1.923s)
[448.055442] Starting dynamic subtest: D-eDP1
[449.970830] Dynamic subtest D-eDP1: SUCCESS (1.926s)
[449.975980] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.675s)
[451.221358] [072/130] (573s left) gem_exec_reloc (basic-gtt-wc-active)
[451.276221] Subtest basic-gtt-wc-active: SKIP (0.000s)
[451.344150] [073/130] (573s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[451.438122] Starting subtest: async-flip-with-page-flip-events-tiled
[451.816304] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[453.153945] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: FAIL (0.754s)
[453.165355] Starting dynamic subtest: pipe-A-eDP-1-4
[453.537939] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.189s)
[453.549856] Starting dynamic subtest: pipe-A-eDP-1-4
[453.663053] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.008s)
[453.673886] Starting dynamic subtest: pipe-A-eDP-1-x
[453.970327] Dynamic subtest pipe-A-eDP-1-x: FAIL (0.599s)
[454.186737] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[455.593811] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: FAIL (1.192s)
[455.605491] Starting dynamic subtest: pipe-B-eDP-1-4
[455.966912] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.177s)
[455.978656] Starting dynamic subtest: pipe-B-eDP-1-4
[456.089548] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.008s)
[456.100566] Starting dynamic subtest: pipe-B-eDP-1-x
[456.406644] Dynamic subtest pipe-B-eDP-1-x: FAIL (0.624s)
[456.569748] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[459.319044] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.756s)
[459.334762] Starting dynamic subtest: pipe-C-eDP-1-4
[461.493691] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[461.503651] Starting dynamic subtest: pipe-C-eDP-1-4
[463.504392] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[463.517591] Starting dynamic subtest: pipe-C-eDP-1-x
[465.682966] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[466.048718] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[468.839732] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[468.851998] Starting dynamic subtest: pipe-D-eDP-1-4
[471.014799] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[471.027071] Starting dynamic subtest: pipe-D-eDP-1-4
[473.024777] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[473.035318] Starting dynamic subtest: pipe-D-eDP-1-x
[475.203139] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[475.206048] Subtest async-flip-with-page-flip-events-tiled: FAIL (23.768s)
[476.462394] [074/130] (548s left) gem_softpin (allocator-basic-reserve)
[476.532637] Starting subtest: allocator-basic-reserve
[476.599328] Subtest allocator-basic-reserve: SUCCESS (0.066s)
[476.774324] [075/130] (548s left) perf_pmu (pmu-read)
[476.813814] Starting subtest: pmu-read
[476.816203] Subtest pmu-read: SUCCESS (0.003s)
[476.978793] [076/130] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[477.079359] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[477.083792] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[477.221836] [077/130] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[477.329551] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[477.333963] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[477.472209] [078/130] (547s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[477.533594] Starting subtest: single-wait-for-submit-available-submitted
[477.535489] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[477.667241] [079/130] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[477.765590] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[477.768799] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[477.897411] [080/130] (547s left) gem_render_copy (yf-tiled-to-vebox-linear)
[477.952416] Starting subtest: yf-tiled-to-vebox-linear
[477.955895] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[478.170476] [081/130] (546s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[478.734875] Starting subtest: syncobj-stationary-timeline-chain-engines
[478.855547] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.121s)
[480.486679] [082/130] (544s left) kms_psr (fbc-pr-primary-mmap-gtt)
[480.586083] Starting subtest: fbc-pr-primary-mmap-gtt
[480.590408] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[480.687017] [083/130] (544s left) gem_mmap_wc (copy)
[480.751397] Subtest copy: SKIP (0.000s)
[480.818465] [084/130] (544s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[480.906479] Starting subtest: plane-upscale-factor-0-25-with-rotation
[480.908691] Starting dynamic subtest: pipe-A
[481.132426] Dynamic subtest pipe-A: SUCCESS (0.227s)
[481.142244] Starting dynamic subtest: pipe-B
[482.412876] Dynamic subtest pipe-B: SUCCESS (1.278s)
[482.422865] Starting dynamic subtest: pipe-C
[483.742724] Dynamic subtest pipe-C: SUCCESS (1.329s)
[483.757648] Starting dynamic subtest: pipe-D
[485.072633] Dynamic subtest pipe-D: SUCCESS (1.329s)
[485.074880] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.169s)
[486.268548] [085/130] (539s left) gem_exec_schedule (preemptive-hang)
[486.448393] Starting subtest: preemptive-hang
[486.451115] Starting dynamic subtest: rcs0
[495.507298] Dynamic subtest rcs0: SUCCESS (9.057s)
[495.515958] Starting dynamic subtest: bcs0
[504.457292] Dynamic subtest bcs0: SUCCESS (8.952s)
[504.466447] Starting dynamic subtest: vcs0
[513.480993] Dynamic subtest vcs0: SUCCESS (9.023s)
[513.490043] Starting dynamic subtest: vcs1
[522.507848] Dynamic subtest vcs1: SUCCESS (9.024s)
[522.523215] Starting dynamic subtest: vecs0
[531.461014] Dynamic subtest vecs0: SUCCESS (8.953s)
[531.471534] Starting dynamic subtest: ccs0
[540.489700] Dynamic subtest ccs0: SUCCESS (9.029s)
[540.492205] Subtest preemptive-hang: SUCCESS (54.049s)
[540.790265] [086/130] (484s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[540.913815] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[540.916001] Starting dynamic subtest: pipe-A-eDP-1
[540.938165] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[540.949331] Starting dynamic subtest: pipe-B-eDP-1
[540.970806] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[540.980333] Starting dynamic subtest: pipe-C-eDP-1
[541.001885] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[541.010976] Starting dynamic subtest: pipe-D-eDP-1
[541.032594] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[541.036672] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[543.232449] [087/130] (482s left) gem_exec_suspend (basic-s3)
[543.295385] Starting subtest: basic-S3
[543.297390] Starting dynamic subtest: smem
[564.095074] Dynamic subtest smem: SUCCESS (7.051s)
[564.097587] Subtest basic-S3: SUCCESS (7.054s)
[564.299858] [088/130] (461s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[564.416742] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[564.420541] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[564.552322] [089/130] (460s left) gem_huc_copy (huc-copy)
[564.610155] Starting subtest: huc-copy
[564.615833] Subtest huc-copy: SUCCESS (0.003s)
[564.767457] [090/130] (460s left) kms_flip (flip-vs-expired-vblank)
[564.876670] Starting subtest: flip-vs-expired-vblank
[564.878605] Starting dynamic subtest: A-eDP1
[573.577536] Dynamic subtest A-eDP1: SUCCESS (8.815s)
[573.591125] Starting dynamic subtest: B-eDP1
[582.220957] Dynamic subtest B-eDP1: SUCCESS (8.678s)
[582.239276] Starting dynamic subtest: C-eDP1
[590.901894] Dynamic subtest C-eDP1: SUCCESS (8.693s)
[590.912106] Starting dynamic subtest: D-eDP1
[599.536344] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[599.541202] Subtest flip-vs-expired-vblank: SUCCESS (34.835s)
[600.826350] [091/130] (424s left) i915_pm_rc6_residency (rc6-fence)
[600.890084] Starting subtest: rc6-fence
[600.908154] Starting dynamic subtest: gt0
[613.227444] Dynamic subtest gt0: SUCCESS (12.317s)
[613.240336] Starting dynamic subtest: gt1
[628.093718] Dynamic subtest gt1: SUCCESS (14.864s)
[628.096321] Subtest rc6-fence: SUCCESS (27.206s)
[628.197003] [092/130] (397s left) kms_plane (plane-position-hole)
[628.303568] Starting subtest: plane-position-hole
[628.847048] Starting dynamic subtest: pipe-A-plane-1
[630.108512] Dynamic subtest pipe-A-plane-1: SUCCESS (1.263s)
[630.118983] Starting dynamic subtest: pipe-A-plane-2
[631.435342] Dynamic subtest pipe-A-plane-2: SUCCESS (1.326s)
[631.445120] Starting dynamic subtest: pipe-A-plane-3
[632.823743] Dynamic subtest pipe-A-plane-3: SUCCESS (1.387s)
[632.833885] Starting dynamic subtest: pipe-A-plane-4
[634.113936] Dynamic subtest pipe-A-plane-4: SUCCESS (1.289s)
[634.124220] Starting dynamic subtest: pipe-A-plane-5
[634.140382] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[635.350280] Starting dynamic subtest: pipe-B-plane-1
[636.655052] Dynamic subtest pipe-B-plane-1: SUCCESS (1.315s)
[636.666857] Starting dynamic subtest: pipe-B-plane-2
[637.916957] Dynamic subtest pipe-B-plane-2: SUCCESS (1.260s)
[637.927229] Starting dynamic subtest: pipe-B-plane-3
[639.212796] Dynamic subtest pipe-B-plane-3: SUCCESS (1.297s)
[639.222464] Starting dynamic subtest: pipe-B-plane-4
[640.441198] Dynamic subtest pipe-B-plane-4: SUCCESS (1.227s)
[640.452104] Starting dynamic subtest: pipe-B-plane-5
[640.467299] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[640.469542] Subtest plane-position-hole: SUCCESS (12.168s)
[641.272860] [093/130] (384s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[641.372764] Starting subtest: random-ccs-data-yf-tiled-ccs
[641.374932] Starting dynamic subtest: pipe-A-eDP-1
[641.398634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[641.410224] Starting dynamic subtest: pipe-B-eDP-1
[641.432646] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[641.441847] Starting dynamic subtest: pipe-C-eDP-1
[641.464896] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[641.474067] Starting dynamic subtest: pipe-D-eDP-1
[641.497917] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[641.502308] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[643.631902] [094/130] (382s left) i915_hangman (engine-engine-error)
[643.702419] Starting subtest: engine-engine-error
[643.704600] Starting dynamic subtest: rcs0
[645.084823] Dynamic subtest rcs0: SUCCESS (1.382s)
[645.099149] Starting dynamic subtest: bcs0
[647.069165] Dynamic subtest bcs0: SUCCESS (1.982s)
[647.084392] Starting dynamic subtest: vcs0
[649.116298] Dynamic subtest vcs0: SUCCESS (2.045s)
[649.129315] Starting dynamic subtest: vcs1
[651.099380] Dynamic subtest vcs1: SUCCESS (1.981s)
[651.112688] Starting dynamic subtest: vecs0
[653.084372] Dynamic subtest vecs0: SUCCESS (1.983s)
[653.097221] Starting dynamic subtest: ccs0
[655.068890] Dynamic subtest ccs0: SUCCESS (1.982s)
[655.071613] Subtest engine-engine-error: SUCCESS (11.372s)
[655.180614] [095/130] (370s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[655.298901] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[662.817555] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.521s)
[662.988349] [096/130] (362s left) gem_pwrite (basic-exhaustion)
[663.050762] Subtest basic-exhaustion: SKIP (0.000s)
[663.121211] [097/130] (362s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[663.178863] Starting subtest: etime-single-wait-available-unsubmitted
[663.281575] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s)
[663.380623] [098/130] (362s left) kms_prime (basic-crc-vgem)
[663.463115] Starting subtest: basic-crc-vgem
[663.465310] Starting dynamic subtest: second-to-first
[664.466793] Dynamic subtest second-to-first: SUCCESS (1.007s)
[664.468865] Subtest basic-crc-vgem: SUCCESS (1.008s)
[664.584759] [099/130] (361s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[664.722938] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[664.724890] Starting dynamic subtest: pipe-A-default-mode
[665.018515] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[665.022895] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.295s)
[665.877082] [100/130] (360s left) gem_exec_balancer (invalid-bonds)
[665.945625] Starting subtest: invalid-bonds
[665.949895] Subtest invalid-bonds: SKIP (0.000s)
[666.302139] [101/130] (359s left) gem_exec_balancer (sliced)
[666.374388] Starting subtest: sliced
[666.378660] Subtest sliced: SKIP (0.000s)
[666.704964] [102/130] (359s left) gem_exec_parallel (basic)
[666.764016] Starting subtest: basic
[666.766395] Starting dynamic subtest: rcs0
[668.239649] Dynamic subtest rcs0: SUCCESS (1.474s)
[668.252796] Starting dynamic subtest: bcs0
[669.767329] Dynamic subtest bcs0: SUCCESS (1.524s)
[669.783419] Starting dynamic subtest: vcs0
[671.210166] Dynamic subtest vcs0: SUCCESS (1.440s)
[671.226685] Starting dynamic subtest: vcs1
[673.149285] Dynamic subtest vcs1: SUCCESS (1.935s)
[673.161621] Starting dynamic subtest: vecs0
[675.133414] Dynamic subtest vecs0: SUCCESS (1.981s)
[675.145647] Starting dynamic subtest: ccs0
[676.647290] Dynamic subtest ccs0: SUCCESS (1.512s)
[676.649735] Subtest basic: SUCCESS (9.880s)
[676.858211] [103/130] (349s left) prime_busy (after)
[676.924995] Starting subtest: after
[676.927234] Starting dynamic subtest: rcs0
[676.976356] Dynamic subtest rcs0: SUCCESS (0.050s)
[676.988239] Starting dynamic subtest: bcs0
[677.054888] Dynamic subtest bcs0: SUCCESS (0.078s)
[677.065175] Starting dynamic subtest: vcs0
[677.094592] Dynamic subtest vcs0: SUCCESS (0.038s)
[677.104092] Starting dynamic subtest: vcs1
[677.133920] Dynamic subtest vcs1: SUCCESS (0.039s)
[677.143516] Starting dynamic subtest: vecs0
[677.175670] Dynamic subtest vecs0: SUCCESS (0.041s)
[677.185240] Starting dynamic subtest: ccs0
[677.217641] Dynamic subtest ccs0: SUCCESS (0.041s)
[677.325786] Subtest after: SUCCESS (0.403s)
[677.426938] [104/130] (348s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[677.534858] Starting subtest: y-tiled-64bpp-rotate-0
[677.538954] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[677.673058] [105/130] (348s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[677.767593] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[677.771519] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[677.901742] [106/130] (348s left) gem_mmap_wc (read-write-distinct)
[677.964409] Subtest read-write-distinct: SKIP (0.000s)
[678.035565] [107/130] (348s left) gem_ctx_sseu (engines)
[678.090468] Subtest engines: SKIP (0.000s)
[678.169187] [108/130] (348s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[678.223968] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[678.330273] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[678.426493] [109/130] (347s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[678.544802] Starting subtest: basic-flip-before-cursor-atomic
[679.459984] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.913s)
[680.298060] [110/130] (346s left) syncobj_wait (single-wait-all-signaled)
[680.357218] Starting subtest: single-wait-all-signaled
[680.359393] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[680.492465] [111/130] (345s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[680.587089] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[681.221881] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[681.427193] [112/130] (345s left) perf (gen12-unprivileged-single-ctx-counters)
[681.561869] Starting subtest: gen12-unprivileged-single-ctx-counters
[681.564124] Starting dynamic subtest: rcs0
[681.644536] Dynamic subtest rcs0: SUCCESS (0.083s)
[681.646918] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.085s)
[681.695668] [113/130] (344s left) kms_psr (psr-cursor-blt)
[681.847463] Starting subtest: psr-cursor-blt
[681.849962] Starting dynamic subtest: eDP-1
[683.549714] Dynamic subtest eDP-1: SUCCESS (1.700s)
[683.552054] Subtest psr-cursor-blt: SUCCESS (1.701s)
[684.435683] [114/130] (342s left) gem_ccs (ctrl-surf-copy)
[684.490273] Starting subtest: ctrl-surf-copy
[684.494661] Subtest ctrl-surf-copy: SKIP (0.000s)
[684.619785] [115/130] (341s left) kms_flip (2x-absolute-wf_vblank)
[684.720060] Starting subtest: 2x-absolute-wf_vblank
[684.728920] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[684.838717] [116/130] (341s left) kms_pm_dc (dc3co-vpb-simulation)
[685.975106] Starting subtest: dc3co-vpb-simulation
[694.888185] Subtest dc3co-vpb-simulation: SKIP (8.909s)
[695.047580] [117/130] (331s left) i915_query (test-query-geometry-subslices)
[695.092525] Starting subtest: test-query-geometry-subslices
[695.094646] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[695.223920] [118/130] (331s left) kms_psr (fbc-psr-sprite-render)
[695.304407] Starting subtest: fbc-psr-sprite-render
[695.306637] Starting dynamic subtest: eDP-1
[695.310793] Dynamic subtest eDP-1: SKIP (0.000s)
[695.315012] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[695.400291] [119/130] (331s left) gem_userptr_blits (sync-overlap)
[695.463477] Starting subtest: sync-overlap
[695.465398] Subtest sync-overlap: SUCCESS (0.000s)
[695.619036] [120/130] (331s left) prime_vgem (fence-read-hang)
[695.696405] Subtest fence-read-hang: SKIP (0.000s)
[695.834064] [121/130] (331s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[695.899991] Starting subtest: invalid-single-wait-all-unsubmitted
[695.901961] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[696.020339] [122/130] (330s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[696.113539] Starting subtest: yf-tiled-64bpp-rotate-270
[696.117220] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[696.244764] [123/130] (330s left) core_setmaster (master-drop-set-shared-fd)
[696.341769] Starting subtest: master-drop-set-shared-fd
[696.360524] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[696.398549] [124/130] (330s left) gem_ctx_create (basic-files)
[696.463391] Starting subtest: basic-files
[698.470940] Subtest basic-files: SUCCESS (2.007s)
[700.246604] [125/130] (326s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[700.313064] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[700.377693] [126/130] (326s left) kms_color (ctm-blue-to-red)
[700.475206] Starting subtest: ctm-blue-to-red
[700.477464] Starting dynamic subtest: pipe-A-eDP-1
[701.180349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[701.190541] Starting dynamic subtest: pipe-B-eDP-1
[702.596238] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.415s)
[702.607106] Starting dynamic subtest: pipe-C-eDP-1
[703.889689] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s)
[703.905834] Starting dynamic subtest: pipe-D-eDP-1
[705.242135] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[705.244447] Subtest ctm-blue-to-red: SUCCESS (4.766s)
[706.074928] [127/130] (321s left) gem_eio (in-flight-external)
[706.322546] Starting subtest: in-flight-external
[708.230816] Subtest in-flight-external: SUCCESS (1.906s)
[708.371301] [128/130] (318s left) kms_frontbuffer_tracking (fbc-2p-rte)
[708.479068] Starting subtest: fbc-2p-rte
[708.483292] Subtest fbc-2p-rte: SKIP (0.000s)
[708.597951] [129/130] (318s left) syncobj_wait (wait-all-for-submit-complex)
[708.657975] Starting subtest: wait-all-for-submit-complex
[708.870683] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[708.976355] [130/130] (318s left) kms_properties (colorop-properties-atomic)
[709.062754] Starting subtest: colorop-properties-atomic
[709.064631] Starting dynamic subtest: pipe-A-eDP-1
[709.420632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[709.431501] Starting dynamic subtest: pipe-B-eDP-1
[710.519842] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.097s)
[710.530949] Starting dynamic subtest: pipe-C-eDP-1
[711.555896] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.035s)
[711.566712] Starting dynamic subtest: pipe-D-eDP-1
[712.590687] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.034s)
[712.592947] Subtest colorop-properties-atomic: SUCCESS (3.530s)
[713.403705] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_fence_thrash
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_parallel
results: parsing output: 4/ for test: gem_wait
results: parsing output: 5/ for test: gem_tiled_wb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_dp_aux_dev
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_dp_linktrain_fallback
results: parsing output: 20/ for test: core_debugfs
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_exec_flush
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: gen7_exec_parse
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: gem_ppgtt
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_wait
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_joiner
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_universal_plane
results: parsing output: 58/ for test: kms_getfb
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_create
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: gem_sync
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_exec_suspend
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_huc_copy
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: i915_pm_rc6_residency
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: i915_hangman
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_pwrite
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_prime
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: gem_exec_parallel
results: parsing output: 102/ for test: prime_busy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: gem_ctx_sseu
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_ccs
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_pm_dc
results: parsing output: 116/ for test: i915_query
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: core_setmaster
results: parsing output: 123/ for test: gem_ctx_create
results: parsing output: 124/ for test: kms_pipe_b_c_ivb
results: parsing output: 125/ for test: kms_color
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_properties
Done.