[64.829208] Initializing watchdogs
[64.829331]   /dev/watchdog0
[64.844219] [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]
[64.848409] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.850600] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.853921] [001/133] (960s left) kms_psr (psr-cursor-mmap-cpu)
[64.996166] Starting subtest: psr-cursor-mmap-cpu
[64.998708] Starting dynamic subtest: eDP-1
[66.671175] Dynamic subtest eDP-1: SUCCESS (1.683s)
[66.674014] Subtest psr-cursor-mmap-cpu: SUCCESS (1.684s)
[67.591789] [002/133] (957s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[67.766219] Starting subtest: multi-wait-for-submit-unsubmitted
[67.874504] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[67.982191] [003/133] (957s left) kms_async_flips (async-flip-dpms)
[68.093113] Starting subtest: async-flip-dpms
[68.462500] Starting dynamic subtest: pipe-A-eDP-1
[72.367087] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.905s)
[72.747869] Starting dynamic subtest: pipe-B-eDP-1
[75.542483] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.801s)
[75.933325] Starting dynamic subtest: pipe-C-eDP-1
[78.707850] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.782s)
[79.085976] Starting dynamic subtest: pipe-D-eDP-1
[81.875501] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.796s)
[81.878030] Subtest async-flip-dpms: SUCCESS (13.785s)
[83.072621] [004/133] (942s left) kms_pm_dc (dc6-dpms)
[84.171339] Starting subtest: dc6-dpms
[86.223770] Subtest dc6-dpms: SUCCESS (2.052s)
[86.317094] [005/133] (939s left) kms_color (ctm-negative)
[86.423791] Starting subtest: ctm-negative
[86.426550] Starting dynamic subtest: pipe-A-eDP-1
[87.134278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[87.143173] Starting dynamic subtest: pipe-B-eDP-1
[88.598569] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s)
[88.607184] Starting dynamic subtest: pipe-C-eDP-1
[89.975637] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[89.987370] Starting dynamic subtest: pipe-D-eDP-1
[91.302842] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[91.305195] Subtest ctm-negative: SUCCESS (4.878s)
[92.123785] [006/133] (933s left) syncobj_timeline (reset-unsignaled)
[92.177246] Starting subtest: reset-unsignaled
[92.179853] Subtest reset-unsignaled: SUCCESS (0.000s)
[92.314148] [007/133] (933s left) perf (gen12-oa-tlb-invalidate)
[92.449906] Starting subtest: gen12-oa-tlb-invalidate
[92.452054] Starting dynamic subtest: 0-rcs0
[102.508792] Dynamic subtest 0-rcs0: SUCCESS (10.058s)
[102.516090] Starting dynamic subtest: 1-vcs1
[112.557073] Dynamic subtest 1-vcs1: SUCCESS (10.048s)
[112.559779] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.107s)
[112.598122] [008/133] (913s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[112.712884] Starting subtest: 4-tiled-16bpp-rotate-180
[113.947292] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.235s)
[114.093200] [009/133] (911s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[114.195409] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[114.197252] Starting dynamic subtest: pipe-A-eDP-1
[114.215829] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[114.224928] Starting dynamic subtest: pipe-B-eDP-1
[114.242961] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[114.249601] Starting dynamic subtest: pipe-C-eDP-1
[114.266748] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[114.273122] Starting dynamic subtest: pipe-D-eDP-1
[114.291080] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[114.294693] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[116.483723] [010/133] (909s left) gem_exec_balancer (full)
[116.542277] Starting subtest: full
[120.769123] Subtest full: SUCCESS (4.227s)
[121.103320] [011/133] (904s left) gen9_exec_parse (unaligned-jump)
[121.162611] Subtest unaligned-jump: SKIP (0.000s)
[121.243776] [012/133] (904s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[121.355119] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[122.455539] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.101s)
[122.610591] [013/133] (903s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[122.728690] Starting subtest: fbcpsr-argb161616f-draw-blt
[122.732349] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[122.850663] [014/133] (903s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[122.962938] Starting subtest: cursorA-vs-flipB-atomic-transitions
[122.966738] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[123.138256] [015/133] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[123.232268] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[123.235841] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[123.373455] [016/133] (902s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[123.462329] Starting subtest: sprite-rotation-90-pos-100-0
[123.465867] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[123.553106] [017/133] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[123.648115] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[123.651507] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[123.783813] [018/133] (902s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[123.843071] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[123.846841] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[124.046901] [019/133] (902s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[124.136946] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[124.139366] Starting dynamic subtest: pipe-A-eDP-1
[124.162562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[124.172448] Starting dynamic subtest: pipe-B-eDP-1
[124.194635] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[124.203311] Starting dynamic subtest: pipe-C-eDP-1
[124.224863] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[124.233208] Starting dynamic subtest: pipe-D-eDP-1
[124.256905] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[124.261518] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[126.363737] [020/133] (899s left) gem_userptr_blits (stress-mm)
[126.441927] Starting subtest: stress-mm
[131.811259] Subtest stress-mm: SUCCESS (5.369s)
[131.984695] [021/133] (894s left) kms_prop_blob (blob-prop-core)
[132.062075] Starting subtest: blob-prop-core
[132.064478] Subtest blob-prop-core: SUCCESS (0.000s)
[132.194884] [022/133] (893s left) syncobj_eventfd (timeline-wait-signaled)
[132.260115] Starting subtest: timeline-wait-signaled
[132.262520] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[132.403698] [023/133] (893s left) kms_psr (fbc-psr2-no-drrs)
[132.507758] Starting subtest: fbc-psr2-no-drrs
[132.509608] Starting dynamic subtest: eDP-1
[132.513610] Dynamic subtest eDP-1: SKIP (0.000s)
[132.517636] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[132.607248] [024/133] (893s left) gem_madvise (dontneed-after-mmap)
[132.644592] Starting subtest: dontneed-after-mmap
[132.677889] Subtest dontneed-after-mmap: SUCCESS (0.032s)
[132.803592] [025/133] (893s left) kms_cursor_legacy (forked-move)
[132.923543] Starting subtest: forked-move
[132.925464] Starting dynamic subtest: pipe-A
[138.406634] Dynamic subtest pipe-A: SUCCESS (5.481s)
[138.418070] Starting dynamic subtest: pipe-B
[143.867391] Dynamic subtest pipe-B: SUCCESS (5.459s)
[143.876798] Starting dynamic subtest: pipe-C
[149.320417] Dynamic subtest pipe-C: SUCCESS (5.452s)
[149.330506] Starting dynamic subtest: pipe-D
[154.779283] Dynamic subtest pipe-D: SUCCESS (5.457s)
[154.789598] Starting dynamic subtest: all-pipes
[160.248496] Dynamic subtest all-pipes: SUCCESS (5.468s)
[160.250806] Subtest forked-move: SUCCESS (27.323s)
[160.450271] [026/133] (865s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[160.565712] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[160.569667] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[160.699066] [027/133] (865s left) syncobj_timeline (wait-for-submit-snapshot)
[160.761167] Starting subtest: wait-for-submit-snapshot
[160.841968] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[160.939195] [028/133] (865s left) gem_exec_fence (syncobj-signal)
[161.448474] Starting subtest: syncobj-signal
[161.453889] Subtest syncobj-signal: SUCCESS (0.005s)
[162.962145] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[162.965432] [029/133] (863s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[163.071356] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[163.075702] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[163.211959] [030/133] (863s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[163.474482] Starting subtest: parallel-dmabuf-import-out-fence
[164.571091] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.097s)
[164.710866] [031/133] (861s left) kms_big_fb (4-tiled-addfb-size-overflow)
[164.815074] Starting subtest: 4-tiled-addfb-size-overflow
[164.817443] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[164.958068] [032/133] (861s left) gem_lmem_swapping (heavy-multi)
[165.007276] Subtest heavy-multi: SKIP (0.000s)
[165.054088] [033/133] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[165.155206] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[165.159274] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[165.289470] [034/133] (861s left) kms_vblank (wait-forked)
[165.395846] Starting subtest: wait-forked
[165.397683] Starting dynamic subtest: pipe-A-eDP-1
[167.193712] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.797s)
[167.206518] Starting dynamic subtest: pipe-D-eDP-1
[169.725837] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s)
[169.728543] Subtest wait-forked: SUCCESS (4.329s)
[170.624940] [035/133] (856s left) gem_mmap_gtt (fault-concurrent-y)
[170.689185] Subtest fault-concurrent-Y: SKIP (0.000s)
[170.769643] [036/133] (855s left) gem_exec_nop (basic-parallel)
[170.846208] Starting subtest: basic-parallel
[185.944307] Subtest basic-parallel: SUCCESS (15.107s)
[186.162821] [037/133] (840s left) gem_mmap_gtt (cpuset-big-copy)
[186.228037] Subtest cpuset-big-copy: SKIP (0.000s)
[186.294248] [038/133] (840s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[186.397339] Starting subtest: x-tiled-16bpp-rotate-0
[187.732094] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.334s)
[187.892871] [039/133] (838s left) gem_ctx_persistence (legacy-engines-cleanup)
[187.956717] Starting subtest: legacy-engines-cleanup
[187.958770] Starting dynamic subtest: render
[188.057277] Dynamic subtest render: SUCCESS (0.100s)
[188.068158] Starting dynamic subtest: bsd1
[188.115377] Dynamic subtest bsd1: SUCCESS (0.056s)
[188.126056] Starting dynamic subtest: bsd2
[188.184307] Dynamic subtest bsd2: SUCCESS (0.067s)
[188.194925] Starting dynamic subtest: blt
[188.250520] Dynamic subtest blt: SUCCESS (0.064s)
[188.261287] Starting dynamic subtest: vebox
[188.314334] Dynamic subtest vebox: SUCCESS (0.062s)
[188.316628] Subtest legacy-engines-cleanup: SUCCESS (0.358s)
[188.415606] [040/133] (838s left) gem_exec_params (invalid-ring2)
[188.479820] Starting subtest: invalid-ring2
[188.481934] Subtest invalid-ring2: SUCCESS (0.000s)
[188.609185] [041/133] (838s left) kms_invalid_mode (zero-vdisplay)
[188.701463] Starting subtest: zero-vdisplay
[188.703440] Starting dynamic subtest: pipe-A-eDP-1
[188.983744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[188.993202] Starting dynamic subtest: pipe-B-eDP-1
[188.995460] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[189.003575] Starting dynamic subtest: pipe-C-eDP-1
[189.005537] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[189.013314] Starting dynamic subtest: pipe-D-eDP-1
[189.015289] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[189.017275] Subtest zero-vdisplay: SUCCESS (0.286s)
[189.854267] [042/133] (837s left) gen9_exec_parse (cmd-crossing-page)
[189.913388] Subtest cmd-crossing-page: SKIP (0.000s)
[190.002012] [043/133] (837s left) kms_scaling_modes (scaling-mode-full)
[190.109215] Starting subtest: scaling-mode-full
[190.111495] Starting dynamic subtest: pipe-A-eDP-1
[190.202458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[190.218428] Starting dynamic subtest: pipe-B-eDP-1
[191.354184] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.151s)
[191.364560] Starting dynamic subtest: pipe-C-eDP-1
[192.465379] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[192.475081] Starting dynamic subtest: pipe-D-eDP-1
[193.587626] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[193.589870] Subtest scaling-mode-full: SUCCESS (3.482s)
[194.768203] [044/133] (832s left) kms_atomic_transition (plane-all-modeset-transition)
[194.860985] Starting subtest: plane-all-modeset-transition
[194.865296] Subtest plane-all-modeset-transition: SKIP (0.000s)
[194.956492] [045/133] (832s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[195.047928] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[195.050234] Starting dynamic subtest: pipe-A-eDP-1
[195.073819] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[195.082546] Starting dynamic subtest: pipe-B-eDP-1
[195.105702] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[195.114150] Starting dynamic subtest: pipe-C-eDP-1
[195.136030] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[195.144179] Starting dynamic subtest: pipe-D-eDP-1
[195.166265] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[195.170290] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[197.240805] [046/133] (829s left) gem_exec_schedule (preempt-user)
[197.317298] Starting subtest: preempt-user
[197.319318] Starting dynamic subtest: rcs0
[197.338099] Dynamic subtest rcs0: SUCCESS (0.029s)
[197.346849] Starting dynamic subtest: bcs0
[197.357083] Dynamic subtest bcs0: SUCCESS (0.019s)
[197.365386] Starting dynamic subtest: vcs0
[197.377038] Dynamic subtest vcs0: SUCCESS (0.019s)
[197.385512] Starting dynamic subtest: vcs1
[197.398047] Dynamic subtest vcs1: SUCCESS (0.020s)
[197.406336] Starting dynamic subtest: vecs0
[197.420877] Dynamic subtest vecs0: SUCCESS (0.022s)
[197.429618] Starting dynamic subtest: ccs0
[197.441848] Dynamic subtest ccs0: SUCCESS (0.020s)
[197.444159] Subtest preempt-user: SUCCESS (0.134s)
[199.058622] [047/133] (828s left) gem_exec_parallel (engines)
[199.126956] Starting subtest: engines
[199.129109] Starting dynamic subtest: basic
[200.653761] Dynamic subtest basic: SUCCESS (1.527s)
[200.665068] Starting dynamic subtest: contexts
[204.356893] Dynamic subtest contexts: SUCCESS (3.698s)
[204.367126] Starting dynamic subtest: fds
[207.977762] Dynamic subtest fds: SUCCESS (3.619s)
[207.988839] Starting dynamic subtest: userptr
[209.878928] Dynamic subtest userptr: SUCCESS (1.899s)
[209.881641] Subtest engines: SUCCESS (10.751s)
[210.110779] [048/133] (817s left) syncobj_wait (multi-wait-all-signaled)
[210.172502] Starting subtest: multi-wait-all-signaled
[210.174678] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[210.309724] [049/133] (816s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[210.407390] Starting subtest: fbc-pr-cursor-mmap-cpu
[210.412618] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[210.499455] [050/133] (816s left) kms_pipe_crc_basic (suspend-read-crc)
[210.591400] Starting subtest: suspend-read-crc
[210.593378] Starting dynamic subtest: pipe-A-eDP-1
[228.207286] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.756s)
[228.217887] Starting dynamic subtest: pipe-B-eDP-1
[246.179494] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.207s)
[246.189812] Starting dynamic subtest: pipe-C-eDP-1
[264.117708] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.059s)
[264.128059] Starting dynamic subtest: pipe-D-eDP-1
[282.100969] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.051s)
[282.103691] Subtest suspend-read-crc: SUCCESS (12.077s)
[282.970182] [051/133] (744s left) gem_pwrite_snooped
[283.130408] [052/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[283.234279] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[283.238875] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[283.370148] [053/133] (744s left) gem_exec_reloc (basic-wc-gtt-active)
[283.429723] Subtest basic-wc-gtt-active: SKIP (0.000s)
[283.506755] [054/133] (743s left) kms_chamelium_audio (dp-audio)
[283.900701] Subtest dp-audio: SKIP (0.000s)
[284.754599] [055/133] (742s left) kms_flip (2x-flip-vs-suspend-interruptible)
[284.858510] Starting subtest: 2x-flip-vs-suspend-interruptible
[284.870108] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[284.970655] [056/133] (742s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[285.070665] Starting subtest: yf-tiled-64bpp-rotate-180
[285.075277] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[285.207981] [057/133] (742s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[285.319019] Starting subtest: fbcpsr-indfb-scaledprimary
[291.046535] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.725s)
[291.238858] [058/133] (736s left) api_intel_allocator (reopen)
[291.300918] Starting subtest: reopen
[291.303798] Subtest reopen: SUCCESS (0.005s)
[291.456628] [059/133] (736s left) kms_psr (fbc-psr-cursor-plane-onoff)
[291.556939] Starting subtest: fbc-psr-cursor-plane-onoff
[291.559971] Starting dynamic subtest: eDP-1
[291.565576] Dynamic subtest eDP-1: SKIP (0.000s)
[291.570679] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.003s)
[291.659551] [060/133] (736s left) syncobj_wait (wait-all-for-submit-snapshot)
[291.726803] Starting subtest: wait-all-for-submit-snapshot
[291.807692] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[291.907068] [061/133] (735s left) kms_properties (crtc-properties-legacy)
[292.007587] Starting subtest: crtc-properties-legacy
[292.009507] Starting dynamic subtest: pipe-A-eDP-1
[292.450548] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[292.459947] Starting dynamic subtest: pipe-B-eDP-1
[293.671867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s)
[293.683591] Starting dynamic subtest: pipe-C-eDP-1
[294.797523] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[294.808313] Starting dynamic subtest: pipe-D-eDP-1
[295.933793] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[295.936302] Subtest crtc-properties-legacy: SUCCESS (3.925s)
[296.770923] [062/133] (731s left) perf (rc6-disable)
[296.876696] Starting subtest: rc6-disable
[297.067987] Subtest rc6-disable: SUCCESS (0.191s)
[297.119969] [063/133] (730s left) kms_flip (dpms-vs-vblank-race)
[297.238860] Starting subtest: dpms-vs-vblank-race
[297.241795] Starting dynamic subtest: A-eDP1
[302.251528] Dynamic subtest A-eDP1: SUCCESS (5.011s)
[302.264516] Starting dynamic subtest: B-eDP1
[305.767555] Dynamic subtest B-eDP1: SUCCESS (3.515s)
[305.777693] Starting dynamic subtest: C-eDP1
[310.394275] Dynamic subtest C-eDP1: SUCCESS (4.625s)
[310.404892] Starting dynamic subtest: D-eDP1
[315.030592] Dynamic subtest D-eDP1: SUCCESS (4.634s)
[315.033334] Subtest dpms-vs-vblank-race: SUCCESS (17.792s)
[315.931565] [064/133] (711s left) gem_userptr_blits (usage-restrictions)
[316.004475] Starting subtest: usage-restrictions
[316.006799] Subtest usage-restrictions: SUCCESS (0.000s)
[316.176728] [065/133] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[316.280957] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[316.286514] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[316.421660] [066/133] (711s left) i915_query (query-topology-unsupported)
[316.480581] Starting subtest: query-topology-unsupported
[316.485642] Subtest query-topology-unsupported: SKIP (0.000s)
[316.613803] [067/133] (711s left) perf_pmu (semaphore-wait)
[316.653635] Starting subtest: semaphore-wait
[316.656020] Starting dynamic subtest: rcs0
[317.168088] Dynamic subtest rcs0: SUCCESS (0.515s)
[317.181930] Starting dynamic subtest: bcs0
[317.681652] Dynamic subtest bcs0: SUCCESS (0.511s)
[317.695387] Starting dynamic subtest: vcs0
[318.195719] Dynamic subtest vcs0: SUCCESS (0.511s)
[318.209116] Starting dynamic subtest: vcs1
[318.708039] Dynamic subtest vcs1: SUCCESS (0.510s)
[318.720699] Starting dynamic subtest: vecs0
[319.222427] Dynamic subtest vecs0: SUCCESS (0.511s)
[319.233318] Starting dynamic subtest: ccs0
[319.738331] Dynamic subtest ccs0: SUCCESS (0.513s)
[319.741084] Subtest semaphore-wait: SUCCESS (3.086s)
[319.877526] [068/133] (708s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[319.978292] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[319.983670] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[320.097650] [069/133] (708s left) gem_busy (semaphore)
[320.280097] Subtest semaphore: SKIP (0.000s)
[320.553222] [070/133] (707s left) kms_big_fb (linear-16bpp-rotate-180)
[320.657946] Starting subtest: linear-16bpp-rotate-180
[322.090097] Subtest linear-16bpp-rotate-180: SUCCESS (1.435s)
[322.294602] [071/133] (705s left) perf (oa-exponents)
[322.401203] Starting subtest: oa-exponents
[322.403932] Starting dynamic subtest: 0-rcs0
[324.182298] Dynamic subtest 0-rcs0: SUCCESS (1.779s)
[324.192053] Starting dynamic subtest: 1-vecs0
[326.014082] Dynamic subtest 1-vecs0: SUCCESS (1.830s)
[326.016966] Subtest oa-exponents: SUCCESS (3.611s)
[326.064385] [072/133] (702s left) api_intel_bb (purge-bb)
[326.138578] Starting subtest: purge-bb
[326.141248] Subtest purge-bb: SUCCESS (0.004s)
[326.307423] [073/133] (701s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[326.404062] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[326.406493] Starting dynamic subtest: pipe-A-default-mode
[326.696860] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[326.701646] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.291s)
[327.560466] [074/133] (700s left) gem_exec_whisper (basic-forked)
[327.623184] Starting subtest: basic-forked
[334.952948] Subtest basic-forked: SUCCESS (7.326s)
[335.165328] [075/133] (693s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[340.247925] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[340.253670] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[341.117716] [076/133] (687s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[342.640878] Starting subtest: dpms-mode-unset-non-lpsp
[343.806622] Subtest dpms-mode-unset-non-lpsp: SKIP (1.166s)
[344.199795] [077/133] (684s left) vgem_basic (dmabuf-fence-before)
[344.250352] Starting subtest: dmabuf-fence-before
[344.252965] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[344.334009] [078/133] (684s left) perf (blocking)
[344.436793] Starting subtest: blocking
[344.439352] Starting dynamic subtest: 0-rcs0
[354.467318] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[354.476979] Starting dynamic subtest: 1-vecs0
[364.490086] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[364.492690] Subtest blocking: SUCCESS (20.048s)
[364.542591] [079/133] (664s left) kms_properties (plane-properties-legacy)
[364.649093] Starting subtest: plane-properties-legacy
[364.651910] Starting dynamic subtest: pipe-A-eDP-1
[365.213696] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[365.224943] Starting dynamic subtest: pipe-B-eDP-1
[366.451631] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[366.463980] Starting dynamic subtest: pipe-C-eDP-1
[367.687192] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[367.700724] Starting dynamic subtest: pipe-D-eDP-1
[368.926648] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[368.929557] Subtest plane-properties-legacy: SUCCESS (4.279s)
[369.747413] [080/133] (658s left) perf_pmu (busy-check-all)
[369.792318] Starting subtest: busy-check-all
[369.794960] Starting dynamic subtest: rcs0
[370.362465] Dynamic subtest rcs0: SUCCESS (0.572s)
[370.375772] Starting dynamic subtest: bcs0
[370.911448] Dynamic subtest bcs0: SUCCESS (0.546s)
[370.924885] Starting dynamic subtest: vcs0
[372.345885] Dynamic subtest vcs0: SUCCESS (1.431s)
[372.359199] Starting dynamic subtest: vcs1
[374.329761] Dynamic subtest vcs1: SUCCESS (1.980s)
[374.342985] Starting dynamic subtest: vecs0
[376.314122] Dynamic subtest vecs0: SUCCESS (1.981s)
[376.326396] Starting dynamic subtest: ccs0
[376.869851] Dynamic subtest ccs0: SUCCESS (0.554s)
[376.872887] Subtest busy-check-all: SUCCESS (7.080s)
[377.045464] [081/133] (651s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[377.158918] Starting subtest: coverage-vs-premult-vs-constant
[377.442579] Starting dynamic subtest: pipe-A-eDP-1
[378.044334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[378.055289] Starting dynamic subtest: pipe-D-eDP-1
[379.336313] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[379.339066] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.179s)
[380.221489] [082/133] (648s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[380.325172] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[380.329959] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[380.457701] [083/133] (648s left) gem_exec_alignment (pi)
[380.515314] Starting subtest: pi
[432.411024] Subtest pi: SUCCESS (51.902s)
[433.163501] [084/133] (595s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[433.281302] Starting subtest: single-wait-all-for-submit-unsubmitted
[433.390249] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[433.501560] [085/133] (595s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[433.614500] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[441.127228] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.515s)
[441.289508] [086/133] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[441.392078] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[448.414079] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.023s)
[448.572499] [087/133] (580s left) kms_psr (pr-primary-mmap-gtt)
[448.678281] Starting subtest: pr-primary-mmap-gtt
[448.683099] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[448.775516] [088/133] (580s left) sw_sync (alloc_fence_invalid_timeline)
[448.810835] Starting subtest: alloc_fence_invalid_timeline
[448.813572] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[448.881315] [089/133] (580s left) sw_sync (sync_multi_producer_single_consumer)
[448.922058] Starting subtest: sync_multi_producer_single_consumer
[449.999032] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[450.087793] [090/133] (578s left) kms_psr (psr2-dpms)
[450.187886] Starting subtest: psr2-dpms
[450.190368] Starting dynamic subtest: eDP-1
[453.074521] Dynamic subtest eDP-1: SUCCESS (2.885s)
[453.076972] Subtest psr2-dpms: SUCCESS (2.886s)
[453.973200] [091/133] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[454.068734] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[461.408751] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.343s)
[461.570138] [092/133] (567s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[461.676676] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[461.687703] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[461.818540] [093/133] (567s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[461.879615] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[461.982023] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[462.083640] [094/133] (567s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[462.192020] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[462.197699] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[462.318859] [095/133] (566s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[462.418550] Starting subtest: dsc-fractional-bpp-with-bpc
[462.454924] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[462.529420] [096/133] (566s left) drm_buddy (drm_buddy)
[462.567544] Starting subtest: drm_buddy
[462.688606] Starting dynamic subtest: drm_test_buddy_alloc_limit
[462.853663] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.165s)
[462.864433] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[463.004459] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.150s)
[463.016045] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[463.143596] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.136s)
[463.154681] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[463.296788] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.151s)
[463.307933] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[463.394280] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.094s)
[463.404906] Starting dynamic subtest: drm_test_buddy_alloc_clear
[463.569840] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.176s)
[463.579925] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[463.722619] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.151s)
[463.734345] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[467.977959] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.252s)
[467.980065] Subtest drm_buddy: SUCCESS (5.411s)
[468.183586] [097/133] (561s left) gem_exec_params (dr1-dirt)
[468.246550] Starting subtest: DR1-dirt
[468.249094] Subtest DR1-dirt: SUCCESS (0.000s)
[468.384423] [098/133] (561s left) gem_softpin (evict-prime)
[468.447053] Starting subtest: evict-prime
[468.449987] Starting dynamic subtest: rcs0
[469.655711] Dynamic subtest rcs0: SUCCESS (1.210s)
[469.669041] Starting dynamic subtest: bcs0
[470.809556] Dynamic subtest bcs0: SUCCESS (1.152s)
[470.822606] Starting dynamic subtest: vcs0
[472.346069] Dynamic subtest vcs0: SUCCESS (1.532s)
[472.359812] Starting dynamic subtest: vcs1
[474.333380] Dynamic subtest vcs1: SUCCESS (1.984s)
[474.350714] Starting dynamic subtest: vecs0
[476.311848] Dynamic subtest vecs0: SUCCESS (1.976s)
[476.325085] Starting dynamic subtest: ccs0
[477.467548] Dynamic subtest ccs0: SUCCESS (1.154s)
[477.480110] Starting dynamic subtest: all
[479.369205] Dynamic subtest all: SUCCESS (1.898s)
[479.371985] Subtest evict-prime: SUCCESS (10.924s)
[479.475621] [099/133] (549s left) kms_getfb (getfb2-handle-protection)
[479.574150] Starting subtest: getfb2-handle-protection
[479.595786] Subtest getfb2-handle-protection: SUCCESS (0.024s)
[479.753793] [100/133] (549s left) gem_exec_suspend (basic)
[479.818693] Starting subtest: basic
[479.821057] Starting dynamic subtest: smem
[481.337879] Dynamic subtest smem: SUCCESS (1.520s)
[481.341038] Subtest basic: SUCCESS (1.522s)
[481.544384] [101/133] (548s left) i915_pm_rpm (system-suspend-devices)
[483.502933] Starting subtest: system-suspend-devices
[491.167707] Subtest system-suspend-devices: SUCCESS (7.664s)
[491.590120] [102/133] (538s left) gem_exec_schedule (pi-ringfull)
[491.779478] Starting subtest: pi-ringfull
[491.781798] Starting dynamic subtest: rcs0
[491.819435] Dynamic subtest rcs0: SUCCESS (0.043s)
[491.829814] Starting dynamic subtest: bcs0
[491.878110] Dynamic subtest bcs0: SUCCESS (0.057s)
[491.889303] Starting dynamic subtest: vcs0
[491.922279] Dynamic subtest vcs0: SUCCESS (0.043s)
[491.932662] Starting dynamic subtest: vcs1
[491.961875] Dynamic subtest vcs1: SUCCESS (0.038s)
[491.972050] Starting dynamic subtest: vecs0
[492.000716] Dynamic subtest vecs0: SUCCESS (0.037s)
[492.015036] Starting dynamic subtest: ccs0
[492.031404] Dynamic subtest ccs0: SUCCESS (0.030s)
[492.034019] Subtest pi-ringfull: SUCCESS (0.256s)
[492.268508] [103/133] (537s left) i915_hangman (detector)
[492.343053] Starting subtest: detector
[492.345944] Starting dynamic subtest: rcs0
[504.282215] Dynamic subtest rcs0: SUCCESS (11.939s)
[504.296041] Starting dynamic subtest: bcs0
[516.311988] Dynamic subtest bcs0: SUCCESS (12.027s)
[516.328124] Starting dynamic subtest: vcs0
[528.279957] Dynamic subtest vcs0: SUCCESS (11.965s)
[528.293091] Starting dynamic subtest: vcs1
[540.248364] Dynamic subtest vcs1: SUCCESS (11.965s)
[540.262078] Starting dynamic subtest: vecs0
[551.255780] Dynamic subtest vecs0: SUCCESS (11.004s)
[551.271210] Starting dynamic subtest: ccs0
[562.264165] Dynamic subtest ccs0: SUCCESS (11.004s)
[562.266933] Subtest detector: SUCCESS (69.921s)
[562.376289] [104/133] (467s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[562.490896] Starting subtest: psr-rgb565-draw-render
[569.493741] Subtest psr-rgb565-draw-render: SUCCESS (7.006s)
[569.669614] [105/133] (460s left) gem_exec_suspend (basic-s4-devices)
[569.729660] Starting subtest: basic-S4-devices
[569.732550] Starting dynamic subtest: smem
[581.371573] Dynamic subtest smem: SUCCESS (11.638s)
[581.375764] Subtest basic-S4-devices: SUCCESS (11.641s)
[588.605912] [106/133] (448s left) kms_content_protection (dp-mst-lic-type-1)
[588.767782] Starting subtest: dp-mst-lic-type-1
[588.772873] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[588.919517] [107/133] (447s left) syncobj_timeline (multi-wait-all-available-submitted)
[588.980724] Starting subtest: multi-wait-all-available-submitted
[588.983462] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[589.114887] [108/133] (447s left) gem_ctx_isolation (dirty-switch)
[589.169844] Starting subtest: dirty-switch
[589.172878] Starting dynamic subtest: rcs0
[589.362271] Dynamic subtest rcs0: SUCCESS (0.192s)
[589.375342] Starting dynamic subtest: bcs0
[589.595057] Dynamic subtest bcs0: SUCCESS (0.232s)
[589.607102] Starting dynamic subtest: vcs0
[589.832436] Dynamic subtest vcs0: SUCCESS (0.237s)
[589.843919] Starting dynamic subtest: vcs1
[591.593172] Dynamic subtest vcs1: SUCCESS (1.760s)
[591.605088] Starting dynamic subtest: vecs0
[593.552097] Dynamic subtest vecs0: SUCCESS (1.958s)
[593.563058] Starting dynamic subtest: ccs0
[595.559975] Dynamic subtest ccs0: SUCCESS (2.007s)
[595.563064] Subtest dirty-switch: SUCCESS (6.390s)
[595.832029] [109/133] (441s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[595.934833] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[595.937346] Starting dynamic subtest: pipe-A-default-mode
[596.228741] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[596.233604] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.294s)
[597.078391] [110/133] (439s left) gem_mmap_wc (invalid-flags)
[597.137804] Subtest invalid-flags: SKIP (0.000s)
[597.207722] [111/133] (439s left) kms_cursor_edge_walk (128x128-right-edge)
[597.304636] Starting subtest: 128x128-right-edge
[597.307695] Starting dynamic subtest: pipe-A-eDP-1
[600.734568] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[600.746092] Starting dynamic subtest: pipe-D-eDP-1
[603.859197] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[603.861775] Subtest 128x128-right-edge: SUCCESS (6.556s)
[604.694690] [112/133] (432s left) kms_cursor_crc (cursor-offscreen-max-size)
[605.004483] Starting subtest: cursor-offscreen-max-size
[605.012923] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[605.172160] [113/133] (431s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[605.280895] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[605.285817] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[605.410313] [114/133] (431s left) kms_hdmi_inject (inject-4k)
[605.748565] Starting subtest: inject-4k
[606.064431] Subtest inject-4k: SUCCESS (0.318s)
[606.660128] [115/133] (430s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[606.752847] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[606.755420] Starting dynamic subtest: pipe-A-eDP-1
[606.780787] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[606.797989] Starting dynamic subtest: pipe-B-eDP-1
[606.825057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[606.836685] Starting dynamic subtest: pipe-C-eDP-1
[606.861877] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[606.872876] Starting dynamic subtest: pipe-D-eDP-1
[606.899364] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[606.904056] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[609.019797] [116/133] (428s left) gem_render_copy (linear)
[609.087632] Starting subtest: linear
[609.089940] Starting dynamic subtest: smem
[609.126587] Dynamic subtest smem: SUCCESS (0.043s)
[609.129653] Subtest linear: SUCCESS (0.043s)
[609.393855] [117/133] (427s left) gem_mmap (pf-nonblock)
[609.458200] Subtest pf-nonblock: SKIP (0.000s)
[609.517512] [118/133] (427s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[609.641961] Starting subtest: verify-pxp-execution-after-suspend-resume
[616.743067] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.101s)
[616.912858] [119/133] (420s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[617.019447] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[623.646062] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.628s)
[623.821632] [120/133] (413s left) kms_rotation_crc (bad-pixel-format)
[623.928079] Starting subtest: bad-pixel-format
[623.933679] Subtest bad-pixel-format: SKIP (0.001s)
[624.025267] [121/133] (413s left) kms_cursor_crc (cursor-random-512x170)
[624.326848] Starting subtest: cursor-random-512x170
[624.332625] Subtest cursor-random-512x170: SKIP (0.001s)
[624.521466] [122/133] (412s left) i915_selftest (perf)
[628.071964] Starting subtest: perf
[628.074605] Starting dynamic subtest: engine_cs
[632.348699] Dynamic subtest engine_cs: SUCCESS (4.275s)
[632.360936] Starting dynamic subtest: request
[639.103347] Dynamic subtest request: SUCCESS (6.752s)
[639.113898] Starting dynamic subtest: migrate
[643.282369] Dynamic subtest migrate: SUCCESS (4.176s)
[643.292901] Starting dynamic subtest: region
[649.002066] Dynamic subtest region: SUCCESS (5.717s)
[649.005044] Subtest perf: SUCCESS (20.928s)
[649.036266] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[649.037094] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[649.041090] [123/133] (388s left) gem_wait (write-busy)
[651.927661] Starting subtest: write-busy
[651.929849] Starting dynamic subtest: all-engines
[652.511200] Dynamic subtest all-engines: SUCCESS (0.586s)
[652.529247] Starting dynamic subtest: rcs0
[653.065939] Dynamic subtest rcs0: SUCCESS (0.548s)
[653.077842] Starting dynamic subtest: bcs0
[653.610735] Dynamic subtest bcs0: SUCCESS (0.549s)
[653.627322] Starting dynamic subtest: vcs0
[655.354956] Dynamic subtest vcs0: SUCCESS (1.740s)
[655.371686] Starting dynamic subtest: vcs1
[657.338533] Dynamic subtest vcs1: SUCCESS (1.981s)
[657.355046] Starting dynamic subtest: vecs0
[659.322186] Dynamic subtest vecs0: SUCCESS (1.980s)
[659.339699] Starting dynamic subtest: ccs0
[659.873672] Dynamic subtest ccs0: SUCCESS (0.550s)
[659.876803] Subtest write-busy: SUCCESS (7.948s)
[660.046148] [FACT gem_wait (write-busy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[660.047287] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.i915: true
[660.051465] [124/133] (377s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[660.179743] Starting subtest: short-flip-after-cursor-atomic-transitions
[661.170950] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.993s)
[661.995467] [125/133] (375s left) kms_plane (plane-position-hole-dpms)
[662.093941] Starting subtest: plane-position-hole-dpms
[662.618651] Starting dynamic subtest: pipe-A-plane-1
[664.977946] Dynamic subtest pipe-A-plane-1: SUCCESS (2.358s)
[664.998082] Starting dynamic subtest: pipe-A-plane-2
[667.258766] Dynamic subtest pipe-A-plane-2: SUCCESS (2.280s)
[667.270308] Starting dynamic subtest: pipe-A-plane-3
[669.524648] Dynamic subtest pipe-A-plane-3: SUCCESS (2.263s)
[669.534820] Starting dynamic subtest: pipe-A-plane-4
[671.860618] Dynamic subtest pipe-A-plane-4: SUCCESS (2.338s)
[671.871960] Starting dynamic subtest: pipe-A-plane-5
[671.888593] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[673.047836] Starting dynamic subtest: pipe-B-plane-1
[675.409787] Dynamic subtest pipe-B-plane-1: SUCCESS (2.371s)
[675.421078] Starting dynamic subtest: pipe-B-plane-2
[677.759707] Dynamic subtest pipe-B-plane-2: SUCCESS (2.349s)
[677.770889] Starting dynamic subtest: pipe-B-plane-3
[680.016919] Dynamic subtest pipe-B-plane-3: SUCCESS (2.258s)
[680.027143] Starting dynamic subtest: pipe-B-plane-4
[682.391442] Dynamic subtest pipe-B-plane-4: SUCCESS (2.372s)
[682.401872] Starting dynamic subtest: pipe-B-plane-5
[682.416911] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[682.419610] Subtest plane-position-hole-dpms: SUCCESS (20.322s)
[683.233415] [126/133] (354s left) kms_addfb_basic (bad-pitch-1024)
[683.306318] Starting subtest: bad-pitch-1024
[683.308874] Subtest bad-pitch-1024: SUCCESS (0.000s)
[683.507789] [127/133] (354s left) kms_frontbuffer_tracking (fbc-argb161616f-draw-mmap-wc)
[683.623966] Starting subtest: fbc-argb161616f-draw-mmap-wc
[683.629570] Subtest fbc-argb161616f-draw-mmap-wc: SKIP (0.000s)
[683.748473] [128/133] (354s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[683.836962] Starting subtest: plane-scaler-unity-scaling-with-rotation
[683.839845] Starting dynamic subtest: pipe-A
[684.120580] Dynamic subtest pipe-A: SUCCESS (0.284s)
[684.130480] Starting dynamic subtest: pipe-B
[685.407046] Dynamic subtest pipe-B: SUCCESS (1.284s)
[685.417236] Starting dynamic subtest: pipe-C
[686.732940] Dynamic subtest pipe-C: SUCCESS (1.324s)
[686.743491] Starting dynamic subtest: pipe-D
[688.109553] Dynamic subtest pipe-D: SUCCESS (1.375s)
[688.112447] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.273s)
[689.283242] [129/133] (348s left) kms_chamelium_color (degamma)
[689.386193] Subtest degamma: SKIP (0.000s)
[689.430682] [130/133] (348s left) syncobj_timeline (invalid-query-illegal-handle)
[689.496062] Starting subtest: invalid-query-illegal-handle
[689.498616] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[689.608525] [131/133] (348s left) kms_chamelium_hpd (dp-hpd-storm)
[690.001293] Subtest dp-hpd-storm: SKIP (0.000s)
[690.775082] [132/133] (347s left) gem_close_race (multigpu-basic-process)
[690.849315] Starting subtest: multigpu-basic-process
[690.854745] Subtest multigpu-basic-process: SKIP (0.000s)
[691.103390] [133/133] (346s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[691.205823] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[691.210810] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[691.332476] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: kms_pm_dc
results: parsing output: 4/ for test: kms_color
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: gen9_exec_parse
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_prop_blob
results: parsing output: 21/ for test: syncobj_eventfd
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_madvise
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: gem_exec_nop
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: kms_scaling_modes
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: gem_exec_parallel
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_pipe_crc_basic
results: parsing output: 50/ for test: gem_pwrite_snooped
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_chamelium_audio
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: api_intel_allocator
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_properties
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_busy
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: vgem_basic
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: kms_plane_alpha_blend
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_alignment
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: sw_sync
results: parsing output: 88/ for test: sw_sync
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_dsc
results: parsing output: 95/ for test: drm_buddy
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: gem_softpin
results: parsing output: 98/ for test: kms_getfb
results: parsing output: 99/ for test: gem_exec_suspend
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: i915_hangman
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_suspend
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: gem_ctx_isolation
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: gem_mmap_wc
results: parsing output: 110/ for test: kms_cursor_edge_walk
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_hdmi_inject
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: gem_mmap
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: i915_selftest
results: parsing output: 122/ for test: gem_wait
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: gem_close_race
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.