[57.061753] Initializing watchdogs [57.061801] /dev/watchdog0 [57.076275] [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.080767] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.083142] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.086624] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [57.497666] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [58.315333] [002/133] (959s left) i915_power (sanity) [58.370643] Starting subtest: sanity [62.416730] Subtest sanity: SUCCESS (4.040s) [63.902135] [003/133] (953s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [63.970230] Subtest no-spare-fences-interruptible: SKIP (0.000s) [64.027967] [004/133] (953s left) i915_module_load (resize-bar) [64.065352] Starting subtest: resize-bar [64.072317] Subtest resize-bar: SKIP (0.006s) [64.118761] [005/133] (953s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [64.222433] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [64.226621] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [64.290016] [006/133] (953s left) gem_fenced_exec_thrash (no-spare-fences) [64.343293] Subtest no-spare-fences: SKIP (0.000s) [64.414615] [007/133] (953s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [64.508573] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [64.510798] Starting dynamic subtest: pipe-A-eDP-1 [64.519777] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [64.529090] Starting dynamic subtest: pipe-B-eDP-1 [64.538266] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [64.545809] Starting dynamic subtest: pipe-C-eDP-1 [64.554151] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [64.561173] Starting dynamic subtest: pipe-D-eDP-1 [64.569528] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [64.573600] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s) [66.805453] [008/133] (951s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [66.919215] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [66.923147] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [67.236059] [009/133] (950s left) perf_pmu (busy-accuracy-50) [67.318092] Starting subtest: busy-accuracy-50 [67.320462] Starting dynamic subtest: rcs0 [68.851643] Dynamic subtest rcs0: SUCCESS (1.534s) [68.861596] Starting dynamic subtest: bcs0 [70.395395] Dynamic subtest bcs0: SUCCESS (1.542s) [70.405306] Starting dynamic subtest: vcs0 [71.938938] Dynamic subtest vcs0: SUCCESS (1.543s) [71.946776] Starting dynamic subtest: vcs1 [73.478493] Dynamic subtest vcs1: SUCCESS (1.538s) [73.487903] Starting dynamic subtest: vecs0 [75.022536] Dynamic subtest vecs0: SUCCESS (1.544s) [75.032474] Starting dynamic subtest: ccs0 [76.566042] Dynamic subtest ccs0: SUCCESS (1.542s) [76.568508] Subtest busy-accuracy-50: SUCCESS (9.249s) [76.682062] [010/133] (941s left) kms_flip (2x-nonexisting-fb-interruptible) [76.776713] Starting subtest: 2x-nonexisting-fb-interruptible [76.790740] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s) [76.877324] [011/133] (941s left) gem_exec_whisper (basic-queues-priority-all) [76.945167] Starting subtest: basic-queues-priority-all [97.194080] Subtest basic-queues-priority-all: SUCCESS (20.228s) [97.362130] [012/133] (920s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [97.470116] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [97.474264] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [97.577647] [013/133] (920s left) kms_psr (psr2-primary-render) [97.668892] Starting subtest: psr2-primary-render [97.671093] Starting dynamic subtest: eDP-1 [99.381520] Dynamic subtest eDP-1: SUCCESS (1.711s) [99.383402] Subtest psr2-primary-render: SUCCESS (1.712s) [100.245030] [014/133] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [100.337404] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [100.341705] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [100.425581] [015/133] (917s left) syncobj_wait (single-wait-signaled) [100.490216] Starting subtest: single-wait-signaled [100.492523] Subtest single-wait-signaled: SUCCESS (0.000s) [100.585571] [016/133] (917s left) kms_properties (plane-properties-legacy) [100.684971] Starting subtest: plane-properties-legacy [100.687438] Starting dynamic subtest: pipe-A-eDP-1 [101.998626] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.311s) [102.009048] Starting dynamic subtest: pipe-B-eDP-1 [102.800849] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.803s) [102.811242] Starting dynamic subtest: pipe-C-eDP-1 [104.035239] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s) [104.045925] Starting dynamic subtest: pipe-D-eDP-1 [105.280454] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s) [105.282648] Subtest plane-properties-legacy: SUCCESS (4.596s) [106.087849] [017/133] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [106.189252] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [106.193702] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [106.283335] [018/133] (911s left) kms_prime (basic-modeset-hybrid) [106.362483] Subtest basic-modeset-hybrid: SKIP (0.000s) [106.503543] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true [106.507632] [019/133] (911s left) syncobj_timeline (wait-all-for-submit-snapshot) [106.558998] Starting subtest: wait-all-for-submit-snapshot [106.640443] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [106.712824] [020/133] (911s left) gem_exec_schedule (semaphore-power) [106.882129] Subtest semaphore-power: SKIP (0.000s) [107.058618] [021/133] (911s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [107.155881] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [111.169024] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.016s) [112.299772] [022/133] (906s left) kms_cursor_crc (cursor-onscreen-512x512) [112.576848] Starting subtest: cursor-onscreen-512x512 [112.581319] Subtest cursor-onscreen-512x512: SKIP (0.001s) [112.751037] [023/133] (905s left) kms_big_fb (linear-32bpp-rotate-180) [112.846709] Starting subtest: linear-32bpp-rotate-180 [114.382526] Subtest linear-32bpp-rotate-180: SUCCESS (1.534s) [114.547460] [024/133] (903s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [114.594103] Starting subtest: multi-wait-all-for-submit-submitted-signaled [114.696920] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s) [114.771304] [025/133] (903s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [114.816306] Starting subtest: mixed-tiled-to-y-tiled-ccs [114.821122] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [115.010495] [026/133] (903s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [115.066419] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [115.143849] [027/133] (903s left) gem_partial_pwrite_pread (reads-display) [115.196966] Subtest reads-display: SKIP (0.000s) [115.286153] [028/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [115.413117] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [115.417669] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [115.557530] [029/133] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [115.652267] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [115.656649] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [115.738166] [030/133] (903s left) drm_buddy (drm_buddy) [115.775978] Starting subtest: drm_buddy [115.780295] Subtest drm_buddy: SKIP (0.001s) [115.833196] [031/133] (902s left) gem_userptr_blits (set-cache-level) [115.895395] Starting subtest: set-cache-level [115.899685] Subtest set-cache-level: SKIP (0.000s) [116.031618] [032/133] (902s left) kms_addfb_basic (bad-pitch-1024) [116.094355] Starting subtest: bad-pitch-1024 [116.096677] Subtest bad-pitch-1024: SUCCESS (0.000s) [116.226852] [033/133] (902s left) gem_exec_alignment (forked) [116.289095] Starting subtest: forked [154.562022] Subtest forked: SUCCESS (38.240s) [154.820130] [034/133] (864s left) prime_self_import (basic-with_one_bo) [154.890271] Starting subtest: basic-with_one_bo [154.902765] Subtest basic-with_one_bo: SUCCESS (0.017s) [155.025395] [035/133] (863s left) gem_exec_schedule (in-order) [155.100323] Starting subtest: in-order [155.102696] Starting dynamic subtest: rcs0 [155.275670] Dynamic subtest rcs0: SUCCESS (0.178s) [155.287465] Starting dynamic subtest: vcs0 [155.392714] Dynamic subtest vcs0: SUCCESS (0.118s) [155.404973] Starting dynamic subtest: vcs1 [155.497242] Dynamic subtest vcs1: SUCCESS (0.104s) [155.510277] Starting dynamic subtest: vecs0 [155.607863] Dynamic subtest vecs0: SUCCESS (0.111s) [155.618994] Starting dynamic subtest: ccs0 [155.737064] Dynamic subtest ccs0: SUCCESS (0.128s) [155.739892] Subtest in-order: SUCCESS (0.640s) [156.964245] [036/133] (862s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [157.061714] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [157.064069] Starting dynamic subtest: pipe-A-eDP-1 [157.134404] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [157.143906] Starting dynamic subtest: pipe-B-eDP-1 [157.201301] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [157.211342] Starting dynamic subtest: pipe-C-eDP-1 [157.269260] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [157.278843] Starting dynamic subtest: pipe-D-eDP-1 [157.339204] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [157.343665] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [159.392094] [037/133] (859s left) gem_softpin (32b-excludes-last-page) [159.443801] Starting subtest: 32b-excludes-last-page [159.446229] Subtest 32b-excludes-last-page: SUCCESS (0.003s) [159.566211] [038/133] (859s left) kms_rotation_crc (primary-rotation-90) [159.664076] Starting subtest: primary-rotation-90 [159.668565] Subtest primary-rotation-90: SKIP (0.001s) [159.755055] [039/133] (859s left) kms_psr (fbc-psr-cursor-render) [159.857290] Starting subtest: fbc-psr-cursor-render [159.859663] Starting dynamic subtest: eDP-1 [159.863872] Dynamic subtest eDP-1: SKIP (0.000s) [159.868080] Subtest fbc-psr-cursor-render: SKIP (0.001s) [159.942886] [040/133] (859s left) kms_psr (fbc-pr-sprite-mmap-gtt) [160.029360] Starting subtest: fbc-pr-sprite-mmap-gtt [160.033577] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [160.105336] [041/133] (859s left) kms_draw_crc (draw-method-mmap-cpu) [160.210078] Starting subtest: draw-method-mmap-cpu [160.212362] Starting dynamic subtest: xrgb8888-untiled [160.441906] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s) [160.451142] Starting dynamic subtest: rgb565-untiled [160.664438] Dynamic subtest rgb565-untiled: SUCCESS (0.222s) [160.674847] Starting dynamic subtest: xrgb2101010-untiled [160.886489] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [160.895857] Starting dynamic subtest: xbgr16161616f-untiled [161.119929] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s) [161.128268] Starting dynamic subtest: xrgb8888-xtiled [161.266273] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [161.274572] Starting dynamic subtest: rgb565-xtiled [161.398070] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [161.407333] Starting dynamic subtest: xrgb2101010-xtiled [161.519987] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [161.528527] Starting dynamic subtest: xbgr16161616f-xtiled [161.653576] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [161.661852] Starting dynamic subtest: xrgb8888-4tiled [161.798243] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [161.806500] Starting dynamic subtest: rgb565-4tiled [161.942653] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [161.951065] Starting dynamic subtest: xrgb2101010-4tiled [162.087639] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s) [162.097084] Starting dynamic subtest: xbgr16161616f-4tiled [162.242649] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s) [162.244661] Subtest draw-method-mmap-cpu: SUCCESS (2.035s) [162.338607] [042/133] (856s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [162.425206] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [162.427119] Starting dynamic subtest: pipe-A-eDP-1 [162.445786] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [162.455035] Starting dynamic subtest: pipe-B-eDP-1 [162.472635] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [162.480645] Starting dynamic subtest: pipe-C-eDP-1 [162.497582] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [162.505585] Starting dynamic subtest: pipe-D-eDP-1 [162.523189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [162.526689] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [164.666766] [043/133] (854s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [164.777226] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [187.798299] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.019s) [187.945366] [044/133] (831s left) gem_exec_capture (capture) [188.019529] Starting subtest: capture [188.021633] Starting dynamic subtest: rcs0-smem [188.860998] Dynamic subtest rcs0-smem: SUCCESS (0.837s) [188.871858] Starting dynamic subtest: bcs0-smem [189.685628] Dynamic subtest bcs0-smem: SUCCESS (0.826s) [189.693585] Starting dynamic subtest: vcs0-smem [190.514069] Dynamic subtest vcs0-smem: SUCCESS (0.827s) [190.522240] Starting dynamic subtest: vcs1-smem [191.837960] Dynamic subtest vcs1-smem: SUCCESS (1.322s) [191.846711] Starting dynamic subtest: vecs0-smem [192.743135] Dynamic subtest vecs0-smem: FAIL (0.846s) [192.753224] Starting dynamic subtest: ccs0-smem [194.007112] Dynamic subtest ccs0-smem: SUCCESS (1.322s) [194.009443] Subtest capture: FAIL (5.984s) [194.134221] [045/133] (825s left) perf_pmu (busy-hang) [194.173456] Starting subtest: busy-hang [194.175798] Starting dynamic subtest: rcs0 [195.430820] Dynamic subtest rcs0: SUCCESS (1.254s) [195.441032] Starting dynamic subtest: bcs0 [196.643495] Dynamic subtest bcs0: SUCCESS (1.210s) [196.652692] Starting dynamic subtest: vcs0 [198.424744] Dynamic subtest vcs0: SUCCESS (1.782s) [198.436240] Starting dynamic subtest: vcs1 [200.404422] Dynamic subtest vcs1: SUCCESS (1.978s) [200.415851] Starting dynamic subtest: vecs0 [202.390026] Dynamic subtest vecs0: SUCCESS (1.981s) [202.398664] Starting dynamic subtest: ccs0 [203.603883] Dynamic subtest ccs0: SUCCESS (1.211s) [203.605885] Subtest busy-hang: SUCCESS (9.427s) [203.696815] [046/133] (815s left) prime_vgem (basic-write) [203.767455] Starting subtest: basic-write [203.788878] Subtest basic-write: SKIP (0.019s) [203.912227] [047/133] (815s left) gem_exec_await (wide-all) [204.143897] Starting subtest: wide-all [227.614282] Subtest wide-all: SUCCESS (23.468s) [227.804800] [048/133] (791s left) kms_dirtyfb (psr-dirtyfb-ioctl) [227.945040] Starting subtest: psr-dirtyfb-ioctl [227.947185] Starting dynamic subtest: A-eDP-1 [231.871879] Dynamic subtest A-eDP-1: SUCCESS (3.925s) [231.874243] Subtest psr-dirtyfb-ioctl: SUCCESS (3.928s) [232.672144] [049/133] (786s left) kms_cursor_crc (cursor-size-hints) [232.815475] Starting subtest: cursor-size-hints [232.817856] Starting dynamic subtest: pipe-A-eDP-1 [233.451777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s) [233.460746] Starting dynamic subtest: pipe-D-eDP-1 [234.738855] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s) [234.741308] Subtest cursor-size-hints: SUCCESS (1.924s) [235.531295] [050/133] (784s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [235.638079] Starting subtest: addfb25-y-tiled-small-legacy [235.642399] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [235.722758] [051/133] (783s left) kms_psr (psr-primary-mmap-cpu) [235.814775] Starting subtest: psr-primary-mmap-cpu [235.817032] Starting dynamic subtest: eDP-1 [237.532258] Dynamic subtest eDP-1: SUCCESS (1.717s) [237.534634] Subtest psr-primary-mmap-cpu: SUCCESS (1.718s) [238.406109] [052/133] (781s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [238.503640] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [238.508191] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [238.598452] [053/133] (781s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [238.708292] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [239.422720] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.716s) [239.591381] [054/133] (780s left) gem_exec_balancer (bonded-false-hang) [239.854191] Starting subtest: bonded-false-hang [239.859742] Subtest bonded-false-hang: SKIP (0.000s) [239.979443] [055/133] (779s left) kms_getfb (getfb2-accept-nv12) [240.074387] Starting subtest: getfb2-accept-nv12 [240.076785] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [240.200061] [056/133] (779s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [240.253995] Subtest writes-after-reads: SKIP (0.000s) [240.340713] [057/133] (779s left) kms_content_protection (suspend-resume) [240.485535] Starting subtest: suspend-resume [240.490077] Subtest suspend-resume: SKIP (0.000s) [240.618740] [058/133] (779s left) gem_mmap_wc (bad-offset) [240.687795] Subtest bad-offset: SKIP (0.000s) [240.748706] [059/133] (779s left) gem_ppgtt (blt-vs-render-ctxn) [240.803972] Starting subtest: blt-vs-render-ctxN [273.514603] Subtest blt-vs-render-ctxN: SUCCESS (32.720s) [273.642362] [060/133] (746s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [273.771978] Starting subtest: crc-primary-basic-y-tiled-ccs [273.774292] Starting dynamic subtest: pipe-A-eDP-1 [273.797614] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [273.809265] Starting dynamic subtest: pipe-B-eDP-1 [273.830862] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [273.839794] Starting dynamic subtest: pipe-C-eDP-1 [273.862198] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [273.870717] Starting dynamic subtest: pipe-D-eDP-1 [273.892859] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [273.897048] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [275.941840] [061/133] (744s left) perf (whitelisted-registers-userspace-config) [276.094083] Starting subtest: whitelisted-registers-userspace-config [276.096365] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [276.138530] [062/133] (743s left) kms_invalid_mode (overflow-vrefresh) [276.229516] Starting subtest: overflow-vrefresh [276.231860] Starting dynamic subtest: pipe-A-eDP-1 [276.528946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s) [276.538243] Starting dynamic subtest: pipe-B-eDP-1 [276.540089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [276.548637] Starting dynamic subtest: pipe-C-eDP-1 [276.550523] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [276.559491] Starting dynamic subtest: pipe-D-eDP-1 [276.561701] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [276.563902] Subtest overflow-vrefresh: SUCCESS (0.307s) [277.372470] [063/133] (742s left) gem_spin_batch (resubmit-new-all) [277.436316] Starting subtest: resubmit-new-all [277.438622] Starting dynamic subtest: rcs0 [277.452213] Dynamic subtest rcs0: SUCCESS (0.015s) [277.464173] Starting dynamic subtest: bcs0 [277.466687] Dynamic subtest bcs0: SUCCESS (0.011s) [277.476414] Starting dynamic subtest: vcs0 [277.478713] Dynamic subtest vcs0: SUCCESS (0.010s) [277.487153] Starting dynamic subtest: vcs1 [277.489356] Dynamic subtest vcs1: SUCCESS (0.011s) [277.498490] Starting dynamic subtest: vecs0 [277.500744] Dynamic subtest vecs0: SUCCESS (0.009s) [277.509406] Starting dynamic subtest: ccs0 [277.514171] Dynamic subtest ccs0: SUCCESS (0.014s) [277.516289] Subtest resubmit-new-all: SUCCESS (0.077s) [278.977932] [064/133] (741s left) api_intel_bb (simple-bb) [279.039359] Starting subtest: simple-bb [279.041832] Subtest simple-bb: SUCCESS (0.005s) [279.157111] [065/133] (741s left) syncobj_timeline (etime-multi-wait-all-submitted) [279.214485] Starting subtest: etime-multi-wait-all-submitted [279.321481] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s) [279.410404] [066/133] (740s left) kms_big_fb (y-tiled-8bpp-rotate-180) [279.512893] Starting subtest: y-tiled-8bpp-rotate-180 [279.517298] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [279.609741] [067/133] (740s left) kms_psr (fbc-pr-cursor-mmap-gtt) [279.714360] Starting subtest: fbc-pr-cursor-mmap-gtt [279.718970] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [279.814884] [068/133] (740s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [281.978372] Starting subtest: dpms-mode-unset-non-lpsp [283.141037] Subtest dpms-mode-unset-non-lpsp: SKIP (1.159s) [283.513822] [069/133] (736s left) gem_ctx_param (root-set) [283.572785] Starting subtest: root-set [283.575195] Subtest root-set: SUCCESS (0.001s) [283.682204] [070/133] (736s left) syncobj_timeline (device-submit-unordered) [283.742569] Starting subtest: device-submit-unordered [283.745075] Subtest device-submit-unordered: SUCCESS (0.000s) [283.859753] [071/133] (736s left) gem_readwrite (read-write) [283.921171] Subtest read-write: SKIP (0.000s) [283.979329] [072/133] (736s left) gem_exec_schedule (u-submit-late-slice) [284.061863] Starting subtest: u-submit-late-slice [284.064078] Starting dynamic subtest: rcs0 [284.093292] Dynamic subtest rcs0: SUCCESS (0.039s) [284.103456] Starting dynamic subtest: bcs0 [284.134742] Dynamic subtest bcs0: SUCCESS (0.041s) [284.144865] Starting dynamic subtest: vcs0 [284.173496] Dynamic subtest vcs0: SUCCESS (0.037s) [284.183652] Starting dynamic subtest: vcs1 [284.212345] Dynamic subtest vcs1: SUCCESS (0.038s) [284.225616] Starting dynamic subtest: vecs0 [284.246797] Dynamic subtest vecs0: SUCCESS (0.034s) [284.256662] Starting dynamic subtest: ccs0 [284.283684] Dynamic subtest ccs0: SUCCESS (0.036s) [284.285991] Subtest u-submit-late-slice: SUCCESS (0.231s) [286.003404] [073/133] (734s left) sriov_basic (enable-vfs-autoprobe-on) [286.059543] Starting subtest: enable-vfs-autoprobe-on [286.061794] Starting dynamic subtest: numvfs-1 [286.142382] Dynamic subtest numvfs-1: FAIL (0.028s) [286.153162] Starting dynamic subtest: numvfs-2 [286.227327] Dynamic subtest numvfs-2: FAIL (0.004s) [286.238240] Starting dynamic subtest: numvfs-3 [286.312583] Dynamic subtest numvfs-3: FAIL (0.004s) [286.322550] Starting dynamic subtest: numvfs-4 [286.395212] Dynamic subtest numvfs-4: FAIL (0.003s) [286.405419] Starting dynamic subtest: numvfs-5 [286.473709] Dynamic subtest numvfs-5: FAIL (0.004s) [286.482591] Starting dynamic subtest: numvfs-6 [286.551606] Dynamic subtest numvfs-6: FAIL (0.004s) [286.560727] Starting dynamic subtest: numvfs-7 [286.630483] Dynamic subtest numvfs-7: FAIL (0.004s) [286.639419] Starting dynamic subtest: numvfs-random [286.712070] Dynamic subtest numvfs-random: FAIL (0.004s) [286.723438] Starting dynamic subtest: numvfs-all [286.796574] Dynamic subtest numvfs-all: FAIL (0.503s) [286.798620] Subtest enable-vfs-autoprobe-on: FAIL (0.565s) [286.838988] [074/133] (733s left) kms_plane_multiple (2x-tiling-y) [286.939894] Starting subtest: 2x-tiling-y [286.944154] Subtest 2x-tiling-y: SKIP (0.000s) [287.008049] [075/133] (733s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [287.127513] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [287.131141] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [287.220451] [076/133] (733s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [287.308370] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [287.310321] Starting dynamic subtest: pipe-A-eDP-1 [287.331427] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [287.342076] Starting dynamic subtest: pipe-B-eDP-1 [287.361751] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [287.370373] Starting dynamic subtest: pipe-C-eDP-1 [287.390022] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [287.398746] Starting dynamic subtest: pipe-D-eDP-1 [287.418913] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [287.422312] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [289.574573] [077/133] (731s left) gem_userptr_blits (process-exit-busy) [289.646513] Starting subtest: process-exit-busy [289.662430] Subtest process-exit-busy: SUCCESS (0.016s) [289.792355] [078/133] (730s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [289.889379] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [289.893765] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [289.987186] [079/133] (730s left) kms_vblank (ts-continuation-modeset-rpm) [290.087059] Starting subtest: ts-continuation-modeset-rpm [290.088920] Starting dynamic subtest: pipe-A-eDP-1 [292.681953] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.593s) [292.695896] Starting dynamic subtest: pipe-D-eDP-1 [294.923297] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s) [294.925653] Subtest ts-continuation-modeset-rpm: SUCCESS (4.838s) [295.732996] [080/133] (725s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [295.845908] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [296.958057] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.112s) [297.082653] [081/133] (723s left) syncobj_wait (multi-wait-all-for-submit-signaled) [297.134317] Starting subtest: multi-wait-all-for-submit-signaled [297.136224] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [297.229227] [082/133] (723s left) kms_plane (plane-panning-top-left) [297.318332] Starting subtest: plane-panning-top-left [297.319947] Starting dynamic subtest: pipe-A [298.967831] Dynamic subtest pipe-A: SUCCESS (1.648s) [298.977132] Starting dynamic subtest: pipe-B [301.350289] Dynamic subtest pipe-B: SUCCESS (2.381s) [301.352841] Subtest plane-panning-top-left: SUCCESS (4.032s) [302.229067] [083/133] (718s left) gem_exec_parallel (userptr) [302.296865] Starting subtest: userptr [302.299335] Starting dynamic subtest: rcs0 [303.755618] Dynamic subtest rcs0: SUCCESS (1.459s) [303.765111] Starting dynamic subtest: bcs0 [305.246359] Dynamic subtest bcs0: SUCCESS (1.490s) [305.260525] Starting dynamic subtest: vcs0 [306.923760] Dynamic subtest vcs0: SUCCESS (1.674s) [306.933495] Starting dynamic subtest: vcs1 [308.900505] Dynamic subtest vcs1: SUCCESS (1.975s) [308.911997] Starting dynamic subtest: vecs0 [310.933093] Dynamic subtest vecs0: SUCCESS (2.029s) [310.944874] Starting dynamic subtest: ccs0 [312.449309] Dynamic subtest ccs0: SUCCESS (1.515s) [312.451705] Subtest userptr: SUCCESS (10.155s) [312.640719] [084/133] (708s left) kms_hdmi_inject (inject-4k) [313.005625] Starting subtest: inject-4k [313.323019] Subtest inject-4k: SUCCESS (0.318s) [313.895953] [085/133] (707s left) kms_chamelium_edid (hdmi-mode-timings) [314.275556] Subtest hdmi-mode-timings: SKIP (0.000s) [315.075519] [086/133] (706s left) syncobj_wait (multi-wait-for-submit-submitted) [315.137959] Starting subtest: multi-wait-for-submit-submitted [315.242399] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s) [315.318547] [087/133] (705s left) gem_exec_schedule (smoketest-all) [315.386734] Starting subtest: smoketest-all [347.770204] Subtest smoketest-all: SUCCESS (32.345s) [349.013802] [088/133] (672s left) sysfs_heartbeat_interval (mixed) [349.067504] Starting subtest: mixed [349.069885] Starting dynamic subtest: vecs0 [354.275411] Dynamic subtest vecs0: SUCCESS (5.207s) [354.287104] Starting dynamic subtest: ccs0 [359.481099] Dynamic subtest ccs0: SUCCESS (5.204s) [359.492083] Starting dynamic subtest: vcs0 [364.659360] Dynamic subtest vcs0: SUCCESS (5.176s) [364.671902] Starting dynamic subtest: bcs0 [369.879211] Dynamic subtest bcs0: SUCCESS (5.217s) [369.891023] Starting dynamic subtest: rcs0 [375.115238] Dynamic subtest rcs0: SUCCESS (5.235s) [375.128198] Starting dynamic subtest: vcs1 [380.353595] Dynamic subtest vcs1: SUCCESS (5.236s) [380.356075] Subtest mixed: SUCCESS (31.287s) [380.432799] [089/133] (640s left) kms_cursor_crc (cursor-sliding-512x512) [380.722946] Starting subtest: cursor-sliding-512x512 [380.727290] Subtest cursor-sliding-512x512: SKIP (0.001s) [380.869782] [090/133] (640s left) perf (sysctl-defaults) [380.939441] Starting subtest: sysctl-defaults [380.941810] Subtest sysctl-defaults: SUCCESS (0.000s) [381.015060] [091/133] (640s left) gem_ctx_persistence (legacy-engines-hostile) [381.080064] Starting subtest: legacy-engines-hostile [381.082248] Starting dynamic subtest: render [381.144643] Dynamic subtest render: SUCCESS (0.064s) [381.158099] Starting dynamic subtest: bsd1 [381.235731] Dynamic subtest bsd1: SUCCESS (0.088s) [381.250047] Starting dynamic subtest: bsd2 [381.306713] Dynamic subtest bsd2: SUCCESS (0.068s) [381.319670] Starting dynamic subtest: blt [381.421269] Dynamic subtest blt: SUCCESS (0.112s) [381.435261] Starting dynamic subtest: vebox [381.510253] Dynamic subtest vebox: SUCCESS (0.086s) [381.512339] Subtest legacy-engines-hostile: SUCCESS (0.432s) [381.589665] [092/133] (639s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [381.680896] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [381.682828] Starting dynamic subtest: pipe-A-eDP-1 [381.799304] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s) [381.808619] Starting dynamic subtest: pipe-B-eDP-1 [382.958197] Dynamic subtest pipe-B-eDP-1: SKIP (1.155s) [382.962633] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.280s) [384.249949] [093/133] (637s left) kms_flip (basic-flip-vs-dpms) [384.352110] Starting subtest: basic-flip-vs-dpms [384.354435] Starting dynamic subtest: A-eDP1 [386.948392] Dynamic subtest A-eDP1: SUCCESS (2.597s) [386.960796] Starting dynamic subtest: B-eDP1 [389.119699] Dynamic subtest B-eDP1: SUCCESS (2.166s) [389.128908] Starting dynamic subtest: C-eDP1 [391.192581] Dynamic subtest C-eDP1: SUCCESS (2.072s) [391.205890] Starting dynamic subtest: D-eDP1 [393.263533] Dynamic subtest D-eDP1: SUCCESS (2.067s) [393.265687] Subtest basic-flip-vs-dpms: SUCCESS (8.916s) [394.072314] [094/133] (627s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [394.170435] Starting subtest: plane-scaler-with-clipping-clamping-rotation [394.172743] Starting dynamic subtest: pipe-A [394.396572] Dynamic subtest pipe-A: SUCCESS (0.229s) [394.406146] Starting dynamic subtest: pipe-B [395.751983] Dynamic subtest pipe-B: SUCCESS (1.354s) [395.761814] Starting dynamic subtest: pipe-C [397.067095] Dynamic subtest pipe-C: SUCCESS (1.310s) [397.077908] Starting dynamic subtest: pipe-D [398.380384] Dynamic subtest pipe-D: SUCCESS (1.316s) [398.382807] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.213s) [399.579616] [095/133] (621s left) gem_mmap_gtt (cpuset-basic-small-copy) [399.652211] Subtest cpuset-basic-small-copy: SKIP (0.000s) [399.715972] [096/133] (621s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [399.820860] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [406.668687] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.849s) [406.781233] [097/133] (614s left) gem_exec_fence (syncobj-channel) [407.246110] Starting subtest: syncobj-channel [408.265853] Subtest syncobj-channel: SUCCESS (1.015s) [408.995563] [098/133] (612s left) gem_ctx_param (invalid-get-engines) [409.053968] Starting subtest: invalid-get-engines [409.056318] Subtest invalid-get-engines: SUCCESS (0.001s) [409.153193] [099/133] (612s left) gem_exec_flush (basic-wb-rw-before-default) [409.217941] Starting subtest: basic-wb-rw-before-default [414.677651] Subtest basic-wb-rw-before-default: SUCCESS (5.460s) [414.867748] [100/133] (606s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [414.961168] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [414.965765] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [415.034595] [101/133] (606s left) gem_mmap_gtt (zero-extend) [415.093740] Subtest zero-extend: SKIP (0.000s) [415.163216] [102/133] (606s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [415.269862] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [416.314914] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.047s) [416.453928] [103/133] (605s left) gem_exec_flush (basic-batch-kernel-default-uc) [416.518434] Starting subtest: basic-batch-kernel-default-uc [424.126684] Subtest basic-batch-kernel-default-uc: SUCCESS (7.607s) [424.315180] [104/133] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [424.415157] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [424.419140] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [424.536482] [105/133] (597s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [424.636483] Starting subtest: flip-vs-dpms-on-nop-interruptible [424.638784] Starting dynamic subtest: A-eDP1 [426.469236] Dynamic subtest A-eDP1: SUCCESS (1.831s) [426.481250] Starting dynamic subtest: B-eDP1 [428.294490] Dynamic subtest B-eDP1: SUCCESS (1.823s) [428.305774] Starting dynamic subtest: C-eDP1 [430.126754] Dynamic subtest C-eDP1: SUCCESS (1.830s) [430.140060] Starting dynamic subtest: D-eDP1 [431.943466] Dynamic subtest D-eDP1: SUCCESS (1.814s) [431.948664] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.313s) [433.135322] [106/133] (588s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [433.240853] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [439.858350] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.620s) [439.984463] [107/133] (582s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [440.083283] Starting subtest: psr-rgb101010-draw-mmap-gtt [440.087171] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [440.186177] [108/133] (581s left) i915_drm_fdinfo (virtual-busy) [440.229797] Starting subtest: virtual-busy [440.234475] Subtest virtual-busy: SKIP (0.000s) [440.306411] [109/133] (581s left) gem_mmap_gtt (basic-small-copy-odd) [440.377228] Subtest basic-small-copy-odd: SKIP (0.000s) [440.440246] [110/133] (581s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [440.529730] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [440.533960] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [440.631823] [111/133] (581s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [440.733724] Starting subtest: basic-max-pipe-crc-check [440.738167] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [440.784913] [112/133] (581s left) api_intel_allocator (fork-simple-stress-signal) [440.842835] Starting subtest: fork-simple-stress-signal [446.247877] Subtest fork-simple-stress-signal: SUCCESS (5.404s) [446.383522] [113/133] (575s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [446.498231] Starting subtest: primary-y-tiled-reflect-x-0 [446.558463] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s) [446.667373] [114/133] (575s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [446.770367] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [453.994237] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.226s) [454.112171] [115/133] (568s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping) [454.212977] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping [454.217565] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [454.286634] [116/133] (568s left) gem_create (create-ext-placement-all) [454.449671] Starting subtest: create-ext-placement-all [454.451787] Subtest create-ext-placement-all: SUCCESS (0.000s) [454.557078] [117/133] (567s left) gem_ctx_create (basic) [454.620769] Starting subtest: basic [454.623235] Subtest basic: SUCCESS (0.000s) [454.799843] [118/133] (567s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [454.853670] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [454.855907] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [454.965598] [119/133] (567s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [455.015437] Starting subtest: invalid-multi-wait-unsubmitted-submitted [455.017618] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [455.115240] [120/133] (567s left) gen9_exec_parse (bb-secure) [455.200019] Subtest bb-secure: SKIP (0.000s) [455.283667] [121/133] (567s left) kms_psr (pr-primary-page-flip) [455.404601] Starting subtest: pr-primary-page-flip [455.408806] Subtest pr-primary-page-flip: SKIP (0.000s) [455.493433] [122/133] (567s left) kms_flip (blocking-wf_vblank) [455.586088] Starting subtest: blocking-wf_vblank [455.588318] Starting dynamic subtest: A-eDP1 [464.550394] Dynamic subtest A-eDP1: SUCCESS (8.963s) [464.559795] Starting dynamic subtest: B-eDP1 [473.493938] Dynamic subtest B-eDP1: SUCCESS (8.941s) [473.509686] Starting dynamic subtest: C-eDP1 [482.412631] Dynamic subtest C-eDP1: SUCCESS (8.915s) [482.422085] Starting dynamic subtest: D-eDP1 [491.349122] Dynamic subtest D-eDP1: SUCCESS (8.934s) [491.351552] Subtest blocking-wf_vblank: SUCCESS (35.765s) [492.576616] [123/133] (530s left) kms_color_pipeline (plane-lut1d-lut1d) [492.664910] Starting subtest: plane-lut1d-lut1d [492.799949] Starting dynamic subtest: pipe-A-plane-0 [492.965920] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [492.987148] Starting dynamic subtest: pipe-A-plane-1 [493.133926] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [493.145630] Starting dynamic subtest: pipe-A-plane-2 [493.322195] Dynamic subtest pipe-A-plane-2: SUCCESS (0.187s) [494.501945] Starting dynamic subtest: pipe-B-plane-0 [494.671483] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [494.681318] Starting dynamic subtest: pipe-B-plane-1 [494.838207] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [494.847781] Starting dynamic subtest: pipe-B-plane-2 [495.004861] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [496.236027] Starting dynamic subtest: pipe-C-plane-0 [496.383221] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [496.392654] Starting dynamic subtest: pipe-C-plane-1 [496.539535] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [496.549647] Starting dynamic subtest: pipe-C-plane-2 [496.694491] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [497.872916] Starting dynamic subtest: pipe-D-plane-0 [498.009199] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [498.018593] Starting dynamic subtest: pipe-D-plane-1 [498.153590] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [498.163749] Starting dynamic subtest: pipe-D-plane-2 [498.298180] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [498.585124] Subtest plane-lut1d-lut1d: SUCCESS (5.921s) [499.413366] [124/133] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [499.514079] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [506.131683] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.622s) [506.267951] [125/133] (516s left) kms_universal_plane (universal-plane-functional) [506.370465] Starting subtest: universal-plane-functional [506.372355] Starting dynamic subtest: pipe-A-eDP-1 [510.326495] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.955s) [510.336377] Starting dynamic subtest: pipe-B-eDP-1 [514.959088] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.632s) [514.969344] Starting dynamic subtest: pipe-C-eDP-1 [519.385804] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.424s) [519.396760] Starting dynamic subtest: pipe-D-eDP-1 [523.775829] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.390s) [523.778251] Subtest universal-plane-functional: SUCCESS (17.407s) [524.642629] [126/133] (498s left) kms_lease (lease-unleased-connector) [524.750847] Starting subtest: lease-unleased-connector [524.752966] Starting dynamic subtest: pipe-A-eDP-1 [524.757920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s) [524.767641] Starting dynamic subtest: pipe-B-eDP-1 [524.769778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s) [524.781936] Starting dynamic subtest: pipe-C-eDP-1 [524.784105] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [524.793650] Starting dynamic subtest: pipe-D-eDP-1 [524.795798] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [524.797964] Subtest lease-unleased-connector: SUCCESS (0.037s) [524.921084] [127/133] (497s left) gem_exec_reloc (basic-gtt-wc-active) [524.981430] Subtest basic-gtt-wc-active: SKIP (0.000s) [525.046444] [128/133] (497s left) kms_getfb (getfb-handle-zero) [525.136637] Starting subtest: getfb-handle-zero [525.139061] Subtest getfb-handle-zero: SUCCESS (0.000s) [525.247516] [129/133] (497s left) i915_pm_rps (reset) [525.314567] Starting subtest: reset [533.784617] Subtest reset: SUCCESS (8.470s) [533.908844] [130/133] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [534.003534] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [540.745918] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.744s) [540.871861] [131/133] (482s left) kms_async_flips (test-cursor-atomic) [540.958846] Starting subtest: test-cursor-atomic [541.339792] Starting dynamic subtest: pipe-A-eDP-1 [542.144463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s) [542.532103] Starting dynamic subtest: pipe-B-eDP-1 [543.276245] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.751s) [543.646519] Starting dynamic subtest: pipe-C-eDP-1 [544.409149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s) [544.778346] Starting dynamic subtest: pipe-D-eDP-1 [545.539986] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s) [545.542154] Subtest test-cursor-atomic: SUCCESS (4.584s) [546.706731] [132/133] (476s left) gem_exec_reloc (basic-gtt-wc) [546.774600] Subtest basic-gtt-wc: SKIP (0.000s) [546.845611] [133/133] (476s left) fbdev (pan) [546.884057] Starting subtest: pan [546.906093] Subtest pan: SUCCESS (0.025s) [546.974197] 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.