[60.929086] Initializing watchdogs
[60.929139]   /dev/watchdog0
[60.942187] [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]
[60.946296] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.948442] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.951877] [001/131] (960s left) vgem_slow (nohang)
[61.058803] Starting subtest: nohang
[71.282090] Subtest nohang: SUCCESS (10.189s)
[71.368763] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[71.371775] [002/131] (950s left) gem_userptr_blits (unsync-overlap)
[71.446693] Subtest unsync-overlap: SKIP (0.000s)
[71.607011] [003/131] (949s left) gem_exec_schedule (u-fairslice-all)
[71.675981] Starting subtest: u-fairslice-all
[73.759304] Subtest u-fairslice-all: SUCCESS (2.087s)
[74.968338] [004/131] (946s left) gem_lmem_swapping (parallel-random)
[75.014116] Subtest parallel-random: SKIP (0.000s)
[75.051366] [005/131] (946s left) kms_sequence (queue-idle)
[75.148387] Starting subtest: queue-idle
[75.150867] Starting dynamic subtest: pipe-A-eDP-1
[76.976927] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.826s)
[76.985716] Starting dynamic subtest: pipe-B-eDP-1
[79.475492] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.495s)
[79.483731] Starting dynamic subtest: pipe-C-eDP-1
[81.906782] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.428s)
[81.915905] Starting dynamic subtest: pipe-D-eDP-1
[84.315184] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.404s)
[84.317138] Subtest queue-idle: SUCCESS (9.157s)
[85.183039] [006/131] (936s left) gem_exec_schedule (lateslice)
[85.256954] Starting subtest: lateslice
[85.259468] Starting dynamic subtest: rcs0
[85.266362] Dynamic subtest rcs0: SUCCESS (0.020s)
[85.275335] Starting dynamic subtest: bcs0
[85.282035] Dynamic subtest bcs0: SUCCESS (0.016s)
[85.289025] Starting dynamic subtest: vcs0
[85.298909] Dynamic subtest vcs0: SUCCESS (0.016s)
[85.305729] Starting dynamic subtest: vcs1
[85.316274] Dynamic subtest vcs1: SUCCESS (0.017s)
[85.322994] Starting dynamic subtest: vecs0
[85.332882] Dynamic subtest vecs0: SUCCESS (0.017s)
[85.339998] Starting dynamic subtest: ccs0
[85.348849] Dynamic subtest ccs0: SUCCESS (0.015s)
[85.351117] Subtest lateslice: SUCCESS (0.103s)
[87.031198] [007/131] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[87.130581] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[87.135085] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[87.270132] [008/131] (934s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[87.805819] Starting subtest: syncobj-timeline-invalid-wait
[87.808229] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[89.023234] [009/131] (932s left) gem_exec_params (no-vebox)
[89.085106] Starting subtest: no-vebox
[89.087468] Subtest no-vebox: SUCCESS (0.002s)
[91.024085] [010/131] (930s left) gem_exec_balancer (parallel-contexts)
[91.284062] Starting subtest: parallel-contexts
[94.888730] Subtest parallel-contexts: SUCCESS (3.602s)
[95.068603] [011/131] (926s left) kms_pm_rpm (legacy-planes-dpms)
[97.032435] Starting subtest: legacy-planes-dpms
[97.034769] Starting dynamic subtest: plane-63
[105.645762] Dynamic subtest plane-63: SUCCESS (8.610s)
[105.655766] Starting dynamic subtest: plane-93
[113.959161] Dynamic subtest plane-93: SUCCESS (8.311s)
[113.969946] Starting dynamic subtest: plane-123
[122.539348] Dynamic subtest plane-123: SUCCESS (8.577s)
[122.549622] Starting dynamic subtest: plane-133
[130.925529] Dynamic subtest plane-133: SUCCESS (8.383s)
[130.928662] Subtest legacy-planes-dpms: SUCCESS (33.885s)
[131.309880] [012/131] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[131.421308] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[131.425529] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[131.558732] [013/131] (890s left) kms_cursor_edge_walk (64x64-left-edge)
[131.654306] Starting subtest: 64x64-left-edge
[131.656640] Starting dynamic subtest: pipe-A-eDP-1
[135.147453] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s)
[135.156274] Starting dynamic subtest: pipe-D-eDP-1
[138.285541] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[138.287950] Subtest 64x64-left-edge: SUCCESS (6.631s)
[139.096566] [014/131] (882s left) gem_mmap_offset (open-flood)
[139.167068] Starting subtest: open-flood
[160.651729] Subtest open-flood: SUCCESS (21.489s)
[160.793498] [015/131] (861s left) gem_spin_batch (spin-each)
[160.867944] Starting subtest: spin-each
[164.238951] Subtest spin-each: SUCCESS (3.370s)
[165.024653] [016/131] (857s left) gem_ctx_persistence (saturated-hostile)
[165.093747] Starting subtest: saturated-hostile
[165.095968] Starting dynamic subtest: rcs0
[165.905635] Dynamic subtest rcs0: SUCCESS (0.811s)
[165.916501] Starting dynamic subtest: bcs0
[166.706346] Dynamic subtest bcs0: SUCCESS (0.799s)
[166.716784] Starting dynamic subtest: vcs0
[167.526110] Dynamic subtest vcs0: SUCCESS (0.818s)
[167.536369] Starting dynamic subtest: vcs1
[168.352359] Dynamic subtest vcs1: SUCCESS (0.825s)
[168.362762] Starting dynamic subtest: vecs0
[169.173139] Dynamic subtest vecs0: SUCCESS (0.817s)
[169.183158] Starting dynamic subtest: ccs0
[170.031083] Dynamic subtest ccs0: SUCCESS (0.858s)
[170.033997] Subtest saturated-hostile: SUCCESS (4.938s)
[170.132606] [017/131] (851s left) gem_ctx_shared (q-independent)
[170.208069] Starting subtest: Q-independent
[170.210101] Starting dynamic subtest: rcs0
[170.321995] Dynamic subtest rcs0: SUCCESS (0.114s)
[170.330519] Starting dynamic subtest: vcs0
[170.380743] Dynamic subtest vcs0: SUCCESS (0.060s)
[170.389901] Starting dynamic subtest: vcs1
[170.444466] Dynamic subtest vcs1: SUCCESS (0.062s)
[170.454742] Starting dynamic subtest: vecs0
[170.499368] Dynamic subtest vecs0: SUCCESS (0.055s)
[170.509196] Starting dynamic subtest: ccs0
[170.573766] Dynamic subtest ccs0: SUCCESS (0.074s)
[170.576785] Subtest Q-independent: SUCCESS (0.368s)
[172.055731] [018/131] (850s left) kms_psr (fbc-psr-primary-render)
[172.148864] Starting subtest: fbc-psr-primary-render
[172.151187] Starting dynamic subtest: eDP-1
[172.155274] Dynamic subtest eDP-1: SKIP (0.000s)
[172.159400] Subtest fbc-psr-primary-render: SKIP (0.001s)
[172.243055] [019/131] (849s left) perf_pmu (rc6-all-gts)
[172.287973] Starting subtest: rc6-all-gts
[178.653775] Subtest rc6-all-gts: SUCCESS (6.365s)
[179.535127] [020/131] (842s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[179.642573] Starting subtest: crc-primary-suspend-y-tiled-ccs
[179.644804] Starting dynamic subtest: pipe-A-eDP-1
[179.653392] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[179.662973] Starting dynamic subtest: pipe-B-eDP-1
[179.671470] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[179.678493] Starting dynamic subtest: pipe-C-eDP-1
[179.685253] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[179.691955] Starting dynamic subtest: pipe-D-eDP-1
[179.698852] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[179.702252] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[181.960704] [021/131] (840s left) gem_pxp (create-regular-context-1)
[182.090855] Starting subtest: create-regular-context-1
[182.093331] Subtest create-regular-context-1: SUCCESS (0.002s)
[182.236529] [022/131] (840s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[182.302535] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[182.307025] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[182.513567] [023/131] (839s left) syncobj_timeline (host-signal-points)
[182.574060] Starting subtest: host-signal-points
[182.578926] Subtest host-signal-points: SUCCESS (0.004s)
[182.703671] [024/131] (839s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[182.802768] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[182.805049] Starting dynamic subtest: pipe-A-eDP-1
[182.830147] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[182.840735] Starting dynamic subtest: pipe-B-eDP-1
[182.864239] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[182.871535] Starting dynamic subtest: pipe-C-eDP-1
[182.895104] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[182.902418] Starting dynamic subtest: pipe-D-eDP-1
[182.926442] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[182.930787] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[185.035396] [025/131] (837s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[185.135948] Starting subtest: stress-xrgb8888-xtiled
[190.946766] Subtest stress-xrgb8888-xtiled: SUCCESS (5.813s)
[191.004254] [026/131] (831s left) kms_async_flips (test-time-stamp)
[191.107905] Starting subtest: test-time-stamp
[191.484841] Starting dynamic subtest: pipe-A-eDP-1
[192.314882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.827s)
[192.691902] Starting dynamic subtest: pipe-B-eDP-1
[193.454162] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.767s)
[193.827780] Starting dynamic subtest: pipe-C-eDP-1
[194.587577] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[194.946394] Starting dynamic subtest: pipe-D-eDP-1
[195.720548] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[195.723077] Subtest test-time-stamp: SUCCESS (4.612s)
[196.902539] [027/131] (825s left) prime_self_import (basic-with_two_bos)
[196.945330] Starting subtest: basic-with_two_bos
[196.974603] Subtest basic-with_two_bos: SUCCESS (0.031s)
[197.117362] [028/131] (825s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[197.227311] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[204.596232] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.370s)
[204.771185] [029/131] (817s left) gem_mmap_gtt (close-race)
[204.835753] Subtest close-race: SKIP (0.000s)
[204.903741] [030/131] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[205.005364] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[209.413337] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.411s)
[210.634306] [031/131] (812s left) gen9_exec_parse (valid-registers)
[210.692519] Subtest valid-registers: SKIP (0.000s)
[210.761890] [032/131] (811s left) kms_color (legacy-gamma-reset)
[210.856176] Starting subtest: legacy-gamma-reset
[210.858419] Starting dynamic subtest: pipe-A-eDP-1
[211.236569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.379s)
[211.244576] Starting dynamic subtest: pipe-B-eDP-1
[211.248984] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[211.256258] Starting dynamic subtest: pipe-C-eDP-1
[211.260677] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[211.267767] Starting dynamic subtest: pipe-D-eDP-1
[211.272940] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[211.275353] Subtest legacy-gamma-reset: SUCCESS (0.415s)
[212.051855] [033/131] (810s left) gem_partial_pwrite_pread (reads-snoop)
[212.120816] Subtest reads-snoop: SKIP (0.000s)
[212.197389] [034/131] (810s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[212.298130] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[212.302141] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[212.433652] [035/131] (810s left) gem_exec_reloc (basic-gtt-noreloc)
[212.497068] Subtest basic-gtt-noreloc: SKIP (0.000s)
[212.567240] [036/131] (810s left) syncobj_timeline (invalid-transfer-illegal-handle)
[212.621122] Starting subtest: invalid-transfer-illegal-handle
[212.623413] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[212.756560] [037/131] (810s left) gem_ctx_param (invalid-get-engines)
[212.808976] Starting subtest: invalid-get-engines
[212.811491] Subtest invalid-get-engines: SUCCESS (0.001s)
[212.945187] [038/131] (810s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[213.041699] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[213.045325] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[213.175558] [039/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[213.288976] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[213.292681] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[213.419636] [040/131] (809s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[213.516522] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[213.519751] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[213.638045] [041/131] (809s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[213.733024] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[213.734904] Starting dynamic subtest: pipe-A-eDP-1
[213.752995] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.761013] Starting dynamic subtest: pipe-B-eDP-1
[213.779438] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.786338] Starting dynamic subtest: pipe-C-eDP-1
[213.803258] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.810786] Starting dynamic subtest: pipe-D-eDP-1
[213.829615] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.832917] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[216.002604] [042/131] (807s left) kms_plane_cursor (primary)
[216.096858] Starting subtest: primary
[216.101389] Starting dynamic subtest: pipe-A-eDP-1-size-64
[218.792467] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.696s)
[218.813395] Starting dynamic subtest: pipe-A-eDP-1-size-128
[221.448245] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.638s)
[221.470444] Starting dynamic subtest: pipe-A-eDP-1-size-256
[224.015218] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[224.336093] Starting dynamic subtest: pipe-B-eDP-1-size-64
[227.589889] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.260s)
[227.611874] Starting dynamic subtest: pipe-B-eDP-1-size-128
[230.167680] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[230.191651] Starting dynamic subtest: pipe-B-eDP-1-size-256
[232.725068] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.537s)
[233.035881] Starting dynamic subtest: pipe-C-eDP-1-size-64
[235.945027] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.916s)
[235.970214] Starting dynamic subtest: pipe-C-eDP-1-size-128
[238.110440] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.146s)
[238.138643] Starting dynamic subtest: pipe-C-eDP-1-size-256
[240.255541] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.124s)
[240.569352] Starting dynamic subtest: pipe-D-eDP-1-size-64
[243.397512] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.837s)
[243.423606] Starting dynamic subtest: pipe-D-eDP-1-size-128
[245.564045] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s)
[245.590062] Starting dynamic subtest: pipe-D-eDP-1-size-256
[247.775368] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[248.082243] Subtest primary: SUCCESS (31.983s)
[248.905986] [043/131] (774s left) kms_flip (dpms-off-confusion-interruptible)
[249.016638] Starting subtest: dpms-off-confusion-interruptible
[249.018601] Starting dynamic subtest: A-eDP1
[257.692095] Dynamic subtest A-eDP1: SUCCESS (8.673s)
[257.702324] Starting dynamic subtest: B-eDP1
[266.325895] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[266.333700] Starting dynamic subtest: C-eDP1
[274.941713] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[274.949385] Starting dynamic subtest: D-eDP1
[283.573217] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[283.578368] Subtest dpms-off-confusion-interruptible: SUCCESS (34.560s)
[284.775531] [044/131] (738s left) kms_cursor_edge_walk (256x256-top-bottom)
[284.859948] Starting subtest: 256x256-top-bottom
[284.862202] Starting dynamic subtest: pipe-A-eDP-1
[288.330201] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[288.337957] Starting dynamic subtest: pipe-D-eDP-1
[291.452070] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[291.453976] Subtest 256x256-top-bottom: SUCCESS (6.592s)
[292.280392] [045/131] (730s left) kms_psr (pr-sprite-plane-onoff)
[292.384094] Starting subtest: pr-sprite-plane-onoff
[292.388598] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[292.481341] [046/131] (730s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[292.601340] Starting subtest: short-flip-before-cursor-toggle
[293.514993] Subtest short-flip-before-cursor-toggle: SUCCESS (0.910s)
[294.410561] [047/131] (728s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[294.510790] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[294.512717] Starting dynamic subtest: A-eDP1
[303.423911] Dynamic subtest A-eDP1: SUCCESS (8.911s)
[303.435202] Starting dynamic subtest: B-eDP1
[312.362121] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[312.372969] Starting dynamic subtest: C-eDP1
[321.288591] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[321.298861] Starting dynamic subtest: D-eDP1
[330.223173] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[330.225509] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.715s)
[331.466382] [048/131] (691s left) gem_exec_params (secure-non-master)
[331.532460] Starting subtest: secure-non-master
[331.537223] Subtest secure-non-master: SKIP (0.000s)
[331.677833] [049/131] (691s left) kms_flip (2x-flip-vs-dpms)
[331.776115] Starting subtest: 2x-flip-vs-dpms
[331.786842] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[331.923941] [050/131] (691s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[332.022651] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[332.026968] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[332.166632] [051/131] (691s left) drm_read (fault-buffer)
[332.304506] Starting subtest: fault-buffer
[332.306808] Subtest fault-buffer: SUCCESS (0.001s)
[332.457882] [052/131] (691s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[332.518153] Starting subtest: basic-batch-kernel-default-cmd
[332.521671] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[332.720717] [053/131] (690s left) kms_cursor_crc (cursor-offscreen-128x128)
[332.918740] Starting subtest: cursor-offscreen-128x128
[332.920984] Starting dynamic subtest: pipe-A-eDP-1
[334.851798] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[334.879679] Starting dynamic subtest: pipe-D-eDP-1
[337.438568] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s)
[337.440947] Subtest cursor-offscreen-128x128: SUCCESS (4.520s)
[338.340223] [054/131] (685s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[338.440291] Starting subtest: x-tiled-8bpp-rotate-90
[338.460391] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[338.619774] [055/131] (685s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[338.678602] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[338.785377] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[338.883534] [056/131] (684s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[338.992257] Starting subtest: 4-tiled-32bpp-rotate-90
[339.014440] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[339.173812] [057/131] (684s left) core_setmaster (master-drop-set-shared-fd)
[339.276139] Starting subtest: master-drop-set-shared-fd
[339.298162] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[339.337175] [058/131] (684s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[339.420393] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[339.429345] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[339.529055] [059/131] (684s left) syncobj_wait (single-wait-all-submitted)
[339.602469] Starting subtest: single-wait-all-submitted
[339.705710] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[339.804404] [060/131] (684s left) kms_big_fb (linear-64bpp-rotate-270)
[339.905514] Starting subtest: linear-64bpp-rotate-270
[339.924802] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[340.087096] [061/131] (683s left) gem_exec_params (invalid-fence-in-submit)
[340.148541] Starting subtest: invalid-fence-in-submit
[340.153822] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[340.311779] [062/131] (683s left) syncobj_wait (single-wait-for-submit-submitted)
[340.377499] Starting subtest: single-wait-for-submit-submitted
[340.480873] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s)
[340.583748] [063/131] (683s left) prime_vgem (fence-write-hang)
[340.674492] Subtest fence-write-hang: SKIP (0.000s)
[340.810569] [064/131] (683s left) syncobj_timeline (single-wait-signaled)
[340.868576] Starting subtest: single-wait-signaled
[340.870795] Subtest single-wait-signaled: SUCCESS (0.000s)
[341.003909] [065/131] (683s left) kms_chamelium_edid (vga-edid-read)
[341.409761] Subtest vga-edid-read: SKIP (0.000s)
[342.222733] [066/131] (681s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[342.359503] Starting subtest: 2x-long-flip-vs-cursor-atomic
[342.364062] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[342.529766] [067/131] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[342.644835] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[347.123043] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.483s)
[348.275441] [068/131] (675s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[348.376026] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[352.964926] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.592s)
[354.164673] [069/131] (670s left) prime_vgem (basic-read)
[354.249621] Starting subtest: basic-read
[354.269408] Subtest basic-read: SKIP (0.018s)
[354.411126] [070/131] (669s left) gem_userptr_blits (vma-merge)
[354.490843] Starting subtest: vma-merge
[354.529022] Subtest vma-merge: SUCCESS (0.038s)
[354.707865] [071/131] (669s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[354.820699] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[354.824985] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[354.955095] [072/131] (669s left) kms_vrr (negative-basic)
[355.054638] Starting subtest: negative-basic
[355.060671] Starting dynamic subtest: pipe-A-eDP-1
[360.476577] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[360.770072] Subtest negative-basic: SUCCESS (5.714s)
[361.591471] [073/131] (662s left) gem_exec_reloc (basic-cpu-read-active)
[361.651781] Subtest basic-cpu-read-active: SKIP (0.000s)
[361.720426] [074/131] (662s left) kms_chamelium_hpd (hdmi-hpd)
[362.117774] Subtest hdmi-hpd: SKIP (0.000s)
[362.899477] [075/131] (661s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[363.011097] Starting subtest: yf-tiled-16bpp-rotate-0
[363.015467] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[363.146551] [076/131] (661s left) syncobj_timeline (reset-signaled)
[363.200214] Starting subtest: reset-signaled
[363.202265] Subtest reset-signaled: SUCCESS (0.000s)
[363.330060] [077/131] (661s left) kms_psr (fbc-psr2-basic)
[363.416206] Starting subtest: fbc-psr2-basic
[363.418084] Starting dynamic subtest: eDP-1
[363.422170] Dynamic subtest eDP-1: SKIP (0.000s)
[363.426253] Subtest fbc-psr2-basic: SKIP (0.001s)
[363.514305] [078/131] (661s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[363.604683] Starting subtest: primary-yf-tiled-reflect-x-0
[363.668596] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.063s)
[363.791796] [079/131] (660s left) kms_prop_blob (basic)
[363.854158] Starting subtest: basic
[363.855881] Subtest basic: SUCCESS (0.000s)
[363.987179] [080/131] (660s left) vgem_basic (debugfs)
[364.028386] Starting subtest: debugfs
[364.030299] Subtest debugfs: SUCCESS (0.000s)
[364.115709] [081/131] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[364.207729] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[371.190193] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.983s)
[371.334488] [082/131] (653s left) gem_userptr_blits (unsync-unmap-cycles)
[371.413051] Subtest unsync-unmap-cycles: SKIP (0.000s)
[371.569815] [083/131] (653s left) perf_pmu (busy-double-start)
[371.618697] Starting subtest: busy-double-start
[371.620703] Starting dynamic subtest: rcs0
[375.257410] Dynamic subtest rcs0: FAIL (3.583s)
[375.267165] Starting dynamic subtest: bcs0
[378.771156] Dynamic subtest bcs0: SUCCESS (3.570s)
[378.781906] Starting dynamic subtest: vcs0
[382.450810] Dynamic subtest vcs0: SUCCESS (3.678s)
[382.461535] Starting dynamic subtest: vcs1
[386.459998] Dynamic subtest vcs1: SUCCESS (4.007s)
[386.471146] Starting dynamic subtest: vecs0
[390.428732] Dynamic subtest vecs0: SUCCESS (3.967s)
[390.439502] Starting dynamic subtest: ccs0
[394.066045] Dynamic subtest ccs0: FAIL (3.564s)
[394.068373] Subtest busy-double-start: FAIL (22.378s)
[394.158684] [084/131] (630s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[394.259349] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[394.263713] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[394.391216] [085/131] (630s left) kms_chamelium_color (ctm-negative)
[394.491818] Subtest ctm-negative: SKIP (0.000s)
[394.535252] [086/131] (630s left) kms_async_flips (async-flip-dpms)
[394.642074] Starting subtest: async-flip-dpms
[395.018129] Starting dynamic subtest: pipe-A-eDP-1
[398.768529] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.750s)
[399.150646] Starting dynamic subtest: pipe-B-eDP-1
[401.935880] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.790s)
[402.310394] Starting dynamic subtest: pipe-C-eDP-1
[405.101330] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.797s)
[405.480983] Starting dynamic subtest: pipe-D-eDP-1
[408.263803] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.787s)
[408.266238] Subtest async-flip-dpms: SUCCESS (13.623s)
[409.510287] [087/131] (615s left) gem_busy (semaphore)
[409.713868] Subtest semaphore: SKIP (0.000s)
[409.982156] [088/131] (615s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[410.081086] Starting subtest: flip-vs-dpms-off-vs-modeset
[410.083422] Starting dynamic subtest: A-eDP1
[413.671215] Dynamic subtest A-eDP1: SUCCESS (3.589s)
[413.679950] Starting dynamic subtest: B-eDP1
[416.852263] Dynamic subtest B-eDP1: SUCCESS (3.179s)
[416.862259] Starting dynamic subtest: C-eDP1
[420.042417] Dynamic subtest C-eDP1: SUCCESS (3.188s)
[420.051200] Starting dynamic subtest: D-eDP1
[423.126696] Dynamic subtest D-eDP1: SUCCESS (3.082s)
[423.128817] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.045s)
[423.945518] [089/131] (601s left) prime_mmap (test_reprime)
[423.992165] Starting subtest: test_reprime
[423.994089] Starting dynamic subtest: test_reprime-smem
[424.020174] Dynamic subtest test_reprime-smem: SUCCESS (0.030s)
[424.022607] Subtest test_reprime: SUCCESS (0.031s)
[424.152502] [090/131] (600s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[429.215939] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[429.220679] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[430.088339] [091/131] (595s left) gem_exec_whisper (basic-fds)
[430.155753] Starting subtest: basic-fds
[435.964874] Subtest basic-fds: SUCCESS (5.804s)
[436.171484] [092/131] (588s left) gem_ctx_param (set-priority-range)
[436.238061] Starting subtest: set-priority-range
[436.251781] Subtest set-priority-range: SUCCESS (0.014s)
[436.388865] [093/131] (588s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[436.488905] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[436.491415] Starting dynamic subtest: pipe-A-default-mode
[439.225117] Dynamic subtest pipe-A-default-mode: SUCCESS (2.735s)
[439.227364] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.737s)
[440.072433] [094/131] (585s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[440.168820] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[440.171115] Starting dynamic subtest: pipe-A-default-mode
[440.463908] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[440.468519] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.295s)
[441.305354] [095/131] (583s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[441.412099] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[441.416432] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[441.543337] [096/131] (583s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[441.651780] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[441.654050] Starting dynamic subtest: pipe-A-eDP-1
[441.798758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[441.808799] Starting dynamic subtest: pipe-B-eDP-1
[441.827609] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[441.835987] Starting dynamic subtest: pipe-C-eDP-1
[441.855279] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[441.863300] Starting dynamic subtest: pipe-D-eDP-1
[441.882715] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[441.884915] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.173s)
[444.080373] [097/131] (581s left) i915_selftest (mock)
[447.570068] Starting subtest: mock
[447.572913] Starting dynamic subtest: sanitycheck
[448.303214] Dynamic subtest sanitycheck: SUCCESS (0.733s)
[448.312282] Starting dynamic subtest: shmem
[449.090605] Dynamic subtest shmem: SUCCESS (0.785s)
[449.099730] Starting dynamic subtest: fence
[457.087428] Dynamic subtest fence: SUCCESS (7.993s)
[457.096271] Starting dynamic subtest: scatterlist
[458.821041] Dynamic subtest scatterlist: SUCCESS (1.732s)
[458.830097] Starting dynamic subtest: syncmap
[462.169942] Dynamic subtest syncmap: SUCCESS (3.346s)
[462.179049] Starting dynamic subtest: uncore
[462.936582] Dynamic subtest uncore: SUCCESS (0.764s)
[462.945606] Starting dynamic subtest: ring
[463.564169] Dynamic subtest ring: SUCCESS (0.626s)
[463.573316] Starting dynamic subtest: engine
[464.323304] Dynamic subtest engine: SUCCESS (0.757s)
[464.332752] Starting dynamic subtest: timelines
[468.319722] Dynamic subtest timelines: SUCCESS (3.993s)
[468.327761] Starting dynamic subtest: requests
[471.814397] Dynamic subtest requests: SUCCESS (3.492s)
[471.822927] Starting dynamic subtest: objects
[472.670239] Dynamic subtest objects: SUCCESS (0.854s)
[472.678613] Starting dynamic subtest: phys
[473.529911] Dynamic subtest phys: SUCCESS (0.858s)
[473.538428] Starting dynamic subtest: dmabuf
[474.374547] Dynamic subtest dmabuf: SUCCESS (0.843s)
[474.383460] Starting dynamic subtest: vma
[479.695388] Dynamic subtest vma: SUCCESS (5.317s)
[479.704867] Starting dynamic subtest: evict
[481.194472] Dynamic subtest evict: SUCCESS (1.497s)
[481.203535] Starting dynamic subtest: gtt
[484.458951] Dynamic subtest gtt: SUCCESS (3.262s)
[484.466854] Starting dynamic subtest: hugepages
[485.451299] Dynamic subtest hugepages: SUCCESS (0.989s)
[485.459079] Starting dynamic subtest: memory_region
[488.008912] Dynamic subtest memory_region: SUCCESS (2.555s)
[488.011650] Subtest mock: SUCCESS (40.438s)
[488.038212] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[488.038897] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[488.041927] [098/131] (537s left) gem_ctx_exec (basic-close-race)
[489.555597] Starting subtest: basic-close-race
[495.352515] Subtest basic-close-race: SUCCESS (5.798s)
[495.454863] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[495.456314] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[495.460295] [099/131] (529s left) prime_busy (after)
[495.524185] Starting subtest: after
[495.529455] Starting dynamic subtest: rcs0
[495.570873] Dynamic subtest rcs0: SUCCESS (0.043s)
[495.577970] Starting dynamic subtest: bcs0
[495.634482] Dynamic subtest bcs0: SUCCESS (0.063s)
[495.641662] Starting dynamic subtest: vcs0
[495.676484] Dynamic subtest vcs0: SUCCESS (0.041s)
[495.684095] Starting dynamic subtest: vcs1
[495.718815] Dynamic subtest vcs1: SUCCESS (0.042s)
[495.726985] Starting dynamic subtest: vecs0
[495.760105] Dynamic subtest vecs0: SUCCESS (0.040s)
[495.768403] Starting dynamic subtest: ccs0
[495.802342] Dynamic subtest ccs0: SUCCESS (0.042s)
[495.911427] Subtest after: SUCCESS (0.385s)
[496.007156] [100/131] (529s left) syncobj_wait (reset-signaled)
[496.072255] Starting subtest: reset-signaled
[496.074630] Subtest reset-signaled: SUCCESS (0.000s)
[496.212728] [101/131] (529s left) kms_dsc (dsc-basic)
[496.315985] Starting subtest: dsc-basic
[496.329306] Subtest dsc-basic: SKIP (0.000s)
[496.410832] [102/131] (529s left) vgem_basic (bad-flag)
[496.451664] Starting subtest: bad-flag
[496.453618] Subtest bad-flag: SUCCESS (0.000s)
[496.535501] [103/131] (529s left) kms_psr (psr2-sprite-mmap-gtt)
[496.618795] Starting subtest: psr2-sprite-mmap-gtt
[496.621079] Starting dynamic subtest: eDP-1
[498.104946] Dynamic subtest eDP-1: SKIP (1.481s)
[498.109661] Subtest psr2-sprite-mmap-gtt: SKIP (1.483s)
[498.235140] [104/131] (527s left) gem_exec_balancer (noheartbeat)
[498.497295] Starting subtest: noheartbeat
[498.502049] Subtest noheartbeat: SKIP (0.000s)
[498.630392] [105/131] (527s left) gem_tiled_wb
[498.751445] [106/131] (526s left) gem_exec_reloc (basic-softpin)
[498.813258] Subtest basic-softpin: SKIP (0.000s)
[498.888707] [107/131] (526s left) gem_pxp (hw-rejects-pxp-buffer)
[499.018972] Starting subtest: hw-rejects-pxp-buffer
[499.023715] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[499.151550] [108/131] (526s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[504.120347] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[504.122535] Starting dynamic subtest: pipe-A-eDP-1
[504.934354] Dynamic subtest pipe-A-eDP-1: SKIP (0.811s)
[504.943205] Starting dynamic subtest: pipe-B-eDP-1
[506.069437] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[506.073870] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.948s)
[507.289213] [109/131] (518s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[507.413581] Starting subtest: 2x-cursor-vs-flip-legacy
[507.418156] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[507.582110] [110/131] (518s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[507.676756] Starting subtest: multiplane-rotation-cropping-bottom
[524.992465] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.315s)
[525.167846] [111/131] (500s left) gem_userptr_blits (sync-overlap)
[525.243625] Starting subtest: sync-overlap
[525.245677] Subtest sync-overlap: SUCCESS (0.000s)
[525.404566] [112/131] (500s left) kms_feature_discovery (psr2)
[525.493519] Starting subtest: psr2
[525.495517] Subtest psr2: SUCCESS (0.000s)
[525.590687] [113/131] (500s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[525.697036] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[532.254183] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.559s)
[532.406186] [114/131] (493s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[532.513791] Starting subtest: y-tiled-32bpp-rotate-0
[532.518304] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[532.653419] [115/131] (493s left) gem_mmap_gtt (basic-small-bo)
[532.711425] Subtest basic-small-bo: SKIP (0.000s)
[532.788442] [116/131] (493s left) api_intel_bb (simple-bb)
[532.855828] Starting subtest: simple-bb
[532.858835] Subtest simple-bb: SUCCESS (0.006s)
[533.023463] [117/131] (493s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[533.118876] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[533.121093] Starting dynamic subtest: pipe-A
[533.140969] Dynamic subtest pipe-A: SKIP (0.017s)
[533.148902] Starting dynamic subtest: pipe-B
[533.171939] Dynamic subtest pipe-B: SKIP (0.031s)
[533.179844] Starting dynamic subtest: pipe-C
[533.204615] Dynamic subtest pipe-C: SKIP (0.030s)
[533.212272] Starting dynamic subtest: pipe-D
[533.235455] Dynamic subtest pipe-D: SKIP (0.029s)
[533.239861] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.112s)
[533.366973] [118/131] (492s left) kms_lease (lease-unleased-connector)
[533.463474] Starting subtest: lease-unleased-connector
[533.465363] Starting dynamic subtest: pipe-A-eDP-1
[533.469812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[533.481558] Starting dynamic subtest: pipe-B-eDP-1
[533.483481] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[533.490772] Starting dynamic subtest: pipe-C-eDP-1
[533.492820] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[533.500272] Starting dynamic subtest: pipe-D-eDP-1
[533.502139] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[533.503886] Subtest lease-unleased-connector: SUCCESS (0.038s)
[533.644444] [119/131] (492s left) gen9_exec_parse (bb-secure)
[533.709959] Subtest bb-secure: SKIP (0.000s)
[533.797610] [120/131] (492s left) vgem_basic (mmap)
[533.843452] Starting subtest: mmap
[533.855885] Subtest mmap: SUCCESS (0.014s)
[533.931888] [121/131] (492s left) gem_eio (in-flight-contexts-10ms)
[534.173257] Starting subtest: in-flight-contexts-10ms
[547.953752] Subtest in-flight-contexts-10ms: SUCCESS (13.779s)
[548.091683] [122/131] (478s left) i915_pm_rpm (debugfs-forcewake-user)
[550.117168] Starting subtest: debugfs-forcewake-user
[561.506061] Subtest debugfs-forcewake-user: SUCCESS (11.392s)
[561.879230] [123/131] (464s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[561.981436] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[561.985869] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[562.123727] [124/131] (464s left) kms_psr (fbc-pr-no-drrs)
[562.228291] Starting subtest: fbc-pr-no-drrs
[562.232265] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[562.321780] [125/131] (464s left) kms_invalid_mode (bad-htotal)
[562.423024] Starting subtest: bad-htotal
[562.425308] Starting dynamic subtest: pipe-A-eDP-1
[562.729599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.308s)
[562.738366] Starting dynamic subtest: pipe-B-eDP-1
[562.740552] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[562.748086] Starting dynamic subtest: pipe-C-eDP-1
[562.750223] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[562.757674] Starting dynamic subtest: pipe-D-eDP-1
[562.759626] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[562.761569] Subtest bad-htotal: SUCCESS (0.314s)
[563.616305] [126/131] (462s left) kms_cursor_crc (cursor-random-128x42)
[563.845963] Starting subtest: cursor-random-128x42
[563.889957] Subtest cursor-random-128x42: SKIP (0.040s)
[564.135805] [127/131] (462s left) gem_linear_blits (interruptible)
[564.667937] Starting subtest: interruptible
[569.111559] Subtest interruptible: SUCCESS (4.441s)
[569.399422] [128/131] (457s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[569.548635] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[576.453687] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.907s)
[576.602403] [129/131] (450s left) i915_hangman (engine-engine-error)
[576.684962] Starting subtest: engine-engine-error
[576.687058] Starting dynamic subtest: rcs0
[577.843664] Dynamic subtest rcs0: SUCCESS (1.159s)
[577.856107] Starting dynamic subtest: bcs0
[579.891805] Dynamic subtest bcs0: SUCCESS (2.045s)
[579.903724] Starting dynamic subtest: vcs0
[581.874352] Dynamic subtest vcs0: SUCCESS (1.980s)
[581.885963] Starting dynamic subtest: vcs1
[583.871591] Dynamic subtest vcs1: SUCCESS (1.981s)
[583.882413] Starting dynamic subtest: vecs0
[585.843088] Dynamic subtest vecs0: SUCCESS (1.984s)
[585.855443] Starting dynamic subtest: ccs0
[587.891540] Dynamic subtest ccs0: SUCCESS (2.045s)
[587.894601] Subtest engine-engine-error: SUCCESS (11.210s)
[588.071613] [130/131] (438s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[588.178319] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[588.182272] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[588.309734] [131/131] (438s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[588.404565] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[588.406974] Starting dynamic subtest: pipe-A
[588.425806] Dynamic subtest pipe-A: SKIP (0.016s)
[588.435731] Starting dynamic subtest: pipe-B
[588.456201] Dynamic subtest pipe-B: SKIP (0.030s)
[588.464725] Starting dynamic subtest: pipe-C
[588.487580] Dynamic subtest pipe-C: SKIP (0.029s)
[588.496169] Starting dynamic subtest: pipe-D
[588.516918] Dynamic subtest pipe-D: SKIP (0.029s)
[588.520738] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.107s)
[588.635515] Closing watchdogs
results: parsing output: 0/ for test: vgem_slow
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_edge_walk
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: gem_ctx_shared
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_pipe_stress
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: prime_self_import
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_plane_cursor
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_cursor_edge_walk
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: drm_read
results: parsing output: 51/ for test: gem_exec_flush
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: core_setmaster
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: prime_vgem
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_chamelium_edid
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_vrr
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_prop_blob
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_chamelium_color
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: gem_busy
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: prime_mmap
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: gem_ctx_param
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: i915_selftest
results: parsing output: 97/ for test: gem_ctx_exec
results: parsing output: 98/ for test: prime_busy
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_dsc
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: gem_tiled_wb
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: kms_feature_discovery
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_invalid_mode
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: gem_linear_blits
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_plane_scaling
Done.