[60.948380] Initializing watchdogs
[60.948426]   /dev/watchdog0
[60.962654] [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]
[60.967218] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.969798] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.973355] [001/133] (960s left) perf_pmu (busy-hang)
[61.039836] Starting subtest: busy-hang
[61.042300] Starting dynamic subtest: rcs0
[62.261066] Dynamic subtest rcs0: SUCCESS (1.221s)
[62.271411] Starting dynamic subtest: bcs0
[63.422372] Dynamic subtest bcs0: SUCCESS (1.160s)
[63.433135] Starting dynamic subtest: vcs0
[65.428432] Dynamic subtest vcs0: SUCCESS (2.004s)
[65.438081] Starting dynamic subtest: vcs1
[67.515456] Dynamic subtest vcs1: SUCCESS (2.084s)
[67.529497] Starting dynamic subtest: vecs0
[69.398451] Dynamic subtest vecs0: SUCCESS (1.880s)
[69.407339] Starting dynamic subtest: ccs0
[70.560498] Dynamic subtest ccs0: SUCCESS (1.163s)
[70.563085] Subtest busy-hang: SUCCESS (9.517s)
[70.673745] [002/133] (950s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[70.726910] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[70.834553] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[70.908617] [003/133] (950s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[71.030949] Starting subtest: cursorA-vs-flipA-toggle
[82.222833] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.187s)
[83.055395] [004/133] (938s left) kms_vrr (negative-basic)
[83.158878] Starting subtest: negative-basic
[83.165483] Starting dynamic subtest: pipe-A-eDP-1
[88.586433] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[88.901414] Subtest negative-basic: SUCCESS (5.739s)
[89.756946] [005/133] (931s left) kms_flip (2x-flip-vs-wf_vblank)
[89.861956] Starting subtest: 2x-flip-vs-wf_vblank
[89.872922] Subtest 2x-flip-vs-wf_vblank: SKIP (0.012s)
[89.968848] [006/133] (931s left) kms_pm_rpm (legacy-planes-dpms)
[92.116714] Starting subtest: legacy-planes-dpms
[92.119245] Starting dynamic subtest: plane-65
[100.572763] Dynamic subtest plane-65: SUCCESS (8.458s)
[100.583243] Starting dynamic subtest: plane-95
[108.870724] Dynamic subtest plane-95: SUCCESS (8.295s)
[108.881930] Starting dynamic subtest: plane-125
[117.200129] Dynamic subtest plane-125: SUCCESS (8.329s)
[117.210347] Starting dynamic subtest: plane-135
[125.516326] Dynamic subtest plane-135: SUCCESS (8.315s)
[125.518913] Subtest legacy-planes-dpms: SUCCESS (33.402s)
[125.926730] [007/133] (895s left) kms_chamelium_color (ctm-red-to-blue)
[126.018268] Subtest ctm-red-to-blue: SKIP (0.000s)
[126.063171] [008/133] (895s left) gem_ctx_isolation (nonpriv)
[126.137171] Starting subtest: nonpriv
[126.139600] Starting dynamic subtest: rcs0
[126.367297] Dynamic subtest rcs0: SUCCESS (0.230s)
[126.377901] Starting dynamic subtest: bcs0
[126.614846] Dynamic subtest bcs0: SUCCESS (0.247s)
[126.625262] Starting dynamic subtest: vcs0
[126.867646] Dynamic subtest vcs0: SUCCESS (0.253s)
[126.880045] Starting dynamic subtest: vcs1
[128.116998] Dynamic subtest vcs1: SUCCESS (1.249s)
[128.129180] Starting dynamic subtest: vecs0
[130.191020] Dynamic subtest vecs0: SUCCESS (2.073s)
[130.201954] Starting dynamic subtest: ccs0
[132.200906] Dynamic subtest ccs0: SUCCESS (2.009s)
[132.203288] Subtest nonpriv: SUCCESS (6.064s)
[132.449871] [009/133] (889s left) perf_pmu (frequency)
[132.498039] Starting subtest: frequency
[132.502748] Starting dynamic subtest: gt0
[134.659140] Dynamic subtest gt0: SUCCESS (2.154s)
[134.668746] Starting dynamic subtest: idle-gt0
[135.164594] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[135.175041] Starting dynamic subtest: gt1
[139.925660] Dynamic subtest gt1: SUCCESS (4.757s)
[139.935722] Starting dynamic subtest: idle-gt1
[140.432499] Dynamic subtest idle-gt1: SUCCESS (0.508s)
[140.435482] Subtest frequency: SUCCESS (7.936s)
[140.531734] [010/133] (881s left) gem_exec_alignment (forked)
[140.601706] Starting subtest: forked
[180.035852] Subtest forked: SUCCESS (39.436s)
[180.123347] [011/133] (841s left) kms_selftest (drm_format)
[180.207914] Starting subtest: drm_format
[180.283489] Starting dynamic subtest: drm_test_format_block_width_invalid
[180.385495] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.101s)
[180.394699] Starting dynamic subtest: drm_test_format_block_width_one_plane
[180.492512] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.107s)
[180.501824] Starting dynamic subtest: drm_test_format_block_width_two_plane
[180.583513] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.091s)
[180.593877] Starting dynamic subtest: drm_test_format_block_width_three_plane
[180.686751] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.102s)
[180.695982] Starting dynamic subtest: drm_test_format_block_width_tiled
[180.774211] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.088s)
[180.783662] Starting dynamic subtest: drm_test_format_block_height_invalid
[180.856281] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.082s)
[180.867313] Starting dynamic subtest: drm_test_format_block_height_one_plane
[180.958635] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.101s)
[180.968291] Starting dynamic subtest: drm_test_format_block_height_two_plane
[181.046845] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.087s)
[181.054143] Starting dynamic subtest: drm_test_format_block_height_three_plane
[181.133696] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.087s)
[181.143458] Starting dynamic subtest: drm_test_format_block_height_tiled
[181.210569] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.076s)
[181.219980] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[181.310828] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.101s)
[181.320422] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[181.411677] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.100s)
[181.421093] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[181.501701] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.089s)
[181.511094] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[181.599434] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.097s)
[181.606940] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[181.693608] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.094s)
[181.701183] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[181.782341] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.088s)
[181.789611] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[181.872718] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.090s)
[181.882184] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[181.961481] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.088s)
[181.963346] Subtest drm_format: SUCCESS (1.754s)
[182.108624] [012/133] (839s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[182.217804] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[182.221105] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[182.297676] [013/133] (839s left) syncobj_wait (multi-wait-all-submitted)
[182.352222] Starting subtest: multi-wait-all-submitted
[182.456888] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[182.528873] [014/133] (839s left) kms_flip (bo-too-big-interruptible)
[182.617956] Starting subtest: bo-too-big-interruptible
[182.620230] Starting dynamic subtest: A-eDP1
[183.949281] Dynamic subtest A-eDP1: SUCCESS (1.330s)
[183.961910] Starting dynamic subtest: B-eDP1
[185.190555] Dynamic subtest B-eDP1: SUCCESS (1.239s)
[185.200989] Starting dynamic subtest: C-eDP1
[186.433868] Dynamic subtest C-eDP1: SUCCESS (1.241s)
[186.444448] Starting dynamic subtest: D-eDP1
[187.686249] Dynamic subtest D-eDP1: SUCCESS (1.252s)
[187.691274] Subtest bo-too-big-interruptible: SUCCESS (5.073s)
[188.880710] [015/133] (833s left) kms_psr (psr2-sprite-plane-move)
[188.987696] Starting subtest: psr2-sprite-plane-move
[188.990052] Starting dynamic subtest: eDP-1
[190.728230] Dynamic subtest eDP-1: SUCCESS (1.741s)
[190.730573] Subtest psr2-sprite-plane-move: SUCCESS (1.742s)
[191.558833] [016/133] (830s left) syncobj_wait (reset-signaled)
[191.628056] Starting subtest: reset-signaled
[191.630441] Subtest reset-signaled: SUCCESS (0.000s)
[191.731570] [017/133] (830s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[191.818896] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[191.905621] [018/133] (830s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[191.994318] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[191.998663] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[192.078101] [019/133] (830s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[192.174460] Starting subtest: y-tiled-16bpp-rotate-270
[192.178725] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[192.270443] [020/133] (829s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[192.366053] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[192.370183] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[192.453262] [021/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[192.546654] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[192.550143] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[192.639832] [022/133] (829s left) gem_lmem_swapping (heavy-verify-multi)
[192.685066] Subtest heavy-verify-multi: SKIP (0.000s)
[192.723454] [023/133] (829s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[192.840461] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[193.531780] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[193.688839] [024/133] (828s left) gem_exec_fence (syncobj-timeline-chain-engines)
[194.246627] Starting subtest: syncobj-timeline-chain-engines
[194.373488] Subtest syncobj-timeline-chain-engines: SUCCESS (0.127s)
[196.011358] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[196.015257] [025/133] (826s left) i915_pm_rc6_residency (rc6-accuracy)
[196.072333] Starting subtest: rc6-accuracy
[196.074603] Starting dynamic subtest: gt0
[199.243365] Dynamic subtest gt0: SUCCESS (3.169s)
[199.255050] Starting dynamic subtest: gt1
[202.412496] Dynamic subtest gt1: SUCCESS (3.168s)
[202.415043] Subtest rc6-accuracy: SUCCESS (6.340s)
[202.487111] [026/133] (819s left) prime_mmap (test_userptr)
[202.550092] Starting subtest: test_userptr
[202.552432] Starting dynamic subtest: test_userptr-smem
[202.554388] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[202.556370] Subtest test_userptr: SUCCESS (0.001s)
[202.650890] [027/133] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[202.752075] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[202.756174] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[202.857042] [028/133] (819s left) kms_addfb_basic (legacy-format)
[202.908888] Starting subtest: legacy-format
[202.933848] Subtest legacy-format: SUCCESS (0.025s)
[203.075624] [029/133] (819s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[203.166902] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[203.193512] Starting dynamic subtest: pipe-A-plane-0
[203.626224] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[203.634685] Starting dynamic subtest: pipe-A-plane-3
[203.881803] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[203.890597] Starting dynamic subtest: pipe-A-plane-5
[203.893937] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[204.955093] Starting dynamic subtest: pipe-B-plane-0
[205.392538] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[205.412262] Starting dynamic subtest: pipe-B-plane-3
[205.647641] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[205.656832] Starting dynamic subtest: pipe-B-plane-5
[205.661678] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[205.961136] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.795s)
[206.827254] [030/133] (815s left) gem_userptr_blits (unsync-unmap-after-close)
[206.898608] Subtest unsync-unmap-after-close: SKIP (0.000s)
[207.024704] [031/133] (815s left) gem_readwrite (new-obj)
[207.080362] Subtest new-obj: SKIP (0.000s)
[207.133030] [032/133] (815s left) gem_exec_schedule (preempt-engines)
[207.210795] Starting subtest: preempt-engines
[207.213019] Starting dynamic subtest: rcs0
[209.471963] Dynamic subtest rcs0: SUCCESS (2.266s)
[209.484065] Starting dynamic subtest: bcs0
[211.762774] Dynamic subtest bcs0: SUCCESS (2.290s)
[211.774186] Starting dynamic subtest: vcs0
[214.043755] Dynamic subtest vcs0: SUCCESS (2.279s)
[214.055603] Starting dynamic subtest: vcs1
[216.329653] Dynamic subtest vcs1: SUCCESS (2.284s)
[216.338256] Starting dynamic subtest: vecs0
[218.605296] Dynamic subtest vecs0: SUCCESS (2.274s)
[218.614040] Starting dynamic subtest: ccs0
[220.925536] Dynamic subtest ccs0: SUCCESS (2.319s)
[220.928102] Subtest preempt-engines: SUCCESS (13.722s)
[221.227070] [033/133] (801s left) gen7_exec_parse (basic-offset)
[221.285232] Subtest basic-offset: SKIP (0.000s)
[221.350564] [034/133] (801s left) gem_shrink (reclaim)
[221.410302] Starting subtest: reclaim
[223.819055] Subtest reclaim: SUCCESS (2.405s)
[223.943916] [035/133] (798s left) syncobj_timeline (reset-unsignaled)
[224.000734] Starting subtest: reset-unsignaled
[224.002889] Subtest reset-unsignaled: SUCCESS (0.000s)
[224.097851] [036/133] (798s left) i915_module_load (reload-no-display)
[224.135908] Starting subtest: reload-no-display
[228.524200] Subtest reload-no-display: SUCCESS (4.389s)
[228.553843] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[228.554577] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[228.558136] [037/133] (794s left) drm_mm (drm_mm)
[228.613057] Starting subtest: drm_mm
[228.618916] Starting dynamic subtest: drm_test_mm_init
[228.702933] Dynamic subtest drm_test_mm_init: SUCCESS (0.082s)
[228.711025] Starting dynamic subtest: drm_test_mm_debug
[228.796979] Dynamic subtest drm_test_mm_debug: SUCCESS (0.093s)
[228.805180] Starting dynamic subtest: drm_test_mm_align32
[228.879934] Dynamic subtest drm_test_mm_align32: SUCCESS (0.082s)
[228.888107] Starting dynamic subtest: drm_test_mm_align64
[228.962680] Dynamic subtest drm_test_mm_align64: SUCCESS (0.083s)
[228.970646] Starting dynamic subtest: drm_test_mm_lowest
[229.054025] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.089s)
[229.062080] Starting dynamic subtest: drm_test_mm_highest
[229.159705] Dynamic subtest drm_test_mm_highest: SUCCESS (0.105s)
[229.161671] Subtest drm_mm: SUCCESS (0.545s)
[229.284176] [038/133] (793s left) kms_flip (2x-blocking-absolute-wf_vblank)
[230.857291] Starting subtest: 2x-blocking-absolute-wf_vblank
[230.869113] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[230.957738] [FACT kms_flip (2x-blocking-absolute-wf_vblank)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[230.958924] [FACT kms_flip (2x-blocking-absolute-wf_vblank)] new: kernel.kmod_is_loaded.i915: true
[230.962451] [039/133] (792s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[231.057055] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[235.365851] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.311s)
[236.582641] [040/133] (786s left) gem_close_race (basic-process)
[236.643679] Starting subtest: basic-process
[236.694487] Subtest basic-process: SUCCESS (0.051s)
[236.890335] [041/133] (786s left) kms_color (ctm-0-75)
[236.981648] Starting subtest: ctm-0-75
[236.983790] Starting dynamic subtest: pipe-A-eDP-1
[241.826616] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.844s)
[241.836712] Starting dynamic subtest: pipe-B-eDP-1
[247.542841] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.716s)
[247.551625] Starting dynamic subtest: pipe-C-eDP-1
[252.883840] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.340s)
[252.892830] Starting dynamic subtest: pipe-D-eDP-1
[258.221109] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.337s)
[258.223426] Subtest ctm-0-75: SUCCESS (21.240s)
[259.033435] [042/133] (764s left) prime_busy (after)
[259.091850] Starting subtest: after
[259.097063] Starting dynamic subtest: rcs0
[259.143950] Dynamic subtest rcs0: SUCCESS (0.049s)
[259.154507] Starting dynamic subtest: bcs0
[259.203210] Dynamic subtest bcs0: SUCCESS (0.058s)
[259.212643] Starting dynamic subtest: vcs0
[259.243665] Dynamic subtest vcs0: SUCCESS (0.040s)
[259.252484] Starting dynamic subtest: vcs1
[259.284256] Dynamic subtest vcs1: SUCCESS (0.040s)
[259.295462] Starting dynamic subtest: vecs0
[259.323081] Dynamic subtest vecs0: SUCCESS (0.036s)
[259.331288] Starting dynamic subtest: ccs0
[259.363591] Dynamic subtest ccs0: SUCCESS (0.040s)
[259.472521] Subtest after: SUCCESS (0.379s)
[259.550271] [043/133] (763s left) api_intel_allocator (default-alignment)
[259.613558] Starting subtest: default-alignment
[259.615937] Subtest default-alignment: SUCCESS (0.003s)
[259.726791] [044/133] (763s left) perf_pmu (all-busy-check-all)
[259.773879] Starting subtest: all-busy-check-all
[260.885523] Subtest all-busy-check-all: SUCCESS (1.110s)
[260.989537] [045/133] (762s left) gem_lmem_swapping (parallel-random-verify)
[261.032373] Subtest parallel-random-verify: SKIP (0.000s)
[261.081410] [046/133] (762s left) kms_atomic_interruptible (legacy-pageflip)
[261.170993] Starting subtest: legacy-pageflip
[261.173310] Starting dynamic subtest: pipe-A-eDP-1
[268.548892] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.375s)
[268.550981] Subtest legacy-pageflip: SUCCESS (7.376s)
[269.375347] [047/133] (753s left) i915_drm_fdinfo (memory-info-active)
[269.416517] Starting subtest: memory-info-active
[269.418739] Starting dynamic subtest: smem0
[271.946584] Dynamic subtest smem0: SUCCESS (2.530s)
[271.949132] Subtest memory-info-active: SUCCESS (2.531s)
[272.023943] [048/133] (751s left) kms_vblank (query-idle-hang)
[272.125730] Starting subtest: query-idle-hang
[272.127683] Starting dynamic subtest: pipe-A-eDP-1
[298.670538] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.541s)
[298.684083] Starting dynamic subtest: pipe-D-eDP-1
[313.694879] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.024s)
[313.697293] Subtest query-idle-hang: SUCCESS (41.570s)
[314.548227] [049/133] (708s left) kms_cursor_crc (cursor-onscreen-128x128)
[314.766296] Starting subtest: cursor-onscreen-128x128
[314.768600] Starting dynamic subtest: pipe-A-eDP-1
[316.867172] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.100s)
[316.897636] Starting dynamic subtest: pipe-D-eDP-1
[319.655546] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[319.657820] Subtest cursor-onscreen-128x128: SUCCESS (4.892s)
[320.519815] [050/133] (702s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[320.634412] Starting subtest: x-tiled-64bpp-rotate-0
[322.236530] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.602s)
[322.412823] [051/133] (701s left) kms_dp_linktrain_fallback (dp-fallback)
[322.513203] Starting subtest: dp-fallback
[322.519275] Subtest dp-fallback: SKIP (0.000s)
[322.584559] [052/133] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[322.679934] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[322.684353] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[322.784158] [053/133] (700s left) i915_pm_rps (thresholds)
[322.847645] Starting subtest: thresholds
[322.852216] Subtest thresholds: SKIP (0.001s)
[322.956942] [054/133] (700s left) gem_mmap_gtt (isolation)
[323.015862] Subtest isolation: SKIP (0.000s)
[323.086212] [055/133] (700s left) syncobj_timeline (wait-all-complex)
[323.139753] Starting subtest: wait-all-complex
[323.354950] Subtest wait-all-complex: SUCCESS (0.214s)
[323.444297] [056/133] (700s left) gem_exec_flush (basic-uc-ro-default)
[323.506440] Starting subtest: basic-uc-ro-default
[328.962473] Subtest basic-uc-ro-default: SUCCESS (5.456s)
[329.150064] [057/133] (694s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[329.356759] Starting subtest: cursor-rapid-movement-128x128
[329.361855] Starting dynamic subtest: pipe-A-eDP-1
[329.901652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[329.932856] Starting dynamic subtest: pipe-D-eDP-1
[331.124694] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.198s)
[331.127012] Subtest cursor-rapid-movement-128x128: SUCCESS (1.767s)
[331.972632] [058/133] (691s left) gem_exec_reloc (basic-write-gtt)
[332.040092] Subtest basic-write-gtt: SKIP (0.000s)
[332.111324] [059/133] (691s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[332.207412] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[332.211703] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[332.282428] [060/133] (691s left) gem_exec_reloc (basic-write-wc-noreloc)
[332.355297] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[332.425720] [061/133] (691s left) gem_exec_schedule (fairslice-all)
[332.501865] Starting subtest: fairslice-all
[334.556227] Subtest fairslice-all: SUCCESS (2.058s)
[335.914158] [062/133] (688s left) gem_exec_params (invalid-bsd-ring)
[335.966998] Starting subtest: invalid-bsd-ring
[335.969301] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[336.079981] [063/133] (687s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[336.181638] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[336.185705] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[336.295268] [064/133] (687s left) gem_busy (close-race)
[336.359187] Starting subtest: close-race
[359.892994] Subtest close-race: SUCCESS (23.532s)
[360.258480] [065/133] (663s left) sysfs_timeslice_duration (timeout)
[360.369687] Starting subtest: timeout
[360.372149] Starting dynamic subtest: vecs0
[368.910308] Dynamic subtest vecs0: SUCCESS (8.536s)
[368.920273] Starting dynamic subtest: ccs0
[370.165883] Dynamic subtest ccs0: SUCCESS (1.253s)
[370.176962] Starting dynamic subtest: vcs0
[379.857529] Dynamic subtest vcs0: SUCCESS (9.690s)
[379.868012] Starting dynamic subtest: bcs0
[380.415163] Dynamic subtest bcs0: SUCCESS (0.557s)
[380.424930] Starting dynamic subtest: rcs0
[381.621725] Dynamic subtest rcs0: SUCCESS (1.203s)
[381.633108] Starting dynamic subtest: vcs1
[390.928654] Dynamic subtest vcs1: SUCCESS (9.306s)
[390.931242] Subtest timeout: SUCCESS (30.558s)
[391.005312] [066/133] (633s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[391.422521] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[392.196270] [067/133] (631s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[392.301628] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[393.593673] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.714s)
[393.631156] [068/133] (630s left) gem_exec_capture (userptr)
[393.681393] Starting subtest: userptr
[394.512107] Subtest userptr: SUCCESS (0.831s)
[394.614536] [069/133] (629s left) gem_busy (busy)
[394.677242] Starting subtest: busy
[394.679564] Starting dynamic subtest: all-engines
[394.732971] Dynamic subtest all-engines: SUCCESS (0.055s)
[394.742362] Starting dynamic subtest: rcs0
[395.871290] Dynamic subtest rcs0: SUCCESS (1.137s)
[395.880291] Starting dynamic subtest: bcs0
[395.913678] Dynamic subtest bcs0: SUCCESS (0.041s)
[395.922879] Starting dynamic subtest: vcs0
[395.954587] Dynamic subtest vcs0: SUCCESS (0.038s)
[395.963749] Starting dynamic subtest: vcs1
[397.913218] Dynamic subtest vcs1: SUCCESS (1.956s)
[397.924780] Starting dynamic subtest: vecs0
[399.899139] Dynamic subtest vecs0: SUCCESS (1.984s)
[399.909972] Starting dynamic subtest: ccs0
[401.883550] Dynamic subtest ccs0: SUCCESS (1.982s)
[401.885735] Subtest busy: SUCCESS (7.203s)
[402.241509] [070/133] (622s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[402.343457] Starting subtest: fbc-rgb101010-draw-blt
[406.933679] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.595s)
[408.162734] [071/133] (616s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[408.255922] Starting subtest: dsc-fractional-bpp-with-bpc
[408.286647] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[408.327626] [072/133] (616s left) gem_exec_params (cliprects-invalid)
[408.386831] Starting subtest: cliprects-invalid
[408.389126] Subtest cliprects-invalid: SUCCESS (0.000s)
[408.491974] [073/133] (615s left) prime_mmap (test_errors)
[408.551339] Starting subtest: test_errors
[408.553571] Starting dynamic subtest: test_errors-smem
[408.649287] Dynamic subtest test_errors-smem: SUCCESS (0.100s)
[408.651721] Subtest test_errors: SUCCESS (0.101s)
[408.766125] [074/133] (615s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[408.856687] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[408.860956] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[408.928754] [075/133] (615s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[409.047565] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[417.648142] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.605s)
[417.773807] [076/133] (606s left) gem_exec_whisper (basic-forked)
[417.840277] Starting subtest: basic-forked
[425.246902] Subtest basic-forked: SUCCESS (7.406s)
[425.439201] [077/133] (599s left) gem_pxp (regular-baseline-src-copy-readible)
[425.568812] Starting subtest: regular-baseline-src-copy-readible
[425.636122] Subtest regular-baseline-src-copy-readible: SUCCESS (0.070s)
[425.761243] [078/133] (598s left) perf (disabled-read-error)
[425.937176] Starting subtest: disabled-read-error
[425.954938] Subtest disabled-read-error: SUCCESS (0.018s)
[426.005974] [079/133] (598s left) gem_mmap_wc (close)
[426.068306] Subtest close: SKIP (0.000s)
[426.138908] [080/133] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[426.244610] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[426.248611] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[426.338826] [081/133] (598s left) kms_properties (connector-properties-atomic)
[426.439057] Starting subtest: connector-properties-atomic
[426.440784] Starting dynamic subtest: pipe-A-eDP-1
[434.332272] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.893s)
[434.341721] Starting dynamic subtest: pipe-None-DP-1
[434.346168] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[434.354569] Starting dynamic subtest: pipe-None-HDMI-A-1
[434.358701] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[434.367082] Starting dynamic subtest: pipe-None-DP-2
[434.371117] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[434.380204] Starting dynamic subtest: pipe-None-HDMI-A-2
[434.384576] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[434.392896] Starting dynamic subtest: pipe-None-DP-3
[434.397355] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[434.405996] Starting dynamic subtest: pipe-None-DP-4
[434.410131] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[434.412186] Subtest connector-properties-atomic: SUCCESS (7.904s)
[435.195169] [082/133] (589s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[435.293603] Starting subtest: psr-rgb101010-draw-render
[442.625470] Subtest psr-rgb101010-draw-render: SUCCESS (7.335s)
[442.738419] [083/133] (582s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[442.794821] Starting subtest: invalid-signal-one-illegal-handle
[442.797158] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s)
[442.898176] [084/133] (581s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[443.001989] Starting subtest: extended-pageflip-modeset-hang-oldfb
[443.004267] Starting dynamic subtest: pipe-A
[450.893189] Dynamic subtest pipe-A: SUCCESS (7.891s)
[450.907391] Starting dynamic subtest: pipe-D
[459.510216] Dynamic subtest pipe-D: SUCCESS (8.611s)
[459.512496] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.508s)
[460.377397] [085/133] (564s left) gem_mmap_gtt (big-bo-tiledy)
[460.433792] Subtest big-bo-tiledY: SKIP (0.000s)
[460.500321] [086/133] (564s left) gem_fence_thrash (bo-write-verify-threaded-y)
[460.547780] Starting subtest: bo-write-verify-threaded-y
[460.562627] Subtest bo-write-verify-threaded-y: SKIP (0.017s)
[460.620932] [087/133] (564s left) perf_pmu (interrupts-sync)
[460.662780] Starting subtest: interrupts-sync
[461.760596] Subtest interrupts-sync: SUCCESS (1.097s)
[461.870405] [088/133] (563s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[461.956219] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[469.338192] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.386s)
[469.477370] [089/133] (555s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[469.581571] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[469.586077] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[469.691845] [090/133] (555s left) gem_ctx_engines (none)
[469.759268] Starting subtest: none
[469.761509] Subtest none: SUCCESS (0.001s)
[469.942724] [091/133] (555s left) gem_spin_batch (legacy-resubmit-new)
[470.011679] Starting subtest: legacy-resubmit-new
[470.014067] Starting dynamic subtest: default
[470.019468] Dynamic subtest default: SUCCESS (0.007s)
[470.030532] Starting dynamic subtest: render
[470.032688] Dynamic subtest render: SUCCESS (0.003s)
[470.041469] Starting dynamic subtest: bsd
[470.043382] Dynamic subtest bsd: SUCCESS (0.004s)
[470.052174] Starting dynamic subtest: bsd1
[470.054323] Dynamic subtest bsd1: SUCCESS (0.003s)
[470.062992] Starting dynamic subtest: bsd2
[470.065183] Dynamic subtest bsd2: SUCCESS (0.004s)
[470.073651] Starting dynamic subtest: blt
[470.075808] Dynamic subtest blt: SUCCESS (0.008s)
[470.084597] Starting dynamic subtest: vebox
[470.086823] Dynamic subtest vebox: SUCCESS (0.004s)
[470.089094] Subtest legacy-resubmit-new: SUCCESS (0.043s)
[471.931785] [092/133] (553s left) api_intel_bb (misplaced-blitter)
[471.986016] Starting subtest: misplaced-blitter
[471.991507] Subtest misplaced-blitter: SUCCESS (0.007s)
[472.114370] [093/133] (553s left) gem_exec_balancer (full-pulse)
[472.176974] Starting subtest: full-pulse
[476.793091] Subtest full-pulse: SUCCESS (4.615s)
[477.102457] [094/133] (548s left) kms_atomic (plane-overlay-legacy)
[477.199850] Starting subtest: plane-overlay-legacy
[477.202160] Starting dynamic subtest: pipe-A-eDP-1
[477.613740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[477.615649] Subtest plane-overlay-legacy: SUCCESS (0.415s)
[478.423449] [095/133] (546s left) kms_plane_scaling (planes-upscale-20x20)
[478.521189] Starting subtest: planes-upscale-20x20
[478.523465] Starting dynamic subtest: pipe-A
[478.580813] Dynamic subtest pipe-A: SUCCESS (0.062s)
[478.589712] Starting dynamic subtest: pipe-B
[479.752345] Dynamic subtest pipe-B: SUCCESS (1.170s)
[479.763799] Starting dynamic subtest: pipe-C
[480.865712] Dynamic subtest pipe-C: SUCCESS (1.113s)
[480.874737] Starting dynamic subtest: pipe-D
[481.990890] Dynamic subtest pipe-D: SUCCESS (1.124s)
[481.993187] Subtest planes-upscale-20x20: SUCCESS (3.473s)
[483.155408] [096/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[483.253646] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[489.954404] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.703s)
[490.081891] [097/133] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[490.179065] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[490.183255] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[490.263826] [098/133] (535s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[490.359838] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[490.362039] Starting dynamic subtest: pipe-A-eDP-1
[490.659342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.268s)
[490.671040] Starting dynamic subtest: pipe-B-eDP-1
[492.012160] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.353s)
[492.024229] Starting dynamic subtest: pipe-C-eDP-1
[493.255608] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.242s)
[493.266803] Starting dynamic subtest: pipe-D-eDP-1
[494.482249] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[494.484176] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.095s)
[495.710505] [099/133] (529s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[495.811099] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[495.815079] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[495.881111] [100/133] (529s left) kms_flip (2x-flip-vs-rmfb)
[495.980719] Starting subtest: 2x-flip-vs-rmfb
[495.990045] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[496.086873] [101/133] (529s left) kms_cursor_edge_walk (64x64-left-edge)
[496.174687] Starting subtest: 64x64-left-edge
[496.176809] Starting dynamic subtest: pipe-A-eDP-1
[499.678697] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.504s)
[499.688527] Starting dynamic subtest: pipe-D-eDP-1
[502.798435] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[502.800712] Subtest 64x64-left-edge: SUCCESS (6.625s)
[503.607869] [102/133] (522s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[503.700176] Starting subtest: fbcpsr-rgb565-draw-blt
[510.724170] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.028s)
[510.859697] [103/133] (514s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[510.967058] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[510.969334] Starting dynamic subtest: pipe-A-eDP-1
[510.989338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[510.998980] Starting dynamic subtest: pipe-B-eDP-1
[511.017548] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[511.026117] Starting dynamic subtest: pipe-C-eDP-1
[511.044493] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[511.053068] Starting dynamic subtest: pipe-D-eDP-1
[511.071267] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[511.073108] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[513.298345] [104/133] (512s left) gem_exec_schedule (u-semaphore-resolve)
[513.370587] Starting subtest: u-semaphore-resolve
[513.400830] Subtest u-semaphore-resolve: SUCCESS (0.037s)
[513.737153] [105/133] (512s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[513.801378] Starting subtest: etime-multi-wait-for-submit-submitted
[513.904975] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[513.981792] [106/133] (511s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[514.045548] Starting subtest: y-tiled-to-vebox-yf-tiled
[514.049616] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[514.233293] [107/133] (511s left) gem_render_linear_blits (basic)
[514.289597] Starting subtest: basic
[514.311177] Subtest basic: SUCCESS (0.022s)
[514.398272] [108/133] (511s left) gem_userptr_blits (sd-probe)
[514.471343] Starting subtest: sd-probe
[514.473529] Subtest sd-probe: SUCCESS (0.000s)
[514.603966] [109/133] (511s left) kms_content_protection (dp-mst-lic-type-1)
[514.749401] Starting subtest: dp-mst-lic-type-1
[514.753691] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[514.883535] [110/133] (511s left) kms_psr (psr-primary-page-flip)
[514.975068] Starting subtest: psr-primary-page-flip
[514.977286] Starting dynamic subtest: eDP-1
[516.695070] Dynamic subtest eDP-1: SUCCESS (1.718s)
[516.697237] Subtest psr-primary-page-flip: SUCCESS (1.719s)
[517.555286] [111/133] (508s left) gem_eio (in-flight-internal-1us)
[517.788484] Starting subtest: in-flight-internal-1us
[518.946119] Subtest in-flight-internal-1us: SUCCESS (1.156s)
[519.071362] [112/133] (506s left) kms_pipe_crc_basic (read-crc)
[519.166632] Starting subtest: read-crc
[519.168779] Starting dynamic subtest: pipe-A-eDP-1
[519.890963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[519.900973] Starting dynamic subtest: pipe-B-eDP-1
[521.236781] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.344s)
[521.246658] Starting dynamic subtest: pipe-C-eDP-1
[522.534814] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s)
[522.544301] Starting dynamic subtest: pipe-D-eDP-1
[523.855274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[523.857638] Subtest read-crc: SUCCESS (4.690s)
[524.707089] [113/133] (501s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[524.810704] Starting subtest: pr-overlay-plane-move-continuous-sf
[524.814658] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[524.879464] [114/133] (501s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[524.970289] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[524.972575] Starting dynamic subtest: pipe-A-eDP-1
[524.995275] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[525.006121] Starting dynamic subtest: pipe-B-eDP-1
[525.026133] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[525.034799] Starting dynamic subtest: pipe-C-eDP-1
[525.055400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[525.063738] Starting dynamic subtest: pipe-D-eDP-1
[525.085179] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[525.089453] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[527.260136] [115/133] (498s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[527.358466] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[527.362887] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[527.454426] [116/133] (498s left) gem_exec_balancer (sliced)
[527.509778] Starting subtest: sliced
[527.514323] Subtest sliced: SKIP (0.000s)
[527.805507] [117/133] (498s left) kms_hdr (static-swap)
[527.889757] Starting subtest: static-swap
[527.896254] Subtest static-swap: SKIP (0.000s)
[527.976122] [118/133] (498s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[528.078268] Starting subtest: 4-tiled-64bpp-rotate-90
[528.098135] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[528.224602] [119/133] (498s left) kms_pm_rpm (fences)
[530.075228] Starting subtest: fences
[530.080937] Subtest fences: SKIP (0.000s)
[530.515430] [120/133] (495s left) kms_addfb_basic (bad-pitch-0)
[530.566143] Starting subtest: bad-pitch-0
[530.568383] Subtest bad-pitch-0: SUCCESS (0.000s)
[530.704536] [121/133] (495s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[530.805778] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[530.807920] Starting dynamic subtest: pipe-A-eDP-1
[530.831796] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[530.842436] Starting dynamic subtest: pipe-B-eDP-1
[530.865947] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[530.875108] Starting dynamic subtest: pipe-C-eDP-1
[530.898614] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[530.907429] Starting dynamic subtest: pipe-D-eDP-1
[530.931350] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[530.935701] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[533.048996] [122/133] (493s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[533.111891] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[533.164174] [123/133] (493s left) kms_psr (fbc-psr2-primary-page-flip)
[533.261040] Starting subtest: fbc-psr2-primary-page-flip
[533.263320] Starting dynamic subtest: eDP-1
[533.267533] Dynamic subtest eDP-1: SKIP (0.000s)
[533.271702] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[533.332650] [124/133] (493s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[533.424952] Starting subtest: fbc-psr2-sprite-plane-onoff
[533.427168] Starting dynamic subtest: eDP-1
[533.431409] Dynamic subtest eDP-1: SKIP (0.000s)
[533.435743] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[533.500678] [125/133] (493s left) gem_ctx_persistence (legacy-engines-queued)
[533.557440] Starting subtest: legacy-engines-queued
[533.559792] Starting dynamic subtest: render
[533.628836] Dynamic subtest render: SUCCESS (0.071s)
[533.639155] Starting dynamic subtest: bsd1
[534.899434] Dynamic subtest bsd1: SUCCESS (1.266s)
[534.911345] Starting dynamic subtest: bsd2
[536.882766] Dynamic subtest bsd2: SUCCESS (1.980s)
[536.895517] Starting dynamic subtest: blt
[536.938076] Dynamic subtest blt: SUCCESS (0.054s)
[536.949300] Starting dynamic subtest: vebox
[538.869645] Dynamic subtest vebox: SUCCESS (1.925s)
[538.872287] Subtest legacy-engines-queued: SUCCESS (5.308s)
[538.947557] [126/133] (487s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[539.036677] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[539.038800] Starting dynamic subtest: pipe-A-eDP-1
[539.058513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[539.068985] Starting dynamic subtest: pipe-B-eDP-1
[539.087661] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[539.096506] Starting dynamic subtest: pipe-C-eDP-1
[539.114957] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[539.125744] Starting dynamic subtest: pipe-D-eDP-1
[539.144570] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[539.146437] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[541.315771] [127/133] (485s left) kms_hdr (bpc-switch-suspend)
[541.405055] Starting subtest: bpc-switch-suspend
[542.486832] Starting dynamic subtest: pipe-A-eDP-1
[562.550227] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.527s)
[562.552364] Subtest bpc-switch-suspend: SUCCESS (6.609s)
[562.681378] [128/133] (464s left) gem_pxp (create-regular-context-2)
[562.791097] Starting subtest: create-regular-context-2
[562.793383] Subtest create-regular-context-2: SUCCESS (0.001s)
[562.911214] [129/133] (463s left) kms_psr (fbc-pr-cursor-plane-onoff)
[562.992995] Starting subtest: fbc-pr-cursor-plane-onoff
[562.997237] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[563.070242] [130/133] (463s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[563.156119] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[563.160087] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[563.273327] [131/133] (463s left) kms_psr (fbc-psr-suspend)
[563.376770] Starting subtest: fbc-psr-suspend
[563.379054] Starting dynamic subtest: eDP-1
[563.383573] Dynamic subtest eDP-1: SKIP (0.000s)
[563.387870] Subtest fbc-psr-suspend: SKIP (0.003s)
[563.463996] [132/133] (463s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[563.571944] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[563.573770] Starting dynamic subtest: pipe-A
[564.719302] Dynamic subtest pipe-A: SUCCESS (1.140s)
[564.731843] Starting dynamic subtest: pipe-B
[566.977316] Dynamic subtest pipe-B: SUCCESS (2.242s)
[566.987396] Starting dynamic subtest: pipe-C
[568.155252] Dynamic subtest pipe-C: SUCCESS (1.169s)
[568.168127] Starting dynamic subtest: pipe-D
[569.397988] Dynamic subtest pipe-D: SUCCESS (1.236s)
[569.400258] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.793s)
[570.603936] [133/133] (456s left) kms_lease (lease-invalid-connector)
[570.691557] Starting subtest: lease-invalid-connector
[570.693823] Starting dynamic subtest: pipe-A-eDP-1
[570.696020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[570.706788] Starting dynamic subtest: pipe-B-eDP-1
[570.709209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[570.719549] Starting dynamic subtest: pipe-C-eDP-1
[570.721425] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[570.730824] Starting dynamic subtest: pipe-D-eDP-1
[570.732778] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[570.734679] Subtest lease-invalid-connector: SUCCESS (0.004s)
[570.778264] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_vrr
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: kms_chamelium_color
results: parsing output: 7/ for test: gem_ctx_isolation
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_exec_alignment
results: parsing output: 10/ for test: kms_selftest
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: i915_pm_rc6_residency
results: parsing output: 25/ for test: prime_mmap
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: gem_readwrite
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gen7_exec_parse
results: parsing output: 33/ for test: gem_shrink
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: i915_module_load
results: parsing output: 36/ for test: drm_mm
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_close_race
results: parsing output: 40/ for test: kms_color
results: parsing output: 41/ for test: prime_busy
results: parsing output: 42/ for test: api_intel_allocator
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: kms_atomic_interruptible
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_dp_linktrain_fallback
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: i915_pm_rps
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_busy
results: parsing output: 64/ for test: sysfs_timeslice_duration
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_exec_capture
results: parsing output: 68/ for test: gem_busy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_dsc
results: parsing output: 71/ for test: gem_exec_params
results: parsing output: 72/ for test: prime_mmap
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: gem_pxp
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_properties
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: gem_fence_thrash
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_engines
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: api_intel_bb
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: kms_atomic
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: gem_render_linear_blits
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_eio
results: parsing output: 111/ for test: kms_pipe_crc_basic
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_hdr
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_pipe_b_c_ivb
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_hdr
results: parsing output: 127/ for test: gem_pxp
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: kms_lease
Done.