[55.595352] Initializing watchdogs [55.595397] /dev/watchdog0 [55.609466] [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] [55.614201] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.616607] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.619496] [001/134] (960s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [55.744885] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [55.747184] Starting dynamic subtest: pipe-A-default-mode [58.457915] Dynamic subtest pipe-A-default-mode: SUCCESS (2.695s) [58.460313] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.696s) [59.348949] [002/134] (956s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [64.352532] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [64.357063] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s) [65.206682] [003/134] (950s left) perf (polling-small-buf) [65.351087] Starting subtest: polling-small-buf [65.441217] Subtest polling-small-buf: SUCCESS (0.089s) [65.483145] [004/134] (950s left) gem_ctx_exec (basic-close-race) [65.536967] Starting subtest: basic-close-race [72.369333] Subtest basic-close-race: SUCCESS (6.820s) [72.516685] [005/134] (943s left) kms_big_fb (x-tiled-16bpp-rotate-0) [72.630775] Starting subtest: x-tiled-16bpp-rotate-0 [73.900152] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.268s) [74.029438] [006/134] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [74.125409] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [74.129073] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [74.232517] [007/134] (942s left) kms_draw_crc (draw-method-mmap-wc) [74.329538] Starting subtest: draw-method-mmap-wc [74.331343] Starting dynamic subtest: xrgb8888-untiled [74.572758] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s) [74.581245] Starting dynamic subtest: rgb565-untiled [74.817504] Dynamic subtest rgb565-untiled: SUCCESS (0.244s) [74.824464] Starting dynamic subtest: xrgb2101010-untiled [75.040025] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [75.047044] Starting dynamic subtest: xbgr16161616f-untiled [75.262083] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [75.269095] Starting dynamic subtest: xrgb8888-xtiled [75.406542] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [75.413306] Starting dynamic subtest: rgb565-xtiled [75.540176] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [75.548250] Starting dynamic subtest: xrgb2101010-xtiled [75.673820] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s) [75.681954] Starting dynamic subtest: xbgr16161616f-xtiled [75.807180] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [75.816028] Starting dynamic subtest: xrgb8888-4tiled [75.951711] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [75.960133] Starting dynamic subtest: rgb565-4tiled [76.107123] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s) [76.113921] Starting dynamic subtest: xrgb2101010-4tiled [76.262985] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s) [76.271459] Starting dynamic subtest: xbgr16161616f-4tiled [76.453418] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.189s) [76.455301] Subtest draw-method-mmap-wc: SUCCESS (2.123s) [76.578347] [008/134] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [76.681192] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [99.871432] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.187s) [100.060251] [009/134] (916s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [100.164120] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [100.166055] Starting dynamic subtest: pipe-A-eDP-1 [100.318600] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s) [100.327844] Starting dynamic subtest: pipe-B-eDP-1 [100.343345] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [100.351821] Starting dynamic subtest: pipe-C-eDP-1 [100.368880] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [100.377810] Starting dynamic subtest: pipe-D-eDP-1 [100.393156] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [100.394846] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.182s) [102.633454] [010/134] (913s left) kms_chamelium_color (ctm-blue-to-red) [102.726573] Subtest ctm-blue-to-red: SKIP (0.000s) [102.766518] [011/134] (913s left) api_intel_bb (reset-bb) [102.815597] Starting subtest: reset-bb [102.818276] Subtest reset-bb: SUCCESS (0.004s) [102.954222] [012/134] (913s left) drm_read (empty-block) [103.102049] Starting subtest: empty-block [104.103698] Subtest empty-block: SUCCESS (1.000s) [104.273506] [013/134] (912s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [104.373744] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [104.377933] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [104.490030] [014/134] (912s left) gen9_exec_parse (bb-start-out) [104.564497] Subtest bb-start-out: SKIP (0.000s) [104.654424] [015/134] (911s left) dmabuf_sync_file (import-basic) [104.741911] Starting subtest: import-basic [104.744236] Subtest import-basic: SUCCESS (0.001s) [104.818426] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true [104.821533] [016/134] (911s left) gem_exec_reloc (basic-write-read) [104.877793] Subtest basic-write-read: SKIP (0.000s) [104.950735] [017/134] (911s left) kms_cursor_crc (cursor-tearing-position-change) [105.048743] Starting subtest: cursor-tearing-position-change [105.051082] Starting dynamic subtest: pipe-A-eDP-1 [105.613967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s) [105.621753] Starting dynamic subtest: pipe-D-eDP-1 [106.842574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s) [106.844783] Subtest cursor-tearing-position-change: SUCCESS (1.791s) [107.687893] [018/134] (909s left) kms_psr (fbc-pr-primary-render) [107.778960] Starting subtest: fbc-pr-primary-render [107.783819] Subtest fbc-pr-primary-render: SKIP (0.000s) [107.860645] [019/134] (908s left) gem_busy (extended) [108.044192] Starting subtest: extended [108.046428] Starting dynamic subtest: rcs0 [108.149233] Dynamic subtest rcs0: SUCCESS (0.107s) [108.159533] Starting dynamic subtest: bcs0 [108.190116] Dynamic subtest bcs0: SUCCESS (0.039s) [108.200775] Starting dynamic subtest: vcs0 [109.907575] Dynamic subtest vcs0: SUCCESS (1.714s) [109.918275] Starting dynamic subtest: vcs1 [111.893276] Dynamic subtest vcs1: SUCCESS (1.982s) [111.904551] Starting dynamic subtest: vecs0 [113.875455] Dynamic subtest vecs0: SUCCESS (1.979s) [113.885693] Starting dynamic subtest: ccs0 [113.918904] Dynamic subtest ccs0: SUCCESS (0.043s) [113.921296] Subtest extended: SUCCESS (5.878s) [114.194550] [020/134] (902s left) gem_exec_schedule (preempt-user) [114.267668] Starting subtest: preempt-user [114.269563] Starting dynamic subtest: rcs0 [114.302377] Dynamic subtest rcs0: SUCCESS (0.040s) [114.310216] Starting dynamic subtest: bcs0 [114.332704] Dynamic subtest bcs0: SUCCESS (0.029s) [114.340157] Starting dynamic subtest: vcs0 [114.355684] Dynamic subtest vcs0: SUCCESS (0.023s) [114.363128] Starting dynamic subtest: vcs1 [114.380591] Dynamic subtest vcs1: SUCCESS (0.024s) [114.391562] Starting dynamic subtest: vecs0 [114.405444] Dynamic subtest vecs0: SUCCESS (0.025s) [114.412916] Starting dynamic subtest: ccs0 [114.439294] Dynamic subtest ccs0: SUCCESS (0.033s) [114.441551] Subtest preempt-user: SUCCESS (0.178s) [116.047872] [021/134] (900s left) kms_big_fb (4-tiled-16bpp-rotate-180) [116.151228] Starting subtest: 4-tiled-16bpp-rotate-180 [117.386896] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.235s) [117.552040] [022/134] (899s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [117.655226] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [117.658911] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [117.789172] [023/134] (899s left) gem_exec_fence (basic-await) [117.969273] Starting subtest: basic-await [117.971840] Starting dynamic subtest: rcs0 [118.046916] Dynamic subtest rcs0: SUCCESS (0.077s) [118.055245] Starting dynamic subtest: bcs0 [118.125142] Dynamic subtest bcs0: SUCCESS (0.077s) [118.133388] Starting dynamic subtest: vcs0 [118.206746] Dynamic subtest vcs0: SUCCESS (0.080s) [118.217621] Starting dynamic subtest: vcs1 [118.279346] Dynamic subtest vcs1: SUCCESS (0.070s) [118.289842] Starting dynamic subtest: vecs0 [118.350590] Dynamic subtest vecs0: SUCCESS (0.070s) [118.361091] Starting dynamic subtest: ccs0 [118.421990] Dynamic subtest ccs0: SUCCESS (0.070s) [118.424697] Subtest basic-await: SUCCESS (0.453s) [120.015377] [024/134] (896s left) kms_selftest (drm_plane_helper) [120.054475] Starting subtest: drm_plane_helper [120.062062] Starting dynamic subtest: drm_test_check_plane_state [120.194820] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.134s) [120.202453] Starting dynamic subtest: drm_test_check_invalid_plane_state [120.344225] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.146s) [120.346238] Subtest drm_plane_helper: SUCCESS (0.287s) [120.546971] [025/134] (896s left) kms_cursor_legacy (cursor-vs-flip-legacy) [120.669526] Starting subtest: cursor-vs-flip-legacy [149.977130] Subtest cursor-vs-flip-legacy: SUCCESS (29.308s) [150.814121] [026/134] (866s left) gem_exec_fence (invalid-fence-array) [151.230236] Starting subtest: invalid-fence-array [151.232656] Subtest invalid-fence-array: SUCCESS (0.002s) [153.012050] [027/134] (864s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [153.116227] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [156.700031] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.588s) [157.899878] [028/134] (859s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [158.003710] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [165.078674] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.078s) [165.212799] [029/134] (851s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [165.306409] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [165.308703] Starting dynamic subtest: pipe-A-default-mode [165.663085] Dynamic subtest pipe-A-default-mode: SKIP (0.356s) [165.667630] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.358s) [166.433104] [030/134] (850s left) kms_psr (fbc-psr-sprite-plane-move) [166.533087] Starting subtest: fbc-psr-sprite-plane-move [166.535306] Starting dynamic subtest: eDP-1 [166.539311] Dynamic subtest eDP-1: SKIP (0.000s) [166.543317] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [166.629874] [031/134] (850s left) vgem_basic (sysfs) [166.670101] Starting subtest: sysfs [166.672326] Subtest sysfs: SUCCESS (0.000s) [166.738061] [032/134] (850s left) api_intel_allocator (fork-simple-once) [166.787903] Starting subtest: fork-simple-once [166.796901] Subtest fork-simple-once: SUCCESS (0.013s) [166.942399] [033/134] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [167.034587] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [167.038969] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [167.174296] [034/134] (850s left) gem_exec_whisper (basic-fds-priority) [167.235277] Starting subtest: basic-fds-priority [191.333933] Subtest basic-fds-priority: SUCCESS (24.095s) [191.527518] [035/134] (825s left) kms_plane (pixel-format) [191.622920] Starting subtest: pixel-format [191.649779] Starting dynamic subtest: pipe-A-plane-0 [196.526222] Dynamic subtest pipe-A-plane-0: SUCCESS (4.877s) [196.535590] Starting dynamic subtest: pipe-A-plane-3 [198.759714] Dynamic subtest pipe-A-plane-3: SUCCESS (2.233s) [198.767879] Starting dynamic subtest: pipe-A-plane-5 [198.970921] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [200.107625] Starting dynamic subtest: pipe-B-plane-0 [204.900745] Dynamic subtest pipe-B-plane-0: SUCCESS (4.800s) [204.909062] Starting dynamic subtest: pipe-B-plane-3 [207.234896] Dynamic subtest pipe-B-plane-3: SUCCESS (2.333s) [207.243516] Starting dynamic subtest: pipe-B-plane-5 [207.445352] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [207.758252] Subtest pixel-format: SUCCESS (16.135s) [208.595823] [036/134] (808s left) perf (blocking) [208.698551] Starting subtest: blocking [208.700874] Starting dynamic subtest: 0-rcs0 [218.729754] Dynamic subtest 0-rcs0: SUCCESS (10.029s) [218.738549] Starting dynamic subtest: 1-vecs0 [228.750099] Dynamic subtest 1-vecs0: SUCCESS (10.018s) [228.752704] Subtest blocking: SUCCESS (20.050s) [228.799970] [037/134] (788s left) kms_hdr (bpc-switch) [228.886663] Starting subtest: bpc-switch [229.943637] Starting dynamic subtest: pipe-A-eDP-1 [233.361261] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s) [233.363795] Subtest bpc-switch: SUCCESS (4.478s) [233.499301] [038/134] (784s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [233.889026] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [234.733294] [039/134] (782s left) gem_ctx_shared (q-promotion) [234.787331] Starting subtest: Q-promotion [234.789779] Starting dynamic subtest: rcs0 [234.909398] Dynamic subtest rcs0: SUCCESS (0.120s) [234.920332] Starting dynamic subtest: vcs0 [235.004208] Dynamic subtest vcs0: SUCCESS (0.095s) [235.019615] Starting dynamic subtest: vcs1 [235.085284] Dynamic subtest vcs1: SUCCESS (0.080s) [235.099213] Starting dynamic subtest: vecs0 [235.164946] Dynamic subtest vecs0: SUCCESS (0.077s) [235.180947] Starting dynamic subtest: ccs0 [235.244824] Dynamic subtest ccs0: SUCCESS (0.079s) [235.247325] Subtest Q-promotion: SUCCESS (0.457s) [237.006514] [040/134] (780s left) i915_hangman (error-state-basic) [237.072402] Starting subtest: error-state-basic [237.234161] Subtest error-state-basic: SUCCESS (0.161s) [237.335307] [041/134] (780s left) gem_softpin (softpin) [237.395585] Starting subtest: softpin [269.622704] Subtest softpin: SUCCESS (32.223s) [269.756844] [042/134] (747s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [269.857745] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [270.548589] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s) [270.766385] [043/134] (746s left) syncobj_wait (reset-multiple-signaled) [270.810730] Starting subtest: reset-multiple-signaled [270.813071] Subtest reset-multiple-signaled: SUCCESS (0.000s) [270.935618] [044/134] (746s left) gem_eio (wait-10ms) [271.168619] Starting subtest: wait-10ms [271.550988] Subtest wait-10ms: SUCCESS (0.382s) [271.710959] [045/134] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [271.820188] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [271.824253] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [271.942807] [046/134] (745s left) gem_sync (basic-all) [272.007751] Starting subtest: basic-all [274.244799] Subtest basic-all: SUCCESS (2.247s) [274.445211] [047/134] (743s left) kms_vblank (wait-forked) [274.546944] Starting subtest: wait-forked [274.549225] Starting dynamic subtest: pipe-A-eDP-1 [276.346987] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.797s) [276.363555] Starting dynamic subtest: pipe-D-eDP-1 [278.840757] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.494s) [278.843075] Subtest wait-forked: SUCCESS (4.295s) [279.711802] [048/134] (738s left) gem_ctx_persistence (many-contexts) [279.769318] Starting subtest: many-contexts [324.953879] Subtest many-contexts: SUCCESS (45.181s) [325.045836] [049/134] (692s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [325.150330] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [325.154648] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [325.289481] [050/134] (692s left) kms_content_protection (type1) [325.430237] Starting subtest: type1 [325.434663] Subtest type1: SKIP (0.000s) [325.586827] [051/134] (692s left) kms_chamelium_frames (dp-crc-single) [325.981703] Subtest dp-crc-single: SKIP (0.000s) [326.806955] [052/134] (691s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [326.902234] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [326.904484] Starting dynamic subtest: pipe-A-eDP-1 [326.913762] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [326.924070] Starting dynamic subtest: pipe-B-eDP-1 [326.933186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [326.942451] Starting dynamic subtest: pipe-C-eDP-1 [326.951064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [326.959373] Starting dynamic subtest: pipe-D-eDP-1 [326.967849] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [326.972029] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s) [329.114127] [053/134] (689s left) gem_ppgtt (shrink-vs-evict-any) [329.182821] Starting subtest: shrink-vs-evict-any [334.961649] Subtest shrink-vs-evict-any: SUCCESS (5.777s) [335.074881] [054/134] (683s left) gem_exec_schedule (preempt-contexts) [335.148381] Starting subtest: preempt-contexts [335.150615] Starting dynamic subtest: rcs0 [335.233455] Dynamic subtest rcs0: SUCCESS (0.091s) [335.243863] Starting dynamic subtest: bcs0 [335.312374] Dynamic subtest bcs0: SUCCESS (0.078s) [335.321802] Starting dynamic subtest: vcs0 [335.374702] Dynamic subtest vcs0: SUCCESS (0.062s) [335.384171] Starting dynamic subtest: vcs1 [335.438458] Dynamic subtest vcs1: SUCCESS (0.062s) [335.448346] Starting dynamic subtest: vecs0 [335.493724] Dynamic subtest vecs0: SUCCESS (0.055s) [335.504357] Starting dynamic subtest: ccs0 [335.574556] Dynamic subtest ccs0: SUCCESS (0.081s) [335.576872] Subtest preempt-contexts: SUCCESS (0.433s) [337.043066] [055/134] (681s left) gem_exec_suspend (basic) [337.105504] Starting subtest: basic [337.107628] Starting dynamic subtest: smem [338.900199] Dynamic subtest smem: SUCCESS (1.796s) [338.903118] Subtest basic: SUCCESS (1.798s) [339.116508] [056/134] (679s left) kms_feature_discovery (psr1) [339.216116] Starting subtest: psr1 [339.218433] Subtest psr1: SUCCESS (0.000s) [339.300215] [057/134] (679s left) kms_psr (psr2-no-drrs) [339.396389] Starting subtest: psr2-no-drrs [339.398688] Starting dynamic subtest: eDP-1 [340.989246] Dynamic subtest eDP-1: SUCCESS (1.592s) [340.991387] Subtest psr2-no-drrs: SUCCESS (1.594s) [341.800887] [058/134] (676s left) kms_frontbuffer_tracking (fbc-tiling-linear) [341.902346] Starting subtest: fbc-tiling-linear [345.657907] Subtest fbc-tiling-linear: SUCCESS (3.758s) [346.801782] [059/134] (671s left) sysfs_timeslice_duration (idempotent) [346.866958] Starting subtest: idempotent [346.869373] Starting dynamic subtest: vecs0 [346.871747] Dynamic subtest vecs0: SUCCESS (0.000s) [346.882080] Starting dynamic subtest: ccs0 [346.883929] Dynamic subtest ccs0: SUCCESS (0.000s) [346.892712] Starting dynamic subtest: vcs0 [346.894634] Dynamic subtest vcs0: SUCCESS (0.000s) [346.902914] Starting dynamic subtest: bcs0 [346.904859] Dynamic subtest bcs0: SUCCESS (0.000s) [346.912957] Starting dynamic subtest: rcs0 [346.914892] Dynamic subtest rcs0: SUCCESS (0.000s) [346.923215] Starting dynamic subtest: vcs1 [346.925108] Dynamic subtest vcs1: SUCCESS (0.000s) [346.926976] Subtest idempotent: SUCCESS (0.006s) [347.022539] [060/134] (671s left) syncobj_timeline (single-wait-signaled) [347.085723] Starting subtest: single-wait-signaled [347.087626] Subtest single-wait-signaled: SUCCESS (0.000s) [347.189926] [061/134] (671s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [347.292162] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [348.404874] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.112s) [348.570559] [062/134] (669s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [348.668622] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [348.672128] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [348.795408] [063/134] (669s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [348.893479] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [355.503034] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.609s) [355.664562] [064/134] (662s left) gem_userptr_blits (dmabuf-sync) [355.722463] Starting subtest: dmabuf-sync [355.726941] Subtest dmabuf-sync: SKIP (0.002s) [355.870738] [065/134] (662s left) gem_watchdog (default-physical) [355.949587] Starting subtest: default-physical [357.705892] Subtest default-physical: SUCCESS (1.768s) [357.808947] [066/134] (660s left) template (b) [357.870558] Starting subtest: B [357.872499] Subtest B: SUCCESS (0.000s) [357.999215] [067/134] (660s left) gem_exec_balancer (noheartbeat) [358.258959] Starting subtest: noheartbeat [358.263768] Subtest noheartbeat: SKIP (0.000s) [358.387704] [068/134] (660s left) kms_colorop (plane-xr24-xr24-ctm_3x4_bt709_enc) [358.525416] Subtest plane-XR24-XR24-ctm_3x4_bt709_enc: SKIP (0.000s) [358.620751] [069/134] (660s left) kms_vrr (lobf) [358.709315] Starting subtest: lobf [358.713630] Subtest lobf: SKIP (0.000s) [358.795635] [070/134] (660s left) kms_lease (empty-lease) [358.892156] Starting subtest: empty-lease [358.894817] Starting dynamic subtest: pipe-A-eDP-1 [358.897548] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [358.908823] Starting dynamic subtest: pipe-B-eDP-1 [358.911091] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [358.920082] Starting dynamic subtest: pipe-C-eDP-1 [358.922221] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [358.930738] Starting dynamic subtest: pipe-D-eDP-1 [358.933030] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [358.935229] Subtest empty-lease: SUCCESS (0.009s) [359.019547] [071/134] (659s left) gem_mmap (basic-small-bo) [359.064318] Subtest basic-small-bo: SKIP (0.000s) [359.149503] [072/134] (659s left) kms_colorop (plane-xr24-xr24-gamma_2_2_inv_oetf-gamma_2_2_oetf) [359.279201] Subtest plane-XR24-XR24-gamma_2_2_inv_oetf-gamma_2_2_oetf: SKIP (0.000s) [359.364732] [073/134] (659s left) i915_drm_fdinfo (context-close-stress) [359.403435] Starting subtest: context-close-stress [370.150257] Subtest context-close-stress: SUCCESS (10.745s) [370.247155] [074/134] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [370.493610] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [370.498047] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [370.592481] [075/134] (648s left) gem_lmem_swapping (verify) [370.637222] Subtest verify: SKIP (0.000s) [370.675685] [076/134] (648s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [370.770920] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [370.775148] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [370.914033] [077/134] (648s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [370.976321] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [370.980860] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [371.188993] [078/134] (647s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [371.287209] Starting subtest: 2x-wf_vblank-ts-check-interruptible [371.299593] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [371.395728] [079/134] (647s left) gem_mmap_wc (read-write) [371.450175] Subtest read-write: SKIP (0.000s) [371.521345] [080/134] (647s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [371.621983] Starting subtest: psr-modesetfrombusy [377.765170] Subtest psr-modesetfrombusy: SUCCESS (6.147s) [377.939089] [081/134] (641s left) perf (invalid-remove-userspace-config) [378.023391] Starting subtest: invalid-remove-userspace-config [378.033305] Subtest invalid-remove-userspace-config: SUCCESS (0.008s) [378.080182] [082/134] (641s left) kms_big_fb (y-tiled-8bpp-rotate-270) [378.179851] Starting subtest: y-tiled-8bpp-rotate-270 [378.183818] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [378.312734] [083/134] (641s left) gem_mmap_wc (read) [378.367856] Subtest read: SKIP (0.000s) [378.431605] [084/134] (640s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [378.519519] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [378.521151] Starting dynamic subtest: pipe-A-eDP-1 [378.540797] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s) [378.550244] Starting dynamic subtest: pipe-B-eDP-1 [378.567066] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [378.575924] Starting dynamic subtest: pipe-C-eDP-1 [378.591821] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s) [378.600511] Starting dynamic subtest: pipe-D-eDP-1 [378.617118] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [378.618911] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s) [380.835034] [085/134] (638s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [380.958088] Starting subtest: nonblocking-modeset-vs-cursor-atomic [382.409604] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.452s) [383.297225] [086/134] (636s left) gem_softpin (allocator-fork) [383.355472] Starting subtest: allocator-fork [385.563883] Subtest allocator-fork: SUCCESS (2.207s) [385.734716] [087/134] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [385.839630] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [392.599246] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.761s) [392.769629] [088/134] (626s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [392.832621] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [392.896986] [089/134] (626s left) gem_softpin (invalid) [392.954725] Starting subtest: invalid [392.961754] Subtest invalid: SUCCESS (0.006s) [393.121390] [090/134] (626s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [393.169673] Starting subtest: multi-wait-all-for-submit-submitted-signaled [393.270887] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s) [393.361267] [091/134] (626s left) kms_pm_backlight (fade) [393.446569] Starting subtest: fade [393.493876] Starting dynamic subtest: eDP-1 [396.180012] Dynamic subtest eDP-1: SUCCESS (2.683s) [396.182236] Subtest fade: SUCCESS (2.733s) [397.061118] [092/134] (622s left) vgem_basic (dmabuf-export) [397.102672] Starting subtest: dmabuf-export [397.159533] Subtest dmabuf-export: SUCCESS (0.059s) [397.290248] [093/134] (622s left) kms_plane_multiple (2x-tiling-none) [397.382151] Starting subtest: 2x-tiling-none [397.386564] Subtest 2x-tiling-none: SKIP (0.000s) [397.467747] [094/134] (622s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [397.570468] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [397.574740] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [397.708048] [095/134] (622s left) kms_flip (absolute-wf_vblank) [397.806375] Starting subtest: absolute-wf_vblank [397.808319] Starting dynamic subtest: A-eDP1 [406.524005] Dynamic subtest A-eDP1: SUCCESS (8.713s) [406.534969] Starting dynamic subtest: B-eDP1 [415.246125] Dynamic subtest B-eDP1: SUCCESS (8.727s) [415.259884] Starting dynamic subtest: C-eDP1 [423.961070] Dynamic subtest C-eDP1: SUCCESS (8.712s) [423.973066] Starting dynamic subtest: D-eDP1 [432.695378] Dynamic subtest D-eDP1: SUCCESS (8.731s) [432.699868] Subtest absolute-wf_vblank: SUCCESS (34.896s) [433.923799] [096/134] (585s left) gem_eio (throttle) [434.155999] Starting subtest: throttle [434.494999] Subtest throttle: SUCCESS (0.337s) [434.649396] [097/134] (585s left) kms_psr (fbc-psr-cursor-plane-move) [434.744134] Starting subtest: fbc-psr-cursor-plane-move [434.746371] Starting dynamic subtest: eDP-1 [434.750464] Dynamic subtest eDP-1: SKIP (0.000s) [434.754607] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [434.830439] [098/134] (585s left) kms_colorop (plane-xr30-xr30-ctm_3x4_bt709_enc) [434.968946] Subtest plane-XR30-XR30-ctm_3x4_bt709_enc: SKIP (0.000s) [435.047224] [099/134] (584s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [435.108847] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [435.215693] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s) [435.305753] [100/134] (584s left) kms_cursor_crc (cursor-sliding-32x10) [435.463868] Starting subtest: cursor-sliding-32x10 [435.509698] Subtest cursor-sliding-32x10: SKIP (0.044s) [435.807084] [101/134] (584s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [440.798349] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [440.801038] Starting dynamic subtest: pipe-A-eDP-1 [447.406312] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.607s) [447.416878] Starting dynamic subtest: pipe-B-eDP-1 [454.051500] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.643s) [454.053647] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.254s) [454.949594] [102/134] (565s left) syncobj_wait (wait-delayed-signal) [455.007733] Starting subtest: wait-delayed-signal [455.108858] Subtest wait-delayed-signal: SUCCESS (0.102s) [455.214191] [103/134] (564s left) kms_pm_rpm (legacy-planes-dpms) [457.052828] Starting subtest: legacy-planes-dpms [457.055585] Starting dynamic subtest: plane-43 [465.370997] Dynamic subtest plane-43: SUCCESS (8.321s) [465.382692] Starting dynamic subtest: plane-53 [473.667059] Dynamic subtest plane-53: SUCCESS (8.292s) [473.679579] Starting dynamic subtest: plane-63 [481.978557] Dynamic subtest plane-63: SUCCESS (8.308s) [481.991644] Starting dynamic subtest: plane-73 [490.595862] Dynamic subtest plane-73: SUCCESS (8.614s) [490.598285] Subtest legacy-planes-dpms: SUCCESS (33.548s) [490.995185] [104/134] (529s left) kms_atomic_interruptible (legacy-cursor) [491.083732] Starting subtest: legacy-cursor [491.085931] Starting dynamic subtest: pipe-A-eDP-1 [498.468589] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.383s) [498.471049] Subtest legacy-cursor: SUCCESS (7.384s) [499.332084] [105/134] (520s left) perf (disabled-read-error) [499.430080] Starting subtest: disabled-read-error [499.445029] Subtest disabled-read-error: SUCCESS (0.014s) [499.487745] [106/134] (520s left) gem_mmap_gtt (basic-small-copy-xy) [499.542148] Subtest basic-small-copy-XY: SKIP (0.000s) [499.598218] [107/134] (520s left) i915_query (query-topology-garbage-items) [499.656465] Starting subtest: query-topology-garbage-items [499.658821] Subtest query-topology-garbage-items: SUCCESS (0.001s) [499.757809] [108/134] (520s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [499.857671] Starting subtest: fbcpsr-rgb565-draw-blt [506.858256] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.002s) [507.004165] [109/134] (513s left) kms_async_flips (async-flip-suspend-resume) [507.100149] Starting subtest: async-flip-suspend-resume [507.484938] Starting dynamic subtest: pipe-A-eDP-1 [508.731740] Dynamic subtest pipe-A-eDP-1: FAIL (0.775s) [508.742199] Starting dynamic subtest: pipe-B-eDP-1 [509.641365] Dynamic subtest pipe-B-eDP-1: FAIL (0.729s) [509.750565] Starting dynamic subtest: pipe-C-eDP-1 [527.584199] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.025s) [527.938980] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [527.943590] Starting dynamic subtest: pipe-D-eDP-1 [545.535986] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.858s) [545.538511] Subtest async-flip-suspend-resume: FAIL (8.881s) [546.794324] [FACT kms_async_flips (async-flip-suspend-resume)] new: kernel.is_tainted.taint_warn: true [546.795362] Closing watchdogs results: parsing output: 0/ for test: kms_flip_scaled_crc results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: perf results: parsing output: 3/ for test: gem_ctx_exec results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_draw_crc results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_ccs results: parsing output: 9/ for test: kms_chamelium_color results: parsing output: 10/ for test: api_intel_bb results: parsing output: 11/ for test: drm_read results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gen9_exec_parse results: parsing output: 14/ for test: dmabuf_sync_file results: parsing output: 15/ for test: gem_exec_reloc results: parsing output: 16/ for test: kms_cursor_crc results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: gem_busy results: parsing output: 19/ for test: gem_exec_schedule results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: kms_selftest results: parsing output: 24/ for test: kms_cursor_legacy results: parsing output: 25/ for test: gem_exec_fence results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_flip_scaled_crc results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: vgem_basic results: parsing output: 31/ for test: api_intel_allocator results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_exec_whisper results: parsing output: 34/ for test: kms_plane results: parsing output: 35/ for test: perf results: parsing output: 36/ for test: kms_hdr results: parsing output: 37/ for test: kms_chamelium_hpd results: parsing output: 38/ for test: gem_ctx_shared results: parsing output: 39/ for test: i915_hangman results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: syncobj_wait results: parsing output: 43/ for test: gem_eio results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_sync results: parsing output: 46/ for test: kms_vblank results: parsing output: 47/ for test: gem_ctx_persistence results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_content_protection results: parsing output: 50/ for test: kms_chamelium_frames results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: gem_ppgtt results: parsing output: 53/ for test: gem_exec_schedule results: parsing output: 54/ for test: gem_exec_suspend results: parsing output: 55/ for test: kms_feature_discovery results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: sysfs_timeslice_duration results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gem_userptr_blits results: parsing output: 64/ for test: gem_watchdog results: parsing output: 65/ for test: template results: parsing output: 66/ for test: gem_exec_balancer results: parsing output: 67/ for test: kms_colorop results: parsing output: 68/ for test: kms_vrr results: parsing output: 69/ for test: kms_lease results: parsing output: 70/ for test: gem_mmap results: parsing output: 71/ for test: kms_colorop results: parsing output: 72/ for test: i915_drm_fdinfo results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_lmem_swapping results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_render_copy results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: gem_mmap_wc results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: perf results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: gem_mmap_wc results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_cursor_legacy results: parsing output: 85/ for test: gem_softpin results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_pipe_b_c_ivb results: parsing output: 88/ for test: gem_softpin results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: kms_pm_backlight results: parsing output: 91/ for test: vgem_basic results: parsing output: 92/ for test: kms_plane_multiple results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: gem_eio results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: kms_colorop results: parsing output: 98/ for test: syncobj_timeline results: parsing output: 99/ for test: kms_cursor_crc results: parsing output: 100/ for test: kms_psr2_sf results: parsing output: 101/ for test: syncobj_wait results: parsing output: 102/ for test: kms_pm_rpm results: parsing output: 103/ for test: kms_atomic_interruptible results: parsing output: 104/ for test: perf results: parsing output: 105/ for test: gem_mmap_gtt results: parsing output: 106/ for test: i915_query results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_async_flips results: parsing output: 109/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 110/ for test: gem_exec_reloc results: no output, setting notrun results: parsing output: 111/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 112/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 113/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 114/ for test: kms_mmap_write_crc results: no output, setting notrun results: parsing output: 115/ for test: kms_ccs results: no output, setting notrun results: parsing output: 116/ for test: kms_properties results: no output, setting notrun results: parsing output: 117/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 118/ for test: perf_pmu results: no output, setting notrun results: parsing output: 119/ for test: kms_psr2_sf results: no output, setting notrun results: parsing output: 120/ for test: gem_eio results: no output, setting notrun results: parsing output: 121/ for test: syncobj_eventfd results: no output, setting notrun results: parsing output: 122/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 123/ for test: kms_psr_stress_test results: no output, setting notrun results: parsing output: 124/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 125/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 126/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 127/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 128/ for test: gem_exec_params results: no output, setting notrun results: parsing output: 129/ for test: i915_pm_rc6_residency results: no output, setting notrun results: parsing output: 130/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 131/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 132/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 133/ for test: gem_ctx_persistence results: no output, setting notrun Done.