[58.847281] Initializing watchdogs [58.847418] /dev/watchdog0 [58.862474] [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] [58.866531] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.868756] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.872039] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [58.991705] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [58.996199] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [59.115971] [002/131] (960s left) gem_exec_fence (submit3) [59.286043] Starting subtest: submit3 [59.290659] Subtest submit3: SKIP (0.000s) [61.023947] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [61.027388] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [61.128940] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [61.133124] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [61.258244] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [61.366532] Starting subtest: fbc-rgb101010-draw-mmap-wc [65.995787] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.633s) [67.173733] [005/131] (952s left) gem_exec_balancer (noheartbeat) [67.590859] Starting subtest: noheartbeat [67.596262] Subtest noheartbeat: SKIP (0.000s) [67.700752] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [67.864292] Subtest ctm-blue-to-red: SKIP (0.000s) [67.950586] [007/131] (951s left) gem_workarounds (suspend-resume) [68.043967] Starting subtest: suspend-resume [84.168244] Subtest suspend-resume: SUCCESS (4.730s) [84.322007] [008/131] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [84.420679] Starting subtest: planes-downscale-factor-0-75-unity-scaling [84.423310] Starting dynamic subtest: pipe-A [84.484347] Dynamic subtest pipe-A: SUCCESS (0.065s) [84.493467] Starting dynamic subtest: pipe-B [85.633358] Dynamic subtest pipe-B: SUCCESS (1.148s) [85.647011] Starting dynamic subtest: pipe-C [86.754085] Dynamic subtest pipe-C: SUCCESS (1.120s) [86.762386] Starting dynamic subtest: pipe-D [87.887858] Dynamic subtest pipe-D: SUCCESS (1.133s) [87.890666] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.468s) [89.082609] [009/131] (930s left) gem_pxp (create-regular-buffer) [89.213421] Starting subtest: create-regular-buffer [89.216482] Subtest create-regular-buffer: SUCCESS (0.000s) [89.365865] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [89.417365] Starting subtest: rel-constants-invalid-rel-gen5 [89.420315] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [89.530209] [011/131] (930s left) gem_exec_nop (basic-series) [89.608351] Starting subtest: basic-series [106.327825] Subtest basic-series: SUCCESS (16.729s) [106.599526] [012/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [106.708691] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [106.713696] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [106.819424] [013/131] (913s left) kms_psr (fbc-psr-primary-page-flip) [106.913250] Starting subtest: fbc-psr-primary-page-flip [106.915626] Starting dynamic subtest: eDP-1 [106.920462] Dynamic subtest eDP-1: SKIP (0.000s) [106.925404] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [107.017001] [014/131] (912s left) i915_pm_rps (engine-order) [107.095278] Starting subtest: engine-order [111.968300] Subtest engine-order: SUCCESS (4.873s) [112.121565] [015/131] (907s left) gem_softpin (evict-active) [112.213062] Starting subtest: evict-active [112.222402] Subtest evict-active: SUCCESS (0.009s) [112.365040] [016/131] (907s left) syncobj_timeline (wait-delayed-signal) [112.423495] Starting subtest: wait-delayed-signal [112.526514] Subtest wait-delayed-signal: SUCCESS (0.103s) [112.631632] [017/131] (907s left) kms_panel_fitting (atomic-fastset) [112.723330] Starting subtest: atomic-fastset [112.726343] Starting dynamic subtest: pipe-A-eDP-1 [112.866499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s) [112.877949] Starting dynamic subtest: pipe-B-eDP-1 [114.114871] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s) [114.124160] Starting dynamic subtest: pipe-C-eDP-1 [115.304727] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.188s) [115.319287] Starting dynamic subtest: pipe-D-eDP-1 [116.453355] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.147s) [116.456331] Subtest atomic-fastset: SUCCESS (3.731s) [117.717470] [018/131] (902s left) kms_big_fb (x-tiled-16bpp-rotate-270) [117.828944] Starting subtest: x-tiled-16bpp-rotate-270 [117.847753] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [118.013076] [019/131] (902s left) api_intel_bb (render-ccs) [118.080735] Starting subtest: render-ccs [118.452843] Subtest render-ccs: SUCCESS (0.373s) [118.563626] [020/131] (901s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [118.664289] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [118.667200] Starting dynamic subtest: pipe-A-eDP-1 [118.693555] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [118.703518] Starting dynamic subtest: pipe-B-eDP-1 [118.729287] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [118.737490] Starting dynamic subtest: pipe-C-eDP-1 [118.762530] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [118.770485] Starting dynamic subtest: pipe-D-eDP-1 [118.796606] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [118.801429] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [120.888946] [021/131] (899s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [120.953363] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [121.054575] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [121.155982] [022/131] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [121.261327] Starting subtest: psr-2p-primscrn-cur-indfb-move [121.266394] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [121.381368] [023/131] (898s left) gem_lmem_swapping (heavy-multi) [121.425339] Subtest heavy-multi: SKIP (0.000s) [121.466650] [024/131] (898s left) kms_async_flips (test-cursor) [121.562249] Starting subtest: test-cursor [121.567297] Subtest test-cursor: SKIP (0.000s) [122.812398] [025/131] (897s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [127.885475] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [127.888368] Starting dynamic subtest: pipe-A-eDP-1 [128.675850] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s) [128.686334] Starting dynamic subtest: pipe-B-eDP-1 [129.803353] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [129.809074] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.916s) [131.016552] [026/131] (889s left) kms_plane_multiple (2x-tiling-4) [131.120768] Starting subtest: 2x-tiling-4 [131.126030] Subtest 2x-tiling-4: SKIP (0.000s) [131.220972] [027/131] (889s left) gem_ctx_param (invalid-param-set) [131.283119] Starting subtest: invalid-param-set [131.285790] Subtest invalid-param-set: SUCCESS (0.000s) [131.379684] [028/131] (889s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [131.482615] Starting subtest: bad-pixel-format-y-tiled-ccs [131.484986] Starting dynamic subtest: pipe-A-eDP-1 [131.510645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [131.520281] Starting dynamic subtest: pipe-B-eDP-1 [131.546030] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [131.555100] Starting dynamic subtest: pipe-C-eDP-1 [131.582267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [131.591250] Starting dynamic subtest: pipe-D-eDP-1 [131.617376] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [131.623438] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [133.769209] [029/131] (886s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [133.866723] Starting subtest: plane-downscale-factor-0-5-with-modifiers [133.869292] Starting dynamic subtest: pipe-A [133.889180] Dynamic subtest pipe-A: SKIP (0.015s) [133.899025] Starting dynamic subtest: pipe-B [133.918368] Dynamic subtest pipe-B: SKIP (0.028s) [133.927428] Starting dynamic subtest: pipe-C [133.944143] Dynamic subtest pipe-C: SKIP (0.028s) [133.952653] Starting dynamic subtest: pipe-D [133.971469] Dynamic subtest pipe-D: SKIP (0.028s) [133.975810] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.100s) [134.093160] [030/131] (886s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [134.149474] Starting subtest: multi-wait-all-available-submitted-signaled [134.152378] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [134.284834] [031/131] (886s left) perf (missing-sample-flags) [134.433434] Starting subtest: missing-sample-flags [134.436206] Subtest missing-sample-flags: SUCCESS (0.000s) [134.479374] [032/131] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [134.569321] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [140.703797] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.138s) [141.861508] [033/131] (878s left) kms_pm_rpm (system-suspend-idle) [143.523114] Starting subtest: system-suspend-idle [163.372940] Subtest system-suspend-idle: SUCCESS (4.293s) [163.766899] [034/131] (857s left) kms_vblank (wait-forked) [163.879736] Starting subtest: wait-forked [163.882549] Starting dynamic subtest: pipe-A-eDP-1 [165.693360] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s) [165.710863] Starting dynamic subtest: pipe-D-eDP-1 [168.221188] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s) [168.223709] Subtest wait-forked: SUCCESS (4.339s) [169.120942] [035/131] (851s left) kms_big_fb (y-tiled-32bpp-rotate-0) [169.235298] Starting subtest: y-tiled-32bpp-rotate-0 [169.240701] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [169.362567] [036/131] (851s left) kms_pipe_crc_basic (read-crc) [169.452763] Starting subtest: read-crc [169.455294] Starting dynamic subtest: pipe-A-eDP-1 [170.161913] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [170.172813] Starting dynamic subtest: pipe-B-eDP-1 [171.556610] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s) [171.567479] Starting dynamic subtest: pipe-C-eDP-1 [172.862579] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s) [172.873748] Starting dynamic subtest: pipe-D-eDP-1 [174.193821] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [174.196489] Subtest read-crc: SUCCESS (4.738s) [175.055818] [037/131] (845s left) kms_cursor_legacy (single-move) [175.176393] Starting subtest: single-move [175.178845] Starting dynamic subtest: pipe-A [180.610137] Dynamic subtest pipe-A: SUCCESS (5.379s) [180.621601] Starting dynamic subtest: pipe-B [185.990849] Dynamic subtest pipe-B: SUCCESS (5.380s) [186.002894] Starting dynamic subtest: pipe-C [191.373388] Dynamic subtest pipe-C: SUCCESS (5.380s) [191.384748] Starting dynamic subtest: pipe-D [196.754989] Dynamic subtest pipe-D: SUCCESS (5.379s) [196.766320] Starting dynamic subtest: all-pipes [202.144032] Dynamic subtest all-pipes: SUCCESS (5.386s) [202.147219] Subtest single-move: SUCCESS (26.913s) [202.261701] [038/131] (818s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [207.287485] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [207.292802] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [208.162610] [039/131] (812s left) gem_unref_active_buffers [208.363925] [040/131] (812s left) kms_psr (fbc-psr2-primary-mmap-gtt) [208.460915] Starting subtest: fbc-psr2-primary-mmap-gtt [208.463215] Starting dynamic subtest: eDP-1 [208.468536] Dynamic subtest eDP-1: SKIP (0.000s) [208.473380] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [208.565849] [041/131] (812s left) syncobj_wait (invalid-signal-zero-handles) [208.623238] Starting subtest: invalid-signal-zero-handles [208.625698] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [208.763789] [042/131] (812s left) gen9_exec_parse (bb-oversize) [208.830393] Subtest bb-oversize: SKIP (0.000s) [208.911573] [043/131] (812s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [208.977934] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [209.079901] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s) [209.186072] [044/131] (812s left) gem_exec_reloc (basic-write-cpu-noreloc) [209.258761] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [209.338739] [045/131] (811s left) gem_mmap_offset (bad-flags) [209.403487] Starting subtest: bad-flags [209.406341] Subtest bad-flags: SUCCESS (0.000s) [209.519151] [046/131] (811s left) kms_cursor_legacy (cursor-vs-flip-legacy) [209.636601] Starting subtest: cursor-vs-flip-legacy [238.877677] Subtest cursor-vs-flip-legacy: SUCCESS (29.241s) [239.705354] [047/131] (781s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [239.801757] Starting subtest: sprite-rotation-90-pos-100-0 [239.806693] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [239.896292] [048/131] (781s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [240.001591] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [240.988722] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.989s) [241.154068] [049/131] (780s left) gem_create (busy-create) [241.224780] Starting subtest: busy-create [241.227560] Starting dynamic subtest: smem0 [274.856800] Dynamic subtest smem0: SUCCESS (33.627s) [274.859927] Subtest busy-create: SUCCESS (33.628s) [275.068327] [050/131] (746s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [275.177557] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [279.318553] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.144s) [280.519563] [051/131] (740s left) perf (invalid-open-flags) [280.637405] Starting subtest: invalid-open-flags [280.640062] Subtest invalid-open-flags: SUCCESS (0.000s) [280.685461] [052/131] (740s left) perf (oa-formats) [280.785123] Starting subtest: oa-formats [280.787943] Starting dynamic subtest: 0-rcs0 [280.800957] Dynamic subtest 0-rcs0: SUCCESS (0.016s) [280.810567] Starting dynamic subtest: 1-vcs1 [280.825709] Dynamic subtest 1-vcs1: SUCCESS (0.024s) [280.828634] Subtest oa-formats: SUCCESS (0.040s) [280.875296] [053/131] (740s left) kms_big_fb (4-tiled-8bpp-rotate-270) [280.983731] Starting subtest: 4-tiled-8bpp-rotate-270 [281.003931] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [281.166733] [054/131] (740s left) kms_cursor_crc (cursor-onscreen-64x21) [281.374923] Starting subtest: cursor-onscreen-64x21 [281.424289] Subtest cursor-onscreen-64x21: SKIP (0.042s) [281.681067] [055/131] (740s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [281.782024] Starting subtest: primary-4-tiled-reflect-x-180 [288.933363] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.153s) [290.168482] [056/131] (731s left) kms_cursor_crc (cursor-onscreen-256x256) [290.401924] Starting subtest: cursor-onscreen-256x256 [290.407613] Starting dynamic subtest: pipe-A-eDP-1 [292.503334] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s) [292.532079] Starting dynamic subtest: pipe-D-eDP-1 [295.347327] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.824s) [295.350164] Subtest cursor-onscreen-256x256: SUCCESS (4.945s) [296.229996] [057/131] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [296.328681] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [303.578226] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.251s) [303.774560] [058/131] (718s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [303.887589] Starting subtest: async-flip-with-page-flip-events-tiled [304.257808] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [306.997924] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.739s) [307.011286] Starting dynamic subtest: pipe-A-eDP-1-4 [309.176758] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s) [309.186949] Starting dynamic subtest: pipe-A-eDP-1-4 [311.183956] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [311.192960] Starting dynamic subtest: pipe-A-eDP-1-x [313.365761] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s) [313.728912] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [316.524540] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.801s) [316.534072] Starting dynamic subtest: pipe-B-eDP-1-4 [318.710759] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [318.720238] Starting dynamic subtest: pipe-B-eDP-1-4 [320.718833] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [320.728954] Starting dynamic subtest: pipe-B-eDP-1-x [322.910169] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [323.274262] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [326.107965] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.778s) [326.126358] Starting dynamic subtest: pipe-C-eDP-1-4 [328.254835] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.207s) [328.267172] Starting dynamic subtest: pipe-C-eDP-1-4 [330.264637] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s) [330.276373] Starting dynamic subtest: pipe-C-eDP-1-x [332.466953] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.200s) [332.830559] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [335.577187] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.755s) [335.587537] Starting dynamic subtest: pipe-D-eDP-1-4 [337.762708] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s) [337.772455] Starting dynamic subtest: pipe-D-eDP-1-4 [339.774673] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [339.787213] Starting dynamic subtest: pipe-D-eDP-1-x [341.967168] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [341.969602] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.076s) [343.181459] [059/131] (678s left) perf (polling) [343.304714] Starting subtest: polling [343.307438] Starting dynamic subtest: 0-rcs0 [353.391575] Dynamic subtest 0-rcs0: SUCCESS (10.033s) [353.403142] Starting dynamic subtest: 1-vcs0 [363.414228] Dynamic subtest 1-vcs0: SUCCESS (10.019s) [363.416692] Subtest polling: SUCCESS (20.055s) [363.459606] [060/131] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [363.565155] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [363.570414] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [363.697239] [061/131] (658s left) syncobj_timeline (reset-signaled) [363.762835] Starting subtest: reset-signaled [363.765732] Subtest reset-signaled: SUCCESS (0.000s) [363.896226] [062/131] (658s left) kms_rmfb (rmfb-ioctl) [363.996218] Starting subtest: rmfb-ioctl [363.998688] Starting dynamic subtest: pipe-A-eDP-1 [364.101062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [364.111578] Starting dynamic subtest: pipe-B-eDP-1 [365.324794] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s) [365.338734] Starting dynamic subtest: pipe-C-eDP-1 [366.540690] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s) [366.549897] Starting dynamic subtest: pipe-D-eDP-1 [367.677701] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s) [367.680201] Subtest rmfb-ioctl: SUCCESS (3.684s) [368.910549] [063/131] (653s left) gem_userptr_blits (create-destroy-sync) [368.983825] Starting subtest: create-destroy-sync [374.051340] Subtest create-destroy-sync: SUCCESS (5.014s) [374.162984] [064/131] (647s left) gem_exec_reloc (basic-gtt-cpu-active) [374.222789] Subtest basic-gtt-cpu-active: SKIP (0.000s) [374.292044] [065/131] (647s left) api_intel_allocator (execbuf-with-allocator) [374.345796] Starting subtest: execbuf-with-allocator [374.352325] Subtest execbuf-with-allocator: SUCCESS (0.009s) [374.522959] [066/131] (647s left) kms_lease (cursor-implicit-plane) [374.640463] Starting subtest: cursor-implicit-plane [374.642733] Starting dynamic subtest: pipe-A-eDP-1 [375.087634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s) [375.097758] Starting dynamic subtest: pipe-B-eDP-1 [376.213573] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s) [376.223056] Starting dynamic subtest: pipe-C-eDP-1 [377.337515] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s) [377.348618] Starting dynamic subtest: pipe-D-eDP-1 [378.453728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s) [378.456779] Subtest cursor-implicit-plane: SUCCESS (3.813s) [379.354599] [067/131] (642s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [379.468504] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [379.473694] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [379.638828] [068/131] (642s left) syncobj_wait (invalid-signal-illegal-handle) [379.704945] Starting subtest: invalid-signal-illegal-handle [379.707404] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [379.819074] [069/131] (642s left) kms_psr (psr-primary-blt) [379.909354] Starting subtest: psr-primary-blt [379.911926] Starting dynamic subtest: eDP-1 [381.627531] Dynamic subtest eDP-1: SUCCESS (1.719s) [381.629983] Subtest psr-primary-blt: SUCCESS (1.720s) [382.506364] [070/131] (639s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [382.604650] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [382.607265] Starting dynamic subtest: pipe-A-eDP-1 [382.671679] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [382.685802] Starting dynamic subtest: pipe-B-eDP-1 [382.750715] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [382.765826] Starting dynamic subtest: pipe-C-eDP-1 [382.836504] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [382.847703] Starting dynamic subtest: pipe-D-eDP-1 [382.914500] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [382.919920] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s) [384.787981] [071/131] (637s left) kms_psr (pr-primary-blt) [384.884460] Starting subtest: pr-primary-blt [384.889788] Subtest pr-primary-blt: SKIP (0.000s) [384.979697] [072/131] (637s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [385.083570] Starting subtest: psr-2p-primscrn-spr-indfb-move [385.088682] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [385.211548] [073/131] (637s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [385.312924] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [385.315298] Starting dynamic subtest: pipe-A-default-mode [386.433796] Dynamic subtest pipe-A-default-mode: SKIP (1.117s) [386.438805] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.118s) [386.605250] [074/131] (635s left) gem_exec_schedule (u-semaphore-noskip) [386.692565] Starting subtest: u-semaphore-noskip [387.091599] Subtest u-semaphore-noskip: SUCCESS (0.406s) [387.479111] [075/131] (635s left) i915_drm_fdinfo (memory-info-idle) [387.522754] Starting subtest: memory-info-idle [387.525715] Starting dynamic subtest: smem0 [387.603423] Dynamic subtest smem0: SUCCESS (0.084s) [387.606434] Subtest memory-info-idle: SUCCESS (0.085s) [387.700383] [076/131] (634s left) i915_selftest (live) [389.654422] Starting subtest: live [389.657189] Starting dynamic subtest: sanitycheck [393.850927] Dynamic subtest sanitycheck: SUCCESS (4.186s) [393.861798] Starting dynamic subtest: uncore [397.881588] Dynamic subtest uncore: SUCCESS (4.040s) [397.892271] Starting dynamic subtest: workarounds [402.486509] Dynamic subtest workarounds: SUCCESS (4.603s) [402.496245] Starting dynamic subtest: gt_engines [406.975463] Dynamic subtest gt_engines: SUCCESS (4.487s) [406.985467] Starting dynamic subtest: gt_timelines [423.957789] Dynamic subtest gt_timelines: SUCCESS (16.982s) [423.967703] Starting dynamic subtest: gt_contexts [428.187533] Dynamic subtest gt_contexts: SUCCESS (4.227s) [428.197746] Starting dynamic subtest: gt_lrc [433.947136] Dynamic subtest gt_lrc: SUCCESS (5.758s) [433.957198] Starting dynamic subtest: gt_mocs [439.796409] Dynamic subtest gt_mocs: SUCCESS (5.846s) [439.806480] Starting dynamic subtest: gt_pm [447.916396] Dynamic subtest gt_pm: SUCCESS (8.119s) [447.926109] Starting dynamic subtest: gt_heartbeat [452.139603] Dynamic subtest gt_heartbeat: SUCCESS (4.221s) [452.154585] Starting dynamic subtest: gt_tlb [462.939427] Dynamic subtest gt_tlb: SUCCESS (10.797s) [462.949110] Starting dynamic subtest: requests [478.094231] Dynamic subtest requests: SUCCESS (15.152s) [478.104073] Starting dynamic subtest: migrate [485.523725] Dynamic subtest migrate: SUCCESS (7.428s) [485.533791] Starting dynamic subtest: active [489.716390] Dynamic subtest active: SUCCESS (4.190s) [489.726572] Starting dynamic subtest: objects [494.343165] Dynamic subtest objects: SUCCESS (4.625s) [494.352803] Starting dynamic subtest: mman [499.254495] Dynamic subtest mman: SUCCESS (4.909s) [499.264752] Starting dynamic subtest: dmabuf [503.384444] Dynamic subtest dmabuf: SUCCESS (4.128s) [503.394831] Starting dynamic subtest: vma [507.520682] Dynamic subtest vma: SUCCESS (4.134s) [507.530837] Starting dynamic subtest: coherency [512.856440] Dynamic subtest coherency: SUCCESS (5.334s) [512.866699] Starting dynamic subtest: gtt [524.209889] Dynamic subtest gtt: SUCCESS (11.350s) [524.219217] Starting dynamic subtest: gem [533.717173] Dynamic subtest gem: SUCCESS (9.505s) [533.726471] Starting dynamic subtest: evict [539.189442] Dynamic subtest evict: SUCCESS (5.469s) [539.199335] Starting dynamic subtest: hugepages [549.452407] Dynamic subtest hugepages: SUCCESS (10.261s) [549.466626] Starting dynamic subtest: gem_contexts [577.866456] Dynamic subtest gem_contexts: SUCCESS (28.410s) [577.876326] Starting dynamic subtest: client [582.055550] Dynamic subtest client: SUCCESS (4.188s) [582.065672] Starting dynamic subtest: gem_migrate [586.111940] Dynamic subtest gem_migrate: SUCCESS (4.054s) [586.126862] Starting dynamic subtest: reset [591.878437] Dynamic subtest reset: SUCCESS (5.764s) [591.888899] Starting dynamic subtest: memory_region [597.576652] Dynamic subtest memory_region: SUCCESS (5.696s) [597.587096] Starting dynamic subtest: hangcheck [611.898223] Dynamic subtest hangcheck: SUCCESS (14.318s) [611.908366] Starting dynamic subtest: execlists [615.997565] Dynamic subtest execlists: SUCCESS (4.097s) [616.007785] Starting dynamic subtest: ring_submission [620.166206] Dynamic subtest ring_submission: SUCCESS (4.166s) [620.177248] Starting dynamic subtest: perf [624.495247] Dynamic subtest perf: SUCCESS (4.326s) [624.509770] Starting dynamic subtest: slpc [639.999770] Dynamic subtest slpc: SUCCESS (15.500s) [640.009331] Starting dynamic subtest: guc [645.352819] Dynamic subtest guc: SUCCESS (5.351s) [645.362503] Starting dynamic subtest: guc_multi_lrc [649.342100] Dynamic subtest guc_multi_lrc: SUCCESS (3.987s) [649.356837] Starting dynamic subtest: guc_hang [654.196246] Dynamic subtest guc_hang: SUCCESS (4.852s) [654.211713] Starting dynamic subtest: late_gt_pm [658.322682] Dynamic subtest late_gt_pm: SUCCESS (4.124s) [658.325924] Subtest live: SUCCESS (268.660s) [658.357997] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [658.358682] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [658.362295] [077/131] (364s left) gem_userptr_blits (nohangcheck) [661.159092] Starting subtest: nohangcheck [661.439917] Subtest nohangcheck: SUCCESS (0.278s) [661.543745] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [661.544985] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [661.549225] [078/131] (361s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [661.654702] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [661.657373] Starting dynamic subtest: pipe-A-eDP-1 [662.542895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.880s) [662.551601] Starting dynamic subtest: pipe-B-eDP-1 [664.165595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.617s) [664.174833] Starting dynamic subtest: pipe-C-eDP-1 [665.670408] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s) [665.680367] Starting dynamic subtest: pipe-D-eDP-1 [667.235664] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.564s) [667.238289] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.570s) [668.497545] [079/131] (354s left) gem_softpin (allocator-nopin) [668.565417] Starting subtest: allocator-nopin [668.673449] Subtest allocator-nopin: SUCCESS (0.106s) [668.823721] [080/131] (353s left) kms_draw_crc (draw-method-pwrite) [668.918859] Starting subtest: draw-method-pwrite [668.921286] Starting dynamic subtest: xrgb8888-untiled [669.439955] Dynamic subtest xrgb8888-untiled: SUCCESS (0.523s) [669.449564] Starting dynamic subtest: rgb565-untiled [669.863581] Dynamic subtest rgb565-untiled: SUCCESS (0.422s) [669.873277] Starting dynamic subtest: xrgb2101010-untiled [670.384617] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.520s) [670.393733] Starting dynamic subtest: xbgr16161616f-untiled [671.117833] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.731s) [671.128945] Starting dynamic subtest: xrgb8888-xtiled [672.873777] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.755s) [672.882546] Starting dynamic subtest: rgb565-xtiled [673.928747] Dynamic subtest rgb565-xtiled: SUCCESS (1.054s) [673.940086] Starting dynamic subtest: xrgb2101010-xtiled [675.652390] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.722s) [675.664550] Starting dynamic subtest: xbgr16161616f-xtiled [678.798846] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.144s) [678.808022] Starting dynamic subtest: xrgb8888-4tiled [679.873720] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.075s) [679.883418] Starting dynamic subtest: rgb565-4tiled [680.429909] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s) [680.438920] Starting dynamic subtest: xrgb2101010-4tiled [681.473957] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.043s) [681.482902] Starting dynamic subtest: xbgr16161616f-4tiled [684.373676] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.898s) [684.376367] Subtest draw-method-pwrite: SUCCESS (15.458s) [684.502232] [081/131] (338s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [684.612683] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [684.617594] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [684.734861] [082/131] (338s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [684.839384] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [684.844558] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [684.976415] [083/131] (337s left) syncobj_timeline (host-signal-points) [685.051401] Starting subtest: host-signal-points [685.057786] Subtest host-signal-points: SUCCESS (0.004s) [685.186160] [084/131] (337s left) gem_mmap_gtt (basic-small-bo) [685.242681] Subtest basic-small-bo: SKIP (0.000s) [685.297524] [085/131] (337s left) perf_pmu (semaphore-wait-idle) [685.334619] Starting subtest: semaphore-wait-idle [685.337088] Starting dynamic subtest: rcs0 [685.849911] Dynamic subtest rcs0: SUCCESS (0.515s) [685.862261] Starting dynamic subtest: bcs0 [686.364267] Dynamic subtest bcs0: SUCCESS (0.511s) [686.376233] Starting dynamic subtest: vcs0 [686.881778] Dynamic subtest vcs0: SUCCESS (0.514s) [686.895088] Starting dynamic subtest: vcs1 [687.397645] Dynamic subtest vcs1: SUCCESS (0.513s) [687.409928] Starting dynamic subtest: vecs0 [687.915818] Dynamic subtest vecs0: SUCCESS (0.514s) [687.928222] Starting dynamic subtest: ccs0 [688.434844] Dynamic subtest ccs0: SUCCESS (0.515s) [688.437926] Subtest semaphore-wait-idle: SUCCESS (3.101s) [689.919346] [086/131] (333s left) kms_addfb_basic (no-handle) [689.974616] Starting subtest: no-handle [689.977333] Subtest no-handle: SUCCESS (0.000s) [690.156281] [087/131] (332s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [690.257499] Starting subtest: fbcpsr-rgb101010-draw-pwrite [697.243756] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.989s) [697.394441] [088/131] (325s left) gem_render_copy (yf-tiled-ccs-to-linear) [697.461844] Starting subtest: yf-tiled-ccs-to-linear [697.467766] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [697.670608] [089/131] (325s left) kms_flip (wf_vblank-ts-check) [697.779442] Starting subtest: wf_vblank-ts-check [697.782018] Starting dynamic subtest: A-eDP1 [706.732536] Dynamic subtest A-eDP1: SUCCESS (8.921s) [706.742315] Starting dynamic subtest: B-eDP1 [715.667902] Dynamic subtest B-eDP1: SUCCESS (8.934s) [715.676928] Starting dynamic subtest: C-eDP1 [724.603195] Dynamic subtest C-eDP1: SUCCESS (8.923s) [724.614015] Starting dynamic subtest: D-eDP1 [733.541076] Dynamic subtest D-eDP1: SUCCESS (8.934s) [733.543581] Subtest wf_vblank-ts-check: SUCCESS (35.723s) [734.751807] [090/131] (288s left) gem_exec_schedule (deep) [734.930840] Starting subtest: deep [734.933562] Starting dynamic subtest: rcs0 [739.587233] Dynamic subtest rcs0: SKIP (4.652s) [739.598592] Starting dynamic subtest: vcs0 [750.265011] Dynamic subtest vcs0: SUCCESS (10.679s) [750.280056] Starting dynamic subtest: vcs1 [761.724329] Dynamic subtest vcs1: SUCCESS (11.455s) [761.737092] Starting dynamic subtest: vecs0 [773.635888] Dynamic subtest vecs0: SUCCESS (11.910s) [773.647920] Starting dynamic subtest: ccs0 [785.642891] Dynamic subtest ccs0: SUCCESS (12.001s) [785.645361] Subtest deep: SUCCESS (50.705s) [787.547591] [091/131] (235s left) kms_sequence (queue-idle) [787.650897] Starting subtest: queue-idle [787.652894] Starting dynamic subtest: pipe-A-eDP-1 [789.457954] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s) [789.467699] Starting dynamic subtest: pipe-B-eDP-1 [791.899934] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.440s) [791.909666] Starting dynamic subtest: pipe-C-eDP-1 [794.326900] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.426s) [794.337150] Starting dynamic subtest: pipe-D-eDP-1 [796.761334] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s) [796.763906] Subtest queue-idle: SUCCESS (9.111s) [797.592550] [092/131] (225s left) gem_gtt_cpu_tlb [797.732285] [093/131] (225s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [797.826697] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [804.387578] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.564s) [804.531887] [094/131] (218s left) gem_eio (create-ext) [804.767926] Starting subtest: create-ext [805.086849] Subtest create-ext: SUCCESS (0.317s) [805.260397] [095/131] (218s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [805.328515] Subtest writes-after-reads-uncached: SKIP (0.000s) [805.410288] [096/131] (217s left) sysfs_preempt_timeout (idempotent) [805.468515] Starting subtest: idempotent [805.470946] Starting dynamic subtest: vecs0 [805.473357] Dynamic subtest vecs0: SUCCESS (0.000s) [805.484673] Starting dynamic subtest: ccs0 [805.487129] Dynamic subtest ccs0: SUCCESS (0.000s) [805.496526] Starting dynamic subtest: vcs0 [805.498663] Dynamic subtest vcs0: SUCCESS (0.000s) [805.508574] Starting dynamic subtest: bcs0 [805.510743] Dynamic subtest bcs0: SUCCESS (0.000s) [805.520387] Starting dynamic subtest: rcs0 [805.522339] Dynamic subtest rcs0: SUCCESS (0.000s) [805.531458] Starting dynamic subtest: vcs1 [805.533715] Dynamic subtest vcs1: SUCCESS (0.000s) [805.536185] Subtest idempotent: SUCCESS (0.006s) [805.602229] [097/131] (217s left) gem_busy (semaphore) [805.792667] Subtest semaphore: SKIP (0.000s) [806.058295] [098/131] (217s left) sriov_basic (enable-vfs-bind-unbind-each) [806.119609] Starting subtest: enable-vfs-bind-unbind-each [806.122104] Starting dynamic subtest: numvfs-1 [806.207923] Dynamic subtest numvfs-1: FAIL (0.033s) [806.218760] Starting dynamic subtest: numvfs-2 [806.302699] Dynamic subtest numvfs-2: FAIL (0.004s) [806.313582] Starting dynamic subtest: numvfs-3 [806.399784] Dynamic subtest numvfs-3: FAIL (0.004s) [806.409839] Starting dynamic subtest: numvfs-4 [806.494905] Dynamic subtest numvfs-4: FAIL (0.006s) [806.505783] Starting dynamic subtest: numvfs-5 [806.591343] Dynamic subtest numvfs-5: FAIL (0.003s) [806.601429] Starting dynamic subtest: numvfs-6 [806.685789] Dynamic subtest numvfs-6: FAIL (0.003s) [806.696615] Starting dynamic subtest: numvfs-7 [806.780908] Dynamic subtest numvfs-7: FAIL (0.003s) [806.790645] Starting dynamic subtest: numvfs-random [806.875720] Dynamic subtest numvfs-random: FAIL (0.003s) [806.878136] Subtest enable-vfs-bind-unbind-each: FAIL (0.065s) [806.917511] [099/131] (216s left) kms_pm_lpsp (screens-disabled) [808.031769] Starting subtest: screens-disabled [808.036801] Subtest screens-disabled: SKIP (0.000s) [808.128275] [100/131] (215s left) gem_exec_capture (capture-invisible) [808.194601] Starting subtest: capture-invisible [808.197166] Starting dynamic subtest: smem0 [808.202377] Dynamic subtest smem0: SKIP (0.000s) [808.207518] Subtest capture-invisible: SKIP (0.001s) [808.345931] [101/131] (215s left) gem_lmem_swapping (verify-ccs) [808.391777] Subtest verify-ccs: SKIP (0.000s) [808.435959] [102/131] (215s left) kms_joiner (basic-force-ultra-joiner) [808.547502] Starting subtest: basic-force-ultra-joiner [808.552681] Subtest basic-force-ultra-joiner: SKIP (0.000s) [808.631566] [103/131] (215s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [808.738530] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [815.213707] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.477s) [815.362410] [104/131] (208s left) kms_color (legacy-gamma) [815.468438] Starting subtest: legacy-gamma [815.470935] Starting dynamic subtest: pipe-A-eDP-1 [816.201242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s) [816.211899] Starting dynamic subtest: pipe-B-eDP-1 [817.631650] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s) [817.642215] Starting dynamic subtest: pipe-C-eDP-1 [819.001780] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s) [819.012438] Starting dynamic subtest: pipe-D-eDP-1 [820.322935] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [820.325806] Subtest legacy-gamma: SUCCESS (4.854s) [821.157906] [105/131] (202s left) gem_exec_schedule (wide) [821.337730] Starting subtest: wide [821.340558] Starting dynamic subtest: rcs0 [832.252831] Dynamic subtest rcs0: SUCCESS (10.862s) [832.262982] Starting dynamic subtest: vcs0 [843.580949] Dynamic subtest vcs0: SUCCESS (11.377s) [843.592906] Starting dynamic subtest: vcs1 [856.796752] Dynamic subtest vcs1: SUCCESS (13.214s) [856.811755] Starting dynamic subtest: vecs0 [867.085532] Dynamic subtest vecs0: SUCCESS (10.286s) [867.098933] Starting dynamic subtest: ccs0 [881.257919] Dynamic subtest ccs0: SUCCESS (14.119s) [881.260934] Subtest wide: SUCCESS (59.866s) [882.262372] [106/131] (141s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [882.374791] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [882.377678] Starting dynamic subtest: pipe-A-default-mode [882.681659] Dynamic subtest pipe-A-default-mode: SKIP (0.303s) [882.687129] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.305s) [883.502830] [107/131] (140s left) kms_big_fb (linear-64bpp-rotate-180) [883.621833] Starting subtest: linear-64bpp-rotate-180 [885.290670] Subtest linear-64bpp-rotate-180: SUCCESS (1.669s) [885.468931] [108/131] (138s left) gem_ppgtt (blt-vs-render-ctxn) [885.525987] Starting subtest: blt-vs-render-ctxN [918.712200] Subtest blt-vs-render-ctxN: SUCCESS (33.183s) [918.877337] [109/131] (105s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [919.044919] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [919.050751] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [919.183555] [110/131] (104s left) kms_chamelium_frames (dp-frame-dump) [919.568923] Subtest dp-frame-dump: SKIP (0.000s) [920.384009] [111/131] (103s left) kms_psr2_su (page_flip-nv12) [920.451431] Subtest page_flip-NV12: SKIP (0.000s) [920.511380] [112/131] (103s left) gem_tiling_max_stride [920.656245] [113/131] (103s left) perf_pmu (busy-idle) [920.698181] Starting subtest: busy-idle [920.700577] Starting dynamic subtest: rcs0 [921.417443] Dynamic subtest rcs0: SUCCESS (0.719s) [921.430811] Starting dynamic subtest: bcs0 [922.090045] Dynamic subtest bcs0: SUCCESS (0.671s) [922.103216] Starting dynamic subtest: vcs0 [923.868106] Dynamic subtest vcs0: SUCCESS (1.774s) [923.881961] Starting dynamic subtest: vcs1 [925.853363] Dynamic subtest vcs1: SUCCESS (1.982s) [925.867954] Starting dynamic subtest: vecs0 [927.835982] Dynamic subtest vecs0: SUCCESS (1.980s) [927.849594] Starting dynamic subtest: ccs0 [928.513096] Dynamic subtest ccs0: SUCCESS (0.675s) [928.515890] Subtest busy-idle: SUCCESS (7.816s) [928.643592] [114/131] ( 95s left) dmabuf_sync_file (export-before-signal) [928.693658] Starting subtest: export-before-signal [928.696232] Subtest export-before-signal: SUCCESS (0.001s) [928.776976] [115/131] ( 95s left) gem_exec_reloc (basic-cpu-read) [928.840545] Subtest basic-cpu-read: SKIP (0.000s) [928.916515] [116/131] ( 95s left) kms_hdr (bpc-switch) [929.012194] Starting subtest: bpc-switch [930.074742] Starting dynamic subtest: pipe-A-eDP-1 [933.570714] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.496s) [933.573533] Subtest bpc-switch: SUCCESS (4.561s) [933.720649] [117/131] ( 90s left) perf (i915-ref-count) [933.835098] Starting subtest: i915-ref-count [933.906602] Subtest i915-ref-count: SUCCESS (0.069s) [933.963401] [118/131] ( 90s left) gem_ctx_isolation (nonpriv) [934.024927] Starting subtest: nonpriv [934.027787] Starting dynamic subtest: rcs0 [934.279651] Dynamic subtest rcs0: SUCCESS (0.255s) [934.290550] Starting dynamic subtest: bcs0 [934.538345] Dynamic subtest bcs0: SUCCESS (0.257s) [934.550890] Starting dynamic subtest: vcs0 [934.809512] Dynamic subtest vcs0: SUCCESS (0.271s) [934.820076] Starting dynamic subtest: vcs1 [936.080941] Dynamic subtest vcs1: SUCCESS (1.269s) [936.093685] Starting dynamic subtest: vecs0 [938.146833] Dynamic subtest vecs0: SUCCESS (2.066s) [938.159107] Starting dynamic subtest: ccs0 [940.165943] Dynamic subtest ccs0: SUCCESS (2.017s) [940.168967] Subtest nonpriv: SUCCESS (6.142s) [940.419414] [119/131] ( 83s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [940.484171] Starting subtest: y-tiled-to-vebox-x-tiled [940.489801] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [940.695426] [120/131] ( 83s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [940.804947] Starting subtest: plane-use-after-nonblocking-unbind [940.807642] Starting dynamic subtest: pipe-A-eDP-1 [940.865722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [941.170147] Starting dynamic subtest: pipe-B-eDP-1 [941.928694] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s) [942.223341] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.419s) [943.100446] [121/131] ( 81s left) i915_hangman (engine-error-state-capture) [943.167624] Starting subtest: engine-error-state-capture [943.170230] Starting dynamic subtest: rcs0 [946.810224] Dynamic subtest rcs0: SUCCESS (3.641s) [946.823973] Starting dynamic subtest: bcs0 [952.761397] Dynamic subtest bcs0: SUCCESS (5.948s) [952.779261] Starting dynamic subtest: vcs0 [958.778258] Dynamic subtest vcs0: SUCCESS (6.013s) [958.792921] Starting dynamic subtest: vcs1 [964.793649] Dynamic subtest vcs1: SUCCESS (6.012s) [964.807197] Starting dynamic subtest: vecs0 [970.745923] Dynamic subtest vecs0: SUCCESS (5.949s) [970.762178] Starting dynamic subtest: ccs0 [975.802629] Dynamic subtest ccs0: SUCCESS (5.053s) [975.805748] Subtest engine-error-state-capture: SUCCESS (32.633s) [975.971579] [122/131] ( 48s left) gem_exec_schedule (pi-shared-iova) [976.167829] Starting subtest: pi-shared-iova [976.170539] Starting dynamic subtest: rcs0 [976.290986] Dynamic subtest rcs0: SUCCESS (0.126s) [976.304144] Starting dynamic subtest: vcs0 [976.391554] Dynamic subtest vcs0: SUCCESS (0.101s) [976.404246] Starting dynamic subtest: vcs1 [976.487541] Dynamic subtest vcs1: SUCCESS (0.095s) [976.501456] Starting dynamic subtest: vecs0 [976.576262] Dynamic subtest vecs0: SUCCESS (0.088s) [976.588824] Starting dynamic subtest: ccs0 [976.690708] Dynamic subtest ccs0: SUCCESS (0.114s) [976.693642] Subtest pi-shared-iova: SUCCESS (0.528s) [978.004436] [123/131] ( 46s left) syncobj_wait (invalid-reset-illegal-handle) [978.065097] Starting subtest: invalid-reset-illegal-handle [978.067495] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [978.175489] [124/131] ( 46s left) syncobj_wait (single-wait-all-for-submit-signaled) [978.244474] Starting subtest: single-wait-all-for-submit-signaled [978.247075] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [978.354291] [125/131] ( 46s left) kms_cursor_crc (cursor-sliding-512x170) [978.645787] Starting subtest: cursor-sliding-512x170 [978.650922] Subtest cursor-sliding-512x170: SKIP (0.001s) [978.826991] [126/131] ( 45s left) kms_chamelium_hpd (hdmi-hpd-fast) [979.218703] Subtest hdmi-hpd-fast: SKIP (0.000s) [980.006382] [127/131] ( 44s left) gem_ctx_persistence (hostile) [980.070722] Starting subtest: hostile [990.226707] Subtest hostile: SUCCESS (10.150s) [990.385048] [128/131] ( 34s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [990.495538] Starting subtest: fbc-rgb565-draw-blt [994.707373] Subtest fbc-rgb565-draw-blt: SUCCESS (4.215s) [995.939702] [129/131] ( 28s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [996.048150] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [1005.011337] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (8.965s) [1005.160989] [130/131] ( 19s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [1005.274511] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [1005.279685] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [1005.399854] [131/131] ( 19s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [1005.498829] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [1005.504487] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [1005.623044] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.