[59.148344] Initializing watchdogs [59.148403] /dev/watchdog0 [59.167125] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [59.177466] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [59.181246] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.183629] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [59.478763] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [59.480470] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [59.607485] [002/131] (960s left) kms_psr (pr-sprite-plane-onoff) [59.808466] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [59.850428] [003/131] (959s left) sysfs_heartbeat_interval (nopreempt) [59.931900] Starting subtest: nopreempt [59.932824] Starting dynamic subtest: vecs0 [64.187365] Dynamic subtest vecs0: SUCCESS (4.240s) [64.195289] Starting dynamic subtest: ccs0 [68.322190] Dynamic subtest ccs0: SUCCESS (4.127s) [68.330266] Starting dynamic subtest: vcs0 [72.379121] Dynamic subtest vcs0: SUCCESS (4.052s) [72.386709] Starting dynamic subtest: bcs0 [76.460116] Dynamic subtest bcs0: SUCCESS (4.078s) [76.467620] Starting dynamic subtest: vecs1 [80.628824] Dynamic subtest vecs1: SUCCESS (4.160s) [80.636489] Starting dynamic subtest: rcs0 [84.865347] Dynamic subtest rcs0: SUCCESS (4.242s) [84.874425] Starting dynamic subtest: vcs1 [88.976223] Dynamic subtest vcs1: SUCCESS (4.109s) [88.977183] Subtest nopreempt: SUCCESS (29.010s) [89.116975] [004/131] (930s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [89.318581] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [89.320302] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [89.448377] [005/131] (930s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [89.653246] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [89.702684] [006/131] (930s left) gem_mmap_offset (open-flood) [89.775012] Starting subtest: open-flood [111.264937] Subtest open-flood: SUCCESS (21.487s) [111.427021] [007/131] (908s left) gem_exec_schedule (implicit-read-write) [111.516423] Starting subtest: implicit-read-write [111.517439] Starting dynamic subtest: rcs0 [111.805901] Dynamic subtest rcs0: SUCCESS (0.281s) [111.813559] Starting dynamic subtest: bcs0 [111.999235] Dynamic subtest bcs0: SUCCESS (0.195s) [112.007064] Starting dynamic subtest: vcs0 [112.206886] Dynamic subtest vcs0: SUCCESS (0.204s) [112.214532] Starting dynamic subtest: vcs1 [112.417254] Dynamic subtest vcs1: SUCCESS (0.209s) [112.424850] Starting dynamic subtest: vecs0 [112.618409] Dynamic subtest vecs0: SUCCESS (0.203s) [112.626152] Starting dynamic subtest: vecs1 [112.822770] Dynamic subtest vecs1: SUCCESS (0.206s) [112.830519] Starting dynamic subtest: ccs0 [113.086455] Dynamic subtest ccs0: SUCCESS (0.260s) [113.087494] Subtest implicit-read-write: SUCCESS (1.561s) [113.518314] [008/131] (906s left) kms_setmode (basic) [113.591172] Starting subtest: basic [113.757430] Starting dynamic subtest: pipe-A-DP-4 [115.924510] Dynamic subtest pipe-A-DP-4: SUCCESS (2.164s) [116.053708] Starting dynamic subtest: pipe-B-DP-4 [118.211621] Dynamic subtest pipe-B-DP-4: SUCCESS (2.162s) [118.285466] Subtest basic: SUCCESS (4.693s) [118.554496] [009/131] (901s left) gem_exec_reloc (basic-write-gtt-active) [118.635160] Subtest basic-write-gtt-active: SKIP (0.000s) [118.709727] [010/131] (901s left) gem_ctx_param (invalid-param-get) [118.782458] Starting subtest: invalid-param-get [118.784427] Subtest invalid-param-get: SUCCESS (0.001s) [118.952621] [011/131] (901s left) gem_ctx_isolation (nonpriv-switch) [119.033955] Starting subtest: nonpriv-switch [119.034991] Starting dynamic subtest: rcs0 [119.828795] Dynamic subtest rcs0: SUCCESS (0.794s) [119.837407] Starting dynamic subtest: bcs0 [120.695401] Dynamic subtest bcs0: SUCCESS (0.866s) [120.703363] Starting dynamic subtest: vcs0 [121.545854] Dynamic subtest vcs0: SUCCESS (0.850s) [121.553996] Starting dynamic subtest: vcs1 [122.393354] Dynamic subtest vcs1: SUCCESS (0.847s) [122.401451] Starting dynamic subtest: vecs0 [123.236941] Dynamic subtest vecs0: SUCCESS (0.843s) [123.244994] Starting dynamic subtest: vecs1 [124.132949] Dynamic subtest vecs1: SUCCESS (0.895s) [124.140980] Starting dynamic subtest: ccs0 [125.027536] Dynamic subtest ccs0: SUCCESS (0.895s) [125.028475] Subtest nonpriv-switch: SUCCESS (5.993s) [125.277514] [012/131] (895s left) gem_eio (wait-immediate) [125.544111] Starting subtest: wait-immediate [126.084453] Subtest wait-immediate: SUCCESS (0.541s) [126.293694] [013/131] (894s left) kms_hdr (invalid-hdr) [126.505118] Starting subtest: invalid-hdr [126.507972] Subtest invalid-hdr: SKIP (0.000s) [126.598350] [014/131] (893s left) gem_exec_schedule (u-fairslice) [126.679102] Starting subtest: u-fairslice [126.679984] Starting dynamic subtest: rcs0 [128.723167] Dynamic subtest rcs0: SUCCESS (2.043s) [128.731673] Starting dynamic subtest: bcs0 [130.740537] Dynamic subtest bcs0: SUCCESS (2.017s) [130.749194] Starting dynamic subtest: vcs0 [132.757292] Dynamic subtest vcs0: SUCCESS (2.016s) [132.765526] Starting dynamic subtest: vcs1 [134.775986] Dynamic subtest vcs1: SUCCESS (2.018s) [134.784501] Starting dynamic subtest: vecs0 [136.792480] Dynamic subtest vecs0: SUCCESS (2.016s) [136.800586] Starting dynamic subtest: vecs1 [138.810949] Dynamic subtest vecs1: SUCCESS (2.018s) [138.819275] Starting dynamic subtest: ccs0 [140.827638] Dynamic subtest ccs0: SUCCESS (2.016s) [140.828687] Subtest u-fairslice: SUCCESS (14.147s) [141.203138] [015/131] (879s left) gem_media_fill (media-fill) [141.276164] Subtest media-fill: SKIP (0.000s) [141.375755] [016/131] (879s left) api_intel_allocator (standalone) [141.446270] Starting subtest: standalone [141.484549] Subtest standalone: SUCCESS (0.039s) [141.631397] [017/131] (878s left) api_intel_bb (simple-bb-ctx) [141.704181] Starting subtest: simple-bb-ctx [141.732229] Subtest simple-bb-ctx: SUCCESS (0.028s) [141.927596] [018/131] (878s left) i915_hangman (error-state-basic) [142.020533] Starting subtest: error-state-basic [142.241225] Subtest error-state-basic: SUCCESS (0.221s) [142.331814] [019/131] (878s left) kms_lease (lease-get) [142.539998] Starting subtest: lease-get [142.540960] Starting dynamic subtest: pipe-A-DP-4 [142.541911] Dynamic subtest pipe-A-DP-4: SUCCESS (0.001s) [142.551627] Starting dynamic subtest: pipe-B-DP-4 [142.552520] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s) [142.560590] Starting dynamic subtest: pipe-C-DP-4 [142.561638] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s) [142.569588] Starting dynamic subtest: pipe-D-DP-4 [142.570712] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s) [142.571840] Subtest lease-get: SUCCESS (0.011s) [142.680602] [020/131] (878s left) perf (enable-disable) [143.008482] Starting subtest: enable-disable [143.009378] Starting dynamic subtest: 0-rcs0 [145.239012] Dynamic subtest 0-rcs0: SUCCESS (2.230s) [145.239989] Subtest enable-disable: SUCCESS (2.231s) [145.292797] [021/131] (875s left) kms_flip (2x-flip-vs-wf_vblank) [145.500145] Starting subtest: 2x-flip-vs-wf_vblank [145.515496] Subtest 2x-flip-vs-wf_vblank: SKIP (0.016s) [145.617181] [022/131] (875s left) kms_atomic_interruptible (atomic-setmode) [145.825161] Starting subtest: atomic-setmode [145.826162] Starting dynamic subtest: pipe-A-DP-4 [152.148701] Dynamic subtest pipe-A-DP-4: SUCCESS (6.322s) [152.149644] Subtest atomic-setmode: SUCCESS (6.324s) [152.373670] [023/131] (868s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [152.572228] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [152.573168] Starting dynamic subtest: pipe-A-DP-4 [152.581917] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [152.590155] Starting dynamic subtest: pipe-B-DP-4 [152.598920] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [152.607128] Starting dynamic subtest: pipe-C-DP-4 [152.615577] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [152.623548] Starting dynamic subtest: pipe-D-DP-4 [152.632149] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [152.634007] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s) [153.056328] [024/131] (867s left) gen9_exec_parse (unaligned-access) [153.128805] Subtest unaligned-access: SKIP (0.000s) [153.187927] [025/131] (867s left) gem_linear_blits (normal) [153.727026] Starting subtest: normal [160.482930] Subtest normal: SUCCESS (6.756s) [160.694455] [026/131] (860s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [160.808501] Starting subtest: multi-wait-available-unsubmitted-signaled [160.809408] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [160.891301] [027/131] (860s left) kms_dp_link_training (uhbr-sst) [161.096426] Starting subtest: uhbr-sst [161.098170] Subtest uhbr-sst: SKIP (0.000s) [161.176476] [028/131] (860s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [161.392164] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [162.620138] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.227s) [162.843827] [029/131] (858s left) perf_pmu (interrupts-sync) [162.909138] Starting subtest: interrupts-sync [164.093137] Subtest interrupts-sync: SUCCESS (1.182s) [164.218634] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true [164.220739] [030/131] (857s left) gem_exec_fence (submit-chain) [164.427638] Starting subtest: submit-chain [164.467265] Subtest submit-chain: SUCCESS (0.040s) [165.181708] [031/131] (856s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [165.487137] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [165.641678] [032/131] (855s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [165.854804] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [165.856498] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [165.979944] [033/131] (855s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [166.189648] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [166.191397] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [166.334805] [034/131] (855s left) perf_pmu (semaphore-wait) [166.405432] Starting subtest: semaphore-wait [166.406446] Starting dynamic subtest: rcs0 [166.938654] Dynamic subtest rcs0: SUCCESS (0.532s) [166.952159] Starting dynamic subtest: bcs0 [167.452354] Dynamic subtest bcs0: SUCCESS (0.510s) [167.465973] Starting dynamic subtest: vcs0 [167.966961] Dynamic subtest vcs0: SUCCESS (0.511s) [167.980332] Starting dynamic subtest: vcs1 [168.481041] Dynamic subtest vcs1: SUCCESS (0.510s) [168.494279] Starting dynamic subtest: vecs0 [168.995083] Dynamic subtest vecs0: SUCCESS (0.510s) [169.008376] Starting dynamic subtest: vecs1 [169.507503] Dynamic subtest vecs1: SUCCESS (0.509s) [169.521078] Starting dynamic subtest: ccs0 [170.020507] Dynamic subtest ccs0: SUCCESS (0.509s) [170.022585] Subtest semaphore-wait: SUCCESS (3.616s) [170.184735] [035/131] (851s left) kms_invalid_mode (bad-hsync-start) [170.400339] Starting subtest: bad-hsync-start [170.401237] Starting dynamic subtest: pipe-A-DP-4 [170.473613] Dynamic subtest pipe-A-DP-4: SUCCESS (0.073s) [170.483576] Starting dynamic subtest: pipe-B-DP-4 [170.484573] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s) [170.494224] Starting dynamic subtest: pipe-C-DP-4 [170.495275] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s) [170.505134] Starting dynamic subtest: pipe-D-DP-4 [170.506080] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s) [170.506983] Subtest bad-hsync-start: SUCCESS (0.080s) [170.722859] [036/131] (851s left) gem_exec_balancer (bonded-true-hang) [171.050714] Starting subtest: bonded-true-hang [171.055405] Subtest bonded-true-hang: SKIP (0.000s) [171.176075] [037/131] (850s left) kms_plane (pixel-format-source-clamping) [171.382210] Starting subtest: pixel-format-source-clamping [171.407421] Starting dynamic subtest: pipe-A-plane-0 [179.724195] Dynamic subtest pipe-A-plane-0: SUCCESS (8.316s) [179.736243] Starting dynamic subtest: pipe-A-plane-3 [183.807744] Dynamic subtest pipe-A-plane-3: SUCCESS (4.083s) [183.818824] Starting dynamic subtest: pipe-A-plane-5 [183.819949] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s) [184.044990] Starting dynamic subtest: pipe-B-plane-0 [191.395509] Dynamic subtest pipe-B-plane-0: SUCCESS (7.366s) [191.438410] Starting dynamic subtest: pipe-B-plane-3 [195.644161] Dynamic subtest pipe-B-plane-3: SUCCESS (4.245s) [195.655769] Starting dynamic subtest: pipe-B-plane-5 [195.656871] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s) [195.720244] Subtest pixel-format-source-clamping: SUCCESS (24.337s) [196.052923] [038/131] (825s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [196.272307] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [197.511723] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.222s) [197.665444] [039/131] (824s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [197.754392] Starting subtest: y-tiled-to-vebox-y-tiled [197.756477] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [198.027080] [040/131] (823s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [198.242200] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [198.244028] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [198.529334] [041/131] (823s left) fbdev (eof) [198.594130] Starting subtest: eof [198.595163] Subtest eof: SUCCESS (0.000s) [198.697100] [042/131] (823s left) kms_psr (fbc-psr-no-drrs) [198.905445] Subtest fbc-psr-no-drrs: SKIP (0.000s) [198.967389] [043/131] (823s left) perf_pmu (busy-no-semaphores) [199.036495] Starting subtest: busy-no-semaphores [199.037458] Starting dynamic subtest: rcs0 [199.606131] Dynamic subtest rcs0: SUCCESS (0.568s) [199.620846] Starting dynamic subtest: bcs0 [200.162201] Dynamic subtest bcs0: SUCCESS (0.552s) [200.176937] Starting dynamic subtest: vcs0 [200.715746] Dynamic subtest vcs0: SUCCESS (0.549s) [200.730879] Starting dynamic subtest: vcs1 [201.270124] Dynamic subtest vcs1: SUCCESS (0.550s) [201.284913] Starting dynamic subtest: vecs0 [201.825100] Dynamic subtest vecs0: SUCCESS (0.550s) [201.839796] Starting dynamic subtest: vecs1 [202.379910] Dynamic subtest vecs1: SUCCESS (0.550s) [202.394812] Starting dynamic subtest: ccs0 [202.934924] Dynamic subtest ccs0: SUCCESS (0.551s) [202.937106] Subtest busy-no-semaphores: SUCCESS (3.899s) [203.113495] [044/131] (819s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [203.326285] Starting subtest: fbc-rgb565-draw-pwrite [207.394984] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.068s) [207.604512] [045/131] (814s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [207.812167] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [207.813075] Starting dynamic subtest: pipe-A-valid-mode [209.463818] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.648s) [209.465470] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SUCCESS (1.651s) [209.727978] [046/131] (812s left) gem_flink_basic (basic) [209.806427] Starting subtest: basic [209.807414] Subtest basic: SUCCESS (0.000s) [209.949111] [047/131] (812s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [210.029062] Starting subtest: etime-multi-wait-available-unsubmitted [210.129502] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.100s) [210.281337] [048/131] (812s left) syncobj_wait (wait-any-snapshot) [210.359166] Starting subtest: wait-any-snapshot [210.442276] Subtest wait-any-snapshot: SUCCESS (0.082s) [210.584194] [049/131] (812s left) gem_exec_whisper (basic-contexts-priority-all) [210.675614] Starting subtest: basic-contexts-priority-all [232.970406] Subtest basic-contexts-priority-all: SUCCESS (22.292s) [233.235621] [050/131] (789s left) gen3_render_linear_blits [233.392539] [051/131] (789s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [233.605360] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [233.607165] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [233.768961] [052/131] (789s left) drm_fdinfo (busy-idle) [233.838422] Starting subtest: busy-idle [233.839352] Starting dynamic subtest: rcs0 [233.874602] Dynamic subtest rcs0: SKIP (0.035s) [233.886800] Starting dynamic subtest: bcs0 [233.888818] Dynamic subtest bcs0: SKIP (0.000s) [233.901029] Starting dynamic subtest: vcs0 [233.903131] Dynamic subtest vcs0: SKIP (0.000s) [233.915300] Starting dynamic subtest: vcs1 [233.917545] Dynamic subtest vcs1: SKIP (0.000s) [233.929471] Starting dynamic subtest: vecs0 [233.931469] Dynamic subtest vecs0: SKIP (0.000s) [233.941337] Starting dynamic subtest: vecs1 [233.943334] Dynamic subtest vecs1: SKIP (0.000s) [233.952973] Starting dynamic subtest: ccs0 [233.954953] Dynamic subtest ccs0: SKIP (0.000s) [233.956979] Subtest busy-idle: SKIP (0.044s) [233.998807] [053/131] (788s left) gem_exec_fence (concurrent) [234.209429] Starting subtest: concurrent [234.211512] Subtest concurrent: SKIP (0.000s) [234.878750] [054/131] (788s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [235.087872] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [235.089532] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [235.265090] [055/131] (787s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [235.477972] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [235.483459] Starting dynamic subtest: A-DP4 [236.428608] Dynamic subtest A-DP4: SUCCESS (0.944s) [236.440839] Starting dynamic subtest: B-DP4 [237.150623] Dynamic subtest B-DP4: SUCCESS (0.721s) [237.161063] Starting dynamic subtest: C-DP4 [237.868918] Dynamic subtest C-DP4: SUCCESS (0.717s) [237.878937] Starting dynamic subtest: D-DP4 [238.610703] Dynamic subtest D-DP4: SUCCESS (0.741s) [238.611595] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.133s) [238.918910] [056/131] (784s left) gem_pxp (verify-pxp-stale-ctx-execution) [241.525464] Starting subtest: verify-pxp-stale-ctx-execution [241.527471] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s) [241.632072] [057/131] (781s left) kms_big_fb (y-tiled-64bpp-rotate-0) [241.846650] Starting subtest: y-tiled-64bpp-rotate-0 [241.848421] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [241.978314] [058/131] (781s left) kms_force_connector_basic (prune-stale-modes) [242.090628] Starting subtest: prune-stale-modes [242.116065] Subtest prune-stale-modes: SUCCESS (0.025s) [242.435405] [059/131] (780s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [242.516782] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [242.517684] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [242.653878] [060/131] (780s left) gem_ctx_param (get-priority-new-ctx) [242.735746] Starting subtest: get-priority-new-ctx [242.738210] Subtest get-priority-new-ctx: SUCCESS (0.001s) [242.894127] [061/131] (780s left) kms_cursor_crc (cursor-random-128x42) [243.256495] Starting subtest: cursor-random-128x42 [243.261874] Starting dynamic subtest: pipe-A-DP-4 [247.826580] Dynamic subtest pipe-A-DP-4: SUCCESS (4.563s) [247.879339] Starting dynamic subtest: pipe-D-DP-4 [252.266344] Dynamic subtest pipe-D-DP-4: SUCCESS (4.397s) [252.267321] Subtest cursor-random-128x42: SUCCESS (9.010s) [252.652787] [062/131] (770s left) kms_plane_scaling (2x-scaler-multi-pipe) [252.871727] Starting subtest: 2x-scaler-multi-pipe [252.874970] Subtest 2x-scaler-multi-pipe: SKIP (0.002s) [253.024131] [063/131] (770s left) kms_atomic (atomic-invalid-params) [253.231272] Starting subtest: atomic-invalid-params [253.232196] Starting dynamic subtest: pipe-A-DP-4 [253.838066] Dynamic subtest pipe-A-DP-4: SUCCESS (0.605s) [253.839164] Subtest atomic-invalid-params: SUCCESS (0.608s) [254.113254] [064/131] (769s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [254.315574] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [254.316484] Starting dynamic subtest: pipe-A-DP-4 [254.889913] Dynamic subtest pipe-A-DP-4: SUCCESS (0.571s) [254.900210] Starting dynamic subtest: pipe-B-DP-4 [255.561818] Dynamic subtest pipe-B-DP-4: SUCCESS (0.670s) [255.572164] Starting dynamic subtest: pipe-C-DP-4 [256.248136] Dynamic subtest pipe-C-DP-4: SUCCESS (0.685s) [256.258407] Starting dynamic subtest: pipe-D-DP-4 [256.935156] Dynamic subtest pipe-D-DP-4: SUCCESS (0.685s) [256.936370] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SUCCESS (2.617s) [257.233981] [065/131] (766s left) perf (gen8-unprivileged-single-ctx-counters) [257.436722] Starting subtest: gen8-unprivileged-single-ctx-counters [257.438750] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [257.494939] [066/131] (766s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [257.575682] Starting subtest: etime-single-wait-for-submit-unsubmitted [257.691042] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s) [257.790462] [067/131] (766s left) gem_exec_flush (basic-wb-ro-before-default) [257.877287] Subtest basic-wb-ro-before-default: SKIP (0.000s) [257.959931] [068/131] (765s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [258.173282] Starting subtest: blocking-absolute-wf_vblank-interruptible [258.178727] Starting dynamic subtest: A-DP4 [265.998569] Dynamic subtest A-DP4: SUCCESS (7.819s) [266.013433] Starting dynamic subtest: B-DP4 [273.754789] Dynamic subtest B-DP4: SUCCESS (7.753s) [273.769401] Starting dynamic subtest: C-DP4 [281.483457] Dynamic subtest C-DP4: SUCCESS (7.724s) [281.495858] Starting dynamic subtest: D-DP4 [289.217395] Dynamic subtest D-DP4: SUCCESS (7.732s) [289.219952] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.043s) [289.555593] [069/131] (734s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [289.767079] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [289.768813] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [289.903291] [070/131] (734s left) gem_ctx_persistence (heartbeat-stop) [289.989669] Starting subtest: heartbeat-stop [289.991913] Subtest heartbeat-stop: SKIP (0.000s) [290.137048] [071/131] (734s left) kms_psr (fbc-psr-sprite-mmap-cpu) [290.347775] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [290.410488] [072/131] (733s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [290.625483] Starting subtest: plane-upscale-20x20-with-pixel-format [290.626250] Starting dynamic subtest: pipe-A [292.253402] Dynamic subtest pipe-A: SUCCESS (1.628s) [292.279666] Starting dynamic subtest: pipe-B [293.991544] Dynamic subtest pipe-B: SUCCESS (1.736s) [294.017820] Starting dynamic subtest: pipe-C [294.312810] Dynamic subtest pipe-C: SUCCESS (0.319s) [294.342770] Starting dynamic subtest: pipe-D [294.633853] Dynamic subtest pipe-D: SUCCESS (0.319s) [294.635230] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (4.010s) [294.961392] [073/131] (729s left) kms_flip (flip-vs-expired-vblank-interruptible) [295.173383] Starting subtest: flip-vs-expired-vblank-interruptible [295.178930] Starting dynamic subtest: A-DP4 [303.005249] Dynamic subtest A-DP4: SUCCESS (7.826s) [303.023554] Starting dynamic subtest: B-DP4 [310.753302] Dynamic subtest B-DP4: SUCCESS (7.746s) [310.767335] Starting dynamic subtest: C-DP4 [318.485298] Dynamic subtest C-DP4: SUCCESS (7.730s) [318.500089] Starting dynamic subtest: D-DP4 [326.244784] Dynamic subtest D-DP4: SUCCESS (7.757s) [326.251195] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.073s) [326.564702] [074/131] (697s left) gem_lmem_swapping (parallel-random-verify) [329.475671] Starting subtest: parallel-random-verify [329.476621] Starting dynamic subtest: lmem0 [386.008767] Dynamic subtest lmem0: SUCCESS (56.530s) [386.009869] Subtest parallel-random-verify: SUCCESS (56.531s) [387.406494] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [387.407508] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true [387.409575] [075/131] (637s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [391.685261] Starting subtest: modeset-atomic-cursor-hotspot [391.687035] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [391.784478] [FACT kms_cursor_legacy (modeset-atomic-cursor-hotspot)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [391.787793] [FACT kms_cursor_legacy (modeset-atomic-cursor-hotspot)] new: kernel.kmod_is_loaded.amdgpu: true [391.787914] [FACT kms_cursor_legacy (modeset-atomic-cursor-hotspot)] new: kernel.kmod_is_loaded.i915: true [391.788777] [FACT kms_cursor_legacy (modeset-atomic-cursor-hotspot)] new: kernel.kmod_is_loaded.xe: true [391.790910] [076/131] (632s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [392.007922] Starting subtest: fbc-rgb101010-draw-pwrite [395.010787] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.003s) [395.196347] [077/131] (629s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [395.405654] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [395.407444] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [395.731740] [078/131] (628s left) gem_userptr_blits (process-exit-busy) [395.831361] Starting subtest: process-exit-busy [395.852011] Subtest process-exit-busy: SUCCESS (0.021s) [396.016107] [079/131] (628s left) gem_eio (throttle) [396.253432] Starting subtest: throttle [396.579599] Subtest throttle: SUCCESS (0.326s) [396.793114] [080/131] (627s left) gem_exec_create (basic) [396.884191] Starting subtest: basic [396.885157] Starting dynamic subtest: smem [398.987259] Dynamic subtest smem: SUCCESS (2.102s) [398.998591] Starting dynamic subtest: lmem0 [401.093038] Dynamic subtest lmem0: SUCCESS (2.105s) [401.094042] Subtest basic: SUCCESS (4.209s) [401.324652] [081/131] (623s left) gem_ccs (ctrl-surf-copy-new-ctx) [401.411690] Starting subtest: ctrl-surf-copy-new-ctx [401.412604] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [401.463542] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.051s) [401.473931] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [401.678600] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.214s) [401.688764] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [401.705298] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s) [401.716183] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [401.922595] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.216s) [401.932827] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [401.949875] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s) [401.960179] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [402.165383] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.214s) [402.175404] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [402.193176] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.027s) [402.203885] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [402.410410] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.216s) [402.411402] Subtest ctrl-surf-copy-new-ctx: SUCCESS (0.999s) [402.589132] [082/131] (622s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [402.672244] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s) [402.740645] [083/131] (622s left) syncobj_wait (invalid-signal-zero-handles) [402.819937] Starting subtest: invalid-signal-zero-handles [402.820885] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [402.947334] [084/131] (622s left) gem_mmap_wc (write-wc-read-gtt) [403.029387] Subtest write-wc-read-gtt: SKIP (0.000s) [403.095107] [085/131] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [403.306437] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [403.308169] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [403.425853] [086/131] (621s left) gem_madvise (dontneed-before-exec) [403.478169] Starting subtest: dontneed-before-exec [403.509557] Subtest dontneed-before-exec: SKIP (0.030s) [403.572581] [087/131] (621s left) kms_color (invalid-degamma-lut-sizes) [403.779406] Starting subtest: invalid-degamma-lut-sizes [403.780315] Starting dynamic subtest: pipe-A [403.858512] Dynamic subtest pipe-A: SUCCESS (0.079s) [403.868537] Starting dynamic subtest: pipe-B [403.869445] Dynamic subtest pipe-B: SUCCESS (0.001s) [403.879364] Starting dynamic subtest: pipe-C [403.880257] Dynamic subtest pipe-C: SUCCESS (0.001s) [403.890170] Starting dynamic subtest: pipe-D [403.890992] Dynamic subtest pipe-D: SUCCESS (0.001s) [403.891767] Subtest invalid-degamma-lut-sizes: SUCCESS (0.085s) [404.080723] [088/131] (621s left) gem_softpin (zero) [404.169147] Starting subtest: zero [404.173622] Subtest zero: SUCCESS (0.004s) [404.373618] [089/131] (620s left) gem_userptr_blits (sync-unmap-cycles) [404.467078] Starting subtest: sync-unmap-cycles [409.843616] Subtest sync-unmap-cycles: SUCCESS (5.376s) [410.058879] [090/131] (615s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [410.144222] Starting subtest: wait-all-for-submit-delayed-submit [410.249563] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s) [410.352146] [091/131] (615s left) gem_ctx_persistence (idempotent) [410.441658] Starting subtest: idempotent [410.442718] Subtest idempotent: SUCCESS (0.000s) [410.601117] [092/131] (614s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20) [410.809513] Starting subtest: planes-downscale-factor-0-25-upscale-20x20 [410.810382] Starting dynamic subtest: pipe-A [411.573301] Dynamic subtest pipe-A: SKIP (0.761s) [411.583303] Starting dynamic subtest: pipe-B [412.722788] Dynamic subtest pipe-B: SKIP (1.149s) [412.732732] Starting dynamic subtest: pipe-C [413.871439] Dynamic subtest pipe-C: SKIP (1.148s) [413.881461] Starting dynamic subtest: pipe-D [415.021984] Dynamic subtest pipe-D: SKIP (1.149s) [415.023445] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (4.211s) [415.133585] [093/131] (610s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [415.346400] Starting subtest: cursorA-vs-flipA-toggle [426.258427] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.911s) [426.508341] [094/131] (599s left) i915_pm_rps (thresholds-park) [426.596936] Starting subtest: thresholds-park [426.598852] Subtest thresholds-park: SKIP (0.000s) [426.717798] [095/131] (599s left) perf (oa-formats) [427.073430] Starting subtest: oa-formats [427.074330] Starting dynamic subtest: 0-rcs0 [427.097816] Dynamic subtest 0-rcs0: SUCCESS (0.024s) [427.098748] Subtest oa-formats: SUCCESS (0.025s) [427.162935] [096/131] (598s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [427.370671] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [427.371564] Starting dynamic subtest: pipe-A-valid-mode [429.961237] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.586s) [429.963105] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SUCCESS (2.589s) [430.209290] [097/131] (595s left) i915_suspend (forcewake) [430.302422] Starting subtest: forcewake [468.396183] Subtest forcewake: SUCCESS (7.012s) [472.501203] [098/131] (588s left) kms_flip (bo-too-big-interruptible) [472.724128] Starting subtest: bo-too-big-interruptible [472.728326] Starting dynamic subtest: A-DP4 [473.023613] Dynamic subtest A-DP4: SUCCESS (0.294s) [473.062739] Starting dynamic subtest: B-DP4 [473.258555] Dynamic subtest B-DP4: SUCCESS (0.230s) [473.295135] Starting dynamic subtest: C-DP4 [473.492097] Dynamic subtest C-DP4: SUCCESS (0.229s) [473.527619] Starting dynamic subtest: D-DP4 [473.720183] Dynamic subtest D-DP4: SUCCESS (0.223s) [473.724643] Subtest bo-too-big-interruptible: SUCCESS (0.999s) [474.100135] [099/131] (586s left) kms_cursor_crc (cursor-sliding-max-size) [474.557278] Starting subtest: cursor-sliding-max-size [474.560042] Subtest cursor-sliding-max-size: SKIP (0.000s) [474.776935] [100/131] (586s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [474.995451] Starting subtest: yf-tiled-16bpp-rotate-90 [474.997257] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [475.126386] [101/131] (586s left) kms_big_fb (linear-8bpp-rotate-0) [475.345479] Starting subtest: linear-8bpp-rotate-0 [476.877597] Subtest linear-8bpp-rotate-0: SUCCESS (1.531s) [477.100043] [102/131] (584s left) kms_psr (psr2-sprite-plane-onoff) [477.317067] Subtest psr2-sprite-plane-onoff: SKIP (0.000s) [477.368180] [103/131] (583s left) kms_vrr (flip-dpms) [477.576883] Starting subtest: flip-dpms [477.579634] Subtest flip-dpms: SKIP (0.000s) [477.675761] [104/131] (583s left) kms_busy (basic) [477.905263] Starting subtest: basic [477.908088] Starting dynamic subtest: flip [478.530730] Dynamic subtest flip: SUCCESS (0.622s) [478.561324] Starting dynamic subtest: modeset [479.564630] Dynamic subtest modeset: SUCCESS (1.030s) [479.565863] Subtest basic: SUCCESS (1.659s) [479.820758] [105/131] (581s left) kms_pm_rpm (fences-dpms) [482.189956] Starting subtest: fences-dpms [482.192183] Subtest fences-dpms: SKIP (0.000s) [482.567797] [106/131] (578s left) gem_exec_reloc (basic-cpu-noreloc) [482.657894] Subtest basic-cpu-noreloc: SKIP (0.000s) [482.717791] [107/131] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [482.935365] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [482.937283] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [483.078180] [108/131] (578s left) gem_set_tiling_vs_blt (tiled-to-untiled) [483.163973] Subtest tiled-to-untiled: SKIP (0.000s) [483.234576] [109/131] (578s left) gem_close_race (basic-process) [483.348896] Starting subtest: basic-process [483.422393] Subtest basic-process: SUCCESS (0.073s) [483.727601] [110/131] (578s left) gem_mmap (big-bo) [483.818341] Subtest big-bo: SKIP (0.000s) [483.927354] [111/131] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [484.144842] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [484.146554] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [484.274623] [112/131] (577s left) kms_plane_cursor (overlay) [484.492171] Starting subtest: overlay [484.493959] Starting dynamic subtest: pipe-A-DP-4-size-64 [488.025232] Dynamic subtest pipe-A-DP-4-size-64: SUCCESS (3.533s) [488.137007] Starting dynamic subtest: pipe-A-DP-4-size-128 [491.708891] Dynamic subtest pipe-A-DP-4-size-128: SUCCESS (3.614s) [491.790215] Starting dynamic subtest: pipe-A-DP-4-size-256 [495.309070] Dynamic subtest pipe-A-DP-4-size-256: SUCCESS (3.532s) [495.495432] Starting dynamic subtest: pipe-B-DP-4-size-64 [499.162679] Dynamic subtest pipe-B-DP-4-size-64: SUCCESS (3.689s) [499.228710] Starting dynamic subtest: pipe-B-DP-4-size-128 [502.813098] Dynamic subtest pipe-B-DP-4-size-128: SUCCESS (3.598s) [502.874611] Starting dynamic subtest: pipe-B-DP-4-size-256 [506.446409] Dynamic subtest pipe-B-DP-4-size-256: SUCCESS (3.583s) [506.583365] Starting dynamic subtest: pipe-C-DP-4-size-64 [510.085327] Dynamic subtest pipe-C-DP-4-size-64: SUCCESS (3.523s) [510.175457] Starting dynamic subtest: pipe-C-DP-4-size-128 [513.702094] Dynamic subtest pipe-C-DP-4-size-128: SUCCESS (3.564s) [513.771136] Starting dynamic subtest: pipe-C-DP-4-size-256 [517.168856] Dynamic subtest pipe-C-DP-4-size-256: SUCCESS (3.416s) [517.296098] Starting dynamic subtest: pipe-D-DP-4-size-64 [520.869735] Dynamic subtest pipe-D-DP-4-size-64: SUCCESS (3.589s) [520.959800] Starting dynamic subtest: pipe-D-DP-4-size-128 [524.471283] Dynamic subtest pipe-D-DP-4-size-128: SUCCESS (3.549s) [524.549897] Starting dynamic subtest: pipe-D-DP-4-size-256 [528.003407] Dynamic subtest pipe-D-DP-4-size-256: SUCCESS (3.482s) [528.114600] Subtest overlay: SUCCESS (43.620s) [528.367139] [113/131] (533s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [528.593076] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [528.644345] [114/131] (533s left) gem_exec_schedule (promotion) [528.741418] Starting subtest: promotion [528.742325] Starting dynamic subtest: rcs0 [529.024950] Dynamic subtest rcs0: SUCCESS (0.277s) [529.037776] Starting dynamic subtest: bcs0 [529.224908] Dynamic subtest bcs0: SUCCESS (0.197s) [529.237670] Starting dynamic subtest: vcs0 [529.437374] Dynamic subtest vcs0: SUCCESS (0.207s) [529.449911] Starting dynamic subtest: vcs1 [529.645336] Dynamic subtest vcs1: SUCCESS (0.209s) [529.657996] Starting dynamic subtest: vecs0 [529.851499] Dynamic subtest vecs0: SUCCESS (0.208s) [529.864059] Starting dynamic subtest: vecs1 [530.081794] Dynamic subtest vecs1: SUCCESS (0.226s) [530.094625] Starting dynamic subtest: ccs0 [530.295281] Dynamic subtest ccs0: SUCCESS (0.215s) [530.296276] Subtest promotion: SUCCESS (1.546s) [530.797900] [115/131] (531s left) kms_universal_plane (cursor-fb-leak) [531.006601] Starting subtest: cursor-fb-leak [531.007467] Starting dynamic subtest: pipe-A-DP-4 [531.487212] Dynamic subtest pipe-A-DP-4: SUCCESS (0.479s) [531.521991] Starting dynamic subtest: pipe-B-DP-4 [532.028142] Dynamic subtest pipe-B-DP-4: SUCCESS (0.535s) [532.045609] Starting dynamic subtest: pipe-C-DP-4 [532.575876] Dynamic subtest pipe-C-DP-4: SUCCESS (0.544s) [532.603483] Starting dynamic subtest: pipe-D-DP-4 [533.124574] Dynamic subtest pipe-D-DP-4: SUCCESS (0.540s) [533.126087] Subtest cursor-fb-leak: SUCCESS (2.120s) [533.462884] [116/131] (528s left) gem_vm_create (invalid-destroy) [533.551515] Starting subtest: invalid-destroy [533.555221] Subtest invalid-destroy: SUCCESS (0.004s) [533.705886] [117/131] (528s left) kms_sequence (queue-busy) [533.921190] Starting subtest: queue-busy [533.922303] Starting dynamic subtest: pipe-A-DP-4 [536.485271] Dynamic subtest pipe-A-DP-4: SUCCESS (2.562s) [536.502408] Starting dynamic subtest: pipe-B-DP-4 [538.977736] Dynamic subtest pipe-B-DP-4: SUCCESS (2.492s) [538.991951] Starting dynamic subtest: pipe-C-DP-4 [541.448821] Dynamic subtest pipe-C-DP-4: SUCCESS (2.469s) [541.463247] Starting dynamic subtest: pipe-D-DP-4 [543.929109] Dynamic subtest pipe-D-DP-4: SUCCESS (2.478s) [543.930120] Subtest queue-busy: SUCCESS (10.008s) [544.208234] [118/131] (518s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [544.425885] Starting subtest: psr-1p-primscrn-cur-indfb-move [544.427667] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [544.566086] [119/131] (517s left) kms_prop_blob (blob-prop-validate) [544.645361] Starting subtest: blob-prop-validate [544.646323] Subtest blob-prop-validate: SUCCESS (0.000s) [544.817498] [120/131] (517s left) kms_big_fb (4-tiled-16bpp-rotate-0) [545.036765] Starting subtest: 4-tiled-16bpp-rotate-0 [546.696819] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.659s) [546.896043] [121/131] (515s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [547.103163] Starting subtest: primary-y-tiled-reflect-x-90 [547.104943] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [547.192750] [122/131] (515s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [547.402132] Starting subtest: psr-rgb565-draw-mmap-gtt [547.403868] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [547.524517] [123/131] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [547.750402] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [547.752340] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [547.906399] [124/131] (514s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [547.985810] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [547.986780] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [548.168413] [125/131] (514s left) kms_chamelium_color (ctm-negative) [548.378901] Subtest ctm-negative: SKIP (0.000s) [548.438959] [126/131] (514s left) gem_exec_balancer (fairslice) [548.525821] Starting subtest: fairslice [553.867118] Subtest fairslice: SUCCESS (5.341s) [554.237463] [127/131] (508s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [554.454132] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [554.455054] Starting dynamic subtest: pipe-A-DP-4 [593.447093] Dynamic subtest pipe-A-DP-4: SUCCESS (8.429s) [593.463142] Starting dynamic subtest: pipe-B-DP-4 [632.102693] Dynamic subtest pipe-B-DP-4: SUCCESS (7.429s) [632.116936] Starting dynamic subtest: pipe-C-DP-4 [671.099422] Dynamic subtest pipe-C-DP-4: SUCCESS (7.553s) [671.120967] Starting dynamic subtest: pipe-D-DP-4 [710.093905] Dynamic subtest pipe-D-DP-4: SUCCESS (7.549s) [710.094960] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SUCCESS (30.970s) [715.446230] [128/131] (477s left) kms_content_protection (lic-type-0) [715.715822] Starting subtest: lic-type-0 [715.752995] Starting dynamic subtest: pipe-A-DP-4 [839.736931] Dynamic subtest pipe-A-DP-4: FAIL (123.804s) [839.739049] Subtest lic-type-0: FAIL (123.946s) [839.992377] [129/131] (352s left) kms_psr (fbc-pr-primary-blt) [840.222937] Subtest fbc-pr-primary-blt: SKIP (0.000s) [840.280798] [130/131] (352s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [840.493134] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [840.494862] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [840.626178] [131/131] (352s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [840.702737] Starting subtest: multi-wait-for-submit-available-submitted-signaled [840.703645] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [840.825072] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: sysfs_heartbeat_interval results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_psr2_sf results: parsing output: 5/ for test: gem_mmap_offset results: parsing output: 6/ for test: gem_exec_schedule results: parsing output: 7/ for test: kms_setmode results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: gem_ctx_param results: parsing output: 10/ for test: gem_ctx_isolation results: parsing output: 11/ for test: gem_eio results: parsing output: 12/ for test: kms_hdr results: parsing output: 13/ for test: gem_exec_schedule results: parsing output: 14/ for test: gem_media_fill results: parsing output: 15/ for test: api_intel_allocator results: parsing output: 16/ for test: api_intel_bb results: parsing output: 17/ for test: i915_hangman results: parsing output: 18/ for test: kms_lease results: parsing output: 19/ for test: perf results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_atomic_interruptible results: parsing output: 22/ for test: kms_ccs results: parsing output: 23/ for test: gen9_exec_parse results: parsing output: 24/ for test: gem_linear_blits results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: kms_dp_link_training results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: perf_pmu results: parsing output: 29/ for test: gem_exec_fence results: parsing output: 30/ for test: kms_chamelium_hpd results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: perf_pmu results: parsing output: 34/ for test: kms_invalid_mode results: parsing output: 35/ for test: gem_exec_balancer results: parsing output: 36/ for test: kms_plane results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: gem_render_copy results: parsing output: 39/ for test: kms_ccs results: parsing output: 40/ for test: fbdev results: parsing output: 41/ for test: kms_psr results: parsing output: 42/ for test: perf_pmu results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_flip_scaled_crc results: parsing output: 45/ for test: gem_flink_basic results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: gem_exec_whisper results: parsing output: 49/ for test: gen3_render_linear_blits results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: drm_fdinfo results: parsing output: 52/ for test: gem_exec_fence results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: gem_pxp results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: kms_force_connector_basic results: parsing output: 58/ for test: syncobj_wait results: parsing output: 59/ for test: gem_ctx_param results: parsing output: 60/ for test: kms_cursor_crc results: parsing output: 61/ for test: kms_plane_scaling results: parsing output: 62/ for test: kms_atomic results: parsing output: 63/ for test: kms_ccs results: parsing output: 64/ for test: perf results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: gem_exec_flush results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_ctx_persistence results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_plane_scaling results: parsing output: 72/ for test: kms_flip results: parsing output: 73/ for test: gem_lmem_swapping results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: gem_userptr_blits results: parsing output: 78/ for test: gem_eio results: parsing output: 79/ for test: gem_exec_create results: parsing output: 80/ for test: gem_ccs results: parsing output: 81/ for test: sriov_basic results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: gem_mmap_wc results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_madvise results: parsing output: 86/ for test: kms_color results: parsing output: 87/ for test: gem_softpin results: parsing output: 88/ for test: gem_userptr_blits results: parsing output: 89/ for test: syncobj_timeline results: parsing output: 90/ for test: gem_ctx_persistence results: parsing output: 91/ for test: kms_plane_scaling results: parsing output: 92/ for test: kms_cursor_legacy results: parsing output: 93/ for test: i915_pm_rps results: parsing output: 94/ for test: perf results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: i915_suspend results: parsing output: 97/ for test: kms_flip results: parsing output: 98/ for test: kms_cursor_crc results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_vrr results: parsing output: 103/ for test: kms_busy results: parsing output: 104/ for test: kms_pm_rpm results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_set_tiling_vs_blt results: parsing output: 108/ for test: gem_close_race results: parsing output: 109/ for test: gem_mmap results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_plane_cursor results: parsing output: 112/ for test: kms_psr2_sf results: parsing output: 113/ for test: gem_exec_schedule results: parsing output: 114/ for test: kms_universal_plane results: parsing output: 115/ for test: gem_vm_create results: parsing output: 116/ for test: kms_sequence results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_prop_blob results: parsing output: 119/ for test: kms_big_fb results: parsing output: 120/ for test: kms_rotation_crc results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_chamelium_color results: parsing output: 125/ for test: gem_exec_balancer results: parsing output: 126/ for test: kms_ccs results: parsing output: 127/ for test: kms_content_protection results: parsing output: 128/ for test: kms_psr results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: syncobj_timeline Done.