[58.272374] Initializing watchdogs
[58.272420]   /dev/watchdog0
[58.287247] [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]
[58.292001] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.294594] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.297967] [001/133] (960s left) vgem_basic (second-client)
[58.396602] Starting subtest: second-client
[58.419172] Subtest second-client: SUCCESS (0.022s)
[58.490544] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[58.493610] [002/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[58.629057] Starting subtest: cursorA-vs-flipB-atomic-transitions
[58.633626] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[58.775199] [003/133] (960s left) syncobj_timeline (multi-wait-available-submitted)
[58.839529] Starting subtest: multi-wait-available-submitted
[58.842212] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[58.941646] [004/133] (959s left) kms_invalid_mode (bad-vsync-end)
[59.040089] Starting subtest: bad-vsync-end
[59.042448] Starting dynamic subtest: pipe-A-eDP-1
[59.324328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[59.331183] Starting dynamic subtest: pipe-B-eDP-1
[59.333126] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[59.339285] Starting dynamic subtest: pipe-C-eDP-1
[59.341221] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[59.347671] Starting dynamic subtest: pipe-D-eDP-1
[59.349890] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[59.351788] Subtest bad-vsync-end: SUCCESS (0.292s)
[60.134702] [005/133] (958s left) kms_pm_backlight (fade-with-dpms)
[60.226062] Starting subtest: fade-with-dpms
[62.427387] Starting dynamic subtest: eDP-1
[64.926587] Dynamic subtest eDP-1: SUCCESS (2.494s)
[64.929094] Subtest fade-with-dpms: SUCCESS (4.692s)
[65.743482] [006/133] (953s left) kms_flip (bo-too-big-interruptible)
[65.837688] Starting subtest: bo-too-big-interruptible
[65.840025] Starting dynamic subtest: A-eDP1
[67.212160] Dynamic subtest A-eDP1: SUCCESS (1.371s)
[67.221778] Starting dynamic subtest: B-eDP1
[68.513710] Dynamic subtest B-eDP1: SUCCESS (1.301s)
[68.521922] Starting dynamic subtest: C-eDP1
[69.740739] Dynamic subtest C-eDP1: SUCCESS (1.225s)
[69.748267] Starting dynamic subtest: D-eDP1
[70.983882] Dynamic subtest D-eDP1: SUCCESS (1.240s)
[70.986498] Subtest bo-too-big-interruptible: SUCCESS (5.144s)
[72.187953] [007/133] (946s left) gem_mmap_gtt (basic-read)
[72.256306] Subtest basic-read: SKIP (0.000s)
[72.313438] [008/133] (946s left) gem_softpin (allocator-evict)
[72.372194] Starting subtest: allocator-evict
[72.374484] Starting dynamic subtest: rcs0
[95.396815] Dynamic subtest rcs0: SUCCESS (23.019s)
[95.407714] Starting dynamic subtest: bcs0
[118.946300] Dynamic subtest bcs0: SUCCESS (23.547s)
[118.954201] Starting dynamic subtest: vcs0
[142.775694] Dynamic subtest vcs0: SUCCESS (23.825s)
[142.787578] Starting dynamic subtest: vcs1
[166.361621] Dynamic subtest vcs1: SUCCESS (23.586s)
[166.369979] Starting dynamic subtest: vecs0
[189.928260] Dynamic subtest vecs0: SUCCESS (23.565s)
[189.938937] Starting dynamic subtest: ccs0
[213.383658] Dynamic subtest ccs0: SUCCESS (23.454s)
[213.386515] Subtest allocator-evict: SUCCESS (141.001s)
[213.461205] [009/133] (805s left) gem_render_linear_blits (basic)
[213.569816] Starting subtest: basic
[213.604428] Subtest basic: SUCCESS (0.039s)
[213.691175] [010/133] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[213.797665] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[213.801882] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[213.902986] [011/133] (805s left) kms_psr (psr-primary-mmap-cpu)
[213.995244] Starting subtest: psr-primary-mmap-cpu
[213.997705] Starting dynamic subtest: eDP-1
[215.780817] Dynamic subtest eDP-1: SUCCESS (1.786s)
[215.783140] Subtest psr-primary-mmap-cpu: SUCCESS (1.787s)
[216.641706] [012/133] (802s left) kms_chamelium_edid (hdmi-mode-timings)
[217.025506] Subtest hdmi-mode-timings: SKIP (0.000s)
[217.853089] [013/133] (801s left) gen7_exec_parse (load-register-reg)
[217.918426] Subtest load-register-reg: SKIP (0.000s)
[217.977851] [014/133] (801s left) syncobj_eventfd (invalid-bad-flags)
[218.049340] Starting subtest: invalid-bad-flags
[218.051750] Subtest invalid-bad-flags: SUCCESS (0.000s)
[218.140337] [015/133] (801s left) gem_ctx_exec (basic-invalid-context)
[218.198889] Starting subtest: basic-invalid-context
[218.203308] Subtest basic-invalid-context: SUCCESS (0.005s)
[218.350142] [016/133] (801s left) gem_exec_reloc (basic-write-read-active)
[218.407870] Subtest basic-write-read-active: SKIP (0.000s)
[218.495453] [017/133] (800s left) kms_vblank (wait-busy-hang)
[218.581900] Starting subtest: wait-busy-hang
[218.583858] Starting dynamic subtest: pipe-A-eDP-1
[244.717711] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.134s)
[244.731319] Starting dynamic subtest: pipe-D-eDP-1
[259.670465] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.950s)
[259.672520] Subtest wait-busy-hang: SUCCESS (41.088s)
[260.548305] [018/133] (758s left) kms_chamelium_color (ctm-0-50)
[260.641638] Subtest ctm-0-50: SKIP (0.000s)
[260.687395] [019/133] (758s left) gem_exec_flush (basic-uc-prw-default)
[260.750559] Starting subtest: basic-uc-prw-default
[266.220303] Subtest basic-uc-prw-default: SUCCESS (5.471s)
[266.420357] [020/133] (753s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[266.528820] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[273.135500] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.608s)
[273.264063] [021/133] (746s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[273.357206] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[273.361268] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[273.439687] [022/133] (746s left) kms_plane_scaling (planes-upscale-factor-0-25)
[273.534897] Starting subtest: planes-upscale-factor-0-25
[273.537193] Starting dynamic subtest: pipe-A
[273.595684] Dynamic subtest pipe-A: SUCCESS (0.063s)
[273.606292] Starting dynamic subtest: pipe-B
[274.702428] Dynamic subtest pipe-B: SUCCESS (1.106s)
[274.712917] Starting dynamic subtest: pipe-C
[275.813814] Dynamic subtest pipe-C: SUCCESS (1.111s)
[275.824202] Starting dynamic subtest: pipe-D
[276.960380] Dynamic subtest pipe-D: SUCCESS (1.146s)
[276.962732] Subtest planes-upscale-factor-0-25: SUCCESS (3.428s)
[278.112364] [023/133] (741s left) i915_selftest (perf)
[281.409691] Starting subtest: perf
[281.416774] Starting dynamic subtest: engine_cs
[285.720948] Dynamic subtest engine_cs: SUCCESS (4.313s)
[285.729703] Starting dynamic subtest: request
[292.947478] Dynamic subtest request: SUCCESS (7.225s)
[292.955463] Starting dynamic subtest: migrate
[297.206453] Dynamic subtest migrate: SUCCESS (4.258s)
[297.215923] Starting dynamic subtest: region
[302.817284] Dynamic subtest region: SUCCESS (5.608s)
[302.819798] Subtest perf: SUCCESS (21.409s)
[302.844326] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[302.845309] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[302.848246] [024/133] (716s left) kms_color (legacy-gamma)
[304.379687] Starting subtest: legacy-gamma
[304.381557] Starting dynamic subtest: pipe-A-eDP-1
[305.092874] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[305.100814] Starting dynamic subtest: pipe-B-eDP-1
[306.535219] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[306.542705] Starting dynamic subtest: pipe-C-eDP-1
[307.857714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.323s)
[307.865458] Starting dynamic subtest: pipe-D-eDP-1
[309.208386] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[309.210665] Subtest legacy-gamma: SUCCESS (4.828s)
[310.058147] [FACT kms_color (legacy-gamma)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[310.059535] [FACT kms_color (legacy-gamma)] new: kernel.kmod_is_loaded.i915: true
[310.064339] [025/133] (709s left) perf (gen12-mi-rpc)
[310.209460] Starting subtest: gen12-mi-rpc
[310.211596] Starting dynamic subtest: rcs0
[310.226738] Dynamic subtest rcs0: SUCCESS (0.016s)
[310.228586] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[310.265228] [026/133] (709s left) syncobj_timeline (invalid-wait-bad-flags)
[310.346708] Starting subtest: invalid-wait-bad-flags
[310.349022] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[310.436460] [027/133] (709s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[310.563873] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[310.568343] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[310.706645] [028/133] (709s left) gem_eio (kms)
[310.915961] Starting subtest: kms
[326.450989] Subtest kms: SUCCESS (15.534s)
[326.567022] [029/133] (693s left) gem_exec_fence (long-history)
[326.981895] Starting subtest: long-history
[333.610285] Subtest long-history: SUCCESS (6.629s)
[335.964880] [030/133] (684s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[336.079497] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[336.083800] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[336.190938] [031/133] (683s left) gem_render_copy (y-tiled)
[336.246114] Starting subtest: y-tiled
[336.250749] Subtest y-tiled: SKIP (0.000s)
[336.427873] [032/133] (683s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[336.520403] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[336.522691] Starting dynamic subtest: pipe-A-default-mode
[337.663188] Dynamic subtest pipe-A-default-mode: SKIP (1.137s)
[337.667214] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.139s)
[337.867072] [033/133] (682s left) sw_sync (sync_multi_consumer)
[337.916669] Starting subtest: sync_multi_consumer
[338.351766] Subtest sync_multi_consumer: SUCCESS (0.436s)
[338.414053] [034/133] (681s left) gem_exec_schedule (noreorder-priority)
[338.584343] Starting subtest: noreorder-priority
[338.586759] Starting dynamic subtest: rcs0
[339.714902] Dynamic subtest rcs0: SUCCESS (1.131s)
[339.726319] Starting dynamic subtest: vcs0
[340.860455] Dynamic subtest vcs0: SUCCESS (1.143s)
[340.872973] Starting dynamic subtest: vcs1
[342.933358] Dynamic subtest vcs1: SUCCESS (2.070s)
[342.949430] Starting dynamic subtest: vecs0
[344.918271] Dynamic subtest vecs0: SUCCESS (1.983s)
[344.930211] Starting dynamic subtest: ccs0
[346.062287] Dynamic subtest ccs0: SUCCESS (1.143s)
[346.064989] Subtest noreorder-priority: SUCCESS (7.480s)
[346.247307] [035/133] (673s left) gem_tiled_fence_blits (basic)
[346.314707] Subtest basic: SKIP (0.000s)
[346.388800] [036/133] (673s left) i915_pm_rpm (gem-execbuf-stress)
[348.117530] Starting subtest: gem-execbuf-stress
[348.120586] Starting dynamic subtest: smem0
[360.980069] Dynamic subtest smem0: SUCCESS (12.861s)
[360.991923] Starting dynamic subtest: extra-wait-smem0
[422.523354] Dynamic subtest extra-wait-smem0: SUCCESS (61.537s)
[422.525901] Subtest gem-execbuf-stress: SUCCESS (74.403s)
[422.911087] [037/133] (597s left) kms_addfb_basic (basic-y-tiled-legacy)
[422.970755] Starting subtest: basic-y-tiled-legacy
[422.975178] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[423.120537] [038/133] (597s left) kms_concurrent (multi-plane-atomic-lowres)
[423.216989] Starting subtest: multi-plane-atomic-lowres
[423.219265] Starting dynamic subtest: pipe-A-eDP-1
[423.733178] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.516s)
[423.742899] Starting dynamic subtest: pipe-B-eDP-1
[424.952759] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s)
[424.962348] Starting dynamic subtest: pipe-C-eDP-1
[426.163199] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[426.173704] Starting dynamic subtest: pipe-D-eDP-1
[427.431370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.264s)
[427.433709] Subtest multi-plane-atomic-lowres: SUCCESS (4.213s)
[428.245984] [039/133] (592s left) gem_exec_balancer (bonded-true-hang)
[428.500838] Starting subtest: bonded-true-hang
[428.506306] Subtest bonded-true-hang: SKIP (0.000s)
[428.613930] [040/133] (591s left) prime_self_import (basic-with_two_bos)
[428.655642] Starting subtest: basic-with_two_bos
[428.675541] Subtest basic-with_two_bos: SUCCESS (0.021s)
[428.783470] [041/133] (591s left) gem_partial_pwrite_pread (reads)
[428.846152] Subtest reads: SKIP (0.000s)
[428.907380] [042/133] (591s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[428.966332] Starting subtest: invalid-multi-wait-unsubmitted
[428.968592] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[429.066786] [043/133] (591s left) sysfs_timeslice_duration (idempotent)
[429.119686] Starting subtest: idempotent
[429.122236] Starting dynamic subtest: vecs0
[429.124816] Dynamic subtest vecs0: SUCCESS (0.000s)
[429.137246] Starting dynamic subtest: ccs0
[429.139253] Dynamic subtest ccs0: SUCCESS (0.000s)
[429.147019] Starting dynamic subtest: vcs0
[429.148932] Dynamic subtest vcs0: SUCCESS (0.000s)
[429.156749] Starting dynamic subtest: bcs0
[429.158648] Dynamic subtest bcs0: SUCCESS (0.000s)
[429.166443] Starting dynamic subtest: rcs0
[429.168331] Dynamic subtest rcs0: SUCCESS (0.000s)
[429.176465] Starting dynamic subtest: vcs1
[429.178678] Dynamic subtest vcs1: SUCCESS (0.000s)
[429.180847] Subtest idempotent: SUCCESS (0.005s)
[429.231830] [044/133] (591s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[429.339137] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[429.343276] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[429.436924] [045/133] (591s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[429.531150] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[436.568419] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.039s)
[436.682957] [046/133] (583s left) kms_vblank (query-busy)
[436.787402] Starting subtest: query-busy
[436.789322] Starting dynamic subtest: pipe-A-eDP-1
[438.683271] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.897s)
[438.698079] Starting dynamic subtest: pipe-D-eDP-1
[441.203075] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.518s)
[441.205444] Subtest query-busy: SUCCESS (4.418s)
[442.018820] [047/133] (578s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[442.068389] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[442.070739] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[442.150309] [048/133] (578s left) gem_render_copy (y-tiled-to-vebox-linear)
[442.204403] Starting subtest: y-tiled-to-vebox-linear
[442.209087] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[442.386229] [049/133] (578s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[442.487285] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[442.491532] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[442.612134] [050/133] (578s left) perf_pmu (interrupts)
[442.661075] Starting subtest: interrupts
[443.756858] Subtest interrupts: SUCCESS (1.096s)
[443.874095] [051/133] (577s left) gem_mmap (basic)
[443.947484] Subtest basic: SKIP (0.000s)
[444.011508] [052/133] (576s left) syncobj_timeline (single-wait-all-available-submitted)
[444.071458] Starting subtest: single-wait-all-available-submitted
[444.074038] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[444.179380] [053/133] (576s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[446.117806] Starting subtest: modeset-lpsp-stress-no-wait
[455.856392] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.741s)
[455.965796] [054/133] (565s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[456.028160] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[456.103816] [055/133] (564s left) gem_exec_fence (syncobj-unused-fence)
[456.527895] Starting subtest: syncobj-unused-fence
[456.532860] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[458.019929] [056/133] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[458.121533] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[458.125625] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[458.207376] [057/133] (562s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[458.320628] Starting subtest: yf-tiled-16bpp-rotate-270
[458.325167] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[458.417340] [058/133] (562s left) gem_exec_fence (basic-wait)
[458.600369] Starting subtest: basic-wait
[458.602705] Starting dynamic subtest: rcs0
[458.698897] Dynamic subtest rcs0: SUCCESS (0.101s)
[458.709887] Starting dynamic subtest: bcs0
[458.757504] Dynamic subtest bcs0: SUCCESS (0.057s)
[458.768027] Starting dynamic subtest: vcs0
[458.817145] Dynamic subtest vcs0: SUCCESS (0.057s)
[458.827806] Starting dynamic subtest: vcs1
[458.882236] Dynamic subtest vcs1: SUCCESS (0.063s)
[458.893217] Starting dynamic subtest: vecs0
[458.948233] Dynamic subtest vecs0: SUCCESS (0.064s)
[458.960072] Starting dynamic subtest: ccs0
[459.015682] Dynamic subtest ccs0: SUCCESS (0.065s)
[459.018352] Subtest basic-wait: SUCCESS (0.420s)
[460.972263] [059/133] (560s left) prime_mmap_coherency (ioctl-errors)
[461.033770] Starting subtest: ioctl-errors
[478.731136] Subtest ioctl-errors: SUCCESS (17.697s)
[478.929906] [060/133] (542s left) kms_busy (basic)
[479.061576] Starting subtest: basic
[479.063229] Starting dynamic subtest: flip
[479.692507] Dynamic subtest flip: SUCCESS (0.630s)
[479.704187] Starting dynamic subtest: modeset
[483.155389] Dynamic subtest modeset: SUCCESS (3.463s)
[483.157774] Subtest basic: SUCCESS (4.095s)
[483.951397] [061/133] (537s left) gem_exec_store (cachelines)
[484.010222] Starting subtest: cachelines
[484.012340] Starting dynamic subtest: rcs0
[484.078980] Dynamic subtest rcs0: SUCCESS (0.070s)
[484.089331] Starting dynamic subtest: bcs0
[484.132519] Dynamic subtest bcs0: SUCCESS (0.052s)
[484.141982] Starting dynamic subtest: vcs0
[484.184557] Dynamic subtest vcs0: SUCCESS (0.051s)
[484.194810] Starting dynamic subtest: vcs1
[484.240421] Dynamic subtest vcs1: SUCCESS (0.054s)
[484.251753] Starting dynamic subtest: vecs0
[484.299035] Dynamic subtest vecs0: SUCCESS (0.056s)
[484.312283] Starting dynamic subtest: ccs0
[484.355088] Dynamic subtest ccs0: SUCCESS (0.055s)
[484.357369] Subtest cachelines: SUCCESS (0.347s)
[484.538070] [062/133] (536s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[484.643519] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[485.622617] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.979s)
[485.757239] [063/133] (535s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[485.850115] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[485.852225] Starting dynamic subtest: pipe-A-eDP-1
[485.874053] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[485.887121] Starting dynamic subtest: pipe-B-eDP-1
[485.906612] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[485.916296] Starting dynamic subtest: pipe-C-eDP-1
[485.933665] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[485.942869] Starting dynamic subtest: pipe-D-eDP-1
[485.961053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[485.964370] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[488.120618] [064/133] (533s left) prime_busy (hang-wait)
[488.185548] Starting subtest: hang-wait
[488.187908] Starting dynamic subtest: rcs0
[514.357952] Dynamic subtest rcs0: SUCCESS (26.171s)
[514.366928] Starting dynamic subtest: bcs0
[521.523236] Dynamic subtest bcs0: SUCCESS (7.162s)
[521.534971] Starting dynamic subtest: vcs0
[528.487545] Dynamic subtest vcs0: SUCCESS (6.960s)
[528.497357] Starting dynamic subtest: vcs1
[535.566321] Dynamic subtest vcs1: SUCCESS (7.078s)
[535.578268] Starting dynamic subtest: vecs0
[542.501641] Dynamic subtest vecs0: SUCCESS (6.932s)
[542.511451] Starting dynamic subtest: ccs0
[556.400964] Dynamic subtest ccs0: SUCCESS (13.896s)
[556.403580] Subtest hang-wait: SUCCESS (68.212s)
[556.534318] [065/133] (464s left) kms_flip (flip-vs-panning-vs-hang)
[556.637045] Starting subtest: flip-vs-panning-vs-hang
[556.639127] Starting dynamic subtest: A-eDP1
[607.364527] Dynamic subtest A-eDP1: SUCCESS (50.728s)
[607.376387] Starting dynamic subtest: D-eDP1
[647.359237] Dynamic subtest D-eDP1: SUCCESS (39.992s)
[647.361447] Subtest flip-vs-panning-vs-hang: SUCCESS (90.724s)
[648.499134] [066/133] (373s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[648.605143] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[648.607605] Starting dynamic subtest: pipe-A-eDP-1
[648.878596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.241s)
[648.889108] Starting dynamic subtest: pipe-B-eDP-1
[650.197874] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s)
[650.209128] Starting dynamic subtest: pipe-C-eDP-1
[651.484044] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.289s)
[651.492752] Starting dynamic subtest: pipe-D-eDP-1
[652.675780] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.188s)
[652.678075] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.040s)
[653.802753] [067/133] (367s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[653.871789] Subtest tiled-to-tiled: SKIP (0.000s)
[653.943436] [068/133] (367s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[654.039944] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[654.044067] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[654.132948] [069/133] (367s left) gem_ctx_isolation (clean)
[654.203774] Starting subtest: clean
[654.206087] Starting dynamic subtest: rcs0
[654.246323] Dynamic subtest rcs0: SUCCESS (0.042s)
[654.257329] Starting dynamic subtest: bcs0
[654.305386] Dynamic subtest bcs0: SUCCESS (0.058s)
[654.316390] Starting dynamic subtest: vcs0
[654.369120] Dynamic subtest vcs0: SUCCESS (0.063s)
[654.380686] Starting dynamic subtest: vcs1
[655.890187] Dynamic subtest vcs1: SUCCESS (1.520s)
[655.902179] Starting dynamic subtest: vecs0
[657.878159] Dynamic subtest vecs0: SUCCESS (1.987s)
[657.889910] Starting dynamic subtest: ccs0
[659.956917] Dynamic subtest ccs0: SUCCESS (2.078s)
[659.959168] Subtest clean: SUCCESS (5.753s)
[660.193904] [070/133] (361s left) perf_pmu (init-sema)
[660.235947] Starting subtest: init-sema
[660.238369] Starting dynamic subtest: rcs0
[660.240779] Dynamic subtest rcs0: SUCCESS (0.002s)
[660.251881] Starting dynamic subtest: bcs0
[660.253773] Dynamic subtest bcs0: SUCCESS (0.000s)
[660.262546] Starting dynamic subtest: vcs0
[660.264421] Dynamic subtest vcs0: SUCCESS (0.001s)
[660.274214] Starting dynamic subtest: vcs1
[660.276334] Dynamic subtest vcs1: SUCCESS (0.001s)
[660.285601] Starting dynamic subtest: vecs0
[660.287493] Dynamic subtest vecs0: SUCCESS (0.000s)
[660.296531] Starting dynamic subtest: ccs0
[660.298699] Dynamic subtest ccs0: SUCCESS (0.000s)
[660.300888] Subtest init-sema: SUCCESS (0.008s)
[660.341409] [071/133] (361s left) kms_force_connector_basic (prune-stale-modes)
[660.414230] Starting subtest: prune-stale-modes
[660.869646] Subtest prune-stale-modes: SUCCESS (0.456s)
[661.010961] [072/133] (360s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[661.081283] Subtest no-spare-fences-busy: SKIP (0.000s)
[661.141196] [073/133] (360s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[661.226474] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[661.230126] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[662.335818] [074/133] (359s left) i915_pm_freq_api (freq-suspend)
[662.402769] Starting subtest: freq-suspend
[662.405182] Starting dynamic subtest: gt0
[678.267639] Dynamic subtest gt0: SUCCESS (1.333s)
[678.284801] Starting dynamic subtest: gt1
[694.283327] Dynamic subtest gt1: SUCCESS (1.236s)
[694.285521] Subtest freq-suspend: SUCCESS (2.573s)
[695.366911] [075/133] (327s left) kms_cursor_edge_walk (256x256-top-bottom)
[695.488168] Starting subtest: 256x256-top-bottom
[695.490328] Starting dynamic subtest: pipe-A-eDP-1
[698.986853] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s)
[698.997524] Starting dynamic subtest: pipe-D-eDP-1
[702.212394] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.190s)
[702.214855] Subtest 256x256-top-bottom: SUCCESS (6.638s)
[703.077121] [076/133] (319s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[703.178986] Starting subtest: psr-rgb565-draw-pwrite
[710.181874] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.971s)
[710.296056] [077/133] (312s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[710.490153] Starting subtest: cursor-rapid-movement-64x64
[710.495000] Starting dynamic subtest: pipe-A-eDP-1
[711.046164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[711.076243] Starting dynamic subtest: pipe-D-eDP-1
[712.296948] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[712.299478] Subtest cursor-rapid-movement-64x64: SUCCESS (1.800s)
[713.113729] [078/133] (309s left) gem_ctx_persistence (legacy-engines-queued)
[713.163860] Starting subtest: legacy-engines-queued
[713.166248] Starting dynamic subtest: render
[713.231960] Dynamic subtest render: SUCCESS (0.067s)
[713.245679] Starting dynamic subtest: bsd1
[715.167418] Dynamic subtest bsd1: SUCCESS (1.928s)
[715.180157] Starting dynamic subtest: bsd2
[717.149742] Dynamic subtest bsd2: SUCCESS (1.975s)
[717.165771] Starting dynamic subtest: blt
[717.186762] Dynamic subtest blt: SUCCESS (0.035s)
[717.199999] Starting dynamic subtest: vebox
[719.196692] Dynamic subtest vebox: SUCCESS (2.004s)
[719.199401] Subtest legacy-engines-queued: SUCCESS (6.022s)
[719.315014] [079/133] (303s left) kms_flip (2x-flip-vs-fences-interruptible)
[719.412899] Starting subtest: 2x-flip-vs-fences-interruptible
[719.417252] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[719.518642] [080/133] (303s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[719.623206] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[719.625431] Starting dynamic subtest: pipe-A-eDP-1
[719.707289] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[719.718269] Starting dynamic subtest: pipe-B-eDP-1
[720.878304] Dynamic subtest pipe-B-eDP-1: SKIP (1.168s)
[720.882874] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.258s)
[722.044444] [081/133] (301s left) syncobj_timeline (etime-multi-wait-submitted)
[722.099212] Starting subtest: etime-multi-wait-submitted
[722.204268] Subtest etime-multi-wait-submitted: SUCCESS (0.104s)
[722.281518] [082/133] (300s left) gem_render_copy (linear-to-vebox-yf-tiled)
[722.343745] Starting subtest: linear-to-vebox-yf-tiled
[722.347924] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[722.546299] [083/133] (300s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[722.656971] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[722.659222] Starting dynamic subtest: pipe-A-eDP-1
[722.679614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[722.692919] Starting dynamic subtest: pipe-B-eDP-1
[722.712344] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[722.723267] Starting dynamic subtest: pipe-C-eDP-1
[722.742732] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[722.753463] Starting dynamic subtest: pipe-D-eDP-1
[722.772393] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[722.774543] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.100s)
[725.039799] [084/133] (298s left) kms_psr (psr-cursor-render)
[725.134265] Starting subtest: psr-cursor-render
[725.136387] Starting dynamic subtest: eDP-1
[726.895337] Dynamic subtest eDP-1: SUCCESS (1.761s)
[726.897681] Subtest psr-cursor-render: SUCCESS (1.762s)
[727.728278] [085/133] (295s left) kms_atomic (atomic-invalid-params)
[727.823563] Starting subtest: atomic-invalid-params
[727.826000] Starting dynamic subtest: pipe-A-eDP-1
[728.210458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.386s)
[728.212601] Subtest atomic-invalid-params: SUCCESS (0.387s)
[729.045899] [086/133] (294s left) gem_exec_schedule (semaphore-power)
[729.232250] Subtest semaphore-power: SKIP (0.000s)
[729.422590] [087/133] (294s left) api_intel_allocator (default-alignment)
[729.480142] Starting subtest: default-alignment
[729.482329] Subtest default-alignment: SUCCESS (0.003s)
[729.597935] [088/133] (293s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[729.692395] Starting subtest: yf-tiled-32bpp-rotate-90
[729.696368] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[729.781665] [089/133] (293s left) gem_mmap_wc (copy)
[729.837372] Subtest copy: SKIP (0.000s)
[729.904107] [090/133] (293s left) gem_exec_whisper (basic-queues-forked-all)
[729.960570] Starting subtest: basic-queues-forked-all
[749.473808] Subtest basic-queues-forked-all: SUCCESS (19.511s)
[749.661564] [091/133] (273s left) kms_plane_scaling (intel-max-src-size)
[749.763992] Starting subtest: intel-max-src-size
[749.770433] Subtest intel-max-src-size: SKIP (0.000s)
[749.852923] [092/133] (273s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[749.954794] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[756.877405] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.924s)
[757.030003] [093/133] (266s left) kms_psr (fbc-psr2-sprite-render)
[757.136427] Starting subtest: fbc-psr2-sprite-render
[757.138741] Starting dynamic subtest: eDP-1
[757.143109] Dynamic subtest eDP-1: SKIP (0.000s)
[757.147435] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[757.212548] [094/133] (266s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[757.312302] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[757.317066] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[757.408556] [095/133] (266s left) gem_pread (self)
[757.466399] Subtest self: SKIP (0.000s)
[757.539566] [096/133] (266s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[757.636802] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[757.641055] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[757.729275] [097/133] (266s left) kms_prop_blob (invalid-set-prop)
[757.789380] Starting subtest: invalid-set-prop
[757.791276] Subtest invalid-set-prop: SUCCESS (0.000s)
[757.890752] [098/133] (266s left) fbdev (unaligned-write)
[757.938707] Starting subtest: unaligned-write
[758.038088] Subtest unaligned-write: SUCCESS (0.098s)
[758.102069] [099/133] (265s left) kms_plane (pixel-format-x-tiled-modifier)
[758.199431] Starting subtest: pixel-format-x-tiled-modifier
[758.224419] Starting dynamic subtest: pipe-A-plane-0
[758.869880] Dynamic subtest pipe-A-plane-0: SUCCESS (0.645s)
[758.881225] Starting dynamic subtest: pipe-A-plane-3
[759.302445] Dynamic subtest pipe-A-plane-3: SUCCESS (0.431s)
[759.314833] Starting dynamic subtest: pipe-A-plane-5
[759.319418] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[760.389459] Starting dynamic subtest: pipe-B-plane-0
[761.069398] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[761.082820] Starting dynamic subtest: pipe-B-plane-3
[761.491708] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[761.502239] Starting dynamic subtest: pipe-B-plane-5
[761.505967] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[761.809630] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.609s)
[762.628760] [100/133] (261s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[762.708282] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[762.785286] [101/133] (261s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[762.882780] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[766.904321] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.024s)
[768.044666] [102/133] (256s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[768.142608] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[768.155320] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[768.231450] [103/133] (255s left) core_getversion (all-cards)
[768.273943] Starting subtest: all-cards
[768.280891] Subtest all-cards: SUCCESS (0.011s)
[768.332022] [104/133] (255s left) gem_exec_reloc (basic-wc-read-noreloc)
[768.384740] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[768.447325] [105/133] (255s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[768.551975] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[768.556487] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[768.663135] [106/133] (255s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[768.768687] Starting subtest: x-tiled-16bpp-rotate-90
[768.788332] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[768.903346] [107/133] (255s left) kms_feature_discovery (display-1x)
[768.991858] Starting subtest: display-1x
[768.993654] Subtest display-1x: SUCCESS (0.000s)
[769.064724] [108/133] (255s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[769.176911] Starting subtest: cursorA-vs-flipB-varying-size
[769.181117] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[769.336243] [109/133] (255s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[769.432636] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[769.436340] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[769.518026] [110/133] (254s left) kms_psr2_su (page_flip-xrgb8888)
[769.566217] Subtest page_flip-XRGB8888: SKIP (0.000s)
[769.634916] [111/133] (254s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[769.738236] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[769.741502] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[769.832795] [112/133] (254s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[769.928229] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[774.345679] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.418s)
[775.541860] [113/133] (249s left) i915_drm_fdinfo (isolation)
[775.580945] Starting subtest: isolation
[775.583458] Starting dynamic subtest: rcs0
[775.600090] Dynamic subtest rcs0: SKIP (0.017s)
[775.609881] Starting dynamic subtest: bcs0
[775.618887] Dynamic subtest bcs0: SKIP (0.018s)
[775.629047] Starting dynamic subtest: vcs0
[775.633146] Dynamic subtest vcs0: SKIP (0.000s)
[775.643272] Starting dynamic subtest: vcs1
[775.647669] Dynamic subtest vcs1: SKIP (0.000s)
[775.657313] Starting dynamic subtest: vecs0
[775.661470] Dynamic subtest vecs0: SKIP (0.001s)
[775.671075] Starting dynamic subtest: ccs0
[775.675199] Dynamic subtest ccs0: SKIP (0.000s)
[775.679321] Subtest isolation: SKIP (0.042s)
[775.716949] [114/133] (248s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[775.804547] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[775.808452] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[775.900628] [115/133] (248s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[775.994479] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[780.395205] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.402s)
[781.552739] [116/133] (243s left) kms_big_fb (4-tiled-addfb)
[781.651541] Starting subtest: 4-tiled-addfb
[781.653929] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[781.738461] [117/133] (242s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[781.843805] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[781.848129] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[781.950899] [118/133] (242s left) kms_cursor_crc (cursor-offscreen-512x512)
[782.208708] Starting subtest: cursor-offscreen-512x512
[782.213106] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[782.356399] [119/133] (242s left) gem_mmap (bad-size)
[782.416962] Subtest bad-size: SKIP (0.000s)
[782.481540] [120/133] (242s left) gem_mmap_offset (blt-coherency)
[782.544914] Starting subtest: blt-coherency
[782.549581] Subtest blt-coherency: SUCCESS (0.007s)
[782.676435] [121/133] (242s left) api_intel_bb (simple-bb-ctx)
[782.726490] Starting subtest: simple-bb-ctx
[782.733257] Subtest simple-bb-ctx: SUCCESS (0.008s)
[782.849253] [122/133] (242s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[782.938183] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[782.941478] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[783.036433] [123/133] (241s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[783.122986] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[783.126440] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[783.190734] [124/133] (241s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[783.271648] Starting subtest: fbc-pr-sprite-mmap-gtt
[783.275345] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[783.345446] [125/133] (241s left) kms_psr (pr-primary-mmap-gtt)
[783.431784] Starting subtest: pr-primary-mmap-gtt
[783.435533] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[783.507273] [126/133] (241s left) kms_pipe_crc_basic (suspend-read-crc)
[783.600688] Starting subtest: suspend-read-crc
[783.602625] Starting dynamic subtest: pipe-A-eDP-1
[801.183251] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.521s)
[801.195510] Starting dynamic subtest: pipe-B-eDP-1
[819.169865] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.103s)
[819.182147] Starting dynamic subtest: pipe-C-eDP-1
[837.127166] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.017s)
[837.141500] Starting dynamic subtest: pipe-D-eDP-1
[855.136215] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.097s)
[855.138559] Subtest suspend-read-crc: SUCCESS (11.744s)
[855.980725] [127/133] (169s left) kms_chamelium_hpd (hdmi-hpd-storm)
[856.382544] Subtest hdmi-hpd-storm: SKIP (0.000s)
[857.166909] [128/133] (168s left) gem_wait (write-busy)
[857.230473] Starting subtest: write-busy
[857.232834] Starting dynamic subtest: all-engines
[857.836862] Dynamic subtest all-engines: SUCCESS (0.606s)
[857.855324] Starting dynamic subtest: rcs0
[858.390474] Dynamic subtest rcs0: SUCCESS (0.551s)
[858.408586] Starting dynamic subtest: bcs0
[858.941515] Dynamic subtest bcs0: SUCCESS (0.548s)
[858.959723] Starting dynamic subtest: vcs0
[860.954082] Dynamic subtest vcs0: SUCCESS (2.004s)
[860.972219] Starting dynamic subtest: vcs1
[862.938088] Dynamic subtest vcs1: SUCCESS (1.976s)
[862.955948] Starting dynamic subtest: vecs0
[864.922680] Dynamic subtest vecs0: SUCCESS (1.978s)
[864.939745] Starting dynamic subtest: ccs0
[865.472129] Dynamic subtest ccs0: SUCCESS (0.547s)
[865.474546] Subtest write-busy: SUCCESS (8.222s)
[865.681696] [129/133] (159s left) gem_userptr_blits (relocations)
[865.753519] Starting subtest: relocations
[865.757849] Subtest relocations: SKIP (0.000s)
[865.878432] [130/133] (159s left) gem_eio (wait-immediate)
[866.088046] Starting subtest: wait-immediate
[866.425201] Subtest wait-immediate: SUCCESS (0.338s)
[866.544665] [131/133] (158s left) gem_userptr_blits (create-destroy-unsync)
[866.602617] Subtest create-destroy-unsync: SKIP (0.000s)
[866.727097] [132/133] (158s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[866.819851] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[874.195403] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.368s)
[874.337812] [133/133] (151s left) gem_exec_reloc (basic-wc)
[874.401647] Subtest basic-wc: SKIP (0.000s)
[874.472318] Closing watchdogs
results: parsing output: 0/ for test: vgem_basic
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_invalid_mode
results: parsing output: 4/ for test: kms_pm_backlight
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: gem_render_linear_blits
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_chamelium_edid
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: syncobj_eventfd
results: parsing output: 14/ for test: gem_ctx_exec
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: kms_chamelium_color
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: i915_selftest
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_tiled_fence_blits
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_concurrent
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: prime_self_import
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: sysfs_timeslice_duration
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_mmap
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: prime_mmap_coherency
results: parsing output: 59/ for test: kms_busy
results: parsing output: 60/ for test: gem_exec_store
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: prime_busy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_set_tiling_vs_blt
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: gem_ctx_isolation
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_force_connector_basic
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: i915_pm_freq_api
results: parsing output: 74/ for test: kms_cursor_edge_walk
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_pread
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_prop_blob
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: core_getversion
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_feature_discovery
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_psr2_su
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: gem_mmap
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_joiner
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: gem_wait
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_reloc
Done.