[56.624516] Initializing watchdogs [56.624562] /dev/watchdog0 [56.646046] [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.650252] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.652525] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.655942] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [56.781654] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [56.786160] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [56.905116] [002/131] (960s left) gem_exec_fence (submit3) [57.090280] Starting subtest: submit3 [57.094909] Subtest submit3: SKIP (0.000s) [58.990229] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [58.993517] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [59.103165] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [59.107567] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.227574] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [59.318282] Starting subtest: fbc-rgb101010-draw-mmap-wc [63.900342] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.553s) [65.032417] [005/131] (952s left) gem_exec_balancer (noheartbeat) [65.285562] Starting subtest: noheartbeat [65.290458] Subtest noheartbeat: SKIP (0.000s) [65.400573] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [65.506617] Subtest ctm-blue-to-red: SKIP (0.000s) [65.550596] [007/131] (951s left) gem_workarounds (suspend-resume) [65.628029] Starting subtest: suspend-resume [81.804136] Subtest suspend-resume: SUCCESS (5.509s) [81.958114] [008/131] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [82.072288] Starting subtest: planes-downscale-factor-0-75-unity-scaling [82.075893] Starting dynamic subtest: pipe-A [82.135114] Dynamic subtest pipe-A: SUCCESS (0.066s) [82.145667] Starting dynamic subtest: pipe-B [83.318077] Dynamic subtest pipe-B: SUCCESS (1.133s) [83.332620] Starting dynamic subtest: pipe-C [84.461080] Dynamic subtest pipe-C: SUCCESS (1.098s) [84.470144] Starting dynamic subtest: pipe-D [85.637883] Dynamic subtest pipe-D: SUCCESS (1.138s) [85.640410] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.438s) [86.862521] [009/131] (930s left) gem_pxp (create-regular-buffer) [86.993571] Starting subtest: create-regular-buffer [86.996595] Subtest create-regular-buffer: SUCCESS (0.000s) [87.123501] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [87.185855] Starting subtest: rel-constants-invalid-rel-gen5 [87.188069] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [87.312534] [011/131] (930s left) gem_exec_nop (basic-series) [87.390918] Starting subtest: basic-series [103.538154] Subtest basic-series: SUCCESS (15.989s) [103.785620] [012/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [103.892442] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [103.898026] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [104.004270] [013/131] (913s left) kms_psr (fbc-psr-primary-page-flip) [104.098124] Starting subtest: fbc-psr-primary-page-flip [104.100941] Starting dynamic subtest: eDP-1 [104.105998] Dynamic subtest eDP-1: SKIP (0.000s) [104.111242] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [104.194702] [014/131] (913s left) i915_pm_rps (engine-order) [104.257641] Starting subtest: engine-order [109.135118] Subtest engine-order: SUCCESS (4.865s) [109.290076] [015/131] (908s left) gem_softpin (evict-active) [109.359101] Starting subtest: evict-active [109.371323] Subtest evict-active: SUCCESS (0.012s) [109.541502] [016/131] (908s left) syncobj_timeline (wait-delayed-signal) [109.610107] Starting subtest: wait-delayed-signal [109.711073] Subtest wait-delayed-signal: SUCCESS (0.103s) [109.815971] [017/131] (907s left) kms_panel_fitting (atomic-fastset) [109.913898] Starting subtest: atomic-fastset [109.916694] Starting dynamic subtest: pipe-A-eDP-1 [110.066089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.154s) [110.076263] Starting dynamic subtest: pipe-B-eDP-1 [111.299519] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.231s) [111.308702] Starting dynamic subtest: pipe-C-eDP-1 [112.479010] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.175s) [112.489090] Starting dynamic subtest: pipe-D-eDP-1 [113.613995] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [113.616829] Subtest atomic-fastset: SUCCESS (3.697s) [114.876455] [018/131] (902s left) kms_big_fb (x-tiled-16bpp-rotate-270) [115.004675] Starting subtest: x-tiled-16bpp-rotate-270 [115.027228] Subtest x-tiled-16bpp-rotate-270: SKIP (0.022s) [115.176928] [019/131] (902s left) api_intel_bb (render-ccs) [115.246211] Starting subtest: render-ccs [115.616686] Subtest render-ccs: SUCCESS (0.371s) [115.761912] [020/131] (902s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [115.861923] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [115.864791] Starting dynamic subtest: pipe-A-eDP-1 [115.891535] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [115.901502] Starting dynamic subtest: pipe-B-eDP-1 [115.926815] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [115.935567] Starting dynamic subtest: pipe-C-eDP-1 [115.961658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [115.971230] Starting dynamic subtest: pipe-D-eDP-1 [115.996969] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [116.002759] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [118.140151] [021/131] (899s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [118.199211] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [118.306602] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s) [118.407428] [022/131] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [118.505261] Starting subtest: psr-2p-primscrn-cur-indfb-move [118.510189] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [118.644277] [023/131] (899s left) gem_lmem_swapping (heavy-multi) [118.694812] Subtest heavy-multi: SKIP (0.000s) [118.742847] [024/131] (899s left) kms_async_flips (test-cursor) [118.845991] Starting subtest: test-cursor [118.851025] Subtest test-cursor: SKIP (0.000s) [120.078007] [025/131] (898s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [125.135985] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [125.139005] Starting dynamic subtest: pipe-A-eDP-1 [125.947220] Dynamic subtest pipe-A-eDP-1: SKIP (0.808s) [125.957435] Starting dynamic subtest: pipe-B-eDP-1 [127.085994] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s) [127.091873] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.948s) [128.304152] [026/131] (889s left) kms_plane_multiple (2x-tiling-4) [128.408987] Starting subtest: 2x-tiling-4 [128.413855] Subtest 2x-tiling-4: SKIP (0.000s) [128.502624] [027/131] (889s left) gem_ctx_param (invalid-param-set) [128.563510] Starting subtest: invalid-param-set [128.566225] Subtest invalid-param-set: SUCCESS (0.000s) [128.667385] [028/131] (889s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [128.764031] Starting subtest: bad-pixel-format-y-tiled-ccs [128.766782] Starting dynamic subtest: pipe-A-eDP-1 [128.792980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [128.802231] Starting dynamic subtest: pipe-B-eDP-1 [128.827149] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [128.835110] Starting dynamic subtest: pipe-C-eDP-1 [128.859956] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [128.867806] Starting dynamic subtest: pipe-D-eDP-1 [128.894375] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [128.900026] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [131.069573] [029/131] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [131.164104] Starting subtest: plane-downscale-factor-0-5-with-modifiers [131.166939] Starting dynamic subtest: pipe-A [131.184244] Dynamic subtest pipe-A: SKIP (0.016s) [131.193970] Starting dynamic subtest: pipe-B [131.216936] Dynamic subtest pipe-B: SKIP (0.032s) [131.225364] Starting dynamic subtest: pipe-C [131.245127] Dynamic subtest pipe-C: SKIP (0.028s) [131.253225] Starting dynamic subtest: pipe-D [131.273384] Dynamic subtest pipe-D: SKIP (0.028s) [131.278429] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.105s) [131.407483] [030/131] (886s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [131.472091] Starting subtest: multi-wait-all-available-submitted-signaled [131.474826] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [131.613023] [031/131] (886s left) perf (missing-sample-flags) [131.749321] Starting subtest: missing-sample-flags [131.752206] Subtest missing-sample-flags: SUCCESS (0.001s) [131.810111] [032/131] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [131.914742] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [138.097073] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.185s) [139.267568] [033/131] (879s left) kms_pm_rpm (system-suspend-idle) [140.826120] Starting subtest: system-suspend-idle [159.959726] Subtest system-suspend-idle: SUCCESS (4.167s) [160.376598] [034/131] (858s left) kms_vblank (wait-forked) [160.474949] Starting subtest: wait-forked [160.477353] Starting dynamic subtest: pipe-A-eDP-1 [162.337358] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s) [162.352597] Starting dynamic subtest: pipe-D-eDP-1 [164.841010] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.442s) [164.843427] Subtest wait-forked: SUCCESS (4.245s) [165.767483] [035/131] (852s left) kms_big_fb (y-tiled-32bpp-rotate-0) [165.884488] Starting subtest: y-tiled-32bpp-rotate-0 [165.888966] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [166.029899] [036/131] (852s left) kms_pipe_crc_basic (read-crc) [166.122443] Starting subtest: read-crc [166.124766] Starting dynamic subtest: pipe-A-eDP-1 [166.822541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s) [166.832939] Starting dynamic subtest: pipe-B-eDP-1 [168.259394] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s) [168.269369] Starting dynamic subtest: pipe-C-eDP-1 [169.594733] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.318s) [169.607873] Starting dynamic subtest: pipe-D-eDP-1 [170.889359] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s) [170.891778] Subtest read-crc: SUCCESS (4.706s) [171.763424] [037/131] (846s left) kms_cursor_legacy (single-move) [171.892760] Starting subtest: single-move [171.894927] Starting dynamic subtest: pipe-A [177.308790] Dynamic subtest pipe-A: SUCCESS (5.379s) [177.320241] Starting dynamic subtest: pipe-B [182.708698] Dynamic subtest pipe-B: SUCCESS (5.380s) [182.719108] Starting dynamic subtest: pipe-C [188.100081] Dynamic subtest pipe-C: SUCCESS (5.379s) [188.110737] Starting dynamic subtest: pipe-D [193.486157] Dynamic subtest pipe-D: SUCCESS (5.380s) [193.496986] Starting dynamic subtest: all-pipes [198.876786] Dynamic subtest all-pipes: SUCCESS (5.386s) [198.879114] Subtest single-move: SUCCESS (26.914s) [199.044792] [038/131] (819s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [204.098574] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [204.103188] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [204.962012] [039/131] (813s left) gem_unref_active_buffers [205.210189] [040/131] (813s left) kms_psr (fbc-psr2-primary-mmap-gtt) [205.303156] Starting subtest: fbc-psr2-primary-mmap-gtt [205.305365] Starting dynamic subtest: eDP-1 [205.309362] Dynamic subtest eDP-1: SKIP (0.000s) [205.313464] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [205.398515] [041/131] (813s left) syncobj_wait (invalid-signal-zero-handles) [205.464951] Starting subtest: invalid-signal-zero-handles [205.467258] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [205.588057] [042/131] (813s left) gen9_exec_parse (bb-oversize) [205.651006] Subtest bb-oversize: SKIP (0.000s) [205.749838] [043/131] (813s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [205.805689] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [205.910599] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s) [206.010077] [044/131] (812s left) gem_exec_reloc (basic-write-cpu-noreloc) [206.078758] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [206.165853] [045/131] (812s left) gem_mmap_offset (bad-flags) [206.224322] Starting subtest: bad-flags [206.226561] Subtest bad-flags: SUCCESS (0.000s) [206.361120] [046/131] (812s left) kms_cursor_legacy (cursor-vs-flip-legacy) [206.489284] Starting subtest: cursor-vs-flip-legacy [235.762504] Subtest cursor-vs-flip-legacy: SUCCESS (29.258s) [236.608454] [047/131] (782s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [236.708245] Starting subtest: sprite-rotation-90-pos-100-0 [236.712522] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [236.808924] [048/131] (782s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [236.916125] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [237.869874] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.955s) [238.053408] [049/131] (781s left) gem_create (busy-create) [238.111454] Starting subtest: busy-create [238.113667] Starting dynamic subtest: smem0 [271.401343] Dynamic subtest smem0: SUCCESS (33.285s) [271.403914] Subtest busy-create: SUCCESS (33.286s) [271.614436] [050/131] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [271.725477] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [275.780080] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.059s) [277.000801] [051/131] (742s left) perf (invalid-open-flags) [277.122109] Starting subtest: invalid-open-flags [277.124161] Subtest invalid-open-flags: SUCCESS (0.000s) [277.168346] [052/131] (742s left) perf (oa-formats) [277.274919] Starting subtest: oa-formats [277.277362] Starting dynamic subtest: 0-rcs0 [277.290123] Dynamic subtest 0-rcs0: SUCCESS (0.015s) [277.300680] Starting dynamic subtest: 1-vcs0 [277.312426] Dynamic subtest 1-vcs0: SUCCESS (0.022s) [277.314715] Subtest oa-formats: SUCCESS (0.038s) [277.361244] [053/131] (742s left) kms_big_fb (4-tiled-8bpp-rotate-270) [277.455756] Starting subtest: 4-tiled-8bpp-rotate-270 [277.475822] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [277.614206] [054/131] (741s left) kms_cursor_crc (cursor-onscreen-64x21) [277.797937] Starting subtest: cursor-onscreen-64x21 [277.842021] Subtest cursor-onscreen-64x21: SKIP (0.042s) [278.110160] [055/131] (741s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [278.207493] Starting subtest: primary-4-tiled-reflect-x-180 [285.198701] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.992s) [286.453634] [056/131] (733s left) kms_cursor_crc (cursor-onscreen-256x256) [286.693793] Starting subtest: cursor-onscreen-256x256 [286.698801] Starting dynamic subtest: pipe-A-eDP-1 [288.787702] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.090s) [288.816535] Starting dynamic subtest: pipe-D-eDP-1 [291.590668] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s) [291.592916] Subtest cursor-onscreen-256x256: SUCCESS (4.895s) [292.409370] [057/131] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [292.513423] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [299.833510] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.322s) [300.018627] [058/131] (719s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [300.114629] Starting subtest: async-flip-with-page-flip-events-tiled [300.484483] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [303.215812] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.730s) [303.225499] Starting dynamic subtest: pipe-A-eDP-1-4 [305.391453] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s) [305.400157] Starting dynamic subtest: pipe-A-eDP-1-4 [307.401839] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [307.411005] Starting dynamic subtest: pipe-A-eDP-1-x [309.614772] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.210s) [309.992537] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [312.747913] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.761s) [312.760086] Starting dynamic subtest: pipe-B-eDP-1-4 [314.922692] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s) [314.932616] Starting dynamic subtest: pipe-B-eDP-1-4 [316.933105] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [316.941927] Starting dynamic subtest: pipe-B-eDP-1-x [319.123993] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [319.490279] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [322.297012] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.799s) [322.306184] Starting dynamic subtest: pipe-C-eDP-1-4 [324.447407] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s) [324.458136] Starting dynamic subtest: pipe-C-eDP-1-4 [326.458170] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [326.469153] Starting dynamic subtest: pipe-C-eDP-1-x [328.626363] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s) [328.989707] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [331.723957] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.739s) [331.733264] Starting dynamic subtest: pipe-D-eDP-1-4 [333.900081] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [333.909105] Starting dynamic subtest: pipe-D-eDP-1-4 [335.910894] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [335.920130] Starting dynamic subtest: pipe-D-eDP-1-x [338.090241] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [338.092679] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (37.967s) [339.326240] [059/131] (680s left) perf (polling) [339.428127] Starting subtest: polling [339.430130] Starting dynamic subtest: 0-rcs0 [349.441438] Dynamic subtest 0-rcs0: SUCCESS (10.011s) [349.455560] Starting dynamic subtest: 1-vecs0 [359.467808] Dynamic subtest 1-vecs0: SUCCESS (10.021s) [359.470405] Subtest polling: SUCCESS (20.036s) [359.515712] [060/131] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [359.634495] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [359.638614] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [359.747042] [061/131] (659s left) syncobj_timeline (reset-signaled) [359.807409] Starting subtest: reset-signaled [359.809637] Subtest reset-signaled: SUCCESS (0.000s) [359.949283] [062/131] (659s left) kms_rmfb (rmfb-ioctl) [360.040023] Starting subtest: rmfb-ioctl [360.041920] Starting dynamic subtest: pipe-A-eDP-1 [360.144016] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [360.155084] Starting dynamic subtest: pipe-B-eDP-1 [361.367525] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s) [361.378791] Starting dynamic subtest: pipe-C-eDP-1 [362.489521] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s) [362.498187] Starting dynamic subtest: pipe-D-eDP-1 [363.619623] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s) [363.621983] Subtest rmfb-ioctl: SUCCESS (3.581s) [364.866006] [063/131] (654s left) gem_userptr_blits (create-destroy-sync) [364.937802] Starting subtest: create-destroy-sync [369.950428] Subtest create-destroy-sync: SUCCESS (5.013s) [370.123168] [064/131] (649s left) gem_exec_reloc (basic-gtt-cpu-active) [370.194483] Subtest basic-gtt-cpu-active: SKIP (0.000s) [370.285239] [065/131] (649s left) api_intel_allocator (execbuf-with-allocator) [370.346334] Starting subtest: execbuf-with-allocator [370.352640] Subtest execbuf-with-allocator: SUCCESS (0.009s) [370.499797] [066/131] (649s left) kms_lease (cursor-implicit-plane) [370.591775] Starting subtest: cursor-implicit-plane [370.594064] Starting dynamic subtest: pipe-A-eDP-1 [371.048584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [371.061117] Starting dynamic subtest: pipe-B-eDP-1 [372.153671] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.102s) [372.162841] Starting dynamic subtest: pipe-C-eDP-1 [373.266709] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s) [373.278195] Starting dynamic subtest: pipe-D-eDP-1 [374.396516] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s) [374.398847] Subtest cursor-implicit-plane: SUCCESS (3.804s) [375.278815] [067/131] (644s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [375.418238] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [375.422821] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [375.587759] [068/131] (644s left) syncobj_wait (invalid-signal-illegal-handle) [375.657240] Starting subtest: invalid-signal-illegal-handle [375.659619] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [375.782827] [069/131] (644s left) kms_psr (psr-primary-blt) [375.879311] Starting subtest: psr-primary-blt [375.881561] Starting dynamic subtest: eDP-1 [377.640683] Dynamic subtest eDP-1: SUCCESS (1.762s) [377.643121] Subtest psr-primary-blt: SUCCESS (1.763s) [378.540579] [070/131] (641s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [378.631895] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [378.634118] Starting dynamic subtest: pipe-A-eDP-1 [378.690297] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [378.698606] Starting dynamic subtest: pipe-B-eDP-1 [378.754488] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [378.764307] Starting dynamic subtest: pipe-C-eDP-1 [378.820636] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [378.830233] Starting dynamic subtest: pipe-D-eDP-1 [378.887021] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [378.891299] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s) [380.902446] [071/131] (639s left) kms_psr (pr-primary-blt) [381.000114] Starting subtest: pr-primary-blt [381.004313] Subtest pr-primary-blt: SKIP (0.000s) [381.099276] [072/131] (639s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [381.212636] Starting subtest: psr-2p-primscrn-spr-indfb-move [381.216810] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [381.345584] [073/131] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [381.445943] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [381.448084] Starting dynamic subtest: pipe-A-default-mode [382.640663] Dynamic subtest pipe-A-default-mode: SKIP (1.193s) [382.644542] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.194s) [382.826654] [074/131] (637s left) gem_exec_schedule (u-semaphore-noskip) [382.903235] Starting subtest: u-semaphore-noskip [383.287358] Subtest u-semaphore-noskip: SUCCESS (0.391s) [383.650902] [075/131] (636s left) i915_drm_fdinfo (memory-info-idle) [383.689675] Starting subtest: memory-info-idle [383.692086] Starting dynamic subtest: smem0 [383.748129] Dynamic subtest smem0: SUCCESS (0.058s) [383.750938] Subtest memory-info-idle: SUCCESS (0.059s) [383.847713] [076/131] (636s left) i915_selftest (live) [387.351528] Starting subtest: live [387.353986] Starting dynamic subtest: sanitycheck [391.818712] Dynamic subtest sanitycheck: SUCCESS (4.471s) [391.827956] Starting dynamic subtest: uncore [396.259484] Dynamic subtest uncore: SUCCESS (4.439s) [396.271764] Starting dynamic subtest: workarounds [399.512505] Dynamic subtest workarounds: SUCCESS (3.251s) [399.522771] Starting dynamic subtest: gt_engines [402.754383] Dynamic subtest gt_engines: SUCCESS (3.242s) [402.764556] Starting dynamic subtest: gt_timelines [418.542231] Dynamic subtest gt_timelines: SUCCESS (15.787s) [418.554326] Starting dynamic subtest: gt_contexts [422.934866] Dynamic subtest gt_contexts: SUCCESS (4.390s) [422.944727] Starting dynamic subtest: gt_lrc [429.293477] Dynamic subtest gt_lrc: SUCCESS (6.357s) [429.303088] Starting dynamic subtest: gt_mocs [433.841087] Dynamic subtest gt_mocs: SUCCESS (4.545s) [433.851264] Starting dynamic subtest: gt_pm [440.772117] Dynamic subtest gt_pm: SUCCESS (6.929s) [440.781524] Starting dynamic subtest: gt_heartbeat [445.206303] Dynamic subtest gt_heartbeat: SUCCESS (4.432s) [445.216024] Starting dynamic subtest: gt_tlb [454.631393] Dynamic subtest gt_tlb: SUCCESS (9.422s) [454.641141] Starting dynamic subtest: requests [468.264596] Dynamic subtest requests: SUCCESS (13.631s) [468.274439] Starting dynamic subtest: migrate [474.436686] Dynamic subtest migrate: SUCCESS (6.169s) [474.446430] Starting dynamic subtest: active [478.832331] Dynamic subtest active: SUCCESS (4.393s) [478.847651] Starting dynamic subtest: objects [483.591521] Dynamic subtest objects: SUCCESS (4.756s) [483.601106] Starting dynamic subtest: mman [488.589285] Dynamic subtest mman: SUCCESS (4.995s) [488.599250] Starting dynamic subtest: dmabuf [493.053624] Dynamic subtest dmabuf: SUCCESS (4.461s) [493.063703] Starting dynamic subtest: vma [497.443591] Dynamic subtest vma: SUCCESS (4.387s) [497.452875] Starting dynamic subtest: coherency [501.346347] Dynamic subtest coherency: SUCCESS (3.900s) [501.356479] Starting dynamic subtest: gtt [513.523105] Dynamic subtest gtt: SUCCESS (12.173s) [513.537816] Starting dynamic subtest: gem [521.292225] Dynamic subtest gem: SUCCESS (7.766s) [521.301728] Starting dynamic subtest: evict [526.832057] Dynamic subtest evict: SUCCESS (5.537s) [526.846632] Starting dynamic subtest: hugepages [537.851255] Dynamic subtest hugepages: SUCCESS (11.015s) [537.861407] Starting dynamic subtest: gem_contexts [566.467659] Dynamic subtest gem_contexts: SUCCESS (28.607s) [566.477815] Starting dynamic subtest: client [570.975252] Dynamic subtest client: SUCCESS (4.505s) [570.985415] Starting dynamic subtest: gem_migrate [575.409892] Dynamic subtest gem_migrate: SUCCESS (4.431s) [575.419879] Starting dynamic subtest: reset [578.321021] Dynamic subtest reset: SUCCESS (2.908s) [578.330859] Starting dynamic subtest: memory_region [582.823979] Dynamic subtest memory_region: SUCCESS (4.499s) [582.834042] Starting dynamic subtest: hangcheck [596.001384] Dynamic subtest hangcheck: SUCCESS (13.171s) [596.015909] Starting dynamic subtest: execlists [600.469510] Dynamic subtest execlists: SUCCESS (4.465s) [600.484852] Starting dynamic subtest: ring_submission [604.950475] Dynamic subtest ring_submission: SUCCESS (4.477s) [604.960327] Starting dynamic subtest: perf [609.442875] Dynamic subtest perf: SUCCESS (4.489s) [609.452856] Starting dynamic subtest: slpc [623.628846] Dynamic subtest slpc: SUCCESS (14.180s) [623.639630] Starting dynamic subtest: guc [627.636305] Dynamic subtest guc: SUCCESS (4.004s) [627.646079] Starting dynamic subtest: guc_multi_lrc [632.147012] Dynamic subtest guc_multi_lrc: SUCCESS (4.507s) [632.161828] Starting dynamic subtest: guc_hang [637.231597] Dynamic subtest guc_hang: SUCCESS (5.081s) [637.241270] Starting dynamic subtest: late_gt_pm [641.658674] Dynamic subtest late_gt_pm: SUCCESS (4.426s) [641.661250] Subtest live: SUCCESS (254.279s) [641.693195] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [641.693916] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [641.697187] [077/131] (378s left) gem_userptr_blits (nohangcheck) [643.267894] Starting subtest: nohangcheck [643.525553] Subtest nohangcheck: SUCCESS (0.256s) [643.631727] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [643.632855] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [643.637070] [078/131] (376s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [643.740113] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [643.742248] Starting dynamic subtest: pipe-A-eDP-1 [644.573019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s) [644.581255] Starting dynamic subtest: pipe-B-eDP-1 [646.143670] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.568s) [646.154413] Starting dynamic subtest: pipe-C-eDP-1 [647.618790] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.475s) [647.628697] Starting dynamic subtest: pipe-D-eDP-1 [649.114349] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.496s) [649.116258] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.372s) [650.320964] [079/131] (370s left) gem_softpin (allocator-nopin) [650.381095] Starting subtest: allocator-nopin [650.475735] Subtest allocator-nopin: SUCCESS (0.094s) [650.599866] [080/131] (369s left) kms_draw_crc (draw-method-pwrite) [650.707153] Starting subtest: draw-method-pwrite [650.709315] Starting dynamic subtest: xrgb8888-untiled [651.239755] Dynamic subtest xrgb8888-untiled: SUCCESS (0.535s) [651.249066] Starting dynamic subtest: rgb565-untiled [651.676407] Dynamic subtest rgb565-untiled: SUCCESS (0.432s) [651.685853] Starting dynamic subtest: xrgb2101010-untiled [652.194747] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.521s) [652.205597] Starting dynamic subtest: xbgr16161616f-untiled [652.950412] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.756s) [652.959407] Starting dynamic subtest: xrgb8888-xtiled [654.693162] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.743s) [654.702490] Starting dynamic subtest: rgb565-xtiled [655.759327] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s) [655.768237] Starting dynamic subtest: xrgb2101010-xtiled [657.491404] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.731s) [657.502263] Starting dynamic subtest: xbgr16161616f-xtiled [660.633867] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.144s) [660.643245] Starting dynamic subtest: xrgb8888-4tiled [661.757014] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.121s) [661.766127] Starting dynamic subtest: rgb565-4tiled [662.299244] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s) [662.308488] Starting dynamic subtest: xrgb2101010-4tiled [663.354687] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.055s) [663.363818] Starting dynamic subtest: xbgr16161616f-4tiled [666.175964] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.821s) [666.178346] Subtest draw-method-pwrite: SUCCESS (15.480s) [666.318568] [081/131] (354s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [666.425651] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [666.429756] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [666.560337] [082/131] (354s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [666.651624] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [666.655741] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [666.790655] [083/131] (353s left) syncobj_timeline (host-signal-points) [666.846624] Starting subtest: host-signal-points [666.848905] Subtest host-signal-points: SUCCESS (0.004s) [666.995595] [084/131] (353s left) gem_mmap_gtt (basic-small-bo) [667.054696] Subtest basic-small-bo: SKIP (0.000s) [667.122682] [085/131] (353s left) perf_pmu (semaphore-wait-idle) [667.159478] Starting subtest: semaphore-wait-idle [667.161263] Starting dynamic subtest: rcs0 [667.674592] Dynamic subtest rcs0: SUCCESS (0.515s) [667.687125] Starting dynamic subtest: bcs0 [668.187027] Dynamic subtest bcs0: SUCCESS (0.510s) [668.198644] Starting dynamic subtest: vcs0 [668.700412] Dynamic subtest vcs0: SUCCESS (0.510s) [668.712235] Starting dynamic subtest: vcs1 [669.210678] Dynamic subtest vcs1: SUCCESS (0.509s) [669.223111] Starting dynamic subtest: vecs0 [669.725516] Dynamic subtest vecs0: SUCCESS (0.511s) [669.737414] Starting dynamic subtest: ccs0 [670.241468] Dynamic subtest ccs0: SUCCESS (0.513s) [670.244497] Subtest semaphore-wait-idle: SUCCESS (3.085s) [671.548465] [086/131] (349s left) kms_addfb_basic (no-handle) [671.602149] Starting subtest: no-handle [671.604090] Subtest no-handle: SUCCESS (0.000s) [671.775727] [087/131] (349s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [671.877106] Starting subtest: fbcpsr-rgb101010-draw-pwrite [678.819939] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.948s) [678.945723] [088/131] (341s left) gem_render_copy (yf-tiled-ccs-to-linear) [679.010938] Starting subtest: yf-tiled-ccs-to-linear [679.015297] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [679.218862] [089/131] (341s left) kms_flip (wf_vblank-ts-check) [679.318145] Starting subtest: wf_vblank-ts-check [679.320446] Starting dynamic subtest: A-eDP1 [688.268870] Dynamic subtest A-eDP1: SUCCESS (8.953s) [688.278711] Starting dynamic subtest: B-eDP1 [697.197042] Dynamic subtest B-eDP1: SUCCESS (8.928s) [697.208463] Starting dynamic subtest: C-eDP1 [706.117850] Dynamic subtest C-eDP1: SUCCESS (8.920s) [706.127075] Starting dynamic subtest: D-eDP1 [715.038482] Dynamic subtest D-eDP1: SUCCESS (8.922s) [715.040956] Subtest wf_vblank-ts-check: SUCCESS (35.733s) [716.280320] [090/131] (304s left) gem_exec_schedule (deep) [716.445723] Starting subtest: deep [716.447763] Starting dynamic subtest: rcs0 [721.694711] Dynamic subtest rcs0: SKIP (5.248s) [721.707731] Starting dynamic subtest: vcs0 [731.814730] Dynamic subtest vcs0: SUCCESS (10.121s) [731.827109] Starting dynamic subtest: vcs1 [743.818108] Dynamic subtest vcs1: SUCCESS (12.004s) [743.830634] Starting dynamic subtest: vecs0 [755.419579] Dynamic subtest vecs0: SUCCESS (11.600s) [755.432096] Starting dynamic subtest: ccs0 [767.779573] Dynamic subtest ccs0: SUCCESS (12.359s) [767.781823] Subtest deep: SUCCESS (51.337s) [769.141620] [091/131] (251s left) kms_sequence (queue-idle) [769.229012] Starting subtest: queue-idle [769.230987] Starting dynamic subtest: pipe-A-eDP-1 [771.044466] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s) [771.054496] Starting dynamic subtest: pipe-B-eDP-1 [773.522293] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.473s) [773.531696] Starting dynamic subtest: pipe-C-eDP-1 [775.956432] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.434s) [775.967445] Starting dynamic subtest: pipe-D-eDP-1 [778.379921] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s) [778.382367] Subtest queue-idle: SUCCESS (9.151s) [779.217760] [092/131] (241s left) gem_gtt_cpu_tlb [779.355435] [093/131] (241s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [779.456660] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [785.922022] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.468s) [786.087984] [094/131] (235s left) gem_eio (create-ext) [786.315231] Starting subtest: create-ext [786.630526] Subtest create-ext: SUCCESS (0.314s) [786.812664] [095/131] (234s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [786.866299] Subtest writes-after-reads-uncached: SKIP (0.000s) [786.943500] [096/131] (234s left) sysfs_preempt_timeout (idempotent) [786.998232] Starting subtest: idempotent [787.000198] Starting dynamic subtest: vecs0 [787.002158] Dynamic subtest vecs0: SUCCESS (0.000s) [787.011184] Starting dynamic subtest: ccs0 [787.012740] Dynamic subtest ccs0: SUCCESS (0.000s) [787.021384] Starting dynamic subtest: vcs0 [787.022940] Dynamic subtest vcs0: SUCCESS (0.000s) [787.031017] Starting dynamic subtest: bcs0 [787.032657] Dynamic subtest bcs0: SUCCESS (0.000s) [787.040824] Starting dynamic subtest: rcs0 [787.042460] Dynamic subtest rcs0: SUCCESS (0.000s) [787.050828] Starting dynamic subtest: vcs1 [787.052429] Dynamic subtest vcs1: SUCCESS (0.001s) [787.054073] Subtest idempotent: SUCCESS (0.007s) [787.141687] [097/131] (234s left) gem_busy (semaphore) [787.338408] Subtest semaphore: SKIP (0.000s) [787.604411] [098/131] (233s left) sriov_basic (enable-vfs-bind-unbind-each) [787.665310] Starting subtest: enable-vfs-bind-unbind-each [787.667458] Starting dynamic subtest: numvfs-1 [787.745402] Dynamic subtest numvfs-1: FAIL (0.029s) [787.754873] Starting dynamic subtest: numvfs-2 [787.826835] Dynamic subtest numvfs-2: FAIL (0.003s) [787.838126] Starting dynamic subtest: numvfs-3 [787.911365] Dynamic subtest numvfs-3: FAIL (0.003s) [787.921685] Starting dynamic subtest: numvfs-4 [787.994120] Dynamic subtest numvfs-4: FAIL (0.003s) [788.005157] Starting dynamic subtest: numvfs-5 [788.077465] Dynamic subtest numvfs-5: FAIL (0.003s) [788.088122] Starting dynamic subtest: numvfs-6 [788.160009] Dynamic subtest numvfs-6: FAIL (0.003s) [788.170966] Starting dynamic subtest: numvfs-7 [788.243309] Dynamic subtest numvfs-7: FAIL (0.003s) [788.253757] Starting dynamic subtest: numvfs-random [788.325339] Dynamic subtest numvfs-random: FAIL (0.004s) [788.327706] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s) [788.367398] [099/131] (232s left) kms_pm_lpsp (screens-disabled) [789.469387] Starting subtest: screens-disabled [789.473783] Subtest screens-disabled: SKIP (0.000s) [789.564401] [100/131] (231s left) gem_exec_capture (capture-invisible) [789.632838] Starting subtest: capture-invisible [789.635136] Starting dynamic subtest: smem0 [789.639625] Dynamic subtest smem0: SKIP (0.000s) [789.644157] Subtest capture-invisible: SKIP (0.001s) [789.758397] [101/131] (231s left) gem_lmem_swapping (verify-ccs) [789.807475] Subtest verify-ccs: SKIP (0.000s) [789.850213] [102/131] (231s left) kms_joiner (basic-force-ultra-joiner) [789.956604] Starting subtest: basic-force-ultra-joiner [789.961097] Subtest basic-force-ultra-joiner: SKIP (0.000s) [790.046112] [103/131] (231s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [790.146187] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [796.629351] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.484s) [796.765948] [104/131] (224s left) kms_color (legacy-gamma) [796.876194] Starting subtest: legacy-gamma [796.878079] Starting dynamic subtest: pipe-A-eDP-1 [797.586861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s) [797.596675] Starting dynamic subtest: pipe-B-eDP-1 [798.948124] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.361s) [798.958806] Starting dynamic subtest: pipe-C-eDP-1 [800.334346] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s) [800.345127] Starting dynamic subtest: pipe-D-eDP-1 [801.651283] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s) [801.653746] Subtest legacy-gamma: SUCCESS (4.776s) [802.509850] [105/131] (219s left) gem_exec_schedule (wide) [802.698549] Starting subtest: wide [802.701120] Starting dynamic subtest: rcs0 [812.769343] Dynamic subtest rcs0: SUCCESS (10.068s) [812.780688] Starting dynamic subtest: vcs0 [825.062280] Dynamic subtest vcs0: SUCCESS (12.291s) [825.073903] Starting dynamic subtest: vcs1 [836.360690] Dynamic subtest vcs1: SUCCESS (11.296s) [836.371726] Starting dynamic subtest: vecs0 [847.943619] Dynamic subtest vecs0: SUCCESS (11.579s) [847.958369] Starting dynamic subtest: ccs0 [860.695093] Dynamic subtest ccs0: SUCCESS (12.750s) [860.697687] Subtest wide: SUCCESS (57.990s) [863.573618] [106/131] (158s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [863.682846] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [863.684985] Starting dynamic subtest: pipe-A-default-mode [863.970945] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [863.975310] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.289s) [864.832874] [107/131] (156s left) kms_big_fb (linear-64bpp-rotate-180) [864.951722] Starting subtest: linear-64bpp-rotate-180 [866.586775] Subtest linear-64bpp-rotate-180: SUCCESS (1.636s) [866.804394] [108/131] (154s left) gem_ppgtt (blt-vs-render-ctxn) [866.866943] Starting subtest: blt-vs-render-ctxN [900.006335] Subtest blt-vs-render-ctxN: SUCCESS (33.134s) [900.178481] [109/131] (121s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [900.329933] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [900.334040] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [900.463158] [110/131] (121s left) kms_chamelium_frames (dp-frame-dump) [900.835270] Subtest dp-frame-dump: SKIP (0.000s) [901.611243] [111/131] (120s left) kms_psr2_su (page_flip-nv12) [901.676145] Subtest page_flip-NV12: SKIP (0.000s) [901.748448] [112/131] (120s left) gem_tiling_max_stride [901.868382] [113/131] (120s left) perf_pmu (busy-idle) [901.910270] Starting subtest: busy-idle [901.912464] Starting dynamic subtest: rcs0 [902.633646] Dynamic subtest rcs0: SUCCESS (0.724s) [902.645877] Starting dynamic subtest: bcs0 [903.312496] Dynamic subtest bcs0: SUCCESS (0.677s) [903.324906] Starting dynamic subtest: vcs0 [904.475260] Dynamic subtest vcs0: SUCCESS (1.159s) [904.487943] Starting dynamic subtest: vcs1 [906.458594] Dynamic subtest vcs1: SUCCESS (1.980s) [906.471719] Starting dynamic subtest: vecs0 [908.443213] Dynamic subtest vecs0: SUCCESS (1.982s) [908.455754] Starting dynamic subtest: ccs0 [909.110551] Dynamic subtest ccs0: SUCCESS (0.666s) [909.113064] Subtest busy-idle: SUCCESS (7.204s) [909.234434] [114/131] (112s left) dmabuf_sync_file (export-before-signal) [909.283126] Starting subtest: export-before-signal [909.284945] Subtest export-before-signal: SUCCESS (0.001s) [909.361307] [115/131] (112s left) gem_exec_reloc (basic-cpu-read) [909.419321] Subtest basic-cpu-read: SKIP (0.000s) [909.500117] [116/131] (112s left) kms_hdr (bpc-switch) [909.618729] Starting subtest: bpc-switch [910.709460] Starting dynamic subtest: pipe-A-eDP-1 [914.213808] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.504s) [914.216861] Subtest bpc-switch: SUCCESS (4.597s) [914.381341] [117/131] (107s left) perf (i915-ref-count) [914.495750] Starting subtest: i915-ref-count [914.563154] Subtest i915-ref-count: SUCCESS (0.069s) [914.624350] [118/131] (107s left) gem_ctx_isolation (nonpriv) [914.697583] Starting subtest: nonpriv [914.699917] Starting dynamic subtest: rcs0 [914.915255] Dynamic subtest rcs0: SUCCESS (0.222s) [914.927704] Starting dynamic subtest: bcs0 [915.189899] Dynamic subtest bcs0: SUCCESS (0.273s) [915.203030] Starting dynamic subtest: vcs0 [915.463556] Dynamic subtest vcs0: SUCCESS (0.273s) [915.475921] Starting dynamic subtest: vcs1 [916.681104] Dynamic subtest vcs1: SUCCESS (1.216s) [916.693705] Starting dynamic subtest: vecs0 [918.683344] Dynamic subtest vecs0: SUCCESS (2.002s) [918.696036] Starting dynamic subtest: ccs0 [920.771998] Dynamic subtest ccs0: SUCCESS (2.088s) [920.774482] Subtest nonpriv: SUCCESS (6.080s) [921.045986] [119/131] (101s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [921.104631] Starting subtest: y-tiled-to-vebox-x-tiled [921.109353] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [921.318013] [120/131] (100s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [921.414382] Starting subtest: plane-use-after-nonblocking-unbind [921.416793] Starting dynamic subtest: pipe-A-eDP-1 [921.473118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s) [921.773130] Starting dynamic subtest: pipe-B-eDP-1 [922.560620] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.797s) [922.858528] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.446s) [923.741315] [121/131] ( 98s left) i915_hangman (engine-error-state-capture) [923.808536] Starting subtest: engine-error-state-capture [923.810884] Starting dynamic subtest: rcs0 [927.417681] Dynamic subtest rcs0: SUCCESS (3.607s) [927.431174] Starting dynamic subtest: bcs0 [933.433702] Dynamic subtest bcs0: SUCCESS (6.014s) [933.448711] Starting dynamic subtest: vcs0 [939.385360] Dynamic subtest vcs0: SUCCESS (5.949s) [939.397976] Starting dynamic subtest: vcs1 [945.337452] Dynamic subtest vcs1: SUCCESS (5.949s) [945.350740] Starting dynamic subtest: vecs0 [950.393394] Dynamic subtest vecs0: SUCCESS (5.054s) [950.406872] Starting dynamic subtest: ccs0 [956.408908] Dynamic subtest ccs0: SUCCESS (6.013s) [956.411852] Subtest engine-error-state-capture: SUCCESS (32.603s) [956.516709] [122/131] ( 65s left) gem_exec_schedule (pi-shared-iova) [956.702689] Starting subtest: pi-shared-iova [956.704948] Starting dynamic subtest: rcs0 [956.828991] Dynamic subtest rcs0: SUCCESS (0.133s) [956.838853] Starting dynamic subtest: vcs0 [956.914772] Dynamic subtest vcs0: SUCCESS (0.084s) [956.930942] Starting dynamic subtest: vcs1 [957.004568] Dynamic subtest vcs1: SUCCESS (0.089s) [957.016034] Starting dynamic subtest: vecs0 [957.086206] Dynamic subtest vecs0: SUCCESS (0.081s) [957.100967] Starting dynamic subtest: ccs0 [957.217821] Dynamic subtest ccs0: SUCCESS (0.129s) [957.220773] Subtest pi-shared-iova: SUCCESS (0.522s) [958.562636] [123/131] ( 63s left) syncobj_wait (invalid-reset-illegal-handle) [958.620801] Starting subtest: invalid-reset-illegal-handle [958.623114] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [958.761093] [124/131] ( 63s left) syncobj_wait (single-wait-all-for-submit-signaled) [958.826457] Starting subtest: single-wait-all-for-submit-signaled [958.828685] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [958.977481] [125/131] ( 63s left) kms_cursor_crc (cursor-sliding-512x170) [959.275770] Starting subtest: cursor-sliding-512x170 [959.280230] Subtest cursor-sliding-512x170: SKIP (0.001s) [959.469546] [126/131] ( 62s left) kms_chamelium_hpd (hdmi-hpd-fast) [959.860882] Subtest hdmi-hpd-fast: SKIP (0.000s) [960.634280] [127/131] ( 61s left) gem_ctx_persistence (hostile) [960.707817] Starting subtest: hostile [970.850762] Subtest hostile: SUCCESS (10.138s) [971.025941] [128/131] ( 51s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [971.132750] Starting subtest: fbc-rgb565-draw-blt [975.363634] Subtest fbc-rgb565-draw-blt: SUCCESS (4.234s) [976.581513] [129/131] ( 45s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [976.676638] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [985.643827] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (8.969s) [985.815446] [130/131] ( 36s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [985.910359] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [985.914287] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [986.024018] [131/131] ( 36s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [986.115721] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [986.119923] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [986.243942] 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.