[56.734886] Initializing watchdogs [56.734986] /dev/watchdog0 [56.749632] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.754045] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.756468] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.759887] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [56.886648] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [56.891274] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [57.014609] [002/131] (960s left) gem_exec_fence (submit3) [57.192770] Starting subtest: submit3 [57.197083] Subtest submit3: SKIP (0.000s) [58.987203] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [58.990198] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [59.103659] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [59.108081] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.244383] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [59.358848] Starting subtest: fbc-rgb101010-draw-mmap-wc [63.940785] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.553s) [65.088838] [005/131] (952s left) gem_exec_balancer (noheartbeat) [65.347345] Starting subtest: noheartbeat [65.352125] Subtest noheartbeat: SKIP (0.000s) [65.467885] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [65.569360] Subtest ctm-blue-to-red: SKIP (0.000s) [65.615012] [007/131] (951s left) gem_workarounds (suspend-resume) [65.676614] Starting subtest: suspend-resume [81.112875] Subtest suspend-resume: SUCCESS (6.466s) [81.276499] [008/131] (936s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [81.377015] Starting subtest: planes-downscale-factor-0-75-unity-scaling [81.379303] Starting dynamic subtest: pipe-A [81.442512] Dynamic subtest pipe-A: SUCCESS (0.065s) [81.455754] Starting dynamic subtest: pipe-B [82.632414] Dynamic subtest pipe-B: SUCCESS (1.140s) [82.644361] Starting dynamic subtest: pipe-C [83.788654] Dynamic subtest pipe-C: SUCCESS (1.112s) [83.801202] Starting dynamic subtest: pipe-D [84.945311] Dynamic subtest pipe-D: SUCCESS (1.119s) [84.947727] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.439s) [86.373874] [009/131] (931s left) gem_pxp (create-regular-buffer) [86.508813] Starting subtest: create-regular-buffer [86.511700] Subtest create-regular-buffer: SUCCESS (0.000s) [86.640307] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [86.701992] Starting subtest: rel-constants-invalid-rel-gen5 [86.704404] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [86.834749] [011/131] (930s left) gem_exec_nop (basic-series) [86.914809] Starting subtest: basic-series [102.866964] Subtest basic-series: SUCCESS (15.800s) [103.140944] [012/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [103.245032] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [103.249154] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [103.373001] [013/131] (914s left) kms_psr (fbc-psr-primary-page-flip) [103.467996] Starting subtest: fbc-psr-primary-page-flip [103.470346] Starting dynamic subtest: eDP-1 [103.474646] Dynamic subtest eDP-1: SKIP (0.000s) [103.479211] Subtest fbc-psr-primary-page-flip: SKIP (0.002s) [103.566916] [014/131] (914s left) i915_pm_rps (engine-order) [103.637790] Starting subtest: engine-order [108.521996] Subtest engine-order: SUCCESS (4.873s) [108.688742] [015/131] (909s left) gem_softpin (evict-active) [108.751705] Starting subtest: evict-active [108.762715] Subtest evict-active: SUCCESS (0.011s) [108.916163] [016/131] (908s left) syncobj_timeline (wait-delayed-signal) [108.979997] Starting subtest: wait-delayed-signal [109.083871] Subtest wait-delayed-signal: SUCCESS (0.103s) [109.197837] [017/131] (908s left) kms_panel_fitting (atomic-fastset) [109.316002] Starting subtest: atomic-fastset [109.318532] Starting dynamic subtest: pipe-A-eDP-1 [109.455868] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s) [109.467512] Starting dynamic subtest: pipe-B-eDP-1 [110.694207] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s) [110.705973] Starting dynamic subtest: pipe-C-eDP-1 [111.879599] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s) [111.888584] Starting dynamic subtest: pipe-D-eDP-1 [113.007813] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s) [113.010311] Subtest atomic-fastset: SUCCESS (3.689s) [114.186206] [018/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-270) [114.295608] Starting subtest: x-tiled-16bpp-rotate-270 [114.315046] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [114.461029] [019/131] (903s left) api_intel_bb (render-ccs) [114.521712] Starting subtest: render-ccs [115.126944] Subtest render-ccs: SUCCESS (0.604s) [115.236388] [020/131] (902s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [115.333672] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [115.335917] Starting dynamic subtest: pipe-A-eDP-1 [115.358930] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [115.369213] Starting dynamic subtest: pipe-B-eDP-1 [115.391065] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [115.399617] Starting dynamic subtest: pipe-C-eDP-1 [115.421073] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [115.429706] Starting dynamic subtest: pipe-D-eDP-1 [115.451466] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [115.455543] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [117.564168] [021/131] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [117.634490] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [117.738579] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s) [117.840113] [022/131] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [117.949183] Starting subtest: psr-2p-primscrn-cur-indfb-move [117.953254] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [118.090428] [023/131] (900s left) gem_lmem_swapping (heavy-multi) [118.137170] Subtest heavy-multi: SKIP (0.000s) [118.184411] [024/131] (900s left) kms_async_flips (test-cursor) [118.277939] Starting subtest: test-cursor [118.282298] Subtest test-cursor: SKIP (0.000s) [119.499932] [025/131] (898s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [124.550745] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [124.553172] Starting dynamic subtest: pipe-A-eDP-1 [125.350534] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s) [125.362725] Starting dynamic subtest: pipe-B-eDP-1 [126.486947] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s) [126.491745] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.932s) [127.701880] [026/131] (890s left) kms_plane_multiple (2x-tiling-4) [127.811190] Starting subtest: 2x-tiling-4 [127.815655] Subtest 2x-tiling-4: SKIP (0.000s) [127.911243] [027/131] (890s left) gem_ctx_param (invalid-param-set) [127.975586] Starting subtest: invalid-param-set [127.977911] Subtest invalid-param-set: SUCCESS (0.000s) [128.072958] [028/131] (890s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [128.155695] Starting subtest: bad-pixel-format-y-tiled-ccs [128.158053] Starting dynamic subtest: pipe-A-eDP-1 [128.180842] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [128.192627] Starting dynamic subtest: pipe-B-eDP-1 [128.213968] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [128.222685] Starting dynamic subtest: pipe-C-eDP-1 [128.244189] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [128.254254] Starting dynamic subtest: pipe-D-eDP-1 [128.275615] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [128.279861] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [130.475506] [029/131] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [130.565700] Starting subtest: plane-downscale-factor-0-5-with-modifiers [130.568009] Starting dynamic subtest: pipe-A [130.586000] Dynamic subtest pipe-A: SKIP (0.016s) [130.596888] Starting dynamic subtest: pipe-B [130.616481] Dynamic subtest pipe-B: SKIP (0.031s) [130.625542] Starting dynamic subtest: pipe-C [130.648930] Dynamic subtest pipe-C: SKIP (0.031s) [130.657823] Starting dynamic subtest: pipe-D [130.680005] Dynamic subtest pipe-D: SKIP (0.030s) [130.683843] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.111s) [130.812017] [030/131] (887s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [130.873678] Starting subtest: multi-wait-all-available-submitted-signaled [130.876048] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [130.996203] [031/131] (887s left) perf (missing-sample-flags) [131.143132] Starting subtest: missing-sample-flags [131.145463] Subtest missing-sample-flags: SUCCESS (0.000s) [131.184750] [032/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [131.276441] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [137.479788] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.203s) [138.666459] [033/131] (879s left) kms_pm_rpm (system-suspend-idle) [140.238504] Starting subtest: system-suspend-idle [159.316845] Subtest system-suspend-idle: SUCCESS (4.270s) [159.724928] [034/131] (858s left) kms_vblank (wait-forked) [159.829815] Starting subtest: wait-forked [159.832333] Starting dynamic subtest: pipe-A-eDP-1 [161.696347] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s) [161.711561] Starting dynamic subtest: pipe-D-eDP-1 [164.209492] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.453s) [164.211805] Subtest wait-forked: SUCCESS (4.265s) [165.125726] [035/131] (853s left) kms_big_fb (y-tiled-32bpp-rotate-0) [165.225693] Starting subtest: y-tiled-32bpp-rotate-0 [165.230672] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [165.338313] [036/131] (853s left) kms_pipe_crc_basic (read-crc) [165.427061] Starting subtest: read-crc [165.429393] Starting dynamic subtest: pipe-A-eDP-1 [166.142147] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s) [166.152834] Starting dynamic subtest: pipe-B-eDP-1 [167.496010] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.334s) [167.506365] Starting dynamic subtest: pipe-C-eDP-1 [168.807238] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.292s) [168.818223] Starting dynamic subtest: pipe-D-eDP-1 [170.150055] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s) [170.152051] Subtest read-crc: SUCCESS (4.663s) [171.006684] [037/131] (847s left) kms_cursor_legacy (single-move) [171.144824] Starting subtest: single-move [171.147128] Starting dynamic subtest: pipe-A [176.560929] Dynamic subtest pipe-A: SUCCESS (5.380s) [176.571552] Starting dynamic subtest: pipe-B [181.960778] Dynamic subtest pipe-B: SUCCESS (5.380s) [181.971677] Starting dynamic subtest: pipe-C [187.351360] Dynamic subtest pipe-C: SUCCESS (5.380s) [187.361172] Starting dynamic subtest: pipe-D [192.740717] Dynamic subtest pipe-D: SUCCESS (5.382s) [192.749772] Starting dynamic subtest: all-pipes [198.129285] Dynamic subtest all-pipes: SUCCESS (5.385s) [198.131501] Subtest single-move: SUCCESS (26.915s) [198.299762] [038/131] (820s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [203.330631] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [203.335192] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s) [204.201586] [039/131] (814s left) gem_unref_active_buffers [204.420223] [040/131] (814s left) kms_psr (fbc-psr2-primary-mmap-gtt) [204.516050] Starting subtest: fbc-psr2-primary-mmap-gtt [204.517930] Starting dynamic subtest: eDP-1 [204.521967] Dynamic subtest eDP-1: SKIP (0.000s) [204.526009] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [204.610296] [041/131] (814s left) syncobj_wait (invalid-signal-zero-handles) [204.677455] Starting subtest: invalid-signal-zero-handles [204.680025] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [204.817405] [042/131] (814s left) gen9_exec_parse (bb-oversize) [204.874477] Subtest bb-oversize: SKIP (0.000s) [204.951014] [043/131] (814s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [205.007732] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [205.114136] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s) [205.217088] [044/131] (813s left) gem_exec_reloc (basic-write-cpu-noreloc) [205.286376] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [205.383549] [045/131] (813s left) gem_mmap_offset (bad-flags) [205.440996] Starting subtest: bad-flags [205.443308] Subtest bad-flags: SUCCESS (0.000s) [205.591145] [046/131] (813s left) kms_cursor_legacy (cursor-vs-flip-legacy) [205.705969] Starting subtest: cursor-vs-flip-legacy [235.039611] Subtest cursor-vs-flip-legacy: SUCCESS (29.321s) [235.937470] [047/131] (783s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [236.027981] Starting subtest: sprite-rotation-90-pos-100-0 [236.032046] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [236.126511] [048/131] (783s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [236.227580] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [237.206433] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.978s) [237.378071] [049/131] (781s left) gem_create (busy-create) [237.435307] Starting subtest: busy-create [237.437606] Starting dynamic subtest: smem0 [270.654778] Dynamic subtest smem0: SUCCESS (33.214s) [270.657272] Subtest busy-create: SUCCESS (33.215s) [270.867332] [050/131] (748s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [270.973454] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [275.163659] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.193s) [276.346270] [051/131] (743s left) perf (invalid-open-flags) [276.457265] Starting subtest: invalid-open-flags [276.459576] Subtest invalid-open-flags: SUCCESS (0.000s) [276.498455] [052/131] (742s left) perf (oa-formats) [276.595363] Starting subtest: oa-formats [276.597953] Starting dynamic subtest: 0-rcs0 [276.609158] Dynamic subtest 0-rcs0: SUCCESS (0.014s) [276.620219] Starting dynamic subtest: 1-vecs0 [276.630003] Dynamic subtest 1-vecs0: SUCCESS (0.020s) [276.632313] Subtest oa-formats: SUCCESS (0.036s) [276.671291] [053/131] (742s left) kms_big_fb (4-tiled-8bpp-rotate-270) [276.792987] Starting subtest: 4-tiled-8bpp-rotate-270 [276.813764] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [276.960074] [054/131] (742s left) kms_cursor_crc (cursor-onscreen-64x21) [277.144417] Starting subtest: cursor-onscreen-64x21 [277.196664] Subtest cursor-onscreen-64x21: SKIP (0.050s) [277.447095] [055/131] (742s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [277.546898] Starting subtest: primary-4-tiled-reflect-x-180 [284.648644] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.102s) [285.890150] [056/131] (733s left) kms_cursor_crc (cursor-onscreen-256x256) [286.117330] Starting subtest: cursor-onscreen-256x256 [286.122401] Starting dynamic subtest: pipe-A-eDP-1 [288.219683] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s) [288.251319] Starting dynamic subtest: pipe-D-eDP-1 [290.947583] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.702s) [290.949790] Subtest cursor-onscreen-256x256: SUCCESS (4.827s) [291.772675] [057/131] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [291.874887] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [299.249068] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.374s) [299.441269] [058/131] (720s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [299.541783] Starting subtest: async-flip-with-page-flip-events-tiled [299.939124] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [302.667641] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.726s) [302.680319] Starting dynamic subtest: pipe-A-eDP-1-4 [304.831530] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.162s) [304.843401] Starting dynamic subtest: pipe-A-eDP-1-4 [306.841780] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [306.851400] Starting dynamic subtest: pipe-A-eDP-1-x [309.021629] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [309.405299] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [312.206281] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.800s) [312.226993] Starting dynamic subtest: pipe-B-eDP-1-4 [314.420012] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.217s) [314.432326] Starting dynamic subtest: pipe-B-eDP-1-4 [316.430516] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [316.440477] Starting dynamic subtest: pipe-B-eDP-1-x [318.610006] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s) [318.996385] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [321.735110] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.745s) [321.747659] Starting dynamic subtest: pipe-C-eDP-1-4 [323.910560] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [323.925654] Starting dynamic subtest: pipe-C-eDP-1-4 [325.921022] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [325.930639] Starting dynamic subtest: pipe-C-eDP-1-x [328.114308] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.190s) [328.506178] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [331.256396] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.760s) [331.268145] Starting dynamic subtest: pipe-D-eDP-1-4 [333.431600] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [333.443801] Starting dynamic subtest: pipe-D-eDP-1-4 [335.442535] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [335.453313] Starting dynamic subtest: pipe-D-eDP-1-x [337.622152] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [337.624425] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.071s) [338.870389] [059/131] (680s left) perf (polling) [338.973319] Starting subtest: polling [338.975594] Starting dynamic subtest: 0-rcs0 [348.999128] Dynamic subtest 0-rcs0: SUCCESS (10.021s) [349.009049] Starting dynamic subtest: 1-vcs1 [359.021512] Dynamic subtest 1-vcs1: SUCCESS (10.017s) [359.024017] Subtest polling: SUCCESS (20.040s) [359.070676] [060/131] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [359.180308] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [359.184264] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [359.307240] [061/131] (660s left) syncobj_timeline (reset-signaled) [359.362243] Starting subtest: reset-signaled [359.364172] Subtest reset-signaled: SUCCESS (0.000s) [359.487216] [062/131] (660s left) kms_rmfb (rmfb-ioctl) [359.586909] Starting subtest: rmfb-ioctl [359.589154] Starting dynamic subtest: pipe-A-eDP-1 [359.691500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [359.706796] Starting dynamic subtest: pipe-B-eDP-1 [360.903801] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s) [360.917926] Starting dynamic subtest: pipe-C-eDP-1 [362.039049] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.132s) [362.048642] Starting dynamic subtest: pipe-D-eDP-1 [363.166964] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s) [363.169163] Subtest rmfb-ioctl: SUCCESS (3.581s) [364.414911] [063/131] (655s left) gem_userptr_blits (create-destroy-sync) [364.492852] Starting subtest: create-destroy-sync [369.507993] Subtest create-destroy-sync: SUCCESS (5.014s) [369.679523] [064/131] (650s left) gem_exec_reloc (basic-gtt-cpu-active) [369.739470] Subtest basic-gtt-cpu-active: SKIP (0.000s) [369.822318] [065/131] (650s left) api_intel_allocator (execbuf-with-allocator) [369.866699] Starting subtest: execbuf-with-allocator [369.870006] Subtest execbuf-with-allocator: SUCCESS (0.006s) [369.988675] [066/131] (650s left) kms_lease (cursor-implicit-plane) [370.090762] Starting subtest: cursor-implicit-plane [370.093121] Starting dynamic subtest: pipe-A-eDP-1 [370.550655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s) [370.563123] Starting dynamic subtest: pipe-B-eDP-1 [371.724899] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.173s) [371.735166] Starting dynamic subtest: pipe-C-eDP-1 [372.833545] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s) [372.844521] Starting dynamic subtest: pipe-D-eDP-1 [373.952471] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s) [373.954935] Subtest cursor-implicit-plane: SUCCESS (3.861s) [374.844292] [067/131] (645s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [374.971684] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [374.976294] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [375.152866] [068/131] (644s left) syncobj_wait (invalid-signal-illegal-handle) [375.208899] Starting subtest: invalid-signal-illegal-handle [375.211249] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [375.363211] [069/131] (644s left) kms_psr (psr-primary-blt) [375.467961] Starting subtest: psr-primary-blt [375.470308] Starting dynamic subtest: eDP-1 [377.222481] Dynamic subtest eDP-1: SUCCESS (1.756s) [377.224777] Subtest psr-primary-blt: SUCCESS (1.757s) [378.106806] [070/131] (642s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [378.208708] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [378.210830] Starting dynamic subtest: pipe-A-eDP-1 [378.269669] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [378.279448] Starting dynamic subtest: pipe-B-eDP-1 [378.337035] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [378.347465] Starting dynamic subtest: pipe-C-eDP-1 [378.404924] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [378.415272] Starting dynamic subtest: pipe-D-eDP-1 [378.472804] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [378.477000] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [380.466573] [071/131] (639s left) kms_psr (pr-primary-blt) [380.563149] Starting subtest: pr-primary-blt [380.567536] Subtest pr-primary-blt: SKIP (0.000s) [380.658110] [072/131] (639s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [380.755645] Starting subtest: psr-2p-primscrn-spr-indfb-move [380.760069] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [380.892139] [073/131] (639s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [380.991980] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [380.994331] Starting dynamic subtest: pipe-A-default-mode [382.111962] Dynamic subtest pipe-A-default-mode: SKIP (1.117s) [382.116016] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.119s) [382.313937] [074/131] (638s left) gem_exec_schedule (u-semaphore-noskip) [382.391955] Starting subtest: u-semaphore-noskip [382.817501] Subtest u-semaphore-noskip: SUCCESS (0.433s) [383.205595] [075/131] (637s left) i915_drm_fdinfo (memory-info-idle) [383.242798] Starting subtest: memory-info-idle [383.245199] Starting dynamic subtest: smem0 [383.316383] Dynamic subtest smem0: SUCCESS (0.075s) [383.319303] Subtest memory-info-idle: SUCCESS (0.076s) [383.415995] [076/131] (637s left) i915_selftest (live) [386.919441] Starting subtest: live [386.921869] Starting dynamic subtest: sanitycheck [391.410390] Dynamic subtest sanitycheck: SUCCESS (4.492s) [391.420413] Starting dynamic subtest: uncore [395.877763] Dynamic subtest uncore: SUCCESS (4.467s) [395.888012] Starting dynamic subtest: workarounds [400.677360] Dynamic subtest workarounds: SUCCESS (4.799s) [400.692915] Starting dynamic subtest: gt_engines [405.428108] Dynamic subtest gt_engines: SUCCESS (4.750s) [405.438114] Starting dynamic subtest: gt_timelines [421.434449] Dynamic subtest gt_timelines: SUCCESS (16.007s) [421.444437] Starting dynamic subtest: gt_contexts [425.765263] Dynamic subtest gt_contexts: SUCCESS (4.329s) [425.780252] Starting dynamic subtest: gt_lrc [432.041669] Dynamic subtest gt_lrc: SUCCESS (6.274s) [432.052027] Starting dynamic subtest: gt_mocs [436.604507] Dynamic subtest gt_mocs: SUCCESS (4.561s) [436.614004] Starting dynamic subtest: gt_pm [441.450829] Dynamic subtest gt_pm: SUCCESS (4.845s) [441.461977] Starting dynamic subtest: gt_heartbeat [445.912926] Dynamic subtest gt_heartbeat: SUCCESS (4.459s) [445.922712] Starting dynamic subtest: gt_tlb [455.327223] Dynamic subtest gt_tlb: SUCCESS (9.412s) [455.337440] Starting dynamic subtest: requests [468.934346] Dynamic subtest requests: SUCCESS (13.604s) [468.943839] Starting dynamic subtest: migrate [477.014031] Dynamic subtest migrate: SUCCESS (8.077s) [477.029665] Starting dynamic subtest: active [481.524002] Dynamic subtest active: SUCCESS (4.507s) [481.533142] Starting dynamic subtest: objects [486.392496] Dynamic subtest objects: SUCCESS (4.865s) [486.402222] Starting dynamic subtest: mman [491.361801] Dynamic subtest mman: SUCCESS (4.966s) [491.372308] Starting dynamic subtest: dmabuf [494.291078] Dynamic subtest dmabuf: SUCCESS (2.926s) [494.301491] Starting dynamic subtest: vma [498.801150] Dynamic subtest vma: SUCCESS (4.507s) [498.811274] Starting dynamic subtest: coherency [504.204068] Dynamic subtest coherency: SUCCESS (5.400s) [504.213918] Starting dynamic subtest: gtt [516.461870] Dynamic subtest gtt: SUCCESS (12.255s) [516.476751] Starting dynamic subtest: gem [524.519629] Dynamic subtest gem: SUCCESS (8.055s) [524.528877] Starting dynamic subtest: evict [530.089101] Dynamic subtest evict: SUCCESS (5.565s) [530.099382] Starting dynamic subtest: hugepages [541.250942] Dynamic subtest hugepages: SUCCESS (11.157s) [541.261112] Starting dynamic subtest: gem_contexts [570.497348] Dynamic subtest gem_contexts: SUCCESS (29.238s) [570.507458] Starting dynamic subtest: client [575.018845] Dynamic subtest client: SUCCESS (4.519s) [575.028762] Starting dynamic subtest: gem_migrate [579.507752] Dynamic subtest gem_migrate: SUCCESS (4.486s) [579.517721] Starting dynamic subtest: reset [584.034075] Dynamic subtest reset: SUCCESS (4.523s) [584.044311] Starting dynamic subtest: memory_region [588.468663] Dynamic subtest memory_region: SUCCESS (4.431s) [588.478407] Starting dynamic subtest: hangcheck [601.910984] Dynamic subtest hangcheck: SUCCESS (13.438s) [601.921336] Starting dynamic subtest: execlists [606.358254] Dynamic subtest execlists: SUCCESS (4.443s) [606.368585] Starting dynamic subtest: ring_submission [610.837314] Dynamic subtest ring_submission: SUCCESS (4.476s) [610.847615] Starting dynamic subtest: perf [615.405166] Dynamic subtest perf: SUCCESS (4.564s) [615.415418] Starting dynamic subtest: slpc [629.742448] Dynamic subtest slpc: SUCCESS (14.331s) [629.751809] Starting dynamic subtest: guc [633.767615] Dynamic subtest guc: SUCCESS (4.021s) [633.777648] Starting dynamic subtest: guc_multi_lrc [638.270810] Dynamic subtest guc_multi_lrc: SUCCESS (4.500s) [638.280768] Starting dynamic subtest: guc_hang [643.354798] Dynamic subtest guc_hang: SUCCESS (5.085s) [643.364072] Starting dynamic subtest: late_gt_pm [647.847922] Dynamic subtest late_gt_pm: SUCCESS (4.495s) [647.850499] Subtest live: SUCCESS (260.907s) [647.877681] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [647.878392] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [647.881507] [077/131] (372s left) gem_userptr_blits (nohangcheck) [649.470497] Starting subtest: nohangcheck [649.757701] Subtest nohangcheck: SUCCESS (0.283s) [649.857098] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [649.858294] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [649.864750] [078/131] (370s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [649.983797] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [649.985826] Starting dynamic subtest: pipe-A-eDP-1 [650.839026] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s) [650.857523] Starting dynamic subtest: pipe-B-eDP-1 [652.460117] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.618s) [652.469333] Starting dynamic subtest: pipe-C-eDP-1 [654.006875] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s) [654.021232] Starting dynamic subtest: pipe-D-eDP-1 [655.535567] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.531s) [655.537803] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.550s) [656.741040] [079/131] (363s left) gem_softpin (allocator-nopin) [656.799669] Starting subtest: allocator-nopin [656.894729] Subtest allocator-nopin: SUCCESS (0.095s) [657.056764] [080/131] (363s left) kms_draw_crc (draw-method-pwrite) [657.154948] Starting subtest: draw-method-pwrite [657.157190] Starting dynamic subtest: xrgb8888-untiled [657.710330] Dynamic subtest xrgb8888-untiled: SUCCESS (0.557s) [657.719776] Starting dynamic subtest: rgb565-untiled [658.132290] Dynamic subtest rgb565-untiled: SUCCESS (0.422s) [658.141860] Starting dynamic subtest: xrgb2101010-untiled [658.676905] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s) [658.686725] Starting dynamic subtest: xbgr16161616f-untiled [659.420794] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.743s) [659.429711] Starting dynamic subtest: xrgb8888-xtiled [661.175782] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.755s) [661.190038] Starting dynamic subtest: rgb565-xtiled [662.241211] Dynamic subtest rgb565-xtiled: SUCCESS (1.065s) [662.251933] Starting dynamic subtest: xrgb2101010-xtiled [664.007273] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.766s) [664.017097] Starting dynamic subtest: xbgr16161616f-xtiled [667.228955] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.222s) [667.238100] Starting dynamic subtest: xrgb8888-4tiled [668.295249] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.064s) [668.304589] Starting dynamic subtest: rgb565-4tiled [668.838598] Dynamic subtest rgb565-4tiled: SUCCESS (0.542s) [668.856726] Starting dynamic subtest: xrgb2101010-4tiled [669.882347] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.043s) [669.891909] Starting dynamic subtest: xbgr16161616f-4tiled [672.758952] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.877s) [672.761163] Subtest draw-method-pwrite: SUCCESS (15.614s) [672.890195] [081/131] (347s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [672.996401] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [673.000947] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [673.128903] [082/131] (347s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [673.232217] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [673.236330] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [673.369791] [083/131] (347s left) syncobj_timeline (host-signal-points) [673.436392] Starting subtest: host-signal-points [673.442212] Subtest host-signal-points: SUCCESS (0.004s) [673.572793] [084/131] (347s left) gem_mmap_gtt (basic-small-bo) [673.635921] Subtest basic-small-bo: SKIP (0.000s) [673.696502] [085/131] (347s left) perf_pmu (semaphore-wait-idle) [673.737457] Starting subtest: semaphore-wait-idle [673.739218] Starting dynamic subtest: rcs0 [674.250408] Dynamic subtest rcs0: SUCCESS (0.514s) [674.262059] Starting dynamic subtest: bcs0 [674.764396] Dynamic subtest bcs0: SUCCESS (0.510s) [674.776642] Starting dynamic subtest: vcs0 [675.278085] Dynamic subtest vcs0: SUCCESS (0.511s) [675.290673] Starting dynamic subtest: vcs1 [675.789771] Dynamic subtest vcs1: SUCCESS (0.510s) [675.800135] Starting dynamic subtest: vecs0 [676.306389] Dynamic subtest vecs0: SUCCESS (0.512s) [676.317807] Starting dynamic subtest: ccs0 [676.821574] Dynamic subtest ccs0: SUCCESS (0.513s) [676.824493] Subtest semaphore-wait-idle: SUCCESS (3.086s) [676.972207] [086/131] (343s left) kms_addfb_basic (no-handle) [677.030696] Starting subtest: no-handle [677.033029] Subtest no-handle: SUCCESS (0.000s) [677.208782] [087/131] (343s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [677.323493] Starting subtest: fbcpsr-rgb101010-draw-pwrite [684.317090] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.998s) [684.457888] [088/131] (336s left) gem_render_copy (yf-tiled-ccs-to-linear) [684.522769] Starting subtest: yf-tiled-ccs-to-linear [684.527683] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [684.729912] [089/131] (336s left) kms_flip (wf_vblank-ts-check) [684.832565] Starting subtest: wf_vblank-ts-check [684.834917] Starting dynamic subtest: A-eDP1 [693.755786] Dynamic subtest A-eDP1: SUCCESS (8.927s) [693.770706] Starting dynamic subtest: B-eDP1 [702.690655] Dynamic subtest B-eDP1: SUCCESS (8.935s) [702.701575] Starting dynamic subtest: C-eDP1 [711.602807] Dynamic subtest C-eDP1: SUCCESS (8.912s) [711.612344] Starting dynamic subtest: D-eDP1 [720.522327] Dynamic subtest D-eDP1: SUCCESS (8.918s) [720.524620] Subtest wf_vblank-ts-check: SUCCESS (35.702s) [721.777252] [090/131] (299s left) gem_exec_schedule (deep) [721.975741] Starting subtest: deep [721.977525] Starting dynamic subtest: rcs0 [726.815445] Dynamic subtest rcs0: SKIP (4.833s) [726.833767] Starting dynamic subtest: vcs0 [736.996160] Dynamic subtest vcs0: SUCCESS (10.186s) [737.008860] Starting dynamic subtest: vcs1 [748.203843] Dynamic subtest vcs1: SUCCESS (11.208s) [748.217352] Starting dynamic subtest: vecs0 [759.229303] Dynamic subtest vecs0: SUCCESS (11.024s) [759.242941] Starting dynamic subtest: ccs0 [771.029390] Dynamic subtest ccs0: SUCCESS (11.799s) [771.032210] Subtest deep: SUCCESS (49.055s) [772.709599] [091/131] (248s left) kms_sequence (queue-idle) [772.811950] Starting subtest: queue-idle [772.814131] Starting dynamic subtest: pipe-A-eDP-1 [774.640723] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.827s) [774.651002] Starting dynamic subtest: pipe-B-eDP-1 [777.137604] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.495s) [777.147802] Starting dynamic subtest: pipe-C-eDP-1 [779.612863] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.474s) [779.622673] Starting dynamic subtest: pipe-D-eDP-1 [782.052672] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s) [782.054666] Subtest queue-idle: SUCCESS (9.240s) [782.880287] [092/131] (238s left) gem_gtt_cpu_tlb [783.011022] [093/131] (238s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [783.115576] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [789.642001] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.528s) [789.780388] [094/131] (231s left) gem_eio (create-ext) [790.061218] Starting subtest: create-ext [790.401783] Subtest create-ext: SUCCESS (0.340s) [790.538746] [095/131] (230s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [790.617847] Subtest writes-after-reads-uncached: SKIP (0.000s) [790.715334] [096/131] (230s left) sysfs_preempt_timeout (idempotent) [790.776982] Starting subtest: idempotent [790.778901] Starting dynamic subtest: vecs0 [790.780892] Dynamic subtest vecs0: SUCCESS (0.000s) [790.793118] Starting dynamic subtest: ccs0 [790.794683] Dynamic subtest ccs0: SUCCESS (0.000s) [790.804052] Starting dynamic subtest: vcs0 [790.805611] Dynamic subtest vcs0: SUCCESS (0.000s) [790.814669] Starting dynamic subtest: bcs0 [790.816299] Dynamic subtest bcs0: SUCCESS (0.000s) [790.825218] Starting dynamic subtest: rcs0 [790.826803] Dynamic subtest rcs0: SUCCESS (0.000s) [790.837700] Starting dynamic subtest: vcs1 [790.839551] Dynamic subtest vcs1: SUCCESS (0.000s) [790.841325] Subtest idempotent: SUCCESS (0.007s) [790.919000] [097/131] (230s left) gem_busy (semaphore) [791.106031] Subtest semaphore: SKIP (0.000s) [791.368423] [098/131] (229s left) sriov_basic (enable-vfs-bind-unbind-each) [791.449972] Starting subtest: enable-vfs-bind-unbind-each [791.452430] Starting dynamic subtest: numvfs-1 [791.533033] Dynamic subtest numvfs-1: FAIL (0.029s) [791.545050] Starting dynamic subtest: numvfs-2 [791.617354] Dynamic subtest numvfs-2: FAIL (0.004s) [791.629675] Starting dynamic subtest: numvfs-3 [791.703701] Dynamic subtest numvfs-3: FAIL (0.003s) [791.714885] Starting dynamic subtest: numvfs-4 [791.786853] Dynamic subtest numvfs-4: FAIL (0.003s) [791.798959] Starting dynamic subtest: numvfs-5 [791.872973] Dynamic subtest numvfs-5: FAIL (0.003s) [791.884834] Starting dynamic subtest: numvfs-6 [791.957710] Dynamic subtest numvfs-6: FAIL (0.004s) [791.969264] Starting dynamic subtest: numvfs-7 [792.043040] Dynamic subtest numvfs-7: FAIL (0.003s) [792.054464] Starting dynamic subtest: numvfs-random [792.126017] Dynamic subtest numvfs-random: FAIL (0.004s) [792.127998] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s) [792.166214] [099/131] (229s left) kms_pm_lpsp (screens-disabled) [793.269251] Starting subtest: screens-disabled [793.273541] Subtest screens-disabled: SKIP (0.000s) [793.365197] [100/131] (228s left) gem_exec_capture (capture-invisible) [793.433111] Starting subtest: capture-invisible [793.435084] Starting dynamic subtest: smem0 [793.439270] Dynamic subtest smem0: SKIP (0.000s) [793.443528] Subtest capture-invisible: SKIP (0.001s) [793.572159] [101/131] (227s left) gem_lmem_swapping (verify-ccs) [793.612078] Subtest verify-ccs: SKIP (0.000s) [793.659140] [102/131] (227s left) kms_joiner (basic-force-ultra-joiner) [793.752981] Starting subtest: basic-force-ultra-joiner [793.757168] Subtest basic-force-ultra-joiner: SKIP (0.000s) [793.842286] [103/131] (227s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [793.951418] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [800.562118] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.613s) [800.728196] [104/131] (220s left) kms_color (legacy-gamma) [800.832135] Starting subtest: legacy-gamma [800.834327] Starting dynamic subtest: pipe-A-eDP-1 [801.566050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s) [801.577838] Starting dynamic subtest: pipe-B-eDP-1 [803.003543] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s) [803.014988] Starting dynamic subtest: pipe-C-eDP-1 [804.392885] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s) [804.403824] Starting dynamic subtest: pipe-D-eDP-1 [805.741527] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s) [805.743962] Subtest legacy-gamma: SUCCESS (4.909s) [806.563770] [105/131] (215s left) gem_exec_schedule (wide) [806.748936] Starting subtest: wide [806.751446] Starting dynamic subtest: rcs0 [816.917036] Dynamic subtest rcs0: SUCCESS (10.167s) [816.929797] Starting dynamic subtest: vcs0 [829.191999] Dynamic subtest vcs0: SUCCESS (12.273s) [829.205159] Starting dynamic subtest: vcs1 [840.917044] Dynamic subtest vcs1: SUCCESS (11.722s) [840.931159] Starting dynamic subtest: vecs0 [852.318056] Dynamic subtest vecs0: SUCCESS (11.399s) [852.331026] Starting dynamic subtest: ccs0 [866.997823] Dynamic subtest ccs0: SUCCESS (14.676s) [867.000372] Subtest wide: SUCCESS (60.242s) [870.393452] [106/131] (151s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [870.518404] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [870.520602] Starting dynamic subtest: pipe-A-default-mode [870.806558] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [870.810955] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.288s) [871.700134] [107/131] (150s left) kms_big_fb (linear-64bpp-rotate-180) [871.812223] Starting subtest: linear-64bpp-rotate-180 [873.455040] Subtest linear-64bpp-rotate-180: SUCCESS (1.644s) [873.649257] [108/131] (148s left) gem_ppgtt (blt-vs-render-ctxn) [873.711014] Starting subtest: blt-vs-render-ctxN [907.218348] Subtest blt-vs-render-ctxN: SUCCESS (33.503s) [907.384351] [109/131] (114s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [907.538131] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [907.542035] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [907.677875] [110/131] (114s left) kms_chamelium_frames (dp-frame-dump) [908.069930] Subtest dp-frame-dump: SKIP (0.000s) [908.872926] [111/131] (113s left) kms_psr2_su (page_flip-nv12) [908.942868] Subtest page_flip-NV12: SKIP (0.000s) [909.011817] [112/131] (112s left) gem_tiling_max_stride [909.133595] [113/131] (112s left) perf_pmu (busy-idle) [909.173663] Starting subtest: busy-idle [909.176099] Starting dynamic subtest: rcs0 [909.897406] Dynamic subtest rcs0: SUCCESS (0.725s) [909.909776] Starting dynamic subtest: bcs0 [910.570710] Dynamic subtest bcs0: SUCCESS (0.671s) [910.584538] Starting dynamic subtest: vcs0 [912.605812] Dynamic subtest vcs0: SUCCESS (2.032s) [912.620032] Starting dynamic subtest: vcs1 [914.589772] Dynamic subtest vcs1: SUCCESS (1.981s) [914.602814] Starting dynamic subtest: vecs0 [916.573160] Dynamic subtest vecs0: SUCCESS (1.981s) [916.586706] Starting dynamic subtest: ccs0 [917.240023] Dynamic subtest ccs0: SUCCESS (0.665s) [917.242474] Subtest busy-idle: SUCCESS (8.070s) [917.363918] [114/131] (104s left) dmabuf_sync_file (export-before-signal) [917.404006] Starting subtest: export-before-signal [917.406049] Subtest export-before-signal: SUCCESS (0.001s) [917.494360] [115/131] (104s left) gem_exec_reloc (basic-cpu-read) [917.556681] Subtest basic-cpu-read: SKIP (0.000s) [917.639388] [116/131] (104s left) kms_hdr (bpc-switch) [917.748360] Starting subtest: bpc-switch [918.859343] Starting dynamic subtest: pipe-A-eDP-1 [922.346043] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.488s) [922.348299] Subtest bpc-switch: SUCCESS (4.600s) [922.509635] [117/131] ( 99s left) perf (i915-ref-count) [922.624113] Starting subtest: i915-ref-count [922.694919] Subtest i915-ref-count: SUCCESS (0.068s) [922.753112] [118/131] ( 99s left) gem_ctx_isolation (nonpriv) [922.816021] Starting subtest: nonpriv [922.818152] Starting dynamic subtest: rcs0 [923.062462] Dynamic subtest rcs0: SUCCESS (0.246s) [923.076271] Starting dynamic subtest: bcs0 [923.339278] Dynamic subtest bcs0: SUCCESS (0.276s) [923.352231] Starting dynamic subtest: vcs0 [923.626884] Dynamic subtest vcs0: SUCCESS (0.287s) [923.637438] Starting dynamic subtest: vcs1 [924.826814] Dynamic subtest vcs1: SUCCESS (1.199s) [924.840659] Starting dynamic subtest: vecs0 [926.876600] Dynamic subtest vecs0: SUCCESS (2.049s) [926.887557] Starting dynamic subtest: ccs0 [928.905504] Dynamic subtest ccs0: SUCCESS (2.028s) [928.907844] Subtest nonpriv: SUCCESS (6.091s) [929.191230] [119/131] ( 93s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [929.260806] Starting subtest: y-tiled-to-vebox-x-tiled [929.265329] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [929.471179] [120/131] ( 92s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [929.569447] Starting subtest: plane-use-after-nonblocking-unbind [929.571725] Starting dynamic subtest: pipe-A-eDP-1 [929.633952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s) [929.931718] Starting dynamic subtest: pipe-B-eDP-1 [930.719727] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.799s) [931.029158] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.461s) [931.895275] [121/131] ( 90s left) i915_hangman (engine-error-state-capture) [931.977437] Starting subtest: engine-error-state-capture [931.979836] Starting dynamic subtest: rcs0 [935.547354] Dynamic subtest rcs0: SUCCESS (3.569s) [935.563283] Starting dynamic subtest: bcs0 [941.564487] Dynamic subtest bcs0: SUCCESS (6.014s) [941.578501] Starting dynamic subtest: vcs0 [947.515093] Dynamic subtest vcs0: SUCCESS (5.948s) [947.528691] Starting dynamic subtest: vcs1 [952.509884] Dynamic subtest vcs1: SUCCESS (4.989s) [952.520791] Starting dynamic subtest: vecs0 [957.500647] Dynamic subtest vecs0: SUCCESS (4.992s) [957.514404] Starting dynamic subtest: ccs0 [962.555757] Dynamic subtest ccs0: SUCCESS (5.052s) [962.558460] Subtest engine-error-state-capture: SUCCESS (30.581s) [962.731531] [122/131] ( 59s left) gem_exec_schedule (pi-shared-iova) [962.925496] Starting subtest: pi-shared-iova [962.927783] Starting dynamic subtest: rcs0 [963.054244] Dynamic subtest rcs0: SUCCESS (0.130s) [963.068869] Starting dynamic subtest: vcs0 [963.139937] Dynamic subtest vcs0: SUCCESS (0.085s) [963.153477] Starting dynamic subtest: vcs1 [963.222933] Dynamic subtest vcs1: SUCCESS (0.081s) [963.234240] Starting dynamic subtest: vecs0 [963.308440] Dynamic subtest vecs0: SUCCESS (0.085s) [963.322539] Starting dynamic subtest: ccs0 [963.431774] Dynamic subtest ccs0: SUCCESS (0.120s) [963.434131] Subtest pi-shared-iova: SUCCESS (0.508s) [964.711346] [123/131] ( 57s left) syncobj_wait (invalid-reset-illegal-handle) [964.776364] Starting subtest: invalid-reset-illegal-handle [964.778782] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [964.906150] [124/131] ( 57s left) syncobj_wait (single-wait-all-for-submit-signaled) [964.963180] Starting subtest: single-wait-all-for-submit-signaled [964.965421] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [965.102979] [125/131] ( 57s left) kms_cursor_crc (cursor-sliding-512x170) [965.414717] Starting subtest: cursor-sliding-512x170 [965.419283] Subtest cursor-sliding-512x170: SKIP (0.001s) [965.593279] [126/131] ( 56s left) kms_chamelium_hpd (hdmi-hpd-fast) [965.984538] Subtest hdmi-hpd-fast: SKIP (0.000s) [966.774168] [127/131] ( 55s left) gem_ctx_persistence (hostile) [966.846910] Starting subtest: hostile [977.006869] Subtest hostile: SUCCESS (10.156s) [977.163388] [128/131] ( 45s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [977.278330] Starting subtest: fbc-rgb565-draw-blt [981.532046] Subtest fbc-rgb565-draw-blt: SUCCESS (4.257s) [982.732996] [129/131] ( 39s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [982.857634] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [992.303991] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.448s) [992.480326] [130/131] ( 30s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [992.576406] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [992.580823] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [992.722420] [131/131] ( 30s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [992.823432] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [992.827559] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [992.945411] 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.