[60.761863] Initializing watchdogs
[60.761961]   /dev/watchdog0
[60.777550] [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.782098] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.785017] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.787432] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[60.884741] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[60.886605] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[60.976399] [002/133] (960s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[61.061883] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[61.063025] Starting dynamic subtest: pipe-A-default-mode
[63.846804] Dynamic subtest pipe-A-default-mode: SUCCESS (2.777s)
[63.847864] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.779s)
[64.670671] [003/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[64.770748] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[64.772630] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[64.862769] [004/133] (956s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[64.912381] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[64.967924] [005/133] (956s left) gem_tiled_wb
[65.070350] [006/133] (956s left) gem_exec_schedule (semaphore-noskip)
[65.133579] Starting subtest: semaphore-noskip
[65.560779] Subtest semaphore-noskip: SUCCESS (0.417s)
[65.877080] [007/133] (955s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[65.960364] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[65.961249] Starting dynamic subtest: pipe-A-eDP-1
[65.969617] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[65.975840] Starting dynamic subtest: pipe-B-eDP-1
[65.984220] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[65.990164] Starting dynamic subtest: pipe-C-eDP-1
[65.998251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.003757] Starting dynamic subtest: pipe-D-eDP-1
[66.011870] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.013430] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[68.231689] [008/133] (953s left) kms_dsc (dsc-basic)
[68.323292] Starting subtest: dsc-basic
[68.327890] Subtest dsc-basic: SKIP (0.000s)
[68.399173] [009/133] (953s left) gem_mmap_gtt (basic-small-bo-tiledy)
[68.441882] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[68.495717] [010/133] (953s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[68.588883] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[69.658393] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.069s)
[69.797761] [011/133] (951s left) gen9_exec_parse (basic-rejected-ctx-param)
[69.854271] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[69.919712] [012/133] (951s left) gem_exec_schedule (deep)
[70.104325] Starting subtest: deep
[70.105598] Starting dynamic subtest: rcs0
[75.213798] Dynamic subtest rcs0: SKIP (5.098s)
[75.222284] Starting dynamic subtest: vcs0
[85.252995] Dynamic subtest vcs0: SUCCESS (10.032s)
[85.263951] Starting dynamic subtest: vcs1
[96.856053] Dynamic subtest vcs1: SUCCESS (11.596s)
[96.867719] Starting dynamic subtest: vecs0
[107.627578] Dynamic subtest vecs0: SUCCESS (10.768s)
[107.638277] Starting dynamic subtest: ccs0
[119.609871] Dynamic subtest ccs0: SUCCESS (11.979s)
[119.611155] Subtest deep: SUCCESS (49.475s)
[120.987007] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[120.989354] [013/133] (900s left) gem_ctx_bad_destroy (double-destroy)
[121.040749] Starting subtest: double-destroy
[121.041767] Subtest double-destroy: SUCCESS (0.000s)
[121.113739] [014/133] (900s left) drm_mm (drm_mm)
[121.153837] Starting subtest: drm_mm
[121.215814] Starting dynamic subtest: drm_test_mm_init
[121.313705] Dynamic subtest drm_test_mm_init: SUCCESS (0.099s)
[121.322352] Starting dynamic subtest: drm_test_mm_debug
[121.414259] Dynamic subtest drm_test_mm_debug: SUCCESS (0.099s)
[121.422264] Starting dynamic subtest: drm_test_mm_align32
[121.503923] Dynamic subtest drm_test_mm_align32: SUCCESS (0.090s)
[121.511385] Starting dynamic subtest: drm_test_mm_align64
[121.600926] Dynamic subtest drm_test_mm_align64: SUCCESS (0.097s)
[121.608926] Starting dynamic subtest: drm_test_mm_lowest
[121.695496] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.094s)
[121.702583] Starting dynamic subtest: drm_test_mm_highest
[121.789062] Dynamic subtest drm_test_mm_highest: SUCCESS (0.092s)
[121.790115] Subtest drm_mm: SUCCESS (0.636s)
[121.934671] [015/133] (899s left) gem_exec_params (invalid-ring)
[121.983655] Starting subtest: invalid-ring
[121.984517] Subtest invalid-ring: SUCCESS (0.000s)
[122.084857] [016/133] (899s left) api_intel_bb (blit-noreloc-purge-cache)
[122.131815] Starting subtest: blit-noreloc-purge-cache
[122.142455] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[122.222686] [017/133] (899s left) syncobj_eventfd (timeline-wait-signaled)
[122.281219] Starting subtest: timeline-wait-signaled
[122.282228] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[122.373123] [018/133] (899s left) kms_atomic (plane-invalid-params)
[122.459069] Starting subtest: plane-invalid-params
[122.460112] Starting dynamic subtest: pipe-A-eDP-1
[122.861755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[122.862664] Subtest plane-invalid-params: SUCCESS (0.403s)
[123.684886] [019/133] (898s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[123.808871] Starting subtest: 2x-long-flip-vs-cursor-atomic
[123.811402] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[123.945813] [020/133] (897s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[124.005387] Starting subtest: saturated-hostile-nopreempt
[124.006390] Starting dynamic subtest: rcs0
[124.089646] Dynamic subtest rcs0: SKIP (0.083s)
[124.098532] Starting dynamic subtest: bcs0
[124.105910] Dynamic subtest bcs0: SKIP (0.016s)
[124.111867] Starting dynamic subtest: vcs0
[124.129918] Dynamic subtest vcs0: SKIP (0.023s)
[124.135871] Starting dynamic subtest: vcs1
[124.150881] Dynamic subtest vcs1: SKIP (0.020s)
[124.156945] Starting dynamic subtest: vecs0
[124.170864] Dynamic subtest vecs0: SKIP (0.019s)
[124.176997] Starting dynamic subtest: ccs0
[124.193944] Dynamic subtest ccs0: SKIP (0.022s)
[124.195680] Subtest saturated-hostile-nopreempt: SKIP (0.188s)
[124.264615] [021/133] (897s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[124.360937] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[124.362787] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[124.441365] [022/133] (897s left) gem_exec_whisper (basic-fds-forked)
[124.491495] Starting subtest: basic-fds-forked
[148.635631] Subtest basic-fds-forked: SUCCESS (24.095s)
[148.783954] [023/133] (873s left) prime_mmap_kms (buffer-sharing)
[148.876992] Starting subtest: buffer-sharing
[149.328570] Subtest buffer-sharing: SUCCESS (0.451s)
[150.113592] [024/133] (871s left) kms_setmode (invalid-clone-single-crtc-stealing)
[150.166739] Starting subtest: invalid-clone-single-crtc-stealing
[150.169351] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[150.262042] [025/133] (871s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[150.359206] Starting subtest: primary-y-tiled-reflect-x-90
[150.360966] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[150.436194] [026/133] (871s left) gem_ctx_bad_destroy (invalid-default-ctx)
[150.483805] Starting subtest: invalid-default-ctx
[150.484763] Subtest invalid-default-ctx: SUCCESS (0.000s)
[150.548799] [027/133] (871s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[150.666361] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[150.668340] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[150.778372] [028/133] (871s left) gem_busy (close-race)
[150.831212] Starting subtest: close-race
[176.930074] Subtest close-race: SUCCESS (26.094s)
[177.297275] [029/133] (844s left) kms_addfb_basic (tile-pitch-mismatch)
[177.399272] Starting subtest: tile-pitch-mismatch
[177.401171] Subtest tile-pitch-mismatch: SKIP (0.000s)
[177.535321] [030/133] (844s left) kms_cursor_crc (cursor-offscreen-64x64)
[177.701807] Starting subtest: cursor-offscreen-64x64
[177.705048] Starting dynamic subtest: pipe-A-eDP-1
[179.663999] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.959s)
[179.694930] Starting dynamic subtest: pipe-D-eDP-1
[182.321371] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s)
[182.322296] Subtest cursor-offscreen-64x64: SUCCESS (4.620s)
[183.170278] [031/133] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[183.258673] Starting subtest: fbcpsr-rgb101010-draw-render
[190.257424] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (7.000s)
[190.364927] [032/133] (831s left) kms_vblank (ts-continuation-modeset-hang)
[190.451400] Starting subtest: ts-continuation-modeset-hang
[190.452356] Starting dynamic subtest: pipe-A-eDP-1
[216.739682] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.289s)
[216.749341] Starting dynamic subtest: pipe-D-eDP-1
[231.700746] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.958s)
[231.701667] Subtest ts-continuation-modeset-hang: SUCCESS (41.251s)
[232.536095] [033/133] (789s left) gem_ctx_shared (exec-single-timeline)
[232.606675] Starting subtest: exec-single-timeline
[232.607687] Starting dynamic subtest: rcs0
[233.661591] Dynamic subtest rcs0: SUCCESS (1.045s)
[233.675830] Starting dynamic subtest: bcs0
[234.685456] Dynamic subtest bcs0: SUCCESS (1.023s)
[234.697605] Starting dynamic subtest: vcs0
[235.710366] Dynamic subtest vcs0: SUCCESS (1.023s)
[235.721645] Starting dynamic subtest: vcs1
[236.798058] Dynamic subtest vcs1: SUCCESS (1.086s)
[236.808640] Starting dynamic subtest: vecs0
[237.887026] Dynamic subtest vecs0: SUCCESS (1.087s)
[237.897538] Starting dynamic subtest: ccs0
[238.975825] Dynamic subtest ccs0: SUCCESS (1.087s)
[238.977201] Subtest exec-single-timeline: SUCCESS (6.361s)
[239.973670] [034/133] (782s left) prime_mmap_coherency (ioctl-errors)
[240.037173] Starting subtest: ioctl-errors
[254.418879] Subtest ioctl-errors: SUCCESS (14.382s)
[254.625155] [035/133] (767s left) gem_workarounds (basic-read)
[254.733561] Starting subtest: basic-read
[254.748911] Subtest basic-read: SUCCESS (0.015s)
[254.875419] [036/133] (767s left) kms_sequence (get-idle)
[254.962977] Starting subtest: get-idle
[254.963729] Starting dynamic subtest: pipe-A-eDP-1
[256.779306] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[256.787154] Starting dynamic subtest: pipe-B-eDP-1
[259.228193] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.447s)
[259.235853] Starting dynamic subtest: pipe-C-eDP-1
[261.638868] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.410s)
[261.646823] Starting dynamic subtest: pipe-D-eDP-1
[264.076194] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.436s)
[264.076933] Subtest get-idle: SUCCESS (9.113s)
[264.890475] [037/133] (757s left) kms_lease (lease-uevent)
[264.985878] Starting subtest: lease-uevent
[266.027400] Subtest lease-uevent: SUCCESS (1.040s)
[266.101879] [038/133] (756s left) gem_ccs (block-multicopy-inplace)
[266.150883] Starting subtest: block-multicopy-inplace
[266.152692] Subtest block-multicopy-inplace: SKIP (0.000s)
[266.271910] [039/133] (756s left) perf_pmu (faulting-read)
[266.305324] Starting subtest: faulting-read
[266.306286] Starting dynamic subtest: wb
[266.307187] Dynamic subtest wb: SUCCESS (0.001s)
[266.316696] Starting dynamic subtest: wc
[266.317568] Dynamic subtest wc: SUCCESS (0.000s)
[266.324956] Starting dynamic subtest: uc
[266.325859] Dynamic subtest uc: SUCCESS (0.000s)
[266.326725] Subtest faulting-read: SUCCESS (0.003s)
[266.395797] [040/133] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[266.495605] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[270.039701] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.544s)
[271.206469] [041/133] (751s left) perf (gen8-unprivileged-single-ctx-counters)
[271.349945] Starting subtest: gen8-unprivileged-single-ctx-counters
[271.351551] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[271.389983] [042/133] (751s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[271.426815] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[271.464411] [043/133] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[271.553601] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[279.081645] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.529s)
[279.214655] [044/133] (743s left) kms_addfb_basic (basic-y-tiled-legacy)
[279.265851] Starting subtest: basic-y-tiled-legacy
[279.267427] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[279.410352] [045/133] (743s left) kms_rotation_crc (multiplane-rotation)
[279.502417] Starting subtest: multiplane-rotation
[296.925520] Subtest multiplane-rotation: SUCCESS (17.416s)
[297.019324] [046/133] (725s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[297.108056] Starting subtest: stress-xrgb8888-xtiled
[303.046154] Subtest stress-xrgb8888-xtiled: SUCCESS (5.939s)
[303.094551] [047/133] (719s left) kms_content_protection (dp-mst-lic-type-0)
[303.233549] Starting subtest: dp-mst-lic-type-0
[303.235512] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[303.362215] [048/133] (719s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[303.454698] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[303.455638] Starting dynamic subtest: pipe-A-eDP-1
[304.360345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.902s)
[304.368486] Starting dynamic subtest: pipe-B-eDP-1
[306.043057] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.681s)
[306.056283] Starting dynamic subtest: pipe-C-eDP-1
[307.595039] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.550s)
[307.603447] Starting dynamic subtest: pipe-D-eDP-1
[309.171636] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.576s)
[309.172405] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.715s)
[310.353915] [049/133] (712s left) gem_exec_schedule (implicit-write-read)
[310.411218] Starting subtest: implicit-write-read
[310.412147] Starting dynamic subtest: rcs0
[310.528364] Dynamic subtest rcs0: SUCCESS (0.116s)
[310.536558] Starting dynamic subtest: vcs0
[310.613202] Dynamic subtest vcs0: SUCCESS (0.083s)
[310.624374] Starting dynamic subtest: vcs1
[310.696387] Dynamic subtest vcs1: SUCCESS (0.084s)
[310.707827] Starting dynamic subtest: vecs0
[310.781403] Dynamic subtest vecs0: SUCCESS (0.084s)
[310.791853] Starting dynamic subtest: ccs0
[310.864579] Dynamic subtest ccs0: SUCCESS (0.081s)
[310.865963] Subtest implicit-write-read: SUCCESS (0.453s)
[311.980064] [050/133] (710s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[312.066630] Starting subtest: psr-rgb101010-draw-blt
[319.478926] Subtest psr-rgb101010-draw-blt: SUCCESS (7.413s)
[319.586807] [051/133] (703s left) kms_big_fb (x-tiled-addfb)
[319.682694] Starting subtest: x-tiled-addfb
[319.683564] Subtest x-tiled-addfb: SUCCESS (0.000s)
[319.793497] [052/133] (703s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[319.846180] Starting subtest: yf-tiled-to-vebox-y-tiled
[319.847852] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[320.041182] [053/133] (703s left) gem_ctx_engines (none)
[320.095355] Starting subtest: none
[320.098039] Subtest none: SUCCESS (0.001s)
[320.275833] [054/133] (702s left) api_intel_bb (reset-flags)
[320.343550] Starting subtest: reset-flags
[320.349768] Subtest reset-flags: SUCCESS (0.007s)
[320.470478] [055/133] (702s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[320.557784] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[320.569892] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[320.644577] [056/133] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[320.735129] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[327.565932] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.831s)
[327.707691] [057/133] (695s left) gem_userptr_blits (userfault)
[327.763907] Starting subtest: userfault
[327.769171] Subtest userfault: SUCCESS (0.007s)
[327.895286] [058/133] (695s left) gem_softpin (evict-snoop)
[327.951648] Starting subtest: evict-snoop
[327.953559] Subtest evict-snoop: SKIP (0.000s)
[328.072837] [059/133] (695s left) kms_chamelium_frames (dp-crc-single)
[328.457578] Subtest dp-crc-single: SKIP (0.000s)
[329.308542] [060/133] (693s left) i915_pm_rc6_residency (rc6-fence)
[329.370247] Starting subtest: rc6-fence
[329.395119] Starting dynamic subtest: gt0
[341.728870] Dynamic subtest gt0: SUCCESS (12.327s)
[341.739464] Starting dynamic subtest: gt1
[356.895984] Dynamic subtest gt1: SUCCESS (15.162s)
[356.897073] Subtest rc6-fence: SUCCESS (27.519s)
[356.972792] [061/133] (666s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[357.074750] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[357.075741] Starting dynamic subtest: pipe-A-eDP-1
[357.085452] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.095674] Starting dynamic subtest: pipe-B-eDP-1
[357.104961] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.112872] Starting dynamic subtest: pipe-C-eDP-1
[357.121604] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.129277] Starting dynamic subtest: pipe-D-eDP-1
[357.138651] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.140200] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[359.407742] [062/133] (663s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[359.497568] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[359.499387] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[359.608565] [063/133] (663s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[359.729663] Starting subtest: flip-vs-cursor-atomic-transitions
[367.745256] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (8.014s)
[368.535075] [064/133] (654s left) kms_flip (2x-flip-vs-fences)
[368.632800] Starting subtest: 2x-flip-vs-fences
[368.634501] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[368.739573] [065/133] (654s left) vgem_basic (unload)
[368.772327] Starting subtest: unload
[397.896165] Subtest unload: SUCCESS (29.079s)
[397.943740] [066/133] (625s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[397.999225] Subtest writes-after-reads: SKIP (0.000s)
[398.057816] [067/133] (625s left) gem_tiled_pread_pwrite
[398.170074] [068/133] (625s left) sw_sync (alloc_fence_invalid_timeline)
[398.198587] Starting subtest: alloc_fence_invalid_timeline
[398.199385] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[398.252149] [069/133] (625s left) gem_reg_read (bad-register)
[398.304046] Starting subtest: bad-register
[398.305056] Subtest bad-register: SUCCESS (0.000s)
[398.411961] [070/133] (625s left) i915_query (hwconfig_table)
[398.459551] Starting subtest: hwconfig_table
[398.566638] Subtest hwconfig_table: SUCCESS (0.001s)
[398.598251] [071/133] (625s left) kms_cursor_crc (cursor-sliding-64x64)
[398.772923] Starting subtest: cursor-sliding-64x64
[398.776399] Starting dynamic subtest: pipe-A-eDP-1
[402.012939] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.230s)
[402.036523] Starting dynamic subtest: pipe-D-eDP-1
[405.938104] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.908s)
[405.939055] Subtest cursor-sliding-64x64: SUCCESS (7.165s)
[406.800397] [072/133] (616s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[406.887621] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[406.889707] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[406.958414] [073/133] (616s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[407.000479] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[407.001549] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[407.095324] [074/133] (616s left) kms_plane (pixel-format-4-tiled-modifier)
[407.184186] Starting subtest: pixel-format-4-tiled-modifier
[407.211483] Starting dynamic subtest: pipe-A-plane-0
[407.844948] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[407.860344] Starting dynamic subtest: pipe-A-plane-3
[408.289104] Dynamic subtest pipe-A-plane-3: SUCCESS (0.442s)
[408.298631] Starting dynamic subtest: pipe-A-plane-5
[408.300372] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[409.393065] Starting dynamic subtest: pipe-B-plane-0
[410.051896] Dynamic subtest pipe-B-plane-0: SUCCESS (0.667s)
[410.059689] Starting dynamic subtest: pipe-B-plane-3
[410.451984] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[410.461109] Starting dynamic subtest: pipe-B-plane-5
[410.463264] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[410.762191] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.577s)
[411.564097] [075/133] (612s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[411.683626] Starting subtest: verify-pxp-key-change-after-suspend-resume
[419.741476] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.059s)
[428.916938] [076/133] (603s left) kms_psr (fbc-psr2-basic)
[429.009035] Starting subtest: fbc-psr2-basic
[429.009860] Starting dynamic subtest: eDP-1
[429.011662] Dynamic subtest eDP-1: SKIP (0.000s)
[429.013284] Subtest fbc-psr2-basic: SKIP (0.001s)
[429.070959] [077/133] (603s left) perf_pmu (busy-accuracy-98)
[429.103559] Starting subtest: busy-accuracy-98
[429.104487] Starting dynamic subtest: rcs0
[432.142369] Dynamic subtest rcs0: SUCCESS (3.033s)
[432.156806] Starting dynamic subtest: bcs0
[435.188723] Dynamic subtest bcs0: SUCCESS (3.045s)
[435.199404] Starting dynamic subtest: vcs0
[438.234805] Dynamic subtest vcs0: SUCCESS (3.044s)
[438.245407] Starting dynamic subtest: vcs1
[441.278453] Dynamic subtest vcs1: SUCCESS (3.041s)
[441.286855] Starting dynamic subtest: vecs0
[444.321507] Dynamic subtest vecs0: SUCCESS (3.041s)
[444.331866] Starting dynamic subtest: ccs0
[447.373637] Dynamic subtest ccs0: SUCCESS (3.049s)
[447.374676] Subtest busy-accuracy-98: SUCCESS (18.264s)
[447.484639] [078/133] (585s left) kms_prop_blob (blob-prop-core)
[447.537570] Starting subtest: blob-prop-core
[447.538490] Subtest blob-prop-core: SUCCESS (0.000s)
[447.634595] [079/133] (585s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[447.744419] Starting subtest: y-tiled-32bpp-rotate-0
[447.746237] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[447.835241] [080/133] (585s left) gem_mmap_wc (write-wc-read-gtt)
[447.887021] Subtest write-wc-read-gtt: SKIP (0.000s)
[447.949863] [081/133] (585s left) kms_force_connector_basic (force-connector-state)
[448.022157] Starting subtest: force-connector-state
[448.631886] Subtest force-connector-state: SUCCESS (0.611s)
[449.569232] [082/133] (583s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[449.618972] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[449.620157] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[449.727940] [083/133] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[449.816425] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[449.818070] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[449.918089] [084/133] (583s left) kms_psr (psr2-primary-render)
[450.015631] Starting subtest: psr2-primary-render
[450.016690] Starting dynamic subtest: eDP-1
[451.783061] Dynamic subtest eDP-1: SUCCESS (1.769s)
[451.783998] Subtest psr2-primary-render: SUCCESS (1.770s)
[452.629805] [085/133] (580s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[452.725185] Starting subtest: yf-tiled-64bpp-rotate-90
[452.727140] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[452.824922] [086/133] (580s left) kms_pm_backlight (fade)
[452.912715] Starting subtest: fade
[452.963061] Starting dynamic subtest: eDP-1
[455.446136] Dynamic subtest eDP-1: SUCCESS (2.483s)
[455.447029] Subtest fade: SUCCESS (2.534s)
[456.231128] [087/133] (577s left) kms_frontbuffer_tracking (fbc-tiling-4)
[456.335672] Starting subtest: fbc-tiling-4
[460.539352] Subtest fbc-tiling-4: SUCCESS (4.203s)
[461.741487] [088/133] (571s left) kms_psr (fbc-psr-cursor-blt)
[461.846455] Starting subtest: fbc-psr-cursor-blt
[461.847404] Starting dynamic subtest: eDP-1
[461.849366] Dynamic subtest eDP-1: SKIP (0.000s)
[461.851141] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[461.919248] [089/133] (571s left) kms_fbcon_fbt (fbc)
[461.974451] Starting subtest: fbc
[468.469040] Subtest fbc: SUCCESS (6.493s)
[469.612847] [090/133] (563s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[469.733337] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[469.735181] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[469.874145] [091/133] (563s left) gem_exec_fence (invalid-timeline-fence-array)
[470.445975] Starting subtest: invalid-timeline-fence-array
[470.447336] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[471.969516] [092/133] (561s left) kms_addfb_basic (unused-modifier)
[472.018848] Starting subtest: unused-modifier
[472.019799] Subtest unused-modifier: SUCCESS (0.000s)
[472.138741] [093/133] (561s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[472.220528] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[472.221482] Starting dynamic subtest: pipe-A-eDP-1
[472.228940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[472.238274] Starting dynamic subtest: pipe-B-eDP-1
[472.245807] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[472.254571] Starting dynamic subtest: pipe-C-eDP-1
[472.261818] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[472.270111] Starting dynamic subtest: pipe-D-eDP-1
[472.277237] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[472.278046] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[474.430328] [094/133] (559s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[474.514066] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[474.515791] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[474.595704] [095/133] (559s left) gem_softpin (allocator-nopin-reserve)
[474.660466] Starting subtest: allocator-nopin-reserve
[474.754738] Subtest allocator-nopin-reserve: SUCCESS (0.094s)
[474.859394] [096/133] (558s left) gem_exec_balancer (bonded-chain)
[474.911680] Starting subtest: bonded-chain
[482.024257] Subtest bonded-chain: SUCCESS (7.103s)
[482.334326] [097/133] (551s left) syncobj_timeline (multi-wait-all-signaled)
[482.382285] Starting subtest: multi-wait-all-signaled
[482.383229] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[482.474089] [098/133] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[482.572018] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[482.573728] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[482.677047] [099/133] (551s left) i915_hangman (engine-engine-hang)
[482.734198] Starting subtest: engine-engine-hang
[482.735265] Starting dynamic subtest: rcs0
[483.902466] Dynamic subtest rcs0: SUCCESS (1.160s)
[483.916887] Starting dynamic subtest: bcs0
[485.887682] Dynamic subtest bcs0: SUCCESS (1.982s)
[485.899485] Starting dynamic subtest: vcs0
[487.871502] Dynamic subtest vcs0: SUCCESS (1.981s)
[487.882781] Starting dynamic subtest: vcs1
[489.855865] Dynamic subtest vcs1: SUCCESS (1.982s)
[489.867598] Starting dynamic subtest: vecs0
[491.903869] Dynamic subtest vecs0: SUCCESS (2.045s)
[491.915482] Starting dynamic subtest: ccs0
[493.888365] Dynamic subtest ccs0: SUCCESS (1.982s)
[493.889791] Subtest engine-engine-hang: SUCCESS (11.147s)
[494.012611] [100/133] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[494.108993] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[494.110722] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[494.206883] [101/133] (539s left) gem_exec_fence (basic-wait)
[494.378531] Starting subtest: basic-wait
[494.379475] Starting dynamic subtest: rcs0
[494.447746] Dynamic subtest rcs0: SUCCESS (0.074s)
[494.460628] Starting dynamic subtest: bcs0
[494.508453] Dynamic subtest bcs0: SUCCESS (0.059s)
[494.520308] Starting dynamic subtest: vcs0
[494.569370] Dynamic subtest vcs0: SUCCESS (0.059s)
[494.581588] Starting dynamic subtest: vcs1
[494.631764] Dynamic subtest vcs1: SUCCESS (0.061s)
[494.643206] Starting dynamic subtest: vecs0
[494.692489] Dynamic subtest vecs0: SUCCESS (0.058s)
[494.704667] Starting dynamic subtest: ccs0
[494.747249] Dynamic subtest ccs0: SUCCESS (0.053s)
[494.749876] Subtest basic-wait: SUCCESS (0.376s)
[497.007411] [102/133] (536s left) gem_ctx_isolation (preservation)
[497.067606] Starting subtest: preservation
[497.068571] Starting dynamic subtest: rcs0
[497.228658] Dynamic subtest rcs0: SUCCESS (0.160s)
[497.240851] Starting dynamic subtest: bcs0
[497.406724] Dynamic subtest bcs0: SUCCESS (0.177s)
[497.418999] Starting dynamic subtest: vcs0
[497.573056] Dynamic subtest vcs0: SUCCESS (0.165s)
[497.585346] Starting dynamic subtest: vcs1
[499.023047] Dynamic subtest vcs1: SUCCESS (1.449s)
[499.035254] Starting dynamic subtest: vecs0
[501.005050] Dynamic subtest vecs0: SUCCESS (1.981s)
[501.016852] Starting dynamic subtest: ccs0
[503.067830] Dynamic subtest ccs0: SUCCESS (2.062s)
[503.069448] Subtest preservation: SUCCESS (6.000s)
[503.301444] [103/133] (530s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[503.394109] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[503.394953] Starting dynamic subtest: pipe-A-eDP-1
[503.403446] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[503.414802] Starting dynamic subtest: pipe-B-eDP-1
[503.423274] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[503.432332] Starting dynamic subtest: pipe-C-eDP-1
[503.440438] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[503.449362] Starting dynamic subtest: pipe-D-eDP-1
[503.457728] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[503.459500] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[505.614572] [104/133] (528s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[505.743246] Starting subtest: flip-vs-cursor-busy-crc-atomic
[506.560469] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.817s)
[507.438244] [105/133] (526s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[507.488297] Starting subtest: invalid-multi-wait-all-unsubmitted
[507.489188] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[507.578966] [106/133] (526s left) kms_invalid_mode (uint-max-clock)
[507.673156] Starting subtest: uint-max-clock
[507.674141] Starting dynamic subtest: pipe-A-eDP-1
[507.957153] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[507.965782] Starting dynamic subtest: pipe-B-eDP-1
[507.966718] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[507.974897] Starting dynamic subtest: pipe-C-eDP-1
[507.975903] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[507.984176] Starting dynamic subtest: pipe-D-eDP-1
[507.985208] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[507.986230] Subtest uint-max-clock: SUCCESS (0.290s)
[508.818035] [107/133] (525s left) syncobj_timeline (wait-any-complex)
[508.866533] Starting subtest: wait-any-complex
[508.930835] Subtest wait-any-complex: SUCCESS (0.063s)
[509.015423] [108/133] (525s left) kms_psr (pr-sprite-mmap-gtt)
[509.119706] Starting subtest: pr-sprite-mmap-gtt
[509.121577] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[509.188793] [109/133] (524s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[509.282331] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[510.339180] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.057s)
[510.457360] [110/133] (523s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[510.552276] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[510.553073] Starting dynamic subtest: pipe-A
[510.570795] Dynamic subtest pipe-A: SKIP (0.018s)
[510.579919] Starting dynamic subtest: pipe-B
[510.603530] Dynamic subtest pipe-B: SKIP (0.031s)
[510.614559] Starting dynamic subtest: pipe-C
[510.635674] Dynamic subtest pipe-C: SKIP (0.032s)
[510.644339] Starting dynamic subtest: pipe-D
[510.667684] Dynamic subtest pipe-D: SKIP (0.032s)
[510.669544] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.114s)
[510.756537] [111/133] (523s left) gem_eio (wait-wedge-10ms)
[510.977757] Starting subtest: wait-wedge-10ms
[511.965648] Subtest wait-wedge-10ms: SUCCESS (0.987s)
[512.119832] [112/133] (522s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[512.211047] Starting subtest: pr-cursor-plane-update-sf
[512.212753] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[512.280706] [113/133] (521s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[512.387331] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[512.389192] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[512.484544] [114/133] (521s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[512.587311] Starting subtest: psr-farfromfence-mmap-gtt
[512.589544] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[512.693573] [115/133] (521s left) gem_mmap_gtt (fault-concurrent)
[512.751603] Subtest fault-concurrent: SKIP (0.000s)
[512.820840] [116/133] (521s left) kms_flip (plain-flip-ts-check-interruptible)
[512.905762] Starting subtest: plain-flip-ts-check-interruptible
[512.907937] Starting dynamic subtest: A-eDP1
[521.805897] Dynamic subtest A-eDP1: SUCCESS (8.873s)
[521.817516] Starting dynamic subtest: B-eDP1
[530.610934] Dynamic subtest B-eDP1: SUCCESS (8.801s)
[530.622523] Starting dynamic subtest: C-eDP1
[539.507600] Dynamic subtest C-eDP1: SUCCESS (8.883s)
[539.517682] Starting dynamic subtest: D-eDP1
[548.279015] Dynamic subtest D-eDP1: SUCCESS (8.801s)
[548.281749] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.374s)
[549.527768] [117/133] (484s left) gem_mmap_offset (blt-coherency)
[549.579130] Starting subtest: blt-coherency
[549.585926] Subtest blt-coherency: SUCCESS (0.007s)
[549.707422] [118/133] (484s left) sysfs_heartbeat_interval (nopreempt)
[549.757093] Starting subtest: nopreempt
[549.757945] Starting dynamic subtest: vecs0
[558.937429] Dynamic subtest vecs0: SUCCESS (9.180s)
[558.951661] Starting dynamic subtest: ccs0
[563.094335] Dynamic subtest ccs0: SUCCESS (4.152s)
[563.104914] Starting dynamic subtest: vcs0
[572.893750] Dynamic subtest vcs0: SUCCESS (9.790s)
[572.903768] Starting dynamic subtest: bcs0
[576.802463] Dynamic subtest bcs0: SUCCESS (3.916s)
[576.814057] Starting dynamic subtest: rcs0
[580.862383] Dynamic subtest rcs0: SUCCESS (4.058s)
[580.872253] Starting dynamic subtest: vcs1
[590.927770] Dynamic subtest vcs1: SUCCESS (10.064s)
[590.930915] Subtest nopreempt: SUCCESS (41.171s)
[591.001697] [119/133] (443s left) kms_cursor_crc (cursor-random-64x64)
[591.183290] Starting subtest: cursor-random-64x64
[591.186803] Starting dynamic subtest: pipe-A-eDP-1
[594.544539] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.357s)
[594.575251] Starting dynamic subtest: pipe-D-eDP-1
[598.591969] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.025s)
[598.592881] Subtest cursor-random-64x64: SUCCESS (7.409s)
[599.408509] [120/133] (435s left) kms_color_pipeline (plane-lut1d)
[599.510344] Starting subtest: plane-lut1d
[599.682203] Starting dynamic subtest: pipe-A-plane-0
[599.882043] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[599.891729] Starting dynamic subtest: pipe-A-plane-1
[600.082234] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[600.091536] Starting dynamic subtest: pipe-A-plane-2
[600.248766] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[601.493343] Starting dynamic subtest: pipe-B-plane-0
[601.679850] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[601.688903] Starting dynamic subtest: pipe-B-plane-1
[601.868670] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[601.877812] Starting dynamic subtest: pipe-B-plane-2
[602.069319] Dynamic subtest pipe-B-plane-2: SUCCESS (0.200s)
[603.276704] Starting dynamic subtest: pipe-C-plane-0
[603.401260] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[603.411295] Starting dynamic subtest: pipe-C-plane-1
[603.556496] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[603.565937] Starting dynamic subtest: pipe-C-plane-2
[603.700967] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[604.871922] Starting dynamic subtest: pipe-D-plane-0
[605.007468] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[605.017065] Starting dynamic subtest: pipe-D-plane-1
[605.151970] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[605.161758] Starting dynamic subtest: pipe-D-plane-2
[605.307578] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[605.597548] Subtest plane-lut1d: SUCCESS (6.086s)
[606.434737] [121/133] (428s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[606.527264] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[606.528883] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[606.621383] [122/133] (428s left) kms_flip (basic-flip-vs-dpms)
[606.702248] Starting subtest: basic-flip-vs-dpms
[606.703041] Starting dynamic subtest: A-eDP1
[609.259403] Dynamic subtest A-eDP1: SUCCESS (2.554s)
[609.268519] Starting dynamic subtest: B-eDP1
[611.454177] Dynamic subtest B-eDP1: SUCCESS (2.194s)
[611.463468] Starting dynamic subtest: C-eDP1
[613.663593] Dynamic subtest C-eDP1: SUCCESS (2.207s)
[613.674246] Starting dynamic subtest: D-eDP1
[615.847045] Dynamic subtest D-eDP1: SUCCESS (2.180s)
[615.849282] Subtest basic-flip-vs-dpms: SUCCESS (9.147s)
[616.711090] [123/133] (417s left) kms_pm_rpm (system-suspend-modeset)
[618.236184] Starting subtest: system-suspend-modeset
[638.144723] Subtest system-suspend-modeset: SUCCESS (4.712s)
[642.553020] [124/133] (396s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[642.652330] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[642.653240] Starting dynamic subtest: pipe-A-eDP-1
[648.486296] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.750s)
[648.496936] Starting dynamic subtest: pipe-B-eDP-1
[655.036381] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.504s)
[655.037290] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.258s)
[655.884407] [125/133] (382s left) kms_big_fb (linear-16bpp-rotate-180)
[656.000569] Starting subtest: linear-16bpp-rotate-180
[657.350934] Subtest linear-16bpp-rotate-180: SUCCESS (1.346s)
[657.502718] [126/133] (381s left) kms_flip (flip-vs-dpms-on-nop)
[657.597405] Starting subtest: flip-vs-dpms-on-nop
[657.599790] Starting dynamic subtest: A-eDP1
[659.460670] Dynamic subtest A-eDP1: SUCCESS (1.855s)
[659.473605] Starting dynamic subtest: B-eDP1
[661.374078] Dynamic subtest B-eDP1: SUCCESS (1.906s)
[661.387694] Starting dynamic subtest: C-eDP1
[663.260968] Dynamic subtest C-eDP1: SUCCESS (1.880s)
[663.271745] Starting dynamic subtest: D-eDP1
[665.084867] Dynamic subtest D-eDP1: SUCCESS (1.809s)
[665.085990] Subtest flip-vs-dpms-on-nop: SUCCESS (7.462s)
[666.219163] [127/133] (372s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[666.314453] Starting subtest: fbc-modesetfrombusy
[670.087667] Subtest fbc-modesetfrombusy: SUCCESS (3.769s)
[671.259834] [128/133] (367s left) perf (polling-parameterized)
[671.351437] Starting subtest: polling-parameterized
[691.414726] Subtest polling-parameterized: SUCCESS (20.015s)
[691.449535] [129/133] (347s left) gem_softpin (evict-active-interruptible)
[691.512124] Starting subtest: evict-active-interruptible
[691.516277] Subtest evict-active-interruptible: SUCCESS (0.004s)
[691.623917] [130/133] (347s left) i915_query (query-topology-kernel-writes)
[691.668233] Starting subtest: query-topology-kernel-writes
[691.669185] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[691.761672] [131/133] (347s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[692.143027] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[692.999489] [132/133] (346s left) i915_drm_fdinfo (busy-idle)
[693.036906] Starting subtest: busy-idle
[693.037730] Starting dynamic subtest: rcs0
[693.059847] Dynamic subtest rcs0: SKIP (0.022s)
[693.070231] Starting dynamic subtest: bcs0
[693.071832] Dynamic subtest bcs0: SKIP (0.000s)
[693.081664] Starting dynamic subtest: vcs0
[693.083371] Dynamic subtest vcs0: SKIP (0.000s)
[693.092413] Starting dynamic subtest: vcs1
[693.094126] Dynamic subtest vcs1: SKIP (0.000s)
[693.102886] Starting dynamic subtest: vecs0
[693.104549] Dynamic subtest vecs0: SKIP (0.000s)
[693.113267] Starting dynamic subtest: ccs0
[693.115075] Dynamic subtest ccs0: SKIP (0.000s)
[693.116694] Subtest busy-idle: SKIP (0.027s)
[693.147958] [133/133] (345s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[693.233129] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[693.234749] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[693.321566] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: gem_tiled_wb
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_dsc
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gen9_exec_parse
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: gem_ctx_bad_destroy
results: parsing output: 13/ for test: drm_mm
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: syncobj_eventfd
results: parsing output: 17/ for test: kms_atomic
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: prime_mmap_kms
results: parsing output: 23/ for test: kms_setmode
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: gem_ctx_bad_destroy
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_busy
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_vblank
results: parsing output: 32/ for test: gem_ctx_shared
results: parsing output: 33/ for test: prime_mmap_coherency
results: parsing output: 34/ for test: gem_workarounds
results: parsing output: 35/ for test: kms_sequence
results: parsing output: 36/ for test: kms_lease
results: parsing output: 37/ for test: gem_ccs
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: kms_pipe_stress
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: gem_ctx_engines
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: kms_chamelium_frames
results: parsing output: 59/ for test: i915_pm_rc6_residency
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: vgem_basic
results: parsing output: 65/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 66/ for test: gem_tiled_pread_pwrite
results: parsing output: 67/ for test: sw_sync
results: parsing output: 68/ for test: gem_reg_read
results: parsing output: 69/ for test: i915_query
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_mmap_wc
results: parsing output: 80/ for test: kms_force_connector_basic
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_pm_backlight
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_fbcon_fbt
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: i915_hangman
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: gem_ctx_isolation
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_invalid_mode
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: gem_eio
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_mmap_offset
results: parsing output: 117/ for test: sysfs_heartbeat_interval
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_color_pipeline
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: i915_query
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: i915_drm_fdinfo
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.