[61.311585] Initializing watchdogs
[61.311633]   /dev/watchdog0
[61.326500] [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]
[61.330905] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.333029] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.334742] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[61.438771] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[61.440483] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.555640] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[61.629695] Starting subtest: basic-S3-devices
[61.630886] Starting dynamic subtest: smem
[72.855388] Dynamic subtest smem: SUCCESS (11.223s)
[72.857053] Subtest basic-S3-devices: SUCCESS (11.224s)
[79.066530] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[79.126638] Starting subtest: y-tiled-ccs-to-yf-tiled
[79.128971] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[79.323197] [004/133] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[79.416997] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[79.417923] Starting dynamic subtest: pipe-A-eDP-1
[79.426876] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.434809] Starting dynamic subtest: pipe-B-eDP-1
[79.443324] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.449489] Starting dynamic subtest: pipe-C-eDP-1
[79.457876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.463862] Starting dynamic subtest: pipe-D-eDP-1
[79.472502] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.474196] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[81.595275] [005/133] (946s left) kms_flip (bo-too-big)
[81.697369] Starting subtest: bo-too-big
[81.701633] Starting dynamic subtest: A-eDP1
[83.041751] Dynamic subtest A-eDP1: SUCCESS (1.339s)
[83.053067] Starting dynamic subtest: B-eDP1
[84.368301] Dynamic subtest B-eDP1: SUCCESS (1.324s)
[84.377662] Starting dynamic subtest: C-eDP1
[85.704267] Dynamic subtest C-eDP1: SUCCESS (1.334s)
[85.711264] Starting dynamic subtest: D-eDP1
[87.040687] Dynamic subtest D-eDP1: SUCCESS (1.335s)
[87.043133] Subtest bo-too-big: SUCCESS (5.345s)
[88.257889] [006/133] (939s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[88.306776] Starting subtest: multi-wait-available-unsubmitted-signaled
[88.307690] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[88.436270] [007/133] (939s left) kms_lease (lease-uevent)
[88.520423] Starting subtest: lease-uevent
[89.538712] Subtest lease-uevent: SUCCESS (1.019s)
[89.647852] [008/133] (938s left) gem_exec_fence (syncobj-timeline-wait)
[90.235896] Starting subtest: syncobj-timeline-wait
[91.940587] Subtest syncobj-timeline-wait: SUCCESS (1.705s)
[93.923654] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[93.925304] [009/133] (934s left) kms_chamelium_color (gamma)
[94.025577] Subtest gamma: SKIP (0.000s)
[94.065176] [010/133] (934s left) prime_mmap (test_errors)
[94.117076] Starting subtest: test_errors
[94.118015] Starting dynamic subtest: test_errors-smem
[94.215292] Dynamic subtest test_errors-smem: SUCCESS (0.098s)
[94.216212] Subtest test_errors: SUCCESS (0.099s)
[94.350158] [011/133] (933s left) i915_drm_fdinfo (idle)
[94.382242] Starting subtest: idle
[94.383084] Starting dynamic subtest: rcs0
[94.974770] Dynamic subtest rcs0: SUCCESS (0.592s)
[94.983986] Starting dynamic subtest: bcs0
[95.481774] Dynamic subtest bcs0: SUCCESS (0.504s)
[95.491265] Starting dynamic subtest: vcs0
[95.986036] Dynamic subtest vcs0: SUCCESS (0.503s)
[95.995442] Starting dynamic subtest: vcs1
[96.491039] Dynamic subtest vcs1: SUCCESS (0.504s)
[96.498528] Starting dynamic subtest: vecs0
[96.995938] Dynamic subtest vecs0: SUCCESS (0.504s)
[97.005496] Starting dynamic subtest: ccs0
[97.500737] Dynamic subtest ccs0: SUCCESS (0.503s)
[97.502321] Subtest idle: SUCCESS (3.116s)
[97.592176] [012/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[97.696635] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[97.698318] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[97.816243] [013/133] (930s left) kms_invalid_mode (zero-hdisplay)
[97.907823] Starting subtest: zero-hdisplay
[97.908708] Starting dynamic subtest: pipe-A-eDP-1
[98.204675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[98.211840] Starting dynamic subtest: pipe-B-eDP-1
[98.212680] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[98.218622] Starting dynamic subtest: pipe-C-eDP-1
[98.219456] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[98.225370] Starting dynamic subtest: pipe-D-eDP-1
[98.226260] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[98.227117] Subtest zero-hdisplay: SUCCESS (0.300s)
[99.097742] [014/133] (929s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[99.185501] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[99.186492] Starting dynamic subtest: pipe-A
[99.250501] Dynamic subtest pipe-A: SUCCESS (0.065s)
[99.262248] Starting dynamic subtest: pipe-B
[100.398273] Dynamic subtest pipe-B: SUCCESS (1.147s)
[100.407101] Starting dynamic subtest: pipe-C
[101.501856] Dynamic subtest pipe-C: SUCCESS (1.103s)
[101.519316] Starting dynamic subtest: pipe-D
[102.654973] Dynamic subtest pipe-D: SUCCESS (1.152s)
[102.657459] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.471s)
[103.829338] [015/133] (924s left) drm_read (fault-buffer)
[104.010309] Starting subtest: fault-buffer
[104.011283] Subtest fault-buffer: SUCCESS (0.000s)
[104.165847] [016/133] (924s left) gem_ccs (suspend-resume)
[104.222450] Starting subtest: suspend-resume
[104.224278] Subtest suspend-resume: SKIP (0.000s)
[104.348603] [017/133] (924s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[104.436053] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[104.436983] Starting dynamic subtest: pipe-A-eDP-1
[104.447336] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[104.458904] Starting dynamic subtest: pipe-B-eDP-1
[104.468577] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[104.476231] Starting dynamic subtest: pipe-C-eDP-1
[104.484795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[104.491406] Starting dynamic subtest: pipe-D-eDP-1
[104.499672] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[104.501356] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[106.687703] [018/133] (921s left) gem_close (many-handles-one-vma)
[106.744740] Starting subtest: many-handles-one-vma
[106.769584] Subtest many-handles-one-vma: SUCCESS (0.025s)
[106.879608] [019/133] (921s left) gem_busy (extended)
[107.052924] Starting subtest: extended
[107.054186] Starting dynamic subtest: rcs0
[107.151800] Dynamic subtest rcs0: SUCCESS (0.100s)
[107.167245] Starting dynamic subtest: bcs0
[107.192529] Dynamic subtest bcs0: SUCCESS (0.040s)
[107.202173] Starting dynamic subtest: vcs0
[108.886883] Dynamic subtest vcs0: SUCCESS (1.691s)
[108.896926] Starting dynamic subtest: vcs1
[110.934382] Dynamic subtest vcs1: SUCCESS (2.047s)
[110.944324] Starting dynamic subtest: vecs0
[112.918885] Dynamic subtest vecs0: SUCCESS (1.984s)
[112.928602] Starting dynamic subtest: ccs0
[112.962754] Dynamic subtest ccs0: SUCCESS (0.046s)
[112.963830] Subtest extended: SUCCESS (5.913s)
[113.225950] [020/133] (915s left) kms_vblank (ts-continuation-suspend)
[113.324789] Starting subtest: ts-continuation-suspend
[113.325694] Starting dynamic subtest: pipe-A-eDP-1
[130.348755] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.973s)
[130.364275] Starting dynamic subtest: pipe-D-eDP-1
[148.355577] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.596s)
[148.356517] Subtest ts-continuation-suspend: SUCCESS (4.572s)
[156.181966] [021/133] (879s left) perf_pmu (semaphore-wait-idle)
[156.219854] Starting subtest: semaphore-wait-idle
[156.220795] Starting dynamic subtest: rcs0
[156.737640] Dynamic subtest rcs0: SUCCESS (0.515s)
[156.748658] Starting dynamic subtest: bcs0
[157.251065] Dynamic subtest bcs0: SUCCESS (0.512s)
[157.259497] Starting dynamic subtest: vcs0
[157.764228] Dynamic subtest vcs0: SUCCESS (0.512s)
[157.777480] Starting dynamic subtest: vcs1
[158.279310] Dynamic subtest vcs1: SUCCESS (0.514s)
[158.291660] Starting dynamic subtest: vecs0
[158.792394] Dynamic subtest vecs0: SUCCESS (0.512s)
[158.801559] Starting dynamic subtest: ccs0
[159.307039] Dynamic subtest ccs0: SUCCESS (0.513s)
[159.308528] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[160.499620] [022/133] (875s left) kms_debugfs (display-off-read-all)
[160.595180] Starting subtest: display-off-read-all
[160.887047] Subtest display-off-read-all: SUCCESS (0.293s)
[161.698178] [023/133] (873s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[161.788669] Starting subtest: fbc-rgb101010-draw-blt
[166.388527] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.600s)
[167.593660] [024/133] (868s left) gem_ctx_param (invalid-get-no-zeromap)
[167.640659] Starting subtest: invalid-get-no-zeromap
[167.641759] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[167.773509] [025/133] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[167.885293] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[167.887099] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[168.026539] [026/133] (867s left) gem_exec_big (single)
[168.077787] Starting subtest: single
[170.372671] Subtest single: SUCCESS (2.292s)
[170.597203] [027/133] (865s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[170.738219] Starting subtest: psr-rgb101010-draw-mmap-gtt
[170.740068] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[170.840281] [028/133] (864s left) gem_exec_flush (basic-uc-prw-default)
[170.902025] Starting subtest: basic-uc-prw-default
[176.358508] Subtest basic-uc-prw-default: SUCCESS (5.456s)
[176.560640] [029/133] (859s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[176.658782] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[176.660420] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[176.772516] [030/133] (859s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[176.867892] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[183.803785] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.934s)
[183.956160] [031/133] (851s left) gem_exec_create (forked)
[184.012205] Starting subtest: forked
[184.013310] Starting dynamic subtest: smem
[205.330902] Dynamic subtest smem: SUCCESS (21.316s)
[205.332572] Subtest forked: SUCCESS (21.317s)
[205.536451] [032/133] (830s left) kms_feature_discovery (display-1x)
[205.645979] Starting subtest: display-1x
[205.646942] Subtest display-1x: SUCCESS (0.000s)
[205.740494] [033/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[205.832987] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[205.834921] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[205.961693] [034/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[206.064313] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[206.066009] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[206.216664] [035/133] (829s left) gem_render_copy_redux (interruptible)
[206.282073] Starting subtest: interruptible
[206.567228] Subtest interruptible: SUCCESS (0.285s)
[206.719109] [036/133] (829s left) i915_pm_rpm (system-suspend-execbuf)
[208.582490] Starting subtest: system-suspend-execbuf
[267.532280] Subtest system-suspend-execbuf: SUCCESS (43.954s)
[267.910603] [037/133] (768s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[268.013891] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[268.015592] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[268.148628] [038/133] (767s left) gem_request_retire (retire-vma-not-inactive)
[268.216844] Starting subtest: retire-vma-not-inactive
[268.276967] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[268.440657] [039/133] (767s left) i915_pm_rps (thresholds-idle)
[268.502128] Starting subtest: thresholds-idle
[268.504154] Subtest thresholds-idle: SKIP (0.000s)
[268.626104] [040/133] (767s left) gem_ctx_persistence (legacy-engines-queued)
[268.681633] Starting subtest: legacy-engines-queued
[268.682602] Starting dynamic subtest: render
[268.785276] Dynamic subtest render: SUCCESS (0.102s)
[268.796260] Starting dynamic subtest: bsd1
[270.337847] Dynamic subtest bsd1: SUCCESS (1.549s)
[270.348031] Starting dynamic subtest: bsd2
[272.319222] Dynamic subtest bsd2: SUCCESS (1.979s)
[272.330409] Starting dynamic subtest: blt
[272.353648] Dynamic subtest blt: SUCCESS (0.035s)
[272.361477] Starting dynamic subtest: vebox
[274.302939] Dynamic subtest vebox: SUCCESS (1.945s)
[274.304372] Subtest legacy-engines-queued: SUCCESS (5.619s)
[274.401744] [041/133] (761s left) i915_hangman (gt-error-state-capture)
[274.462388] Starting subtest: gt-error-state-capture
[274.463330] Starting dynamic subtest: rcs0
[286.336671] Dynamic subtest rcs0: SUCCESS (11.871s)
[286.346822] Starting dynamic subtest: bcs0
[297.345983] Dynamic subtest bcs0: SUCCESS (11.007s)
[297.357962] Starting dynamic subtest: vcs0
[308.354768] Dynamic subtest vcs0: SUCCESS (11.006s)
[308.366186] Starting dynamic subtest: vcs1
[320.320023] Dynamic subtest vcs1: SUCCESS (11.963s)
[320.330905] Starting dynamic subtest: vecs0
[332.353102] Dynamic subtest vecs0: SUCCESS (12.031s)
[332.364865] Starting dynamic subtest: ccs0
[343.360313] Dynamic subtest ccs0: SUCCESS (11.004s)
[343.361622] Subtest gt-error-state-capture: SUCCESS (68.894s)
[343.529852] [042/133] (692s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[343.755570] Starting subtest: cursor-rapid-movement-128x42
[343.817940] Subtest cursor-rapid-movement-128x42: SKIP (0.060s)
[344.064278] [043/133] (692s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[344.124277] Subtest writes-after-reads-uncached: SKIP (0.000s)
[344.189241] [044/133] (692s left) gem_mmap_wc (coherency)
[344.240181] Subtest coherency: SKIP (0.000s)
[344.296558] [045/133] (692s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[344.347735] Starting subtest: single-wait-all-for-submit-signaled
[344.348809] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[344.473502] [046/133] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[344.564262] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[348.324153] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.759s)
[349.526470] [047/133] (686s left) kms_psr (fbc-psr-primary-mmap-cpu)
[349.614757] Starting subtest: fbc-psr-primary-mmap-cpu
[349.615754] Starting dynamic subtest: eDP-1
[349.617564] Dynamic subtest eDP-1: SKIP (0.000s)
[349.619263] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[349.706839] [048/133] (686s left) kms_invalid_mode (bad-vsync-start)
[349.799702] Starting subtest: bad-vsync-start
[349.800625] Starting dynamic subtest: pipe-A-eDP-1
[350.095394] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[350.103637] Starting dynamic subtest: pipe-B-eDP-1
[350.104541] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[350.112154] Starting dynamic subtest: pipe-C-eDP-1
[350.113072] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[350.120834] Starting dynamic subtest: pipe-D-eDP-1
[350.121786] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[350.122727] Subtest bad-vsync-start: SUCCESS (0.301s)
[350.945352] [049/133] (685s left) gem_exec_reloc (basic-wc-gtt)
[351.019175] Subtest basic-wc-gtt: SKIP (0.000s)
[351.109028] [050/133] (685s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[351.170476] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[351.237385] [051/133] (685s left) kms_prop_blob (blob-multiple)
[351.289395] Starting subtest: blob-multiple
[351.292580] Subtest blob-multiple: SUCCESS (0.004s)
[351.449807] [052/133] (685s left) api_intel_allocator (open-vm)
[351.502601] Starting subtest: open-vm
[351.505087] Subtest open-vm: SUCCESS (0.003s)
[351.646738] [053/133] (684s left) kms_getfb (getfb-repeated-different-handles)
[351.748558] Starting subtest: getfb-repeated-different-handles
[351.749427] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[351.880817] [054/133] (684s left) kms_content_protection (legacy-hdcp14)
[352.041820] Starting subtest: legacy-hdcp14
[352.043703] Subtest legacy-hdcp14: SKIP (0.000s)
[352.213775] [055/133] (684s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[352.606329] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[353.425188] [056/133] (683s left) kms_flip (blocking-absolute-wf_vblank)
[353.516401] Starting subtest: blocking-absolute-wf_vblank
[353.517406] Starting dynamic subtest: A-eDP1
[362.316987] Dynamic subtest A-eDP1: SUCCESS (8.799s)
[362.327856] Starting dynamic subtest: B-eDP1
[371.042334] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[371.057081] Starting dynamic subtest: C-eDP1
[379.753016] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[379.762621] Starting dynamic subtest: D-eDP1
[388.483251] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[388.486626] Subtest blocking-absolute-wf_vblank: SUCCESS (34.970s)
[389.712044] [057/133] (647s left) gem_mmap_offset (bad-object)
[389.774196] Starting subtest: bad-object
[389.775359] Subtest bad-object: SUCCESS (0.001s)
[389.903928] [058/133] (646s left) kms_psr (psr2-no-drrs)
[390.004509] Starting subtest: psr2-no-drrs
[390.005407] Starting dynamic subtest: eDP-1
[391.658406] Dynamic subtest eDP-1: SUCCESS (1.654s)
[391.659390] Subtest psr2-no-drrs: SUCCESS (1.655s)
[392.480477] [059/133] (644s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[392.541853] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[392.622795] [060/133] (644s left) kms_vblank (wait-idle)
[392.717266] Starting subtest: wait-idle
[392.718212] Starting dynamic subtest: pipe-A-eDP-1
[394.471435] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[394.481788] Starting dynamic subtest: pipe-D-eDP-1
[396.902659] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.429s)
[396.903737] Subtest wait-idle: SUCCESS (4.185s)
[397.739165] [061/133] (639s left) gem_exec_whisper (basic-contexts-all)
[397.807659] Starting subtest: basic-contexts-all
[408.475892] Subtest basic-contexts-all: SUCCESS (10.664s)
[408.672753] [062/133] (628s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[408.791731] Starting subtest: x-tiled-16bpp-rotate-0
[410.131365] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.340s)
[410.285037] [063/133] (626s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[410.384401] Starting subtest: plane-primary-overlay-mutable-zpos
[413.861203] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.475s)
[415.066753] [064/133] (621s left) gen9_exec_parse (bb-start-cmd)
[415.118223] Subtest bb-start-cmd: SKIP (0.000s)
[415.189074] [065/133] (621s left) kms_cursor_crc (cursor-alpha-opaque)
[415.292760] Starting subtest: cursor-alpha-opaque
[415.294792] Starting dynamic subtest: pipe-A-eDP-1
[415.914366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[415.922500] Starting dynamic subtest: pipe-D-eDP-1
[417.216533] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.300s)
[417.217396] Subtest cursor-alpha-opaque: SUCCESS (1.923s)
[418.043920] [066/133] (618s left) kms_cursor_crc (cursor-sliding-64x64)
[418.219750] Starting subtest: cursor-sliding-64x64
[418.223419] Starting dynamic subtest: pipe-A-eDP-1
[421.456797] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.233s)
[421.487193] Starting dynamic subtest: pipe-D-eDP-1
[425.303421] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.824s)
[425.304983] Subtest cursor-sliding-64x64: SUCCESS (7.084s)
[426.203304] [067/133] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[426.313326] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[433.105617] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.793s)
[433.260047] [068/133] (603s left) gem_ctx_shared (exec-single-timeline)
[433.330676] Starting subtest: exec-single-timeline
[433.331714] Starting dynamic subtest: rcs0
[434.366045] Dynamic subtest rcs0: SUCCESS (1.032s)
[434.377565] Starting dynamic subtest: bcs0
[435.454618] Dynamic subtest bcs0: SUCCESS (1.086s)
[435.464991] Starting dynamic subtest: vcs0
[436.543387] Dynamic subtest vcs0: SUCCESS (1.086s)
[436.553388] Starting dynamic subtest: vcs1
[437.630725] Dynamic subtest vcs1: SUCCESS (1.084s)
[437.641055] Starting dynamic subtest: vecs0
[438.719261] Dynamic subtest vecs0: SUCCESS (1.086s)
[438.730398] Starting dynamic subtest: ccs0
[439.807484] Dynamic subtest ccs0: SUCCESS (1.085s)
[439.808950] Subtest exec-single-timeline: SUCCESS (6.476s)
[440.018187] [069/133] (597s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[440.123835] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[440.124800] Starting dynamic subtest: pipe-A
[441.310569] Dynamic subtest pipe-A: SUCCESS (1.186s)
[441.320150] Starting dynamic subtest: pipe-B
[443.560028] Dynamic subtest pipe-B: SUCCESS (2.248s)
[443.569719] Starting dynamic subtest: pipe-C
[444.728134] Dynamic subtest pipe-C: SUCCESS (1.166s)
[444.736470] Starting dynamic subtest: pipe-D
[445.862532] Dynamic subtest pipe-D: SUCCESS (1.133s)
[445.866064] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.740s)
[447.080732] [070/133] (590s left) gem_wait (write-busy)
[447.143395] Starting subtest: write-busy
[447.144398] Starting dynamic subtest: all-engines
[447.751636] Dynamic subtest all-engines: SUCCESS (0.610s)
[447.762966] Starting dynamic subtest: rcs0
[448.308451] Dynamic subtest rcs0: SUCCESS (0.555s)
[448.323619] Starting dynamic subtest: bcs0
[448.862184] Dynamic subtest bcs0: SUCCESS (0.553s)
[448.878075] Starting dynamic subtest: vcs0
[450.337673] Dynamic subtest vcs0: SUCCESS (1.472s)
[450.352272] Starting dynamic subtest: vcs1
[452.322715] Dynamic subtest vcs1: SUCCESS (1.981s)
[452.336831] Starting dynamic subtest: vecs0
[454.369215] Dynamic subtest vecs0: SUCCESS (2.043s)
[454.384477] Starting dynamic subtest: ccs0
[454.919050] Dynamic subtest ccs0: SUCCESS (0.550s)
[454.920177] Subtest write-busy: SUCCESS (7.778s)
[455.138618] [071/133] (582s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[455.240568] Starting subtest: y-tiled-8bpp-rotate-0
[455.242252] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[455.368549] [072/133] (581s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[455.483163] Starting subtest: basic-busy-flip-before-cursor-legacy
[455.484965] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[455.648759] [073/133] (581s left) gem_basic (bad-close)
[455.694691] Starting subtest: bad-close
[455.696393] Subtest bad-close: SUCCESS (0.000s)
[455.823916] [074/133] (581s left) kms_big_fb (linear-16bpp-rotate-0)
[455.919957] Starting subtest: linear-16bpp-rotate-0
[457.354576] Subtest linear-16bpp-rotate-0: SUCCESS (1.435s)
[457.520332] [075/133] (579s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[462.551561] Starting subtest: pr-overlay-plane-update-continuous-sf
[462.553525] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[463.401871] [076/133] (573s left) drm_read (short-buffer-wakeup)
[463.538334] Starting subtest: short-buffer-wakeup
[495.757203] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[495.940101] [077/133] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[496.041202] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[503.091083] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.047s)
[503.257920] [078/133] (534s left) kms_psr (fbc-pr-cursor-render)
[503.345257] Starting subtest: fbc-pr-cursor-render
[503.347052] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[503.438991] [079/133] (534s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[503.521799] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[503.522705] Starting dynamic subtest: pipe-A-eDP-1
[503.525996] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[503.534707] Starting dynamic subtest: pipe-B-eDP-1
[503.538028] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[503.546061] Starting dynamic subtest: pipe-C-eDP-1
[503.549354] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[503.557390] Starting dynamic subtest: pipe-D-eDP-1
[503.560624] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[503.562266] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[505.855145] [080/133] (531s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[505.959107] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[505.960068] Starting dynamic subtest: pipe-A-eDP-1
[507.252283] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.293s)
[507.261766] Starting dynamic subtest: pipe-B-eDP-1
[509.592861] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.339s)
[509.603743] Starting dynamic subtest: pipe-C-eDP-1
[511.920963] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.327s)
[511.930788] Starting dynamic subtest: pipe-D-eDP-1
[514.234442] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.312s)
[514.236518] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.277s)
[515.472455] [081/133] (522s left) sw_sync (sync_multi_timeline_wait)
[515.506566] Starting subtest: sync_multi_timeline_wait
[515.507466] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[515.577156] [082/133] (521s left) sysfs_heartbeat_interval (idempotent)
[515.637602] Starting subtest: idempotent
[515.639522] Starting dynamic subtest: vecs0
[515.640319] Dynamic subtest vecs0: SUCCESS (0.001s)
[515.651389] Starting dynamic subtest: ccs0
[515.652219] Dynamic subtest ccs0: SUCCESS (0.001s)
[515.660154] Starting dynamic subtest: vcs0
[515.661005] Dynamic subtest vcs0: SUCCESS (0.000s)
[515.668764] Starting dynamic subtest: bcs0
[515.669626] Dynamic subtest bcs0: SUCCESS (0.001s)
[515.677539] Starting dynamic subtest: rcs0
[515.678408] Dynamic subtest rcs0: SUCCESS (0.000s)
[515.686203] Starting dynamic subtest: vcs1
[515.687118] Dynamic subtest vcs1: SUCCESS (0.000s)
[515.688036] Subtest idempotent: SUCCESS (0.009s)
[515.775493] [083/133] (521s left) syncobj_eventfd (invalid-bad-pad)
[515.832365] Starting subtest: invalid-bad-pad
[515.833309] Subtest invalid-bad-pad: SUCCESS (0.000s)
[515.964121] [084/133] (521s left) kms_busy (extended-pageflip-hang-newfb)
[516.057420] Starting subtest: extended-pageflip-hang-newfb
[516.058230] Starting dynamic subtest: pipe-A
[542.188989] Dynamic subtest pipe-A: SUCCESS (26.130s)
[542.203533] Starting dynamic subtest: pipe-D
[567.152849] Dynamic subtest pipe-D: SUCCESS (24.960s)
[567.153802] Subtest extended-pageflip-hang-newfb: SUCCESS (51.094s)
[568.035157] [085/133] (469s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[573.110817] Starting subtest: psr2-cursor-plane-update-sf
[573.111730] Starting dynamic subtest: pipe-A-eDP-1
[574.423951] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.312s)
[574.433408] Starting dynamic subtest: pipe-B-eDP-1
[575.742012] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.315s)
[575.743109] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.632s)
[576.634372] [086/133] (461s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[576.743787] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[577.436317] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.693s)
[577.638773] [087/133] (460s left) gem_exec_balancer (busy)
[577.702746] Starting subtest: busy
[579.344392] Subtest busy: SUCCESS (1.638s)
[579.723813] [088/133] (458s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[579.826930] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[579.828676] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[579.950897] [089/133] (457s left) vgem_slow (nohang)
[579.994550] Starting subtest: nohang
[590.334816] Subtest nohang: SUCCESS (10.337s)
[590.424276] [090/133] (447s left) gem_spin_batch (resubmit-new-all)
[590.491862] Starting subtest: resubmit-new-all
[590.492891] Starting dynamic subtest: rcs0
[590.519321] Dynamic subtest rcs0: SUCCESS (0.027s)
[590.529751] Starting dynamic subtest: bcs0
[590.536895] Dynamic subtest bcs0: SUCCESS (0.017s)
[590.545479] Starting dynamic subtest: vcs0
[590.564454] Dynamic subtest vcs0: SUCCESS (0.026s)
[590.574241] Starting dynamic subtest: vcs1
[590.593148] Dynamic subtest vcs1: SUCCESS (0.026s)
[590.602865] Starting dynamic subtest: vecs0
[590.622990] Dynamic subtest vecs0: SUCCESS (0.028s)
[590.633146] Starting dynamic subtest: ccs0
[590.654177] Dynamic subtest ccs0: SUCCESS (0.028s)
[590.656639] Subtest resubmit-new-all: SUCCESS (0.164s)
[592.421157] [091/133] (445s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[592.493118] Starting subtest: mixed-tiled-to-y-tiled-ccs
[592.495131] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[592.701319] [092/133] (445s left) syncobj_timeline (invalid-signal-illegal-point)
[592.770273] Starting subtest: invalid-signal-illegal-point
[592.771769] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[592.907172] [093/133] (445s left) gem_exec_schedule (preempt-contexts)
[592.977831] Starting subtest: preempt-contexts
[592.978748] Starting dynamic subtest: rcs0
[593.078517] Dynamic subtest rcs0: SUCCESS (0.100s)
[593.087416] Starting dynamic subtest: bcs0
[593.176939] Dynamic subtest bcs0: SUCCESS (0.097s)
[593.185602] Starting dynamic subtest: vcs0
[593.250037] Dynamic subtest vcs0: SUCCESS (0.072s)
[593.263701] Starting dynamic subtest: vcs1
[593.310417] Dynamic subtest vcs1: SUCCESS (0.059s)
[593.318900] Starting dynamic subtest: vecs0
[593.368110] Dynamic subtest vecs0: SUCCESS (0.057s)
[593.376373] Starting dynamic subtest: ccs0
[593.448493] Dynamic subtest ccs0: SUCCESS (0.080s)
[593.449384] Subtest preempt-contexts: SUCCESS (0.471s)
[594.474137] [094/133] (443s left) gem_pwrite_snooped
[594.586713] [095/133] (443s left) kms_tiled_display (basic-test-pattern)
[594.703141] Subtest basic-test-pattern: SKIP (0.000s)
[594.744308] [096/133] (443s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[594.834002] Starting subtest: psr-shrfb-scaledprimary
[600.618351] Subtest psr-shrfb-scaledprimary: SUCCESS (5.785s)
[600.767513] [097/133] (437s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[600.874396] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[600.876208] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[600.994661] [098/133] (437s left) gem_pwrite (basic-self)
[601.054357] Subtest basic-self: SKIP (0.000s)
[601.141868] [099/133] (437s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[602.672709] Starting subtest: dpms-mode-unset-non-lpsp
[603.827928] Subtest dpms-mode-unset-non-lpsp: SKIP (1.154s)
[604.216223] [100/133] (434s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[604.313877] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[604.315683] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[604.439553] [101/133] (433s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[604.529107] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[604.531501] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[604.659541] [102/133] (433s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[604.760020] Starting subtest: plane-lut1d-ctm3x4-lut1d
[604.778653] Starting dynamic subtest: pipe-A-eDP-1
[605.239631] Dynamic subtest pipe-A-eDP-1: FAIL (0.324s)
[606.172689] Starting dynamic subtest: pipe-B-eDP-1
[606.700917] Dynamic subtest pipe-B-eDP-1: FAIL (0.324s)
[607.610875] Starting dynamic subtest: pipe-C-eDP-1
[608.076428] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[608.937123] Starting dynamic subtest: pipe-D-eDP-1
[609.402366] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[609.486634] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.726s)
[610.344597] [103/133] (428s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[610.453043] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[617.253272] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.800s)
[617.427163] [104/133] (420s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[617.537657] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[624.635260] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.097s)
[624.789907] [105/133] (413s left) gem_exec_schedule (preempt-queue-contexts-chain)
[624.858598] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[625.176053] [106/133] (413s left) api_intel_bb (object-noreloc-keep-cache-simple)
[625.228613] Starting subtest: object-noreloc-keep-cache-simple
[625.233533] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[625.387795] [107/133] (413s left) gem_mmap (bad-object)
[625.443723] Subtest bad-object: SKIP (0.000s)
[625.507119] [108/133] (413s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[625.608724] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[625.609605] Starting dynamic subtest: pipe-A-default-mode
[625.897286] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[625.899097] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.289s)
[626.728898] [109/133] (411s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[626.828370] Starting subtest: bo-too-small-due-to-tiling
[626.830133] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[626.944996] [110/133] (411s left) kms_psr (pr-sprite-blt)
[627.041610] Starting subtest: pr-sprite-blt
[627.043253] Subtest pr-sprite-blt: SKIP (0.000s)
[627.138082] [111/133] (411s left) kms_draw_crc (fill-fb)
[627.236087] Starting subtest: fill-fb
[627.766831] Subtest fill-fb: SUCCESS (0.531s)
[627.883647] [112/133] (410s left) perf_pmu (busy-idle)
[627.923611] Starting subtest: busy-idle
[627.924549] Starting dynamic subtest: rcs0
[628.629265] Dynamic subtest rcs0: SUCCESS (0.704s)
[628.641872] Starting dynamic subtest: bcs0
[629.309881] Dynamic subtest bcs0: SUCCESS (0.679s)
[629.321484] Starting dynamic subtest: vcs0
[631.330000] Dynamic subtest vcs0: SUCCESS (2.014s)
[631.341411] Starting dynamic subtest: vcs1
[633.377739] Dynamic subtest vcs1: SUCCESS (2.045s)
[633.392534] Starting dynamic subtest: vecs0
[635.362033] Dynamic subtest vecs0: SUCCESS (1.981s)
[635.373241] Starting dynamic subtest: ccs0
[636.038381] Dynamic subtest ccs0: SUCCESS (0.676s)
[636.039845] Subtest busy-idle: SUCCESS (8.115s)
[636.180344] [113/133] (402s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[636.273692] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[636.274528] Starting dynamic subtest: pipe-A-eDP-1
[636.295854] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[636.304963] Starting dynamic subtest: pipe-B-eDP-1
[636.326216] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[636.334171] Starting dynamic subtest: pipe-C-eDP-1
[636.355573] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[636.363898] Starting dynamic subtest: pipe-D-eDP-1
[636.384117] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[636.385714] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.011s)
[638.596539] [114/133] (400s left) gem_exec_flush (basic-batch-kernel-default-uc)
[638.658595] Starting subtest: basic-batch-kernel-default-uc
[645.790437] Subtest basic-batch-kernel-default-uc: SUCCESS (7.131s)
[646.002106] [115/133] (392s left) gem_mmap_wc (write-read-distinct)
[646.071818] Subtest write-read-distinct: SKIP (0.000s)
[646.135478] [116/133] (392s left) kms_plane_lowres (tiling-x)
[646.228274] Starting subtest: tiling-x
[646.229142] Starting dynamic subtest: pipe-A-eDP-1
[646.230756] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[646.540654] Starting dynamic subtest: pipe-B-eDP-1
[646.542391] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[646.550582] Starting dynamic subtest: pipe-C-eDP-1
[646.552311] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[646.560523] Starting dynamic subtest: pipe-D-eDP-1
[646.562255] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[646.563962] Subtest tiling-x: SKIP (0.311s)
[647.349102] [117/133] (391s left) sw_sync (alloc_merge_fence)
[647.376970] Starting subtest: alloc_merge_fence
[647.377856] Subtest alloc_merge_fence: SUCCESS (0.000s)
[647.446560] [118/133] (391s left) kms_pm_backlight (fade)
[647.537426] Starting subtest: fade
[647.591687] Starting dynamic subtest: eDP-1
[650.286755] Dynamic subtest eDP-1: SUCCESS (2.696s)
[650.287834] Subtest fade: SUCCESS (2.748s)
[651.110388] [119/133] (387s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[651.210732] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[651.211750] Starting dynamic subtest: pipe-A-default-mode
[652.352749] Dynamic subtest pipe-A-default-mode: SKIP (1.139s)
[652.354413] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.141s)
[652.537066] [120/133] (386s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[652.589937] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[652.693769] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[652.790897] [121/133] (386s left) kms_psr (psr-cursor-mmap-cpu)
[652.886000] Starting subtest: psr-cursor-mmap-cpu
[652.887007] Starting dynamic subtest: eDP-1
[654.605952] Dynamic subtest eDP-1: SUCCESS (1.720s)
[654.606811] Subtest psr-cursor-mmap-cpu: SUCCESS (1.721s)
[655.498680] [122/133] (383s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[655.606718] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[656.265591] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[656.467177] [123/133] (382s left) gem_exec_whisper (basic-queues-priority-all)
[656.525835] Starting subtest: basic-queues-priority-all
[678.860276] Subtest basic-queues-priority-all: SUCCESS (22.329s)
[679.059886] [124/133] (360s left) syncobj_timeline (etime-single-wait-all-submitted)
[679.103809] Starting subtest: etime-single-wait-all-submitted
[679.213835] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[679.311196] [125/133] (359s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[679.400570] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[679.402248] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[679.508935] [126/133] (359s left) kms_async_flips (async-flip-dpms)
[679.604597] Starting subtest: async-flip-dpms
[679.977397] Starting dynamic subtest: pipe-A-eDP-1
[683.800152] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.823s)
[684.198766] Starting dynamic subtest: pipe-B-eDP-1
[686.975197] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.783s)
[687.364712] Starting dynamic subtest: pipe-C-eDP-1
[690.151278] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.794s)
[690.538242] Starting dynamic subtest: pipe-D-eDP-1
[693.338211] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.806s)
[693.339332] Subtest async-flip-dpms: SUCCESS (13.733s)
[694.544706] [127/133] (344s left) gem_exec_reloc (basic-cpu-read-noreloc)
[694.616767] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[694.707982] [128/133] (344s left) syncobj_wait (invalid-reset-illegal-handle)
[694.758421] Starting subtest: invalid-reset-illegal-handle
[694.759428] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[694.885800] [129/133] (344s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[694.944129] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[695.054122] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[695.156649] [130/133] (344s left) gem_tiled_swapping (non-threaded)
[695.200034] Subtest non-threaded: SKIP (0.000s)
[695.266964] [131/133] (344s left) gem_exec_fence (syncobj-timeline-chain-engines)
[695.897240] Starting subtest: syncobj-timeline-chain-engines
[696.019230] Subtest syncobj-timeline-chain-engines: SUCCESS (0.125s)
[697.445720] [132/133] (341s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[697.579994] Starting subtest: flip-vs-cursor-legacy
[704.694391] Subtest flip-vs-cursor-legacy: SUCCESS (7.113s)
[705.576143] [133/133] (333s left) syncobj_basic (illegal-fd-to-handle)
[705.631285] Starting subtest: illegal-fd-to-handle
[705.632316] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[705.759241] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_suspend
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_chamelium_color
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: drm_read
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_close
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_debugfs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_big
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_request_retire
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_fenced_exec_thrash
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_tiled_display
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_pwrite
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: syncobj_basic
Done.