[60.980060] Initializing watchdogs [60.980111] /dev/watchdog0 [60.995080] [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] [60.999406] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.001779] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.005201] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [61.142200] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [61.146689] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [61.257509] [002/131] (960s left) gem_exec_fence (submit3) [61.439085] Starting subtest: submit3 [61.443662] Subtest submit3: SKIP (0.000s) [63.054994] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [63.057871] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [63.169435] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [63.174041] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [63.303608] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [63.407188] Starting subtest: fbc-rgb101010-draw-mmap-wc [68.011078] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.611s) [69.230788] [005/131] (952s left) gem_exec_balancer (noheartbeat) [69.489174] Starting subtest: noheartbeat [69.493807] Subtest noheartbeat: SKIP (0.000s) [69.614706] [006/131] (952s left) kms_chamelium_color (ctm-blue-to-red) [69.714076] Subtest ctm-blue-to-red: SKIP (0.000s) [69.755183] [007/131] (951s left) gem_workarounds (suspend-resume) [69.819440] Starting subtest: suspend-resume [85.869448] Subtest suspend-resume: SUCCESS (4.952s) [85.997762] [008/131] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [86.105000] Starting subtest: planes-downscale-factor-0-75-unity-scaling [86.107728] Starting dynamic subtest: pipe-A [86.169799] Dynamic subtest pipe-A: SUCCESS (0.065s) [86.178402] Starting dynamic subtest: pipe-B [87.328455] Dynamic subtest pipe-B: SUCCESS (1.168s) [87.342098] Starting dynamic subtest: pipe-C [88.420459] Dynamic subtest pipe-C: SUCCESS (1.101s) [88.428831] Starting dynamic subtest: pipe-D [89.547304] Dynamic subtest pipe-D: SUCCESS (1.135s) [89.549933] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.472s) [90.719045] [009/131] (931s left) gem_pxp (create-regular-buffer) [90.842945] Starting subtest: create-regular-buffer [90.845789] Subtest create-regular-buffer: SUCCESS (0.000s) [90.970968] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [91.031782] Starting subtest: rel-constants-invalid-rel-gen5 [91.034395] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [91.150021] [011/131] (930s left) gem_exec_nop (basic-series) [91.236693] Starting subtest: basic-series [106.996351] Subtest basic-series: SUCCESS (15.815s) [107.272351] [012/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [107.397695] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [107.403094] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [107.515065] [013/131] (914s left) kms_psr (fbc-psr-primary-page-flip) [107.617247] Starting subtest: fbc-psr-primary-page-flip [107.619610] Starting dynamic subtest: eDP-1 [107.624684] Dynamic subtest eDP-1: SKIP (0.000s) [107.629787] Subtest fbc-psr-primary-page-flip: SKIP (0.002s) [107.717093] [014/131] (914s left) i915_pm_rps (engine-order) [107.785620] Starting subtest: engine-order [112.610804] Subtest engine-order: SUCCESS (4.830s) [112.807089] [015/131] (909s left) gem_softpin (evict-active) [112.870512] Starting subtest: evict-active [112.880976] Subtest evict-active: SUCCESS (0.011s) [113.045751] [016/131] (909s left) syncobj_timeline (wait-delayed-signal) [113.116000] Starting subtest: wait-delayed-signal [113.218201] Subtest wait-delayed-signal: SUCCESS (0.103s) [113.330034] [017/131] (908s left) kms_panel_fitting (atomic-fastset) [113.418598] Starting subtest: atomic-fastset [113.421459] Starting dynamic subtest: pipe-A-eDP-1 [113.591074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s) [113.601719] Starting dynamic subtest: pipe-B-eDP-1 [114.793239] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.203s) [114.805271] Starting dynamic subtest: pipe-C-eDP-1 [115.979841] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s) [115.992398] Starting dynamic subtest: pipe-D-eDP-1 [117.116865] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s) [117.119793] Subtest atomic-fastset: SUCCESS (3.702s) [118.286406] [018/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-270) [118.407757] Starting subtest: x-tiled-16bpp-rotate-270 [118.427923] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [118.563685] [019/131] (903s left) api_intel_bb (render-ccs) [118.608661] Starting subtest: render-ccs [118.961710] Subtest render-ccs: SUCCESS (0.353s) [119.088209] [020/131] (903s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [119.179852] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [119.182667] Starting dynamic subtest: pipe-A-eDP-1 [119.208713] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [119.218741] Starting dynamic subtest: pipe-B-eDP-1 [119.246733] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [119.256655] Starting dynamic subtest: pipe-C-eDP-1 [119.282372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [119.291524] Starting dynamic subtest: pipe-D-eDP-1 [119.317390] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [119.322357] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [121.469468] [021/131] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [121.534835] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [121.636232] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s) [121.734973] [022/131] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [121.829818] Starting subtest: psr-2p-primscrn-cur-indfb-move [121.835255] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [121.960226] [023/131] (900s left) gem_lmem_swapping (heavy-multi) [122.005804] Subtest heavy-multi: SKIP (0.000s) [122.052555] [024/131] (900s left) kms_async_flips (test-cursor) [122.147300] Starting subtest: test-cursor [122.152370] Subtest test-cursor: SKIP (0.000s) [123.372362] [025/131] (899s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [128.440759] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [128.443687] Starting dynamic subtest: pipe-A-eDP-1 [129.230081] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s) [129.240731] Starting dynamic subtest: pipe-B-eDP-1 [130.364900] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s) [130.370112] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.924s) [131.574915] [026/131] (890s left) kms_plane_multiple (2x-tiling-4) [131.676455] Starting subtest: 2x-tiling-4 [131.681563] Subtest 2x-tiling-4: SKIP (0.000s) [131.771970] [027/131] (890s left) gem_ctx_param (invalid-param-set) [131.833996] Starting subtest: invalid-param-set [131.836931] Subtest invalid-param-set: SUCCESS (0.000s) [131.932703] [028/131] (890s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [132.025898] Starting subtest: bad-pixel-format-y-tiled-ccs [132.028615] Starting dynamic subtest: pipe-A-eDP-1 [132.055560] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [132.068976] Starting dynamic subtest: pipe-B-eDP-1 [132.094107] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [132.102957] Starting dynamic subtest: pipe-C-eDP-1 [132.128910] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [132.137526] Starting dynamic subtest: pipe-D-eDP-1 [132.163719] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [132.168753] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [134.244786] [029/131] (888s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [134.341749] Starting subtest: plane-downscale-factor-0-5-with-modifiers [134.344579] Starting dynamic subtest: pipe-A [134.364646] Dynamic subtest pipe-A: SKIP (0.016s) [134.374760] Starting dynamic subtest: pipe-B [134.394104] Dynamic subtest pipe-B: SKIP (0.029s) [134.402989] Starting dynamic subtest: pipe-C [134.424583] Dynamic subtest pipe-C: SKIP (0.029s) [134.433956] Starting dynamic subtest: pipe-D [134.454833] Dynamic subtest pipe-D: SKIP (0.030s) [134.459773] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.106s) [134.593636] [030/131] (888s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [134.667923] Starting subtest: multi-wait-all-available-submitted-signaled [134.670959] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [134.805642] [031/131] (887s left) perf (missing-sample-flags) [134.936607] Starting subtest: missing-sample-flags [134.939157] Subtest missing-sample-flags: SUCCESS (0.000s) [134.980300] [032/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [135.076696] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [141.270219] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.191s) [142.461139] [033/131] (880s left) kms_pm_rpm (system-suspend-idle) [144.123721] Starting subtest: system-suspend-idle [164.396612] Subtest system-suspend-idle: SUCCESS (4.637s) [164.840127] [034/131] (858s left) kms_vblank (wait-forked) [164.949590] Starting subtest: wait-forked [164.951790] Starting dynamic subtest: pipe-A-eDP-1 [166.760775] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s) [166.776006] Starting dynamic subtest: pipe-D-eDP-1 [169.252092] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.501s) [169.254332] Subtest wait-forked: SUCCESS (4.327s) [170.128301] [035/131] (852s left) kms_big_fb (y-tiled-32bpp-rotate-0) [170.252877] Starting subtest: y-tiled-32bpp-rotate-0 [170.257167] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [170.387580] [036/131] (852s left) kms_pipe_crc_basic (read-crc) [170.487672] Starting subtest: read-crc [170.489638] Starting dynamic subtest: pipe-A-eDP-1 [171.197849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [171.208591] Starting dynamic subtest: pipe-B-eDP-1 [172.571090] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s) [172.582350] Starting dynamic subtest: pipe-C-eDP-1 [173.968371] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s) [173.978919] Starting dynamic subtest: pipe-D-eDP-1 [175.288196] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s) [175.290094] Subtest read-crc: SUCCESS (4.814s) [176.145439] [037/131] (846s left) kms_cursor_legacy (single-move) [176.266150] Starting subtest: single-move [176.268374] Starting dynamic subtest: pipe-A [181.640603] Dynamic subtest pipe-A: SUCCESS (5.380s) [181.652593] Starting dynamic subtest: pipe-B [187.019216] Dynamic subtest pipe-B: SUCCESS (5.382s) [187.030639] Starting dynamic subtest: pipe-C [192.397416] Dynamic subtest pipe-C: SUCCESS (5.380s) [192.408977] Starting dynamic subtest: pipe-D [197.778596] Dynamic subtest pipe-D: SUCCESS (5.380s) [197.790051] Starting dynamic subtest: all-pipes [203.177531] Dynamic subtest all-pipes: SUCCESS (5.387s) [203.179997] Subtest single-move: SUCCESS (26.918s) [203.352016] [038/131] (819s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [208.375631] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [208.380649] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [209.259304] [039/131] (813s left) gem_unref_active_buffers [209.452720] [040/131] (813s left) kms_psr (fbc-psr2-primary-mmap-gtt) [209.548627] Starting subtest: fbc-psr2-primary-mmap-gtt [209.550819] Starting dynamic subtest: eDP-1 [209.554803] Dynamic subtest eDP-1: SKIP (0.000s) [209.558736] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [209.642760] [041/131] (813s left) syncobj_wait (invalid-signal-zero-handles) [209.701942] Starting subtest: invalid-signal-zero-handles [209.704280] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [209.822432] [042/131] (813s left) gen9_exec_parse (bb-oversize) [209.875216] Subtest bb-oversize: SKIP (0.000s) [209.945661] [043/131] (813s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [210.006903] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [210.115466] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [210.217112] [044/131] (813s left) gem_exec_reloc (basic-write-cpu-noreloc) [210.284636] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [210.355104] [045/131] (813s left) gem_mmap_offset (bad-flags) [210.409518] Starting subtest: bad-flags [210.411847] Subtest bad-flags: SUCCESS (0.000s) [210.557853] [046/131] (812s left) kms_cursor_legacy (cursor-vs-flip-legacy) [210.683771] Starting subtest: cursor-vs-flip-legacy [240.035035] Subtest cursor-vs-flip-legacy: SUCCESS (29.354s) [240.877483] [047/131] (782s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [240.974820] Starting subtest: sprite-rotation-90-pos-100-0 [240.978880] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [241.071899] [048/131] (782s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [241.182606] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [242.205205] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.023s) [242.393070] [049/131] (781s left) gem_create (busy-create) [242.455537] Starting subtest: busy-create [242.457669] Starting dynamic subtest: smem0 [275.707445] Dynamic subtest smem0: SUCCESS (33.248s) [275.710481] Subtest busy-create: SUCCESS (33.249s) [275.920301] [050/131] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [276.015157] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [280.266370] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.253s) [281.475550] [051/131] (742s left) perf (invalid-open-flags) [281.590668] Starting subtest: invalid-open-flags [281.592980] Subtest invalid-open-flags: SUCCESS (0.000s) [281.629504] [052/131] (742s left) perf (oa-formats) [281.742293] Starting subtest: oa-formats [281.744742] Starting dynamic subtest: 0-rcs0 [281.757311] Dynamic subtest 0-rcs0: SUCCESS (0.015s) [281.767822] Starting dynamic subtest: 1-vcs1 [281.779236] Dynamic subtest 1-vcs1: SUCCESS (0.021s) [281.781465] Subtest oa-formats: SUCCESS (0.037s) [281.821442] [053/131] (741s left) kms_big_fb (4-tiled-8bpp-rotate-270) [281.925334] Starting subtest: 4-tiled-8bpp-rotate-270 [281.945835] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [282.084165] [054/131] (741s left) kms_cursor_crc (cursor-onscreen-64x21) [282.295150] Starting subtest: cursor-onscreen-64x21 [282.349521] Subtest cursor-onscreen-64x21: SKIP (0.048s) [282.615885] [055/131] (741s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [282.709824] Starting subtest: primary-4-tiled-reflect-x-180 [289.850987] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.141s) [291.052777] [056/131] (732s left) kms_cursor_crc (cursor-onscreen-256x256) [291.304253] Starting subtest: cursor-onscreen-256x256 [291.306558] Starting dynamic subtest: pipe-A-eDP-1 [293.406886] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s) [293.436847] Starting dynamic subtest: pipe-D-eDP-1 [296.195435] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s) [296.198078] Subtest cursor-onscreen-256x256: SUCCESS (4.893s) [297.028215] [057/131] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [297.137142] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [304.526173] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.391s) [304.696940] [058/131] (719s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [304.802315] Starting subtest: async-flip-with-page-flip-events-tiled [305.185590] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [307.975594] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.790s) [307.985258] Starting dynamic subtest: pipe-A-eDP-1-4 [310.149582] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s) [310.159306] Starting dynamic subtest: pipe-A-eDP-1-4 [312.159613] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [312.171664] Starting dynamic subtest: pipe-A-eDP-1-x [314.338570] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [314.705358] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [317.502369] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.805s) [317.514731] Starting dynamic subtest: pipe-B-eDP-1-4 [319.676909] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s) [319.688357] Starting dynamic subtest: pipe-B-eDP-1-4 [321.686647] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [321.696540] Starting dynamic subtest: pipe-B-eDP-1-x [323.865588] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s) [324.256115] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [327.030210] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.782s) [327.042625] Starting dynamic subtest: pipe-C-eDP-1-4 [329.204600] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [329.215774] Starting dynamic subtest: pipe-C-eDP-1-4 [331.214599] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [331.224263] Starting dynamic subtest: pipe-C-eDP-1-x [333.393384] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [333.765507] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [336.564777] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.807s) [336.577186] Starting dynamic subtest: pipe-D-eDP-1-4 [338.738741] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [338.751176] Starting dynamic subtest: pipe-D-eDP-1-4 [340.749003] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [340.761971] Starting dynamic subtest: pipe-D-eDP-1-x [342.926865] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [342.929067] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.130s) [344.180437] [059/131] (679s left) perf (polling) [344.287657] Starting subtest: polling [344.290059] Starting dynamic subtest: 0-rcs0 [354.307921] Dynamic subtest 0-rcs0: SUCCESS (10.020s) [354.318006] Starting dynamic subtest: 1-vecs0 [364.329434] Dynamic subtest 1-vecs0: SUCCESS (10.022s) [364.332500] Subtest polling: SUCCESS (20.045s) [364.378625] [060/131] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [364.482457] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [364.486983] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [364.616785] [061/131] (659s left) syncobj_timeline (reset-signaled) [364.677568] Starting subtest: reset-signaled [364.679752] Subtest reset-signaled: SUCCESS (0.000s) [364.813849] [062/131] (659s left) kms_rmfb (rmfb-ioctl) [364.908608] Starting subtest: rmfb-ioctl [364.910873] Starting dynamic subtest: pipe-A-eDP-1 [365.013092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [365.022368] Starting dynamic subtest: pipe-B-eDP-1 [366.221190] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s) [366.232362] Starting dynamic subtest: pipe-C-eDP-1 [367.343954] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s) [367.355145] Starting dynamic subtest: pipe-D-eDP-1 [368.464222] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s) [368.466502] Subtest rmfb-ioctl: SUCCESS (3.559s) [369.708999] [063/131] (654s left) gem_userptr_blits (create-destroy-sync) [369.789525] Starting subtest: create-destroy-sync [374.799764] Subtest create-destroy-sync: SUCCESS (5.011s) [374.952583] [064/131] (649s left) gem_exec_reloc (basic-gtt-cpu-active) [375.021237] Subtest basic-gtt-cpu-active: SKIP (0.000s) [375.101628] [065/131] (649s left) api_intel_allocator (execbuf-with-allocator) [375.174331] Starting subtest: execbuf-with-allocator [375.182254] Subtest execbuf-with-allocator: SUCCESS (0.009s) [375.354929] [066/131] (648s left) kms_lease (cursor-implicit-plane) [375.452928] Starting subtest: cursor-implicit-plane [375.455239] Starting dynamic subtest: pipe-A-eDP-1 [375.919383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s) [375.930482] Starting dynamic subtest: pipe-B-eDP-1 [377.007675] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.086s) [377.017968] Starting dynamic subtest: pipe-C-eDP-1 [378.129956] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s) [378.145755] Starting dynamic subtest: pipe-D-eDP-1 [379.261760] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [379.264159] Subtest cursor-implicit-plane: SUCCESS (3.812s) [380.151634] [067/131] (644s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [380.269037] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [380.273452] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [380.438825] [068/131] (643s left) syncobj_wait (invalid-signal-illegal-handle) [380.497719] Starting subtest: invalid-signal-illegal-handle [380.500063] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [380.631889] [069/131] (643s left) kms_psr (psr-primary-blt) [380.728534] Starting subtest: psr-primary-blt [380.730767] Starting dynamic subtest: eDP-1 [382.423300] Dynamic subtest eDP-1: SUCCESS (1.694s) [382.425608] Subtest psr-primary-blt: SUCCESS (1.695s) [383.319953] [070/131] (641s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [383.417280] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [383.419622] Starting dynamic subtest: pipe-A-eDP-1 [383.476584] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [383.485852] Starting dynamic subtest: pipe-B-eDP-1 [383.541705] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [383.552312] Starting dynamic subtest: pipe-C-eDP-1 [383.608208] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [383.618486] Starting dynamic subtest: pipe-D-eDP-1 [383.677055] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [383.681317] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [385.679009] [071/131] (638s left) kms_psr (pr-primary-blt) [385.778901] Starting subtest: pr-primary-blt [385.783282] Subtest pr-primary-blt: SKIP (0.000s) [385.879587] [072/131] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [385.979088] Starting subtest: psr-2p-primscrn-spr-indfb-move [385.983200] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [386.088640] [073/131] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [386.186958] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [386.189269] Starting dynamic subtest: pipe-A-default-mode [387.304337] Dynamic subtest pipe-A-default-mode: SKIP (1.115s) [387.308600] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.116s) [387.507774] [074/131] (637s left) gem_exec_schedule (u-semaphore-noskip) [387.584826] Starting subtest: u-semaphore-noskip [387.978498] Subtest u-semaphore-noskip: SUCCESS (0.401s) [388.366825] [075/131] (636s left) i915_drm_fdinfo (memory-info-idle) [388.412995] Starting subtest: memory-info-idle [388.415181] Starting dynamic subtest: smem0 [388.482349] Dynamic subtest smem0: SUCCESS (0.071s) [388.485280] Subtest memory-info-idle: SUCCESS (0.072s) [388.582249] [076/131] (636s left) i915_selftest (live) [392.129298] Starting subtest: live [392.132209] Starting dynamic subtest: sanitycheck [396.636779] Dynamic subtest sanitycheck: SUCCESS (4.506s) [396.646727] Starting dynamic subtest: uncore [401.133294] Dynamic subtest uncore: SUCCESS (4.493s) [401.143208] Starting dynamic subtest: workarounds [404.416894] Dynamic subtest workarounds: SUCCESS (3.280s) [404.427073] Starting dynamic subtest: gt_engines [409.118401] Dynamic subtest gt_engines: SUCCESS (4.698s) [409.128114] Starting dynamic subtest: gt_timelines [426.787919] Dynamic subtest gt_timelines: SUCCESS (17.664s) [426.798194] Starting dynamic subtest: gt_contexts [429.706455] Dynamic subtest gt_contexts: SUCCESS (2.916s) [429.716522] Starting dynamic subtest: gt_lrc [434.247834] Dynamic subtest gt_lrc: SUCCESS (4.538s) [434.257975] Starting dynamic subtest: gt_mocs [437.384492] Dynamic subtest gt_mocs: SUCCESS (3.135s) [437.394334] Starting dynamic subtest: gt_pm [444.333074] Dynamic subtest gt_pm: SUCCESS (6.945s) [444.343708] Starting dynamic subtest: gt_heartbeat [448.786520] Dynamic subtest gt_heartbeat: SUCCESS (4.452s) [448.797047] Starting dynamic subtest: gt_tlb [458.312883] Dynamic subtest gt_tlb: SUCCESS (9.524s) [458.323372] Starting dynamic subtest: requests [471.764077] Dynamic subtest requests: SUCCESS (13.449s) [471.774217] Starting dynamic subtest: migrate [477.926737] Dynamic subtest migrate: SUCCESS (6.160s) [477.936647] Starting dynamic subtest: active [482.387568] Dynamic subtest active: SUCCESS (4.459s) [482.397834] Starting dynamic subtest: objects [487.216887] Dynamic subtest objects: SUCCESS (4.827s) [487.226592] Starting dynamic subtest: mman [492.209870] Dynamic subtest mman: SUCCESS (4.991s) [492.219668] Starting dynamic subtest: dmabuf [496.739606] Dynamic subtest dmabuf: SUCCESS (4.528s) [496.755821] Starting dynamic subtest: vma [501.228590] Dynamic subtest vma: SUCCESS (4.487s) [501.238482] Starting dynamic subtest: coherency [506.307777] Dynamic subtest coherency: SUCCESS (5.077s) [506.318217] Starting dynamic subtest: gtt [518.358032] Dynamic subtest gtt: SUCCESS (12.050s) [518.368209] Starting dynamic subtest: gem [526.515969] Dynamic subtest gem: SUCCESS (8.157s) [526.526455] Starting dynamic subtest: evict [532.101317] Dynamic subtest evict: SUCCESS (5.585s) [532.114878] Starting dynamic subtest: hugepages [543.227854] Dynamic subtest hugepages: SUCCESS (11.124s) [543.236360] Starting dynamic subtest: gem_contexts [571.911975] Dynamic subtest gem_contexts: SUCCESS (28.688s) [571.922065] Starting dynamic subtest: client [576.440149] Dynamic subtest client: SUCCESS (4.528s) [576.449771] Starting dynamic subtest: gem_migrate [580.929950] Dynamic subtest gem_migrate: SUCCESS (4.489s) [580.940673] Starting dynamic subtest: reset [585.410255] Dynamic subtest reset: SUCCESS (4.479s) [585.420199] Starting dynamic subtest: memory_region [589.929576] Dynamic subtest memory_region: SUCCESS (4.518s) [589.940221] Starting dynamic subtest: hangcheck [603.157426] Dynamic subtest hangcheck: SUCCESS (13.228s) [603.170671] Starting dynamic subtest: execlists [607.578644] Dynamic subtest execlists: SUCCESS (4.421s) [607.588324] Starting dynamic subtest: ring_submission [612.029327] Dynamic subtest ring_submission: SUCCESS (4.450s) [612.039474] Starting dynamic subtest: perf [616.487628] Dynamic subtest perf: SUCCESS (4.457s) [616.497630] Starting dynamic subtest: slpc [630.732896] Dynamic subtest slpc: SUCCESS (14.245s) [630.743089] Starting dynamic subtest: guc [634.747603] Dynamic subtest guc: SUCCESS (4.014s) [634.757840] Starting dynamic subtest: guc_multi_lrc [639.192505] Dynamic subtest guc_multi_lrc: SUCCESS (4.442s) [639.202596] Starting dynamic subtest: guc_hang [644.108783] Dynamic subtest guc_hang: SUCCESS (4.914s) [644.118743] Starting dynamic subtest: late_gt_pm [648.688347] Dynamic subtest late_gt_pm: SUCCESS (4.573s) [648.691145] Subtest live: SUCCESS (256.569s) [648.718750] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [648.719470] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [648.722637] [077/131] (376s left) gem_userptr_blits (nohangcheck) [650.252994] Starting subtest: nohangcheck [650.509924] Subtest nohangcheck: SUCCESS (0.255s) [650.619005] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [650.620271] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [650.624058] [078/131] (374s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [650.721739] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [650.724048] Starting dynamic subtest: pipe-A-eDP-1 [651.603445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.875s) [651.612667] Starting dynamic subtest: pipe-B-eDP-1 [653.145710] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.539s) [653.155662] Starting dynamic subtest: pipe-C-eDP-1 [654.641827] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.493s) [654.651951] Starting dynamic subtest: pipe-D-eDP-1 [656.159871] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s) [656.162034] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.429s) [657.373041] [079/131] (367s left) gem_softpin (allocator-nopin) [657.435231] Starting subtest: allocator-nopin [657.539705] Subtest allocator-nopin: SUCCESS (0.103s) [657.673908] [080/131] (367s left) kms_draw_crc (draw-method-pwrite) [657.785818] Starting subtest: draw-method-pwrite [657.787934] Starting dynamic subtest: xrgb8888-untiled [658.352047] Dynamic subtest xrgb8888-untiled: SUCCESS (0.567s) [658.361633] Starting dynamic subtest: rgb565-untiled [658.808206] Dynamic subtest rgb565-untiled: SUCCESS (0.455s) [658.817807] Starting dynamic subtest: xrgb2101010-untiled [659.363919] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s) [659.373432] Starting dynamic subtest: xbgr16161616f-untiled [660.119967] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s) [660.129748] Starting dynamic subtest: xrgb8888-xtiled [661.920984] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.799s) [661.931071] Starting dynamic subtest: rgb565-xtiled [662.999749] Dynamic subtest rgb565-xtiled: SUCCESS (1.077s) [663.009192] Starting dynamic subtest: xrgb2101010-xtiled [664.789822] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.788s) [664.800456] Starting dynamic subtest: xbgr16161616f-xtiled [668.069460] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.277s) [668.079339] Starting dynamic subtest: xrgb8888-4tiled [669.170110] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s) [669.179964] Starting dynamic subtest: rgb565-4tiled [669.748108] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s) [669.758106] Starting dynamic subtest: xrgb2101010-4tiled [670.848761] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s) [670.858396] Starting dynamic subtest: xbgr16161616f-4tiled [673.839441] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.988s) [673.841696] Subtest draw-method-pwrite: SUCCESS (16.046s) [673.969184] [081/131] (350s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [674.075858] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [674.080159] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [674.208056] [082/131] (350s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [674.312775] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [674.316949] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [674.455005] [083/131] (350s left) syncobj_timeline (host-signal-points) [674.519060] Starting subtest: host-signal-points [674.521328] Subtest host-signal-points: SUCCESS (0.004s) [674.655130] [084/131] (350s left) gem_mmap_gtt (basic-small-bo) [674.714235] Subtest basic-small-bo: SKIP (0.000s) [674.785891] [085/131] (350s left) perf_pmu (semaphore-wait-idle) [674.822233] Starting subtest: semaphore-wait-idle [674.824087] Starting dynamic subtest: rcs0 [675.336708] Dynamic subtest rcs0: SUCCESS (0.513s) [675.351714] Starting dynamic subtest: bcs0 [675.852662] Dynamic subtest bcs0: SUCCESS (0.511s) [675.864635] Starting dynamic subtest: vcs0 [676.366269] Dynamic subtest vcs0: SUCCESS (0.511s) [676.378300] Starting dynamic subtest: vcs1 [676.877615] Dynamic subtest vcs1: SUCCESS (0.510s) [676.888262] Starting dynamic subtest: vecs0 [677.394397] Dynamic subtest vecs0: SUCCESS (0.512s) [677.405615] Starting dynamic subtest: ccs0 [677.909998] Dynamic subtest ccs0: SUCCESS (0.513s) [677.912771] Subtest semaphore-wait-idle: SUCCESS (3.086s) [678.053418] [086/131] (347s left) kms_addfb_basic (no-handle) [678.115105] Starting subtest: no-handle [678.117590] Subtest no-handle: SUCCESS (0.000s) [678.294135] [087/131] (346s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [678.391982] Starting subtest: fbcpsr-rgb101010-draw-pwrite [685.411953] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.018s) [685.577406] [088/131] (339s left) gem_render_copy (yf-tiled-ccs-to-linear) [685.650126] Starting subtest: yf-tiled-ccs-to-linear [685.654373] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [685.859101] [089/131] (339s left) kms_flip (wf_vblank-ts-check) [685.966012] Starting subtest: wf_vblank-ts-check [685.968424] Starting dynamic subtest: A-eDP1 [694.869480] Dynamic subtest A-eDP1: SUCCESS (8.900s) [694.879442] Starting dynamic subtest: B-eDP1 [703.807324] Dynamic subtest B-eDP1: SUCCESS (8.934s) [703.817536] Starting dynamic subtest: C-eDP1 [712.724599] Dynamic subtest C-eDP1: SUCCESS (8.913s) [712.734178] Starting dynamic subtest: D-eDP1 [721.654042] Dynamic subtest D-eDP1: SUCCESS (8.926s) [721.659286] Subtest wf_vblank-ts-check: SUCCESS (35.684s) [723.008228] [090/131] (302s left) gem_exec_schedule (deep) [723.190273] Starting subtest: deep [723.192683] Starting dynamic subtest: rcs0 [727.981475] Dynamic subtest rcs0: SKIP (4.787s) [727.993403] Starting dynamic subtest: vcs0 [738.132824] Dynamic subtest vcs0: SUCCESS (10.152s) [738.143388] Starting dynamic subtest: vcs1 [748.722502] Dynamic subtest vcs1: SUCCESS (10.586s) [748.735283] Starting dynamic subtest: vecs0 [760.105685] Dynamic subtest vecs0: SUCCESS (11.382s) [760.119906] Starting dynamic subtest: ccs0 [771.957510] Dynamic subtest ccs0: SUCCESS (11.850s) [771.961085] Subtest deep: SUCCESS (48.762s) [773.763625] [091/131] (251s left) kms_sequence (queue-idle) [773.851377] Starting subtest: queue-idle [773.853223] Starting dynamic subtest: pipe-A-eDP-1 [775.670366] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s) [775.680777] Starting dynamic subtest: pipe-B-eDP-1 [778.151765] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.479s) [778.161742] Starting dynamic subtest: pipe-C-eDP-1 [780.570407] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.420s) [780.580530] Starting dynamic subtest: pipe-D-eDP-1 [783.002813] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s) [783.005228] Subtest queue-idle: SUCCESS (9.152s) [783.833264] [092/131] (241s left) gem_gtt_cpu_tlb [783.967843] [093/131] (241s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [784.061121] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [790.562053] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.503s) [790.698994] [094/131] (234s left) gem_eio (create-ext) [790.927702] Starting subtest: create-ext [791.257064] Subtest create-ext: SUCCESS (0.328s) [791.423837] [095/131] (234s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [791.489387] Subtest writes-after-reads-uncached: SKIP (0.000s) [791.583098] [096/131] (233s left) sysfs_preempt_timeout (idempotent) [791.646914] Starting subtest: idempotent [791.648978] Starting dynamic subtest: vecs0 [791.650943] Dynamic subtest vecs0: SUCCESS (0.000s) [791.665852] Starting dynamic subtest: ccs0 [791.667825] Dynamic subtest ccs0: SUCCESS (0.000s) [791.679447] Starting dynamic subtest: vcs0 [791.681402] Dynamic subtest vcs0: SUCCESS (0.000s) [791.691558] Starting dynamic subtest: bcs0 [791.693199] Dynamic subtest bcs0: SUCCESS (0.000s) [791.702372] Starting dynamic subtest: rcs0 [791.704227] Dynamic subtest rcs0: SUCCESS (0.000s) [791.713425] Starting dynamic subtest: vcs1 [791.715308] Dynamic subtest vcs1: SUCCESS (0.000s) [791.717107] Subtest idempotent: SUCCESS (0.007s) [791.772177] [097/131] (233s left) gem_busy (semaphore) [791.961246] Subtest semaphore: SKIP (0.000s) [792.229843] [098/131] (233s left) sriov_basic (enable-vfs-bind-unbind-each) [792.288668] Starting subtest: enable-vfs-bind-unbind-each [792.291112] Starting dynamic subtest: numvfs-1 [792.374200] Dynamic subtest numvfs-1: FAIL (0.032s) [792.389312] Starting dynamic subtest: numvfs-2 [792.463632] Dynamic subtest numvfs-2: FAIL (0.004s) [792.475762] Starting dynamic subtest: numvfs-3 [792.550612] Dynamic subtest numvfs-3: FAIL (0.003s) [792.561631] Starting dynamic subtest: numvfs-4 [792.633234] Dynamic subtest numvfs-4: FAIL (0.003s) [792.644284] Starting dynamic subtest: numvfs-5 [792.717832] Dynamic subtest numvfs-5: FAIL (0.004s) [792.729041] Starting dynamic subtest: numvfs-6 [792.801612] Dynamic subtest numvfs-6: FAIL (0.005s) [792.812890] Starting dynamic subtest: numvfs-7 [792.886787] Dynamic subtest numvfs-7: FAIL (0.003s) [792.898169] Starting dynamic subtest: numvfs-random [792.971853] Dynamic subtest numvfs-random: FAIL (0.004s) [792.973860] Subtest enable-vfs-bind-unbind-each: FAIL (0.063s) [793.014437] [099/131] (232s left) kms_pm_lpsp (screens-disabled) [794.123861] Starting subtest: screens-disabled [794.128261] Subtest screens-disabled: SKIP (0.000s) [794.222193] [100/131] (231s left) gem_exec_capture (capture-invisible) [794.290720] Starting subtest: capture-invisible [794.293112] Starting dynamic subtest: smem0 [794.297500] Dynamic subtest smem0: SKIP (0.000s) [794.301894] Subtest capture-invisible: SKIP (0.001s) [794.436681] [101/131] (231s left) gem_lmem_swapping (verify-ccs) [794.478810] Subtest verify-ccs: SKIP (0.000s) [794.518423] [102/131] (231s left) kms_joiner (basic-force-ultra-joiner) [794.617461] Starting subtest: basic-force-ultra-joiner [794.621740] Subtest basic-force-ultra-joiner: SKIP (0.000s) [794.711165] [103/131] (231s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [794.824587] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [801.400889] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.579s) [801.549825] [104/131] (224s left) kms_color (legacy-gamma) [801.646641] Starting subtest: legacy-gamma [801.648521] Starting dynamic subtest: pipe-A-eDP-1 [802.390675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s) [802.401489] Starting dynamic subtest: pipe-B-eDP-1 [803.778238] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s) [803.789377] Starting dynamic subtest: pipe-C-eDP-1 [805.154804] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s) [805.167793] Starting dynamic subtest: pipe-D-eDP-1 [806.480899] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s) [806.483179] Subtest legacy-gamma: SUCCESS (4.836s) [807.315867] [105/131] (218s left) gem_exec_schedule (wide) [807.514430] Starting subtest: wide [807.516736] Starting dynamic subtest: rcs0 [818.164262] Dynamic subtest rcs0: SUCCESS (10.649s) [818.179571] Starting dynamic subtest: vcs0 [829.488282] Dynamic subtest vcs0: SUCCESS (11.323s) [829.501574] Starting dynamic subtest: vcs1 [838.833059] Dynamic subtest vcs1: SUCCESS (9.343s) [838.845411] Starting dynamic subtest: vecs0 [850.139597] Dynamic subtest vecs0: SUCCESS (11.306s) [850.152014] Starting dynamic subtest: ccs0 [864.024636] Dynamic subtest ccs0: SUCCESS (13.885s) [864.026979] Subtest wide: SUCCESS (56.512s) [865.646001] [106/131] (160s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [865.750285] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [865.752595] Starting dynamic subtest: pipe-A-default-mode [866.040212] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [866.045104] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.287s) [866.943468] [107/131] (159s left) kms_big_fb (linear-64bpp-rotate-180) [867.048956] Starting subtest: linear-64bpp-rotate-180 [868.750865] Subtest linear-64bpp-rotate-180: SUCCESS (1.702s) [868.967869] [108/131] (157s left) gem_ppgtt (blt-vs-render-ctxn) [869.045192] Starting subtest: blt-vs-render-ctxN [902.239613] Subtest blt-vs-render-ctxN: SUCCESS (33.196s) [902.437474] [109/131] (123s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [902.588097] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [902.592247] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [902.724939] [110/131] (123s left) kms_chamelium_frames (dp-frame-dump) [903.127756] Subtest dp-frame-dump: SKIP (0.000s) [903.920373] [111/131] (122s left) kms_psr2_su (page_flip-nv12) [903.989915] Subtest page_flip-NV12: SKIP (0.000s) [904.058920] [112/131] (122s left) gem_tiling_max_stride [904.194306] [113/131] (122s left) perf_pmu (busy-idle) [904.231537] Starting subtest: busy-idle [904.233636] Starting dynamic subtest: rcs0 [904.957392] Dynamic subtest rcs0: SUCCESS (0.727s) [904.971091] Starting dynamic subtest: bcs0 [905.626230] Dynamic subtest bcs0: SUCCESS (0.666s) [905.640387] Starting dynamic subtest: vcs0 [907.671235] Dynamic subtest vcs0: SUCCESS (2.041s) [907.684872] Starting dynamic subtest: vcs1 [909.655468] Dynamic subtest vcs1: SUCCESS (1.980s) [909.669151] Starting dynamic subtest: vecs0 [911.639796] Dynamic subtest vecs0: SUCCESS (1.981s) [911.653372] Starting dynamic subtest: ccs0 [912.314752] Dynamic subtest ccs0: SUCCESS (0.674s) [912.317220] Subtest busy-idle: SUCCESS (8.085s) [912.464235] [114/131] (113s left) dmabuf_sync_file (export-before-signal) [912.502876] Starting subtest: export-before-signal [912.504745] Subtest export-before-signal: SUCCESS (0.001s) [912.586283] [115/131] (113s left) gem_exec_reloc (basic-cpu-read) [912.661413] Subtest basic-cpu-read: SKIP (0.000s) [912.752944] [116/131] (113s left) kms_hdr (bpc-switch) [912.863263] Starting subtest: bpc-switch [913.914354] Starting dynamic subtest: pipe-A-eDP-1 [917.410887] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s) [917.413257] Subtest bpc-switch: SUCCESS (4.548s) [917.558724] [117/131] (108s left) perf (i915-ref-count) [917.674595] Starting subtest: i915-ref-count [917.743810] Subtest i915-ref-count: SUCCESS (0.067s) [917.802588] [118/131] (108s left) gem_ctx_isolation (nonpriv) [917.865993] Starting subtest: nonpriv [917.868376] Starting dynamic subtest: rcs0 [918.090927] Dynamic subtest rcs0: SUCCESS (0.224s) [918.103495] Starting dynamic subtest: bcs0 [918.364762] Dynamic subtest bcs0: SUCCESS (0.273s) [918.378694] Starting dynamic subtest: vcs0 [918.650034] Dynamic subtest vcs0: SUCCESS (0.285s) [918.662648] Starting dynamic subtest: vcs1 [919.892962] Dynamic subtest vcs1: SUCCESS (1.241s) [919.906211] Starting dynamic subtest: vecs0 [921.959620] Dynamic subtest vecs0: SUCCESS (2.065s) [921.971154] Starting dynamic subtest: ccs0 [923.963942] Dynamic subtest ccs0: SUCCESS (2.003s) [923.966341] Subtest nonpriv: SUCCESS (6.097s) [924.245666] [119/131] (102s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [924.315914] Starting subtest: y-tiled-to-vebox-x-tiled [924.320392] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [924.526345] [120/131] (102s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [924.639362] Starting subtest: plane-use-after-nonblocking-unbind [924.641796] Starting dynamic subtest: pipe-A-eDP-1 [924.698684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [924.995603] Starting dynamic subtest: pipe-B-eDP-1 [925.777063] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.793s) [926.063072] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.425s) [926.967748] [121/131] ( 99s left) i915_hangman (engine-error-state-capture) [927.038766] Starting subtest: engine-error-state-capture [927.041008] Starting dynamic subtest: rcs0 [930.613993] Dynamic subtest rcs0: SUCCESS (3.575s) [930.627621] Starting dynamic subtest: bcs0 [936.630089] Dynamic subtest bcs0: SUCCESS (6.012s) [936.641993] Starting dynamic subtest: vcs0 [942.582596] Dynamic subtest vcs0: SUCCESS (5.948s) [942.595529] Starting dynamic subtest: vcs1 [947.573846] Dynamic subtest vcs1: SUCCESS (4.988s) [947.587261] Starting dynamic subtest: vecs0 [952.568961] Dynamic subtest vecs0: SUCCESS (4.992s) [952.591475] Starting dynamic subtest: ccs0 [958.645495] Dynamic subtest ccs0: SUCCESS (6.074s) [958.648610] Subtest engine-error-state-capture: SUCCESS (31.605s) [958.751174] [122/131] ( 67s left) gem_exec_schedule (pi-shared-iova) [958.940230] Starting subtest: pi-shared-iova [958.942599] Starting dynamic subtest: rcs0 [959.069374] Dynamic subtest rcs0: SUCCESS (0.130s) [959.084270] Starting dynamic subtest: vcs0 [959.160889] Dynamic subtest vcs0: SUCCESS (0.092s) [959.175745] Starting dynamic subtest: vcs1 [959.252104] Dynamic subtest vcs1: SUCCESS (0.091s) [959.266983] Starting dynamic subtest: vecs0 [959.341603] Dynamic subtest vecs0: SUCCESS (0.087s) [959.356036] Starting dynamic subtest: ccs0 [959.464056] Dynamic subtest ccs0: SUCCESS (0.121s) [959.466621] Subtest pi-shared-iova: SUCCESS (0.526s) [960.788613] [123/131] ( 65s left) syncobj_wait (invalid-reset-illegal-handle) [960.845112] Starting subtest: invalid-reset-illegal-handle [960.847466] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [960.992722] [124/131] ( 65s left) syncobj_wait (single-wait-all-for-submit-signaled) [961.049506] Starting subtest: single-wait-all-for-submit-signaled [961.051737] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [961.185628] [125/131] ( 65s left) kms_cursor_crc (cursor-sliding-512x170) [961.490363] Starting subtest: cursor-sliding-512x170 [961.495146] Subtest cursor-sliding-512x170: SKIP (0.001s) [961.672730] [126/131] ( 65s left) kms_chamelium_hpd (hdmi-hpd-fast) [962.055775] Subtest hdmi-hpd-fast: SKIP (0.000s) [962.844265] [127/131] ( 64s left) gem_ctx_persistence (hostile) [962.909014] Starting subtest: hostile [973.075593] Subtest hostile: SUCCESS (10.160s) [973.245696] [128/131] ( 53s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [973.356358] Starting subtest: fbc-rgb565-draw-blt [977.575311] Subtest fbc-rgb565-draw-blt: SUCCESS (4.224s) [978.809775] [129/131] ( 48s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [978.908859] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [988.448852] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.541s) [988.618475] [130/131] ( 38s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [988.731374] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [988.735509] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [988.871431] [131/131] ( 38s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [988.966245] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [988.970346] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [989.090064] 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.