[56.770046] Initializing watchdogs
[56.770089]   /dev/watchdog0
[56.783136] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.787242] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.789318] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.792553] [001/131] (960s left) kms_content_protection (type1)
[56.972923] Starting subtest: type1
[56.977198] Subtest type1: SKIP (0.000s)
[57.126583] [002/131] (960s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[57.230459] Starting subtest: basic-modeset-with-all-modifiers-formats
[57.608195] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[58.345571] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.745s)
[58.354108] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[58.366729] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[58.373338] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[58.388935] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[58.399261] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[58.542689] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[58.554794] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[58.565078] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[58.571853] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[58.586755] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[58.593690] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[58.609167] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[58.615757] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[58.631224] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[58.640987] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[58.653409] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[58.662913] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[58.675287] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[58.684371] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[58.697346] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[58.704082] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[58.719240] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[58.726379] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[58.873489] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[58.880318] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[58.895412] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[58.901987] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[58.917796] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[58.924580] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[58.939710] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[58.946322] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[58.961671] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[58.968432] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[58.983648] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[58.990317] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[59.005668] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[59.012312] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[59.027609] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[59.034850] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[59.049764] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[59.058622] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[59.204339] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[59.211460] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[59.226392] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[59.233453] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[59.248388] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[59.255290] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[59.270019] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[59.276819] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[59.292265] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[59.300631] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[59.314047] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[59.323175] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[59.336053] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[59.342736] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[59.358148] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[59.366495] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[59.380642] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[59.781603] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.577s)
[60.632295] [003/131] (956s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[60.728424] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[60.730764] Starting dynamic subtest: pipe-A-eDP-1
[60.754031] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.763607] Starting dynamic subtest: pipe-B-eDP-1
[60.785223] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.792512] Starting dynamic subtest: pipe-C-eDP-1
[60.814119] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.822782] Starting dynamic subtest: pipe-D-eDP-1
[60.848165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.852850] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.003s)
[62.966145] [004/131] (954s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[63.036331] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[63.094991] [005/131] (954s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[63.204879] Starting subtest: 4-tiled-16bpp-rotate-0
[64.565624] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.367s)
[64.722513] [006/131] (952s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[64.819832] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[72.031992] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.232s)
[72.191786] [007/131] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[72.307694] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[79.231739] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.931s)
[79.386228] [008/131] (938s left) gem_mmap_gtt (basic-write-read-distinct)
[79.446348] Subtest basic-write-read-distinct: SKIP (0.000s)
[79.518257] [009/131] (938s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[79.615310] Starting subtest: yf-tiled-16bpp-rotate-90
[79.619447] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[79.732961] [010/131] (937s left) prime_vgem (shrink)
[79.878311] Starting subtest: shrink
[79.893883] Subtest shrink: SUCCESS (0.014s)
[80.024296] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[80.027230] [011/131] (937s left) kms_hdr (bpc-switch-suspend)
[80.115850] Starting subtest: bpc-switch-suspend
[81.157736] Starting dynamic subtest: pipe-A-eDP-1
[101.077963] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.991s)
[101.080808] Subtest bpc-switch-suspend: SUCCESS (10.032s)
[101.208816] [012/131] (916s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[101.335823] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[101.338184] Starting dynamic subtest: pipe-A-default-mode
[101.628132] Dynamic subtest pipe-A-default-mode: SKIP (0.301s)
[101.633864] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.302s)
[102.442950] [013/131] (915s left) gem_ringfill (legacy-basic)
[107.878860] Starting subtest: legacy-basic
[107.881814] Starting dynamic subtest: default
[107.949480] Dynamic subtest default: SUCCESS (0.073s)
[107.961232] Starting dynamic subtest: render
[107.992630] Dynamic subtest render: SUCCESS (0.042s)
[108.002888] Starting dynamic subtest: bsd
[108.034047] Dynamic subtest bsd: SUCCESS (0.041s)
[108.043846] Starting dynamic subtest: bsd1
[108.074200] Dynamic subtest bsd1: SUCCESS (0.039s)
[108.083719] Starting dynamic subtest: bsd2
[108.118188] Dynamic subtest bsd2: SUCCESS (0.043s)
[108.128401] Starting dynamic subtest: blt
[108.163970] Dynamic subtest blt: SUCCESS (0.045s)
[108.174360] Starting dynamic subtest: vebox
[108.208201] Dynamic subtest vebox: SUCCESS (0.043s)
[108.210934] Subtest legacy-basic: SUCCESS (0.338s)
[108.307483] [014/131] (909s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[108.411372] Starting subtest: fbcpsr-tiling-4
[115.463188] Subtest fbcpsr-tiling-4: SUCCESS (7.134s)
[115.606332] [015/131] (902s left) kms_scaling_modes (scaling-mode-full)
[115.700955] Starting subtest: scaling-mode-full
[115.703753] Starting dynamic subtest: pipe-A-eDP-1
[115.818997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.117s)
[115.829435] Starting dynamic subtest: pipe-B-eDP-1
[116.955199] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s)
[116.965495] Starting dynamic subtest: pipe-C-eDP-1
[118.154051] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.204s)
[118.163682] Starting dynamic subtest: pipe-D-eDP-1
[119.281994] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[119.284905] Subtest scaling-mode-full: SUCCESS (3.601s)
[120.455516] [016/131] (897s left) vgem_basic (bad-pad)
[120.511966] Starting subtest: bad-pad
[120.514716] Subtest bad-pad: SUCCESS (0.000s)
[120.588265] [017/131] (897s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[120.697602] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[120.700167] Starting dynamic subtest: pipe-A-eDP-1
[120.724210] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[120.734259] Starting dynamic subtest: pipe-B-eDP-1
[120.756961] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[120.764942] Starting dynamic subtest: pipe-C-eDP-1
[120.787647] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[120.795500] Starting dynamic subtest: pipe-D-eDP-1
[120.818719] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[120.820940] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[122.941003] [018/131] (895s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[123.007184] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[123.010189] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[123.129582] [019/131] (894s left) kms_psr (fbc-psr2-basic)
[123.234021] Starting subtest: fbc-psr2-basic
[123.236839] Starting dynamic subtest: eDP-1
[123.241826] Dynamic subtest eDP-1: SKIP (0.000s)
[123.246780] Subtest fbc-psr2-basic: SKIP (0.001s)
[123.325755] [020/131] (894s left) core_auth (getclient-simple)
[123.359961] Starting subtest: getclient-simple
[123.382288] Subtest getclient-simple: SUCCESS (0.022s)
[123.519965] [021/131] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[123.624101] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[123.629498] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[123.756271] [022/131] (894s left) drm_read (short-buffer-wakeup)
[123.905140] Starting subtest: short-buffer-wakeup
[156.116233] Subtest short-buffer-wakeup: SUCCESS (32.220s)
[156.289942] [023/131] (861s left) perf_pmu (init-wait)
[156.328932] Starting subtest: init-wait
[156.331632] Starting dynamic subtest: rcs0
[156.334074] Dynamic subtest rcs0: SUCCESS (0.002s)
[156.347962] Starting dynamic subtest: bcs0
[156.350218] Dynamic subtest bcs0: SUCCESS (0.001s)
[156.357792] Starting dynamic subtest: vcs0
[156.360138] Dynamic subtest vcs0: SUCCESS (0.001s)
[156.368385] Starting dynamic subtest: vcs1
[156.370745] Dynamic subtest vcs1: SUCCESS (0.001s)
[156.379031] Starting dynamic subtest: vecs0
[156.381370] Dynamic subtest vecs0: SUCCESS (0.001s)
[156.399147] Starting dynamic subtest: ccs0
[156.402113] Dynamic subtest ccs0: SUCCESS (0.000s)
[156.405045] Subtest init-wait: SUCCESS (0.007s)
[156.456943] [024/131] (861s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[156.517110] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[156.519651] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[156.635010] [025/131] (861s left) kms_plane_alpha_blend (constant-alpha-max)
[156.722894] Starting subtest: constant-alpha-max
[157.008783] Starting dynamic subtest: pipe-A-eDP-1
[157.894720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.886s)
[157.905198] Starting dynamic subtest: pipe-D-eDP-1
[159.518196] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.623s)
[159.521232] Subtest constant-alpha-max: SUCCESS (2.796s)
[160.370605] [026/131] (857s left) kms_psr (fbc-pr-primary-mmap-gtt)
[160.466245] Starting subtest: fbc-pr-primary-mmap-gtt
[160.471920] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[160.561480] [027/131] (857s left) kms_flip (bo-too-big-interruptible)
[160.662951] Starting subtest: bo-too-big-interruptible
[160.665603] Starting dynamic subtest: A-eDP1
[161.991218] Dynamic subtest A-eDP1: SUCCESS (1.328s)
[161.999876] Starting dynamic subtest: B-eDP1
[163.246778] Dynamic subtest B-eDP1: SUCCESS (1.254s)
[163.257901] Starting dynamic subtest: C-eDP1
[164.493577] Dynamic subtest C-eDP1: SUCCESS (1.246s)
[164.508226] Starting dynamic subtest: D-eDP1
[165.834245] Dynamic subtest D-eDP1: SUCCESS (1.339s)
[165.837181] Subtest bo-too-big-interruptible: SUCCESS (5.176s)
[167.057983] [028/131] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[167.166021] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[167.171192] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[167.297071] [029/131] (851s left) kms_cdclk (mode-transition-all-outputs)
[167.399952] Starting subtest: mode-transition-all-outputs
[167.687809] Subtest mode-transition-all-outputs: SKIP (0.288s)
[168.506574] [030/131] (849s left) gem_exec_schedule (fairslice-all)
[168.586945] Starting subtest: fairslice-all
[170.638969] Subtest fairslice-all: SUCCESS (2.061s)
[171.935442] [031/131] (846s left) kms_lease (invalid-create-leases)
[172.036784] Starting subtest: invalid-create-leases
[172.042104] Subtest invalid-create-leases: SUCCESS (0.006s)
[172.185412] [032/131] (846s left) gem_eio (in-flight-1us)
[172.423771] Starting subtest: in-flight-1us
[180.883247] Subtest in-flight-1us: SUCCESS (8.459s)
[181.086514] [033/131] (837s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[181.215707] Starting subtest: cursorB-vs-flipB-atomic
[181.220998] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[181.384194] [034/131] (837s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[181.483578] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[181.486273] Starting dynamic subtest: pipe-A-eDP-1
[181.514957] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[181.524058] Starting dynamic subtest: pipe-B-eDP-1
[181.553098] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[181.562205] Starting dynamic subtest: pipe-C-eDP-1
[181.591221] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[181.599878] Starting dynamic subtest: pipe-D-eDP-1
[181.624574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[181.629112] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[183.674721] [035/131] (835s left) gem_userptr_blits (huge-split)
[183.755250] Starting subtest: huge-split
[183.763098] Subtest huge-split: SUCCESS (0.008s)
[183.923454] [036/131] (834s left) kms_cursor_edge_walk (64x64-right-edge)
[184.029003] Starting subtest: 64x64-right-edge
[184.031949] Starting dynamic subtest: pipe-A-eDP-1
[187.519730] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.493s)
[187.530866] Starting dynamic subtest: pipe-D-eDP-1
[190.632412] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[190.635124] Subtest 64x64-right-edge: SUCCESS (6.606s)
[191.464485] [037/131] (827s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[196.523959] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[196.526803] Starting dynamic subtest: pipe-A-eDP-1
[213.726878] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.193s)
[213.737007] Starting dynamic subtest: pipe-B-eDP-1
[230.943505] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.213s)
[230.946194] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.410s)
[231.845878] [038/131] (786s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[231.945826] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[231.956570] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[232.056014] [039/131] (786s left) prime_self_import (basic-with_fd_dup)
[232.092772] Starting subtest: basic-with_fd_dup
[232.120884] Subtest basic-with_fd_dup: SUCCESS (0.025s)
[232.249704] [040/131] (786s left) syncobj_wait (invalid-signal-bad-pad)
[232.306207] Starting subtest: invalid-signal-bad-pad
[232.308795] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[232.431129] [041/131] (786s left) gem_ctx_shared (exec-single-timeline)
[232.492104] Starting subtest: exec-single-timeline
[232.494941] Starting dynamic subtest: rcs0
[233.535680] Dynamic subtest rcs0: SUCCESS (1.042s)
[233.547866] Starting dynamic subtest: bcs0
[234.623659] Dynamic subtest bcs0: SUCCESS (1.085s)
[234.637031] Starting dynamic subtest: vcs0
[235.713699] Dynamic subtest vcs0: SUCCESS (1.087s)
[235.726232] Starting dynamic subtest: vcs1
[236.801985] Dynamic subtest vcs1: SUCCESS (1.086s)
[236.814673] Starting dynamic subtest: vecs0
[237.892187] Dynamic subtest vecs0: SUCCESS (1.087s)
[237.904030] Starting dynamic subtest: ccs0
[238.975774] Dynamic subtest ccs0: SUCCESS (1.081s)
[238.978647] Subtest exec-single-timeline: SUCCESS (6.485s)
[239.966986] [042/131] (779s left) gem_tiled_fence_blits (basic)
[240.027997] Subtest basic: SKIP (0.000s)
[240.100205] [043/131] (778s left) kms_plane_scaling (planes-scaler-unity-scaling)
[240.193735] Starting subtest: planes-scaler-unity-scaling
[240.196180] Starting dynamic subtest: pipe-A
[240.256076] Dynamic subtest pipe-A: SUCCESS (0.064s)
[240.266087] Starting dynamic subtest: pipe-B
[241.442213] Dynamic subtest pipe-B: SUCCESS (1.185s)
[241.453189] Starting dynamic subtest: pipe-C
[242.559862] Dynamic subtest pipe-C: SUCCESS (1.115s)
[242.569247] Starting dynamic subtest: pipe-D
[243.696786] Dynamic subtest pipe-D: SUCCESS (1.136s)
[243.699468] Subtest planes-scaler-unity-scaling: SUCCESS (3.506s)
[244.886597] [044/131] (774s left) kms_big_fb (yf-tiled-addfb)
[244.995066] Starting subtest: yf-tiled-addfb
[245.000192] Subtest yf-tiled-addfb: SKIP (0.000s)
[245.129855] [045/131] (773s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[245.512583] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[246.376301] [046/131] (772s left) gem_create (create-size-update)
[246.434137] Starting subtest: create-size-update
[246.436992] Subtest create-size-update: SUCCESS (0.000s)
[246.675444] [047/131] (772s left) syncobj_timeline (invalid-transfer-non-existent-point)
[246.739499] Starting subtest: invalid-transfer-non-existent-point
[246.742167] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[246.874244] [048/131] (772s left) syncobj_wait (invalid-reset-one-illegal-handle)
[246.939988] Starting subtest: invalid-reset-one-illegal-handle
[246.942883] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[247.083597] [049/131] (772s left) gem_exec_fence (syncobj-import)
[247.506307] Starting subtest: syncobj-import
[247.511947] Subtest syncobj-import: SUCCESS (0.005s)
[248.950474] [050/131] (770s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[249.054017] Starting subtest: y-tiled-64bpp-rotate-90
[249.060273] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[249.194080] [051/131] (770s left) sw_sync (timeline_closed_signaled)
[249.232513] Starting subtest: timeline_closed_signaled
[249.234661] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[249.313722] [052/131] (770s left) kms_pm_rpm (legacy-planes-dpms)
[251.042835] Starting subtest: legacy-planes-dpms
[251.046020] Starting dynamic subtest: plane-63
[259.344395] Dynamic subtest plane-63: SUCCESS (8.306s)
[259.359191] Starting dynamic subtest: plane-93
[267.650648] Dynamic subtest plane-93: SUCCESS (8.304s)
[267.661879] Starting dynamic subtest: plane-123
[275.946524] Dynamic subtest plane-123: SUCCESS (8.295s)
[275.958108] Starting dynamic subtest: plane-133
[284.278994] Dynamic subtest plane-133: SUCCESS (8.331s)
[284.282183] Subtest legacy-planes-dpms: SUCCESS (33.249s)
[284.694538] [053/131] (734s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[284.817468] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[284.822409] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[284.986770] [054/131] (734s left) gem_exec_schedule (in-order)
[285.062351] Starting subtest: in-order
[285.064257] Starting dynamic subtest: rcs0
[285.162439] Dynamic subtest rcs0: SUCCESS (0.109s)
[285.172685] Starting dynamic subtest: vcs0
[285.248780] Dynamic subtest vcs0: SUCCESS (0.086s)
[285.258359] Starting dynamic subtest: vcs1
[285.341460] Dynamic subtest vcs1: SUCCESS (0.092s)
[285.350980] Starting dynamic subtest: vecs0
[285.423613] Dynamic subtest vecs0: SUCCESS (0.081s)
[285.433640] Starting dynamic subtest: ccs0
[285.542234] Dynamic subtest ccs0: SUCCESS (0.118s)
[285.545084] Subtest in-order: SUCCESS (0.490s)
[287.014487] [055/131] (732s left) kms_vblank (wait-forked-busy-hang)
[287.115956] Starting subtest: wait-forked-busy-hang
[287.118775] Starting dynamic subtest: pipe-A-eDP-1
[313.709937] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.600s)
[313.725545] Starting dynamic subtest: pipe-D-eDP-1
[338.594550] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.878s)
[338.597225] Subtest wait-forked-busy-hang: SUCCESS (51.484s)
[339.419438] [056/131] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[339.514731] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[339.519693] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[339.659655] [057/131] (679s left) gem_ctx_persistence (legacy-engines-queued)
[339.736663] Starting subtest: legacy-engines-queued
[339.739387] Starting dynamic subtest: render
[339.851211] Dynamic subtest render: SUCCESS (0.114s)
[339.863459] Starting dynamic subtest: bsd1
[341.828199] Dynamic subtest bsd1: SUCCESS (1.972s)
[341.840365] Starting dynamic subtest: bsd2
[343.809616] Dynamic subtest bsd2: SUCCESS (1.977s)
[343.821985] Starting dynamic subtest: blt
[343.874756] Dynamic subtest blt: SUCCESS (0.060s)
[343.883893] Starting dynamic subtest: vebox
[345.857834] Dynamic subtest vebox: SUCCESS (1.982s)
[345.860987] Subtest legacy-engines-queued: SUCCESS (6.120s)
[345.966168] [058/131] (673s left) kms_prop_blob (basic)
[346.028221] Starting subtest: basic
[346.031107] Subtest basic: SUCCESS (0.000s)
[346.162404] [059/131] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[346.278900] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[346.283826] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[346.391571] [060/131] (673s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[346.488466] Starting subtest: psr-rgb565-draw-render
[353.511936] Subtest psr-rgb565-draw-render: SUCCESS (7.026s)
[353.695535] [061/131] (666s left) gen9_exec_parse (bb-oversize)
[353.764186] Subtest bb-oversize: SKIP (0.000s)
[353.846172] [062/131] (665s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[353.952894] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[353.957880] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[354.085664] [063/131] (665s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[354.189217] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[354.200829] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[354.303299] [064/131] (665s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[354.408195] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[354.413039] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[354.522206] [065/131] (665s left) gem_exec_whisper (basic-sync)
[354.586660] Starting subtest: basic-sync
[365.382748] Subtest basic-sync: SUCCESS (10.790s)
[365.591356] [066/131] (654s left) kms_flip (2x-flip-vs-wf_vblank)
[365.702849] Starting subtest: 2x-flip-vs-wf_vblank
[365.711023] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[365.815396] [067/131] (654s left) kms_psr (fbc-psr-basic)
[365.929208] Starting subtest: fbc-psr-basic
[365.931987] Starting dynamic subtest: eDP-1
[365.937295] Dynamic subtest eDP-1: SKIP (0.000s)
[365.942328] Subtest fbc-psr-basic: SKIP (0.001s)
[366.035069] [068/131] (654s left) i915_hangman (engine-engine-error)
[366.113147] Starting subtest: engine-engine-error
[366.115976] Starting dynamic subtest: rcs0
[367.811324] Dynamic subtest rcs0: SUCCESS (1.699s)
[367.824831] Starting dynamic subtest: bcs0
[369.859731] Dynamic subtest bcs0: SUCCESS (2.045s)
[369.873068] Starting dynamic subtest: vcs0
[371.777245] Dynamic subtest vcs0: SUCCESS (1.916s)
[371.793657] Starting dynamic subtest: vcs1
[372.864226] Dynamic subtest vcs1: SUCCESS (1.084s)
[372.877894] Starting dynamic subtest: vecs0
[374.849594] Dynamic subtest vecs0: SUCCESS (1.982s)
[374.865180] Starting dynamic subtest: ccs0
[376.833185] Dynamic subtest ccs0: SUCCESS (1.981s)
[376.836132] Subtest engine-engine-error: SUCCESS (10.723s)
[376.941043] [069/131] (643s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[377.329782] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[378.147515] [070/131] (642s left) gem_workarounds (reset)
[378.211502] Starting subtest: reset
[378.353191] Subtest reset: SUCCESS (0.140s)
[378.507196] [071/131] (641s left) i915_pm_rpm (debugfs-forcewake-user)
[380.029848] Starting subtest: debugfs-forcewake-user
[391.409117] Subtest debugfs-forcewake-user: SUCCESS (11.382s)
[391.815577] [072/131] (628s left) gem_pxp (create-protected-buffer)
[391.948217] Starting subtest: create-protected-buffer
[391.951210] Subtest create-protected-buffer: SUCCESS (0.000s)
[392.078432] [073/131] (628s left) gem_exec_parallel (fds)
[392.151128] Starting subtest: fds
[392.154017] Starting dynamic subtest: rcs0
[395.986903] Dynamic subtest rcs0: SUCCESS (3.834s)
[395.998680] Starting dynamic subtest: bcs0
[401.061535] Dynamic subtest bcs0: SUCCESS (5.075s)
[401.073438] Starting dynamic subtest: vcs0
[406.975649] Dynamic subtest vcs0: SUCCESS (5.911s)
[406.986069] Starting dynamic subtest: vcs1
[412.900782] Dynamic subtest vcs1: SUCCESS (5.922s)
[412.910860] Starting dynamic subtest: vecs0
[418.920842] Dynamic subtest vecs0: SUCCESS (6.018s)
[418.933220] Starting dynamic subtest: ccs0
[424.503545] Dynamic subtest ccs0: SUCCESS (5.580s)
[424.506617] Subtest fds: SUCCESS (32.353s)
[424.726694] [074/131] (595s left) gem_exec_whisper (basic-contexts-all)
[424.801213] Starting subtest: basic-contexts-all
[436.373212] Subtest basic-contexts-all: SUCCESS (11.571s)
[436.582116] [075/131] (583s left) kms_cursor_crc (cursor-random-64x21)
[436.790982] Starting subtest: cursor-random-64x21
[436.838001] Subtest cursor-random-64x21: SKIP (0.040s)
[437.127369] [076/131] (583s left) gem_mmap_offset (open-flood)
[437.190637] Starting subtest: open-flood
[458.673622] Subtest open-flood: SUCCESS (21.488s)
[458.818844] [077/131] (561s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[458.925669] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[459.959485] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.033s)
[460.119934] [078/131] (560s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[460.193232] Subtest tiled-to-tiled: SKIP (0.000s)
[460.277361] [079/131] (560s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[460.380621] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[467.795190] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.417s)
[467.947147] [080/131] (552s left) gem_exec_capture (capture)
[468.016966] Starting subtest: capture
[468.019602] Starting dynamic subtest: rcs0-smem
[468.845133] Dynamic subtest rcs0-smem: SUCCESS (0.827s)
[468.856193] Starting dynamic subtest: bcs0-smem
[469.664873] Dynamic subtest bcs0-smem: SUCCESS (0.819s)
[469.675658] Starting dynamic subtest: vcs0-smem
[470.492441] Dynamic subtest vcs0-smem: SUCCESS (0.826s)
[470.503562] Starting dynamic subtest: vcs1-smem
[471.817722] Dynamic subtest vcs1-smem: SUCCESS (1.324s)
[471.828447] Starting dynamic subtest: vecs0-smem
[472.713053] Dynamic subtest vecs0-smem: FAIL (0.838s)
[472.723468] Starting dynamic subtest: ccs0-smem
[473.987580] Dynamic subtest ccs0-smem: SUCCESS (1.332s)
[473.990296] Subtest capture: FAIL (5.970s)
[474.162814] [081/131] (546s left) kms_psr (pr-primary-blt)
[474.264011] Starting subtest: pr-primary-blt
[474.269045] Subtest pr-primary-blt: SKIP (0.000s)
[474.362366] [082/131] (546s left) kms_universal_plane (disable-primary-vs-flip)
[474.455486] Starting subtest: disable-primary-vs-flip
[474.457849] Starting dynamic subtest: pipe-A-eDP-1
[476.012484] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.557s)
[476.022947] Starting dynamic subtest: pipe-B-eDP-1
[478.262045] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.248s)
[478.272633] Starting dynamic subtest: pipe-C-eDP-1
[480.433053] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.171s)
[480.445372] Starting dynamic subtest: pipe-D-eDP-1
[482.603519] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.169s)
[482.606132] Subtest disable-primary-vs-flip: SUCCESS (8.151s)
[483.429454] [083/131] (537s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[483.536711] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[483.539133] Starting dynamic subtest: pipe-A
[484.819055] Dynamic subtest pipe-A: SUCCESS (1.284s)
[484.828730] Starting dynamic subtest: pipe-B
[487.078648] Dynamic subtest pipe-B: SUCCESS (2.259s)
[487.088212] Starting dynamic subtest: pipe-C
[488.302219] Dynamic subtest pipe-C: SUCCESS (1.223s)
[488.312765] Starting dynamic subtest: pipe-D
[489.531055] Dynamic subtest pipe-D: SUCCESS (1.228s)
[489.534168] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.998s)
[490.747739] [084/131] (530s left) gem_spin_batch (resubmit)
[490.801900] Starting subtest: resubmit
[490.804526] Starting dynamic subtest: rcs0
[490.809827] Dynamic subtest rcs0: SUCCESS (0.007s)
[490.820644] Starting dynamic subtest: bcs0
[490.823042] Dynamic subtest bcs0: SUCCESS (0.003s)
[490.833060] Starting dynamic subtest: vcs0
[490.835423] Dynamic subtest vcs0: SUCCESS (0.003s)
[490.844898] Starting dynamic subtest: vcs1
[490.847059] Dynamic subtest vcs1: SUCCESS (0.003s)
[490.857655] Starting dynamic subtest: vecs0
[490.859986] Dynamic subtest vecs0: SUCCESS (0.003s)
[490.870836] Starting dynamic subtest: ccs0
[490.873076] Dynamic subtest ccs0: SUCCESS (0.004s)
[490.875498] Subtest resubmit: SUCCESS (0.028s)
[491.082013] [085/131] (529s left) kms_flip (nonexisting-fb)
[491.174990] Starting subtest: nonexisting-fb
[491.177545] Starting dynamic subtest: A-eDP1
[492.309198] Dynamic subtest A-eDP1: SUCCESS (1.137s)
[492.320266] Starting dynamic subtest: B-eDP1
[493.441676] Dynamic subtest B-eDP1: SUCCESS (1.131s)
[493.452101] Starting dynamic subtest: C-eDP1
[494.575874] Dynamic subtest C-eDP1: SUCCESS (1.134s)
[494.591000] Starting dynamic subtest: D-eDP1
[495.706997] Dynamic subtest D-eDP1: SUCCESS (1.130s)
[495.709495] Subtest nonexisting-fb: SUCCESS (4.540s)
[496.912187] [086/131] (523s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[496.972234] Starting subtest: etime-single-wait-all-for-submit-submitted
[497.078992] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[497.184895] [087/131] (523s left) kms_frontbuffer_tracking (psr-1p-rte)
[497.281970] Starting subtest: psr-1p-rte
[502.701633] Subtest psr-1p-rte: SUCCESS (5.424s)
[502.880720] [088/131] (518s left) gem_fenced_exec_thrash (no-spare-fences)
[502.948992] Subtest no-spare-fences: SKIP (0.000s)
[503.020518] [089/131] (517s left) perf_pmu (interrupts)
[503.059338] Starting subtest: interrupts
[504.178524] Subtest interrupts: SUCCESS (1.118s)
[504.322573] [090/131] (516s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[504.416045] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[504.421450] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[504.540335] [091/131] (516s left) kms_plane_lowres (tiling-x)
[504.632009] Starting subtest: tiling-x
[504.634803] Starting dynamic subtest: pipe-A-eDP-1
[504.640011] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[504.929216] Starting dynamic subtest: pipe-B-eDP-1
[504.935189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[504.945187] Starting dynamic subtest: pipe-C-eDP-1
[504.950984] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[504.961033] Starting dynamic subtest: pipe-D-eDP-1
[504.966842] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[504.972244] Subtest tiling-x: SKIP (0.292s)
[505.765571] [092/131] (515s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[505.862076] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[505.870491] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[505.980246] [093/131] (515s left) kms_flip (basic-flip-vs-wf_vblank)
[506.067474] Starting subtest: basic-flip-vs-wf_vblank
[506.069751] Starting dynamic subtest: A-eDP1
[507.990832] Dynamic subtest A-eDP1: SUCCESS (1.922s)
[508.004953] Starting dynamic subtest: B-eDP1
[509.924829] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[509.939788] Starting dynamic subtest: C-eDP1
[511.837069] Dynamic subtest C-eDP1: SUCCESS (1.908s)
[511.848250] Starting dynamic subtest: D-eDP1
[513.766437] Dynamic subtest D-eDP1: SUCCESS (1.928s)
[513.769231] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.703s)
[515.025691] [094/131] (506s left) kms_cursor_crc (cursor-sliding-512x512)
[515.322261] Starting subtest: cursor-sliding-512x512
[515.327871] Subtest cursor-sliding-512x512: SKIP (0.001s)
[515.530506] [095/131] (505s left) prime_mmap (test_userptr)
[515.597402] Starting subtest: test_userptr
[515.600378] Starting dynamic subtest: test_userptr-smem
[515.603025] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[515.605639] Subtest test_userptr: SUCCESS (0.002s)
[515.722731] [096/131] (505s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[515.823801] Starting subtest: 4-tiled-8bpp-rotate-180
[517.060631] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.237s)
[517.221009] [097/131] (504s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[517.320974] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[517.323540] Starting dynamic subtest: A-eDP1
[520.907009] Dynamic subtest A-eDP1: SUCCESS (3.584s)
[520.917714] Starting dynamic subtest: B-eDP1
[524.092797] Dynamic subtest B-eDP1: SUCCESS (3.185s)
[524.103633] Starting dynamic subtest: C-eDP1
[527.213034] Dynamic subtest C-eDP1: SUCCESS (3.118s)
[527.224203] Starting dynamic subtest: D-eDP1
[530.339893] Dynamic subtest D-eDP1: SUCCESS (3.128s)
[530.342453] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.024s)
[531.167111] [098/131] (490s left) kms_big_fb (linear-32bpp-rotate-90)
[531.279049] Starting subtest: linear-32bpp-rotate-90
[531.299244] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[531.449657] [099/131] (489s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[531.553831] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[531.559080] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[531.680256] [100/131] (489s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[531.743546] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[531.847601] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[531.954138] [101/131] (489s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[532.052712] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[536.028744] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.982s)
[537.165652] [102/131] (484s left) gem_sync (basic-store-each)
[537.244111] Starting subtest: basic-store-each
[539.728507] Subtest basic-store-each: SUCCESS (2.498s)
[539.942183] [103/131] (481s left) gem_ctx_persistence (engines-hostile)
[540.012599] Starting subtest: engines-hostile
[540.015186] Starting dynamic subtest: rcs0
[540.166473] Dynamic subtest rcs0: SUCCESS (0.153s)
[540.182193] Starting dynamic subtest: bcs0
[540.287451] Dynamic subtest bcs0: SUCCESS (0.118s)
[540.301013] Starting dynamic subtest: vcs0
[540.406428] Dynamic subtest vcs0: SUCCESS (0.117s)
[540.419363] Starting dynamic subtest: vcs1
[540.519549] Dynamic subtest vcs1: SUCCESS (0.111s)
[540.531969] Starting dynamic subtest: vecs0
[540.643505] Dynamic subtest vecs0: SUCCESS (0.122s)
[540.657245] Starting dynamic subtest: ccs0
[540.726108] Dynamic subtest ccs0: SUCCESS (0.080s)
[540.729238] Subtest engines-hostile: SUCCESS (0.716s)
[540.919240] [104/131] (480s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[545.920022] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[545.923119] Starting dynamic subtest: pipe-A-eDP-1
[546.722730] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[546.733763] Starting dynamic subtest: pipe-B-eDP-1
[547.849938] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[547.855216] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.927s)
[549.054336] [105/131] (472s left) kms_addfb_basic (addfb25-modifier-no-flag)
[549.151054] Starting subtest: addfb25-modifier-no-flag
[549.153660] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[549.282490] [106/131] (472s left) kms_dp_linktrain_fallback (dsc-fallback)
[549.392917] Starting subtest: dsc-fallback
[549.400461] Subtest dsc-fallback: SKIP (0.000s)
[549.489322] [107/131] (472s left) syncobj_timeline (single-wait-available-signaled)
[549.547225] Starting subtest: single-wait-available-signaled
[549.550033] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[549.671545] [108/131] (472s left) kms_addfb_basic (bad-pitch-256)
[549.737681] Starting subtest: bad-pitch-256
[549.740451] Subtest bad-pitch-256: SUCCESS (0.000s)
[549.889429] [109/131] (471s left) perf (i915-ref-count)
[549.979124] Starting subtest: i915-ref-count
[550.039814] Subtest i915-ref-count: SUCCESS (0.059s)
[550.095894] [110/131] (471s left) i915_drm_fdinfo (idle)
[550.139845] Starting subtest: idle
[550.141919] Starting dynamic subtest: rcs0
[550.680626] Dynamic subtest rcs0: SUCCESS (0.542s)
[550.693826] Starting dynamic subtest: bcs0
[551.213216] Dynamic subtest bcs0: SUCCESS (0.529s)
[551.226883] Starting dynamic subtest: vcs0
[551.718961] Dynamic subtest vcs0: SUCCESS (0.503s)
[551.731844] Starting dynamic subtest: vcs1
[552.224584] Dynamic subtest vcs1: SUCCESS (0.503s)
[552.238314] Starting dynamic subtest: vecs0
[552.730830] Dynamic subtest vecs0: SUCCESS (0.503s)
[552.743884] Starting dynamic subtest: ccs0
[553.236684] Dynamic subtest ccs0: SUCCESS (0.503s)
[553.239827] Subtest idle: SUCCESS (3.099s)
[553.338041] [111/131] (468s left) gem_ccs (block-copy-uncompressed)
[553.404705] Starting subtest: block-copy-uncompressed
[553.409115] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[553.431993] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.030s)
[553.446695] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[553.454046] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[553.464638] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[553.475326] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[553.488221] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[553.496854] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[553.499483] Subtest block-copy-uncompressed: SUCCESS (0.097s)
[553.663396] [112/131] (468s left) gem_tiled_blits (normal)
[553.734696] Subtest normal: SKIP (0.000s)
[553.809520] [113/131] (468s left) api_intel_bb (blit-noreloc-keep-cache)
[553.871226] Starting subtest: blit-noreloc-keep-cache
[553.883748] Subtest blit-noreloc-keep-cache: SUCCESS (0.016s)
[554.001584] [114/131] (468s left) gem_exec_balancer (nohangcheck)
[554.267501] Starting subtest: nohangcheck
[555.126967] Subtest nohangcheck: SUCCESS (0.861s)
[555.287576] [115/131] (466s left) perf_pmu (busy-accuracy-50)
[555.333982] Starting subtest: busy-accuracy-50
[555.336507] Starting dynamic subtest: rcs0
[556.876019] Dynamic subtest rcs0: SUCCESS (1.544s)
[556.887974] Starting dynamic subtest: bcs0
[558.429674] Dynamic subtest bcs0: SUCCESS (1.551s)
[558.440184] Starting dynamic subtest: vcs0
[559.973042] Dynamic subtest vcs0: SUCCESS (1.541s)
[559.984997] Starting dynamic subtest: vcs1
[561.516104] Dynamic subtest vcs1: SUCCESS (1.542s)
[561.528169] Starting dynamic subtest: vecs0
[563.054483] Dynamic subtest vecs0: SUCCESS (1.537s)
[563.066844] Starting dynamic subtest: ccs0
[564.601452] Dynamic subtest ccs0: SUCCESS (1.545s)
[564.604114] Subtest busy-accuracy-50: SUCCESS (9.273s)
[564.737486] [116/131] (457s left) i915_pm_rps (thresholds-park)
[564.802032] Starting subtest: thresholds-park
[564.808032] Subtest thresholds-park: SKIP (0.001s)
[564.949550] [117/131] (457s left) gem_softpin (evict-active-interruptible)
[565.019947] Starting subtest: evict-active-interruptible
[565.028638] Subtest evict-active-interruptible: SUCCESS (0.009s)
[565.197165] [118/131] (457s left) kms_color (ctm-green-to-red)
[565.292053] Starting subtest: ctm-green-to-red
[565.294509] Starting dynamic subtest: pipe-A-eDP-1
[565.970090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.679s)
[565.981285] Starting dynamic subtest: pipe-B-eDP-1
[567.315198] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.345s)
[567.326883] Starting dynamic subtest: pipe-C-eDP-1
[568.601969] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.286s)
[568.613021] Starting dynamic subtest: pipe-D-eDP-1
[569.924450] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[569.927028] Subtest ctm-green-to-red: SUCCESS (4.636s)
[570.805638] [119/131] (451s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[570.919820] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[570.924615] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[571.060573] [120/131] (451s left) kms_psr (psr2-primary-page-flip)
[571.154984] Starting subtest: psr2-primary-page-flip
[571.157498] Starting dynamic subtest: eDP-1
[572.867530] Dynamic subtest eDP-1: SUCCESS (1.711s)
[572.870143] Subtest psr2-primary-page-flip: SUCCESS (1.712s)
[573.760719] [121/131] (448s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[573.854186] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[573.857111] Starting dynamic subtest: pipe-A-eDP-1
[573.869043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[573.882906] Starting dynamic subtest: pipe-B-eDP-1
[573.892668] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[573.902993] Starting dynamic subtest: pipe-C-eDP-1
[573.914035] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[573.923218] Starting dynamic subtest: pipe-D-eDP-1
[573.934226] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[573.939715] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[576.041604] [122/131] (446s left) gem_exec_reloc (basic-cpu-read-active)
[576.111196] Subtest basic-cpu-read-active: SKIP (0.000s)
[576.193335] [123/131] (446s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[576.257836] Starting subtest: yf-tiled-ccs-to-x-tiled
[576.263722] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[576.462718] [124/131] (446s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[576.562724] Starting subtest: psr-rgb101010-draw-mmap-cpu
[583.850928] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.293s)
[583.999833] [125/131] (438s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[584.105045] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[584.110018] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[584.217013] [126/131] (438s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[584.314070] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[584.316895] Starting dynamic subtest: pipe-A-eDP-1
[584.340276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[584.352140] Starting dynamic subtest: pipe-B-eDP-1
[584.375765] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[584.386039] Starting dynamic subtest: pipe-C-eDP-1
[584.408977] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[584.419083] Starting dynamic subtest: pipe-D-eDP-1
[584.442042] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[584.444636] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[586.524538] [127/131] (436s left) gem_exec_schedule (u-independent)
[586.601112] Starting subtest: u-independent
[586.603723] Starting dynamic subtest: rcs0
[587.875194] Dynamic subtest rcs0: SUCCESS (1.286s)
[587.889587] Starting dynamic subtest: vcs0
[589.893968] Dynamic subtest vcs0: SUCCESS (2.017s)
[589.907860] Starting dynamic subtest: vcs1
[591.878257] Dynamic subtest vcs1: SUCCESS (1.982s)
[591.895994] Starting dynamic subtest: vecs0
[593.915352] Dynamic subtest vecs0: SUCCESS (2.036s)
[593.928250] Starting dynamic subtest: ccs0
[595.874997] Dynamic subtest ccs0: SUCCESS (1.958s)
[595.877832] Subtest u-independent: SUCCESS (9.289s)
[596.205194] [128/131] (426s left) gem_exec_params (sol-reset-invalid)
[596.263206] Starting subtest: sol-reset-invalid
[596.269054] Subtest sol-reset-invalid: SUCCESS (0.005s)
[597.979511] [129/131] (424s left) kms_rotation_crc (bad-tiling)
[598.082125] Starting subtest: bad-tiling
[598.087101] Subtest bad-tiling: SKIP (0.001s)
[598.178385] [130/131] (424s left) perf (enable-disable)
[598.284085] Starting subtest: enable-disable
[598.286954] Starting dynamic subtest: 0-rcs0
[600.543722] Dynamic subtest 0-rcs0: SUCCESS (2.259s)
[600.555132] Starting dynamic subtest: 1-vcs1
[605.005456] Dynamic subtest 1-vcs1: SUCCESS (4.462s)
[605.008381] Subtest enable-disable: SUCCESS (6.722s)
[605.057568] [131/131] (417s left) gem_eio (throttle)
[605.289146] Starting subtest: throttle
[605.620803] Subtest throttle: SUCCESS (0.333s)
[605.781220] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_async_flips
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_hdr
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gem_ringfill
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_scaling_modes
results: parsing output: 15/ for test: vgem_basic
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: core_auth
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_plane_alpha_blend
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cdclk
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_lease
results: parsing output: 31/ for test: gem_eio
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_cursor_edge_walk
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: prime_self_import
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_ctx_shared
results: parsing output: 41/ for test: gem_tiled_fence_blits
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_chamelium_hpd
results: parsing output: 45/ for test: gem_create
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: gem_exec_fence
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: sw_sync
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gen9_exec_parse
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_whisper
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: i915_hangman
results: parsing output: 68/ for test: kms_chamelium_edid
results: parsing output: 69/ for test: gem_workarounds
results: parsing output: 70/ for test: i915_pm_rpm
results: parsing output: 71/ for test: gem_pxp
results: parsing output: 72/ for test: gem_exec_parallel
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_mmap_offset
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: gem_set_tiling_vs_blt
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_capture
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_universal_plane
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: gem_spin_batch
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_fenced_exec_thrash
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane_lowres
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_sync
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_dp_linktrain_fallback
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: gem_ccs
results: parsing output: 111/ for test: gem_tiled_blits
results: parsing output: 112/ for test: api_intel_bb
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_exec_params
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: gem_eio
Done.