[60.413810] Initializing watchdogs
[60.413857]   /dev/watchdog0
[60.427950] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.432206] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.434475] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.437787] [001/133] (960s left) kms_rotation_crc (primary-rotation-90)
[60.565106] Starting subtest: primary-rotation-90
[60.569519] Subtest primary-rotation-90: SKIP (0.001s)
[60.658855] [002/133] (960s left) gem_exec_schedule (semaphore-power)
[60.845400] Subtest semaphore-power: SKIP (0.000s)
[61.039064] [003/133] (959s left) gem_exec_balancer (hang)
[61.295529] Starting subtest: hang
[62.929352] Subtest hang: SUCCESS (1.629s)
[63.070312] [004/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[63.172078] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[63.176409] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[63.301441] [005/133] (957s left) kms_vrr (flipline)
[63.394453] Starting subtest: flipline
[63.401182] Subtest flipline: SKIP (0.000s)
[63.487899] [006/133] (957s left) syncobj_wait (invalid-reset-zero-handles)
[63.547754] Starting subtest: invalid-reset-zero-handles
[63.550150] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[63.672325] [007/133] (957s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[63.781693] Starting subtest: 4-tiled-16bpp-rotate-270
[63.813725] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.031s)
[63.945976] [008/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[64.040766] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[64.044358] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[64.163692] [009/133] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[64.260025] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[71.061778] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.793s)
[71.193093] [010/133] (950s left) i915_pm_rpm (reg-read-ioctl)
[73.047444] Starting subtest: reg-read-ioctl
[75.442208] Subtest reg-read-ioctl: SUCCESS (2.391s)
[75.828487] [011/133] (945s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[75.929687] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[75.931568] Starting dynamic subtest: pipe-A-default-mode
[76.221642] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[76.226378] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.290s)
[77.046487] [012/133] (944s left) kms_async_flips (async-flip-dpms)
[77.143322] Starting subtest: async-flip-dpms
[77.520026] Starting dynamic subtest: pipe-A-eDP-1
[81.347868] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.825s)
[81.735345] Starting dynamic subtest: pipe-B-eDP-1
[84.608493] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.877s)
[84.985441] Starting dynamic subtest: pipe-C-eDP-1
[87.769615] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.789s)
[88.143667] Starting dynamic subtest: pipe-D-eDP-1
[90.934969] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.797s)
[90.938294] Subtest async-flip-dpms: SUCCESS (13.787s)
[92.139217] [013/133] (929s left) kms_addfb_basic (bad-pitch-65536)
[92.207916] Starting subtest: bad-pitch-65536
[92.210272] Subtest bad-pitch-65536: SUCCESS (0.000s)
[92.375197] [014/133] (929s left) kms_psr (psr2-cursor-render)
[92.472806] Starting subtest: psr2-cursor-render
[92.475097] Starting dynamic subtest: eDP-1
[94.194352] Dynamic subtest eDP-1: SUCCESS (1.721s)
[94.196281] Subtest psr2-cursor-render: SUCCESS (1.722s)
[95.013626] [015/133] (926s left) gen9_exec_parse (bb-start-cmd)
[95.072115] Subtest bb-start-cmd: SKIP (0.000s)
[95.152632] [016/133] (926s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[95.264767] Starting subtest: modeset-atomic-cursor-hotspot
[95.269163] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[95.426956] [017/133] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[95.523309] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[95.527671] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[95.654426] [018/133] (925s left) kms_flip (modeset-vs-vblank-race-interruptible)
[95.750437] Starting subtest: modeset-vs-vblank-race-interruptible
[95.752694] Starting dynamic subtest: A-eDP1
[100.406899] Dynamic subtest A-eDP1: SUCCESS (4.654s)
[100.419494] Starting dynamic subtest: B-eDP1
[105.038436] Dynamic subtest B-eDP1: SUCCESS (4.629s)
[105.046653] Starting dynamic subtest: C-eDP1
[109.633462] Dynamic subtest C-eDP1: SUCCESS (4.592s)
[109.643426] Starting dynamic subtest: D-eDP1
[114.168250] Dynamic subtest D-eDP1: SUCCESS (4.532s)
[114.173964] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.421s)
[115.446211] [019/133] (906s left) kms_vblank (query-busy-hang)
[115.553743] Starting subtest: query-busy-hang
[115.555947] Starting dynamic subtest: pipe-A-eDP-1
[141.715188] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.159s)
[141.727912] Starting dynamic subtest: pipe-D-eDP-1
[166.677981] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.960s)
[166.680317] Subtest query-busy-hang: SUCCESS (51.122s)
[167.500192] [020/133] (854s left) kms_pm_lpsp (kms-lpsp)
[168.609536] Starting subtest: kms-lpsp
[168.611739] Starting dynamic subtest: pipe-A-eDP-1
[168.759366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[169.058585] Subtest kms-lpsp: SUCCESS (0.450s)
[169.939682] [021/133] (851s left) gem_workarounds (reset)
[170.019826] Starting subtest: reset
[170.152987] Subtest reset: SUCCESS (0.133s)
[170.309242] [022/133] (851s left) i915_hangman (gt-error-state-capture)
[170.371326] Starting subtest: gt-error-state-capture
[170.373669] Starting dynamic subtest: rcs0
[181.878635] Dynamic subtest rcs0: SUCCESS (11.506s)
[181.889642] Starting dynamic subtest: bcs0
[193.843170] Dynamic subtest bcs0: SUCCESS (11.962s)
[193.853202] Starting dynamic subtest: vcs0
[205.876054] Dynamic subtest vcs0: SUCCESS (12.030s)
[205.886221] Starting dynamic subtest: vcs1
[217.844032] Dynamic subtest vcs1: SUCCESS (11.964s)
[217.854736] Starting dynamic subtest: vecs0
[228.852673] Dynamic subtest vecs0: SUCCESS (11.006s)
[228.864467] Starting dynamic subtest: ccs0
[240.883613] Dynamic subtest ccs0: SUCCESS (12.028s)
[240.886950] Subtest gt-error-state-capture: SUCCESS (70.508s)
[241.046949] [023/133] (780s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[241.158509] Starting subtest: extended-modeset-hang-oldfb-with-reset
[241.160750] Starting dynamic subtest: pipe-A
[252.884974] Dynamic subtest pipe-A: SUCCESS (11.723s)
[252.895269] Starting dynamic subtest: pipe-D
[265.134375] Dynamic subtest pipe-D: SUCCESS (12.246s)
[265.136843] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.973s)
[265.945781] [024/133] (755s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[266.047722] Starting subtest: fbc-psr2-primary-mmap-cpu
[266.049856] Starting dynamic subtest: eDP-1
[266.053804] Dynamic subtest eDP-1: SKIP (0.000s)
[266.057683] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[266.146726] [025/133] (755s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[266.237818] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[266.240137] Starting dynamic subtest: pipe-A-eDP-1
[267.116591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s)
[267.124991] Starting dynamic subtest: pipe-B-eDP-1
[268.630925] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.512s)
[268.639840] Starting dynamic subtest: pipe-C-eDP-1
[270.139533] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.508s)
[270.148460] Starting dynamic subtest: pipe-D-eDP-1
[271.681592] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.539s)
[271.683531] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.436s)
[272.892272] [026/133] (748s left) kms_hdr (invalid-hdr)
[273.003007] Starting subtest: invalid-hdr
[275.084502] Starting dynamic subtest: pipe-A-eDP-1
[278.056156] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.972s)
[278.058399] Subtest invalid-hdr: SUCCESS (5.056s)
[278.193013] [027/133] (743s left) gem_create (hog-create)
[278.257275] Starting subtest: hog-create
[278.259601] Starting dynamic subtest: smem0
[311.914545] Dynamic subtest smem0: SUCCESS (33.655s)
[311.917317] Subtest hog-create: SUCCESS (33.657s)
[312.126657] [028/133] (709s left) kms_plane_cursor (viewport)
[312.222926] Starting subtest: viewport
[312.227500] Starting dynamic subtest: pipe-A-eDP-1-size-64
[315.674206] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (3.452s)
[315.733477] Starting dynamic subtest: pipe-A-eDP-1-size-128
[318.287733] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.559s)
[318.346365] Starting dynamic subtest: pipe-A-eDP-1-size-256
[320.854480] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.515s)
[321.199932] Starting dynamic subtest: pipe-B-eDP-1-size-64
[324.437752] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.244s)
[324.497031] Starting dynamic subtest: pipe-B-eDP-1-size-128
[327.027755] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.537s)
[327.086508] Starting dynamic subtest: pipe-B-eDP-1-size-256
[329.639649] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[329.995066] Starting dynamic subtest: pipe-C-eDP-1-size-64
[332.928199] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.944s)
[332.964457] Starting dynamic subtest: pipe-C-eDP-1-size-128
[335.105813] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[335.142418] Starting dynamic subtest: pipe-C-eDP-1-size-256
[337.317508] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[337.645936] Starting dynamic subtest: pipe-D-eDP-1-size-64
[340.489473] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.853s)
[340.525287] Starting dynamic subtest: pipe-D-eDP-1-size-128
[342.656620] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.135s)
[342.693065] Starting dynamic subtest: pipe-D-eDP-1-size-256
[344.790490] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[345.110685] Subtest viewport: SUCCESS (32.885s)
[345.986149] [029/133] (675s left) dumb_buffer (invalid-bpp)
[346.046149] Starting subtest: invalid-bpp
[346.048043] Subtest invalid-bpp: SUCCESS (0.000s)
[346.173089] [030/133] (675s left) kms_addfb_basic (too-wide)
[346.275069] Starting subtest: too-wide
[346.277367] Subtest too-wide: SUCCESS (0.000s)
[346.406350] [031/133] (675s left) kms_pipe_crc_basic (hang-read-crc)
[346.498881] Starting subtest: hang-read-crc
[346.501202] Starting dynamic subtest: pipe-A-eDP-1
[348.562556] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.063s)
[348.571071] Starting dynamic subtest: pipe-B-eDP-1
[351.317631] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.753s)
[351.327248] Starting dynamic subtest: pipe-C-eDP-1
[353.966537] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.647s)
[353.976075] Starting dynamic subtest: pipe-D-eDP-1
[356.622168] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.654s)
[356.624591] Subtest hang-read-crc: SUCCESS (10.123s)
[357.469284] [032/133] (664s left) gem_mmap (bad-offset)
[357.528053] Subtest bad-offset: SKIP (0.000s)
[357.594398] [033/133] (664s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-cpu)
[357.696521] Starting subtest: psr-abgr161616f-draw-mmap-cpu
[357.700929] Subtest psr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[357.830244] [034/133] (664s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[358.035685] Starting subtest: cursor-rapid-movement-64x64
[358.037910] Starting dynamic subtest: pipe-A-eDP-1
[358.599621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[358.640108] Starting dynamic subtest: pipe-D-eDP-1
[359.758132] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[359.760267] Subtest cursor-rapid-movement-64x64: SUCCESS (1.723s)
[360.660173] [035/133] (661s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[360.778061] Starting subtest: cursor-tearing-framebuffer-change
[360.780276] Starting dynamic subtest: pipe-A-eDP-1
[361.330966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[361.339458] Starting dynamic subtest: pipe-D-eDP-1
[362.548613] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[362.551091] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.770s)
[363.414856] [036/133] (658s left) kms_psr (pr-cursor-render)
[363.511219] Starting subtest: pr-cursor-render
[363.515182] Subtest pr-cursor-render: SKIP (0.000s)
[363.601881] [037/133] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[363.709442] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[363.713864] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[363.819000] [038/133] (658s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[363.926615] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[363.930730] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[364.043735] [039/133] (658s left) kms_psr (psr-cursor-mmap-gtt)
[364.132958] Starting subtest: psr-cursor-mmap-gtt
[364.135700] Starting dynamic subtest: eDP-1
[365.883754] Dynamic subtest eDP-1: SUCCESS (1.749s)
[365.885626] Subtest psr-cursor-mmap-gtt: SUCCESS (1.750s)
[366.767793] [040/133] (655s left) kms_selftest (drm_damage_helper)
[366.813792] Starting subtest: drm_damage_helper
[366.860263] Starting dynamic subtest: drm_test_damage_iter_no_damage
[366.977128] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.115s)
[366.986759] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[367.110058] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.132s)
[367.118308] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[367.248917] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.138s)
[367.257047] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[367.381399] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.132s)
[367.388786] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[367.524213] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.142s)
[367.531414] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[367.653073] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.127s)
[367.660912] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[367.776555] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.124s)
[367.784124] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[367.920066] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.142s)
[367.927694] Starting dynamic subtest: drm_test_damage_iter_single_damage
[368.069331] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.149s)
[368.076606] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[368.210443] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.140s)
[368.217670] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[368.354092] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.143s)
[368.361819] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[368.498401] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.144s)
[368.505929] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[368.651491] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.151s)
[368.659187] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[368.778429] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.128s)
[368.785676] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[368.914680] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.134s)
[368.922493] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[369.042491] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.128s)
[369.050051] Starting dynamic subtest: drm_test_damage_iter_damage
[369.196659] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.153s)
[369.204663] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[369.345355] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.149s)
[369.353417] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[369.460756] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.113s)
[369.468253] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[369.609108] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.147s)
[369.618397] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[369.714049] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.104s)
[369.716326] Subtest drm_damage_helper: SUCCESS (2.899s)
[369.921231] [041/133] (652s left) gem_render_copy_redux (normal)
[369.982626] Starting subtest: normal
[370.385600] Subtest normal: SUCCESS (0.403s)
[370.545434] [042/133] (651s left) kms_setmode (invalid-clone-exclusive-crtc)
[370.606205] Starting subtest: invalid-clone-exclusive-crtc
[370.612867] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[370.715133] [043/133] (651s left) gem_pxp (create-regular-buffer)
[370.831765] Starting subtest: create-regular-buffer
[370.834124] Subtest create-regular-buffer: SUCCESS (0.000s)
[370.969567] [044/133] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[371.061810] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[377.543434] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.482s)
[377.712754] [045/133] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[377.818351] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[377.822731] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[377.953387] [046/133] (644s left) kms_draw_crc (draw-method-mmap-gtt)
[378.054032] Starting subtest: draw-method-mmap-gtt
[378.058431] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[378.190608] [047/133] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[378.306758] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[378.311198] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[378.430917] [048/133] (644s left) gem_softpin (noreloc-interruptible)
[378.494983] Starting subtest: noreloc-interruptible
[383.888647] Subtest noreloc-interruptible: SUCCESS (5.392s)
[384.072729] [049/133] (638s left) gem_exec_schedule (independent)
[384.163816] Starting subtest: independent
[384.165842] Starting dynamic subtest: rcs0
[385.941685] Dynamic subtest rcs0: SUCCESS (1.785s)
[385.953072] Starting dynamic subtest: vcs0
[387.943587] Dynamic subtest vcs0: SUCCESS (1.999s)
[387.954229] Starting dynamic subtest: vcs1
[389.928381] Dynamic subtest vcs1: SUCCESS (1.982s)
[389.939053] Starting dynamic subtest: vecs0
[391.943556] Dynamic subtest vecs0: SUCCESS (2.012s)
[391.954966] Starting dynamic subtest: ccs0
[393.878678] Dynamic subtest ccs0: SUCCESS (1.932s)
[393.881283] Subtest independent: SUCCESS (9.724s)
[394.200006] [050/133] (628s left) sriov_basic (bind-unbind-vf)
[394.253058] Starting subtest: bind-unbind-vf
[394.255352] Starting dynamic subtest: vf-1
[394.334973] Dynamic subtest vf-1: FAIL (0.028s)
[394.345226] Starting dynamic subtest: vf-2
[394.417029] Dynamic subtest vf-2: FAIL (0.004s)
[394.426459] Starting dynamic subtest: vf-3
[394.499488] Dynamic subtest vf-3: FAIL (0.003s)
[394.509042] Starting dynamic subtest: vf-4
[394.581081] Dynamic subtest vf-4: FAIL (0.003s)
[394.590242] Starting dynamic subtest: vf-5
[394.662603] Dynamic subtest vf-5: FAIL (0.004s)
[394.672087] Starting dynamic subtest: vf-6
[394.743959] Dynamic subtest vf-6: FAIL (0.003s)
[394.753292] Starting dynamic subtest: vf-7
[394.826156] Dynamic subtest vf-7: FAIL (0.003s)
[394.835513] Starting dynamic subtest: vf-random
[394.904800] Dynamic subtest vf-random: FAIL (0.003s)
[394.913762] Starting dynamic subtest: vf-last
[394.985130] Dynamic subtest vf-last: FAIL (0.503s)
[394.987435] Subtest bind-unbind-vf: FAIL (0.562s)
[395.023079] [051/133] (627s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[395.115172] Starting subtest: flip-vs-dpms-off-vs-modeset
[395.117356] Starting dynamic subtest: A-eDP1
[398.694523] Dynamic subtest A-eDP1: SUCCESS (3.578s)
[398.703267] Starting dynamic subtest: B-eDP1
[401.895746] Dynamic subtest B-eDP1: SUCCESS (3.199s)
[401.904878] Starting dynamic subtest: C-eDP1
[405.003141] Dynamic subtest C-eDP1: SUCCESS (3.107s)
[405.012541] Starting dynamic subtest: D-eDP1
[408.132901] Dynamic subtest D-eDP1: SUCCESS (3.128s)
[408.134792] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.020s)
[408.943745] [052/133] (613s left) kms_properties (colorop-properties-legacy)
[409.049693] Starting subtest: colorop-properties-legacy
[409.051906] Starting dynamic subtest: pipe-A-eDP-1
[409.382470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.332s)
[409.391520] Starting dynamic subtest: pipe-B-eDP-1
[410.489570] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.107s)
[410.498420] Starting dynamic subtest: pipe-C-eDP-1
[411.519047] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.027s)
[411.527760] Starting dynamic subtest: pipe-D-eDP-1
[412.555773] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[412.558088] Subtest colorop-properties-legacy: SUCCESS (3.508s)
[413.374902] [053/133] (609s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[413.439450] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[413.441741] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[413.563158] [054/133] (609s left) kms_flip (plain-flip-fb-recreate)
[413.659874] Starting subtest: plain-flip-fb-recreate
[413.662062] Starting dynamic subtest: A-eDP1
[422.549658] Dynamic subtest A-eDP1: SUCCESS (8.891s)
[422.561666] Starting dynamic subtest: B-eDP1
[431.379456] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[431.388944] Starting dynamic subtest: C-eDP1
[440.198032] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[440.207495] Starting dynamic subtest: D-eDP1
[449.023177] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[449.029431] Subtest plain-flip-fb-recreate: SUCCESS (35.371s)
[450.227838] [055/133] (572s left) i915_drm_fdinfo (memory-info-shared)
[450.273638] Starting subtest: memory-info-shared
[450.275876] Starting dynamic subtest: smem0
[450.330476] Dynamic subtest smem0: SUCCESS (0.058s)
[450.332992] Subtest memory-info-shared: SUCCESS (0.058s)
[450.431881] [056/133] (572s left) gem_exec_capture (capture-recoverable)
[450.486407] Starting subtest: capture-recoverable
[450.488393] Subtest capture-recoverable: SUCCESS (0.002s)
[450.630269] [057/133] (572s left) vgem_basic (create)
[450.738090] Starting subtest: create
[450.740375] Subtest create: SUCCESS (0.000s)
[450.817545] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[450.820795] [058/133] (572s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[453.055083] Starting subtest: dpms-mode-unset-lpsp
[457.117807] Subtest dpms-mode-unset-lpsp: SUCCESS (4.066s)
[457.497353] [059/133] (565s left) kms_invalid_mode (zero-vdisplay)
[457.598897] Starting subtest: zero-vdisplay
[457.601151] Starting dynamic subtest: pipe-A-eDP-1
[457.897107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[457.905800] Starting dynamic subtest: pipe-B-eDP-1
[457.907687] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[457.915477] Starting dynamic subtest: pipe-C-eDP-1
[457.917393] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[457.925280] Starting dynamic subtest: pipe-D-eDP-1
[457.927419] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[457.929634] Subtest zero-vdisplay: SUCCESS (0.305s)
[458.742241] [060/133] (564s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[458.869410] Starting subtest: cursorB-vs-flipA-varying-size
[458.873763] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[459.039347] [061/133] (564s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[459.144231] Starting subtest: y-tiled-16bpp-rotate-270
[459.148698] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[459.263589] [062/133] (564s left) gem_exec_flush (basic-uc-set-default)
[459.334310] Starting subtest: basic-uc-set-default
[464.785374] Subtest basic-uc-set-default: SUCCESS (5.451s)
[464.994412] [063/133] (558s left) kms_async_flips (test-time-stamp-atomic)
[465.092821] Starting subtest: test-time-stamp-atomic
[465.485452] Starting dynamic subtest: pipe-A-eDP-1
[466.316391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[466.689751] Starting dynamic subtest: pipe-B-eDP-1
[467.442727] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[467.820036] Starting dynamic subtest: pipe-C-eDP-1
[468.572941] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.759s)
[468.946245] Starting dynamic subtest: pipe-D-eDP-1
[469.704628] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[469.706900] Subtest test-time-stamp-atomic: SUCCESS (4.611s)
[470.886035] [064/133] (552s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[471.006360] Starting subtest: basic-flip-before-cursor-atomic
[471.921778] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.914s)
[472.828432] [065/133] (550s left) kms_chamelium_hpd (hdmi-hpd-fast)
[473.210856] Subtest hdmi-hpd-fast: SKIP (0.000s)
[474.015905] [066/133] (549s left) i915_suspend (forcewake)
[474.071176] Starting subtest: forcewake
[506.119702] Subtest forcewake: SUCCESS (2.357s)
[506.223205] [067/133] (517s left) gem_ctx_persistence (engines-mixed-process)
[506.292081] Starting subtest: engines-mixed-process
[506.294462] Starting dynamic subtest: rcs0
[507.584822] Dynamic subtest rcs0: SUCCESS (1.259s)
[507.596430] Starting dynamic subtest: bcs0
[509.596994] Dynamic subtest bcs0: SUCCESS (1.958s)
[509.606982] Starting dynamic subtest: vcs0
[511.621802] Dynamic subtest vcs0: SUCCESS (1.982s)
[511.631746] Starting dynamic subtest: vcs1
[513.625120] Dynamic subtest vcs1: SUCCESS (1.970s)
[513.636670] Starting dynamic subtest: vecs0
[515.606660] Dynamic subtest vecs0: SUCCESS (1.955s)
[515.618259] Starting dynamic subtest: ccs0
[517.586002] Dynamic subtest ccs0: SUCCESS (1.959s)
[517.588920] Subtest engines-mixed-process: SUCCESS (11.092s)
[517.692512] [068/133] (505s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[517.795472] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[518.458240] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[518.633028] [069/133] (504s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[518.735274] Starting subtest: psr-rgb565-draw-pwrite
[525.786333] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.020s)
[525.921474] [070/133] (497s left) kms_color (ctm-0-75)
[526.020933] Starting subtest: ctm-0-75
[526.023219] Starting dynamic subtest: pipe-A-eDP-1
[530.894584] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.862s)
[530.912341] Starting dynamic subtest: pipe-B-eDP-1
[536.597326] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.694s)
[536.606773] Starting dynamic subtest: pipe-C-eDP-1
[541.954920] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.356s)
[541.964568] Starting dynamic subtest: pipe-D-eDP-1
[547.275825] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.320s)
[547.278188] Subtest ctm-0-75: SUCCESS (21.235s)
[548.134743] [071/133] (475s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[548.253478] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[548.257490] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[548.389959] [072/133] (475s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[548.474159] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[548.478438] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[548.601052] [073/133] (475s left) gem_tiling_max_stride
[548.732180] [074/133] (475s left) kms_big_fb (linear-64bpp-rotate-180)
[548.839878] Starting subtest: linear-64bpp-rotate-180
[550.385922] Subtest linear-64bpp-rotate-180: SUCCESS (1.545s)
[550.622471] [075/133] (473s left) gem_partial_pwrite_pread (writes-after-reads)
[550.694463] Subtest writes-after-reads: SKIP (0.000s)
[550.764950] [076/133] (473s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[550.858193] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[550.860468] Starting dynamic subtest: pipe-A-eDP-1
[550.885816] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[550.896750] Starting dynamic subtest: pipe-B-eDP-1
[550.920464] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[550.929002] Starting dynamic subtest: pipe-C-eDP-1
[550.953351] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[550.961963] Starting dynamic subtest: pipe-D-eDP-1
[550.985446] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[550.989934] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[553.108356] [077/133] (470s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[553.208927] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[553.211222] Starting dynamic subtest: pipe-A-default-mode
[553.509147] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[553.513800] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.301s)
[554.333281] [078/133] (469s left) kms_cursor_crc (cursor-onscreen-512x512)
[554.630971] Starting subtest: cursor-onscreen-512x512
[554.635396] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[554.848471] [079/133] (469s left) kms_addfb_basic (clobberred-modifier)
[554.912464] Starting subtest: clobberred-modifier
[554.916623] Subtest clobberred-modifier: SKIP (0.000s)
[555.086433] [080/133] (468s left) gem_ctx_bad_destroy (invalid-pad)
[555.138645] Starting subtest: invalid-pad
[555.140866] Subtest invalid-pad: SUCCESS (0.000s)
[555.249583] [081/133] (468s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[555.336125] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[555.338142] Starting dynamic subtest: pipe-A-default-mode
[556.479776] Dynamic subtest pipe-A-default-mode: SKIP (1.140s)
[556.484229] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.142s)
[556.687323] [082/133] (467s left) kms_psr (fbc-pr-no-drrs)
[556.780050] Starting subtest: fbc-pr-no-drrs
[556.784042] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[556.874900] [083/133] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[556.980184] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[556.984522] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[557.119347] [084/133] (467s left) kms_pwrite_crc
[558.706062] [085/133] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[558.803070] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[558.807031] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[558.930638] [086/133] (465s left) gem_spin_batch (engines)
[558.983760] Starting subtest: engines
[558.985919] Starting dynamic subtest: rcs0
[562.224743] Dynamic subtest rcs0: SUCCESS (3.234s)
[562.235478] Starting dynamic subtest: bcs0
[565.461551] Dynamic subtest bcs0: SUCCESS (3.233s)
[565.471709] Starting dynamic subtest: vcs0
[568.698235] Dynamic subtest vcs0: SUCCESS (3.233s)
[568.709545] Starting dynamic subtest: vcs1
[571.935050] Dynamic subtest vcs1: SUCCESS (3.232s)
[571.945485] Starting dynamic subtest: vecs0
[575.172329] Dynamic subtest vecs0: SUCCESS (3.233s)
[575.183465] Starting dynamic subtest: ccs0
[578.410317] Dynamic subtest ccs0: SUCCESS (3.234s)
[578.412451] Subtest engines: SUCCESS (19.416s)
[578.681209] [087/133] (445s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[578.793011] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[578.797324] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[578.920402] [088/133] (445s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[579.029468] Starting subtest: verify-pxp-key-change-after-suspend-resume
[586.226112] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.196s)
[586.377712] [089/133] (438s left) perf_pmu (frequency)
[586.418084] Starting subtest: frequency
[586.422849] Starting dynamic subtest: gt0
[588.648243] Dynamic subtest gt0: SUCCESS (2.220s)
[588.660213] Starting dynamic subtest: idle-gt0
[589.153944] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[589.166312] Starting dynamic subtest: gt1
[593.587874] Dynamic subtest gt1: SUCCESS (4.428s)
[593.598708] Starting dynamic subtest: idle-gt1
[594.124843] Dynamic subtest idle-gt1: SUCCESS (0.536s)
[594.127789] Subtest frequency: SUCCESS (7.707s)
[594.247585] [090/133] (430s left) perf_pmu (busy-check-all)
[594.292129] Starting subtest: busy-check-all
[594.294527] Starting dynamic subtest: rcs0
[594.864839] Dynamic subtest rcs0: SUCCESS (0.573s)
[594.877350] Starting dynamic subtest: bcs0
[595.416773] Dynamic subtest bcs0: SUCCESS (0.550s)
[595.428667] Starting dynamic subtest: vcs0
[596.608778] Dynamic subtest vcs0: SUCCESS (1.188s)
[596.620661] Starting dynamic subtest: vcs1
[598.593920] Dynamic subtest vcs1: SUCCESS (1.982s)
[598.605774] Starting dynamic subtest: vecs0
[600.577865] Dynamic subtest vecs0: SUCCESS (1.980s)
[600.590174] Starting dynamic subtest: ccs0
[601.130950] Dynamic subtest ccs0: SUCCESS (0.552s)
[601.133284] Subtest busy-check-all: SUCCESS (6.840s)
[601.266114] [091/133] (423s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[601.396415] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[601.400930] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[601.557328] [092/133] (423s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[602.112472] Starting subtest: syncobj-timeline-invalid-flags
[602.115126] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[603.718868] [093/133] (420s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[603.787863] Starting subtest: map-fixed-invalidate-overlap
[603.792453] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[603.949748] [094/133] (420s left) gem_wait (await)
[604.024140] Starting subtest: await
[604.026121] Starting dynamic subtest: all-engines
[605.158072] Dynamic subtest all-engines: SUCCESS (1.136s)
[605.175686] Starting dynamic subtest: rcs0
[606.215286] Dynamic subtest rcs0: SUCCESS (1.055s)
[606.233036] Starting dynamic subtest: bcs0
[607.273468] Dynamic subtest bcs0: SUCCESS (1.055s)
[607.291314] Starting dynamic subtest: vcs0
[608.328094] Dynamic subtest vcs0: SUCCESS (1.051s)
[608.344296] Starting dynamic subtest: vcs1
[609.379922] Dynamic subtest vcs1: SUCCESS (1.050s)
[609.396294] Starting dynamic subtest: vecs0
[610.433155] Dynamic subtest vecs0: SUCCESS (1.051s)
[610.449382] Starting dynamic subtest: ccs0
[611.488270] Dynamic subtest ccs0: SUCCESS (1.053s)
[611.490844] Subtest await: SUCCESS (7.466s)
[611.711196] [095/133] (412s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[611.813131] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[611.815329] Starting dynamic subtest: pipe-A-eDP-1
[613.869246] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.054s)
[613.878960] Starting dynamic subtest: pipe-B-eDP-1
[616.076584] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.204s)
[616.086327] Starting dynamic subtest: pipe-C-eDP-1
[618.213339] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.136s)
[618.223578] Starting dynamic subtest: pipe-D-eDP-1
[620.292291] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.078s)
[620.294534] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.477s)
[621.528761] [096/133] (403s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[621.637123] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[621.639569] Starting dynamic subtest: pipe-A-eDP-1
[621.660081] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[621.676615] Starting dynamic subtest: pipe-B-eDP-1
[621.697208] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[621.706368] Starting dynamic subtest: pipe-C-eDP-1
[621.725518] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[621.734498] Starting dynamic subtest: pipe-D-eDP-1
[621.753673] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[621.755561] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[623.810291] [097/133] (400s left) kms_content_protection (lic-type-0)
[623.960154] Starting subtest: lic-type-0
[623.964162] Subtest lic-type-0: SKIP (0.000s)
[624.131405] [098/133] (400s left) gem_partial_pwrite_pread (write-snoop)
[624.200430] Subtest write-snoop: SKIP (0.000s)
[624.266356] [099/133] (400s left) api_intel_bb (reset-bb)
[624.314976] Starting subtest: reset-bb
[624.317311] Subtest reset-bb: SUCCESS (0.004s)
[624.453088] [100/133] (400s left) gem_exec_suspend (basic)
[624.520195] Starting subtest: basic
[624.522532] Starting dynamic subtest: smem
[626.561443] Dynamic subtest smem: SUCCESS (2.039s)
[626.564607] Subtest basic: SUCCESS (2.042s)
[626.777598] [101/133] (398s left) kms_chamelium_frames (hdmi-crc-single)
[627.186112] Subtest hdmi-crc-single: SKIP (0.000s)
[627.985950] [102/133] (397s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[628.102927] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[635.234971] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.133s)
[635.432037] [103/133] (389s left) gem_userptr_blits (relocations)
[635.488047] Starting subtest: relocations
[635.492086] Subtest relocations: SKIP (0.000s)
[635.664946] [104/133] (389s left) prime_busy (after)
[635.736034] Starting subtest: after
[635.737932] Starting dynamic subtest: rcs0
[635.787387] Dynamic subtest rcs0: SUCCESS (0.049s)
[635.799606] Starting dynamic subtest: bcs0
[635.845774] Dynamic subtest bcs0: SUCCESS (0.058s)
[635.856665] Starting dynamic subtest: vcs0
[635.886660] Dynamic subtest vcs0: SUCCESS (0.040s)
[635.896042] Starting dynamic subtest: vcs1
[635.927911] Dynamic subtest vcs1: SUCCESS (0.041s)
[635.937509] Starting dynamic subtest: vecs0
[635.968666] Dynamic subtest vecs0: SUCCESS (0.040s)
[635.978449] Starting dynamic subtest: ccs0
[636.008858] Dynamic subtest ccs0: SUCCESS (0.039s)
[636.117012] Subtest after: SUCCESS (0.380s)
[636.216855] [105/133] (388s left) gem_flink_basic (double-flink)
[636.279372] Starting subtest: double-flink
[636.281306] Subtest double-flink: SUCCESS (0.000s)
[636.384599] [106/133] (388s left) kms_flip (2x-flip-vs-panning)
[636.478501] Starting subtest: 2x-flip-vs-panning
[636.487560] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[636.591317] [107/133] (388s left) prime_mmap (test_reprime)
[636.651459] Starting subtest: test_reprime
[636.653415] Starting dynamic subtest: test_reprime-smem
[636.679592] Dynamic subtest test_reprime-smem: SUCCESS (0.030s)
[636.681983] Subtest test_reprime: SUCCESS (0.030s)
[636.825693] [108/133] (388s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[636.916420] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[636.918763] Starting dynamic subtest: pipe-A-eDP-1
[636.941530] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[636.953731] Starting dynamic subtest: pipe-B-eDP-1
[636.974977] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[636.983971] Starting dynamic subtest: pipe-C-eDP-1
[637.005166] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[637.014127] Starting dynamic subtest: pipe-D-eDP-1
[637.035589] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[637.039947] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[639.130694] [109/133] (386s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[639.243832] Starting subtest: x-tiled-8bpp-rotate-0
[640.424720] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.180s)
[640.583189] [110/133] (384s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[640.644555] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[640.648403] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[640.852180] [111/133] (384s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[640.954180] Starting subtest: fbcpsr-tiling-4
[647.916268] Subtest fbcpsr-tiling-4: SUCCESS (6.963s)
[648.086827] [112/133] (377s left) syncobj_timeline (single-wait-available-submitted)
[648.146571] Starting subtest: single-wait-available-submitted
[648.148832] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[648.315581] [113/133] (377s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[648.414350] Starting subtest: plane-scaler-unity-scaling-with-rotation
[648.416560] Starting dynamic subtest: pipe-A
[648.641122] Dynamic subtest pipe-A: SUCCESS (0.228s)
[648.650818] Starting dynamic subtest: pipe-B
[649.919226] Dynamic subtest pipe-B: SUCCESS (1.277s)
[649.931636] Starting dynamic subtest: pipe-C
[651.253534] Dynamic subtest pipe-C: SUCCESS (1.332s)
[651.263374] Starting dynamic subtest: pipe-D
[652.615479] Dynamic subtest pipe-D: SUCCESS (1.359s)
[652.617811] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.203s)
[653.810446] [114/133] (371s left) gem_eio (in-flight-immediate)
[654.055562] Starting subtest: in-flight-immediate
[662.692017] Subtest in-flight-immediate: SUCCESS (8.635s)
[662.881292] [115/133] (362s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[667.845502] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[667.847928] Starting dynamic subtest: pipe-A-eDP-1
[679.891929] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.040s)
[679.904867] Starting dynamic subtest: pipe-B-eDP-1
[691.931130] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.035s)
[691.933448] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.079s)
[692.798309] [116/133] (332s left) gem_exec_reloc (basic-scanout)
[692.869056] Subtest basic-scanout: SKIP (0.000s)
[692.965301] [117/133] (332s left) syncobj_timeline (invalid-query-zero-handles)
[693.028611] Starting subtest: invalid-query-zero-handles
[693.030656] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[693.164470] [118/133] (332s left) gen3_mixed_blits
[693.306165] [119/133] (332s left) gem_lmem_swapping (heavy-multi)
[693.349258] Subtest heavy-multi: SKIP (0.000s)
[693.394801] [120/133] (332s left) gem_ctx_shared (q-smoketest-all)
[693.454385] Starting subtest: Q-smoketest-all
[725.844815] Subtest Q-smoketest-all: SUCCESS (32.334s)
[727.699110] [121/133] (298s left) gem_ccs (block-multicopy-compressed)
[727.768226] Starting subtest: block-multicopy-compressed
[727.772729] Subtest block-multicopy-compressed: SKIP (0.000s)
[727.912911] [122/133] (297s left) gem_ctx_persistence (hostile)
[727.983282] Starting subtest: hostile
[738.152587] Subtest hostile: SUCCESS (10.164s)
[738.325067] [123/133] (287s left) gem_partial_pwrite_pread (reads)
[738.384724] Subtest reads: SKIP (0.000s)
[738.455760] [124/133] (287s left) vgem_basic (dmabuf-fence-before)
[738.498637] Starting subtest: dmabuf-fence-before
[738.500965] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[738.583549] [125/133] (287s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[743.547752] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[743.552514] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[744.429536] [126/133] (281s left) kms_atomic_transition (plane-all-modeset-transition)
[744.520819] Starting subtest: plane-all-modeset-transition
[744.525203] Subtest plane-all-modeset-transition: SKIP (0.000s)
[744.623255] [127/133] (281s left) kms_plane (plane-position-hole-dpms)
[744.710729] Starting subtest: plane-position-hole-dpms
[745.222930] Starting dynamic subtest: pipe-A-plane-1
[747.482202] Dynamic subtest pipe-A-plane-1: SUCCESS (2.259s)
[747.493286] Starting dynamic subtest: pipe-A-plane-2
[749.845413] Dynamic subtest pipe-A-plane-2: SUCCESS (2.361s)
[749.856771] Starting dynamic subtest: pipe-A-plane-3
[752.216410] Dynamic subtest pipe-A-plane-3: SUCCESS (2.368s)
[752.231151] Starting dynamic subtest: pipe-A-plane-4
[754.596650] Dynamic subtest pipe-A-plane-4: SUCCESS (2.381s)
[754.607191] Starting dynamic subtest: pipe-A-plane-5
[754.622694] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[755.766225] Starting dynamic subtest: pipe-B-plane-1
[758.179766] Dynamic subtest pipe-B-plane-1: SUCCESS (2.427s)
[758.190947] Starting dynamic subtest: pipe-B-plane-2
[760.433021] Dynamic subtest pipe-B-plane-2: SUCCESS (2.249s)
[760.444211] Starting dynamic subtest: pipe-B-plane-3
[762.815314] Dynamic subtest pipe-B-plane-3: SUCCESS (2.383s)
[762.825129] Starting dynamic subtest: pipe-B-plane-4
[765.171346] Dynamic subtest pipe-B-plane-4: SUCCESS (2.354s)
[765.181699] Starting dynamic subtest: pipe-B-plane-5
[765.199537] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[765.201660] Subtest plane-position-hole-dpms: SUCCESS (20.482s)
[766.015301] [128/133] (260s left) api_intel_bb (blit-noreloc-purge-cache)
[766.079925] Starting subtest: blit-noreloc-purge-cache
[766.090694] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[766.256735] [129/133] (259s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[766.325497] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[766.429604] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[766.529910] [130/133] (259s left) gem_exec_whisper (basic-normal-all)
[766.600926] Starting subtest: basic-normal-all
[769.289196] Subtest basic-normal-all: SUCCESS (2.687s)
[769.497325] [131/133] (256s left) syncobj_timeline (wait-for-submit-delayed-submit)
[769.553693] Starting subtest: wait-for-submit-delayed-submit
[769.655344] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[769.760346] [132/133] (256s left) gem_exec_reloc (basic-gtt)
[769.837539] Subtest basic-gtt: SKIP (0.000s)
[769.937114] [133/133] (256s left) gem_mmap_gtt (fault-concurrent-y)
[770.009396] Subtest fault-concurrent-Y: SKIP (0.000s)
[770.070335] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_vrr
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: i915_pm_rpm
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: kms_async_flips
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gen9_exec_parse
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: kms_pm_lpsp
results: parsing output: 20/ for test: gem_workarounds
results: parsing output: 21/ for test: i915_hangman
results: parsing output: 22/ for test: kms_busy
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_hdr
results: parsing output: 26/ for test: gem_create
results: parsing output: 27/ for test: kms_plane_cursor
results: parsing output: 28/ for test: dumb_buffer
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: gem_mmap
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_selftest
results: parsing output: 40/ for test: gem_render_copy_redux
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: gem_pxp
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_draw_crc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: sriov_basic
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_properties
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: gem_exec_capture
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: kms_invalid_mode
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_exec_flush
results: parsing output: 62/ for test: kms_async_flips
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_chamelium_hpd
results: parsing output: 65/ for test: i915_suspend
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_color
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_tiling_max_stride
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_partial_pwrite_pread
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: gem_ctx_bad_destroy
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_pwrite_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_spin_batch
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: gem_wait
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: gem_partial_pwrite_pread
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: gem_exec_suspend
results: parsing output: 100/ for test: kms_chamelium_frames
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: prime_busy
results: parsing output: 104/ for test: gem_flink_basic
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: prime_mmap
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gen3_mixed_blits
results: parsing output: 118/ for test: gem_lmem_swapping
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: gem_ccs
results: parsing output: 121/ for test: gem_ctx_persistence
results: parsing output: 122/ for test: gem_partial_pwrite_pread
results: parsing output: 123/ for test: vgem_basic
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_atomic_transition
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: api_intel_bb
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: gem_mmap_gtt
Done.