[63.729020] Initializing watchdogs
[63.729085]   /dev/watchdog0
[63.742621] [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]
[63.746788] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.748935] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.752798] [001/134] (960s left) kms_async_flips (test-time-stamp)
[63.895081] Starting subtest: test-time-stamp
[64.267279] Starting dynamic subtest: pipe-A-eDP-1
[65.112984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.841s)
[65.493087] Starting dynamic subtest: pipe-B-eDP-1
[66.253918] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[66.643588] Starting dynamic subtest: pipe-C-eDP-1
[67.411255] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[67.792727] Starting dynamic subtest: pipe-D-eDP-1
[68.551847] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.761s)
[68.554092] Subtest test-time-stamp: SUCCESS (4.641s)
[69.741112] [002/134] (954s left) kms_properties (plane-properties-legacy)
[69.838419] Starting subtest: plane-properties-legacy
[69.840632] Starting dynamic subtest: pipe-A-eDP-1
[70.412678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[70.419317] Starting dynamic subtest: pipe-B-eDP-1
[71.694533] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.276s)
[71.703621] Starting dynamic subtest: pipe-C-eDP-1
[72.929019] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[72.939970] Starting dynamic subtest: pipe-D-eDP-1
[74.167394] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[74.169720] Subtest plane-properties-legacy: SUCCESS (4.323s)
[74.978058] [003/134] (949s left) gem_create (create-clear)
[75.023670] Starting subtest: create-clear
[75.025704] Starting dynamic subtest: smem0
[107.847074] Dynamic subtest smem0: SUCCESS (32.802s)
[107.850569] Subtest create-clear: SUCCESS (32.803s)
[108.047952] [004/134] (916s left) gem_exec_fence (keep-in-fence)
[108.241084] Starting subtest: keep-in-fence
[108.243915] Starting dynamic subtest: rcs0
[108.332986] Dynamic subtest rcs0: SUCCESS (0.092s)
[108.341873] Starting dynamic subtest: bcs0
[108.388554] Dynamic subtest bcs0: SUCCESS (0.055s)
[108.398320] Starting dynamic subtest: vcs0
[109.911587] Dynamic subtest vcs0: SUCCESS (1.520s)
[109.921891] Starting dynamic subtest: vcs1
[111.893250] Dynamic subtest vcs1: SUCCESS (1.980s)
[111.901716] Starting dynamic subtest: vecs0
[113.941950] Dynamic subtest vecs0: SUCCESS (2.047s)
[113.951731] Starting dynamic subtest: ccs0
[114.186769] Dynamic subtest ccs0: SUCCESS (0.245s)
[114.189854] Subtest keep-in-fence: SUCCESS (5.945s)
[116.027203] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[116.030304] [005/134] (908s left) api_intel_bb (offset-control)
[116.093053] Starting subtest: offset-control
[116.113619] Subtest offset-control: SUCCESS (0.020s)
[116.249243] [006/134] (908s left) gem_ctx_param (set-priority-range)
[116.311723] Starting subtest: set-priority-range
[116.326322] Subtest set-priority-range: SUCCESS (0.015s)
[116.463602] [007/134] (908s left) gem_exec_flush (basic-batch-kernel-default-uc)
[116.526644] Starting subtest: basic-batch-kernel-default-uc
[122.684201] Subtest basic-batch-kernel-default-uc: SUCCESS (6.157s)
[122.895563] [008/134] (901s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[127.963777] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[127.966175] Starting dynamic subtest: pipe-A-eDP-1
[145.155210] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.187s)
[145.164052] Starting dynamic subtest: pipe-B-eDP-1
[162.294374] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.138s)
[162.296666] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.329s)
[163.103147] [009/134] (861s left) gem_exec_balancer (full)
[163.176264] Starting subtest: full
[167.782593] Subtest full: SUCCESS (4.608s)
[168.065244] [010/134] (856s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[168.183066] Starting subtest: crc-primary-basic-yf-tiled-ccs
[168.185412] Starting dynamic subtest: pipe-A-eDP-1
[168.208322] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[168.218130] Starting dynamic subtest: pipe-B-eDP-1
[168.239832] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[168.246603] Starting dynamic subtest: pipe-C-eDP-1
[168.268208] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[168.275031] Starting dynamic subtest: pipe-D-eDP-1
[168.297024] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[168.301369] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.004s)
[170.458245] [011/134] (854s left) gem_exec_schedule (u-independent)
[170.527718] Starting subtest: u-independent
[170.529880] Starting dynamic subtest: rcs0
[171.861661] Dynamic subtest rcs0: SUCCESS (1.342s)
[171.873034] Starting dynamic subtest: vcs0
[173.950881] Dynamic subtest vcs0: SUCCESS (2.088s)
[173.961550] Starting dynamic subtest: vcs1
[175.939841] Dynamic subtest vcs1: SUCCESS (1.988s)
[175.951130] Starting dynamic subtest: vecs0
[177.914947] Dynamic subtest vecs0: SUCCESS (1.974s)
[177.926711] Starting dynamic subtest: ccs0
[179.924302] Dynamic subtest ccs0: SUCCESS (2.008s)
[179.927067] Subtest u-independent: SUCCESS (9.405s)
[180.237135] [012/134] (844s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[180.355430] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[180.359538] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[180.485127] [013/134] (844s left) syncobj_timeline (transfer-timeline-point)
[180.555298] Starting subtest: transfer-timeline-point
[180.557610] Subtest transfer-timeline-point: SUCCESS (0.000s)
[180.681934] [014/134] (844s left) kms_flip (absolute-wf_vblank)
[180.778448] Starting subtest: absolute-wf_vblank
[180.780443] Starting dynamic subtest: A-eDP1
[189.529796] Dynamic subtest A-eDP1: SUCCESS (8.752s)
[189.538087] Starting dynamic subtest: B-eDP1
[198.243901] Dynamic subtest B-eDP1: SUCCESS (8.713s)
[198.256067] Starting dynamic subtest: C-eDP1
[206.968423] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[206.977814] Starting dynamic subtest: D-eDP1
[215.704531] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[215.709358] Subtest absolute-wf_vblank: SUCCESS (34.932s)
[216.918963] [015/134] (807s left) gem_partial_pwrite_pread (writes-after-reads-display)
[216.994058] Subtest writes-after-reads-display: SKIP (0.000s)
[217.076758] [016/134] (807s left) kms_psr (pr-suspend)
[217.168762] Starting subtest: pr-suspend
[217.172642] Subtest pr-suspend: SKIP (0.000s)
[217.252632] [017/134] (807s left) gem_exec_whisper (basic-queues-forked-all)
[217.320134] Starting subtest: basic-queues-forked-all
[237.060880] Subtest basic-queues-forked-all: SUCCESS (19.735s)
[237.266546] [018/134] (787s left) kms_pm_rpm (system-suspend-modeset)
[239.095846] Starting subtest: system-suspend-modeset
[258.409042] Subtest system-suspend-modeset: SUCCESS (4.648s)
[258.809588] [019/134] (766s left) kms_addfb_basic (too-high)
[258.944930] Starting subtest: too-high
[258.947896] Subtest too-high: SUCCESS (0.001s)
[259.070562] [020/134] (765s left) i915_pm_freq_mult (media-freq)
[259.136641] Starting subtest: media-freq
[259.139733] Starting dynamic subtest: gt0
[259.145104] Dynamic subtest gt0: SKIP (0.000s)
[259.164061] Starting dynamic subtest: gt1
[259.169607] Dynamic subtest gt1: SKIP (0.000s)
[259.174807] Subtest media-freq: SKIP (0.001s)
[259.243254] [021/134] (765s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[259.356904] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[259.362035] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[259.465375] [022/134] (765s left) kms_getfb (getfb-handle-closed)
[259.574636] Starting subtest: getfb-handle-closed
[259.577238] Subtest getfb-handle-closed: SUCCESS (0.000s)
[259.724082] [023/134] (765s left) gem_exec_schedule (implicit-boths)
[259.808185] Starting subtest: implicit-boths
[259.810474] Starting dynamic subtest: rcs0
[259.917076] Dynamic subtest rcs0: SUCCESS (0.117s)
[259.928747] Starting dynamic subtest: vcs0
[259.997598] Dynamic subtest vcs0: SUCCESS (0.079s)
[260.009508] Starting dynamic subtest: vcs1
[260.085663] Dynamic subtest vcs1: SUCCESS (0.086s)
[260.096873] Starting dynamic subtest: vecs0
[260.159676] Dynamic subtest vecs0: SUCCESS (0.072s)
[260.170891] Starting dynamic subtest: ccs0
[260.241747] Dynamic subtest ccs0: SUCCESS (0.081s)
[260.244339] Subtest implicit-boths: SUCCESS (0.437s)
[261.644054] [024/134] (763s left) gem_userptr_blits (stress-mm-invalidate-close)
[261.709915] Starting subtest: stress-mm-invalidate-close
[263.889768] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[264.050008] [025/134] (761s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[264.158874] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[264.778230] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.614s)
[264.970405] [026/134] (760s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[265.065771] Starting subtest: x-tiled-16bpp-rotate-0
[266.301053] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.223s)
[266.433218] [027/134] (758s left) kms_chamelium_frames (hdmi-frame-dump)
[266.829803] Subtest hdmi-frame-dump: SKIP (0.000s)
[267.629289] [028/134] (757s left) gem_exec_parallel (fds)
[267.700781] Starting subtest: fds
[267.703862] Starting dynamic subtest: rcs0
[271.054054] Dynamic subtest rcs0: SUCCESS (3.330s)
[271.066067] Starting dynamic subtest: bcs0
[275.711898] Dynamic subtest bcs0: SUCCESS (4.637s)
[275.723835] Starting dynamic subtest: vcs0
[279.735354] Dynamic subtest vcs0: SUCCESS (4.013s)
[279.745903] Starting dynamic subtest: vcs1
[283.787174] Dynamic subtest vcs1: SUCCESS (4.043s)
[283.798788] Starting dynamic subtest: vecs0
[287.783812] Dynamic subtest vecs0: SUCCESS (3.992s)
[287.795704] Starting dynamic subtest: ccs0
[292.832654] Dynamic subtest ccs0: SUCCESS (5.047s)
[292.835422] Subtest fds: SUCCESS (25.072s)
[293.039297] [029/134] (732s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[293.107403] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[293.206086] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[293.301161] [030/134] (732s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[293.398813] Starting subtest: addfb25-yf-tiled-legacy
[293.401036] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[293.534234] [031/134] (731s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[293.637770] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[297.409580] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.777s)
[298.625418] [032/134] (726s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[298.712836] Starting subtest: bad-pixel-format-yf-tiled-ccs
[298.715586] Starting dynamic subtest: pipe-A-eDP-1
[298.741275] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[298.750084] Starting dynamic subtest: pipe-B-eDP-1
[298.775943] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[298.784737] Starting dynamic subtest: pipe-C-eDP-1
[298.810765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[298.818744] Starting dynamic subtest: pipe-D-eDP-1
[298.844266] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[298.849569] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[300.969668] [033/134] (724s left) i915_drm_fdinfo (virtual-busy-idle-all)
[301.010910] Starting subtest: virtual-busy-idle-all
[301.016756] Subtest virtual-busy-idle-all: SKIP (0.000s)
[301.095191] [034/134] (724s left) gem_eio (in-flight-contexts-1us)
[301.314596] Starting subtest: in-flight-contexts-1us
[314.550802] Subtest in-flight-contexts-1us: SUCCESS (13.230s)
[314.741474] [035/134] (710s left) kms_prop_blob (invalid-get-prop-any)
[314.793041] Starting subtest: invalid-get-prop-any
[314.796039] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[314.899158] [036/134] (710s left) gem_exec_capture (userptr)
[314.964428] Starting subtest: userptr
[315.792172] Subtest userptr: SUCCESS (0.828s)
[315.921300] [037/134] (709s left) gem_userptr_blits (create-destroy-unsync)
[316.004682] Subtest create-destroy-unsync: SKIP (0.000s)
[316.160328] [038/134] (709s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[316.256623] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[316.259053] Starting dynamic subtest: pipe-A
[316.608410] Dynamic subtest pipe-A: SUCCESS (0.354s)
[316.617206] Starting dynamic subtest: pipe-B
[318.055828] Dynamic subtest pipe-B: SUCCESS (1.446s)
[318.065254] Starting dynamic subtest: pipe-C
[319.494080] Dynamic subtest pipe-C: SUCCESS (1.437s)
[319.503686] Starting dynamic subtest: pipe-D
[320.925480] Dynamic subtest pipe-D: SUCCESS (1.430s)
[320.927904] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.671s)
[322.118894] [039/134] (703s left) kms_flip_scaled_crc (flip-32bpp-yuv-linear-to-32bpp-yuv-linear-reflect-x)
[322.222869] Starting subtest: flip-32bpp-yuv-linear-to-32bpp-yuv-linear-reflect-x
[322.228077] Subtest flip-32bpp-yuv-linear-to-32bpp-yuv-linear-reflect-x: SKIP (0.000s)
[322.304178] [040/134] (703s left) prime_vgem (fence-flip-hang)
[322.392009] Subtest fence-flip-hang: SKIP (0.000s)
[322.509830] [041/134] (703s left) kms_pwrite_crc
[324.156486] [042/134] (701s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[324.259400] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[324.261835] Starting dynamic subtest: pipe-A-eDP-1
[324.288588] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[324.299002] Starting dynamic subtest: pipe-B-eDP-1
[324.325120] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[324.334333] Starting dynamic subtest: pipe-C-eDP-1
[324.360062] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[324.371604] Starting dynamic subtest: pipe-D-eDP-1
[324.398019] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[324.403558] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[326.433829] [043/134] (699s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[326.501066] Starting subtest: x-tiled-to-vebox-y-tiled
[326.506063] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[326.697580] [044/134] (699s left) i915_suspend (debugfs-reader)
[326.758581] Starting subtest: debugfs-reader
[344.849199] Subtest debugfs-reader: SUCCESS (3.098s)
[345.063470] [045/134] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[345.194385] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[352.248911] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.920s)
[352.398333] [046/134] (673s left) i915_query (query-topology-known-pci-ids)
[352.467534] Starting subtest: query-topology-known-pci-ids
[352.471942] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[352.602090] [047/134] (673s left) kms_chamelium_hpd (dp-hpd)
[352.998125] Subtest dp-hpd: SKIP (0.000s)
[353.845561] [048/134] (672s left) kms_psr (fbc-psr2-basic)
[353.950584] Starting subtest: fbc-psr2-basic
[353.952819] Starting dynamic subtest: eDP-1
[353.956833] Dynamic subtest eDP-1: SKIP (0.000s)
[353.960908] Subtest fbc-psr2-basic: SKIP (0.001s)
[354.039194] [049/134] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[354.150061] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[354.154153] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[354.275857] [050/134] (672s left) kms_plane (pixel-format-x-tiled-modifier)
[354.377047] Starting subtest: pixel-format-x-tiled-modifier
[354.403547] Starting dynamic subtest: pipe-A-plane-0
[355.046257] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[355.056079] Starting dynamic subtest: pipe-A-plane-3
[355.455546] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[355.466401] Starting dynamic subtest: pipe-A-plane-5
[355.470071] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[356.571104] Starting dynamic subtest: pipe-B-plane-0
[357.202778] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[357.218886] Starting dynamic subtest: pipe-B-plane-3
[357.614116] Dynamic subtest pipe-B-plane-3: SUCCESS (0.409s)
[357.624837] Starting dynamic subtest: pipe-B-plane-5
[357.628467] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[357.926090] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.523s)
[358.764862] [051/134] (667s left) gem_ctx_isolation (preservation)
[358.824178] Starting subtest: preservation
[358.826634] Starting dynamic subtest: rcs0
[358.970212] Dynamic subtest rcs0: SUCCESS (0.145s)
[358.982435] Starting dynamic subtest: bcs0
[359.119285] Dynamic subtest bcs0: SUCCESS (0.147s)
[359.131367] Starting dynamic subtest: vcs0
[359.276450] Dynamic subtest vcs0: SUCCESS (0.156s)
[359.288818] Starting dynamic subtest: vcs1
[360.604923] Dynamic subtest vcs1: SUCCESS (1.321s)
[360.617794] Starting dynamic subtest: vecs0
[362.616834] Dynamic subtest vecs0: SUCCESS (2.003s)
[362.629138] Starting dynamic subtest: ccs0
[364.688930] Dynamic subtest ccs0: SUCCESS (2.065s)
[364.691468] Subtest preservation: SUCCESS (5.842s)
[364.983178] [052/134] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[365.095212] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[365.099534] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[365.220771] [053/134] (661s left) kms_cursor_edge_walk (64x64-left-edge)
[365.309955] Starting subtest: 64x64-left-edge
[365.312240] Starting dynamic subtest: pipe-A-eDP-1
[368.756078] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s)
[368.765315] Starting dynamic subtest: pipe-D-eDP-1
[371.879003] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[371.881283] Subtest 64x64-left-edge: SUCCESS (6.558s)
[372.697517] [054/134] (653s left) gem_mmap_gtt (cpuset-medium-copy)
[372.773958] Subtest cpuset-medium-copy: SKIP (0.000s)
[372.842804] [055/134] (653s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[372.947138] Starting subtest: fbcpsr-tiling-y
[372.951478] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[373.087297] [056/134] (653s left) kms_frontbuffer_tracking (fbc-2p-rte)
[373.202320] Starting subtest: fbc-2p-rte
[373.206327] Subtest fbc-2p-rte: SKIP (0.000s)
[373.338132] [057/134] (653s left) kms_pipe_crc_basic (read-crc)
[373.419346] Starting subtest: read-crc
[373.421479] Starting dynamic subtest: pipe-A-eDP-1
[374.121402] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[374.131436] Starting dynamic subtest: pipe-B-eDP-1
[375.474010] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s)
[375.484291] Starting dynamic subtest: pipe-C-eDP-1
[376.759004] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.284s)
[376.769803] Starting dynamic subtest: pipe-D-eDP-1
[378.107000] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[378.109373] Subtest read-crc: SUCCESS (4.684s)
[378.985943] [058/134] (647s left) gem_mmap_wc (read)
[379.049429] Subtest read: SKIP (0.000s)
[379.130986] [059/134] (647s left) vgem_basic (bad-fence)
[379.172535] Starting subtest: bad-fence
[379.174463] Subtest bad-fence: SUCCESS (0.000s)
[379.237451] [060/134] (647s left) gen9_exec_parse (bb-secure)
[379.294546] Subtest bb-secure: SKIP (0.000s)
[379.379578] [061/134] (647s left) gem_tiled_blits (basic)
[379.440598] Subtest basic: SKIP (0.000s)
[379.500426] [062/134] (647s left) i915_drm_fdinfo (all-busy-idle-check-all)
[379.539950] Starting subtest: all-busy-idle-check-all
[379.544387] Subtest all-busy-idle-check-all: SKIP (0.004s)
[379.625560] [063/134] (647s left) kms_psr (fbc-pr-basic)
[379.775857] Starting subtest: fbc-pr-basic
[379.780334] Subtest fbc-pr-basic: SKIP (0.000s)
[379.860482] [064/134] (647s left) perf_pmu (init-wait)
[379.904166] Starting subtest: init-wait
[379.906205] Starting dynamic subtest: rcs0
[379.908134] Dynamic subtest rcs0: SUCCESS (0.002s)
[379.917142] Starting dynamic subtest: bcs0
[379.918948] Dynamic subtest bcs0: SUCCESS (0.000s)
[379.927365] Starting dynamic subtest: vcs0
[379.929218] Dynamic subtest vcs0: SUCCESS (0.001s)
[379.937608] Starting dynamic subtest: vcs1
[379.939525] Dynamic subtest vcs1: SUCCESS (0.001s)
[379.947817] Starting dynamic subtest: vecs0
[379.949587] Dynamic subtest vecs0: SUCCESS (0.001s)
[379.957893] Starting dynamic subtest: ccs0
[379.959657] Dynamic subtest ccs0: SUCCESS (0.001s)
[379.961514] Subtest init-wait: SUCCESS (0.010s)
[380.037829] [065/134] (647s left) syncobj_timeline (invalid-signal-illegal-point)
[380.094213] Starting subtest: invalid-signal-illegal-point
[380.096243] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[380.209081] [066/134] (646s left) kms_feature_discovery (display)
[380.305202] Starting subtest: display
[380.307088] Subtest display: SUCCESS (0.000s)
[380.389179] [067/134] (646s left) kms_cursor_crc (cursor-onscreen-256x256)
[380.613267] Starting subtest: cursor-onscreen-256x256
[380.615215] Starting dynamic subtest: pipe-A-eDP-1
[382.724357] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.107s)
[382.751409] Starting dynamic subtest: pipe-D-eDP-1
[385.501480] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s)
[385.503790] Subtest cursor-onscreen-256x256: SUCCESS (4.889s)
[386.312611] [068/134] (640s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[386.432044] Starting subtest: cursorB-vs-flipB-toggle
[386.436320] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[386.603870] [069/134] (640s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[386.705519] Starting subtest: yf-tiled-32bpp-rotate-90
[386.709878] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[386.835585] [070/134] (640s left) kms_cursor_legacy (torture-move)
[386.959728] Starting subtest: torture-move
[386.961866] Starting dynamic subtest: pipe-A
[392.940722] Dynamic subtest pipe-A: SUCCESS (5.975s)
[392.954523] Starting dynamic subtest: pipe-B
[400.467553] Dynamic subtest pipe-B: SUCCESS (7.521s)
[400.483500] Starting dynamic subtest: pipe-C
[407.468292] Dynamic subtest pipe-C: SUCCESS (6.997s)
[407.478317] Starting dynamic subtest: pipe-D
[415.534175] Dynamic subtest pipe-D: SUCCESS (8.064s)
[415.546148] Starting dynamic subtest: all-pipes
[423.187947] Dynamic subtest all-pipes: SUCCESS (7.649s)
[423.190708] Subtest torture-move: SUCCESS (36.219s)
[423.353924] [071/134] (603s left) perf_pmu (frequency)
[423.420972] Starting subtest: frequency
[423.426616] Starting dynamic subtest: gt0
[425.639222] Dynamic subtest gt0: SUCCESS (2.206s)
[425.651267] Starting dynamic subtest: idle-gt0
[426.145159] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[426.157335] Starting dynamic subtest: gt1
[430.525161] Dynamic subtest gt1: SUCCESS (4.376s)
[430.536579] Starting dynamic subtest: idle-gt1
[431.030824] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[431.033354] Subtest frequency: SUCCESS (7.610s)
[431.161133] [072/134] (596s left) kms_hdr (static-toggle-dpms)
[431.253841] Starting subtest: static-toggle-dpms
[431.260616] Subtest static-toggle-dpms: SKIP (0.000s)
[431.337626] [073/134] (596s left) kms_invalid_mode (bad-vtotal)
[431.430113] Starting subtest: bad-vtotal
[431.432332] Starting dynamic subtest: pipe-A-eDP-1
[431.731923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.304s)
[431.741612] Starting dynamic subtest: pipe-B-eDP-1
[431.743770] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[431.752952] Starting dynamic subtest: pipe-C-eDP-1
[431.755239] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[431.764387] Starting dynamic subtest: pipe-D-eDP-1
[431.766605] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[431.768811] Subtest bad-vtotal: SUCCESS (0.309s)
[432.550100] [074/134] (594s left) gem_mmap_wc (bad-object)
[432.613090] Subtest bad-object: SKIP (0.000s)
[432.671698] [075/134] (594s left) dmabuf_sync_file (export-basic)
[432.714917] Starting subtest: export-basic
[432.717271] Subtest export-basic: SUCCESS (0.001s)
[432.783155] [076/134] (594s left) kms_content_protection (atomic)
[432.930437] Starting subtest: atomic
[432.934914] Subtest atomic: SKIP (0.000s)
[433.068444] [077/134] (594s left) prime_vgem (basic-fence-read)
[433.152424] Starting subtest: basic-fence-read
[433.171378] Subtest basic-fence-read: SKIP (0.018s)
[433.327839] [078/134] (594s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[433.447848] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[450.634167] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.181s)
[451.438587] [079/134] (576s left) gem_vm_create (isolation)
[451.492323] Starting subtest: isolation
[451.499516] Subtest isolation: SUCCESS (0.008s)
[451.636091] [080/134] (576s left) kms_pm_lpsp (kms-lpsp)
[452.733076] Starting subtest: kms-lpsp
[452.735101] Starting dynamic subtest: pipe-A-eDP-1
[452.878007] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s)
[453.176461] Subtest kms-lpsp: SUCCESS (0.445s)
[453.984023] [081/134] (573s left) kms_frontbuffer_tracking (fbc-suspend)
[454.080922] Starting subtest: fbc-suspend
[492.422007] Subtest fbc-suspend: SUCCESS (7.451s)
[493.686317] [082/134] (534s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[493.800153] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[493.802981] Starting dynamic subtest: pipe-A-eDP-1
[493.863076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[493.877572] Starting dynamic subtest: pipe-B-eDP-1
[493.925747] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[493.936236] Starting dynamic subtest: pipe-C-eDP-1
[494.006719] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.079s)
[494.016671] Starting dynamic subtest: pipe-D-eDP-1
[494.070027] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[494.072606] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.265s)
[496.349487] [083/134] (531s left) kms_addfb_basic (unused-handle)
[496.405906] Starting subtest: unused-handle
[496.408879] Subtest unused-handle: SUCCESS (0.000s)
[496.558209] [084/134] (531s left) kms_cdclk (plane-scaling)
[496.650915] Starting subtest: plane-scaling
[496.653289] Starting dynamic subtest: pipe-A-eDP-1
[496.943544] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[496.952995] Starting dynamic subtest: pipe-B-eDP-1
[496.957798] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[496.967302] Starting dynamic subtest: pipe-C-eDP-1
[496.973024] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[496.985230] Starting dynamic subtest: pipe-D-eDP-1
[496.990164] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[496.994958] Subtest plane-scaling: SKIP (0.294s)
[497.802175] [085/134] (530s left) prime_self_import (reimport-vs-gem_close-race)
[497.834373] Starting subtest: reimport-vs-gem_close-race
[502.938914] Subtest reimport-vs-gem_close-race: SUCCESS (5.057s)
[503.025664] [086/134] (524s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[503.136103] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[503.141803] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[503.258739] [087/134] (524s left) gem_userptr_blits (unsync-overlap)
[503.328913] Subtest unsync-overlap: SKIP (0.000s)
[503.480748] [088/134] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[503.592114] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[503.597160] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[503.714789] [089/134] (524s left) kms_flip (wf_vblank-ts-check-interruptible)
[503.817890] Starting subtest: wf_vblank-ts-check-interruptible
[503.820578] Starting dynamic subtest: A-eDP1
[512.821621] Dynamic subtest A-eDP1: SUCCESS (8.970s)
[512.831262] Starting dynamic subtest: B-eDP1
[521.761972] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[521.771671] Starting dynamic subtest: C-eDP1
[530.680967] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[530.690664] Starting dynamic subtest: D-eDP1
[539.609926] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[539.612780] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.755s)
[540.854177] [090/134] (487s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[540.978577] Starting subtest: cursorA-vs-flipB-varying-size
[540.983416] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[541.135829] [091/134] (487s left) gem_ctx_persistence (processes)
[541.200918] Starting subtest: processes
[543.298574] Subtest processes: SUCCESS (2.097s)
[543.391448] [092/134] (484s left) gem_mmap_gtt (hang-user)
[543.449858] Subtest hang-user: SKIP (0.000s)
[543.514702] [093/134] (484s left) syncobj_wait (single-wait-all-for-submit-submitted)
[543.562940] Starting subtest: single-wait-all-for-submit-submitted
[543.672550] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[543.775722] [094/134] (484s left) gem_basic (multigpu-create-close)
[543.830453] Starting subtest: multigpu-create-close
[543.835941] Subtest multigpu-create-close: SKIP (0.000s)
[543.948118] [095/134] (484s left) kms_selftest (drm_framebuffer)
[543.988186] Starting subtest: drm_framebuffer
[544.022102] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[544.162951] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.140s)
[544.173219] Starting dynamic subtest: drm_test_framebuffer_cleanup
[544.326789] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.160s)
[544.339143] Starting dynamic subtest: drm_test_framebuffer_create
[544.590678] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.261s)
[544.600158] Starting dynamic subtest: drm_test_framebuffer_free
[544.795608] Dynamic subtest drm_test_framebuffer_free: FAIL (0.143s)
[544.800738] Subtest drm_framebuffer: FAIL (0.746s)
[544.958995] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[544.976610] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[544.977542] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: kms_properties
results: parsing output: 2/ for test: gem_create
results: parsing output: 3/ for test: gem_exec_fence
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: gem_exec_flush
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_partial_pwrite_pread
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: i915_pm_freq_mult
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_getfb
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_chamelium_frames
results: parsing output: 27/ for test: gem_exec_parallel
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_prop_blob
results: parsing output: 35/ for test: gem_exec_capture
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: prime_vgem
results: parsing output: 40/ for test: kms_pwrite_crc
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: i915_suspend
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: i915_query
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: gem_ctx_isolation
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_edge_walk
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_pipe_crc_basic
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: gem_tiled_blits
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_feature_discovery
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_hdr
results: parsing output: 72/ for test: kms_invalid_mode
results: parsing output: 73/ for test: gem_mmap_wc
results: parsing output: 74/ for test: dmabuf_sync_file
results: parsing output: 75/ for test: kms_content_protection
results: parsing output: 76/ for test: prime_vgem
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_vm_create
results: parsing output: 79/ for test: kms_pm_lpsp
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_cdclk
results: parsing output: 84/ for test: prime_self_import
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: gem_basic
results: parsing output: 94/ for test: kms_selftest
results: parsing output: 95/ for test: kms_lease
results: no output, setting notrun
results: parsing output: 96/ for test: gem_exec_alignment
results: no output, setting notrun
results: parsing output: 97/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 98/ for test: kms_color
results: no output, setting notrun
results: parsing output: 99/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 100/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 101/ for test: syncobj_basic
results: no output, setting notrun
results: parsing output: 102/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: no output, setting notrun
results: parsing output: 104/ for test: gem_exec_whisper
results: no output, setting notrun
results: parsing output: 105/ for test: prime_busy
results: no output, setting notrun
results: parsing output: 106/ for test: kms_vblank
results: no output, setting notrun
results: parsing output: 107/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 108/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 109/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 110/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 111/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 112/ for test: gem_partial_pwrite_pread
results: no output, setting notrun
results: parsing output: 113/ for test: kms_flip_tiling
results: no output, setting notrun
results: parsing output: 114/ for test: kms_plane_multiple
results: no output, setting notrun
results: parsing output: 115/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 116/ for test: gem_softpin
results: no output, setting notrun
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 118/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 119/ for test: gem_exec_balancer
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: perf_pmu
results: no output, setting notrun
results: parsing output: 122/ for test: api_intel_allocator
results: no output, setting notrun
results: parsing output: 123/ for test: kms_plane_scaling
results: no output, setting notrun
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 125/ for test: kms_frontbuffer_tracking
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: testdisplay
results: no output, setting notrun
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 129/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 131/ for test: gem_eio
results: no output, setting notrun
results: parsing output: 132/ for test: perf
results: no output, setting notrun
results: parsing output: 133/ for test: syncobj_timeline
results: no output, setting notrun
Done.