[59.725965] Initializing watchdogs [59.726037] /dev/watchdog0 [59.739656] [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] [59.744141] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.746529] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.750132] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [60.162546] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [60.979119] [002/133] (959s left) i915_power (sanity) [61.046676] Starting subtest: sanity [65.093347] Subtest sanity: SUCCESS (4.042s) [66.949188] [003/133] (953s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [67.188789] Subtest no-spare-fences-interruptible: SKIP (0.000s) [67.555435] [004/133] (952s left) i915_module_load (resize-bar) [67.602593] Starting subtest: resize-bar [67.614571] Subtest resize-bar: SKIP (0.010s) [67.665107] [005/133] (952s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [67.813934] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [67.818351] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [67.971685] [006/133] (952s left) gem_fenced_exec_thrash (no-spare-fences) [68.030345] Subtest no-spare-fences: SKIP (0.000s) [68.083672] [007/133] (952s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [68.178368] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [68.180560] Starting dynamic subtest: pipe-A-eDP-1 [68.189614] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [68.198920] Starting dynamic subtest: pipe-B-eDP-1 [68.207318] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [68.214151] Starting dynamic subtest: pipe-C-eDP-1 [68.222203] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [68.228750] Starting dynamic subtest: pipe-D-eDP-1 [68.236722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [68.240686] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s) [70.393186] [008/133] (950s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [70.491840] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [70.496049] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [70.610014] [009/133] (949s left) perf_pmu (busy-accuracy-50) [70.654150] Starting subtest: busy-accuracy-50 [70.656091] Starting dynamic subtest: rcs0 [72.182548] Dynamic subtest rcs0: SUCCESS (1.527s) [72.193542] Starting dynamic subtest: bcs0 [73.729964] Dynamic subtest bcs0: SUCCESS (1.547s) [73.740329] Starting dynamic subtest: vcs0 [75.268825] Dynamic subtest vcs0: SUCCESS (1.539s) [75.278480] Starting dynamic subtest: vcs1 [76.811481] Dynamic subtest vcs1: SUCCESS (1.542s) [76.820914] Starting dynamic subtest: vecs0 [78.353794] Dynamic subtest vecs0: SUCCESS (1.542s) [78.363361] Starting dynamic subtest: ccs0 [79.895518] Dynamic subtest ccs0: SUCCESS (1.541s) [79.898118] Subtest busy-accuracy-50: SUCCESS (9.241s) [80.005960] [010/133] (940s left) kms_flip (2x-nonexisting-fb-interruptible) [80.112836] Starting subtest: 2x-nonexisting-fb-interruptible [80.123726] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s) [80.207350] [011/133] (940s left) gem_exec_whisper (basic-queues-priority-all) [80.269272] Starting subtest: basic-queues-priority-all [102.093881] Subtest basic-queues-priority-all: SUCCESS (21.822s) [102.272970] [012/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [102.381758] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [102.386287] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [102.475146] [013/133] (918s left) kms_psr (psr2-primary-render) [102.568062] Starting subtest: psr2-primary-render [102.570362] Starting dynamic subtest: eDP-1 [104.282668] Dynamic subtest eDP-1: SUCCESS (1.716s) [104.285085] Subtest psr2-primary-render: SUCCESS (1.716s) [105.152645] [014/133] (915s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [105.249877] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [105.254154] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [105.340306] [015/133] (915s left) syncobj_wait (single-wait-signaled) [105.397730] Starting subtest: single-wait-signaled [105.399859] Subtest single-wait-signaled: SUCCESS (0.000s) [105.487603] [016/133] (915s left) kms_properties (plane-properties-legacy) [105.566920] Starting subtest: plane-properties-legacy [105.569236] Starting dynamic subtest: pipe-A-eDP-1 [106.139474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s) [106.147194] Starting dynamic subtest: pipe-B-eDP-1 [107.432532] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.291s) [107.444121] Starting dynamic subtest: pipe-C-eDP-1 [108.663194] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.231s) [108.671074] Starting dynamic subtest: pipe-D-eDP-1 [109.894493] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s) [109.896832] Subtest plane-properties-legacy: SUCCESS (4.328s) [110.688463] [017/133] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [110.782979] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [110.786999] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [110.869253] [018/133] (910s left) kms_prime (basic-modeset-hybrid) [110.950998] Subtest basic-modeset-hybrid: SKIP (0.000s) [111.068265] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true [111.071135] [019/133] (909s left) syncobj_timeline (wait-all-for-submit-snapshot) [111.132206] Starting subtest: wait-all-for-submit-snapshot [111.215861] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s) [111.289924] [020/133] (909s left) gem_exec_schedule (semaphore-power) [111.472568] Subtest semaphore-power: SKIP (0.000s) [111.659395] [021/133] (909s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [111.753474] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [115.670594] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.920s) [116.806971] [022/133] (904s left) kms_cursor_crc (cursor-onscreen-512x512) [117.082661] Starting subtest: cursor-onscreen-512x512 [117.087342] Subtest cursor-onscreen-512x512: SKIP (0.001s) [117.252247] [023/133] (903s left) kms_big_fb (linear-32bpp-rotate-180) [117.374070] Starting subtest: linear-32bpp-rotate-180 [118.975090] Subtest linear-32bpp-rotate-180: SUCCESS (1.601s) [119.115466] [024/133] (902s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [119.165600] Starting subtest: multi-wait-all-for-submit-submitted-signaled [119.273633] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s) [119.351353] [025/133] (901s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [119.404272] Starting subtest: mixed-tiled-to-y-tiled-ccs [119.408886] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [119.588751] [026/133] (901s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [119.651614] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [119.734703] [027/133] (901s left) gem_partial_pwrite_pread (reads-display) [119.792608] Subtest reads-display: SKIP (0.000s) [119.853183] [028/133] (901s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [119.977751] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [119.982153] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [120.128312] [029/133] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [120.226057] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [120.230098] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [120.336161] [030/133] (901s left) drm_buddy (drm_buddy) [120.367600] Starting subtest: drm_buddy [120.371859] Subtest drm_buddy: SKIP (0.001s) [120.421172] [031/133] (901s left) gem_userptr_blits (set-cache-level) [120.481552] Starting subtest: set-cache-level [120.485679] Subtest set-cache-level: SKIP (0.000s) [120.602211] [032/133] (900s left) kms_addfb_basic (bad-pitch-1024) [120.652171] Starting subtest: bad-pitch-1024 [120.653734] Subtest bad-pitch-1024: SUCCESS (0.000s) [120.772287] [033/133] (900s left) gem_exec_alignment (forked) [120.829377] Starting subtest: forked [158.224636] Subtest forked: SUCCESS (37.392s) [158.520816] [034/133] (863s left) prime_self_import (basic-with_one_bo) [158.589805] Starting subtest: basic-with_one_bo [158.602671] Subtest basic-with_one_bo: SUCCESS (0.015s) [158.709547] [035/133] (862s left) gem_exec_schedule (in-order) [158.791809] Starting subtest: in-order [158.794079] Starting dynamic subtest: rcs0 [158.953316] Dynamic subtest rcs0: SUCCESS (0.165s) [158.965667] Starting dynamic subtest: vcs0 [159.052072] Dynamic subtest vcs0: SUCCESS (0.099s) [159.062774] Starting dynamic subtest: vcs1 [159.161816] Dynamic subtest vcs1: SUCCESS (0.110s) [159.172925] Starting dynamic subtest: vecs0 [159.273206] Dynamic subtest vecs0: SUCCESS (0.110s) [159.284867] Starting dynamic subtest: ccs0 [159.396918] Dynamic subtest ccs0: SUCCESS (0.124s) [159.399521] Subtest in-order: SUCCESS (0.609s) [161.009407] [036/133] (860s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [161.107616] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [161.109838] Starting dynamic subtest: pipe-A-eDP-1 [161.166463] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [161.177637] Starting dynamic subtest: pipe-B-eDP-1 [161.233996] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [161.243299] Starting dynamic subtest: pipe-C-eDP-1 [161.301498] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [161.310945] Starting dynamic subtest: pipe-D-eDP-1 [161.368538] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [161.373086] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [163.275215] [037/133] (858s left) gem_softpin (32b-excludes-last-page) [163.346519] Starting subtest: 32b-excludes-last-page [163.351225] Subtest 32b-excludes-last-page: SUCCESS (0.004s) [163.482364] [038/133] (858s left) kms_rotation_crc (primary-rotation-90) [163.581024] Starting subtest: primary-rotation-90 [163.585256] Subtest primary-rotation-90: SKIP (0.001s) [163.651822] [039/133] (858s left) kms_psr (fbc-psr-cursor-render) [163.740362] Starting subtest: fbc-psr-cursor-render [163.742294] Starting dynamic subtest: eDP-1 [163.746328] Dynamic subtest eDP-1: SKIP (0.000s) [163.750442] Subtest fbc-psr-cursor-render: SKIP (0.000s) [163.813752] [040/133] (857s left) kms_psr (fbc-pr-sprite-mmap-gtt) [163.904531] Starting subtest: fbc-pr-sprite-mmap-gtt [163.908519] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [163.975845] [041/133] (857s left) kms_draw_crc (draw-method-mmap-cpu) [164.076448] Starting subtest: draw-method-mmap-cpu [164.078661] Starting dynamic subtest: xrgb8888-untiled [164.321719] Dynamic subtest xrgb8888-untiled: SUCCESS (0.247s) [164.329563] Starting dynamic subtest: rgb565-untiled [164.543795] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [164.553414] Starting dynamic subtest: xrgb2101010-untiled [164.843742] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.299s) [164.851968] Starting dynamic subtest: xbgr16161616f-untiled [165.066206] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [165.075077] Starting dynamic subtest: xrgb8888-xtiled [165.188313] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [165.198141] Starting dynamic subtest: rgb565-xtiled [165.321675] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [165.330176] Starting dynamic subtest: xrgb2101010-xtiled [165.443894] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [165.452586] Starting dynamic subtest: xbgr16161616f-xtiled [165.577133] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [165.585981] Starting dynamic subtest: xrgb8888-4tiled [165.722154] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [165.731092] Starting dynamic subtest: rgb565-4tiled [165.866093] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s) [165.874939] Starting dynamic subtest: xrgb2101010-4tiled [165.989190] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s) [166.003609] Starting dynamic subtest: xbgr16161616f-4tiled [166.144377] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.154s) [166.146588] Subtest draw-method-mmap-cpu: SUCCESS (2.070s) [166.260265] [042/133] (855s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [166.365498] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [166.367439] Starting dynamic subtest: pipe-A-eDP-1 [166.387034] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [166.396756] Starting dynamic subtest: pipe-B-eDP-1 [166.414873] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [166.422341] Starting dynamic subtest: pipe-C-eDP-1 [166.439994] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [166.447297] Starting dynamic subtest: pipe-D-eDP-1 [166.465652] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [166.469043] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [168.647793] [043/133] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [168.759314] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [191.612229] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.857s) [191.746500] [044/133] (830s left) gem_exec_capture (capture) [191.828850] Starting subtest: capture [191.830842] Starting dynamic subtest: rcs0-smem [192.663983] Dynamic subtest rcs0-smem: SUCCESS (0.833s) [192.674209] Starting dynamic subtest: bcs0-smem [193.979646] Dynamic subtest bcs0-smem: SUCCESS (1.317s) [193.990117] Starting dynamic subtest: vcs0-smem [194.813187] Dynamic subtest vcs0-smem: SUCCESS (0.831s) [194.822347] Starting dynamic subtest: vcs1-smem [195.629638] Dynamic subtest vcs1-smem: SUCCESS (0.818s) [195.640372] Starting dynamic subtest: vecs0-smem [197.021637] Dynamic subtest vecs0-smem: FAIL (1.330s) [197.031692] Starting dynamic subtest: ccs0-smem [198.282714] Dynamic subtest ccs0-smem: SUCCESS (1.320s) [198.285173] Subtest capture: FAIL (6.452s) [198.403182] [045/133] (823s left) perf_pmu (busy-hang) [198.446586] Starting subtest: busy-hang [198.449251] Starting dynamic subtest: rcs0 [199.682945] Dynamic subtest rcs0: SUCCESS (1.235s) [199.693239] Starting dynamic subtest: bcs0 [200.884622] Dynamic subtest bcs0: SUCCESS (1.199s) [200.892960] Starting dynamic subtest: vcs0 [203.419897] Dynamic subtest vcs0: SUCCESS (2.534s) [203.430055] Starting dynamic subtest: vcs1 [205.404250] Dynamic subtest vcs1: SUCCESS (1.986s) [205.420067] Starting dynamic subtest: vecs0 [207.444422] Dynamic subtest vecs0: SUCCESS (2.037s) [207.454907] Starting dynamic subtest: ccs0 [208.650464] Dynamic subtest ccs0: SUCCESS (1.201s) [208.652920] Subtest busy-hang: SUCCESS (10.203s) [208.788991] [046/133] (813s left) prime_vgem (basic-write) [208.859160] Starting subtest: basic-write [208.882418] Subtest basic-write: SKIP (0.021s) [209.011728] [047/133] (813s left) gem_exec_await (wide-all) [209.241760] Starting subtest: wide-all [232.624083] Subtest wide-all: SUCCESS (23.382s) [232.812786] [048/133] (789s left) kms_dirtyfb (psr-dirtyfb-ioctl) [232.950050] Starting subtest: psr-dirtyfb-ioctl [232.952328] Starting dynamic subtest: A-eDP-1 [236.838565] Dynamic subtest A-eDP-1: SUCCESS (3.886s) [236.840577] Subtest psr-dirtyfb-ioctl: SUCCESS (3.887s) [237.652524] [049/133] (784s left) kms_cursor_crc (cursor-size-hints) [237.778775] Starting subtest: cursor-size-hints [237.780871] Starting dynamic subtest: pipe-A-eDP-1 [238.429337] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.651s) [238.438563] Starting dynamic subtest: pipe-D-eDP-1 [239.716762] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s) [239.719252] Subtest cursor-size-hints: SUCCESS (1.941s) [240.503355] [050/133] (781s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [240.603442] Starting subtest: addfb25-y-tiled-small-legacy [240.607609] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [240.696981] [051/133] (781s left) kms_psr (psr-primary-mmap-cpu) [240.790745] Starting subtest: psr-primary-mmap-cpu [240.793060] Starting dynamic subtest: eDP-1 [242.501483] Dynamic subtest eDP-1: SUCCESS (1.711s) [242.503707] Subtest psr-primary-mmap-cpu: SUCCESS (1.712s) [243.362959] [052/133] (778s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [243.454782] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [243.459189] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [243.551062] [053/133] (778s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [243.662351] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [244.342370] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s) [244.509254] [054/133] (777s left) gem_exec_balancer (bonded-false-hang) [244.772741] Starting subtest: bonded-false-hang [244.778257] Subtest bonded-false-hang: SKIP (0.000s) [244.881834] [055/133] (777s left) kms_getfb (getfb2-accept-nv12) [244.975206] Starting subtest: getfb2-accept-nv12 [244.977332] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [245.062945] [056/133] (777s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [245.120935] Subtest writes-after-reads: SKIP (0.000s) [245.200960] [057/133] (777s left) kms_content_protection (suspend-resume) [245.339072] Starting subtest: suspend-resume [245.343591] Subtest suspend-resume: SKIP (0.000s) [245.461249] [058/133] (777s left) gem_mmap_wc (bad-offset) [245.516619] Subtest bad-offset: SKIP (0.000s) [245.574448] [059/133] (777s left) gem_ppgtt (blt-vs-render-ctxn) [245.628704] Starting subtest: blt-vs-render-ctxN [278.296088] Subtest blt-vs-render-ctxN: SUCCESS (32.663s) [278.433651] [060/133] (744s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [278.564721] Starting subtest: crc-primary-basic-y-tiled-ccs [278.567236] Starting dynamic subtest: pipe-A-eDP-1 [278.589994] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [278.600780] Starting dynamic subtest: pipe-B-eDP-1 [278.621219] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [278.629535] Starting dynamic subtest: pipe-C-eDP-1 [278.651310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [278.659463] Starting dynamic subtest: pipe-D-eDP-1 [278.682890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [278.687346] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.007s) [280.833854] [061/133] (741s left) perf (whitelisted-registers-userspace-config) [280.988844] Starting subtest: whitelisted-registers-userspace-config [280.991110] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [281.030658] [062/133] (741s left) kms_invalid_mode (overflow-vrefresh) [281.125945] Starting subtest: overflow-vrefresh [281.128069] Starting dynamic subtest: pipe-A-eDP-1 [281.409716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [281.418867] Starting dynamic subtest: pipe-B-eDP-1 [281.421063] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [281.429492] Starting dynamic subtest: pipe-C-eDP-1 [281.431649] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [281.440425] Starting dynamic subtest: pipe-D-eDP-1 [281.442753] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [281.445110] Subtest overflow-vrefresh: SUCCESS (0.290s) [282.255323] [063/133] (740s left) gem_spin_batch (resubmit-new-all) [282.315707] Starting subtest: resubmit-new-all [282.318073] Starting dynamic subtest: rcs0 [282.329109] Dynamic subtest rcs0: SUCCESS (0.012s) [282.340510] Starting dynamic subtest: bcs0 [282.342477] Dynamic subtest bcs0: SUCCESS (0.009s) [282.350610] Starting dynamic subtest: vcs0 [282.353044] Dynamic subtest vcs0: SUCCESS (0.012s) [282.361292] Starting dynamic subtest: vcs1 [282.365767] Dynamic subtest vcs1: SUCCESS (0.013s) [282.373961] Starting dynamic subtest: vecs0 [282.376400] Dynamic subtest vecs0: SUCCESS (0.009s) [282.384804] Starting dynamic subtest: ccs0 [282.395906] Dynamic subtest ccs0: SUCCESS (0.019s) [282.398423] Subtest resubmit-new-all: SUCCESS (0.082s) [283.965764] [064/133] (738s left) api_intel_bb (simple-bb) [284.023578] Starting subtest: simple-bb [284.028470] Subtest simple-bb: SUCCESS (0.006s) [284.149277] [065/133] (738s left) syncobj_timeline (etime-multi-wait-all-submitted) [284.207581] Starting subtest: etime-multi-wait-all-submitted [284.314431] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s) [284.401493] [066/133] (738s left) kms_big_fb (y-tiled-8bpp-rotate-180) [284.513659] Starting subtest: y-tiled-8bpp-rotate-180 [284.517960] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [284.609886] [067/133] (738s left) kms_psr (fbc-pr-cursor-mmap-gtt) [284.718121] Starting subtest: fbc-pr-cursor-mmap-gtt [284.722527] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [284.791640] [068/133] (738s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [287.073569] Starting subtest: dpms-mode-unset-non-lpsp [288.234313] Subtest dpms-mode-unset-non-lpsp: SKIP (1.160s) [288.612059] [069/133] (734s left) gem_ctx_param (root-set) [288.662805] Starting subtest: root-set [288.665063] Subtest root-set: SUCCESS (0.001s) [288.755900] [070/133] (734s left) syncobj_timeline (device-submit-unordered) [288.822886] Starting subtest: device-submit-unordered [288.825135] Subtest device-submit-unordered: SUCCESS (0.000s) [288.918647] [071/133] (734s left) gem_readwrite (read-write) [288.987019] Subtest read-write: SKIP (0.000s) [289.047612] [072/133] (734s left) gem_exec_schedule (u-submit-late-slice) [289.129059] Starting subtest: u-submit-late-slice [289.131352] Starting dynamic subtest: rcs0 [289.164156] Dynamic subtest rcs0: SUCCESS (0.045s) [289.174910] Starting dynamic subtest: bcs0 [289.201160] Dynamic subtest bcs0: SUCCESS (0.036s) [289.210229] Starting dynamic subtest: vcs0 [289.237497] Dynamic subtest vcs0: SUCCESS (0.036s) [289.247266] Starting dynamic subtest: vcs1 [289.270383] Dynamic subtest vcs1: SUCCESS (0.032s) [289.282078] Starting dynamic subtest: vecs0 [289.303204] Dynamic subtest vecs0: SUCCESS (0.032s) [289.312400] Starting dynamic subtest: ccs0 [289.342947] Dynamic subtest ccs0: SUCCESS (0.039s) [289.345246] Subtest u-submit-late-slice: SUCCESS (0.224s) [290.919242] [073/133] (732s left) sriov_basic (enable-vfs-autoprobe-on) [290.979257] Starting subtest: enable-vfs-autoprobe-on [290.981623] Starting dynamic subtest: numvfs-1 [291.064597] Dynamic subtest numvfs-1: FAIL (0.034s) [291.073264] Starting dynamic subtest: numvfs-2 [291.147553] Dynamic subtest numvfs-2: FAIL (0.003s) [291.157934] Starting dynamic subtest: numvfs-3 [291.231292] Dynamic subtest numvfs-3: FAIL (0.003s) [291.241160] Starting dynamic subtest: numvfs-4 [291.314310] Dynamic subtest numvfs-4: FAIL (0.003s) [291.324990] Starting dynamic subtest: numvfs-5 [291.398857] Dynamic subtest numvfs-5: FAIL (0.003s) [291.408625] Starting dynamic subtest: numvfs-6 [291.483578] Dynamic subtest numvfs-6: FAIL (0.003s) [291.494576] Starting dynamic subtest: numvfs-7 [291.567397] Dynamic subtest numvfs-7: FAIL (0.003s) [291.577430] Starting dynamic subtest: numvfs-random [291.648961] Dynamic subtest numvfs-random: FAIL (0.004s) [291.659843] Starting dynamic subtest: numvfs-all [291.732044] Dynamic subtest numvfs-all: FAIL (0.516s) [291.734085] Subtest enable-vfs-autoprobe-on: FAIL (0.581s) [291.772891] [074/133] (731s left) kms_plane_multiple (2x-tiling-y) [291.863712] Starting subtest: 2x-tiling-y [291.867835] Subtest 2x-tiling-y: SKIP (0.000s) [291.933314] [075/133] (731s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [292.039238] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [292.042795] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [292.141798] [076/133] (731s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [292.234347] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [292.236208] Starting dynamic subtest: pipe-A-eDP-1 [292.256232] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [292.266523] Starting dynamic subtest: pipe-B-eDP-1 [292.285256] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [292.293535] Starting dynamic subtest: pipe-C-eDP-1 [292.312134] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [292.320388] Starting dynamic subtest: pipe-D-eDP-1 [292.340361] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [292.343748] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [294.387925] [077/133] (728s left) gem_userptr_blits (process-exit-busy) [294.444540] Starting subtest: process-exit-busy [294.454156] Subtest process-exit-busy: SUCCESS (0.014s) [294.582989] [078/133] (728s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [294.693505] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [294.697797] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [294.792985] [079/133] (728s left) kms_vblank (ts-continuation-modeset-rpm) [294.895598] Starting subtest: ts-continuation-modeset-rpm [294.897538] Starting dynamic subtest: pipe-A-eDP-1 [297.402989] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.509s) [297.417816] Starting dynamic subtest: pipe-D-eDP-1 [299.634338] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.229s) [299.636722] Subtest ts-continuation-modeset-rpm: SUCCESS (4.742s) [300.433815] [080/133] (723s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [300.537489] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [301.648788] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.111s) [301.784153] [081/133] (721s left) syncobj_wait (multi-wait-all-for-submit-signaled) [301.835069] Starting subtest: multi-wait-all-for-submit-signaled [301.836872] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [301.923432] [082/133] (721s left) kms_plane (plane-panning-top-left) [302.016271] Starting subtest: plane-panning-top-left [302.017897] Starting dynamic subtest: pipe-A [303.705534] Dynamic subtest pipe-A: SUCCESS (1.689s) [303.715633] Starting dynamic subtest: pipe-B [306.103526] Dynamic subtest pipe-B: SUCCESS (2.396s) [306.105791] Subtest plane-panning-top-left: SUCCESS (4.088s) [306.981620] [083/133] (716s left) gem_exec_parallel (userptr) [307.049335] Starting subtest: userptr [307.051977] Starting dynamic subtest: rcs0 [308.483833] Dynamic subtest rcs0: SUCCESS (1.438s) [308.495706] Starting dynamic subtest: bcs0 [309.965677] Dynamic subtest bcs0: SUCCESS (1.480s) [309.985708] Starting dynamic subtest: vcs0 [311.912284] Dynamic subtest vcs0: SUCCESS (1.942s) [311.923996] Starting dynamic subtest: vcs1 [313.876334] Dynamic subtest vcs1: SUCCESS (1.961s) [313.887764] Starting dynamic subtest: vecs0 [315.925118] Dynamic subtest vecs0: SUCCESS (2.048s) [315.935448] Starting dynamic subtest: ccs0 [317.420401] Dynamic subtest ccs0: SUCCESS (1.494s) [317.422732] Subtest userptr: SUCCESS (10.375s) [317.608263] [084/133] (706s left) kms_hdmi_inject (inject-4k) [317.967952] Starting subtest: inject-4k [318.286055] Subtest inject-4k: SUCCESS (0.319s) [318.841479] [085/133] (704s left) kms_chamelium_edid (hdmi-mode-timings) [319.230722] Subtest hdmi-mode-timings: SKIP (0.000s) [320.006794] [086/133] (703s left) syncobj_wait (multi-wait-for-submit-submitted) [320.061760] Starting subtest: multi-wait-for-submit-submitted [320.168337] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s) [320.244732] [087/133] (703s left) gem_exec_schedule (smoketest-all) [320.314927] Starting subtest: smoketest-all [352.707313] Subtest smoketest-all: SUCCESS (32.348s) [352.954815] [088/133] (670s left) sysfs_heartbeat_interval (mixed) [353.016642] Starting subtest: mixed [353.019227] Starting dynamic subtest: vecs0 [358.268150] Dynamic subtest vecs0: SUCCESS (5.251s) [358.279462] Starting dynamic subtest: ccs0 [363.443908] Dynamic subtest ccs0: SUCCESS (5.173s) [363.455229] Starting dynamic subtest: vcs0 [368.666246] Dynamic subtest vcs0: SUCCESS (5.220s) [368.679190] Starting dynamic subtest: bcs0 [373.876905] Dynamic subtest bcs0: SUCCESS (5.208s) [373.887671] Starting dynamic subtest: rcs0 [379.078931] Dynamic subtest rcs0: SUCCESS (5.201s) [379.090645] Starting dynamic subtest: vcs1 [384.328543] Dynamic subtest vcs1: SUCCESS (5.248s) [384.331344] Subtest mixed: SUCCESS (31.313s) [384.460300] [089/133] (639s left) kms_cursor_crc (cursor-sliding-512x512) [384.750646] Starting subtest: cursor-sliding-512x512 [384.754928] Subtest cursor-sliding-512x512: SKIP (0.001s) [384.913582] [090/133] (639s left) perf (sysctl-defaults) [384.980081] Starting subtest: sysctl-defaults [384.982416] Subtest sysctl-defaults: SUCCESS (0.000s) [385.053526] [091/133] (638s left) gem_ctx_persistence (legacy-engines-hostile) [385.103836] Starting subtest: legacy-engines-hostile [385.106167] Starting dynamic subtest: render [385.243765] Dynamic subtest render: SUCCESS (0.139s) [385.258220] Starting dynamic subtest: bsd1 [385.328203] Dynamic subtest bsd1: SUCCESS (0.082s) [385.341316] Starting dynamic subtest: bsd2 [385.456041] Dynamic subtest bsd2: SUCCESS (0.125s) [385.469910] Starting dynamic subtest: blt [385.549602] Dynamic subtest blt: SUCCESS (0.090s) [385.563314] Starting dynamic subtest: vebox [385.641585] Dynamic subtest vebox: SUCCESS (0.089s) [385.643729] Subtest legacy-engines-hostile: SUCCESS (0.539s) [385.726105] [092/133] (638s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [385.828261] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [385.830316] Starting dynamic subtest: pipe-A-eDP-1 [385.947484] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s) [385.959931] Starting dynamic subtest: pipe-B-eDP-1 [387.150703] Dynamic subtest pipe-B-eDP-1: SKIP (1.196s) [387.155297] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.323s) [388.409073] [093/133] (635s left) kms_flip (basic-flip-vs-dpms) [388.504240] Starting subtest: basic-flip-vs-dpms [388.506405] Starting dynamic subtest: A-eDP1 [391.057915] Dynamic subtest A-eDP1: SUCCESS (2.553s) [391.067310] Starting dynamic subtest: B-eDP1 [393.244558] Dynamic subtest B-eDP1: SUCCESS (2.185s) [393.253913] Starting dynamic subtest: C-eDP1 [395.444198] Dynamic subtest C-eDP1: SUCCESS (2.196s) [395.455776] Starting dynamic subtest: D-eDP1 [397.642224] Dynamic subtest D-eDP1: SUCCESS (2.197s) [397.644563] Subtest basic-flip-vs-dpms: SUCCESS (9.144s) [398.502184] [094/133] (625s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [398.594285] Starting subtest: plane-scaler-with-clipping-clamping-rotation [398.596645] Starting dynamic subtest: pipe-A [398.842772] Dynamic subtest pipe-A: SUCCESS (0.251s) [398.852970] Starting dynamic subtest: pipe-B [400.162270] Dynamic subtest pipe-B: SUCCESS (1.318s) [400.171482] Starting dynamic subtest: pipe-C [401.450182] Dynamic subtest pipe-C: SUCCESS (1.287s) [401.463054] Starting dynamic subtest: pipe-D [402.755949] Dynamic subtest pipe-D: SUCCESS (1.305s) [402.758162] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.165s) [403.909941] [095/133] (620s left) gem_mmap_gtt (cpuset-basic-small-copy) [403.971305] Subtest cpuset-basic-small-copy: SKIP (0.000s) [404.041188] [096/133] (620s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [404.142410] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [410.883242] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.743s) [411.019194] [097/133] (613s left) gem_exec_fence (syncobj-channel) [411.503028] Starting subtest: syncobj-channel [412.523907] Subtest syncobj-channel: SUCCESS (1.016s) [412.970757] [098/133] (611s left) gem_ctx_param (invalid-get-engines) [413.026844] Starting subtest: invalid-get-engines [413.029169] Subtest invalid-get-engines: SUCCESS (0.001s) [413.141023] [099/133] (611s left) gem_exec_flush (basic-wb-rw-before-default) [413.195848] Starting subtest: basic-wb-rw-before-default [418.669430] Subtest basic-wb-rw-before-default: SUCCESS (5.473s) [418.866806] [100/133] (605s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [418.962325] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [418.966842] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [419.055140] [101/133] (605s left) gem_mmap_gtt (zero-extend) [419.108776] Subtest zero-extend: SKIP (0.000s) [419.170550] [102/133] (605s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [419.262341] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [420.341452] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.080s) [420.463942] [103/133] (604s left) gem_exec_flush (basic-batch-kernel-default-uc) [420.532202] Starting subtest: basic-batch-kernel-default-uc [428.201674] Subtest basic-batch-kernel-default-uc: SUCCESS (7.669s) [428.392513] [104/133] (596s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [428.491861] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [428.496423] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [428.609983] [105/133] (595s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [428.703712] Starting subtest: flip-vs-dpms-on-nop-interruptible [428.706170] Starting dynamic subtest: A-eDP1 [430.570617] Dynamic subtest A-eDP1: SUCCESS (1.866s) [430.582310] Starting dynamic subtest: B-eDP1 [432.368871] Dynamic subtest B-eDP1: SUCCESS (1.798s) [432.380877] Starting dynamic subtest: C-eDP1 [434.157656] Dynamic subtest C-eDP1: SUCCESS (1.786s) [434.169914] Starting dynamic subtest: D-eDP1 [435.954100] Dynamic subtest D-eDP1: SUCCESS (1.794s) [435.959779] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.256s) [437.112635] [106/133] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [437.213255] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [443.673136] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.462s) [443.783283] [107/133] (580s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [443.873561] Starting subtest: psr-rgb101010-draw-mmap-gtt [443.877631] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [443.972958] [108/133] (580s left) i915_drm_fdinfo (virtual-busy) [444.021425] Starting subtest: virtual-busy [444.025633] Subtest virtual-busy: SKIP (0.000s) [444.086804] [109/133] (580s left) gem_mmap_gtt (basic-small-copy-odd) [444.150771] Subtest basic-small-copy-odd: SKIP (0.000s) [444.203068] [110/133] (580s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [444.297607] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [444.302116] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [444.383829] [111/133] (580s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [444.485364] Starting subtest: basic-max-pipe-crc-check [444.489661] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [444.532421] [112/133] (580s left) api_intel_allocator (fork-simple-stress-signal) [444.592743] Starting subtest: fork-simple-stress-signal [449.991563] Subtest fork-simple-stress-signal: SUCCESS (5.401s) [450.115593] [113/133] (574s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [450.217151] Starting subtest: primary-y-tiled-reflect-x-0 [450.277330] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s) [450.383161] [114/133] (574s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [450.497694] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [457.558285] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.064s) [457.679994] [115/133] (567s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping) [457.777170] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping [457.781250] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [457.866612] [116/133] (567s left) gem_create (create-ext-placement-all) [458.042403] Starting subtest: create-ext-placement-all [458.044347] Subtest create-ext-placement-all: SUCCESS (0.000s) [458.140916] [117/133] (566s left) gem_ctx_create (basic) [458.195835] Starting subtest: basic [458.198173] Subtest basic: SUCCESS (0.000s) [458.376839] [118/133] (566s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [458.429743] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [458.431959] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [458.547798] [119/133] (566s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [458.608951] Starting subtest: invalid-multi-wait-unsubmitted-submitted [458.610910] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s) [458.707510] [120/133] (566s left) gen9_exec_parse (bb-secure) [458.763056] Subtest bb-secure: SKIP (0.000s) [458.838185] [121/133] (566s left) kms_psr (pr-primary-page-flip) [458.928025] Starting subtest: pr-primary-page-flip [458.932480] Subtest pr-primary-page-flip: SKIP (0.000s) [458.998831] [122/133] (566s left) kms_flip (blocking-wf_vblank) [459.090594] Starting subtest: blocking-wf_vblank [459.092694] Starting dynamic subtest: A-eDP1 [468.018142] Dynamic subtest A-eDP1: SUCCESS (8.929s) [468.027515] Starting dynamic subtest: B-eDP1 [476.915213] Dynamic subtest B-eDP1: SUCCESS (8.895s) [476.931305] Starting dynamic subtest: C-eDP1 [485.805530] Dynamic subtest C-eDP1: SUCCESS (8.887s) [485.818951] Starting dynamic subtest: D-eDP1 [494.708644] Dynamic subtest D-eDP1: SUCCESS (8.901s) [494.713696] Subtest blocking-wf_vblank: SUCCESS (35.625s) [495.908735] [123/133] (529s left) kms_color_pipeline (plane-lut1d-lut1d) [496.006400] Starting subtest: plane-lut1d-lut1d [496.129258] Starting dynamic subtest: pipe-A-plane-0 [496.318920] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [496.327888] Starting dynamic subtest: pipe-A-plane-1 [496.451318] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [496.460501] Starting dynamic subtest: pipe-A-plane-2 [496.629221] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s) [497.904621] Starting dynamic subtest: pipe-B-plane-0 [498.040912] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [498.050720] Starting dynamic subtest: pipe-B-plane-1 [498.230077] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [498.240828] Starting dynamic subtest: pipe-B-plane-2 [498.407974] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s) [499.563531] Starting dynamic subtest: pipe-C-plane-0 [499.689445] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [499.698865] Starting dynamic subtest: pipe-C-plane-1 [499.834239] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [499.843806] Starting dynamic subtest: pipe-C-plane-2 [499.978429] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [501.153370] Starting dynamic subtest: pipe-D-plane-0 [501.279347] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [501.288614] Starting dynamic subtest: pipe-D-plane-1 [501.412647] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s) [501.421980] Starting dynamic subtest: pipe-D-plane-2 [501.568269] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [501.868112] Subtest plane-lut1d-lut1d: SUCCESS (5.862s) [502.708425] [124/133] (522s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [502.805522] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [509.228497] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.425s) [509.373045] [125/133] (516s left) kms_universal_plane (universal-plane-functional) [509.476309] Starting subtest: universal-plane-functional [509.478247] Starting dynamic subtest: pipe-A-eDP-1 [513.386591] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.909s) [513.396209] Starting dynamic subtest: pipe-B-eDP-1 [518.078046] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.692s) [518.088368] Starting dynamic subtest: pipe-C-eDP-1 [522.349999] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.268s) [522.360352] Starting dynamic subtest: pipe-D-eDP-1 [526.645075] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.296s) [526.647524] Subtest universal-plane-functional: SUCCESS (17.170s) [527.489478] [126/133] (497s left) kms_lease (lease-unleased-connector) [527.582101] Starting subtest: lease-unleased-connector [527.584209] Starting dynamic subtest: pipe-A-eDP-1 [527.589182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [527.598685] Starting dynamic subtest: pipe-B-eDP-1 [527.601043] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [527.610854] Starting dynamic subtest: pipe-C-eDP-1 [527.613160] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [527.621775] Starting dynamic subtest: pipe-D-eDP-1 [527.623933] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [527.626116] Subtest lease-unleased-connector: SUCCESS (0.030s) [527.742571] [127/133] (497s left) gem_exec_reloc (basic-gtt-wc-active) [527.807603] Subtest basic-gtt-wc-active: SKIP (0.000s) [527.873996] [128/133] (497s left) kms_getfb (getfb-handle-zero) [527.960179] Starting subtest: getfb-handle-zero [527.962055] Subtest getfb-handle-zero: SUCCESS (0.000s) [528.061487] [129/133] (497s left) i915_pm_rps (reset) [528.118041] Starting subtest: reset [536.583977] Subtest reset: SUCCESS (8.464s) [536.698226] [130/133] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [536.797374] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [543.385419] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.590s) [543.508897] [131/133] (482s left) kms_async_flips (test-cursor-atomic) [543.600109] Starting subtest: test-cursor-atomic [543.969819] Starting dynamic subtest: pipe-A-eDP-1 [544.754626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s) [545.127660] Starting dynamic subtest: pipe-B-eDP-1 [545.870112] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.751s) [546.252748] Starting dynamic subtest: pipe-C-eDP-1 [547.047617] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.806s) [547.432180] Starting dynamic subtest: pipe-D-eDP-1 [548.261521] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.843s) [548.263681] Subtest test-cursor-atomic: SUCCESS (4.664s) [549.492599] [132/133] (476s left) gem_exec_reloc (basic-gtt-wc) [549.552504] Subtest basic-gtt-wc: SKIP (0.000s) [549.614596] [133/133] (476s left) fbdev (pan) [549.655544] Starting subtest: pan [549.689952] Subtest pan: SUCCESS (0.035s) [549.757021] 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.