[57.292218] Initializing watchdogs [57.292266] /dev/watchdog0 [57.307040] [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.311561] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.313821] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.317794] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [57.721245] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [58.542695] [002/133] (959s left) i915_power (sanity) [58.600855] Starting subtest: sanity [62.645957] Subtest sanity: SUCCESS (4.065s) [63.901357] [003/133] (953s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [63.957525] Subtest no-spare-fences-interruptible: SKIP (0.000s) [63.999705] [004/133] (953s left) i915_module_load (resize-bar) [64.036446] Starting subtest: resize-bar [64.042816] Subtest resize-bar: SKIP (0.006s) [64.081673] [005/133] (953s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [64.191502] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [64.196033] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [64.258941] [006/133] (953s left) gem_fenced_exec_thrash (no-spare-fences) [64.320227] Subtest no-spare-fences: SKIP (0.000s) [64.406022] [007/133] (953s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [64.509312] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [64.511653] Starting dynamic subtest: pipe-A-eDP-1 [64.520849] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [64.529898] Starting dynamic subtest: pipe-B-eDP-1 [64.539389] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [64.547173] Starting dynamic subtest: pipe-C-eDP-1 [64.555647] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [64.562748] Starting dynamic subtest: pipe-D-eDP-1 [64.571136] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [64.575127] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s) [66.795302] [008/133] (951s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [66.907441] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [66.911350] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [67.370100] [009/133] (950s left) perf_pmu (busy-accuracy-50) [67.451035] Starting subtest: busy-accuracy-50 [67.453606] Starting dynamic subtest: rcs0 [68.990310] Dynamic subtest rcs0: SUCCESS (1.540s) [68.999984] Starting dynamic subtest: bcs0 [70.529605] Dynamic subtest bcs0: SUCCESS (1.541s) [70.539216] Starting dynamic subtest: vcs0 [72.070205] Dynamic subtest vcs0: SUCCESS (1.542s) [72.080475] Starting dynamic subtest: vcs1 [73.607252] Dynamic subtest vcs1: SUCCESS (1.538s) [73.617242] Starting dynamic subtest: vecs0 [75.147915] Dynamic subtest vecs0: SUCCESS (1.542s) [75.157787] Starting dynamic subtest: ccs0 [76.691360] Dynamic subtest ccs0: SUCCESS (1.544s) [76.693873] Subtest busy-accuracy-50: SUCCESS (9.252s) [76.800102] [010/133] (941s left) kms_flip (2x-nonexisting-fb-interruptible) [76.895056] Starting subtest: 2x-nonexisting-fb-interruptible [76.907388] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s) [76.981656] [011/133] (941s left) gem_exec_whisper (basic-queues-priority-all) [77.043259] Starting subtest: basic-queues-priority-all [97.278711] Subtest basic-queues-priority-all: SUCCESS (20.228s) [97.454157] [012/133] (920s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [97.570584] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [97.574614] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [97.665514] [013/133] (920s left) kms_psr (psr2-primary-render) [97.766811] Starting subtest: psr2-primary-render [97.769076] Starting dynamic subtest: eDP-1 [99.489207] Dynamic subtest eDP-1: SUCCESS (1.722s) [99.491088] Subtest psr2-primary-render: SUCCESS (1.723s) [100.346282] [014/133] (918s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [100.439488] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [100.443549] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [100.546390] [015/133] (917s left) syncobj_wait (single-wait-signaled) [100.598490] Starting subtest: single-wait-signaled [100.600920] Subtest single-wait-signaled: SUCCESS (0.000s) [100.697722] [016/133] (917s left) kms_properties (plane-properties-legacy) [100.776636] Starting subtest: plane-properties-legacy [100.778541] Starting dynamic subtest: pipe-A-eDP-1 [101.366138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s) [101.375740] Starting dynamic subtest: pipe-B-eDP-1 [102.630272] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.264s) [102.640665] Starting dynamic subtest: pipe-C-eDP-1 [103.871419] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s) [103.881228] Starting dynamic subtest: pipe-D-eDP-1 [105.115336] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s) [105.117460] Subtest plane-properties-legacy: SUCCESS (4.338s) [105.913281] [017/133] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [106.022437] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [106.026783] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [106.134516] [018/133] (912s left) kms_prime (basic-modeset-hybrid) [106.222926] Subtest basic-modeset-hybrid: SKIP (0.000s) [106.350102] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true [106.353475] [019/133] (912s left) syncobj_timeline (wait-all-for-submit-snapshot) [106.409050] Starting subtest: wait-all-for-submit-snapshot [106.489387] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [106.579140] [020/133] (912s left) gem_exec_schedule (semaphore-power) [106.765070] Subtest semaphore-power: SKIP (0.000s) [106.943783] [021/133] (911s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [107.040555] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [110.994827] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.960s) [112.113595] [022/133] (906s left) kms_cursor_crc (cursor-onscreen-512x512) [112.422759] Starting subtest: cursor-onscreen-512x512 [112.427204] Subtest cursor-onscreen-512x512: SKIP (0.001s) [112.564320] [023/133] (906s left) kms_big_fb (linear-32bpp-rotate-180) [112.654051] Starting subtest: linear-32bpp-rotate-180 [114.231987] Subtest linear-32bpp-rotate-180: SUCCESS (1.579s) [114.374170] [024/133] (904s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [114.424850] Starting subtest: multi-wait-all-for-submit-submitted-signaled [114.531799] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s) [114.606828] [025/133] (904s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [114.650031] Starting subtest: mixed-tiled-to-y-tiled-ccs [114.654491] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [114.831469] [026/133] (903s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [114.903880] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [114.971779] [027/133] (903s left) gem_partial_pwrite_pread (reads-display) [115.030620] Subtest reads-display: SKIP (0.000s) [115.112864] [028/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [115.236620] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [115.240907] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [115.383149] [029/133] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [115.479179] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [115.483179] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [115.581851] [030/133] (903s left) drm_buddy (drm_buddy) [115.615525] Starting subtest: drm_buddy [115.619800] Subtest drm_buddy: SKIP (0.001s) [115.665191] [031/133] (903s left) gem_userptr_blits (set-cache-level) [115.731591] Starting subtest: set-cache-level [115.735979] Subtest set-cache-level: SKIP (0.000s) [115.876207] [032/133] (903s left) kms_addfb_basic (bad-pitch-1024) [115.931188] Starting subtest: bad-pitch-1024 [115.933060] Subtest bad-pitch-1024: SUCCESS (0.000s) [116.058228] [033/133] (903s left) gem_exec_alignment (forked) [116.121046] Starting subtest: forked [155.032228] Subtest forked: SUCCESS (38.909s) [155.200123] [034/133] (863s left) prime_self_import (basic-with_one_bo) [155.277284] Starting subtest: basic-with_one_bo [155.294985] Subtest basic-with_one_bo: SUCCESS (0.020s) [155.441451] [035/133] (863s left) gem_exec_schedule (in-order) [155.519433] Starting subtest: in-order [155.521743] Starting dynamic subtest: rcs0 [155.690052] Dynamic subtest rcs0: SUCCESS (0.172s) [155.704267] Starting dynamic subtest: vcs0 [155.794776] Dynamic subtest vcs0: SUCCESS (0.105s) [155.807077] Starting dynamic subtest: vcs1 [155.907025] Dynamic subtest vcs1: SUCCESS (0.113s) [155.918505] Starting dynamic subtest: vecs0 [156.012577] Dynamic subtest vecs0: SUCCESS (0.105s) [156.024207] Starting dynamic subtest: ccs0 [156.139200] Dynamic subtest ccs0: SUCCESS (0.126s) [156.142083] Subtest in-order: SUCCESS (0.623s) [156.992689] [036/133] (862s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [157.086793] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [157.089165] Starting dynamic subtest: pipe-A-eDP-1 [157.147236] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [157.157828] Starting dynamic subtest: pipe-B-eDP-1 [157.214972] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [157.224976] Starting dynamic subtest: pipe-C-eDP-1 [157.282053] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [157.292147] Starting dynamic subtest: pipe-D-eDP-1 [157.357754] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [157.362498] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [159.291555] [037/133] (860s left) gem_softpin (32b-excludes-last-page) [159.356106] Starting subtest: 32b-excludes-last-page [159.360893] Subtest 32b-excludes-last-page: SUCCESS (0.003s) [159.484432] [038/133] (859s left) kms_rotation_crc (primary-rotation-90) [159.583319] Starting subtest: primary-rotation-90 [159.587815] Subtest primary-rotation-90: SKIP (0.001s) [159.656888] [039/133] (859s left) kms_psr (fbc-psr-cursor-render) [159.754600] Starting subtest: fbc-psr-cursor-render [159.756704] Starting dynamic subtest: eDP-1 [159.760709] Dynamic subtest eDP-1: SKIP (0.000s) [159.764695] Subtest fbc-psr-cursor-render: SKIP (0.000s) [159.835974] [040/133] (859s left) kms_psr (fbc-pr-sprite-mmap-gtt) [159.930994] Starting subtest: fbc-pr-sprite-mmap-gtt [159.935278] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [160.015634] [041/133] (859s left) kms_draw_crc (draw-method-mmap-cpu) [160.106130] Starting subtest: draw-method-mmap-cpu [160.108172] Starting dynamic subtest: xrgb8888-untiled [160.370919] Dynamic subtest xrgb8888-untiled: SUCCESS (0.268s) [160.380579] Starting dynamic subtest: rgb565-untiled [160.604091] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [160.613966] Starting dynamic subtest: xrgb2101010-untiled [160.826294] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [160.836075] Starting dynamic subtest: xbgr16161616f-untiled [161.093492] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.266s) [161.102884] Starting dynamic subtest: xrgb8888-xtiled [161.237695] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [161.247734] Starting dynamic subtest: rgb565-xtiled [161.371113] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [161.381198] Starting dynamic subtest: xrgb2101010-xtiled [161.493066] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [161.502381] Starting dynamic subtest: xbgr16161616f-xtiled [161.626498] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s) [161.635865] Starting dynamic subtest: xrgb8888-4tiled [161.770916] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [161.780448] Starting dynamic subtest: rgb565-4tiled [161.915286] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s) [161.924972] Starting dynamic subtest: xrgb2101010-4tiled [162.048709] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [162.057744] Starting dynamic subtest: xbgr16161616f-4tiled [162.194112] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [162.196054] Subtest draw-method-mmap-cpu: SUCCESS (2.091s) [162.288793] [042/133] (857s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [162.388339] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [162.390346] Starting dynamic subtest: pipe-A-eDP-1 [162.409740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [162.420426] Starting dynamic subtest: pipe-B-eDP-1 [162.438388] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [162.446491] Starting dynamic subtest: pipe-C-eDP-1 [162.463860] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [162.473360] Starting dynamic subtest: pipe-D-eDP-1 [162.491792] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [162.495426] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [164.642012] [043/133] (854s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [164.735413] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [187.871990] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.139s) [188.012686] [044/133] (831s left) gem_exec_capture (capture) [188.075351] Starting subtest: capture [188.077192] Starting dynamic subtest: rcs0-smem [188.913530] Dynamic subtest rcs0-smem: SUCCESS (0.836s) [188.922174] Starting dynamic subtest: bcs0-smem [189.735467] Dynamic subtest bcs0-smem: SUCCESS (0.821s) [189.745261] Starting dynamic subtest: vcs0-smem [190.564955] Dynamic subtest vcs0-smem: SUCCESS (0.829s) [190.573572] Starting dynamic subtest: vcs1-smem [191.885913] Dynamic subtest vcs1-smem: SUCCESS (1.319s) [191.894410] Starting dynamic subtest: vecs0-smem [192.779191] Dynamic subtest vecs0-smem: FAIL (0.835s) [192.789798] Starting dynamic subtest: ccs0-smem [194.044100] Dynamic subtest ccs0-smem: SUCCESS (1.322s) [194.046431] Subtest capture: FAIL (5.965s) [194.155198] [045/133] (825s left) perf_pmu (busy-hang) [194.199589] Starting subtest: busy-hang [194.201935] Starting dynamic subtest: rcs0 [195.444604] Dynamic subtest rcs0: SUCCESS (1.246s) [195.455928] Starting dynamic subtest: bcs0 [196.653857] Dynamic subtest bcs0: SUCCESS (1.205s) [196.664513] Starting dynamic subtest: vcs0 [198.432953] Dynamic subtest vcs0: SUCCESS (1.777s) [198.445541] Starting dynamic subtest: vcs1 [200.406534] Dynamic subtest vcs1: SUCCESS (1.974s) [200.417593] Starting dynamic subtest: vecs0 [202.458682] Dynamic subtest vecs0: SUCCESS (2.047s) [202.469664] Starting dynamic subtest: ccs0 [203.667456] Dynamic subtest ccs0: SUCCESS (1.210s) [203.670030] Subtest busy-hang: SUCCESS (9.470s) [203.783717] [046/133] (815s left) prime_vgem (basic-write) [203.856418] Starting subtest: basic-write [203.879565] Subtest basic-write: SKIP (0.024s) [204.002989] [047/133] (815s left) gem_exec_await (wide-all) [204.233315] Starting subtest: wide-all [227.677827] Subtest wide-all: SUCCESS (23.441s) [227.892178] [048/133] (791s left) kms_dirtyfb (psr-dirtyfb-ioctl) [228.045179] Starting subtest: psr-dirtyfb-ioctl [228.047184] Starting dynamic subtest: A-eDP-1 [231.907803] Dynamic subtest A-eDP-1: SUCCESS (3.863s) [231.910366] Subtest psr-dirtyfb-ioctl: SUCCESS (3.865s) [232.707367] [049/133] (787s left) kms_cursor_crc (cursor-size-hints) [232.842942] Starting subtest: cursor-size-hints [232.845332] Starting dynamic subtest: pipe-A-eDP-1 [233.497167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.653s) [233.506478] Starting dynamic subtest: pipe-D-eDP-1 [234.759392] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.261s) [234.761305] Subtest cursor-size-hints: SUCCESS (1.917s) [235.564722] [050/133] (784s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [235.669038] Starting subtest: addfb25-y-tiled-small-legacy [235.673371] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [235.770980] [051/133] (784s left) kms_psr (psr-primary-mmap-cpu) [235.877933] Starting subtest: psr-primary-mmap-cpu [235.880163] Starting dynamic subtest: eDP-1 [237.651815] Dynamic subtest eDP-1: SUCCESS (1.774s) [237.654124] Subtest psr-primary-mmap-cpu: SUCCESS (1.775s) [238.525443] [052/133] (781s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [238.626410] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [238.630718] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [238.746509] [053/133] (781s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [238.844397] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [239.524228] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s) [239.697234] [054/133] (780s left) gem_exec_balancer (bonded-false-hang) [239.954984] Starting subtest: bonded-false-hang [239.960322] Subtest bonded-false-hang: SKIP (0.000s) [240.071535] [055/133] (780s left) kms_getfb (getfb2-accept-nv12) [240.161074] Starting subtest: getfb2-accept-nv12 [240.163357] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [240.265838] [056/133] (779s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [240.326186] Subtest writes-after-reads: SKIP (0.000s) [240.407829] [057/133] (779s left) kms_content_protection (suspend-resume) [240.545705] Starting subtest: suspend-resume [240.550271] Subtest suspend-resume: SKIP (0.000s) [240.664383] [058/133] (779s left) gem_mmap_wc (bad-offset) [240.719944] Subtest bad-offset: SKIP (0.000s) [240.777249] [059/133] (779s left) gem_ppgtt (blt-vs-render-ctxn) [240.837163] Starting subtest: blt-vs-render-ctxN [273.536338] Subtest blt-vs-render-ctxN: SUCCESS (32.696s) [273.665819] [060/133] (746s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [273.799851] Starting subtest: crc-primary-basic-y-tiled-ccs [273.802143] Starting dynamic subtest: pipe-A-eDP-1 [273.824535] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [273.835822] Starting dynamic subtest: pipe-B-eDP-1 [273.856180] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [273.865107] Starting dynamic subtest: pipe-C-eDP-1 [273.885269] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [273.893779] Starting dynamic subtest: pipe-D-eDP-1 [273.915268] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [273.919555] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [276.101414] [061/133] (744s left) perf (whitelisted-registers-userspace-config) [276.245978] Starting subtest: whitelisted-registers-userspace-config [276.248172] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [276.288326] [062/133] (744s left) kms_invalid_mode (overflow-vrefresh) [276.386962] Starting subtest: overflow-vrefresh [276.389129] Starting dynamic subtest: pipe-A-eDP-1 [276.678489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s) [276.687942] Starting dynamic subtest: pipe-B-eDP-1 [276.689793] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [276.698674] Starting dynamic subtest: pipe-C-eDP-1 [276.700988] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [276.709865] Starting dynamic subtest: pipe-D-eDP-1 [276.712334] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [276.714643] Subtest overflow-vrefresh: SUCCESS (0.301s) [277.519125] [063/133] (742s left) gem_spin_batch (resubmit-new-all) [277.582482] Starting subtest: resubmit-new-all [277.584920] Starting dynamic subtest: rcs0 [277.596641] Dynamic subtest rcs0: SUCCESS (0.014s) [277.608027] Starting dynamic subtest: bcs0 [277.609972] Dynamic subtest bcs0: SUCCESS (0.012s) [277.623760] Starting dynamic subtest: vcs0 [277.626060] Dynamic subtest vcs0: SUCCESS (0.010s) [277.637656] Starting dynamic subtest: vcs1 [277.639614] Dynamic subtest vcs1: SUCCESS (0.009s) [277.649137] Starting dynamic subtest: vecs0 [277.651248] Dynamic subtest vecs0: SUCCESS (0.011s) [277.660220] Starting dynamic subtest: ccs0 [277.662070] Dynamic subtest ccs0: SUCCESS (0.010s) [277.663873] Subtest resubmit-new-all: SUCCESS (0.072s) [278.988131] [064/133] (741s left) api_intel_bb (simple-bb) [279.047540] Starting subtest: simple-bb [279.050757] Subtest simple-bb: SUCCESS (0.006s) [279.174458] [065/133] (741s left) syncobj_timeline (etime-multi-wait-all-submitted) [279.232776] Starting subtest: etime-multi-wait-all-submitted [279.339812] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s) [279.430472] [066/133] (741s left) kms_big_fb (y-tiled-8bpp-rotate-180) [279.541939] Starting subtest: y-tiled-8bpp-rotate-180 [279.546695] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [279.636759] [067/133] (740s left) kms_psr (fbc-pr-cursor-mmap-gtt) [279.742426] Starting subtest: fbc-pr-cursor-mmap-gtt [279.746721] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [279.817678] [068/133] (740s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [281.997188] Starting subtest: dpms-mode-unset-non-lpsp [283.157060] Subtest dpms-mode-unset-non-lpsp: SKIP (1.155s) [283.558145] [069/133] (737s left) gem_ctx_param (root-set) [283.605845] Starting subtest: root-set [283.608188] Subtest root-set: SUCCESS (0.001s) [283.724635] [070/133] (737s left) syncobj_timeline (device-submit-unordered) [283.772963] Starting subtest: device-submit-unordered [283.775284] Subtest device-submit-unordered: SUCCESS (0.001s) [283.897870] [071/133] (736s left) gem_readwrite (read-write) [283.956375] Subtest read-write: SKIP (0.000s) [284.023150] [072/133] (736s left) gem_exec_schedule (u-submit-late-slice) [284.104241] Starting subtest: u-submit-late-slice [284.106256] Starting dynamic subtest: rcs0 [284.135537] Dynamic subtest rcs0: SUCCESS (0.038s) [284.154298] Starting dynamic subtest: bcs0 [284.169781] Dynamic subtest bcs0: SUCCESS (0.033s) [284.181658] Starting dynamic subtest: vcs0 [284.198743] Dynamic subtest vcs0: SUCCESS (0.028s) [284.208274] Starting dynamic subtest: vcs1 [284.234292] Dynamic subtest vcs1: SUCCESS (0.034s) [284.248688] Starting dynamic subtest: vecs0 [284.266792] Dynamic subtest vecs0: SUCCESS (0.031s) [284.276108] Starting dynamic subtest: ccs0 [284.308368] Dynamic subtest ccs0: SUCCESS (0.040s) [284.310753] Subtest u-submit-late-slice: SUCCESS (0.213s) [286.003809] [073/133] (734s left) sriov_basic (enable-vfs-autoprobe-on) [286.063673] Starting subtest: enable-vfs-autoprobe-on [286.066101] Starting dynamic subtest: numvfs-1 [286.145448] Dynamic subtest numvfs-1: FAIL (0.029s) [286.155484] Starting dynamic subtest: numvfs-2 [286.226713] Dynamic subtest numvfs-2: FAIL (0.004s) [286.236923] Starting dynamic subtest: numvfs-3 [286.310137] Dynamic subtest numvfs-3: FAIL (0.004s) [286.321217] Starting dynamic subtest: numvfs-4 [286.389848] Dynamic subtest numvfs-4: FAIL (0.004s) [286.399377] Starting dynamic subtest: numvfs-5 [286.470755] Dynamic subtest numvfs-5: FAIL (0.005s) [286.482275] Starting dynamic subtest: numvfs-6 [286.551374] Dynamic subtest numvfs-6: FAIL (0.004s) [286.561429] Starting dynamic subtest: numvfs-7 [286.631034] Dynamic subtest numvfs-7: FAIL (0.004s) [286.639675] Starting dynamic subtest: numvfs-random [286.708604] Dynamic subtest numvfs-random: FAIL (0.004s) [286.718736] Starting dynamic subtest: numvfs-all [286.793480] Dynamic subtest numvfs-all: FAIL (0.498s) [286.795738] Subtest enable-vfs-autoprobe-on: FAIL (0.562s) [286.835771] [074/133] (734s left) kms_plane_multiple (2x-tiling-y) [286.932771] Starting subtest: 2x-tiling-y [286.936856] Subtest 2x-tiling-y: SKIP (0.000s) [287.002434] [075/133] (733s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [287.103505] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [287.107206] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [287.200719] [076/133] (733s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [287.302364] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [287.304154] Starting dynamic subtest: pipe-A-eDP-1 [287.324074] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [287.334237] Starting dynamic subtest: pipe-B-eDP-1 [287.355093] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [287.365902] Starting dynamic subtest: pipe-C-eDP-1 [287.385676] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [287.394800] Starting dynamic subtest: pipe-D-eDP-1 [287.413880] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [287.417121] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s) [289.526528] [077/133] (731s left) gem_userptr_blits (process-exit-busy) [289.598192] Starting subtest: process-exit-busy [289.609295] Subtest process-exit-busy: SUCCESS (0.013s) [289.731651] [078/133] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [289.830978] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [289.834872] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [289.936456] [079/133] (731s left) kms_vblank (ts-continuation-modeset-rpm) [290.031110] Starting subtest: ts-continuation-modeset-rpm [290.033262] Starting dynamic subtest: pipe-A-eDP-1 [292.511320] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.480s) [292.525892] Starting dynamic subtest: pipe-D-eDP-1 [294.766979] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.251s) [294.769338] Subtest ts-continuation-modeset-rpm: SUCCESS (4.737s) [295.559174] [080/133] (725s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [295.666884] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [296.756616] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.090s) [296.879243] [081/133] (724s left) syncobj_wait (multi-wait-all-for-submit-signaled) [296.944928] Starting subtest: multi-wait-all-for-submit-signaled [296.947161] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [297.063013] [082/133] (724s left) kms_plane (plane-panning-top-left) [297.157350] Starting subtest: plane-panning-top-left [297.158988] Starting dynamic subtest: pipe-A [298.853166] Dynamic subtest pipe-A: SUCCESS (1.694s) [298.866892] Starting dynamic subtest: pipe-B [301.285706] Dynamic subtest pipe-B: SUCCESS (2.431s) [301.288084] Subtest plane-panning-top-left: SUCCESS (4.130s) [302.091474] [083/133] (719s left) gem_exec_parallel (userptr) [302.158453] Starting subtest: userptr [302.160941] Starting dynamic subtest: rcs0 [303.625834] Dynamic subtest rcs0: SUCCESS (1.467s) [303.638520] Starting dynamic subtest: bcs0 [305.118198] Dynamic subtest bcs0: SUCCESS (1.490s) [305.130052] Starting dynamic subtest: vcs0 [306.858132] Dynamic subtest vcs0: SUCCESS (1.736s) [306.869775] Starting dynamic subtest: vcs1 [308.887243] Dynamic subtest vcs1: SUCCESS (2.027s) [308.898530] Starting dynamic subtest: vecs0 [310.936747] Dynamic subtest vecs0: SUCCESS (2.046s) [310.950748] Starting dynamic subtest: ccs0 [312.423206] Dynamic subtest ccs0: SUCCESS (1.486s) [312.425488] Subtest userptr: SUCCESS (10.266s) [312.631217] [084/133] (708s left) kms_hdmi_inject (inject-4k) [312.986829] Starting subtest: inject-4k [313.303737] Subtest inject-4k: SUCCESS (0.318s) [313.894076] [085/133] (707s left) kms_chamelium_edid (hdmi-mode-timings) [314.281794] Subtest hdmi-mode-timings: SKIP (0.000s) [315.099593] [086/133] (706s left) syncobj_wait (multi-wait-for-submit-submitted) [315.147531] Starting subtest: multi-wait-for-submit-submitted [315.252093] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s) [315.336418] [087/133] (706s left) gem_exec_schedule (smoketest-all) [315.404631] Starting subtest: smoketest-all [347.778308] Subtest smoketest-all: SUCCESS (32.332s) [348.952620] [088/133] (672s left) sysfs_heartbeat_interval (mixed) [349.010674] Starting subtest: mixed [349.013211] Starting dynamic subtest: vecs0 [354.263050] Dynamic subtest vecs0: SUCCESS (5.252s) [354.273423] Starting dynamic subtest: ccs0 [359.470067] Dynamic subtest ccs0: SUCCESS (5.205s) [359.481697] Starting dynamic subtest: vcs0 [364.684299] Dynamic subtest vcs0: SUCCESS (5.212s) [364.696436] Starting dynamic subtest: bcs0 [369.890102] Dynamic subtest bcs0: SUCCESS (5.203s) [369.904673] Starting dynamic subtest: rcs0 [375.064937] Dynamic subtest rcs0: SUCCESS (5.172s) [375.074920] Starting dynamic subtest: vcs1 [380.286923] Dynamic subtest vcs1: SUCCESS (5.222s) [380.289434] Subtest mixed: SUCCESS (31.277s) [380.373366] [089/133] (641s left) kms_cursor_crc (cursor-sliding-512x512) [380.666991] Starting subtest: cursor-sliding-512x512 [380.670756] Subtest cursor-sliding-512x512: SKIP (0.001s) [380.842735] [090/133] (640s left) perf (sysctl-defaults) [380.917441] Starting subtest: sysctl-defaults [380.919834] Subtest sysctl-defaults: SUCCESS (0.000s) [380.991418] [091/133] (640s left) gem_ctx_persistence (legacy-engines-hostile) [381.046547] Starting subtest: legacy-engines-hostile [381.048851] Starting dynamic subtest: render [381.101561] Dynamic subtest render: SUCCESS (0.054s) [381.116108] Starting dynamic subtest: bsd1 [381.196083] Dynamic subtest bsd1: SUCCESS (0.091s) [381.208161] Starting dynamic subtest: bsd2 [381.293354] Dynamic subtest bsd2: SUCCESS (0.095s) [381.307203] Starting dynamic subtest: blt [381.383512] Dynamic subtest blt: SUCCESS (0.088s) [381.397452] Starting dynamic subtest: vebox [381.474339] Dynamic subtest vebox: SUCCESS (0.088s) [381.476447] Subtest legacy-engines-hostile: SUCCESS (0.429s) [381.556702] [092/133] (640s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [381.646873] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [381.648766] Starting dynamic subtest: pipe-A-eDP-1 [381.766551] Dynamic subtest pipe-A-eDP-1: SKIP (0.123s) [381.779478] Starting dynamic subtest: pipe-B-eDP-1 [382.952479] Dynamic subtest pipe-B-eDP-1: SKIP (1.182s) [382.956937] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.307s) [384.118808] [093/133] (637s left) kms_flip (basic-flip-vs-dpms) [384.210478] Starting subtest: basic-flip-vs-dpms [384.212800] Starting dynamic subtest: A-eDP1 [386.754431] Dynamic subtest A-eDP1: SUCCESS (2.542s) [386.767337] Starting dynamic subtest: B-eDP1 [388.957094] Dynamic subtest B-eDP1: SUCCESS (2.200s) [388.967220] Starting dynamic subtest: C-eDP1 [391.146631] Dynamic subtest C-eDP1: SUCCESS (2.186s) [391.156238] Starting dynamic subtest: D-eDP1 [393.362694] Dynamic subtest D-eDP1: SUCCESS (2.214s) [393.365071] Subtest basic-flip-vs-dpms: SUCCESS (9.153s) [394.219579] [094/133] (627s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [394.326000] Starting subtest: plane-scaler-with-clipping-clamping-rotation [394.328376] Starting dynamic subtest: pipe-A [394.555944] Dynamic subtest pipe-A: SUCCESS (0.231s) [394.566883] Starting dynamic subtest: pipe-B [395.866211] Dynamic subtest pipe-B: SUCCESS (1.308s) [395.879488] Starting dynamic subtest: pipe-C [397.166323] Dynamic subtest pipe-C: SUCCESS (1.299s) [397.178773] Starting dynamic subtest: pipe-D [398.473978] Dynamic subtest pipe-D: SUCCESS (1.306s) [398.476672] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.151s) [399.614647] [095/133] (622s left) gem_mmap_gtt (cpuset-basic-small-copy) [399.676131] Subtest cpuset-basic-small-copy: SKIP (0.000s) [399.743871] [096/133] (622s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [399.837874] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [406.589230] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.754s) [406.712327] [097/133] (615s left) gem_exec_fence (syncobj-channel) [407.181853] Starting subtest: syncobj-channel [408.197921] Subtest syncobj-channel: SUCCESS (1.017s) [409.006457] [098/133] (612s left) gem_ctx_param (invalid-get-engines) [409.063585] Starting subtest: invalid-get-engines [409.065908] Subtest invalid-get-engines: SUCCESS (0.001s) [409.180582] [099/133] (612s left) gem_exec_flush (basic-wb-rw-before-default) [409.241459] Starting subtest: basic-wb-rw-before-default [414.726556] Subtest basic-wb-rw-before-default: SUCCESS (5.485s) [414.931494] [100/133] (607s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [415.027823] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [415.032116] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [415.102676] [101/133] (606s left) gem_mmap_gtt (zero-extend) [415.159084] Subtest zero-extend: SKIP (0.000s) [415.216602] [102/133] (606s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [415.313576] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [416.372316] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.059s) [416.497955] [103/133] (605s left) gem_exec_flush (basic-batch-kernel-default-uc) [416.560717] Starting subtest: basic-batch-kernel-default-uc [423.896288] Subtest basic-batch-kernel-default-uc: SUCCESS (7.337s) [424.085840] [104/133] (598s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [424.183327] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [424.187728] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [424.292428] [105/133] (597s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [424.380824] Starting subtest: flip-vs-dpms-on-nop-interruptible [424.385975] Starting dynamic subtest: A-eDP1 [426.269921] Dynamic subtest A-eDP1: SUCCESS (1.886s) [426.283286] Starting dynamic subtest: B-eDP1 [428.082046] Dynamic subtest B-eDP1: SUCCESS (1.811s) [428.094169] Starting dynamic subtest: C-eDP1 [429.961582] Dynamic subtest C-eDP1: SUCCESS (1.877s) [429.971833] Starting dynamic subtest: D-eDP1 [431.769466] Dynamic subtest D-eDP1: SUCCESS (1.807s) [431.774595] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.392s) [433.009960] [106/133] (589s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [433.108846] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [439.622126] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.516s) [439.747054] [107/133] (582s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [439.867090] Starting subtest: psr-rgb101010-draw-mmap-gtt [439.871581] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [439.986266] [108/133] (582s left) i915_drm_fdinfo (virtual-busy) [440.039964] Starting subtest: virtual-busy [440.044089] Subtest virtual-busy: SKIP (0.000s) [440.113591] [109/133] (582s left) gem_mmap_gtt (basic-small-copy-odd) [440.161955] Subtest basic-small-copy-odd: SKIP (0.000s) [440.226592] [110/133] (582s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [440.322318] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [440.326340] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [440.435365] [111/133] (582s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [440.532036] Starting subtest: basic-max-pipe-crc-check [440.536468] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [440.581213] [112/133] (581s left) api_intel_allocator (fork-simple-stress-signal) [440.635517] Starting subtest: fork-simple-stress-signal [446.041177] Subtest fork-simple-stress-signal: SUCCESS (5.404s) [446.167718] [113/133] (576s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [446.277451] Starting subtest: primary-y-tiled-reflect-x-0 [446.349035] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s) [446.455188] [114/133] (576s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [446.557895] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [453.679366] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.125s) [453.797556] [115/133] (568s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping) [453.898119] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping [453.902288] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [453.969158] [116/133] (568s left) gem_create (create-ext-placement-all) [454.131762] Starting subtest: create-ext-placement-all [454.134334] Subtest create-ext-placement-all: SUCCESS (0.000s) [454.226919] [117/133] (568s left) gem_ctx_create (basic) [454.288095] Starting subtest: basic [454.290209] Subtest basic: SUCCESS (0.000s) [454.482645] [118/133] (568s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [454.540225] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [454.542555] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [454.636509] [119/133] (568s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [454.692874] Starting subtest: invalid-multi-wait-unsubmitted-submitted [454.694768] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [454.807162] [120/133] (568s left) gen9_exec_parse (bb-secure) [454.867183] Subtest bb-secure: SKIP (0.000s) [454.945679] [121/133] (567s left) kms_psr (pr-primary-page-flip) [455.039262] Starting subtest: pr-primary-page-flip [455.043679] Subtest pr-primary-page-flip: SKIP (0.000s) [455.125470] [122/133] (567s left) kms_flip (blocking-wf_vblank) [455.215916] Starting subtest: blocking-wf_vblank [455.218310] Starting dynamic subtest: A-eDP1 [464.127900] Dynamic subtest A-eDP1: SUCCESS (8.911s) [464.144060] Starting dynamic subtest: B-eDP1 [473.022122] Dynamic subtest B-eDP1: SUCCESS (8.892s) [473.036075] Starting dynamic subtest: C-eDP1 [481.916956] Dynamic subtest C-eDP1: SUCCESS (8.890s) [481.931716] Starting dynamic subtest: D-eDP1 [490.808110] Dynamic subtest D-eDP1: SUCCESS (8.889s) [490.814230] Subtest blocking-wf_vblank: SUCCESS (35.596s) [492.009568] [123/133] (531s left) kms_color_pipeline (plane-lut1d-lut1d) [492.106115] Starting subtest: plane-lut1d-lut1d [492.251502] Starting dynamic subtest: pipe-A-plane-0 [492.429105] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s) [492.439320] Starting dynamic subtest: pipe-A-plane-1 [492.595801] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [492.606023] Starting dynamic subtest: pipe-A-plane-2 [492.751392] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [493.985129] Starting dynamic subtest: pipe-B-plane-0 [494.154645] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [494.165070] Starting dynamic subtest: pipe-B-plane-1 [494.321221] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [494.331226] Starting dynamic subtest: pipe-B-plane-2 [494.521604] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s) [495.672602] Starting dynamic subtest: pipe-C-plane-0 [495.819233] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [495.829398] Starting dynamic subtest: pipe-C-plane-1 [495.974918] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [495.984853] Starting dynamic subtest: pipe-C-plane-2 [496.131329] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [497.380807] Starting dynamic subtest: pipe-D-plane-0 [497.516421] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [497.529150] Starting dynamic subtest: pipe-D-plane-1 [497.671679] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [497.681394] Starting dynamic subtest: pipe-D-plane-2 [497.838428] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [498.122575] Subtest plane-lut1d-lut1d: SUCCESS (6.019s) [499.025507] [124/133] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [499.141185] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [505.678448] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.539s) [505.819320] [125/133] (517s left) kms_universal_plane (universal-plane-functional) [505.928593] Starting subtest: universal-plane-functional [505.930942] Starting dynamic subtest: pipe-A-eDP-1 [509.921817] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.992s) [509.932038] Starting dynamic subtest: pipe-B-eDP-1 [514.528370] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.603s) [514.539423] Starting dynamic subtest: pipe-C-eDP-1 [518.875796] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.348s) [518.886343] Starting dynamic subtest: pipe-D-eDP-1 [523.251500] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.374s) [523.253849] Subtest universal-plane-functional: SUCCESS (17.325s) [524.121379] [126/133] (499s left) kms_lease (lease-unleased-connector) [524.228538] Starting subtest: lease-unleased-connector [524.230852] Starting dynamic subtest: pipe-A-eDP-1 [524.236211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [524.246572] Starting dynamic subtest: pipe-B-eDP-1 [524.249017] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [524.259070] Starting dynamic subtest: pipe-C-eDP-1 [524.261548] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [524.271507] Starting dynamic subtest: pipe-D-eDP-1 [524.273484] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [524.275558] Subtest lease-unleased-connector: SUCCESS (0.035s) [524.384509] [127/133] (498s left) gem_exec_reloc (basic-gtt-wc-active) [524.450428] Subtest basic-gtt-wc-active: SKIP (0.000s) [524.522812] [128/133] (498s left) kms_getfb (getfb-handle-zero) [524.622446] Starting subtest: getfb-handle-zero [524.624618] Subtest getfb-handle-zero: SUCCESS (0.000s) [524.735864] [129/133] (498s left) i915_pm_rps (reset) [524.795311] Starting subtest: reset [533.245830] Subtest reset: SUCCESS (8.447s) [533.389021] [130/133] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [533.495396] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [540.203039] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.709s) [540.327963] [131/133] (483s left) kms_async_flips (test-cursor-atomic) [540.420027] Starting subtest: test-cursor-atomic [540.794546] Starting dynamic subtest: pipe-A-eDP-1 [541.553497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.760s) [541.933951] Starting dynamic subtest: pipe-B-eDP-1 [542.754756] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.829s) [543.141518] Starting dynamic subtest: pipe-C-eDP-1 [543.961652] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.829s) [544.329642] Starting dynamic subtest: pipe-D-eDP-1 [545.154680] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.835s) [545.157100] Subtest test-cursor-atomic: SUCCESS (4.737s) [546.408704] [132/133] (477s left) gem_exec_reloc (basic-gtt-wc) [546.467064] Subtest basic-gtt-wc: SKIP (0.000s) [546.530885] [133/133] (476s left) fbdev (pan) [546.572530] Starting subtest: pan [546.592596] Subtest pan: SUCCESS (0.026s) [546.661560] Closing watchdogs results: parsing output: 0/ for test: kms_chamelium_hpd results: parsing output: 1/ for test: i915_power results: parsing output: 2/ for test: gem_fenced_exec_thrash results: parsing output: 3/ for test: i915_module_load results: parsing output: 4/ for test: kms_psr2_sf results: parsing output: 5/ for test: gem_fenced_exec_thrash results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: perf_pmu results: parsing output: 9/ for test: kms_flip results: parsing output: 10/ for test: gem_exec_whisper results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: syncobj_wait results: parsing output: 15/ for test: kms_properties results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_prime results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: gem_exec_schedule results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_cursor_crc results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: syncobj_wait results: parsing output: 24/ for test: gem_render_copy results: parsing output: 25/ for test: gem_exec_reloc results: parsing output: 26/ for test: gem_partial_pwrite_pread results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: drm_buddy results: parsing output: 30/ for test: gem_userptr_blits results: parsing output: 31/ for test: kms_addfb_basic results: parsing output: 32/ for test: gem_exec_alignment results: parsing output: 33/ for test: prime_self_import results: parsing output: 34/ for test: gem_exec_schedule results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: gem_softpin results: parsing output: 37/ for test: kms_rotation_crc results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: kms_draw_crc results: parsing output: 41/ for test: kms_ccs results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_exec_capture results: parsing output: 44/ for test: perf_pmu results: parsing output: 45/ for test: prime_vgem results: parsing output: 46/ for test: gem_exec_await results: parsing output: 47/ for test: kms_dirtyfb results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: kms_addfb_basic results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_exec_balancer results: parsing output: 54/ for test: kms_getfb results: parsing output: 55/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 56/ for test: kms_content_protection results: parsing output: 57/ for test: gem_mmap_wc results: parsing output: 58/ for test: gem_ppgtt results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: perf results: parsing output: 61/ for test: kms_invalid_mode results: parsing output: 62/ for test: gem_spin_batch results: parsing output: 63/ for test: api_intel_bb results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: kms_psr results: parsing output: 67/ for test: kms_pm_rpm results: parsing output: 68/ for test: gem_ctx_param results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: gem_readwrite results: parsing output: 71/ for test: gem_exec_schedule results: parsing output: 72/ for test: sriov_basic results: parsing output: 73/ for test: kms_plane_multiple results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_vblank results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: syncobj_wait results: parsing output: 81/ for test: kms_plane results: parsing output: 82/ for test: gem_exec_parallel results: parsing output: 83/ for test: kms_hdmi_inject results: parsing output: 84/ for test: kms_chamelium_edid results: parsing output: 85/ for test: syncobj_wait results: parsing output: 86/ for test: gem_exec_schedule results: parsing output: 87/ for test: sysfs_heartbeat_interval results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: perf results: parsing output: 90/ for test: gem_ctx_persistence results: parsing output: 91/ for test: kms_psr2_sf results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: kms_plane_scaling results: parsing output: 94/ for test: gem_mmap_gtt results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_exec_fence results: parsing output: 97/ for test: gem_ctx_param results: parsing output: 98/ for test: gem_exec_flush results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: gem_mmap_gtt results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: gem_exec_flush results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: i915_drm_fdinfo results: parsing output: 108/ for test: gem_mmap_gtt results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_multipipe_modeset results: parsing output: 111/ for test: api_intel_allocator results: parsing output: 112/ for test: kms_rotation_crc results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_plane results: parsing output: 115/ for test: gem_create results: parsing output: 116/ for test: gem_ctx_create results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: kms_color_pipeline results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_universal_plane results: parsing output: 125/ for test: kms_lease results: parsing output: 126/ for test: gem_exec_reloc results: parsing output: 127/ for test: kms_getfb results: parsing output: 128/ for test: i915_pm_rps results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_async_flips results: parsing output: 131/ for test: gem_exec_reloc results: parsing output: 132/ for test: fbdev Done.