[56.499973] Initializing watchdogs
[56.500068]   /dev/watchdog0
[56.514946] [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]
[56.519764] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.522497] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.526126] [001/156] (960s left) gem_exec_balancer (full-late)
[56.614605] Starting subtest: full-late
[61.193410] Subtest full-late: SUCCESS (4.580s)
[61.514121] [002/156] (955s left) vgem_basic (dmabuf-export)
[61.576863] Starting subtest: dmabuf-export
[61.617890] Subtest dmabuf-export: SUCCESS (0.042s)
[61.700982] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[61.704115] [003/156] (955s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[61.797346] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[61.802029] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[61.881876] [004/156] (955s left) kms_addfb_basic (too-high)
[61.971948] Starting subtest: too-high
[61.974324] Subtest too-high: SUCCESS (0.001s)
[62.082969] [005/156] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[62.178295] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[62.182210] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[62.287203] [006/156] (954s left) perf_pmu (interrupts)
[62.327195] Starting subtest: interrupts
[63.389546] Subtest interrupts: SUCCESS (1.062s)
[63.523085] [007/156] (953s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[63.628200] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[63.632103] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[63.720263] [008/156] (953s left) gem_exec_async (forked-writes)
[63.781782] Starting subtest: forked-writes
[63.783673] Starting dynamic subtest: rcs0
[63.810107] Dynamic subtest rcs0: SUCCESS (0.031s)
[63.821252] Starting dynamic subtest: bcs0
[63.836439] Dynamic subtest bcs0: SUCCESS (0.026s)
[63.845336] Starting dynamic subtest: vcs0
[63.859622] Dynamic subtest vcs0: SUCCESS (0.023s)
[63.868839] Starting dynamic subtest: vcs1
[63.883458] Dynamic subtest vcs1: SUCCESS (0.024s)
[63.893977] Starting dynamic subtest: vecs0
[63.907353] Dynamic subtest vecs0: SUCCESS (0.024s)
[63.916413] Starting dynamic subtest: ccs0
[63.930667] Dynamic subtest ccs0: SUCCESS (0.023s)
[63.933033] Subtest forked-writes: SUCCESS (0.152s)
[64.183415] [009/156] (953s left) syncobj_timeline (reset-during-wait-for-submit)
[64.240955] Starting subtest: reset-during-wait-for-submit
[64.346469] Subtest reset-during-wait-for-submit: SUCCESS (0.105s)
[64.440021] [010/156] (952s left) kms_cursor_edge_walk (128x128-top-edge)
[64.542763] Starting subtest: 128x128-top-edge
[64.545077] Starting dynamic subtest: pipe-A-eDP-1
[68.011181] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[68.021164] Starting dynamic subtest: pipe-D-eDP-1
[71.218526] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.207s)
[71.220787] Subtest 128x128-top-edge: SUCCESS (6.676s)
[72.033639] [011/156] (945s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[72.136326] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[72.140571] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[72.214775] [012/156] (945s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[72.337011] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[79.688199] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.357s)
[79.812216] [013/156] (937s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[79.917364] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[79.921343] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[79.999212] [014/156] (937s left) kms_chamelium_frames (dp-crc-multiple)
[80.391038] Subtest dp-crc-multiple: SKIP (0.000s)
[81.186987] [015/156] (936s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-plflip-blt)
[81.294595] Starting subtest: psrhdr-1p-primscrn-indfb-plflip-blt
[81.299250] Subtest psrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[81.410212] [016/156] (936s left) kms_psr (fbc-pr-cursor-plane-move)
[81.506545] Starting subtest: fbc-pr-cursor-plane-move
[81.510618] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[81.589811] [017/156] (936s left) i915_pm_rps (min-max-config-loaded)
[81.647821] Starting subtest: min-max-config-loaded
[81.652236] Subtest min-max-config-loaded: SKIP (0.001s)
[81.767048] [018/156] (935s left) kms_psr (psr-cursor-plane-move)
[81.861979] Starting subtest: psr-cursor-plane-move
[81.864458] Starting dynamic subtest: eDP-1
[83.610861] Dynamic subtest eDP-1: SUCCESS (1.748s)
[83.613240] Subtest psr-cursor-plane-move: SUCCESS (1.749s)
[84.481342] [019/156] (933s left) kms_flip (flip-vs-fences-interruptible)
[84.579052] Starting subtest: flip-vs-fences-interruptible
[84.583667] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[84.684055] [020/156] (933s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[84.787046] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[84.791442] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[84.887630] [021/156] (932s left) gen3_render_mixed_blits
[85.015263] [022/156] (932s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[85.130471] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[85.134936] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[85.240348] [023/156] (932s left) gem_exec_reloc (basic-cpu-wc-active)
[85.311083] Subtest basic-cpu-wc-active: SKIP (0.000s)
[85.380482] [024/156] (932s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[85.476072] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[89.928420] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.457s)
[91.089818] [025/156] (926s left) gem_exec_fence (long-history)
[91.510878] Starting subtest: long-history
[99.083385] Subtest long-history: SUCCESS (7.573s)
[99.519600] [026/156] (918s left) syncobj_wait (invalid-signal-one-illegal-handle)
[99.577953] Starting subtest: invalid-signal-one-illegal-handle
[99.580266] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[99.685386] [027/156] (918s left) gem_mmap_wc (read)
[99.736305] Subtest read: SKIP (0.000s)
[99.790650] [028/156] (918s left) kms_joiner (basic-ultra-joiner)
[99.888692] Starting subtest: basic-ultra-joiner
[99.893244] Subtest basic-ultra-joiner: SKIP (0.000s)
[99.952895] [029/156] (918s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[100.047745] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[105.470224] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.425s)
[106.694098] [030/156] (911s left) gem_userptr_blits (dmabuf-unsync)
[106.755679] Subtest dmabuf-unsync: SKIP (0.000s)
[106.884204] [031/156] (911s left) gem_exec_capture (capture-recoverable)
[106.939230] Starting subtest: capture-recoverable
[106.941212] Subtest capture-recoverable: SUCCESS (0.003s)
[107.061783] [032/156] (911s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[107.177112] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[107.181192] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[107.270672] [033/156] (911s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[107.360034] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[107.362444] Starting dynamic subtest: pipe-A-eDP-1
[140.788113] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.581s)
[140.799780] Starting dynamic subtest: pipe-B-eDP-1
[175.738951] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.529s)
[175.749425] Starting dynamic subtest: pipe-C-eDP-1
[210.713976] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.515s)
[210.725238] Starting dynamic subtest: pipe-D-eDP-1
[245.718771] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.433s)
[245.721146] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (18.062s)
[255.957795] [034/156] (771s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[256.069552] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[256.073936] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[256.142073] [035/156] (771s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[256.237842] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[256.239830] Starting dynamic subtest: pipe-A-eDP-1
[256.259917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[256.273165] Starting dynamic subtest: pipe-B-eDP-1
[256.292637] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[256.302611] Starting dynamic subtest: pipe-C-eDP-1
[256.322152] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[256.331657] Starting dynamic subtest: pipe-D-eDP-1
[256.352345] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[256.354525] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[258.612766] [036/156] (768s left) perf (gen12-group-exclusive-stream-sample-oa)
[258.746540] Starting subtest: gen12-group-exclusive-stream-sample-oa
[258.768544] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.023s)
[258.822183] [037/156] (768s left) api_intel_bb (blit-reloc-purge-cache)
[258.873033] Starting subtest: blit-reloc-purge-cache
[258.877186] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[258.999182] [038/156] (768s left) gem_mmap_wc (close)
[259.048405] Subtest close: SKIP (0.000s)
[259.119157] [039/156] (768s left) kms_cursor_crc (cursor-onscreen-32x10)
[259.285053] Starting subtest: cursor-onscreen-32x10
[259.332831] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[259.594538] [040/156] (768s left) perf_pmu (pmu-read)
[259.632343] Starting subtest: pmu-read
[259.633941] Subtest pmu-read: SUCCESS (0.003s)
[259.741580] [041/156] (767s left) kms_cursor_legacy (forked-move)
[259.857293] Starting subtest: forked-move
[259.859327] Starting dynamic subtest: pipe-A
[265.330635] Dynamic subtest pipe-A: SUCCESS (5.467s)
[265.345079] Starting dynamic subtest: pipe-B
[270.812634] Dynamic subtest pipe-B: SUCCESS (5.478s)
[270.834170] Starting dynamic subtest: pipe-C
[276.284685] Dynamic subtest pipe-C: SUCCESS (5.469s)
[276.304094] Starting dynamic subtest: pipe-D
[281.762868] Dynamic subtest pipe-D: SUCCESS (5.477s)
[281.776437] Starting dynamic subtest: all-pipes
[287.282667] Dynamic subtest all-pipes: SUCCESS (5.518s)
[287.285136] Subtest forked-move: SUCCESS (27.416s)
[287.434094] [042/156] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[287.544984] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[287.549036] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[287.654911] [043/156] (740s left) gem_bad_reloc (negative-reloc-lut)
[287.707058] Subtest negative-reloc-lut: SKIP (0.000s)
[287.783173] [044/156] (740s left) perf (invalid-oa-exponent)
[287.864069] Starting subtest: invalid-oa-exponent
[287.873365] Subtest invalid-oa-exponent: SUCCESS (0.011s)
[287.914205] [045/156] (739s left) kms_properties (invalid-properties-atomic)
[287.996935] Starting subtest: invalid-properties-atomic
[288.304229] Subtest invalid-properties-atomic: SUCCESS (0.307s)
[288.378071] [046/156] (739s left) gem_exec_params (cliprects_ptr-dirt)
[288.435861] Starting subtest: cliprects_ptr-dirt
[288.438188] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[288.529829] [047/156] (739s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[288.621293] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[288.623582] Starting dynamic subtest: pipe-A-default-mode
[291.376296] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s)
[291.378283] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.756s)
[292.212732] [048/156] (735s left) kms_pm_rpm (legacy-planes)
[293.746112] Starting subtest: legacy-planes
[293.748528] Starting dynamic subtest: plane-65
[302.161722] Dynamic subtest plane-65: SUCCESS (8.415s)
[302.173568] Starting dynamic subtest: plane-95
[310.547508] Dynamic subtest plane-95: SUCCESS (8.384s)
[310.559730] Starting dynamic subtest: plane-125
[318.862076] Dynamic subtest plane-125: SUCCESS (8.312s)
[318.875786] Starting dynamic subtest: plane-135
[327.252397] Dynamic subtest plane-135: SUCCESS (8.388s)
[327.254835] Subtest legacy-planes: SUCCESS (33.506s)
[327.665348] [049/156] (700s left) kms_psr (pr-primary-page-flip)
[327.767571] Starting subtest: pr-primary-page-flip
[327.771976] Subtest pr-primary-page-flip: SKIP (0.000s)
[327.854319] [050/156] (700s left) kms_psr (fbc-psr-basic)
[327.948608] Starting subtest: fbc-psr-basic
[327.950854] Starting dynamic subtest: eDP-1
[327.954860] Dynamic subtest eDP-1: SKIP (0.000s)
[327.959405] Subtest fbc-psr-basic: SKIP (0.001s)
[328.023081] [051/156] (700s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[328.126538] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[328.130544] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[328.229932] [052/156] (699s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[328.326237] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[328.330480] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[328.428080] [053/156] (699s left) kms_flip (2x-flip-vs-panning)
[328.520005] Starting subtest: 2x-flip-vs-panning
[328.534079] Subtest 2x-flip-vs-panning: SKIP (0.012s)
[328.636849] [054/156] (699s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[328.692115] Starting subtest: saturated-hostile-nopreempt
[328.693626] Starting dynamic subtest: rcs0
[328.757017] Dynamic subtest rcs0: SKIP (0.065s)
[328.768756] Starting dynamic subtest: bcs0
[328.783753] Dynamic subtest bcs0: SKIP (0.025s)
[328.793390] Starting dynamic subtest: vcs0
[328.799182] Dynamic subtest vcs0: SKIP (0.013s)
[328.808539] Starting dynamic subtest: vcs1
[328.818134] Dynamic subtest vcs1: SKIP (0.018s)
[328.827597] Starting dynamic subtest: vecs0
[328.839704] Dynamic subtest vecs0: SKIP (0.021s)
[328.849123] Starting dynamic subtest: ccs0
[328.862742] Dynamic subtest ccs0: SKIP (0.022s)
[328.866468] Subtest saturated-hostile-nopreempt: SKIP (0.172s)
[328.940779] [055/156] (699s left) gem_softpin (noreloc-interruptible)
[328.993213] Starting subtest: noreloc-interruptible
[334.424507] Subtest noreloc-interruptible: SUCCESS (5.429s)
[334.559999] [056/156] (693s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[334.656684] Starting subtest: psr-rgb565-draw-render
[341.780965] Subtest psr-rgb565-draw-render: SUCCESS (7.130s)
[341.905629] [057/156] (686s left) gem_userptr_blits (relocations)
[341.975644] Starting subtest: relocations
[341.979965] Subtest relocations: SKIP (0.001s)
[342.113972] [058/156] (686s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[342.221377] Starting subtest: fbcpsr-rgb101010-draw-render
[346.960966] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.745s)
[347.086468] [059/156] (681s left) api_intel_bb (simple-bb-ctx)
[347.142123] Starting subtest: simple-bb-ctx
[347.150741] Subtest simple-bb-ctx: SUCCESS (0.010s)
[347.272643] [060/156] (681s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[347.384370] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[347.388365] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[347.482256] [061/156] (681s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[347.578698] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[347.582875] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[347.680198] [062/156] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[347.777709] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[352.370398] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.597s)
[353.723705] [063/156] (674s left) syncobj_timeline (wait-all-delayed-signal)
[353.789418] Starting subtest: wait-all-delayed-signal
[353.894271] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[353.977029] [064/156] (674s left) gem_ctx_isolation (nonpriv-switch)
[354.037830] Starting subtest: nonpriv-switch
[354.040077] Starting dynamic subtest: rcs0
[354.339465] Dynamic subtest rcs0: SUCCESS (0.301s)
[354.351916] Starting dynamic subtest: bcs0
[354.646799] Dynamic subtest bcs0: SUCCESS (0.306s)
[354.657093] Starting dynamic subtest: vcs0
[354.943347] Dynamic subtest vcs0: SUCCESS (0.296s)
[354.958295] Starting dynamic subtest: vcs1
[356.920574] Dynamic subtest vcs1: SUCCESS (1.976s)
[356.930668] Starting dynamic subtest: vecs0
[358.897716] Dynamic subtest vecs0: SUCCESS (1.976s)
[358.907855] Starting dynamic subtest: ccs0
[360.986693] Dynamic subtest ccs0: SUCCESS (2.088s)
[360.988922] Subtest nonpriv-switch: SUCCESS (6.949s)
[361.244886] [065/156] (667s left) gem_exec_schedule (u-fairslice)
[361.308548] Starting subtest: u-fairslice
[361.310624] Starting dynamic subtest: rcs0
[363.340260] Dynamic subtest rcs0: SUCCESS (2.036s)
[363.350305] Starting dynamic subtest: bcs0
[365.367319] Dynamic subtest bcs0: SUCCESS (2.023s)
[365.377611] Starting dynamic subtest: vcs0
[367.390694] Dynamic subtest vcs0: SUCCESS (2.023s)
[367.400376] Starting dynamic subtest: vcs1
[369.408053] Dynamic subtest vcs1: SUCCESS (2.019s)
[369.418286] Starting dynamic subtest: vecs0
[371.427881] Dynamic subtest vecs0: SUCCESS (2.018s)
[371.437719] Starting dynamic subtest: ccs0
[373.446968] Dynamic subtest ccs0: SUCCESS (2.019s)
[373.449361] Subtest u-fairslice: SUCCESS (12.143s)
[373.750827] [066/156] (655s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[373.866323] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[381.252257] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.395s)
[381.399120] [067/156] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[381.502110] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[381.506309] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[381.611416] [068/156] (647s left) kms_sequence (queue-busy)
[381.702729] Starting subtest: queue-busy
[381.705156] Starting dynamic subtest: pipe-A-eDP-1
[383.644098] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[383.654316] Starting dynamic subtest: pipe-B-eDP-1
[386.263734] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.618s)
[386.275075] Starting dynamic subtest: pipe-C-eDP-1
[388.878038] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[388.888462] Starting dynamic subtest: pipe-D-eDP-1
[391.480077] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.599s)
[391.482268] Subtest queue-busy: SUCCESS (9.776s)
[392.368339] [069/156] (636s left) gem_create (create-ext-placement-all)
[392.524036] Starting subtest: create-ext-placement-all
[392.526882] Subtest create-ext-placement-all: SUCCESS (0.000s)
[392.624612] [070/156] (636s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render)
[392.720434] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render
[392.724869] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[392.840054] [071/156] (636s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[392.928914] Starting subtest: stress-xrgb8888-ytiled
[392.933424] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[393.004094] [072/156] (636s left) gem_render_copy (linear-to-vebox-y-tiled)
[393.070567] Starting subtest: linear-to-vebox-y-tiled
[393.074990] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[393.268152] [073/156] (635s left) gem_unref_active_buffers
[393.489204] [074/156] (635s left) kms_vrr (flip-dpms)
[393.587158] Starting subtest: flip-dpms
[393.593065] Subtest flip-dpms: SKIP (0.000s)
[393.660871] [075/156] (635s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[393.759968] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[393.763929] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[393.861651] [076/156] (635s left) kms_psr (fbc-pr-sprite-plane-move)
[393.950095] Starting subtest: fbc-pr-sprite-plane-move
[393.954101] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[394.048436] [077/156] (635s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[394.159043] Starting subtest: cursorB-vs-flipA-toggle
[394.163410] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[394.305426] [078/156] (635s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[394.399822] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[394.401712] Starting dynamic subtest: pipe-A-eDP-1
[394.422439] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[394.433344] Starting dynamic subtest: pipe-B-eDP-1
[394.453047] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[394.462617] Starting dynamic subtest: pipe-C-eDP-1
[394.481987] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[394.491249] Starting dynamic subtest: pipe-D-eDP-1
[394.512243] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[394.515648] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[396.741104] [079/156] (632s left) i915_drm_fdinfo (virtual-busy-hang)
[396.781944] Starting subtest: virtual-busy-hang
[396.786487] Subtest virtual-busy-hang: SKIP (0.000s)
[396.909382] [080/156] (632s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[397.003465] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[397.007597] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[397.091365] [081/156] (632s left) kms_pm_rpm (modeset-non-lpsp)
[398.715307] Starting subtest: modeset-non-lpsp
[399.870460] Subtest modeset-non-lpsp: SKIP (1.154s)
[400.256083] [082/156] (629s left) gen9_exec_parse (batch-invalid-length)
[400.323068] Subtest batch-invalid-length: SKIP (0.000s)
[400.400903] [083/156] (629s left) drm_read (invalid-buffer)
[400.549901] Starting subtest: invalid-buffer
[400.552155] Subtest invalid-buffer: SUCCESS (0.000s)
[400.666650] [084/156] (628s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[400.763853] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[400.767928] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[400.859808] [085/156] (628s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[400.962173] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[400.966554] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[401.069996] [086/156] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[401.171922] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[401.175174] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[401.264998] [087/156] (628s left) kms_flip (flip-vs-suspend-interruptible)
[401.365302] Starting subtest: flip-vs-suspend-interruptible
[401.367284] Starting dynamic subtest: A-eDP1
[514.546620] Dynamic subtest A-eDP1: SUCCESS (11.696s)
[514.549108] Subtest flip-vs-suspend-interruptible: SUCCESS (11.699s)
[525.692584] [088/156] (515s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[525.801911] Starting subtest: yf-tiled-32bpp-rotate-0
[525.806847] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[525.893592] [089/156] (514s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[525.979765] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[525.982480] Starting dynamic subtest: pipe-A
[527.163596] Dynamic subtest pipe-A: SUCCESS (1.184s)
[527.173794] Starting dynamic subtest: pipe-B
[529.466691] Dynamic subtest pipe-B: SUCCESS (2.301s)
[529.477471] Starting dynamic subtest: pipe-C
[530.628959] Dynamic subtest pipe-C: SUCCESS (1.159s)
[530.639069] Starting dynamic subtest: pipe-D
[531.860723] Dynamic subtest pipe-D: SUCCESS (1.230s)
[531.863323] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.878s)
[533.055336] [090/156] (507s left) gem_exec_whisper (basic-queues-priority-all)
[533.120934] Starting subtest: basic-queues-priority-all
[555.392075] Subtest basic-queues-priority-all: SUCCESS (22.257s)
[555.579285] [091/156] (485s left) gem_spin_batch (spin-each)
[555.638802] Starting subtest: spin-each
[559.015993] Subtest spin-each: SUCCESS (3.376s)
[559.251828] [092/156] (481s left) intel_hwmon (hwmon-read)
[559.305079] Subtest hwmon-read: SKIP (0.000s)
[559.365939] [093/156] (481s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[559.642378] Starting subtest: cursor-rapid-movement-512x512
[559.647072] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[559.804153] [094/156] (481s left) kms_concurrent (multi-plane-atomic-lowres)
[559.889685] Starting subtest: multi-plane-atomic-lowres
[559.891596] Starting dynamic subtest: pipe-A-eDP-1
[560.409808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.518s)
[560.421814] Starting dynamic subtest: pipe-B-eDP-1
[561.708616] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.298s)
[561.721316] Starting dynamic subtest: pipe-C-eDP-1
[562.941566] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[562.954900] Starting dynamic subtest: pipe-D-eDP-1
[564.187968] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[564.190860] Subtest multi-plane-atomic-lowres: SUCCESS (4.300s)
[565.007872] [095/156] (476s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[565.111874] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[565.116991] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[565.226352] [096/156] (475s left) gem_ctx_param (non-root-set)
[565.275160] Starting subtest: non-root-set
[565.303354] Subtest non-root-set: SUCCESS (0.028s)
[565.392842] [097/156] (475s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[565.490541] Starting subtest: hdr-rgb565-draw-pwrite
[565.495165] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[565.592672] [098/156] (475s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[565.687421] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[565.692041] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[565.782959] [099/156] (475s left) i915_hangman (engine-engine-error)
[565.864056] Starting subtest: engine-engine-error
[565.866463] Starting dynamic subtest: rcs0
[567.060369] Dynamic subtest rcs0: SUCCESS (1.197s)
[567.072285] Starting dynamic subtest: bcs0
[569.044210] Dynamic subtest bcs0: SUCCESS (1.981s)
[569.057845] Starting dynamic subtest: vcs0
[571.091168] Dynamic subtest vcs0: SUCCESS (2.044s)
[571.104434] Starting dynamic subtest: vcs1
[573.075897] Dynamic subtest vcs1: SUCCESS (1.982s)
[573.093358] Starting dynamic subtest: vecs0
[575.059034] Dynamic subtest vecs0: SUCCESS (1.980s)
[575.076540] Starting dynamic subtest: ccs0
[577.107404] Dynamic subtest ccs0: SUCCESS (2.045s)
[577.110060] Subtest engine-engine-error: SUCCESS (11.245s)
[577.195340] [100/156] (464s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[577.293245] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[577.295670] Starting dynamic subtest: pipe-A-eDP-1
[593.801990] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.507s)
[593.812770] Starting dynamic subtest: pipe-B-eDP-1
[610.992050] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.186s)
[610.994859] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.696s)
[611.894102] [101/156] (429s left) perf (oa-exponents)
[612.000318] Starting subtest: oa-exponents
[612.002850] Starting dynamic subtest: 0-rcs0
[613.782090] Dynamic subtest 0-rcs0: SUCCESS (1.779s)
[613.793532] Starting dynamic subtest: 1-vecs0
[615.611129] Dynamic subtest 1-vecs0: SUCCESS (1.828s)
[615.613942] Subtest oa-exponents: SUCCESS (3.609s)
[615.664078] [102/156] (425s left) kms_atomic_transition (modeset-transition)
[615.750631] Starting subtest: modeset-transition
[615.752767] Starting dynamic subtest: 1x-outputs
[626.877180] Dynamic subtest 1x-outputs: SUCCESS (11.125s)
[626.879876] Subtest modeset-transition: SUCCESS (11.127s)
[627.743592] [103/156] (413s left) gem_mmap_gtt (big-bo-tiledx)
[627.794642] Subtest big-bo-tiledX: SKIP (0.000s)
[627.854857] [104/156] (413s left) kms_selftest (drm_format)
[627.895068] Starting subtest: drm_format
[627.912801] Starting dynamic subtest: drm_test_format_block_width_invalid
[628.003431] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.090s)
[628.015221] Starting dynamic subtest: drm_test_format_block_width_one_plane
[628.096539] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.091s)
[628.118142] Starting dynamic subtest: drm_test_format_block_width_two_plane
[628.178059] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.080s)
[628.194704] Starting dynamic subtest: drm_test_format_block_width_three_plane
[628.271629] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.094s)
[628.282997] Starting dynamic subtest: drm_test_format_block_width_tiled
[628.343823] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.071s)
[628.353946] Starting dynamic subtest: drm_test_format_block_height_invalid
[628.420903] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.074s)
[628.430714] Starting dynamic subtest: drm_test_format_block_height_one_plane
[628.509684] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.087s)
[628.521596] Starting dynamic subtest: drm_test_format_block_height_two_plane
[628.592405] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.081s)
[628.603551] Starting dynamic subtest: drm_test_format_block_height_three_plane
[628.668839] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.077s)
[628.680331] Starting dynamic subtest: drm_test_format_block_height_tiled
[628.759315] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.089s)
[628.769751] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[628.850508] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.091s)
[628.861093] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[628.943514] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.092s)
[628.955437] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[629.020957] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.076s)
[629.031431] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[629.106334] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.084s)
[629.118357] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[629.196088] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.090s)
[629.208040] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[629.286846] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.089s)
[629.300143] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[629.378863] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.091s)
[629.390187] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[629.462366] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.083s)
[629.465029] Subtest drm_format: SUCCESS (1.568s)
[629.622277] [105/156] (411s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[629.725548] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[630.939740] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.213s)
[631.050583] [106/156] (410s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[631.155672] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[631.160507] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[631.266914] [107/156] (410s left) kms_plane (pixel-format-linear-modifier)
[631.359718] Starting subtest: pixel-format-linear-modifier
[631.385947] Starting dynamic subtest: pipe-A-plane-0
[631.997515] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s)
[632.008142] Starting dynamic subtest: pipe-A-plane-3
[632.497833] Dynamic subtest pipe-A-plane-3: SUCCESS (0.499s)
[632.508383] Starting dynamic subtest: pipe-A-plane-5
[632.707823] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[633.841100] Starting dynamic subtest: pipe-B-plane-0
[634.451984] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[634.463057] Starting dynamic subtest: pipe-B-plane-3
[634.906662] Dynamic subtest pipe-B-plane-3: SUCCESS (0.454s)
[634.916582] Starting dynamic subtest: pipe-B-plane-5
[635.118310] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[635.431733] Subtest pixel-format-linear-modifier: SUCCESS (4.075s)
[636.313854] [108/156] (405s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-gtt)
[636.416971] Starting subtest: fbchdr-rgb565-draw-mmap-gtt
[636.422088] Subtest fbchdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[636.524376] [109/156] (405s left) gem_exec_whisper (basic-fds)
[636.581820] Starting subtest: basic-fds
[642.529950] Subtest basic-fds: SUCCESS (5.946s)
[642.717617] [110/156] (399s left) syncobj_timeline (etime-single-wait-all-submitted)
[642.767818] Starting subtest: etime-single-wait-all-submitted
[642.873120] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[642.959907] [111/156] (398s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[643.066342] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[643.070918] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[643.161032] [112/156] (398s left) kms_flip (2x-flip-vs-panning-vs-hang)
[643.261817] Starting subtest: 2x-flip-vs-panning-vs-hang
[643.268076] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[643.368444] [113/156] (398s left) dumb_buffer (create-clear)
[643.417704] Starting subtest: create-clear
[677.659060] Subtest create-clear: SUCCESS (34.237s)
[677.776557] [114/156] (364s left) gem_mmap_offset (open-flood)
[677.824790] Starting subtest: open-flood
[699.314725] Subtest open-flood: SUCCESS (21.491s)
[699.422792] [115/156] (342s left) vgem_basic (dmabuf-fence-before)
[699.471867] Starting subtest: dmabuf-fence-before
[699.474044] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[699.543298] [116/156] (342s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[699.647045] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[699.651769] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[699.740191] [117/156] (342s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[699.860265] Starting subtest: flip-vs-cursor-legacy
[707.367711] Subtest flip-vs-cursor-legacy: SUCCESS (7.504s)
[708.241685] [118/156] (333s left) kms_hdmi_inject (inject-4k)
[708.590917] Starting subtest: inject-4k
[708.940893] Subtest inject-4k: SUCCESS (0.352s)
[709.502122] [119/156] (332s left) kms_chamelium_hpd (hdmi-hpd-storm)
[709.878748] Subtest hdmi-hpd-storm: SKIP (0.000s)
[710.667095] [120/156] (331s left) prime_busy (before-wait)
[710.719749] Starting subtest: before-wait
[710.725108] Starting dynamic subtest: rcs0
[710.744338] Dynamic subtest rcs0: SUCCESS (0.021s)
[710.756871] Starting dynamic subtest: bcs0
[710.786343] Dynamic subtest bcs0: SUCCESS (0.041s)
[710.797647] Starting dynamic subtest: vcs0
[710.828798] Dynamic subtest vcs0: SUCCESS (0.042s)
[710.839433] Starting dynamic subtest: vcs1
[710.872235] Dynamic subtest vcs1: SUCCESS (0.043s)
[710.883369] Starting dynamic subtest: vecs0
[710.914546] Dynamic subtest vecs0: SUCCESS (0.041s)
[710.925324] Starting dynamic subtest: ccs0
[710.957246] Dynamic subtest ccs0: SUCCESS (0.042s)
[711.065753] Subtest before-wait: SUCCESS (0.345s)
[711.141378] [121/156] (331s left) kms_feature_discovery (display-2x)
[711.241068] Starting subtest: display-2x
[711.246519] Subtest display-2x: SKIP (0.000s)
[711.327336] [122/156] (331s left) gem_softpin (32b-excludes-last-page)
[711.391986] Starting subtest: 32b-excludes-last-page
[711.397789] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[711.514235] [123/156] (330s left) kms_lease (lease-revoke)
[711.601058] Starting subtest: lease-revoke
[711.603794] Starting dynamic subtest: pipe-A-eDP-1
[711.628931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[711.640620] Starting dynamic subtest: pipe-B-eDP-1
[711.662094] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.031s)
[711.672981] Starting dynamic subtest: pipe-C-eDP-1
[711.692606] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[711.703486] Starting dynamic subtest: pipe-D-eDP-1
[711.721099] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[711.723878] Subtest lease-revoke: SUCCESS (0.122s)
[711.836656] [124/156] (330s left) kms_flip (flip-vs-rmfb)
[711.927061] Starting subtest: flip-vs-rmfb
[711.929698] Starting dynamic subtest: A-eDP1
[720.637045] Dynamic subtest A-eDP1: SUCCESS (8.709s)
[720.647848] Starting dynamic subtest: B-eDP1
[729.326704] Dynamic subtest B-eDP1: SUCCESS (8.687s)
[729.340342] Starting dynamic subtest: C-eDP1
[738.021431] Dynamic subtest C-eDP1: SUCCESS (8.690s)
[738.035737] Starting dynamic subtest: D-eDP1
[746.723673] Dynamic subtest D-eDP1: SUCCESS (8.699s)
[746.725864] Subtest flip-vs-rmfb: SUCCESS (34.796s)
[747.966549] [125/156] (294s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[748.069516] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[748.074793] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[748.175048] [126/156] (294s left) syncobj_timeline (multi-wait-all-signaled)
[748.229576] Starting subtest: multi-wait-all-signaled
[748.232059] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[748.326127] [127/156] (294s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[748.430208] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite
[748.434953] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[748.517480] [128/156] (294s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[748.614331] Starting subtest: x-tiled-64bpp-rotate-180
[750.193054] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.579s)
[750.354287] [129/156] (292s left) gem_exec_schedule (noreorder)
[750.522878] Starting subtest: noreorder
[750.525658] Starting dynamic subtest: rcs0
[750.579587] Dynamic subtest rcs0: SUCCESS (0.057s)
[750.590604] Starting dynamic subtest: vcs0
[752.111716] Dynamic subtest vcs0: SUCCESS (1.528s)
[752.127261] Starting dynamic subtest: vcs1
[754.094368] Dynamic subtest vcs1: SUCCESS (1.980s)
[754.107627] Starting dynamic subtest: vecs0
[756.079991] Dynamic subtest vecs0: SUCCESS (1.983s)
[756.093237] Starting dynamic subtest: ccs0
[756.151313] Dynamic subtest ccs0: SUCCESS (0.070s)
[756.154071] Subtest noreorder: SUCCESS (5.630s)
[756.339333] [130/156] (286s left) i915_query (query-topology-matches-eu-total)
[756.398878] Starting subtest: query-topology-matches-eu-total
[756.401816] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[756.499431] [131/156] (286s left) sw_sync (alloc_merge_fence)
[756.533891] Starting subtest: alloc_merge_fence
[756.536815] Subtest alloc_merge_fence: SUCCESS (0.000s)
[756.611534] [132/156] (286s left) gem_mmap_wc (bad-size)
[756.662881] Subtest bad-size: SKIP (0.000s)
[756.732257] [133/156] (286s left) sysfs_heartbeat_interval (nopreempt)
[756.800904] Starting subtest: nopreempt
[756.803517] Starting dynamic subtest: vecs0
[766.132321] Dynamic subtest vecs0: SUCCESS (9.334s)
[766.145041] Starting dynamic subtest: ccs0
[770.062813] Dynamic subtest ccs0: SUCCESS (3.928s)
[770.074247] Starting dynamic subtest: vcs0
[780.079990] Dynamic subtest vcs0: SUCCESS (10.017s)
[780.093981] Starting dynamic subtest: bcs0
[783.963596] Dynamic subtest bcs0: SUCCESS (3.882s)
[783.976437] Starting dynamic subtest: rcs0
[787.977996] Dynamic subtest rcs0: SUCCESS (4.012s)
[787.989369] Starting dynamic subtest: vcs1
[797.105790] Dynamic subtest vcs1: SUCCESS (9.124s)
[797.108792] Subtest nopreempt: SUCCESS (40.307s)
[797.184766] [134/156] (245s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[797.284622] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[797.287073] Starting dynamic subtest: pipe-A
[798.332858] Dynamic subtest pipe-A: SUCCESS (1.050s)
[798.344057] Starting dynamic subtest: pipe-B
[800.437917] Dynamic subtest pipe-B: SUCCESS (2.104s)
[800.450039] Starting dynamic subtest: pipe-C
[801.600064] Dynamic subtest pipe-C: SUCCESS (1.161s)
[801.613539] Starting dynamic subtest: pipe-D
[802.803364] Dynamic subtest pipe-D: SUCCESS (1.202s)
[802.805905] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.521s)
[803.965877] [135/156] (238s left) kms_addfb_basic (basic-x-tiled-legacy)
[804.031896] Starting subtest: basic-x-tiled-legacy
[804.037067] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[804.179848] [136/156] (238s left) kms_content_protection (uevent)
[804.314912] Starting subtest: uevent
[804.320846] Subtest uevent: SKIP (0.000s)
[804.444969] [137/156] (238s left) kms_rotation_crc (sprite-rotation-90)
[804.541533] Starting subtest: sprite-rotation-90
[804.546668] Subtest sprite-rotation-90: SKIP (0.001s)
[804.616845] [138/156] (238s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[804.715831] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[804.720842] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[804.831223] [139/156] (238s left) gem_userptr_blits (forbidden-operations)
[804.898110] Starting subtest: forbidden-operations
[804.902238] Subtest forbidden-operations: SKIP (0.000s)
[805.024322] [140/156] (238s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[805.074036] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[805.174697] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[805.253938] [141/156] (237s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[805.350935] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[805.355423] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[805.442874] [142/156] (237s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[805.545574] Starting subtest: 4-tiled-64bpp-rotate-180
[807.615810] Subtest 4-tiled-64bpp-rotate-180: FAIL (1.413s)
[807.659384] [143/156] (235s left) gem_mmap_gtt (big-copy-xy)
[807.707915] Subtest big-copy-XY: SKIP (0.000s)
[807.773356] [144/156] (235s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[807.861001] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[807.863257] Starting dynamic subtest: pipe-A-eDP-1
[807.882347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[807.893810] Starting dynamic subtest: pipe-B-eDP-1
[807.911715] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[807.922578] Starting dynamic subtest: pipe-C-eDP-1
[807.941850] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[807.952378] Starting dynamic subtest: pipe-D-eDP-1
[807.972316] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[807.974532] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[810.162516] [145/156] (233s left) gem_mmap_gtt (cpuset-basic-small-copy)
[810.221791] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[810.284923] [146/156] (233s left) kms_frontbuffer_tracking (psrhdr-suspend)
[810.379483] Starting subtest: psrhdr-suspend
[810.383998] Subtest psrhdr-suspend: SKIP (0.000s)
[810.458947] [147/156] (232s left) vgem_basic (second-client)
[810.510831] Starting subtest: second-client
[810.532075] Subtest second-client: SUCCESS (0.022s)
[810.591248] [148/156] (232s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[810.680373] Starting subtest: y-tiled-64bpp-rotate-0
[810.685487] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[810.801896] [149/156] (232s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[810.908317] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[818.429993] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.528s)
[818.559820] [150/156] (225s left) gem_userptr_blits (vma-merge)
[818.618882] Starting subtest: vma-merge
[818.662023] Subtest vma-merge: SUCCESS (0.043s)
[818.778450] [151/156] (224s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[818.893577] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[836.809704] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.914s)
[837.666324] [152/156] (206s left) gem_exec_params (invalid-fence-in-submit)
[837.726839] Starting subtest: invalid-fence-in-submit
[837.729987] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[837.853458] [153/156] (205s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[837.957801] Starting subtest: fbc-psr2-cursor-plane-update-sf
[837.960519] Starting dynamic subtest: pipe-A-eDP-1
[838.031525] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[838.044432] Starting dynamic subtest: pipe-B-eDP-1
[839.211323] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[839.216918] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.258s)
[840.372494] [154/156] (203s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render)
[840.465639] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render
[840.471061] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[840.564639] [155/156] (203s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[840.656168] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[840.661257] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[841.756282] [156/156] (202s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[841.853849] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[841.859035] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[841.954866] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_async
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_cursor_edge_walk
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_frames
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gen3_render_mixed_blits
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: kms_joiner
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: gem_exec_capture
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: gem_mmap_wc
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_bad_reloc
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_properties
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_sequence
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_pipe_stress
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: gem_unref_active_buffers
results: parsing output: 73/ for test: kms_vrr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_pm_rpm
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: drm_read
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: intel_hwmon
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_concurrent
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_ctx_param
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: i915_hangman
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_selftest
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: dumb_buffer
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: vgem_basic
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_hdmi_inject
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: prime_busy
results: parsing output: 120/ for test: kms_feature_discovery
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: i915_query
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: gem_mmap_wc
results: parsing output: 132/ for test: sysfs_heartbeat_interval
results: parsing output: 133/ for test: kms_plane_scaling
results: parsing output: 134/ for test: kms_addfb_basic
results: parsing output: 135/ for test: kms_content_protection
results: parsing output: 136/ for test: kms_rotation_crc
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_userptr_blits
results: parsing output: 139/ for test: syncobj_timeline
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: gem_mmap_gtt
results: parsing output: 143/ for test: kms_ccs
results: parsing output: 144/ for test: gem_mmap_gtt
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: vgem_basic
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_userptr_blits
results: parsing output: 150/ for test: kms_cursor_legacy
results: parsing output: 151/ for test: gem_exec_params
results: parsing output: 152/ for test: kms_psr2_sf
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_ccs
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.