[57.206940] Initializing watchdogs [57.207077] /dev/watchdog0 [57.223173] [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] [57.227839] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.230335] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.233697] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [57.369233] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [57.373601] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [57.486967] [002/131] (960s left) gem_exec_fence (submit3) [57.660147] Starting subtest: submit3 [57.664647] Subtest submit3: SKIP (0.000s) [58.980796] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [58.984239] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [59.072266] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [59.076281] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.196125] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [59.293353] Starting subtest: fbc-rgb101010-draw-mmap-wc [63.911803] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.640s) [65.128626] [005/131] (952s left) gem_exec_balancer (noheartbeat) [65.379134] Starting subtest: noheartbeat [65.384375] Subtest noheartbeat: SKIP (0.000s) [65.513757] [006/131] (952s left) kms_chamelium_color (ctm-blue-to-red) [65.623648] Subtest ctm-blue-to-red: SKIP (0.000s) [65.667040] [007/131] (952s left) gem_workarounds (suspend-resume) [65.735393] Starting subtest: suspend-resume [81.880284] Subtest suspend-resume: SUCCESS (5.810s) [82.994873] [008/131] (936s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [83.105923] Starting subtest: planes-downscale-factor-0-75-unity-scaling [83.108428] Starting dynamic subtest: pipe-A [83.168005] Dynamic subtest pipe-A: SUCCESS (0.066s) [83.178119] Starting dynamic subtest: pipe-B [84.303194] Dynamic subtest pipe-B: SUCCESS (1.165s) [84.314275] Starting dynamic subtest: pipe-C [85.374267] Dynamic subtest pipe-C: SUCCESS (1.095s) [85.385635] Starting dynamic subtest: pipe-D [86.493084] Dynamic subtest pipe-D: SUCCESS (1.140s) [86.495868] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.468s) [87.742401] [009/131] (931s left) gem_pxp (create-regular-buffer) [87.875361] Starting subtest: create-regular-buffer [87.878341] Subtest create-regular-buffer: SUCCESS (0.000s) [88.025913] [010/131] (931s left) gem_exec_params (rel-constants-invalid-rel-gen5) [88.086970] Starting subtest: rel-constants-invalid-rel-gen5 [88.089562] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [88.217890] [011/131] (930s left) gem_exec_nop (basic-series) [88.303748] Starting subtest: basic-series [104.258185] Subtest basic-series: SUCCESS (16.064s) [104.514667] [012/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [104.632076] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [104.637837] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [104.758714] [013/131] (914s left) kms_psr (fbc-psr-primary-page-flip) [104.849765] Starting subtest: fbc-psr-primary-page-flip [104.852279] Starting dynamic subtest: eDP-1 [104.857234] Dynamic subtest eDP-1: SKIP (0.000s) [104.862329] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [104.946153] [014/131] (914s left) i915_pm_rps (engine-order) [105.010056] Starting subtest: engine-order [109.895327] Subtest engine-order: SUCCESS (4.891s) [110.068961] [015/131] (909s left) gem_softpin (evict-active) [110.136731] Starting subtest: evict-active [110.149154] Subtest evict-active: SUCCESS (0.012s) [110.294582] [016/131] (909s left) syncobj_timeline (wait-delayed-signal) [110.357100] Starting subtest: wait-delayed-signal [110.459559] Subtest wait-delayed-signal: SUCCESS (0.103s) [110.565712] [017/131] (908s left) kms_panel_fitting (atomic-fastset) [110.660745] Starting subtest: atomic-fastset [110.663302] Starting dynamic subtest: pipe-A-eDP-1 [110.804026] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s) [110.813607] Starting dynamic subtest: pipe-B-eDP-1 [112.062320] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s) [112.071678] Starting dynamic subtest: pipe-C-eDP-1 [113.259064] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.192s) [113.269321] Starting dynamic subtest: pipe-D-eDP-1 [114.382879] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s) [114.385583] Subtest atomic-fastset: SUCCESS (3.726s) [115.562878] [018/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-270) [115.681279] Starting subtest: x-tiled-16bpp-rotate-270 [115.701150] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [115.863162] [019/131] (903s left) api_intel_bb (render-ccs) [115.924709] Starting subtest: render-ccs [116.281292] Subtest render-ccs: SUCCESS (0.356s) [116.460442] [020/131] (903s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [116.558264] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [116.560728] Starting dynamic subtest: pipe-A-eDP-1 [116.585725] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [116.597290] Starting dynamic subtest: pipe-B-eDP-1 [116.622223] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [116.631194] Starting dynamic subtest: pipe-C-eDP-1 [116.656940] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [116.665872] Starting dynamic subtest: pipe-D-eDP-1 [116.692074] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [116.697136] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [118.820047] [021/131] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [118.884137] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [118.983754] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s) [119.089661] [022/131] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [119.198487] Starting subtest: psr-2p-primscrn-cur-indfb-move [119.203135] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [119.333932] [023/131] (900s left) gem_lmem_swapping (heavy-multi) [119.381082] Subtest heavy-multi: SKIP (0.000s) [119.467177] [024/131] (900s left) kms_async_flips (test-cursor) [119.564159] Starting subtest: test-cursor [119.569239] Subtest test-cursor: SKIP (0.000s) [120.764311] [025/131] (899s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [125.818221] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [125.820871] Starting dynamic subtest: pipe-A-eDP-1 [126.614294] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s) [126.624883] Starting dynamic subtest: pipe-B-eDP-1 [127.736139] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s) [127.741992] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.914s) [128.958918] [026/131] (890s left) kms_plane_multiple (2x-tiling-4) [129.045113] Starting subtest: 2x-tiling-4 [129.050613] Subtest 2x-tiling-4: SKIP (0.000s) [129.157489] [027/131] (890s left) gem_ctx_param (invalid-param-set) [129.217999] Starting subtest: invalid-param-set [129.221063] Subtest invalid-param-set: SUCCESS (0.000s) [129.319293] [028/131] (890s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [129.425192] Starting subtest: bad-pixel-format-y-tiled-ccs [129.427987] Starting dynamic subtest: pipe-A-eDP-1 [129.454708] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [129.464888] Starting dynamic subtest: pipe-B-eDP-1 [129.490047] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [129.499117] Starting dynamic subtest: pipe-C-eDP-1 [129.524768] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [129.534139] Starting dynamic subtest: pipe-D-eDP-1 [129.562195] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [129.568090] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [131.648928] [029/131] (888s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [131.738202] Starting subtest: plane-downscale-factor-0-5-with-modifiers [131.741087] Starting dynamic subtest: pipe-A [131.759432] Dynamic subtest pipe-A: SKIP (0.016s) [131.769902] Starting dynamic subtest: pipe-B [131.788634] Dynamic subtest pipe-B: SKIP (0.030s) [131.798088] Starting dynamic subtest: pipe-C [131.821220] Dynamic subtest pipe-C: SKIP (0.032s) [131.830493] Starting dynamic subtest: pipe-D [131.851163] Dynamic subtest pipe-D: SKIP (0.030s) [131.856198] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.110s) [131.973651] [030/131] (888s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [132.038254] Starting subtest: multi-wait-all-available-submitted-signaled [132.041106] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [132.164477] [031/131] (887s left) perf (missing-sample-flags) [132.307103] Starting subtest: missing-sample-flags [132.309268] Subtest missing-sample-flags: SUCCESS (0.000s) [132.348862] [032/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [132.462950] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [138.917279] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.460s) [140.140851] [033/131] (880s left) kms_pm_rpm (system-suspend-idle) [142.400319] Starting subtest: system-suspend-idle [162.106526] Subtest system-suspend-idle: SUCCESS (4.338s) [162.517082] [034/131] (857s left) kms_vblank (wait-forked) [162.613575] Starting subtest: wait-forked [162.616135] Starting dynamic subtest: pipe-A-eDP-1 [164.403052] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s) [164.419493] Starting dynamic subtest: pipe-D-eDP-1 [166.894549] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s) [166.896741] Subtest wait-forked: SUCCESS (4.371s) [167.760830] [035/131] (852s left) kms_big_fb (y-tiled-32bpp-rotate-0) [167.863581] Starting subtest: y-tiled-32bpp-rotate-0 [167.868566] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [167.978803] [036/131] (852s left) kms_pipe_crc_basic (read-crc) [168.075503] Starting subtest: read-crc [168.077740] Starting dynamic subtest: pipe-A-eDP-1 [168.779568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s) [168.790544] Starting dynamic subtest: pipe-B-eDP-1 [170.191614] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s) [170.202722] Starting dynamic subtest: pipe-C-eDP-1 [171.547186] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s) [171.558201] Starting dynamic subtest: pipe-D-eDP-1 [172.875442] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s) [172.877911] Subtest read-crc: SUCCESS (4.863s) [173.710422] [037/131] (846s left) kms_cursor_legacy (single-move) [173.843905] Starting subtest: single-move [173.846614] Starting dynamic subtest: pipe-A [179.247912] Dynamic subtest pipe-A: SUCCESS (5.379s) [179.259883] Starting dynamic subtest: pipe-B [184.611164] Dynamic subtest pipe-B: SUCCESS (5.380s) [184.622815] Starting dynamic subtest: pipe-C [189.983461] Dynamic subtest pipe-C: SUCCESS (5.380s) [189.995409] Starting dynamic subtest: pipe-D [195.358910] Dynamic subtest pipe-D: SUCCESS (5.380s) [195.370377] Starting dynamic subtest: all-pipes [200.748341] Dynamic subtest all-pipes: SUCCESS (5.387s) [200.751121] Subtest single-move: SUCCESS (26.914s) [200.871458] [038/131] (819s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [205.885022] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [205.890634] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [206.765169] [039/131] (813s left) gem_unref_active_buffers [206.974113] [040/131] (813s left) kms_psr (fbc-psr2-primary-mmap-gtt) [207.061704] Starting subtest: fbc-psr2-primary-mmap-gtt [207.064458] Starting dynamic subtest: eDP-1 [207.069254] Dynamic subtest eDP-1: SKIP (0.000s) [207.074132] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [207.161231] [041/131] (813s left) syncobj_wait (invalid-signal-zero-handles) [207.226819] Starting subtest: invalid-signal-zero-handles [207.229743] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [207.358567] [042/131] (813s left) gen9_exec_parse (bb-oversize) [207.427756] Subtest bb-oversize: SKIP (0.000s) [207.518391] [043/131] (813s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [207.574940] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [207.674854] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s) [207.774962] [044/131] (812s left) gem_exec_reloc (basic-write-cpu-noreloc) [207.847549] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [207.944424] [045/131] (812s left) gem_mmap_offset (bad-flags) [208.009912] Starting subtest: bad-flags [208.012236] Subtest bad-flags: SUCCESS (0.000s) [208.138396] [046/131] (812s left) kms_cursor_legacy (cursor-vs-flip-legacy) [208.267753] Starting subtest: cursor-vs-flip-legacy [237.635757] Subtest cursor-vs-flip-legacy: SUCCESS (29.371s) [238.517948] [047/131] (782s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [238.619693] Starting subtest: sprite-rotation-90-pos-100-0 [238.624730] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [238.719630] [048/131] (782s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [238.835668] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [239.833680] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.001s) [240.005172] [049/131] (780s left) gem_create (busy-create) [240.057511] Starting subtest: busy-create [240.059816] Starting dynamic subtest: smem0 [273.633079] Dynamic subtest smem0: SUCCESS (33.574s) [273.635937] Subtest busy-create: SUCCESS (33.575s) [273.849923] [050/131] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [273.953427] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [278.167897] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.218s) [279.396148] [051/131] (741s left) perf (invalid-open-flags) [279.505812] Starting subtest: invalid-open-flags [279.508462] Subtest invalid-open-flags: SUCCESS (0.000s) [279.547619] [052/131] (741s left) perf (oa-formats) [279.649634] Starting subtest: oa-formats [279.651920] Starting dynamic subtest: 0-rcs0 [279.666053] Dynamic subtest 0-rcs0: SUCCESS (0.016s) [279.676749] Starting dynamic subtest: 1-vcs1 [279.688690] Dynamic subtest 1-vcs1: SUCCESS (0.022s) [279.691347] Subtest oa-formats: SUCCESS (0.040s) [279.736779] [053/131] (741s left) kms_big_fb (4-tiled-8bpp-rotate-270) [279.849519] Starting subtest: 4-tiled-8bpp-rotate-270 [279.870778] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s) [280.033858] [054/131] (741s left) kms_cursor_crc (cursor-onscreen-64x21) [280.218562] Starting subtest: cursor-onscreen-64x21 [280.266114] Subtest cursor-onscreen-64x21: SKIP (0.042s) [280.526682] [055/131] (740s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [280.630223] Starting subtest: primary-4-tiled-reflect-x-180 [287.953528] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.323s) [289.161126] [056/131] (732s left) kms_cursor_crc (cursor-onscreen-256x256) [289.444143] Starting subtest: cursor-onscreen-256x256 [289.446920] Starting dynamic subtest: pipe-A-eDP-1 [291.548602] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.101s) [291.577535] Starting dynamic subtest: pipe-D-eDP-1 [294.319334] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.748s) [294.321737] Subtest cursor-onscreen-256x256: SUCCESS (4.876s) [295.145657] [057/131] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [295.251179] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [302.499095] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.250s) [302.649250] [058/131] (718s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [302.752705] Starting subtest: async-flip-with-page-flip-events-tiled [303.135931] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [305.989359] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.798s) [306.001040] Starting dynamic subtest: pipe-A-eDP-1-4 [308.184516] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.197s) [308.194174] Starting dynamic subtest: pipe-A-eDP-1-4 [310.142380] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [310.153948] Starting dynamic subtest: pipe-A-eDP-1-x [312.384838] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s) [312.700655] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [315.515235] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.772s) [315.525961] Starting dynamic subtest: pipe-B-eDP-1-4 [317.701509] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s) [317.711742] Starting dynamic subtest: pipe-B-eDP-1-4 [319.659911] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [319.670768] Starting dynamic subtest: pipe-B-eDP-1-x [321.904286] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [322.245711] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [325.050893] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.760s) [325.061444] Starting dynamic subtest: pipe-C-eDP-1-4 [327.237010] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s) [327.247399] Starting dynamic subtest: pipe-C-eDP-1-4 [329.194724] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [329.205549] Starting dynamic subtest: pipe-C-eDP-1-x [331.425024] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [331.742864] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [334.530854] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.796s) [334.541358] Starting dynamic subtest: pipe-D-eDP-1-4 [336.758467] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [336.767704] Starting dynamic subtest: pipe-D-eDP-1-4 [338.715184] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [338.727721] Starting dynamic subtest: pipe-D-eDP-1-x [340.893742] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [340.896787] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.147s) [342.149585] [059/131] (679s left) perf (polling) [342.255757] Starting subtest: polling [342.258348] Starting dynamic subtest: 0-rcs0 [352.329393] Dynamic subtest 0-rcs0: SUCCESS (10.021s) [352.341685] Starting dynamic subtest: 1-vcs0 [362.344452] Dynamic subtest 1-vcs0: SUCCESS (10.018s) [362.346953] Subtest polling: SUCCESS (20.042s) [362.388623] [060/131] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [362.504657] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [362.509522] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [362.642021] [061/131] (658s left) syncobj_timeline (reset-signaled) [362.701707] Starting subtest: reset-signaled [362.704180] Subtest reset-signaled: SUCCESS (0.000s) [362.830197] [062/131] (658s left) kms_rmfb (rmfb-ioctl) [362.925390] Starting subtest: rmfb-ioctl [362.927572] Starting dynamic subtest: pipe-A-eDP-1 [363.030703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [363.041852] Starting dynamic subtest: pipe-B-eDP-1 [364.286204] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s) [364.296757] Starting dynamic subtest: pipe-C-eDP-1 [365.417972] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s) [365.432595] Starting dynamic subtest: pipe-D-eDP-1 [366.570687] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s) [366.573487] Subtest rmfb-ioctl: SUCCESS (3.649s) [367.821131] [063/131] (653s left) gem_userptr_blits (create-destroy-sync) [367.892270] Starting subtest: create-destroy-sync [372.956162] Subtest create-destroy-sync: SUCCESS (5.014s) [373.084039] [064/131] (648s left) gem_exec_reloc (basic-gtt-cpu-active) [373.148727] Subtest basic-gtt-cpu-active: SKIP (0.000s) [373.241431] [065/131] (648s left) api_intel_allocator (execbuf-with-allocator) [373.302491] Starting subtest: execbuf-with-allocator [373.308714] Subtest execbuf-with-allocator: SUCCESS (0.009s) [373.485430] [066/131] (648s left) kms_lease (cursor-implicit-plane) [373.577221] Starting subtest: cursor-implicit-plane [373.579662] Starting dynamic subtest: pipe-A-eDP-1 [374.023343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s) [374.034408] Starting dynamic subtest: pipe-B-eDP-1 [375.133115] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.107s) [375.144393] Starting dynamic subtest: pipe-C-eDP-1 [376.243831] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s) [376.263047] Starting dynamic subtest: pipe-D-eDP-1 [377.363084] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s) [377.365702] Subtest cursor-implicit-plane: SUCCESS (3.788s) [378.247823] [067/131] (643s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [378.373675] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [378.378772] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [378.560725] [068/131] (643s left) syncobj_wait (invalid-signal-illegal-handle) [378.618906] Starting subtest: invalid-signal-illegal-handle [378.621368] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [378.753814] [069/131] (643s left) kms_psr (psr-primary-blt) [378.856228] Starting subtest: psr-primary-blt [378.858664] Starting dynamic subtest: eDP-1 [380.622227] Dynamic subtest eDP-1: SUCCESS (1.765s) [380.624918] Subtest psr-primary-blt: SUCCESS (1.767s) [381.511220] [070/131] (640s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [381.614774] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [381.617550] Starting dynamic subtest: pipe-A-eDP-1 [381.685890] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [381.695195] Starting dynamic subtest: pipe-B-eDP-1 [381.762591] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [381.774899] Starting dynamic subtest: pipe-C-eDP-1 [381.842919] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [381.853733] Starting dynamic subtest: pipe-D-eDP-1 [381.921906] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [381.926816] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [383.874934] [071/131] (637s left) kms_psr (pr-primary-blt) [383.976575] Starting subtest: pr-primary-blt [383.981345] Subtest pr-primary-blt: SKIP (0.000s) [384.072643] [072/131] (637s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [384.186799] Starting subtest: psr-2p-primscrn-spr-indfb-move [384.191746] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [384.320194] [073/131] (637s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [384.408564] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [384.410881] Starting dynamic subtest: pipe-A-default-mode [385.605650] Dynamic subtest pipe-A-default-mode: SKIP (1.196s) [385.610716] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.197s) [385.801018] [074/131] (636s left) gem_exec_schedule (u-semaphore-noskip) [385.879490] Starting subtest: u-semaphore-noskip [386.291203] Subtest u-semaphore-noskip: SUCCESS (0.421s) [386.677371] [075/131] (635s left) i915_drm_fdinfo (memory-info-idle) [386.722922] Starting subtest: memory-info-idle [386.725239] Starting dynamic subtest: smem0 [386.791725] Dynamic subtest smem0: SUCCESS (0.071s) [386.794498] Subtest memory-info-idle: SUCCESS (0.071s) [386.895497] [076/131] (635s left) i915_selftest (live) [390.485096] Starting subtest: live [390.487702] Starting dynamic subtest: sanitycheck [394.692830] Dynamic subtest sanitycheck: SUCCESS (4.206s) [394.702938] Starting dynamic subtest: uncore [398.807645] Dynamic subtest uncore: SUCCESS (4.111s) [398.817757] Starting dynamic subtest: workarounds [403.445151] Dynamic subtest workarounds: SUCCESS (4.633s) [403.455502] Starting dynamic subtest: gt_engines [408.022352] Dynamic subtest gt_engines: SUCCESS (4.574s) [408.032461] Starting dynamic subtest: gt_timelines [425.211327] Dynamic subtest gt_timelines: SUCCESS (17.184s) [425.227087] Starting dynamic subtest: gt_contexts [429.446296] Dynamic subtest gt_contexts: SUCCESS (4.232s) [429.455931] Starting dynamic subtest: gt_lrc [435.264279] Dynamic subtest gt_lrc: SUCCESS (5.816s) [435.274483] Starting dynamic subtest: gt_mocs [439.685941] Dynamic subtest gt_mocs: SUCCESS (4.419s) [439.696164] Starting dynamic subtest: gt_pm [445.894286] Dynamic subtest gt_pm: SUCCESS (6.206s) [445.904905] Starting dynamic subtest: gt_heartbeat [449.935429] Dynamic subtest gt_heartbeat: SUCCESS (4.038s) [449.946323] Starting dynamic subtest: gt_tlb [460.700320] Dynamic subtest gt_tlb: SUCCESS (10.762s) [460.710569] Starting dynamic subtest: requests [472.474517] Dynamic subtest requests: SUCCESS (11.773s) [472.485340] Starting dynamic subtest: migrate [479.940931] Dynamic subtest migrate: SUCCESS (7.465s) [479.951781] Starting dynamic subtest: active [485.632510] Dynamic subtest active: SUCCESS (5.690s) [485.642887] Starting dynamic subtest: objects [490.181987] Dynamic subtest objects: SUCCESS (4.548s) [490.191578] Starting dynamic subtest: mman [496.455676] Dynamic subtest mman: SUCCESS (6.272s) [496.466157] Starting dynamic subtest: dmabuf [500.696480] Dynamic subtest dmabuf: SUCCESS (4.239s) [500.707133] Starting dynamic subtest: vma [504.861589] Dynamic subtest vma: SUCCESS (4.163s) [504.871785] Starting dynamic subtest: coherency [509.804945] Dynamic subtest coherency: SUCCESS (4.942s) [509.814030] Starting dynamic subtest: gtt [521.305066] Dynamic subtest gtt: SUCCESS (11.498s) [521.315752] Starting dynamic subtest: gem [528.523119] Dynamic subtest gem: SUCCESS (7.218s) [528.538692] Starting dynamic subtest: evict [535.395213] Dynamic subtest evict: SUCCESS (6.871s) [535.405548] Starting dynamic subtest: hugepages [545.795830] Dynamic subtest hugepages: SUCCESS (10.400s) [545.805684] Starting dynamic subtest: gem_contexts [574.466671] Dynamic subtest gem_contexts: SUCCESS (28.673s) [574.477268] Starting dynamic subtest: client [578.771493] Dynamic subtest client: SUCCESS (4.304s) [578.781155] Starting dynamic subtest: gem_migrate [582.936118] Dynamic subtest gem_migrate: SUCCESS (4.164s) [582.952408] Starting dynamic subtest: reset [588.676520] Dynamic subtest reset: SUCCESS (5.739s) [588.687735] Starting dynamic subtest: memory_region [592.836203] Dynamic subtest memory_region: SUCCESS (4.159s) [592.851831] Starting dynamic subtest: hangcheck [607.355315] Dynamic subtest hangcheck: SUCCESS (14.520s) [607.365459] Starting dynamic subtest: execlists [611.445950] Dynamic subtest execlists: SUCCESS (4.089s) [611.455908] Starting dynamic subtest: ring_submission [617.129383] Dynamic subtest ring_submission: SUCCESS (5.682s) [617.138429] Starting dynamic subtest: perf [621.349354] Dynamic subtest perf: SUCCESS (4.218s) [621.359751] Starting dynamic subtest: slpc [634.854929] Dynamic subtest slpc: SUCCESS (13.507s) [634.865785] Starting dynamic subtest: guc [640.244721] Dynamic subtest guc: SUCCESS (5.388s) [640.254805] Starting dynamic subtest: guc_multi_lrc [644.300261] Dynamic subtest guc_multi_lrc: SUCCESS (4.053s) [644.310827] Starting dynamic subtest: guc_hang [649.156439] Dynamic subtest guc_hang: SUCCESS (4.851s) [649.167418] Starting dynamic subtest: late_gt_pm [653.348143] Dynamic subtest late_gt_pm: SUCCESS (4.188s) [653.351241] Subtest live: SUCCESS (262.869s) [653.381079] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [653.381781] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [653.385351] [077/131] (368s left) gem_userptr_blits (nohangcheck) [656.216742] Starting subtest: nohangcheck [656.495755] Subtest nohangcheck: SUCCESS (0.277s) [656.600014] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [656.601202] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [656.605506] [078/131] (365s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [656.710627] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [656.712831] Starting dynamic subtest: pipe-A-eDP-1 [657.572221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s) [657.583432] Starting dynamic subtest: pipe-B-eDP-1 [659.271913] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.698s) [659.282163] Starting dynamic subtest: pipe-C-eDP-1 [660.758684] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.485s) [660.779005] Starting dynamic subtest: pipe-D-eDP-1 [662.412916] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.651s) [662.415681] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.691s) [663.677226] [079/131] (358s left) gem_softpin (allocator-nopin) [663.756081] Starting subtest: allocator-nopin [663.851671] Subtest allocator-nopin: SUCCESS (0.099s) [664.010607] [080/131] (358s left) kms_draw_crc (draw-method-pwrite) [664.110697] Starting subtest: draw-method-pwrite [664.113206] Starting dynamic subtest: xrgb8888-untiled [664.678087] Dynamic subtest xrgb8888-untiled: SUCCESS (0.569s) [664.697541] Starting dynamic subtest: rgb565-untiled [665.133430] Dynamic subtest rgb565-untiled: SUCCESS (0.454s) [665.144894] Starting dynamic subtest: xrgb2101010-untiled [665.689456] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s) [665.698962] Starting dynamic subtest: xbgr16161616f-untiled [666.434581] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.744s) [666.444921] Starting dynamic subtest: xrgb8888-xtiled [668.236233] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.798s) [668.251574] Starting dynamic subtest: rgb565-xtiled [669.335454] Dynamic subtest rgb565-xtiled: SUCCESS (1.097s) [669.345131] Starting dynamic subtest: xrgb2101010-xtiled [671.104624] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.766s) [671.114149] Starting dynamic subtest: xbgr16161616f-xtiled [674.327594] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.220s) [674.337436] Starting dynamic subtest: xrgb8888-4tiled [675.417269] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.088s) [675.426977] Starting dynamic subtest: rgb565-4tiled [675.983573] Dynamic subtest rgb565-4tiled: SUCCESS (0.564s) [675.995834] Starting dynamic subtest: xrgb2101010-4tiled [677.084530] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s) [677.094933] Starting dynamic subtest: xbgr16161616f-4tiled [680.041540] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.955s) [680.044190] Subtest draw-method-pwrite: SUCCESS (15.925s) [680.158247] [081/131] (342s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [680.297597] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [680.302810] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [680.436943] [082/131] (341s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [680.536311] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [680.540907] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [680.672070] [083/131] (341s left) syncobj_timeline (host-signal-points) [680.742582] Starting subtest: host-signal-points [680.745200] Subtest host-signal-points: SUCCESS (0.004s) [680.858420] [084/131] (341s left) gem_mmap_gtt (basic-small-bo) [680.928854] Subtest basic-small-bo: SKIP (0.000s) [680.998743] [085/131] (341s left) perf_pmu (semaphore-wait-idle) [681.039687] Starting subtest: semaphore-wait-idle [681.042114] Starting dynamic subtest: rcs0 [681.555463] Dynamic subtest rcs0: SUCCESS (0.515s) [681.569190] Starting dynamic subtest: bcs0 [682.069712] Dynamic subtest bcs0: SUCCESS (0.511s) [682.082992] Starting dynamic subtest: vcs0 [682.585431] Dynamic subtest vcs0: SUCCESS (0.511s) [682.597201] Starting dynamic subtest: vcs1 [683.098593] Dynamic subtest vcs1: SUCCESS (0.511s) [683.114028] Starting dynamic subtest: vecs0 [683.615951] Dynamic subtest vecs0: SUCCESS (0.512s) [683.629728] Starting dynamic subtest: ccs0 [684.133401] Dynamic subtest ccs0: SUCCESS (0.514s) [684.136463] Subtest semaphore-wait-idle: SUCCESS (3.094s) [684.287892] [086/131] (338s left) kms_addfb_basic (no-handle) [684.336642] Starting subtest: no-handle [684.338711] Subtest no-handle: SUCCESS (0.000s) [684.488567] [087/131] (338s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [684.583318] Starting subtest: fbcpsr-rgb101010-draw-pwrite [691.576748] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.995s) [691.717821] [088/131] (330s left) gem_render_copy (yf-tiled-ccs-to-linear) [691.786249] Starting subtest: yf-tiled-ccs-to-linear [691.791899] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [691.993579] [089/131] (330s left) kms_flip (wf_vblank-ts-check) [692.095797] Starting subtest: wf_vblank-ts-check [692.098652] Starting dynamic subtest: A-eDP1 [701.071546] Dynamic subtest A-eDP1: SUCCESS (8.940s) [701.082053] Starting dynamic subtest: B-eDP1 [709.999052] Dynamic subtest B-eDP1: SUCCESS (8.924s) [710.010621] Starting dynamic subtest: C-eDP1 [718.937842] Dynamic subtest C-eDP1: SUCCESS (8.923s) [718.949672] Starting dynamic subtest: D-eDP1 [727.862820] Dynamic subtest D-eDP1: SUCCESS (8.918s) [727.865471] Subtest wf_vblank-ts-check: SUCCESS (35.715s) [729.077216] [090/131] (293s left) gem_exec_schedule (deep) [729.272764] Starting subtest: deep [729.275587] Starting dynamic subtest: rcs0 [734.160471] Dynamic subtest rcs0: SKIP (4.884s) [734.172354] Starting dynamic subtest: vcs0 [744.821239] Dynamic subtest vcs0: SUCCESS (10.660s) [744.837164] Starting dynamic subtest: vcs1 [756.252136] Dynamic subtest vcs1: SUCCESS (11.428s) [756.265981] Starting dynamic subtest: vecs0 [767.578894] Dynamic subtest vecs0: SUCCESS (11.324s) [767.590548] Starting dynamic subtest: ccs0 [779.970457] Dynamic subtest ccs0: SUCCESS (12.391s) [779.973360] Subtest deep: SUCCESS (50.693s) [781.186421] [091/131] (241s left) kms_sequence (queue-idle) [781.284327] Starting subtest: queue-idle [781.286674] Starting dynamic subtest: pipe-A-eDP-1 [783.090592] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.805s) [783.101240] Starting dynamic subtest: pipe-B-eDP-1 [785.538137] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.441s) [785.549486] Starting dynamic subtest: pipe-C-eDP-1 [788.042911] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.509s) [788.053911] Starting dynamic subtest: pipe-D-eDP-1 [790.471729] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s) [790.474787] Subtest queue-idle: SUCCESS (9.186s) [791.319700] [092/131] (231s left) gem_gtt_cpu_tlb [791.465764] [093/131] (231s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [791.577182] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [798.105844] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.530s) [798.276179] [094/131] (224s left) gem_eio (create-ext) [798.501980] Starting subtest: create-ext [798.857626] Subtest create-ext: SUCCESS (0.356s) [799.038832] [095/131] (223s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [799.114453] Subtest writes-after-reads-uncached: SKIP (0.000s) [799.192269] [096/131] (223s left) sysfs_preempt_timeout (idempotent) [799.248499] Starting subtest: idempotent [799.250755] Starting dynamic subtest: vecs0 [799.253316] Dynamic subtest vecs0: SUCCESS (0.000s) [799.264847] Starting dynamic subtest: ccs0 [799.266917] Dynamic subtest ccs0: SUCCESS (0.000s) [799.276906] Starting dynamic subtest: vcs0 [799.279096] Dynamic subtest vcs0: SUCCESS (0.000s) [799.289034] Starting dynamic subtest: bcs0 [799.290946] Dynamic subtest bcs0: SUCCESS (0.000s) [799.300935] Starting dynamic subtest: rcs0 [799.303223] Dynamic subtest rcs0: SUCCESS (0.000s) [799.313147] Starting dynamic subtest: vcs1 [799.315138] Dynamic subtest vcs1: SUCCESS (0.000s) [799.317157] Subtest idempotent: SUCCESS (0.007s) [799.376626] [097/131] (223s left) gem_busy (semaphore) [799.556769] Subtest semaphore: SKIP (0.000s) [799.841210] [098/131] (223s left) sriov_basic (enable-vfs-bind-unbind-each) [799.902236] Starting subtest: enable-vfs-bind-unbind-each [799.904912] Starting dynamic subtest: numvfs-1 [799.994781] Dynamic subtest numvfs-1: FAIL (0.031s) [800.015603] Starting dynamic subtest: numvfs-2 [800.108752] Dynamic subtest numvfs-2: FAIL (0.003s) [800.129069] Starting dynamic subtest: numvfs-3 [800.216122] Dynamic subtest numvfs-3: FAIL (0.003s) [800.226754] Starting dynamic subtest: numvfs-4 [800.302088] Dynamic subtest numvfs-4: FAIL (0.003s) [800.312038] Starting dynamic subtest: numvfs-5 [800.389703] Dynamic subtest numvfs-5: FAIL (0.004s) [800.399347] Starting dynamic subtest: numvfs-6 [800.475374] Dynamic subtest numvfs-6: FAIL (0.004s) [800.484849] Starting dynamic subtest: numvfs-7 [800.561454] Dynamic subtest numvfs-7: FAIL (0.004s) [800.572019] Starting dynamic subtest: numvfs-random [800.647933] Dynamic subtest numvfs-random: FAIL (0.004s) [800.650424] Subtest enable-vfs-bind-unbind-each: FAIL (0.062s) [800.689186] [099/131] (222s left) kms_pm_lpsp (screens-disabled) [801.808741] Starting subtest: screens-disabled [801.813786] Subtest screens-disabled: SKIP (0.000s) [801.907608] [100/131] (221s left) gem_exec_capture (capture-invisible) [801.969741] Starting subtest: capture-invisible [801.972120] Starting dynamic subtest: smem0 [801.976675] Dynamic subtest smem0: SKIP (0.000s) [801.981040] Subtest capture-invisible: SKIP (0.001s) [802.127723] [101/131] (221s left) gem_lmem_swapping (verify-ccs) [802.173782] Subtest verify-ccs: SKIP (0.000s) [802.221621] [102/131] (221s left) kms_joiner (basic-force-ultra-joiner) [802.321740] Starting subtest: basic-force-ultra-joiner [802.326689] Subtest basic-force-ultra-joiner: SKIP (0.000s) [802.414787] [103/131] (220s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [802.514860] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [808.965329] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.453s) [809.104439] [104/131] (214s left) kms_color (legacy-gamma) [809.206698] Starting subtest: legacy-gamma [809.209434] Starting dynamic subtest: pipe-A-eDP-1 [809.927713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s) [809.938315] Starting dynamic subtest: pipe-B-eDP-1 [811.390919] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.461s) [811.411383] Starting dynamic subtest: pipe-C-eDP-1 [812.814607] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.421s) [812.826520] Starting dynamic subtest: pipe-D-eDP-1 [814.186772] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.373s) [814.189774] Subtest legacy-gamma: SUCCESS (4.983s) [815.029465] [105/131] (208s left) gem_exec_schedule (wide) [815.224151] Starting subtest: wide [815.226923] Starting dynamic subtest: rcs0 [827.081428] Dynamic subtest rcs0: SUCCESS (11.803s) [827.094590] Starting dynamic subtest: vcs0 [840.511893] Dynamic subtest vcs0: SUCCESS (13.479s) [840.527855] Starting dynamic subtest: vcs1 [852.223041] Dynamic subtest vcs1: SUCCESS (11.709s) [852.236640] Starting dynamic subtest: vecs0 [862.889310] Dynamic subtest vecs0: SUCCESS (10.664s) [862.902291] Starting dynamic subtest: ccs0 [877.903133] Dynamic subtest ccs0: SUCCESS (15.014s) [877.906845] Subtest wide: SUCCESS (62.680s) [878.917667] [106/131] (144s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [879.026767] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [879.029072] Starting dynamic subtest: pipe-A-default-mode [879.323086] Dynamic subtest pipe-A-default-mode: SKIP (0.293s) [879.328092] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.295s) [880.144277] [107/131] (143s left) kms_big_fb (linear-64bpp-rotate-180) [880.249913] Starting subtest: linear-64bpp-rotate-180 [881.964834] Subtest linear-64bpp-rotate-180: SUCCESS (1.717s) [882.135801] [108/131] (141s left) gem_ppgtt (blt-vs-render-ctxn) [882.205691] Starting subtest: blt-vs-render-ctxN [915.304954] Subtest blt-vs-render-ctxN: SUCCESS (33.095s) [915.472466] [109/131] (108s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [915.633606] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [915.639701] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [915.768379] [110/131] (107s left) kms_chamelium_frames (dp-frame-dump) [916.161908] Subtest dp-frame-dump: SKIP (0.000s) [916.942290] [111/131] (106s left) kms_psr2_su (page_flip-nv12) [917.006945] Subtest page_flip-NV12: SKIP (0.000s) [917.072165] [112/131] (106s left) gem_tiling_max_stride [917.210406] [113/131] (106s left) perf_pmu (busy-idle) [917.255724] Starting subtest: busy-idle [917.258091] Starting dynamic subtest: rcs0 [917.957767] Dynamic subtest rcs0: SUCCESS (0.704s) [917.970717] Starting dynamic subtest: bcs0 [918.627853] Dynamic subtest bcs0: SUCCESS (0.668s) [918.640555] Starting dynamic subtest: vcs0 [920.648340] Dynamic subtest vcs0: SUCCESS (2.016s) [920.662698] Starting dynamic subtest: vcs1 [922.631380] Dynamic subtest vcs1: SUCCESS (1.980s) [922.645782] Starting dynamic subtest: vecs0 [924.615916] Dynamic subtest vecs0: SUCCESS (1.982s) [924.629785] Starting dynamic subtest: ccs0 [925.286861] Dynamic subtest ccs0: SUCCESS (0.669s) [925.291002] Subtest busy-idle: SUCCESS (8.033s) [925.419980] [114/131] ( 98s left) dmabuf_sync_file (export-before-signal) [925.467208] Starting subtest: export-before-signal [925.470011] Subtest export-before-signal: SUCCESS (0.001s) [925.549770] [115/131] ( 98s left) gem_exec_reloc (basic-cpu-read) [925.612179] Subtest basic-cpu-read: SKIP (0.000s) [925.678267] [116/131] ( 98s left) kms_hdr (bpc-switch) [925.772081] Starting subtest: bpc-switch [926.832210] Starting dynamic subtest: pipe-A-eDP-1 [930.333761] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s) [930.336678] Subtest bpc-switch: SUCCESS (4.563s) [930.495345] [117/131] ( 93s left) perf (i915-ref-count) [930.613593] Starting subtest: i915-ref-count [930.682662] Subtest i915-ref-count: SUCCESS (0.067s) [930.744292] [118/131] ( 93s left) gem_ctx_isolation (nonpriv) [930.809850] Starting subtest: nonpriv [930.812818] Starting dynamic subtest: rcs0 [931.068737] Dynamic subtest rcs0: SUCCESS (0.258s) [931.081385] Starting dynamic subtest: bcs0 [931.368490] Dynamic subtest bcs0: SUCCESS (0.300s) [931.380228] Starting dynamic subtest: vcs0 [931.653602] Dynamic subtest vcs0: SUCCESS (0.284s) [931.666942] Starting dynamic subtest: vcs1 [932.871893] Dynamic subtest vcs1: SUCCESS (1.215s) [932.884407] Starting dynamic subtest: vecs0 [934.886213] Dynamic subtest vecs0: SUCCESS (2.013s) [934.899940] Starting dynamic subtest: ccs0 [936.959955] Dynamic subtest ccs0: SUCCESS (2.072s) [936.962863] Subtest nonpriv: SUCCESS (6.149s) [937.232235] [119/131] ( 86s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [937.313774] Starting subtest: y-tiled-to-vebox-x-tiled [937.319202] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [937.525345] [120/131] ( 86s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [937.631003] Starting subtest: plane-use-after-nonblocking-unbind [937.633787] Starting dynamic subtest: pipe-A-eDP-1 [937.691932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s) [937.998163] Starting dynamic subtest: pipe-B-eDP-1 [938.792114] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.804s) [939.086941] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.453s) [939.980657] [121/131] ( 84s left) i915_hangman (engine-error-state-capture) [940.052087] Starting subtest: engine-error-state-capture [940.054462] Starting dynamic subtest: rcs0 [943.590122] Dynamic subtest rcs0: SUCCESS (3.537s) [943.604742] Starting dynamic subtest: bcs0 [949.541780] Dynamic subtest bcs0: SUCCESS (5.948s) [949.555673] Starting dynamic subtest: vcs0 [955.558229] Dynamic subtest vcs0: SUCCESS (6.013s) [955.572982] Starting dynamic subtest: vcs1 [961.509905] Dynamic subtest vcs1: SUCCESS (5.948s) [961.524731] Starting dynamic subtest: vecs0 [966.565465] Dynamic subtest vecs0: SUCCESS (5.052s) [966.579411] Starting dynamic subtest: ccs0 [972.582074] Dynamic subtest ccs0: SUCCESS (6.013s) [972.585188] Subtest engine-error-state-capture: SUCCESS (32.527s) [972.694181] [122/131] ( 51s left) gem_exec_schedule (pi-shared-iova) [972.883206] Starting subtest: pi-shared-iova [972.885650] Starting dynamic subtest: rcs0 [973.011411] Dynamic subtest rcs0: SUCCESS (0.131s) [973.025950] Starting dynamic subtest: vcs0 [973.107719] Dynamic subtest vcs0: SUCCESS (0.096s) [973.122313] Starting dynamic subtest: vcs1 [973.192940] Dynamic subtest vcs1: SUCCESS (0.085s) [973.204512] Starting dynamic subtest: vecs0 [973.285427] Dynamic subtest vecs0: SUCCESS (0.091s) [973.303677] Starting dynamic subtest: ccs0 [973.414200] Dynamic subtest ccs0: SUCCESS (0.126s) [973.417196] Subtest pi-shared-iova: SUCCESS (0.534s) [974.742069] [123/131] ( 49s left) syncobj_wait (invalid-reset-illegal-handle) [974.807098] Starting subtest: invalid-reset-illegal-handle [974.809839] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [974.944519] [124/131] ( 49s left) syncobj_wait (single-wait-all-for-submit-signaled) [975.007729] Starting subtest: single-wait-all-for-submit-signaled [975.010475] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [975.146775] [125/131] ( 49s left) kms_cursor_crc (cursor-sliding-512x170) [975.453089] Starting subtest: cursor-sliding-512x170 [975.458306] Subtest cursor-sliding-512x170: SKIP (0.001s) [975.642459] [126/131] ( 48s left) kms_chamelium_hpd (hdmi-hpd-fast) [976.021757] Subtest hdmi-hpd-fast: SKIP (0.000s) [976.872857] [127/131] ( 47s left) gem_ctx_persistence (hostile) [976.941960] Starting subtest: hostile [987.092828] Subtest hostile: SUCCESS (10.148s) [987.246198] [128/131] ( 37s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [987.351581] Starting subtest: fbc-rgb565-draw-blt [991.605123] Subtest fbc-rgb565-draw-blt: SUCCESS (4.259s) [992.802856] [129/131] ( 31s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [992.906067] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [1002.171832] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.267s) [1002.346291] [130/131] ( 22s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [1002.446653] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [1002.451601] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [1002.597246] [131/131] ( 21s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [1002.705654] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [1002.710778] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [1002.826022] 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.