[57.311096] Initializing watchdogs [57.311145] /dev/watchdog0 [57.325392] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.329891] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.332154] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.335519] [001/133] (960s left) kms_sequence (get-forked-busy) [57.463035] Starting subtest: get-forked-busy [57.465388] Starting dynamic subtest: pipe-A-eDP-1 [59.425992] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s) [59.433703] Starting dynamic subtest: pipe-B-eDP-1 [62.092527] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.647s) [62.099538] Starting dynamic subtest: pipe-C-eDP-1 [64.688080] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.586s) [64.697373] Starting dynamic subtest: pipe-D-eDP-1 [67.226974] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s) [67.229675] Subtest get-forked-busy: SUCCESS (9.714s) [68.036222] [002/133] (949s left) gem_mmap (big-bo) [68.138612] Subtest big-bo: SKIP (0.000s) [68.231375] [003/133] (949s left) gem_busy (extended) [68.520543] Starting subtest: extended [68.523049] Starting dynamic subtest: rcs0 [68.638245] Dynamic subtest rcs0: SUCCESS (0.118s) [68.647919] Starting dynamic subtest: bcs0 [68.679474] Dynamic subtest bcs0: SUCCESS (0.040s) [68.688247] Starting dynamic subtest: vcs0 [69.911548] Dynamic subtest vcs0: SUCCESS (1.227s) [69.922560] Starting dynamic subtest: vcs1 [71.894350] Dynamic subtest vcs1: SUCCESS (1.978s) [71.905085] Starting dynamic subtest: vecs0 [73.994719] Dynamic subtest vecs0: SUCCESS (2.044s) [74.004704] Starting dynamic subtest: ccs0 [74.007052] Dynamic subtest ccs0: SUCCESS (0.047s) [74.009328] Subtest extended: SUCCESS (5.460s) [74.255301] [004/133] (943s left) gen9_exec_parse (allowed-single) [74.317621] Subtest allowed-single: SKIP (0.000s) [74.399271] [005/133] (943s left) gem_tiled_fence_blits (basic) [74.453918] Subtest basic: SKIP (0.000s) [74.540145] [006/133] (943s left) kms_big_fb (y-tiled-32bpp-rotate-270) [74.648864] Starting subtest: y-tiled-32bpp-rotate-270 [74.653222] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [74.756746] [007/133] (943s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [74.848768] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [74.851060] Starting dynamic subtest: pipe-A-default-mode [75.994462] Dynamic subtest pipe-A-default-mode: SKIP (1.141s) [76.000843] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.143s) [76.159592] [008/133] (941s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [76.257659] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [80.739067] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.481s) [81.880303] [009/133] (936s left) i915_drm_fdinfo (busy) [81.920773] Starting subtest: busy [81.923030] Starting dynamic subtest: rcs0 [81.962088] Dynamic subtest rcs0: SKIP (0.039s) [81.971317] Starting dynamic subtest: bcs0 [81.975701] Dynamic subtest bcs0: SKIP (0.000s) [81.983256] Starting dynamic subtest: vcs0 [81.988029] Dynamic subtest vcs0: SKIP (0.000s) [81.996572] Starting dynamic subtest: vcs1 [82.000806] Dynamic subtest vcs1: SKIP (0.000s) [82.007613] Starting dynamic subtest: vecs0 [82.011930] Dynamic subtest vecs0: SKIP (0.000s) [82.018739] Starting dynamic subtest: ccs0 [82.023074] Dynamic subtest ccs0: SKIP (0.000s) [82.027338] Subtest busy: SKIP (0.042s) [82.059859] [010/133] (936s left) gem_exec_reloc (basic-gtt-wc-active) [82.125449] Subtest basic-gtt-wc-active: SKIP (0.000s) [82.187894] [011/133] (936s left) kms_busy (basic) [82.293844] Starting subtest: basic [82.296353] Starting dynamic subtest: flip [82.916119] Dynamic subtest flip: SUCCESS (0.623s) [82.925331] Starting dynamic subtest: modeset [86.384946] Dynamic subtest modeset: SUCCESS (3.466s) [86.387421] Subtest basic: SUCCESS (4.090s) [87.202194] [012/133] (931s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [87.323995] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [87.970464] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s) [88.162200] [013/133] (930s left) kms_flip (flip-vs-fences-interruptible) [88.269260] Starting subtest: flip-vs-fences-interruptible [88.273849] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [88.408601] [014/133] (929s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [88.534900] Starting subtest: cursor-vs-flip-atomic-transitions [118.385203] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.842s) [119.231986] [015/133] (899s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [119.335042] Starting subtest: plane-use-after-nonblocking-unbind [119.337351] Starting dynamic subtest: pipe-A-eDP-1 [119.401489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.067s) [119.705214] Starting dynamic subtest: pipe-B-eDP-1 [120.518397] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.820s) [120.805356] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.469s) [121.683805] [016/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [121.788662] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [121.792699] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [121.912658] [017/133] (896s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [122.023417] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [122.025662] Starting dynamic subtest: pipe-A-eDP-1 [133.015499] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.992s) [133.025393] Starting dynamic subtest: pipe-B-eDP-1 [144.694271] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.679s) [144.696513] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.674s) [145.568812] [018/133] (872s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [145.662918] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [152.431973] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.772s) [152.585856] [019/133] (865s left) gem_vm_create (create-ext) [152.655455] Starting subtest: create-ext [152.660416] Subtest create-ext: SUCCESS (0.005s) [152.823557] [020/133] (865s left) gem_exec_fence (nb-await) [152.997813] Starting subtest: nb-await [153.000246] Starting dynamic subtest: rcs0 [153.068919] Dynamic subtest rcs0: SUCCESS (0.071s) [153.079348] Starting dynamic subtest: bcs0 [153.127813] Dynamic subtest bcs0: SUCCESS (0.057s) [153.137586] Starting dynamic subtest: vcs0 [153.187287] Dynamic subtest vcs0: SUCCESS (0.058s) [153.198054] Starting dynamic subtest: vcs1 [153.245999] Dynamic subtest vcs1: SUCCESS (0.058s) [153.255967] Starting dynamic subtest: vecs0 [153.305223] Dynamic subtest vecs0: SUCCESS (0.058s) [153.315987] Starting dynamic subtest: ccs0 [153.363623] Dynamic subtest ccs0: SUCCESS (0.058s) [153.366174] Subtest nb-await: SUCCESS (0.366s) [155.024288] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true [155.027461] [021/133] (863s left) gem_exec_schedule (semaphore-user) [155.097910] Starting subtest: semaphore-user [155.151606] Subtest semaphore-user: SUCCESS (0.062s) [156.936347] [022/133] (861s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [157.044813] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [157.048809] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s) [157.130381] [023/133] (861s left) gem_eio (wait-10ms) [157.366178] Starting subtest: wait-10ms [157.714024] Subtest wait-10ms: SUCCESS (0.347s) [157.887011] [024/133] (860s left) kms_vblank (crtc-id) [157.973310] Starting subtest: crtc-id [157.975114] Starting dynamic subtest: pipe-A-eDP-1 [158.424508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s) [158.440558] Starting dynamic subtest: pipe-D-eDP-1 [159.595941] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.168s) [159.598189] Subtest crtc-id: SUCCESS (1.623s) [160.441490] [025/133] (858s left) kms_lease (lease-again) [160.541901] Starting subtest: lease-again [160.544239] Starting dynamic subtest: pipe-A-eDP-1 [160.546385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [160.554971] Starting dynamic subtest: pipe-B-eDP-1 [160.557157] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [160.564738] Starting dynamic subtest: pipe-C-eDP-1 [160.566801] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [160.574413] Starting dynamic subtest: pipe-D-eDP-1 [160.576513] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [160.578578] Subtest lease-again: SUCCESS (0.012s) [160.696996] [026/133] (858s left) kms_cursor_crc (cursor-random-256x85) [160.972763] Starting subtest: cursor-random-256x85 [161.020540] Subtest cursor-random-256x85: SKIP (0.043s) [161.210763] [027/133] (857s left) kms_pm_rpm (fences) [163.037277] Starting subtest: fences [163.042401] Subtest fences: SKIP (0.000s) [163.473672] [028/133] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [163.578887] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [163.583278] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [163.707630] [029/133] (855s left) gem_tiled_fence_blits (normal) [163.762061] Subtest normal: SKIP (0.000s) [163.841440] [030/133] (855s left) kms_psr (pr-sprite-plane-move) [163.936863] Starting subtest: pr-sprite-plane-move [163.940766] Subtest pr-sprite-plane-move: SKIP (0.000s) [164.018435] [031/133] (855s left) kms_pipe_crc_basic (hang-read-crc) [164.107818] Starting subtest: hang-read-crc [164.110079] Starting dynamic subtest: pipe-A-eDP-1 [166.245290] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.137s) [166.257435] Starting dynamic subtest: pipe-B-eDP-1 [169.026482] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.781s) [169.035188] Starting dynamic subtest: pipe-C-eDP-1 [171.663454] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.634s) [171.672863] Starting dynamic subtest: pipe-D-eDP-1 [174.316437] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.651s) [174.318700] Subtest hang-read-crc: SUCCESS (10.208s) [175.153337] [032/133] (843s left) kms_atomic_transition (plane-all-transition-nonblocking) [175.261053] Starting subtest: plane-all-transition-nonblocking [175.263262] Starting dynamic subtest: pipe-A-eDP-1 [177.754041] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [178.066533] Starting dynamic subtest: pipe-B-eDP-1 [181.292050] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.233s) [181.593499] Subtest plane-all-transition-nonblocking: SUCCESS (6.331s) [182.420068] [033/133] (836s left) gem_create (create-valid-nonaligned) [182.490214] Starting subtest: create-valid-nonaligned [182.492549] Subtest create-valid-nonaligned: SUCCESS (0.000s) [182.684311] [034/133] (836s left) kms_psr (psr-cursor-plane-move) [182.786916] Starting subtest: psr-cursor-plane-move [182.789288] Starting dynamic subtest: eDP-1 [184.500322] Dynamic subtest eDP-1: SUCCESS (1.712s) [184.502628] Subtest psr-cursor-plane-move: SUCCESS (1.713s) [185.362199] [035/133] (833s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [185.472580] Starting subtest: psr-rgb101010-draw-mmap-gtt [185.476659] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [185.590427] [036/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [185.690829] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [185.695222] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [185.818959] [037/133] (833s left) kms_content_protection (mei-interface) [185.962682] Starting subtest: mei-interface [185.967330] Subtest mei-interface: SKIP (0.001s) [186.121409] [038/133] (833s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [186.221313] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [192.764282] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.545s) [192.875569] [039/133] (826s left) kms_plane (pixel-format-y-tiled-ccs-modifier) [192.977327] Starting subtest: pixel-format-y-tiled-ccs-modifier [193.003418] Starting dynamic subtest: pipe-A-plane-0 [193.008025] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [193.016779] Starting dynamic subtest: pipe-A-plane-3 [193.021318] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [193.031403] Starting dynamic subtest: pipe-A-plane-5 [193.035689] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [194.062067] Starting dynamic subtest: pipe-B-plane-0 [194.066298] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [194.076392] Starting dynamic subtest: pipe-B-plane-3 [194.081055] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [194.090749] Starting dynamic subtest: pipe-B-plane-5 [194.095483] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [194.381915] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (1.404s) [195.248783] [040/133] (824s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [195.406244] Starting subtest: short-flip-after-cursor-atomic-transitions [196.365310] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.956s) [197.173205] [041/133] (822s left) kms_cursor_crc (cursor-offscreen-512x512) [197.466933] Starting subtest: cursor-offscreen-512x512 [197.470996] Subtest cursor-offscreen-512x512: SKIP (0.001s) [197.652064] [042/133] (821s left) kms_invalid_mode (bad-hsync-end) [197.766437] Starting subtest: bad-hsync-end [197.768632] Starting dynamic subtest: pipe-A-eDP-1 [198.052655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [198.064178] Starting dynamic subtest: pipe-B-eDP-1 [198.066123] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [198.074146] Starting dynamic subtest: pipe-C-eDP-1 [198.076310] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [198.083904] Starting dynamic subtest: pipe-D-eDP-1 [198.086199] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [198.088350] Subtest bad-hsync-end: SUCCESS (0.290s) [198.905756] [043/133] (820s left) i915_suspend (fence-restore-untiled) [198.962515] Starting subtest: fence-restore-untiled [198.966632] Subtest fence-restore-untiled: SKIP (0.000s) [199.092315] [044/133] (820s left) kms_addfb_basic (addfb25-4-tiled) [199.190408] Starting subtest: addfb25-4-tiled [199.192643] Subtest addfb25-4-tiled: SUCCESS (0.000s) [199.333259] [045/133] (820s left) gem_create (create-ext-set-pat) [199.502042] Starting subtest: create-ext-set-pat [199.504890] Subtest create-ext-set-pat: SUCCESS (0.001s) [199.650499] [046/133] (820s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [199.764761] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [199.768889] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [199.890913] [047/133] (819s left) gem_exec_schedule (preempt-other) [199.975255] Starting subtest: preempt-other [199.977533] Starting dynamic subtest: rcs0 [200.040680] Dynamic subtest rcs0: SUCCESS (0.071s) [200.051576] Starting dynamic subtest: bcs0 [200.106447] Dynamic subtest bcs0: SUCCESS (0.065s) [200.118038] Starting dynamic subtest: vcs0 [200.176026] Dynamic subtest vcs0: SUCCESS (0.069s) [200.186190] Starting dynamic subtest: vcs1 [200.243189] Dynamic subtest vcs1: SUCCESS (0.066s) [200.254941] Starting dynamic subtest: vecs0 [200.309341] Dynamic subtest vecs0: SUCCESS (0.065s) [200.322479] Starting dynamic subtest: ccs0 [200.375340] Dynamic subtest ccs0: SUCCESS (0.065s) [200.378038] Subtest preempt-other: SUCCESS (0.406s) [201.995530] [048/133] (817s left) gem_softpin (evict-single-offset) [202.060909] Starting subtest: evict-single-offset [226.838399] Subtest evict-single-offset: SUCCESS (24.773s) [226.948518] [049/133] (792s left) gem_lmem_swapping (verify-random) [227.038781] Subtest verify-random: SKIP (0.000s) [227.090849] [050/133] (792s left) gem_ctx_param (basic-default) [227.147591] Starting subtest: basic-default [227.149965] Subtest basic-default: SUCCESS (0.000s) [227.280902] [051/133] (792s left) i915_pm_freq_mult (media-freq) [227.346622] Starting subtest: media-freq [227.349059] Starting dynamic subtest: gt0 [227.353201] Dynamic subtest gt0: SKIP (0.000s) [227.363054] Starting dynamic subtest: gt1 [227.367161] Dynamic subtest gt1: SKIP (0.000s) [227.371259] Subtest media-freq: SKIP (0.003s) [227.478734] [052/133] (792s left) vgem_basic (mmap) [227.517469] Starting subtest: mmap [227.538680] Subtest mmap: SUCCESS (0.023s) [227.614430] [053/133] (792s left) kms_pm_rpm (package-g7) [229.187234] Starting subtest: package-g7 [229.192736] Subtest package-g7: SKIP (0.000s) [229.955580] [054/133] (790s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [230.018252] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [230.094714] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.031s) [230.131207] [055/133] (789s left) gem_ctx_sseu (engines) [230.195077] Subtest engines: SKIP (0.000s) [230.272200] [056/133] (789s left) kms_atomic_interruptible (legacy-dpms) [230.370041] Starting subtest: legacy-dpms [230.372305] Starting dynamic subtest: pipe-A-eDP-1 [237.769264] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.397s) [237.771411] Subtest legacy-dpms: SUCCESS (7.399s) [238.618416] [057/133] (781s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [238.715290] Starting subtest: fbcpsr-rgb101010-draw-render [245.530109] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.816s) [245.667439] [058/133] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [245.775266] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [245.779202] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [245.888405] [059/133] (774s left) gem_exec_params (readonly) [245.956590] Starting subtest: readonly [245.961971] Subtest readonly: SUCCESS (0.003s) [246.098629] [060/133] (774s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [246.207159] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [246.211595] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [246.318030] [061/133] (774s left) gem_exec_schedule (wide) [246.501088] Starting subtest: wide [246.503749] Starting dynamic subtest: rcs0 [256.356715] Dynamic subtest rcs0: SUCCESS (9.802s) [256.366164] Starting dynamic subtest: vcs0 [268.830526] Dynamic subtest vcs0: SUCCESS (12.523s) [268.839275] Starting dynamic subtest: vcs1 [281.365276] Dynamic subtest vcs1: SUCCESS (12.534s) [281.373435] Starting dynamic subtest: vecs0 [293.058290] Dynamic subtest vecs0: SUCCESS (11.692s) [293.066771] Starting dynamic subtest: ccs0 [306.977453] Dynamic subtest ccs0: SUCCESS (13.919s) [306.979877] Subtest wide: SUCCESS (60.475s) [309.272526] [062/133] (711s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [309.370910] Starting subtest: missing-ccs-buffer-y-tiled-ccs [309.373166] Starting dynamic subtest: pipe-A-eDP-1 [309.395648] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [309.407410] Starting dynamic subtest: pipe-B-eDP-1 [309.428758] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [309.437661] Starting dynamic subtest: pipe-C-eDP-1 [309.458070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [309.465758] Starting dynamic subtest: pipe-D-eDP-1 [309.486548] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [309.490803] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s) [311.700374] [063/133] (708s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [311.807562] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [311.811812] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [311.945369] [064/133] (708s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [312.054602] Starting subtest: cursorA-vs-flipB-toggle [312.058980] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [312.224188] [065/133] (708s left) kms_cursor_crc (cursor-sliding-256x85) [312.486234] Starting subtest: cursor-sliding-256x85 [312.534216] Subtest cursor-sliding-256x85: SKIP (0.041s) [312.749884] [066/133] (707s left) perf_pmu (busy-no-semaphores) [312.785098] Starting subtest: busy-no-semaphores [312.786953] Starting dynamic subtest: rcs0 [313.361487] Dynamic subtest rcs0: SUCCESS (0.576s) [313.371259] Starting dynamic subtest: bcs0 [313.914586] Dynamic subtest bcs0: SUCCESS (0.549s) [313.926721] Starting dynamic subtest: vcs0 [314.463749] Dynamic subtest vcs0: SUCCESS (0.547s) [314.474714] Starting dynamic subtest: vcs1 [316.442225] Dynamic subtest vcs1: SUCCESS (1.974s) [316.454561] Starting dynamic subtest: vecs0 [318.424906] Dynamic subtest vecs0: SUCCESS (1.981s) [318.436562] Starting dynamic subtest: ccs0 [320.410901] Dynamic subtest ccs0: SUCCESS (1.982s) [320.413861] Subtest busy-no-semaphores: SUCCESS (7.626s) [320.538277] [067/133] (700s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [320.607931] Starting subtest: yf-tiled-ccs-to-y-tiled [320.612387] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [320.811990] [068/133] (699s left) gem_exec_schedule (smoketest-all) [320.881138] Starting subtest: smoketest-all [353.279091] Subtest smoketest-all: SUCCESS (32.357s) [354.983638] [069/133] (665s left) kms_psr2_su (page_flip-p010) [355.060322] Subtest page_flip-P010: SKIP (0.000s) [355.130997] [070/133] (665s left) syncobj_eventfd (binary-wait-before-signal) [355.198460] Starting subtest: binary-wait-before-signal [355.227367] Subtest binary-wait-before-signal: SUCCESS (0.031s) [355.315444] [071/133] (665s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [355.432177] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [355.434409] Starting dynamic subtest: pipe-A-eDP-1 [355.506175] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [355.515910] Starting dynamic subtest: pipe-B-eDP-1 [356.663884] Dynamic subtest pipe-B-eDP-1: SKIP (1.155s) [356.668024] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.236s) [357.890991] [072/133] (662s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [357.996142] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [357.998449] Starting dynamic subtest: pipe-A-eDP-1 [358.022976] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [358.033028] Starting dynamic subtest: pipe-B-eDP-1 [358.055261] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [358.064308] Starting dynamic subtest: pipe-C-eDP-1 [358.086574] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [358.095478] Starting dynamic subtest: pipe-D-eDP-1 [358.118244] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [358.122408] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [360.256182] [073/133] (660s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [360.362393] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [360.364728] Starting dynamic subtest: pipe-A-eDP-1 [360.390355] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [360.399584] Starting dynamic subtest: pipe-B-eDP-1 [360.423886] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [360.432422] Starting dynamic subtest: pipe-C-eDP-1 [360.456340] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [360.464595] Starting dynamic subtest: pipe-D-eDP-1 [360.487745] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [360.491694] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s) [362.604982] [074/133] (658s left) api_intel_bb (object-reloc-purge-cache) [362.671482] Starting subtest: object-reloc-purge-cache [362.679141] Subtest object-reloc-purge-cache: SKIP (0.004s) [362.830093] [075/133] (658s left) gem_ctx_persistence (engines-mixed-process) [362.898340] Starting subtest: engines-mixed-process [362.900258] Starting dynamic subtest: rcs0 [364.910089] Dynamic subtest rcs0: SUCCESS (2.014s) [364.921555] Starting dynamic subtest: bcs0 [366.963058] Dynamic subtest bcs0: SUCCESS (2.051s) [366.974537] Starting dynamic subtest: vcs0 [368.941115] Dynamic subtest vcs0: SUCCESS (1.976s) [368.952661] Starting dynamic subtest: vcs1 [370.927911] Dynamic subtest vcs1: SUCCESS (1.985s) [370.939245] Starting dynamic subtest: vecs0 [372.910914] Dynamic subtest vecs0: SUCCESS (1.981s) [372.922304] Starting dynamic subtest: ccs0 [374.900318] Dynamic subtest ccs0: SUCCESS (1.987s) [374.903094] Subtest engines-mixed-process: SUCCESS (12.005s) [375.006900] [076/133] (645s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [375.115219] Starting subtest: bad-rotation-90-yf-tiled-ccs [375.117489] Starting dynamic subtest: pipe-A-eDP-1 [375.140808] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [375.152582] Starting dynamic subtest: pipe-B-eDP-1 [375.174434] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [375.183318] Starting dynamic subtest: pipe-C-eDP-1 [375.205205] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [375.213966] Starting dynamic subtest: pipe-D-eDP-1 [375.235908] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [375.239992] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s) [377.378388] [077/133] (643s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [377.515834] Starting subtest: flip-vs-cursor-crc-atomic [378.181150] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.664s) [378.994152] [078/133] (642s left) gem_mmap_wc (bad-object) [379.052630] Subtest bad-object: SKIP (0.000s) [379.114764] [079/133] (641s left) gem_exec_balancer (parallel-balancer) [379.376899] Starting subtest: parallel-balancer [380.259096] Subtest parallel-balancer: SUCCESS (0.882s) [380.385554] [080/133] (640s left) kms_plane_multiple (2x-tiling-y) [380.482131] Starting subtest: 2x-tiling-y [380.486485] Subtest 2x-tiling-y: SKIP (0.000s) [380.581675] [081/133] (640s left) syncobj_basic (test-valid-cycle) [380.637450] Starting subtest: test-valid-cycle [380.639348] Subtest test-valid-cycle: SUCCESS (0.000s) [380.780524] [082/133] (640s left) kms_plane_scaling (planes-upscale-factor-0-25) [380.884622] Starting subtest: planes-upscale-factor-0-25 [380.886834] Starting dynamic subtest: pipe-A [380.945819] Dynamic subtest pipe-A: SUCCESS (0.062s) [380.956399] Starting dynamic subtest: pipe-B [382.107500] Dynamic subtest pipe-B: SUCCESS (1.159s) [382.118237] Starting dynamic subtest: pipe-C [383.230748] Dynamic subtest pipe-C: SUCCESS (1.121s) [383.245616] Starting dynamic subtest: pipe-D [384.352188] Dynamic subtest pipe-D: SUCCESS (1.121s) [384.354638] Subtest planes-upscale-factor-0-25: SUCCESS (3.469s) [385.526608] [083/133] (635s left) gem_pxp (regular-baseline-src-copy-readible) [385.645922] Starting subtest: regular-baseline-src-copy-readible [385.704933] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s) [385.853913] [084/133] (635s left) i915_pm_freq_api (freq-reset-multiple) [385.928781] Starting subtest: freq-reset-multiple [385.931204] Starting dynamic subtest: gt0 [396.024389] Dynamic subtest gt0: SUCCESS (10.092s) [396.041727] Starting dynamic subtest: gt1 [404.759294] Dynamic subtest gt1: SUCCESS (8.734s) [404.761860] Subtest freq-reset-multiple: SUCCESS (18.828s) [404.851382] [085/133] (616s left) i915_query (query-topology-unsupported) [404.911699] Starting subtest: query-topology-unsupported [404.916360] Subtest query-topology-unsupported: SKIP (0.000s) [405.040515] [086/133] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [405.153605] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [405.158060] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [405.259129] [087/133] (616s left) kms_big_fb (x-tiled-16bpp-rotate-90) [405.363301] Starting subtest: x-tiled-16bpp-rotate-90 [405.382967] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s) [405.513189] [088/133] (615s left) kms_psr (fbc-pr-sprite-plane-move) [405.621911] Starting subtest: fbc-pr-sprite-plane-move [405.626144] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [405.719582] [089/133] (615s left) gem_exec_balancer (semaphore) [405.789885] Starting subtest: semaphore [407.913092] Subtest semaphore: SUCCESS (2.121s) [408.250393] [090/133] (613s left) gem_madvise (dontneed-before-mmap) [408.299838] Starting subtest: dontneed-before-mmap [408.326670] Subtest dontneed-before-mmap: SUCCESS (0.028s) [408.437098] [091/133] (613s left) gem_exec_flush (basic-batch-kernel-default-wb) [408.513260] Starting subtest: basic-batch-kernel-default-wb [414.684026] Subtest basic-batch-kernel-default-wb: SUCCESS (6.172s) [414.892704] [092/133] (606s left) gem_userptr_blits (invalid-null-pointer) [414.962915] Starting subtest: invalid-null-pointer [414.965075] Subtest invalid-null-pointer: SUCCESS (0.001s) [415.126473] [093/133] (606s left) kms_dsc (dsc-with-output-formats-with-bpc) [415.222758] Starting subtest: dsc-with-output-formats-with-bpc [415.278918] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s) [415.317619] [094/133] (606s left) gem_ctx_persistence (heartbeat-hang) [415.382638] Starting subtest: heartbeat-hang [415.387160] Subtest heartbeat-hang: SKIP (0.000s) [415.519178] [095/133] (606s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [415.624592] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [416.727272] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.104s) [416.904517] [096/133] (604s left) core_getversion (basic) [416.939874] Starting subtest: basic [416.944137] Subtest basic: SUCCESS (0.000s) [417.019851] [097/133] (604s left) perf_pmu (interrupts) [417.052321] Starting subtest: interrupts [418.159504] Subtest interrupts: SUCCESS (1.106s) [418.296311] [098/133] (603s left) kms_dp_linktrain_fallback (dsc-fallback) [418.385931] Starting subtest: dsc-fallback [418.392178] Subtest dsc-fallback: SKIP (0.000s) [418.469767] [099/133] (603s left) kms_tv_load_detect (load-detect) [418.520473] Subtest load-detect: SKIP (0.000s) [418.591454] [100/133] (603s left) kms_psr (psr-sprite-mmap-gtt) [418.677691] Starting subtest: psr-sprite-mmap-gtt [418.679785] Starting dynamic subtest: eDP-1 [420.405072] Dynamic subtest eDP-1: SKIP (1.724s) [420.409680] Subtest psr-sprite-mmap-gtt: SKIP (1.726s) [420.600597] [101/133] (601s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [420.698224] Starting subtest: fbc-rgb565-draw-mmap-gtt [420.702728] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [420.804230] [102/133] (601s left) gem_mmap_offset (perf) [420.851051] Starting subtest: perf [420.853193] Starting dynamic subtest: smem0 [421.216400] Dynamic subtest smem0: SUCCESS (0.364s) [421.218902] Subtest perf: SUCCESS (0.365s) [421.353327] [103/133] (600s left) i915_query (query-topology-matches-eu-total) [421.404058] Starting subtest: query-topology-matches-eu-total [421.406366] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [421.541930] [104/133] (600s left) kms_psr (fbc-psr-sprite-plane-move) [421.647115] Starting subtest: fbc-psr-sprite-plane-move [421.649400] Starting dynamic subtest: eDP-1 [421.653811] Dynamic subtest eDP-1: SKIP (0.000s) [421.658223] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [421.732434] [105/133] (600s left) vgem_basic (bad-flag) [421.772405] Starting subtest: bad-flag [421.774306] Subtest bad-flag: SUCCESS (0.000s) [421.839811] [106/133] (600s left) gem_partial_pwrite_pread (write-display) [421.905597] Subtest write-display: SKIP (0.000s) [421.982370] [107/133] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [422.085412] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [425.860696] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.779s) [427.022312] [108/133] (595s left) kms_hdr (invalid-metadata-sizes) [427.115220] Starting subtest: invalid-metadata-sizes [427.121665] Subtest invalid-metadata-sizes: SKIP (0.000s) [427.200637] [109/133] (595s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [427.320996] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [427.325291] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s) [427.485667] [110/133] (594s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [427.573848] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [427.576067] Starting dynamic subtest: pipe-A-eDP-1 [427.598370] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [427.610164] Starting dynamic subtest: pipe-B-eDP-1 [427.632243] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [427.643070] Starting dynamic subtest: pipe-C-eDP-1 [427.663661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [427.672769] Starting dynamic subtest: pipe-D-eDP-1 [427.694905] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [427.698966] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [429.857642] [111/133] (592s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [429.963391] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [429.967987] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [430.086374] [112/133] (592s left) prime_mmap (test_correct_cpu_write) [430.134813] Starting subtest: test_correct_cpu_write [430.137100] Starting dynamic subtest: test_correct_cpu_write-smem [430.139213] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [430.141306] Subtest test_correct_cpu_write: SUCCESS (0.001s) [430.230813] [113/133] (592s left) kms_flip_event_leak (basic) [430.332165] Starting subtest: basic [430.333937] Starting dynamic subtest: pipe-A-eDP-1 [430.763940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s) [430.776063] Starting dynamic subtest: pipe-B-eDP-1 [431.887260] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.120s) [431.896209] Starting dynamic subtest: pipe-C-eDP-1 [433.000612] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s) [433.010254] Starting dynamic subtest: pipe-D-eDP-1 [434.121304] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s) [434.123528] Subtest basic: SUCCESS (3.790s) [435.009305] [114/133] (587s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [435.109831] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [435.114098] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [435.240995] [115/133] (587s left) gem_userptr_blits (input-checking) [435.313663] Starting subtest: input-checking [435.315600] Subtest input-checking: SUCCESS (0.000s) [435.470540] [116/133] (587s left) kms_async_flips (test-cursor) [435.567684] Starting subtest: test-cursor [435.571734] Subtest test-cursor: SKIP (0.000s) [436.813964] [117/133] (585s left) kms_chamelium_frames (hdmi-crc-fast) [437.212962] Subtest hdmi-crc-fast: SKIP (0.000s) [438.009373] [118/133] (584s left) syncobj_timeline (host-signal-points) [438.073890] Starting subtest: host-signal-points [438.079650] Subtest host-signal-points: SUCCESS (0.008s) [438.207868] [119/133] (584s left) api_intel_bb (blit-reloc-keep-cache) [438.266202] Starting subtest: blit-reloc-keep-cache [438.270164] Subtest blit-reloc-keep-cache: SKIP (0.001s) [438.415449] [120/133] (584s left) gem_exercise_blt (fast-copy-emit) [438.479687] Starting subtest: fast-copy-emit [438.482012] Starting dynamic subtest: linear-smem-smem-emit [438.501998] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [438.512756] Starting dynamic subtest: xmajor-smem-smem-emit [438.519131] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s) [438.528062] Starting dynamic subtest: tile4-smem-smem-emit [438.536848] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s) [438.545712] Starting dynamic subtest: tile64-smem-smem-emit [438.553807] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s) [438.556010] Subtest fast-copy-emit: SUCCESS (0.075s) [438.700948] [121/133] (584s left) kms_color (invalid-gamma-lut-sizes) [438.803865] Starting subtest: invalid-gamma-lut-sizes [438.806015] Starting dynamic subtest: pipe-A [439.101358] Dynamic subtest pipe-A: SUCCESS (0.298s) [439.110718] Starting dynamic subtest: pipe-B [439.112941] Dynamic subtest pipe-B: SUCCESS (0.000s) [439.121968] Starting dynamic subtest: pipe-C [439.124249] Dynamic subtest pipe-C: SUCCESS (0.000s) [439.133188] Starting dynamic subtest: pipe-D [439.135349] Dynamic subtest pipe-D: SUCCESS (0.000s) [439.137189] Subtest invalid-gamma-lut-sizes: SUCCESS (0.301s) [439.971057] [122/133] (582s left) kms_vrr (negative-basic) [440.068592] Starting subtest: negative-basic [440.075414] Starting dynamic subtest: pipe-A-eDP-1 [445.556560] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.427s) [445.780325] Subtest negative-basic: SUCCESS (5.714s) [446.620160] [123/133] (576s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [446.715139] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [450.416025] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.703s) [451.600622] [124/133] (571s left) kms_vblank (query-forked-hang) [451.690119] Starting subtest: query-forked-hang [451.692412] Starting dynamic subtest: pipe-A-eDP-1 [478.677261] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.984s) [478.691387] Starting dynamic subtest: pipe-D-eDP-1 [493.663185] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.982s) [493.665515] Subtest query-forked-hang: SUCCESS (41.971s) [494.476923] [125/133] (528s left) syncobj_timeline (multi-wait-available-signaled) [494.529493] Starting subtest: multi-wait-available-signaled [494.531435] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [494.660090] [126/133] (528s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [494.787519] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [505.972676] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.183s) [506.807054] [127/133] (516s left) kms_plane (plane-position-hole) [506.913280] Starting subtest: plane-position-hole [507.427475] Starting dynamic subtest: pipe-A-plane-1 [508.689373] Dynamic subtest pipe-A-plane-1: SUCCESS (1.262s) [508.699252] Starting dynamic subtest: pipe-A-plane-2 [510.046252] Dynamic subtest pipe-A-plane-2: SUCCESS (1.358s) [510.056093] Starting dynamic subtest: pipe-A-plane-3 [511.348820] Dynamic subtest pipe-A-plane-3: SUCCESS (1.302s) [511.358519] Starting dynamic subtest: pipe-A-plane-4 [512.654257] Dynamic subtest pipe-A-plane-4: SUCCESS (1.302s) [512.664827] Starting dynamic subtest: pipe-A-plane-5 [512.678213] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [513.835967] Starting dynamic subtest: pipe-B-plane-1 [515.121024] Dynamic subtest pipe-B-plane-1: SUCCESS (1.294s) [515.131051] Starting dynamic subtest: pipe-B-plane-2 [516.358667] Dynamic subtest pipe-B-plane-2: SUCCESS (1.233s) [516.368700] Starting dynamic subtest: pipe-B-plane-3 [517.584126] Dynamic subtest pipe-B-plane-3: SUCCESS (1.226s) [517.594837] Starting dynamic subtest: pipe-B-plane-4 [518.848257] Dynamic subtest pipe-B-plane-4: SUCCESS (1.263s) [518.857868] Starting dynamic subtest: pipe-B-plane-5 [518.872448] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [518.874753] Subtest plane-position-hole: SUCCESS (11.958s) [519.659548] [128/133] (503s left) kms_chamelium_hpd (hdmi-hpd-fast) [520.046851] Subtest hdmi-hpd-fast: SKIP (0.000s) [520.857776] [129/133] (502s left) syncobj_timeline (single-wait-all-available-signaled) [520.913758] Starting subtest: single-wait-all-available-signaled [520.915952] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [521.044244] [130/133] (502s left) syncobj_timeline (invalid-wait-illegal-handle) [521.101887] Starting subtest: invalid-wait-illegal-handle [521.104220] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [521.212734] [131/133] (502s left) kms_big_fb (linear-16bpp-rotate-180) [521.305153] Starting subtest: linear-16bpp-rotate-180 [522.749563] Subtest linear-16bpp-rotate-180: SUCCESS (1.446s) [522.891205] [132/133] (500s left) kms_addfb_basic (bad-pitch-128) [522.960561] Starting subtest: bad-pitch-128 [522.962418] Subtest bad-pitch-128: SUCCESS (0.000s) [523.123409] [133/133] (500s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [523.222154] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [523.225744] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [523.346244] Closing watchdogs results: parsing output: 0/ for test: kms_sequence results: parsing output: 1/ for test: gem_mmap results: parsing output: 2/ for test: gem_busy results: parsing output: 3/ for test: gen9_exec_parse results: parsing output: 4/ for test: gem_tiled_fence_blits results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_flip_scaled_crc results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: i915_drm_fdinfo results: parsing output: 9/ for test: gem_exec_reloc results: parsing output: 10/ for test: kms_busy results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_cursor_legacy results: parsing output: 14/ for test: kms_atomic_transition results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_psr2_sf results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_vm_create results: parsing output: 19/ for test: gem_exec_fence results: parsing output: 20/ for test: gem_exec_schedule results: parsing output: 21/ for test: kms_flip_scaled_crc results: parsing output: 22/ for test: gem_eio results: parsing output: 23/ for test: kms_vblank results: parsing output: 24/ for test: kms_lease results: parsing output: 25/ for test: kms_cursor_crc results: parsing output: 26/ for test: kms_pm_rpm results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_tiled_fence_blits results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: kms_pipe_crc_basic results: parsing output: 31/ for test: kms_atomic_transition results: parsing output: 32/ for test: gem_create results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_content_protection results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_plane results: parsing output: 39/ for test: kms_cursor_legacy results: parsing output: 40/ for test: kms_cursor_crc results: parsing output: 41/ for test: kms_invalid_mode results: parsing output: 42/ for test: i915_suspend results: parsing output: 43/ for test: kms_addfb_basic results: parsing output: 44/ for test: gem_create results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_schedule results: parsing output: 47/ for test: gem_softpin results: parsing output: 48/ for test: gem_lmem_swapping results: parsing output: 49/ for test: gem_ctx_param results: parsing output: 50/ for test: i915_pm_freq_mult results: parsing output: 51/ for test: vgem_basic results: parsing output: 52/ for test: kms_pm_rpm results: parsing output: 53/ for test: sriov_basic results: parsing output: 54/ for test: gem_ctx_sseu results: parsing output: 55/ for test: kms_atomic_interruptible results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_exec_params results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: gem_exec_schedule results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_cursor_legacy results: parsing output: 64/ for test: kms_cursor_crc results: parsing output: 65/ for test: perf_pmu results: parsing output: 66/ for test: gem_render_copy results: parsing output: 67/ for test: gem_exec_schedule results: parsing output: 68/ for test: kms_psr2_su results: parsing output: 69/ for test: syncobj_eventfd results: parsing output: 70/ for test: kms_psr2_sf results: parsing output: 71/ for test: kms_ccs results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: api_intel_bb results: parsing output: 74/ for test: gem_ctx_persistence results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: gem_mmap_wc results: parsing output: 78/ for test: gem_exec_balancer results: parsing output: 79/ for test: kms_plane_multiple results: parsing output: 80/ for test: syncobj_basic results: parsing output: 81/ for test: kms_plane_scaling results: parsing output: 82/ for test: gem_pxp results: parsing output: 83/ for test: i915_pm_freq_api results: parsing output: 84/ for test: i915_query results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: gem_exec_balancer results: parsing output: 89/ for test: gem_madvise results: parsing output: 90/ for test: gem_exec_flush results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: kms_dsc results: parsing output: 93/ for test: gem_ctx_persistence results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: core_getversion results: parsing output: 96/ for test: perf_pmu results: parsing output: 97/ for test: kms_dp_linktrain_fallback results: parsing output: 98/ for test: kms_tv_load_detect results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_mmap_offset results: parsing output: 102/ for test: i915_query results: parsing output: 103/ for test: kms_psr results: parsing output: 104/ for test: vgem_basic results: parsing output: 105/ for test: gem_partial_pwrite_pread results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_hdr results: parsing output: 108/ for test: kms_cursor_legacy results: parsing output: 109/ for test: kms_ccs results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: prime_mmap results: parsing output: 112/ for test: kms_flip_event_leak results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_userptr_blits results: parsing output: 115/ for test: kms_async_flips results: parsing output: 116/ for test: kms_chamelium_frames results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: api_intel_bb results: parsing output: 119/ for test: gem_exercise_blt results: parsing output: 120/ for test: kms_color results: parsing output: 121/ for test: kms_vrr results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_vblank results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: kms_cursor_legacy results: parsing output: 126/ for test: kms_plane results: parsing output: 127/ for test: kms_chamelium_hpd results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: kms_addfb_basic results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.