[57.068745] Initializing watchdogs
[57.068791]   /dev/watchdog0
[57.083705] [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]
[57.088182] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.090186] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.092160] [001/131] (960s left) i915_pm_rpm (gem-idle)
[59.040447] Starting subtest: gem-idle
[65.239430] Subtest gem-idle: SUCCESS (6.250s)
[65.561301] [002/131] (952s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[66.908086] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[66.909066] Starting dynamic subtest: pipe-A-default-mode
[68.020257] Dynamic subtest pipe-A-default-mode: SKIP (1.114s)
[68.022384] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.115s)
[68.156964] [003/131] (949s left) gem_mmap_wc (write-cpu-read-wc)
[68.204839] Subtest write-cpu-read-wc: SKIP (0.000s)
[68.267889] [004/131] (949s left) gem_ctx_persistence (hostile)
[68.317308] Starting subtest: hostile
[78.476484] Subtest hostile: SUCCESS (10.174s)
[78.619589] [005/131] (939s left) kms_flip (flip-vs-blocking-wf-vblank)
[78.718736] Starting subtest: flip-vs-blocking-wf-vblank
[78.720498] Starting dynamic subtest: A-eDP1
[87.623737] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[87.631647] Starting dynamic subtest: B-eDP1
[96.564293] Dynamic subtest B-eDP1: SUCCESS (8.939s)
[96.570087] Starting dynamic subtest: C-eDP1
[105.484260] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[105.492616] Starting dynamic subtest: D-eDP1
[114.419054] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[114.422686] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.703s)
[115.644017] [006/131] (902s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[115.739393] Starting subtest: y-tiled-16bpp-rotate-0
[115.741355] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[115.882066] [007/131] (901s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[115.983593] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[115.985283] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[116.102757] [008/131] (901s left) gem_workarounds (basic-read-fd)
[116.168057] Starting subtest: basic-read-fd
[116.179225] Subtest basic-read-fd: SUCCESS (0.011s)
[116.340840] [009/131] (901s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[116.440373] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[120.613412] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.173s)
[121.732223] [010/131] (896s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[121.781497] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[121.782413] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[121.872935] [011/131] (896s left) gem_exec_store (cachelines)
[121.934966] Starting subtest: cachelines
[121.936044] Starting dynamic subtest: rcs0
[122.038032] Dynamic subtest rcs0: SUCCESS (0.102s)
[122.046766] Starting dynamic subtest: bcs0
[122.101642] Dynamic subtest bcs0: SUCCESS (0.064s)
[122.109715] Starting dynamic subtest: vcs0
[122.157526] Dynamic subtest vcs0: SUCCESS (0.055s)
[122.166250] Starting dynamic subtest: vcs1
[122.216349] Dynamic subtest vcs1: SUCCESS (0.059s)
[122.222919] Starting dynamic subtest: vecs0
[122.274199] Dynamic subtest vecs0: SUCCESS (0.057s)
[122.282412] Starting dynamic subtest: ccs0
[122.336431] Dynamic subtest ccs0: SUCCESS (0.062s)
[122.337551] Subtest cachelines: SUCCESS (0.401s)
[122.520202] [012/131] (895s left) prime_mmap_kms (buffer-sharing)
[122.617782] Starting subtest: buffer-sharing
[123.075489] Subtest buffer-sharing: SUCCESS (0.457s)
[123.952524] [013/131] (893s left) api_intel_bb (blit-noreloc-purge-cache)
[124.007819] Starting subtest: blit-noreloc-purge-cache
[124.020224] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[124.179855] [014/131] (893s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[124.238325] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[124.309778] [015/131] (893s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[124.418715] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[124.420574] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[124.580347] [016/131] (893s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[124.668139] Starting subtest: fbc-pr-sprite-mmap-gtt
[124.669926] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[124.754392] [017/131] (893s left) gem_pxp (reject-modify-context-protection-on)
[124.865034] Starting subtest: reject-modify-context-protection-on
[124.867375] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[125.006436] [018/131] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[125.100050] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[125.101809] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[125.221398] [019/131] (892s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[125.309435] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[125.321102] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[125.435371] [020/131] (892s left) kms_psr (psr-cursor-mmap-cpu)
[125.516136] Starting subtest: psr-cursor-mmap-cpu
[125.517032] Starting dynamic subtest: eDP-1
[127.249959] Dynamic subtest eDP-1: SUCCESS (1.734s)
[127.250952] Subtest psr-cursor-mmap-cpu: SUCCESS (1.734s)
[128.120313] [021/131] (890s left) kms_chamelium_frames (hdmi-crc-fast)
[128.503624] Subtest hdmi-crc-fast: SKIP (0.000s)
[129.318937] [022/131] (888s left) kms_pm_rpm (modeset-lpsp-stress)
[131.036030] Starting subtest: modeset-lpsp-stress
[146.821268] Subtest modeset-lpsp-stress: SUCCESS (15.784s)
[146.925725] [023/131] (871s left) kms_content_protection (legacy)
[147.070260] Starting subtest: legacy
[147.072364] Subtest legacy: SKIP (0.000s)
[147.241043] [024/131] (871s left) gem_exec_reloc (basic-cpu-wc-active)
[147.288334] Subtest basic-cpu-wc-active: SKIP (0.000s)
[147.350324] [025/131] (870s left) kms_plane (plane-position-hole-dpms)
[147.425983] Starting subtest: plane-position-hole-dpms
[147.938028] Starting dynamic subtest: pipe-A-plane-1
[150.317932] Dynamic subtest pipe-A-plane-1: SUCCESS (2.379s)
[150.324217] Starting dynamic subtest: pipe-A-plane-2
[152.594217] Dynamic subtest pipe-A-plane-2: SUCCESS (2.276s)
[152.599984] Starting dynamic subtest: pipe-A-plane-3
[154.865491] Dynamic subtest pipe-A-plane-3: SUCCESS (2.270s)
[154.871803] Starting dynamic subtest: pipe-A-plane-4
[157.144818] Dynamic subtest pipe-A-plane-4: SUCCESS (2.279s)
[157.150918] Starting dynamic subtest: pipe-A-plane-5
[157.168759] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[158.303971] Starting dynamic subtest: pipe-B-plane-1
[160.574656] Dynamic subtest pipe-B-plane-1: SUCCESS (2.276s)
[160.580456] Starting dynamic subtest: pipe-B-plane-2
[162.841598] Dynamic subtest pipe-B-plane-2: SUCCESS (2.266s)
[162.847060] Starting dynamic subtest: pipe-B-plane-3
[165.091776] Dynamic subtest pipe-B-plane-3: SUCCESS (2.250s)
[165.097755] Starting dynamic subtest: pipe-B-plane-4
[167.399703] Dynamic subtest pipe-B-plane-4: SUCCESS (2.307s)
[167.405461] Starting dynamic subtest: pipe-B-plane-5
[167.423981] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[167.424995] Subtest plane-position-hole-dpms: SUCCESS (19.997s)
[168.225807] [026/131] (850s left) prime_vgem (basic-blt)
[168.339086] Starting subtest: basic-blt
[168.363595] Subtest basic-blt: SUCCESS (0.024s)
[168.513551] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[168.515364] [027/131] (849s left) gem_exec_fence (syncobj-timeline-export)
[169.039417] Starting subtest: syncobj-timeline-export
[169.044247] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[170.075365] [028/131] (848s left) gem_exec_schedule (u-lateslice)
[170.131953] Starting subtest: u-lateslice
[170.132841] Starting dynamic subtest: rcs0
[170.155252] Dynamic subtest rcs0: SUCCESS (0.023s)
[170.162876] Starting dynamic subtest: bcs0
[170.172491] Dynamic subtest bcs0: SUCCESS (0.017s)
[170.178428] Starting dynamic subtest: vcs0
[170.191350] Dynamic subtest vcs0: SUCCESS (0.019s)
[170.196981] Starting dynamic subtest: vcs1
[170.208054] Dynamic subtest vcs1: SUCCESS (0.016s)
[170.213895] Starting dynamic subtest: vecs0
[170.225430] Dynamic subtest vecs0: SUCCESS (0.017s)
[170.231505] Starting dynamic subtest: ccs0
[170.242742] Dynamic subtest ccs0: SUCCESS (0.017s)
[170.243624] Subtest u-lateslice: SUCCESS (0.111s)
[172.046464] [029/131] (846s left) i915_drm_fdinfo (virtual-busy-idle)
[172.078150] Starting subtest: virtual-busy-idle
[172.080270] Subtest virtual-busy-idle: SKIP (0.000s)
[172.164844] [030/131] (846s left) kms_lease (lease-again)
[172.256145] Starting subtest: lease-again
[172.256992] Starting dynamic subtest: pipe-A-eDP-1
[172.257835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[172.263839] Starting dynamic subtest: pipe-B-eDP-1
[172.264865] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[172.270835] Starting dynamic subtest: pipe-C-eDP-1
[172.271684] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[172.277204] Starting dynamic subtest: pipe-D-eDP-1
[172.278102] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[172.278914] Subtest lease-again: SUCCESS (0.011s)
[172.369090] [031/131] (846s left) gem_eio (create-ext)
[172.578799] Starting subtest: create-ext
[172.898634] Subtest create-ext: SUCCESS (0.319s)
[173.045484] [032/131] (845s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[178.098843] Starting subtest: pr-cursor-plane-move-continuous-sf
[178.101595] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[178.962543] [033/131] (839s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[179.007637] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[179.116109] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[179.194114] [034/131] (839s left) kms_flip (modeset-vs-vblank-race)
[179.275854] Starting subtest: modeset-vs-vblank-race
[179.277997] Starting dynamic subtest: A-eDP1
[183.971085] Dynamic subtest A-eDP1: SUCCESS (4.693s)
[183.980370] Starting dynamic subtest: B-eDP1
[188.703056] Dynamic subtest B-eDP1: SUCCESS (4.730s)
[188.711709] Starting dynamic subtest: C-eDP1
[193.321595] Dynamic subtest C-eDP1: SUCCESS (4.617s)
[193.329183] Starting dynamic subtest: D-eDP1
[197.863059] Dynamic subtest D-eDP1: SUCCESS (4.540s)
[197.866338] Subtest modeset-vs-vblank-race: SUCCESS (18.590s)
[199.031166] [035/131] (819s left) kms_vblank (query-forked-busy)
[199.115852] Starting subtest: query-forked-busy
[199.118210] Starting dynamic subtest: pipe-A-eDP-1
[200.991527] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s)
[200.999663] Starting dynamic subtest: pipe-D-eDP-1
[203.579148] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.586s)
[203.579937] Subtest query-forked-busy: SUCCESS (4.463s)
[204.390528] [036/131] (814s left) kms_atomic_interruptible (legacy-setmode)
[204.480560] Starting subtest: legacy-setmode
[204.481515] Starting dynamic subtest: pipe-A-eDP-1
[211.370359] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.887s)
[211.371231] Subtest legacy-setmode: SUCCESS (6.889s)
[212.262195] [037/131] (806s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[212.348297] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[212.349174] Starting dynamic subtest: pipe-A-eDP-1
[212.357570] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[212.365311] Starting dynamic subtest: pipe-B-eDP-1
[212.373863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[212.379984] Starting dynamic subtest: pipe-C-eDP-1
[212.388431] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[212.394108] Starting dynamic subtest: pipe-D-eDP-1
[212.402539] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[212.404197] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[214.525531] [038/131] (804s left) gem_mmap_gtt (cpuset-big-copy)
[214.570926] Subtest cpuset-big-copy: SKIP (0.000s)
[214.629053] [039/131] (804s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[214.714714] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[214.715719] Starting dynamic subtest: pipe-A-eDP-1
[216.729067] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.015s)
[216.736622] Starting dynamic subtest: pipe-B-eDP-1
[218.768306] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.038s)
[218.775707] Starting dynamic subtest: pipe-C-eDP-1
[220.773336] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.004s)
[220.781215] Starting dynamic subtest: pipe-D-eDP-1
[222.788867] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.014s)
[222.789880] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.076s)
[223.958842] [040/131] (794s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[224.068164] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[224.776276] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.500s)
[224.803256] [041/131] (793s left) syncobj_timeline (signal-point-0)
[224.847544] Starting subtest: signal-point-0
[224.848787] Subtest signal-point-0: SUCCESS (0.000s)
[224.964137] [042/131] (793s left) syncobj_basic (test-valid-cycle)
[225.011030] Starting subtest: test-valid-cycle
[225.011968] Subtest test-valid-cycle: SUCCESS (0.000s)
[225.117376] [043/131] (793s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[225.202501] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[225.567568] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[228.321265] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.751s)
[228.327427] Starting dynamic subtest: pipe-A-eDP-1-4
[230.507977] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.186s)
[230.514214] Starting dynamic subtest: pipe-A-eDP-1-4
[232.517709] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[232.523971] Starting dynamic subtest: pipe-A-eDP-1-x
[234.708048] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[235.069504] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[237.853546] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[237.862303] Starting dynamic subtest: pipe-B-eDP-1-4
[240.039832] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[240.048513] Starting dynamic subtest: pipe-B-eDP-1-4
[242.049888] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[242.058387] Starting dynamic subtest: pipe-B-eDP-1-x
[244.251322] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[244.620215] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[247.383760] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[247.393083] Starting dynamic subtest: pipe-C-eDP-1-4
[249.559435] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[249.571658] Starting dynamic subtest: pipe-C-eDP-1-4
[251.570038] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[251.579041] Starting dynamic subtest: pipe-C-eDP-1-x
[253.759857] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[254.118604] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[256.914856] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.802s)
[256.921327] Starting dynamic subtest: pipe-D-eDP-1-4
[259.089978] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[259.097028] Starting dynamic subtest: pipe-D-eDP-1-4
[261.100467] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[261.109920] Starting dynamic subtest: pipe-D-eDP-1-x
[263.278890] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[263.280138] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.074s)
[264.507828] [044/131] (754s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[264.602858] Starting subtest: fbcpsr-tiling-y
[264.604763] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[264.725599] [045/131] (754s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[265.022064] Starting subtest: cursor-rapid-movement-max-size
[265.024823] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[265.202819] [046/131] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[265.292882] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[265.294938] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[265.426542] [047/131] (753s left) gem_shrink (reclaim)
[265.476794] Starting subtest: reclaim
[267.926920] Subtest reclaim: SUCCESS (2.448s)
[268.087495] [048/131] (750s left) kms_psr (fbc-psr-primary-mmap-gtt)
[268.187915] Starting subtest: fbc-psr-primary-mmap-gtt
[268.188887] Starting dynamic subtest: eDP-1
[268.190666] Dynamic subtest eDP-1: SKIP (0.000s)
[268.192436] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[268.268310] [049/131] (750s left) gem_exec_capture (capture-invisible)
[268.332075] Starting subtest: capture-invisible
[268.333061] Starting dynamic subtest: smem0
[268.334897] Dynamic subtest smem0: SKIP (0.000s)
[268.336705] Subtest capture-invisible: SKIP (0.001s)
[268.463571] [050/131] (750s left) gem_partial_pwrite_pread (writes-after-reads-display)
[268.525588] Subtest writes-after-reads-display: SKIP (0.000s)
[268.596582] [051/131] (750s left) perf_pmu (init-wait)
[268.629295] Starting subtest: init-wait
[268.630197] Starting dynamic subtest: rcs0
[268.632335] Dynamic subtest rcs0: SUCCESS (0.002s)
[268.639085] Starting dynamic subtest: bcs0
[268.639946] Dynamic subtest bcs0: SUCCESS (0.000s)
[268.645872] Starting dynamic subtest: vcs0
[268.646825] Dynamic subtest vcs0: SUCCESS (0.001s)
[268.652786] Starting dynamic subtest: vcs1
[268.653614] Dynamic subtest vcs1: SUCCESS (0.001s)
[268.659469] Starting dynamic subtest: vecs0
[268.660299] Dynamic subtest vecs0: SUCCESS (0.000s)
[268.666186] Starting dynamic subtest: ccs0
[268.667025] Dynamic subtest ccs0: SUCCESS (0.000s)
[268.667850] Subtest init-wait: SUCCESS (0.007s)
[268.736029] [052/131] (750s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[268.814708] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[268.816719] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[269.941329] [053/131] (749s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[270.033303] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[270.043393] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[270.180395] [054/131] (749s left) kms_cursor_edge_walk (128x128-left-edge)
[270.263317] Starting subtest: 128x128-left-edge
[270.264261] Starting dynamic subtest: pipe-A-eDP-1
[273.691605] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s)
[273.699450] Starting dynamic subtest: pipe-D-eDP-1
[276.838073] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.144s)
[276.839095] Subtest 128x128-left-edge: SUCCESS (6.576s)
[277.657296] [055/131] (741s left) i915_query (query-topology-garbage-items)
[277.704355] Starting subtest: query-topology-garbage-items
[277.705213] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[277.845302] [056/131] (741s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[277.946985] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[278.870033] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.923s)
[278.997390] [057/131] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[279.095962] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[286.362107] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.267s)
[286.537046] [058/131] (732s left) kms_atomic (plane-cursor-legacy)
[286.631469] Starting subtest: plane-cursor-legacy
[286.632478] Starting dynamic subtest: pipe-A-eDP-1
[287.006179] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s)
[287.007057] Subtest plane-cursor-legacy: SUCCESS (0.375s)
[287.886606] [059/131] (731s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[287.975922] Starting subtest: x-tiled-16bpp-rotate-270
[287.995781] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[288.149573] [060/131] (731s left) kms_psr (psr2-cursor-blt)
[288.236247] Starting subtest: psr2-cursor-blt
[288.237121] Starting dynamic subtest: eDP-1
[289.944703] Dynamic subtest eDP-1: SUCCESS (1.708s)
[289.945799] Subtest psr2-cursor-blt: SUCCESS (1.708s)
[290.761432] [061/131] (728s left) gem_reg_read (timestamp-moving)
[290.822181] Starting subtest: timestamp-moving
[291.827394] Subtest timestamp-moving: SUCCESS (1.001s)
[291.905405] [062/131] (727s left) gem_exec_reloc (basic-write-read)
[291.964032] Subtest basic-write-read: SKIP (0.000s)
[292.040725] [063/131] (727s left) gem_ctx_engines (invalid-engines)
[292.094867] Starting subtest: invalid-engines
[292.102944] Subtest invalid-engines: SUCCESS (0.008s)
[292.364513] [064/131] (727s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[292.460278] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[299.805086] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.345s)
[299.959063] [065/131] (719s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[300.020973] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[300.023114] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[300.206648] [066/131] (719s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[305.260516] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[305.261800] Starting dynamic subtest: pipe-A-eDP-1
[306.058137] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s)
[306.066593] Starting dynamic subtest: pipe-B-eDP-1
[307.193083] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[307.195100] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.932s)
[308.381491] [067/131] (711s left) gem_partial_pwrite_pread (write)
[308.437293] Subtest write: SKIP (0.000s)
[308.500762] [068/131] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[308.602669] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[308.604593] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[308.728946] [069/131] (710s left) drm_read (invalid-buffer)
[308.876300] Starting subtest: invalid-buffer
[308.877477] Subtest invalid-buffer: SUCCESS (0.000s)
[309.007112] [070/131] (710s left) kms_frontbuffer_tracking (psr-1p-rte)
[309.104266] Starting subtest: psr-1p-rte
[314.434310] Subtest psr-1p-rte: SUCCESS (5.332s)
[314.574153] [071/131] (705s left) kms_hdr (static-toggle-suspend)
[314.657455] Starting subtest: static-toggle-suspend
[314.660042] Subtest static-toggle-suspend: SKIP (0.000s)
[314.734721] [072/131] (705s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[314.834662] Starting subtest: 4-tiled-8bpp-rotate-0
[315.913032] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.079s)
[316.056392] [073/131] (703s left) gem_softpin (invalid)
[316.106577] Starting subtest: invalid
[316.112648] Subtest invalid: SUCCESS (0.006s)
[316.260465] [074/131] (703s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[316.346050] Starting subtest: coverage-vs-premult-vs-constant
[316.640478] Starting dynamic subtest: pipe-A-eDP-1
[317.183073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[317.189824] Starting dynamic subtest: pipe-D-eDP-1
[318.478199] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[318.479081] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.131s)
[319.370255] [075/131] (700s left) gem_exec_whisper (basic-queues)
[319.426149] Starting subtest: basic-queues
[326.904439] Subtest basic-queues: SUCCESS (7.474s)
[327.102764] [076/131] (692s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[327.205237] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[331.193940] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.989s)
[332.376203] [077/131] (687s left) core_debugfs (read-all-entries)
[332.424129] Starting subtest: read-all-entries
[332.503786] Subtest read-all-entries: SUCCESS (0.081s)
[332.575319] [078/131] (687s left) vgem_basic (sysfs)
[332.612530] Starting subtest: sysfs
[332.613747] Subtest sysfs: SUCCESS (0.000s)
[332.679290] [079/131] (687s left) gen9_exec_parse (bb-oversize)
[332.726083] Subtest bb-oversize: SKIP (0.000s)
[332.803019] [080/131] (687s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[332.858422] Subtest no-spare-fences-busy: SKIP (0.000s)
[332.947244] [081/131] (687s left) gem_softpin (evict-single-offset)
[332.997556] Starting subtest: evict-single-offset
[357.913951] Subtest evict-single-offset: SUCCESS (24.912s)
[358.000757] [082/131] (662s left) fbdev (info)
[358.064797] Starting subtest: info
[358.065860] Subtest info: SUCCESS (0.000s)
[358.155442] [083/131] (662s left) perf_pmu (busy-idle-no-semaphores)
[358.189050] Starting subtest: busy-idle-no-semaphores
[358.190164] Starting dynamic subtest: rcs0
[358.869402] Dynamic subtest rcs0: SUCCESS (0.677s)
[358.879530] Starting dynamic subtest: bcs0
[359.523660] Dynamic subtest bcs0: SUCCESS (0.651s)
[359.533837] Starting dynamic subtest: vcs0
[360.176688] Dynamic subtest vcs0: SUCCESS (0.650s)
[360.185762] Starting dynamic subtest: vcs1
[361.534730] Dynamic subtest vcs1: SUCCESS (1.356s)
[361.542556] Starting dynamic subtest: vecs0
[363.520452] Dynamic subtest vecs0: SUCCESS (1.984s)
[363.530899] Starting dynamic subtest: ccs0
[365.505255] Dynamic subtest ccs0: SUCCESS (1.982s)
[365.507206] Subtest busy-idle-no-semaphores: SUCCESS (7.314s)
[365.656216] [084/131] (654s left) kms_fbcon_fbt (psr)
[365.706542] Starting subtest: psr
[373.092761] Subtest psr: SUCCESS (7.382s)
[373.182082] [085/131] (647s left) syncobj_timeline (wait-all-for-submit-snapshot)
[373.231432] Starting subtest: wait-all-for-submit-snapshot
[373.313952] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[373.405513] [086/131] (646s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[373.494692] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[373.496407] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[373.593411] [087/131] (646s left) syncobj_wait (multi-wait-for-submit-submitted)
[373.640905] Starting subtest: multi-wait-for-submit-submitted
[373.747761] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[373.830335] [088/131] (646s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[373.944237] Starting subtest: cursorB-vs-flipA-legacy
[373.947054] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[374.096043] [089/131] (646s left) gem_wait (await)
[374.155451] Starting subtest: await
[374.156425] Starting dynamic subtest: all-engines
[375.280727] Dynamic subtest all-engines: SUCCESS (1.124s)
[375.291513] Starting dynamic subtest: rcs0
[376.344371] Dynamic subtest rcs0: SUCCESS (1.062s)
[376.358507] Starting dynamic subtest: bcs0
[377.402983] Dynamic subtest bcs0: SUCCESS (1.057s)
[377.418943] Starting dynamic subtest: vcs0
[378.458318] Dynamic subtest vcs0: SUCCESS (1.053s)
[378.474851] Starting dynamic subtest: vcs1
[379.512305] Dynamic subtest vcs1: SUCCESS (1.052s)
[379.528407] Starting dynamic subtest: vecs0
[380.565104] Dynamic subtest vecs0: SUCCESS (1.051s)
[380.580918] Starting dynamic subtest: ccs0
[381.623048] Dynamic subtest ccs0: SUCCESS (1.055s)
[381.624330] Subtest await: SUCCESS (7.468s)
[381.842629] [090/131] (638s left) gem_softpin (noreloc-s3)
[381.892526] Starting subtest: noreloc-S3
[402.715630] Subtest noreloc-S3: SUCCESS (5.419s)
[405.873297] [091/131] (617s left) kms_plane_scaling (planes-upscale-factor-0-25)
[405.961173] Starting subtest: planes-upscale-factor-0-25
[405.962048] Starting dynamic subtest: pipe-A
[406.021325] Dynamic subtest pipe-A: SUCCESS (0.063s)
[406.030792] Starting dynamic subtest: pipe-B
[407.138625] Dynamic subtest pipe-B: SUCCESS (1.155s)
[407.148829] Starting dynamic subtest: pipe-C
[408.230060] Dynamic subtest pipe-C: SUCCESS (1.122s)
[408.240523] Starting dynamic subtest: pipe-D
[409.317106] Dynamic subtest pipe-D: SUCCESS (1.113s)
[409.318043] Subtest planes-upscale-factor-0-25: SUCCESS (3.456s)
[410.465509] [092/131] (613s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[410.561104] Starting subtest: fbc-psr2-primary-mmap-cpu
[410.562048] Starting dynamic subtest: eDP-1
[410.563699] Dynamic subtest eDP-1: SKIP (0.000s)
[410.565363] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[410.654062] [093/131] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[410.745522] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[410.747131] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[410.887811] [094/131] (612s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[410.948214] Subtest writes-after-reads-uncached: SKIP (0.000s)
[411.026923] [095/131] (612s left) kms_cursor_crc (cursor-offscreen-64x21)
[411.215966] Starting subtest: cursor-offscreen-64x21
[411.253241] Subtest cursor-offscreen-64x21: SKIP (0.036s)
[411.509128] [096/131] (612s left) kms_selftest (drm_framebuffer)
[411.542590] Starting subtest: drm_framebuffer
[411.591788] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[411.684075] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.094s)
[411.694072] Starting dynamic subtest: drm_test_framebuffer_cleanup
[411.791190] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.109s)
[411.801712] Starting dynamic subtest: drm_test_framebuffer_create
[411.983412] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.193s)
[411.991968] Starting dynamic subtest: drm_test_framebuffer_free
[412.175063] Dynamic subtest drm_test_framebuffer_free: FAIL (0.180s)
[412.176780] Subtest drm_framebuffer: FAIL (0.628s)
[412.326256] Aborting: Kernel badly tainted (0x40244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[412.342705] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[412.343539] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rpm
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: gem_mmap_wc
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_workarounds
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_exec_store
results: parsing output: 11/ for test: prime_mmap_kms
results: parsing output: 12/ for test: api_intel_bb
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_chamelium_frames
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: prime_vgem
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: kms_lease
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: kms_atomic_interruptible
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: syncobj_basic
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_shrink
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_exec_capture
results: parsing output: 49/ for test: gem_partial_pwrite_pread
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_reg_read
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: gem_ctx_engines
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: gem_partial_pwrite_pread
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: drm_read
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_hdr
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_plane_alpha_blend
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: core_debugfs
results: parsing output: 77/ for test: vgem_basic
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: gem_fenced_exec_thrash
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: fbdev
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_fbcon_fbt
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_wait
results: parsing output: 89/ for test: gem_softpin
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_partial_pwrite_pread
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_selftest
results: parsing output: 96/ for test: kms_tv_load_detect
results: no output, setting notrun
results: parsing output: 97/ for test: gem_softpin
results: no output, setting notrun
results: parsing output: 98/ for test: kms_hdr
results: no output, setting notrun
results: parsing output: 99/ for test: kms_writeback
results: no output, setting notrun
results: parsing output: 100/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 101/ for test: gem_mmap_wc
results: no output, setting notrun
results: parsing output: 102/ for test: core_getversion
results: no output, setting notrun
results: parsing output: 103/ for test: gem_exec_flush
results: no output, setting notrun
results: parsing output: 104/ for test: i915_drm_fdinfo
results: no output, setting notrun
results: parsing output: 105/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 106/ for test: kms_pipe_stress
results: no output, setting notrun
results: parsing output: 107/ for test: syncobj_basic
results: no output, setting notrun
results: parsing output: 108/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 109/ for test: kms_chamelium_hpd
results: no output, setting notrun
results: parsing output: 110/ for test: gem_wait
results: no output, setting notrun
results: parsing output: 111/ for test: kms_pipe_crc_basic
results: no output, setting notrun
results: parsing output: 112/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 113/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 114/ for test: gem_ctx_exec
results: no output, setting notrun
results: parsing output: 115/ for test: kms_feature_discovery
results: no output, setting notrun
results: parsing output: 116/ for test: sysfs_timeslice_duration
results: no output, setting notrun
results: parsing output: 117/ for test: kms_chamelium_color
results: no output, setting notrun
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 119/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 121/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 122/ for test: kms_pm_rpm
results: no output, setting notrun
results: parsing output: 123/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 124/ for test: kms_addfb_basic
results: no output, setting notrun
results: parsing output: 125/ for test: kms_big_fb
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: gem_madvise
results: no output, setting notrun
results: parsing output: 128/ for test: gem_exec_balancer
results: no output, setting notrun
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 130/ for test: syncobj_timeline
results: no output, setting notrun
Done.