[56.410088] Initializing watchdogs
[56.410148]   /dev/watchdog0
[56.424113] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.428639] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.430974] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.434419] [001/131] (960s left) vgem_slow (nohang)
[56.525089] Starting subtest: nohang
[66.674178] Subtest nohang: SUCCESS (10.217s)
[66.767413] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[66.770301] [002/131] (950s left) gem_userptr_blits (unsync-overlap)
[66.862547] Subtest unsync-overlap: SKIP (0.000s)
[67.299799] [003/131] (949s left) gem_exec_schedule (u-fairslice-all)
[67.492177] Starting subtest: u-fairslice-all
[69.594134] Subtest u-fairslice-all: SUCCESS (2.106s)
[71.007848] [004/131] (946s left) gem_lmem_swapping (parallel-random)
[71.057664] Subtest parallel-random: SKIP (0.000s)
[71.099199] [005/131] (946s left) kms_sequence (queue-idle)
[71.194793] Starting subtest: queue-idle
[71.196903] Starting dynamic subtest: pipe-A-eDP-1
[73.007598] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[73.017786] Starting dynamic subtest: pipe-B-eDP-1
[75.536410] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.531s)
[75.545450] Starting dynamic subtest: pipe-C-eDP-1
[77.951949] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.417s)
[77.960799] Starting dynamic subtest: pipe-D-eDP-1
[80.381216] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.428s)
[80.383579] Subtest queue-idle: SUCCESS (9.195s)
[81.203530] [006/131] (935s left) gem_exec_schedule (lateslice)
[81.283045] Starting subtest: lateslice
[81.285129] Starting dynamic subtest: rcs0
[81.291051] Dynamic subtest rcs0: SUCCESS (0.020s)
[81.299673] Starting dynamic subtest: bcs0
[81.308890] Dynamic subtest bcs0: SUCCESS (0.017s)
[81.316239] Starting dynamic subtest: vcs0
[81.325706] Dynamic subtest vcs0: SUCCESS (0.017s)
[81.332654] Starting dynamic subtest: vcs1
[81.342973] Dynamic subtest vcs1: SUCCESS (0.017s)
[81.350204] Starting dynamic subtest: vecs0
[81.360384] Dynamic subtest vecs0: SUCCESS (0.017s)
[81.367535] Starting dynamic subtest: ccs0
[81.375115] Dynamic subtest ccs0: SUCCESS (0.015s)
[81.377402] Subtest lateslice: SUCCESS (0.104s)
[83.037122] [007/131] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[83.144311] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[83.148659] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[83.259650] [008/131] (933s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[83.794587] Starting subtest: syncobj-timeline-invalid-wait
[83.796887] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[85.004418] [009/131] (932s left) gem_exec_params (no-vebox)
[85.069552] Starting subtest: no-vebox
[85.071844] Subtest no-vebox: SUCCESS (0.002s)
[87.058564] [010/131] (930s left) gem_exec_balancer (parallel-contexts)
[87.332515] Starting subtest: parallel-contexts
[90.951814] Subtest parallel-contexts: SUCCESS (3.618s)
[91.167969] [011/131] (926s left) kms_pm_rpm (legacy-planes-dpms)
[93.024712] Starting subtest: legacy-planes-dpms
[93.027215] Starting dynamic subtest: plane-63
[101.630975] Dynamic subtest plane-63: SUCCESS (8.607s)
[101.641509] Starting dynamic subtest: plane-93
[109.954058] Dynamic subtest plane-93: SUCCESS (8.322s)
[109.964121] Starting dynamic subtest: plane-123
[118.576856] Dynamic subtest plane-123: SUCCESS (8.621s)
[118.586322] Starting dynamic subtest: plane-133
[127.150315] Dynamic subtest plane-133: SUCCESS (8.572s)
[127.153230] Subtest legacy-planes-dpms: SUCCESS (34.126s)
[127.554130] [012/131] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[127.661733] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[127.666108] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[127.797335] [013/131] (889s left) kms_cursor_edge_walk (64x64-left-edge)
[127.887753] Starting subtest: 64x64-left-edge
[127.890021] Starting dynamic subtest: pipe-A-eDP-1
[131.397509] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[131.413090] Starting dynamic subtest: pipe-D-eDP-1
[134.504170] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.106s)
[134.506430] Subtest 64x64-left-edge: SUCCESS (6.617s)
[135.342942] [014/131] (882s left) gem_mmap_offset (open-flood)
[135.390447] Starting subtest: open-flood
[156.886615] Subtest open-flood: SUCCESS (21.496s)
[157.029527] [015/131] (860s left) gem_spin_batch (spin-each)
[157.100229] Starting subtest: spin-each
[160.465073] Subtest spin-each: SUCCESS (3.358s)
[160.977985] [016/131] (856s left) gem_ctx_persistence (saturated-hostile)
[161.047056] Starting subtest: saturated-hostile
[161.049441] Starting dynamic subtest: rcs0
[161.908217] Dynamic subtest rcs0: SUCCESS (0.863s)
[161.918300] Starting dynamic subtest: bcs0
[162.705011] Dynamic subtest bcs0: SUCCESS (0.796s)
[162.719831] Starting dynamic subtest: vcs0
[163.514052] Dynamic subtest vcs0: SUCCESS (0.807s)
[163.524528] Starting dynamic subtest: vcs1
[164.339352] Dynamic subtest vcs1: SUCCESS (0.822s)
[164.349158] Starting dynamic subtest: vecs0
[165.171820] Dynamic subtest vecs0: SUCCESS (0.829s)
[165.181382] Starting dynamic subtest: ccs0
[166.004202] Dynamic subtest ccs0: SUCCESS (0.834s)
[166.006654] Subtest saturated-hostile: SUCCESS (4.960s)
[166.115206] [017/131] (851s left) gem_ctx_shared (q-independent)
[166.181403] Starting subtest: Q-independent
[166.183663] Starting dynamic subtest: rcs0
[166.298727] Dynamic subtest rcs0: SUCCESS (0.115s)
[166.308679] Starting dynamic subtest: vcs0
[166.355927] Dynamic subtest vcs0: SUCCESS (0.057s)
[166.364645] Starting dynamic subtest: vcs1
[166.421637] Dynamic subtest vcs1: SUCCESS (0.066s)
[166.437994] Starting dynamic subtest: vecs0
[166.487580] Dynamic subtest vecs0: SUCCESS (0.066s)
[166.499914] Starting dynamic subtest: ccs0
[166.566500] Dynamic subtest ccs0: SUCCESS (0.078s)
[166.569488] Subtest Q-independent: SUCCESS (0.384s)
[168.030100] [018/131] (849s left) kms_psr (fbc-psr-primary-render)
[168.127922] Starting subtest: fbc-psr-primary-render
[168.130116] Starting dynamic subtest: eDP-1
[168.134357] Dynamic subtest eDP-1: SKIP (0.000s)
[168.138641] Subtest fbc-psr-primary-render: SKIP (0.001s)
[168.225177] [019/131] (849s left) perf_pmu (rc6-all-gts)
[168.265088] Starting subtest: rc6-all-gts
[174.632884] Subtest rc6-all-gts: SUCCESS (6.365s)
[175.509291] [020/131] (842s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[175.614831] Starting subtest: crc-primary-suspend-y-tiled-ccs
[175.617054] Starting dynamic subtest: pipe-A-eDP-1
[175.625727] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.638738] Starting dynamic subtest: pipe-B-eDP-1
[175.647313] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.655784] Starting dynamic subtest: pipe-C-eDP-1
[175.662467] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.669054] Starting dynamic subtest: pipe-D-eDP-1
[175.675715] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.678934] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[177.896333] [021/131] (839s left) gem_pxp (create-regular-context-1)
[178.019600] Starting subtest: create-regular-context-1
[178.022058] Subtest create-regular-context-1: SUCCESS (0.002s)
[178.164569] [022/131] (839s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[178.224305] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[178.228801] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[178.428318] [023/131] (839s left) syncobj_timeline (host-signal-points)
[178.484540] Starting subtest: host-signal-points
[178.488911] Subtest host-signal-points: SUCCESS (0.006s)
[178.633033] [024/131] (839s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[178.728114] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[178.730378] Starting dynamic subtest: pipe-A-eDP-1
[178.755047] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[178.763542] Starting dynamic subtest: pipe-B-eDP-1
[178.788046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[178.797471] Starting dynamic subtest: pipe-C-eDP-1
[178.820395] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[178.828666] Starting dynamic subtest: pipe-D-eDP-1
[178.854384] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[178.858687] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[180.975410] [025/131] (836s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[181.066659] Starting subtest: stress-xrgb8888-xtiled
[186.991863] Subtest stress-xrgb8888-xtiled: SUCCESS (5.926s)
[187.042560] [026/131] (830s left) kms_async_flips (test-time-stamp)
[187.140159] Starting subtest: test-time-stamp
[187.528113] Starting dynamic subtest: pipe-A-eDP-1
[188.354655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[188.739580] Starting dynamic subtest: pipe-B-eDP-1
[189.499910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[189.865593] Starting dynamic subtest: pipe-C-eDP-1
[190.627765] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[190.988550] Starting dynamic subtest: pipe-D-eDP-1
[191.756799] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[191.759070] Subtest test-time-stamp: SUCCESS (4.616s)
[192.933594] [027/131] (825s left) prime_self_import (basic-with_two_bos)
[192.972400] Starting subtest: basic-with_two_bos
[192.994073] Subtest basic-with_two_bos: SUCCESS (0.022s)
[193.128863] [028/131] (824s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[193.230293] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[200.734109] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.507s)
[200.894876] [029/131] (817s left) gem_mmap_gtt (close-race)
[200.959679] Subtest close-race: SKIP (0.000s)
[201.024125] [030/131] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[201.116147] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[205.572778] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.459s)
[206.753101] [031/131] (811s left) gen9_exec_parse (valid-registers)
[206.813406] Subtest valid-registers: SKIP (0.000s)
[206.895187] [032/131] (811s left) kms_color (legacy-gamma-reset)
[206.991108] Starting subtest: legacy-gamma-reset
[206.993243] Starting dynamic subtest: pipe-A-eDP-1
[207.364211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s)
[207.372083] Starting dynamic subtest: pipe-B-eDP-1
[207.374325] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[207.381906] Starting dynamic subtest: pipe-C-eDP-1
[207.386847] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[207.394307] Starting dynamic subtest: pipe-D-eDP-1
[207.399466] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[207.401825] Subtest legacy-gamma-reset: SUCCESS (0.409s)
[208.179617] [033/131] (810s left) gem_partial_pwrite_pread (reads-snoop)
[208.245268] Subtest reads-snoop: SKIP (0.000s)
[208.330157] [034/131] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[208.420499] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[208.424676] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[208.538424] [035/131] (809s left) gem_exec_reloc (basic-gtt-noreloc)
[208.604985] Subtest basic-gtt-noreloc: SKIP (0.000s)
[208.692808] [036/131] (809s left) syncobj_timeline (invalid-transfer-illegal-handle)
[208.756584] Starting subtest: invalid-transfer-illegal-handle
[208.758522] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[208.886018] [037/131] (809s left) gem_ctx_param (invalid-get-engines)
[208.945133] Starting subtest: invalid-get-engines
[208.947705] Subtest invalid-get-engines: SUCCESS (0.001s)
[209.086625] [038/131] (809s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[209.180459] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[209.183915] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[209.322421] [039/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[209.429043] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[209.432848] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[209.573642] [040/131] (808s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[209.677614] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[209.681040] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[209.811239] [041/131] (808s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[209.905745] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[209.907797] Starting dynamic subtest: pipe-A-eDP-1
[209.927623] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[209.936842] Starting dynamic subtest: pipe-B-eDP-1
[209.955315] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.962665] Starting dynamic subtest: pipe-C-eDP-1
[209.980976] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.989203] Starting dynamic subtest: pipe-D-eDP-1
[210.008247] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.011677] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[212.229524] [042/131] (806s left) kms_plane_cursor (primary)
[212.321214] Starting subtest: primary
[212.325901] Starting dynamic subtest: pipe-A-eDP-1-size-64
[214.872436] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.550s)
[214.896061] Starting dynamic subtest: pipe-A-eDP-1-size-128
[217.449516] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[217.474649] Starting dynamic subtest: pipe-A-eDP-1-size-256
[220.019093] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.548s)
[220.339277] Starting dynamic subtest: pipe-B-eDP-1-size-64
[223.584678] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.252s)
[223.606620] Starting dynamic subtest: pipe-B-eDP-1-size-128
[226.151244] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[226.174315] Starting dynamic subtest: pipe-B-eDP-1-size-256
[228.697723] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.528s)
[229.025989] Starting dynamic subtest: pipe-C-eDP-1-size-64
[231.995954] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.989s)
[232.020070] Starting dynamic subtest: pipe-C-eDP-1-size-128
[234.172178] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.157s)
[234.197287] Starting dynamic subtest: pipe-C-eDP-1-size-256
[236.317412] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.124s)
[236.638767] Starting dynamic subtest: pipe-D-eDP-1-size-64
[239.497514] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.867s)
[239.523779] Starting dynamic subtest: pipe-D-eDP-1-size-128
[241.675470] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[241.701272] Starting dynamic subtest: pipe-D-eDP-1-size-256
[243.875374] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[244.182733] Subtest primary: SUCCESS (31.860s)
[245.037016] [043/131] (773s left) kms_flip (dpms-off-confusion-interruptible)
[245.132516] Starting subtest: dpms-off-confusion-interruptible
[245.134922] Starting dynamic subtest: A-eDP1
[253.817091] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[253.829260] Starting dynamic subtest: B-eDP1
[262.453640] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[262.466444] Starting dynamic subtest: C-eDP1
[271.064909] Dynamic subtest C-eDP1: SUCCESS (8.608s)
[271.076783] Starting dynamic subtest: D-eDP1
[279.694882] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[279.697138] Subtest dpms-off-confusion-interruptible: SUCCESS (34.566s)
[280.889722] [044/131] (737s left) kms_cursor_edge_walk (256x256-top-bottom)
[281.000114] Starting subtest: 256x256-top-bottom
[281.002373] Starting dynamic subtest: pipe-A-eDP-1
[284.420247] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[284.428926] Starting dynamic subtest: pipe-D-eDP-1
[287.554391] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[287.556687] Subtest 256x256-top-bottom: SUCCESS (6.555s)
[288.401545] [045/131] (730s left) kms_psr (pr-sprite-plane-onoff)
[288.508072] Starting subtest: pr-sprite-plane-onoff
[288.512168] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[288.602510] [046/131] (730s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[288.722440] Starting subtest: short-flip-before-cursor-toggle
[289.644167] Subtest short-flip-before-cursor-toggle: SUCCESS (0.921s)
[290.519501] [047/131] (728s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[290.617359] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[290.619731] Starting dynamic subtest: A-eDP1
[299.544077] Dynamic subtest A-eDP1: SUCCESS (8.926s)
[299.554079] Starting dynamic subtest: B-eDP1
[308.463678] Dynamic subtest B-eDP1: SUCCESS (8.918s)
[308.473290] Starting dynamic subtest: C-eDP1
[317.381478] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[317.392148] Starting dynamic subtest: D-eDP1
[326.319483] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[326.321940] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.703s)
[327.574921] [048/131] (691s left) gem_exec_params (secure-non-master)
[327.635095] Starting subtest: secure-non-master
[327.639199] Subtest secure-non-master: SKIP (0.000s)
[327.757819] [049/131] (691s left) kms_flip (2x-flip-vs-dpms)
[327.853184] Starting subtest: 2x-flip-vs-dpms
[327.861474] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[328.006632] [050/131] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[328.097632] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[328.102099] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[328.214855] [051/131] (690s left) drm_read (fault-buffer)
[328.365126] Starting subtest: fault-buffer
[328.367516] Subtest fault-buffer: SUCCESS (0.001s)
[328.546982] [052/131] (690s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[328.622405] Starting subtest: basic-batch-kernel-default-cmd
[328.625740] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[328.831490] [053/131] (690s left) kms_cursor_crc (cursor-offscreen-128x128)
[329.023884] Starting subtest: cursor-offscreen-128x128
[329.028536] Starting dynamic subtest: pipe-A-eDP-1
[330.948446] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.921s)
[330.977917] Starting dynamic subtest: pipe-D-eDP-1
[333.530977] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[333.533274] Subtest cursor-offscreen-128x128: SUCCESS (4.507s)
[334.429792] [054/131] (684s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[334.537818] Starting subtest: x-tiled-8bpp-rotate-90
[334.560808] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[334.711014] [055/131] (684s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[334.769944] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[334.871498] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[334.972559] [056/131] (684s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[335.087173] Starting subtest: 4-tiled-32bpp-rotate-90
[335.106139] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.018s)
[335.248962] [057/131] (683s left) core_setmaster (master-drop-set-shared-fd)
[335.348451] Starting subtest: master-drop-set-shared-fd
[335.370097] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[335.406379] [058/131] (683s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[335.500204] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[335.508720] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[335.640061] [059/131] (683s left) syncobj_wait (single-wait-all-submitted)
[335.694821] Starting subtest: single-wait-all-submitted
[335.801485] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[335.902405] [060/131] (683s left) kms_big_fb (linear-64bpp-rotate-270)
[336.002172] Starting subtest: linear-64bpp-rotate-270
[336.022139] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[336.172178] [061/131] (683s left) gem_exec_params (invalid-fence-in-submit)
[336.231407] Starting subtest: invalid-fence-in-submit
[336.237287] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[336.375312] [062/131] (683s left) syncobj_wait (single-wait-for-submit-submitted)
[336.437797] Starting subtest: single-wait-for-submit-submitted
[336.544114] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[336.640590] [063/131] (682s left) prime_vgem (fence-write-hang)
[336.731510] Subtest fence-write-hang: SKIP (0.000s)
[336.851856] [064/131] (682s left) syncobj_timeline (single-wait-signaled)
[336.899872] Starting subtest: single-wait-signaled
[336.902243] Subtest single-wait-signaled: SUCCESS (0.000s)
[337.043967] [065/131] (682s left) kms_chamelium_edid (vga-edid-read)
[337.437558] Subtest vga-edid-read: SKIP (0.000s)
[338.219736] [066/131] (681s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[338.339311] Starting subtest: 2x-long-flip-vs-cursor-atomic
[338.343678] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[338.504248] [067/131] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[338.605791] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[343.138595] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.536s)
[344.367836] [068/131] (675s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[344.489671] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[349.160211] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.674s)
[350.345094] [069/131] (669s left) prime_vgem (basic-read)
[350.433046] Starting subtest: basic-read
[350.451195] Subtest basic-read: SKIP (0.016s)
[350.580523] [070/131] (669s left) gem_userptr_blits (vma-merge)
[350.649056] Starting subtest: vma-merge
[350.686457] Subtest vma-merge: SUCCESS (0.037s)
[350.854704] [071/131] (668s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[350.967604] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[350.972168] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[351.099462] [072/131] (668s left) kms_vrr (negative-basic)
[351.198293] Starting subtest: negative-basic
[351.205069] Starting dynamic subtest: pipe-A-eDP-1
[356.638997] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.429s)
[356.941845] Subtest negative-basic: SUCCESS (5.742s)
[357.776722] [073/131] (662s left) gem_exec_reloc (basic-cpu-read-active)
[357.843805] Subtest basic-cpu-read-active: SKIP (0.000s)
[357.932312] [074/131] (661s left) kms_chamelium_hpd (hdmi-hpd)
[358.318819] Subtest hdmi-hpd: SKIP (0.000s)
[359.161540] [075/131] (660s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[359.268133] Starting subtest: yf-tiled-16bpp-rotate-0
[359.272675] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[359.404901] [076/131] (660s left) syncobj_timeline (reset-signaled)
[359.456587] Starting subtest: reset-signaled
[359.458796] Subtest reset-signaled: SUCCESS (0.000s)
[359.576191] [077/131] (660s left) kms_psr (fbc-psr2-basic)
[359.670270] Starting subtest: fbc-psr2-basic
[359.672157] Starting dynamic subtest: eDP-1
[359.676223] Dynamic subtest eDP-1: SKIP (0.000s)
[359.680287] Subtest fbc-psr2-basic: SKIP (0.001s)
[359.762467] [078/131] (660s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[359.859700] Starting subtest: primary-yf-tiled-reflect-x-0
[359.918225] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[360.043558] [079/131] (660s left) kms_prop_blob (basic)
[360.099145] Starting subtest: basic
[360.101107] Subtest basic: SUCCESS (0.000s)
[360.250690] [080/131] (659s left) vgem_basic (debugfs)
[360.312133] Starting subtest: debugfs
[360.314163] Subtest debugfs: SUCCESS (0.001s)
[360.397320] [081/131] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[360.498960] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[367.444108] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.946s)
[367.592207] [082/131] (652s left) gem_userptr_blits (unsync-unmap-cycles)
[367.668681] Subtest unsync-unmap-cycles: SKIP (0.000s)
[367.842015] [083/131] (652s left) perf_pmu (busy-double-start)
[367.877734] Starting subtest: busy-double-start
[367.880109] Starting dynamic subtest: rcs0
[371.518340] Dynamic subtest rcs0: FAIL (3.582s)
[371.528797] Starting dynamic subtest: bcs0
[375.033735] Dynamic subtest bcs0: SUCCESS (3.574s)
[375.043306] Starting dynamic subtest: vcs0
[379.457885] Dynamic subtest vcs0: SUCCESS (4.422s)
[379.469305] Starting dynamic subtest: vcs1
[383.496070] Dynamic subtest vcs1: SUCCESS (4.035s)
[383.507231] Starting dynamic subtest: vecs0
[387.410089] Dynamic subtest vecs0: SUCCESS (3.912s)
[387.420760] Starting dynamic subtest: ccs0
[391.046367] Dynamic subtest ccs0: FAIL (3.565s)
[391.048624] Subtest busy-double-start: FAIL (23.100s)
[391.121490] [084/131] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[391.235073] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[391.239357] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[391.381469] [085/131] (628s left) kms_chamelium_color (ctm-negative)
[391.472178] Subtest ctm-negative: SKIP (0.000s)
[391.517059] [086/131] (628s left) kms_async_flips (async-flip-dpms)
[391.613190] Starting subtest: async-flip-dpms
[391.986095] Starting dynamic subtest: pipe-A-eDP-1
[395.833445] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.849s)
[396.213550] Starting dynamic subtest: pipe-B-eDP-1
[398.993105] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.786s)
[399.358426] Starting dynamic subtest: pipe-C-eDP-1
[402.135359] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.783s)
[402.517499] Starting dynamic subtest: pipe-D-eDP-1
[405.301300] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[405.303692] Subtest async-flip-dpms: SUCCESS (13.689s)
[406.506459] [087/131] (613s left) gem_busy (semaphore)
[406.703769] Subtest semaphore: SKIP (0.000s)
[406.976356] [088/131] (613s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[407.076451] Starting subtest: flip-vs-dpms-off-vs-modeset
[407.078665] Starting dynamic subtest: A-eDP1
[410.733816] Dynamic subtest A-eDP1: SUCCESS (3.658s)
[410.742111] Starting dynamic subtest: B-eDP1
[413.924883] Dynamic subtest B-eDP1: SUCCESS (3.191s)
[413.932873] Starting dynamic subtest: C-eDP1
[417.052812] Dynamic subtest C-eDP1: SUCCESS (3.124s)
[417.062082] Starting dynamic subtest: D-eDP1
[420.162209] Dynamic subtest D-eDP1: SUCCESS (3.109s)
[420.164315] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.089s)
[420.983278] [089/131] (599s left) prime_mmap (test_reprime)
[421.038400] Starting subtest: test_reprime
[421.040631] Starting dynamic subtest: test_reprime-smem
[421.067334] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[421.069707] Subtest test_reprime: SUCCESS (0.032s)
[421.212894] [090/131] (599s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[426.238347] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[426.242971] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[427.114473] [091/131] (593s left) gem_exec_whisper (basic-fds)
[427.187563] Starting subtest: basic-fds
[433.069042] Subtest basic-fds: SUCCESS (5.881s)
[433.273812] [092/131] (587s left) gem_ctx_param (set-priority-range)
[433.343422] Starting subtest: set-priority-range
[433.358125] Subtest set-priority-range: SUCCESS (0.015s)
[433.510321] [093/131] (587s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[433.618882] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[433.621125] Starting dynamic subtest: pipe-A-default-mode
[436.319312] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[436.321720] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.702s)
[437.207485] [094/131] (583s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[437.310129] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[437.312346] Starting dynamic subtest: pipe-A-default-mode
[437.598627] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[437.603138] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.287s)
[438.434115] [095/131] (582s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[438.535905] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[438.540423] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[438.673173] [096/131] (582s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[438.762375] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[438.764658] Starting dynamic subtest: pipe-A-eDP-1
[438.910787] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[438.920971] Starting dynamic subtest: pipe-B-eDP-1
[438.939792] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[438.948067] Starting dynamic subtest: pipe-C-eDP-1
[438.967214] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[438.975095] Starting dynamic subtest: pipe-D-eDP-1
[438.993594] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[438.995652] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.171s)
[441.188510] [097/131] (579s left) i915_selftest (mock)
[444.698088] Starting subtest: mock
[444.700599] Starting dynamic subtest: sanitycheck
[445.392370] Dynamic subtest sanitycheck: SUCCESS (0.698s)
[445.401797] Starting dynamic subtest: shmem
[446.119302] Dynamic subtest shmem: SUCCESS (0.725s)
[446.128346] Starting dynamic subtest: fence
[454.068761] Dynamic subtest fence: SUCCESS (7.947s)
[454.077774] Starting dynamic subtest: scatterlist
[455.783855] Dynamic subtest scatterlist: SUCCESS (1.713s)
[455.793198] Starting dynamic subtest: syncmap
[459.166946] Dynamic subtest syncmap: SUCCESS (3.381s)
[459.176424] Starting dynamic subtest: uncore
[459.896186] Dynamic subtest uncore: SUCCESS (0.728s)
[459.905198] Starting dynamic subtest: ring
[460.609057] Dynamic subtest ring: SUCCESS (0.711s)
[460.617806] Starting dynamic subtest: engine
[461.299072] Dynamic subtest engine: SUCCESS (0.688s)
[461.307928] Starting dynamic subtest: timelines
[465.116068] Dynamic subtest timelines: SUCCESS (3.814s)
[465.125290] Starting dynamic subtest: requests
[468.905063] Dynamic subtest requests: SUCCESS (3.787s)
[468.913805] Starting dynamic subtest: objects
[469.765786] Dynamic subtest objects: SUCCESS (0.859s)
[469.774598] Starting dynamic subtest: phys
[470.629529] Dynamic subtest phys: SUCCESS (0.862s)
[470.637513] Starting dynamic subtest: dmabuf
[471.494475] Dynamic subtest dmabuf: SUCCESS (0.862s)
[471.502952] Starting dynamic subtest: vma
[476.821736] Dynamic subtest vma: SUCCESS (5.321s)
[476.830686] Starting dynamic subtest: evict
[478.248198] Dynamic subtest evict: SUCCESS (1.427s)
[478.257171] Starting dynamic subtest: gtt
[481.450496] Dynamic subtest gtt: SUCCESS (3.200s)
[481.459265] Starting dynamic subtest: hugepages
[482.398600] Dynamic subtest hugepages: SUCCESS (0.946s)
[482.408041] Starting dynamic subtest: memory_region
[485.003402] Dynamic subtest memory_region: SUCCESS (2.602s)
[485.006322] Subtest mock: SUCCESS (40.309s)
[485.033340] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[485.034118] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[485.037256] [098/131] (535s left) gem_ctx_exec (basic-close-race)
[486.573639] Starting subtest: basic-close-race
[492.728120] Subtest basic-close-race: SUCCESS (6.156s)
[492.829941] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[492.831321] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[492.834857] [099/131] (528s left) prime_busy (after)
[492.906445] Starting subtest: after
[492.911913] Starting dynamic subtest: rcs0
[492.964139] Dynamic subtest rcs0: SUCCESS (0.055s)
[492.973630] Starting dynamic subtest: bcs0
[493.023576] Dynamic subtest bcs0: SUCCESS (0.058s)
[493.031121] Starting dynamic subtest: vcs0
[493.063768] Dynamic subtest vcs0: SUCCESS (0.039s)
[493.077148] Starting dynamic subtest: vcs1
[493.104551] Dynamic subtest vcs1: SUCCESS (0.039s)
[493.111698] Starting dynamic subtest: vecs0
[493.143496] Dynamic subtest vecs0: SUCCESS (0.038s)
[493.150664] Starting dynamic subtest: ccs0
[493.184675] Dynamic subtest ccs0: SUCCESS (0.040s)
[493.294109] Subtest after: SUCCESS (0.386s)
[493.391152] [100/131] (527s left) syncobj_wait (reset-signaled)
[493.450061] Starting subtest: reset-signaled
[493.452409] Subtest reset-signaled: SUCCESS (0.000s)
[493.574328] [101/131] (527s left) kms_dsc (dsc-basic)
[493.670194] Starting subtest: dsc-basic
[493.683019] Subtest dsc-basic: SKIP (0.000s)
[493.760233] [102/131] (527s left) vgem_basic (bad-flag)
[493.807173] Starting subtest: bad-flag
[493.809765] Subtest bad-flag: SUCCESS (0.000s)
[493.925522] [103/131] (527s left) kms_psr (psr2-sprite-mmap-gtt)
[494.025035] Starting subtest: psr2-sprite-mmap-gtt
[494.027249] Starting dynamic subtest: eDP-1
[495.413992] Dynamic subtest eDP-1: SKIP (1.386s)
[495.418909] Subtest psr2-sprite-mmap-gtt: SKIP (1.388s)
[495.613823] [104/131] (525s left) gem_exec_balancer (noheartbeat)
[495.886037] Starting subtest: noheartbeat
[495.890890] Subtest noheartbeat: SKIP (0.000s)
[496.019461] [105/131] (525s left) gem_tiled_wb
[496.144744] [106/131] (525s left) gem_exec_reloc (basic-softpin)
[496.212176] Subtest basic-softpin: SKIP (0.000s)
[496.290596] [107/131] (525s left) gem_pxp (hw-rejects-pxp-buffer)
[496.414850] Starting subtest: hw-rejects-pxp-buffer
[496.419511] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[496.560149] [108/131] (524s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[501.544924] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[501.547443] Starting dynamic subtest: pipe-A-eDP-1
[502.325502] Dynamic subtest pipe-A-eDP-1: SKIP (0.777s)
[502.334286] Starting dynamic subtest: pipe-B-eDP-1
[503.448727] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[503.453254] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.903s)
[504.649429] [109/131] (516s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[504.759436] Starting subtest: 2x-cursor-vs-flip-legacy
[504.763828] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[504.928665] [110/131] (516s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[505.027603] Starting subtest: multiplane-rotation-cropping-bottom
[522.352663] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.327s)
[522.528576] [111/131] (498s left) gem_userptr_blits (sync-overlap)
[522.604287] Starting subtest: sync-overlap
[522.606275] Subtest sync-overlap: SUCCESS (0.000s)
[522.761414] [112/131] (498s left) kms_feature_discovery (psr2)
[522.844506] Starting subtest: psr2
[522.846300] Subtest psr2: SUCCESS (0.000s)
[522.937505] [113/131] (498s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[523.031192] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[529.715123] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.684s)
[529.861305] [114/131] (491s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[529.963785] Starting subtest: y-tiled-32bpp-rotate-0
[529.968335] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[530.083521] [115/131] (491s left) gem_mmap_gtt (basic-small-bo)
[530.147694] Subtest basic-small-bo: SKIP (0.000s)
[530.210901] [116/131] (491s left) api_intel_bb (simple-bb)
[530.266514] Starting subtest: simple-bb
[530.275921] Subtest simple-bb: SUCCESS (0.010s)
[530.448972] [117/131] (491s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[530.558207] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[530.560487] Starting dynamic subtest: pipe-A
[530.586437] Dynamic subtest pipe-A: SKIP (0.025s)
[530.594295] Starting dynamic subtest: pipe-B
[530.636294] Dynamic subtest pipe-B: SKIP (0.047s)
[530.645885] Starting dynamic subtest: pipe-C
[530.671122] Dynamic subtest pipe-C: SKIP (0.033s)
[530.680700] Starting dynamic subtest: pipe-D
[530.701422] Dynamic subtest pipe-D: SKIP (0.029s)
[530.705581] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.140s)
[530.836391] [118/131] (490s left) kms_lease (lease-unleased-connector)
[530.937903] Starting subtest: lease-unleased-connector
[530.939700] Starting dynamic subtest: pipe-A-eDP-1
[530.946958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[530.954897] Starting dynamic subtest: pipe-B-eDP-1
[530.957205] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[530.964865] Starting dynamic subtest: pipe-C-eDP-1
[530.966810] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[530.974540] Starting dynamic subtest: pipe-D-eDP-1
[530.976172] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[530.977748] Subtest lease-unleased-connector: SUCCESS (0.032s)
[531.100793] [119/131] (490s left) gen9_exec_parse (bb-secure)
[531.166553] Subtest bb-secure: SKIP (0.000s)
[531.248361] [120/131] (490s left) vgem_basic (mmap)
[531.292432] Starting subtest: mmap
[531.304798] Subtest mmap: SUCCESS (0.014s)
[531.382436] [121/131] (490s left) gem_eio (in-flight-contexts-10ms)
[531.619515] Starting subtest: in-flight-contexts-10ms
[542.882157] Subtest in-flight-contexts-10ms: SUCCESS (11.262s)
[543.081683] [122/131] (478s left) i915_pm_rpm (debugfs-forcewake-user)
[545.104381] Starting subtest: debugfs-forcewake-user
[556.494063] Subtest debugfs-forcewake-user: SUCCESS (11.390s)
[556.892266] [123/131] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[556.990801] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[556.995062] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[557.131640] [124/131] (464s left) kms_psr (fbc-pr-no-drrs)
[557.229883] Starting subtest: fbc-pr-no-drrs
[557.234082] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[557.327440] [125/131] (464s left) kms_invalid_mode (bad-htotal)
[557.431081] Starting subtest: bad-htotal
[557.433303] Starting dynamic subtest: pipe-A-eDP-1
[557.713864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[557.722678] Starting dynamic subtest: pipe-B-eDP-1
[557.724755] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[557.733077] Starting dynamic subtest: pipe-C-eDP-1
[557.735279] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[557.743476] Starting dynamic subtest: pipe-D-eDP-1
[557.745855] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[557.748215] Subtest bad-htotal: SUCCESS (0.291s)
[558.613067] [126/131] (463s left) kms_cursor_crc (cursor-random-128x42)
[558.856255] Starting subtest: cursor-random-128x42
[558.922339] Subtest cursor-random-128x42: SKIP (0.063s)
[559.162564] [127/131] (462s left) gem_linear_blits (interruptible)
[559.783581] Starting subtest: interruptible
[564.510997] Subtest interruptible: SUCCESS (4.730s)
[564.652871] [128/131] (457s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[564.797191] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[571.813111] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.018s)
[571.960094] [129/131] (450s left) i915_hangman (engine-engine-error)
[572.044484] Starting subtest: engine-engine-error
[572.046745] Starting dynamic subtest: rcs0
[573.875352] Dynamic subtest rcs0: SUCCESS (1.829s)
[573.887644] Starting dynamic subtest: bcs0
[575.859060] Dynamic subtest bcs0: SUCCESS (1.981s)
[575.871452] Starting dynamic subtest: vcs0
[577.843059] Dynamic subtest vcs0: SUCCESS (1.981s)
[577.855353] Starting dynamic subtest: vcs1
[579.891862] Dynamic subtest vcs1: SUCCESS (2.046s)
[579.903096] Starting dynamic subtest: vecs0
[581.876356] Dynamic subtest vecs0: SUCCESS (1.980s)
[581.887605] Starting dynamic subtest: ccs0
[583.858066] Dynamic subtest ccs0: SUCCESS (1.980s)
[583.860967] Subtest engine-engine-error: SUCCESS (11.814s)
[583.962888] [130/131] (438s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[584.078403] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[584.082796] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[584.208129] [131/131] (438s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[584.306454] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[584.308857] Starting dynamic subtest: pipe-A
[584.327337] Dynamic subtest pipe-A: SKIP (0.017s)
[584.337596] Starting dynamic subtest: pipe-B
[584.358160] Dynamic subtest pipe-B: SKIP (0.030s)
[584.367276] Starting dynamic subtest: pipe-C
[584.387751] Dynamic subtest pipe-C: SKIP (0.029s)
[584.396333] Starting dynamic subtest: pipe-D
[584.418963] Dynamic subtest pipe-D: SKIP (0.029s)
[584.422674] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.109s)
[584.558054] 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.