[59.075685] Initializing watchdogs [59.075731] /dev/watchdog0 [59.089079] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.093641] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.095965] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.099333] [001/134] (960s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [59.207813] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [59.210128] Starting dynamic subtest: pipe-A-default-mode [61.923949] Dynamic subtest pipe-A-default-mode: SUCCESS (2.710s) [61.925866] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.711s) [62.796637] [002/134] (956s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [67.810701] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [67.815765] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [68.663480] [003/134] (951s left) perf (polling-small-buf) [68.803821] Starting subtest: polling-small-buf [68.896071] Subtest polling-small-buf: SUCCESS (0.090s) [68.938287] [004/134] (950s left) gem_ctx_exec (basic-close-race) [69.003315] Starting subtest: basic-close-race [75.154754] Subtest basic-close-race: SUCCESS (6.096s) [75.261591] [005/134] (944s left) kms_big_fb (x-tiled-16bpp-rotate-0) [75.373644] Starting subtest: x-tiled-16bpp-rotate-0 [76.638819] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.267s) [76.782229] [006/134] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [76.880679] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [76.884218] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [77.013569] [007/134] (942s left) kms_draw_crc (draw-method-mmap-wc) [77.095275] Starting subtest: draw-method-mmap-wc [77.096959] Starting dynamic subtest: xrgb8888-untiled [77.337877] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s) [77.345377] Starting dynamic subtest: rgb565-untiled [77.537949] Dynamic subtest rgb565-untiled: SUCCESS (0.199s) [77.546758] Starting dynamic subtest: xrgb2101010-untiled [77.759881] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [77.767967] Starting dynamic subtest: xbgr16161616f-untiled [77.982671] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [77.992250] Starting dynamic subtest: xrgb8888-xtiled [78.127075] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s) [78.133738] Starting dynamic subtest: rgb565-xtiled [78.260203] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [78.266856] Starting dynamic subtest: xrgb2101010-xtiled [78.382312] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [78.391182] Starting dynamic subtest: xbgr16161616f-xtiled [78.515716] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [78.524108] Starting dynamic subtest: xrgb8888-4tiled [78.660219] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [78.668062] Starting dynamic subtest: rgb565-4tiled [78.804849] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [78.811516] Starting dynamic subtest: xrgb2101010-4tiled [78.960110] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s) [78.970751] Starting dynamic subtest: xbgr16161616f-4tiled [79.138174] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.178s) [79.140192] Subtest draw-method-mmap-wc: SUCCESS (2.045s) [79.264205] [008/134] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [79.366990] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [102.238513] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.873s) [102.404540] [009/134] (917s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [102.505416] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [102.507078] Starting dynamic subtest: pipe-A-eDP-1 [102.655149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s) [102.664592] Starting dynamic subtest: pipe-B-eDP-1 [102.679887] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.016s) [102.686893] Starting dynamic subtest: pipe-C-eDP-1 [102.703462] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [102.710405] Starting dynamic subtest: pipe-D-eDP-1 [102.726459] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [102.728047] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.184s) [104.983965] [010/134] (914s left) kms_chamelium_color (ctm-blue-to-red) [105.081365] Subtest ctm-blue-to-red: SKIP (0.000s) [105.121729] [011/134] (914s left) api_intel_bb (reset-bb) [105.174191] Starting subtest: reset-bb [105.176604] Subtest reset-bb: SUCCESS (0.004s) [105.322897] [012/134] (914s left) drm_read (empty-block) [105.456930] Starting subtest: empty-block [106.457460] Subtest empty-block: SUCCESS (1.000s) [106.637666] [013/134] (913s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [106.736263] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [106.740476] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [106.868909] [014/134] (913s left) gen9_exec_parse (bb-start-out) [106.934275] Subtest bb-start-out: SKIP (0.000s) [107.019590] [015/134] (913s left) dmabuf_sync_file (import-basic) [107.110496] Starting subtest: import-basic [107.112613] Subtest import-basic: SUCCESS (0.001s) [107.169846] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true [107.172832] [016/134] (913s left) gem_exec_reloc (basic-write-read) [107.241863] Subtest basic-write-read: SKIP (0.000s) [107.306071] [017/134] (912s left) kms_cursor_crc (cursor-tearing-position-change) [107.416578] Starting subtest: cursor-tearing-position-change [107.418947] Starting dynamic subtest: pipe-A-eDP-1 [107.971016] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s) [107.982600] Starting dynamic subtest: pipe-D-eDP-1 [109.190787] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s) [109.193056] Subtest cursor-tearing-position-change: SUCCESS (1.771s) [110.037338] [018/134] (910s left) kms_psr (fbc-pr-primary-render) [110.137151] Starting subtest: fbc-pr-primary-render [110.141483] Subtest fbc-pr-primary-render: SKIP (0.000s) [110.220644] [019/134] (910s left) gem_busy (extended) [110.400043] Starting subtest: extended [110.402779] Starting dynamic subtest: rcs0 [110.511616] Dynamic subtest rcs0: SUCCESS (0.111s) [110.521093] Starting dynamic subtest: bcs0 [110.552221] Dynamic subtest bcs0: SUCCESS (0.039s) [110.560968] Starting dynamic subtest: vcs0 [111.893313] Dynamic subtest vcs0: SUCCESS (1.337s) [111.902848] Starting dynamic subtest: vcs1 [113.876771] Dynamic subtest vcs1: SUCCESS (1.980s) [113.886632] Starting dynamic subtest: vecs0 [115.977355] Dynamic subtest vecs0: SUCCESS (2.046s) [115.986862] Starting dynamic subtest: ccs0 [115.988838] Dynamic subtest ccs0: SUCCESS (0.044s) [115.990845] Subtest extended: SUCCESS (5.570s) [116.237525] [020/134] (904s left) gem_exec_schedule (preempt-user) [116.302289] Starting subtest: preempt-user [116.304252] Starting dynamic subtest: rcs0 [116.331867] Dynamic subtest rcs0: SUCCESS (0.037s) [116.342241] Starting dynamic subtest: bcs0 [116.362579] Dynamic subtest bcs0: SUCCESS (0.029s) [116.372413] Starting dynamic subtest: vcs0 [116.390025] Dynamic subtest vcs0: SUCCESS (0.027s) [116.399758] Starting dynamic subtest: vcs1 [116.414345] Dynamic subtest vcs1: SUCCESS (0.023s) [116.421814] Starting dynamic subtest: vecs0 [116.436175] Dynamic subtest vecs0: SUCCESS (0.021s) [116.443802] Starting dynamic subtest: ccs0 [116.471430] Dynamic subtest ccs0: SUCCESS (0.034s) [116.473802] Subtest preempt-user: SUCCESS (0.177s) [118.012549] [021/134] (902s left) kms_big_fb (4-tiled-16bpp-rotate-180) [118.116822] Starting subtest: 4-tiled-16bpp-rotate-180 [119.453103] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.335s) [119.597644] [022/134] (900s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [119.701528] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [119.705128] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [119.824804] [023/134] (900s left) gem_exec_fence (basic-await) [119.995791] Starting subtest: basic-await [119.998216] Starting dynamic subtest: rcs0 [120.072214] Dynamic subtest rcs0: SUCCESS (0.077s) [120.082177] Starting dynamic subtest: bcs0 [120.152998] Dynamic subtest bcs0: SUCCESS (0.079s) [120.163131] Starting dynamic subtest: vcs0 [120.225334] Dynamic subtest vcs0: SUCCESS (0.071s) [120.235372] Starting dynamic subtest: vcs1 [120.299121] Dynamic subtest vcs1: SUCCESS (0.072s) [120.310319] Starting dynamic subtest: vecs0 [120.371673] Dynamic subtest vecs0: SUCCESS (0.071s) [120.381980] Starting dynamic subtest: ccs0 [120.443627] Dynamic subtest ccs0: SUCCESS (0.070s) [120.446080] Subtest basic-await: SUCCESS (0.449s) [122.078274] [024/134] (898s left) kms_selftest (drm_plane_helper) [122.117489] Starting subtest: drm_plane_helper [122.125985] Starting dynamic subtest: drm_test_check_plane_state [122.286250] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.159s) [122.295503] Starting dynamic subtest: drm_test_check_invalid_plane_state [122.425948] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.138s) [122.427958] Subtest drm_plane_helper: SUCCESS (0.307s) [122.633110] [025/134] (897s left) kms_cursor_legacy (cursor-vs-flip-legacy) [122.763379] Starting subtest: cursor-vs-flip-legacy [151.980777] Subtest cursor-vs-flip-legacy: SUCCESS (29.215s) [152.856467] [026/134] (867s left) gem_exec_fence (invalid-fence-array) [153.256691] Starting subtest: invalid-fence-array [153.259380] Subtest invalid-fence-array: SUCCESS (0.002s) [155.016267] [027/134] (865s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [155.119873] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [158.738552] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.622s) [159.944685] [028/134] (860s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [160.043467] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [167.060565] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.019s) [167.183277] [029/134] (853s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [167.280059] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [167.282394] Starting dynamic subtest: pipe-A-default-mode [167.640903] Dynamic subtest pipe-A-default-mode: SKIP (0.359s) [167.645363] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.361s) [168.385542] [030/134] (852s left) kms_psr (fbc-psr-sprite-plane-move) [168.488263] Starting subtest: fbc-psr-sprite-plane-move [168.490562] Starting dynamic subtest: eDP-1 [168.494998] Dynamic subtest eDP-1: SKIP (0.000s) [168.499421] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [168.584872] [031/134] (852s left) vgem_basic (sysfs) [168.625679] Starting subtest: sysfs [168.627693] Subtest sysfs: SUCCESS (0.000s) [168.710250] [032/134] (852s left) api_intel_allocator (fork-simple-once) [168.775715] Starting subtest: fork-simple-once [168.792118] Subtest fork-simple-once: SUCCESS (0.019s) [168.949703] [033/134] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [169.042758] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [169.047318] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [169.174377] [034/134] (851s left) gem_exec_whisper (basic-fds-priority) [169.239938] Starting subtest: basic-fds-priority [193.451673] Subtest basic-fds-priority: SUCCESS (24.156s) [193.589589] [035/134] (827s left) kms_plane (pixel-format) [193.687041] Starting subtest: pixel-format [193.713948] Starting dynamic subtest: pipe-A-plane-0 [198.568786] Dynamic subtest pipe-A-plane-0: SUCCESS (4.855s) [198.577459] Starting dynamic subtest: pipe-A-plane-3 [200.824795] Dynamic subtest pipe-A-plane-3: SUCCESS (2.255s) [200.833577] Starting dynamic subtest: pipe-A-plane-5 [201.024904] Dynamic subtest pipe-A-plane-5: SUCCESS (0.199s) [202.147791] Starting dynamic subtest: pipe-B-plane-0 [206.952755] Dynamic subtest pipe-B-plane-0: SUCCESS (4.812s) [206.961121] Starting dynamic subtest: pipe-B-plane-3 [209.218373] Dynamic subtest pipe-B-plane-3: SUCCESS (2.265s) [209.227287] Starting dynamic subtest: pipe-B-plane-5 [209.429776] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [209.741876] Subtest pixel-format: SUCCESS (16.054s) [210.638230] [036/134] (810s left) perf (blocking) [210.729069] Starting subtest: blocking [210.730862] Starting dynamic subtest: 0-rcs0 [220.752531] Dynamic subtest 0-rcs0: SUCCESS (10.024s) [220.760980] Starting dynamic subtest: 1-vecs0 [230.773178] Dynamic subtest 1-vecs0: SUCCESS (10.019s) [230.775974] Subtest blocking: SUCCESS (20.045s) [230.820289] [037/134] (790s left) kms_hdr (bpc-switch) [230.921569] Starting subtest: bpc-switch [232.000973] Starting dynamic subtest: pipe-A-eDP-1 [235.491214] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s) [235.493586] Subtest bpc-switch: SUCCESS (4.571s) [235.649219] [038/134] (785s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [236.025655] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [236.869272] [039/134] (784s left) gem_ctx_shared (q-promotion) [236.919645] Starting subtest: Q-promotion [236.922301] Starting dynamic subtest: rcs0 [237.039071] Dynamic subtest rcs0: SUCCESS (0.118s) [237.055816] Starting dynamic subtest: vcs0 [237.129549] Dynamic subtest vcs0: SUCCESS (0.089s) [237.144050] Starting dynamic subtest: vcs1 [237.202493] Dynamic subtest vcs1: SUCCESS (0.072s) [237.215614] Starting dynamic subtest: vecs0 [237.278349] Dynamic subtest vecs0: SUCCESS (0.075s) [237.293464] Starting dynamic subtest: ccs0 [237.356658] Dynamic subtest ccs0: SUCCESS (0.076s) [237.359308] Subtest Q-promotion: SUCCESS (0.437s) [239.068063] [040/134] (782s left) i915_hangman (error-state-basic) [239.127183] Starting subtest: error-state-basic [239.277600] Subtest error-state-basic: SUCCESS (0.151s) [239.363404] [041/134] (781s left) gem_softpin (softpin) [239.430443] Starting subtest: softpin [271.809536] Subtest softpin: SUCCESS (32.375s) [271.981712] [042/134] (749s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [272.078740] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [272.735929] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s) [272.910947] [043/134] (748s left) syncobj_wait (reset-multiple-signaled) [272.966699] Starting subtest: reset-multiple-signaled [272.968999] Subtest reset-multiple-signaled: SUCCESS (0.000s) [273.073647] [044/134] (748s left) gem_eio (wait-10ms) [273.301510] Starting subtest: wait-10ms [273.672723] Subtest wait-10ms: SUCCESS (0.371s) [273.842711] [045/134] (747s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [273.947586] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [273.951960] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [274.067361] [046/134] (747s left) gem_sync (basic-all) [274.144476] Starting subtest: basic-all [276.342299] Subtest basic-all: SUCCESS (2.209s) [276.540190] [047/134] (744s left) kms_vblank (wait-forked) [276.641080] Starting subtest: wait-forked [276.642967] Starting dynamic subtest: pipe-A-eDP-1 [278.451496] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s) [278.465779] Starting dynamic subtest: pipe-D-eDP-1 [280.992593] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s) [280.994696] Subtest wait-forked: SUCCESS (4.350s) [281.861607] [048/134] (739s left) gem_ctx_persistence (many-contexts) [281.928670] Starting subtest: many-contexts [327.165594] Subtest many-contexts: SUCCESS (45.217s) [327.329574] [049/134] (694s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [327.438573] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [327.442886] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [327.551963] [050/134] (693s left) kms_content_protection (type1) [327.687999] Starting subtest: type1 [327.692606] Subtest type1: SKIP (0.000s) [327.847406] [051/134] (693s left) kms_chamelium_frames (dp-crc-single) [328.228537] Subtest dp-crc-single: SKIP (0.000s) [329.059688] [052/134] (692s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [329.163516] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [329.165987] Starting dynamic subtest: pipe-A-eDP-1 [329.175583] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [329.186469] Starting dynamic subtest: pipe-B-eDP-1 [329.196785] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [329.207130] Starting dynamic subtest: pipe-C-eDP-1 [329.215547] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [329.223426] Starting dynamic subtest: pipe-D-eDP-1 [329.231894] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [329.236028] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s) [331.466957] [053/134] (690s left) gem_ppgtt (shrink-vs-evict-any) [331.528674] Starting subtest: shrink-vs-evict-any [336.938389] Subtest shrink-vs-evict-any: SUCCESS (5.357s) [336.994674] [054/134] (684s left) gem_exec_schedule (preempt-contexts) [337.072036] Starting subtest: preempt-contexts [337.074446] Starting dynamic subtest: rcs0 [337.155459] Dynamic subtest rcs0: SUCCESS (0.092s) [337.165374] Starting dynamic subtest: bcs0 [337.231040] Dynamic subtest bcs0: SUCCESS (0.075s) [337.240284] Starting dynamic subtest: vcs0 [337.291023] Dynamic subtest vcs0: SUCCESS (0.058s) [337.299956] Starting dynamic subtest: vcs1 [337.348526] Dynamic subtest vcs1: SUCCESS (0.057s) [337.357329] Starting dynamic subtest: vecs0 [337.400144] Dynamic subtest vecs0: SUCCESS (0.048s) [337.408728] Starting dynamic subtest: ccs0 [337.482149] Dynamic subtest ccs0: SUCCESS (0.084s) [337.484370] Subtest preempt-contexts: SUCCESS (0.419s) [339.037832] [055/134] (682s left) gem_exec_suspend (basic) [339.099882] Starting subtest: basic [339.102420] Starting dynamic subtest: smem [340.884557] Dynamic subtest smem: SUCCESS (1.782s) [340.887320] Subtest basic: SUCCESS (1.786s) [341.094175] [056/134] (680s left) kms_feature_discovery (psr1) [341.184991] Starting subtest: psr1 [341.187186] Subtest psr1: SUCCESS (0.000s) [341.279657] [057/134] (680s left) kms_psr (psr2-no-drrs) [341.370173] Starting subtest: psr2-no-drrs [341.372488] Starting dynamic subtest: eDP-1 [342.942767] Dynamic subtest eDP-1: SUCCESS (1.574s) [342.945207] Subtest psr2-no-drrs: SUCCESS (1.575s) [343.753599] [058/134] (678s left) kms_frontbuffer_tracking (fbc-tiling-linear) [343.851416] Starting subtest: fbc-tiling-linear [347.613751] Subtest fbc-tiling-linear: SUCCESS (3.765s) [348.759794] [059/134] (673s left) sysfs_timeslice_duration (idempotent) [348.820948] Starting subtest: idempotent [348.823422] Starting dynamic subtest: vecs0 [348.826050] Dynamic subtest vecs0: SUCCESS (0.000s) [348.835959] Starting dynamic subtest: ccs0 [348.838031] Dynamic subtest ccs0: SUCCESS (0.000s) [348.845751] Starting dynamic subtest: vcs0 [348.847689] Dynamic subtest vcs0: SUCCESS (0.000s) [348.855474] Starting dynamic subtest: bcs0 [348.857366] Dynamic subtest bcs0: SUCCESS (0.000s) [348.865083] Starting dynamic subtest: rcs0 [348.867050] Dynamic subtest rcs0: SUCCESS (0.000s) [348.874887] Starting dynamic subtest: vcs1 [348.876755] Dynamic subtest vcs1: SUCCESS (0.000s) [348.878679] Subtest idempotent: SUCCESS (0.007s) [348.974168] [060/134] (672s left) syncobj_timeline (single-wait-signaled) [349.034797] Starting subtest: single-wait-signaled [349.036781] Subtest single-wait-signaled: SUCCESS (0.000s) [349.150187] [061/134] (672s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [349.252463] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [350.343261] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.090s) [350.509916] [062/134] (671s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [350.613563] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [350.617214] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [350.746139] [063/134] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [350.839837] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [357.379157] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.540s) [357.530600] [064/134] (664s left) gem_userptr_blits (dmabuf-sync) [357.598616] Starting subtest: dmabuf-sync [357.602784] Subtest dmabuf-sync: SKIP (0.003s) [357.776235] [065/134] (664s left) gem_watchdog (default-physical) [357.858759] Starting subtest: default-physical [359.612502] Subtest default-physical: SUCCESS (1.765s) [359.713081] [066/134] (662s left) template (b) [359.764763] Starting subtest: B [359.767082] Subtest B: SUCCESS (0.000s) [359.888315] [067/134] (662s left) gem_exec_balancer (noheartbeat) [360.148339] Starting subtest: noheartbeat [360.153026] Subtest noheartbeat: SKIP (0.000s) [360.280667] [068/134] (661s left) kms_colorop (plane-xr24-xr24-ctm_3x4_bt709_enc) [360.405459] Subtest plane-XR24-XR24-ctm_3x4_bt709_enc: SKIP (0.000s) [360.488056] [069/134] (661s left) kms_vrr (lobf) [360.577147] Starting subtest: lobf [360.581362] Subtest lobf: SKIP (0.000s) [360.663357] [070/134] (661s left) kms_lease (empty-lease) [360.759353] Starting subtest: empty-lease [360.761624] Starting dynamic subtest: pipe-A-eDP-1 [360.763865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [360.772975] Starting dynamic subtest: pipe-B-eDP-1 [360.775228] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [360.783964] Starting dynamic subtest: pipe-C-eDP-1 [360.786265] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [360.795594] Starting dynamic subtest: pipe-D-eDP-1 [360.797805] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [360.800021] Subtest empty-lease: SUCCESS (0.008s) [360.881217] [071/134] (661s left) gem_mmap (basic-small-bo) [360.941813] Subtest basic-small-bo: SKIP (0.000s) [361.004903] [072/134] (661s left) kms_colorop (plane-xr24-xr24-gamma_2_2_inv_oetf-gamma_2_2_oetf) [361.135594] Subtest plane-XR24-XR24-gamma_2_2_inv_oetf-gamma_2_2_oetf: SKIP (0.000s) [361.229581] [073/134] (661s left) i915_drm_fdinfo (context-close-stress) [361.268389] Starting subtest: context-close-stress [372.068567] Subtest context-close-stress: SUCCESS (10.747s) [372.115193] [074/134] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [372.340236] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [372.344531] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [372.479947] [075/134] (650s left) gem_lmem_swapping (verify) [372.523048] Subtest verify: SKIP (0.000s) [372.567700] [076/134] (650s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [372.675150] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [372.679173] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [372.815200] [077/134] (649s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [372.875888] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [372.879966] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [373.072423] [078/134] (649s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [373.175664] Starting subtest: 2x-wf_vblank-ts-check-interruptible [373.186510] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s) [373.274737] [079/134] (649s left) gem_mmap_wc (read-write) [373.334670] Subtest read-write: SKIP (0.000s) [373.402307] [080/134] (649s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [373.502177] Starting subtest: psr-modesetfrombusy [379.744284] Subtest psr-modesetfrombusy: SUCCESS (6.247s) [379.928349] [081/134] (642s left) perf (invalid-remove-userspace-config) [380.012938] Starting subtest: invalid-remove-userspace-config [380.021910] Subtest invalid-remove-userspace-config: SUCCESS (0.009s) [380.070753] [082/134] (642s left) kms_big_fb (y-tiled-8bpp-rotate-270) [380.178342] Starting subtest: y-tiled-8bpp-rotate-270 [380.182353] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [380.303467] [083/134] (642s left) gem_mmap_wc (read) [380.358170] Subtest read: SKIP (0.000s) [380.422368] [084/134] (642s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [380.510628] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [380.512456] Starting dynamic subtest: pipe-A-eDP-1 [380.530897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s) [380.540046] Starting dynamic subtest: pipe-B-eDP-1 [380.556111] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s) [380.564350] Starting dynamic subtest: pipe-C-eDP-1 [380.580834] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [380.589034] Starting dynamic subtest: pipe-D-eDP-1 [380.607837] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [380.609853] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s) [382.897630] [085/134] (640s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [383.011656] Starting subtest: nonblocking-modeset-vs-cursor-atomic [384.466311] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.456s) [385.282361] [086/134] (637s left) gem_softpin (allocator-fork) [385.332816] Starting subtest: allocator-fork [387.591538] Subtest allocator-fork: SUCCESS (2.204s) [387.695785] [087/134] (635s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [387.795284] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [394.626800] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.833s) [394.784437] [088/134] (628s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [394.851364] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [394.918882] [089/134] (628s left) gem_softpin (invalid) [394.979641] Starting subtest: invalid [394.987832] Subtest invalid: SUCCESS (0.006s) [395.125470] [090/134] (627s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [395.186817] Starting subtest: multi-wait-all-for-submit-submitted-signaled [395.297467] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s) [395.397043] [091/134] (627s left) kms_pm_backlight (fade) [395.479667] Starting subtest: fade [395.529832] Starting dynamic subtest: eDP-1 [398.213111] Dynamic subtest eDP-1: SUCCESS (2.684s) [398.215468] Subtest fade: SUCCESS (2.735s) [399.034657] [092/134] (624s left) vgem_basic (dmabuf-export) [399.075867] Starting subtest: dmabuf-export [399.123328] Subtest dmabuf-export: SUCCESS (0.049s) [399.260381] [093/134] (623s left) kms_plane_multiple (2x-tiling-none) [399.349127] Starting subtest: 2x-tiling-none [399.353237] Subtest 2x-tiling-none: SKIP (0.000s) [399.434920] [094/134] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [399.538188] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [399.542139] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [399.669142] [095/134] (623s left) kms_flip (absolute-wf_vblank) [399.763627] Starting subtest: absolute-wf_vblank [399.765845] Starting dynamic subtest: A-eDP1 [408.501737] Dynamic subtest A-eDP1: SUCCESS (8.705s) [408.510072] Starting dynamic subtest: B-eDP1 [417.229375] Dynamic subtest B-eDP1: SUCCESS (8.728s) [417.239978] Starting dynamic subtest: C-eDP1 [425.959147] Dynamic subtest C-eDP1: SUCCESS (8.714s) [425.969868] Starting dynamic subtest: D-eDP1 [434.682660] Dynamic subtest D-eDP1: SUCCESS (8.722s) [434.684901] Subtest absolute-wf_vblank: SUCCESS (34.877s) [435.859340] [096/134] (587s left) gem_eio (throttle) [436.088573] Starting subtest: throttle [436.409880] Subtest throttle: SUCCESS (0.322s) [436.585485] [097/134] (586s left) kms_psr (fbc-psr-cursor-plane-move) [436.682448] Starting subtest: fbc-psr-cursor-plane-move [436.684390] Starting dynamic subtest: eDP-1 [436.688476] Dynamic subtest eDP-1: SKIP (0.000s) [436.692607] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [436.774095] [098/134] (586s left) kms_colorop (plane-xr30-xr30-ctm_3x4_bt709_enc) [436.912961] Subtest plane-XR30-XR30-ctm_3x4_bt709_enc: SKIP (0.000s) [436.998480] [099/134] (586s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [437.050487] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [437.152406] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [437.240722] [100/134] (586s left) kms_cursor_crc (cursor-sliding-32x10) [437.401461] Starting subtest: cursor-sliding-32x10 [437.450380] Subtest cursor-sliding-32x10: SKIP (0.043s) [437.767603] [101/134] (585s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [442.765093] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [442.767580] Starting dynamic subtest: pipe-A-eDP-1 [449.366680] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.599s) [449.379068] Starting dynamic subtest: pipe-B-eDP-1 [455.995714] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.627s) [455.998103] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.230s) [456.907187] [102/134] (566s left) syncobj_wait (wait-delayed-signal) [456.966316] Starting subtest: wait-delayed-signal [457.068998] Subtest wait-delayed-signal: SUCCESS (0.103s) [457.161347] [103/134] (566s left) kms_pm_rpm (legacy-planes-dpms) [459.089409] Starting subtest: legacy-planes-dpms [459.091648] Starting dynamic subtest: plane-43 [467.393417] Dynamic subtest plane-43: SUCCESS (8.307s) [467.405902] Starting dynamic subtest: plane-53 [478.725769] Dynamic subtest plane-53: SUCCESS (11.329s) [478.738555] Starting dynamic subtest: plane-63 [489.626998] Dynamic subtest plane-63: SUCCESS (10.899s) [489.642891] Starting dynamic subtest: plane-73 [498.246479] Dynamic subtest plane-73: SUCCESS (8.616s) [498.249255] Subtest legacy-planes-dpms: SUCCESS (39.162s) [498.641609] [104/134] (525s left) kms_atomic_interruptible (legacy-cursor) [498.740125] Starting subtest: legacy-cursor [498.742401] Starting dynamic subtest: pipe-A-eDP-1 [506.128644] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.385s) [506.130754] Subtest legacy-cursor: SUCCESS (7.387s) [506.996928] [105/134] (516s left) perf (disabled-read-error) [507.083451] Starting subtest: disabled-read-error [507.094236] Subtest disabled-read-error: SUCCESS (0.012s) [507.137686] [106/134] (516s left) gem_mmap_gtt (basic-small-copy-xy) [507.198607] Subtest basic-small-copy-XY: SKIP (0.000s) [507.270370] [107/134] (516s left) i915_query (query-topology-garbage-items) [507.333391] Starting subtest: query-topology-garbage-items [507.335356] Subtest query-topology-garbage-items: SUCCESS (0.000s) [507.459528] [108/134] (516s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [507.547449] Starting subtest: fbcpsr-rgb565-draw-blt [514.622720] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.077s) [514.771013] [109/134] (509s left) kms_async_flips (async-flip-suspend-resume) [514.864312] Starting subtest: async-flip-suspend-resume [515.234368] Starting dynamic subtest: pipe-A-eDP-1 [516.478235] Dynamic subtest pipe-A-eDP-1: FAIL (0.769s) [516.489642] Starting dynamic subtest: pipe-B-eDP-1 [517.372733] Dynamic subtest pipe-B-eDP-1: FAIL (0.740s) [517.503346] Starting dynamic subtest: pipe-C-eDP-1 [535.903176] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.245s) [536.274596] Starting dynamic subtest: pipe-D-eDP-1 [554.589316] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.829s) [554.591667] Subtest async-flip-suspend-resume: FAIL (9.068s) [555.817525] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [555.834698] [FACT kms_async_flips (async-flip-suspend-resume)] new: kernel.is_tainted.taint_warn: true [555.835579] 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.