[56.605354] Initializing watchdogs [56.605399] /dev/watchdog0 [56.617962] [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.621698] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.623689] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.626809] [001/130] (960s left) gem_eio (in-flight-internal-10ms) [56.849082] Starting subtest: in-flight-internal-10ms [58.008990] Subtest in-flight-internal-10ms: SUCCESS (1.180s) [58.121506] [002/130] (959s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [58.215061] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [59.459236] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.264s) [59.582222] [003/130] (957s left) kms_big_fb (4-tiled-64bpp-rotate-180) [59.696744] Starting subtest: 4-tiled-64bpp-rotate-180 [61.807094] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (2.134s) [62.092367] [004/130] (955s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [62.209386] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [67.061500] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.887s) [67.191713] [005/130] (949s left) perf_pmu (busy-accuracy-98) [67.228801] Starting subtest: busy-accuracy-98 [67.230647] Starting dynamic subtest: rcs0 [70.265234] Dynamic subtest rcs0: SUCCESS (3.046s) [70.275080] Starting dynamic subtest: bcs0 [73.322185] Dynamic subtest bcs0: SUCCESS (3.065s) [73.332473] Starting dynamic subtest: vcs0 [76.364862] Dynamic subtest vcs0: SUCCESS (3.048s) [76.371832] Starting dynamic subtest: vcs1 [79.409570] Dynamic subtest vcs1: SUCCESS (3.048s) [79.416627] Starting dynamic subtest: vecs0 [82.452258] Dynamic subtest vecs0: SUCCESS (3.044s) [82.461664] Starting dynamic subtest: ccs0 [85.513447] Dynamic subtest ccs0: SUCCESS (3.060s) [85.515560] Subtest busy-accuracy-98: SUCCESS (18.313s) [85.623260] [006/130] (931s left) api_intel_bb (intel-bb-blit-y) [85.693139] Starting subtest: intel-bb-blit-y [89.593263] Subtest intel-bb-blit-y: SUCCESS (3.899s) [89.729918] [007/130] (927s left) gem_exec_reloc (basic-write-cpu-noreloc) [89.792381] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [89.858684] [008/130] (927s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [89.908996] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [89.911472] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [89.998557] [009/130] (927s left) gem_exec_schedule (lateslice) [90.082568] Starting subtest: lateslice [90.084627] Starting dynamic subtest: rcs0 [90.103619] Dynamic subtest rcs0: SUCCESS (0.031s) [90.113918] Starting dynamic subtest: bcs0 [90.126148] Dynamic subtest bcs0: SUCCESS (0.022s) [90.133299] Starting dynamic subtest: vcs0 [90.148069] Dynamic subtest vcs0: SUCCESS (0.022s) [90.154783] Starting dynamic subtest: vcs1 [90.170120] Dynamic subtest vcs1: SUCCESS (0.022s) [90.177154] Starting dynamic subtest: vecs0 [90.194597] Dynamic subtest vecs0: SUCCESS (0.024s) [90.201310] Starting dynamic subtest: ccs0 [90.214688] Dynamic subtest ccs0: SUCCESS (0.020s) [90.217092] Subtest lateslice: SUCCESS (0.142s) [92.048599] [010/130] (925s left) gem_exec_fence (syncobj-timeline-signal) [92.621362] Starting subtest: syncobj-timeline-signal [92.632235] Subtest syncobj-timeline-signal: SUCCESS (0.013s) [94.028101] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true [94.030978] [011/130] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [94.135434] Starting subtest: fbcpsr-2p-rte [94.139677] Subtest fbcpsr-2p-rte: SKIP (0.000s) [94.225319] [012/130] (923s left) perf_pmu (rc6-suspend) [94.265112] Starting subtest: rc6-suspend [117.536587] Subtest rc6-suspend: SUCCESS (7.642s) [118.411660] [013/130] (914s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [118.523045] Starting subtest: cursorA-vs-flipB-varying-size [118.527555] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [118.648450] [014/130] (914s left) kms_cursor_crc (cursor-rapid-movement-256x256) [118.849570] Starting subtest: cursor-rapid-movement-256x256 [118.853437] Starting dynamic subtest: pipe-A-eDP-1 [119.404758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s) [119.433936] Starting dynamic subtest: pipe-D-eDP-1 [120.638252] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [120.640251] Subtest cursor-rapid-movement-256x256: SUCCESS (1.819s) [121.455837] [015/130] (911s left) gem_vm_create (isolation) [121.515941] Starting subtest: isolation [121.521726] Subtest isolation: SUCCESS (0.008s) [121.658386] [016/130] (911s left) kms_flip (bo-too-big) [121.757800] Starting subtest: bo-too-big [121.760294] Starting dynamic subtest: A-eDP1 [123.519504] Dynamic subtest A-eDP1: SUCCESS (1.784s) [123.529649] Starting dynamic subtest: B-eDP1 [125.250150] Dynamic subtest B-eDP1: SUCCESS (1.748s) [125.260385] Starting dynamic subtest: C-eDP1 [126.949648] Dynamic subtest C-eDP1: SUCCESS (1.713s) [126.959196] Starting dynamic subtest: D-eDP1 [128.665801] Dynamic subtest D-eDP1: SUCCESS (1.727s) [128.668369] Subtest bo-too-big: SUCCESS (6.976s) [129.908114] [017/130] (903s left) kms_sequence (queue-idle) [129.999919] Starting subtest: queue-idle [130.002172] Starting dynamic subtest: pipe-A-eDP-1 [131.805768] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s) [131.815130] Starting dynamic subtest: pipe-B-eDP-1 [134.270383] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.472s) [134.279984] Starting dynamic subtest: pipe-C-eDP-1 [136.665788] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.401s) [136.675412] Starting dynamic subtest: pipe-D-eDP-1 [139.082944] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s) [139.085303] Subtest queue-idle: SUCCESS (9.108s) [139.886912] [018/130] (893s left) kms_psr (fbc-psr-cursor-plane-move) [139.989204] Starting subtest: fbc-psr-cursor-plane-move [139.991544] Starting dynamic subtest: eDP-1 [139.995875] Dynamic subtest eDP-1: SKIP (0.000s) [140.000178] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [140.053564] [019/130] (893s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [140.155746] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [140.160243] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [140.259741] [020/130] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [140.369771] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [140.374186] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [140.465176] [021/130] (892s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [140.565441] Starting subtest: addfb25-yf-tiled-legacy [140.567394] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [140.650785] [022/130] (892s left) drm_fdinfo (most-busy-check-all) [140.690242] Starting subtest: most-busy-check-all [140.692582] Starting dynamic subtest: rcs0 [140.697775] Dynamic subtest rcs0: SKIP (0.004s) [140.707852] Starting dynamic subtest: bcs0 [140.711966] Dynamic subtest bcs0: SKIP (0.000s) [140.719529] Starting dynamic subtest: vcs0 [140.723919] Dynamic subtest vcs0: SKIP (0.000s) [140.731257] Starting dynamic subtest: vcs1 [140.735691] Dynamic subtest vcs1: SKIP (0.000s) [140.742939] Starting dynamic subtest: vecs0 [140.747329] Dynamic subtest vecs0: SKIP (0.000s) [140.754943] Starting dynamic subtest: ccs0 [140.759234] Dynamic subtest ccs0: SKIP (0.000s) [140.763397] Subtest most-busy-check-all: SKIP (0.006s) [140.791418] [023/130] (892s left) syncobj_wait (multi-wait-all-submitted) [140.885682] Starting subtest: multi-wait-all-submitted [140.994031] Subtest multi-wait-all-submitted: SUCCESS (0.106s) [141.068599] [024/130] (892s left) gem_ctx_persistence (legacy-engines-cleanup) [141.132632] Starting subtest: legacy-engines-cleanup [141.135368] Starting dynamic subtest: render [141.244558] Dynamic subtest render: SUCCESS (0.111s) [141.255836] Starting dynamic subtest: bsd1 [141.269834] Dynamic subtest bsd1: SUCCESS (0.024s) [141.277814] Starting dynamic subtest: bsd2 [141.376067] Dynamic subtest bsd2: SUCCESS (0.105s) [141.387153] Starting dynamic subtest: blt [141.444930] Dynamic subtest blt: SUCCESS (0.068s) [141.455450] Starting dynamic subtest: vebox [141.468654] Dynamic subtest vebox: SUCCESS (0.023s) [141.471032] Subtest legacy-engines-cleanup: SUCCESS (0.337s) [141.608328] [025/130] (891s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [146.619510] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [146.624212] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s) [147.478554] [026/130] (885s left) gem_pread (exhaustion) [147.533740] Subtest exhaustion: SKIP (0.000s) [147.591675] [027/130] (885s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [147.695519] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [147.707743] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s) [147.777948] [028/130] (885s left) gem_ctx_param (invalid-get-no-zeromap) [147.826406] Starting subtest: invalid-get-no-zeromap [147.828741] Subtest invalid-get-no-zeromap: SUCCESS (0.002s) [147.929684] [029/130] (885s left) kms_joiner (invalid-modeset-force-ultra-joiner) [148.031983] Starting subtest: invalid-modeset-force-ultra-joiner [148.036593] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [148.092096] [030/130] (885s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [148.185927] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [148.188090] Starting dynamic subtest: pipe-A-eDP-1 [148.210040] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [148.217870] Starting dynamic subtest: pipe-B-eDP-1 [148.239650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [148.247638] Starting dynamic subtest: pipe-C-eDP-1 [148.269878] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [148.279102] Starting dynamic subtest: pipe-D-eDP-1 [148.301159] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [148.305536] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s) [150.332354] [031/130] (883s left) sysfs_timeslice_duration (idempotent) [150.387384] Starting subtest: idempotent [150.389652] Starting dynamic subtest: vecs0 [150.391930] Dynamic subtest vecs0: SUCCESS (0.000s) [150.400367] Starting dynamic subtest: ccs0 [150.402522] Dynamic subtest ccs0: SUCCESS (0.000s) [150.410190] Starting dynamic subtest: vcs0 [150.412288] Dynamic subtest vcs0: SUCCESS (0.000s) [150.419995] Starting dynamic subtest: bcs0 [150.422185] Dynamic subtest bcs0: SUCCESS (0.000s) [150.429718] Starting dynamic subtest: rcs0 [150.431880] Dynamic subtest rcs0: SUCCESS (0.000s) [150.439215] Starting dynamic subtest: vcs1 [150.440983] Dynamic subtest vcs1: SUCCESS (0.000s) [150.442849] Subtest idempotent: SUCCESS (0.003s) [150.487240] [032/130] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [150.589285] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [155.894825] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.309s) [156.016922] [033/130] (877s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [156.128479] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [156.132723] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [156.227685] [034/130] (877s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [156.288436] Starting subtest: yf-tiled-to-vebox-y-tiled [156.293058] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [156.464728] [035/130] (877s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [156.561004] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [156.563320] Starting dynamic subtest: A-eDP1 [160.203712] Dynamic subtest A-eDP1: SUCCESS (3.640s) [160.216486] Starting dynamic subtest: B-eDP1 [163.397996] Dynamic subtest B-eDP1: SUCCESS (3.193s) [163.406091] Starting dynamic subtest: C-eDP1 [166.456076] Dynamic subtest C-eDP1: SUCCESS (3.060s) [166.465685] Starting dynamic subtest: D-eDP1 [169.535310] Dynamic subtest D-eDP1: SUCCESS (3.078s) [169.537137] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.977s) [170.322812] [036/130] (863s left) kms_cursor_edge_walk (128x128-top-edge) [170.429703] Starting subtest: 128x128-top-edge [170.431919] Starting dynamic subtest: pipe-A-eDP-1 [173.876808] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s) [173.884934] Starting dynamic subtest: pipe-D-eDP-1 [176.989207] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s) [176.991180] Subtest 128x128-top-edge: SUCCESS (6.558s) [177.801436] [037/130] (855s left) dmabuf_sync_file (export-before-signal) [177.843738] Starting subtest: export-before-signal [177.846030] Subtest export-before-signal: SUCCESS (0.001s) [177.897290] [038/130] (855s left) kms_dsc (dsc-with-formats) [177.987409] Starting subtest: dsc-with-formats [178.027268] Subtest dsc-with-formats: SKIP (0.001s) [178.058253] [039/130] (855s left) device_reset (cold-reset-bound) [178.105198] Starting subtest: cold-reset-bound [178.109738] Subtest cold-reset-bound: SKIP (0.000s) [178.171441] [040/130] (855s left) i915_pm_rc6_residency (rc6-accuracy) [178.225573] Starting subtest: rc6-accuracy [178.227569] Starting dynamic subtest: gt0 [181.397171] Dynamic subtest gt0: SUCCESS (3.170s) [181.406799] Starting dynamic subtest: gt1 [184.568008] Dynamic subtest gt1: SUCCESS (3.170s) [184.570559] Subtest rc6-accuracy: SUCCESS (6.343s) [184.636380] [041/130] (849s left) kms_color (ctm-0-75) [184.737164] Starting subtest: ctm-0-75 [184.739485] Starting dynamic subtest: pipe-A-eDP-1 [189.490906] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.754s) [189.500404] Starting dynamic subtest: pipe-B-eDP-1 [194.910066] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.421s) [194.920258] Starting dynamic subtest: pipe-C-eDP-1 [200.170831] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.263s) [200.180406] Starting dynamic subtest: pipe-D-eDP-1 [205.435006] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.265s) [205.437490] Subtest ctm-0-75: SUCCESS (20.705s) [206.291004] [042/130] (827s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [206.398496] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [206.400923] Starting dynamic subtest: pipe-A-eDP-1 [207.295973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.888s) [207.305103] Starting dynamic subtest: pipe-B-eDP-1 [208.836650] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.539s) [208.844478] Starting dynamic subtest: pipe-C-eDP-1 [210.294340] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.455s) [210.304907] Starting dynamic subtest: pipe-D-eDP-1 [211.716075] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.420s) [211.718604] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.306s) [212.892779] [043/130] (820s left) gem_mmap_wc (write-read-distinct) [212.943554] Subtest write-read-distinct: SKIP (0.000s) [212.998672] [044/130] (820s left) kms_atomic (plane-immutable-zpos) [213.101190] Starting subtest: plane-immutable-zpos [213.103369] Starting dynamic subtest: pipe-A-eDP-1 [213.755248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.650s) [213.757574] Subtest plane-immutable-zpos: SUCCESS (0.651s) [214.619151] [045/130] (819s left) kms_chamelium_frames (dp-frame-dump) [215.009244] Subtest dp-frame-dump: SKIP (0.000s) [215.819719] [046/130] (818s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [215.926759] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [215.931024] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [216.036293] [047/130] (817s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [216.086621] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [216.194112] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s) [216.270362] [048/130] (817s left) kms_cursor_crc (cursor-onscreen-max-size) [216.545909] Starting subtest: cursor-onscreen-max-size [216.554333] Subtest cursor-onscreen-max-size: SKIP (0.000s) [216.676345] [049/130] (817s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [221.690506] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [221.694985] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s) [222.543458] [050/130] (811s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [222.640255] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [227.270022] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.631s) [227.365031] [051/130] (806s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [227.471286] Starting subtest: yf-tiled-64bpp-rotate-270 [227.475804] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [227.560889] [052/130] (806s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [227.648510] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [227.650802] Starting dynamic subtest: pipe-A-default-mode [230.298243] Dynamic subtest pipe-A-default-mode: SUCCESS (2.646s) [230.300609] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.648s) [231.167674] [053/130] (803s left) syncobj_wait (invalid-wait-illegal-handle) [231.221133] Starting subtest: invalid-wait-illegal-handle [231.223461] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [231.317608] [054/130] (802s left) kms_vblank (query-idle-hang) [231.409979] Starting subtest: query-idle-hang [231.411803] Starting dynamic subtest: pipe-A-eDP-1 [257.450916] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.041s) [257.463941] Starting dynamic subtest: pipe-D-eDP-1 [282.417530] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.967s) [282.419809] Subtest query-idle-hang: SUCCESS (51.012s) [283.211744] [055/130] (751s left) gem_exec_whisper (basic-fds-priority-all) [283.270682] Starting subtest: basic-fds-priority-all [305.230284] Subtest basic-fds-priority-all: SUCCESS (21.962s) [305.410177] [056/130] (728s left) kms_busy (extended-modeset-hang-newfb) [305.508514] Starting subtest: extended-modeset-hang-newfb [305.510652] Starting dynamic subtest: pipe-A [339.521406] Dynamic subtest pipe-A: SUCCESS (34.017s) [339.530002] Starting dynamic subtest: pipe-D [362.498029] Dynamic subtest pipe-D: SUCCESS (22.965s) [362.500372] Subtest extended-modeset-hang-newfb: SUCCESS (56.988s) [363.280757] [057/130] (671s left) kms_plane (plane-panning-top-left) [363.385310] Starting subtest: plane-panning-top-left [363.387632] Starting dynamic subtest: pipe-A [365.025700] Dynamic subtest pipe-A: SUCCESS (1.638s) [365.034779] Starting dynamic subtest: pipe-B [367.268178] Dynamic subtest pipe-B: SUCCESS (2.242s) [367.270600] Subtest plane-panning-top-left: SUCCESS (3.882s) [368.086058] [058/130] (666s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [368.198348] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [368.202362] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [368.310246] [059/130] (666s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [368.399852] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [368.404313] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [369.506881] [060/130] (664s left) gem_exec_balancer (parallel-out-fence) [369.751195] Starting subtest: parallel-out-fence [370.794047] Subtest parallel-out-fence: SUCCESS (1.043s) [370.898489] [061/130] (663s left) gem_exec_schedule (preempt-queue-contexts-chain) [370.976854] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [371.259090] [062/130] (663s left) gem_mmap_wc (write-gtt-read-wc) [371.309027] Subtest write-gtt-read-wc: SKIP (0.000s) [371.369642] [063/130] (663s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [376.368242] Starting subtest: pr-plane-move-sf-dmg-area [376.373368] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s) [377.202082] [064/130] (657s left) kms_pipe_crc_basic (bad-source) [377.304632] Starting subtest: bad-source [377.306534] Subtest bad-source: SUCCESS (0.000s) [377.374975] [065/130] (657s left) api_intel_allocator (execbuf-with-allocator) [377.437859] Starting subtest: execbuf-with-allocator [377.444184] Subtest execbuf-with-allocator: SUCCESS (0.008s) [377.592784] [066/130] (657s left) kms_psr (psr2-primary-mmap-gtt) [377.694180] Starting subtest: psr2-primary-mmap-gtt [377.696496] Starting dynamic subtest: eDP-1 [379.093924] Dynamic subtest eDP-1: SKIP (1.394s) [379.099172] Subtest psr2-primary-mmap-gtt: SKIP (1.395s) [379.228593] [067/130] (655s left) gem_workarounds (suspend-resume-fd) [379.303932] Starting subtest: suspend-resume-fd [395.362805] Subtest suspend-resume-fd: SUCCESS (1.198s) [395.492970] [068/130] (654s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [395.596947] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [395.601139] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [395.708238] [069/130] (653s left) gem_exec_create (forked) [395.775859] Starting subtest: forked [395.778323] Starting dynamic subtest: smem [415.972117] Dynamic subtest smem: SUCCESS (20.479s) [415.974559] Subtest forked: SUCCESS (20.481s) [416.159417] [070/130] (633s left) kms_addfb_basic (bo-too-small-due-to-tiling) [416.264171] Starting subtest: bo-too-small-due-to-tiling [416.268747] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [416.383237] [071/130] (633s left) prime_vgem (shrink) [416.475202] Starting subtest: shrink [416.499160] Subtest shrink: SUCCESS (0.024s) [416.618550] [072/130] (632s left) gem_mmap_gtt (medium-copy-xy) [416.674863] Subtest medium-copy-XY: SKIP (0.000s) [416.745845] [073/130] (632s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [416.842398] Starting subtest: bad-aux-stride-y-tiled-ccs [416.844858] Starting dynamic subtest: pipe-A-eDP-1 [416.868029] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [416.878244] Starting dynamic subtest: pipe-B-eDP-1 [416.900112] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [416.908066] Starting dynamic subtest: pipe-C-eDP-1 [416.929387] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [416.937232] Starting dynamic subtest: pipe-D-eDP-1 [416.960722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [416.965331] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s) [418.982814] [074/130] (630s left) kms_psr (pr-dpms) [419.086845] Starting subtest: pr-dpms [419.091111] Subtest pr-dpms: SKIP (0.000s) [419.155354] [075/130] (630s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [419.262222] Starting subtest: plane-upscale-factor-0-25-with-modifiers [419.264838] Starting dynamic subtest: pipe-A [419.597112] Dynamic subtest pipe-A: SUCCESS (0.338s) [419.606190] Starting dynamic subtest: pipe-B [420.964583] Dynamic subtest pipe-B: SUCCESS (1.370s) [420.972851] Starting dynamic subtest: pipe-C [422.393656] Dynamic subtest pipe-C: SUCCESS (1.430s) [422.406738] Starting dynamic subtest: pipe-D [423.817320] Dynamic subtest pipe-D: SUCCESS (1.425s) [423.820037] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.567s) [424.980024] [076/130] (624s left) sw_sync (alloc_timeline) [425.018398] Starting subtest: alloc_timeline [425.020643] Subtest alloc_timeline: SUCCESS (0.000s) [425.071589] [077/130] (624s left) gem_exec_fence (basic-await) [425.262451] Starting subtest: basic-await [425.265030] Starting dynamic subtest: rcs0 [425.342674] Dynamic subtest rcs0: SUCCESS (0.080s) [425.355741] Starting dynamic subtest: bcs0 [425.423393] Dynamic subtest bcs0: SUCCESS (0.079s) [425.434973] Starting dynamic subtest: vcs0 [425.500847] Dynamic subtest vcs0: SUCCESS (0.076s) [425.512230] Starting dynamic subtest: vcs1 [425.578761] Dynamic subtest vcs1: SUCCESS (0.077s) [425.589240] Starting dynamic subtest: vecs0 [425.654697] Dynamic subtest vecs0: SUCCESS (0.075s) [425.665960] Starting dynamic subtest: ccs0 [425.731378] Dynamic subtest ccs0: SUCCESS (0.076s) [425.733908] Subtest basic-await: SUCCESS (0.470s) [427.600401] [078/130] (622s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [427.739048] Starting subtest: flip-vs-cursor-atomic-transitions [435.039318] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.295s) [435.903426] [079/130] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [436.006905] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [439.705084] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.701s) [439.870329] [080/130] (609s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [439.963927] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [439.965974] Starting dynamic subtest: pipe-A-default-mode [440.250561] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [440.255305] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.284s) [441.047273] [081/130] (608s left) i915_query (query-topology-known-pci-ids) [441.102729] Starting subtest: query-topology-known-pci-ids [441.106817] Subtest query-topology-known-pci-ids: SKIP (0.000s) [441.184306] [082/130] (608s left) syncobj_timeline (etime-multi-wait-submitted) [441.231205] Starting subtest: etime-multi-wait-submitted [441.335801] Subtest etime-multi-wait-submitted: SUCCESS (0.104s) [441.407295] [083/130] (608s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [441.509585] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [446.351071] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.844s) [446.473444] [084/130] (603s left) i915_hangman (detector) [446.544196] Starting subtest: detector [446.546498] Starting dynamic subtest: rcs0 [458.522070] Dynamic subtest rcs0: SUCCESS (11.976s) [458.532654] Starting dynamic subtest: bcs0 [470.490357] Dynamic subtest bcs0: SUCCESS (11.968s) [470.501860] Starting dynamic subtest: vcs0 [482.480589] Dynamic subtest vcs0: SUCCESS (11.967s) [482.491672] Starting dynamic subtest: vcs1 [493.466744] Dynamic subtest vcs1: SUCCESS (11.012s) [493.478302] Starting dynamic subtest: vecs0 [505.435275] Dynamic subtest vecs0: SUCCESS (11.961s) [505.448217] Starting dynamic subtest: ccs0 [516.506162] Dynamic subtest ccs0: SUCCESS (11.066s) [516.508831] Subtest detector: SUCCESS (69.964s) [516.583589] [085/130] (533s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [516.682775] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [516.685104] Starting dynamic subtest: pipe-A [518.238882] Dynamic subtest pipe-A: SUCCESS (1.555s) [518.248401] Starting dynamic subtest: pipe-B [520.771753] Dynamic subtest pipe-B: SUCCESS (2.532s) [520.780585] Starting dynamic subtest: pipe-C [522.014142] Dynamic subtest pipe-C: SUCCESS (1.241s) [522.029201] Starting dynamic subtest: pipe-D [523.223573] Dynamic subtest pipe-D: SUCCESS (1.209s) [523.225808] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.540s) [524.409923] [086/130] (525s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [524.469094] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [524.473623] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [524.646900] [087/130] (525s left) gem_lmem_swapping (heavy-verify-random-ccs) [524.691063] Subtest heavy-verify-random-ccs: SKIP (0.000s) [524.732173] [088/130] (525s left) gem_ctx_param (basic-default) [524.786432] Starting subtest: basic-default [524.788909] Subtest basic-default: SUCCESS (0.000s) [524.857077] [089/130] (525s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [524.970351] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [527.936261] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.969s) [528.102806] [090/130] (522s left) kms_psr (fbc-pr-cursor-mmap-gtt) [528.209883] Starting subtest: fbc-pr-cursor-mmap-gtt [528.213721] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [528.276375] [091/130] (521s left) kms_vrr (seamless-rr-switch-drrs) [528.375690] Starting subtest: seamless-rr-switch-drrs [528.381186] Subtest seamless-rr-switch-drrs: SKIP (0.000s) [528.449330] [092/130] (521s left) kms_getfb (getfb2-into-addfb2) [528.503230] Starting subtest: getfb2-into-addfb2 [528.505298] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [528.615179] [093/130] (521s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [528.717307] Starting subtest: 2x-flip-vs-blocking-wf-vblank [528.727786] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s) [528.801401] [094/130] (521s left) gem_ctx_isolation (nonpriv-switch) [528.867028] Starting subtest: nonpriv-switch [528.869364] Starting dynamic subtest: rcs0 [529.474817] Dynamic subtest rcs0: SUCCESS (0.607s) [529.486070] Starting dynamic subtest: bcs0 [530.070928] Dynamic subtest bcs0: SUCCESS (0.595s) [530.079442] Starting dynamic subtest: vcs0 [530.711276] Dynamic subtest vcs0: SUCCESS (0.640s) [530.722273] Starting dynamic subtest: vcs1 [532.155669] Dynamic subtest vcs1: SUCCESS (1.443s) [532.166625] Starting dynamic subtest: vecs0 [534.190205] Dynamic subtest vecs0: SUCCESS (2.035s) [534.201352] Starting dynamic subtest: ccs0 [536.173813] Dynamic subtest ccs0: SUCCESS (1.983s) [536.176432] Subtest nonpriv-switch: SUCCESS (7.307s) [536.432358] [095/130] (513s left) gem_softpin (safe-alignment) [536.501263] Starting subtest: safe-alignment [536.537695] Subtest safe-alignment: SUCCESS (0.037s) [538.592601] [096/130] (511s left) drm_read (empty-block) [538.779905] Starting subtest: empty-block [539.782296] Subtest empty-block: SUCCESS (1.001s) [539.933468] [097/130] (510s left) gem_mmap_wc (bad-size) [539.992465] Subtest bad-size: SKIP (0.000s) [540.049869] [098/130] (510s left) kms_addfb_basic (bad-pitch-63) [540.106521] Starting subtest: bad-pitch-63 [540.108958] Subtest bad-pitch-63: SUCCESS (0.000s) [540.255717] [099/130] (510s left) gem_exec_schedule (thriceslice) [540.335558] Starting subtest: thriceslice [540.337651] Starting dynamic subtest: rcs0 [540.353741] Dynamic subtest rcs0: SUCCESS (0.029s) [540.365154] Starting dynamic subtest: bcs0 [540.380876] Dynamic subtest bcs0: SUCCESS (0.027s) [540.389947] Starting dynamic subtest: vcs0 [540.409112] Dynamic subtest vcs0: SUCCESS (0.027s) [540.418158] Starting dynamic subtest: vcs1 [540.437123] Dynamic subtest vcs1: SUCCESS (0.027s) [540.446283] Starting dynamic subtest: vecs0 [540.465757] Dynamic subtest vecs0: SUCCESS (0.027s) [540.477761] Starting dynamic subtest: ccs0 [540.495032] Dynamic subtest ccs0: SUCCESS (0.029s) [540.497602] Subtest thriceslice: SUCCESS (0.171s) [541.596356] [100/130] (508s left) gem_exec_reloc (basic-cpu-active) [541.662622] Subtest basic-cpu-active: SKIP (0.000s) [541.738727] [101/130] (508s left) gem_exec_params (secure-non-root) [541.800435] Starting subtest: secure-non-root [541.804964] Subtest secure-non-root: SKIP (0.000s) [541.906088] [102/130] (508s left) prime_vgem (basic-write) [541.989920] Starting subtest: basic-write [542.001625] Subtest basic-write: SKIP (0.010s) [542.110113] [103/130] (508s left) syncobj_timeline (wait-all-delayed-signal) [542.171441] Starting subtest: wait-all-delayed-signal [542.276059] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [542.353145] [104/130] (508s left) kms_flip (nonblocking-read) [542.442239] Starting subtest: nonblocking-read [542.444431] Subtest nonblocking-read: SUCCESS (0.000s) [542.558198] [105/130] (508s left) kms_pm_lpsp (kms-lpsp) [543.658946] Starting subtest: kms-lpsp [543.660807] Starting dynamic subtest: pipe-A-eDP-1 [543.819128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.161s) [544.101185] Subtest kms-lpsp: SUCCESS (0.443s) [544.954085] [106/130] (505s left) gem_flink_basic (bad-flink) [545.016653] Starting subtest: bad-flink [545.018621] Subtest bad-flink: SUCCESS (0.000s) [545.111025] [107/130] (505s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [545.223596] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [545.228061] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [545.329478] [108/130] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [545.426784] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [550.221845] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.799s) [550.339957] [109/130] (500s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [550.436822] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [550.439180] Starting dynamic subtest: pipe-A-eDP-1 [550.463870] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [550.472119] Starting dynamic subtest: pipe-B-eDP-1 [550.495878] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [550.504439] Starting dynamic subtest: pipe-C-eDP-1 [550.528236] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [550.536331] Starting dynamic subtest: pipe-D-eDP-1 [550.560638] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [550.565093] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s) [552.537559] [110/130] (498s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [552.638186] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [553.606595] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.968s) [553.758458] [111/130] (497s left) kms_big_fb (x-tiled-16bpp-rotate-180) [553.861187] Starting subtest: x-tiled-16bpp-rotate-180 [555.314440] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.455s) [555.443592] [112/130] (495s left) gem_sync (basic-store-all) [555.518213] Starting subtest: basic-store-all [559.352357] Subtest basic-store-all: SUCCESS (3.840s) [559.532614] [113/130] (491s left) kms_chamelium_hpd (hdmi-hpd) [559.914783] Subtest hdmi-hpd: SKIP (0.000s) [560.735062] [114/130] (490s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [560.838254] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [560.842201] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [560.952407] [115/130] (490s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc) [561.062788] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc [565.620840] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.561s) [565.749901] [116/130] (485s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [565.846061] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [565.848298] Starting dynamic subtest: pipe-A-default-mode [566.134366] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [566.138818] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.284s) [566.934274] [117/130] (484s left) kms_big_fb (y-tiled-8bpp-rotate-90) [567.042673] Starting subtest: y-tiled-8bpp-rotate-90 [567.047082] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [567.156546] [118/130] (483s left) kms_plane_alpha_blend (alpha-7efc) [567.257067] Starting subtest: alpha-7efc [567.662086] Starting dynamic subtest: pipe-A-eDP-1 [568.191132] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.527s) [568.212726] Starting dynamic subtest: pipe-D-eDP-1 [569.528390] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s) [569.530767] Subtest alpha-7efc: SUCCESS (2.270s) [570.388051] [119/130] (480s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [570.492859] Starting subtest: psr-shrfb-scaledprimary [574.163486] Subtest psr-shrfb-scaledprimary: SUCCESS (3.674s) [574.281011] [120/130] (476s left) gem_request_retire (retire-vma-not-inactive) [574.348724] Starting subtest: retire-vma-not-inactive [574.408441] Subtest retire-vma-not-inactive: SUCCESS (0.056s) [574.532778] [121/130] (476s left) kms_properties (plane-properties-legacy) [574.630233] Starting subtest: plane-properties-legacy [574.632562] Starting dynamic subtest: pipe-A-eDP-1 [575.194475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s) [575.203814] Starting dynamic subtest: pipe-B-eDP-1 [576.487822] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.290s) [576.496574] Starting dynamic subtest: pipe-C-eDP-1 [577.695676] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s) [577.704160] Starting dynamic subtest: pipe-D-eDP-1 [578.929071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s) [578.931434] Subtest plane-properties-legacy: SUCCESS (4.299s) [579.715907] [122/130] (471s left) kms_cursor_legacy (cursor-vs-flip-atomic) [579.832977] Starting subtest: cursor-vs-flip-atomic [609.277049] Subtest cursor-vs-flip-atomic: SUCCESS (29.451s) [610.134194] [123/130] (441s left) gem_mmap_gtt (hang-user) [610.190731] Subtest hang-user: SKIP (0.000s) [610.240182] [124/130] (441s left) gem_ccs (large-ctrl-surf-copy) [610.298351] Starting subtest: large-ctrl-surf-copy [610.303072] Subtest large-ctrl-surf-copy: SKIP (0.000s) [610.387887] [125/130] (440s left) kms_psr (psr-basic) [610.484346] Starting subtest: psr-basic [610.486729] Starting dynamic subtest: eDP-1 [612.115155] Dynamic subtest eDP-1: SUCCESS (1.630s) [612.117509] Subtest psr-basic: SUCCESS (1.631s) [612.984204] [126/130] (438s left) kms_cursor_crc (cursor-alpha-transparent) [613.079911] Starting subtest: cursor-alpha-transparent [613.082336] Starting dynamic subtest: pipe-A-eDP-1 [613.716095] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s) [613.724652] Starting dynamic subtest: pipe-D-eDP-1 [614.969413] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s) [614.971829] Subtest cursor-alpha-transparent: SUCCESS (1.889s) [615.829366] [127/130] (435s left) i915_pm_rps (reset) [615.892540] Starting subtest: reset [615.971494] Subtest reset: FAIL (0.011s) [616.040113] [128/130] (435s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [616.136758] Starting subtest: basic-max-pipe-crc-check [616.141131] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [616.180305] [129/130] (435s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [616.238197] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [616.240537] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [616.354943] [130/130] (435s left) perf (invalid-create-userspace-config) [616.470600] Starting subtest: invalid-create-userspace-config [616.472482] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [616.503068] Closing watchdogs Done.