[56.241489] Initializing watchdogs [56.241542] /dev/watchdog0 [56.259139] [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.263844] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.266176] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.269387] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [56.404728] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [56.409245] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [56.527585] [002/131] (960s left) prime_busy (after-wait) [56.591864] Starting subtest: after-wait [56.594260] Starting dynamic subtest: rcs0 [56.647080] Dynamic subtest rcs0: SUCCESS (0.053s) [56.656473] Starting dynamic subtest: bcs0 [56.722625] Dynamic subtest bcs0: SUCCESS (0.074s) [56.731319] Starting dynamic subtest: vcs0 [56.761740] Dynamic subtest vcs0: SUCCESS (0.039s) [56.769751] Starting dynamic subtest: vcs1 [56.801473] Dynamic subtest vcs1: SUCCESS (0.039s) [56.809576] Starting dynamic subtest: vecs0 [56.842097] Dynamic subtest vecs0: SUCCESS (0.039s) [56.849321] Starting dynamic subtest: ccs0 [56.881471] Dynamic subtest ccs0: SUCCESS (0.038s) [56.991830] Subtest after-wait: SUCCESS (0.392s) [57.074831] [003/131] (959s left) api_intel_bb (simple-bb) [57.137930] Starting subtest: simple-bb [57.143009] Subtest simple-bb: SUCCESS (0.006s) [57.245319] [004/131] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [57.348386] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [57.352994] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [57.475278] [005/131] (959s left) gem_exec_whisper (basic-queues) [57.545734] Starting subtest: basic-queues [62.907846] Subtest basic-queues: SUCCESS (5.288s) [63.096224] [006/131] (953s left) i915_pm_rps (thresholds-idle) [63.155197] Starting subtest: thresholds-idle [63.160102] Subtest thresholds-idle: SKIP (0.001s) [63.242369] [007/131] (953s left) kms_psr (fbc-psr-sprite-blt) [63.347854] Starting subtest: fbc-psr-sprite-blt [63.349754] Starting dynamic subtest: eDP-1 [63.353950] Dynamic subtest eDP-1: SKIP (0.000s) [63.358193] Subtest fbc-psr-sprite-blt: SKIP (0.000s) [63.435724] [008/131] (953s left) syncobj_basic (bad-pad-handle-to-fd) [63.490007] Starting subtest: bad-pad-handle-to-fd [63.492414] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [63.617760] [009/131] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [63.714282] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [67.480540] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.746s) [68.667447] [010/131] (948s left) syncobj_timeline (multi-wait-all-signaled) [68.731098] Starting subtest: multi-wait-all-signaled [68.733615] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [68.824714] [011/131] (948s left) gem_mmap_wc (bad-object) [68.870571] Subtest bad-object: SKIP (0.000s) [68.925653] [012/131] (948s left) kms_addfb_basic (basic) [68.981953] Starting subtest: basic [68.984372] Subtest basic: SUCCESS (0.000s) [69.121452] [013/131] (948s left) gem_exec_balancer (full-late) [69.186772] Starting subtest: full-late [73.771416] Subtest full-late: SUCCESS (4.571s) [74.111424] [014/131] (943s left) perf_pmu (semaphore-wait) [74.150249] Starting subtest: semaphore-wait [74.152537] Starting dynamic subtest: rcs0 [74.665802] Dynamic subtest rcs0: SUCCESS (0.513s) [74.674656] Starting dynamic subtest: bcs0 [75.181065] Dynamic subtest bcs0: SUCCESS (0.512s) [75.194536] Starting dynamic subtest: vcs0 [75.694839] Dynamic subtest vcs0: SUCCESS (0.511s) [75.708453] Starting dynamic subtest: vcs1 [76.208919] Dynamic subtest vcs1: SUCCESS (0.512s) [76.220612] Starting dynamic subtest: vecs0 [76.723386] Dynamic subtest vecs0: SUCCESS (0.512s) [76.732826] Starting dynamic subtest: ccs0 [77.238754] Dynamic subtest ccs0: SUCCESS (0.513s) [77.241771] Subtest semaphore-wait: SUCCESS (3.083s) [77.395376] [015/131] (939s left) core_getversion (basic) [77.433211] Starting subtest: basic [77.437844] Subtest basic: SUCCESS (0.000s) [77.508442] [016/131] (939s left) kms_big_fb (y-tiled-8bpp-rotate-0) [77.615675] Starting subtest: y-tiled-8bpp-rotate-0 [77.620341] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [77.740991] [017/131] (939s left) kms_plane_multiple (2x-tiling-4) [77.828616] Starting subtest: 2x-tiling-4 [77.832956] Subtest 2x-tiling-4: SKIP (0.000s) [77.909316] [018/131] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [78.002058] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [78.006074] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [78.119522] [019/131] (939s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [83.178635] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf [83.181045] Starting dynamic subtest: pipe-A-eDP-1 [94.574710] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.389s) [94.584992] Starting dynamic subtest: pipe-B-eDP-1 [106.017533] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.440s) [106.020017] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.833s) [106.878684] [020/131] (910s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [106.972818] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [106.974700] Starting dynamic subtest: pipe-A-eDP-1 [107.810792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s) [107.820049] Starting dynamic subtest: pipe-B-eDP-1 [109.380335] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.565s) [109.389955] Starting dynamic subtest: pipe-C-eDP-1 [110.883675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s) [110.893429] Starting dynamic subtest: pipe-D-eDP-1 [112.411211] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.526s) [112.413648] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.429s) [113.604477] [021/131] (903s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [113.712487] Starting subtest: psr-rgb565-draw-blt [120.661334] Subtest psr-rgb565-draw-blt: SUCCESS (6.951s) [120.829308] [022/131] (896s left) gem_exec_reloc (basic-cpu-read-active) [120.895261] Subtest basic-cpu-read-active: SKIP (0.000s) [120.962899] [023/131] (896s left) perf_pmu (all-busy-check-all) [120.998070] Starting subtest: all-busy-check-all [122.901327] Subtest all-busy-check-all: SUCCESS (1.903s) [123.021079] [024/131] (894s left) kms_psr (psr2-sprite-blt) [123.122290] Starting subtest: psr2-sprite-blt [123.124589] Starting dynamic subtest: eDP-1 [124.810631] Dynamic subtest eDP-1: SUCCESS (1.686s) [124.812641] Subtest psr2-sprite-blt: SUCCESS (1.687s) [125.701229] [025/131] (891s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [125.798621] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [130.328883] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.532s) [131.510083] [026/131] (886s left) kms_color (deep-color) [131.603529] Starting subtest: deep-color [132.650998] Starting dynamic subtest: pipe-A-eDP-1-gamma [133.344393] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.693s) [133.353613] Starting dynamic subtest: pipe-A-eDP-1-degamma [134.744109] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.398s) [134.753081] Starting dynamic subtest: pipe-A-eDP-1-ctm [136.152933] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.408s) [136.965514] Starting dynamic subtest: pipe-B-eDP-1-gamma [137.672690] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.712s) [137.680772] Starting dynamic subtest: pipe-B-eDP-1-degamma [139.165544] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.493s) [139.175743] Starting dynamic subtest: pipe-B-eDP-1-ctm [140.546081] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.381s) [141.353916] Starting dynamic subtest: pipe-C-eDP-1-gamma [141.999379] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.648s) [142.007873] Starting dynamic subtest: pipe-C-eDP-1-degamma [143.407971] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.410s) [143.416292] Starting dynamic subtest: pipe-C-eDP-1-ctm [144.823682] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.413s) [145.647182] Starting dynamic subtest: pipe-D-eDP-1-gamma [146.293502] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.653s) [146.301680] Starting dynamic subtest: pipe-D-eDP-1-degamma [147.667180] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.375s) [147.679457] Starting dynamic subtest: pipe-D-eDP-1-ctm [149.007443] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.339s) [149.009856] Subtest deep-color: SUCCESS (17.404s) [149.813288] [027/131] (867s left) kms_joiner (basic-big-joiner) [149.921597] Starting subtest: basic-big-joiner [149.925863] Subtest basic-big-joiner: SKIP (0.000s) [150.014259] [028/131] (867s left) fbdev (unaligned-write) [150.049623] Starting subtest: unaligned-write [150.148204] Subtest unaligned-write: SUCCESS (0.098s) [150.232557] [029/131] (867s left) gem_spin_batch (user-each) [150.304986] Starting subtest: user-each [153.572286] Subtest user-each: SUCCESS (3.261s) [154.051569] [030/131] (863s left) gem_exec_fence (submit) [154.227930] Starting subtest: submit [154.232497] Subtest submit: SKIP (0.000s) [156.049225] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true [156.052850] [031/131] (861s left) kms_flip (2x-flip-vs-modeset-vs-hang) [156.156184] Starting subtest: 2x-flip-vs-modeset-vs-hang [156.165143] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s) [156.268759] [032/131] (861s left) gem_render_copy_redux (interruptible) [156.336655] Starting subtest: interruptible [156.609974] Subtest interruptible: SUCCESS (0.275s) [156.757926] [033/131] (861s left) gem_exec_whisper (basic-fds-priority) [156.826312] Starting subtest: basic-fds-priority [180.450784] Subtest basic-fds-priority: SUCCESS (23.616s) [180.658257] [034/131] (837s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [180.772712] Starting subtest: extended-modeset-hang-oldfb-with-reset [180.775066] Starting dynamic subtest: pipe-A [192.490609] Dynamic subtest pipe-A: SUCCESS (11.711s) [192.500850] Starting dynamic subtest: pipe-D [204.764257] Dynamic subtest pipe-D: SUCCESS (12.271s) [204.766519] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.987s) [205.582953] [035/131] (812s left) kms_big_fb (x-tiled-64bpp-rotate-180) [205.693308] Starting subtest: x-tiled-64bpp-rotate-180 [207.215460] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.523s) [207.398489] [036/131] (810s left) gem_pxp (protected-encrypted-src-copy-not-readible) [207.529800] Starting subtest: protected-encrypted-src-copy-not-readible [207.644333] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.115s) [207.818323] [037/131] (810s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [207.933033] Starting subtest: 2x-cursor-vs-flip-legacy [207.937675] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s) [208.078660] [038/131] (810s left) gem_exec_params (no-blt) [208.141370] Starting subtest: no-blt [208.143812] Subtest no-blt: SUCCESS (0.002s) [208.304367] [039/131] (809s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [208.363645] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [208.368132] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [208.557070] [040/131] (809s left) kms_flip (basic-plain-flip) [208.660341] Starting subtest: basic-plain-flip [208.662692] Starting dynamic subtest: A-eDP1 [210.369910] Dynamic subtest A-eDP1: SUCCESS (1.709s) [210.381443] Starting dynamic subtest: B-eDP1 [212.007427] Dynamic subtest B-eDP1: SUCCESS (1.635s) [212.019554] Starting dynamic subtest: C-eDP1 [213.638335] Dynamic subtest C-eDP1: SUCCESS (1.630s) [213.648851] Starting dynamic subtest: D-eDP1 [215.276585] Dynamic subtest D-eDP1: SUCCESS (1.637s) [215.281822] Subtest basic-plain-flip: SUCCESS (6.622s) [216.478065] [041/131] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [216.576288] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [216.580279] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [216.699780] [042/131] (801s left) kms_atomic_interruptible (atomic-setmode) [216.797193] Starting subtest: atomic-setmode [216.799596] Starting dynamic subtest: pipe-A-eDP-1 [223.699705] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.902s) [223.702125] Subtest atomic-setmode: SUCCESS (6.903s) [224.601756] [043/131] (793s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [224.691174] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [224.693412] Starting dynamic subtest: pipe-A-eDP-1 [224.717728] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [224.728360] Starting dynamic subtest: pipe-B-eDP-1 [224.751167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [224.759776] Starting dynamic subtest: pipe-C-eDP-1 [224.783085] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [224.791560] Starting dynamic subtest: pipe-D-eDP-1 [224.815499] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [224.819903] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s) [226.954296] [044/131] (791s left) kms_big_fb (4-tiled-64bpp-rotate-90) [227.061466] Starting subtest: 4-tiled-64bpp-rotate-90 [227.084820] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.022s) [227.218555] [045/131] (791s left) gem_exec_basic (basic) [227.276394] Starting subtest: basic [227.278726] Starting dynamic subtest: rcs0-smem [227.281108] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [227.292703] Starting dynamic subtest: bcs0-smem [227.294610] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [227.303074] Starting dynamic subtest: vcs0-smem [227.304928] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [227.313573] Starting dynamic subtest: vcs1-smem [227.315496] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [227.323895] Starting dynamic subtest: vecs0-smem [227.325837] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [227.334558] Starting dynamic subtest: ccs0-smem [227.336611] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [227.338605] Subtest basic: SUCCESS (0.014s) [228.932298] [046/131] (789s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [228.982015] Starting subtest: y-tiled-ccs-to-y-tiled [228.986444] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [229.176053] [047/131] (789s left) kms_joiner (invalid-modeset-ultra-joiner) [229.272679] Starting subtest: invalid-modeset-ultra-joiner [229.276857] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [229.349576] [048/131] (789s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [229.450129] Starting subtest: plane-primary-toggle-with-vblank-wait [229.452515] Starting dynamic subtest: pipe-A-eDP-1 [229.624049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.176s) [229.929337] Starting dynamic subtest: pipe-B-eDP-1 [230.842491] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.922s) [231.146589] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.698s) [232.019752] [049/131] (786s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [232.113741] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [232.251076] [050/131] (786s left) syncobj_wait (wait-all-for-submit-complex) [232.315804] Starting subtest: wait-all-for-submit-complex [232.530852] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [232.631519] [051/131] (786s left) tools_test (sysfs_l3_parity) [232.678896] Starting subtest: sysfs_l3_parity [232.751382] Subtest sysfs_l3_parity: SKIP (0.086s) [232.831632] [052/131] (785s left) i915_pm_rpm (gem-execbuf-stress-pc8) [235.063626] Starting subtest: gem-execbuf-stress-pc8 [235.099692] Subtest gem-execbuf-stress-pc8: SKIP (0.038s) [235.452166] [053/131] (783s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [235.544585] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [235.548730] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [235.684516] [054/131] (783s left) kms_psr2_su (frontbuffer-xrgb8888) [235.744072] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [235.809076] [055/131] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [235.904807] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [235.908968] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [236.046538] [056/131] (782s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [236.150443] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [240.100851] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.954s) [241.252736] [057/131] (777s left) i915_drm_fdinfo (busy-idle-check-all) [241.294184] Starting subtest: busy-idle-check-all [241.296406] Starting dynamic subtest: rcs0 [241.300822] Dynamic subtest rcs0: SKIP (0.004s) [241.310273] Starting dynamic subtest: bcs0 [241.314526] Dynamic subtest bcs0: SKIP (0.000s) [241.323283] Starting dynamic subtest: vcs0 [241.327585] Dynamic subtest vcs0: SKIP (0.000s) [241.336147] Starting dynamic subtest: vcs1 [241.340393] Dynamic subtest vcs1: SKIP (0.000s) [241.349152] Starting dynamic subtest: vecs0 [241.353319] Dynamic subtest vecs0: SKIP (0.000s) [241.362289] Starting dynamic subtest: ccs0 [241.366673] Dynamic subtest ccs0: SKIP (0.000s) [241.371088] Subtest busy-idle-check-all: SKIP (0.009s) [241.410961] [058/131] (777s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [241.548317] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [250.818723] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.271s) [250.968929] [059/131] (768s left) i915_getparams_basic (basic-subslice-total) [251.021857] Starting subtest: basic-subslice-total [251.026133] Subtest basic-subslice-total: SUCCESS (0.000s) [251.137619] [060/131] (767s left) perf (gen12-unprivileged-single-ctx-counters) [251.266051] Starting subtest: gen12-unprivileged-single-ctx-counters [251.268355] Starting dynamic subtest: rcs0 [251.303668] Dynamic subtest rcs0: SUCCESS (0.037s) [251.306073] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.038s) [251.366437] [061/131] (767s left) kms_setmode (invalid-clone-single-crtc) [251.428912] Starting subtest: invalid-clone-single-crtc [251.436130] Subtest invalid-clone-single-crtc: SKIP (0.000s) [251.565575] [062/131] (767s left) syncobj_timeline (device-signal-unordered) [251.615379] Starting subtest: device-signal-unordered [251.617703] Subtest device-signal-unordered: SUCCESS (0.000s) [251.745314] [063/131] (767s left) gem_exec_schedule (submit-golden-slice) [251.818984] Starting subtest: submit-golden-slice [251.821056] Starting dynamic subtest: rcs0 [251.842660] Dynamic subtest rcs0: SUCCESS (0.034s) [251.852576] Starting dynamic subtest: bcs0 [251.876079] Dynamic subtest bcs0: SUCCESS (0.033s) [251.884916] Starting dynamic subtest: vcs0 [251.911050] Dynamic subtest vcs0: SUCCESS (0.034s) [251.920291] Starting dynamic subtest: vcs1 [251.945754] Dynamic subtest vcs1: SUCCESS (0.034s) [251.954650] Starting dynamic subtest: vecs0 [251.978082] Dynamic subtest vecs0: SUCCESS (0.031s) [251.986929] Starting dynamic subtest: ccs0 [252.011070] Dynamic subtest ccs0: SUCCESS (0.032s) [252.013024] Subtest submit-golden-slice: SUCCESS (0.203s) [253.013333] [064/131] (766s left) kms_async_flips (crc-atomic) [253.102118] Starting subtest: crc-atomic [253.475623] Starting dynamic subtest: pipe-A-eDP-1 [256.379247] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.904s) [256.756642] Starting dynamic subtest: pipe-B-eDP-1 [259.614918] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.866s) [259.993670] Starting dynamic subtest: pipe-C-eDP-1 [262.925299] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.942s) [263.294463] Starting dynamic subtest: pipe-D-eDP-1 [266.139412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.857s) [266.141718] Subtest crc-atomic: SUCCESS (13.038s) [267.326371] [065/131] (751s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [267.426416] Starting subtest: async-flip-with-page-flip-events-tiled [267.801523] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [270.574295] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.771s) [270.585746] Starting dynamic subtest: pipe-A-eDP-1-4 [272.750242] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s) [272.759515] Starting dynamic subtest: pipe-A-eDP-1-4 [274.759771] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [274.768622] Starting dynamic subtest: pipe-A-eDP-1-x [276.950665] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s) [277.324506] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [280.103513] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.785s) [280.115596] Starting dynamic subtest: pipe-B-eDP-1-4 [282.290401] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [282.299724] Starting dynamic subtest: pipe-B-eDP-1-4 [284.300589] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [284.310369] Starting dynamic subtest: pipe-B-eDP-1-x [286.501128] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s) [286.872925] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [289.639896] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.772s) [289.649630] Starting dynamic subtest: pipe-C-eDP-1-4 [291.813598] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [291.825707] Starting dynamic subtest: pipe-C-eDP-1-4 [293.824252] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [293.835746] Starting dynamic subtest: pipe-C-eDP-1-x [296.002848] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s) [296.360446] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [299.154378] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.801s) [299.164223] Starting dynamic subtest: pipe-D-eDP-1-4 [301.330103] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s) [301.339884] Starting dynamic subtest: pipe-D-eDP-1-4 [303.340314] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [303.354958] Starting dynamic subtest: pipe-D-eDP-1-x [305.519598] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [305.522158] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.092s) [306.762517] [066/131] (712s left) kms_cursor_crc (cursor-onscreen-64x64) [306.943816] Starting subtest: cursor-onscreen-64x64 [306.951030] Starting dynamic subtest: pipe-A-eDP-1 [309.037244] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.089s) [309.067061] Starting dynamic subtest: pipe-D-eDP-1 [311.835806] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s) [311.838262] Subtest cursor-onscreen-64x64: SUCCESS (4.890s) [312.727366] [067/131] (706s left) gem_lmem_swapping (verify-random-ccs) [312.769302] Subtest verify-random-ccs: SKIP (0.000s) [312.810675] [068/131] (706s left) gem_mmap_wc (read-write) [312.869148] Subtest read-write: SKIP (0.000s) [312.926972] [069/131] (706s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [317.902186] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [317.906770] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s) [318.762930] [070/131] (700s left) gen9_exec_parse (allowed-single) [318.828553] Subtest allowed-single: SKIP (0.000s) [318.922012] [071/131] (700s left) kms_fbcon_fbt (psr) [318.986611] Starting subtest: psr [326.269350] Subtest psr: SUCCESS (7.281s) [326.346394] [072/131] (693s left) kms_cursor_crc (cursor-onscreen-256x256) [326.596780] Starting subtest: cursor-onscreen-256x256 [326.602109] Starting dynamic subtest: pipe-A-eDP-1 [328.701561] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s) [328.727267] Starting dynamic subtest: pipe-D-eDP-1 [331.476394] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s) [331.478611] Subtest cursor-onscreen-256x256: SUCCESS (4.877s) [332.372657] [073/131] (687s left) kms_chamelium_edid (dp-mode-timings) [332.767150] Subtest dp-mode-timings: SKIP (0.000s) [333.566344] [074/131] (686s left) gem_ctx_persistence (legacy-engines-queued) [333.632603] Starting subtest: legacy-engines-queued [333.634979] Starting dynamic subtest: render [333.745998] Dynamic subtest render: SUCCESS (0.112s) [333.757523] Starting dynamic subtest: bsd1 [334.836481] Dynamic subtest bsd1: SUCCESS (1.086s) [334.849728] Starting dynamic subtest: bsd2 [336.884089] Dynamic subtest bsd2: SUCCESS (2.044s) [336.897025] Starting dynamic subtest: blt [336.973954] Dynamic subtest blt: SUCCESS (0.088s) [336.984884] Starting dynamic subtest: vebox [338.866595] Dynamic subtest vebox: SUCCESS (1.888s) [338.869699] Subtest legacy-engines-queued: SUCCESS (5.233s) [338.964438] [075/131] (680s left) kms_dp_linktrain_fallback (dsc-fallback) [339.060021] Starting subtest: dsc-fallback [339.066724] Subtest dsc-fallback: SKIP (0.000s) [339.167689] [076/131] (680s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [339.277521] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [339.281798] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [339.415785] [077/131] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [339.519806] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [339.523872] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [339.644183] [078/131] (680s left) gem_userptr_blits (unsync-unmap-after-close) [339.717067] Subtest unsync-unmap-after-close: SKIP (0.000s) [339.881396] [079/131] (680s left) gem_readwrite (read-write) [339.936120] Subtest read-write: SKIP (0.000s) [340.001203] [080/131] (679s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [340.098796] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [340.102549] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [340.233509] [081/131] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [340.337297] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [346.842591] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.507s) [347.003044] [082/131] (673s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [347.097866] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [347.100092] Starting dynamic subtest: pipe-A-default-mode [347.388961] Dynamic subtest pipe-A-default-mode: SKIP (0.289s) [347.393371] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.290s) [348.252643] [083/131] (671s left) kms_sequence (get-forked-busy) [348.345134] Starting subtest: get-forked-busy [348.347257] Starting dynamic subtest: pipe-A-eDP-1 [350.284724] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s) [350.294056] Starting dynamic subtest: pipe-B-eDP-1 [352.931819] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.644s) [352.941892] Starting dynamic subtest: pipe-C-eDP-1 [355.553170] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s) [355.563168] Starting dynamic subtest: pipe-D-eDP-1 [358.173700] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.619s) [358.175944] Subtest get-forked-busy: SUCCESS (9.828s) [358.979601] [084/131] (661s left) kms_dsc (dsc-fractional-bpp-with-bpc) [359.078897] Starting subtest: dsc-fractional-bpp-with-bpc [359.108984] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [359.174415] [085/131] (660s left) kms_prop_blob (blob-prop-core) [359.235513] Starting subtest: blob-prop-core [359.237707] Subtest blob-prop-core: SUCCESS (0.000s) [359.353182] [086/131] (660s left) prime_vgem (coherency-gtt) [359.426241] Starting subtest: coherency-gtt [359.430268] Subtest coherency-gtt: SKIP (0.000s) [359.560179] [087/131] (660s left) gem_mmap_gtt (flink-race) [359.618372] Subtest flink-race: SKIP (0.000s) [359.675964] [088/131] (660s left) kms_cursor_edge_walk (64x64-right-edge) [359.760272] Starting subtest: 64x64-right-edge [359.762663] Starting dynamic subtest: pipe-A-eDP-1 [363.238415] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s) [363.248318] Starting dynamic subtest: pipe-D-eDP-1 [366.366066] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s) [366.368307] Subtest 64x64-right-edge: SUCCESS (6.609s) [367.190153] [089/131] (653s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [367.279131] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [367.281698] Starting dynamic subtest: pipe-A-default-mode [370.039653] Dynamic subtest pipe-A-default-mode: SUCCESS (2.760s) [370.041970] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.762s) [370.905686] [090/131] (649s left) kms_selftest (drm_plane_helper) [370.940734] Starting subtest: drm_plane_helper [370.983743] Starting dynamic subtest: drm_test_check_plane_state [371.178680] Dynamic subtest drm_test_check_plane_state: FAIL (0.120s) [371.188692] Starting dynamic subtest: drm_test_check_invalid_plane_state [371.331776] Dynamic subtest drm_test_check_invalid_plane_state: FAIL (0.155s) [371.333783] Subtest drm_plane_helper: FAIL (0.318s) [371.457366] [091/131] (648s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [373.082415] Starting subtest: dpms-mode-unset-non-lpsp [374.248457] Subtest dpms-mode-unset-non-lpsp: SKIP (1.166s) [374.649125] [092/131] (645s left) gem_partial_pwrite_pread (writes-after-reads) [374.726106] Subtest writes-after-reads: SKIP (0.000s) [374.816106] [093/131] (645s left) gem_userptr_blits (forbidden-operations) [374.891917] Starting subtest: forbidden-operations [374.896608] Subtest forbidden-operations: SKIP (0.000s) [375.062964] [094/131] (645s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [375.176374] Starting subtest: cursorB-vs-flipA-legacy [375.180767] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [375.333179] [095/131] (645s left) gem_mmap_gtt (hang) [375.393969] Subtest hang: SKIP (0.000s) [375.458452] [096/131] (645s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [375.555544] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [375.557321] Starting dynamic subtest: pipe-A-eDP-1 [377.573277] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.017s) [377.582358] Starting dynamic subtest: pipe-B-eDP-1 [379.798994] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.224s) [379.808059] Starting dynamic subtest: pipe-C-eDP-1 [381.853689] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.054s) [381.863544] Starting dynamic subtest: pipe-D-eDP-1 [383.884786] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.028s) [383.887111] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.328s) [385.172390] [097/131] (635s left) gem_workarounds (reset-fd) [385.232588] Starting subtest: reset-fd [385.420915] Subtest reset-fd: SUCCESS (0.185s) [385.589702] [098/131] (635s left) syncobj_timeline (single-wait-all-signaled) [385.655911] Starting subtest: single-wait-all-signaled [385.658232] Subtest single-wait-all-signaled: SUCCESS (0.000s) [385.781172] [099/131] (634s left) prime_mmap (test_errors) [385.847121] Starting subtest: test_errors [385.849407] Starting dynamic subtest: test_errors-smem [386.020973] Dynamic subtest test_errors-smem: SUCCESS (0.174s) [386.023743] Subtest test_errors: SUCCESS (0.175s) [386.116172] [100/131] (634s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [386.208071] Starting subtest: primary-yf-tiled-reflect-x-90 [386.212614] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [386.290471] [101/131] (634s left) kms_atomic_transition (plane-toggle-modeset-transition) [386.391471] Starting subtest: plane-toggle-modeset-transition [386.393382] Starting dynamic subtest: pipe-A-eDP-1 [399.072821] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.682s) [399.084757] Starting dynamic subtest: pipe-B-eDP-1 [411.514548] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.436s) [411.517293] Subtest plane-toggle-modeset-transition: SUCCESS (25.126s) [412.335124] [102/131] (608s left) gem_ctx_shared (create-shared-gtt) [412.393619] Starting subtest: create-shared-gtt [414.544304] Subtest create-shared-gtt: SUCCESS (2.152s) [414.879079] [103/131] (606s left) api_intel_allocator (two-level-inception) [414.937813] Starting subtest: two-level-inception [420.337288] Subtest two-level-inception: SUCCESS (5.399s) [420.478507] [104/131] (600s left) syncobj_timeline (etime-single-wait-all-submitted) [420.533352] Starting subtest: etime-single-wait-all-submitted [420.640245] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s) [420.732194] [105/131] (600s left) gem_exec_schedule (pi-distinct-iova) [420.918743] Starting subtest: pi-distinct-iova [420.920644] Starting dynamic subtest: rcs0 [421.071254] Dynamic subtest rcs0: SUCCESS (0.154s) [421.085767] Starting dynamic subtest: vcs0 [421.165995] Dynamic subtest vcs0: SUCCESS (0.094s) [421.175299] Starting dynamic subtest: vcs1 [421.256337] Dynamic subtest vcs1: SUCCESS (0.088s) [421.266621] Starting dynamic subtest: vecs0 [421.353893] Dynamic subtest vecs0: SUCCESS (0.095s) [421.367658] Starting dynamic subtest: ccs0 [421.473279] Dynamic subtest ccs0: SUCCESS (0.117s) [421.475607] Subtest pi-distinct-iova: SUCCESS (0.557s) [423.081292] [106/131] (597s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [423.208752] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [454.690511] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.481s) [455.577433] [107/131] (565s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [455.969514] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [456.763000] [108/131] (564s left) kms_pipe_crc_basic (hang-read-crc) [456.851163] Starting subtest: hang-read-crc [456.853375] Starting dynamic subtest: pipe-A-eDP-1 [458.958658] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.106s) [458.969753] Starting dynamic subtest: pipe-B-eDP-1 [461.628315] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.668s) [461.638606] Starting dynamic subtest: pipe-C-eDP-1 [464.247833] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s) [464.257546] Starting dynamic subtest: pipe-D-eDP-1 [466.918860] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.668s) [466.921238] Subtest hang-read-crc: SUCCESS (10.070s) [467.782724] [109/131] (553s left) kms_addfb_basic (too-high) [467.869599] Starting subtest: too-high [467.872050] Subtest too-high: SUCCESS (0.000s) [467.997909] [110/131] (553s left) kms_vblank (ts-continuation-modeset-rpm) [468.092410] Starting subtest: ts-continuation-modeset-rpm [468.094572] Starting dynamic subtest: pipe-A-eDP-1 [470.653623] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.562s) [470.670048] Starting dynamic subtest: pipe-D-eDP-1 [472.904456] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s) [472.906807] Subtest ts-continuation-modeset-rpm: SUCCESS (4.814s) [473.717190] [111/131] (547s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [473.814210] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [473.816419] Starting dynamic subtest: pipe-A-eDP-1 [473.841502] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [473.851736] Starting dynamic subtest: pipe-B-eDP-1 [473.875471] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [473.884797] Starting dynamic subtest: pipe-C-eDP-1 [473.908825] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [473.917463] Starting dynamic subtest: pipe-D-eDP-1 [473.941419] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [473.945807] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [475.994855] [112/131] (545s left) kms_frontbuffer_tracking (fbc-2p-rte) [476.096283] Starting subtest: fbc-2p-rte [476.100151] Subtest fbc-2p-rte: SKIP (0.000s) [476.235360] [113/131] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [476.333054] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [483.268815] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.937s) [483.429358] [114/131] (537s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [483.518469] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [483.522921] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [484.653698] [115/131] (536s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [484.713436] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [484.715774] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [484.838533] [116/131] (536s left) gem_exec_reloc (basic-gtt-wc) [484.905638] Subtest basic-gtt-wc: SKIP (0.000s) [484.993217] [117/131] (536s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [485.086870] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [485.089158] Starting dynamic subtest: pipe-A [486.213928] Dynamic subtest pipe-A: SUCCESS (1.129s) [486.223499] Starting dynamic subtest: pipe-B [488.421608] Dynamic subtest pipe-B: SUCCESS (2.207s) [488.431696] Starting dynamic subtest: pipe-C [489.565345] Dynamic subtest pipe-C: SUCCESS (1.142s) [489.574721] Starting dynamic subtest: pipe-D [490.716977] Dynamic subtest pipe-D: SUCCESS (1.151s) [490.719313] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.632s) [491.920455] [118/131] (529s left) gem_exec_flush (basic-batch-kernel-default-wb) [491.980087] Starting subtest: basic-batch-kernel-default-wb [498.673836] Subtest basic-batch-kernel-default-wb: SUCCESS (6.694s) [498.871570] [119/131] (522s left) gem_tiled_wb [498.999739] [120/131] (522s left) kms_psr (fbc-psr2-no-drrs) [499.088966] Starting subtest: fbc-psr2-no-drrs [499.091259] Starting dynamic subtest: eDP-1 [499.095300] Dynamic subtest eDP-1: SKIP (0.000s) [499.099300] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [499.188765] [121/131] (522s left) gem_ctx_isolation (preservation) [499.250396] Starting subtest: preservation [499.252775] Starting dynamic subtest: rcs0 [499.399947] Dynamic subtest rcs0: SUCCESS (0.149s) [499.412034] Starting dynamic subtest: bcs0 [499.556364] Dynamic subtest bcs0: SUCCESS (0.156s) [499.566038] Starting dynamic subtest: vcs0 [499.742279] Dynamic subtest vcs0: SUCCESS (0.184s) [499.755358] Starting dynamic subtest: vcs1 [501.012335] Dynamic subtest vcs1: SUCCESS (1.269s) [501.025099] Starting dynamic subtest: vecs0 [503.078607] Dynamic subtest vecs0: SUCCESS (2.066s) [503.091551] Starting dynamic subtest: ccs0 [505.065353] Dynamic subtest ccs0: SUCCESS (1.985s) [505.068195] Subtest preservation: SUCCESS (5.814s) [505.346201] [122/131] (516s left) sysfs_timeslice_duration (duration) [505.414084] Starting subtest: duration [505.416339] Starting dynamic subtest: vecs0 [518.834397] Dynamic subtest vecs0: SUCCESS (13.419s) [518.846833] Starting dynamic subtest: ccs0 [532.015062] Dynamic subtest ccs0: SUCCESS (13.178s) [532.027681] Starting dynamic subtest: vcs0 [545.842497] Dynamic subtest vcs0: SUCCESS (13.824s) [545.855215] Starting dynamic subtest: bcs0 [559.007055] Dynamic subtest bcs0: SUCCESS (13.164s) [559.019566] Starting dynamic subtest: rcs0 [572.186380] Dynamic subtest rcs0: SUCCESS (13.177s) [572.198533] Starting dynamic subtest: vcs1 [585.843429] Dynamic subtest vcs1: SUCCESS (13.653s) [585.846622] Subtest duration: SUCCESS (80.431s) [585.938015] [123/131] (435s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [586.047664] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt [586.051585] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [586.181937] [124/131] (435s left) kms_psr (psr2-cursor-plane-onoff) [586.272546] Starting subtest: psr2-cursor-plane-onoff [586.274675] Starting dynamic subtest: eDP-1 [587.987746] Dynamic subtest eDP-1: SUCCESS (1.714s) [587.989799] Subtest psr2-cursor-plane-onoff: SUCCESS (1.715s) [588.796887] [125/131] (433s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [588.889204] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [589.713622] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s) [589.932215] [126/131] (431s left) kms_plane_scaling (planes-scaler-unity-scaling) [590.020249] Starting subtest: planes-scaler-unity-scaling [590.022593] Starting dynamic subtest: pipe-A [590.087193] Dynamic subtest pipe-A: SUCCESS (0.068s) [590.102957] Starting dynamic subtest: pipe-B [591.204893] Dynamic subtest pipe-B: SUCCESS (1.115s) [591.220446] Starting dynamic subtest: pipe-C [592.314720] Dynamic subtest pipe-C: SUCCESS (1.109s) [592.325374] Starting dynamic subtest: pipe-D [593.453301] Dynamic subtest pipe-D: SUCCESS (1.137s) [593.455603] Subtest planes-scaler-unity-scaling: SUCCESS (3.436s) [594.623195] [127/131] (427s left) gem_create (create-ext-placement-sanity-check) [594.794936] Starting subtest: create-ext-placement-sanity-check [594.797687] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s) [594.908178] [128/131] (427s left) gem_softpin (allocator-fork) [594.978441] Starting subtest: allocator-fork [597.187943] Subtest allocator-fork: SUCCESS (2.210s) [597.395998] [129/131] (424s left) gem_exec_params (readonly) [597.459339] Starting subtest: readonly [597.464668] Subtest readonly: SUCCESS (0.004s) [597.619824] [130/131] (424s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [597.720350] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [597.724614] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [597.835626] [131/131] (424s left) kms_big_fb (linear-64bpp-rotate-270) [597.931592] Starting subtest: linear-64bpp-rotate-270 [597.953351] Subtest linear-64bpp-rotate-270: SKIP (0.020s) [598.110143] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: prime_busy results: parsing output: 2/ for test: api_intel_bb results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_whisper results: parsing output: 5/ for test: i915_pm_rps results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: syncobj_basic results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: gem_mmap_wc results: parsing output: 11/ for test: kms_addfb_basic results: parsing output: 12/ for test: gem_exec_balancer results: parsing output: 13/ for test: perf_pmu results: parsing output: 14/ for test: core_getversion results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: kms_plane_multiple results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_exec_reloc results: parsing output: 22/ for test: perf_pmu results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_color results: parsing output: 26/ for test: kms_joiner results: parsing output: 27/ for test: fbdev results: parsing output: 28/ for test: gem_spin_batch results: parsing output: 29/ for test: gem_exec_fence results: parsing output: 30/ for test: kms_flip results: parsing output: 31/ for test: gem_render_copy_redux results: parsing output: 32/ for test: gem_exec_whisper results: parsing output: 33/ for test: kms_busy results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_pxp results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: gem_exec_params results: parsing output: 38/ for test: gem_render_copy results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_atomic_interruptible results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: gem_exec_basic results: parsing output: 45/ for test: gem_render_copy results: parsing output: 46/ for test: kms_joiner results: parsing output: 47/ for test: kms_atomic_transition results: parsing output: 48/ for test: kms_addfb_basic results: parsing output: 49/ for test: syncobj_wait results: parsing output: 50/ for test: tools_test results: parsing output: 51/ for test: i915_pm_rpm results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_psr2_su results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: i915_drm_fdinfo results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: i915_getparams_basic results: parsing output: 59/ for test: perf results: parsing output: 60/ for test: kms_setmode results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: gem_exec_schedule results: parsing output: 63/ for test: kms_async_flips results: parsing output: 64/ for test: kms_async_flips results: parsing output: 65/ for test: kms_cursor_crc results: parsing output: 66/ for test: gem_lmem_swapping results: parsing output: 67/ for test: gem_mmap_wc results: parsing output: 68/ for test: kms_psr2_sf results: parsing output: 69/ for test: gen9_exec_parse results: parsing output: 70/ for test: kms_fbcon_fbt results: parsing output: 71/ for test: kms_cursor_crc results: parsing output: 72/ for test: kms_chamelium_edid results: parsing output: 73/ for test: gem_ctx_persistence results: parsing output: 74/ for test: kms_dp_linktrain_fallback results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_userptr_blits results: parsing output: 78/ for test: gem_readwrite results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_flip_scaled_crc results: parsing output: 82/ for test: kms_sequence results: parsing output: 83/ for test: kms_dsc results: parsing output: 84/ for test: kms_prop_blob results: parsing output: 85/ for test: prime_vgem results: parsing output: 86/ for test: gem_mmap_gtt results: parsing output: 87/ for test: kms_cursor_edge_walk results: parsing output: 88/ for test: kms_flip_scaled_crc results: parsing output: 89/ for test: kms_selftest results: parsing output: 90/ for test: kms_pm_rpm results: parsing output: 91/ for test: gem_partial_pwrite_pread results: parsing output: 92/ for test: gem_userptr_blits results: parsing output: 93/ for test: kms_cursor_legacy results: parsing output: 94/ for test: gem_mmap_gtt results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: gem_workarounds results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: prime_mmap results: parsing output: 99/ for test: kms_rotation_crc results: parsing output: 100/ for test: kms_atomic_transition results: parsing output: 101/ for test: gem_ctx_shared results: parsing output: 102/ for test: api_intel_allocator results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_cursor_legacy results: parsing output: 106/ for test: kms_chamelium_hpd results: parsing output: 107/ for test: kms_pipe_crc_basic results: parsing output: 108/ for test: kms_addfb_basic results: parsing output: 109/ for test: kms_vblank results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_ccs results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: gem_exec_reloc results: parsing output: 116/ for test: kms_plane_scaling results: parsing output: 117/ for test: gem_exec_flush results: parsing output: 118/ for test: gem_tiled_wb results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: gem_ctx_isolation results: parsing output: 121/ for test: sysfs_timeslice_duration results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_plane_scaling results: parsing output: 126/ for test: gem_create results: parsing output: 127/ for test: gem_softpin results: parsing output: 128/ for test: gem_exec_params results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_big_fb Done.