[59.243665] Initializing watchdogs
[59.243711]   /dev/watchdog0
[59.259083] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.263691] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.266127] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.268049] [001/133] (960s left) kms_psr (pr-cursor-plane-move)
[59.379967] Starting subtest: pr-cursor-plane-move
[59.382039] Subtest pr-cursor-plane-move: SKIP (0.000s)
[59.452117] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[59.544734] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[59.546596] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[59.634022] [003/133] (960s left) kms_cursor_crc (cursor-offscreen-256x256)
[59.869056] Starting subtest: cursor-offscreen-256x256
[59.884682] Starting dynamic subtest: pipe-A-eDP-1
[61.874423] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.988s)
[61.905892] Starting dynamic subtest: pipe-D-eDP-1
[64.516374] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s)
[64.517396] Subtest cursor-offscreen-256x256: SUCCESS (4.641s)
[65.374998] [004/133] (954s left) perf_pmu (idle)
[65.418531] Starting subtest: idle
[65.419683] Starting dynamic subtest: rcs0
[65.973329] Dynamic subtest rcs0: SUCCESS (0.545s)
[65.982235] Starting dynamic subtest: bcs0
[66.493056] Dynamic subtest bcs0: SUCCESS (0.518s)
[66.504459] Starting dynamic subtest: vcs0
[67.013925] Dynamic subtest vcs0: SUCCESS (0.519s)
[67.023650] Starting dynamic subtest: vcs1
[67.688798] Dynamic subtest vcs1: SUCCESS (0.673s)
[67.697808] Starting dynamic subtest: vecs0
[68.222126] Dynamic subtest vecs0: SUCCESS (0.531s)
[68.229945] Starting dynamic subtest: ccs0
[68.738720] Dynamic subtest ccs0: SUCCESS (0.515s)
[68.739793] Subtest idle: SUCCESS (3.309s)
[68.828393] [005/133] (951s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[68.936754] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[68.938493] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[69.000466] [006/133] (950s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[69.095922] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[69.098044] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[69.195927] [007/133] (950s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[69.293130] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[69.295382] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[70.417188] [008/133] (949s left) kms_legacy_colorkey (basic)
[70.503859] Starting subtest: basic
[70.504745] Starting dynamic subtest: pipe-A
[70.548859] Dynamic subtest pipe-A: SUCCESS (0.045s)
[70.558386] Starting dynamic subtest: pipe-B
[70.559504] Dynamic subtest pipe-B: SUCCESS (0.001s)
[70.565421] Starting dynamic subtest: pipe-C
[70.566361] Dynamic subtest pipe-C: SUCCESS (0.000s)
[70.572696] Starting dynamic subtest: pipe-D
[70.573550] Dynamic subtest pipe-D: SUCCESS (0.001s)
[70.574426] Subtest basic: SUCCESS (0.049s)
[70.608018] [009/133] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[70.694731] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[77.772452] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.076s)
[77.913237] [010/133] (942s left) gem_eio (wait-wedge-immediate)
[78.096385] Starting subtest: wait-wedge-immediate
[79.941231] Subtest wait-wedge-immediate: SUCCESS (1.845s)
[80.079928] [011/133] (939s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[80.167941] Starting subtest: modeset-transition-nonblocking-fencing
[80.168912] Starting dynamic subtest: 1x-outputs
[91.041254] Dynamic subtest 1x-outputs: SUCCESS (10.864s)
[91.042205] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.865s)
[91.891585] [012/133] (928s left) kms_properties (plane-properties-legacy)
[91.984890] Starting subtest: plane-properties-legacy
[91.985979] Starting dynamic subtest: pipe-A-eDP-1
[92.541225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[92.549344] Starting dynamic subtest: pipe-B-eDP-1
[93.787796] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[93.794955] Starting dynamic subtest: pipe-C-eDP-1
[95.017317] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s)
[95.025046] Starting dynamic subtest: pipe-D-eDP-1
[96.249598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[96.250490] Subtest plane-properties-legacy: SUCCESS (4.264s)
[97.048194] [013/133] (923s left) gem_lmem_swapping (verify-ccs)
[97.087209] Subtest verify-ccs: SKIP (0.000s)
[97.122431] [014/133] (923s left) dmabuf (all-tests)
[97.149910] Starting subtest: all-tests
[97.151071] Starting dynamic subtest: sanitycheck
[97.242429] Dynamic subtest sanitycheck: SUCCESS (0.092s)
[97.254671] Starting dynamic subtest: dma_fence
[97.435360] Dynamic subtest dma_fence: SUCCESS (0.191s)
[97.445501] Starting dynamic subtest: dma_fence_chain
[106.974213] Dynamic subtest dma_fence_chain: SUCCESS (9.529s)
[106.982769] Starting dynamic subtest: dma_fence_unwrap
[107.056279] Dynamic subtest dma_fence_unwrap: SUCCESS (0.089s)
[107.066322] Starting dynamic subtest: dma_resv
[107.134442] Dynamic subtest dma_resv: SUCCESS (0.077s)
[107.136058] Subtest all-tests: SUCCESS (9.984s)
[107.193296] [015/133] (913s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[107.293764] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[107.295500] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[107.408853] [016/133] (912s left) kms_pm_rpm (pm-caching)
[109.025512] Starting subtest: pm-caching
[109.027976] Subtest pm-caching: SKIP (0.000s)
[109.692212] [017/133] (910s left) kms_flip (bo-too-big)
[109.771417] Starting subtest: bo-too-big
[109.772375] Starting dynamic subtest: A-eDP1
[111.063498] Dynamic subtest A-eDP1: SUCCESS (1.291s)
[111.074870] Starting dynamic subtest: B-eDP1
[112.401423] Dynamic subtest B-eDP1: SUCCESS (1.336s)
[112.410248] Starting dynamic subtest: C-eDP1
[113.740523] Dynamic subtest C-eDP1: SUCCESS (1.338s)
[113.750807] Starting dynamic subtest: D-eDP1
[115.075217] Dynamic subtest D-eDP1: SUCCESS (1.333s)
[115.077998] Subtest bo-too-big: SUCCESS (5.308s)
[116.269692] [018/133] (904s left) gem_userptr_blits (set-cache-level)
[116.328865] Starting subtest: set-cache-level
[116.330680] Subtest set-cache-level: SKIP (0.000s)
[116.454689] [019/133] (903s left) gem_exec_flush (basic-wb-pro-default)
[116.510383] Starting subtest: basic-wb-pro-default
[121.968675] Subtest basic-wb-pro-default: SUCCESS (5.457s)
[122.152114] [020/133] (898s left) gem_eio (in-flight-suspend)
[122.374739] Starting subtest: in-flight-suspend
[166.082798] Subtest in-flight-suspend: SUCCESS (13.915s)
[173.218837] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[173.230929] [021/133] (854s left) gem_exec_balancer (parallel-ordering)
[173.504321] Starting subtest: parallel-ordering
[174.555920] Subtest parallel-ordering: SUCCESS (1.047s)
[174.675461] [022/133] (852s left) syncobj_eventfd (invalid-illegal-eventfd)
[174.735159] Starting subtest: invalid-illegal-eventfd
[174.736204] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[174.837496] [023/133] (852s left) prime_udl
[174.905365] [024/133] (852s left) gem_caching (reads)
[174.954740] Subtest reads: SKIP (0.000s)
[175.022113] [025/133] (852s left) gem_madvise (dontneed-before-exec)
[175.048152] Starting subtest: dontneed-before-exec
[175.064873] Subtest dontneed-before-exec: SKIP (0.016s)
[175.131588] [026/133] (852s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[175.219679] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[175.220569] Starting dynamic subtest: pipe-A-eDP-1
[175.229773] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.238404] Starting dynamic subtest: pipe-B-eDP-1
[175.247262] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.255958] Starting dynamic subtest: pipe-C-eDP-1
[175.264183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.272125] Starting dynamic subtest: pipe-D-eDP-1
[175.280570] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.282129] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[177.396357] [027/133] (850s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[177.509142] Starting subtest: y-tiled-32bpp-rotate-0
[177.511180] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[177.603172] [028/133] (850s left) kms_psr (psr2-sprite-render)
[177.702440] Starting subtest: psr2-sprite-render
[177.703224] Starting dynamic subtest: eDP-1
[179.397044] Dynamic subtest eDP-1: SUCCESS (1.685s)
[179.398009] Subtest psr2-sprite-render: SUCCESS (1.686s)
[180.257916] [029/133] (847s left) i915_suspend (debugfs-reader)
[180.320279] Starting subtest: debugfs-reader
[198.828492] Subtest debugfs-reader: SUCCESS (3.532s)
[205.009993] [030/133] (828s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[205.070746] Starting subtest: single-wait-all-for-submit-unsubmitted
[205.176549] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[205.250435] [031/133] (828s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[205.340411] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[205.342042] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[205.469591] [032/133] (828s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[205.567788] Starting subtest: psr-rgb565-draw-mmap-gtt
[205.569451] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[205.683906] [033/133] (828s left) gem_render_copy (yf-tiled)
[205.739189] Starting subtest: yf-tiled
[205.741101] Subtest yf-tiled: SKIP (0.000s)
[205.938329] [034/133] (828s left) gem_exec_whisper (basic-sync-all)
[206.002994] Starting subtest: basic-sync-all
[212.576940] Subtest basic-sync-all: SUCCESS (6.534s)
[212.759347] [035/133] (821s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[212.857870] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[212.859675] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[212.952336] [036/133] (821s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[213.038798] Starting subtest: crc-primary-basic-y-tiled-ccs
[213.039660] Starting dynamic subtest: pipe-A-eDP-1
[213.048112] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.060755] Starting dynamic subtest: pipe-B-eDP-1
[213.068973] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.077618] Starting dynamic subtest: pipe-C-eDP-1
[213.085623] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.093770] Starting dynamic subtest: pipe-D-eDP-1
[213.102306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.104046] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[215.302009] [037/133] (818s left) gem_exec_schedule (manyslice)
[215.359773] Starting subtest: manyslice
[215.360715] Starting dynamic subtest: rcs0
[220.048974] Dynamic subtest rcs0: SUCCESS (4.634s)
[220.057222] Starting dynamic subtest: bcs0
[226.173743] Dynamic subtest bcs0: SUCCESS (6.114s)
[226.190691] Starting dynamic subtest: vcs0
[231.774074] Dynamic subtest vcs0: SUCCESS (5.595s)
[231.787580] Starting dynamic subtest: vcs1
[237.352511] Dynamic subtest vcs1: SUCCESS (5.573s)
[237.368320] Starting dynamic subtest: vecs0
[243.399517] Dynamic subtest vecs0: SUCCESS (6.085s)
[243.409159] Starting dynamic subtest: ccs0
[249.112816] Dynamic subtest ccs0: SUCCESS (5.677s)
[249.113851] Subtest manyslice: SUCCESS (33.684s)
[249.401158] [038/133] (784s left) gem_mmap_wc (write)
[249.460264] Subtest write: SKIP (0.000s)
[249.518359] [039/133] (784s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[249.577880] Starting subtest: etime-multi-wait-available-unsubmitted
[249.687545] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.108s)
[249.775775] [040/133] (784s left) api_intel_bb (blit-reloc-purge-cache)
[249.832976] Starting subtest: blit-reloc-purge-cache
[249.834831] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[249.953564] [041/133] (784s left) perf_pmu (busy)
[249.986380] Starting subtest: busy
[249.987446] Starting dynamic subtest: rcs0
[250.578950] Dynamic subtest rcs0: SUCCESS (0.592s)
[250.590653] Starting dynamic subtest: bcs0
[251.143849] Dynamic subtest bcs0: SUCCESS (0.564s)
[251.156691] Starting dynamic subtest: vcs0
[252.660227] Dynamic subtest vcs0: SUCCESS (1.506s)
[252.672206] Starting dynamic subtest: vcs1
[254.707939] Dynamic subtest vcs1: SUCCESS (2.046s)
[254.719234] Starting dynamic subtest: vecs0
[256.694308] Dynamic subtest vecs0: SUCCESS (1.985s)
[256.705546] Starting dynamic subtest: ccs0
[257.253461] Dynamic subtest ccs0: SUCCESS (0.567s)
[257.255129] Subtest busy: SUCCESS (7.267s)
[257.370794] [042/133] (777s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[257.462732] Starting subtest: 2x-flip-vs-modeset-vs-hang
[257.472796] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[257.547284] [043/133] (776s left) kms_big_fb (linear-32bpp-rotate-0)
[257.646133] Starting subtest: linear-32bpp-rotate-0
[259.113269] Subtest linear-32bpp-rotate-0: SUCCESS (1.467s)
[259.236905] [044/133] (775s left) kms_color_pipeline (plane-lut1d)
[259.327134] Starting subtest: plane-lut1d
[259.507810] Starting dynamic subtest: pipe-A-plane-0
[259.707897] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[259.716813] Starting dynamic subtest: pipe-A-plane-1
[259.896678] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[259.905362] Starting dynamic subtest: pipe-A-plane-2
[260.085560] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[261.252233] Starting dynamic subtest: pipe-B-plane-0
[261.410527] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[261.419637] Starting dynamic subtest: pipe-B-plane-1
[261.577411] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[261.586261] Starting dynamic subtest: pipe-B-plane-2
[261.756243] Dynamic subtest pipe-B-plane-2: SUCCESS (0.178s)
[263.006184] Starting dynamic subtest: pipe-C-plane-0
[263.142815] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[263.151602] Starting dynamic subtest: pipe-C-plane-1
[263.276314] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[263.285231] Starting dynamic subtest: pipe-C-plane-2
[263.421242] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[264.595238] Starting dynamic subtest: pipe-D-plane-0
[264.730668] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[264.739344] Starting dynamic subtest: pipe-D-plane-1
[264.886389] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[264.895766] Starting dynamic subtest: pipe-D-plane-2
[265.031093] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[265.323879] Subtest plane-lut1d: SUCCESS (5.997s)
[266.165435] [045/133] (768s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[266.271192] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[266.272889] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[266.383266] [046/133] (768s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[266.435162] Starting subtest: multi-wait-available-submitted-signaled
[266.436084] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[266.531817] [047/133] (768s left) gem_exec_fence (keep-in-fence)
[266.708350] Starting subtest: keep-in-fence
[266.709502] Starting dynamic subtest: rcs0
[266.755528] Dynamic subtest rcs0: SUCCESS (0.053s)
[266.766899] Starting dynamic subtest: bcs0
[266.807120] Dynamic subtest bcs0: SUCCESS (0.050s)
[266.819307] Starting dynamic subtest: vcs0
[268.660976] Dynamic subtest vcs0: SUCCESS (1.844s)
[268.671725] Starting dynamic subtest: vcs1
[270.645193] Dynamic subtest vcs1: SUCCESS (1.981s)
[270.656180] Starting dynamic subtest: vecs0
[272.692244] Dynamic subtest vecs0: SUCCESS (2.045s)
[272.702738] Starting dynamic subtest: ccs0
[272.905010] Dynamic subtest ccs0: SUCCESS (0.219s)
[272.906576] Subtest keep-in-fence: SUCCESS (6.203s)
[274.716617] [048/133] (759s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[274.801739] Starting subtest: sprite-rotation-90-pos-100-0
[274.803428] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[274.870914] [049/133] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[274.956635] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[274.958308] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[275.049999] [050/133] (759s left) syncobj_timeline (multi-wait-all-available-signaled)
[275.102187] Starting subtest: multi-wait-all-available-signaled
[275.103104] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[275.200025] [051/133] (759s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[275.320001] Starting subtest: cursorB-vs-flipB-atomic
[275.321504] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[275.472705] [052/133] (759s left) kms_content_protection (uevent)
[275.616377] Starting subtest: uevent
[275.618122] Subtest uevent: SKIP (0.000s)
[275.748451] [053/133] (759s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[275.799345] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[275.800301] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[275.889302] [054/133] (758s left) gem_ctx_param (root-set)
[275.950289] Starting subtest: root-set
[275.951293] Subtest root-set: SUCCESS (0.001s)
[276.061330] [055/133] (758s left) gem_exec_schedule (implicit-boths)
[276.130407] Starting subtest: implicit-boths
[276.131329] Starting dynamic subtest: rcs0
[276.243429] Dynamic subtest rcs0: SUCCESS (0.111s)
[276.255560] Starting dynamic subtest: vcs0
[276.331129] Dynamic subtest vcs0: SUCCESS (0.088s)
[276.342236] Starting dynamic subtest: vcs1
[276.411801] Dynamic subtest vcs1: SUCCESS (0.079s)
[276.424200] Starting dynamic subtest: vecs0
[276.491746] Dynamic subtest vecs0: SUCCESS (0.080s)
[276.502623] Starting dynamic subtest: ccs0
[276.582145] Dynamic subtest ccs0: SUCCESS (0.090s)
[276.583632] Subtest implicit-boths: SUCCESS (0.451s)
[277.752496] [056/133] (757s left) syncobj_timeline (wait-zero-handles)
[277.811563] Starting subtest: wait-zero-handles
[277.812450] Subtest wait-zero-handles: SUCCESS (0.000s)
[277.921395] [057/133] (756s left) kms_properties (connector-properties-legacy)
[278.004308] Starting subtest: connector-properties-legacy
[278.005247] Starting dynamic subtest: pipe-A-eDP-1
[285.868604] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.862s)
[285.877401] Starting dynamic subtest: pipe-None-DP-1
[285.879143] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[285.887029] Starting dynamic subtest: pipe-None-HDMI-A-1
[285.888674] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[285.896469] Starting dynamic subtest: pipe-None-DP-2
[285.898254] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[285.906477] Starting dynamic subtest: pipe-None-HDMI-A-2
[285.908190] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[285.916045] Starting dynamic subtest: pipe-None-DP-3
[285.917755] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[285.928653] Starting dynamic subtest: pipe-None-DP-4
[285.930436] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[285.931311] Subtest connector-properties-legacy: SUCCESS (7.872s)
[286.771815] [058/133] (748s left) kms_chamelium_audio (hdmi-audio-edid)
[287.165433] Subtest hdmi-audio-edid: SKIP (0.000s)
[287.957480] [059/133] (747s left) kms_pm_dc (dc6-dpms)
[289.063066] Starting subtest: dc6-dpms
[291.179136] Subtest dc6-dpms: SUCCESS (2.105s)
[291.257340] [060/133] (743s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[291.342248] Starting subtest: psr2-plane-move-sf-dmg-area
[291.343330] Starting dynamic subtest: pipe-A-eDP-1
[295.885617] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.540s)
[295.894448] Starting dynamic subtest: pipe-B-eDP-1
[301.220630] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.332s)
[301.221851] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.875s)
[302.106647] [061/133] (732s left) kms_plane_cursor (viewport)
[302.210240] Starting subtest: viewport
[302.212138] Starting dynamic subtest: pipe-A-eDP-1-size-64
[304.729361] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.519s)
[304.791143] Starting dynamic subtest: pipe-A-eDP-1-size-128
[307.285030] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.505s)
[307.347821] Starting dynamic subtest: pipe-A-eDP-1-size-256
[309.852294] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[310.201222] Starting dynamic subtest: pipe-B-eDP-1-size-64
[313.461022] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.270s)
[313.523235] Starting dynamic subtest: pipe-B-eDP-1-size-128
[316.061185] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[316.124016] Starting dynamic subtest: pipe-B-eDP-1-size-256
[318.651272] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[319.006646] Starting dynamic subtest: pipe-C-eDP-1-size-64
[321.950163] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.953s)
[321.989380] Starting dynamic subtest: pipe-C-eDP-1-size-128
[324.160845] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.181s)
[324.200427] Starting dynamic subtest: pipe-C-eDP-1-size-256
[326.360686] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.170s)
[326.688575] Starting dynamic subtest: pipe-D-eDP-1-size-64
[329.517228] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.837s)
[329.556620] Starting dynamic subtest: pipe-D-eDP-1-size-128
[331.706213] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.159s)
[331.745803] Starting dynamic subtest: pipe-D-eDP-1-size-256
[333.895294] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.159s)
[334.214297] Subtest viewport: SUCCESS (32.008s)
[335.015103] [062/133] (700s left) i915_hangman (engine-engine-hang)
[335.078113] Starting subtest: engine-engine-hang
[335.079084] Starting dynamic subtest: rcs0
[336.659526] Dynamic subtest rcs0: SUCCESS (1.571s)
[336.672528] Starting dynamic subtest: bcs0
[338.643172] Dynamic subtest bcs0: SUCCESS (1.981s)
[338.654546] Starting dynamic subtest: vcs0
[340.627090] Dynamic subtest vcs0: SUCCESS (1.981s)
[340.638236] Starting dynamic subtest: vcs1
[342.675232] Dynamic subtest vcs1: SUCCESS (2.045s)
[342.690519] Starting dynamic subtest: vecs0
[344.594024] Dynamic subtest vecs0: SUCCESS (1.915s)
[344.611322] Starting dynamic subtest: ccs0
[346.642668] Dynamic subtest ccs0: SUCCESS (2.045s)
[346.644159] Subtest engine-engine-hang: SUCCESS (11.555s)
[346.748454] [063/133] (688s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[346.807660] Subtest untiled-to-tiled: SKIP (0.000s)
[346.868552] [064/133] (688s left) kms_addfb_basic (basic-x-tiled-legacy)
[346.914994] Starting subtest: basic-x-tiled-legacy
[346.916680] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[347.043413] [065/133] (688s left) gem_spin_batch (resubmit)
[347.104865] Starting subtest: resubmit
[347.105833] Starting dynamic subtest: rcs0
[347.111424] Dynamic subtest rcs0: SUCCESS (0.006s)
[347.120634] Starting dynamic subtest: bcs0
[347.121518] Dynamic subtest bcs0: SUCCESS (0.002s)
[347.129793] Starting dynamic subtest: vcs0
[347.130797] Dynamic subtest vcs0: SUCCESS (0.002s)
[347.140974] Starting dynamic subtest: vcs1
[347.141738] Dynamic subtest vcs1: SUCCESS (0.002s)
[347.149721] Starting dynamic subtest: vecs0
[347.150535] Dynamic subtest vecs0: SUCCESS (0.003s)
[347.158830] Starting dynamic subtest: ccs0
[347.159586] Dynamic subtest ccs0: SUCCESS (0.003s)
[347.160386] Subtest resubmit: SUCCESS (0.023s)
[347.366470] [066/133] (687s left) kms_dsc (dsc-with-bpc-formats)
[347.466969] Starting subtest: dsc-with-bpc-formats
[347.509220] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[347.540976] [067/133] (687s left) kms_flip (flip-vs-suspend)
[347.634745] Starting subtest: flip-vs-suspend
[347.637753] Starting dynamic subtest: A-eDP1
[380.860368] Dynamic subtest A-eDP1: SUCCESS (4.249s)
[380.877976] Starting dynamic subtest: B-eDP1
[414.876286] Dynamic subtest B-eDP1: SUCCESS (4.155s)
[414.888043] Starting dynamic subtest: C-eDP1
[448.852314] Dynamic subtest C-eDP1: SUCCESS (4.175s)
[448.864299] Starting dynamic subtest: D-eDP1
[482.857147] Dynamic subtest D-eDP1: SUCCESS (4.175s)
[482.860929] Subtest flip-vs-suspend: SUCCESS (16.766s)
[489.081145] [068/133] (551s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[489.179751] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[496.271055] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.039s)
[496.372159] [069/133] (544s left) syncobj_timeline (wait-all-snapshot)
[496.418059] Starting subtest: wait-all-snapshot
[496.500608] Subtest wait-all-snapshot: SUCCESS (0.082s)
[496.586080] [070/133] (543s left) gem_exec_balancer (individual)
[496.637821] Starting subtest: individual
[498.158125] Subtest individual: SUCCESS (1.503s)
[498.457991] [071/133] (542s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[498.556849] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[498.558798] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[498.646265] [072/133] (541s left) kms_addfb_basic (unused-offsets)
[498.705415] Starting subtest: unused-offsets
[498.706303] Subtest unused-offsets: SUCCESS (0.000s)
[498.835793] [073/133] (541s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[498.931958] Starting subtest: psr-dirtyfb-ioctl
[498.932747] Starting dynamic subtest: A-eDP-1
[502.880565] Dynamic subtest A-eDP-1: SUCCESS (3.934s)
[502.881524] Subtest psr-dirtyfb-ioctl: SUCCESS (3.935s)
[503.768801] [074/133] (536s left) gem_exec_schedule (wide)
[503.956693] Starting subtest: wide
[503.957688] Starting dynamic subtest: rcs0
[514.251710] Dynamic subtest rcs0: SUCCESS (10.241s)
[514.262966] Starting dynamic subtest: vcs0
[525.171896] Dynamic subtest vcs0: SUCCESS (10.952s)
[525.184087] Starting dynamic subtest: vcs1
[537.089040] Dynamic subtest vcs1: SUCCESS (11.916s)
[537.100128] Starting dynamic subtest: vecs0
[548.787013] Dynamic subtest vecs0: SUCCESS (11.694s)
[548.798990] Starting dynamic subtest: ccs0
[563.569895] Dynamic subtest ccs0: SUCCESS (14.740s)
[563.570966] Subtest wide: SUCCESS (59.551s)
[566.206675] [075/133] (474s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[566.307854] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[566.309759] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[566.421321] [076/133] (474s left) gen9_exec_parse (valid-registers)
[566.467699] Subtest valid-registers: SKIP (0.000s)
[566.532175] [077/133] (474s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[566.632235] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[567.667446] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.035s)
[567.786211] [078/133] (472s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[567.883856] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[568.907313] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.023s)
[569.042770] [079/133] (471s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[569.135213] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[569.136855] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[569.244765] [080/133] (471s left) kms_rotation_crc (multiplane-rotation)
[569.333026] Starting subtest: multiplane-rotation
[586.829795] Subtest multiplane-rotation: SUCCESS (17.493s)
[586.954603] [081/133] (453s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[587.059964] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[587.060969] Starting dynamic subtest: pipe-A-eDP-1
[587.161016] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[587.172237] Starting dynamic subtest: pipe-B-eDP-1
[588.348549] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s)
[588.350296] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.289s)
[589.542771] [082/133] (451s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[589.590259] Starting subtest: invalid-bsd2-flag-on-blt
[589.591280] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[589.712234] [083/133] (451s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[589.805878] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[589.807794] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[589.921280] [084/133] (451s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[590.024899] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[590.035579] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[590.109523] [085/133] (450s left) gem_render_copy (y-tiled-to-vebox-linear)
[590.160334] Starting subtest: y-tiled-to-vebox-linear
[590.162216] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[590.346057] [086/133] (450s left) gem_exec_reloc (basic-cpu)
[590.397496] Subtest basic-cpu: SKIP (0.000s)
[590.459319] [087/133] (450s left) gem_close_race (multigpu-basic-threads)
[590.519588] Starting subtest: multigpu-basic-threads
[590.521343] Subtest multigpu-basic-threads: SKIP (0.000s)
[590.738668] [088/133] (450s left) perf (polling)
[590.859720] Starting subtest: polling
[590.860675] Starting dynamic subtest: 0-rcs0
[600.943081] Dynamic subtest 0-rcs0: SUCCESS (10.040s)
[600.954281] Starting dynamic subtest: 1-vcs0
[610.965580] Dynamic subtest 1-vcs0: SUCCESS (10.021s)
[610.966730] Subtest polling: SUCCESS (20.064s)
[610.998539] [089/133] (430s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[611.092527] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[611.094114] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[611.199418] [090/133] (429s left) gem_exec_reloc (basic-write-wc)
[611.252971] Subtest basic-write-wc: SKIP (0.000s)
[611.322826] [091/133] (429s left) gem_partial_pwrite_pread (write-display)
[611.369020] Subtest write-display: SKIP (0.000s)
[611.434778] [092/133] (429s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[611.500720] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[611.572785] [093/133] (429s left) kms_cursor_crc (cursor-sliding-32x10)
[611.721358] Starting subtest: cursor-sliding-32x10
[611.767753] Subtest cursor-sliding-32x10: SKIP (0.045s)
[612.044496] [094/133] (429s left) kms_psr (fbc-psr2-dpms)
[612.131354] Starting subtest: fbc-psr2-dpms
[612.132253] Starting dynamic subtest: eDP-1
[612.133839] Dynamic subtest eDP-1: SKIP (0.000s)
[612.135449] Subtest fbc-psr2-dpms: SKIP (0.001s)
[612.202581] [095/133] (429s left) api_intel_bb (simple-bb)
[612.259678] Starting subtest: simple-bb
[612.264777] Subtest simple-bb: SUCCESS (0.006s)
[612.355371] [096/133] (429s left) gem_userptr_blits (forbidden-operations)
[612.424235] Starting subtest: forbidden-operations
[612.425961] Subtest forbidden-operations: SKIP (0.000s)
[612.566063] [097/133] (428s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[612.667116] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[620.575221] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.908s)
[620.709185] [098/133] (420s left) gem_ctx_isolation (nonpriv)
[620.762556] Starting subtest: nonpriv
[620.763581] Starting dynamic subtest: rcs0
[620.997295] Dynamic subtest rcs0: SUCCESS (0.234s)
[621.008364] Starting dynamic subtest: bcs0
[621.257498] Dynamic subtest bcs0: SUCCESS (0.259s)
[621.268466] Starting dynamic subtest: vcs0
[621.487021] Dynamic subtest vcs0: SUCCESS (0.229s)
[621.497759] Starting dynamic subtest: vcs1
[623.377240] Dynamic subtest vcs1: SUCCESS (1.889s)
[623.388467] Starting dynamic subtest: vecs0
[625.389168] Dynamic subtest vecs0: SUCCESS (2.010s)
[625.400731] Starting dynamic subtest: ccs0
[627.391998] Dynamic subtest ccs0: SUCCESS (2.002s)
[627.392956] Subtest nonpriv: SUCCESS (6.629s)
[627.627603] [099/133] (413s left) kms_plane (pixel-format-linear-modifier)
[627.714641] Starting subtest: pixel-format-linear-modifier
[627.743194] Starting dynamic subtest: pipe-A-plane-0
[631.287926] Dynamic subtest pipe-A-plane-0: SUCCESS (3.544s)
[631.298304] Starting dynamic subtest: pipe-A-plane-3
[633.043706] Dynamic subtest pipe-A-plane-3: SUCCESS (1.755s)
[633.053151] Starting dynamic subtest: pipe-A-plane-5
[633.265993] Dynamic subtest pipe-A-plane-5: SUCCESS (0.221s)
[634.358104] Starting dynamic subtest: pipe-B-plane-0
[637.938494] Dynamic subtest pipe-B-plane-0: SUCCESS (3.589s)
[637.948751] Starting dynamic subtest: pipe-B-plane-3
[639.728503] Dynamic subtest pipe-B-plane-3: SUCCESS (1.787s)
[639.746375] Starting dynamic subtest: pipe-B-plane-5
[639.939465] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[640.250429] Subtest pixel-format-linear-modifier: SUCCESS (12.534s)
[641.041879] [100/133] (400s left) gem_mmap_offset (perf)
[641.094135] Starting subtest: perf
[641.095208] Starting dynamic subtest: smem0
[641.543187] Dynamic subtest smem0: SUCCESS (0.448s)
[641.544471] Subtest perf: SUCCESS (0.449s)
[641.660197] [101/133] (399s left) kms_cursor_crc (cursor-sliding-128x128)
[641.860345] Starting subtest: cursor-sliding-128x128
[641.863711] Starting dynamic subtest: pipe-A-eDP-1
[645.111047] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.246s)
[645.148259] Starting dynamic subtest: pipe-D-eDP-1
[649.061324] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.920s)
[649.062219] Subtest cursor-sliding-128x128: SUCCESS (7.199s)
[649.907802] [102/133] (391s left) gem_softpin (invalid)
[649.955509] Starting subtest: invalid
[649.960402] Subtest invalid: SUCCESS (0.006s)
[650.083589] [103/133] (391s left) syncobj_wait (invalid-signal-bad-pad)
[650.136469] Starting subtest: invalid-signal-bad-pad
[650.137552] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[650.238318] [104/133] (391s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[650.365833] Starting subtest: flip-vs-cursor-atomic-transitions
[658.389095] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (8.021s)
[659.253712] [105/133] (382s left) i915_pm_rc6_residency (rc6-idle)
[659.309180] Starting subtest: rc6-idle
[659.343996] Starting dynamic subtest: gt0-rcs0
[683.633623] Dynamic subtest gt0-rcs0: SUCCESS (24.283s)
[683.645146] Starting dynamic subtest: gt0-bcs0
[707.999466] Dynamic subtest gt0-bcs0: SUCCESS (24.357s)
[708.013617] Starting dynamic subtest: gt0-ccs0
[732.267160] Dynamic subtest gt0-ccs0: SUCCESS (24.269s)
[732.278487] Starting dynamic subtest: gt1-vcs0
[738.437676] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[738.451652] Starting dynamic subtest: gt1-vecs0
[744.620476] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[744.621930] Subtest rc6-idle: SUCCESS (85.296s)
[744.705088] [106/133] (297s left) gem_busy (extended)
[744.885213] Starting subtest: extended
[744.886281] Starting dynamic subtest: rcs0
[744.963268] Dynamic subtest rcs0: SUCCESS (0.082s)
[744.976531] Starting dynamic subtest: bcs0
[745.008741] Dynamic subtest bcs0: SUCCESS (0.044s)
[745.021029] Starting dynamic subtest: vcs0
[746.094134] Dynamic subtest vcs0: SUCCESS (1.073s)
[746.104807] Starting dynamic subtest: vcs1
[748.142484] Dynamic subtest vcs1: SUCCESS (2.045s)
[748.153884] Starting dynamic subtest: vecs0
[750.127207] Dynamic subtest vecs0: SUCCESS (1.982s)
[750.136947] Starting dynamic subtest: ccs0
[750.163803] Dynamic subtest ccs0: SUCCESS (0.044s)
[750.167390] Subtest extended: SUCCESS (5.285s)
[750.410274] [107/133] (291s left) gem_ctx_persistence (heartbeat-many)
[750.477649] Starting subtest: heartbeat-many
[750.479375] Subtest heartbeat-many: SKIP (0.000s)
[750.573208] [108/133] (291s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[750.662735] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[750.664384] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[750.752004] [109/133] (291s left) kms_sequence (queue-busy)
[750.843094] Starting subtest: queue-busy
[750.843855] Starting dynamic subtest: pipe-A-eDP-1
[752.778643] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[752.789097] Starting dynamic subtest: pipe-B-eDP-1
[755.347477] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.567s)
[755.356368] Starting dynamic subtest: pipe-C-eDP-1
[757.948373] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[757.957198] Starting dynamic subtest: pipe-D-eDP-1
[760.484513] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[760.485523] Subtest queue-busy: SUCCESS (9.642s)
[761.275643] [110/133] (280s left) gem_pxp (create-regular-context-1)
[761.387223] Starting subtest: create-regular-context-1
[761.388923] Subtest create-regular-context-1: SUCCESS (0.002s)
[761.504363] [111/133] (280s left) gem_userptr_blits (process-exit)
[761.579022] Starting subtest: process-exit
[761.586030] Subtest process-exit: SUCCESS (0.009s)
[761.695361] [112/133] (280s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[761.786052] Starting subtest: psr-farfromfence-mmap-gtt
[761.787853] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[761.924380] [113/133] (280s left) gen9_exec_parse (bb-start-out)
[761.983045] Subtest bb-start-out: SKIP (0.000s)
[762.059837] [114/133] (280s left) prime_busy (after-wait)
[762.110418] Starting subtest: after-wait
[762.114321] Starting dynamic subtest: rcs0
[762.139872] Dynamic subtest rcs0: SUCCESS (0.026s)
[762.150674] Starting dynamic subtest: bcs0
[762.179819] Dynamic subtest bcs0: SUCCESS (0.039s)
[762.193006] Starting dynamic subtest: vcs0
[762.220283] Dynamic subtest vcs0: SUCCESS (0.038s)
[762.231400] Starting dynamic subtest: vcs1
[762.261325] Dynamic subtest vcs1: SUCCESS (0.040s)
[762.270291] Starting dynamic subtest: vecs0
[762.302834] Dynamic subtest vecs0: SUCCESS (0.041s)
[762.313417] Starting dynamic subtest: ccs0
[762.342916] Dynamic subtest ccs0: SUCCESS (0.039s)
[762.450424] Subtest after-wait: SUCCESS (0.339s)
[762.521249] [115/133] (279s left) kms_addfb_basic (bad-pitch-63)
[762.569625] Starting subtest: bad-pitch-63
[762.570463] Subtest bad-pitch-63: SUCCESS (0.000s)
[762.691362] [116/133] (279s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[762.791438] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[762.793132] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[762.881817] [117/133] (279s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[762.981238] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[762.982190] Starting dynamic subtest: pipe-A-eDP-1
[762.989808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[762.998831] Starting dynamic subtest: pipe-B-eDP-1
[763.006577] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[763.015453] Starting dynamic subtest: pipe-C-eDP-1
[763.022971] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[763.031701] Starting dynamic subtest: pipe-D-eDP-1
[763.038927] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[763.039701] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[765.249716] [118/133] (276s left) kms_chamelium_frames (hdmi-aspect-ratio)
[765.641462] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[766.453124] [119/133] (275s left) gem_ctx_sseu (invalid-args)
[766.514845] Subtest invalid-args: SKIP (0.000s)
[766.573897] [120/133] (275s left) kms_vblank (query-idle)
[766.671382] Starting subtest: query-idle
[766.672271] Starting dynamic subtest: pipe-A-eDP-1
[768.412140] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.740s)
[768.422854] Starting dynamic subtest: pipe-D-eDP-1
[770.814799] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.400s)
[770.816119] Subtest query-idle: SUCCESS (4.144s)
[771.633234] [121/133] (270s left) kms_plane_scaling (planes-downscale-factor-0-75)
[771.724326] Starting subtest: planes-downscale-factor-0-75
[771.725224] Starting dynamic subtest: pipe-A
[771.744668] Dynamic subtest pipe-A: SKIP (0.019s)
[771.753686] Starting dynamic subtest: pipe-B
[771.777468] Dynamic subtest pipe-B: SKIP (0.032s)
[771.786205] Starting dynamic subtest: pipe-C
[771.810875] Dynamic subtest pipe-C: SKIP (0.033s)
[771.819591] Starting dynamic subtest: pipe-D
[771.846673] Dynamic subtest pipe-D: SKIP (0.033s)
[771.848369] Subtest planes-downscale-factor-0-75: SKIP (0.120s)
[771.952474] [122/133] (270s left) gem_exec_schedule (smoketest-all)
[772.008817] Starting subtest: smoketest-all
[804.365538] Subtest smoketest-all: SUCCESS (32.328s)
[805.204313] [123/133] (237s left) kms_invalid_mode (int-max-clock)
[805.294806] Starting subtest: int-max-clock
[805.295762] Starting dynamic subtest: pipe-A-eDP-1
[805.581439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[805.592148] Starting dynamic subtest: pipe-B-eDP-1
[805.593041] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[805.601409] Starting dynamic subtest: pipe-C-eDP-1
[805.602443] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[805.611074] Starting dynamic subtest: pipe-D-eDP-1
[805.611909] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[805.612742] Subtest int-max-clock: SUCCESS (0.292s)
[806.384012] [124/133] (236s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[806.486265] Starting subtest: yf-tiled-8bpp-rotate-90
[806.488097] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[806.591483] [125/133] (235s left) kms_psr (fbc-psr-primary-page-flip)
[806.681448] Starting subtest: fbc-psr-primary-page-flip
[806.682473] Starting dynamic subtest: eDP-1
[806.684237] Dynamic subtest eDP-1: SKIP (0.000s)
[806.685873] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[806.751785] [126/133] (235s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[806.837506] Starting subtest: disable-crc-after-crtc
[806.838489] Starting dynamic subtest: pipe-A-eDP-1
[808.545659] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.709s)
[808.559653] Starting dynamic subtest: pipe-B-eDP-1
[810.910931] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.364s)
[810.921113] Starting dynamic subtest: pipe-C-eDP-1
[813.155878] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s)
[813.165213] Starting dynamic subtest: pipe-D-eDP-1
[815.426110] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.270s)
[815.427040] Subtest disable-crc-after-crtc: SUCCESS (8.590s)
[816.263279] [127/133] (226s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[816.315980] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[816.316832] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[816.408981] [128/133] (226s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[816.496999] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[816.497938] Starting dynamic subtest: pipe-A-default-mode
[817.620975] Dynamic subtest pipe-A-default-mode: SKIP (1.122s)
[817.622692] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.123s)
[817.753705] [129/133] (224s left) gem_exec_schedule (u-fairslice)
[817.817659] Starting subtest: u-fairslice
[817.819077] Starting dynamic subtest: rcs0
[819.843024] Dynamic subtest rcs0: SUCCESS (2.018s)
[819.853939] Starting dynamic subtest: bcs0
[821.860257] Dynamic subtest bcs0: SUCCESS (2.016s)
[821.871761] Starting dynamic subtest: vcs0
[823.877484] Dynamic subtest vcs0: SUCCESS (2.016s)
[823.888151] Starting dynamic subtest: vcs1
[825.895262] Dynamic subtest vcs1: SUCCESS (2.017s)
[825.906134] Starting dynamic subtest: vecs0
[827.912904] Dynamic subtest vecs0: SUCCESS (2.016s)
[827.922924] Starting dynamic subtest: ccs0
[829.932258] Dynamic subtest ccs0: SUCCESS (2.020s)
[829.933251] Subtest u-fairslice: SUCCESS (12.109s)
[830.225796] [130/133] (212s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[830.623498] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[831.406661] [131/133] (211s left) gem_exec_parallel (contexts)
[831.474711] Starting subtest: contexts
[831.475677] Starting dynamic subtest: rcs0
[834.284177] Dynamic subtest rcs0: SUCCESS (2.801s)
[834.296738] Starting dynamic subtest: bcs0
[837.550352] Dynamic subtest bcs0: SUCCESS (3.263s)
[837.560558] Starting dynamic subtest: vcs0
[841.532429] Dynamic subtest vcs0: SUCCESS (3.978s)
[841.543858] Starting dynamic subtest: vcs1
[845.617234] Dynamic subtest vcs1: SUCCESS (4.081s)
[845.629589] Starting dynamic subtest: vecs0
[849.607812] Dynamic subtest vecs0: SUCCESS (3.989s)
[849.620027] Starting dynamic subtest: ccs0
[853.515430] Dynamic subtest ccs0: SUCCESS (3.905s)
[853.516473] Subtest contexts: SUCCESS (22.031s)
[853.689682] [132/133] (189s left) gem_tiled_blits (basic)
[853.743650] Subtest basic: SKIP (0.000s)
[853.806334] [133/133] (188s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[853.893916] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[853.894785] Starting dynamic subtest: pipe-A
[854.295398] Dynamic subtest pipe-A: SUCCESS (0.401s)
[854.305627] Starting dynamic subtest: pipe-B
[855.715830] Dynamic subtest pipe-B: SUCCESS (1.418s)
[855.726314] Starting dynamic subtest: pipe-C
[857.207151] Dynamic subtest pipe-C: SUCCESS (1.490s)
[857.218329] Starting dynamic subtest: pipe-D
[858.605148] Dynamic subtest pipe-D: SUCCESS (1.397s)
[858.606083] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.711s)
[859.751822] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_legacy_colorkey
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: kms_atomic_transition
results: parsing output: 11/ for test: kms_properties
results: parsing output: 12/ for test: gem_lmem_swapping
results: parsing output: 13/ for test: dmabuf
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: syncobj_eventfd
results: parsing output: 22/ for test: prime_udl
results: parsing output: 23/ for test: gem_caching
results: parsing output: 24/ for test: gem_madvise
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: i915_suspend
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_mmap_wc
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_color_pipeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: kms_rotation_crc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_properties
results: parsing output: 57/ for test: kms_chamelium_audio
results: parsing output: 58/ for test: kms_pm_dc
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_plane_cursor
results: parsing output: 61/ for test: i915_hangman
results: parsing output: 62/ for test: gem_set_tiling_vs_blt
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gem_spin_batch
results: parsing output: 65/ for test: kms_dsc
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_dirtyfb
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: gem_close_race
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: gem_partial_pwrite_pread
results: parsing output: 91/ for test: gem_fenced_exec_thrash
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_ctx_isolation
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: gem_mmap_offset
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: i915_pm_rc6_residency
results: parsing output: 105/ for test: gem_busy
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_sequence
results: parsing output: 109/ for test: gem_pxp
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: prime_busy
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_chamelium_frames
results: parsing output: 118/ for test: gem_ctx_sseu
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: gem_exec_parallel
results: parsing output: 131/ for test: gem_tiled_blits
results: parsing output: 132/ for test: kms_plane_scaling
Done.