[59.265156] Initializing watchdogs
[59.265204]   /dev/watchdog0
[59.280474] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.284758] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.286957] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.290216] [001/133] (960s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[59.421614] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[59.425958] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[59.495037] [002/133] (960s left) kms_flip (flip-vs-suspend-interruptible)
[59.587798] Starting subtest: flip-vs-suspend-interruptible
[59.590097] Starting dynamic subtest: A-eDP1
[109.419633] Dynamic subtest A-eDP1: SUCCESS (4.686s)
[109.431542] Starting dynamic subtest: B-eDP1
[142.423121] Dynamic subtest B-eDP1: SUCCESS (4.550s)
[142.431787] Starting dynamic subtest: C-eDP1
[191.420115] Dynamic subtest C-eDP1: SUCCESS (4.565s)
[191.431464] Starting dynamic subtest: D-eDP1
[240.398920] Dynamic subtest D-eDP1: SUCCESS (4.537s)
[240.401270] Subtest flip-vs-suspend-interruptible: SUCCESS (18.346s)
[241.546244] [003/133] (778s left) syncobj_wait (single-wait-all-for-submit-submitted)
[241.612318] Starting subtest: single-wait-all-for-submit-submitted
[241.721701] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.113s)
[241.794155] [004/133] (778s left) gem_eio (throttle)
[241.935188] Starting subtest: throttle
[242.103820] Subtest throttle: SUCCESS (0.173s)
[242.210488] [005/133] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[242.310010] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[242.315171] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[242.403644] [006/133] (777s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[242.494898] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[242.497164] Starting dynamic subtest: pipe-A-default-mode
[243.644376] Dynamic subtest pipe-A-default-mode: SKIP (1.183s)
[243.649639] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.184s)
[243.805693] [007/133] (776s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[243.918182] Starting subtest: yf-tiled-16bpp-rotate-90
[243.922832] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[244.011313] [008/133] (776s left) kms_psr (fbc-pr-primary-mmap-cpu)
[244.102256] Starting subtest: fbc-pr-primary-mmap-cpu
[244.107140] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[244.172510] [009/133] (775s left) gem_exec_balancer (bonded-dual)
[244.239298] Starting subtest: bonded-dual
[244.245109] Subtest bonded-dual: SKIP (0.000s)
[244.525195] [010/133] (775s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[244.617168] Starting subtest: yf-tiled-32bpp-rotate-90
[244.622117] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[244.718509] [011/133] (775s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[244.806793] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[244.808997] Starting dynamic subtest: pipe-A
[245.134832] Dynamic subtest pipe-A: SUCCESS (0.338s)
[245.143299] Starting dynamic subtest: pipe-B
[246.527083] Dynamic subtest pipe-B: SUCCESS (1.423s)
[246.535770] Starting dynamic subtest: pipe-C
[247.929906] Dynamic subtest pipe-C: SUCCESS (1.429s)
[247.938983] Starting dynamic subtest: pipe-D
[249.331773] Dynamic subtest pipe-D: SUCCESS (1.422s)
[249.334231] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.614s)
[250.482919] [012/133] (769s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[250.582129] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[257.173654] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.650s)
[257.307787] [013/133] (762s left) kms_cursor_legacy (single-move)
[257.435071] Starting subtest: single-move
[257.437868] Starting dynamic subtest: pipe-A
[262.797121] Dynamic subtest pipe-A: SUCCESS (5.380s)
[262.807816] Starting dynamic subtest: pipe-B
[268.168955] Dynamic subtest pipe-B: SUCCESS (5.381s)
[268.179287] Starting dynamic subtest: pipe-C
[273.548940] Dynamic subtest pipe-C: SUCCESS (5.380s)
[273.559434] Starting dynamic subtest: pipe-D
[278.937266] Dynamic subtest pipe-D: SUCCESS (5.380s)
[278.946409] Starting dynamic subtest: all-pipes
[284.328504] Dynamic subtest all-pipes: SUCCESS (5.387s)
[284.330927] Subtest single-move: SUCCESS (26.917s)
[284.472470] [014/133] (735s left) gem_exec_reloc (basic-wc-read)
[284.600116] Subtest basic-wc-read: SKIP (0.000s)
[284.673230] [015/133] (735s left) kms_atomic (plane-invalid-params)
[284.767052] Starting subtest: plane-invalid-params
[284.769620] Starting dynamic subtest: pipe-A-eDP-1
[285.180463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[285.183279] Subtest plane-invalid-params: SUCCESS (0.414s)
[286.055370] [016/133] (734s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[286.162229] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[286.167450] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[286.261667] [017/133] (734s left) kms_addfb_basic (unused-handle)
[286.315383] Starting subtest: unused-handle
[286.317812] Subtest unused-handle: SUCCESS (0.000s)
[286.460301] [018/133] (733s left) gem_softpin (reverse)
[286.520849] Starting subtest: reverse
[286.528925] Subtest reverse: SUCCESS (0.008s)
[286.656036] [019/133] (733s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[286.752518] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[291.304103] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.554s)
[292.446535] [020/133] (728s left) gem_ctx_engines (independent)
[292.506977] Starting subtest: independent
[292.509618] Starting dynamic subtest: rcs0
[292.683192] Dynamic subtest rcs0: SUCCESS (0.175s)
[292.695412] Starting dynamic subtest: bcs0
[292.837714] Dynamic subtest bcs0: SUCCESS (0.154s)
[292.847272] Starting dynamic subtest: vcs0
[293.010555] Dynamic subtest vcs0: SUCCESS (0.172s)
[293.022663] Starting dynamic subtest: vcs1
[293.185080] Dynamic subtest vcs1: SUCCESS (0.174s)
[293.196956] Starting dynamic subtest: vecs0
[293.344079] Dynamic subtest vecs0: SUCCESS (0.158s)
[293.356847] Starting dynamic subtest: ccs0
[293.524708] Dynamic subtest ccs0: SUCCESS (0.180s)
[293.537581] Starting dynamic subtest: all-engines
[294.405414] Dynamic subtest all-engines: SUCCESS (0.880s)
[294.408125] Subtest independent: SUCCESS (1.898s)
[295.029675] [021/133] (725s left) kms_addfb_basic (bad-pitch-128)
[295.078377] Starting subtest: bad-pitch-128
[295.081241] Subtest bad-pitch-128: SUCCESS (0.000s)
[295.215053] [022/133] (725s left) kms_psr (psr-cursor-mmap-cpu)
[295.308393] Starting subtest: psr-cursor-mmap-cpu
[295.311061] Starting dynamic subtest: eDP-1
[297.043257] Dynamic subtest eDP-1: SUCCESS (1.735s)
[297.045816] Subtest psr-cursor-mmap-cpu: SUCCESS (1.736s)
[297.892358] [023/133] (722s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[298.017823] Starting subtest: cursorB-vs-flipB-atomic-transitions
[298.022675] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[298.171858] [024/133] (722s left) kms_content_protection (suspend-resume)
[298.317048] Starting subtest: suspend-resume
[298.322090] Subtest suspend-resume: SKIP (0.000s)
[298.441741] [025/133] (722s left) kms_cursor_edge_walk (256x256-top-bottom)
[298.538820] Starting subtest: 256x256-top-bottom
[298.541274] Starting dynamic subtest: pipe-A-eDP-1
[301.966186] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[301.976248] Starting dynamic subtest: pipe-D-eDP-1
[305.095455] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[305.098286] Subtest 256x256-top-bottom: SUCCESS (6.555s)
[305.897227] [026/133] (714s left) api_intel_allocator (reloc-allocator)
[305.964987] Starting subtest: reloc-allocator
[305.967241] Starting dynamic subtest: basic
[305.970156] Dynamic subtest basic: SUCCESS (0.004s)
[305.981183] Starting dynamic subtest: parallel-one
[305.983224] Dynamic subtest parallel-one: SUCCESS (0.008s)
[305.992599] Starting dynamic subtest: print
[305.995195] Dynamic subtest print: SUCCESS (0.000s)
[306.004276] Starting dynamic subtest: reuse
[306.007432] Dynamic subtest reuse: SUCCESS (0.000s)
[306.019095] Starting dynamic subtest: fork-reopen-allocator
[306.021369] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[306.024095] Subtest reloc-allocator: SUCCESS (0.026s)
[306.095089] [027/133] (714s left) syncobj_basic (bad-destroy)
[306.162152] Starting subtest: bad-destroy
[306.165218] Subtest bad-destroy: SUCCESS (0.000s)
[306.244591] [028/133] (714s left) kms_vblank (ts-continuation-idle)
[306.347491] Starting subtest: ts-continuation-idle
[306.350370] Starting dynamic subtest: pipe-A-eDP-1
[306.748395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[306.770103] Starting dynamic subtest: pipe-D-eDP-1
[307.891424] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[307.894257] Subtest ts-continuation-idle: SUCCESS (1.544s)
[308.762867] [029/133] (712s left) gem_exec_capture (pi)
[308.823812] Starting subtest: pi
[308.826313] Starting dynamic subtest: rcs0
[313.268875] Dynamic subtest rcs0: SUCCESS (4.445s)
[313.283379] Starting dynamic subtest: bcs0
[317.263707] Dynamic subtest bcs0: SUCCESS (3.994s)
[317.274559] Starting dynamic subtest: vcs0
[321.214865] Dynamic subtest vcs0: SUCCESS (3.951s)
[321.232214] Starting dynamic subtest: vcs1
[325.152359] Dynamic subtest vcs1: SUCCESS (3.937s)
[325.165406] Starting dynamic subtest: vecs0
[329.092782] Dynamic subtest vecs0: SUCCESS (3.941s)
[329.103548] Starting dynamic subtest: ccs0
[333.072295] Dynamic subtest ccs0: SUCCESS (3.980s)
[333.075312] Subtest pi: SUCCESS (24.256s)
[333.170701] [030/133] (687s left) fbdev (read)
[333.281081] Starting subtest: read
[333.809348] Subtest read: SUCCESS (0.527s)
[333.875847] [031/133] (687s left) kms_cursor_crc (cursor-random-256x256)
[334.165422] Starting subtest: cursor-random-256x256
[334.168009] Starting dynamic subtest: pipe-A-eDP-1
[337.541170] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.371s)
[337.571906] Starting dynamic subtest: pipe-D-eDP-1
[341.607635] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.043s)
[341.610367] Subtest cursor-random-256x256: SUCCESS (7.440s)
[342.430464] [032/133] (678s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[342.527202] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[342.618511] [033/133] (678s left) kms_atomic_transition (plane-all-modeset-transition)
[342.712146] Starting subtest: plane-all-modeset-transition
[342.717101] Subtest plane-all-modeset-transition: SKIP (0.000s)
[342.783959] [034/133] (678s left) core_auth (getclient-simple)
[342.821376] Starting subtest: getclient-simple
[342.840404] Subtest getclient-simple: SUCCESS (0.016s)
[342.945296] [035/133] (678s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[343.046371] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[343.904274] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.859s)
[344.054494] [036/133] (677s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[344.147741] Starting subtest: blocking-absolute-wf_vblank-interruptible
[344.149984] Starting dynamic subtest: A-eDP1
[352.894111] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[352.904679] Starting dynamic subtest: B-eDP1
[361.632986] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[361.642552] Starting dynamic subtest: C-eDP1
[370.364946] Dynamic subtest C-eDP1: SUCCESS (8.729s)
[370.379403] Starting dynamic subtest: D-eDP1
[379.098410] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[379.104592] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.951s)
[380.314307] [037/133] (640s left) kms_lease (page-flip-implicit-plane)
[380.418400] Starting subtest: page-flip-implicit-plane
[380.420948] Starting dynamic subtest: pipe-A-eDP-1
[380.899832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s)
[380.910081] Starting dynamic subtest: pipe-B-eDP-1
[382.072537] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.172s)
[382.083145] Starting dynamic subtest: pipe-C-eDP-1
[383.185619] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[383.195979] Starting dynamic subtest: pipe-D-eDP-1
[384.318116] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[384.320850] Subtest page-flip-implicit-plane: SUCCESS (3.903s)
[385.133209] [038/133] (636s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[385.239112] Starting subtest: bad-aux-stride-y-tiled-ccs
[385.241802] Starting dynamic subtest: pipe-A-eDP-1
[385.267423] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[385.278217] Starting dynamic subtest: pipe-B-eDP-1
[385.303989] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[385.313368] Starting dynamic subtest: pipe-C-eDP-1
[385.341184] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[385.351280] Starting dynamic subtest: pipe-D-eDP-1
[385.377800] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[385.382512] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[387.409545] [039/133] (633s left) kms_fence_pin_leak
[387.577935] [040/133] (633s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[387.680692] Starting subtest: extended-modeset-hang-oldfb-with-reset
[387.683144] Starting dynamic subtest: pipe-A
[399.404956] Dynamic subtest pipe-A: SUCCESS (11.725s)
[399.417723] Starting dynamic subtest: pipe-D
[411.672291] Dynamic subtest pipe-D: SUCCESS (12.267s)
[411.675138] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.998s)
[412.471583] [041/133] (608s left) perf_pmu (busy-idle-no-semaphores)
[412.523028] Starting subtest: busy-idle-no-semaphores
[412.524875] Starting dynamic subtest: rcs0
[413.175314] Dynamic subtest rcs0: SUCCESS (0.652s)
[413.189324] Starting dynamic subtest: bcs0
[413.827915] Dynamic subtest bcs0: SUCCESS (0.650s)
[413.841527] Starting dynamic subtest: vcs0
[414.479405] Dynamic subtest vcs0: SUCCESS (0.650s)
[414.493388] Starting dynamic subtest: vcs1
[416.439768] Dynamic subtest vcs1: SUCCESS (1.958s)
[416.453508] Starting dynamic subtest: vecs0
[418.483172] Dynamic subtest vecs0: SUCCESS (2.041s)
[418.494626] Starting dynamic subtest: ccs0
[420.470201] Dynamic subtest ccs0: SUCCESS (1.985s)
[420.473045] Subtest busy-idle-no-semaphores: SUCCESS (7.949s)
[420.585592] [042/133] (600s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[420.676300] Starting subtest: plane-use-after-nonblocking-unbind
[420.678815] Starting dynamic subtest: pipe-A-eDP-1
[420.737299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[421.043941] Starting dynamic subtest: pipe-B-eDP-1
[421.879761] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.847s)
[422.170165] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.496s)
[423.027084] [043/133] (598s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[423.133391] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[423.140414] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[423.227903] [044/133] (598s left) kms_psr (psr-sprite-render)
[423.317370] Starting subtest: psr-sprite-render
[423.320022] Starting dynamic subtest: eDP-1
[425.060037] Dynamic subtest eDP-1: SUCCESS (1.742s)
[425.062398] Subtest psr-sprite-render: SUCCESS (1.743s)
[425.900114] [045/133] (595s left) kms_getfb (getfb-handle-protection)
[425.993133] Starting subtest: getfb-handle-protection
[426.010249] Subtest getfb-handle-protection: SUCCESS (0.018s)
[426.119964] [046/133] (595s left) i915_hangman (engine-engine-error)
[426.192853] Starting subtest: engine-engine-error
[426.195264] Starting dynamic subtest: rcs0
[427.819947] Dynamic subtest rcs0: SUCCESS (1.625s)
[427.833392] Starting dynamic subtest: bcs0
[429.803403] Dynamic subtest bcs0: SUCCESS (1.981s)
[429.816863] Starting dynamic subtest: vcs0
[431.788752] Dynamic subtest vcs0: SUCCESS (1.983s)
[431.802781] Starting dynamic subtest: vcs1
[433.835053] Dynamic subtest vcs1: SUCCESS (2.044s)
[433.848636] Starting dynamic subtest: vecs0
[435.755358] Dynamic subtest vecs0: SUCCESS (1.918s)
[435.768676] Starting dynamic subtest: ccs0
[437.802822] Dynamic subtest ccs0: SUCCESS (2.045s)
[437.805815] Subtest engine-engine-error: SUCCESS (11.612s)
[437.931101] [047/133] (583s left) gem_pxp (display-protected-crc)
[438.055867] Starting subtest: display-protected-crc
[439.740971] Subtest display-protected-crc: SUCCESS (1.689s)
[439.858491] [048/133] (581s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[439.966980] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[439.972154] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[440.064852] [049/133] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[440.153327] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[440.158625] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[440.251873] [050/133] (581s left) kms_chamelium_frames (dp-frame-dump)
[440.631311] Subtest dp-frame-dump: SKIP (0.000s)
[441.414301] [051/133] (580s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[441.518086] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[442.564019] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.046s)
[442.673642] [052/133] (579s left) kms_atomic_interruptible (legacy-pageflip)
[442.763731] Starting subtest: legacy-pageflip
[442.766144] Starting dynamic subtest: pipe-A-eDP-1
[450.151212] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.387s)
[450.154165] Subtest legacy-pageflip: SUCCESS (7.389s)
[450.994447] [053/133] (570s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[451.093126] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[451.098130] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[451.164463] [054/133] (570s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[451.280940] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[451.326189] [055/133] (570s left) gem_mmap_gtt (zero-extend)
[451.380216] Subtest zero-extend: SKIP (0.000s)
[451.439378] [056/133] (570s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[451.522782] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[451.525078] Starting dynamic subtest: pipe-A-eDP-1
[451.546472] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[451.557691] Starting dynamic subtest: pipe-B-eDP-1
[451.582214] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[451.592095] Starting dynamic subtest: pipe-C-eDP-1
[451.617043] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.627106] Starting dynamic subtest: pipe-D-eDP-1
[451.652712] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[451.657377] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[453.761771] [057/133] (568s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[453.884017] Starting subtest: flip-vs-cursor-crc-atomic
[454.556312] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.671s)
[455.397130] [058/133] (566s left) gem_exec_schedule (pi-ringfull)
[455.577018] Starting subtest: pi-ringfull
[455.579352] Starting dynamic subtest: rcs0
[455.666219] Dynamic subtest rcs0: SUCCESS (0.091s)
[455.682135] Starting dynamic subtest: bcs0
[455.692909] Dynamic subtest bcs0: SUCCESS (0.026s)
[455.707920] Starting dynamic subtest: vcs0
[455.721218] Dynamic subtest vcs0: SUCCESS (0.027s)
[455.736412] Starting dynamic subtest: vcs1
[455.748659] Dynamic subtest vcs1: SUCCESS (0.027s)
[455.763258] Starting dynamic subtest: vecs0
[455.776808] Dynamic subtest vecs0: SUCCESS (0.027s)
[455.792054] Starting dynamic subtest: ccs0
[455.803827] Dynamic subtest ccs0: SUCCESS (0.026s)
[455.806415] Subtest pi-ringfull: SUCCESS (0.230s)
[456.023829] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[456.027609] [059/133] (566s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[456.135602] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[456.140406] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[456.232635] [060/133] (565s left) kms_flip (dpms-off-confusion-interruptible)
[456.324181] Starting subtest: dpms-off-confusion-interruptible
[456.326951] Starting dynamic subtest: A-eDP1
[465.008277] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[465.023218] Starting dynamic subtest: B-eDP1
[473.632862] Dynamic subtest B-eDP1: SUCCESS (8.620s)
[473.644479] Starting dynamic subtest: C-eDP1
[482.255022] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[482.267414] Starting dynamic subtest: D-eDP1
[490.888266] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[490.891058] Subtest dpms-off-confusion-interruptible: SUCCESS (34.562s)
[492.062241] [061/133] (530s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[492.168640] Starting subtest: x-tiled-16bpp-rotate-0
[493.459204] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.290s)
[493.602226] [062/133] (528s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[493.652130] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[493.761469] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[493.837470] [063/133] (528s left) gem_lmem_swapping (verify-random)
[493.883262] Subtest verify-random: SKIP (0.000s)
[493.928901] [064/133] (528s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[494.025095] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[494.030076] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[494.111391] [065/133] (528s left) prime_busy (after)
[494.173833] Starting subtest: after
[494.179384] Starting dynamic subtest: rcs0
[494.212069] Dynamic subtest rcs0: SUCCESS (0.035s)
[494.223441] Starting dynamic subtest: bcs0
[494.253104] Dynamic subtest bcs0: SUCCESS (0.040s)
[494.266158] Starting dynamic subtest: vcs0
[494.294001] Dynamic subtest vcs0: SUCCESS (0.040s)
[494.304404] Starting dynamic subtest: vcs1
[494.336084] Dynamic subtest vcs1: SUCCESS (0.041s)
[494.347000] Starting dynamic subtest: vecs0
[494.378405] Dynamic subtest vecs0: SUCCESS (0.041s)
[494.389420] Starting dynamic subtest: ccs0
[494.419956] Dynamic subtest ccs0: SUCCESS (0.041s)
[494.528556] Subtest after: SUCCESS (0.353s)
[494.612246] [066/133] (527s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[494.674191] Starting subtest: y-tiled-ccs-to-x-tiled
[494.680308] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[494.855261] [067/133] (527s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[494.918210] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[494.923433] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[495.102737] [068/133] (527s left) sysfs_heartbeat_interval (precise)
[495.160410] Starting subtest: precise
[495.162621] Starting dynamic subtest: vecs0
[502.858213] Dynamic subtest vecs0: SUCCESS (7.692s)
[502.871355] Starting dynamic subtest: ccs0
[503.975374] Dynamic subtest ccs0: SUCCESS (1.116s)
[503.986633] Starting dynamic subtest: vcs0
[511.816383] Dynamic subtest vcs0: SUCCESS (7.841s)
[511.829861] Starting dynamic subtest: bcs0
[512.946130] Dynamic subtest bcs0: SUCCESS (1.124s)
[512.958315] Starting dynamic subtest: rcs0
[514.030080] Dynamic subtest rcs0: SUCCESS (1.084s)
[514.041985] Starting dynamic subtest: vcs1
[521.866167] Dynamic subtest vcs1: SUCCESS (7.834s)
[521.869189] Subtest precise: SUCCESS (26.703s)
[521.957863] [069/133] (500s left) syncobj_timeline (invalid-transfer-illegal-handle)
[522.017369] Starting subtest: invalid-transfer-illegal-handle
[522.020207] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[522.132050] [070/133] (500s left) kms_pm_rpm (legacy-planes)
[523.965327] Starting subtest: legacy-planes
[523.967917] Starting dynamic subtest: plane-65
[532.253558] Dynamic subtest plane-65: SUCCESS (8.289s)
[532.267701] Starting dynamic subtest: plane-95
[540.537540] Dynamic subtest plane-95: SUCCESS (8.283s)
[540.551239] Starting dynamic subtest: plane-125
[548.829446] Dynamic subtest plane-125: SUCCESS (8.289s)
[548.843381] Starting dynamic subtest: plane-135
[557.128277] Dynamic subtest plane-135: SUCCESS (8.296s)
[557.131054] Subtest legacy-planes: SUCCESS (33.167s)
[557.510088] [071/133] (465s left) gem_exec_fence (syncobj-export)
[557.945132] Starting subtest: syncobj-export
[557.950326] Subtest syncobj-export: SUCCESS (0.008s)
[559.903518] [072/133] (462s left) gem_exec_whisper (basic-queues-forked)
[559.990416] Starting subtest: basic-queues-forked
[582.585975] Subtest basic-queues-forked: SUCCESS (22.595s)
[582.786090] [073/133] (440s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[582.900230] Starting subtest: read-crc-frame-sequence
[582.902994] Starting dynamic subtest: pipe-A-eDP-1
[583.624212] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[583.635390] Starting dynamic subtest: pipe-B-eDP-1
[584.984117] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.356s)
[584.995985] Starting dynamic subtest: pipe-C-eDP-1
[586.286172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.302s)
[586.298529] Starting dynamic subtest: pipe-D-eDP-1
[587.616272] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[587.618806] Subtest read-crc-frame-sequence: SUCCESS (4.717s)
[588.466676] [074/133] (434s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[588.568025] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[588.572980] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[588.662450] [075/133] (434s left) prime_mmap (test_aperture_limit)
[588.722970] Starting subtest: test_aperture_limit
[588.725157] Starting dynamic subtest: test_aperture_limit-smem
[588.731255] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[588.736250] Subtest test_aperture_limit: SKIP (0.009s)
[588.831995] [076/133] (434s left) i915_pm_rc6_residency (rc6-accuracy)
[588.892000] Starting subtest: rc6-accuracy
[588.894776] Starting dynamic subtest: gt0
[592.062874] Dynamic subtest gt0: SUCCESS (3.170s)
[592.076419] Starting dynamic subtest: gt1
[595.235597] Dynamic subtest gt1: SUCCESS (3.169s)
[595.238427] Subtest rc6-accuracy: SUCCESS (6.346s)
[595.317972] [077/133] (427s left) perf (global-sseu-config-invalid)
[595.465113] Starting subtest: global-sseu-config-invalid
[595.469652] Subtest global-sseu-config-invalid: SKIP (0.000s)
[595.512081] [078/133] (427s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[595.613954] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[599.891561] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.281s)
[601.037751] [079/133] (422s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[601.141215] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[601.146799] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[601.234193] [080/133] (421s left) kms_pm_rpm (cursor)
[602.967391] Starting subtest: cursor
[602.972944] Subtest cursor: SKIP (0.000s)
[603.476982] [081/133] (419s left) sw_sync (sync_multi_consumer)
[603.524136] Starting subtest: sync_multi_consumer
[604.300009] Subtest sync_multi_consumer: SUCCESS (0.779s)
[604.364753] [082/133] (418s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[604.465083] Starting subtest: fbc-psr-cursor-mmap-cpu
[604.467607] Starting dynamic subtest: eDP-1
[604.472602] Dynamic subtest eDP-1: SKIP (0.000s)
[604.477383] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[604.540757] [083/133] (418s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[604.641225] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[613.297419] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.660s)
[613.416200] [084/133] (409s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[613.515207] Starting subtest: y-tiled-8bpp-rotate-180
[613.520184] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[613.628753] [085/133] (409s left) gem_exec_reloc (basic-softpin)
[613.689323] Subtest basic-softpin: SKIP (0.000s)
[613.763943] [086/133] (409s left) gem_exec_schedule (timeslicing)
[613.848169] Starting subtest: timeslicing
[613.850999] Starting dynamic subtest: rcs0
[613.857411] Dynamic subtest rcs0: SUCCESS (0.021s)
[613.873521] Starting dynamic subtest: bcs0
[613.879658] Dynamic subtest bcs0: SUCCESS (0.022s)
[613.890203] Starting dynamic subtest: vcs0
[613.897378] Dynamic subtest vcs0: SUCCESS (0.020s)
[613.908168] Starting dynamic subtest: vcs1
[613.917469] Dynamic subtest vcs1: SUCCESS (0.020s)
[613.928323] Starting dynamic subtest: vecs0
[613.938959] Dynamic subtest vecs0: SUCCESS (0.020s)
[613.950063] Starting dynamic subtest: ccs0
[613.961877] Dynamic subtest ccs0: SUCCESS (0.022s)
[613.964557] Subtest timeslicing: SUCCESS (0.129s)
[615.872023] [087/133] (407s left) kms_chamelium_color (ctm-green-to-red)
[615.966310] Subtest ctm-green-to-red: SKIP (0.000s)
[616.016383] [088/133] (407s left) gen9_exec_parse (batch-zero-length)
[616.093133] Subtest batch-zero-length: SKIP (0.000s)
[616.170480] [089/133] (407s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[616.276206] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[616.281619] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[616.369872] [090/133] (407s left) dmabuf_sync_file (export-multiwait)
[616.412506] Starting subtest: export-multiwait
[616.415214] Subtest export-multiwait: SUCCESS (0.002s)
[616.489680] [091/133] (407s left) gen3_render_tiledx_blits
[616.609737] [092/133] (407s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[616.703124] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[616.705863] Starting dynamic subtest: pipe-A-eDP-1
[616.733234] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[616.745328] Starting dynamic subtest: pipe-B-eDP-1
[616.770955] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[616.781282] Starting dynamic subtest: pipe-C-eDP-1
[616.806523] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[616.816533] Starting dynamic subtest: pipe-D-eDP-1
[616.839835] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[616.844441] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[618.907750] [093/133] (404s left) kms_color (gamma)
[618.997363] Starting subtest: gamma
[619.000248] Starting dynamic subtest: pipe-A-eDP-1
[619.743595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[619.754672] Starting dynamic subtest: pipe-B-eDP-1
[621.126642] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[621.138227] Starting dynamic subtest: pipe-C-eDP-1
[622.522686] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[622.533852] Starting dynamic subtest: pipe-D-eDP-1
[623.858179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[623.860895] Subtest gamma: SUCCESS (4.861s)
[624.661785] [094/133] (399s left) gem_ctx_persistence (legacy-engines-mixed-process)
[624.728377] Starting subtest: legacy-engines-mixed-process
[624.731158] Starting dynamic subtest: render
[626.834297] Dynamic subtest render: SUCCESS (2.105s)
[626.847420] Starting dynamic subtest: bsd1
[628.800898] Dynamic subtest bsd1: SUCCESS (1.963s)
[628.816047] Starting dynamic subtest: bsd2
[630.798300] Dynamic subtest bsd2: SUCCESS (1.999s)
[630.810063] Starting dynamic subtest: blt
[632.859632] Dynamic subtest blt: SUCCESS (2.059s)
[632.871425] Starting dynamic subtest: vebox
[634.841099] Dynamic subtest vebox: SUCCESS (1.980s)
[634.844001] Subtest legacy-engines-mixed-process: SUCCESS (10.114s)
[634.936053] [095/133] (388s left) kms_plane (pixel-format-y-tiled-modifier)
[635.033381] Starting subtest: pixel-format-y-tiled-modifier
[635.038396] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[635.115222] [096/133] (388s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[635.211102] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[635.213229] Starting dynamic subtest: pipe-A-eDP-1
[635.279256] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[635.290198] Starting dynamic subtest: pipe-B-eDP-1
[635.357126] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[635.368544] Starting dynamic subtest: pipe-C-eDP-1
[635.435157] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[635.446572] Starting dynamic subtest: pipe-D-eDP-1
[635.513240] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[635.518361] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.012s)
[637.425675] [097/133] (386s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[637.528926] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[644.341421] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.816s)
[644.466554] [098/133] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[644.562298] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[644.567372] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[644.657117] [099/133] (379s left) gem_exec_reloc (basic-scanout)
[644.717022] Subtest basic-scanout: SKIP (0.000s)
[644.791175] [100/133] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[644.892040] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[644.896962] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[644.992319] [101/133] (379s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[645.103939] Starting subtest: cursor-vs-flip-toggle
[676.492781] Subtest cursor-vs-flip-toggle: SUCCESS (31.392s)
[677.303958] [102/133] (346s left) syncobj_timeline (single-wait-available-signaled)
[677.362036] Starting subtest: single-wait-available-signaled
[677.364635] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[677.466446] [103/133] (346s left) gem_ctx_isolation (clean)
[677.528373] Starting subtest: clean
[677.531139] Starting dynamic subtest: rcs0
[677.578745] Dynamic subtest rcs0: SUCCESS (0.050s)
[677.591425] Starting dynamic subtest: bcs0
[677.645889] Dynamic subtest bcs0: SUCCESS (0.066s)
[677.658401] Starting dynamic subtest: vcs0
[677.700986] Dynamic subtest vcs0: SUCCESS (0.054s)
[677.713432] Starting dynamic subtest: vcs1
[678.880107] Dynamic subtest vcs1: SUCCESS (1.178s)
[678.891545] Starting dynamic subtest: vecs0
[680.867834] Dynamic subtest vecs0: SUCCESS (1.987s)
[680.878937] Starting dynamic subtest: ccs0
[682.858573] Dynamic subtest ccs0: SUCCESS (1.990s)
[682.861304] Subtest clean: SUCCESS (5.331s)
[683.094302] [104/133] (341s left) kms_plane_multiple (tiling-4)
[683.189151] Starting subtest: tiling-4
[683.191947] Starting dynamic subtest: pipe-A-eDP-1
[687.136179] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.946s)
[687.147533] Starting dynamic subtest: pipe-B-eDP-1
[691.584239] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.446s)
[691.598402] Starting dynamic subtest: pipe-C-eDP-1
[695.909416] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.323s)
[695.921124] Starting dynamic subtest: pipe-D-eDP-1
[700.238271] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.328s)
[700.241214] Subtest tiling-4: SUCCESS (17.050s)
[701.052758] [105/133] (323s left) syncobj_timeline (multi-wait-submitted-signaled)
[701.108999] Starting subtest: multi-wait-submitted-signaled
[701.111536] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[701.208183] [106/133] (323s left) gem_exec_flush (basic-uc-set-default)
[701.265600] Starting subtest: basic-uc-set-default
[706.732255] Subtest basic-uc-set-default: SUCCESS (5.462s)
[706.937377] [107/133] (317s left) gem_readwrite (new-obj)
[706.991604] Subtest new-obj: SKIP (0.000s)
[707.056791] [108/133] (317s left) kms_joiner (basic-ultra-joiner)
[707.154410] Starting subtest: basic-ultra-joiner
[707.159633] Subtest basic-ultra-joiner: SKIP (0.000s)
[707.222573] [109/133] (317s left) i915_drm_fdinfo (most-busy-idle-check-all)
[707.265378] Starting subtest: most-busy-idle-check-all
[707.267886] Starting dynamic subtest: rcs0
[707.273091] Dynamic subtest rcs0: SKIP (0.005s)
[707.285165] Starting dynamic subtest: bcs0
[707.290385] Dynamic subtest bcs0: SKIP (0.001s)
[707.301623] Starting dynamic subtest: vcs0
[707.306595] Dynamic subtest vcs0: SKIP (0.000s)
[707.317104] Starting dynamic subtest: vcs1
[707.322537] Dynamic subtest vcs1: SKIP (0.000s)
[707.333170] Starting dynamic subtest: vecs0
[707.338138] Dynamic subtest vecs0: SKIP (0.000s)
[707.348496] Starting dynamic subtest: ccs0
[707.353467] Dynamic subtest ccs0: SKIP (0.000s)
[707.359027] Subtest most-busy-idle-check-all: SKIP (0.012s)
[707.400105] [110/133] (317s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[707.538062] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[707.543190] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[707.684517] [111/133] (316s left) gem_exec_alignment (forked)
[707.745261] Starting subtest: forked
[747.147373] Subtest forked: SUCCESS (39.386s)
[747.229900] [112/133] (277s left) kms_chamelium_hpd (vga-hpd-fast)
[747.664889] Subtest vga-hpd-fast: SKIP (0.000s)
[748.481830] [113/133] (276s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[748.595973] Starting subtest: fbc-rgb101010-draw-pwrite
[754.009680] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.415s)
[755.188817] [114/133] (269s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[755.247179] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[755.314822] [115/133] (269s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[755.403485] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[755.407767] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[755.515105] [116/133] (269s left) syncobj_wait (wait-any-interrupted)
[755.573071] Starting subtest: wait-any-interrupted
[755.675546] Subtest wait-any-interrupted: SUCCESS (0.102s)
[755.769911] [117/133] (269s left) kms_flip (2x-modeset-vs-vblank-race)
[755.861158] Starting subtest: 2x-modeset-vs-vblank-race
[755.870872] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[755.958827] [118/133] (268s left) gem_exec_reloc (basic-cpu-gtt)
[756.020683] Subtest basic-cpu-gtt: SKIP (0.000s)
[756.097623] [119/133] (268s left) gem_exec_whisper (basic-contexts-all)
[756.171721] Starting subtest: basic-contexts-all
[766.617737] Subtest basic-contexts-all: SUCCESS (10.439s)
[766.808768] [120/133] (258s left) prime_mmap (test_correct_cpu_write)
[766.869329] Starting subtest: test_correct_cpu_write
[766.872164] Starting dynamic subtest: test_correct_cpu_write-smem
[766.875031] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[766.878407] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[766.951629] [121/133] (258s left) kms_dp_link_training (uhbr-sst)
[767.054385] Starting subtest: uhbr-sst
[767.064663] Subtest uhbr-sst: SKIP (0.000s)
[767.134823] [122/133] (257s left) kms_flip (basic-flip-vs-wf_vblank)
[767.229162] Starting subtest: basic-flip-vs-wf_vblank
[767.231736] Starting dynamic subtest: A-eDP1
[769.218221] Dynamic subtest A-eDP1: SUCCESS (1.991s)
[769.231010] Starting dynamic subtest: B-eDP1
[771.146383] Dynamic subtest B-eDP1: SUCCESS (1.926s)
[771.165141] Starting dynamic subtest: C-eDP1
[773.074716] Dynamic subtest C-eDP1: SUCCESS (1.923s)
[773.086446] Starting dynamic subtest: D-eDP1
[775.002686] Dynamic subtest D-eDP1: SUCCESS (1.925s)
[775.005400] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.776s)
[776.232583] [123/133] (248s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[776.328166] Starting subtest: fbc-farfromfence-mmap-gtt
[776.333229] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[776.422183] [124/133] (248s left) syncobj_timeline (device-signal-unordered)
[776.473819] Starting subtest: device-signal-unordered
[776.476366] Subtest device-signal-unordered: SUCCESS (0.000s)
[776.590736] [125/133] (248s left) kms_psr (fbc-psr2-cursor-plane-move)
[776.688873] Starting subtest: fbc-psr2-cursor-plane-move
[776.691423] Starting dynamic subtest: eDP-1
[776.696195] Dynamic subtest eDP-1: SKIP (0.000s)
[776.701207] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[776.763942] [126/133] (248s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[776.817094] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[776.873477] [127/133] (248s left) gem_watchdog (default-physical)
[776.944587] Starting subtest: default-physical
[778.700985] Subtest default-physical: SUCCESS (1.769s)
[778.799254] [128/133] (246s left) kms_psr (pr-primary-page-flip)
[778.911436] Starting subtest: pr-primary-page-flip
[778.916791] Subtest pr-primary-page-flip: SKIP (0.000s)
[778.984530] [129/133] (246s left) gem_tiled_blits (basic)
[779.046899] Subtest basic: SKIP (0.000s)
[779.126428] [130/133] (246s left) kms_cursor_crc (cursor-offscreen-512x512)
[779.414906] Starting subtest: cursor-offscreen-512x512
[779.419428] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[779.562885] [131/133] (245s left) kms_setmode (basic)
[779.610962] Starting subtest: basic
[779.934814] Starting dynamic subtest: pipe-A-eDP-1
[782.053839] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[782.400067] Starting dynamic subtest: pipe-B-eDP-1
[784.477064] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.082s)
[784.783660] Subtest basic: SUCCESS (5.170s)
[785.614864] [132/133] (239s left) i915_query (engine-info)
[785.671347] Starting subtest: engine-info
[785.674078] Subtest engine-info: SUCCESS (0.005s)
[785.820502] [133/133] (239s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[785.881786] Starting subtest: yf-tiled-ccs-to-x-tiled
[785.886834] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[786.062400] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: gem_eio
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_atomic
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_engines
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_cursor_edge_walk
results: parsing output: 25/ for test: api_intel_allocator
results: parsing output: 26/ for test: syncobj_basic
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: gem_exec_capture
results: parsing output: 29/ for test: fbdev
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_atomic_transition
results: parsing output: 33/ for test: core_auth
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_lease
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_fence_pin_leak
results: parsing output: 39/ for test: kms_busy
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_getfb
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_atomic_interruptible
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: kms_tiled_display
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: prime_busy
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: sysfs_heartbeat_interval
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: gem_exec_whisper
results: parsing output: 72/ for test: kms_pipe_crc_basic
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: prime_mmap
results: parsing output: 75/ for test: i915_pm_rc6_residency
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_pm_rpm
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_chamelium_color
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: dmabuf_sync_file
results: parsing output: 90/ for test: gen3_render_tiledx_blits
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_ctx_isolation
results: parsing output: 103/ for test: kms_plane_multiple
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_exec_flush
results: parsing output: 106/ for test: gem_readwrite
results: parsing output: 107/ for test: kms_joiner
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: gem_exec_alignment
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_pipe_b_c_ivb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: prime_mmap
results: parsing output: 120/ for test: kms_dp_link_training
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: gem_watchdog
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_tiled_blits
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_setmode
results: parsing output: 131/ for test: i915_query
results: parsing output: 132/ for test: gem_render_copy
Done.