[57.702369] Initializing watchdogs
[57.702415]   /dev/watchdog0
[57.716082] [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]
[57.721041] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.723349] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.726950] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[57.869322] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[57.873686] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[58.000935] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[58.080772] Starting subtest: basic-S3-devices
[58.083233] Starting dynamic subtest: smem
[69.909693] Dynamic subtest smem: SUCCESS (11.847s)
[69.912895] Subtest basic-S3-devices: SUCCESS (11.848s)
[70.115252] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[70.192384] Starting subtest: y-tiled-ccs-to-yf-tiled
[70.196957] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[70.398442] [004/133] (947s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[70.494761] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[70.497114] Starting dynamic subtest: pipe-A-eDP-1
[70.520814] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.531112] Starting dynamic subtest: pipe-B-eDP-1
[70.552907] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.560568] Starting dynamic subtest: pipe-C-eDP-1
[70.582522] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[70.590941] Starting dynamic subtest: pipe-D-eDP-1
[70.612926] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[70.617563] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[72.815857] [005/133] (945s left) kms_flip (bo-too-big)
[72.918368] Starting subtest: bo-too-big
[72.920639] Starting dynamic subtest: A-eDP1
[74.247610] Dynamic subtest A-eDP1: SUCCESS (1.332s)
[74.259808] Starting dynamic subtest: B-eDP1
[75.579758] Dynamic subtest B-eDP1: SUCCESS (1.332s)
[75.587268] Starting dynamic subtest: C-eDP1
[76.919828] Dynamic subtest C-eDP1: SUCCESS (1.339s)
[76.930754] Starting dynamic subtest: D-eDP1
[78.236238] Dynamic subtest D-eDP1: SUCCESS (1.317s)
[78.238688] Subtest bo-too-big: SUCCESS (5.325s)
[79.460936] [006/133] (938s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[79.527806] Starting subtest: multi-wait-available-unsubmitted-signaled
[79.530262] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[79.654327] [007/133] (938s left) kms_lease (lease-uevent)
[79.744088] Starting subtest: lease-uevent
[80.759520] Subtest lease-uevent: SUCCESS (1.018s)
[80.864609] [008/133] (937s left) gem_exec_fence (syncobj-timeline-wait)
[81.427807] Starting subtest: syncobj-timeline-wait
[82.940266] Subtest syncobj-timeline-wait: SUCCESS (1.513s)
[83.209808] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[83.212855] [009/133] (935s left) kms_chamelium_color (gamma)
[83.310184] Subtest gamma: SKIP (0.000s)
[83.354409] [010/133] (935s left) prime_mmap (test_errors)
[83.407737] Starting subtest: test_errors
[83.409867] Starting dynamic subtest: test_errors-smem
[83.502250] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[83.504733] Subtest test_errors: SUCCESS (0.096s)
[83.630899] [011/133] (934s left) i915_drm_fdinfo (idle)
[83.676615] Starting subtest: idle
[83.678777] Starting dynamic subtest: rcs0
[84.290673] Dynamic subtest rcs0: SUCCESS (0.616s)
[84.301620] Starting dynamic subtest: bcs0
[84.797410] Dynamic subtest bcs0: SUCCESS (0.504s)
[84.808083] Starting dynamic subtest: vcs0
[85.302419] Dynamic subtest vcs0: SUCCESS (0.504s)
[85.312869] Starting dynamic subtest: vcs1
[85.807086] Dynamic subtest vcs1: SUCCESS (0.504s)
[85.817734] Starting dynamic subtest: vecs0
[86.313415] Dynamic subtest vecs0: SUCCESS (0.505s)
[86.324054] Starting dynamic subtest: ccs0
[86.818351] Dynamic subtest ccs0: SUCCESS (0.504s)
[86.821137] Subtest idle: SUCCESS (3.143s)
[86.919024] [012/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[87.021808] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[87.026319] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[87.156792] [013/133] (931s left) kms_invalid_mode (zero-hdisplay)
[87.244958] Starting subtest: zero-hdisplay
[87.247291] Starting dynamic subtest: pipe-A-eDP-1
[87.541640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[87.550595] Starting dynamic subtest: pipe-B-eDP-1
[87.552586] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[87.559992] Starting dynamic subtest: pipe-C-eDP-1
[87.562406] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[87.570068] Starting dynamic subtest: pipe-D-eDP-1
[87.572293] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[87.574517] Subtest zero-hdisplay: SUCCESS (0.299s)
[88.390559] [014/133] (930s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[88.480072] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[88.482447] Starting dynamic subtest: pipe-A
[88.542819] Dynamic subtest pipe-A: SUCCESS (0.065s)
[88.556565] Starting dynamic subtest: pipe-B
[89.692169] Dynamic subtest pipe-B: SUCCESS (1.148s)
[89.705572] Starting dynamic subtest: pipe-C
[90.805858] Dynamic subtest pipe-C: SUCCESS (1.113s)
[90.815607] Starting dynamic subtest: pipe-D
[91.947044] Dynamic subtest pipe-D: SUCCESS (1.140s)
[91.949518] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.470s)
[93.124980] [015/133] (925s left) drm_read (fault-buffer)
[93.269815] Starting subtest: fault-buffer
[93.272125] Subtest fault-buffer: SUCCESS (0.000s)
[93.429280] [016/133] (925s left) gem_ccs (suspend-resume)
[93.496711] Starting subtest: suspend-resume
[93.500920] Subtest suspend-resume: SKIP (0.000s)
[93.620371] [017/133] (925s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[93.715851] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[93.718123] Starting dynamic subtest: pipe-A-eDP-1
[93.740991] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.751783] Starting dynamic subtest: pipe-B-eDP-1
[93.772592] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.779816] Starting dynamic subtest: pipe-C-eDP-1
[93.801595] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.810366] Starting dynamic subtest: pipe-D-eDP-1
[93.831847] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.835839] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[95.971749] [018/133] (922s left) gem_close (many-handles-one-vma)
[96.044517] Starting subtest: many-handles-one-vma
[96.067609] Subtest many-handles-one-vma: SUCCESS (0.026s)
[96.220886] [019/133] (922s left) gem_busy (extended)
[96.417024] Starting subtest: extended
[96.419783] Starting dynamic subtest: rcs0
[96.505277] Dynamic subtest rcs0: SUCCESS (0.088s)
[96.516238] Starting dynamic subtest: bcs0
[96.547459] Dynamic subtest bcs0: SUCCESS (0.041s)
[96.557885] Starting dynamic subtest: vcs0
[97.877024] Dynamic subtest vcs0: SUCCESS (1.327s)
[97.887687] Starting dynamic subtest: vcs1
[99.924945] Dynamic subtest vcs1: SUCCESS (2.045s)
[99.935907] Starting dynamic subtest: vecs0
[101.908910] Dynamic subtest vecs0: SUCCESS (1.983s)
[101.919759] Starting dynamic subtest: ccs0
[101.952643] Dynamic subtest ccs0: SUCCESS (0.045s)
[101.954989] Subtest extended: SUCCESS (5.537s)
[102.233759] [020/133] (916s left) kms_vblank (ts-continuation-suspend)
[102.343618] Starting subtest: ts-continuation-suspend
[102.345811] Starting dynamic subtest: pipe-A-eDP-1
[119.195550] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.500s)
[119.209630] Starting dynamic subtest: pipe-D-eDP-1
[136.200855] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.209s)
[136.202765] Subtest ts-continuation-suspend: SUCCESS (3.712s)
[137.019333] [021/133] (881s left) perf_pmu (semaphore-wait-idle)
[137.064901] Starting subtest: semaphore-wait-idle
[137.066736] Starting dynamic subtest: rcs0
[137.581950] Dynamic subtest rcs0: SUCCESS (0.516s)
[137.593538] Starting dynamic subtest: bcs0
[138.094415] Dynamic subtest bcs0: SUCCESS (0.511s)
[138.105785] Starting dynamic subtest: vcs0
[138.608452] Dynamic subtest vcs0: SUCCESS (0.512s)
[138.619362] Starting dynamic subtest: vcs1
[139.119751] Dynamic subtest vcs1: SUCCESS (0.510s)
[139.130092] Starting dynamic subtest: vecs0
[139.631432] Dynamic subtest vecs0: SUCCESS (0.509s)
[139.642244] Starting dynamic subtest: ccs0
[140.146778] Dynamic subtest ccs0: SUCCESS (0.514s)
[140.149670] Subtest semaphore-wait-idle: SUCCESS (3.082s)
[140.307354] [022/133] (878s left) kms_debugfs (display-off-read-all)
[140.418033] Starting subtest: display-off-read-all
[140.708540] Subtest display-off-read-all: SUCCESS (0.288s)
[141.542007] [023/133] (877s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[141.644521] Starting subtest: fbc-rgb101010-draw-blt
[146.236174] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.594s)
[147.454162] [024/133] (871s left) gem_ctx_param (invalid-get-no-zeromap)
[147.507391] Starting subtest: invalid-get-no-zeromap
[147.509658] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[147.669763] [025/133] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[147.776359] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[147.780370] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[147.924716] [026/133] (871s left) gem_exec_big (single)
[147.988295] Starting subtest: single
[150.331033] Subtest single: FAIL (2.285s)
[150.380997] [027/133] (868s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[150.531705] Starting subtest: psr-rgb101010-draw-mmap-gtt
[150.535893] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[150.670666] [028/133] (868s left) gem_exec_flush (basic-uc-prw-default)
[150.735392] Starting subtest: basic-uc-prw-default
[156.212530] Subtest basic-uc-prw-default: SUCCESS (5.479s)
[156.431257] [029/133] (862s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[156.538444] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[156.542338] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[156.670113] [030/133] (862s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[156.772762] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[163.611444] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.840s)
[163.774203] [031/133] (855s left) gem_exec_create (forked)
[163.835409] Starting subtest: forked
[163.837852] Starting dynamic subtest: smem
[184.084381] Dynamic subtest smem: SUCCESS (20.360s)
[184.087041] Subtest forked: SUCCESS (20.362s)
[184.301485] [032/133] (835s left) kms_feature_discovery (display-1x)
[184.397954] Starting subtest: display-1x
[184.400242] Subtest display-1x: SUCCESS (0.000s)
[184.514963] [033/133] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[184.622452] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[184.626484] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[184.769739] [034/133] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[184.863434] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[184.867360] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[184.996685] [035/133] (834s left) gem_render_copy_redux (interruptible)
[185.059814] Starting subtest: interruptible
[185.315754] Subtest interruptible: SUCCESS (0.257s)
[185.481565] [036/133] (834s left) i915_pm_rpm (system-suspend-execbuf)
[187.226786] Starting subtest: system-suspend-execbuf
[247.815696] Subtest system-suspend-execbuf: SUCCESS (45.114s)
[248.198496] [037/133] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[248.293371] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[248.297788] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[248.410253] [038/133] (771s left) gem_request_retire (retire-vma-not-inactive)
[248.465301] Starting subtest: retire-vma-not-inactive
[248.525241] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[248.692320] [039/133] (771s left) i915_pm_rps (thresholds-idle)
[248.756367] Starting subtest: thresholds-idle
[248.761072] Subtest thresholds-idle: SKIP (0.000s)
[248.883259] [040/133] (770s left) gem_ctx_persistence (legacy-engines-queued)
[248.934668] Starting subtest: legacy-engines-queued
[248.937102] Starting dynamic subtest: render
[249.022787] Dynamic subtest render: SUCCESS (0.087s)
[249.034818] Starting dynamic subtest: bsd1
[250.664398] Dynamic subtest bsd1: SUCCESS (1.638s)
[250.676710] Starting dynamic subtest: bsd2
[252.646557] Dynamic subtest bsd2: SUCCESS (1.979s)
[252.658646] Starting dynamic subtest: blt
[252.713653] Dynamic subtest blt: SUCCESS (0.066s)
[252.723068] Starting dynamic subtest: vebox
[254.630231] Dynamic subtest vebox: SUCCESS (1.914s)
[254.633055] Subtest legacy-engines-queued: SUCCESS (5.695s)
[254.735634] [041/133] (765s left) i915_hangman (gt-error-state-capture)
[254.812961] Starting subtest: gt-error-state-capture
[254.815255] Starting dynamic subtest: rcs0
[266.598034] Dynamic subtest rcs0: SUCCESS (11.786s)
[266.610710] Starting dynamic subtest: bcs0
[278.629215] Dynamic subtest bcs0: SUCCESS (12.033s)
[278.641428] Starting dynamic subtest: vcs0
[289.637722] Dynamic subtest vcs0: SUCCESS (11.010s)
[289.656378] Starting dynamic subtest: vcs1
[300.645623] Dynamic subtest vcs1: SUCCESS (11.009s)
[300.657624] Starting dynamic subtest: vecs0
[312.550447] Dynamic subtest vecs0: SUCCESS (11.898s)
[312.562640] Starting dynamic subtest: ccs0
[323.622679] Dynamic subtest ccs0: SUCCESS (11.068s)
[323.625507] Subtest gt-error-state-capture: SUCCESS (68.814s)
[323.728709] [042/133] (696s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[323.951795] Starting subtest: cursor-rapid-movement-128x42
[323.996592] Subtest cursor-rapid-movement-128x42: SKIP (0.040s)
[324.247852] [043/133] (695s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[324.315226] Subtest writes-after-reads-uncached: SKIP (0.000s)
[324.405291] [044/133] (695s left) gem_mmap_wc (coherency)
[324.468464] Subtest coherency: SKIP (0.000s)
[324.534898] [045/133] (695s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[324.597519] Starting subtest: single-wait-all-for-submit-signaled
[324.599895] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[324.731497] [046/133] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[324.826941] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[328.590597] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.768s)
[329.787342] [047/133] (690s left) kms_psr (fbc-psr-primary-mmap-cpu)
[329.897269] Starting subtest: fbc-psr-primary-mmap-cpu
[329.899143] Starting dynamic subtest: eDP-1
[329.903234] Dynamic subtest eDP-1: SKIP (0.000s)
[329.907255] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[329.992291] [048/133] (690s left) kms_invalid_mode (bad-vsync-start)
[330.090336] Starting subtest: bad-vsync-start
[330.092584] Starting dynamic subtest: pipe-A-eDP-1
[330.378030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[330.388739] Starting dynamic subtest: pipe-B-eDP-1
[330.390853] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[330.401181] Starting dynamic subtest: pipe-C-eDP-1
[330.403301] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[330.411642] Starting dynamic subtest: pipe-D-eDP-1
[330.413712] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[330.415851] Subtest bad-vsync-start: SUCCESS (0.291s)
[331.206986] [049/133] (689s left) gem_exec_reloc (basic-wc-gtt)
[331.278428] Subtest basic-wc-gtt: SKIP (0.000s)
[331.358652] [050/133] (688s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[331.412763] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[331.477788] [051/133] (688s left) kms_prop_blob (blob-multiple)
[331.523949] Starting subtest: blob-multiple
[331.526375] Subtest blob-multiple: SUCCESS (0.002s)
[331.660538] [052/133] (688s left) api_intel_allocator (open-vm)
[331.719039] Starting subtest: open-vm
[331.721305] Subtest open-vm: SUCCESS (0.003s)
[331.875372] [053/133] (688s left) kms_getfb (getfb-repeated-different-handles)
[331.971800] Starting subtest: getfb-repeated-different-handles
[331.974092] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[332.107733] [054/133] (688s left) kms_content_protection (legacy-hdcp14)
[332.245670] Starting subtest: legacy-hdcp14
[332.249632] Subtest legacy-hdcp14: SKIP (0.000s)
[332.404596] [055/133] (688s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[332.806303] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[333.583839] [056/133] (686s left) kms_flip (blocking-absolute-wf_vblank)
[333.679411] Starting subtest: blocking-absolute-wf_vblank
[333.681731] Starting dynamic subtest: A-eDP1
[342.377941] Dynamic subtest A-eDP1: SUCCESS (8.697s)
[342.393896] Starting dynamic subtest: B-eDP1
[351.107099] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[351.118233] Starting dynamic subtest: C-eDP1
[359.828292] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[359.839061] Starting dynamic subtest: D-eDP1
[368.550314] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[368.555428] Subtest blocking-absolute-wf_vblank: SUCCESS (34.881s)
[369.806895] [057/133] (650s left) gem_mmap_offset (bad-object)
[369.881328] Starting subtest: bad-object
[369.883588] Subtest bad-object: SUCCESS (0.001s)
[369.990867] [058/133] (650s left) kms_psr (psr2-no-drrs)
[370.083037] Starting subtest: psr2-no-drrs
[370.085278] Starting dynamic subtest: eDP-1
[371.722514] Dynamic subtest eDP-1: SUCCESS (1.639s)
[371.724759] Subtest psr2-no-drrs: SUCCESS (1.639s)
[372.545682] [059/133] (648s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[372.610596] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[372.684212] [060/133] (647s left) kms_vblank (wait-idle)
[372.782875] Starting subtest: wait-idle
[372.784757] Starting dynamic subtest: pipe-A-eDP-1
[374.535045] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[374.559693] Starting dynamic subtest: pipe-D-eDP-1
[376.962583] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.426s)
[376.965061] Subtest wait-idle: SUCCESS (4.182s)
[377.804685] [061/133] (642s left) gem_exec_whisper (basic-contexts-all)
[377.876500] Starting subtest: basic-contexts-all
[389.606195] Subtest basic-contexts-all: SUCCESS (11.730s)
[389.823929] [062/133] (630s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[389.941132] Starting subtest: x-tiled-16bpp-rotate-0
[391.297316] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.356s)
[391.454919] [063/133] (629s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[391.553105] Starting subtest: plane-primary-overlay-mutable-zpos
[395.025300] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.469s)
[396.236381] [064/133] (624s left) gen9_exec_parse (bb-start-cmd)
[396.294944] Subtest bb-start-cmd: SKIP (0.000s)
[396.360683] [065/133] (624s left) kms_cursor_crc (cursor-alpha-opaque)
[396.456934] Starting subtest: cursor-alpha-opaque
[396.459066] Starting dynamic subtest: pipe-A-eDP-1
[397.076921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[397.086857] Starting dynamic subtest: pipe-D-eDP-1
[398.386958] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[398.389306] Subtest cursor-alpha-opaque: SUCCESS (1.930s)
[399.199272] [066/133] (621s left) kms_cursor_crc (cursor-sliding-64x64)
[399.376360] Starting subtest: cursor-sliding-64x64
[399.381259] Starting dynamic subtest: pipe-A-eDP-1
[402.611159] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.232s)
[402.641525] Starting dynamic subtest: pipe-D-eDP-1
[406.504519] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.871s)
[406.506752] Subtest cursor-sliding-64x64: SUCCESS (7.129s)
[407.354370] [067/133] (613s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[407.472232] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[414.210252] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.742s)
[414.379310] [068/133] (606s left) gem_ctx_shared (exec-single-timeline)
[414.444484] Starting subtest: exec-single-timeline
[414.446802] Starting dynamic subtest: rcs0
[415.524574] Dynamic subtest rcs0: SUCCESS (1.078s)
[415.536867] Starting dynamic subtest: bcs0
[416.612280] Dynamic subtest bcs0: SUCCESS (1.085s)
[416.623798] Starting dynamic subtest: vcs0
[417.710661] Dynamic subtest vcs0: SUCCESS (1.085s)
[417.721031] Starting dynamic subtest: vcs1
[418.788721] Dynamic subtest vcs1: SUCCESS (1.089s)
[418.800774] Starting dynamic subtest: vecs0
[419.877374] Dynamic subtest vecs0: SUCCESS (1.086s)
[419.890627] Starting dynamic subtest: ccs0
[420.965038] Dynamic subtest ccs0: SUCCESS (1.085s)
[420.967797] Subtest exec-single-timeline: SUCCESS (6.523s)
[421.699821] [069/133] (599s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[421.800265] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[421.802622] Starting dynamic subtest: pipe-A
[423.095068] Dynamic subtest pipe-A: SUCCESS (1.297s)
[423.104283] Starting dynamic subtest: pipe-B
[425.393490] Dynamic subtest pipe-B: SUCCESS (2.297s)
[425.404351] Starting dynamic subtest: pipe-C
[426.544103] Dynamic subtest pipe-C: SUCCESS (1.149s)
[426.555975] Starting dynamic subtest: pipe-D
[427.686980] Dynamic subtest pipe-D: SUCCESS (1.143s)
[427.689285] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.891s)
[428.898211] [070/133] (592s left) gem_wait (write-busy)
[428.968892] Starting subtest: write-busy
[428.971225] Starting dynamic subtest: all-engines
[429.596076] Dynamic subtest all-engines: SUCCESS (0.626s)
[429.608116] Starting dynamic subtest: rcs0
[430.157465] Dynamic subtest rcs0: SUCCESS (0.559s)
[430.174164] Starting dynamic subtest: bcs0
[430.707418] Dynamic subtest bcs0: SUCCESS (0.549s)
[430.723334] Starting dynamic subtest: vcs0
[432.647481] Dynamic subtest vcs0: SUCCESS (1.937s)
[432.666197] Starting dynamic subtest: vcs1
[434.631384] Dynamic subtest vcs1: SUCCESS (1.981s)
[434.647785] Starting dynamic subtest: vecs0
[436.678892] Dynamic subtest vecs0: SUCCESS (2.044s)
[436.696520] Starting dynamic subtest: ccs0
[437.232826] Dynamic subtest ccs0: SUCCESS (0.553s)
[437.235137] Subtest write-busy: SUCCESS (8.261s)
[437.453089] [071/133] (583s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[437.562365] Starting subtest: y-tiled-8bpp-rotate-0
[437.566351] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[437.694980] [072/133] (583s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[437.809798] Starting subtest: basic-busy-flip-before-cursor-legacy
[437.814758] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[437.985455] [073/133] (583s left) gem_basic (bad-close)
[438.061037] Starting subtest: bad-close
[438.065536] Subtest bad-close: SUCCESS (0.000s)
[438.207333] [074/133] (583s left) kms_big_fb (linear-16bpp-rotate-0)
[438.308891] Starting subtest: linear-16bpp-rotate-0
[439.720378] Subtest linear-16bpp-rotate-0: SUCCESS (1.412s)
[439.892106] [075/133] (581s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[444.838324] Starting subtest: pr-overlay-plane-update-continuous-sf
[444.842769] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[445.723296] [076/133] (575s left) drm_read (short-buffer-wakeup)
[445.865307] Starting subtest: short-buffer-wakeup
[478.083862] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[478.251519] [077/133] (543s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[478.352575] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[485.184832] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.834s)
[485.356786] [078/133] (536s left) kms_psr (fbc-pr-cursor-render)
[485.442757] Starting subtest: fbc-pr-cursor-render
[485.446740] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[485.539124] [079/133] (535s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[485.632922] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[485.635141] Starting dynamic subtest: pipe-A-eDP-1
[485.643786] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[485.653088] Starting dynamic subtest: pipe-B-eDP-1
[485.662442] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[485.672765] Starting dynamic subtest: pipe-C-eDP-1
[485.681217] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[485.689771] Starting dynamic subtest: pipe-D-eDP-1
[485.698498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[485.702557] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[487.896752] [080/133] (533s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[487.990233] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[487.992439] Starting dynamic subtest: pipe-A-eDP-1
[489.197234] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.209s)
[489.206894] Starting dynamic subtest: pipe-B-eDP-1
[491.474538] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.275s)
[491.483830] Starting dynamic subtest: pipe-C-eDP-1
[493.727903] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.252s)
[493.739121] Starting dynamic subtest: pipe-D-eDP-1
[496.036484] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.309s)
[496.038698] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.049s)
[497.222075] [081/133] (524s left) sw_sync (sync_multi_timeline_wait)
[497.260462] Starting subtest: sync_multi_timeline_wait
[497.262903] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[497.373686] [082/133] (524s left) sysfs_heartbeat_interval (idempotent)
[497.437882] Starting subtest: idempotent
[497.440249] Starting dynamic subtest: vecs0
[497.442560] Dynamic subtest vecs0: SUCCESS (0.001s)
[497.452935] Starting dynamic subtest: ccs0
[497.455144] Dynamic subtest ccs0: SUCCESS (0.001s)
[497.463855] Starting dynamic subtest: vcs0
[497.466084] Dynamic subtest vcs0: SUCCESS (0.000s)
[497.475141] Starting dynamic subtest: bcs0
[497.477422] Dynamic subtest bcs0: SUCCESS (0.001s)
[497.486123] Starting dynamic subtest: rcs0
[497.488286] Dynamic subtest rcs0: SUCCESS (0.001s)
[497.496963] Starting dynamic subtest: vcs1
[497.499224] Dynamic subtest vcs1: SUCCESS (0.000s)
[497.501391] Subtest idempotent: SUCCESS (0.008s)
[497.593499] [083/133] (524s left) syncobj_eventfd (invalid-bad-pad)
[497.648071] Starting subtest: invalid-bad-pad
[497.650274] Subtest invalid-bad-pad: SUCCESS (0.000s)
[497.775595] [084/133] (523s left) kms_busy (extended-pageflip-hang-newfb)
[497.884349] Starting subtest: extended-pageflip-hang-newfb
[497.886963] Starting dynamic subtest: pipe-A
[524.449829] Dynamic subtest pipe-A: SUCCESS (26.562s)
[524.460353] Starting dynamic subtest: pipe-D
[549.400319] Dynamic subtest pipe-D: SUCCESS (24.951s)
[549.402571] Subtest extended-pageflip-hang-newfb: SUCCESS (51.519s)
[550.273578] [085/133] (471s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[555.228045] Starting subtest: psr2-cursor-plane-update-sf
[555.230403] Starting dynamic subtest: pipe-A-eDP-1
[556.542928] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.312s)
[556.553695] Starting dynamic subtest: pipe-B-eDP-1
[557.878600] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.334s)
[557.881051] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.650s)
[558.776153] [086/133] (463s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[558.874462] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[559.553586] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[559.752081] [087/133] (462s left) gem_exec_balancer (busy)
[559.826231] Starting subtest: busy
[561.679021] Subtest busy: SUCCESS (1.854s)
[562.052471] [088/133] (459s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[562.154233] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[562.158434] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[562.280583] [089/133] (459s left) vgem_slow (nohang)
[562.319813] Starting subtest: nohang
[572.709062] Subtest nohang: SUCCESS (10.392s)
[572.804413] [090/133] (449s left) gem_spin_batch (resubmit-new-all)
[572.875173] Starting subtest: resubmit-new-all
[572.877430] Starting dynamic subtest: rcs0
[572.899366] Dynamic subtest rcs0: SUCCESS (0.024s)
[572.911437] Starting dynamic subtest: bcs0
[572.915933] Dynamic subtest bcs0: SUCCESS (0.015s)
[572.925435] Starting dynamic subtest: vcs0
[572.931424] Dynamic subtest vcs0: SUCCESS (0.016s)
[572.940832] Starting dynamic subtest: vcs1
[572.948645] Dynamic subtest vcs1: SUCCESS (0.016s)
[572.958055] Starting dynamic subtest: vecs0
[572.966797] Dynamic subtest vecs0: SUCCESS (0.018s)
[572.976226] Starting dynamic subtest: ccs0
[572.987475] Dynamic subtest ccs0: SUCCESS (0.019s)
[572.989710] Subtest resubmit-new-all: SUCCESS (0.113s)
[574.731622] [091/133] (447s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[574.803973] Starting subtest: mixed-tiled-to-y-tiled-ccs
[574.808627] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[575.016201] [092/133] (447s left) syncobj_timeline (invalid-signal-illegal-point)
[575.082046] Starting subtest: invalid-signal-illegal-point
[575.084407] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[575.203975] [093/133] (446s left) gem_exec_schedule (preempt-contexts)
[575.287277] Starting subtest: preempt-contexts
[575.290654] Starting dynamic subtest: rcs0
[575.384152] Dynamic subtest rcs0: SUCCESS (0.101s)
[575.393713] Starting dynamic subtest: bcs0
[575.464546] Dynamic subtest bcs0: SUCCESS (0.080s)
[575.474538] Starting dynamic subtest: vcs0
[575.520306] Dynamic subtest vcs0: SUCCESS (0.055s)
[575.529868] Starting dynamic subtest: vcs1
[575.586863] Dynamic subtest vcs1: SUCCESS (0.066s)
[575.596565] Starting dynamic subtest: vecs0
[575.643734] Dynamic subtest vecs0: SUCCESS (0.055s)
[575.653691] Starting dynamic subtest: ccs0
[575.721361] Dynamic subtest ccs0: SUCCESS (0.077s)
[575.723662] Subtest preempt-contexts: SUCCESS (0.439s)
[576.779231] [094/133] (445s left) gem_pwrite_snooped
[576.920677] [095/133] (445s left) kms_tiled_display (basic-test-pattern)
[577.039891] Subtest basic-test-pattern: SKIP (0.000s)
[577.083722] [096/133] (445s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[577.184439] Starting subtest: psr-shrfb-scaledprimary
[582.956398] Subtest psr-shrfb-scaledprimary: SUCCESS (5.775s)
[583.139720] [097/133] (439s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[583.255869] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[583.259954] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[583.395071] [098/133] (438s left) gem_pwrite (basic-self)
[583.465795] Subtest basic-self: SKIP (0.000s)
[583.535344] [099/133] (438s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[585.855878] Starting subtest: dpms-mode-unset-non-lpsp
[587.006710] Subtest dpms-mode-unset-non-lpsp: SKIP (1.152s)
[587.429251] [100/133] (434s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[587.537255] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[587.542007] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[587.660656] [101/133] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[587.756670] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[587.760871] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[587.877353] [102/133] (434s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[587.980169] Starting subtest: plane-lut1d-ctm3x4-lut1d
[587.992939] Starting dynamic subtest: pipe-A-eDP-1
[588.627206] Dynamic subtest pipe-A-eDP-1: FAIL (0.283s)
[589.355389] Starting dynamic subtest: pipe-B-eDP-1
[590.202606] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[590.696686] Starting dynamic subtest: pipe-C-eDP-1
[591.527766] Dynamic subtest pipe-C-eDP-1: FAIL (0.256s)
[592.022732] Starting dynamic subtest: pipe-D-eDP-1
[592.883407] Dynamic subtest pipe-D-eDP-1: FAIL (0.280s)
[592.885426] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.605s)
[593.415711] [103/133] (429s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[593.507916] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[600.341427] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.837s)
[600.504251] [104/133] (422s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[600.636380] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[607.659182] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.024s)
[607.819576] [105/133] (414s left) gem_exec_schedule (preempt-queue-contexts-chain)
[607.894072] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[608.212440] [106/133] (414s left) api_intel_bb (object-noreloc-keep-cache-simple)
[608.285806] Starting subtest: object-noreloc-keep-cache-simple
[608.290904] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[608.455562] [107/133] (414s left) gem_mmap (bad-object)
[608.514201] Subtest bad-object: SKIP (0.000s)
[608.582275] [108/133] (414s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[608.674224] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[608.676463] Starting dynamic subtest: pipe-A-default-mode
[608.964147] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[608.968754] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.288s)
[609.797889] [109/133] (412s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[609.898672] Starting subtest: bo-too-small-due-to-tiling
[609.902880] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[610.019339] [110/133] (412s left) kms_psr (pr-sprite-blt)
[610.118084] Starting subtest: pr-sprite-blt
[610.122360] Subtest pr-sprite-blt: SKIP (0.000s)
[610.222399] [111/133] (412s left) kms_draw_crc (fill-fb)
[610.317349] Starting subtest: fill-fb
[610.801991] Subtest fill-fb: SUCCESS (0.486s)
[610.943237] [112/133] (411s left) perf_pmu (busy-idle)
[610.986681] Starting subtest: busy-idle
[610.988175] Starting dynamic subtest: rcs0
[611.684452] Dynamic subtest rcs0: SUCCESS (0.699s)
[611.696571] Starting dynamic subtest: bcs0
[612.353552] Dynamic subtest bcs0: SUCCESS (0.667s)
[612.365635] Starting dynamic subtest: vcs0
[613.640030] Dynamic subtest vcs0: SUCCESS (1.282s)
[613.652412] Starting dynamic subtest: vcs1
[615.623309] Dynamic subtest vcs1: SUCCESS (1.981s)
[615.633045] Starting dynamic subtest: vecs0
[617.672275] Dynamic subtest vecs0: SUCCESS (2.046s)
[617.683309] Starting dynamic subtest: ccs0
[618.348052] Dynamic subtest ccs0: SUCCESS (0.674s)
[618.350467] Subtest busy-idle: SUCCESS (7.365s)
[618.471564] [113/133] (404s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[618.569896] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[618.572057] Starting dynamic subtest: pipe-A-eDP-1
[618.627669] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[618.636649] Starting dynamic subtest: pipe-B-eDP-1
[618.692128] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[618.703074] Starting dynamic subtest: pipe-C-eDP-1
[618.759609] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[618.769791] Starting dynamic subtest: pipe-D-eDP-1
[618.826311] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[618.830723] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[620.759878] [114/133] (402s left) gem_exec_flush (basic-batch-kernel-default-uc)
[620.829413] Starting subtest: basic-batch-kernel-default-uc
[628.114834] Subtest basic-batch-kernel-default-uc: SUCCESS (7.287s)
[628.337007] [115/133] (394s left) gem_mmap_wc (write-read-distinct)
[628.399901] Subtest write-read-distinct: SKIP (0.000s)
[628.475699] [116/133] (394s left) kms_plane_lowres (tiling-x)
[628.577803] Starting subtest: tiling-x
[628.580036] Starting dynamic subtest: pipe-A-eDP-1
[628.584289] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[628.872835] Starting dynamic subtest: pipe-B-eDP-1
[628.877429] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[628.887059] Starting dynamic subtest: pipe-C-eDP-1
[628.891693] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[628.901294] Starting dynamic subtest: pipe-D-eDP-1
[628.905922] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[628.910296] Subtest tiling-x: SKIP (0.293s)
[629.683858] [117/133] (393s left) sw_sync (alloc_merge_fence)
[629.721837] Starting subtest: alloc_merge_fence
[629.724088] Subtest alloc_merge_fence: SUCCESS (0.000s)
[629.817344] [118/133] (393s left) kms_pm_backlight (fade)
[629.907955] Starting subtest: fade
[629.960514] Starting dynamic subtest: eDP-1
[632.631684] Dynamic subtest eDP-1: SUCCESS (2.672s)
[632.634044] Subtest fade: SUCCESS (2.724s)
[633.518615] [119/133] (389s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[633.619984] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[633.622219] Starting dynamic subtest: pipe-A-default-mode
[634.759943] Dynamic subtest pipe-A-default-mode: SKIP (1.137s)
[634.763945] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.138s)
[634.941547] [120/133] (388s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[634.999928] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[635.107888] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[635.212511] [121/133] (388s left) kms_psr (psr-cursor-mmap-cpu)
[635.317334] Starting subtest: psr-cursor-mmap-cpu
[635.319552] Starting dynamic subtest: eDP-1
[637.013822] Dynamic subtest eDP-1: SUCCESS (1.693s)
[637.016452] Subtest psr-cursor-mmap-cpu: SUCCESS (1.695s)
[637.915655] [122/133] (385s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[638.019064] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[638.664582] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[638.848023] [123/133] (384s left) gem_exec_whisper (basic-queues-priority-all)
[638.924053] Starting subtest: basic-queues-priority-all
[661.098425] Subtest basic-queues-priority-all: SUCCESS (22.178s)
[661.310600] [124/133] (362s left) syncobj_timeline (etime-single-wait-all-submitted)
[661.365282] Starting subtest: etime-single-wait-all-submitted
[661.475484] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[661.583846] [125/133] (361s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[661.689258] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[661.693184] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[661.820682] [126/133] (361s left) kms_async_flips (async-flip-dpms)
[661.914670] Starting subtest: async-flip-dpms
[662.290364] Starting dynamic subtest: pipe-A-eDP-1
[666.102373] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.814s)
[666.471661] Starting dynamic subtest: pipe-B-eDP-1
[669.263388] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.801s)
[669.636425] Starting dynamic subtest: pipe-C-eDP-1
[672.420074] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.792s)
[672.808840] Starting dynamic subtest: pipe-D-eDP-1
[675.589465] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.791s)
[675.591730] Subtest async-flip-dpms: SUCCESS (13.680s)
[676.789934] [127/133] (346s left) gem_exec_reloc (basic-cpu-read-noreloc)
[676.851516] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[676.926522] [128/133] (346s left) syncobj_wait (invalid-reset-illegal-handle)
[676.991484] Starting subtest: invalid-reset-illegal-handle
[676.993564] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[677.108395] [129/133] (346s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[677.159715] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[677.267443] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[677.403615] [130/133] (346s left) gem_tiled_swapping (non-threaded)
[677.465871] Subtest non-threaded: SKIP (0.000s)
[677.569230] [131/133] (346s left) gem_exec_fence (syncobj-timeline-chain-engines)
[678.118597] Starting subtest: syncobj-timeline-chain-engines
[678.240167] Subtest syncobj-timeline-chain-engines: SUCCESS (0.122s)
[679.767894] [132/133] (344s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[679.896312] Starting subtest: flip-vs-cursor-legacy
[686.897712] Subtest flip-vs-cursor-legacy: SUCCESS (7.000s)
[687.721276] [133/133] (336s left) syncobj_basic (illegal-fd-to-handle)
[687.792683] Starting subtest: illegal-fd-to-handle
[687.795069] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[687.925394] 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.