[57.261782] Initializing watchdogs
[57.261830]   /dev/watchdog0
[57.275650] [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.280228] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.282592] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.286701] [001/133] (960s left) kms_flip (wf_vblank-ts-check-interruptible)
[57.403622] Starting subtest: wf_vblank-ts-check-interruptible
[57.405933] Starting dynamic subtest: A-eDP1
[66.376065] Dynamic subtest A-eDP1: SUCCESS (8.947s)
[66.386189] Starting dynamic subtest: B-eDP1
[75.313817] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[75.321107] Starting dynamic subtest: C-eDP1
[84.242151] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[84.250372] Starting dynamic subtest: D-eDP1
[93.184430] Dynamic subtest D-eDP1: SUCCESS (8.940s)
[93.189220] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.748s)
[94.419213] [002/133] (923s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[94.516758] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[94.521206] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[94.621573] [003/133] (923s left) kms_plane (pixel-format-linear-modifier)
[94.714429] Starting subtest: pixel-format-linear-modifier
[94.750500] Starting dynamic subtest: pipe-A-plane-0
[98.294741] Dynamic subtest pipe-A-plane-0: SUCCESS (3.544s)
[98.301415] Starting dynamic subtest: pipe-A-plane-3
[99.939591] Dynamic subtest pipe-A-plane-3: SUCCESS (1.644s)
[99.949188] Starting dynamic subtest: pipe-A-plane-5
[100.128464] Dynamic subtest pipe-A-plane-5: SUCCESS (0.188s)
[101.202176] Starting dynamic subtest: pipe-B-plane-0
[104.649148] Dynamic subtest pipe-B-plane-0: SUCCESS (3.456s)
[104.657664] Starting dynamic subtest: pipe-B-plane-3
[106.349544] Dynamic subtest pipe-B-plane-3: SUCCESS (1.699s)
[106.358036] Starting dynamic subtest: pipe-B-plane-5
[106.560263] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[106.871762] Subtest pixel-format-linear-modifier: SUCCESS (12.156s)
[107.669811] [004/133] (910s left) sysfs_heartbeat_interval (nopreempt)
[107.740106] Starting subtest: nopreempt
[107.742204] Starting dynamic subtest: vecs0
[116.889836] Dynamic subtest vecs0: SUCCESS (9.148s)
[116.899831] Starting dynamic subtest: ccs0
[120.848231] Dynamic subtest ccs0: SUCCESS (3.959s)
[120.858489] Starting dynamic subtest: vcs0
[130.907248] Dynamic subtest vcs0: SUCCESS (10.055s)
[130.917251] Starting dynamic subtest: bcs0
[134.796429] Dynamic subtest bcs0: SUCCESS (3.890s)
[134.806023] Starting dynamic subtest: rcs0
[138.786125] Dynamic subtest rcs0: SUCCESS (3.984s)
[138.797861] Starting dynamic subtest: vcs1
[147.926737] Dynamic subtest vcs1: SUCCESS (9.145s)
[147.929436] Subtest nopreempt: SUCCESS (40.187s)
[148.003036] [005/133] (869s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[148.120571] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[148.777407] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[148.938420] [006/133] (869s left) kms_addfb_basic (bad-pitch-256)
[149.001844] Starting subtest: bad-pitch-256
[149.004099] Subtest bad-pitch-256: SUCCESS (0.000s)
[149.124909] [007/133] (868s left) kms_cursor_legacy (torture-move)
[149.249487] Starting subtest: torture-move
[149.251782] Starting dynamic subtest: pipe-A
[155.794983] Dynamic subtest pipe-A: SUCCESS (6.542s)
[155.805759] Starting dynamic subtest: pipe-B
[162.277471] Dynamic subtest pipe-B: SUCCESS (6.484s)
[162.289454] Starting dynamic subtest: pipe-C
[169.932836] Dynamic subtest pipe-C: SUCCESS (7.653s)
[169.942610] Starting dynamic subtest: pipe-D
[177.267786] Dynamic subtest pipe-D: SUCCESS (7.336s)
[177.276132] Starting dynamic subtest: all-pipes
[183.243328] Dynamic subtest all-pipes: SUCCESS (5.975s)
[183.245735] Subtest torture-move: SUCCESS (33.993s)
[183.430355] [008/133] (834s left) gem_ppgtt (shrink-vs-evict-any)
[183.508209] Starting subtest: shrink-vs-evict-any
[188.913572] Subtest shrink-vs-evict-any: SUCCESS (5.403s)
[188.994607] [009/133] (829s left) syncobj_timeline (wait-all-for-submit-snapshot)
[189.048701] Starting subtest: wait-all-for-submit-snapshot
[189.129982] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[189.207495] [010/133] (828s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[189.309460] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[189.313899] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[189.414851] [011/133] (828s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[189.791588] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[190.569273] [012/133] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[190.666532] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[190.670738] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[190.785805] [013/133] (827s left) gem_mmap_gtt (basic-write-read-distinct)
[190.850173] Subtest basic-write-read-distinct: SKIP (0.000s)
[190.909513] [014/133] (827s left) perf_pmu (busy-no-semaphores)
[190.952031] Starting subtest: busy-no-semaphores
[190.954161] Starting dynamic subtest: rcs0
[191.522561] Dynamic subtest rcs0: SUCCESS (0.568s)
[191.533803] Starting dynamic subtest: bcs0
[192.075052] Dynamic subtest bcs0: SUCCESS (0.550s)
[192.086066] Starting dynamic subtest: vcs0
[192.625604] Dynamic subtest vcs0: SUCCESS (0.548s)
[192.637474] Starting dynamic subtest: vcs1
[194.394775] Dynamic subtest vcs1: SUCCESS (1.768s)
[194.405908] Starting dynamic subtest: vecs0
[196.442581] Dynamic subtest vecs0: SUCCESS (2.045s)
[196.452768] Starting dynamic subtest: ccs0
[198.427984] Dynamic subtest ccs0: SUCCESS (1.984s)
[198.430885] Subtest busy-no-semaphores: SUCCESS (7.475s)
[198.543317] [015/133] (819s left) core_getstats (basic)
[198.594095] Starting subtest: basic
[198.596514] Subtest basic: SUCCESS (0.000s)
[198.690256] [016/133] (819s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[198.763231] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[198.767861] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[198.944487] [017/133] (819s left) gem_exec_alignment (pi)
[199.002111] Starting subtest: pi
[250.550195] Subtest pi: SUCCESS (51.543s)
[251.616694] [018/133] (766s left) gem_lmem_swapping (smem-oom)
[251.704635] Subtest smem-oom: SKIP (0.000s)
[251.748411] [019/133] (766s left) kms_prop_blob (blob-prop-lifetime)
[251.810826] Starting subtest: blob-prop-lifetime
[251.813110] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[251.900872] [020/133] (766s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[252.004377] Starting subtest: extended-modeset-hang-oldfb-with-reset
[252.006642] Starting dynamic subtest: pipe-A
[263.675666] Dynamic subtest pipe-A: SUCCESS (11.669s)
[263.685395] Starting dynamic subtest: pipe-D
[275.948983] Dynamic subtest pipe-D: SUCCESS (12.270s)
[275.951419] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.943s)
[276.763150] [021/133] (741s left) gem_exec_await (wide-all)
[277.025668] Starting subtest: wide-all
[300.601990] Subtest wide-all: SUCCESS (23.574s)
[300.789702] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[300.794507] [022/133] (717s left) kms_hdr (static-toggle-suspend)
[300.954652] Starting subtest: static-toggle-suspend
[300.961106] Subtest static-toggle-suspend: SKIP (0.000s)
[301.027706] [023/133] (717s left) gem_ctx_param (vm)
[301.087672] Starting subtest: vm
[301.145019] Subtest vm: SUCCESS (0.057s)
[301.289605] [024/133] (717s left) gem_mmap_gtt (big-copy-odd)
[301.344335] Subtest big-copy-odd: SKIP (0.000s)
[301.406990] [025/133] (717s left) kms_cursor_crc (cursor-random-128x128)
[301.621447] Starting subtest: cursor-random-128x128
[301.623770] Starting dynamic subtest: pipe-A-eDP-1
[304.954816] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.331s)
[304.983766] Starting dynamic subtest: pipe-D-eDP-1
[308.940862] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.963s)
[308.942730] Subtest cursor-random-128x128: SUCCESS (7.318s)
[309.805594] [026/133] (709s left) vgem_basic (unload)
[309.850695] Starting subtest: unload
[338.919742] Subtest unload: SUCCESS (29.067s)
[339.038236] [027/133] (679s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[339.163356] Starting subtest: x-tiled-8bpp-rotate-90
[339.185674] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[339.309846] [028/133] (679s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[339.407203] Starting subtest: multiplane-rotation-cropping-top
[356.888920] Subtest multiplane-rotation-cropping-top: SUCCESS (17.482s)
[357.002691] [029/133] (661s left) sw_sync (alloc_fence_invalid_timeline)
[357.045215] Starting subtest: alloc_fence_invalid_timeline
[357.047111] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[357.104859] [030/133] (661s left) kms_setmode (invalid-clone-exclusive-crtc)
[357.167087] Starting subtest: invalid-clone-exclusive-crtc
[357.172639] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[357.283137] [031/133] (661s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[357.331375] Starting subtest: etime-multi-wait-all-available-unsubmitted
[357.442425] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[357.535846] [032/133] (661s left) gem_mmap_gtt (big-bo-tiledx)
[357.603636] Subtest big-bo-tiledX: SKIP (0.000s)
[357.669919] [033/133] (661s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[357.762041] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[357.764327] Starting dynamic subtest: pipe-A-eDP-1
[357.789074] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.800934] Starting dynamic subtest: pipe-B-eDP-1
[357.823211] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.831918] Starting dynamic subtest: pipe-C-eDP-1
[357.853690] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.864730] Starting dynamic subtest: pipe-D-eDP-1
[357.887607] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.892603] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[359.987014] [034/133] (659s left) gem_userptr_blits (readonly-unsync)
[360.067958] Subtest readonly-unsync: SKIP (0.000s)
[360.205468] [035/133] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[360.304532] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[360.308963] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[360.404448] [036/133] (658s left) syncobj_wait (multi-wait-for-submit-submitted)
[360.460665] Starting subtest: multi-wait-for-submit-submitted
[360.561074] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[360.638457] [037/133] (658s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[360.693967] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[360.801965] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[360.880457] [038/133] (658s left) kms_draw_crc (draw-method-mmap-wc)
[360.982907] Starting subtest: draw-method-mmap-wc
[360.985197] Starting dynamic subtest: xrgb8888-untiled
[361.205850] Dynamic subtest xrgb8888-untiled: SUCCESS (0.223s)
[361.214937] Starting dynamic subtest: rgb565-untiled
[361.427920] Dynamic subtest rgb565-untiled: SUCCESS (0.220s)
[361.436618] Starting dynamic subtest: xrgb2101010-untiled
[361.649786] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[361.658737] Starting dynamic subtest: xbgr16161616f-untiled
[361.861146] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.209s)
[361.871776] Starting dynamic subtest: xrgb8888-xtiled
[361.994188] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[362.004837] Starting dynamic subtest: rgb565-xtiled
[362.117457] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[362.125813] Starting dynamic subtest: xrgb2101010-xtiled
[362.238598] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[362.247302] Starting dynamic subtest: xbgr16161616f-xtiled
[362.371791] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[362.383018] Starting dynamic subtest: xrgb8888-4tiled
[362.516527] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.142s)
[362.525083] Starting dynamic subtest: rgb565-4tiled
[362.660716] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[362.671373] Starting dynamic subtest: xrgb2101010-4tiled
[362.805643] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.142s)
[362.814386] Starting dynamic subtest: xbgr16161616f-4tiled
[362.983012] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.176s)
[362.984930] Subtest draw-method-mmap-wc: SUCCESS (2.002s)
[363.074069] [039/133] (656s left) gem_render_linear_blits (basic)
[363.135119] Starting subtest: basic
[363.154562] Subtest basic: SUCCESS (0.019s)
[363.238857] [040/133] (656s left) kms_pm_rpm (fences-dpms)
[365.068215] Starting subtest: fences-dpms
[365.073141] Subtest fences-dpms: SKIP (0.000s)
[365.522266] [041/133] (653s left) kms_cursor_crc (cursor-dpms)
[365.651965] Starting subtest: cursor-dpms
[365.654386] Starting dynamic subtest: pipe-A-eDP-1
[368.682298] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.028s)
[368.692488] Starting dynamic subtest: pipe-D-eDP-1
[372.271040] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.587s)
[372.273386] Subtest cursor-dpms: SUCCESS (6.618s)
[373.119964] [042/133] (646s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[373.212748] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[373.214929] Starting dynamic subtest: pipe-A
[373.234956] Dynamic subtest pipe-A: SKIP (0.018s)
[373.244421] Starting dynamic subtest: pipe-B
[373.266290] Dynamic subtest pipe-B: SKIP (0.032s)
[373.275079] Starting dynamic subtest: pipe-C
[373.297141] Dynamic subtest pipe-C: SKIP (0.031s)
[373.306152] Starting dynamic subtest: pipe-D
[373.328658] Dynamic subtest pipe-D: SKIP (0.029s)
[373.332416] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.112s)
[373.431564] [043/133] (646s left) kms_color (ctm-blue-to-red)
[373.523074] Starting subtest: ctm-blue-to-red
[373.524872] Starting dynamic subtest: pipe-A-eDP-1
[374.197256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.676s)
[374.207552] Starting dynamic subtest: pipe-B-eDP-1
[375.588668] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s)
[375.598777] Starting dynamic subtest: pipe-C-eDP-1
[376.867893] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s)
[376.882849] Starting dynamic subtest: pipe-D-eDP-1
[378.204482] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[378.206877] Subtest ctm-blue-to-red: SUCCESS (4.680s)
[379.042993] [044/133] (640s left) kms_plane_alpha_blend (constant-alpha-min)
[379.140070] Starting subtest: constant-alpha-min
[379.433894] Starting dynamic subtest: pipe-A-eDP-1
[380.125527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s)
[380.135016] Starting dynamic subtest: pipe-D-eDP-1
[381.585182] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.458s)
[381.587625] Subtest constant-alpha-min: SUCCESS (2.446s)
[382.408263] [045/133] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[382.504645] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[382.509048] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[382.612336] [046/133] (637s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[382.703122] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[382.705402] Starting dynamic subtest: pipe-A-eDP-1
[382.728245] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[382.740088] Starting dynamic subtest: pipe-B-eDP-1
[382.761448] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[382.770358] Starting dynamic subtest: pipe-C-eDP-1
[382.791658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[382.800467] Starting dynamic subtest: pipe-D-eDP-1
[382.822249] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[382.826558] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[384.951971] [047/133] (634s left) kms_lease (lease-uevent)
[385.050199] Starting subtest: lease-uevent
[386.060719] Subtest lease-uevent: SUCCESS (1.010s)
[386.137899] [048/133] (633s left) gen7_exec_parse (oacontrol-tracking)
[386.199821] Subtest oacontrol-tracking: SKIP (0.000s)
[386.268279] [049/133] (633s left) gem_userptr_blits (unsync-unmap-cycles)
[386.330252] Subtest unsync-unmap-cycles: SKIP (0.000s)
[386.470102] [050/133] (633s left) kms_flip (basic-flip-vs-modeset)
[386.564346] Starting subtest: basic-flip-vs-modeset
[386.566647] Starting dynamic subtest: A-eDP1
[389.150437] Dynamic subtest A-eDP1: SUCCESS (2.583s)
[389.160114] Starting dynamic subtest: B-eDP1
[391.329100] Dynamic subtest B-eDP1: SUCCESS (2.179s)
[391.339057] Starting dynamic subtest: C-eDP1
[393.485590] Dynamic subtest C-eDP1: SUCCESS (2.153s)
[393.495783] Starting dynamic subtest: D-eDP1
[395.577839] Dynamic subtest D-eDP1: SUCCESS (2.093s)
[395.580184] Subtest basic-flip-vs-modeset: SUCCESS (9.016s)
[396.375966] [051/133] (623s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[396.445618] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[396.448041] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[396.537651] [052/133] (623s left) syncobj_timeline (reset-during-wait-for-submit)
[396.592923] Starting subtest: reset-during-wait-for-submit
[396.696252] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[396.773096] [053/133] (623s left) perf (buffer-fill)
[396.918651] Starting subtest: buffer-fill
[396.920853] Starting dynamic subtest: 0-rcs0
[399.160316] Dynamic subtest 0-rcs0: SUCCESS (2.242s)
[399.170452] Starting dynamic subtest: 1-vcs0
[403.594969] Dynamic subtest 1-vcs0: SUCCESS (4.434s)
[403.598336] Subtest buffer-fill: SUCCESS (6.679s)
[403.646909] [054/133] (616s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[403.747819] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[407.837427] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.093s)
[408.981535] [055/133] (611s left) prime_vgem (wait)
[409.057133] Starting subtest: wait
[409.059491] Starting dynamic subtest: rcs0
[409.095844] Dynamic subtest rcs0: SUCCESS (0.042s)
[409.106902] Starting dynamic subtest: bcs0
[409.161632] Dynamic subtest bcs0: SUCCESS (0.065s)
[409.171186] Starting dynamic subtest: vcs0
[409.199943] Dynamic subtest vcs0: SUCCESS (0.037s)
[409.210087] Starting dynamic subtest: vcs1
[409.248650] Dynamic subtest vcs1: SUCCESS (0.048s)
[409.258843] Starting dynamic subtest: vecs0
[409.293294] Dynamic subtest vecs0: SUCCESS (0.044s)
[409.303313] Starting dynamic subtest: ccs0
[409.342840] Dynamic subtest ccs0: SUCCESS (0.048s)
[409.345196] Subtest wait: SUCCESS (0.290s)
[409.469515] [056/133] (610s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[409.576855] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[410.567066] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.990s)
[410.693180] [057/133] (609s left) gem_exec_fence (syncobj-timeline-unused-fence)
[411.224640] Starting subtest: syncobj-timeline-unused-fence
[411.230256] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[412.959859] [058/133] (607s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[413.053638] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[413.055740] Starting dynamic subtest: pipe-A-default-mode
[415.814591] Dynamic subtest pipe-A-default-mode: SUCCESS (2.757s)
[415.816638] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.759s)
[416.665352] [059/133] (603s left) kms_psr (pr-basic)
[416.752508] Starting subtest: pr-basic
[416.756563] Subtest pr-basic: SKIP (0.000s)
[416.822372] [060/133] (603s left) dmabuf_sync_file (export-wait-after-attach)
[416.865958] Starting subtest: export-wait-after-attach
[416.868244] Subtest export-wait-after-attach: SUCCESS (0.001s)
[416.922781] [061/133] (603s left) gem_exec_balancer (busy)
[416.994954] Starting subtest: busy
[418.903306] Subtest busy: SUCCESS (1.907s)
[419.236481] [062/133] (601s left) gem_userptr_blits (dmabuf-unsync)
[419.300814] Subtest dmabuf-unsync: SKIP (0.000s)
[419.462613] [063/133] (600s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[419.572431] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[420.944114] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.371s)
[421.737282] [064/133] (598s left) gem_render_copy (yf-tiled-ccs-to-linear)
[421.806626] Starting subtest: yf-tiled-ccs-to-linear
[421.810809] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[421.985914] [065/133] (598s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[422.074199] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[422.076601] Starting dynamic subtest: pipe-A-eDP-1
[438.546895] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.476s)
[438.558117] Starting dynamic subtest: pipe-B-eDP-1
[455.715380] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.164s)
[455.717672] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.643s)
[456.521040] [066/133] (563s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[456.615115] Starting subtest: pr-overlay-plane-move-continuous-sf
[456.619527] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[456.704029] [067/133] (563s left) i915_selftest (mock)
[460.018330] Starting subtest: mock
[460.020719] Starting dynamic subtest: sanitycheck
[460.708125] Dynamic subtest sanitycheck: SUCCESS (0.689s)
[460.718308] Starting dynamic subtest: shmem
[461.351219] Dynamic subtest shmem: SUCCESS (0.641s)
[461.361151] Starting dynamic subtest: fence
[469.000049] Dynamic subtest fence: SUCCESS (7.646s)
[469.010291] Starting dynamic subtest: scatterlist
[470.648802] Dynamic subtest scatterlist: SUCCESS (1.648s)
[470.665505] Starting dynamic subtest: syncmap
[473.795206] Dynamic subtest syncmap: SUCCESS (3.143s)
[473.805078] Starting dynamic subtest: uncore
[474.439130] Dynamic subtest uncore: SUCCESS (0.642s)
[474.448391] Starting dynamic subtest: ring
[475.105048] Dynamic subtest ring: SUCCESS (0.664s)
[475.114492] Starting dynamic subtest: engine
[475.763268] Dynamic subtest engine: SUCCESS (0.656s)
[475.772959] Starting dynamic subtest: timelines
[479.610024] Dynamic subtest timelines: SUCCESS (3.843s)
[479.619463] Starting dynamic subtest: requests
[483.418062] Dynamic subtest requests: SUCCESS (3.806s)
[483.428370] Starting dynamic subtest: objects
[484.173116] Dynamic subtest objects: SUCCESS (0.755s)
[484.183222] Starting dynamic subtest: phys
[484.973479] Dynamic subtest phys: SUCCESS (0.798s)
[484.983073] Starting dynamic subtest: dmabuf
[485.732056] Dynamic subtest dmabuf: SUCCESS (0.756s)
[485.742053] Starting dynamic subtest: vma
[491.384766] Dynamic subtest vma: SUCCESS (5.650s)
[491.394362] Starting dynamic subtest: evict
[492.744701] Dynamic subtest evict: SUCCESS (1.360s)
[492.754324] Starting dynamic subtest: gtt
[496.023758] Dynamic subtest gtt: SUCCESS (3.277s)
[496.033040] Starting dynamic subtest: hugepages
[496.915751] Dynamic subtest hugepages: SUCCESS (0.891s)
[496.925040] Starting dynamic subtest: memory_region
[499.467097] Dynamic subtest memory_region: SUCCESS (2.549s)
[499.469999] Subtest mock: SUCCESS (39.447s)
[499.502360] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[499.503065] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[499.506089] [068/133] (521s left) kms_pm_dc (dc5-dpms)
[502.088053] Starting subtest: dc5-dpms
[504.160348] Subtest dc5-dpms: SUCCESS (2.072s)
[504.262724] [FACT kms_pm_dc (dc5-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[504.263893] [FACT kms_pm_dc (dc5-dpms)] new: kernel.kmod_is_loaded.i915: true
[504.267447] [069/133] (516s left) kms_tiled_display (basic-test-pattern)
[504.378822] Subtest basic-test-pattern: SKIP (0.000s)
[504.427139] [070/133] (516s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[504.522642] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[511.957203] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.437s)
[512.080521] [071/133] (508s left) gem_vm_create (execbuf)
[512.141567] Starting subtest: execbuf
[512.153112] Subtest execbuf: SUCCESS (0.011s)
[512.275369] [072/133] (508s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[512.359263] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[519.316868] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.961s)
[519.407267] [073/133] (501s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[519.496223] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[525.700164] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.207s)
[526.856150] [074/133] (493s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[526.957572] Starting subtest: pipe-fbc-rte
[526.964370] Starting dynamic subtest: pipe-B-eDP-1
[532.408808] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.454s)
[532.416560] Subtest pipe-fbc-rte: SUCCESS (5.457s)
[534.680399] [075/133] (486s left) gem_userptr_blits (sync-unmap)
[534.742936] Starting subtest: sync-unmap
[534.766027] Subtest sync-unmap: SUCCESS (0.024s)
[534.904458] [076/133] (486s left) gem_exec_balancer (sliced)
[534.964275] Starting subtest: sliced
[534.968812] Subtest sliced: SKIP (0.000s)
[535.245940] [077/133] (485s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[535.338660] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[535.346335] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[535.469555] [078/133] (485s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[535.524310] Starting subtest: invalid-signal-one-illegal-handle
[535.526523] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[535.626116] [079/133] (485s left) kms_vblank (wait-busy)
[535.719800] Starting subtest: wait-busy
[535.721635] Starting dynamic subtest: pipe-A-eDP-1
[537.600035] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[537.623867] Starting dynamic subtest: pipe-D-eDP-1
[540.136713] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[540.138614] Subtest wait-busy: SUCCESS (4.417s)
[540.940722] [080/133] (480s left) kms_psr (psr2-dpms)
[541.033814] Starting subtest: psr2-dpms
[541.036018] Starting dynamic subtest: eDP-1
[543.868685] Dynamic subtest eDP-1: SUCCESS (2.836s)
[543.871029] Subtest psr2-dpms: SUCCESS (2.837s)
[544.737619] [081/133] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[544.838672] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[544.842884] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[544.970088] [082/133] (476s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[545.090712] Starting subtest: cursorB-vs-flipB-toggle
[545.095423] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[545.233442] [083/133] (476s left) kms_addfb_basic (bad-pitch-65536)
[545.288152] Starting subtest: bad-pitch-65536
[545.290038] Subtest bad-pitch-65536: SUCCESS (0.000s)
[545.412572] [084/133] (475s left) fbdev (eof)
[545.449510] Starting subtest: eof
[545.451908] Subtest eof: SUCCESS (0.000s)
[545.513934] [085/133] (475s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[545.610924] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[545.613199] Starting dynamic subtest: pipe-A-eDP-1
[545.636444] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[545.645787] Starting dynamic subtest: pipe-B-eDP-1
[545.667088] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[545.675793] Starting dynamic subtest: pipe-C-eDP-1
[545.694640] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[545.703071] Starting dynamic subtest: pipe-D-eDP-1
[545.722179] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[545.725476] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[547.903672] [086/133] (473s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[547.975577] Starting subtest: legacy-engines-hostile-preempt
[547.977925] Starting dynamic subtest: render
[548.054550] Dynamic subtest render: SUCCESS (0.078s)
[548.068099] Starting dynamic subtest: bsd1
[549.906200] Dynamic subtest bsd1: SUCCESS (1.847s)
[549.916981] Starting dynamic subtest: bsd2
[551.893299] Dynamic subtest bsd2: SUCCESS (1.984s)
[551.903747] Starting dynamic subtest: blt
[551.946077] Dynamic subtest blt: SUCCESS (0.051s)
[551.955849] Starting dynamic subtest: vebox
[553.938388] Dynamic subtest vebox: SUCCESS (1.988s)
[553.941189] Subtest legacy-engines-hostile-preempt: SUCCESS (5.962s)
[554.018491] [087/133] (467s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[554.126163] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[554.130636] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[554.249286] [088/133] (467s left) gem_exec_schedule (in-order)
[554.309255] Starting subtest: in-order
[554.311443] Starting dynamic subtest: rcs0
[554.423445] Dynamic subtest rcs0: SUCCESS (0.120s)
[554.434824] Starting dynamic subtest: vcs0
[554.504561] Dynamic subtest vcs0: SUCCESS (0.080s)
[554.517170] Starting dynamic subtest: vcs1
[554.583506] Dynamic subtest vcs1: SUCCESS (0.078s)
[554.595231] Starting dynamic subtest: vecs0
[554.681332] Dynamic subtest vecs0: SUCCESS (0.097s)
[554.694627] Starting dynamic subtest: ccs0
[554.771771] Dynamic subtest ccs0: SUCCESS (0.089s)
[554.774256] Subtest in-order: SUCCESS (0.470s)
[556.033504] [089/133] (465s left) kms_psr (fbc-psr-primary-mmap-cpu)
[556.126188] Starting subtest: fbc-psr-primary-mmap-cpu
[556.128556] Starting dynamic subtest: eDP-1
[556.133116] Dynamic subtest eDP-1: SKIP (0.000s)
[556.137713] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[556.200194] [090/133] (465s left) kms_fbcon_fbt (fbc-suspend)
[556.262939] Starting subtest: fbc-suspend
[605.156511] Subtest fbc-suspend: SUCCESS (20.213s)
[606.499718] [091/133] (415s left) kms_plane_scaling (invalid-num-scalers)
[606.605139] Starting subtest: invalid-num-scalers
[606.607506] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[606.623071] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[606.633678] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[606.654318] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[606.664206] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[606.690104] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[606.702637] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[606.721459] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[606.723812] Subtest invalid-num-scalers: SUCCESS (0.116s)
[606.833910] [092/133] (414s left) gem_workarounds (reset-fd)
[606.914762] Starting subtest: reset-fd
[607.094780] Subtest reset-fd: SUCCESS (0.177s)
[607.225101] [093/133] (414s left) i915_pm_rc6_residency (rc6-idle)
[607.285158] Starting subtest: rc6-idle
[607.316927] Starting dynamic subtest: gt0-rcs0
[631.721548] Dynamic subtest gt0-rcs0: SUCCESS (24.301s)
[631.731446] Starting dynamic subtest: gt0-bcs0
[655.935023] Dynamic subtest gt0-bcs0: SUCCESS (24.208s)
[655.946775] Starting dynamic subtest: gt0-ccs0
[680.235280] Dynamic subtest gt0-ccs0: SUCCESS (24.292s)
[680.245253] Starting dynamic subtest: gt1-vcs0
[686.412081] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[686.424871] Starting dynamic subtest: gt1-vecs0
[692.585477] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[692.588137] Subtest rc6-idle: SUCCESS (85.183s)
[692.666747] [094/133] (329s left) i915_module_load (reload-no-display)
[692.710632] Starting subtest: reload-no-display
[699.818479] Subtest reload-no-display: SUCCESS (7.105s)
[699.851039] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[699.851748] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[699.854908] [095/133] (321s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[701.444520] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[706.241260] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.802s)
[707.484535] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[707.485727] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[707.489463] [096/133] (314s left) kms_plane_cursor (viewport)
[707.591843] Starting subtest: viewport
[707.596666] Starting dynamic subtest: pipe-A-eDP-1-size-64
[710.072076] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.482s)
[710.131947] Starting dynamic subtest: pipe-A-eDP-1-size-128
[712.572052] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.450s)
[712.631906] Starting dynamic subtest: pipe-A-eDP-1-size-256
[715.041051] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.416s)
[715.391589] Starting dynamic subtest: pipe-B-eDP-1-size-64
[718.465545] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.085s)
[718.526498] Starting dynamic subtest: pipe-B-eDP-1-size-128
[720.910497] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.395s)
[720.972761] Starting dynamic subtest: pipe-B-eDP-1-size-256
[723.454449] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.494s)
[723.813054] Starting dynamic subtest: pipe-C-eDP-1-size-64
[726.687611] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.888s)
[726.724678] Starting dynamic subtest: pipe-C-eDP-1-size-128
[728.964338] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.247s)
[729.003808] Starting dynamic subtest: pipe-C-eDP-1-size-256
[731.097878] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.103s)
[731.440739] Starting dynamic subtest: pipe-D-eDP-1-size-64
[734.214152] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.786s)
[734.253666] Starting dynamic subtest: pipe-D-eDP-1-size-128
[736.306283] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s)
[736.343693] Starting dynamic subtest: pipe-D-eDP-1-size-256
[738.348475] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.014s)
[738.670074] Subtest viewport: SUCCESS (31.079s)
[739.498714] [097/133] (282s left) gem_exec_whisper (basic-fds-forked)
[739.580207] Starting subtest: basic-fds-forked
[765.505841] Subtest basic-fds-forked: SUCCESS (25.920s)
[765.705037] [098/133] (256s left) gem_mmap_gtt (zero-extend)
[765.772969] Subtest zero-extend: SKIP (0.000s)
[765.842340] [099/133] (256s left) kms_chamelium_frames (dp-crc-single)
[766.228751] Subtest dp-crc-single: SKIP (0.000s)
[767.003876] [100/133] (254s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[767.099876] Starting subtest: psr-rgb101010-draw-mmap-wc
[774.137581] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.039s)
[774.254297] [101/133] (247s left) gem_exec_reloc (basic-gtt-read-noreloc)
[774.317378] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[774.395364] [102/133] (247s left) kms_properties (get_properties-sanity-atomic)
[774.475427] Starting subtest: get_properties-sanity-atomic
[774.477718] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[774.553268] [103/133] (247s left) gem_softpin (evict-single-offset)
[774.620529] Starting subtest: evict-single-offset
[803.421014] Subtest evict-single-offset: SUCCESS (28.790s)
[803.509540] [104/133] (218s left) kms_addfb_basic (invalid-set-prop-any)
[803.608390] Starting subtest: invalid-set-prop-any
[803.610827] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[803.750077] [105/133] (218s left) gem_create (create-massive)
[803.810283] Starting subtest: create-massive
[803.812731] Subtest create-massive: SUCCESS (0.000s)
[804.007230] [106/133] (218s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[804.099209] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[804.103661] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[804.199766] [107/133] (218s left) kms_flip (2x-flip-vs-suspend-interruptible)
[804.290202] Starting subtest: 2x-flip-vs-suspend-interruptible
[804.301650] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[804.385178] [108/133] (217s left) gem_exec_fence (syncobj-channel)
[804.845285] Starting subtest: syncobj-channel
[805.865213] Subtest syncobj-channel: SUCCESS (1.015s)
[806.511213] [109/133] (215s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[806.606860] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[810.562124] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.959s)
[811.784355] [110/133] (210s left) gem_eio (in-flight-contexts-immediate)
[811.995997] Starting subtest: in-flight-contexts-immediate
[825.390531] Subtest in-flight-contexts-immediate: SUCCESS (13.390s)
[825.565001] [111/133] (196s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[825.625031] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[825.684250] [112/133] (196s left) kms_async_flips (async-flip-hang)
[825.781749] Starting subtest: async-flip-hang
[826.154004] Starting dynamic subtest: pipe-A-eDP-1
[829.319034] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.163s)
[829.702896] Starting dynamic subtest: pipe-B-eDP-1
[832.839802] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.145s)
[833.224947] Starting dynamic subtest: pipe-C-eDP-1
[836.457238] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.240s)
[836.838845] Starting dynamic subtest: pipe-D-eDP-1
[839.992234] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.161s)
[839.994848] Subtest async-flip-hang: SUCCESS (14.214s)
[841.201933] [113/133] (181s left) kms_psr (fbc-pr-sprite-render)
[841.297658] Starting subtest: fbc-pr-sprite-render
[841.301770] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[841.385658] [114/133] (181s left) gem_flink_basic (bad-open)
[841.446681] Starting subtest: bad-open
[841.448996] Subtest bad-open: SUCCESS (0.000s)
[841.556739] [115/133] (181s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[841.650525] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[841.654724] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[841.743929] [116/133] (180s left) kms_getfb (getfb2-handle-closed)
[841.838347] Starting subtest: getfb2-handle-closed
[841.840650] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[841.968441] [117/133] (180s left) gem_exec_params (no-vebox)
[842.038483] Starting subtest: no-vebox
[842.040834] Subtest no-vebox: SUCCESS (0.002s)
[843.488593] [118/133] (179s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[843.584051] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[843.588395] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[843.695174] [119/133] (179s left) kms_atomic (plane-immutable-zpos)
[843.786530] Starting subtest: plane-immutable-zpos
[843.788808] Starting dynamic subtest: pipe-A-eDP-1
[844.447221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.661s)
[844.449527] Subtest plane-immutable-zpos: SUCCESS (0.662s)
[845.242018] [120/133] (177s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[845.339688] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[845.344003] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[845.427759] [121/133] (177s left) api_intel_allocator (alloc-simple)
[845.490514] Starting subtest: alloc-simple
[845.493144] Subtest alloc-simple: SUCCESS (0.003s)
[845.613967] [122/133] (177s left) gem_exec_whisper (basic-queues-forked)
[845.676350] Starting subtest: basic-queues-forked
[870.451242] Subtest basic-queues-forked: SUCCESS (24.777s)
[870.640620] [123/133] (152s left) i915_drm_fdinfo (busy-idle)
[870.683860] Starting subtest: busy-idle
[870.685868] Starting dynamic subtest: rcs0
[870.707486] Dynamic subtest rcs0: SKIP (0.022s)
[870.720791] Starting dynamic subtest: bcs0
[870.724967] Dynamic subtest bcs0: SKIP (0.000s)
[870.735174] Starting dynamic subtest: vcs0
[870.739224] Dynamic subtest vcs0: SKIP (0.000s)
[870.749824] Starting dynamic subtest: vcs1
[870.753853] Dynamic subtest vcs1: SKIP (0.000s)
[870.766590] Starting dynamic subtest: vecs0
[870.770565] Dynamic subtest vecs0: SKIP (0.000s)
[870.780524] Starting dynamic subtest: ccs0
[870.784365] Dynamic subtest ccs0: SKIP (0.000s)
[870.788205] Subtest busy-idle: SKIP (0.026s)
[870.826867] [124/133] (152s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[870.921421] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[870.923691] Starting dynamic subtest: pipe-A-eDP-1
[870.946167] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[870.959130] Starting dynamic subtest: pipe-B-eDP-1
[870.980761] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[870.990908] Starting dynamic subtest: pipe-C-eDP-1
[871.012322] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[871.022485] Starting dynamic subtest: pipe-D-eDP-1
[871.045651] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[871.049726] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[873.108346] [125/133] (149s left) kms_big_fb (linear-16bpp-rotate-0)
[873.210652] Starting subtest: linear-16bpp-rotate-0
[874.667334] Subtest linear-16bpp-rotate-0: SUCCESS (1.457s)
[874.776403] [126/133] (148s left) gem_exec_schedule (u-semaphore-resolve)
[874.866565] Starting subtest: u-semaphore-resolve
[874.910934] Subtest u-semaphore-resolve: SUCCESS (0.050s)
[875.249240] [127/133] (147s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[875.325786] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[875.327972] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[875.440540] [128/133] (147s left) perf_pmu (busy)
[875.486092] Starting subtest: busy
[875.488470] Starting dynamic subtest: rcs0
[876.074510] Dynamic subtest rcs0: SUCCESS (0.590s)
[876.088017] Starting dynamic subtest: bcs0
[876.647493] Dynamic subtest bcs0: SUCCESS (0.571s)
[876.661381] Starting dynamic subtest: vcs0
[878.363271] Dynamic subtest vcs0: SUCCESS (1.712s)
[878.375676] Starting dynamic subtest: vcs1
[880.410843] Dynamic subtest vcs1: SUCCESS (2.044s)
[880.429769] Starting dynamic subtest: vecs0
[882.395860] Dynamic subtest vecs0: SUCCESS (1.982s)
[882.409711] Starting dynamic subtest: ccs0
[882.971079] Dynamic subtest ccs0: SUCCESS (0.574s)
[882.973774] Subtest busy: SUCCESS (7.488s)
[883.089245] [129/133] (140s left) kms_chamelium_color (ctm-blue-to-red)
[883.185377] Subtest ctm-blue-to-red: SKIP (0.000s)
[883.231883] [130/133] (140s left) kms_content_protection (lic-type-0-hdcp14)
[883.365391] Starting subtest: lic-type-0-hdcp14
[883.370000] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[883.504131] [131/133] (139s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[883.588666] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[883.593140] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[883.678228] [132/133] (139s left) gem_ppgtt (flink-and-close-vma-leak)
[883.739770] Starting subtest: flink-and-close-vma-leak
[883.780592] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[883.909433] [133/133] (139s left) kms_cursor_crc (cursor-sliding-512x170)
[884.224681] Starting subtest: cursor-sliding-512x170
[884.228020] Subtest cursor-sliding-512x170: SKIP (0.001s)
[884.359089] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: sysfs_heartbeat_interval
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_ppgtt
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: core_getstats
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: gem_exec_alignment
results: parsing output: 17/ for test: gem_lmem_swapping
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: gem_exec_await
results: parsing output: 21/ for test: kms_hdr
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: sw_sync
results: parsing output: 29/ for test: kms_setmode
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_draw_crc
results: parsing output: 38/ for test: gem_render_linear_blits
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_color
results: parsing output: 43/ for test: kms_plane_alpha_blend
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: gen7_exec_parse
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: prime_vgem
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: dmabuf_sync_file
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: i915_selftest
results: parsing output: 67/ for test: kms_pm_dc
results: parsing output: 68/ for test: kms_tiled_display
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_vm_create
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: fbdev
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_fbcon_fbt
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: gem_workarounds
results: parsing output: 92/ for test: i915_pm_rc6_residency
results: parsing output: 93/ for test: i915_module_load
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_cursor
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: gem_create
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_pipe_b_c_ivb
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_flink_basic
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_getfb
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_ppgtt
results: parsing output: 132/ for test: kms_cursor_crc
Done.