[61.532355] Initializing watchdogs [61.532403] /dev/watchdog0 [61.552756] [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] [61.556995] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.559336] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.562214] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [61.697844] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [61.702315] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [61.832127] [002/131] (960s left) gem_exec_fence (submit3) [62.019312] Starting subtest: submit3 [62.024185] Subtest submit3: SKIP (0.000s) [64.035825] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [64.039007] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [64.152967] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [64.157365] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [64.273580] [004/131] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [64.368886] Starting subtest: fbc-rgb101010-draw-mmap-wc [68.975431] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.611s) [70.123330] [005/131] (952s left) gem_exec_balancer (noheartbeat) [70.386178] Starting subtest: noheartbeat [70.390642] Subtest noheartbeat: SKIP (0.000s) [70.510379] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [70.603296] Subtest ctm-blue-to-red: SKIP (0.000s) [70.647232] [007/131] (951s left) gem_workarounds (suspend-resume) [70.729840] Starting subtest: suspend-resume [86.708043] Subtest suspend-resume: SUCCESS (4.944s) [87.874688] [008/131] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [87.993045] Starting subtest: planes-downscale-factor-0-75-unity-scaling [87.995413] Starting dynamic subtest: pipe-A [88.056496] Dynamic subtest pipe-A: SUCCESS (0.065s) [88.067459] Starting dynamic subtest: pipe-B [89.194063] Dynamic subtest pipe-B: SUCCESS (1.136s) [89.206958] Starting dynamic subtest: pipe-C [90.301653] Dynamic subtest pipe-C: SUCCESS (1.106s) [90.310026] Starting dynamic subtest: pipe-D [91.433478] Dynamic subtest pipe-D: SUCCESS (1.130s) [91.435926] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.441s) [92.609590] [009/131] (930s left) gem_pxp (create-regular-buffer) [92.747699] Starting subtest: create-regular-buffer [92.750188] Subtest create-regular-buffer: SUCCESS (0.000s) [92.873877] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [92.933967] Starting subtest: rel-constants-invalid-rel-gen5 [92.936294] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [93.065822] [011/131] (930s left) gem_exec_nop (basic-series) [93.149096] Starting subtest: basic-series [108.914738] Subtest basic-series: SUCCESS (15.772s) [109.181115] [012/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [109.293261] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [109.297463] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [109.440802] [013/131] (914s left) kms_psr (fbc-psr-primary-page-flip) [109.540930] Starting subtest: fbc-psr-primary-page-flip [109.543111] Starting dynamic subtest: eDP-1 [109.547471] Dynamic subtest eDP-1: SKIP (0.000s) [109.552087] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [109.640970] [014/131] (913s left) i915_pm_rps (engine-order) [109.714744] Starting subtest: engine-order [114.659050] Subtest engine-order: SUCCESS (4.943s) [114.831257] [015/131] (908s left) gem_softpin (evict-active) [114.900833] Starting subtest: evict-active [114.911126] Subtest evict-active: SUCCESS (0.010s) [115.082089] [016/131] (908s left) syncobj_timeline (wait-delayed-signal) [115.144797] Starting subtest: wait-delayed-signal [115.248321] Subtest wait-delayed-signal: SUCCESS (0.103s) [115.356723] [017/131] (908s left) kms_panel_fitting (atomic-fastset) [115.453298] Starting subtest: atomic-fastset [115.455755] Starting dynamic subtest: pipe-A-eDP-1 [115.598250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s) [115.609576] Starting dynamic subtest: pipe-B-eDP-1 [116.836474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.238s) [116.849579] Starting dynamic subtest: pipe-C-eDP-1 [118.035569] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.198s) [118.044735] Starting dynamic subtest: pipe-D-eDP-1 [119.170504] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [119.172727] Subtest atomic-fastset: SUCCESS (3.717s) [120.437233] [018/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-270) [120.549077] Starting subtest: x-tiled-16bpp-rotate-270 [120.568242] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [120.729144] [019/131] (903s left) api_intel_bb (render-ccs) [120.790743] Starting subtest: render-ccs [121.147740] Subtest render-ccs: SUCCESS (0.357s) [121.302530] [020/131] (902s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [121.398939] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [121.401332] Starting dynamic subtest: pipe-A-eDP-1 [121.424979] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [121.436049] Starting dynamic subtest: pipe-B-eDP-1 [121.457025] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [121.465684] Starting dynamic subtest: pipe-C-eDP-1 [121.487640] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [121.498409] Starting dynamic subtest: pipe-D-eDP-1 [121.520384] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [121.524835] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [123.626383] [021/131] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [123.684653] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [123.787974] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s) [123.885784] [022/131] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [123.994658] Starting subtest: psr-2p-primscrn-cur-indfb-move [123.999047] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [124.133907] [023/131] (899s left) gem_lmem_swapping (heavy-multi) [124.172867] Subtest heavy-multi: SKIP (0.000s) [124.218714] [024/131] (899s left) kms_async_flips (test-cursor) [124.321036] Starting subtest: test-cursor [124.325367] Subtest test-cursor: SKIP (0.000s) [125.547666] [025/131] (898s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [130.587437] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [130.589880] Starting dynamic subtest: pipe-A-eDP-1 [131.403225] Dynamic subtest pipe-A-eDP-1: SKIP (0.812s) [131.412920] Starting dynamic subtest: pipe-B-eDP-1 [132.530949] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s) [132.535681] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.941s) [133.736018] [026/131] (890s left) kms_plane_multiple (2x-tiling-4) [133.821128] Starting subtest: 2x-tiling-4 [133.825363] Subtest 2x-tiling-4: SKIP (0.000s) [133.914989] [027/131] (890s left) gem_ctx_param (invalid-param-set) [133.982730] Starting subtest: invalid-param-set [133.985169] Subtest invalid-param-set: SUCCESS (0.000s) [134.080594] [028/131] (890s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [134.182635] Starting subtest: bad-pixel-format-y-tiled-ccs [134.184934] Starting dynamic subtest: pipe-A-eDP-1 [134.207243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [134.216598] Starting dynamic subtest: pipe-B-eDP-1 [134.238054] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [134.246329] Starting dynamic subtest: pipe-C-eDP-1 [134.267714] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [134.276105] Starting dynamic subtest: pipe-D-eDP-1 [134.298429] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [134.302834] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [136.503996] [029/131] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [136.595578] Starting subtest: plane-downscale-factor-0-5-with-modifiers [136.597928] Starting dynamic subtest: pipe-A [136.621610] Dynamic subtest pipe-A: SKIP (0.020s) [136.632514] Starting dynamic subtest: pipe-B [136.656973] Dynamic subtest pipe-B: SKIP (0.036s) [136.665741] Starting dynamic subtest: pipe-C [136.689974] Dynamic subtest pipe-C: SKIP (0.031s) [136.698603] Starting dynamic subtest: pipe-D [136.720663] Dynamic subtest pipe-D: SKIP (0.031s) [136.725188] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.119s) [136.876367] [030/131] (887s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [136.933715] Starting subtest: multi-wait-all-available-submitted-signaled [136.935945] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [137.073564] [031/131] (887s left) perf (missing-sample-flags) [137.214824] Starting subtest: missing-sample-flags [137.216728] Subtest missing-sample-flags: SUCCESS (0.000s) [137.255101] [032/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [137.363810] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [143.534399] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.174s) [144.714620] [033/131] (879s left) kms_pm_rpm (system-suspend-idle) [146.272501] Starting subtest: system-suspend-idle [165.936820] Subtest system-suspend-idle: SUCCESS (4.325s) [166.324405] [034/131] (858s left) kms_vblank (wait-forked) [166.428718] Starting subtest: wait-forked [166.430905] Starting dynamic subtest: pipe-A-eDP-1 [168.226718] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.796s) [168.241989] Starting dynamic subtest: pipe-D-eDP-1 [170.689839] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.461s) [170.692247] Subtest wait-forked: SUCCESS (4.261s) [171.608207] [035/131] (852s left) kms_big_fb (y-tiled-32bpp-rotate-0) [171.708062] Starting subtest: y-tiled-32bpp-rotate-0 [171.712509] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [171.843904] [036/131] (852s left) kms_pipe_crc_basic (read-crc) [171.940555] Starting subtest: read-crc [171.942414] Starting dynamic subtest: pipe-A-eDP-1 [172.649715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [172.664097] Starting dynamic subtest: pipe-B-eDP-1 [174.096958] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.448s) [174.113816] Starting dynamic subtest: pipe-C-eDP-1 [175.450647] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.352s) [175.460493] Starting dynamic subtest: pipe-D-eDP-1 [176.798289] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s) [176.800292] Subtest read-crc: SUCCESS (4.857s) [177.635916] [037/131] (846s left) kms_cursor_legacy (single-move) [177.757998] Starting subtest: single-move [177.760171] Starting dynamic subtest: pipe-A [183.138610] Dynamic subtest pipe-A: SUCCESS (5.379s) [183.147739] Starting dynamic subtest: pipe-B [188.524763] Dynamic subtest pipe-B: SUCCESS (5.384s) [188.534754] Starting dynamic subtest: pipe-C [193.907756] Dynamic subtest pipe-C: SUCCESS (5.380s) [193.918899] Starting dynamic subtest: pipe-D [199.289791] Dynamic subtest pipe-D: SUCCESS (5.380s) [199.301246] Starting dynamic subtest: all-pipes [204.678097] Dynamic subtest all-pipes: SUCCESS (5.387s) [204.680618] Subtest single-move: SUCCESS (26.918s) [204.844866] [038/131] (819s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [209.978125] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [209.982777] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s) [210.861790] [039/131] (813s left) gem_unref_active_buffers [211.092977] [040/131] (813s left) kms_psr (fbc-psr2-primary-mmap-gtt) [211.192766] Starting subtest: fbc-psr2-primary-mmap-gtt [211.194909] Starting dynamic subtest: eDP-1 [211.198869] Dynamic subtest eDP-1: SKIP (0.000s) [211.202894] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [211.287870] [041/131] (813s left) syncobj_wait (invalid-signal-zero-handles) [211.351989] Starting subtest: invalid-signal-zero-handles [211.354252] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [211.489583] [042/131] (813s left) gen9_exec_parse (bb-oversize) [211.566818] Subtest bb-oversize: SKIP (0.000s) [211.658575] [043/131] (813s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [211.720075] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [211.825949] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s) [211.921934] [044/131] (812s left) gem_exec_reloc (basic-write-cpu-noreloc) [211.998016] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [212.094618] [045/131] (812s left) gem_mmap_offset (bad-flags) [212.155183] Starting subtest: bad-flags [212.157157] Subtest bad-flags: SUCCESS (0.000s) [212.293261] [046/131] (812s left) kms_cursor_legacy (cursor-vs-flip-legacy) [212.414433] Starting subtest: cursor-vs-flip-legacy [241.749295] Subtest cursor-vs-flip-legacy: SUCCESS (29.335s) [242.604584] [047/131] (782s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [242.707753] Starting subtest: sprite-rotation-90-pos-100-0 [242.711947] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [242.803894] [048/131] (782s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [242.915514] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [243.917685] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.002s) [244.071584] [049/131] (780s left) gem_create (busy-create) [244.134823] Starting subtest: busy-create [244.136692] Starting dynamic subtest: smem0 [278.324356] Dynamic subtest smem0: SUCCESS (34.188s) [278.327269] Subtest busy-create: SUCCESS (34.190s) [278.536054] [050/131] (746s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [278.657774] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [282.838672] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.183s) [284.016988] [051/131] (741s left) perf (invalid-open-flags) [284.127378] Starting subtest: invalid-open-flags [284.129630] Subtest invalid-open-flags: SUCCESS (0.000s) [284.170611] [052/131] (740s left) perf (oa-formats) [284.267397] Starting subtest: oa-formats [284.269902] Starting dynamic subtest: 0-rcs0 [284.281786] Dynamic subtest 0-rcs0: SUCCESS (0.015s) [284.292033] Starting dynamic subtest: 1-vcs1 [284.304581] Dynamic subtest 1-vcs1: SUCCESS (0.022s) [284.306768] Subtest oa-formats: SUCCESS (0.038s) [284.344806] [053/131] (740s left) kms_big_fb (4-tiled-8bpp-rotate-270) [284.450299] Starting subtest: 4-tiled-8bpp-rotate-270 [284.470945] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [284.633744] [054/131] (740s left) kms_cursor_crc (cursor-onscreen-64x21) [284.805540] Starting subtest: cursor-onscreen-64x21 [284.853858] Subtest cursor-onscreen-64x21: SKIP (0.043s) [285.112650] [055/131] (740s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [285.205717] Starting subtest: primary-4-tiled-reflect-x-180 [292.276124] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.071s) [293.490442] [056/131] (731s left) kms_cursor_crc (cursor-onscreen-256x256) [293.715509] Starting subtest: cursor-onscreen-256x256 [293.720388] Starting dynamic subtest: pipe-A-eDP-1 [295.974122] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.252s) [296.002286] Starting dynamic subtest: pipe-D-eDP-1 [298.739761] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.745s) [298.742176] Subtest cursor-onscreen-256x256: SUCCESS (5.024s) [299.645303] [057/131] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [299.757554] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [307.154741] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.399s) [307.349546] [058/131] (718s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [307.446565] Starting subtest: async-flip-with-page-flip-events-tiled [307.817143] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [310.615058] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.796s) [310.624803] Starting dynamic subtest: pipe-A-eDP-1-4 [312.788832] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s) [312.798311] Starting dynamic subtest: pipe-A-eDP-1-4 [314.799160] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [314.808522] Starting dynamic subtest: pipe-A-eDP-1-x [316.977781] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s) [317.360370] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [320.145537] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.793s) [320.159038] Starting dynamic subtest: pipe-B-eDP-1-4 [322.343129] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s) [322.352620] Starting dynamic subtest: pipe-B-eDP-1-4 [324.353385] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [324.362914] Starting dynamic subtest: pipe-B-eDP-1-x [326.543607] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [326.932000] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [329.683364] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.757s) [329.692943] Starting dynamic subtest: pipe-C-eDP-1-4 [331.846791] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s) [331.857599] Starting dynamic subtest: pipe-C-eDP-1-4 [333.857348] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s) [333.867390] Starting dynamic subtest: pipe-C-eDP-1-x [336.025291] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s) [336.398370] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [339.126088] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.733s) [339.137536] Starting dynamic subtest: pipe-D-eDP-1-4 [341.290351] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.164s) [341.299979] Starting dynamic subtest: pipe-D-eDP-1-4 [343.298744] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [343.308541] Starting dynamic subtest: pipe-D-eDP-1-x [345.478958] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [345.481259] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.032s) [346.739136] [059/131] (678s left) perf (polling) [346.839615] Starting subtest: polling [346.842107] Starting dynamic subtest: 0-rcs0 [356.865174] Dynamic subtest 0-rcs0: SUCCESS (10.023s) [356.874521] Starting dynamic subtest: 1-vcs0 [366.889131] Dynamic subtest 1-vcs0: SUCCESS (10.022s) [366.891786] Subtest polling: SUCCESS (20.047s) [366.943997] [060/131] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [367.046343] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [367.050474] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [367.183840] [061/131] (658s left) syncobj_timeline (reset-signaled) [367.240110] Starting subtest: reset-signaled [367.242453] Subtest reset-signaled: SUCCESS (0.001s) [367.379548] [062/131] (658s left) kms_rmfb (rmfb-ioctl) [367.484997] Starting subtest: rmfb-ioctl [367.487243] Starting dynamic subtest: pipe-A-eDP-1 [367.588380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [367.600106] Starting dynamic subtest: pipe-B-eDP-1 [368.777912] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.188s) [368.788715] Starting dynamic subtest: pipe-C-eDP-1 [369.905020] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s) [369.917898] Starting dynamic subtest: pipe-D-eDP-1 [371.032551] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s) [371.035164] Subtest rmfb-ioctl: SUCCESS (3.552s) [372.275589] [063/131] (653s left) gem_userptr_blits (create-destroy-sync) [372.352011] Starting subtest: create-destroy-sync [377.370988] Subtest create-destroy-sync: SUCCESS (5.019s) [377.537601] [064/131] (648s left) gem_exec_reloc (basic-gtt-cpu-active) [377.603906] Subtest basic-gtt-cpu-active: SKIP (0.000s) [377.693748] [065/131] (647s left) api_intel_allocator (execbuf-with-allocator) [377.748606] Starting subtest: execbuf-with-allocator [377.755875] Subtest execbuf-with-allocator: SUCCESS (0.009s) [377.876695] [066/131] (647s left) kms_lease (cursor-implicit-plane) [377.984876] Starting subtest: cursor-implicit-plane [377.987216] Starting dynamic subtest: pipe-A-eDP-1 [378.442424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [378.452413] Starting dynamic subtest: pipe-B-eDP-1 [379.582423] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.140s) [379.592540] Starting dynamic subtest: pipe-C-eDP-1 [380.697469] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s) [380.707412] Starting dynamic subtest: pipe-D-eDP-1 [381.829798] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s) [381.832154] Subtest cursor-implicit-plane: SUCCESS (3.845s) [382.701165] [067/131] (643s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [382.813749] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [382.818113] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [382.986152] [068/131] (642s left) syncobj_wait (invalid-signal-illegal-handle) [383.052030] Starting subtest: invalid-signal-illegal-handle [383.054282] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [383.189060] [069/131] (642s left) kms_psr (psr-primary-blt) [383.296509] Starting subtest: psr-primary-blt [383.298769] Starting dynamic subtest: eDP-1 [385.080192] Dynamic subtest eDP-1: SUCCESS (1.782s) [385.082561] Subtest psr-primary-blt: SUCCESS (1.783s) [385.965268] [070/131] (639s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [386.072798] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [386.074955] Starting dynamic subtest: pipe-A-eDP-1 [386.132313] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [386.143772] Starting dynamic subtest: pipe-B-eDP-1 [386.200175] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [386.210783] Starting dynamic subtest: pipe-C-eDP-1 [386.266932] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [386.277106] Starting dynamic subtest: pipe-D-eDP-1 [386.335791] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [386.340326] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.010s) [388.431146] [071/131] (637s left) kms_psr (pr-primary-blt) [388.534568] Starting subtest: pr-primary-blt [388.538916] Subtest pr-primary-blt: SKIP (0.000s) [388.653960] [072/131] (637s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [388.752645] Starting subtest: psr-2p-primscrn-spr-indfb-move [388.756947] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [388.899941] [073/131] (637s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [388.997045] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [388.999314] Starting dynamic subtest: pipe-A-default-mode [390.167356] Dynamic subtest pipe-A-default-mode: SKIP (1.169s) [390.172075] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.170s) [390.364876] [074/131] (635s left) gem_exec_schedule (u-semaphore-noskip) [390.449831] Starting subtest: u-semaphore-noskip [390.844551] Subtest u-semaphore-noskip: SUCCESS (0.397s) [391.236688] [075/131] (634s left) i915_drm_fdinfo (memory-info-idle) [391.272997] Starting subtest: memory-info-idle [391.274899] Starting dynamic subtest: smem0 [391.355439] Dynamic subtest smem0: SUCCESS (0.084s) [391.358158] Subtest memory-info-idle: SUCCESS (0.085s) [391.454219] [076/131] (634s left) i915_selftest (live) [395.010053] Starting subtest: live [395.012447] Starting dynamic subtest: sanitycheck [399.465542] Dynamic subtest sanitycheck: SUCCESS (4.454s) [399.475684] Starting dynamic subtest: uncore [402.342420] Dynamic subtest uncore: SUCCESS (2.875s) [402.357775] Starting dynamic subtest: workarounds [407.134103] Dynamic subtest workarounds: SUCCESS (4.790s) [407.144466] Starting dynamic subtest: gt_engines [411.891827] Dynamic subtest gt_engines: SUCCESS (4.755s) [411.901796] Starting dynamic subtest: gt_timelines [429.687292] Dynamic subtest gt_timelines: SUCCESS (17.792s) [429.697699] Starting dynamic subtest: gt_contexts [434.174561] Dynamic subtest gt_contexts: SUCCESS (4.485s) [434.184775] Starting dynamic subtest: gt_lrc [439.148379] Dynamic subtest gt_lrc: SUCCESS (4.971s) [439.158594] Starting dynamic subtest: gt_mocs [442.358261] Dynamic subtest gt_mocs: SUCCESS (3.208s) [442.368013] Starting dynamic subtest: gt_pm [449.214015] Dynamic subtest gt_pm: SUCCESS (6.853s) [449.224917] Starting dynamic subtest: gt_heartbeat [453.721085] Dynamic subtest gt_heartbeat: SUCCESS (4.505s) [453.731232] Starting dynamic subtest: gt_tlb [463.110104] Dynamic subtest gt_tlb: SUCCESS (9.386s) [463.120188] Starting dynamic subtest: requests [476.810738] Dynamic subtest requests: SUCCESS (13.698s) [476.820575] Starting dynamic subtest: migrate [484.822300] Dynamic subtest migrate: SUCCESS (8.009s) [484.832751] Starting dynamic subtest: active [489.392630] Dynamic subtest active: SUCCESS (4.568s) [489.402391] Starting dynamic subtest: objects [494.228270] Dynamic subtest objects: SUCCESS (4.833s) [494.237818] Starting dynamic subtest: mman [499.175786] Dynamic subtest mman: SUCCESS (4.946s) [499.185957] Starting dynamic subtest: dmabuf [502.094474] Dynamic subtest dmabuf: SUCCESS (2.916s) [502.104973] Starting dynamic subtest: vma [506.569598] Dynamic subtest vma: SUCCESS (4.473s) [506.579345] Starting dynamic subtest: coherency [511.820047] Dynamic subtest coherency: SUCCESS (5.247s) [511.829487] Starting dynamic subtest: gtt [523.865103] Dynamic subtest gtt: SUCCESS (12.042s) [523.875321] Starting dynamic subtest: gem [532.185782] Dynamic subtest gem: SUCCESS (8.319s) [532.197713] Starting dynamic subtest: evict [536.347027] Dynamic subtest evict: SUCCESS (4.158s) [536.356759] Starting dynamic subtest: hugepages [545.568772] Dynamic subtest hugepages: SUCCESS (9.219s) [545.577665] Starting dynamic subtest: gem_contexts [574.353772] Dynamic subtest gem_contexts: SUCCESS (28.782s) [574.362535] Starting dynamic subtest: client [577.244380] Dynamic subtest client: SUCCESS (2.888s) [577.254419] Starting dynamic subtest: gem_migrate [581.740632] Dynamic subtest gem_migrate: SUCCESS (4.493s) [581.750815] Starting dynamic subtest: reset [586.116641] Dynamic subtest reset: SUCCESS (4.374s) [586.126943] Starting dynamic subtest: memory_region [590.474064] Dynamic subtest memory_region: SUCCESS (4.355s) [590.484692] Starting dynamic subtest: hangcheck [603.762050] Dynamic subtest hangcheck: SUCCESS (13.286s) [603.772025] Starting dynamic subtest: execlists [608.280043] Dynamic subtest execlists: SUCCESS (4.516s) [608.290317] Starting dynamic subtest: ring_submission [612.730131] Dynamic subtest ring_submission: SUCCESS (4.446s) [612.740483] Starting dynamic subtest: perf [617.188116] Dynamic subtest perf: SUCCESS (4.456s) [617.198012] Starting dynamic subtest: slpc [631.334033] Dynamic subtest slpc: SUCCESS (14.143s) [631.344105] Starting dynamic subtest: guc [635.375230] Dynamic subtest guc: SUCCESS (4.038s) [635.385818] Starting dynamic subtest: guc_multi_lrc [639.797183] Dynamic subtest guc_multi_lrc: SUCCESS (4.420s) [639.807895] Starting dynamic subtest: guc_hang [644.851073] Dynamic subtest guc_hang: SUCCESS (5.052s) [644.861174] Starting dynamic subtest: late_gt_pm [649.291590] Dynamic subtest late_gt_pm: SUCCESS (4.438s) [649.294525] Subtest live: SUCCESS (254.271s) [649.323986] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [649.324696] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [649.327382] [077/131] (376s left) gem_userptr_blits (nohangcheck) [650.943424] Starting subtest: nohangcheck [651.237951] Subtest nohangcheck: SUCCESS (0.291s) [651.337846] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [651.339009] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [651.342213] [078/131] (374s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [651.450056] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [651.452342] Starting dynamic subtest: pipe-A-eDP-1 [652.307373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s) [652.317471] Starting dynamic subtest: pipe-B-eDP-1 [653.856641] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [653.870160] Starting dynamic subtest: pipe-C-eDP-1 [655.336187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.478s) [655.346422] Starting dynamic subtest: pipe-D-eDP-1 [656.882865] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.546s) [656.884778] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.424s) [658.079424] [079/131] (368s left) gem_softpin (allocator-nopin) [658.152483] Starting subtest: allocator-nopin [658.245079] Subtest allocator-nopin: SUCCESS (0.093s) [658.392741] [080/131] (367s left) kms_draw_crc (draw-method-pwrite) [658.504472] Starting subtest: draw-method-pwrite [658.506777] Starting dynamic subtest: xrgb8888-untiled [659.171077] Dynamic subtest xrgb8888-untiled: SUCCESS (0.668s) [659.180248] Starting dynamic subtest: rgb565-untiled [659.715264] Dynamic subtest rgb565-untiled: SUCCESS (0.543s) [659.724985] Starting dynamic subtest: xrgb2101010-untiled [660.371026] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.655s) [660.381057] Starting dynamic subtest: xbgr16161616f-untiled [661.204473] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.833s) [661.213666] Starting dynamic subtest: xrgb8888-xtiled [663.416877] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.211s) [663.426954] Starting dynamic subtest: rgb565-xtiled [664.860104] Dynamic subtest rgb565-xtiled: SUCCESS (1.441s) [664.872090] Starting dynamic subtest: xrgb2101010-xtiled [667.049168] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.188s) [667.058664] Starting dynamic subtest: xbgr16161616f-xtiled [670.860317] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.810s) [670.870114] Starting dynamic subtest: xrgb8888-4tiled [672.216113] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.355s) [672.225685] Starting dynamic subtest: rgb565-4tiled [672.938374] Dynamic subtest rgb565-4tiled: SUCCESS (0.722s) [672.948047] Starting dynamic subtest: xrgb2101010-4tiled [674.282964] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.344s) [674.292789] Starting dynamic subtest: xbgr16161616f-4tiled [677.683288] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.399s) [677.685594] Subtest draw-method-pwrite: SUCCESS (19.180s) [677.811725] [081/131] (348s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [677.932809] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [677.937343] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [678.056240] [082/131] (348s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [678.154270] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [678.158678] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [678.285732] [083/131] (348s left) syncobj_timeline (host-signal-points) [678.343297] Starting subtest: host-signal-points [678.345310] Subtest host-signal-points: SUCCESS (0.004s) [678.482739] [084/131] (347s left) gem_mmap_gtt (basic-small-bo) [678.543460] Subtest basic-small-bo: SKIP (0.000s) [678.602884] [085/131] (347s left) perf_pmu (semaphore-wait-idle) [678.644871] Starting subtest: semaphore-wait-idle [678.646691] Starting dynamic subtest: rcs0 [679.158580] Dynamic subtest rcs0: SUCCESS (0.513s) [679.171114] Starting dynamic subtest: bcs0 [679.671560] Dynamic subtest bcs0: SUCCESS (0.510s) [679.683978] Starting dynamic subtest: vcs0 [680.185325] Dynamic subtest vcs0: SUCCESS (0.510s) [680.197375] Starting dynamic subtest: vcs1 [680.698386] Dynamic subtest vcs1: SUCCESS (0.510s) [680.711067] Starting dynamic subtest: vecs0 [681.212345] Dynamic subtest vecs0: SUCCESS (0.512s) [681.225043] Starting dynamic subtest: ccs0 [681.728076] Dynamic subtest ccs0: SUCCESS (0.513s) [681.731145] Subtest semaphore-wait-idle: SUCCESS (3.085s) [681.871842] [086/131] (344s left) kms_addfb_basic (no-handle) [681.934167] Starting subtest: no-handle [681.936132] Subtest no-handle: SUCCESS (0.000s) [682.101612] [087/131] (344s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [682.206207] Starting subtest: fbcpsr-rgb101010-draw-pwrite [689.149955] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.945s) [689.299219] [088/131] (337s left) gem_render_copy (yf-tiled-ccs-to-linear) [689.371877] Starting subtest: yf-tiled-ccs-to-linear [689.376066] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [689.577620] [089/131] (337s left) kms_flip (wf_vblank-ts-check) [689.675475] Starting subtest: wf_vblank-ts-check [689.677794] Starting dynamic subtest: A-eDP1 [698.596265] Dynamic subtest A-eDP1: SUCCESS (8.922s) [698.608170] Starting dynamic subtest: B-eDP1 [707.530961] Dynamic subtest B-eDP1: SUCCESS (8.933s) [707.542815] Starting dynamic subtest: C-eDP1 [716.444110] Dynamic subtest C-eDP1: SUCCESS (8.910s) [716.453565] Starting dynamic subtest: D-eDP1 [725.376271] Dynamic subtest D-eDP1: SUCCESS (8.931s) [725.378668] Subtest wf_vblank-ts-check: SUCCESS (35.704s) [726.617123] [090/131] (300s left) gem_exec_schedule (deep) [726.806999] Starting subtest: deep [726.809310] Starting dynamic subtest: rcs0 [731.517959] Dynamic subtest rcs0: SKIP (4.709s) [731.530156] Starting dynamic subtest: vcs0 [741.608771] Dynamic subtest vcs0: SUCCESS (10.092s) [741.618423] Starting dynamic subtest: vcs1 [752.318901] Dynamic subtest vcs1: SUCCESS (10.709s) [752.330477] Starting dynamic subtest: vecs0 [763.303546] Dynamic subtest vecs0: SUCCESS (10.982s) [763.319308] Starting dynamic subtest: ccs0 [775.805932] Dynamic subtest ccs0: SUCCESS (12.503s) [775.808453] Subtest deep: SUCCESS (48.999s) [776.944655] [091/131] (249s left) kms_sequence (queue-idle) [777.044761] Starting subtest: queue-idle [777.047042] Starting dynamic subtest: pipe-A-eDP-1 [778.849281] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.804s) [778.859016] Starting dynamic subtest: pipe-B-eDP-1 [781.361601] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.512s) [781.374551] Starting dynamic subtest: pipe-C-eDP-1 [783.775398] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.409s) [783.793282] Starting dynamic subtest: pipe-D-eDP-1 [786.212534] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s) [786.214794] Subtest queue-idle: SUCCESS (9.168s) [787.041329] [092/131] (239s left) gem_gtt_cpu_tlb [787.173197] [093/131] (239s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [787.263628] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [793.794737] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.535s) [793.968867] [094/131] (232s left) gem_eio (create-ext) [794.202093] Starting subtest: create-ext [794.530416] Subtest create-ext: SUCCESS (0.328s) [794.709153] [095/131] (232s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [794.769816] Subtest writes-after-reads-uncached: SKIP (0.000s) [794.881730] [096/131] (232s left) sysfs_preempt_timeout (idempotent) [794.944021] Starting subtest: idempotent [794.945935] Starting dynamic subtest: vecs0 [794.947882] Dynamic subtest vecs0: SUCCESS (0.000s) [794.958366] Starting dynamic subtest: ccs0 [794.959981] Dynamic subtest ccs0: SUCCESS (0.000s) [794.969779] Starting dynamic subtest: vcs0 [794.971471] Dynamic subtest vcs0: SUCCESS (0.000s) [794.981413] Starting dynamic subtest: bcs0 [794.982958] Dynamic subtest bcs0: SUCCESS (0.000s) [794.992158] Starting dynamic subtest: rcs0 [794.993743] Dynamic subtest rcs0: SUCCESS (0.000s) [795.002744] Starting dynamic subtest: vcs1 [795.004280] Dynamic subtest vcs1: SUCCESS (0.000s) [795.005803] Subtest idempotent: SUCCESS (0.006s) [795.044896] [097/131] (231s left) gem_busy (semaphore) [795.242430] Subtest semaphore: SKIP (0.000s) [795.519836] [098/131] (231s left) sriov_basic (enable-vfs-bind-unbind-each) [795.576487] Starting subtest: enable-vfs-bind-unbind-each [795.578822] Starting dynamic subtest: numvfs-1 [795.661636] Dynamic subtest numvfs-1: FAIL (0.035s) [795.674034] Starting dynamic subtest: numvfs-2 [795.746544] Dynamic subtest numvfs-2: FAIL (0.007s) [795.757996] Starting dynamic subtest: numvfs-3 [795.831196] Dynamic subtest numvfs-3: FAIL (0.004s) [795.843780] Starting dynamic subtest: numvfs-4 [795.918597] Dynamic subtest numvfs-4: FAIL (0.003s) [795.931328] Starting dynamic subtest: numvfs-5 [796.004046] Dynamic subtest numvfs-5: FAIL (0.003s) [796.015299] Starting dynamic subtest: numvfs-6 [796.088241] Dynamic subtest numvfs-6: FAIL (0.004s) [796.099743] Starting dynamic subtest: numvfs-7 [796.172975] Dynamic subtest numvfs-7: FAIL (0.004s) [796.184476] Starting dynamic subtest: numvfs-random [796.257305] Dynamic subtest numvfs-random: FAIL (0.010s) [796.259646] Subtest enable-vfs-bind-unbind-each: FAIL (0.077s) [796.299623] [099/131] (230s left) kms_pm_lpsp (screens-disabled) [797.410437] Starting subtest: screens-disabled [797.414948] Subtest screens-disabled: SKIP (0.000s) [797.511688] [100/131] (229s left) gem_exec_capture (capture-invisible) [797.575913] Starting subtest: capture-invisible [797.578054] Starting dynamic subtest: smem0 [797.582303] Dynamic subtest smem0: SKIP (0.000s) [797.586690] Subtest capture-invisible: SKIP (0.001s) [797.707738] [101/131] (229s left) gem_lmem_swapping (verify-ccs) [797.753574] Subtest verify-ccs: SKIP (0.000s) [797.793950] [102/131] (229s left) kms_joiner (basic-force-ultra-joiner) [797.886125] Starting subtest: basic-force-ultra-joiner [797.890447] Subtest basic-force-ultra-joiner: SKIP (0.000s) [797.979602] [103/131] (229s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [798.081972] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [804.697810] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.617s) [804.847439] [104/131] (222s left) kms_color (legacy-gamma) [804.956076] Starting subtest: legacy-gamma [804.958022] Starting dynamic subtest: pipe-A-eDP-1 [805.685875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s) [805.696174] Starting dynamic subtest: pipe-B-eDP-1 [807.067769] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s) [807.078473] Starting dynamic subtest: pipe-C-eDP-1 [808.445567] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s) [808.465256] Starting dynamic subtest: pipe-D-eDP-1 [809.773762] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s) [809.775993] Subtest legacy-gamma: SUCCESS (4.819s) [810.607642] [105/131] (216s left) gem_exec_schedule (wide) [810.795242] Starting subtest: wide [810.797642] Starting dynamic subtest: rcs0 [820.854665] Dynamic subtest rcs0: SUCCESS (10.057s) [820.868907] Starting dynamic subtest: vcs0 [831.921748] Dynamic subtest vcs0: SUCCESS (11.065s) [831.934874] Starting dynamic subtest: vcs1 [841.885085] Dynamic subtest vcs1: SUCCESS (9.959s) [841.897400] Starting dynamic subtest: vecs0 [852.150107] Dynamic subtest vecs0: SUCCESS (10.263s) [852.164772] Starting dynamic subtest: ccs0 [866.273080] Dynamic subtest ccs0: SUCCESS (14.122s) [866.275779] Subtest wide: SUCCESS (55.475s) [867.424327] [106/131] (159s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [867.522935] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [867.525317] Starting dynamic subtest: pipe-A-default-mode [867.811111] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [867.815751] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.288s) [868.627476] [107/131] (158s left) kms_big_fb (linear-64bpp-rotate-180) [868.734619] Starting subtest: linear-64bpp-rotate-180 [870.413855] Subtest linear-64bpp-rotate-180: SUCCESS (1.679s) [870.620671] [108/131] (156s left) gem_ppgtt (blt-vs-render-ctxn) [870.677086] Starting subtest: blt-vs-render-ctxN [903.832339] Subtest blt-vs-render-ctxN: SUCCESS (33.149s) [904.006258] [109/131] (123s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [904.164085] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [904.168561] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [904.308889] [110/131] (123s left) kms_chamelium_frames (dp-frame-dump) [904.679657] Subtest dp-frame-dump: SKIP (0.000s) [905.513677] [111/131] (122s left) kms_psr2_su (page_flip-nv12) [905.590146] Subtest page_flip-NV12: SKIP (0.000s) [905.656073] [112/131] (121s left) gem_tiling_max_stride [905.795795] [113/131] (121s left) perf_pmu (busy-idle) [905.832385] Starting subtest: busy-idle [905.834641] Starting dynamic subtest: rcs0 [906.557457] Dynamic subtest rcs0: SUCCESS (0.724s) [906.570248] Starting dynamic subtest: bcs0 [907.218546] Dynamic subtest bcs0: SUCCESS (0.658s) [907.231934] Starting dynamic subtest: vcs0 [909.277603] Dynamic subtest vcs0: SUCCESS (2.055s) [909.288896] Starting dynamic subtest: vcs1 [911.260749] Dynamic subtest vcs1: SUCCESS (1.981s) [911.273434] Starting dynamic subtest: vecs0 [913.327683] Dynamic subtest vecs0: SUCCESS (2.045s) [913.341189] Starting dynamic subtest: ccs0 [913.981339] Dynamic subtest ccs0: SUCCESS (0.672s) [913.983946] Subtest busy-idle: SUCCESS (8.149s) [914.124981] [114/131] (113s left) dmabuf_sync_file (export-before-signal) [914.165005] Starting subtest: export-before-signal [914.166895] Subtest export-before-signal: SUCCESS (0.001s) [914.245419] [115/131] (113s left) gem_exec_reloc (basic-cpu-read) [914.308323] Subtest basic-cpu-read: SKIP (0.000s) [914.393535] [116/131] (113s left) kms_hdr (bpc-switch) [914.503745] Starting subtest: bpc-switch [915.602108] Starting dynamic subtest: pipe-A-eDP-1 [919.105576] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.506s) [919.107790] Subtest bpc-switch: SUCCESS (4.605s) [919.266658] [117/131] (108s left) perf (i915-ref-count) [919.378792] Starting subtest: i915-ref-count [919.449771] Subtest i915-ref-count: SUCCESS (0.069s) [919.507189] [118/131] (108s left) gem_ctx_isolation (nonpriv) [919.574495] Starting subtest: nonpriv [919.576886] Starting dynamic subtest: rcs0 [919.797116] Dynamic subtest rcs0: SUCCESS (0.225s) [919.810342] Starting dynamic subtest: bcs0 [920.069970] Dynamic subtest bcs0: SUCCESS (0.272s) [920.082980] Starting dynamic subtest: vcs0 [920.325998] Dynamic subtest vcs0: SUCCESS (0.255s) [920.336747] Starting dynamic subtest: vcs1 [921.538166] Dynamic subtest vcs1: SUCCESS (1.211s) [921.548791] Starting dynamic subtest: vecs0 [923.560366] Dynamic subtest vecs0: SUCCESS (2.022s) [923.573597] Starting dynamic subtest: ccs0 [925.568025] Dynamic subtest ccs0: SUCCESS (2.007s) [925.570411] Subtest nonpriv: SUCCESS (5.997s) [925.832698] [119/131] (102s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [925.891795] Starting subtest: y-tiled-to-vebox-x-tiled [925.896346] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [926.102048] [120/131] (101s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [926.188626] Starting subtest: plane-use-after-nonblocking-unbind [926.190895] Starting dynamic subtest: pipe-A-eDP-1 [926.249362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [926.546760] Starting dynamic subtest: pipe-B-eDP-1 [927.369107] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.833s) [927.670716] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.481s) [928.554384] [121/131] ( 99s left) i915_hangman (engine-error-state-capture) [928.621142] Starting subtest: engine-error-state-capture [928.623529] Starting dynamic subtest: rcs0 [932.218561] Dynamic subtest rcs0: SUCCESS (3.599s) [932.230848] Starting dynamic subtest: bcs0 [938.235861] Dynamic subtest bcs0: SUCCESS (6.014s) [938.249494] Starting dynamic subtest: vcs0 [944.188393] Dynamic subtest vcs0: SUCCESS (5.949s) [944.202502] Starting dynamic subtest: vcs1 [949.179292] Dynamic subtest vcs1: SUCCESS (4.988s) [949.193134] Starting dynamic subtest: vecs0 [954.171982] Dynamic subtest vecs0: SUCCESS (4.990s) [954.186051] Starting dynamic subtest: ccs0 [959.228449] Dynamic subtest ccs0: SUCCESS (5.053s) [959.231376] Subtest engine-error-state-capture: SUCCESS (30.608s) [959.337611] [122/131] ( 68s left) gem_exec_schedule (pi-shared-iova) [959.524099] Starting subtest: pi-shared-iova [959.526351] Starting dynamic subtest: rcs0 [959.657690] Dynamic subtest rcs0: SUCCESS (0.134s) [959.670748] Starting dynamic subtest: vcs0 [959.744993] Dynamic subtest vcs0: SUCCESS (0.087s) [959.760792] Starting dynamic subtest: vcs1 [959.834373] Dynamic subtest vcs1: SUCCESS (0.088s) [959.848589] Starting dynamic subtest: vecs0 [959.922765] Dynamic subtest vecs0: SUCCESS (0.087s) [959.936481] Starting dynamic subtest: ccs0 [960.031706] Dynamic subtest ccs0: SUCCESS (0.109s) [960.034442] Subtest pi-shared-iova: SUCCESS (0.510s) [961.440748] [123/131] ( 66s left) syncobj_wait (invalid-reset-illegal-handle) [961.501274] Starting subtest: invalid-reset-illegal-handle [961.503641] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [961.633784] [124/131] ( 66s left) syncobj_wait (single-wait-all-for-submit-signaled) [961.702402] Starting subtest: single-wait-all-for-submit-signaled [961.705056] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [961.832596] [125/131] ( 66s left) kms_cursor_crc (cursor-sliding-512x170) [962.122683] Starting subtest: cursor-sliding-512x170 [962.127398] Subtest cursor-sliding-512x170: SKIP (0.001s) [962.329676] [126/131] ( 65s left) kms_chamelium_hpd (hdmi-hpd-fast) [962.723506] Subtest hdmi-hpd-fast: SKIP (0.000s) [963.539476] [127/131] ( 64s left) gem_ctx_persistence (hostile) [963.600030] Starting subtest: hostile [973.748770] Subtest hostile: SUCCESS (10.148s) [973.906925] [128/131] ( 54s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [974.022573] Starting subtest: fbc-rgb565-draw-blt [978.271377] Subtest fbc-rgb565-draw-blt: SUCCESS (4.253s) [979.507443] [129/131] ( 48s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [979.609937] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [988.989607] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.382s) [989.154064] [130/131] ( 39s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [989.253917] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [989.258349] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [989.383827] [131/131] ( 39s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [989.471033] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [989.475377] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [989.594001] 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.