[55.557624] Initializing watchdogs
[55.557722]   /dev/watchdog0
[55.572567] [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.577045] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.579213] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.582532] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[55.688374] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[55.690609] Starting dynamic subtest: pipe-A-default-mode
[58.367911] Dynamic subtest pipe-A-default-mode: SUCCESS (2.679s)
[58.370298] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.680s)
[59.247247] [002/133] (956s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[64.317409] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[64.322143] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[65.185655] [003/133] (950s left) perf (polling-small-buf)
[65.331280] Starting subtest: polling-small-buf
[65.422995] Subtest polling-small-buf: SUCCESS (0.089s)
[65.464718] [004/133] (950s left) gem_ctx_exec (basic-close-race)
[65.529147] Starting subtest: basic-close-race
[72.448953] Subtest basic-close-race: SUCCESS (6.919s)
[72.607523] [005/133] (943s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[72.716242] Starting subtest: x-tiled-16bpp-rotate-0
[74.073381] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.357s)
[74.196950] [006/133] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[74.297684] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[74.301310] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[74.427386] [007/133] (941s left) kms_draw_crc (draw-method-mmap-wc)
[74.526836] Starting subtest: draw-method-mmap-wc
[74.528679] Starting dynamic subtest: xrgb8888-untiled
[74.758724] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[74.766210] Starting dynamic subtest: rgb565-untiled
[74.980465] Dynamic subtest rgb565-untiled: SUCCESS (0.220s)
[74.986889] Starting dynamic subtest: xrgb2101010-untiled
[75.192549] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[75.200959] Starting dynamic subtest: xbgr16161616f-untiled
[75.402670] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[75.411914] Starting dynamic subtest: xrgb8888-xtiled
[75.546889] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[75.554945] Starting dynamic subtest: rgb565-xtiled
[75.680535] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[75.688682] Starting dynamic subtest: xrgb2101010-xtiled
[75.803048] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[75.811376] Starting dynamic subtest: xbgr16161616f-xtiled
[75.936043] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[75.942716] Starting dynamic subtest: xrgb8888-4tiled
[76.080494] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[76.087128] Starting dynamic subtest: rgb565-4tiled
[76.213982] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[76.221280] Starting dynamic subtest: xrgb2101010-4tiled
[76.347298] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[76.355188] Starting dynamic subtest: xbgr16161616f-4tiled
[76.513639] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[76.515642] Subtest draw-method-mmap-wc: SUCCESS (1.989s)
[76.668887] [008/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[76.770282] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[99.617107] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.848s)
[99.783444] [009/133] (916s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[99.881145] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[99.883044] Starting dynamic subtest: pipe-A-eDP-1
[100.023579] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[100.030853] Starting dynamic subtest: pipe-B-eDP-1
[100.046533] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[100.053849] Starting dynamic subtest: pipe-C-eDP-1
[100.070858] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[100.078270] Starting dynamic subtest: pipe-D-eDP-1
[100.093771] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[100.095296] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.170s)
[102.373615] [010/133] (914s left) kms_chamelium_color (ctm-blue-to-red)
[102.465450] Subtest ctm-blue-to-red: SKIP (0.000s)
[102.511148] [011/133] (913s left) api_intel_bb (reset-bb)
[102.568463] Starting subtest: reset-bb
[102.570857] Subtest reset-bb: SUCCESS (0.003s)
[102.710939] [012/133] (913s left) drm_read (empty-block)
[102.841792] Starting subtest: empty-block
[103.839939] Subtest empty-block: SUCCESS (1.000s)
[103.994175] [013/133] (912s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[104.099608] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[104.103979] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[104.233260] [014/133] (912s left) gen9_exec_parse (bb-start-out)
[104.292860] Subtest bb-start-out: SKIP (0.000s)
[104.359401] [015/133] (912s left) dmabuf_sync_file (import-basic)
[104.441866] Starting subtest: import-basic
[104.444258] Subtest import-basic: SUCCESS (0.001s)
[104.521933] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[104.525327] [016/133] (912s left) gem_exec_reloc (basic-write-read)
[104.580747] Subtest basic-write-read: SKIP (0.000s)
[104.667879] [017/133] (912s left) kms_cursor_crc (cursor-tearing-position-change)
[104.772723] Starting subtest: cursor-tearing-position-change
[104.775053] Starting dynamic subtest: pipe-A-eDP-1
[105.339088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[105.346854] Starting dynamic subtest: pipe-D-eDP-1
[106.588893] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[106.591145] Subtest cursor-tearing-position-change: SUCCESS (1.815s)
[107.447677] [018/133] (909s left) kms_psr (fbc-pr-primary-render)
[107.538132] Starting subtest: fbc-pr-primary-render
[107.542246] Subtest fbc-pr-primary-render: SKIP (0.000s)
[107.619224] [019/133] (909s left) gem_busy (extended)
[107.808640] Starting subtest: extended
[107.811297] Starting dynamic subtest: rcs0
[107.904854] Dynamic subtest rcs0: SUCCESS (0.096s)
[107.915517] Starting dynamic subtest: bcs0
[107.947879] Dynamic subtest bcs0: SUCCESS (0.041s)
[107.958013] Starting dynamic subtest: vcs0
[109.910421] Dynamic subtest vcs0: SUCCESS (1.959s)
[109.920786] Starting dynamic subtest: vcs1
[111.894061] Dynamic subtest vcs1: SUCCESS (1.981s)
[111.904957] Starting dynamic subtest: vecs0
[113.878231] Dynamic subtest vecs0: SUCCESS (1.981s)
[113.889287] Starting dynamic subtest: ccs0
[113.925239] Dynamic subtest ccs0: SUCCESS (0.046s)
[113.927842] Subtest extended: SUCCESS (6.118s)
[114.200760] [020/133] (902s left) gem_exec_schedule (preempt-user)
[114.277504] Starting subtest: preempt-user
[114.279684] Starting dynamic subtest: rcs0
[114.306939] Dynamic subtest rcs0: SUCCESS (0.036s)
[114.316736] Starting dynamic subtest: bcs0
[114.337841] Dynamic subtest bcs0: SUCCESS (0.030s)
[114.344999] Starting dynamic subtest: vcs0
[114.367694] Dynamic subtest vcs0: SUCCESS (0.028s)
[114.377959] Starting dynamic subtest: vcs1
[114.392983] Dynamic subtest vcs1: SUCCESS (0.025s)
[114.402831] Starting dynamic subtest: vecs0
[114.416995] Dynamic subtest vecs0: SUCCESS (0.024s)
[114.428081] Starting dynamic subtest: ccs0
[114.448932] Dynamic subtest ccs0: SUCCESS (0.031s)
[114.451291] Subtest preempt-user: SUCCESS (0.178s)
[116.049039] [021/133] (900s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[116.156749] Starting subtest: 4-tiled-16bpp-rotate-180
[117.481475] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.326s)
[117.636600] [022/133] (899s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[117.737631] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[117.741521] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[117.849193] [023/133] (899s left) gem_exec_fence (basic-await)
[118.028426] Starting subtest: basic-await
[118.030638] Starting dynamic subtest: rcs0
[118.105631] Dynamic subtest rcs0: SUCCESS (0.076s)
[118.116437] Starting dynamic subtest: bcs0
[118.177485] Dynamic subtest bcs0: SUCCESS (0.071s)
[118.187429] Starting dynamic subtest: vcs0
[118.249823] Dynamic subtest vcs0: SUCCESS (0.070s)
[118.261356] Starting dynamic subtest: vcs1
[118.321940] Dynamic subtest vcs1: SUCCESS (0.071s)
[118.332150] Starting dynamic subtest: vecs0
[118.393287] Dynamic subtest vecs0: SUCCESS (0.070s)
[118.403527] Starting dynamic subtest: ccs0
[118.464583] Dynamic subtest ccs0: SUCCESS (0.070s)
[118.467025] Subtest basic-await: SUCCESS (0.436s)
[119.991296] [024/133] (896s left) kms_selftest (drm_plane_helper)
[120.026301] Starting subtest: drm_plane_helper
[120.035068] Starting dynamic subtest: drm_test_check_plane_state
[120.185390] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.150s)
[120.192721] Starting dynamic subtest: drm_test_check_invalid_plane_state
[120.336449] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.152s)
[120.338870] Subtest drm_plane_helper: SUCCESS (0.311s)
[120.566898] [025/133] (896s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[120.682501] Starting subtest: cursor-vs-flip-legacy
[149.894652] Subtest cursor-vs-flip-legacy: SUCCESS (29.211s)
[150.768783] [026/133] (866s left) gem_exec_fence (invalid-fence-array)
[151.171082] Starting subtest: invalid-fence-array
[151.173492] Subtest invalid-fence-array: SUCCESS (0.002s)
[153.031236] [027/133] (864s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[153.133633] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[156.742040] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.613s)
[157.968126] [028/133] (859s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[158.074272] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[164.993544] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.922s)
[165.145799] [029/133] (852s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[165.241868] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[165.244233] Starting dynamic subtest: pipe-A-default-mode
[165.586505] Dynamic subtest pipe-A-default-mode: SKIP (0.350s)
[165.590848] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.351s)
[166.389172] [030/133] (850s left) kms_psr (fbc-psr-sprite-plane-move)
[166.485836] Starting subtest: fbc-psr-sprite-plane-move
[166.488079] Starting dynamic subtest: eDP-1
[166.492311] Dynamic subtest eDP-1: SKIP (0.000s)
[166.496485] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[166.567279] [031/133] (850s left) vgem_basic (sysfs)
[166.615230] Starting subtest: sysfs
[166.617157] Subtest sysfs: SUCCESS (0.001s)
[166.681338] [032/133] (850s left) api_intel_allocator (fork-simple-once)
[166.734617] Starting subtest: fork-simple-once
[166.746819] Subtest fork-simple-once: SUCCESS (0.015s)
[166.894614] [033/133] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[166.988674] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[166.992819] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[167.103061] [034/133] (850s left) gem_exec_whisper (basic-fds-priority)
[167.166323] Starting subtest: basic-fds-priority
[191.945319] Subtest basic-fds-priority: SUCCESS (24.777s)
[192.144568] [035/133] (825s left) kms_plane (pixel-format)
[192.246053] Starting subtest: pixel-format
[192.273621] Starting dynamic subtest: pipe-A-plane-0
[197.094744] Dynamic subtest pipe-A-plane-0: SUCCESS (4.822s)
[197.103015] Starting dynamic subtest: pipe-A-plane-3
[199.472960] Dynamic subtest pipe-A-plane-3: SUCCESS (2.377s)
[199.481771] Starting dynamic subtest: pipe-A-plane-5
[199.684036] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[200.763871] Starting dynamic subtest: pipe-B-plane-0
[205.682140] Dynamic subtest pipe-B-plane-0: SUCCESS (4.922s)
[205.699030] Starting dynamic subtest: pipe-B-plane-3
[207.968832] Dynamic subtest pipe-B-plane-3: SUCCESS (2.288s)
[207.978596] Starting dynamic subtest: pipe-B-plane-5
[208.179960] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[208.499811] Subtest pixel-format: SUCCESS (16.255s)
[209.360311] [036/133] (808s left) perf (blocking)
[209.449866] Starting subtest: blocking
[209.452226] Starting dynamic subtest: 0-rcs0
[219.470066] Dynamic subtest 0-rcs0: SUCCESS (10.018s)
[219.480941] Starting dynamic subtest: 1-vecs0
[229.499134] Dynamic subtest 1-vecs0: SUCCESS (10.018s)
[229.506199] Subtest blocking: SUCCESS (20.039s)
[229.570461] [037/133] (787s left) kms_hdr (bpc-switch)
[229.676288] Starting subtest: bpc-switch
[230.721223] Starting dynamic subtest: pipe-A-eDP-1
[234.232235] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s)
[234.234584] Subtest bpc-switch: SUCCESS (4.558s)
[234.371894] [038/133] (783s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[234.756356] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[235.606800] [039/133] (781s left) gem_ctx_shared (q-promotion)
[235.678832] Starting subtest: Q-promotion
[235.680997] Starting dynamic subtest: rcs0
[235.792684] Dynamic subtest rcs0: SUCCESS (0.112s)
[235.803880] Starting dynamic subtest: vcs0
[235.888492] Dynamic subtest vcs0: SUCCESS (0.094s)
[235.896516] Starting dynamic subtest: vcs1
[235.973532] Dynamic subtest vcs1: SUCCESS (0.081s)
[235.988325] Starting dynamic subtest: vecs0
[236.046936] Dynamic subtest vecs0: SUCCESS (0.075s)
[236.062055] Starting dynamic subtest: ccs0
[236.123668] Dynamic subtest ccs0: SUCCESS (0.076s)
[236.126705] Subtest Q-promotion: SUCCESS (0.445s)
[237.000441] [040/133] (780s left) i915_hangman (error-state-basic)
[237.063551] Starting subtest: error-state-basic
[237.217158] Subtest error-state-basic: SUCCESS (0.154s)
[237.304499] [041/133] (780s left) gem_softpin (softpin)
[237.365985] Starting subtest: softpin
[269.788647] Subtest softpin: SUCCESS (32.418s)
[269.918712] [042/133] (747s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[270.019930] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[270.677244] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[270.897509] [043/133] (746s left) syncobj_wait (reset-multiple-signaled)
[270.947459] Starting subtest: reset-multiple-signaled
[270.949782] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[271.065091] [044/133] (746s left) gem_eio (wait-10ms)
[271.293325] Starting subtest: wait-10ms
[271.661114] Subtest wait-10ms: SUCCESS (0.368s)
[271.822677] [045/133] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[271.914708] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[271.917942] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[272.043285] [046/133] (745s left) gem_sync (basic-all)
[272.107341] Starting subtest: basic-all
[274.902398] Subtest basic-all: SUCCESS (2.801s)
[275.096147] [047/133] (742s left) kms_vblank (wait-forked)
[275.194287] Starting subtest: wait-forked
[275.196534] Starting dynamic subtest: pipe-A-eDP-1
[277.010612] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[277.024043] Starting dynamic subtest: pipe-D-eDP-1
[279.521714] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.507s)
[279.523636] Subtest wait-forked: SUCCESS (4.324s)
[280.416921] [048/133] (737s left) gem_ctx_persistence (many-contexts)
[280.487343] Starting subtest: many-contexts
[325.707784] Subtest many-contexts: SUCCESS (45.220s)
[325.799688] [049/133] (692s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[325.905494] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[325.909944] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[326.034538] [050/133] (691s left) kms_content_protection (type1)
[326.180767] Starting subtest: type1
[326.185207] Subtest type1: SKIP (0.000s)
[326.325709] [051/133] (691s left) kms_chamelium_frames (dp-crc-single)
[326.707917] Subtest dp-crc-single: SKIP (0.000s)
[327.486380] [052/133] (690s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[327.585707] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[327.587973] Starting dynamic subtest: pipe-A-eDP-1
[327.597036] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.606270] Starting dynamic subtest: pipe-B-eDP-1
[327.614990] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.623489] Starting dynamic subtest: pipe-C-eDP-1
[327.632096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.639606] Starting dynamic subtest: pipe-D-eDP-1
[327.648217] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.652135] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[329.795549] [053/133] (688s left) gem_ppgtt (shrink-vs-evict-any)
[329.853658] Starting subtest: shrink-vs-evict-any
[337.876578] Subtest shrink-vs-evict-any: SUCCESS (8.020s)
[337.992451] [054/133] (680s left) gem_exec_schedule (preempt-contexts)
[338.068169] Starting subtest: preempt-contexts
[338.070449] Starting dynamic subtest: rcs0
[338.144663] Dynamic subtest rcs0: SUCCESS (0.082s)
[338.153820] Starting dynamic subtest: bcs0
[338.220770] Dynamic subtest bcs0: SUCCESS (0.075s)
[338.230291] Starting dynamic subtest: vcs0
[338.285453] Dynamic subtest vcs0: SUCCESS (0.064s)
[338.294325] Starting dynamic subtest: vcs1
[338.342891] Dynamic subtest vcs1: SUCCESS (0.056s)
[338.352508] Starting dynamic subtest: vecs0
[338.400061] Dynamic subtest vecs0: SUCCESS (0.056s)
[338.409185] Starting dynamic subtest: ccs0
[338.491647] Dynamic subtest ccs0: SUCCESS (0.092s)
[338.493902] Subtest preempt-contexts: SUCCESS (0.430s)
[340.057888] [055/133] (678s left) gem_exec_suspend (basic)
[340.118448] Starting subtest: basic
[340.121024] Starting dynamic subtest: smem
[341.909392] Dynamic subtest smem: SUCCESS (1.789s)
[341.912526] Subtest basic: SUCCESS (1.791s)
[342.120622] [056/133] (676s left) kms_feature_discovery (psr1)
[342.215988] Starting subtest: psr1
[342.218315] Subtest psr1: SUCCESS (0.000s)
[342.298915] [057/133] (676s left) kms_psr (psr2-no-drrs)
[342.389345] Starting subtest: psr2-no-drrs
[342.391558] Starting dynamic subtest: eDP-1
[343.951697] Dynamic subtest eDP-1: SUCCESS (1.561s)
[343.954061] Subtest psr2-no-drrs: SUCCESS (1.562s)
[344.755595] [058/133] (673s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[344.844474] Starting subtest: fbc-tiling-linear
[348.602938] Subtest fbc-tiling-linear: SUCCESS (3.762s)
[349.784776] [059/133] (668s left) sysfs_timeslice_duration (idempotent)
[349.853049] Starting subtest: idempotent
[349.855375] Starting dynamic subtest: vecs0
[349.857626] Dynamic subtest vecs0: SUCCESS (0.000s)
[349.865830] Starting dynamic subtest: ccs0
[349.868094] Dynamic subtest ccs0: SUCCESS (0.000s)
[349.876074] Starting dynamic subtest: vcs0
[349.878256] Dynamic subtest vcs0: SUCCESS (0.000s)
[349.885990] Starting dynamic subtest: bcs0
[349.888242] Dynamic subtest bcs0: SUCCESS (0.000s)
[349.895805] Starting dynamic subtest: rcs0
[349.897988] Dynamic subtest rcs0: SUCCESS (0.000s)
[349.905812] Starting dynamic subtest: vcs1
[349.907758] Dynamic subtest vcs1: SUCCESS (0.000s)
[349.909650] Subtest idempotent: SUCCESS (0.006s)
[349.985822] [060/133] (668s left) syncobj_timeline (single-wait-signaled)
[350.038537] Starting subtest: single-wait-signaled
[350.040482] Subtest single-wait-signaled: SUCCESS (0.000s)
[350.150149] [061/133] (668s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[350.257384] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[351.200240] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.944s)
[351.345529] [062/133] (667s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[351.448023] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[351.452491] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[351.564533] [063/133] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[351.656389] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[358.178319] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.522s)
[358.315047] [064/133] (660s left) gem_userptr_blits (dmabuf-sync)
[358.374892] Starting subtest: dmabuf-sync
[358.379363] Subtest dmabuf-sync: SKIP (0.002s)
[358.530259] [065/133] (660s left) gem_watchdog (default-physical)
[358.598705] Starting subtest: default-physical
[360.353882] Subtest default-physical: SUCCESS (1.768s)
[360.446477] [066/133] (658s left) template (b)
[360.492998] Starting subtest: B
[360.495177] Subtest B: SUCCESS (0.000s)
[360.619135] [067/133] (658s left) gem_exec_balancer (noheartbeat)
[360.879269] Starting subtest: noheartbeat
[360.884041] Subtest noheartbeat: SKIP (0.000s)
[360.992568] [068/133] (657s left) kms_colorop (plane-xr24-xr24-ctm_3x4_bt709_enc)
[361.129121] Subtest plane-XR24-XR24-ctm_3x4_bt709_enc: SKIP (0.000s)
[361.211086] [069/133] (657s left) kms_vrr (lobf)
[361.316591] Starting subtest: lobf
[361.320877] Subtest lobf: SKIP (0.000s)
[361.413625] [070/133] (657s left) kms_lease (empty-lease)
[361.500142] Starting subtest: empty-lease
[361.502486] Starting dynamic subtest: pipe-A-eDP-1
[361.504796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[361.513446] Starting dynamic subtest: pipe-B-eDP-1
[361.515672] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[361.523804] Starting dynamic subtest: pipe-C-eDP-1
[361.526061] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[361.533890] Starting dynamic subtest: pipe-D-eDP-1
[361.536113] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[361.538277] Subtest empty-lease: SUCCESS (0.008s)
[361.638615] [071/133] (657s left) gem_mmap (basic-small-bo)
[361.700036] Subtest basic-small-bo: SKIP (0.000s)
[361.769376] [072/133] (657s left) kms_colorop (plane-xr24-xr24-gamma_2_2_inv_oetf-gamma_2_2_oetf)
[361.885469] Subtest plane-XR24-XR24-gamma_2_2_inv_oetf-gamma_2_2_oetf: SKIP (0.000s)
[361.978785] [073/133] (656s left) i915_drm_fdinfo (context-close-stress)
[362.017545] Starting subtest: context-close-stress
[372.760883] Subtest context-close-stress: SUCCESS (10.745s)
[372.873431] [074/133] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[373.091407] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[373.095524] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[373.207628] [075/133] (645s left) gem_lmem_swapping (verify)
[373.245803] Subtest verify: SKIP (0.000s)
[373.290903] [076/133] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[373.388917] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[373.393305] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[373.527720] [077/133] (645s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[373.591418] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[373.596089] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[373.797598] [078/133] (645s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[373.891660] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[373.903507] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[374.004272] [079/133] (645s left) gem_mmap_wc (read-write)
[374.069097] Subtest read-write: SKIP (0.000s)
[374.132052] [080/133] (645s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[374.231659] Starting subtest: psr-modesetfrombusy
[380.387336] Subtest psr-modesetfrombusy: SUCCESS (6.160s)
[380.549634] [081/133] (638s left) perf (invalid-remove-userspace-config)
[380.646108] Starting subtest: invalid-remove-userspace-config
[380.655193] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[380.699075] [082/133] (638s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[380.803520] Starting subtest: y-tiled-8bpp-rotate-270
[380.807266] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[380.907548] [083/133] (638s left) gem_mmap_wc (read)
[380.965341] Subtest read: SKIP (0.000s)
[381.028078] [084/133] (638s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[381.122977] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[381.125050] Starting dynamic subtest: pipe-A-eDP-1
[381.141928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[381.151664] Starting dynamic subtest: pipe-B-eDP-1
[381.169065] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[381.182385] Starting dynamic subtest: pipe-C-eDP-1
[381.200264] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[381.213728] Starting dynamic subtest: pipe-D-eDP-1
[381.231186] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[381.233195] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[383.483222] [085/133] (635s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[383.608508] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[385.022501] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.414s)
[385.843993] [086/133] (633s left) gem_softpin (allocator-fork)
[385.898611] Starting subtest: allocator-fork
[388.112313] Subtest allocator-fork: SUCCESS (2.212s)
[388.264230] [087/133] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[388.368419] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[395.153095] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.788s)
[395.300144] [088/133] (624s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[395.358553] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[395.413111] [089/133] (624s left) gem_softpin (invalid)
[395.463131] Starting subtest: invalid
[395.471079] Subtest invalid: SUCCESS (0.006s)
[395.651186] [090/133] (623s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[395.710835] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[395.818382] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[395.917951] [091/133] (623s left) kms_pm_backlight (fade)
[396.006234] Starting subtest: fade
[396.054882] Starting dynamic subtest: eDP-1
[398.725428] Dynamic subtest eDP-1: SUCCESS (2.674s)
[398.727847] Subtest fade: SUCCESS (2.722s)
[399.593539] [092/133] (620s left) vgem_basic (dmabuf-export)
[399.638614] Starting subtest: dmabuf-export
[399.686390] Subtest dmabuf-export: SUCCESS (0.049s)
[399.820408] [093/133] (619s left) kms_plane_multiple (2x-tiling-none)
[399.919049] Starting subtest: 2x-tiling-none
[399.923201] Subtest 2x-tiling-none: SKIP (0.000s)
[400.002130] [094/133] (619s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[400.099439] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[400.103616] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[400.227373] [095/133] (619s left) kms_flip (absolute-wf_vblank)
[400.327592] Starting subtest: absolute-wf_vblank
[400.329963] Starting dynamic subtest: A-eDP1
[409.045827] Dynamic subtest A-eDP1: SUCCESS (8.720s)
[409.054441] Starting dynamic subtest: B-eDP1
[417.776949] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[417.785501] Starting dynamic subtest: C-eDP1
[426.486830] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[426.496873] Starting dynamic subtest: D-eDP1
[435.217032] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[435.219729] Subtest absolute-wf_vblank: SUCCESS (34.895s)
[436.451327] [096/133] (583s left) gem_eio (throttle)
[436.671811] Starting subtest: throttle
[436.996658] Subtest throttle: SUCCESS (0.324s)
[437.121479] [097/133] (582s left) kms_psr (fbc-psr-cursor-plane-move)
[437.215794] Starting subtest: fbc-psr-cursor-plane-move
[437.218080] Starting dynamic subtest: eDP-1
[437.222350] Dynamic subtest eDP-1: SKIP (0.000s)
[437.226562] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[437.298609] [098/133] (582s left) kms_colorop (plane-xr30-xr30-ctm_3x4_bt709_enc)
[437.425885] Subtest plane-XR30-XR30-ctm_3x4_bt709_enc: SKIP (0.000s)
[437.504321] [099/133] (582s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[437.568220] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[437.673184] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[437.761474] [100/133] (582s left) kms_cursor_crc (cursor-sliding-32x10)
[437.921137] Starting subtest: cursor-sliding-32x10
[437.966863] Subtest cursor-sliding-32x10: SKIP (0.044s)
[438.276879] [101/133] (581s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[443.398622] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[443.400984] Starting dynamic subtest: pipe-A-eDP-1
[449.927954] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.524s)
[449.942349] Starting dynamic subtest: pipe-B-eDP-1
[456.580244] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.651s)
[456.582835] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.181s)
[457.466180] [102/133] (562s left) syncobj_wait (wait-delayed-signal)
[457.521614] Starting subtest: wait-delayed-signal
[457.627061] Subtest wait-delayed-signal: SUCCESS (0.104s)
[457.712074] [103/133] (562s left) kms_atomic_interruptible (legacy-cursor)
[457.806680] Starting subtest: legacy-cursor
[457.808960] Starting dynamic subtest: pipe-A-eDP-1
[465.175550] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.368s)
[465.177808] Subtest legacy-cursor: SUCCESS (7.370s)
[466.047971] [104/133] (554s left) perf (disabled-read-error)
[466.131661] Starting subtest: disabled-read-error
[466.145612] Subtest disabled-read-error: SUCCESS (0.013s)
[466.189957] [105/133] (554s left) gem_mmap_gtt (basic-small-copy-xy)
[466.250065] Subtest basic-small-copy-XY: SKIP (0.000s)
[466.309459] [106/133] (553s left) i915_query (query-topology-garbage-items)
[466.370974] Starting subtest: query-topology-garbage-items
[466.373319] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[466.500376] [107/133] (553s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[466.598775] Starting subtest: fbcpsr-rgb565-draw-blt
[473.686592] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.091s)
[473.845209] [108/133] (546s left) kms_async_flips (async-flip-suspend-resume)
[473.939814] Starting subtest: async-flip-suspend-resume
[474.319835] Starting dynamic subtest: pipe-A-eDP-1
[475.544101] Dynamic subtest pipe-A-eDP-1: FAIL (0.750s)
[475.554092] Starting dynamic subtest: pipe-B-eDP-1
[476.456302] Dynamic subtest pipe-B-eDP-1: FAIL (0.736s)
[476.579841] Starting dynamic subtest: pipe-C-eDP-1
[494.245429] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.987s)
[494.618027] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[494.622827] Starting dynamic subtest: pipe-D-eDP-1
[512.213648] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.870s)
[512.215883] Subtest async-flip-suspend-resume: FAIL (8.856s)
[513.446777] [FACT kms_async_flips (async-flip-suspend-resume)] new: kernel.is_tainted.taint_warn: true
[513.447610] 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_atomic_interruptible
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 109/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 110/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 111/ for test: gem_lmem_swapping
results: no output, setting notrun
results: parsing output: 112/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 113/ for test: kms_mmap_write_crc
results: no output, setting notrun
results: parsing output: 114/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 115/ for test: kms_properties
results: no output, setting notrun
results: parsing output: 116/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 117/ for test: perf_pmu
results: no output, setting notrun
results: parsing output: 118/ for test: kms_psr2_sf
results: no output, setting notrun
results: parsing output: 119/ for test: gem_eio
results: no output, setting notrun
results: parsing output: 120/ for test: syncobj_eventfd
results: no output, setting notrun
results: parsing output: 121/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 122/ for test: kms_psr_stress_test
results: no output, setting notrun
results: parsing output: 123/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 124/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 125/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 126/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 127/ for test: gem_exec_params
results: no output, setting notrun
results: parsing output: 128/ for test: i915_pm_rc6_residency
results: no output, setting notrun
results: parsing output: 129/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 130/ for test: kms_plane_scaling
results: no output, setting notrun
results: parsing output: 131/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 132/ for test: gem_ctx_persistence
results: no output, setting notrun
Done.