[57.421354] Initializing watchdogs
[57.421401]   /dev/watchdog0
[57.435237] [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.439611] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.441952] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.445463] [001/133] (960s left) kms_psr (psr-cursor-render)
[57.575760] Starting subtest: psr-cursor-render
[57.577970] Starting dynamic subtest: eDP-1
[59.351948] Dynamic subtest eDP-1: SUCCESS (1.770s)
[59.354409] Subtest psr-cursor-render: SUCCESS (1.772s)
[60.233451] [002/133] (957s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[60.329944] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[60.445193] [003/133] (957s left) kms_chamelium_audio (hdmi-audio)
[60.840268] Subtest hdmi-audio: SKIP (0.000s)
[61.637092] [004/133] (956s left) gem_lmem_swapping (basic)
[61.690069] Subtest basic: SKIP (0.000s)
[61.734021] [005/133] (956s left) kms_sequence (get-busy)
[61.837207] Starting subtest: get-busy
[61.839601] Starting dynamic subtest: pipe-A-eDP-1
[63.783898] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[63.793067] Starting dynamic subtest: pipe-B-eDP-1
[66.372296] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.584s)
[66.380903] Starting dynamic subtest: pipe-C-eDP-1
[68.991076] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.619s)
[69.000722] Starting dynamic subtest: pipe-D-eDP-1
[71.614592] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s)
[71.616894] Subtest get-busy: SUCCESS (9.772s)
[72.412830] [006/133] (945s left) gem_mmap_offset (mmap-unmap)
[72.469075] Starting subtest: mmap-unmap
[72.471146] Starting dynamic subtest: smem0
[95.099664] Dynamic subtest smem0: SUCCESS (22.627s)
[95.102536] Subtest mmap-unmap: SUCCESS (22.627s)
[95.217885] [007/133] (922s left) gem_mmap (basic)
[95.278803] Subtest basic: SKIP (0.000s)
[95.330945] [008/133] (922s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[95.433421] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[95.435695] Starting dynamic subtest: pipe-A-eDP-1
[95.459041] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[95.467778] Starting dynamic subtest: pipe-B-eDP-1
[95.489124] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[95.495490] Starting dynamic subtest: pipe-C-eDP-1
[95.516127] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[95.522501] Starting dynamic subtest: pipe-D-eDP-1
[95.543147] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[95.547073] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[97.661308] [009/133] (920s left) gem_ctx_bad_destroy (invalid-ctx)
[97.716619] Starting subtest: invalid-ctx
[97.719080] Subtest invalid-ctx: SUCCESS (0.000s)
[97.792886] [010/133] (920s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[97.892470] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[104.766949] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.876s)
[104.899774] [011/133] (913s left) kms_flip (basic-flip-vs-modeset)
[104.987059] Starting subtest: basic-flip-vs-modeset
[104.989373] Starting dynamic subtest: A-eDP1
[107.575891] Dynamic subtest A-eDP1: SUCCESS (2.585s)
[107.584612] Starting dynamic subtest: B-eDP1
[109.737321] Dynamic subtest B-eDP1: SUCCESS (2.162s)
[109.744213] Starting dynamic subtest: C-eDP1
[111.908938] Dynamic subtest C-eDP1: SUCCESS (2.172s)
[111.917847] Starting dynamic subtest: D-eDP1
[114.086827] Dynamic subtest D-eDP1: SUCCESS (2.177s)
[114.089264] Subtest basic-flip-vs-modeset: SUCCESS (9.102s)
[114.882859] [012/133] (903s left) kms_vblank (wait-forked)
[114.979999] Starting subtest: wait-forked
[114.981963] Starting dynamic subtest: pipe-A-eDP-1
[116.802732] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s)
[116.815052] Starting dynamic subtest: pipe-D-eDP-1
[119.284530] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.479s)
[119.286711] Subtest wait-forked: SUCCESS (4.305s)
[120.160492] [013/133] (898s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[120.266074] Starting subtest: yf-tiled-addfb-size-offset-overflow
[120.270598] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[120.381489] [014/133] (898s left) syncobj_wait (wait-all-complex)
[120.437947] Starting subtest: wait-all-complex
[120.654892] Subtest wait-all-complex: SUCCESS (0.216s)
[120.725265] [015/133] (897s left) gem_wait (busy)
[120.786918] Starting subtest: busy
[120.789324] Starting dynamic subtest: all-engines
[121.877341] Dynamic subtest all-engines: SUCCESS (1.088s)
[121.886034] Starting dynamic subtest: rcs0
[122.418874] Dynamic subtest rcs0: SUCCESS (0.542s)
[122.428939] Starting dynamic subtest: bcs0
[122.958695] Dynamic subtest bcs0: SUCCESS (0.539s)
[122.968359] Starting dynamic subtest: vcs0
[124.887038] Dynamic subtest vcs0: SUCCESS (1.926s)
[124.897071] Starting dynamic subtest: vcs1
[126.933427] Dynamic subtest vcs1: SUCCESS (2.045s)
[126.943705] Starting dynamic subtest: vecs0
[128.916905] Dynamic subtest vecs0: SUCCESS (1.983s)
[128.925930] Starting dynamic subtest: ccs0
[129.456290] Dynamic subtest ccs0: SUCCESS (0.540s)
[129.459098] Subtest busy: SUCCESS (8.669s)
[129.650952] [016/133] (888s left) syncobj_timeline (transfer-timeline-point)
[129.712882] Starting subtest: transfer-timeline-point
[129.715471] Subtest transfer-timeline-point: SUCCESS (0.001s)
[129.812856] [017/133] (888s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[129.903621] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[136.734139] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.833s)
[136.871888] [018/133] (881s left) kms_content_protection (uevent)
[137.019494] Starting subtest: uevent
[137.024102] Subtest uevent: SKIP (0.000s)
[137.138104] [019/133] (881s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[137.235851] Starting subtest: 4-tiled-32bpp-rotate-180
[138.559604] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.324s)
[138.678221] [020/133] (880s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[138.792328] Starting subtest: cursor-vs-flip-atomic
[168.063330] Subtest cursor-vs-flip-atomic: SUCCESS (29.267s)
[168.901907] [021/133] (849s left) gem_userptr_blits (create-destroy-sync)
[168.980709] Starting subtest: create-destroy-sync
[174.001145] Subtest create-destroy-sync: SUCCESS (5.019s)
[174.115758] [022/133] (844s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[174.209518] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[174.211890] Starting dynamic subtest: pipe-A-eDP-1
[174.221305] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.230541] Starting dynamic subtest: pipe-B-eDP-1
[174.239545] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[174.246709] Starting dynamic subtest: pipe-C-eDP-1
[174.255183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[174.261597] Starting dynamic subtest: pipe-D-eDP-1
[174.269941] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[174.274007] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[176.371318] [023/133] (842s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[176.425970] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[176.428384] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[176.525949] [024/133] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[176.640232] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[183.212937] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.575s)
[183.361297] [025/133] (835s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[183.480349] Starting subtest: flip-vs-cursor-atomic-transitions
[191.029668] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.548s)
[191.833130] [026/133] (827s left) prime_mmap (test_aperture_limit)
[191.902996] Starting subtest: test_aperture_limit
[191.904847] Starting dynamic subtest: test_aperture_limit-smem
[191.911500] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[191.915681] Subtest test_aperture_limit: SKIP (0.008s)
[192.018352] [027/133] (826s left) gem_ctx_param (set-priority-range)
[192.081312] Starting subtest: set-priority-range
[192.094241] Subtest set-priority-range: SUCCESS (0.016s)
[192.186918] [028/133] (826s left) perf_pmu (multi-client)
[192.234056] Starting subtest: multi-client
[192.236409] Starting dynamic subtest: rcs0
[193.296836] Dynamic subtest rcs0: SUCCESS (1.062s)
[193.306693] Starting dynamic subtest: bcs0
[194.344640] Dynamic subtest bcs0: SUCCESS (1.047s)
[194.355988] Starting dynamic subtest: vcs0
[195.399097] Dynamic subtest vcs0: SUCCESS (1.051s)
[195.409540] Starting dynamic subtest: vcs1
[196.939472] Dynamic subtest vcs1: SUCCESS (1.539s)
[196.950253] Starting dynamic subtest: vecs0
[198.926391] Dynamic subtest vecs0: SUCCESS (1.985s)
[198.936862] Starting dynamic subtest: ccs0
[200.910087] Dynamic subtest ccs0: SUCCESS (1.981s)
[200.912782] Subtest multi-client: SUCCESS (8.677s)
[201.023030] [029/133] (818s left) kms_hdr (static-toggle-suspend)
[201.120941] Starting subtest: static-toggle-suspend
[201.127353] Subtest static-toggle-suspend: SKIP (0.000s)
[201.224929] [030/133] (817s left) kms_cursor_edge_walk (256x256-right-edge)
[201.335690] Starting subtest: 256x256-right-edge
[201.337794] Starting dynamic subtest: pipe-A-eDP-1
[204.796398] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[204.804795] Starting dynamic subtest: pipe-D-eDP-1
[207.908354] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[207.910591] Subtest 256x256-right-edge: SUCCESS (6.572s)
[208.711958] [031/133] (810s left) i915_pm_rpm (sysfs-read)
[210.231038] Starting subtest: sysfs-read
[211.387756] Subtest sysfs-read: SUCCESS (1.154s)
[211.751304] [032/133] (807s left) gem_linear_blits (normal)
[212.079398] Starting subtest: normal
[215.628842] Subtest normal: SUCCESS (3.549s)
[215.773833] [033/133] (803s left) kms_setmode (invalid-clone-single-crtc-stealing)
[215.863276] Starting subtest: invalid-clone-single-crtc-stealing
[215.869600] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[215.942285] [034/133] (803s left) gem_exec_schedule (independent)
[216.028866] Starting subtest: independent
[216.030771] Starting dynamic subtest: rcs0
[217.944388] Dynamic subtest rcs0: SUCCESS (1.920s)
[217.955439] Starting dynamic subtest: vcs0
[219.933221] Dynamic subtest vcs0: SUCCESS (1.987s)
[219.942787] Starting dynamic subtest: vcs1
[221.855431] Dynamic subtest vcs1: SUCCESS (1.920s)
[221.867294] Starting dynamic subtest: vecs0
[223.904368] Dynamic subtest vecs0: SUCCESS (2.047s)
[223.914107] Starting dynamic subtest: ccs0
[225.941673] Dynamic subtest ccs0: SUCCESS (2.035s)
[225.944351] Subtest independent: SUCCESS (9.919s)
[226.244696] [035/133] (793s left) dumb_buffer (create-valid-dumb)
[226.301294] Starting subtest: create-valid-dumb
[226.303483] Subtest create-valid-dumb: SUCCESS (0.000s)
[226.389987] [036/133] (792s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[226.770392] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[227.550764] [037/133] (791s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[227.657756] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[228.471743] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.816s)
[228.632128] [038/133] (790s left) kms_getfb (getfb-addfb-different-handles)
[228.732235] Starting subtest: getfb-addfb-different-handles
[228.734431] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[228.829225] [039/133] (790s left) kms_plane_scaling (planes-upscale-factor-0-25)
[228.926868] Starting subtest: planes-upscale-factor-0-25
[228.928988] Starting dynamic subtest: pipe-A
[228.986369] Dynamic subtest pipe-A: SUCCESS (0.061s)
[228.994793] Starting dynamic subtest: pipe-B
[230.101347] Dynamic subtest pipe-B: SUCCESS (1.115s)
[230.111908] Starting dynamic subtest: pipe-C
[231.211606] Dynamic subtest pipe-C: SUCCESS (1.108s)
[231.221250] Starting dynamic subtest: pipe-D
[232.337451] Dynamic subtest pipe-D: SUCCESS (1.125s)
[232.339887] Subtest planes-upscale-factor-0-25: SUCCESS (3.413s)
[233.493412] [040/133] (786s left) kms_lease (lease-get)
[233.584030] Starting subtest: lease-get
[233.586213] Starting dynamic subtest: pipe-A-eDP-1
[233.588503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[233.597107] Starting dynamic subtest: pipe-B-eDP-1
[233.599024] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[233.606537] Starting dynamic subtest: pipe-C-eDP-1
[233.608451] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[233.615756] Starting dynamic subtest: pipe-D-eDP-1
[233.617682] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[233.619577] Subtest lease-get: SUCCESS (0.008s)
[233.713536] [041/133] (785s left) kms_addfb_basic (size-max)
[233.804853] Starting subtest: size-max
[233.806979] Subtest size-max: SUCCESS (0.000s)
[233.893859] [042/133] (785s left) gem_exec_schedule (u-semaphore-user)
[233.958737] Starting subtest: u-semaphore-user
[234.011783] Subtest u-semaphore-user: SUCCESS (0.060s)
[235.962246] [043/133] (783s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[236.065162] Starting subtest: fbc-rgb101010-draw-mmap-wc
[240.680932] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.618s)
[241.815994] [044/133] (777s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[241.930245] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[241.934266] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[241.998083] [045/133] (777s left) perf (blocking-parameterized)
[242.150285] Starting subtest: blocking-parameterized
[262.170470] Subtest blocking-parameterized: SUCCESS (20.020s)
[262.221181] [046/133] (757s left) gem_lmem_swapping (parallel-random-verify)
[262.268926] Subtest parallel-random-verify: SKIP (0.000s)
[262.351383] [047/133] (757s left) gem_create (hog-create)
[262.405183] Starting subtest: hog-create
[262.407492] Starting dynamic subtest: smem0
[295.894318] Dynamic subtest smem0: SUCCESS (33.486s)
[295.896995] Subtest hog-create: SUCCESS (33.489s)
[296.096170] [048/133] (723s left) api_intel_bb (intel-bb-blit-x)
[296.160456] Starting subtest: intel-bb-blit-x
[299.897053] Subtest intel-bb-blit-x: SUCCESS (3.737s)
[299.999798] [049/133] (719s left) kms_pipe_crc_basic (suspend-read-crc)
[300.099873] Starting subtest: suspend-read-crc
[300.102195] Starting dynamic subtest: pipe-A-eDP-1
[318.113739] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.709s)
[318.123047] Starting dynamic subtest: pipe-B-eDP-1
[336.082374] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.174s)
[336.092209] Starting dynamic subtest: pipe-C-eDP-1
[354.045800] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.023s)
[354.056184] Starting dynamic subtest: pipe-D-eDP-1
[372.047277] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[372.049737] Subtest suspend-read-crc: SUCCESS (12.040s)
[372.887013] [050/133] (647s left) gem_exec_whisper (basic-fds-priority-all)
[372.979886] Starting subtest: basic-fds-priority-all
[395.171439] Subtest basic-fds-priority-all: SUCCESS (22.099s)
[395.357046] [051/133] (624s left) gem_exec_balancer (full)
[395.421510] Starting subtest: full
[400.568879] Subtest full: SUCCESS (5.142s)
[400.885321] [052/133] (619s left) kms_dp_link_training (uhbr-sst)
[400.985669] Starting subtest: uhbr-sst
[400.994140] Subtest uhbr-sst: SKIP (0.000s)
[401.056608] [053/133] (618s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[401.155339] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[401.160032] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[401.263065] [054/133] (618s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[401.349950] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[401.354284] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[402.520432] [055/133] (617s left) gem_exec_flush (basic-wb-pro-default)
[402.588576] Starting subtest: basic-wb-pro-default
[408.052850] Subtest basic-wb-pro-default: SUCCESS (5.466s)
[408.253486] [056/133] (611s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[408.373060] Starting subtest: flip-vs-cursor-toggle
[416.879052] Subtest flip-vs-cursor-toggle: SUCCESS (8.506s)
[417.745264] [057/133] (602s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[417.846873] Starting subtest: fbc-pr-cursor-mmap-cpu
[417.850812] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[417.921004] [058/133] (602s left) drm_read (empty-block)
[418.077505] Starting subtest: empty-block
[419.085493] Subtest empty-block: SUCCESS (1.001s)
[419.205562] [059/133] (601s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[419.292046] Starting subtest: fbc-pr-sprite-mmap-gtt
[419.296058] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[419.361920] [060/133] (600s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[419.466739] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[423.418991] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.955s)
[424.548897] [061/133] (595s left) vgem_basic (bad-handle)
[424.717883] Starting subtest: bad-handle
[424.719772] Subtest bad-handle: SUCCESS (0.000s)
[424.770168] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[424.773425] [062/133] (595s left) gem_exec_params (mmapped)
[424.824351] Starting subtest: mmapped
[424.829346] Subtest mmapped: SUCCESS (0.003s)
[424.934639] [063/133] (595s left) kms_pm_dc (dc6-psr)
[426.035606] Starting subtest: dc6-psr
[429.023451] Subtest dc6-psr: SUCCESS (2.986s)
[429.876299] [064/133] (590s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[429.934178] Starting subtest: framebuffer-vs-set-tiling
[429.938454] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[430.064546] [065/133] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[430.165212] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[430.169525] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[430.279340] [066/133] (590s left) gem_softpin (evict-prime-sanity-check)
[430.344151] Starting subtest: evict-prime-sanity-check
[430.346525] Starting dynamic subtest: rcs0
[431.485998] Dynamic subtest rcs0: SUCCESS (1.140s)
[431.497898] Starting dynamic subtest: bcs0
[432.599598] Dynamic subtest bcs0: SUCCESS (1.112s)
[432.612203] Starting dynamic subtest: vcs0
[435.688069] Dynamic subtest vcs0: SUCCESS (3.085s)
[435.699879] Starting dynamic subtest: vcs1
[437.668041] Dynamic subtest vcs1: SUCCESS (1.977s)
[437.679905] Starting dynamic subtest: vecs0
[439.654093] Dynamic subtest vecs0: SUCCESS (1.982s)
[439.666711] Starting dynamic subtest: ccs0
[440.776483] Dynamic subtest ccs0: SUCCESS (1.121s)
[440.789750] Starting dynamic subtest: all
[441.894572] Dynamic subtest all: SUCCESS (1.116s)
[441.896931] Subtest evict-prime-sanity-check: SUCCESS (11.548s)
[441.975250] [067/133] (578s left) kms_cursor_legacy (torture-move)
[442.089174] Starting subtest: torture-move
[442.091423] Starting dynamic subtest: pipe-A
[447.828190] Dynamic subtest pipe-A: SUCCESS (5.734s)
[447.844141] Starting dynamic subtest: pipe-B
[453.694247] Dynamic subtest pipe-B: SUCCESS (5.864s)
[453.710545] Starting dynamic subtest: pipe-C
[460.599628] Dynamic subtest pipe-C: SUCCESS (6.900s)
[460.610880] Starting dynamic subtest: pipe-D
[467.023973] Dynamic subtest pipe-D: SUCCESS (6.419s)
[467.037546] Starting dynamic subtest: all-pipes
[473.948969] Dynamic subtest all-pipes: SUCCESS (6.925s)
[473.951526] Subtest torture-move: SUCCESS (31.852s)
[474.105025] [068/133] (546s left) kms_flip (plain-flip-fb-recreate-interruptible)
[474.206746] Starting subtest: plain-flip-fb-recreate-interruptible
[474.208945] Starting dynamic subtest: A-eDP1
[483.067647] Dynamic subtest A-eDP1: SUCCESS (8.861s)
[483.079225] Starting dynamic subtest: B-eDP1
[491.897974] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[491.909088] Starting dynamic subtest: C-eDP1
[500.704397] Dynamic subtest C-eDP1: SUCCESS (8.804s)
[500.713773] Starting dynamic subtest: D-eDP1
[509.539297] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[509.543999] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.336s)
[510.724057] [069/133] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[510.826403] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[510.830753] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[510.924943] [070/133] (509s left) perf_pmu (all-busy-check-all)
[510.965259] Starting subtest: all-busy-check-all
[512.683785] Subtest all-busy-check-all: SUCCESS (1.718s)
[512.785128] [071/133] (507s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[512.880959] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[512.907262] Starting dynamic subtest: pipe-A-plane-0
[513.351700] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[513.363364] Starting dynamic subtest: pipe-A-plane-3
[513.618478] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[513.628012] Starting dynamic subtest: pipe-A-plane-5
[513.632442] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[514.709803] Starting dynamic subtest: pipe-B-plane-0
[515.134758] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[515.144796] Starting dynamic subtest: pipe-B-plane-3
[515.390582] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[515.401247] Starting dynamic subtest: pipe-B-plane-5
[515.405836] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[515.705018] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.823s)
[516.584124] [072/133] (504s left) gem_ctx_param (invalid-get-ringsize)
[516.641211] Starting subtest: invalid-get-ringsize
[516.643650] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[516.753992] [073/133] (504s left) gem_eio (in-flight-contexts-1us)
[516.978415] Starting subtest: in-flight-contexts-1us
[528.717013] Subtest in-flight-contexts-1us: SUCCESS (11.737s)
[528.878574] [074/133] (492s left) kms_frontbuffer_tracking (fbc-1p-rte)
[528.981794] Starting subtest: fbc-1p-rte
[534.469873] Subtest fbc-1p-rte: SUCCESS (5.491s)
[535.593640] [075/133] (485s left) gem_pxp (reject-modify-context-protection-off-2)
[535.712751] Starting subtest: reject-modify-context-protection-off-2
[535.715220] Subtest reject-modify-context-protection-off-2: SUCCESS (0.001s)
[535.819115] [076/133] (485s left) drm_read (short-buffer-block)
[535.959513] Starting subtest: short-buffer-block
[535.961415] Subtest short-buffer-block: SUCCESS (0.000s)
[536.073371] [077/133] (484s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[536.162740] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[536.164876] Starting dynamic subtest: pipe-A-eDP-1
[536.188723] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[536.199939] Starting dynamic subtest: pipe-B-eDP-1
[536.222583] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[536.232557] Starting dynamic subtest: pipe-C-eDP-1
[536.255694] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[536.265598] Starting dynamic subtest: pipe-D-eDP-1
[536.289243] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[536.293565] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[538.454625] [078/133] (482s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[538.540894] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[538.543137] Starting dynamic subtest: pipe-A
[538.946091] Dynamic subtest pipe-A: SUCCESS (0.408s)
[538.961421] Starting dynamic subtest: pipe-B
[540.341703] Dynamic subtest pipe-B: SUCCESS (1.394s)
[540.351187] Starting dynamic subtest: pipe-C
[541.774485] Dynamic subtest pipe-C: SUCCESS (1.432s)
[541.783799] Starting dynamic subtest: pipe-D
[543.211424] Dynamic subtest pipe-D: SUCCESS (1.435s)
[543.213663] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.674s)
[544.364863] [079/133] (476s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[544.453934] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[544.458151] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[544.526295] [080/133] (476s left) gem_exec_alignment (pi)
[544.601281] Starting subtest: pi
[597.909877] Subtest pi: SUCCESS (53.295s)
[599.009205] [081/133] (422s left) kms_cursor_crc (cursor-onscreen-256x256)
[599.323354] Starting subtest: cursor-onscreen-256x256
[599.325596] Starting dynamic subtest: pipe-A-eDP-1
[601.523386] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.199s)
[601.556050] Starting dynamic subtest: pipe-D-eDP-1
[604.297728] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.751s)
[604.300012] Subtest cursor-onscreen-256x256: SUCCESS (4.978s)
[605.158921] [082/133] (416s left) syncobj_wait (single-wait-for-submit-signaled)
[605.230451] Starting subtest: single-wait-for-submit-signaled
[605.232756] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[605.339835] [083/133] (415s left) kms_psr (psr2-sprite-blt)
[605.430446] Starting subtest: psr2-sprite-blt
[605.432838] Starting dynamic subtest: eDP-1
[607.143894] Dynamic subtest eDP-1: SUCCESS (1.710s)
[607.146148] Subtest psr2-sprite-blt: SUCCESS (1.712s)
[608.014407] [084/133] (413s left) syncobj_timeline (multi-wait-all-available-submitted)
[608.069957] Starting subtest: multi-wait-all-available-submitted
[608.072336] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[608.164760] [085/133] (413s left) gen3_render_tiledx_blits
[608.283713] [086/133] (413s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[608.534025] Starting subtest: cursor-rapid-movement-256x256
[608.539032] Starting dynamic subtest: pipe-A-eDP-1
[609.081644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[609.108853] Starting dynamic subtest: pipe-D-eDP-1
[610.330192] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[610.332617] Subtest cursor-rapid-movement-256x256: SUCCESS (1.796s)
[611.180098] [087/133] (410s left) kms_psr (pr-primary-blt)
[611.273058] Starting subtest: pr-primary-blt
[611.277076] Subtest pr-primary-blt: SKIP (0.000s)
[611.349764] [088/133] (410s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[611.446387] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[611.450576] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[611.539792] [089/133] (409s left) gem_userptr_blits (coherency-sync)
[611.603271] Starting subtest: coherency-sync
[611.742856] Subtest coherency-sync: SKIP (0.105s)
[611.825258] [090/133] (409s left) kms_chamelium_frames (dp-frame-dump)
[612.241091] Subtest dp-frame-dump: SKIP (0.000s)
[613.093486] [091/133] (408s left) i915_selftest (live)
[617.802686] Starting subtest: live
[617.805441] Starting dynamic subtest: sanitycheck
[622.173301] Dynamic subtest sanitycheck: SUCCESS (4.369s)
[622.183403] Starting dynamic subtest: uncore
[626.529269] Dynamic subtest uncore: SUCCESS (4.354s)
[626.538136] Starting dynamic subtest: workarounds
[629.560531] Dynamic subtest workarounds: SUCCESS (3.029s)
[629.575583] Starting dynamic subtest: gt_engines
[632.623030] Dynamic subtest gt_engines: SUCCESS (3.061s)
[632.632528] Starting dynamic subtest: gt_timelines
[648.253572] Dynamic subtest gt_timelines: SUCCESS (15.630s)
[648.269115] Starting dynamic subtest: gt_contexts
[652.542840] Dynamic subtest gt_contexts: SUCCESS (4.288s)
[652.552884] Starting dynamic subtest: gt_lrc
[658.648544] Dynamic subtest gt_lrc: SUCCESS (6.103s)
[658.656283] Starting dynamic subtest: gt_mocs
[661.600028] Dynamic subtest gt_mocs: SUCCESS (2.949s)
[661.609875] Starting dynamic subtest: gt_pm
[666.330671] Dynamic subtest gt_pm: SUCCESS (4.730s)
[666.340657] Starting dynamic subtest: gt_heartbeat
[670.602766] Dynamic subtest gt_heartbeat: SUCCESS (4.270s)
[670.613003] Starting dynamic subtest: gt_tlb
[679.875341] Dynamic subtest gt_tlb: SUCCESS (9.271s)
[679.885103] Starting dynamic subtest: requests
[691.364651] Dynamic subtest requests: SUCCESS (11.486s)
[691.374663] Starting dynamic subtest: migrate
[697.127789] Dynamic subtest migrate: SUCCESS (5.760s)
[697.138281] Starting dynamic subtest: active
[701.490048] Dynamic subtest active: SUCCESS (4.359s)
[701.500670] Starting dynamic subtest: objects
[706.242228] Dynamic subtest objects: SUCCESS (4.750s)
[706.252688] Starting dynamic subtest: mman
[709.566377] Dynamic subtest mman: SUCCESS (3.321s)
[709.578203] Starting dynamic subtest: dmabuf
[712.349439] Dynamic subtest dmabuf: SUCCESS (2.781s)
[712.359805] Starting dynamic subtest: vma
[716.644329] Dynamic subtest vma: SUCCESS (4.292s)
[716.654800] Starting dynamic subtest: coherency
[721.613910] Dynamic subtest coherency: SUCCESS (4.967s)
[721.623915] Starting dynamic subtest: gtt
[733.470077] Dynamic subtest gtt: SUCCESS (11.853s)
[733.480378] Starting dynamic subtest: gem
[739.399839] Dynamic subtest gem: SUCCESS (5.927s)
[739.409711] Starting dynamic subtest: evict
[743.390171] Dynamic subtest evict: SUCCESS (3.988s)
[743.399985] Starting dynamic subtest: hugepages
[752.180851] Dynamic subtest hugepages: SUCCESS (8.787s)
[752.190329] Starting dynamic subtest: gem_contexts
[778.782837] Dynamic subtest gem_contexts: SUCCESS (26.595s)
[778.792711] Starting dynamic subtest: client
[783.173730] Dynamic subtest client: SUCCESS (4.390s)
[783.183253] Starting dynamic subtest: gem_migrate
[787.512577] Dynamic subtest gem_migrate: SUCCESS (4.336s)
[787.523054] Starting dynamic subtest: reset
[790.729651] Dynamic subtest reset: SUCCESS (3.214s)
[790.753688] Starting dynamic subtest: memory_region
[795.451412] Dynamic subtest memory_region: SUCCESS (4.717s)
[795.461432] Starting dynamic subtest: hangcheck
[808.559725] Dynamic subtest hangcheck: SUCCESS (13.104s)
[808.568210] Starting dynamic subtest: execlists
[812.904181] Dynamic subtest execlists: SUCCESS (4.341s)
[812.914357] Starting dynamic subtest: ring_submission
[817.191853] Dynamic subtest ring_submission: SUCCESS (4.285s)
[817.200887] Starting dynamic subtest: perf
[821.461624] Dynamic subtest perf: SUCCESS (4.266s)
[821.471914] Starting dynamic subtest: slpc
[835.560085] Dynamic subtest slpc: SUCCESS (14.095s)
[835.570167] Starting dynamic subtest: guc
[839.465670] Dynamic subtest guc: SUCCESS (3.903s)
[839.474897] Starting dynamic subtest: guc_multi_lrc
[843.761013] Dynamic subtest guc_multi_lrc: SUCCESS (4.293s)
[843.771086] Starting dynamic subtest: guc_hang
[847.166490] Dynamic subtest guc_hang: SUCCESS (3.403s)
[847.176481] Starting dynamic subtest: late_gt_pm
[851.541856] Dynamic subtest late_gt_pm: SUCCESS (4.374s)
[851.544390] Subtest live: SUCCESS (233.707s)
[851.574877] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[851.575566] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[851.578750] [092/133] (170s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[853.129236] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[853.133350] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[853.227322] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[853.228494] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[853.232896] [093/133] (168s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[853.327779] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[853.329645] Starting dynamic subtest: pipe-A-eDP-1
[853.387444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[853.395990] Starting dynamic subtest: pipe-B-eDP-1
[853.447418] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[853.455838] Starting dynamic subtest: pipe-C-eDP-1
[853.507534] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[853.516477] Starting dynamic subtest: pipe-D-eDP-1
[853.564392] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[853.566684] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.239s)
[855.804473] [094/133] (165s left) perf (polling)
[855.959178] Starting subtest: polling
[855.961006] Starting dynamic subtest: 0-rcs0
[865.991361] Dynamic subtest 0-rcs0: SUCCESS (10.036s)
[866.001030] Starting dynamic subtest: 1-vcs0
[876.011322] Dynamic subtest 1-vcs0: SUCCESS (10.023s)
[876.013956] Subtest polling: SUCCESS (20.062s)
[876.061163] [095/133] (145s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[876.172797] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[879.756403] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.586s)
[880.896644] [096/133] (140s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[880.952864] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[880.955280] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[881.057527] [097/133] (140s left) kms_prime (basic-crc-hybrid)
[881.136622] Subtest basic-crc-hybrid: SKIP (0.000s)
[881.241810] [098/133] (140s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[881.362113] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[881.366764] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[881.503467] [099/133] (140s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[881.598849] Starting subtest: x-tiled-8bpp-rotate-90
[881.623430] Subtest x-tiled-8bpp-rotate-90: SKIP (0.024s)
[881.735961] [100/133] (140s left) gen9_exec_parse (unaligned-jump)
[881.791218] Subtest unaligned-jump: SKIP (0.000s)
[881.847490] [101/133] (140s left) perf_pmu (semaphore-wait)
[881.883271] Starting subtest: semaphore-wait
[881.885274] Starting dynamic subtest: rcs0
[882.400381] Dynamic subtest rcs0: SUCCESS (0.515s)
[882.416497] Starting dynamic subtest: bcs0
[882.913833] Dynamic subtest bcs0: SUCCESS (0.510s)
[882.926515] Starting dynamic subtest: vcs0
[883.426884] Dynamic subtest vcs0: SUCCESS (0.511s)
[883.438311] Starting dynamic subtest: vcs1
[883.939736] Dynamic subtest vcs1: SUCCESS (0.510s)
[883.950635] Starting dynamic subtest: vecs0
[884.453053] Dynamic subtest vecs0: SUCCESS (0.510s)
[884.465197] Starting dynamic subtest: ccs0
[884.970187] Dynamic subtest ccs0: SUCCESS (0.514s)
[884.973244] Subtest semaphore-wait: SUCCESS (3.088s)
[885.084305] [102/133] (136s left) syncobj_wait (invalid-reset-one-illegal-handle)
[885.141125] Starting subtest: invalid-reset-one-illegal-handle
[885.143442] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[885.267836] [103/133] (136s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[885.344082] Starting subtest: yf-tiled-to-vebox-yf-tiled
[885.348283] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[885.532394] [104/133] (136s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[885.632255] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[885.634615] Starting dynamic subtest: A-eDP1
[889.204653] Dynamic subtest A-eDP1: SUCCESS (3.571s)
[889.217661] Starting dynamic subtest: B-eDP1
[892.394585] Dynamic subtest B-eDP1: SUCCESS (3.189s)
[892.404211] Starting dynamic subtest: C-eDP1
[895.470571] Dynamic subtest C-eDP1: SUCCESS (3.077s)
[895.479927] Starting dynamic subtest: D-eDP1
[898.601599] Dynamic subtest D-eDP1: SUCCESS (3.131s)
[898.603900] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.975s)
[899.396729] [105/133] (122s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[899.506030] Starting subtest: fbcpsr-rgb101010-draw-render
[906.253906] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.752s)
[906.369305] [106/133] (115s left) i915_drm_fdinfo (virtual-busy-idle-all)
[906.411313] Starting subtest: virtual-busy-idle-all
[906.415459] Subtest virtual-busy-idle-all: SKIP (0.000s)
[906.476272] [107/133] (115s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[906.532414] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[906.590337] [108/133] (115s left) kms_psr (fbc-psr-dpms)
[906.676231] Starting subtest: fbc-psr-dpms
[906.678583] Starting dynamic subtest: eDP-1
[906.683532] Dynamic subtest eDP-1: SKIP (0.000s)
[906.688365] Subtest fbc-psr-dpms: SKIP (0.001s)
[906.752281] [109/133] (115s left) gem_render_linear_blits (basic)
[906.809069] Starting subtest: basic
[906.833120] Subtest basic: SUCCESS (0.024s)
[906.918510] [110/133] (115s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[907.044458] Starting subtest: psr-rgb101010-draw-pwrite
[914.749152] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.707s)
[914.849397] [111/133] (107s left) intel_hwmon (hwmon-read)
[914.913611] Subtest hwmon-read: SKIP (0.000s)
[914.976734] [112/133] (107s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[915.082503] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[915.084753] Starting dynamic subtest: pipe-A-eDP-1
[926.068094] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.991s)
[926.082030] Starting dynamic subtest: pipe-B-eDP-1
[937.803948] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.737s)
[937.806383] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.731s)
[938.684355] [113/133] ( 83s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[938.785341] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[946.154105] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.372s)
[946.295683] [114/133] ( 76s left) gem_ctx_persistence (processes)
[946.353499] Starting subtest: processes
[947.706651] Subtest processes: SUCCESS (1.352s)
[947.800701] [115/133] ( 74s left) gem_exec_reloc (basic-gtt)
[947.861877] Subtest basic-gtt: SKIP (0.000s)
[947.936386] [116/133] ( 74s left) syncobj_eventfd (invalid-bad-flags)
[947.985582] Starting subtest: invalid-bad-flags
[947.987549] Subtest invalid-bad-flags: SUCCESS (0.000s)
[948.097453] [117/133] ( 74s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[948.192806] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[948.197215] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[948.290900] [118/133] ( 74s left) kms_atomic (crtc-invalid-params-fence)
[948.382872] Starting subtest: crtc-invalid-params-fence
[948.385194] Starting dynamic subtest: pipe-A-eDP-1
[948.794778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s)
[948.797394] Subtest crtc-invalid-params-fence: SUCCESS (0.412s)
[949.619329] [119/133] ( 73s left) dumb_buffer (map-valid)
[949.669967] Starting subtest: map-valid
[949.672240] Subtest map-valid: SUCCESS (0.000s)
[949.782373] [120/133] ( 73s left) gem_exec_reloc (basic-wc-read-active)
[949.844160] Subtest basic-wc-read-active: SKIP (0.000s)
[949.917632] [121/133] ( 72s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[950.009153] Starting subtest: psr-1p-pri-indfb-multidraw
[972.613061] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.608s)
[972.754391] [122/133] ( 50s left) kms_color_pipeline (plane-ctm3x4)
[972.863527] Starting subtest: plane-ctm3x4
[973.031840] Starting dynamic subtest: pipe-A-plane-0
[973.175938] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[973.188895] Starting dynamic subtest: pipe-A-plane-1
[973.309634] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s)
[973.319457] Starting dynamic subtest: pipe-A-plane-2
[973.442986] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[974.652659] Starting dynamic subtest: pipe-B-plane-0
[974.789111] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[974.798798] Starting dynamic subtest: pipe-B-plane-1
[974.922218] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[974.931894] Starting dynamic subtest: pipe-B-plane-2
[975.080786] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[976.273572] Starting dynamic subtest: pipe-C-plane-0
[976.404113] Dynamic subtest pipe-C-plane-0: SUCCESS (0.143s)
[976.414681] Starting dynamic subtest: pipe-C-plane-1
[976.537138] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[976.550112] Starting dynamic subtest: pipe-C-plane-2
[976.659282] Dynamic subtest pipe-C-plane-2: SUCCESS (0.121s)
[977.899245] Starting dynamic subtest: pipe-D-plane-0
[978.024532] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[978.035244] Starting dynamic subtest: pipe-D-plane-1
[978.135560] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[978.145401] Starting dynamic subtest: pipe-D-plane-2
[978.246479] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[978.532878] Subtest plane-ctm3x4: SUCCESS (5.670s)
[979.359995] [123/133] ( 43s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[979.463882] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[979.468280] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[979.543459] [124/133] ( 43s left) gem_exec_big (single)
[979.610209] Starting subtest: single
[983.016421] Subtest single: FAIL (3.347s)
[983.057885] [125/133] ( 39s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[983.192794] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[983.195099] Starting dynamic subtest: pipe-A-default-mode
[985.937838] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[985.940383] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.746s)
[986.785940] [126/133] ( 36s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[986.894713] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[986.899285] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[986.993967] [127/133] ( 36s left) gem_exec_fence (syncobj-channel)
[987.434267] Starting subtest: syncobj-channel
[988.453904] Subtest syncobj-channel: SUCCESS (1.015s)
[988.815711] [128/133] ( 34s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[988.918147] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[988.922231] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[989.009381] [129/133] ( 34s left) gem_pwrite (basic-random)
[989.074016] Subtest basic-random: SKIP (0.000s)
[989.136209] [130/133] ( 34s left) syncobj_wait (reset-unsignaled)
[989.195056] Starting subtest: reset-unsignaled
[989.197571] Subtest reset-unsignaled: SUCCESS (0.000s)
[989.284095] [131/133] ( 34s left) api_intel_allocator (reloc-allocator)
[989.335877] Starting subtest: reloc-allocator
[989.338178] Starting dynamic subtest: basic
[989.340414] Dynamic subtest basic: SUCCESS (0.004s)
[989.355361] Starting dynamic subtest: parallel-one
[989.357699] Dynamic subtest parallel-one: SUCCESS (0.008s)
[989.368186] Starting dynamic subtest: print
[989.370470] Dynamic subtest print: SUCCESS (0.000s)
[989.379649] Starting dynamic subtest: reuse
[989.381848] Dynamic subtest reuse: SUCCESS (0.000s)
[989.390926] Starting dynamic subtest: fork-reopen-allocator
[989.393190] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[989.395393] Subtest reloc-allocator: SUCCESS (0.029s)
[989.484167] [132/133] ( 33s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[989.578944] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[990.557616] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.979s)
[990.675397] [133/133] ( 32s left) gen9_exec_parse (allowed-single)
[990.738323] Subtest allowed-single: SKIP (0.000s)
[990.797419] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_chamelium_audio
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: gem_mmap
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_ctx_bad_destroy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_wait
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: prime_mmap
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_hdr
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: gem_linear_blits
results: parsing output: 32/ for test: kms_setmode
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: dumb_buffer
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: gem_create
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_dp_link_training
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: drm_read
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: vgem_basic
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_pm_dc
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: gem_exec_alignment
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gen3_render_tiledx_blits
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: i915_selftest
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_prime
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gen9_exec_parse
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_pipe_b_c_ivb
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_render_linear_blits
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: intel_hwmon
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: syncobj_eventfd
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_atomic
results: parsing output: 118/ for test: dumb_buffer
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_color_pipeline
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_exec_big
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_pwrite
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: api_intel_allocator
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gen9_exec_parse
Done.