[58.053367] Initializing watchdogs [58.053500] /dev/watchdog0 [58.074231] [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] [58.078668] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.080908] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.084200] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [58.503758] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [59.349187] [002/133] (959s left) i915_power (sanity) [59.405892] Starting subtest: sanity [63.455575] Subtest sanity: SUCCESS (4.029s) [64.930820] [003/133] (953s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [64.988253] Subtest no-spare-fences-interruptible: SKIP (0.000s) [65.050020] [004/133] (953s left) i915_module_load (resize-bar) [65.088661] Starting subtest: resize-bar [65.095699] Subtest resize-bar: SKIP (0.006s) [65.135588] [005/133] (953s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [65.238242] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [65.242194] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [65.302439] [006/133] (953s left) gem_fenced_exec_thrash (no-spare-fences) [65.353218] Subtest no-spare-fences: SKIP (0.000s) [65.420086] [007/133] (953s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [65.521193] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [65.523594] Starting dynamic subtest: pipe-A-eDP-1 [65.532862] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [65.541340] Starting dynamic subtest: pipe-B-eDP-1 [65.550381] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [65.557868] Starting dynamic subtest: pipe-C-eDP-1 [65.566608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [65.573260] Starting dynamic subtest: pipe-D-eDP-1 [65.582082] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [65.586441] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s) [67.671288] [008/133] (951s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [67.824058] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [67.828465] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [68.025564] [009/133] (950s left) perf_pmu (busy-accuracy-50) [68.067040] Starting subtest: busy-accuracy-50 [68.069266] Starting dynamic subtest: rcs0 [69.603423] Dynamic subtest rcs0: SUCCESS (1.533s) [69.610634] Starting dynamic subtest: bcs0 [71.150642] Dynamic subtest bcs0: SUCCESS (1.544s) [71.160189] Starting dynamic subtest: vcs0 [72.695704] Dynamic subtest vcs0: SUCCESS (1.543s) [72.703075] Starting dynamic subtest: vcs1 [74.237825] Dynamic subtest vcs1: SUCCESS (1.539s) [74.247679] Starting dynamic subtest: vecs0 [75.780447] Dynamic subtest vecs0: SUCCESS (1.541s) [75.788923] Starting dynamic subtest: ccs0 [77.326098] Dynamic subtest ccs0: SUCCESS (1.544s) [77.328561] Subtest busy-accuracy-50: SUCCESS (9.250s) [77.449581] [010/133] (941s left) kms_flip (2x-nonexisting-fb-interruptible) [77.552128] Starting subtest: 2x-nonexisting-fb-interruptible [77.563087] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s) [77.663354] [011/133] (941s left) gem_exec_whisper (basic-queues-priority-all) [77.742233] Starting subtest: basic-queues-priority-all [99.997259] Subtest basic-queues-priority-all: SUCCESS (22.248s) [100.176067] [012/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [100.283731] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [100.288139] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [100.369236] [013/133] (918s left) kms_psr (psr2-primary-render) [100.452462] Starting subtest: psr2-primary-render [100.454826] Starting dynamic subtest: eDP-1 [102.184389] Dynamic subtest eDP-1: SUCCESS (1.731s) [102.186760] Subtest psr2-primary-render: SUCCESS (1.732s) [103.064528] [014/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [103.156546] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [103.160902] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [103.247742] [015/133] (915s left) syncobj_wait (single-wait-signaled) [103.296700] Starting subtest: single-wait-signaled [103.299038] Subtest single-wait-signaled: SUCCESS (0.000s) [103.388331] [016/133] (915s left) kms_properties (plane-properties-legacy) [103.477175] Starting subtest: plane-properties-legacy [103.479539] Starting dynamic subtest: pipe-A-eDP-1 [104.050976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s) [104.060424] Starting dynamic subtest: pipe-B-eDP-1 [105.313493] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s) [105.321310] Starting dynamic subtest: pipe-C-eDP-1 [106.546478] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s) [106.556314] Starting dynamic subtest: pipe-D-eDP-1 [107.785402] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s) [107.787639] Subtest plane-properties-legacy: SUCCESS (4.309s) [108.581116] [017/133] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [108.697451] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [108.701712] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [108.796251] [018/133] (910s left) kms_prime (basic-modeset-hybrid) [108.874088] Subtest basic-modeset-hybrid: SKIP (0.000s) [109.017995] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true [109.021486] [019/133] (910s left) syncobj_timeline (wait-all-for-submit-snapshot) [109.073506] Starting subtest: wait-all-for-submit-snapshot [109.154930] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [109.237631] [020/133] (910s left) gem_exec_schedule (semaphore-power) [109.425296] Subtest semaphore-power: SKIP (0.000s) [109.611194] [021/133] (909s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [109.731690] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [113.703844] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.977s) [114.889106] [022/133] (904s left) kms_cursor_crc (cursor-onscreen-512x512) [115.175052] Starting subtest: cursor-onscreen-512x512 [115.179053] Subtest cursor-onscreen-512x512: SKIP (0.001s) [115.358592] [023/133] (904s left) kms_big_fb (linear-32bpp-rotate-180) [115.456073] Starting subtest: linear-32bpp-rotate-180 [117.012044] Subtest linear-32bpp-rotate-180: SUCCESS (1.557s) [117.129084] [024/133] (902s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [117.201285] Starting subtest: multi-wait-all-for-submit-submitted-signaled [117.305847] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s) [117.377682] [025/133] (902s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [117.440701] Starting subtest: mixed-tiled-to-y-tiled-ccs [117.445315] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [117.619386] [026/133] (901s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [117.678361] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [117.744666] [027/133] (901s left) gem_partial_pwrite_pread (reads-display) [117.793050] Subtest reads-display: SKIP (0.000s) [117.860029] [028/133] (901s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [117.967866] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [117.972262] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [118.112536] [029/133] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [118.215302] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [118.219244] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [118.309568] [030/133] (901s left) drm_buddy (drm_buddy) [118.353045] Starting subtest: drm_buddy [118.356977] Subtest drm_buddy: SKIP (0.001s) [118.411197] [031/133] (901s left) gem_userptr_blits (set-cache-level) [118.481984] Starting subtest: set-cache-level [118.486304] Subtest set-cache-level: SKIP (0.000s) [118.600770] [032/133] (901s left) kms_addfb_basic (bad-pitch-1024) [118.655307] Starting subtest: bad-pitch-1024 [118.657316] Subtest bad-pitch-1024: SUCCESS (0.000s) [118.795168] [033/133] (901s left) gem_exec_alignment (forked) [118.868285] Starting subtest: forked [157.973500] Subtest forked: SUCCESS (39.101s) [158.066594] [034/133] (861s left) prime_self_import (basic-with_one_bo) [158.139234] Starting subtest: basic-with_one_bo [158.162837] Subtest basic-with_one_bo: SUCCESS (0.025s) [158.308212] [035/133] (861s left) gem_exec_schedule (in-order) [158.381044] Starting subtest: in-order [158.385445] Starting dynamic subtest: rcs0 [158.556822] Dynamic subtest rcs0: SUCCESS (0.179s) [158.568656] Starting dynamic subtest: vcs0 [158.670871] Dynamic subtest vcs0: SUCCESS (0.113s) [158.682271] Starting dynamic subtest: vcs1 [158.781696] Dynamic subtest vcs1: SUCCESS (0.110s) [158.793652] Starting dynamic subtest: vecs0 [158.889798] Dynamic subtest vecs0: SUCCESS (0.107s) [158.900872] Starting dynamic subtest: ccs0 [159.017954] Dynamic subtest ccs0: SUCCESS (0.128s) [159.020280] Subtest in-order: SUCCESS (0.641s) [159.979713] [036/133] (859s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [160.077798] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [160.080158] Starting dynamic subtest: pipe-A-eDP-1 [160.138763] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [160.146875] Starting dynamic subtest: pipe-B-eDP-1 [160.204303] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [160.214149] Starting dynamic subtest: pipe-C-eDP-1 [160.272049] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [160.281714] Starting dynamic subtest: pipe-D-eDP-1 [160.339656] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [160.343819] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [162.282659] [037/133] (857s left) gem_softpin (32b-excludes-last-page) [162.346776] Starting subtest: 32b-excludes-last-page [162.349278] Subtest 32b-excludes-last-page: SUCCESS (0.004s) [162.475787] [038/133] (857s left) kms_rotation_crc (primary-rotation-90) [162.574091] Starting subtest: primary-rotation-90 [162.578388] Subtest primary-rotation-90: SKIP (0.001s) [162.645780] [039/133] (857s left) kms_psr (fbc-psr-cursor-render) [162.735836] Starting subtest: fbc-psr-cursor-render [162.738100] Starting dynamic subtest: eDP-1 [162.742190] Dynamic subtest eDP-1: SKIP (0.000s) [162.746260] Subtest fbc-psr-cursor-render: SKIP (0.000s) [162.819639] [040/133] (857s left) kms_psr (fbc-pr-sprite-mmap-gtt) [162.906921] Starting subtest: fbc-pr-sprite-mmap-gtt [162.911505] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [162.980067] [041/133] (857s left) kms_draw_crc (draw-method-mmap-cpu) [163.071999] Starting subtest: draw-method-mmap-cpu [163.074034] Starting dynamic subtest: xrgb8888-untiled [163.302042] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s) [163.311787] Starting dynamic subtest: rgb565-untiled [163.524330] Dynamic subtest rgb565-untiled: SUCCESS (0.222s) [163.533662] Starting dynamic subtest: xrgb2101010-untiled [163.746481] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [163.754590] Starting dynamic subtest: xbgr16161616f-untiled [163.980044] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [163.989919] Starting dynamic subtest: xrgb8888-xtiled [164.113240] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [164.123917] Starting dynamic subtest: rgb565-xtiled [164.235459] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [164.244187] Starting dynamic subtest: xrgb2101010-xtiled [164.357698] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [164.366888] Starting dynamic subtest: xbgr16161616f-xtiled [164.491040] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [164.499162] Starting dynamic subtest: xrgb8888-4tiled [164.624231] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s) [164.632984] Starting dynamic subtest: rgb565-4tiled [164.770330] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [164.780974] Starting dynamic subtest: xrgb2101010-4tiled [164.902669] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s) [164.917517] Starting dynamic subtest: xbgr16161616f-4tiled [165.057887] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.154s) [165.059888] Subtest draw-method-mmap-cpu: SUCCESS (1.989s) [165.160734] [042/133] (855s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [165.253754] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [165.255836] Starting dynamic subtest: pipe-A-eDP-1 [165.275771] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [165.291375] Starting dynamic subtest: pipe-B-eDP-1 [165.309607] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [165.317165] Starting dynamic subtest: pipe-C-eDP-1 [165.334846] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [165.342114] Starting dynamic subtest: pipe-D-eDP-1 [165.359756] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [165.363207] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [167.541591] [043/133] (852s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [167.643079] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [190.515957] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.876s) [190.638869] [044/133] (829s left) gem_exec_capture (capture) [190.716888] Starting subtest: capture [190.718934] Starting dynamic subtest: rcs0-smem [191.555470] Dynamic subtest rcs0-smem: SUCCESS (0.836s) [191.563688] Starting dynamic subtest: bcs0-smem [192.884690] Dynamic subtest bcs0-smem: SUCCESS (1.328s) [192.892873] Starting dynamic subtest: vcs0-smem [193.711860] Dynamic subtest vcs0-smem: SUCCESS (0.825s) [193.720103] Starting dynamic subtest: vcs1-smem [194.533943] Dynamic subtest vcs1-smem: SUCCESS (0.822s) [194.542794] Starting dynamic subtest: vecs0-smem [195.925413] Dynamic subtest vecs0-smem: FAIL (1.332s) [195.935708] Starting dynamic subtest: ccs0-smem [197.186232] Dynamic subtest ccs0-smem: SUCCESS (1.318s) [197.188434] Subtest capture: FAIL (6.466s) [197.328160] [045/133] (823s left) perf_pmu (busy-hang) [197.366928] Starting subtest: busy-hang [197.369071] Starting dynamic subtest: rcs0 [198.622074] Dynamic subtest rcs0: SUCCESS (1.258s) [198.632858] Starting dynamic subtest: bcs0 [199.822163] Dynamic subtest bcs0: SUCCESS (1.198s) [199.832370] Starting dynamic subtest: vcs0 [202.457597] Dynamic subtest vcs0: SUCCESS (2.631s) [202.469680] Starting dynamic subtest: vcs1 [204.373919] Dynamic subtest vcs1: SUCCESS (1.917s) [204.384737] Starting dynamic subtest: vecs0 [206.425773] Dynamic subtest vecs0: SUCCESS (2.049s) [206.436572] Starting dynamic subtest: ccs0 [207.638059] Dynamic subtest ccs0: SUCCESS (1.211s) [207.640583] Subtest busy-hang: SUCCESS (10.275s) [207.743037] [046/133] (812s left) prime_vgem (basic-write) [207.829481] Starting subtest: basic-write [207.850866] Subtest basic-write: SKIP (0.019s) [207.982374] [047/133] (812s left) gem_exec_await (wide-all) [208.283053] Starting subtest: wide-all [231.807564] Subtest wide-all: SUCCESS (23.525s) [232.006251] [048/133] (788s left) kms_dirtyfb (psr-dirtyfb-ioctl) [232.147483] Starting subtest: psr-dirtyfb-ioctl [232.149552] Starting dynamic subtest: A-eDP-1 [236.058112] Dynamic subtest A-eDP-1: SUCCESS (3.909s) [236.060407] Subtest psr-dirtyfb-ioctl: SUCCESS (3.911s) [236.856924] [049/133] (783s left) kms_cursor_crc (cursor-size-hints) [236.988104] Starting subtest: cursor-size-hints [236.990467] Starting dynamic subtest: pipe-A-eDP-1 [237.621270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s) [237.630326] Starting dynamic subtest: pipe-D-eDP-1 [238.918840] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s) [238.921201] Subtest cursor-size-hints: SUCCESS (1.933s) [239.715438] [050/133] (780s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [239.817243] Starting subtest: addfb25-y-tiled-small-legacy [239.821262] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [239.899046] [051/133] (780s left) kms_psr (psr-primary-mmap-cpu) [239.994189] Starting subtest: psr-primary-mmap-cpu [239.996472] Starting dynamic subtest: eDP-1 [241.720737] Dynamic subtest eDP-1: SUCCESS (1.727s) [241.723080] Subtest psr-primary-mmap-cpu: SUCCESS (1.728s) [242.612749] [052/133] (778s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [242.712031] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [242.716230] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [242.800054] [053/133] (777s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [242.900784] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [243.547083] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s) [243.720054] [054/133] (776s left) gem_exec_balancer (bonded-false-hang) [243.979117] Starting subtest: bonded-false-hang [243.984055] Subtest bonded-false-hang: SKIP (0.000s) [244.087281] [055/133] (776s left) kms_getfb (getfb2-accept-nv12) [244.178981] Starting subtest: getfb2-accept-nv12 [244.181266] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [244.277844] [056/133] (776s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [244.343427] Subtest writes-after-reads: SKIP (0.000s) [244.413409] [057/133] (776s left) kms_content_protection (suspend-resume) [244.551313] Starting subtest: suspend-resume [244.555558] Subtest suspend-resume: SKIP (0.000s) [244.669767] [058/133] (776s left) gem_mmap_wc (bad-offset) [244.721227] Subtest bad-offset: SKIP (0.000s) [244.783806] [059/133] (776s left) gem_ppgtt (blt-vs-render-ctxn) [244.847738] Starting subtest: blt-vs-render-ctxN [277.510194] Subtest blt-vs-render-ctxN: SUCCESS (32.659s) [277.652143] [060/133] (743s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [277.782027] Starting subtest: crc-primary-basic-y-tiled-ccs [277.784319] Starting dynamic subtest: pipe-A-eDP-1 [277.807326] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [277.818779] Starting dynamic subtest: pipe-B-eDP-1 [277.840260] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [277.848735] Starting dynamic subtest: pipe-C-eDP-1 [277.869751] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [277.878197] Starting dynamic subtest: pipe-D-eDP-1 [277.899443] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [277.903490] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [280.034801] [061/133] (740s left) perf (whitelisted-registers-userspace-config) [280.181405] Starting subtest: whitelisted-registers-userspace-config [280.183667] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [280.222918] [062/133] (740s left) kms_invalid_mode (overflow-vrefresh) [280.322089] Starting subtest: overflow-vrefresh [280.324366] Starting dynamic subtest: pipe-A-eDP-1 [280.612008] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [280.622588] Starting dynamic subtest: pipe-B-eDP-1 [280.624532] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [280.632697] Starting dynamic subtest: pipe-C-eDP-1 [280.635078] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [280.643432] Starting dynamic subtest: pipe-D-eDP-1 [280.645328] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [280.647234] Subtest overflow-vrefresh: SUCCESS (0.298s) [281.474230] [063/133] (739s left) gem_spin_batch (resubmit-new-all) [281.537131] Starting subtest: resubmit-new-all [281.539557] Starting dynamic subtest: rcs0 [281.553630] Dynamic subtest rcs0: SUCCESS (0.016s) [281.562492] Starting dynamic subtest: bcs0 [281.568280] Dynamic subtest bcs0: SUCCESS (0.013s) [281.583120] Starting dynamic subtest: vcs0 [281.585212] Dynamic subtest vcs0: SUCCESS (0.013s) [281.593605] Starting dynamic subtest: vcs1 [281.595498] Dynamic subtest vcs1: SUCCESS (0.011s) [281.604371] Starting dynamic subtest: vecs0 [281.606620] Dynamic subtest vecs0: SUCCESS (0.009s) [281.614983] Starting dynamic subtest: ccs0 [281.619632] Dynamic subtest ccs0: SUCCESS (0.012s) [281.621775] Subtest resubmit-new-all: SUCCESS (0.081s) [282.939634] [064/133] (738s left) api_intel_bb (simple-bb) [282.991401] Starting subtest: simple-bb [282.993484] Subtest simple-bb: SUCCESS (0.005s) [283.110927] [065/133] (738s left) syncobj_timeline (etime-multi-wait-all-submitted) [283.167661] Starting subtest: etime-multi-wait-all-submitted [283.274270] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s) [283.351381] [066/133] (737s left) kms_big_fb (y-tiled-8bpp-rotate-180) [283.449336] Starting subtest: y-tiled-8bpp-rotate-180 [283.453347] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [283.533096] [067/133] (737s left) kms_psr (fbc-pr-cursor-mmap-gtt) [283.637179] Starting subtest: fbc-pr-cursor-mmap-gtt [283.641485] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [283.712601] [068/133] (737s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [285.268084] Starting subtest: dpms-mode-unset-non-lpsp [286.436769] Subtest dpms-mode-unset-non-lpsp: SKIP (1.166s) [286.823995] [069/133] (734s left) gem_ctx_param (root-set) [286.880854] Starting subtest: root-set [286.883273] Subtest root-set: SUCCESS (0.001s) [286.986658] [070/133] (734s left) syncobj_timeline (device-submit-unordered) [287.051562] Starting subtest: device-submit-unordered [287.053822] Subtest device-submit-unordered: SUCCESS (0.001s) [287.179435] [071/133] (734s left) gem_readwrite (read-write) [287.233607] Subtest read-write: SKIP (0.000s) [287.292782] [072/133] (734s left) gem_exec_schedule (u-submit-late-slice) [287.357840] Starting subtest: u-submit-late-slice [287.359955] Starting dynamic subtest: rcs0 [287.386150] Dynamic subtest rcs0: SUCCESS (0.036s) [287.397156] Starting dynamic subtest: bcs0 [287.422186] Dynamic subtest bcs0: SUCCESS (0.035s) [287.431619] Starting dynamic subtest: vcs0 [287.460486] Dynamic subtest vcs0: SUCCESS (0.038s) [287.469244] Starting dynamic subtest: vcs1 [287.491809] Dynamic subtest vcs1: SUCCESS (0.031s) [287.500459] Starting dynamic subtest: vecs0 [287.522549] Dynamic subtest vecs0: SUCCESS (0.030s) [287.533142] Starting dynamic subtest: ccs0 [287.556827] Dynamic subtest ccs0: SUCCESS (0.033s) [287.559531] Subtest u-submit-late-slice: SUCCESS (0.208s) [288.985592] [073/133] (732s left) sriov_basic (enable-vfs-autoprobe-on) [289.035828] Starting subtest: enable-vfs-autoprobe-on [289.037992] Starting dynamic subtest: numvfs-1 [289.115297] Dynamic subtest numvfs-1: FAIL (0.028s) [289.126091] Starting dynamic subtest: numvfs-2 [289.196982] Dynamic subtest numvfs-2: FAIL (0.003s) [289.207726] Starting dynamic subtest: numvfs-3 [289.281228] Dynamic subtest numvfs-3: FAIL (0.003s) [289.292128] Starting dynamic subtest: numvfs-4 [289.363954] Dynamic subtest numvfs-4: FAIL (0.003s) [289.374586] Starting dynamic subtest: numvfs-5 [289.446861] Dynamic subtest numvfs-5: FAIL (0.004s) [289.457163] Starting dynamic subtest: numvfs-6 [289.525619] Dynamic subtest numvfs-6: FAIL (0.003s) [289.534782] Starting dynamic subtest: numvfs-7 [289.603896] Dynamic subtest numvfs-7: FAIL (0.004s) [289.618887] Starting dynamic subtest: numvfs-random [289.695076] Dynamic subtest numvfs-random: FAIL (0.003s) [289.705097] Starting dynamic subtest: numvfs-all [289.779303] Dynamic subtest numvfs-all: FAIL (0.500s) [289.781332] Subtest enable-vfs-autoprobe-on: FAIL (0.560s) [289.822439] [074/133] (731s left) kms_plane_multiple (2x-tiling-y) [289.922724] Starting subtest: 2x-tiling-y [289.926951] Subtest 2x-tiling-y: SKIP (0.000s) [289.998150] [075/133] (731s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [290.096342] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [290.100042] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [290.209488] [076/133] (731s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [290.300679] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [290.302697] Starting dynamic subtest: pipe-A-eDP-1 [290.323621] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [290.333922] Starting dynamic subtest: pipe-B-eDP-1 [290.352827] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [290.360899] Starting dynamic subtest: pipe-C-eDP-1 [290.381083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [290.388929] Starting dynamic subtest: pipe-D-eDP-1 [290.408992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [290.412385] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [292.478765] [077/133] (729s left) gem_userptr_blits (process-exit-busy) [292.551698] Starting subtest: process-exit-busy [292.564163] Subtest process-exit-busy: SUCCESS (0.014s) [292.705212] [078/133] (728s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [292.800065] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [292.804435] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [292.888749] [079/133] (728s left) kms_vblank (ts-continuation-modeset-rpm) [292.982827] Starting subtest: ts-continuation-modeset-rpm [292.985075] Starting dynamic subtest: pipe-A-eDP-1 [295.473640] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.490s) [295.488414] Starting dynamic subtest: pipe-D-eDP-1 [297.708390] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.232s) [297.710588] Subtest ts-continuation-modeset-rpm: SUCCESS (4.726s) [298.508007] [080/133] (723s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [298.614050] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [299.669863] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.056s) [299.791327] [081/133] (722s left) syncobj_wait (multi-wait-all-for-submit-signaled) [299.841793] Starting subtest: multi-wait-all-for-submit-signaled [299.843754] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [299.932514] [082/133] (721s left) kms_plane (plane-panning-top-left) [300.023214] Starting subtest: plane-panning-top-left [300.024802] Starting dynamic subtest: pipe-A [301.659063] Dynamic subtest pipe-A: SUCCESS (1.635s) [301.668287] Starting dynamic subtest: pipe-B [304.020882] Dynamic subtest pipe-B: SUCCESS (2.362s) [304.023261] Subtest plane-panning-top-left: SUCCESS (4.000s) [304.827399] [083/133] (717s left) gem_exec_parallel (userptr) [304.892817] Starting subtest: userptr [304.895324] Starting dynamic subtest: rcs0 [306.360147] Dynamic subtest rcs0: SUCCESS (1.467s) [306.370537] Starting dynamic subtest: bcs0 [307.835949] Dynamic subtest bcs0: SUCCESS (1.474s) [307.846800] Starting dynamic subtest: vcs0 [309.909234] Dynamic subtest vcs0: SUCCESS (2.071s) [309.920998] Starting dynamic subtest: vcs1 [311.892881] Dynamic subtest vcs1: SUCCESS (1.981s) [311.904607] Starting dynamic subtest: vecs0 [313.877340] Dynamic subtest vecs0: SUCCESS (1.981s) [313.887682] Starting dynamic subtest: ccs0 [315.390084] Dynamic subtest ccs0: SUCCESS (1.511s) [315.392401] Subtest userptr: SUCCESS (10.496s) [315.584343] [084/133] (706s left) kms_hdmi_inject (inject-4k) [315.944656] Starting subtest: inject-4k [316.260523] Subtest inject-4k: SUCCESS (0.316s) [316.792969] [085/133] (705s left) kms_chamelium_edid (hdmi-mode-timings) [317.167807] Subtest hdmi-mode-timings: SKIP (0.000s) [317.942505] [086/133] (704s left) syncobj_wait (multi-wait-for-submit-submitted) [318.003707] Starting subtest: multi-wait-for-submit-submitted [318.105074] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s) [318.187115] [087/133] (703s left) gem_exec_schedule (smoketest-all) [318.265420] Starting subtest: smoketest-all [350.632229] Subtest smoketest-all: SUCCESS (32.325s) [351.940407] [088/133] (670s left) sysfs_heartbeat_interval (mixed) [352.005904] Starting subtest: mixed [352.008245] Starting dynamic subtest: vecs0 [357.223289] Dynamic subtest vecs0: SUCCESS (5.220s) [357.236728] Starting dynamic subtest: ccs0 [362.424279] Dynamic subtest ccs0: SUCCESS (5.198s) [362.435533] Starting dynamic subtest: vcs0 [367.626189] Dynamic subtest vcs0: SUCCESS (5.200s) [367.637656] Starting dynamic subtest: bcs0 [372.868743] Dynamic subtest bcs0: SUCCESS (5.238s) [372.880367] Starting dynamic subtest: rcs0 [378.080919] Dynamic subtest rcs0: SUCCESS (5.212s) [378.091816] Starting dynamic subtest: vcs1 [383.330759] Dynamic subtest vcs1: SUCCESS (5.248s) [383.333206] Subtest mixed: SUCCESS (31.328s) [383.409946] [089/133] (638s left) kms_cursor_crc (cursor-sliding-512x512) [383.678743] Starting subtest: cursor-sliding-512x512 [383.683324] Subtest cursor-sliding-512x512: SKIP (0.001s) [383.830549] [090/133] (638s left) perf (sysctl-defaults) [383.896301] Starting subtest: sysctl-defaults [383.898621] Subtest sysctl-defaults: SUCCESS (0.000s) [383.965107] [091/133] (638s left) gem_ctx_persistence (legacy-engines-hostile) [384.021562] Starting subtest: legacy-engines-hostile [384.023913] Starting dynamic subtest: render [384.105051] Dynamic subtest render: SUCCESS (0.083s) [384.116561] Starting dynamic subtest: bsd1 [384.190740] Dynamic subtest bsd1: SUCCESS (0.083s) [384.205079] Starting dynamic subtest: bsd2 [384.284583] Dynamic subtest bsd2: SUCCESS (0.091s) [384.298698] Starting dynamic subtest: blt [384.379444] Dynamic subtest blt: SUCCESS (0.092s) [384.392713] Starting dynamic subtest: vebox [384.467610] Dynamic subtest vebox: SUCCESS (0.085s) [384.470272] Subtest legacy-engines-hostile: SUCCESS (0.448s) [384.545735] [092/133] (637s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [384.647143] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [384.648984] Starting dynamic subtest: pipe-A-eDP-1 [384.768038] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s) [384.778930] Starting dynamic subtest: pipe-B-eDP-1 [385.908497] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s) [385.912862] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.261s) [387.055122] [093/133] (635s left) kms_flip (basic-flip-vs-dpms) [387.155403] Starting subtest: basic-flip-vs-dpms [387.157736] Starting dynamic subtest: A-eDP1 [389.698470] Dynamic subtest A-eDP1: SUCCESS (2.539s) [389.709181] Starting dynamic subtest: B-eDP1 [391.892451] Dynamic subtest B-eDP1: SUCCESS (2.193s) [391.902520] Starting dynamic subtest: C-eDP1 [394.100819] Dynamic subtest C-eDP1: SUCCESS (2.207s) [394.112524] Starting dynamic subtest: D-eDP1 [396.303310] Dynamic subtest D-eDP1: SUCCESS (2.201s) [396.305594] Subtest basic-flip-vs-dpms: SUCCESS (9.150s) [397.148181] [094/133] (625s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [397.240294] Starting subtest: plane-scaler-with-clipping-clamping-rotation [397.242617] Starting dynamic subtest: pipe-A [397.488785] Dynamic subtest pipe-A: SUCCESS (0.251s) [397.498916] Starting dynamic subtest: pipe-B [398.803293] Dynamic subtest pipe-B: SUCCESS (1.313s) [398.812496] Starting dynamic subtest: pipe-C [400.112119] Dynamic subtest pipe-C: SUCCESS (1.308s) [400.122054] Starting dynamic subtest: pipe-D [401.415302] Dynamic subtest pipe-D: SUCCESS (1.303s) [401.417529] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.178s) [402.567735] [095/133] (619s left) gem_mmap_gtt (cpuset-basic-small-copy) [402.622348] Subtest cpuset-basic-small-copy: SKIP (0.000s) [402.681422] [096/133] (619s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [402.768467] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [409.489407] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.722s) [409.647894] [097/133] (612s left) gem_exec_fence (syncobj-channel) [410.095450] Starting subtest: syncobj-channel [411.111084] Subtest syncobj-channel: SUCCESS (1.014s) [411.995401] [098/133] (610s left) gem_ctx_param (invalid-get-engines) [412.046466] Starting subtest: invalid-get-engines [412.048683] Subtest invalid-get-engines: SUCCESS (0.001s) [412.145237] [099/133] (610s left) gem_exec_flush (basic-wb-rw-before-default) [412.195017] Starting subtest: basic-wb-rw-before-default [417.651206] Subtest basic-wb-rw-before-default: SUCCESS (5.457s) [417.843386] [100/133] (604s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [417.947307] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [417.952020] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [418.021937] [101/133] (604s left) gem_mmap_gtt (zero-extend) [418.077322] Subtest zero-extend: SKIP (0.000s) [418.141457] [102/133] (604s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [418.237152] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [419.215725] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.978s) [419.350761] [103/133] (603s left) gem_exec_flush (basic-batch-kernel-default-uc) [419.414665] Starting subtest: basic-batch-kernel-default-uc [426.391397] Subtest basic-batch-kernel-default-uc: SUCCESS (6.976s) [426.592378] [104/133] (596s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [426.688388] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [426.692698] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [426.776766] [105/133] (596s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [426.877348] Starting subtest: flip-vs-dpms-on-nop-interruptible [426.882126] Starting dynamic subtest: A-eDP1 [428.715494] Dynamic subtest A-eDP1: SUCCESS (1.835s) [428.727147] Starting dynamic subtest: B-eDP1 [430.514575] Dynamic subtest B-eDP1: SUCCESS (1.798s) [430.524735] Starting dynamic subtest: C-eDP1 [432.318306] Dynamic subtest C-eDP1: SUCCESS (1.802s) [432.328181] Starting dynamic subtest: D-eDP1 [434.114574] Dynamic subtest D-eDP1: SUCCESS (1.793s) [434.119678] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.240s) [435.352593] [106/133] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [435.456799] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [441.914101] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.460s) [442.034714] [107/133] (580s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [442.143264] Starting subtest: psr-rgb101010-draw-mmap-gtt [442.147615] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [442.249697] [108/133] (580s left) i915_drm_fdinfo (virtual-busy) [442.286851] Starting subtest: virtual-busy [442.291302] Subtest virtual-busy: SKIP (0.000s) [442.360684] [109/133] (580s left) gem_mmap_gtt (basic-small-copy-odd) [442.414484] Subtest basic-small-copy-odd: SKIP (0.000s) [442.478962] [110/133] (580s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [442.581970] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [442.586328] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [442.692686] [111/133] (580s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [442.773895] Starting subtest: basic-max-pipe-crc-check [442.778264] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [442.822204] [112/133] (580s left) api_intel_allocator (fork-simple-stress-signal) [442.885591] Starting subtest: fork-simple-stress-signal [448.287920] Subtest fork-simple-stress-signal: SUCCESS (5.402s) [448.416300] [113/133] (574s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [448.517061] Starting subtest: primary-y-tiled-reflect-x-0 [448.576447] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s) [448.681666] [114/133] (574s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [448.785129] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [455.911614] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.128s) [456.013232] [115/133] (567s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping) [456.115824] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping [456.120266] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [456.186129] [116/133] (567s left) gem_create (create-ext-placement-all) [456.356843] Starting subtest: create-ext-placement-all [456.358969] Subtest create-ext-placement-all: SUCCESS (0.000s) [456.466788] [117/133] (566s left) gem_ctx_create (basic) [456.535606] Starting subtest: basic [456.538034] Subtest basic: SUCCESS (0.000s) [456.714764] [118/133] (566s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [456.775619] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [456.777797] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [456.872031] [119/133] (566s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [456.921955] Starting subtest: invalid-multi-wait-unsubmitted-submitted [456.924201] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [457.033859] [120/133] (566s left) gen9_exec_parse (bb-secure) [457.100158] Subtest bb-secure: SKIP (0.000s) [457.171656] [121/133] (566s left) kms_psr (pr-primary-page-flip) [457.262973] Starting subtest: pr-primary-page-flip [457.267225] Subtest pr-primary-page-flip: SKIP (0.000s) [457.331547] [122/133] (566s left) kms_flip (blocking-wf_vblank) [457.412280] Starting subtest: blocking-wf_vblank [457.414727] Starting dynamic subtest: A-eDP1 [466.374243] Dynamic subtest A-eDP1: SUCCESS (8.961s) [466.387643] Starting dynamic subtest: B-eDP1 [475.272642] Dynamic subtest B-eDP1: SUCCESS (8.895s) [475.283235] Starting dynamic subtest: C-eDP1 [484.149889] Dynamic subtest C-eDP1: SUCCESS (8.876s) [484.170321] Starting dynamic subtest: D-eDP1 [493.052335] Dynamic subtest D-eDP1: SUCCESS (8.899s) [493.058474] Subtest blocking-wf_vblank: SUCCESS (35.644s) [494.259532] [123/133] (529s left) kms_color_pipeline (plane-lut1d-lut1d) [494.367384] Starting subtest: plane-lut1d-lut1d [494.491885] Starting dynamic subtest: pipe-A-plane-0 [494.659614] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [494.668892] Starting dynamic subtest: pipe-A-plane-1 [494.848544] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s) [494.861729] Starting dynamic subtest: pipe-A-plane-2 [495.036491] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [496.208515] Starting dynamic subtest: pipe-B-plane-0 [496.367864] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [496.377205] Starting dynamic subtest: pipe-B-plane-1 [496.556193] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [496.566265] Starting dynamic subtest: pipe-B-plane-2 [496.689243] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s) [497.901424] Starting dynamic subtest: pipe-C-plane-0 [498.048690] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [498.058454] Starting dynamic subtest: pipe-C-plane-1 [498.193305] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [498.202944] Starting dynamic subtest: pipe-C-plane-2 [498.326349] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s) [499.520843] Starting dynamic subtest: pipe-D-plane-0 [499.680373] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s) [499.689833] Starting dynamic subtest: pipe-D-plane-1 [499.847331] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [499.856660] Starting dynamic subtest: pipe-D-plane-2 [499.980346] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s) [500.267177] Subtest plane-lut1d-lut1d: SUCCESS (5.898s) [501.154452] [124/133] (522s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [501.257237] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [507.685947] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.432s) [507.809921] [125/133] (515s left) kms_universal_plane (universal-plane-functional) [507.909537] Starting subtest: universal-plane-functional [507.911630] Starting dynamic subtest: pipe-A-eDP-1 [511.833311] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.924s) [511.844095] Starting dynamic subtest: pipe-B-eDP-1 [516.238717] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.402s) [516.248512] Starting dynamic subtest: pipe-C-eDP-1 [520.499866] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.260s) [520.511224] Starting dynamic subtest: pipe-D-eDP-1 [525.017652] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.517s) [525.020170] Subtest universal-plane-functional: SUCCESS (17.109s) [525.848834] [126/133] (497s left) kms_lease (lease-unleased-connector) [525.944960] Starting subtest: lease-unleased-connector [525.947179] Starting dynamic subtest: pipe-A-eDP-1 [525.949236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [525.963120] Starting dynamic subtest: pipe-B-eDP-1 [525.965300] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [525.974644] Starting dynamic subtest: pipe-C-eDP-1 [525.976900] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [525.985766] Starting dynamic subtest: pipe-D-eDP-1 [525.987894] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s) [525.990160] Subtest lease-unleased-connector: SUCCESS (0.034s) [526.089568] [127/133] (497s left) gem_exec_reloc (basic-gtt-wc-active) [526.156179] Subtest basic-gtt-wc-active: SKIP (0.000s) [526.231706] [128/133] (497s left) kms_getfb (getfb-handle-zero) [526.321799] Starting subtest: getfb-handle-zero [526.324047] Subtest getfb-handle-zero: SUCCESS (0.000s) [526.438175] [129/133] (497s left) i915_pm_rps (reset) [526.494632] Starting subtest: reset [534.931956] Subtest reset: SUCCESS (8.435s) [535.046480] [130/133] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [535.140979] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [541.727373] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.587s) [541.856554] [131/133] (482s left) kms_async_flips (test-cursor-atomic) [541.948842] Starting subtest: test-cursor-atomic [542.332606] Starting dynamic subtest: pipe-A-eDP-1 [543.109590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.778s) [543.502529] Starting dynamic subtest: pipe-B-eDP-1 [544.300381] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.807s) [544.672618] Starting dynamic subtest: pipe-C-eDP-1 [545.415636] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.751s) [545.799323] Starting dynamic subtest: pipe-D-eDP-1 [546.603503] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.811s) [546.605854] Subtest test-cursor-atomic: SUCCESS (4.656s) [547.757572] [132/133] (476s left) gem_exec_reloc (basic-gtt-wc) [547.828222] Subtest basic-gtt-wc: SKIP (0.000s) [547.915206] [133/133] (476s left) fbdev (pan) [547.950749] Starting subtest: pan [547.975094] Subtest pan: SUCCESS (0.027s) [548.068108] 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.