[62.247693] Initializing watchdogs [62.247826] /dev/watchdog0 [62.263505] [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] [62.267929] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.270125] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.273733] [001/132] (960s left) kms_plane_alpha_blend (alpha-opaque-fb) [62.410062] Starting subtest: alpha-opaque-fb [62.700536] Starting dynamic subtest: pipe-A-eDP-1 [63.380278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.678s) [63.388663] Starting dynamic subtest: pipe-D-eDP-1 [64.756884] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.376s) [64.759286] Subtest alpha-opaque-fb: SUCCESS (2.348s) [65.588231] [002/132] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [65.695070] Starting subtest: fbc-rgb101010-draw-pwrite [71.105269] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.411s) [72.275011] [003/132] (950s left) kms_plane_scaling (planes-downscale-factor-0-75) [72.372751] Starting subtest: planes-downscale-factor-0-75 [72.375078] Starting dynamic subtest: pipe-A [72.395211] Dynamic subtest pipe-A: SKIP (0.019s) [72.402420] Starting dynamic subtest: pipe-B [72.432056] Dynamic subtest pipe-B: SKIP (0.037s) [72.439188] Starting dynamic subtest: pipe-C [72.470068] Dynamic subtest pipe-C: SKIP (0.037s) [72.477216] Starting dynamic subtest: pipe-D [72.502120] Dynamic subtest pipe-D: SKIP (0.032s) [72.506507] Subtest planes-downscale-factor-0-75: SKIP (0.126s) [72.601186] [004/132] (950s left) gem_exec_store (dword) [72.668568] Starting subtest: dword [72.670858] Starting dynamic subtest: rcs0 [72.719894] Dynamic subtest rcs0: SUCCESS (0.051s) [72.730490] Starting dynamic subtest: bcs0 [72.760407] Dynamic subtest bcs0: SUCCESS (0.040s) [72.769387] Starting dynamic subtest: vcs0 [72.802086] Dynamic subtest vcs0: SUCCESS (0.041s) [72.811071] Starting dynamic subtest: vcs1 [72.844199] Dynamic subtest vcs1: SUCCESS (0.041s) [72.853552] Starting dynamic subtest: vecs0 [72.886086] Dynamic subtest vecs0: SUCCESS (0.041s) [72.895230] Starting dynamic subtest: ccs0 [72.927677] Dynamic subtest ccs0: SUCCESS (0.041s) [72.930216] Subtest dword: SUCCESS (0.260s) [73.106551] [005/132] (949s left) kms_flip (2x-plain-flip-ts-check) [73.205381] Starting subtest: 2x-plain-flip-ts-check [73.216963] Subtest 2x-plain-flip-ts-check: SKIP (0.011s) [73.306121] [006/132] (949s left) perf_pmu (multi-client) [73.349435] Starting subtest: multi-client [73.351876] Starting dynamic subtest: rcs0 [74.411854] Dynamic subtest rcs0: SUCCESS (1.062s) [74.421755] Starting dynamic subtest: bcs0 [75.460246] Dynamic subtest bcs0: SUCCESS (1.048s) [75.470047] Starting dynamic subtest: vcs0 [76.510255] Dynamic subtest vcs0: SUCCESS (1.049s) [76.519870] Starting dynamic subtest: vcs1 [77.901230] Dynamic subtest vcs1: SUCCESS (1.390s) [77.910295] Starting dynamic subtest: vecs0 [79.947938] Dynamic subtest vecs0: SUCCESS (2.046s) [79.957310] Starting dynamic subtest: ccs0 [81.933521] Dynamic subtest ccs0: SUCCESS (1.984s) [81.936820] Subtest multi-client: SUCCESS (8.584s) [82.080178] [007/132] (940s left) syncobj_timeline (wait-all-complex) [82.144204] Starting subtest: wait-all-complex [82.358656] Subtest wait-all-complex: SUCCESS (0.213s) [82.430670] [008/132] (940s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [82.487922] Starting subtest: etime-single-wait-for-submit-unsubmitted [82.594260] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s) [82.673932] [009/132] (940s left) gem_softpin (evict-prime-sanity-check) [82.735816] Starting subtest: evict-prime-sanity-check [82.738226] Starting dynamic subtest: rcs0 [83.876583] Dynamic subtest rcs0: SUCCESS (1.140s) [83.886118] Starting dynamic subtest: bcs0 [85.006058] Dynamic subtest bcs0: SUCCESS (1.129s) [85.014780] Starting dynamic subtest: vcs0 [86.845119] Dynamic subtest vcs0: SUCCESS (1.836s) [86.856601] Starting dynamic subtest: vcs1 [88.914108] Dynamic subtest vcs1: SUCCESS (2.069s) [88.924396] Starting dynamic subtest: vecs0 [90.812934] Dynamic subtest vecs0: SUCCESS (1.897s) [90.821201] Starting dynamic subtest: ccs0 [91.952723] Dynamic subtest ccs0: SUCCESS (1.140s) [91.963059] Starting dynamic subtest: all [93.072286] Dynamic subtest all: SUCCESS (1.119s) [93.074845] Subtest evict-prime-sanity-check: SUCCESS (10.336s) [93.155156] [010/132] (930s left) gem_mmap_wc (close) [93.225054] Subtest close: SKIP (0.000s) [93.288079] [011/132] (929s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [93.352636] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [93.354994] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [93.462711] [012/132] (929s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [93.566550] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [100.937858] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.374s) [101.048971] [013/132] (922s left) gen3_render_tiledx_blits [101.163816] [014/132] (922s left) kms_selftest (drm_format) [101.198767] Starting subtest: drm_format [101.242556] Starting dynamic subtest: drm_test_format_block_width_invalid [101.332440] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.090s) [101.342347] Starting dynamic subtest: drm_test_format_block_width_one_plane [101.432354] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.098s) [101.441794] Starting dynamic subtest: drm_test_format_block_width_two_plane [101.535258] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.102s) [101.544878] Starting dynamic subtest: drm_test_format_block_width_three_plane [101.629152] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.093s) [101.636858] Starting dynamic subtest: drm_test_format_block_width_tiled [101.716364] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.088s) [101.723866] Starting dynamic subtest: drm_test_format_block_height_invalid [101.800476] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.084s) [101.809987] Starting dynamic subtest: drm_test_format_block_height_one_plane [101.883771] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.083s) [101.892994] Starting dynamic subtest: drm_test_format_block_height_two_plane [101.968087] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.082s) [101.977258] Starting dynamic subtest: drm_test_format_block_height_three_plane [102.053888] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.086s) [102.063264] Starting dynamic subtest: drm_test_format_block_height_tiled [102.151771] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.097s) [102.160988] Starting dynamic subtest: drm_test_format_min_pitch_invalid [102.236890] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.085s) [102.245920] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp [102.321983] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.084s) [102.330879] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp [102.406535] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.086s) [102.415742] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp [102.495087] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.086s) [102.504063] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp [102.580598] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.086s) [102.588295] Starting dynamic subtest: drm_test_format_min_pitch_two_plane [102.676442] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.095s) [102.683410] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp [102.757838] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.081s) [102.766125] Starting dynamic subtest: drm_test_format_min_pitch_tiled [102.844319] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.086s) [102.846052] Subtest drm_format: SUCCESS (1.645s) [102.978992] [015/132] (920s left) sw_sync (sync_multi_timeline_wait) [103.015117] Starting subtest: sync_multi_timeline_wait [103.016821] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [103.065934] [016/132] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [103.164401] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [103.167929] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [103.252190] [017/132] (920s left) perf (non-zero-reason) [103.367518] Starting subtest: non-zero-reason [103.369523] Starting dynamic subtest: 0-rcs0 [108.843905] Dynamic subtest 0-rcs0: SUCCESS (5.415s) [108.854045] Starting dynamic subtest: 1-vecs0 [112.697924] Dynamic subtest 1-vecs0: SUCCESS (3.914s) [112.700833] Subtest non-zero-reason: SUCCESS (9.330s) [112.742813] [018/132] (910s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [112.842570] Starting subtest: fbc-farfromfence-mmap-gtt [112.846650] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [112.939717] [019/132] (910s left) gem_ctx_create (basic) [113.004818] Starting subtest: basic [113.007150] Subtest basic: SUCCESS (0.000s) [113.196058] [020/132] (910s left) gem_ctx_persistence (heartbeat-many) [113.254427] Starting subtest: heartbeat-many [113.259123] Subtest heartbeat-many: SKIP (0.000s) [113.358425] [021/132] (910s left) kms_force_connector_basic (force-edid) [113.450667] Starting subtest: force-edid [113.814083] Subtest force-edid: SUCCESS (0.366s) [113.959038] [022/132] (909s left) drm_read (fault-buffer) [114.135273] Starting subtest: fault-buffer [114.137378] Subtest fault-buffer: SUCCESS (0.000s) [114.248418] [023/132] (909s left) syncobj_wait (wait-zero-handles) [114.313745] Starting subtest: wait-zero-handles [114.315535] Subtest wait-zero-handles: SUCCESS (0.000s) [114.431067] [024/132] (909s left) kms_flip (basic-flip-vs-wf_vblank) [114.524436] Starting subtest: basic-flip-vs-wf_vblank [114.526783] Starting dynamic subtest: A-eDP1 [116.420542] Dynamic subtest A-eDP1: SUCCESS (1.897s) [116.430367] Starting dynamic subtest: B-eDP1 [118.318489] Dynamic subtest B-eDP1: SUCCESS (1.897s) [118.327338] Starting dynamic subtest: C-eDP1 [120.207950] Dynamic subtest C-eDP1: SUCCESS (1.888s) [120.216091] Starting dynamic subtest: D-eDP1 [122.114509] Dynamic subtest D-eDP1: SUCCESS (1.905s) [122.117180] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.595s) [123.296141] [025/132] (900s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [123.395145] Starting subtest: drrs-dirtyfb-ioctl [123.408542] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [123.497558] [026/132] (900s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [123.585494] Starting subtest: fbc-2p-primscrn-spr-indfb-move [123.589672] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [123.687885] [027/132] (900s left) kms_content_protection (srm) [123.827277] Starting subtest: srm [123.833979] Subtest srm: SKIP (0.002s) [123.945063] [028/132] (899s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [124.029874] Starting subtest: crc-primary-basic-y-tiled-ccs [124.032209] Starting dynamic subtest: pipe-A-eDP-1 [124.054393] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [124.064807] Starting dynamic subtest: pipe-B-eDP-1 [124.084944] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [124.092612] Starting dynamic subtest: pipe-C-eDP-1 [124.113419] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [124.120869] Starting dynamic subtest: pipe-D-eDP-1 [124.143223] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [124.147588] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s) [126.299981] [029/132] (897s left) kms_chamelium_frames (hdmi-frame-dump) [126.695843] Subtest hdmi-frame-dump: SKIP (0.000s) [127.479783] [030/132] (896s left) gem_close_race (basic-process) [127.569130] Starting subtest: basic-process [127.613483] Subtest basic-process: SUCCESS (0.046s) [127.794415] [031/132] (896s left) gem_exec_schedule (independent) [127.872088] Starting subtest: independent [127.874625] Starting dynamic subtest: rcs0 [129.997597] Dynamic subtest rcs0: SUCCESS (2.082s) [130.008832] Starting dynamic subtest: vcs0 [131.932227] Dynamic subtest vcs0: SUCCESS (1.987s) [131.943802] Starting dynamic subtest: vcs1 [133.919446] Dynamic subtest vcs1: SUCCESS (1.986s) [133.930238] Starting dynamic subtest: vecs0 [135.903636] Dynamic subtest vecs0: SUCCESS (1.983s) [135.913256] Starting dynamic subtest: ccs0 [137.877600] Dynamic subtest ccs0: SUCCESS (1.973s) [137.880048] Subtest independent: SUCCESS (10.016s) [138.176940] [032/132] (885s left) gem_lmem_swapping (parallel-multi) [138.229830] Subtest parallel-multi: SKIP (0.000s) [138.276807] [033/132] (885s left) gem_pxp (create-valid-protected-context) [138.401782] Starting subtest: create-valid-protected-context [138.407471] Subtest create-valid-protected-context: SUCCESS (0.002s) [138.524850] [034/132] (885s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [138.587717] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [138.689937] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s) [138.772255] [035/132] (885s left) gem_pxp (regular-baseline-src-copy-readible) [138.837651] Starting subtest: regular-baseline-src-copy-readible [138.904267] Subtest regular-baseline-src-copy-readible: SUCCESS (0.068s) [139.015797] [036/132] (885s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [139.113330] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [139.117443] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [139.204046] [037/132] (885s left) gem_barrier_race (remote-request) [139.264991] Starting subtest: remote-request [139.266824] Starting dynamic subtest: rcs0 [144.439588] Dynamic subtest rcs0: SUCCESS (5.172s) [144.441466] Subtest remote-request: SUCCESS (5.173s) [144.588855] [038/132] (879s left) kms_big_fb (x-tiled-32bpp-rotate-270) [144.701305] Starting subtest: x-tiled-32bpp-rotate-270 [144.720527] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [144.833073] [039/132] (879s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [144.955149] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [144.959380] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [145.080593] [040/132] (879s left) kms_big_fb (linear-32bpp-rotate-270) [145.192557] Starting subtest: linear-32bpp-rotate-270 [145.212047] Subtest linear-32bpp-rotate-270: SKIP (0.019s) [145.334970] [041/132] (879s left) gem_render_copy (y-tiled-ccs-to-linear) [145.402979] Starting subtest: y-tiled-ccs-to-linear [145.406875] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [145.586800] [042/132] (878s left) gem_exec_schedule (semaphore-noskip) [145.655142] Starting subtest: semaphore-noskip [146.068666] Subtest semaphore-noskip: SUCCESS (0.421s) [146.414970] [043/132] (878s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [146.508577] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [146.512765] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [146.607742] [044/132] (877s left) kms_cursor_edge_walk (128x128-left-edge) [146.705253] Starting subtest: 128x128-left-edge [146.707595] Starting dynamic subtest: pipe-A-eDP-1 [150.150533] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s) [150.159810] Starting dynamic subtest: pipe-D-eDP-1 [153.324487] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.172s) [153.326837] Subtest 128x128-left-edge: SUCCESS (6.619s) [154.218083] [045/132] (870s left) api_intel_bb (misplaced-blitter) [154.271809] Starting subtest: misplaced-blitter [154.278999] Subtest misplaced-blitter: SUCCESS (0.007s) [154.394513] [046/132] (870s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [154.483539] Starting subtest: fbc-modesetfrombusy [158.274384] Subtest fbc-modesetfrombusy: SUCCESS (3.795s) [159.434733] [047/132] (865s left) gem_eio (in-flight-internal-immediate) [159.674223] Starting subtest: in-flight-internal-immediate [160.990200] Subtest in-flight-internal-immediate: SUCCESS (1.315s) [161.123119] [048/132] (863s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [161.227284] Starting subtest: crc-primary-suspend-yf-tiled-ccs [161.229520] Starting dynamic subtest: pipe-A-eDP-1 [161.238639] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [161.248657] Starting dynamic subtest: pipe-B-eDP-1 [161.257437] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [161.266221] Starting dynamic subtest: pipe-C-eDP-1 [161.274535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [161.282667] Starting dynamic subtest: pipe-D-eDP-1 [161.290780] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [161.294692] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [163.510280] [049/132] (861s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [163.613273] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [163.617849] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [163.688490] [050/132] (861s left) prime_busy (after) [163.751294] Starting subtest: after [163.756752] Starting dynamic subtest: rcs0 [163.802609] Dynamic subtest rcs0: SUCCESS (0.046s) [163.813408] Starting dynamic subtest: bcs0 [163.843066] Dynamic subtest bcs0: SUCCESS (0.040s) [163.852256] Starting dynamic subtest: vcs0 [163.883419] Dynamic subtest vcs0: SUCCESS (0.040s) [163.892737] Starting dynamic subtest: vcs1 [163.924304] Dynamic subtest vcs1: SUCCESS (0.040s) [163.933216] Starting dynamic subtest: vecs0 [163.965278] Dynamic subtest vecs0: SUCCESS (0.040s) [163.974399] Starting dynamic subtest: ccs0 [164.005370] Dynamic subtest ccs0: SUCCESS (0.040s) [164.114647] Subtest after: SUCCESS (0.362s) [164.187400] [051/132] (860s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [164.298061] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [164.302136] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [164.362110] [052/132] (860s left) kms_cdclk (plane-scaling) [164.465212] Starting subtest: plane-scaling [164.467470] Starting dynamic subtest: pipe-A-eDP-1 [164.757664] Dynamic subtest pipe-A-eDP-1: SKIP (0.291s) [164.767287] Starting dynamic subtest: pipe-B-eDP-1 [164.771881] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [164.781881] Starting dynamic subtest: pipe-C-eDP-1 [164.786493] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [164.794783] Starting dynamic subtest: pipe-D-eDP-1 [164.799426] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [164.804078] Subtest plane-scaling: SKIP (0.297s) [165.599777] [053/132] (859s left) kms_psr (psr-cursor-blt) [165.696170] Starting subtest: psr-cursor-blt [165.698548] Starting dynamic subtest: eDP-1 [167.372697] Dynamic subtest eDP-1: SUCCESS (1.677s) [167.375071] Subtest psr-cursor-blt: SUCCESS (1.678s) [168.206476] [054/132] (856s left) kms_psr (fbc-psr2-sprite-blt) [168.305161] Starting subtest: fbc-psr2-sprite-blt [168.307490] Starting dynamic subtest: eDP-1 [168.311924] Dynamic subtest eDP-1: SKIP (0.000s) [168.316325] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [168.376138] [055/132] (856s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [168.468589] Starting subtest: 2x-wf_vblank-ts-check-interruptible [168.481080] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [168.571326] [056/132] (856s left) kms_atomic_interruptible (legacy-setmode) [168.666730] Starting subtest: legacy-setmode [168.669061] Starting dynamic subtest: pipe-A-eDP-1 [175.583617] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.914s) [175.585936] Subtest legacy-setmode: SUCCESS (6.916s) [176.404320] [057/132] (848s left) i915_pm_rpm (gem-evict-pwrite) [177.944919] Starting subtest: gem-evict-pwrite [177.949766] Subtest gem-evict-pwrite: SKIP (0.000s) [178.706795] [058/132] (846s left) prime_udl [178.797988] [059/132] (846s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [178.890144] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [178.894225] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [178.964301] [060/132] (846s left) gen9_exec_parse (batch-invalid-length) [179.024928] Subtest batch-invalid-length: SKIP (0.000s) [179.094961] [061/132] (846s left) i915_drm_fdinfo (idle) [179.132626] Starting subtest: idle [179.135020] Starting dynamic subtest: rcs0 [179.687556] Dynamic subtest rcs0: SUCCESS (0.554s) [179.698044] Starting dynamic subtest: bcs0 [180.194081] Dynamic subtest bcs0: SUCCESS (0.504s) [180.205049] Starting dynamic subtest: vcs0 [180.698776] Dynamic subtest vcs0: SUCCESS (0.503s) [180.711192] Starting dynamic subtest: vcs1 [181.204060] Dynamic subtest vcs1: SUCCESS (0.504s) [181.215587] Starting dynamic subtest: vecs0 [181.717066] Dynamic subtest vecs0: SUCCESS (0.502s) [181.725982] Starting dynamic subtest: ccs0 [182.213681] Dynamic subtest ccs0: SUCCESS (0.503s) [182.216399] Subtest idle: SUCCESS (3.080s) [182.295132] [062/132] (842s left) gem_exec_params (dr4-dirt) [182.360878] Starting subtest: DR4-dirt [182.363263] Subtest DR4-dirt: SUCCESS (0.000s) [182.482264] [063/132] (842s left) gem_tiled_partial_pwrite_pread (writes) [182.554663] Subtest writes: SKIP (0.000s) [182.627693] [064/132] (842s left) kms_psr (fbc-psr-basic) [182.727095] Starting subtest: fbc-psr-basic [182.729325] Starting dynamic subtest: eDP-1 [182.733565] Dynamic subtest eDP-1: SKIP (0.000s) [182.737754] Subtest fbc-psr-basic: SKIP (0.001s) [182.811353] [065/132] (842s left) gem_ctx_engines (independent) [182.872207] Starting subtest: independent [182.874469] Starting dynamic subtest: rcs0 [183.021606] Dynamic subtest rcs0: SUCCESS (0.151s) [183.029850] Starting dynamic subtest: bcs0 [183.167636] Dynamic subtest bcs0: SUCCESS (0.145s) [183.176556] Starting dynamic subtest: vcs0 [183.333130] Dynamic subtest vcs0: SUCCESS (0.164s) [183.342537] Starting dynamic subtest: vcs1 [183.507771] Dynamic subtest vcs1: SUCCESS (0.174s) [183.517219] Starting dynamic subtest: vecs0 [183.686794] Dynamic subtest vecs0: SUCCESS (0.178s) [183.697184] Starting dynamic subtest: ccs0 [183.870561] Dynamic subtest ccs0: SUCCESS (0.183s) [183.885997] Starting dynamic subtest: all-engines [184.568859] Dynamic subtest all-engines: SUCCESS (0.698s) [184.571259] Subtest independent: SUCCESS (1.700s) [185.084468] [066/132] (840s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [185.177192] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [185.179421] Starting dynamic subtest: pipe-A-eDP-1 [185.204703] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [185.214600] Starting dynamic subtest: pipe-B-eDP-1 [185.238765] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [185.247062] Starting dynamic subtest: pipe-C-eDP-1 [185.270826] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [185.279058] Starting dynamic subtest: pipe-D-eDP-1 [185.302983] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [185.307349] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s) [187.399042] [067/132] (838s left) syncobj_wait (signal) [187.469493] Starting subtest: signal [187.471479] Subtest signal: SUCCESS (0.000s) [187.563398] [068/132] (837s left) kms_pm_dc (dc5-dpms) [188.655433] Starting subtest: dc5-dpms [190.748405] Subtest dc5-dpms: SUCCESS (2.092s) [190.839306] [069/132] (834s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [190.932378] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [190.934623] Starting dynamic subtest: pipe-A [190.957144] Dynamic subtest pipe-A: SKIP (0.020s) [190.966649] Starting dynamic subtest: pipe-B [190.991739] Dynamic subtest pipe-B: SKIP (0.033s) [191.000585] Starting dynamic subtest: pipe-C [191.023457] Dynamic subtest pipe-C: SKIP (0.031s) [191.033352] Starting dynamic subtest: pipe-D [191.051846] Dynamic subtest pipe-D: SKIP (0.031s) [191.056053] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.117s) [191.142620] [070/132] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [191.240624] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [191.244743] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [191.342367] [071/132] (834s left) gem_userptr_blits (access-control) [191.421689] Starting subtest: access-control [191.426219] Subtest access-control: SKIP (0.000s) [191.535860] [072/132] (834s left) kms_psr (pr-cursor-render) [191.623060] Starting subtest: pr-cursor-render [191.627471] Subtest pr-cursor-render: SKIP (0.000s) [191.699124] [073/132] (833s left) gem_ringfill (basic-all) [197.851239] Starting subtest: basic-all [199.018227] Subtest basic-all: SUCCESS (1.167s) [199.143633] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true [199.146767] [074/132] (826s left) kms_cursor_crc (cursor-onscreen-32x32) [199.307768] Starting subtest: cursor-onscreen-32x32 [199.358219] Subtest cursor-onscreen-32x32: SKIP (0.047s) [199.644114] [075/132] (826s left) i915_pm_rps (thresholds-idle-park) [199.707460] Starting subtest: thresholds-idle-park [199.711664] Subtest thresholds-idle-park: SKIP (0.000s) [199.815950] [076/132] (825s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [199.909751] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [199.914062] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [200.018162] [077/132] (825s left) gem_softpin (noreloc-s3) [200.073987] Starting subtest: noreloc-S3 [219.892882] Subtest noreloc-S3: SUCCESS (5.419s) [228.082482] [078/132] (805s left) gem_exec_reloc (basic-wc-cpu-noreloc) [228.167043] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [228.241306] [079/132] (805s left) kms_big_fb (y-tiled-8bpp-rotate-0) [228.347367] Starting subtest: y-tiled-8bpp-rotate-0 [228.351787] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [228.446067] [080/132] (805s left) kms_rotation_crc (multiplane-rotation) [228.533499] Starting subtest: multiplane-rotation [245.927271] Subtest multiplane-rotation: SUCCESS (17.393s) [246.032460] [081/132] (788s left) gem_exec_basic (basic) [246.096893] Starting subtest: basic [246.098920] Starting dynamic subtest: rcs0-smem [246.100850] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [246.111356] Starting dynamic subtest: bcs0-smem [246.113497] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [246.122630] Starting dynamic subtest: vcs0-smem [246.124201] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [246.132724] Starting dynamic subtest: vcs1-smem [246.134338] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [246.142978] Starting dynamic subtest: vecs0-smem [246.144599] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [246.153185] Starting dynamic subtest: ccs0-smem [246.154782] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [246.156398] Subtest basic: SUCCESS (0.016s) [247.358965] [082/132] (786s left) kms_plane (pixel-format-yf-tiled-ccs-modifier) [247.454520] Starting subtest: pixel-format-yf-tiled-ccs-modifier [247.458988] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s) [247.528917] [083/132] (786s left) kms_cursor_crc (cursor-rapid-movement-64x64) [247.703230] Starting subtest: cursor-rapid-movement-64x64 [247.708146] Starting dynamic subtest: pipe-A-eDP-1 [249.022491] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.312s) [249.052715] Starting dynamic subtest: pipe-D-eDP-1 [249.790385] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.743s) [249.792686] Subtest cursor-rapid-movement-64x64: SUCCESS (2.087s) [250.608945] [084/132] (783s left) kms_addfb_basic (addfb25-y-tiled-legacy) [250.712107] Starting subtest: addfb25-y-tiled-legacy [250.714399] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [250.825085] [085/132] (783s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [250.926536] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [257.958273] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.032s) [258.086218] [086/132] (776s left) kms_lease (lease-invalid-connector) [258.187629] Starting subtest: lease-invalid-connector [258.189959] Starting dynamic subtest: pipe-A-eDP-1 [258.192264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [258.201774] Starting dynamic subtest: pipe-B-eDP-1 [258.204140] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [258.213840] Starting dynamic subtest: pipe-C-eDP-1 [258.216149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [258.225167] Starting dynamic subtest: pipe-D-eDP-1 [258.227075] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [258.228961] Subtest lease-invalid-connector: SUCCESS (0.004s) [258.276027] [087/132] (776s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [258.367850] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [258.371803] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [258.453322] [088/132] (775s left) gem_exec_flush (basic-wb-ro-before-default) [258.502393] Starting subtest: basic-wb-ro-before-default [263.992991] Subtest basic-wb-ro-before-default: SUCCESS (5.458s) [264.151876] [089/132] (770s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [264.264268] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [271.297213] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.035s) [271.422494] [090/132] (763s left) kms_draw_crc (draw-method-render) [271.523770] Starting subtest: draw-method-render [271.525651] Starting dynamic subtest: xrgb8888-untiled [271.789537] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [271.801624] Starting dynamic subtest: rgb565-untiled [272.033793] Dynamic subtest rgb565-untiled: SUCCESS (0.243s) [272.046590] Starting dynamic subtest: xrgb2101010-untiled [272.266637] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.231s) [272.275982] Starting dynamic subtest: xbgr16161616f-untiled [272.501108] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [272.510309] Starting dynamic subtest: xrgb8888-xtiled [272.633291] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s) [272.642731] Starting dynamic subtest: rgb565-xtiled [272.756241] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [272.766151] Starting dynamic subtest: xrgb2101010-xtiled [272.877852] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [272.887233] Starting dynamic subtest: xbgr16161616f-xtiled [273.011318] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s) [273.023657] Starting dynamic subtest: xrgb8888-4tiled [273.144592] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.131s) [273.156671] Starting dynamic subtest: rgb565-4tiled [273.255933] Dynamic subtest rgb565-4tiled: SUCCESS (0.109s) [273.271300] Starting dynamic subtest: xrgb2101010-4tiled [273.389413] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.131s) [273.401174] Starting dynamic subtest: xbgr16161616f-4tiled [273.533508] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.142s) [273.535513] Subtest draw-method-render: SUCCESS (2.013s) [273.671536] [091/132] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [273.770002] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [273.773277] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [273.888247] [092/132] (760s left) api_intel_allocator (open-vm) [273.944452] Starting subtest: open-vm [273.948503] Subtest open-vm: SUCCESS (0.003s) [274.069516] [093/132] (760s left) gem_userptr_blits (sync-unmap-after-close) [274.138848] Starting subtest: sync-unmap-after-close [274.150664] Subtest sync-unmap-after-close: SUCCESS (0.011s) [274.274924] [094/132] (760s left) core_getversion (all-cards) [274.310629] Starting subtest: all-cards [274.322503] Subtest all-cards: SUCCESS (0.015s) [274.376627] [095/132] (760s left) kms_psr (fbc-pr-no-drrs) [274.470516] Starting subtest: fbc-pr-no-drrs [274.474335] Subtest fbc-pr-no-drrs: SKIP (0.000s) [274.554713] [096/132] (760s left) i915_pciid [274.746018] [097/132] (760s left) i915_query (query-topology-coherent-slice-mask) [274.793966] Starting subtest: query-topology-coherent-slice-mask [274.797363] Subtest query-topology-coherent-slice-mask: SKIP (0.000s) [274.892610] [098/132] (759s left) kms_joiner (invalid-modeset-force-ultra-joiner) [274.983660] Starting subtest: invalid-modeset-force-ultra-joiner [274.987264] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [275.051427] [099/132] (759s left) gem_tiled_partial_pwrite_pread (reads) [275.112615] Subtest reads: SKIP (0.000s) [275.190396] [100/132] (759s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [275.295799] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [276.387054] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.090s) [276.511748] [101/132] (758s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [276.578163] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [276.642540] [102/132] (758s left) gem_exec_fence (submit-chain) [276.812075] Starting subtest: submit-chain [276.832018] Subtest submit-chain: SUCCESS (0.021s) [278.379269] [103/132] (756s left) kms_chamelium_hpd (hdmi-hpd) [278.768083] Subtest hdmi-hpd: SKIP (0.000s) [279.578826] [104/132] (755s left) gem_eio (throttle) [279.789364] Starting subtest: throttle [280.115930] Subtest throttle: SUCCESS (0.325s) [280.256125] [105/132] (754s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [280.356295] Starting subtest: fbc-pr-plane-move-sf-dmg-area [280.360689] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [280.429415] [106/132] (754s left) perf_pmu (all-busy-check-all) [280.474674] Starting subtest: all-busy-check-all [282.324000] Subtest all-busy-check-all: SUCCESS (1.849s) [282.428999] [107/132] (752s left) gem_softpin (overlap) [282.499561] Starting subtest: overlap [283.461467] Subtest overlap: SUCCESS (0.962s) [283.597645] [108/132] (751s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [283.652521] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [283.760149] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [283.839333] [109/132] (751s left) kms_flip (2x-plain-flip) [283.942734] Starting subtest: 2x-plain-flip [283.956899] Subtest 2x-plain-flip: SKIP (0.013s) [284.089036] [110/132] (751s left) gem_exec_parallel (userptr) [284.157781] Starting subtest: userptr [284.160173] Starting dynamic subtest: rcs0 [285.579471] Dynamic subtest rcs0: SUCCESS (1.421s) [285.590578] Starting dynamic subtest: bcs0 [287.047514] Dynamic subtest bcs0: SUCCESS (1.466s) [287.059419] Starting dynamic subtest: vcs0 [290.322696] Dynamic subtest vcs0: SUCCESS (3.271s) [290.339502] Starting dynamic subtest: vcs1 [292.305668] Dynamic subtest vcs1: SUCCESS (1.981s) [292.315514] Starting dynamic subtest: vecs0 [294.299154] Dynamic subtest vecs0: SUCCESS (1.991s) [294.310178] Starting dynamic subtest: ccs0 [295.804494] Dynamic subtest ccs0: SUCCESS (1.504s) [295.806994] Subtest userptr: SUCCESS (11.646s) [295.998415] [111/132] (739s left) gem_exec_balancer (full-pulse) [296.066688] Starting subtest: full-pulse [301.175005] Subtest full-pulse: SUCCESS (5.108s) [301.509023] [112/132] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [301.616201] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [301.624613] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [301.711321] [113/132] (733s left) syncobj_timeline (invalid-query-zero-handles) [301.767491] Starting subtest: invalid-query-zero-handles [301.769617] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [301.877792] [114/132] (733s left) kms_getfb (getfb2-handle-zero) [301.968512] Starting subtest: getfb2-handle-zero [301.970729] Subtest getfb2-handle-zero: SUCCESS (0.000s) [302.071551] [115/132] (733s left) gem_ctx_isolation (clean) [302.129943] Starting subtest: clean [302.132316] Starting dynamic subtest: rcs0 [302.186039] Dynamic subtest rcs0: SUCCESS (0.056s) [302.198028] Starting dynamic subtest: bcs0 [302.245311] Dynamic subtest bcs0: SUCCESS (0.058s) [302.257903] Starting dynamic subtest: vcs0 [302.311406] Dynamic subtest vcs0: SUCCESS (0.065s) [302.324189] Starting dynamic subtest: vcs1 [304.354299] Dynamic subtest vcs1: SUCCESS (2.042s) [304.365856] Starting dynamic subtest: vecs0 [306.324940] Dynamic subtest vecs0: SUCCESS (1.969s) [306.337402] Starting dynamic subtest: ccs0 [308.308949] Dynamic subtest ccs0: SUCCESS (1.983s) [308.311520] Subtest clean: SUCCESS (6.179s) [308.554239] [116/132] (727s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [308.655261] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [316.236622] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.586s) [316.364681] [117/132] (719s left) gem_fence_thrash (bo-write-verify-threaded-none) [316.398687] Starting subtest: bo-write-verify-threaded-none [316.422489] Subtest bo-write-verify-threaded-none: SKIP (0.021s) [316.487880] [118/132] (719s left) gem_mmap_offset (perf) [316.540832] Starting subtest: perf [316.542779] Starting dynamic subtest: smem0 [316.818500] Dynamic subtest smem0: SUCCESS (0.277s) [316.820822] Subtest perf: SUCCESS (0.278s) [316.927854] [119/132] (718s left) gem_tiled_wb [317.040702] [120/132] (718s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [317.138021] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [317.142196] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [317.220626] [121/132] (718s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [317.313358] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [317.316822] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [317.411321] [122/132] (718s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [317.503871] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [317.507209] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [317.597343] [123/132] (718s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [317.714495] Starting subtest: flip-vs-cursor-varying-size [326.398458] Subtest flip-vs-cursor-varying-size: SUCCESS (8.681s) [327.200028] [124/132] (708s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [327.296721] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [327.301002] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [327.393911] [125/132] (708s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [327.493228] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [327.495473] Starting dynamic subtest: pipe-A-eDP-1 [327.928826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s) [327.940653] Starting dynamic subtest: pipe-B-eDP-1 [327.960916] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [327.973346] Starting dynamic subtest: pipe-C-eDP-1 [327.992720] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [328.002035] Starting dynamic subtest: pipe-D-eDP-1 [328.021407] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [328.023622] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.451s) [330.191989] [126/132] (705s left) kms_color_pipeline (plane-ctm3x4-lut1d) [330.295767] Starting subtest: plane-ctm3x4-lut1d [330.463416] Starting dynamic subtest: pipe-A-plane-0 [330.821037] Dynamic subtest pipe-A-plane-0: FAIL (0.191s) [330.831054] Starting dynamic subtest: pipe-A-plane-1 [331.049624] Dynamic subtest pipe-A-plane-1: FAIL (0.182s) [331.061387] Starting dynamic subtest: pipe-A-plane-2 [331.267507] Dynamic subtest pipe-A-plane-2: FAIL (0.169s) [332.291505] Starting dynamic subtest: pipe-B-plane-0 [332.723297] Dynamic subtest pipe-B-plane-0: FAIL (0.174s) [332.733310] Starting dynamic subtest: pipe-B-plane-1 [333.034327] Dynamic subtest pipe-B-plane-1: FAIL (0.178s) [333.046660] Starting dynamic subtest: pipe-B-plane-2 [333.337493] Dynamic subtest pipe-B-plane-2: FAIL (0.176s) [333.956647] Starting dynamic subtest: pipe-C-plane-0 [334.435911] Dynamic subtest pipe-C-plane-0: FAIL (0.129s) [334.446847] Starting dynamic subtest: pipe-C-plane-1 [334.842380] Dynamic subtest pipe-C-plane-1: FAIL (0.596s) [334.853715] Starting dynamic subtest: pipe-C-plane-2 [335.210240] Dynamic subtest pipe-C-plane-2: FAIL (0.178s) [336.063891] Starting dynamic subtest: pipe-D-plane-0 [336.653505] Dynamic subtest pipe-D-plane-0: FAIL (0.143s) [336.665363] Starting dynamic subtest: pipe-D-plane-1 [337.115432] Dynamic subtest pipe-D-plane-1: FAIL (0.624s) [337.126974] Starting dynamic subtest: pipe-D-plane-2 [337.555720] Dynamic subtest pipe-D-plane-2: FAIL (0.561s) [337.684063] Subtest plane-ctm3x4-lut1d: FAIL (7.390s) [338.495660] [127/132] (697s left) kms_big_fb (4-tiled-32bpp-rotate-180) [338.612056] Starting subtest: 4-tiled-32bpp-rotate-180 [339.991756] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.380s) [340.123862] [128/132] (695s left) gem_wait (await) [340.195895] Starting subtest: await [340.197529] Starting dynamic subtest: all-engines [341.324332] Dynamic subtest all-engines: SUCCESS (1.130s) [341.341986] Starting dynamic subtest: rcs0 [342.388120] Dynamic subtest rcs0: SUCCESS (1.062s) [342.406120] Starting dynamic subtest: bcs0 [343.448175] Dynamic subtest bcs0: SUCCESS (1.058s) [343.466479] Starting dynamic subtest: vcs0 [344.506294] Dynamic subtest vcs0: SUCCESS (1.056s) [344.523872] Starting dynamic subtest: vcs1 [345.560204] Dynamic subtest vcs1: SUCCESS (1.052s) [345.577414] Starting dynamic subtest: vecs0 [346.613797] Dynamic subtest vecs0: SUCCESS (1.051s) [346.632446] Starting dynamic subtest: ccs0 [347.671251] Dynamic subtest ccs0: SUCCESS (1.055s) [347.674238] Subtest await: SUCCESS (7.478s) [347.883679] [129/132] (688s left) gem_ctx_shared (q-in-order) [347.953038] Starting subtest: Q-in-order [347.956151] Starting dynamic subtest: rcs0 [348.117497] Dynamic subtest rcs0: SUCCESS (0.162s) [348.136887] Starting dynamic subtest: vcs0 [348.226337] Dynamic subtest vcs0: SUCCESS (0.109s) [348.242494] Starting dynamic subtest: vcs1 [348.351235] Dynamic subtest vcs1: SUCCESS (0.123s) [348.368036] Starting dynamic subtest: vecs0 [348.456483] Dynamic subtest vecs0: SUCCESS (0.106s) [348.474490] Starting dynamic subtest: ccs0 [348.588463] Dynamic subtest ccs0: SUCCESS (0.129s) [348.590575] Subtest Q-in-order: SUCCESS (0.635s) [349.445948] [130/132] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [349.557400] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [349.561249] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [349.652387] [131/132] (686s left) kms_vblank (wait-busy-hang) [349.753334] Starting subtest: wait-busy-hang [349.755124] Starting dynamic subtest: pipe-A-eDP-1 [377.046973] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.291s) [377.061326] Starting dynamic subtest: pipe-D-eDP-1 [402.068648] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.020s) [402.070987] Subtest wait-busy-hang: SUCCESS (52.316s) [402.893283] [132/132] (633s left) kms_async_flips (test-time-stamp-atomic) [402.991357] Starting subtest: test-time-stamp-atomic [403.365125] Starting dynamic subtest: pipe-A-eDP-1 [404.162743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s) [404.554665] Starting dynamic subtest: pipe-B-eDP-1 [405.361226] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.811s) [405.742198] Starting dynamic subtest: pipe-C-eDP-1 [406.566395] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.833s) [406.929136] Starting dynamic subtest: pipe-D-eDP-1 [407.763386] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.840s) [407.765900] Subtest test-time-stamp-atomic: SUCCESS (4.772s) [408.987070] Closing watchdogs results: parsing output: 0/ for test: kms_plane_alpha_blend results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_plane_scaling results: parsing output: 3/ for test: gem_exec_store results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: perf_pmu results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: syncobj_timeline results: parsing output: 8/ for test: gem_softpin results: parsing output: 9/ for test: gem_mmap_wc results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gen3_render_tiledx_blits results: parsing output: 13/ for test: kms_selftest results: parsing output: 14/ for test: sw_sync results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: perf results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_ctx_create results: parsing output: 19/ for test: gem_ctx_persistence results: parsing output: 20/ for test: kms_force_connector_basic results: parsing output: 21/ for test: drm_read results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: kms_flip results: parsing output: 24/ for test: kms_dirtyfb results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_content_protection results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_chamelium_frames results: parsing output: 29/ for test: gem_close_race results: parsing output: 30/ for test: gem_exec_schedule results: parsing output: 31/ for test: gem_lmem_swapping results: parsing output: 32/ for test: gem_pxp results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: gem_pxp results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_barrier_race results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: gem_render_copy results: parsing output: 41/ for test: gem_exec_schedule results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_cursor_edge_walk results: parsing output: 44/ for test: api_intel_bb results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_eio results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: kms_flip_scaled_crc results: parsing output: 49/ for test: prime_busy results: parsing output: 50/ for test: kms_psr2_sf results: parsing output: 51/ for test: kms_cdclk results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: kms_atomic_interruptible results: parsing output: 56/ for test: i915_pm_rpm results: parsing output: 57/ for test: prime_udl results: parsing output: 58/ for test: kms_plane results: parsing output: 59/ for test: gen9_exec_parse results: parsing output: 60/ for test: i915_drm_fdinfo results: parsing output: 61/ for test: gem_exec_params results: parsing output: 62/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: gem_ctx_engines results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: kms_pm_dc results: parsing output: 68/ for test: kms_plane_scaling results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_userptr_blits results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: gem_ringfill results: parsing output: 73/ for test: kms_cursor_crc results: parsing output: 74/ for test: i915_pm_rps results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: gem_softpin results: parsing output: 77/ for test: gem_exec_reloc results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_rotation_crc results: parsing output: 80/ for test: gem_exec_basic results: parsing output: 81/ for test: kms_plane results: parsing output: 82/ for test: kms_cursor_crc results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_lease results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_exec_flush results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_draw_crc results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: api_intel_allocator results: parsing output: 92/ for test: gem_userptr_blits results: parsing output: 93/ for test: core_getversion results: parsing output: 94/ for test: kms_psr results: parsing output: 95/ for test: i915_pciid results: parsing output: 96/ for test: i915_query results: parsing output: 97/ for test: kms_joiner results: parsing output: 98/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: gem_mmap_gtt results: parsing output: 101/ for test: gem_exec_fence results: parsing output: 102/ for test: kms_chamelium_hpd results: parsing output: 103/ for test: gem_eio results: parsing output: 104/ for test: kms_psr2_sf results: parsing output: 105/ for test: perf_pmu results: parsing output: 106/ for test: gem_softpin results: parsing output: 107/ for test: syncobj_wait results: parsing output: 108/ for test: kms_flip results: parsing output: 109/ for test: gem_exec_parallel results: parsing output: 110/ for test: gem_exec_balancer results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_getfb results: parsing output: 114/ for test: gem_ctx_isolation results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_fence_thrash results: parsing output: 117/ for test: gem_mmap_offset results: parsing output: 118/ for test: gem_tiled_wb results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_flip_scaled_crc results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_ccs results: parsing output: 125/ for test: kms_color_pipeline results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: gem_wait results: parsing output: 128/ for test: gem_ctx_shared results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_vblank results: parsing output: 131/ for test: kms_async_flips Done.