[39.047885] Initializing watchdogs
[39.047924]   /dev/watchdog0
[39.053760] [001/140] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[39.141111] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[39.145823] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[39.214910] [002/140] (960s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[39.647377] Starting subtest: pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[39.653305] Subtest pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[40.535635] [003/140] (959s left) gem_ctx_param (invalid-param-set)
[40.593387] Starting subtest: invalid-param-set
[40.595832] Subtest invalid-param-set: SUCCESS (0.000s)
[40.650184] [004/140] (958s left) gem_mmap_gtt (bad-object)
[40.712558] Subtest bad-object: SKIP (0.000s)
[40.743405] [005/140] (958s left) kms_pm_lpsp (screens-disabled)
[41.828875] Starting subtest: screens-disabled
[41.833787] Subtest screens-disabled: SKIP (0.000s)
[41.886399] [006/140] (957s left) gem_exec_fence (basic-wait-all)
[41.948054] Starting subtest: basic-wait-all
[42.022722] Subtest basic-wait-all: SUCCESS (0.082s)
[43.488284] [007/140] (956s left) i915_suspend (sysfs-reader)
[43.550061] Starting subtest: sysfs-reader
[61.659942] Subtest sysfs-reader: SUCCESS (3.121s)
[61.715567] [008/140] (953s left) kms_ccs (pipe-b-missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[62.088679] Starting subtest: pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs
[62.091512] Subtest pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[62.952708] [009/140] (951s left) gem_softpin (evict-active)
[63.008216] Starting subtest: evict-active
[63.017093] Subtest evict-active: SUCCESS (0.009s)
[63.111189] [010/140] (951s left) kms_dirtyfb (default-dirtyfb-ioctl)
[63.176569] Starting subtest: default-dirtyfb-ioctl
[63.178960] Starting dynamic subtest: A-eDP-1
[64.825734] Dynamic subtest A-eDP-1: SUCCESS (1.647s)
[64.827918] Subtest default-dirtyfb-ioctl: SUCCESS (1.647s)
[65.709158] [011/140] (949s left) i915_module_load (reload-with-fault-injection)
[65.762691] Starting subtest: reload-with-fault-injection
[87.935774] Subtest reload-with-fault-injection: SUCCESS (22.174s)
[87.955750] [012/140] (926s left) kms_sequence (get-forked-busy)
[89.515113] Starting subtest: get-forked-busy
[89.517277] Starting dynamic subtest: pipe-A-eDP-1
[91.469494] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s)
[91.481759] Starting dynamic subtest: pipe-B-eDP-1
[94.172967] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.704s)
[94.188217] Starting dynamic subtest: pipe-C-eDP-1
[96.850456] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.674s)
[96.866893] Starting dynamic subtest: pipe-D-eDP-1
[99.541637] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.688s)
[99.544414] Subtest get-forked-busy: SUCCESS (10.026s)
[100.470090] [013/140] (914s left) kms_cursor_crc (cursor-offscreen-256x256)
[100.645763] Starting subtest: cursor-offscreen-256x256
[100.648186] Starting dynamic subtest: pipe-A-eDP-1
[102.753566] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.104s)
[102.786914] Starting dynamic subtest: pipe-D-eDP-1
[105.463178] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.684s)
[105.466158] Subtest cursor-offscreen-256x256: SUCCESS (4.813s)
[106.340593] [014/140] (908s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[106.699945] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[106.705854] Subtest pipe-A-crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.001s)
[107.563016] [015/140] (907s left) gem_spin_batch (spin-all)
[107.627651] Starting subtest: spin-all
[107.648982] Subtest spin-all: SUCCESS (0.020s)
[109.459639] [016/140] (905s left) kms_psr (psr2_sprite_plane_move)
[109.553452] Starting subtest: psr2_sprite_plane_move
[109.555956] Starting dynamic subtest: eDP-1
[111.395384] Dynamic subtest eDP-1: SUCCESS (1.841s)
[111.398154] Subtest psr2_sprite_plane_move: SUCCESS (1.841s)
[112.297098] [017/140] (902s left) kms_addfb_basic (too-high)
[112.364735] Starting subtest: too-high
[112.367324] Subtest too-high: SUCCESS (0.000s)
[112.446390] [018/140] (902s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[112.519890] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[112.521912] Starting dynamic subtest: pipe-A-eDP-1
[114.334153] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[114.341291] Starting dynamic subtest: pipe-B-eDP-1
[117.330116] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.994s)
[117.337711] Starting dynamic subtest: pipe-C-eDP-1
[118.706496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[118.719489] Starting dynamic subtest: pipe-D-eDP-1
[120.006309] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[120.008881] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (7.489s)
[121.260647] [019/140] (893s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[121.350669] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[121.394626] [020/140] (893s left) gem_exec_params (secure-non-root)
[121.437065] Starting subtest: secure-non-root
[121.444092] Subtest secure-non-root: SKIP (0.000s)
[121.517019] [021/140] (893s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[121.610915] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[127.830137] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (6.224s)
[127.933417] [022/140] (887s left) kms_3d
[130.382552] [023/140] (884s left) gem_pxp (reject-modify-context-protection-on)
[133.001253] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[133.032223] [024/140] (882s left) kms_big_fb (linear-16bpp-rotate-0)
[133.116463] Starting subtest: linear-16bpp-rotate-0
[134.483542] Subtest linear-16bpp-rotate-0: SUCCESS (1.366s)
[134.590982] [025/140] (880s left) gem_pxp (create-protected-buffer)
[137.231752] Subtest create-protected-buffer: SKIP (0.000s)
[137.265398] [026/140] (877s left) kms_vblank (ts-continuation-dpms-suspend)
[137.348249] Starting subtest: ts-continuation-dpms-suspend
[137.351039] Starting dynamic subtest: pipe-A-eDP-1
[154.238279] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.847s)
[154.254351] Starting dynamic subtest: pipe-D-eDP-1
[172.267367] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[172.270428] Subtest ts-continuation-dpms-suspend: SUCCESS (4.405s)
[173.154412] [027/140] (872s left) gem_mmap_offset (clear)
[173.199177] Starting subtest: clear
[173.201845] Starting dynamic subtest: smem0
[195.335028] Dynamic subtest smem0: SUCCESS (22.130s)
[195.338153] Subtest clear: SUCCESS (22.132s)
[195.448015] [028/140] (850s left) kms_psr2_sf (overlay-plane-move-continuous-sf)
[200.717386] Starting subtest: overlay-plane-move-continuous-sf
[200.720009] Starting dynamic subtest: pipe-A-eDP-1
[207.489581] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.767s)
[207.505059] Starting dynamic subtest: pipe-B-eDP-1
[214.245258] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.753s)
[214.248012] Subtest overlay-plane-move-continuous-sf: SUCCESS (13.527s)
[215.135041] [029/140] (830s left) gem_ctx_persistence (engines-hostile-preempt)
[215.188924] Starting subtest: engines-hostile-preempt
[215.191558] Starting dynamic subtest: rcs0
[215.223717] Dynamic subtest rcs0: SUCCESS (0.036s)
[215.238803] Starting dynamic subtest: bcs0
[215.400884] Dynamic subtest bcs0: SUCCESS (0.176s)
[215.411504] Starting dynamic subtest: vcs0
[216.908255] Dynamic subtest vcs0: SUCCESS (1.505s)
[216.923354] Starting dynamic subtest: vcs1
[218.967910] Dynamic subtest vcs1: SUCCESS (2.059s)
[218.983609] Starting dynamic subtest: vecs0
[220.942345] Dynamic subtest vecs0: SUCCESS (1.972s)
[220.957292] Starting dynamic subtest: ccs0
[221.013142] Dynamic subtest ccs0: SUCCESS (0.072s)
[221.015889] Subtest engines-hostile-preempt: SUCCESS (5.826s)
[221.087940] [030/140] (824s left) prime_mmap (test_reprime)
[221.135298] Starting subtest: test_reprime
[221.137639] Starting dynamic subtest: test_reprime-smem
[221.157145] Dynamic subtest test_reprime-smem: SUCCESS (0.026s)
[221.159857] Subtest test_reprime: SUCCESS (0.026s)
[221.243434] [031/140] (824s left) gem_partial_pwrite_pread (reads)
[221.300862] Subtest reads: SKIP (0.000s)
[221.333947] [032/140] (824s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[221.387604] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[221.392206] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[221.466049] [033/140] (824s left) v3d/v3d_submit_csd (bad-in-sync)
[221.564105] Subtest bad-in-sync: SKIP (0.000s)
[221.612636] [034/140] (824s left) syncobj_timeline (invalid-query-zero-handles)
[221.665550] Starting subtest: invalid-query-zero-handles
[221.667483] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[221.727719] [035/140] (824s left) v3d/v3d_perfmon (create-two-perfmon)
[221.803956] Subtest create-two-perfmon: SKIP (0.000s)
[221.850213] [036/140] (824s left) template (b)
[221.912508] Starting subtest: B
[221.914715] Subtest B: SUCCESS (0.000s)
[221.972511] [037/140] (824s left) gem_exec_fence (syncobj-timeline-wait)
[222.543152] Starting subtest: syncobj-timeline-wait
[223.952591] Subtest syncobj-timeline-wait: SUCCESS (1.410s)
[226.002704] [038/140] (820s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-ccs)
[226.367763] Starting subtest: pipe-A-bad-rotation-90-y-tiled-ccs
[226.374441] Subtest pipe-A-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[227.298955] [039/140] (818s left) gem_ctx_exec (basic-nohangcheck)
[227.353608] Starting subtest: basic-nohangcheck
[227.623530] Subtest basic-nohangcheck: SUCCESS (0.271s)
[227.726589] [040/140] (818s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-gen12-mc-ccs)
[228.139736] Starting subtest: pipe-D-bad-pixel-format-y-tiled-gen12-mc-ccs
[228.145102] Subtest pipe-D-bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[229.022480] [041/140] (817s left) kms_ccs (pipe-d-bad-rotation-90-y-tiled-gen12-rc-ccs)
[229.420964] Starting subtest: pipe-D-bad-rotation-90-y-tiled-gen12-rc-ccs
[229.427130] Subtest pipe-D-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[230.303628] [042/140] (815s left) kms_cursor_crc (cursor-offscreen-64x21)
[230.422634] Starting subtest: cursor-offscreen-64x21
[230.425454] Starting dynamic subtest: pipe-A-eDP-1
[232.444774] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.020s)
[232.481430] Starting dynamic subtest: pipe-D-eDP-1
[235.198142] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.729s)
[235.200688] Subtest cursor-offscreen-64x21: SUCCESS (4.776s)
[236.082504] [043/140] (810s left) syncobj_timeline (wait-for-submit-complex)
[236.153909] Starting subtest: wait-for-submit-complex
[236.213827] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[236.284377] [044/140] (809s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[236.350171] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[236.362309] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.014s)
[236.435723] [045/140] (809s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[236.506712] Starting subtest: y-tiled-64bpp-rotate-180
[236.510543] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[236.581271] [046/140] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[236.651912] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[236.656557] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[236.724467] [047/140] (809s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[237.109830] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[237.114976] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[237.952073] [048/140] (808s left) gem_exec_balancer (sliced)
[238.003674] Starting subtest: sliced
[238.008040] Subtest sliced: SKIP (0.000s)
[238.247750] [049/140] (808s left) kms_getfb (getfb2-into-addfb2)
[238.291330] Starting subtest: getfb2-into-addfb2
[238.293893] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[238.384080] [050/140] (808s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[238.804483] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs-cc
[239.590743] Subtest pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.784s)
[240.800821] [051/140] (805s left) gem_ctx_sseu (invalid-args)
[240.850541] Subtest invalid-args: SKIP (0.000s)
[240.889830] [052/140] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[240.941585] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[245.499178] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.562s)
[245.591830] [053/140] (800s left) i915_pm_rpm (gem-execbuf)
[247.101931] Starting subtest: gem-execbuf
[247.105263] Starting dynamic subtest: smem0
[249.228869] Dynamic subtest smem0: SUCCESS (2.125s)
[249.231473] Subtest gem-execbuf: SUCCESS (2.127s)
[249.305538] [054/140] (797s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[249.382413] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[249.387188] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[249.460766] [055/140] (797s left) vc4/vc4_label_bo (set-label)
[249.512858] Subtest set-label: SKIP (0.000s)
[249.564967] [056/140] (797s left) prime_busy (hang-wait)
[249.624604] Starting subtest: hang-wait
[249.627178] Starting dynamic subtest: rcs0
[263.499720] Dynamic subtest rcs0: SUCCESS (13.869s)
[263.506066] Starting dynamic subtest: bcs0
[270.591814] Dynamic subtest bcs0: SUCCESS (7.093s)
[270.607284] Starting dynamic subtest: vcs0
[277.630115] Dynamic subtest vcs0: SUCCESS (7.039s)
[277.646686] Starting dynamic subtest: vcs1
[284.605064] Dynamic subtest vcs1: SUCCESS (6.974s)
[284.621382] Starting dynamic subtest: vecs0
[291.584105] Dynamic subtest vecs0: SUCCESS (6.972s)
[291.600084] Starting dynamic subtest: ccs0
[305.479597] Dynamic subtest ccs0: SUCCESS (13.901s)
[305.482552] Subtest hang-wait: SUCCESS (55.854s)
[305.587913] [057/140] (741s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[305.651138] Starting subtest: fbc-rgb101010-draw-mmap-wc
[309.248240] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.603s)
[309.344518] [058/140] (737s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[309.390438] Starting subtest: yf-tiled-to-vebox-yf-tiled
[309.395244] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[309.570562] [059/140] (737s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[309.954650] Starting subtest: pipe-A-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[309.960118] Subtest pipe-A-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[310.818695] [060/140] (735s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation)
[310.884029] Starting subtest: plane-downscale-factor-0-25-with-rotation
[310.886450] Starting dynamic subtest: pipe-A-eDP-1
[310.917774] Dynamic subtest pipe-A-eDP-1: SKIP (0.030s)
[310.925000] Starting dynamic subtest: pipe-B-eDP-1
[310.957493] Dynamic subtest pipe-B-eDP-1: SKIP (0.039s)
[310.968017] Starting dynamic subtest: pipe-C-eDP-1
[310.992355] Dynamic subtest pipe-C-eDP-1: SKIP (0.033s)
[311.007738] Starting dynamic subtest: pipe-D-eDP-1
[311.025427] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[311.030121] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (0.141s)
[311.123616] [061/140] (735s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[311.221041] Starting subtest: fbc-farfromfence-mmap-gtt
[311.225416] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[311.292751] [062/140] (735s left) syncobj_timeline (transfer-timeline-point)
[311.359234] Starting subtest: transfer-timeline-point
[311.361984] Subtest transfer-timeline-point: SUCCESS (0.001s)
[311.427055] [063/140] (735s left) gem_create (create-valid-nonaligned)
[311.491566] Starting subtest: create-valid-nonaligned
[311.494292] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[311.666588] [064/140] (735s left) api_intel_allocator (reserve-simple)
[311.717873] Starting subtest: reserve-simple
[311.720865] Subtest reserve-simple: SUCCESS (0.004s)
[311.817250] [065/140] (735s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[312.170859] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[313.026945] [066/140] (733s left) kms_color (deep-color)
[313.091192] Starting subtest: deep-color
[314.225391] Starting dynamic subtest: pipe-A-eDP-1-gamma
[315.018697] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.794s)
[315.034985] Starting dynamic subtest: pipe-A-eDP-1-degamma
[317.228661] Dynamic subtest pipe-A-eDP-1-degamma: FAIL (2.053s)
[317.245398] Starting dynamic subtest: pipe-A-eDP-1-ctm
[318.141558] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.069s)
[319.035683] Starting dynamic subtest: pipe-B-eDP-1-gamma
[319.816874] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.793s)
[319.829229] Starting dynamic subtest: pipe-B-eDP-1-degamma
[322.066647] Dynamic subtest pipe-B-eDP-1-degamma: FAIL (2.083s)
[322.082460] Starting dynamic subtest: pipe-B-eDP-1-ctm
[322.976003] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.074s)
[323.833731] Starting dynamic subtest: pipe-C-eDP-1-gamma
[324.596656] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.771s)
[324.613340] Starting dynamic subtest: pipe-C-eDP-1-degamma
[326.865428] Dynamic subtest pipe-C-eDP-1-degamma: FAIL (2.090s)
[326.883175] Starting dynamic subtest: pipe-C-eDP-1-ctm
[327.770635] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.080s)
[328.635203] Starting dynamic subtest: pipe-D-eDP-1-gamma
[329.371942] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.749s)
[329.384313] Starting dynamic subtest: pipe-D-eDP-1-degamma
[331.522047] Dynamic subtest pipe-D-eDP-1-degamma: FAIL (1.986s)
[331.538088] Starting dynamic subtest: pipe-D-eDP-1-ctm
[332.383028] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.024s)
[332.385579] Subtest deep-color: FAIL (19.293s)
[333.281135] [067/140] (713s left) drm_fdinfo (virtual-busy-idle)
[333.339998] Starting subtest: virtual-busy-idle
[333.345607] Subtest virtual-busy-idle: SKIP (0.000s)
[333.409498] [068/140] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[333.483575] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[333.487408] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[333.577083] [069/140] (713s left) kms_vblank (wait-forked-busy)
[333.645897] Starting subtest: wait-forked-busy
[333.648224] Starting dynamic subtest: pipe-A-eDP-1
[335.523645] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[335.537045] Starting dynamic subtest: pipe-D-eDP-1
[338.158730] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.631s)
[338.161219] Subtest wait-forked-busy: SUCCESS (4.516s)
[339.041616] [070/140] (707s left) gem_exec_schedule (u-lateslice)
[339.101399] Starting subtest: u-lateslice
[339.103272] Starting dynamic subtest: rcs0
[339.127565] Dynamic subtest rcs0: SUCCESS (0.028s)
[339.141712] Starting dynamic subtest: bcs0
[339.155625] Dynamic subtest bcs0: SUCCESS (0.027s)
[339.169492] Starting dynamic subtest: vcs0
[339.182221] Dynamic subtest vcs0: SUCCESS (0.025s)
[339.195539] Starting dynamic subtest: vcs1
[339.206190] Dynamic subtest vcs1: SUCCESS (0.023s)
[339.219084] Starting dynamic subtest: vecs0
[339.229273] Dynamic subtest vecs0: SUCCESS (0.021s)
[339.238344] Starting dynamic subtest: ccs0
[339.252297] Dynamic subtest ccs0: SUCCESS (0.023s)
[339.254697] Subtest u-lateslice: SUCCESS (0.154s)
[340.932928] [071/140] (706s left) kms_big_fb (linear-32bpp-rotate-270)
[340.992310] Starting subtest: linear-32bpp-rotate-270
[341.009962] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[341.105668] [072/140] (705s left) kms_plane_multiple (tiling-yf)
[341.159211] Starting subtest: tiling-yf
[341.163528] Subtest tiling-yf: SKIP (0.000s)
[341.214365] [073/140] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[341.294690] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[346.477692] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.185s)
[346.583376] [074/140] (700s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[346.655270] Starting subtest: cursorB-vs-flipA-toggle
[346.660091] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[346.797336] [075/140] (700s left) kms_ccs (pipe-d-missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[347.197395] Starting subtest: pipe-D-missing-ccs-buffer-y-tiled-gen12-rc-ccs
[347.203221] Subtest pipe-D-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[348.066439] [076/140] (699s left) kms_addfb_basic (bad-pitch-999)
[348.124617] Starting subtest: bad-pitch-999
[348.127109] Subtest bad-pitch-999: SUCCESS (0.000s)
[348.219697] [077/140] (698s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[348.307705] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[348.312310] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[348.392855] [078/140] (698s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[348.462939] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[348.477115] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.014s)
[348.539758] [079/140] (698s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[348.611408] Starting subtest: psr-rgb101010-draw-pwrite
[353.790986] Subtest psr-rgb101010-draw-pwrite: SUCCESS (5.182s)
[353.883343] [080/140] (693s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[353.957663] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[356.911408] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (2.962s)
[357.044270] [081/140] (690s left) gem_exec_alignment (single)
[357.100885] Starting subtest: single
[357.102994] Subtest single: SUCCESS (0.002s)
[357.194220] [082/140] (690s left) gem_exec_params (dr4-dirt)
[357.250514] Starting subtest: DR4-dirt
[357.252530] Subtest DR4-dirt: SUCCESS (0.000s)
[357.339423] [083/140] (690s left) vgem_basic (sysfs)
[357.405360] Starting subtest: sysfs
[357.407549] Subtest sysfs: SUCCESS (0.001s)
[357.452267] [084/140] (689s left) kms_properties (crtc-properties-atomic)
[357.548448] Starting subtest: crtc-properties-atomic
[361.378456] Subtest crtc-properties-atomic: SUCCESS (3.828s)
[362.275336] [085/140] (685s left) kms_psr (pr_sprite_mmap_cpu)
[362.339819] Starting subtest: pr_sprite_mmap_cpu
[362.344600] Subtest pr_sprite_mmap_cpu: SKIP (0.000s)
[362.441383] [086/140] (684s left) syncobj_eventfd (binary-wait-signaled)
[362.499941] Starting subtest: binary-wait-signaled
[362.501865] Subtest binary-wait-signaled: SUCCESS (0.000s)
[362.564740] [087/140] (684s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[362.649816] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[362.659810] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.014s)
[362.736695] [088/140] (684s left) gem_busy (parallel)
[362.920725] Starting subtest: parallel
[362.923284] Starting dynamic subtest: rcs0
[364.966663] Dynamic subtest rcs0: SUCCESS (2.043s)
[364.983246] Starting dynamic subtest: bcs0
[366.950375] Dynamic subtest bcs0: SUCCESS (1.982s)
[366.966987] Starting dynamic subtest: vcs0
[368.935080] Dynamic subtest vcs0: SUCCESS (1.982s)
[368.951629] Starting dynamic subtest: vcs1
[371.035393] Dynamic subtest vcs1: SUCCESS (2.046s)
[371.051590] Starting dynamic subtest: vecs0
[372.966627] Dynamic subtest vecs0: SUCCESS (1.982s)
[372.986283] Starting dynamic subtest: ccs0
[374.951163] Dynamic subtest ccs0: SUCCESS (1.982s)
[374.954109] Subtest parallel: SUCCESS (12.029s)
[375.173878] [089/140] (672s left) gem_exec_whisper (basic-fds-priority-all)
[375.238951] Starting subtest: basic-fds-priority-all
[407.136512] Subtest basic-fds-priority-all: SUCCESS (31.894s)
[407.319774] [090/140] (640s left) kms_dsc (dsc-with-output-formats)
[407.395476] Subtest dsc-with-output-formats: SKIP (0.000s)
[407.417996] [091/140] (640s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[407.472119] Starting subtest: 4-tiled-16bpp-rotate-90
[407.494763] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.023s)
[407.591107] [092/140] (640s left) kms_addfb_basic (bad-pitch-1024)
[407.632895] Starting subtest: bad-pitch-1024
[407.634852] Subtest bad-pitch-1024: SUCCESS (0.000s)
[407.747415] [093/140] (639s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-mc-ccs)
[408.153591] Starting subtest: pipe-D-crc-primary-basic-y-tiled-gen12-mc-ccs
[408.159567] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[408.992347] [094/140] (638s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[409.055145] Starting subtest: yf-tiled-8bpp-rotate-270
[409.059816] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[409.122325] [095/140] (638s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[409.174301] Starting subtest: extended-modeset-hang-oldfb-with-reset
[409.176684] Starting dynamic subtest: pipe-A
[412.013259] Dynamic subtest pipe-A: SUCCESS (2.836s)
[412.027571] Starting dynamic subtest: pipe-D
[415.404033] Dynamic subtest pipe-D: SUCCESS (3.386s)
[415.406839] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (6.231s)
[416.293952] [096/140] (631s left) gem_eio (wait-wedge-immediate)
[416.492880] Starting subtest: wait-wedge-immediate
[418.056173] Subtest wait-wedge-immediate: SUCCESS (1.562s)
[418.168455] [097/140] (629s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[418.225620] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[418.228056] Starting dynamic subtest: pipe-A-default-mode
[418.531877] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[418.536847] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.306s)
[419.427860] [098/140] (628s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[419.507865] Starting subtest: x-tiled-8bpp-rotate-90
[419.529342] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[419.640632] [099/140] (628s left) gem_exec_params (no-vebox)
[419.697885] Starting subtest: no-vebox
[419.700302] Subtest no-vebox: SUCCESS (0.003s)
[421.022332] [100/140] (626s left) gem_exec_schedule (preempt-queue-contexts)
[421.094530] Subtest preempt-queue-contexts: SKIP (0.000s)
[421.390675] [101/140] (626s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[421.451982] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[421.554369] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[421.640058] [102/140] (626s left) i915_query (engine-info-invalid)
[421.693938] Starting subtest: engine-info-invalid
[421.696185] Subtest engine-info-invalid: SUCCESS (0.000s)
[421.749502] [103/140] (626s left) gem_exec_fence (syncobj-export)
[422.159211] Starting subtest: syncobj-export
[422.165260] Subtest syncobj-export: SUCCESS (0.004s)
[423.981970] [104/140] (623s left) kms_lease (possible-crtcs-filtering)
[424.047021] Starting subtest: possible-crtcs-filtering
[424.049351] Subtest possible-crtcs-filtering: SUCCESS (0.003s)
[424.106735] [105/140] (623s left) kms_cursor_crc (cursor-random-max-size)
[424.402239] Starting subtest: cursor-random-max-size
[424.409466] Subtest cursor-random-max-size: SKIP (0.000s)
[424.511608] [106/140] (623s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-gen12-mc-ccs)
[424.904654] Starting subtest: pipe-B-random-ccs-data-y-tiled-gen12-mc-ccs
[424.912424] Subtest pipe-B-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[425.761950] [107/140] (622s left) drm_fdinfo (all-busy-idle-check-all)
[425.820109] Starting subtest: all-busy-idle-check-all
[425.827239] Subtest all-busy-idle-check-all: SKIP (0.005s)
[425.893661] [108/140] (622s left) gem_ctx_shared (q-in-order)
[425.963052] Starting subtest: Q-in-order
[425.966048] Starting dynamic subtest: rcs0
[426.069631] Dynamic subtest rcs0: SUCCESS (0.106s)
[426.099184] Starting dynamic subtest: vcs0
[426.200086] Dynamic subtest vcs0: SUCCESS (0.129s)
[426.227758] Starting dynamic subtest: vcs1
[426.300586] Dynamic subtest vcs1: SUCCESS (0.099s)
[426.327481] Starting dynamic subtest: vecs0
[426.394320] Dynamic subtest vecs0: SUCCESS (0.093s)
[426.419368] Starting dynamic subtest: ccs0
[426.485657] Dynamic subtest ccs0: SUCCESS (0.090s)
[426.488341] Subtest Q-in-order: SUCCESS (0.523s)
[428.008476] [109/140] (620s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[428.074881] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[428.077231] Starting dynamic subtest: pipe-A-default-mode
[430.982323] Dynamic subtest pipe-A-default-mode: SUCCESS (2.907s)
[430.984858] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.909s)
[431.906642] [110/140] (616s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[431.979061] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[431.983466] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[432.061535] [111/140] (616s left) vgem_basic (bad-handle)
[432.141081] Starting subtest: bad-handle
[432.143626] Subtest bad-handle: SUCCESS (0.000s)
[432.194336] [112/140] (615s left) gem_tiled_blits (interruptible)
[432.253097] Subtest interruptible: SKIP (0.000s)
[432.284889] [113/140] (615s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[432.372829] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[437.636623] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.267s)
[437.740884] [114/140] (610s left) kms_properties (invalid-properties-legacy)
[437.816590] Starting subtest: invalid-properties-legacy
[437.940279] Subtest invalid-properties-legacy: SUCCESS (0.123s)
[438.002990] [115/140] (610s left) kms_chamelium_edid (hdmi-edid-read)
[438.365124] Subtest hdmi-edid-read: SKIP (0.000s)
[439.238503] [116/140] (609s left) kms_addfb_basic (bad-pitch-65536)
[439.295316] Starting subtest: bad-pitch-65536
[439.297873] Subtest bad-pitch-65536: SUCCESS (0.000s)
[439.397664] [117/140] (608s left) gem_flink_basic (bad-open)
[439.466115] Starting subtest: bad-open
[439.468829] Subtest bad-open: SUCCESS (0.000s)
[439.536021] [118/140] (608s left) gen9_exec_parse (cmd-crossing-page)
[439.589465] Subtest cmd-crossing-page: SKIP (0.000s)
[439.604383] [119/140] (608s left) gem_exec_schedule (preempt-engines)
[439.671753] Starting subtest: preempt-engines
[439.674094] Starting dynamic subtest: rcs0
[441.965956] Dynamic subtest rcs0: SUCCESS (2.247s)
[441.985824] Starting dynamic subtest: bcs0
[444.160229] Dynamic subtest bcs0: SUCCESS (2.244s)
[444.179333] Starting dynamic subtest: vcs0
[446.481400] Dynamic subtest vcs0: SUCCESS (2.319s)
[446.501136] Starting dynamic subtest: vcs1
[448.895666] Dynamic subtest vcs1: SUCCESS (2.361s)
[448.914983] Starting dynamic subtest: vecs0
[451.205611] Dynamic subtest vecs0: SUCCESS (2.360s)
[451.225434] Starting dynamic subtest: ccs0
[453.595878] Dynamic subtest ccs0: SUCCESS (2.337s)
[453.599336] Subtest preempt-engines: SUCCESS (13.877s)
[453.854100] [120/140] (594s left) api_intel_bb (simple-bb)
[453.900438] Starting subtest: simple-bb
[453.908830] Subtest simple-bb: SUCCESS (0.010s)
[453.997746] [121/140] (594s left) perf (gen12-invalid-class-instance)
[454.162853] Starting subtest: gen12-invalid-class-instance
[454.175391] Subtest gen12-invalid-class-instance: SUCCESS (0.012s)
[454.207915] [122/140] (594s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[454.271038] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[454.273644] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[454.339436] [123/140] (594s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[454.435003] Starting subtest: short-flip-after-cursor-toggle
[455.375877] Subtest short-flip-after-cursor-toggle: SUCCESS (0.940s)
[456.283809] [124/140] (592s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[456.361798] Starting subtest: cursor-vs-flip-varying-size
[485.257893] Subtest cursor-vs-flip-varying-size: SUCCESS (28.895s)
[486.182417] [125/140] (562s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[486.255791] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[489.731555] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.483s)
[489.877103] [126/140] (558s left) drm_read (short-buffer-nonblock)
[489.991652] Starting subtest: short-buffer-nonblock
[489.994055] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[490.106120] [127/140] (558s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[490.171765] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[493.455218] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (3.286s)
[493.589834] [128/140] (555s left) kms_panel_fitting (atomic-fastset)
[493.670338] Starting subtest: atomic-fastset
[493.672414] Starting dynamic subtest: pipe-A-eDP-1
[493.824382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.154s)
[493.841397] Starting dynamic subtest: pipe-B-eDP-1
[495.171947] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.345s)
[495.189747] Starting dynamic subtest: pipe-C-eDP-1
[496.397206] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.221s)
[496.410458] Starting dynamic subtest: pipe-D-eDP-1
[497.625526] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[497.628039] Subtest atomic-fastset: SUCCESS (3.953s)
[498.850530] [129/140] (549s left) gem_exec_balancer (busy)
[498.896510] Starting subtest: busy
[500.960055] Subtest busy: SUCCESS (2.063s)
[501.209237] [130/140] (547s left) kms_prop_blob (invalid-get-prop)
[501.265153] Starting subtest: invalid-get-prop
[501.267370] Subtest invalid-get-prop: SUCCESS (0.000s)
[501.312657] [131/140] (547s left) gem_reg_read (timestamp-monotonic)
[501.362549] Starting subtest: timestamp-monotonic
[506.254134] Subtest timestamp-monotonic: SUCCESS (4.843s)
[506.279252] [132/140] (542s left) perf_pmu (cpu-hotplug)
[506.349951] Starting subtest: cpu-hotplug
[506.361981] Subtest cpu-hotplug: SKIP (0.008s)
[506.469325] [133/140] (542s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[506.526568] Starting subtest: 2x-flip-vs-rmfb-interruptible
[506.541966] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.014s)
[506.608818] [134/140] (542s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-dg2-mc-ccs)
[507.009189] Starting subtest: pipe-B-bad-pixel-format-4-tiled-dg2-mc-ccs
[507.015187] Subtest pipe-B-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[507.851276] [135/140] (540s left) kms_plane_alpha_blend (alpha-basic)
[507.923136] Starting subtest: alpha-basic
[508.186770] Starting dynamic subtest: pipe-A-eDP-1
[510.141713] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[510.179464] Starting dynamic subtest: pipe-D-eDP-1
[512.901291] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.736s)
[512.903714] Subtest alpha-basic: SUCCESS (4.978s)
[513.828132] [136/140] (535s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[514.195942] Starting subtest: pipe-B-crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[514.202100] Subtest pipe-B-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[515.107464] [137/140] (533s left) gem_userptr_blits (process-exit-busy)
[515.195002] Starting subtest: process-exit-busy
[515.209441] Subtest process-exit-busy: SUCCESS (0.022s)
[515.327970] [138/140] (533s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[515.416648] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[515.421086] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[515.510689] [139/140] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[515.571058] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[520.533496] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.965s)
[520.643864] [140/140] (528s left) gem_watchdog (default-physical)
[520.704732] Starting subtest: default-physical
[521.726988] Subtest default-physical: SUCCESS (1.037s)
[521.813959] Closing watchdogs
Done.