[47.728544] Initializing watchdogs
[47.728610]   /dev/watchdog0
[47.744638] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[47.750220] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.753384] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.755409] [001/156] (960s left) syncobj_wait (single-wait-signaled)
[47.792565] Starting subtest: single-wait-signaled
[47.793276] Subtest single-wait-signaled: SUCCESS (0.001s)
[47.864261] [002/156] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[47.912297] Starting subtest: map-fixed-invalidate-overlap
[47.913028] Starting dynamic subtest: gtt
[48.004150] Dynamic subtest gtt: SUCCESS (0.092s)
[48.010852] Starting dynamic subtest: wb
[48.063841] Dynamic subtest wb: SUCCESS (0.059s)
[48.069717] Starting dynamic subtest: wc
[48.119874] Dynamic subtest wc: SUCCESS (0.056s)
[48.126044] Starting dynamic subtest: uc
[48.177994] Dynamic subtest uc: SUCCESS (0.058s)
[48.178826] Subtest map-fixed-invalidate-overlap: SUCCESS (0.266s)
[48.284163] [003/156] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[48.374528] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[48.375288] Starting dynamic subtest: pipe-A-HDMI-A-1
[48.382397] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[48.388259] Starting dynamic subtest: pipe-B-HDMI-A-1
[48.395257] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[48.400747] Starting dynamic subtest: pipe-C-HDMI-A-1
[48.407667] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[48.413333] Starting dynamic subtest: pipe-D-HDMI-A-1
[48.420338] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[48.421692] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[48.626834] [004/156] (959s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[48.717421] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[48.718837] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[48.766864] [005/156] (959s left) kms_plane_multiple (2x-tiling-4)
[48.854555] Starting subtest: 2x-tiling-4
[48.855945] Subtest 2x-tiling-4: SKIP (0.000s)
[48.911407] [006/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt)
[49.004944] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt
[49.006466] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[49.105723] [007/156] (959s left) gem_userptr_blits (huge-split)
[49.160417] Starting subtest: huge-split
[49.164018] Subtest huge-split: SUCCESS (0.004s)
[49.301746] [008/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt)
[49.392016] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt
[49.393344] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[49.479575] [009/156] (959s left) gem_exec_params (batch-first)
[49.516551] Starting subtest: batch-first
[49.520530] Subtest batch-first: SUCCESS (0.004s)
[49.641387] [010/156] (958s left) gem_exec_fence (keep-in-fence)
[49.804301] Starting subtest: keep-in-fence
[49.805354] Starting dynamic subtest: rcs0
[49.844116] Dynamic subtest rcs0: SUCCESS (0.039s)
[49.857505] Starting dynamic subtest: bcs0
[49.874512] Dynamic subtest bcs0: SUCCESS (0.030s)
[49.889887] Starting dynamic subtest: vcs0
[49.908405] Dynamic subtest vcs0: SUCCESS (0.033s)
[49.921442] Starting dynamic subtest: vcs1
[49.945611] Dynamic subtest vcs1: SUCCESS (0.036s)
[49.958427] Starting dynamic subtest: vecs0
[49.980668] Dynamic subtest vecs0: SUCCESS (0.035s)
[49.981766] Subtest keep-in-fence: SUCCESS (0.177s)
[50.468821] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[50.470665] [011/156] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[50.565390] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[50.566867] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[50.670137] [012/156] (958s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[52.089844] Starting subtest: dpms-mode-unset-lpsp
[55.792179] Subtest dpms-mode-unset-lpsp: SUCCESS (3.702s)
[55.970757] [013/156] (952s left) vgem_basic (mmap)
[56.009405] Starting subtest: mmap
[56.016555] Subtest mmap: SUCCESS (0.008s)
[56.083776] [014/156] (952s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[56.118561] Starting subtest: framebuffer-vs-set-tiling
[56.119341] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[56.274467] [015/156] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[56.366428] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[56.367839] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[56.474196] [016/156] (952s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[56.562672] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[56.563372] Starting dynamic subtest: pipe-A
[56.696785] Dynamic subtest pipe-A: SUCCESS (0.134s)
[56.703872] Starting dynamic subtest: pipe-B
[56.849344] Dynamic subtest pipe-B: SUCCESS (0.152s)
[56.856981] Starting dynamic subtest: pipe-C
[56.992033] Dynamic subtest pipe-C: SUCCESS (0.142s)
[57.005863] Starting dynamic subtest: pipe-D
[57.135450] Dynamic subtest pipe-D: SUCCESS (0.143s)
[57.136159] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.573s)
[57.322670] [017/156] (951s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[57.358171] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[57.358950] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[57.426743] [018/156] (951s left) gem_exec_schedule (fairslice-all)
[57.470687] Starting subtest: fairslice-all
[59.507650] Subtest fairslice-all: SUCCESS (2.036s)
[59.821723] [019/156] (949s left) kms_big_fb (yf-tiled-addfb)
[59.922965] Starting subtest: yf-tiled-addfb
[59.924425] Subtest yf-tiled-addfb: SKIP (0.000s)
[60.015761] [020/156] (948s left) syncobj_timeline (invalid-transfer-bad-pad)
[60.050274] Starting subtest: invalid-transfer-bad-pad
[60.051040] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[60.124965] [021/156] (948s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[60.217498] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[60.218911] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[60.326644] [022/156] (948s left) kms_rotation_crc (sprite-rotation-270)
[60.413353] Starting subtest: sprite-rotation-270
[65.349299] Subtest sprite-rotation-270: SUCCESS (4.936s)
[65.550606] [023/156] (943s left) gem_flink_basic (bad-open)
[65.585330] Starting subtest: bad-open
[65.586037] Subtest bad-open: SUCCESS (0.000s)
[65.662374] [024/156] (943s left) kms_vblank (wait-idle)
[65.752630] Starting subtest: wait-idle
[65.753394] Starting dynamic subtest: pipe-A-HDMI-A-1
[66.923736] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.170s)
[66.935315] Starting dynamic subtest: pipe-D-HDMI-A-1
[68.178960] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.250s)
[68.179718] Subtest wait-idle: SUCCESS (2.427s)
[68.334432] [025/156] (940s left) gem_exec_flush (basic-uc-rw-default)
[68.380415] Starting subtest: basic-uc-rw-default
[73.808077] Subtest basic-uc-rw-default: SUCCESS (5.428s)
[74.016986] [026/156] (935s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[74.106465] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[74.107216] Starting dynamic subtest: pipe-A-HDMI-A-1
[74.125099] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[74.131650] Starting dynamic subtest: pipe-B-HDMI-A-1
[74.149196] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[74.155663] Starting dynamic subtest: pipe-C-HDMI-A-1
[74.172970] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[74.180019] Starting dynamic subtest: pipe-D-HDMI-A-1
[74.198569] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[74.199967] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.012s)
[74.360399] [027/156] (934s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[74.454271] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[74.464310] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.009s)
[74.540108] [028/156] (934s left) kms_color (ctm-0-25)
[74.628937] Starting subtest: ctm-0-25
[74.629687] Starting dynamic subtest: pipe-A-HDMI-A-1
[75.473027] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.844s)
[75.479740] Starting dynamic subtest: pipe-B-HDMI-A-1
[76.287144] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.814s)
[76.294539] Starting dynamic subtest: pipe-C-HDMI-A-1
[77.114346] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.826s)
[77.121611] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.924958] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.810s)
[77.925742] Subtest ctm-0-25: SUCCESS (3.296s)
[78.097830] [029/156] (931s left) gem_exec_schedule (semaphore-power)
[78.270584] Starting subtest: semaphore-power
[79.335180] Subtest semaphore-power: SUCCESS (1.054s)
[79.494679] [030/156] (929s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[79.594208] Starting subtest: y-tiled-8bpp-rotate-180
[80.595428] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.001s)
[80.723525] [031/156] (928s left) sw_sync (sync_busy_fork_unixsocket)
[80.756050] Starting subtest: sync_busy_fork_unixsocket
[80.764976] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[80.813670] [032/156] (928s left) gem_reg_read (timestamp-moving)
[80.847583] Starting subtest: timestamp-moving
[81.857333] Subtest timestamp-moving: SUCCESS (1.001s)
[81.920230] [033/156] (927s left) gem_ctx_persistence (hostile)
[81.956355] Starting subtest: hostile
[84.767513] Subtest hostile: SUCCESS (2.803s)
[84.870036] [034/156] (924s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[84.973221] Starting subtest: x-tiled-32bpp-rotate-270
[85.064115] Subtest x-tiled-32bpp-rotate-270: SKIP (0.090s)
[85.168563] [035/156] (924s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[85.266492] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[85.268022] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[85.387127] [036/156] (924s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[85.479323] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[85.480744] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[85.605980] [037/156] (924s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[85.700525] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[85.701991] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[85.801784] [038/156] (923s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[85.835820] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[85.875960] [039/156] (923s left) kms_cursor_crc (cursor-onscreen-256x85)
[85.967609] Starting subtest: cursor-onscreen-256x85
[85.972766] Starting dynamic subtest: pipe-A-HDMI-A-1
[87.147048] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.175s)
[87.186832] Starting dynamic subtest: pipe-D-HDMI-A-1
[88.344773] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.166s)
[88.345693] Subtest cursor-onscreen-256x85: SUCCESS (2.377s)
[88.524538] [040/156] (921s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[88.564385] Starting subtest: multi-wait-for-submit-available-signaled
[88.565151] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[88.635464] [041/156] (921s left) gem_exec_whisper (basic-forked-all)
[88.678589] Starting subtest: basic-forked-all
[91.215450] Subtest basic-forked-all: SUCCESS (2.536s)
[91.413668] [042/156] (918s left) kms_draw_crc (fill-fb)
[91.503184] Starting subtest: fill-fb
[91.728116] Subtest fill-fb: SUCCESS (0.224s)
[91.845415] [043/156] (918s left) syncobj_timeline (etime-multi-wait-submitted)
[91.880771] Starting subtest: etime-multi-wait-submitted
[91.981884] Subtest etime-multi-wait-submitted: SUCCESS (0.101s)
[92.069463] [044/156] (917s left) gem_exec_schedule (manyslice)
[92.112440] Starting subtest: manyslice
[92.113177] Starting dynamic subtest: rcs0
[92.699937] Dynamic subtest rcs0: SUCCESS (0.579s)
[92.713377] Starting dynamic subtest: bcs0
[93.007867] Dynamic subtest bcs0: SUCCESS (0.307s)
[93.023504] Starting dynamic subtest: vcs0
[93.313312] Dynamic subtest vcs0: SUCCESS (0.305s)
[93.331537] Starting dynamic subtest: vcs1
[93.678415] Dynamic subtest vcs1: SUCCESS (0.373s)
[93.705436] Starting dynamic subtest: vecs0
[94.064249] Dynamic subtest vecs0: SUCCESS (0.377s)
[94.065011] Subtest manyslice: SUCCESS (1.944s)
[94.365802] [045/156] (915s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[94.460435] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[94.461886] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[94.550862] [046/156] (915s left) perf (non-zero-reason)
[94.634382] Starting subtest: non-zero-reason
[94.635153] Starting dynamic subtest: 0-rcs0
[102.351797] Dynamic subtest 0-rcs0: SUCCESS (7.683s)
[102.352768] Subtest non-zero-reason: SUCCESS (7.684s)
[102.388923] [047/156] (907s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[102.477510] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[102.478211] Starting dynamic subtest: pipe-A-HDMI-A-1
[102.484935] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[102.492314] Starting dynamic subtest: pipe-B-HDMI-A-1
[102.498988] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[102.506227] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.512888] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[102.519955] Starting dynamic subtest: pipe-D-HDMI-A-1
[102.526858] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[102.528262] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[102.723972] [048/156] (907s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[102.819231] Starting subtest: hdr-1p-pri-indfb-multidraw
[102.820623] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[102.905475] [049/156] (907s left) i915_pm_rpm (debugfs-forcewake-user)
[104.303025] Starting subtest: debugfs-forcewake-user
[115.743841] Subtest debugfs-forcewake-user: SUCCESS (11.442s)
[115.934620] [050/156] (894s left) kms_cursor_crc (cursor-random-256x85)
[116.030742] Starting subtest: cursor-random-256x85
[116.036058] Starting dynamic subtest: pipe-A-HDMI-A-1
[117.955786] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.920s)
[117.992537] Starting dynamic subtest: pipe-D-HDMI-A-1
[119.872971] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.889s)
[119.873815] Subtest cursor-random-256x85: SUCCESS (3.842s)
[120.042325] [051/156] (890s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[120.141124] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[120.142598] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[120.247634] [052/156] (890s left) gem_userptr_blits (map-fixed-invalidate-busy)
[120.292724] Starting subtest: map-fixed-invalidate-busy
[120.293556] Starting dynamic subtest: gtt
[121.875856] Dynamic subtest gtt: SUCCESS (1.574s)
[121.883371] Starting dynamic subtest: wb
[123.389629] Dynamic subtest wb: SUCCESS (1.514s)
[123.397075] Starting dynamic subtest: wc
[124.898634] Dynamic subtest wc: SUCCESS (1.508s)
[124.905912] Starting dynamic subtest: uc
[126.413081] Dynamic subtest uc: SUCCESS (1.514s)
[126.413870] Subtest map-fixed-invalidate-busy: SUCCESS (6.112s)
[126.510937] [053/156] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[126.604410] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[126.605791] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[126.698620] [054/156] (883s left) kms_plane_scaling (invalid-parameters)
[126.795843] Starting subtest: invalid-parameters
[126.796580] Starting dynamic subtest: less-than-1-height-src
[126.811546] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s)
[126.819165] Starting dynamic subtest: less-than-1-width-src
[126.827552] Dynamic subtest less-than-1-width-src: SUCCESS (0.016s)
[126.828321] Subtest invalid-parameters: SUCCESS (0.032s)
[126.908718] [055/156] (883s left) gem_busy (busy)
[126.953676] Starting subtest: busy
[126.954482] Starting dynamic subtest: all-engines
[126.984778] Dynamic subtest all-engines: SUCCESS (0.030s)
[126.992587] Starting dynamic subtest: rcs0
[127.005778] Dynamic subtest rcs0: SUCCESS (0.020s)
[127.014581] Starting dynamic subtest: bcs0
[127.025630] Dynamic subtest bcs0: SUCCESS (0.019s)
[127.035100] Starting dynamic subtest: vcs0
[127.038367] Dynamic subtest vcs0: SUCCESS (0.012s)
[127.046514] Starting dynamic subtest: vcs1
[127.056348] Dynamic subtest vcs1: SUCCESS (0.017s)
[127.064693] Starting dynamic subtest: vecs0
[127.071398] Dynamic subtest vecs0: SUCCESS (0.014s)
[127.072139] Subtest busy: SUCCESS (0.118s)
[127.421447] [056/156] (883s left) gem_pwrite (basic-random)
[127.454605] Starting subtest: basic-random
[133.095122] Subtest basic-random: SUCCESS (5.631s)
[133.184566] [057/156] (877s left) syncobj_wait (invalid-reset-one-illegal-handle)
[133.274540] Starting subtest: invalid-reset-one-illegal-handle
[133.275282] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[133.348883] [058/156] (877s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[133.443309] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[133.444088] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.451979] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[133.462630] Starting dynamic subtest: pipe-B-HDMI-A-1
[133.470428] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[133.480542] Starting dynamic subtest: pipe-C-HDMI-A-1
[133.495358] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[133.503532] Starting dynamic subtest: pipe-D-HDMI-A-1
[133.511186] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[133.512625] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[133.697876] [059/156] (876s left) syncobj_timeline (single-wait-available-signaled)
[133.735414] Starting subtest: single-wait-available-signaled
[133.736161] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[133.805527] [060/156] (876s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[133.897882] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[133.899297] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[133.992211] [061/156] (876s left) kms_addfb_basic (master-rmfb)
[134.027149] Starting subtest: master-rmfb
[134.027888] Subtest master-rmfb: SUCCESS (0.001s)
[134.195233] [062/156] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[134.290356] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[134.291741] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[134.363780] [063/156] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render)
[134.455486] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render
[134.456846] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[134.550012] [064/156] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[134.642378] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[134.643765] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[134.730983] [065/156] (876s left) kms_debugfs (display-off-read-all)
[134.818833] Starting subtest: display-off-read-all
[134.872499] Subtest display-off-read-all: SUCCESS (0.054s)
[134.987969] [066/156] (875s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[135.081447] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[135.082824] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[135.185482] [067/156] (875s left) i915_drm_fdinfo (most-busy-check-all)
[135.223721] Starting subtest: most-busy-check-all
[135.224397] Starting dynamic subtest: rcs0
[135.767158] Dynamic subtest rcs0: SUCCESS (0.544s)
[135.780165] Starting dynamic subtest: bcs0
[136.293620] Dynamic subtest bcs0: SUCCESS (0.523s)
[136.308433] Starting dynamic subtest: vcs0
[136.821335] Dynamic subtest vcs0: SUCCESS (0.528s)
[136.833770] Starting dynamic subtest: vcs1
[137.356412] Dynamic subtest vcs1: SUCCESS (0.533s)
[137.368252] Starting dynamic subtest: vecs0
[137.894424] Dynamic subtest vecs0: SUCCESS (0.536s)
[137.895599] Subtest most-busy-check-all: SUCCESS (2.672s)
[137.960757] [068/156] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[138.059854] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[138.061471] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[138.145760] [069/156] (872s left) gem_mmap_offset (basic-uaf)
[138.179607] Starting subtest: basic-uaf
[138.181307] Subtest basic-uaf: SUCCESS (0.002s)
[138.284731] [070/156] (872s left) kms_flip (plain-flip-ts-check)
[138.372698] Starting subtest: plain-flip-ts-check
[138.375042] Starting dynamic subtest: A-HDMI-A1
[146.247516] Dynamic subtest A-HDMI-A1: SUCCESS (7.855s)
[146.254901] Starting dynamic subtest: B-HDMI-A1
[154.036110] Dynamic subtest B-HDMI-A1: SUCCESS (7.802s)
[154.045677] Starting dynamic subtest: C-HDMI-A1
[161.860566] Dynamic subtest C-HDMI-A1: SUCCESS (7.797s)
[161.868624] Starting dynamic subtest: D-HDMI-A1
[169.647728] Dynamic subtest D-HDMI-A1: SUCCESS (7.811s)
[169.648886] Subtest plain-flip-ts-check: SUCCESS (31.276s)
[169.800369] [071/156] (841s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[169.903282] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[169.904682] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[170.002983] [072/156] (841s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[170.090863] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[170.091557] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.097681] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[170.105406] Starting dynamic subtest: pipe-B-HDMI-A-1
[170.111400] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[170.119020] Starting dynamic subtest: pipe-C-HDMI-A-1
[170.125017] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[170.132478] Starting dynamic subtest: pipe-D-HDMI-A-1
[170.138286] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[170.138959] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.007s)
[170.353019] [073/156] (840s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[170.444421] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[170.445822] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[170.547018] [074/156] (840s left) api_intel_bb (purge-bb)
[170.582100] Starting subtest: purge-bb
[170.585135] Subtest purge-bb: SUCCESS (0.003s)
[170.687689] [075/156] (840s left) i915_getparams_basic (basic-subslice-total)
[170.721011] Starting subtest: basic-subslice-total
[170.722403] Subtest basic-subslice-total: SUCCESS (0.000s)
[170.807254] [076/156] (840s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[170.898495] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[170.899932] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[171.006673] [077/156] (840s left) gem_mmap (big-bo)
[171.040911] Starting subtest: big-bo
[171.158395] Subtest big-bo: SUCCESS (0.117s)
[171.270604] [078/156] (840s left) kms_psr (psr-no-drrs)
[171.412710] Subtest psr-no-drrs: SKIP (0.000s)
[171.456727] [079/156] (839s left) kms_invalid_mode (zero-hdisplay)
[171.544644] Starting subtest: zero-hdisplay
[171.545337] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.600646] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.054s)
[171.608829] Starting dynamic subtest: pipe-B-HDMI-A-1
[171.609559] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[171.617417] Starting dynamic subtest: pipe-C-HDMI-A-1
[171.618151] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[171.625882] Starting dynamic subtest: pipe-D-HDMI-A-1
[171.626588] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[171.627331] Subtest zero-hdisplay: SUCCESS (0.063s)
[171.753797] [080/156] (839s left) gem_ctx_isolation (dirty-switch)
[171.799655] Starting subtest: dirty-switch
[171.800394] Starting dynamic subtest: rcs0
[171.984714] Dynamic subtest rcs0: SUCCESS (0.176s)
[171.997846] Starting dynamic subtest: bcs0
[172.206882] Dynamic subtest bcs0: SUCCESS (0.221s)
[172.214780] Starting dynamic subtest: vcs0
[172.412830] Dynamic subtest vcs0: SUCCESS (0.205s)
[172.420704] Starting dynamic subtest: vcs1
[172.619638] Dynamic subtest vcs1: SUCCESS (0.214s)
[172.628793] Starting dynamic subtest: vecs0
[172.834490] Dynamic subtest vecs0: SUCCESS (0.205s)
[172.835479] Subtest dirty-switch: SUCCESS (1.027s)
[173.007501] [081/156] (838s left) gem_pipe_control_store_loop (reused-buffer)
[173.048765] Starting subtest: reused-buffer
[175.207873] Subtest reused-buffer: SUCCESS (2.151s)
[175.315494] [082/156] (836s left) gem_tiled_partial_pwrite_pread (writes)
[175.353762] Starting subtest: writes
[175.992735] Subtest writes: SUCCESS (0.639s)
[176.097155] [083/156] (835s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[176.137846] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[176.138544] Starting dynamic subtest: smem
[176.217782] Dynamic subtest smem: SUCCESS (0.080s)
[176.218497] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.081s)
[176.400896] [084/156] (835s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-onoff)
[176.495404] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-onoff
[176.496799] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[176.600830] [085/156] (835s left) perf_pmu (busy-start)
[176.638710] Starting subtest: busy-start
[176.639542] Starting dynamic subtest: rcs0
[179.164556] Dynamic subtest rcs0: SUCCESS (2.525s)
[179.179578] Starting dynamic subtest: bcs0
[181.711447] Dynamic subtest bcs0: SUCCESS (2.520s)
[181.722304] Starting dynamic subtest: vcs0
[184.231973] Dynamic subtest vcs0: SUCCESS (2.517s)
[184.242927] Starting dynamic subtest: vcs1
[186.752742] Dynamic subtest vcs1: SUCCESS (2.521s)
[186.763746] Starting dynamic subtest: vecs0
[189.273589] Dynamic subtest vecs0: SUCCESS (2.519s)
[189.274503] Subtest busy-start: SUCCESS (12.612s)
[189.320996] [086/156] (822s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[189.416277] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[189.417760] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[189.503947] [087/156] (822s left) gem_spin_batch (spin-all)
[189.545621] Starting subtest: spin-all
[189.555570] Subtest spin-all: SUCCESS (0.010s)
[189.743635] [088/156] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[189.835707] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[189.837114] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[189.932909] [089/156] (821s left) gen7_exec_parse (oacontrol-tracking)
[189.970369] Subtest oacontrol-tracking: SKIP (0.000s)
[190.018234] [090/156] (821s left) kms_cursor_edge_walk (128x128-top-bottom)
[190.106174] Starting subtest: 128x128-top-bottom
[190.106916] Starting dynamic subtest: pipe-A-HDMI-A-1
[191.917305] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.811s)
[191.927932] Starting dynamic subtest: pipe-D-HDMI-A-1
[193.611247] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.691s)
[193.611982] Subtest 128x128-top-bottom: SUCCESS (3.506s)
[193.734803] [091/156] (818s left) kms_psr (fbc-pr-basic)
[193.826720] Subtest fbc-pr-basic: SKIP (0.000s)
[193.872878] [092/156] (818s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[193.907605] Starting subtest: write-cpu-read-wc-unflushed
[193.985510] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.078s)
[194.077657] [093/156] (817s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[194.170502] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[194.171910] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[194.262120] [094/156] (817s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[194.307873] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[194.376154] [095/156] (817s left) gem_userptr_blits (sync-unmap-after-close)
[194.421101] Starting subtest: sync-unmap-after-close
[194.433363] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[194.545630] [096/156] (817s left) kms_hdr (static-toggle)
[194.633065] Starting subtest: static-toggle
[194.633860] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010
[194.635232] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s)
[194.644465] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F
[194.645948] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s)
[194.647391] Subtest static-toggle: SKIP (0.004s)
[194.699916] [097/156] (817s left) gem_create (create-ext-placement-sanity-check)
[194.846739] Starting subtest: create-ext-placement-sanity-check
[194.852568] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[194.947483] [098/156] (817s left) gem_ppgtt (flink-and-close-vma-leak)
[194.985497] Starting subtest: flink-and-close-vma-leak
[194.989430] Subtest flink-and-close-vma-leak: SUCCESS (0.004s)
[195.106008] [099/156] (817s left) gem_exec_reloc (basic-gtt)
[195.144916] Starting subtest: basic-gtt
[195.152299] Subtest basic-gtt: SUCCESS (0.007s)
[195.266293] [100/156] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[195.358759] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[195.360242] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[195.442168] [101/156] (816s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[195.534786] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[195.536266] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[195.627915] [102/156] (816s left) vgem_basic (bad-flag)
[195.665027] Starting subtest: bad-flag
[195.665767] Subtest bad-flag: SUCCESS (0.000s)
[195.725012] [103/156] (816s left) kms_vblank (query-forked-busy-hang)
[195.812626] Starting subtest: query-forked-busy-hang
[195.813450] Starting dynamic subtest: pipe-A-HDMI-A-1
[209.549318] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.736s)
[209.562955] Starting dynamic subtest: pipe-D-HDMI-A-1
[223.875738] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.321s)
[223.876499] Subtest query-forked-busy-hang: SUCCESS (28.063s)
[224.060899] [104/156] (788s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[224.170104] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[224.171573] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[224.245070] [105/156] (788s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[224.349989] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[224.973257] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.623s)
[225.091645] [106/156] (787s left) prime_mmap (test_invalid_sync_flags)
[225.127345] Starting subtest: test_invalid_sync_flags
[225.128042] Starting dynamic subtest: test_invalid_sync_flags-smem
[225.128738] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[225.129420] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[225.217568] [107/156] (787s left) gem_softpin (noreloc)
[225.258977] Starting subtest: noreloc
[230.709245] Subtest noreloc: SUCCESS (5.413s)
[230.797864] [108/156] (781s left) core_sysfs (read-all-entries)
[230.832491] Starting subtest: read-all-entries
[230.836931] Subtest read-all-entries: SUCCESS (0.005s)
[230.900938] [109/156] (781s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[230.993119] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[230.993858] Starting dynamic subtest: pipe-A-HDMI-A-1
[231.000923] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[231.008996] Starting dynamic subtest: pipe-B-HDMI-A-1
[231.016037] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[231.024174] Starting dynamic subtest: pipe-C-HDMI-A-1
[231.031170] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[231.038890] Starting dynamic subtest: pipe-D-HDMI-A-1
[231.046233] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[231.047649] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[231.247089] [110/156] (781s left) kms_pm_rpm (system-suspend-idle)
[232.645966] Starting subtest: system-suspend-idle
[252.135609] Subtest system-suspend-idle: SUCCESS (4.893s)
[259.397441] [111/156] (760s left) gem_exec_alignment (many)
[259.443357] Starting subtest: many
[292.366713] Subtest many: SUCCESS (32.904s)
[292.915243] [112/156] (726s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[293.002413] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[293.106039] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[293.206336] [113/156] (726s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[293.301237] Starting subtest: modeset-transition-nonblocking-fencing
[293.301946] Starting dynamic subtest: 1x-outputs
[294.593264] Dynamic subtest 1x-outputs: SUCCESS (1.291s)
[294.594087] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.292s)
[294.737397] [114/156] (725s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[294.831309] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[294.832774] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[294.899460] [115/156] (725s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt)
[294.993548] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt
[294.995038] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[295.082056] [116/156] (724s left) gem_exec_balancer (full-pulse)
[295.127888] Starting subtest: full-pulse
[296.741237] Subtest full-pulse: SUCCESS (1.613s)
[296.928445] [117/156] (723s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[297.021708] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[297.023203] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[297.114329] [118/156] (722s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[297.205203] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[297.252385] [119/156] (722s left) kms_fb_coherency (memset-crc)
[297.341665] Starting subtest: memset-crc
[297.342371] Starting dynamic subtest: mmap-gtt
[297.586418] Dynamic subtest mmap-gtt: SUCCESS (0.244s)
[297.663046] Starting dynamic subtest: mmap-offset-wc
[297.874358] Dynamic subtest mmap-offset-wc: SUCCESS (0.219s)
[297.952639] Starting dynamic subtest: mmap-offset-uc
[298.508846] Dynamic subtest mmap-offset-uc: SUCCESS (0.567s)
[298.585181] Starting dynamic subtest: mmap-legacy-wc
[298.787932] Dynamic subtest mmap-legacy-wc: SUCCESS (0.211s)
[298.854150] Subtest memset-crc: SUCCESS (1.511s)
[299.017227] [120/156] (721s left) gem_sync (basic-store-all)
[299.064959] Starting subtest: basic-store-all
[301.526497] Subtest basic-store-all: SUCCESS (2.444s)
[301.694311] [121/156] (718s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[301.733682] Starting subtest: tiled-to-tiled
[301.864630] Subtest tiled-to-tiled: SUCCESS (0.122s)
[301.957892] [122/156] (718s left) kms_psr (psr-sprite-plane-move)
[302.050827] Subtest psr-sprite-plane-move: SKIP (0.000s)
[302.094132] [123/156] (718s left) gem_exec_params (secure-non-root)
[302.135524] Starting subtest: secure-non-root
[302.137039] Subtest secure-non-root: SKIP (0.000s)
[302.241487] [124/156] (718s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[302.333713] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[302.335138] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[302.424183] [125/156] (717s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[302.512265] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[302.520849] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[302.570970] [126/156] (717s left) kms_getfb (getfb-repeated-different-handles)
[302.658240] Starting subtest: getfb-repeated-different-handles
[302.658981] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[302.759575] [127/156] (717s left) prime_busy (before)
[302.797723] Starting subtest: before
[302.803560] Starting dynamic subtest: rcs0
[302.837149] Dynamic subtest rcs0: SUCCESS (0.033s)
[302.848846] Starting dynamic subtest: bcs0
[302.855254] Dynamic subtest bcs0: SUCCESS (0.016s)
[302.865275] Starting dynamic subtest: vcs0
[302.874190] Dynamic subtest vcs0: SUCCESS (0.018s)
[302.884515] Starting dynamic subtest: vcs1
[302.896802] Dynamic subtest vcs1: SUCCESS (0.021s)
[302.907423] Starting dynamic subtest: vecs0
[302.913080] Dynamic subtest vecs0: SUCCESS (0.015s)
[303.023071] Subtest before: SUCCESS (0.224s)
[303.099300] [128/156] (717s left) kms_psr (pr-primary-mmap-cpu)
[303.187514] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[303.239303] [129/156] (717s left) kms_psr (fbc-psr-sprite-plane-onoff)
[303.327960] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[303.375299] [130/156] (717s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[303.415716] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[303.416436] Starting dynamic subtest: smem
[303.528649] Dynamic subtest smem: SUCCESS (0.112s)
[303.529399] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SUCCESS (0.113s)
[303.719174] [131/156] (716s left) syncobj_wait (multi-wait-all-submitted-signaled)
[303.755186] Starting subtest: multi-wait-all-submitted-signaled
[303.857984] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[303.932882] [132/156] (716s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[304.036173] Starting subtest: 4-tiled-64bpp-rotate-0
[304.037740] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[304.125239] [133/156] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[304.218675] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[304.220105] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[304.311610] [134/156] (716s left) kms_chamelium_frames (hdmi-crc-fast)
[304.452588] Subtest hdmi-crc-fast: SKIP (0.000s)
[304.557561] [135/156] (716s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[304.654957] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[305.857623] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.203s)
[305.997830] [136/156] (714s left) kms_flip (flip-vs-expired-vblank)
[306.089278] Starting subtest: flip-vs-expired-vblank
[306.091483] Starting dynamic subtest: A-HDMI-A1
[313.801149] Dynamic subtest A-HDMI-A1: SUCCESS (7.687s)
[313.809691] Starting dynamic subtest: B-HDMI-A1
[321.449542] Dynamic subtest B-HDMI-A1: SUCCESS (7.663s)
[321.459071] Starting dynamic subtest: C-HDMI-A1
[329.129154] Dynamic subtest C-HDMI-A1: SUCCESS (7.674s)
[329.140189] Starting dynamic subtest: D-HDMI-A1
[336.801721] Dynamic subtest D-HDMI-A1: SUCCESS (7.673s)
[336.804376] Subtest flip-vs-expired-vblank: SUCCESS (30.713s)
[336.975381] [137/156] (683s left) kms_plane_alpha_blend (constant-alpha-max)
[337.069691] Starting subtest: constant-alpha-max
[337.135845] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.608235] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.472s)
[337.620070] Starting dynamic subtest: pipe-D-HDMI-A-1
[338.116999] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.506s)
[338.117693] Subtest constant-alpha-max: SUCCESS (1.048s)
[338.288813] [138/156] (682s left) gem_mmap_gtt (medium-copy-odd)
[338.326600] Starting subtest: medium-copy-odd
[341.798860] Subtest medium-copy-odd: SUCCESS (3.472s)
[341.888451] [139/156] (679s left) kms_color_pipeline (plane-lut1d)
[342.027284] Starting subtest: plane-lut1d
[342.118273] Starting dynamic subtest: pipe-A-plane-0
[342.216603] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[342.227253] Starting dynamic subtest: pipe-A-plane-1
[342.300446] Dynamic subtest pipe-A-plane-1: SUCCESS (0.082s)
[342.316534] Starting dynamic subtest: pipe-A-plane-2
[342.400719] Dynamic subtest pipe-A-plane-2: SUCCESS (0.098s)
[342.615877] Starting dynamic subtest: pipe-B-plane-0
[342.691035] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s)
[342.711021] Starting dynamic subtest: pipe-B-plane-1
[342.782427] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[342.798572] Starting dynamic subtest: pipe-B-plane-2
[342.882571] Dynamic subtest pipe-B-plane-2: SUCCESS (0.097s)
[343.088309] Starting dynamic subtest: pipe-C-plane-0
[343.161733] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[343.175596] Starting dynamic subtest: pipe-C-plane-1
[343.260956] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[343.275668] Starting dynamic subtest: pipe-C-plane-2
[343.353255] Dynamic subtest pipe-C-plane-2: SUCCESS (0.089s)
[343.578356] Starting dynamic subtest: pipe-D-plane-0
[343.667168] Dynamic subtest pipe-D-plane-0: SUCCESS (0.100s)
[343.681670] Starting dynamic subtest: pipe-D-plane-1
[343.767568] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[343.783617] Starting dynamic subtest: pipe-D-plane-2
[343.867521] Dynamic subtest pipe-D-plane-2: SUCCESS (0.097s)
[343.916279] Subtest plane-lut1d: SUCCESS (1.889s)
[344.039379] [140/156] (676s left) i915_pm_rps (waitboost)
[344.081316] Starting subtest: waitboost
[347.643195] Subtest waitboost: SUCCESS (3.530s)
[347.744478] [141/156] (673s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[347.841285] Starting subtest: hdr-rgb101010-draw-blt
[347.842776] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s)
[347.926547] [142/156] (673s left) gem_exec_balancer (sliced)
[347.973515] Starting subtest: sliced
[349.452250] Subtest sliced: SUCCESS (1.471s)
[349.659611] [143/156] (671s left) kms_frontbuffer_tracking (psrhdr-2p-rte)
[349.755808] Starting subtest: psrhdr-2p-rte
[349.757252] Subtest psrhdr-2p-rte: SKIP (0.000s)
[349.852472] [144/156] (671s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[349.943569] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[349.945072] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[350.044100] [145/156] (671s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[350.139248] Starting subtest: fbcpsr-modesetfrombusy
[350.140673] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[350.236471] [146/156] (671s left) gem_mmap_gtt (bad-object)
[350.269489] Starting subtest: bad-object
[350.270194] Subtest bad-object: SUCCESS (0.000s)
[350.376980] [147/156] (670s left) api_intel_allocator (default-alignment)
[350.411675] Starting subtest: default-alignment
[350.412920] Subtest default-alignment: SUCCESS (0.002s)
[350.517331] [148/156] (670s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[350.606877] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[350.651858] [149/156] (670s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[350.743449] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[350.744952] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[350.844821] [150/156] (670s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt)
[350.936947] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt
[350.938427] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[351.034986] [151/156] (670s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[351.127598] Starting subtest: dp-mst-type-0-suspend-resume
[351.129106] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[351.242085] [152/156] (670s left) kms_lease (simple-lease)
[351.330293] Starting subtest: simple-lease
[351.332184] Starting dynamic subtest: pipe-A-HDMI-A-1
[351.577452] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.246s)
[351.610489] Starting dynamic subtest: pipe-B-HDMI-A-1
[351.780735] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.200s)
[351.791104] Starting dynamic subtest: pipe-C-HDMI-A-1
[351.989422] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.207s)
[352.004478] Starting dynamic subtest: pipe-D-HDMI-A-1
[352.198951] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.208s)
[352.200900] Subtest simple-lease: SUCCESS (0.870s)
[352.326534] [153/156] (669s left) kms_vblank (crtc-id)
[352.426808] Starting subtest: crtc-id
[352.427563] Starting dynamic subtest: pipe-A-HDMI-A-1
[352.621743] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.194s)
[352.633176] Starting dynamic subtest: pipe-D-HDMI-A-1
[352.804244] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.178s)
[352.805055] Subtest crtc-id: SUCCESS (0.378s)
[352.965418] [154/156] (668s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[353.060191] Starting subtest: fbchdr-rgb565-draw-blt
[353.061628] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[353.155102] [155/156] (668s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[353.247739] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[353.249181] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[353.359955] [156/156] (668s left) kms_psr (fbc-psr2-sprite-blt)
[353.449004] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[353.490326] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_plane_multiple
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: vgem_basic
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: gem_flink_basic
results: parsing output: 23/ for test: kms_vblank
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_color
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: sw_sync
results: parsing output: 31/ for test: gem_reg_read
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_pipe_b_c_ivb
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_exec_whisper
results: parsing output: 41/ for test: kms_draw_crc
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: gem_busy
results: parsing output: 55/ for test: gem_pwrite
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_debugfs
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: i915_drm_fdinfo
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_offset
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: i915_getparams_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_mmap
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: gem_ctx_isolation
results: parsing output: 80/ for test: gem_pipe_control_store_loop
results: parsing output: 81/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_spin_batch
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gen7_exec_parse
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: kms_hdr
results: parsing output: 96/ for test: gem_create
results: parsing output: 97/ for test: gem_ppgtt
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: gem_softpin
results: parsing output: 107/ for test: core_sysfs
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: gem_exec_alignment
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_atomic_transition
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_fb_coherency
results: parsing output: 119/ for test: gem_sync
results: parsing output: 120/ for test: gem_set_tiling_vs_blt
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_getfb
results: parsing output: 126/ for test: prime_busy
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_chamelium_frames
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_flip
results: parsing output: 136/ for test: kms_plane_alpha_blend
results: parsing output: 137/ for test: gem_mmap_gtt
results: parsing output: 138/ for test: kms_color_pipeline
results: parsing output: 139/ for test: i915_pm_rps
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_exec_balancer
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_mmap_gtt
results: parsing output: 146/ for test: api_intel_allocator
results: parsing output: 147/ for test: kms_psr2_sf
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_content_protection
results: parsing output: 151/ for test: kms_lease
results: parsing output: 152/ for test: kms_vblank
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_psr
Done.