[56.953949] Initializing watchdogs
[56.954129]   /dev/watchdog0
[56.971908] [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]
[56.976378] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.978663] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.981790] [001/133] (960s left) kms_psr (fbc-psr2-primary-page-flip)
[57.099646] Starting subtest: fbc-psr2-primary-page-flip
[57.101836] Starting dynamic subtest: eDP-1
[57.105877] Dynamic subtest eDP-1: SKIP (0.000s)
[57.110040] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[57.182222] [002/133] (960s left) syncobj_timeline (host-signal-points)
[57.242734] Starting subtest: host-signal-points
[57.247863] Subtest host-signal-points: SUCCESS (0.004s)
[57.343279] [003/133] (960s left) gem_bad_reloc (negative-reloc-lut)
[57.398417] Subtest negative-reloc-lut: SKIP (0.000s)
[57.489421] [004/133] (960s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[59.047452] Starting subtest: modeset-lpsp-stress-no-wait
[69.192582] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.145s)
[69.291091] [005/133] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[69.393674] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[76.737784] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.348s)
[76.894903] [006/133] (940s left) gem_exec_reloc (basic-wc)
[76.961980] Subtest basic-wc: SKIP (0.000s)
[77.027661] [007/133] (940s left) kms_vblank (query-idle)
[77.121553] Starting subtest: query-idle
[77.123891] Starting dynamic subtest: pipe-A-eDP-1
[78.869028] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.749s)
[78.882226] Starting dynamic subtest: pipe-D-eDP-1
[81.303088] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[81.305550] Subtest query-idle: SUCCESS (4.183s)
[82.127804] [008/133] (935s left) gem_busy (close-race)
[82.194960] Starting subtest: close-race
[107.862039] Subtest close-race: SUCCESS (25.666s)
[108.202251] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[108.207144] [009/133] (909s left) gem_pread (exhaustion)
[108.302306] Subtest exhaustion: SKIP (0.000s)
[108.368615] [010/133] (909s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[108.433209] Starting subtest: single-wait-all-for-submit-unsubmitted
[108.538458] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[108.614767] [011/133] (909s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[108.714035] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[108.716477] Starting dynamic subtest: pipe-A
[108.776035] Dynamic subtest pipe-A: SUCCESS (0.065s)
[108.783368] Starting dynamic subtest: pipe-B
[109.960338] Dynamic subtest pipe-B: SUCCESS (1.184s)
[109.968704] Starting dynamic subtest: pipe-C
[111.064953] Dynamic subtest pipe-C: SUCCESS (1.103s)
[111.075641] Starting dynamic subtest: pipe-D
[112.192584] Dynamic subtest pipe-D: SUCCESS (1.128s)
[112.195116] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.481s)
[113.355281] [012/133] (904s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[115.008119] Starting subtest: dpms-mode-unset-lpsp
[119.049042] Subtest dpms-mode-unset-lpsp: SUCCESS (4.042s)
[119.446191] [013/133] (898s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[119.497713] Starting subtest: mixed-tiled-to-y-tiled-ccs
[119.501934] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[119.681367] [014/133] (898s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[119.827956] Starting subtest: dp-mst-lic-type-0-hdcp14
[119.832495] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[119.964186] [015/133] (898s left) i915_drm_fdinfo (busy-idle-check-all)
[120.013396] Starting subtest: busy-idle-check-all
[120.015280] Starting dynamic subtest: rcs0
[120.019619] Dynamic subtest rcs0: SKIP (0.003s)
[120.030198] Starting dynamic subtest: bcs0
[120.034590] Dynamic subtest bcs0: SKIP (0.000s)
[120.041813] Starting dynamic subtest: vcs0
[120.046115] Dynamic subtest vcs0: SKIP (0.000s)
[120.053127] Starting dynamic subtest: vcs1
[120.057386] Dynamic subtest vcs1: SKIP (0.000s)
[120.064436] Starting dynamic subtest: vecs0
[120.068763] Dynamic subtest vecs0: SKIP (0.000s)
[120.075702] Starting dynamic subtest: ccs0
[120.080058] Dynamic subtest ccs0: SKIP (0.000s)
[120.084325] Subtest busy-idle-check-all: SKIP (0.006s)
[120.119854] [016/133] (897s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[120.224847] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[120.250939] Starting dynamic subtest: pipe-A-plane-0
[120.543676] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[120.553721] Starting dynamic subtest: pipe-A-plane-3
[120.783893] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[121.910785] Starting dynamic subtest: pipe-B-plane-0
[122.204196] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[122.214161] Starting dynamic subtest: pipe-B-plane-3
[122.437385] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[122.747047] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.521s)
[123.571650] [017/133] (894s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[123.674674] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[123.678779] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[123.792420] [018/133] (894s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[123.893222] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[123.897312] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[123.962887] [019/133] (894s left) gem_lmem_swapping (parallel-random)
[124.007626] Subtest parallel-random: SKIP (0.000s)
[124.048750] [020/133] (894s left) prime_udl
[124.136945] [021/133] (894s left) kms_psr (fbc-psr-primary-mmap-cpu)
[124.238560] Starting subtest: fbc-psr-primary-mmap-cpu
[124.240859] Starting dynamic subtest: eDP-1
[124.245358] Dynamic subtest eDP-1: SKIP (0.000s)
[124.249885] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[124.354246] [022/133] (894s left) kms_color (ctm-0-75)
[124.450137] Starting subtest: ctm-0-75
[124.452423] Starting dynamic subtest: pipe-A-eDP-1
[129.250238] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.800s)
[129.259113] Starting dynamic subtest: pipe-B-eDP-1
[134.894309] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.638s)
[134.903899] Starting dynamic subtest: pipe-C-eDP-1
[140.184978] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.297s)
[140.194573] Starting dynamic subtest: pipe-D-eDP-1
[145.513326] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.327s)
[145.515628] Subtest ctm-0-75: SUCCESS (21.064s)
[146.332723] [023/133] (872s left) i915_query (query-regions-sanity-check)
[146.402525] Starting subtest: query-regions-sanity-check
[146.409621] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[146.548744] [024/133] (871s left) gem_fence_thrash (bo-write-verify-threaded-none)
[146.586547] Starting subtest: bo-write-verify-threaded-none
[146.607356] Subtest bo-write-verify-threaded-none: SKIP (0.017s)
[146.665966] [025/133] (871s left) gem_userptr_blits (forbidden-operations)
[146.718615] Starting subtest: forbidden-operations
[146.722695] Subtest forbidden-operations: SKIP (0.000s)
[146.841603] [026/133] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[146.967538] Starting subtest: basic-busy-flip-before-cursor-atomic
[146.972032] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[147.108504] [027/133] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[147.221600] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[147.226019] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[147.319337] [028/133] (871s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[147.408522] Starting subtest: bad-pixel-format-yf-tiled-ccs
[147.410475] Starting dynamic subtest: pipe-A-eDP-1
[147.428817] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.437491] Starting dynamic subtest: pipe-B-eDP-1
[147.455727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.462798] Starting dynamic subtest: pipe-C-eDP-1
[147.480478] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.488586] Starting dynamic subtest: pipe-D-eDP-1
[147.506438] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.510056] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[149.621700] [029/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[149.722822] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[149.727199] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[149.816005] [030/133] (868s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[149.929662] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[153.955887] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.031s)
[155.123527] [031/133] (863s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[155.220062] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[155.222389] Starting dynamic subtest: pipe-A
[155.240358] Dynamic subtest pipe-A: SKIP (0.016s)
[155.250173] Starting dynamic subtest: pipe-B
[155.268195] Dynamic subtest pipe-B: SKIP (0.029s)
[155.276222] Starting dynamic subtest: pipe-C
[155.299079] Dynamic subtest pipe-C: SKIP (0.029s)
[155.306590] Starting dynamic subtest: pipe-D
[155.329594] Dynamic subtest pipe-D: SKIP (0.030s)
[155.333717] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.106s)
[155.436937] [032/133] (863s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[155.549431] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[155.553757] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[155.642767] [033/133] (863s left) kms_getfb (getfb2-handle-zero)
[155.745611] Starting subtest: getfb2-handle-zero
[155.747946] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[155.873741] [034/133] (862s left) kms_async_flips (alternate-sync-async-flip-atomic)
[155.967927] Starting subtest: alternate-sync-async-flip-atomic
[156.338746] Starting dynamic subtest: pipe-A-eDP-1
[159.098574] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.760s)
[159.477256] Starting dynamic subtest: pipe-B-eDP-1
[162.229198] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s)
[162.623939] Starting dynamic subtest: pipe-C-eDP-1
[165.367805] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.749s)
[165.736724] Starting dynamic subtest: pipe-D-eDP-1
[168.498833] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[168.500916] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.534s)
[169.667806] [035/133] (849s left) tools_test (tools_test)
[169.729761] Starting subtest: tools_test
[169.785671] Subtest tools_test: SUCCESS (0.070s)
[169.849885] [036/133] (849s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[169.953437] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[169.957658] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[170.059849] [037/133] (848s left) prime_mmap (test_dup)
[170.115051] Starting subtest: test_dup
[170.116970] Starting dynamic subtest: test_dup-smem
[170.143155] Dynamic subtest test_dup-smem: SUCCESS (0.030s)
[170.145654] Subtest test_dup: SUCCESS (0.031s)
[170.216908] [038/133] (848s left) gem_vm_create (isolation)
[170.266936] Starting subtest: isolation
[170.279645] Subtest isolation: SUCCESS (0.015s)
[170.395842] [039/133] (848s left) kms_cursor_edge_walk (256x256-right-edge)
[170.500926] Starting subtest: 256x256-right-edge
[170.503101] Starting dynamic subtest: pipe-A-eDP-1
[173.935337] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[173.943312] Starting dynamic subtest: pipe-D-eDP-1
[177.048919] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[177.051710] Subtest 256x256-right-edge: SUCCESS (6.550s)
[177.870712] [040/133] (841s left) gen7_exec_parse (batch-without-end)
[177.942053] Subtest batch-without-end: SKIP (0.000s)
[178.014017] [041/133] (841s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[178.119517] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[178.121690] Starting dynamic subtest: pipe-A-eDP-1
[178.215489] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[178.224094] Starting dynamic subtest: pipe-B-eDP-1
[179.353768] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[179.358276] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.239s)
[180.645379] [042/133] (838s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[180.753194] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[180.755547] Starting dynamic subtest: pipe-A-eDP-1
[180.778605] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[180.787688] Starting dynamic subtest: pipe-B-eDP-1
[180.809137] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.816249] Starting dynamic subtest: pipe-C-eDP-1
[180.837578] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.845201] Starting dynamic subtest: pipe-D-eDP-1
[180.868467] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.872946] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[182.998852] [043/133] (836s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[183.101050] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[184.213834] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.113s)
[184.324573] [044/133] (834s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[184.420336] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[184.422360] Starting dynamic subtest: pipe-A-eDP-1
[200.875905] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.460s)
[200.886270] Starting dynamic subtest: pipe-B-eDP-1
[218.063488] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.186s)
[218.065897] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.649s)
[218.865310] [045/133] (800s left) gem_exec_whisper (basic-forked-all)
[218.933185] Starting subtest: basic-forked-all
[232.856999] Subtest basic-forked-all: SUCCESS (13.919s)
[233.038909] [046/133] (786s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[233.098682] Starting subtest: invalid-multi-wait-all-unsubmitted
[233.100858] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[233.210119] [047/133] (786s left) kms_lease (invalid-create-leases)
[233.335085] Starting subtest: invalid-create-leases
[233.340149] Subtest invalid-create-leases: SUCCESS (0.005s)
[233.440594] [048/133] (785s left) kms_cursor_legacy (torture-move)
[233.551387] Starting subtest: torture-move
[233.553290] Starting dynamic subtest: pipe-A
[240.028783] Dynamic subtest pipe-A: SUCCESS (6.475s)
[240.040028] Starting dynamic subtest: pipe-B
[247.170423] Dynamic subtest pipe-B: SUCCESS (7.139s)
[247.181203] Starting dynamic subtest: pipe-C
[253.877731] Dynamic subtest pipe-C: SUCCESS (6.706s)
[253.891984] Starting dynamic subtest: pipe-D
[259.705312] Dynamic subtest pipe-D: SUCCESS (5.827s)
[259.714396] Starting dynamic subtest: all-pipes
[265.987613] Dynamic subtest all-pipes: SUCCESS (6.277s)
[265.990133] Subtest torture-move: SUCCESS (32.434s)
[266.160556] [049/133] (753s left) gem_cs_tlb (engines)
[266.233335] Starting subtest: engines
[266.235551] Starting dynamic subtest: rcs0
[268.388490] Dynamic subtest rcs0: SUCCESS (2.153s)
[268.398062] Starting dynamic subtest: bcs0
[270.540399] Dynamic subtest bcs0: SUCCESS (2.151s)
[270.548619] Starting dynamic subtest: vcs0
[272.693947] Dynamic subtest vcs0: SUCCESS (2.152s)
[272.702325] Starting dynamic subtest: vcs1
[274.847534] Dynamic subtest vcs1: SUCCESS (2.152s)
[274.855633] Starting dynamic subtest: vecs0
[277.000062] Dynamic subtest vecs0: SUCCESS (2.152s)
[277.008637] Starting dynamic subtest: ccs0
[279.154512] Dynamic subtest ccs0: SUCCESS (2.154s)
[279.156750] Subtest engines: SUCCESS (12.921s)
[279.283152] [050/133] (740s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[279.377301] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[287.002089] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.627s)
[287.103790] [051/133] (732s left) i915_pm_rps (basic-api)
[287.174539] Starting subtest: basic-api
[287.179023] Subtest basic-api: SKIP (0.001s)
[287.247218] [052/133] (732s left) gem_ctx_persistence (legacy-engines-hang)
[287.302021] Starting subtest: legacy-engines-hang
[287.304371] Starting dynamic subtest: render
[287.413636] Dynamic subtest render: SUCCESS (0.111s)
[287.427599] Starting dynamic subtest: bsd1
[287.503990] Dynamic subtest bsd1: SUCCESS (0.087s)
[287.516200] Starting dynamic subtest: bsd2
[287.596636] Dynamic subtest bsd2: SUCCESS (0.090s)
[287.609634] Starting dynamic subtest: blt
[287.688695] Dynamic subtest blt: SUCCESS (0.089s)
[287.701451] Starting dynamic subtest: vebox
[287.800600] Dynamic subtest vebox: SUCCESS (0.109s)
[287.802899] Subtest legacy-engines-hang: SUCCESS (0.500s)
[287.878874] [053/133] (731s left) perf (gen12-unprivileged-single-ctx-counters)
[288.002395] Starting subtest: gen12-unprivileged-single-ctx-counters
[288.003964] Starting dynamic subtest: rcs0
[288.509221] Dynamic subtest rcs0: SUCCESS (0.508s)
[288.511069] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.510s)
[288.559652] [054/133] (731s left) gem_softpin (evict-prime-sanity-check)
[288.612811] Starting subtest: evict-prime-sanity-check
[288.614813] Starting dynamic subtest: rcs0
[289.764302] Dynamic subtest rcs0: SUCCESS (1.150s)
[289.775528] Starting dynamic subtest: bcs0
[290.879925] Dynamic subtest bcs0: SUCCESS (1.113s)
[290.888465] Starting dynamic subtest: vcs0
[292.875419] Dynamic subtest vcs0: SUCCESS (1.992s)
[292.884801] Starting dynamic subtest: vcs1
[294.859158] Dynamic subtest vcs1: SUCCESS (1.981s)
[294.868569] Starting dynamic subtest: vecs0
[296.843287] Dynamic subtest vecs0: SUCCESS (1.981s)
[296.852819] Starting dynamic subtest: ccs0
[297.958627] Dynamic subtest ccs0: SUCCESS (1.114s)
[297.966753] Starting dynamic subtest: all
[299.082702] Dynamic subtest all: SUCCESS (1.123s)
[299.085580] Subtest evict-prime-sanity-check: SUCCESS (10.470s)
[299.159524] [055/133] (720s left) gem_mmap_offset (partial-remap)
[299.218895] Starting subtest: partial-remap
[299.221061] Starting dynamic subtest: smem0
[299.229697] Dynamic subtest smem0: SUCCESS (0.005s)
[299.231814] Subtest partial-remap: SUCCESS (0.005s)
[299.348406] [056/133] (720s left) kms_cursor_crc (cursor-offscreen-64x21)
[299.554664] Starting subtest: cursor-offscreen-64x21
[299.598306] Subtest cursor-offscreen-64x21: SKIP (0.040s)
[299.822866] [057/133] (719s left) gem_softpin (softpin)
[299.875579] Starting subtest: softpin
[332.152870] Subtest softpin: SUCCESS (32.270s)
[332.257783] [058/133] (687s left) kms_psr (pr-cursor-render)
[332.353056] Starting subtest: pr-cursor-render
[332.357347] Subtest pr-cursor-render: SKIP (0.000s)
[332.438381] [059/133] (687s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[332.554325] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[332.558591] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[332.648513] [060/133] (687s left) kms_big_fb (4-tiled-addfb)
[332.739768] Starting subtest: 4-tiled-addfb
[332.742060] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[332.839857] [061/133] (687s left) gem_exec_reloc (basic-cpu)
[332.911544] Subtest basic-cpu: SKIP (0.000s)
[332.993667] [062/133] (686s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[333.100173] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[334.038061] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.938s)
[334.163406] [063/133] (685s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[334.266476] Starting subtest: x-tiled-32bpp-rotate-0
[335.693017] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.428s)
[335.849568] [064/133] (684s left) gem_exec_fence (submit)
[336.029221] Starting subtest: submit
[336.033941] Subtest submit: SKIP (0.000s)
[337.950461] [065/133] (682s left) kms_flip (modeset-vs-vblank-race-interruptible)
[338.041210] Starting subtest: modeset-vs-vblank-race-interruptible
[338.043393] Starting dynamic subtest: A-eDP1
[342.676688] Dynamic subtest A-eDP1: SUCCESS (4.634s)
[342.688474] Starting dynamic subtest: B-eDP1
[347.286524] Dynamic subtest B-eDP1: SUCCESS (4.608s)
[347.299513] Starting dynamic subtest: C-eDP1
[351.826206] Dynamic subtest C-eDP1: SUCCESS (4.537s)
[351.837335] Starting dynamic subtest: D-eDP1
[356.355619] Dynamic subtest D-eDP1: SUCCESS (4.527s)
[356.360414] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.319s)
[357.526503] [066/133] (662s left) kms_cursor_crc (cursor-random-64x21)
[357.723564] Starting subtest: cursor-random-64x21
[357.768555] Subtest cursor-random-64x21: SKIP (0.040s)
[357.986321] [067/133] (662s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[358.076490] Starting subtest: psr-2p-primscrn-spr-indfb-move
[358.080872] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[358.170807] [068/133] (662s left) gem_set_tiling_vs_gtt
[358.299428] [069/133] (661s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[358.359849] Starting subtest: wait-all-for-submit-delayed-submit
[358.461077] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[358.539917] [070/133] (661s left) gem_ctx_shared (q-in-order)
[358.601346] Starting subtest: Q-in-order
[358.603673] Starting dynamic subtest: rcs0
[358.713521] Dynamic subtest rcs0: SUCCESS (0.110s)
[358.730422] Starting dynamic subtest: vcs0
[358.794373] Dynamic subtest vcs0: SUCCESS (0.081s)
[358.810423] Starting dynamic subtest: vcs1
[358.870872] Dynamic subtest vcs1: SUCCESS (0.075s)
[358.887984] Starting dynamic subtest: vecs0
[358.947586] Dynamic subtest vecs0: SUCCESS (0.076s)
[358.964997] Starting dynamic subtest: ccs0
[359.028322] Dynamic subtest ccs0: SUCCESS (0.080s)
[359.031295] Subtest Q-in-order: SUCCESS (0.426s)
[359.978848] [071/133] (660s left) perf_pmu (busy-idle)
[360.019039] Starting subtest: busy-idle
[360.021421] Starting dynamic subtest: rcs0
[360.710898] Dynamic subtest rcs0: SUCCESS (0.691s)
[360.721110] Starting dynamic subtest: bcs0
[361.372403] Dynamic subtest bcs0: SUCCESS (0.659s)
[361.382999] Starting dynamic subtest: vcs0
[362.902502] Dynamic subtest vcs0: SUCCESS (1.525s)
[362.917869] Starting dynamic subtest: vcs1
[364.886210] Dynamic subtest vcs1: SUCCESS (1.981s)
[364.897344] Starting dynamic subtest: vecs0
[366.869887] Dynamic subtest vecs0: SUCCESS (1.980s)
[366.879904] Starting dynamic subtest: ccs0
[367.551612] Dynamic subtest ccs0: SUCCESS (0.680s)
[367.554144] Subtest busy-idle: SUCCESS (7.534s)
[367.662579] [072/133] (652s left) gem_exec_schedule (deep)
[367.849655] Starting subtest: deep
[367.852217] Starting dynamic subtest: rcs0
[374.037675] Dynamic subtest rcs0: SKIP (6.186s)
[374.047605] Starting dynamic subtest: vcs0
[384.305469] Dynamic subtest vcs0: SUCCESS (10.269s)
[384.317396] Starting dynamic subtest: vcs1
[395.467749] Dynamic subtest vcs1: SUCCESS (11.160s)
[395.484072] Starting dynamic subtest: vecs0
[407.151761] Dynamic subtest vecs0: SUCCESS (11.681s)
[407.162637] Starting dynamic subtest: ccs0
[419.595039] Dynamic subtest ccs0: SUCCESS (12.442s)
[419.598235] Subtest deep: SUCCESS (51.745s)
[421.110201] [073/133] (599s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[421.236574] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[421.241255] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[421.382160] [074/133] (599s left) prime_busy (before-wait)
[421.448986] Starting subtest: before-wait
[421.451385] Starting dynamic subtest: rcs0
[421.486616] Dynamic subtest rcs0: SUCCESS (0.037s)
[421.496698] Starting dynamic subtest: bcs0
[421.548956] Dynamic subtest bcs0: SUCCESS (0.062s)
[421.559074] Starting dynamic subtest: vcs0
[421.589627] Dynamic subtest vcs0: SUCCESS (0.040s)
[421.599893] Starting dynamic subtest: vcs1
[421.632340] Dynamic subtest vcs1: SUCCESS (0.042s)
[421.640851] Starting dynamic subtest: vecs0
[421.671063] Dynamic subtest vecs0: SUCCESS (0.038s)
[421.679122] Starting dynamic subtest: ccs0
[421.717134] Dynamic subtest ccs0: SUCCESS (0.045s)
[421.826883] Subtest before-wait: SUCCESS (0.378s)
[421.902417] [075/133] (598s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[422.002471] Starting subtest: fbc-psr2-cursor-plane-update-sf
[422.004889] Starting dynamic subtest: pipe-A-eDP-1
[422.080034] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[422.089762] Starting dynamic subtest: pipe-B-eDP-1
[423.201307] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[423.205455] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.201s)
[424.393539] [076/133] (596s left) syncobj_wait (wait-zero-handles)
[424.450602] Starting subtest: wait-zero-handles
[424.452764] Subtest wait-zero-handles: SUCCESS (0.000s)
[424.558152] [077/133] (596s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[424.617139] Subtest writes-after-reads-uncached: SKIP (0.000s)
[424.691717] [078/133] (595s left) api_intel_allocator (two-level-inception)
[424.750565] Starting subtest: two-level-inception
[430.148646] Subtest two-level-inception: SUCCESS (5.399s)
[430.271561] [079/133] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[430.372717] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[434.184933] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.816s)
[435.309891] [080/133] (585s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[435.371659] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[435.374015] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[435.497408] [081/133] (585s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[435.562135] Starting subtest: invalid-bsd2-flag-on-blt
[435.564547] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[435.682869] [082/133] (585s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[435.790432] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[443.145904] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.358s)
[443.270314] [083/133] (577s left) syncobj_wait (single-wait-all-for-submit-submitted)
[443.342982] Starting subtest: single-wait-all-for-submit-submitted
[443.450232] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[443.531076] [084/133] (577s left) gem_exec_schedule (u-submit-early-slice)
[443.596414] Starting subtest: u-submit-early-slice
[443.598319] Starting dynamic subtest: rcs0
[443.632163] Dynamic subtest rcs0: SUCCESS (0.044s)
[443.643126] Starting dynamic subtest: bcs0
[443.670696] Dynamic subtest bcs0: SUCCESS (0.037s)
[443.679930] Starting dynamic subtest: vcs0
[443.708247] Dynamic subtest vcs0: SUCCESS (0.037s)
[443.717687] Starting dynamic subtest: vcs1
[443.743734] Dynamic subtest vcs1: SUCCESS (0.035s)
[443.754590] Starting dynamic subtest: vecs0
[443.779840] Dynamic subtest vecs0: SUCCESS (0.035s)
[443.788740] Starting dynamic subtest: ccs0
[443.824747] Dynamic subtest ccs0: SUCCESS (0.044s)
[443.826984] Subtest u-submit-early-slice: SUCCESS (0.238s)
[444.960418] [085/133] (575s left) gem_ctx_persistence (engines-queued)
[445.013034] Starting subtest: engines-queued
[445.015290] Starting dynamic subtest: rcs0
[445.087260] Dynamic subtest rcs0: SUCCESS (0.074s)
[445.100642] Starting dynamic subtest: bcs0
[445.124461] Dynamic subtest bcs0: SUCCESS (0.035s)
[445.132843] Starting dynamic subtest: vcs0
[446.838429] Dynamic subtest vcs0: SUCCESS (1.710s)
[446.850610] Starting dynamic subtest: vcs1
[447.860350] Dynamic subtest vcs1: SUCCESS (1.018s)
[447.871547] Starting dynamic subtest: vecs0
[449.908803] Dynamic subtest vecs0: SUCCESS (2.046s)
[449.919887] Starting dynamic subtest: ccs0
[450.091933] Dynamic subtest ccs0: SUCCESS (0.182s)
[450.094450] Subtest engines-queued: SUCCESS (5.079s)
[450.202418] [086/133] (570s left) kms_plane_alpha_blend (constant-alpha-min)
[450.299981] Starting subtest: constant-alpha-min
[450.604659] Starting dynamic subtest: pipe-A-eDP-1
[451.296513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[451.306453] Starting dynamic subtest: pipe-D-eDP-1
[452.809428] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.514s)
[452.811842] Subtest constant-alpha-min: SUCCESS (2.511s)
[453.595465] [087/133] (567s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[453.706490] Starting subtest: y-tiled-16bpp-rotate-0
[453.710996] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[453.805123] [088/133] (567s left) perf_pmu (rc6)
[453.847484] Starting subtest: rc6
[453.849813] Starting dynamic subtest: gt0
[460.224951] Dynamic subtest gt0: SUCCESS (6.376s)
[460.236730] Starting dynamic subtest: runtime-pm-gt0
[468.018026] Dynamic subtest runtime-pm-gt0: SUCCESS (7.792s)
[468.028618] Starting dynamic subtest: runtime-pm-long-gt0
[480.456527] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.435s)
[480.467994] Starting dynamic subtest: other-idle-gt0
[486.800092] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[486.811999] Starting dynamic subtest: gt1
[493.148077] Dynamic subtest gt1: SUCCESS (6.339s)
[493.159097] Starting dynamic subtest: runtime-pm-gt1
[500.632940] Dynamic subtest runtime-pm-gt1: SUCCESS (7.491s)
[500.651882] Starting dynamic subtest: runtime-pm-long-gt1
[513.102657] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.466s)
[513.115189] Starting dynamic subtest: other-idle-gt1
[519.451392] Dynamic subtest other-idle-gt1: SUCCESS (6.347s)
[519.454141] Subtest rc6: SUCCESS (65.604s)
[520.596150] [089/133] (500s left) kms_atomic_interruptible (legacy-cursor)
[520.697216] Starting subtest: legacy-cursor
[520.699357] Starting dynamic subtest: pipe-A-eDP-1
[528.131373] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.433s)
[528.133653] Subtest legacy-cursor: SUCCESS (7.435s)
[528.954243] [090/133] (492s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[529.004614] Starting subtest: etime-multi-wait-all-available-unsubmitted
[529.104685] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[529.161513] [091/133] (492s left) kms_dp_link_training (uhbr-sst)
[529.243916] Starting subtest: uhbr-sst
[529.252307] Subtest uhbr-sst: SKIP (0.000s)
[529.291924] [092/133] (491s left) i915_getparams_basic (basic-subslice-total)
[529.346668] Starting subtest: basic-subslice-total
[529.350700] Subtest basic-subslice-total: SUCCESS (0.000s)
[529.407391] [093/133] (491s left) dmabuf_sync_file (export-before-signal)
[529.447475] Starting subtest: export-before-signal
[529.449447] Subtest export-before-signal: SUCCESS (0.000s)
[529.485804] [094/133] (491s left) syncobj_wait (wait-all-for-submit-snapshot)
[529.536964] Starting subtest: wait-all-for-submit-snapshot
[529.616608] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[529.670039] [095/133] (491s left) syncobj_wait (wait-all-complex)
[529.736502] Starting subtest: wait-all-complex
[529.950038] Subtest wait-all-complex: SUCCESS (0.213s)
[530.001750] [096/133] (491s left) gem_mmap_gtt (cpuset-medium-copy)
[530.052755] Subtest cpuset-medium-copy: SKIP (0.000s)
[530.114616] [097/133] (491s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[530.215340] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[530.219695] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[530.283739] [098/133] (491s left) api_intel_bb (intel-bb-blit-none)
[530.338352] Starting subtest: intel-bb-blit-none
[534.455842] Subtest intel-bb-blit-none: SUCCESS (4.118s)
[534.540392] [099/133] (486s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[534.636597] Starting subtest: crc-primary-suspend-y-tiled-ccs
[534.638689] Starting dynamic subtest: pipe-A-eDP-1
[534.647279] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[534.656044] Starting dynamic subtest: pipe-B-eDP-1
[534.665066] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[534.673022] Starting dynamic subtest: pipe-C-eDP-1
[534.681190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[534.688774] Starting dynamic subtest: pipe-D-eDP-1
[534.696683] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[534.700527] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[536.911690] [100/133] (484s left) kms_rotation_crc (sprite-rotation-90)
[537.010297] Starting subtest: sprite-rotation-90
[537.014669] Subtest sprite-rotation-90: SKIP (0.001s)
[537.065257] [101/133] (484s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[537.465645] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[538.241122] [102/133] (483s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[538.300279] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[538.302701] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[538.385702] [103/133] (483s left) gem_exec_await (wide-contexts)
[538.644470] Starting subtest: wide-contexts
[561.664674] Subtest wide-contexts: SUCCESS (23.018s)
[561.836376] [104/133] (459s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[561.963444] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[561.967550] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[562.011957] [105/133] (459s left) syncobj_timeline (multi-wait-available-signaled)
[562.082182] Starting subtest: multi-wait-available-signaled
[562.084337] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[562.139780] [106/133] (459s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[562.230558] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[562.234649] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[562.296649] [107/133] (459s left) perf_pmu (interrupts)
[562.335122] Starting subtest: interrupts
[563.404050] Subtest interrupts: SUCCESS (1.069s)
[563.497069] [108/133] (458s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[563.602783] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[563.606950] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[563.671188] [109/133] (458s left) kms_chamelium_color (ctm-0-25)
[563.760568] Subtest ctm-0-25: SKIP (0.000s)
[563.816754] [110/133] (458s left) gem_exec_big (single)
[563.867101] Starting subtest: single
[567.146821] Subtest single: FAIL (3.218s)
[567.190180] [111/133] (454s left) gem_ctx_param (set-priority-invalid-size)
[567.289281] Starting subtest: set-priority-invalid-size
[567.291696] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[567.335360] [112/133] (454s left) kms_psr (psr-cursor-mmap-gtt)
[567.436925] Starting subtest: psr-cursor-mmap-gtt
[567.439136] Starting dynamic subtest: eDP-1
[569.161061] Dynamic subtest eDP-1: SUCCESS (1.725s)
[569.163376] Subtest psr-cursor-mmap-gtt: SUCCESS (1.726s)
[570.006429] [113/133] (452s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[570.110570] Starting subtest: fbcpsr-2p-rte
[570.114702] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[570.187912] [114/133] (451s left) kms_chamelium_frames (hdmi-crc-multiple)
[570.573692] Subtest hdmi-crc-multiple: SKIP (0.000s)
[571.426089] [115/133] (450s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[571.519351] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[571.521636] Starting dynamic subtest: pipe-A-eDP-1
[571.544376] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.555095] Starting dynamic subtest: pipe-B-eDP-1
[571.576184] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.584052] Starting dynamic subtest: pipe-C-eDP-1
[571.604725] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.612713] Starting dynamic subtest: pipe-D-eDP-1
[571.634136] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.638329] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[573.795905] [116/133] (448s left) kms_joiner (invalid-modeset-ultra-joiner)
[573.894637] Starting subtest: invalid-modeset-ultra-joiner
[573.898881] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[573.936804] [117/133] (448s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[573.997599] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[574.001648] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[574.160837] [118/133] (448s left) kms_draw_crc (fill-fb)
[574.267603] Starting subtest: fill-fb
[574.741202] Subtest fill-fb: SUCCESS (0.475s)
[574.812576] [119/133] (447s left) kms_force_connector_basic (force-load-detect)
[574.885888] Starting subtest: force-load-detect
[574.890260] Subtest force-load-detect: SKIP (0.000s)
[574.978922] [120/133] (447s left) gem_exec_schedule (preempt-engines)
[575.057638] Starting subtest: preempt-engines
[575.059684] Starting dynamic subtest: rcs0
[577.294819] Dynamic subtest rcs0: SUCCESS (2.244s)
[577.306840] Starting dynamic subtest: bcs0
[579.505463] Dynamic subtest bcs0: SUCCESS (2.209s)
[579.515886] Starting dynamic subtest: vcs0
[581.779287] Dynamic subtest vcs0: SUCCESS (2.271s)
[581.788223] Starting dynamic subtest: vcs1
[584.052229] Dynamic subtest vcs1: SUCCESS (2.270s)
[584.061160] Starting dynamic subtest: vecs0
[586.332954] Dynamic subtest vecs0: SUCCESS (2.278s)
[586.344507] Starting dynamic subtest: ccs0
[588.629640] Dynamic subtest ccs0: SUCCESS (2.296s)
[588.632056] Subtest preempt-engines: SUCCESS (13.581s)
[588.906781] [121/133] (433s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[589.008596] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[589.012992] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[589.089939] [122/133] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[589.185136] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[589.189091] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[589.253598] [123/133] (433s left) kms_plane_lowres (tiling-y)
[589.337807] Starting subtest: tiling-y
[589.342087] Subtest tiling-y: SKIP (0.000s)
[589.385040] [124/133] (433s left) gem_exec_balancer (parallel)
[589.649690] Starting subtest: parallel
[590.548573] Subtest parallel: SUCCESS (0.901s)
[590.950924] [125/133] (431s left) gem_pread (uncached)
[591.007605] Subtest uncached: SKIP (0.000s)
[591.071374] [126/133] (431s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[591.132298] Starting subtest: y-tiled-ccs-to-x-tiled
[591.136762] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[591.290295] [127/133] (431s left) kms_sequence (get-busy)
[591.393277] Starting subtest: get-busy
[591.395664] Starting dynamic subtest: pipe-A-eDP-1
[593.332865] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[593.344819] Starting dynamic subtest: pipe-B-eDP-1
[595.906663] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[595.916069] Starting dynamic subtest: pipe-C-eDP-1
[598.517962] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s)
[598.527284] Starting dynamic subtest: pipe-D-eDP-1
[601.055309] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[601.057220] Subtest get-busy: SUCCESS (9.662s)
[601.836268] [128/133] (420s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[601.935219] Starting subtest: psr-rgb101010-draw-mmap-gtt
[601.939193] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[602.001819] [129/133] (420s left) kms_psr (psr-sprite-mmap-cpu)
[602.087403] Starting subtest: psr-sprite-mmap-cpu
[602.089674] Starting dynamic subtest: eDP-1
[603.866522] Dynamic subtest eDP-1: SUCCESS (1.777s)
[603.868461] Subtest psr-sprite-mmap-cpu: SUCCESS (1.778s)
[604.687351] [130/133] (418s left) gem_ctx_param (invalid-size-set)
[604.751556] Starting subtest: invalid-size-set
[604.753824] Subtest invalid-size-set: SUCCESS (0.001s)
[604.824521] [131/133] (417s left) gem_workarounds (basic-read-fd)
[604.889440] Starting subtest: basic-read-fd
[604.904831] Subtest basic-read-fd: SUCCESS (0.012s)
[604.993419] [132/133] (417s left) kms_atomic (crtc-invalid-params)
[605.090885] Starting subtest: crtc-invalid-params
[605.093075] Starting dynamic subtest: pipe-A-eDP-1
[605.469731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.380s)
[605.472069] Subtest crtc-invalid-params: SUCCESS (0.381s)
[606.312649] [133/133] (416s left) kms_flip (plain-flip-fb-recreate)
[606.410165] Starting subtest: plain-flip-fb-recreate
[606.412521] Starting dynamic subtest: A-eDP1
[615.242887] Dynamic subtest A-eDP1: SUCCESS (8.836s)
[615.254918] Starting dynamic subtest: B-eDP1
[624.068665] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[624.079199] Starting dynamic subtest: C-eDP1
[632.892216] Dynamic subtest C-eDP1: SUCCESS (8.821s)
[632.904102] Starting dynamic subtest: D-eDP1
[641.720809] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[641.725134] Subtest plain-flip-fb-recreate: SUCCESS (35.317s)
[642.885680] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_bad_reloc
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: gem_busy
results: parsing output: 8/ for test: gem_pread
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: gem_lmem_swapping
results: parsing output: 19/ for test: prime_udl
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_color
results: parsing output: 22/ for test: i915_query
results: parsing output: 23/ for test: gem_fence_thrash
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_plane_scaling
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_getfb
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: tools_test
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: prime_mmap
results: parsing output: 37/ for test: gem_vm_create
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: gen7_exec_parse
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: gem_cs_tlb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: i915_pm_rps
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: gem_mmap_offset
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_set_tiling_vs_gtt
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_ctx_shared
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: prime_busy
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_partial_pwrite_pread
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: kms_plane_alpha_blend
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: kms_atomic_interruptible
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_dp_link_training
results: parsing output: 91/ for test: i915_getparams_basic
results: parsing output: 92/ for test: dmabuf_sync_file
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_chamelium_hpd
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_exec_await
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_chamelium_color
results: parsing output: 109/ for test: gem_exec_big
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_chamelium_frames
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_joiner
results: parsing output: 116/ for test: gem_render_copy
results: parsing output: 117/ for test: kms_draw_crc
results: parsing output: 118/ for test: kms_force_connector_basic
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_plane_lowres
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: gem_pread
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: kms_sequence
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_ctx_param
results: parsing output: 130/ for test: gem_workarounds
results: parsing output: 131/ for test: kms_atomic
results: parsing output: 132/ for test: kms_flip
Done.