[59.582546] Initializing watchdogs
[59.582595]   /dev/watchdog0
[59.597425] [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]
[59.602098] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.604322] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.606284] [001/133] (960s left) kms_cursor_crc (cursor-sliding-512x512)
[59.889570] Starting subtest: cursor-sliding-512x512
[59.892262] Subtest cursor-sliding-512x512: SKIP (0.001s)
[60.079187] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[60.176570] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[60.178221] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[60.275430] [003/133] (959s left) kms_selftest (drm_format)
[60.311688] Starting subtest: drm_format
[60.320245] Starting dynamic subtest: drm_test_format_block_width_invalid
[60.407128] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.086s)
[60.414169] Starting dynamic subtest: drm_test_format_block_width_one_plane
[60.493697] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.087s)
[60.500898] Starting dynamic subtest: drm_test_format_block_width_two_plane
[60.585820] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.092s)
[60.592480] Starting dynamic subtest: drm_test_format_block_width_three_plane
[60.667756] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.081s)
[60.675147] Starting dynamic subtest: drm_test_format_block_width_tiled
[60.762189] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.094s)
[60.768348] Starting dynamic subtest: drm_test_format_block_height_invalid
[60.850080] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.088s)
[60.857508] Starting dynamic subtest: drm_test_format_block_height_one_plane
[60.938553] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.089s)
[60.946241] Starting dynamic subtest: drm_test_format_block_height_two_plane
[61.040248] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.101s)
[61.046431] Starting dynamic subtest: drm_test_format_block_height_three_plane
[61.139176] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.098s)
[61.153183] Starting dynamic subtest: drm_test_format_block_height_tiled
[61.226862] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.087s)
[61.234632] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[61.360523] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.126s)
[61.368261] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[61.444065] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.091s)
[61.449723] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[61.542268] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.097s)
[61.549416] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[61.633693] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.092s)
[61.641140] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[61.722094] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.087s)
[61.729883] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[61.807029] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.085s)
[61.814738] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[61.897079] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.090s)
[61.903921] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[61.979730] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.083s)
[61.980771] Subtest drm_format: SUCCESS (1.673s)
[62.115857] [004/133] (958s left) gem_ctx_persistence (legacy-engines-mixed-process)
[62.181257] Starting subtest: legacy-engines-mixed-process
[62.182508] Starting dynamic subtest: render
[63.817558] Dynamic subtest render: SUCCESS (1.640s)
[63.828386] Starting dynamic subtest: bsd1
[65.878730] Dynamic subtest bsd1: SUCCESS (2.064s)
[65.885279] Starting dynamic subtest: bsd2
[68.110144] Dynamic subtest bsd2: SUCCESS (2.224s)
[68.125675] Starting dynamic subtest: blt
[69.903431] Dynamic subtest blt: SUCCESS (1.804s)
[69.911097] Starting dynamic subtest: vebox
[71.899935] Dynamic subtest vebox: SUCCESS (1.996s)
[71.901322] Subtest legacy-engines-mixed-process: SUCCESS (9.734s)
[71.973188] [005/133] (948s left) kms_flip (2x-flip-vs-panning)
[72.064314] Starting subtest: 2x-flip-vs-panning
[72.076018] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[72.165703] [006/133] (948s left) kms_cursor_crc (cursor-random-256x85)
[72.420931] Starting subtest: cursor-random-256x85
[72.474211] Subtest cursor-random-256x85: SKIP (0.051s)
[72.631075] [007/133] (947s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[72.727705] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[77.704915] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.980s)
[78.906967] [008/133] (941s left) kms_psr (pr-cursor-mmap-gtt)
[78.997095] Starting subtest: pr-cursor-mmap-gtt
[78.998852] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[79.061730] [009/133] (941s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[79.624258] Starting subtest: syncobj-timeline-multiple-ext-nodes
[79.625495] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[81.005121] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[81.006940] [010/133] (939s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[81.100280] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[87.813227] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.714s)
[87.912698] [011/133] (932s left) kms_joiner (basic-max-non-joiner)
[88.001673] Starting subtest: basic-max-non-joiner
[88.003477] Subtest basic-max-non-joiner: SKIP (0.000s)
[88.068483] [012/133] (932s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[88.109196] Starting subtest: single-wait-all-for-submit-available-signaled
[88.110180] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[88.196424] [013/133] (932s left) kms_flip (flip-vs-panning-vs-hang)
[88.281101] Starting subtest: flip-vs-panning-vs-hang
[88.282075] Starting dynamic subtest: A-eDP1
[139.395505] Dynamic subtest A-eDP1: SUCCESS (51.113s)
[139.404280] Starting dynamic subtest: D-eDP1
[189.378952] Dynamic subtest D-eDP1: SUCCESS (49.980s)
[189.381826] Subtest flip-vs-panning-vs-hang: SUCCESS (101.098s)
[190.518309] [014/133] (830s left) kms_psr (fbc-psr2-suspend)
[190.607361] Starting subtest: fbc-psr2-suspend
[190.608285] Starting dynamic subtest: eDP-1
[190.609974] Dynamic subtest eDP-1: SKIP (0.000s)
[190.611793] Subtest fbc-psr2-suspend: SKIP (0.000s)
[190.673396] [015/133] (829s left) gem_sync (basic-store-each)
[190.734294] Starting subtest: basic-store-each
[193.207761] Subtest basic-store-each: SUCCESS (2.474s)
[193.384852] [016/133] (827s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[193.485628] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[193.486483] Starting dynamic subtest: pipe-A-eDP-1
[209.955464] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.469s)
[209.967357] Starting dynamic subtest: pipe-B-eDP-1
[227.093034] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.136s)
[227.093945] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.608s)
[227.890114] [017/133] (792s left) gem_exec_parallel (contexts)
[227.958160] Starting subtest: contexts
[227.959117] Starting dynamic subtest: rcs0
[231.145076] Dynamic subtest rcs0: SUCCESS (3.177s)
[231.153473] Starting dynamic subtest: bcs0
[234.913224] Dynamic subtest bcs0: SUCCESS (3.767s)
[234.920140] Starting dynamic subtest: vcs0
[239.456404] Dynamic subtest vcs0: SUCCESS (4.541s)
[239.465375] Starting dynamic subtest: vcs1
[245.362341] Dynamic subtest vcs1: SUCCESS (5.868s)
[245.372973] Starting dynamic subtest: vecs0
[251.354930] Dynamic subtest vecs0: SUCCESS (5.990s)
[251.365376] Starting dynamic subtest: ccs0
[255.440353] Dynamic subtest ccs0: SUCCESS (4.120s)
[255.441691] Subtest contexts: SUCCESS (27.473s)
[255.612710] [018/133] (765s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[255.706938] Starting subtest: bad-aux-stride-yf-tiled-ccs
[255.707916] Starting dynamic subtest: pipe-A-eDP-1
[255.716407] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[255.724175] Starting dynamic subtest: pipe-B-eDP-1
[255.740470] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[255.747558] Starting dynamic subtest: pipe-C-eDP-1
[255.756030] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[255.762545] Starting dynamic subtest: pipe-D-eDP-1
[255.771148] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[255.772802] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[257.935542] [019/133] (762s left) perf_pmu (semaphore-wait-idle)
[257.969429] Starting subtest: semaphore-wait-idle
[257.970366] Starting dynamic subtest: rcs0
[258.492435] Dynamic subtest rcs0: SUCCESS (0.513s)
[258.501322] Starting dynamic subtest: bcs0
[259.005035] Dynamic subtest bcs0: SUCCESS (0.511s)
[259.016852] Starting dynamic subtest: vcs0
[259.517396] Dynamic subtest vcs0: SUCCESS (0.511s)
[259.527265] Starting dynamic subtest: vcs1
[260.029430] Dynamic subtest vcs1: SUCCESS (0.511s)
[260.039484] Starting dynamic subtest: vecs0
[260.541281] Dynamic subtest vecs0: SUCCESS (0.510s)
[260.551220] Starting dynamic subtest: ccs0
[261.058479] Dynamic subtest ccs0: SUCCESS (0.515s)
[261.059788] Subtest semaphore-wait-idle: SUCCESS (3.079s)
[261.161186] [020/133] (759s left) kms_big_fb (linear-8bpp-rotate-270)
[261.259343] Starting subtest: linear-8bpp-rotate-270
[261.280936] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[261.406361] [021/133] (759s left) kms_addfb_basic (legacy-format)
[261.451311] Starting subtest: legacy-format
[261.471407] Subtest legacy-format: SUCCESS (0.020s)
[261.585995] [022/133] (759s left) kms_frontbuffer_tracking (fbc-2p-rte)
[261.678425] Starting subtest: fbc-2p-rte
[261.680179] Subtest fbc-2p-rte: SKIP (0.000s)
[261.769544] [023/133] (759s left) gem_workarounds (suspend-resume)
[261.831367] Starting subtest: suspend-resume
[278.930058] Subtest suspend-resume: SUCCESS (1.695s)
[287.120858] [024/133] (741s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[287.227218] Starting subtest: yf-tiled-32bpp-rotate-0
[287.229159] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[287.305673] [025/133] (741s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[287.380032] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[287.381774] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[287.459011] [026/133] (741s left) dumb_buffer (map-invalid-size)
[287.502149] Starting subtest: map-invalid-size
[287.503146] Subtest map-invalid-size: SUCCESS (0.000s)
[287.591360] [027/133] (741s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[287.680247] Starting subtest: psr-rgb565-draw-pwrite
[294.708525] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.107s)
[294.815917] [028/133] (734s left) syncobj_wait (wait-delayed-signal)
[294.866467] Starting subtest: wait-delayed-signal
[294.969144] Subtest wait-delayed-signal: SUCCESS (0.103s)
[295.045396] [029/133] (734s left) syncobj_wait (multi-wait-for-submit-signaled)
[295.086956] Starting subtest: multi-wait-for-submit-signaled
[295.087827] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[295.193409] [030/133] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[295.286263] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[302.762473] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.508s)
[302.877816] [031/133] (726s left) gem_pxp (reject-modify-context-protection-off-1)
[302.998799] Starting subtest: reject-modify-context-protection-off-1
[303.000070] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[303.116924] [032/133] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[303.207821] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[303.209426] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[303.322738] [033/133] (725s left) gem_exec_flush (basic-uc-ro-default)
[303.377459] Starting subtest: basic-uc-ro-default
[308.825442] Subtest basic-uc-ro-default: SUCCESS (5.457s)
[309.012586] [034/133] (720s left) perf_pmu (busy-idle-check-all)
[309.060747] Starting subtest: busy-idle-check-all
[309.061814] Starting dynamic subtest: rcs0
[309.737420] Dynamic subtest rcs0: SUCCESS (0.677s)
[309.750244] Starting dynamic subtest: bcs0
[310.392355] Dynamic subtest bcs0: SUCCESS (0.654s)
[310.403633] Starting dynamic subtest: vcs0
[312.330643] Dynamic subtest vcs0: SUCCESS (1.928s)
[312.339580] Starting dynamic subtest: vcs1
[312.984211] Dynamic subtest vcs1: FAIL (0.641s)
[312.991938] Starting dynamic subtest: vecs0
[313.620460] Dynamic subtest vecs0: FAIL (0.623s)
[313.628382] Starting dynamic subtest: ccs0
[314.245524] Dynamic subtest ccs0: FAIL (0.623s)
[314.246396] Subtest busy-idle-check-all: FAIL (5.155s)
[314.376917] [035/133] (714s left) gem_exec_reloc (basic-write-gtt-noreloc)
[314.426504] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[314.488300] [036/133] (714s left) gem_exec_schedule (submit-late-slice)
[314.547533] Starting subtest: submit-late-slice
[314.548491] Starting dynamic subtest: rcs0
[314.600477] Dynamic subtest rcs0: SUCCESS (0.053s)
[314.608976] Starting dynamic subtest: bcs0
[314.652460] Dynamic subtest bcs0: SUCCESS (0.052s)
[314.667318] Starting dynamic subtest: vcs0
[314.707394] Dynamic subtest vcs0: SUCCESS (0.053s)
[314.721240] Starting dynamic subtest: vcs1
[314.758643] Dynamic subtest vcs1: SUCCESS (0.050s)
[314.770589] Starting dynamic subtest: vecs0
[314.804058] Dynamic subtest vecs0: SUCCESS (0.045s)
[314.814428] Starting dynamic subtest: ccs0
[314.864019] Dynamic subtest ccs0: SUCCESS (0.059s)
[314.865228] Subtest submit-late-slice: SUCCESS (0.317s)
[316.374797] [037/133] (713s left) kms_concurrent (multi-plane-atomic-lowres)
[316.462799] Starting subtest: multi-plane-atomic-lowres
[316.463621] Starting dynamic subtest: pipe-A-eDP-1
[316.975399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.512s)
[316.984574] Starting dynamic subtest: pipe-B-eDP-1
[318.267457] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.290s)
[318.276691] Starting dynamic subtest: pipe-C-eDP-1
[319.466070] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.198s)
[319.474295] Starting dynamic subtest: pipe-D-eDP-1
[320.707667] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[320.708617] Subtest multi-plane-atomic-lowres: SUCCESS (4.245s)
[321.541239] [038/133] (707s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[321.593051] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[321.593902] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[321.687003] [039/133] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[321.771645] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[328.535625] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.766s)
[328.683016] [040/133] (700s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[328.763751] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[328.765434] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[328.835705] [041/133] (700s left) i915_selftest (live)
[332.163511] Starting subtest: live
[332.164625] Starting dynamic subtest: sanitycheck
[336.510430] Dynamic subtest sanitycheck: SUCCESS (4.350s)
[336.519627] Starting dynamic subtest: uncore
[341.174176] Dynamic subtest uncore: SUCCESS (4.663s)
[341.183269] Starting dynamic subtest: workarounds
[345.752089] Dynamic subtest workarounds: SUCCESS (4.577s)
[345.760151] Starting dynamic subtest: gt_engines
[348.771720] Dynamic subtest gt_engines: SUCCESS (3.021s)
[348.779624] Starting dynamic subtest: gt_timelines
[366.650133] Dynamic subtest gt_timelines: SUCCESS (17.883s)
[366.659073] Starting dynamic subtest: gt_contexts
[370.988167] Dynamic subtest gt_contexts: SUCCESS (4.339s)
[370.996225] Starting dynamic subtest: gt_lrc
[375.358844] Dynamic subtest gt_lrc: SUCCESS (4.369s)
[375.367712] Starting dynamic subtest: gt_mocs
[378.283385] Dynamic subtest gt_mocs: SUCCESS (2.925s)
[378.292308] Starting dynamic subtest: gt_pm
[385.082018] Dynamic subtest gt_pm: SUCCESS (6.795s)
[385.090396] Starting dynamic subtest: gt_heartbeat
[389.427120] Dynamic subtest gt_heartbeat: SUCCESS (4.340s)
[389.435815] Starting dynamic subtest: gt_tlb
[398.754599] Dynamic subtest gt_tlb: SUCCESS (9.324s)
[398.763493] Starting dynamic subtest: requests
[410.271646] Dynamic subtest requests: SUCCESS (11.513s)
[410.280800] Starting dynamic subtest: migrate
[418.090973] Dynamic subtest migrate: SUCCESS (7.818s)
[418.100040] Starting dynamic subtest: active
[422.496907] Dynamic subtest active: SUCCESS (4.404s)
[422.505693] Starting dynamic subtest: objects
[427.226627] Dynamic subtest objects: SUCCESS (4.728s)
[427.236089] Starting dynamic subtest: mman
[432.100788] Dynamic subtest mman: SUCCESS (4.872s)
[432.109729] Starting dynamic subtest: dmabuf
[436.500799] Dynamic subtest dmabuf: SUCCESS (4.398s)
[436.509494] Starting dynamic subtest: vma
[440.815135] Dynamic subtest vma: SUCCESS (4.311s)
[440.824331] Starting dynamic subtest: coherency
[446.084667] Dynamic subtest coherency: SUCCESS (5.269s)
[446.093540] Starting dynamic subtest: gtt
[458.006110] Dynamic subtest gtt: SUCCESS (11.923s)
[458.014795] Starting dynamic subtest: gem
[465.933454] Dynamic subtest gem: SUCCESS (7.928s)
[465.942850] Starting dynamic subtest: evict
[471.500374] Dynamic subtest evict: SUCCESS (5.567s)
[471.509781] Starting dynamic subtest: hugepages
[480.283585] Dynamic subtest hugepages: SUCCESS (8.784s)
[480.294244] Starting dynamic subtest: gem_contexts
[509.081417] Dynamic subtest gem_contexts: SUCCESS (28.804s)
[509.090758] Starting dynamic subtest: client
[513.479323] Dynamic subtest client: SUCCESS (4.395s)
[513.487219] Starting dynamic subtest: gem_migrate
[517.813855] Dynamic subtest gem_migrate: SUCCESS (4.330s)
[517.822729] Starting dynamic subtest: reset
[520.580840] Dynamic subtest reset: SUCCESS (2.766s)
[520.590579] Starting dynamic subtest: memory_region
[524.903398] Dynamic subtest memory_region: SUCCESS (4.320s)
[524.912787] Starting dynamic subtest: hangcheck
[538.132598] Dynamic subtest hangcheck: SUCCESS (13.223s)
[538.141691] Starting dynamic subtest: execlists
[542.475842] Dynamic subtest execlists: SUCCESS (4.341s)
[542.485044] Starting dynamic subtest: ring_submission
[546.768563] Dynamic subtest ring_submission: SUCCESS (4.290s)
[546.777314] Starting dynamic subtest: perf
[551.078534] Dynamic subtest perf: SUCCESS (4.309s)
[551.087769] Starting dynamic subtest: slpc
[565.133241] Dynamic subtest slpc: SUCCESS (14.052s)
[565.141672] Starting dynamic subtest: guc
[569.028432] Dynamic subtest guc: SUCCESS (3.892s)
[569.037509] Starting dynamic subtest: guc_multi_lrc
[573.365857] Dynamic subtest guc_multi_lrc: SUCCESS (4.335s)
[573.377274] Starting dynamic subtest: guc_hang
[578.415154] Dynamic subtest guc_hang: SUCCESS (5.047s)
[578.423883] Starting dynamic subtest: late_gt_pm
[581.132869] Dynamic subtest late_gt_pm: SUCCESS (2.716s)
[581.134253] Subtest live: SUCCESS (248.985s)
[581.156529] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[581.157281] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[581.159173] [042/133] (448s left) gem_ccs (suspend-resume)
[582.767394] Starting subtest: suspend-resume
[582.769505] Subtest suspend-resume: SKIP (0.000s)
[582.842273] [FACT gem_ccs (suspend-resume)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[582.843589] [FACT gem_ccs (suspend-resume)] new: kernel.kmod_is_loaded.i915: true
[582.847391] [043/133] (446s left) gem_exec_reloc (basic-write-read-noreloc)
[582.908754] Subtest basic-write-read-noreloc: SKIP (0.000s)
[582.973566] [044/133] (446s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[583.075782] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[590.525800] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.452s)
[590.678395] [045/133] (439s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[590.774133] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[595.164463] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.392s)
[596.348429] [046/133] (433s left) syncobj_wait (reset-multiple-signaled)
[596.404975] Starting subtest: reset-multiple-signaled
[596.405942] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[596.493149] [047/133] (433s left) kms_rotation_crc (sprite-rotation-270)
[596.578798] Starting subtest: sprite-rotation-270
[596.580462] Subtest sprite-rotation-270: SKIP (0.001s)
[596.664497] [048/133] (433s left) gem_userptr_blits (userfault)
[596.711481] Starting subtest: userfault
[596.716212] Subtest userfault: SUCCESS (0.007s)
[596.844827] [049/133] (432s left) gem_mmap_offset (oob-read)
[596.894579] Starting subtest: oob-read
[596.895460] Subtest oob-read: SUCCESS (0.000s)
[596.988763] [050/133] (432s left) gem_exec_balancer (bonded-semaphore)
[597.050248] Starting subtest: bonded-semaphore
[597.052163] Subtest bonded-semaphore: SKIP (0.000s)
[597.340494] [051/133] (432s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[597.390091] Starting subtest: y-tiled-ccs-to-yf-tiled
[597.391759] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[597.565725] [052/133] (432s left) kms_getfb (getfb-addfb-different-handles)
[597.646690] Starting subtest: getfb-addfb-different-handles
[597.647547] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[597.736485] [053/133] (432s left) gem_exec_gttfill (engines)
[597.795174] Starting subtest: engines
[597.796335] Starting dynamic subtest: rcs0
[620.840896] Dynamic subtest rcs0: SUCCESS (23.046s)
[620.855826] Starting dynamic subtest: bcs0
[644.171097] Dynamic subtest bcs0: SUCCESS (23.333s)
[644.179949] Starting dynamic subtest: vcs0
[667.499504] Dynamic subtest vcs0: SUCCESS (23.331s)
[667.510906] Starting dynamic subtest: vcs1
[690.847059] Dynamic subtest vcs1: SUCCESS (23.350s)
[690.859356] Starting dynamic subtest: vecs0
[714.227346] Dynamic subtest vecs0: SUCCESS (23.373s)
[714.238123] Starting dynamic subtest: ccs0
[737.552641] Dynamic subtest ccs0: SUCCESS (23.337s)
[737.556372] Subtest engines: SUCCESS (139.780s)
[737.736023] [054/133] (292s left) gem_exec_reloc (basic-cpu-noreloc)
[737.844087] Subtest basic-cpu-noreloc: SKIP (0.000s)
[737.913831] [055/133] (292s left) gem_readwrite (new-obj)
[737.972108] Subtest new-obj: SKIP (0.000s)
[738.038868] [056/133] (292s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[738.138699] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[738.139816] Starting dynamic subtest: pipe-A-eDP-1
[738.148907] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[738.159151] Starting dynamic subtest: pipe-B-eDP-1
[738.167058] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[738.175126] Starting dynamic subtest: pipe-C-eDP-1
[738.182835] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[738.190836] Starting dynamic subtest: pipe-D-eDP-1
[738.199074] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[738.200546] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[740.472138] [057/133] (289s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[740.564013] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[740.591345] Starting dynamic subtest: pipe-A-plane-0
[740.882948] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[740.891640] Starting dynamic subtest: pipe-A-plane-3
[741.134742] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[741.147402] Starting dynamic subtest: pipe-A-plane-5
[741.149450] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[742.256877] Starting dynamic subtest: pipe-B-plane-0
[742.548513] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[742.557109] Starting dynamic subtest: pipe-B-plane-3
[742.781958] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[742.791533] Starting dynamic subtest: pipe-B-plane-5
[742.793057] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[743.108753] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.546s)
[743.945507] [058/133] (286s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[744.035276] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[744.037586] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[744.125107] [059/133] (286s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[744.194512] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[744.301095] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[744.375771] [060/133] (285s left) gem_spin_batch (spin-all-new)
[744.431328] Starting subtest: spin-all-new
[744.446569] Subtest spin-all-new: SUCCESS (0.015s)
[746.340258] [061/133] (283s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[746.396205] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[746.502432] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[746.571307] [062/133] (283s left) api_intel_bb (object-reloc-purge-cache)
[746.624728] Starting subtest: object-reloc-purge-cache
[746.628005] Subtest object-reloc-purge-cache: SKIP (0.003s)
[746.733480] [063/133] (283s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[746.818964] Starting subtest: fbc-pr-sprite-mmap-cpu
[746.820715] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[746.898550] [064/133] (283s left) kms_plane_scaling (planes-scaler-unity-scaling)
[746.977288] Starting subtest: planes-scaler-unity-scaling
[746.978143] Starting dynamic subtest: pipe-A
[747.040129] Dynamic subtest pipe-A: SUCCESS (0.064s)
[747.049820] Starting dynamic subtest: pipe-B
[748.158378] Dynamic subtest pipe-B: SUCCESS (1.117s)
[748.169129] Starting dynamic subtest: pipe-C
[749.269183] Dynamic subtest pipe-C: SUCCESS (1.109s)
[749.278145] Starting dynamic subtest: pipe-D
[750.398763] Dynamic subtest pipe-D: SUCCESS (1.129s)
[750.399669] Subtest planes-scaler-unity-scaling: SUCCESS (3.423s)
[751.551061] [065/133] (278s left) sysfs_defaults (readonly)
[751.599700] Starting subtest: readonly
[751.600534] Starting dynamic subtest: vecs0
[751.601414] Dynamic subtest vecs0: SUCCESS (0.000s)
[751.610179] Starting dynamic subtest: ccs0
[751.611002] Dynamic subtest ccs0: SUCCESS (0.000s)
[751.619063] Starting dynamic subtest: vcs0
[751.619866] Dynamic subtest vcs0: SUCCESS (0.000s)
[751.627741] Starting dynamic subtest: bcs0
[751.628567] Dynamic subtest bcs0: SUCCESS (0.000s)
[751.636394] Starting dynamic subtest: rcs0
[751.637278] Dynamic subtest rcs0: SUCCESS (0.000s)
[751.645145] Starting dynamic subtest: vcs1
[751.646159] Dynamic subtest vcs1: SUCCESS (0.000s)
[751.647065] Subtest readonly: SUCCESS (0.006s)
[751.695055] [066/133] (278s left) kms_vblank (wait-forked-busy)
[751.780061] Starting subtest: wait-forked-busy
[751.781065] Starting dynamic subtest: pipe-A-eDP-1
[753.653596] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[753.664119] Starting dynamic subtest: pipe-D-eDP-1
[756.218627] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[756.219535] Subtest wait-forked-busy: SUCCESS (4.441s)
[757.028180] [067/133] (273s left) gem_bad_reloc (negative-reloc-lut)
[757.075730] Subtest negative-reloc-lut: SKIP (0.000s)
[757.140548] [068/133] (273s left) gem_softpin (evict-active-interruptible)
[757.194821] Starting subtest: evict-active-interruptible
[757.200530] Subtest evict-active-interruptible: SUCCESS (0.007s)
[757.316662] [069/133] (273s left) kms_psr (psr2-sprite-mmap-cpu)
[757.408254] Starting subtest: psr2-sprite-mmap-cpu
[757.409441] Starting dynamic subtest: eDP-1
[759.106933] Dynamic subtest eDP-1: SUCCESS (1.699s)
[759.107738] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.700s)
[759.973532] [070/133] (270s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[760.057105] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[760.069467] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[760.144446] [071/133] (270s left) gem_mmap_gtt (basic-read-write)
[760.199356] Subtest basic-read-write: SKIP (0.000s)
[760.253788] [072/133] (270s left) kms_frontbuffer_tracking (fbc-stridechange)
[760.341365] Starting subtest: fbc-stridechange
[763.612357] Subtest fbc-stridechange: SUCCESS (3.272s)
[764.796025] [073/133] (265s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[764.893446] Starting subtest: fbc-tiling-linear
[768.598233] Subtest fbc-tiling-linear: SUCCESS (3.702s)
[769.760901] [074/133] (260s left) kms_async_flips (test-cursor-atomic)
[769.850245] Starting subtest: test-cursor-atomic
[770.243465] Starting dynamic subtest: pipe-A-eDP-1
[771.036131] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s)
[771.418442] Starting dynamic subtest: pipe-B-eDP-1
[772.163447] Dynamic subtest pipe-B-eDP-1: SKIP (0.752s)
[772.543251] Starting dynamic subtest: pipe-C-eDP-1
[773.293955] Dynamic subtest pipe-C-eDP-1: SKIP (0.757s)
[773.678896] Starting dynamic subtest: pipe-D-eDP-1
[774.434355] Dynamic subtest pipe-D-eDP-1: SKIP (0.762s)
[774.436090] Subtest test-cursor-atomic: SKIP (4.581s)
[775.613325] [075/133] (255s left) syncobj_eventfd (timeline-wait-before-signal)
[775.667655] Starting subtest: timeline-wait-before-signal
[775.697688] Subtest timeline-wait-before-signal: SUCCESS (0.032s)
[775.781551] [076/133] (254s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[775.875844] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[775.876683] Starting dynamic subtest: pipe-A-eDP-1
[775.886802] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[775.897043] Starting dynamic subtest: pipe-B-eDP-1
[775.906257] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[775.914627] Starting dynamic subtest: pipe-C-eDP-1
[775.923467] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[775.931692] Starting dynamic subtest: pipe-D-eDP-1
[775.941117] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[775.942670] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[778.169499] [077/133] (252s left) kms_draw_crc (draw-method-mmap-wc)
[778.257119] Starting subtest: draw-method-mmap-wc
[778.258044] Starting dynamic subtest: xrgb8888-untiled
[778.489702] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[778.499229] Starting dynamic subtest: rgb565-untiled
[778.723634] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[778.734155] Starting dynamic subtest: xrgb2101010-untiled
[778.946016] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[778.954806] Starting dynamic subtest: xbgr16161616f-untiled
[779.168416] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[779.178702] Starting dynamic subtest: xrgb8888-xtiled
[779.290858] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[779.305375] Starting dynamic subtest: rgb565-xtiled
[779.423869] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[779.433080] Starting dynamic subtest: xrgb2101010-xtiled
[779.557262] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[779.572136] Starting dynamic subtest: xbgr16161616f-xtiled
[779.691344] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[779.702007] Starting dynamic subtest: xrgb8888-4tiled
[779.846652] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[779.855087] Starting dynamic subtest: rgb565-4tiled
[779.991344] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[780.001395] Starting dynamic subtest: xrgb2101010-4tiled
[780.137839] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.142s)
[780.155718] Starting dynamic subtest: xbgr16161616f-4tiled
[780.314414] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.175s)
[780.315454] Subtest draw-method-mmap-wc: SUCCESS (2.058s)
[780.444324] [078/133] (250s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[780.540279] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[780.551813] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[780.653437] [079/133] (250s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[780.738228] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[780.739935] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[780.822255] [080/133] (250s left) kms_dp_linktrain_fallback (dsc-fallback)
[780.911169] Starting subtest: dsc-fallback
[780.913950] Subtest dsc-fallback: SKIP (0.000s)
[780.979461] [081/133] (250s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[781.392511] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[782.178162] [082/133] (248s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[782.285251] Starting subtest: 4-tiled-32bpp-rotate-180
[783.754752] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.469s)
[783.897751] [083/133] (247s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[783.988474] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[783.990119] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[784.101306] [084/133] (247s left) i915_pm_rpm (reg-read-ioctl)
[785.630461] Starting subtest: reg-read-ioctl
[788.033916] Subtest reg-read-ioctl: SUCCESS (2.404s)
[788.405599] [085/133] (242s left) kms_getfb (getfb-handle-protection)
[788.509124] Starting subtest: getfb-handle-protection
[788.536048] Subtest getfb-handle-protection: SUCCESS (0.027s)
[788.643995] [086/133] (242s left) gem_mmap_gtt (medium-copy-odd)
[788.687650] Subtest medium-copy-odd: SKIP (0.000s)
[788.743855] [087/133] (242s left) kms_chamelium_frames (hdmi-aspect-ratio)
[789.118235] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[789.906475] [088/133] (241s left) kms_color (ctm-signed)
[789.994063] Starting subtest: ctm-signed
[789.994921] Starting dynamic subtest: pipe-A-eDP-1
[792.114343] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[792.122975] Starting dynamic subtest: pipe-B-eDP-1
[794.938666] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.821s)
[794.947037] Starting dynamic subtest: pipe-C-eDP-1
[797.624417] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.684s)
[797.633519] Starting dynamic subtest: pipe-D-eDP-1
[800.282227] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.655s)
[800.283132] Subtest ctm-signed: SUCCESS (10.283s)
[801.108109] [089/133] (230s left) i915_pm_freq_api (freq-reset-multiple)
[801.162512] Starting subtest: freq-reset-multiple
[801.163481] Starting dynamic subtest: gt0
[811.192069] Dynamic subtest gt0: SUCCESS (10.023s)
[811.201471] Starting dynamic subtest: gt1
[819.719582] Dynamic subtest gt1: SUCCESS (8.514s)
[819.721116] Subtest freq-reset-multiple: SUCCESS (18.540s)
[819.787331] [090/133] (211s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[819.887825] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[819.888697] Starting dynamic subtest: pipe-A-eDP-1
[819.896334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[819.905714] Starting dynamic subtest: pipe-B-eDP-1
[819.913474] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[819.922306] Starting dynamic subtest: pipe-C-eDP-1
[819.929807] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[819.938299] Starting dynamic subtest: pipe-D-eDP-1
[819.946121] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[819.946998] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[822.171725] [091/133] (209s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[822.265235] Starting subtest: x-tiled-32bpp-rotate-270
[822.284787] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[822.388746] [092/133] (208s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[822.473140] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[822.474827] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[822.569963] [093/133] (208s left) gem_ctx_persistence (engines-mixed)
[822.621822] Starting subtest: engines-mixed
[822.622794] Starting dynamic subtest: rcs0
[822.688331] Dynamic subtest rcs0: SUCCESS (0.066s)
[822.702155] Starting dynamic subtest: bcs0
[822.747487] Dynamic subtest bcs0: SUCCESS (0.058s)
[822.760938] Starting dynamic subtest: vcs0
[822.794296] Dynamic subtest vcs0: SUCCESS (0.045s)
[822.805904] Starting dynamic subtest: vcs1
[822.842084] Dynamic subtest vcs1: SUCCESS (0.046s)
[822.856119] Starting dynamic subtest: vecs0
[822.906368] Dynamic subtest vecs0: SUCCESS (0.063s)
[822.920398] Starting dynamic subtest: ccs0
[822.955280] Dynamic subtest ccs0: SUCCESS (0.047s)
[822.956867] Subtest engines-mixed: SUCCESS (0.334s)
[823.030196] [094/133] (208s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[823.115152] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[823.116095] Starting dynamic subtest: pipe-A
[824.310226] Dynamic subtest pipe-A: SUCCESS (1.195s)
[824.319343] Starting dynamic subtest: pipe-B
[826.521872] Dynamic subtest pipe-B: SUCCESS (2.210s)
[826.532976] Starting dynamic subtest: pipe-C
[827.681505] Dynamic subtest pipe-C: SUCCESS (1.158s)
[827.692743] Starting dynamic subtest: pipe-D
[828.821550] Dynamic subtest pipe-D: SUCCESS (1.138s)
[828.823227] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.706s)
[830.023501] [095/133] (201s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[830.137538] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[830.139012] Starting dynamic subtest: A-eDP1
[839.076176] Dynamic subtest A-eDP1: SUCCESS (8.934s)
[839.088394] Starting dynamic subtest: B-eDP1
[848.010882] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[848.022690] Starting dynamic subtest: C-eDP1
[856.963592] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[856.975409] Starting dynamic subtest: D-eDP1
[865.897633] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[865.898820] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.720s)
[867.086188] [096/133] (164s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[867.185873] Starting subtest: multiplane-rotation-cropping-top
[884.735448] Subtest multiplane-rotation-cropping-top: SUCCESS (17.549s)
[884.838580] [097/133] (146s left) gem_lmem_swapping (verify)
[884.882055] Subtest verify: SKIP (0.000s)
[884.920402] [098/133] (146s left) kms_plane_cursor (viewport)
[884.999066] Starting subtest: viewport
[885.000816] Starting dynamic subtest: pipe-A-eDP-1-size-64
[887.520351] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.521s)
[887.584340] Starting dynamic subtest: pipe-A-eDP-1-size-128
[890.065961] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s)
[890.130513] Starting dynamic subtest: pipe-A-eDP-1-size-256
[892.589081] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s)
[892.936629] Starting dynamic subtest: pipe-B-eDP-1-size-64
[896.087557] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.160s)
[896.149903] Starting dynamic subtest: pipe-B-eDP-1-size-128
[898.655432] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.516s)
[898.719233] Starting dynamic subtest: pipe-B-eDP-1-size-256
[901.189654] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.482s)
[901.544727] Starting dynamic subtest: pipe-C-eDP-1-size-64
[904.343805] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.807s)
[904.383887] Starting dynamic subtest: pipe-C-eDP-1-size-128
[906.510824] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s)
[906.551865] Starting dynamic subtest: pipe-C-eDP-1-size-256
[908.688579] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[909.017550] Starting dynamic subtest: pipe-D-eDP-1-size-64
[911.929532] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.924s)
[911.970508] Starting dynamic subtest: pipe-D-eDP-1-size-128
[914.151561] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.192s)
[914.191770] Starting dynamic subtest: pipe-D-eDP-1-size-256
[916.340772] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[916.662978] Subtest viewport: SUCCESS (31.662s)
[917.506212] [099/133] (114s left) gem_ctx_param (basic)
[917.565171] Starting subtest: basic
[917.566311] Subtest basic: SUCCESS (0.001s)
[917.675028] [100/133] (113s left) api_intel_allocator (reopen-fork)
[917.722775] Starting subtest: reopen-fork
[921.147969] Subtest reopen-fork: SUCCESS (3.417s)
[921.227041] [101/133] (110s left) gem_exec_balancer (semaphore)
[921.286053] Starting subtest: semaphore
[923.335071] Subtest semaphore: SUCCESS (2.040s)
[923.658576] [102/133] (108s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[923.777180] Starting subtest: flip-vs-cursor-busy-crc-legacy
[924.586944] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.809s)
[925.454349] [103/133] (106s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[925.565582] Starting subtest: extended-modeset-hang-oldfb-with-reset
[925.566337] Starting dynamic subtest: pipe-A
[937.691598] Dynamic subtest pipe-A: SUCCESS (12.124s)
[937.702146] Starting dynamic subtest: pipe-D
[950.267881] Dynamic subtest pipe-D: SUCCESS (12.573s)
[950.269072] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.702s)
[951.060165] [104/133] ( 80s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[951.154415] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[951.156526] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[951.243499] [105/133] ( 80s left) gem_exec_reloc (basic-cpu-gtt-active)
[951.304542] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[951.372709] [106/133] ( 80s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[951.433221] Starting subtest: multi-wait-for-submit-available-submitted
[951.434312] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[951.528208] [107/133] ( 80s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[951.594571] Starting subtest: invalid-bsd1-flag-on-blt
[951.595537] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[951.704315] [108/133] ( 80s left) gem_exec_schedule (preempt-other)
[951.762789] Starting subtest: preempt-other
[951.763767] Starting dynamic subtest: rcs0
[951.834999] Dynamic subtest rcs0: SUCCESS (0.071s)
[951.848181] Starting dynamic subtest: bcs0
[951.900001] Dynamic subtest bcs0: SUCCESS (0.064s)
[951.913124] Starting dynamic subtest: vcs0
[951.968640] Dynamic subtest vcs0: SUCCESS (0.068s)
[951.983213] Starting dynamic subtest: vcs1
[952.036817] Dynamic subtest vcs1: SUCCESS (0.067s)
[952.050541] Starting dynamic subtest: vecs0
[952.101443] Dynamic subtest vecs0: SUCCESS (0.064s)
[952.117342] Starting dynamic subtest: ccs0
[952.167916] Dynamic subtest ccs0: SUCCESS (0.066s)
[952.168954] Subtest preempt-other: SUCCESS (0.405s)
[953.365576] [109/133] ( 78s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[953.470030] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[953.471789] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[953.557544] [110/133] ( 78s left) kms_cursor_crc (cursor-onscreen-64x21)
[953.735678] Starting subtest: cursor-onscreen-64x21
[953.781878] Subtest cursor-onscreen-64x21: SKIP (0.045s)
[954.011796] [111/133] ( 78s left) kms_vrr (max-min)
[954.113022] Starting subtest: max-min
[954.115540] Subtest max-min: SKIP (0.000s)
[954.179983] [112/133] ( 77s left) gem_exec_params (secure-non-master)
[954.239362] Starting subtest: secure-non-master
[954.241320] Subtest secure-non-master: SKIP (0.000s)
[954.354807] [113/133] ( 77s left) gem_mmap_wc (pf-nonblock)
[954.407986] Subtest pf-nonblock: SKIP (0.000s)
[954.464365] [114/133] ( 77s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[954.552960] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[954.554671] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[954.655704] [115/133] ( 77s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[954.741626] Starting subtest: stress-xrgb8888-ytiled
[954.743259] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[954.812144] [116/133] ( 77s left) gem_exec_nop (basic-series)
[954.876699] Starting subtest: basic-series
[971.341233] Subtest basic-series: SUCCESS (16.456s)
[971.536139] [117/133] ( 60s left) gem_lmem_swapping (heavy-random)
[971.576457] Subtest heavy-random: SKIP (0.000s)
[971.610408] [118/133] ( 60s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[971.698976] Starting subtest: flip-vs-dpms-off-vs-modeset
[971.699915] Starting dynamic subtest: A-eDP1
[975.314947] Dynamic subtest A-eDP1: SUCCESS (3.614s)
[975.324223] Starting dynamic subtest: B-eDP1
[978.528886] Dynamic subtest B-eDP1: SUCCESS (3.213s)
[978.538280] Starting dynamic subtest: C-eDP1
[981.639147] Dynamic subtest C-eDP1: SUCCESS (3.110s)
[981.648489] Starting dynamic subtest: D-eDP1
[984.752065] Dynamic subtest D-eDP1: SUCCESS (3.113s)
[984.754318] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.057s)
[985.568294] [119/133] ( 46s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[985.651644] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[985.653242] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[985.739227] [120/133] ( 46s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[985.837689] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[985.838536] Starting dynamic subtest: pipe-A-eDP-1
[985.926644] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[985.938580] Starting dynamic subtest: pipe-B-eDP-1
[987.034279] Dynamic subtest pipe-B-eDP-1: SKIP (1.107s)
[987.036021] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.198s)
[988.321041] [121/133] ( 44s left) kms_chamelium_color (ctm-negative)
[988.408990] Subtest ctm-negative: SKIP (0.000s)
[988.452483] [122/133] ( 44s left) kms_pm_dc (dc3co-vpb-simulation)
[989.544886] Starting subtest: dc3co-vpb-simulation
[998.286473] Subtest dc3co-vpb-simulation: SKIP (8.694s)
[998.361145] [123/133] ( 34s left) i915_drm_fdinfo (memory-info-idle)
[998.412561] Starting subtest: memory-info-idle
[998.413804] Starting dynamic subtest: smem0
[998.480016] Dynamic subtest smem0: SUCCESS (0.067s)
[998.481472] Subtest memory-info-idle: SUCCESS (0.067s)
[998.564998] [124/133] ( 33s left) gen7_exec_parse (basic-rejected)
[998.623186] Subtest basic-rejected: SKIP (0.000s)
[998.681465] [125/133] ( 33s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[998.783042] Starting subtest: yf-tiled-8bpp-rotate-90
[998.784954] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[998.882883] [126/133] ( 33s left) syncobj_timeline (invalid-query-illegal-handle)
[998.935362] Starting subtest: invalid-query-illegal-handle
[998.936362] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[999.049262] [127/133] ( 33s left) gem_exec_whisper (basic-normal)
[999.103364] Starting subtest: basic-normal
[1003.416286] Subtest basic-normal: SUCCESS (4.315s)
[1003.603384] [128/133] ( 29s left) kms_pm_rpm (modeset-non-lpsp)
[1005.432063] Starting subtest: modeset-non-lpsp
[1006.598646] Subtest modeset-non-lpsp: SKIP (1.165s)
[1006.965855] [129/133] ( 25s left) gem_mmap_wc (copy)
[1007.011714] Subtest copy: SKIP (0.000s)
[1007.066987] [130/133] ( 25s left) kms_flip (dpms-vs-vblank-race)
[1007.147923] Starting subtest: dpms-vs-vblank-race
[1007.148839] Starting dynamic subtest: A-eDP1
[1011.030902] Dynamic subtest A-eDP1: SUCCESS (3.882s)
[1011.042186] Starting dynamic subtest: B-eDP1
[1015.634751] Dynamic subtest B-eDP1: SUCCESS (4.601s)
[1015.645504] Starting dynamic subtest: C-eDP1
[1020.239630] Dynamic subtest C-eDP1: SUCCESS (4.602s)
[1020.252936] Starting dynamic subtest: D-eDP1
[1024.881166] Dynamic subtest D-eDP1: SUCCESS (4.638s)
[1024.884829] Subtest dpms-vs-vblank-race: SUCCESS (17.739s)
[1025.765259] [131/133] (  7s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[1025.877529] Starting subtest: fbc-pr-cursor-plane-update-sf
[1025.879382] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[1025.976759] [132/133] (  6s left) gem_ctx_shared (single-timeline)
[1026.037899] Starting subtest: single-timeline
[1026.054662] Subtest single-timeline: SUCCESS (0.016s)
[1026.282417] [133/133] (  6s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[1026.375515] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[1026.377169] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[1026.442408] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_selftest
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_joiner
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_sync
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_exec_parallel
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_workarounds
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: dumb_buffer
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_flush
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_concurrent
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: i915_selftest
results: parsing output: 41/ for test: gem_ccs
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: kms_getfb
results: parsing output: 52/ for test: gem_exec_gttfill
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_readwrite
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_spin_batch
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: api_intel_bb
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: sysfs_defaults
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: gem_bad_reloc
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_async_flips
results: parsing output: 74/ for test: syncobj_eventfd
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_draw_crc
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_dp_linktrain_fallback
results: parsing output: 80/ for test: kms_chamelium_hpd
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: i915_pm_rpm
results: parsing output: 84/ for test: kms_getfb
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_chamelium_frames
results: parsing output: 87/ for test: kms_color
results: parsing output: 88/ for test: i915_pm_freq_api
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_rotation_crc
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_plane_cursor
results: parsing output: 98/ for test: gem_ctx_param
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_busy
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_vrr
results: parsing output: 111/ for test: gem_exec_params
results: parsing output: 112/ for test: gem_mmap_wc
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_pipe_stress
results: parsing output: 115/ for test: gem_exec_nop
results: parsing output: 116/ for test: gem_lmem_swapping
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_chamelium_color
results: parsing output: 121/ for test: kms_pm_dc
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: gen7_exec_parse
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_exec_whisper
results: parsing output: 127/ for test: kms_pm_rpm
results: parsing output: 128/ for test: gem_mmap_wc
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: gem_ctx_shared
results: parsing output: 132/ for test: kms_joiner
Done.