[56.012150] Initializing watchdogs
[56.012197]   /dev/watchdog0
[56.025531] [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.029675] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.031906] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.035213] [001/131] (960s left) vgem_slow (nohang)
[56.121742] Starting subtest: nohang
[66.162731] Subtest nohang: SUCCESS (10.041s)
[66.245954] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[66.248948] [002/131] (950s left) gem_userptr_blits (unsync-overlap)
[66.323258] Subtest unsync-overlap: SKIP (0.000s)
[66.491523] [003/131] (950s left) gem_exec_schedule (u-fairslice-all)
[66.564213] Starting subtest: u-fairslice-all
[68.638908] Subtest u-fairslice-all: SUCCESS (2.078s)
[70.038222] [004/131] (946s left) gem_lmem_swapping (parallel-random)
[70.077884] Subtest parallel-random: SKIP (0.000s)
[70.115091] [005/131] (946s left) kms_sequence (queue-idle)
[70.228920] Starting subtest: queue-idle
[70.231434] Starting dynamic subtest: pipe-A-eDP-1
[72.057128] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.828s)
[72.065981] Starting dynamic subtest: pipe-B-eDP-1
[74.530837] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.474s)
[74.539697] Starting dynamic subtest: pipe-C-eDP-1
[76.961710] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.430s)
[76.970797] Starting dynamic subtest: pipe-D-eDP-1
[79.417713] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.454s)
[79.420197] Subtest queue-idle: SUCCESS (9.189s)
[80.241271] [006/131] (936s left) gem_exec_schedule (lateslice)
[80.319048] Starting subtest: lateslice
[80.321049] Starting dynamic subtest: rcs0
[80.328637] Dynamic subtest rcs0: SUCCESS (0.018s)
[80.337634] Starting dynamic subtest: bcs0
[80.347643] Dynamic subtest bcs0: SUCCESS (0.019s)
[80.354755] Starting dynamic subtest: vcs0
[80.366223] Dynamic subtest vcs0: SUCCESS (0.018s)
[80.372874] Starting dynamic subtest: vcs1
[80.384250] Dynamic subtest vcs1: SUCCESS (0.018s)
[80.391078] Starting dynamic subtest: vecs0
[80.404260] Dynamic subtest vecs0: SUCCESS (0.019s)
[80.410797] Starting dynamic subtest: ccs0
[80.420930] Dynamic subtest ccs0: SUCCESS (0.017s)
[80.423181] Subtest lateslice: SUCCESS (0.112s)
[81.990428] [007/131] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[82.090394] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[82.094715] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[82.208794] [008/131] (934s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[82.754571] Starting subtest: syncobj-timeline-invalid-wait
[82.756962] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[84.046886] [009/131] (932s left) gem_exec_params (no-vebox)
[84.114272] Starting subtest: no-vebox
[84.118619] Subtest no-vebox: SUCCESS (0.003s)
[86.026918] [010/131] (930s left) gem_exec_balancer (parallel-contexts)
[86.279208] Starting subtest: parallel-contexts
[89.961641] Subtest parallel-contexts: SUCCESS (3.682s)
[90.147825] [011/131] (926s left) kms_pm_rpm (legacy-planes-dpms)
[92.120035] Starting subtest: legacy-planes-dpms
[92.122533] Starting dynamic subtest: plane-63
[100.398351] Dynamic subtest plane-63: SUCCESS (8.282s)
[100.408670] Starting dynamic subtest: plane-93
[108.995650] Dynamic subtest plane-93: SUCCESS (8.596s)
[109.006225] Starting dynamic subtest: plane-123
[117.323688] Dynamic subtest plane-123: SUCCESS (8.328s)
[117.335181] Starting dynamic subtest: plane-133
[125.925865] Dynamic subtest plane-133: SUCCESS (8.600s)
[125.928473] Subtest legacy-planes-dpms: SUCCESS (33.810s)
[126.315800] [012/131] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[126.427058] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[126.431243] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[126.566143] [013/131] (890s left) kms_cursor_edge_walk (64x64-left-edge)
[126.674226] Starting subtest: 64x64-left-edge
[126.676565] Starting dynamic subtest: pipe-A-eDP-1
[130.158451] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[130.167639] Starting dynamic subtest: pipe-D-eDP-1
[133.270265] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[133.272599] Subtest 64x64-left-edge: SUCCESS (6.598s)
[134.102345] [014/131] (882s left) gem_mmap_offset (open-flood)
[134.161668] Starting subtest: open-flood
[155.649918] Subtest open-flood: SUCCESS (21.489s)
[155.783376] [015/131] (861s left) gem_spin_batch (spin-each)
[155.852946] Starting subtest: spin-each
[159.222595] Subtest spin-each: SUCCESS (3.368s)
[160.009378] [016/131] (857s left) gem_ctx_persistence (saturated-hostile)
[160.077905] Starting subtest: saturated-hostile
[160.080314] Starting dynamic subtest: rcs0
[160.900349] Dynamic subtest rcs0: SUCCESS (0.822s)
[160.911586] Starting dynamic subtest: bcs0
[161.719603] Dynamic subtest bcs0: SUCCESS (0.818s)
[161.730247] Starting dynamic subtest: vcs0
[162.536914] Dynamic subtest vcs0: SUCCESS (0.816s)
[162.546799] Starting dynamic subtest: vcs1
[163.353264] Dynamic subtest vcs1: SUCCESS (0.815s)
[163.363484] Starting dynamic subtest: vecs0
[164.167518] Dynamic subtest vecs0: SUCCESS (0.810s)
[164.177382] Starting dynamic subtest: ccs0
[164.975879] Dynamic subtest ccs0: SUCCESS (0.810s)
[164.978568] Subtest saturated-hostile: SUCCESS (4.898s)
[165.077392] [017/131] (852s left) gem_ctx_shared (q-independent)
[165.146852] Starting subtest: Q-independent
[165.149866] Starting dynamic subtest: rcs0
[165.258032] Dynamic subtest rcs0: SUCCESS (0.113s)
[165.269185] Starting dynamic subtest: vcs0
[165.320473] Dynamic subtest vcs0: SUCCESS (0.062s)
[165.330559] Starting dynamic subtest: vcs1
[165.390322] Dynamic subtest vcs1: SUCCESS (0.070s)
[165.400204] Starting dynamic subtest: vecs0
[165.463165] Dynamic subtest vecs0: SUCCESS (0.072s)
[165.473600] Starting dynamic subtest: ccs0
[165.548707] Dynamic subtest ccs0: SUCCESS (0.084s)
[165.551553] Subtest Q-independent: SUCCESS (0.405s)
[167.066857] [018/131] (850s left) kms_psr (fbc-psr-primary-render)
[167.165060] Starting subtest: fbc-psr-primary-render
[167.167328] Starting dynamic subtest: eDP-1
[167.171548] Dynamic subtest eDP-1: SKIP (0.000s)
[167.175700] Subtest fbc-psr-primary-render: SKIP (0.001s)
[167.257873] [019/131] (849s left) perf_pmu (rc6-all-gts)
[167.298691] Starting subtest: rc6-all-gts
[173.671176] Subtest rc6-all-gts: SUCCESS (6.371s)
[174.553340] [020/131] (842s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[174.667765] Starting subtest: crc-primary-suspend-y-tiled-ccs
[174.670074] Starting dynamic subtest: pipe-A-eDP-1
[174.679076] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.687024] Starting dynamic subtest: pipe-B-eDP-1
[174.694869] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[174.701861] Starting dynamic subtest: pipe-C-eDP-1
[174.708777] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[174.715562] Starting dynamic subtest: pipe-D-eDP-1
[174.722346] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[174.725747] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[176.875436] [021/131] (840s left) gem_pxp (create-regular-context-1)
[176.991839] Starting subtest: create-regular-context-1
[176.994433] Subtest create-regular-context-1: SUCCESS (0.002s)
[177.116831] [022/131] (840s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[177.177457] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[177.182281] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[177.381045] [023/131] (839s left) syncobj_timeline (host-signal-points)
[177.430232] Starting subtest: host-signal-points
[177.432204] Subtest host-signal-points: SUCCESS (0.004s)
[177.544290] [024/131] (839s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[177.636067] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[177.648543] Starting dynamic subtest: pipe-A-eDP-1
[177.672279] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[177.681642] Starting dynamic subtest: pipe-B-eDP-1
[177.705512] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[177.714689] Starting dynamic subtest: pipe-C-eDP-1
[177.738162] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[177.746518] Starting dynamic subtest: pipe-D-eDP-1
[177.770371] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[177.774411] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[179.851937] [025/131] (837s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[179.953637] Starting subtest: stress-xrgb8888-xtiled
[185.790630] Subtest stress-xrgb8888-xtiled: SUCCESS (5.838s)
[185.840887] [026/131] (831s left) kms_async_flips (test-time-stamp)
[185.936680] Starting subtest: test-time-stamp
[186.317762] Starting dynamic subtest: pipe-A-eDP-1
[187.138762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s)
[187.502349] Starting dynamic subtest: pipe-B-eDP-1
[188.265945] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.767s)
[188.641471] Starting dynamic subtest: pipe-C-eDP-1
[189.404138] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[189.770864] Starting dynamic subtest: pipe-D-eDP-1
[190.534244] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[190.536714] Subtest test-time-stamp: SUCCESS (4.596s)
[191.717690] [027/131] (825s left) prime_self_import (basic-with_two_bos)
[191.753407] Starting subtest: basic-with_two_bos
[191.769038] Subtest basic-with_two_bos: SUCCESS (0.016s)
[191.889075] [028/131] (825s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[191.979580] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[199.482998] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.506s)
[199.650620] [029/131] (817s left) gem_mmap_gtt (close-race)
[199.712749] Subtest close-race: SKIP (0.000s)
[199.779485] [030/131] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[199.874404] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[204.266240] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.394s)
[205.479635] [031/131] (812s left) gen9_exec_parse (valid-registers)
[205.542640] Subtest valid-registers: SKIP (0.000s)
[205.617486] [032/131] (812s left) kms_color (legacy-gamma-reset)
[205.709087] Starting subtest: legacy-gamma-reset
[205.710889] Starting dynamic subtest: pipe-A-eDP-1
[206.081779] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[206.089979] Starting dynamic subtest: pipe-B-eDP-1
[206.094410] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[206.102325] Starting dynamic subtest: pipe-C-eDP-1
[206.106772] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[206.114593] Starting dynamic subtest: pipe-D-eDP-1
[206.119763] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[206.122186] Subtest legacy-gamma-reset: SUCCESS (0.410s)
[206.965388] [033/131] (810s left) gem_partial_pwrite_pread (reads-snoop)
[207.026631] Subtest reads-snoop: SKIP (0.000s)
[207.108217] [034/131] (810s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[207.201942] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[207.206186] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[207.334386] [035/131] (810s left) gem_exec_reloc (basic-gtt-noreloc)
[207.403683] Subtest basic-gtt-noreloc: SKIP (0.000s)
[207.486600] [036/131] (810s left) syncobj_timeline (invalid-transfer-illegal-handle)
[207.550829] Starting subtest: invalid-transfer-illegal-handle
[207.553169] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[207.667134] [037/131] (810s left) gem_ctx_param (invalid-get-engines)
[207.730471] Starting subtest: invalid-get-engines
[207.732555] Subtest invalid-get-engines: SUCCESS (0.001s)
[207.863673] [038/131] (810s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[207.959924] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[207.963493] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[208.077524] [039/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[208.175089] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[208.178517] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[208.308422] [040/131] (809s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[208.410039] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[208.413571] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[208.536401] [041/131] (809s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[208.633452] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[208.635385] Starting dynamic subtest: pipe-A-eDP-1
[208.654202] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.663530] Starting dynamic subtest: pipe-B-eDP-1
[208.681193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.689061] Starting dynamic subtest: pipe-C-eDP-1
[208.706915] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.715455] Starting dynamic subtest: pipe-D-eDP-1
[208.733271] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.736648] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[210.925428] [042/131] (807s left) kms_plane_cursor (primary)
[211.016492] Starting subtest: primary
[211.020783] Starting dynamic subtest: pipe-A-eDP-1-size-64
[213.590743] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.575s)
[213.618241] Starting dynamic subtest: pipe-A-eDP-1-size-128
[216.167940] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[216.192518] Starting dynamic subtest: pipe-A-eDP-1-size-256
[218.781492] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.593s)
[219.096392] Starting dynamic subtest: pipe-B-eDP-1-size-64
[222.358478] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.272s)
[222.385045] Starting dynamic subtest: pipe-B-eDP-1-size-128
[224.949439] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[224.972465] Starting dynamic subtest: pipe-B-eDP-1-size-256
[227.517075] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[227.831122] Starting dynamic subtest: pipe-C-eDP-1-size-64
[230.716200] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.894s)
[230.749750] Starting dynamic subtest: pipe-C-eDP-1-size-128
[232.917079] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.179s)
[232.941933] Starting dynamic subtest: pipe-C-eDP-1-size-256
[235.072269] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.136s)
[235.391647] Starting dynamic subtest: pipe-D-eDP-1-size-64
[238.230910] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.849s)
[238.264019] Starting dynamic subtest: pipe-D-eDP-1-size-128
[240.377342] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.127s)
[240.401369] Starting dynamic subtest: pipe-D-eDP-1-size-256
[242.475403] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.079s)
[242.783569] Subtest primary: SUCCESS (31.765s)
[243.646694] [043/131] (774s left) kms_flip (dpms-off-confusion-interruptible)
[243.737232] Starting subtest: dpms-off-confusion-interruptible
[243.739505] Starting dynamic subtest: A-eDP1
[252.422090] Dynamic subtest A-eDP1: SUCCESS (8.683s)
[252.432447] Starting dynamic subtest: B-eDP1
[261.046780] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[261.055650] Starting dynamic subtest: C-eDP1
[269.669148] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[269.681454] Starting dynamic subtest: D-eDP1
[278.288554] Dynamic subtest D-eDP1: SUCCESS (8.616s)
[278.293173] Subtest dpms-off-confusion-interruptible: SUCCESS (34.556s)
[279.579141] [044/131] (738s left) kms_cursor_edge_walk (256x256-top-bottom)
[279.675762] Starting subtest: 256x256-top-bottom
[279.678052] Starting dynamic subtest: pipe-A-eDP-1
[283.111589] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.434s)
[283.120770] Starting dynamic subtest: pipe-D-eDP-1
[286.251312] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[286.253678] Subtest 256x256-top-bottom: SUCCESS (6.576s)
[287.072454] [045/131] (731s left) kms_psr (pr-sprite-plane-onoff)
[287.166579] Starting subtest: pr-sprite-plane-onoff
[287.170804] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[287.262667] [046/131] (731s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[287.385511] Starting subtest: short-flip-before-cursor-toggle
[288.309178] Subtest short-flip-before-cursor-toggle: SUCCESS (0.924s)
[289.198276] [047/131] (729s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[289.305096] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[289.307278] Starting dynamic subtest: A-eDP1
[298.214187] Dynamic subtest A-eDP1: SUCCESS (8.908s)
[298.224915] Starting dynamic subtest: B-eDP1
[307.134881] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[307.144389] Starting dynamic subtest: C-eDP1
[316.060766] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[316.071275] Starting dynamic subtest: D-eDP1
[324.891729] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[324.897655] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.590s)
[326.143601] [048/131] (692s left) gem_exec_params (secure-non-master)
[326.211646] Starting subtest: secure-non-master
[326.216215] Subtest secure-non-master: SKIP (0.000s)
[326.336636] [049/131] (692s left) kms_flip (2x-flip-vs-dpms)
[326.428134] Starting subtest: 2x-flip-vs-dpms
[326.436501] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[326.543894] [050/131] (691s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[326.650327] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[326.654231] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[326.766643] [051/131] (691s left) drm_read (fault-buffer)
[326.910886] Starting subtest: fault-buffer
[326.913323] Subtest fault-buffer: SUCCESS (0.000s)
[327.073549] [052/131] (691s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[327.142399] Starting subtest: basic-batch-kernel-default-cmd
[327.146309] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[327.352661] [053/131] (691s left) kms_cursor_crc (cursor-offscreen-128x128)
[327.557510] Starting subtest: cursor-offscreen-128x128
[327.562373] Starting dynamic subtest: pipe-A-eDP-1
[329.484787] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[329.525870] Starting dynamic subtest: pipe-D-eDP-1
[332.097792] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.588s)
[332.100222] Subtest cursor-offscreen-128x128: SUCCESS (4.540s)
[332.987334] [054/131] (685s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[333.086138] Starting subtest: x-tiled-8bpp-rotate-90
[333.107132] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[333.265442] [055/131] (685s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[333.322490] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[333.424509] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[333.524126] [056/131] (685s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[333.622314] Starting subtest: 4-tiled-32bpp-rotate-90
[333.642029] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[333.790197] [057/131] (684s left) core_setmaster (master-drop-set-shared-fd)
[333.887578] Starting subtest: master-drop-set-shared-fd
[333.906793] Subtest master-drop-set-shared-fd: SUCCESS (0.020s)
[333.952424] [058/131] (684s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[334.059054] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[334.068404] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[334.215133] [059/131] (684s left) syncobj_wait (single-wait-all-submitted)
[334.281077] Starting subtest: single-wait-all-submitted
[334.384577] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[334.482477] [060/131] (684s left) kms_big_fb (linear-64bpp-rotate-270)
[334.589143] Starting subtest: linear-64bpp-rotate-270
[334.607905] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[334.767401] [061/131] (684s left) gem_exec_params (invalid-fence-in-submit)
[334.823477] Starting subtest: invalid-fence-in-submit
[334.828363] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[334.967033] [062/131] (684s left) syncobj_wait (single-wait-for-submit-submitted)
[335.032770] Starting subtest: single-wait-for-submit-submitted
[335.137410] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[335.235372] [063/131] (683s left) prime_vgem (fence-write-hang)
[335.302314] Subtest fence-write-hang: SKIP (0.000s)
[335.437352] [064/131] (683s left) syncobj_timeline (single-wait-signaled)
[335.497609] Starting subtest: single-wait-signaled
[335.499930] Subtest single-wait-signaled: SUCCESS (0.000s)
[335.635779] [065/131] (683s left) kms_chamelium_edid (vga-edid-read)
[336.016780] Subtest vga-edid-read: SKIP (0.000s)
[336.868625] [066/131] (682s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[336.990871] Starting subtest: 2x-long-flip-vs-cursor-atomic
[336.995433] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[337.158718] [067/131] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[337.267969] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[341.797264] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.532s)
[343.012666] [068/131] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[343.116635] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[347.754802] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.643s)
[348.909839] [069/131] (670s left) prime_vgem (basic-read)
[348.982156] Starting subtest: basic-read
[349.000690] Subtest basic-read: SKIP (0.016s)
[349.158327] [070/131] (670s left) gem_userptr_blits (vma-merge)
[349.236111] Starting subtest: vma-merge
[349.274734] Subtest vma-merge: SUCCESS (0.039s)
[349.439860] [071/131] (669s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[349.548828] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[349.553296] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[349.680378] [072/131] (669s left) kms_vrr (negative-basic)
[349.781816] Starting subtest: negative-basic
[349.788645] Starting dynamic subtest: pipe-A-eDP-1
[355.202568] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.412s)
[355.493243] Subtest negative-basic: SUCCESS (5.710s)
[356.326860] [073/131] (663s left) gem_exec_reloc (basic-cpu-read-active)
[356.380043] Subtest basic-cpu-read-active: SKIP (0.000s)
[356.452286] [074/131] (663s left) kms_chamelium_hpd (hdmi-hpd)
[356.828593] Subtest hdmi-hpd: SKIP (0.000s)
[357.611566] [075/131] (661s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[357.710091] Starting subtest: yf-tiled-16bpp-rotate-0
[357.714433] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[357.820964] [076/131] (661s left) syncobj_timeline (reset-signaled)
[357.875069] Starting subtest: reset-signaled
[357.877540] Subtest reset-signaled: SUCCESS (0.000s)
[358.008122] [077/131] (661s left) kms_psr (fbc-psr2-basic)
[358.097295] Starting subtest: fbc-psr2-basic
[358.099201] Starting dynamic subtest: eDP-1
[358.103390] Dynamic subtest eDP-1: SKIP (0.000s)
[358.107543] Subtest fbc-psr2-basic: SKIP (0.001s)
[358.195228] [078/131] (661s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[358.302217] Starting subtest: primary-yf-tiled-reflect-x-0
[358.361642] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[358.484148] [079/131] (661s left) kms_prop_blob (basic)
[358.553106] Starting subtest: basic
[358.555855] Subtest basic: SUCCESS (0.000s)
[358.685740] [080/131] (661s left) vgem_basic (debugfs)
[358.720055] Starting subtest: debugfs
[358.721999] Subtest debugfs: SUCCESS (0.000s)
[358.798475] [081/131] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[358.898798] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[365.876078] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.979s)
[366.037484] [082/131] (653s left) gem_userptr_blits (unsync-unmap-cycles)
[366.117955] Subtest unsync-unmap-cycles: SKIP (0.000s)
[366.259039] [083/131] (653s left) perf_pmu (busy-double-start)
[366.296728] Starting subtest: busy-double-start
[366.298740] Starting dynamic subtest: rcs0
[369.861200] Dynamic subtest rcs0: SUCCESS (3.566s)
[369.876386] Starting dynamic subtest: bcs0
[373.429514] Dynamic subtest bcs0: SUCCESS (3.566s)
[373.440227] Starting dynamic subtest: vcs0
[377.435937] Dynamic subtest vcs0: SUCCESS (4.005s)
[377.445759] Starting dynamic subtest: vcs1
[381.444272] Dynamic subtest vcs1: SUCCESS (4.005s)
[381.454981] Starting dynamic subtest: vecs0
[385.431226] Dynamic subtest vecs0: SUCCESS (3.985s)
[385.441303] Starting dynamic subtest: ccs0
[389.074992] Dynamic subtest ccs0: FAIL (3.582s)
[389.077304] Subtest busy-double-start: FAIL (22.721s)
[389.156359] [084/131] (630s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[389.269625] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[389.274138] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[389.398149] [085/131] (630s left) kms_chamelium_color (ctm-negative)
[389.494679] Subtest ctm-negative: SKIP (0.000s)
[389.537494] [086/131] (630s left) kms_async_flips (async-flip-dpms)
[389.637992] Starting subtest: async-flip-dpms
[390.015788] Starting dynamic subtest: pipe-A-eDP-1
[393.861150] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.844s)
[394.228143] Starting dynamic subtest: pipe-B-eDP-1
[397.020070] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.796s)
[397.397714] Starting dynamic subtest: pipe-C-eDP-1
[400.178432] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.787s)
[400.552055] Starting dynamic subtest: pipe-D-eDP-1
[403.344781] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.799s)
[403.347022] Subtest async-flip-dpms: SUCCESS (13.709s)
[404.543554] [087/131] (615s left) gem_busy (semaphore)
[404.733885] Subtest semaphore: SKIP (0.000s)
[405.007582] [088/131] (615s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[405.108290] Starting subtest: flip-vs-dpms-off-vs-modeset
[405.110602] Starting dynamic subtest: A-eDP1
[408.729315] Dynamic subtest A-eDP1: SUCCESS (3.622s)
[408.738580] Starting dynamic subtest: B-eDP1
[411.962266] Dynamic subtest B-eDP1: SUCCESS (3.229s)
[411.971023] Starting dynamic subtest: C-eDP1
[415.150512] Dynamic subtest C-eDP1: SUCCESS (3.187s)
[415.159427] Starting dynamic subtest: D-eDP1
[418.249770] Dynamic subtest D-eDP1: SUCCESS (3.100s)
[418.252042] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.146s)
[419.066489] [089/131] (600s left) prime_mmap (test_reprime)
[419.131640] Starting subtest: test_reprime
[419.133574] Starting dynamic subtest: test_reprime-smem
[419.160575] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[419.162972] Subtest test_reprime: SUCCESS (0.032s)
[419.305961] [090/131] (600s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[424.322497] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[424.327045] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[425.200960] [091/131] (594s left) gem_exec_whisper (basic-fds)
[425.267322] Starting subtest: basic-fds
[431.088950] Subtest basic-fds: SUCCESS (5.821s)
[431.295344] [092/131] (588s left) gem_ctx_param (set-priority-range)
[431.349663] Starting subtest: set-priority-range
[431.365186] Subtest set-priority-range: SUCCESS (0.015s)
[431.501920] [093/131] (588s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[431.597987] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[431.600339] Starting dynamic subtest: pipe-A-default-mode
[434.327408] Dynamic subtest pipe-A-default-mode: SUCCESS (2.728s)
[434.329835] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.730s)
[435.192128] [094/131] (585s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[435.297094] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[435.299360] Starting dynamic subtest: pipe-A-default-mode
[435.584679] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[435.589167] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.287s)
[436.422227] [095/131] (583s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[436.531021] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[436.535575] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[436.650815] [096/131] (583s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[436.747706] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[436.749958] Starting dynamic subtest: pipe-A-eDP-1
[436.891997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[436.902291] Starting dynamic subtest: pipe-B-eDP-1
[436.921583] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[436.930074] Starting dynamic subtest: pipe-C-eDP-1
[436.950025] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[436.957810] Starting dynamic subtest: pipe-D-eDP-1
[436.977117] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[436.979228] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.170s)
[439.194553] [097/131] (581s left) i915_selftest (mock)
[442.616753] Starting subtest: mock
[442.618904] Starting dynamic subtest: sanitycheck
[443.337345] Dynamic subtest sanitycheck: SUCCESS (0.724s)
[443.346200] Starting dynamic subtest: shmem
[444.081141] Dynamic subtest shmem: SUCCESS (0.742s)
[444.090074] Starting dynamic subtest: fence
[452.081343] Dynamic subtest fence: SUCCESS (7.997s)
[452.090581] Starting dynamic subtest: scatterlist
[453.838990] Dynamic subtest scatterlist: SUCCESS (1.755s)
[453.847887] Starting dynamic subtest: syncmap
[457.245242] Dynamic subtest syncmap: SUCCESS (3.404s)
[457.254249] Starting dynamic subtest: uncore
[457.968160] Dynamic subtest uncore: SUCCESS (0.721s)
[457.976754] Starting dynamic subtest: ring
[458.724169] Dynamic subtest ring: SUCCESS (0.754s)
[458.733080] Starting dynamic subtest: engine
[459.486199] Dynamic subtest engine: SUCCESS (0.760s)
[459.494960] Starting dynamic subtest: timelines
[463.353228] Dynamic subtest timelines: SUCCESS (3.864s)
[463.362340] Starting dynamic subtest: requests
[466.793089] Dynamic subtest requests: SUCCESS (3.437s)
[466.802027] Starting dynamic subtest: objects
[467.691440] Dynamic subtest objects: SUCCESS (0.897s)
[467.699263] Starting dynamic subtest: phys
[468.577517] Dynamic subtest phys: SUCCESS (0.884s)
[468.586332] Starting dynamic subtest: dmabuf
[469.455446] Dynamic subtest dmabuf: SUCCESS (0.876s)
[469.464086] Starting dynamic subtest: vma
[474.744227] Dynamic subtest vma: SUCCESS (5.286s)
[474.753170] Starting dynamic subtest: evict
[476.168248] Dynamic subtest evict: SUCCESS (1.422s)
[476.177107] Starting dynamic subtest: gtt
[479.423956] Dynamic subtest gtt: SUCCESS (3.228s)
[479.432903] Starting dynamic subtest: hugepages
[480.370976] Dynamic subtest hugepages: SUCCESS (0.969s)
[480.379676] Starting dynamic subtest: memory_region
[482.922100] Dynamic subtest memory_region: SUCCESS (2.549s)
[482.924893] Subtest mock: SUCCESS (40.309s)
[482.951811] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[482.952493] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[482.955586] [098/131] (537s left) gem_ctx_exec (basic-close-race)
[484.481681] Starting subtest: basic-close-race
[490.543889] Subtest basic-close-race: SUCCESS (6.061s)
[490.659128] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[490.660367] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[490.666227] [099/131] (529s left) prime_busy (after)
[490.745308] Starting subtest: after
[490.747704] Starting dynamic subtest: rcs0
[490.785021] Dynamic subtest rcs0: SUCCESS (0.039s)
[490.794315] Starting dynamic subtest: bcs0
[490.843645] Dynamic subtest bcs0: SUCCESS (0.058s)
[490.852055] Starting dynamic subtest: vcs0
[490.884907] Dynamic subtest vcs0: SUCCESS (0.041s)
[490.892654] Starting dynamic subtest: vcs1
[490.926775] Dynamic subtest vcs1: SUCCESS (0.041s)
[490.935544] Starting dynamic subtest: vecs0
[490.968361] Dynamic subtest vecs0: SUCCESS (0.041s)
[490.976604] Starting dynamic subtest: ccs0
[491.011575] Dynamic subtest ccs0: SUCCESS (0.043s)
[491.121213] Subtest after: SUCCESS (0.376s)
[491.233532] [100/131] (529s left) syncobj_wait (reset-signaled)
[491.291063] Starting subtest: reset-signaled
[491.293843] Subtest reset-signaled: SUCCESS (0.000s)
[491.414817] [101/131] (529s left) kms_dsc (dsc-basic)
[491.505866] Starting subtest: dsc-basic
[491.518977] Subtest dsc-basic: SKIP (0.000s)
[491.600442] [102/131] (528s left) vgem_basic (bad-flag)
[491.653370] Starting subtest: bad-flag
[491.655609] Subtest bad-flag: SUCCESS (0.000s)
[491.735876] [103/131] (528s left) kms_psr (psr2-sprite-mmap-gtt)
[491.825920] Starting subtest: psr2-sprite-mmap-gtt
[491.828277] Starting dynamic subtest: eDP-1
[493.215757] Dynamic subtest eDP-1: SKIP (1.387s)
[493.220683] Subtest psr2-sprite-mmap-gtt: SKIP (1.389s)
[493.427907] [104/131] (527s left) gem_exec_balancer (noheartbeat)
[493.686283] Starting subtest: noheartbeat
[493.691255] Subtest noheartbeat: SKIP (0.000s)
[493.821638] [105/131] (526s left) gem_tiled_wb
[493.951263] [106/131] (526s left) gem_exec_reloc (basic-softpin)
[494.008955] Subtest basic-softpin: SKIP (0.000s)
[494.071837] [107/131] (526s left) gem_pxp (hw-rejects-pxp-buffer)
[494.204502] Starting subtest: hw-rejects-pxp-buffer
[494.209371] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[494.335420] [108/131] (526s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[499.332168] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[499.334322] Starting dynamic subtest: pipe-A-eDP-1
[500.116939] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s)
[500.124535] Starting dynamic subtest: pipe-B-eDP-1
[501.250895] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[501.255187] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.918s)
[502.445182] [109/131] (518s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[502.570551] Starting subtest: 2x-cursor-vs-flip-legacy
[502.575056] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[502.740901] [110/131] (518s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[502.843956] Starting subtest: multiplane-rotation-cropping-bottom
[520.259846] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.417s)
[520.418974] [111/131] (500s left) gem_userptr_blits (sync-overlap)
[520.481808] Starting subtest: sync-overlap
[520.483733] Subtest sync-overlap: SUCCESS (0.000s)
[520.640632] [112/131] (500s left) kms_feature_discovery (psr2)
[520.742985] Starting subtest: psr2
[520.744864] Subtest psr2: SUCCESS (0.000s)
[520.840412] [113/131] (500s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[520.950558] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[527.523211] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.575s)
[527.672980] [114/131] (493s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[527.786580] Starting subtest: y-tiled-32bpp-rotate-0
[527.790865] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[527.925903] [115/131] (493s left) gem_mmap_gtt (basic-small-bo)
[527.992771] Subtest basic-small-bo: SKIP (0.000s)
[528.057673] [116/131] (493s left) api_intel_bb (simple-bb)
[528.107613] Starting subtest: simple-bb
[528.110527] Subtest simple-bb: SUCCESS (0.006s)
[528.250933] [117/131] (492s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[528.348748] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[528.350972] Starting dynamic subtest: pipe-A
[528.369792] Dynamic subtest pipe-A: SKIP (0.016s)
[528.377960] Starting dynamic subtest: pipe-B
[528.400066] Dynamic subtest pipe-B: SKIP (0.030s)
[528.408075] Starting dynamic subtest: pipe-C
[528.430414] Dynamic subtest pipe-C: SKIP (0.029s)
[528.438520] Starting dynamic subtest: pipe-D
[528.459221] Dynamic subtest pipe-D: SKIP (0.029s)
[528.462977] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.108s)
[528.588840] [118/131] (492s left) kms_lease (lease-unleased-connector)
[528.676944] Starting subtest: lease-unleased-connector
[528.678952] Starting dynamic subtest: pipe-A-eDP-1
[528.685787] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[528.693972] Starting dynamic subtest: pipe-B-eDP-1
[528.695838] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[528.703525] Starting dynamic subtest: pipe-C-eDP-1
[528.705257] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[528.712868] Starting dynamic subtest: pipe-D-eDP-1
[528.714644] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[528.716371] Subtest lease-unleased-connector: SUCCESS (0.031s)
[528.844697] [119/131] (492s left) gen9_exec_parse (bb-secure)
[528.897895] Subtest bb-secure: SKIP (0.000s)
[528.972024] [120/131] (492s left) vgem_basic (mmap)
[529.015100] Starting subtest: mmap
[529.043093] Subtest mmap: SUCCESS (0.029s)
[529.119007] [121/131] (492s left) gem_eio (in-flight-contexts-10ms)
[529.354888] Starting subtest: in-flight-contexts-10ms
[540.904831] Subtest in-flight-contexts-10ms: SUCCESS (11.547s)
[541.109676] [122/131] (480s left) i915_pm_rpm (debugfs-forcewake-user)
[543.136068] Starting subtest: debugfs-forcewake-user
[554.517330] Subtest debugfs-forcewake-user: SUCCESS (11.385s)
[554.918032] [123/131] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[555.032825] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[555.037201] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[555.164664] [124/131] (466s left) kms_psr (fbc-pr-no-drrs)
[555.262123] Starting subtest: fbc-pr-no-drrs
[555.266161] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[555.356027] [125/131] (466s left) kms_invalid_mode (bad-htotal)
[555.455697] Starting subtest: bad-htotal
[555.458174] Starting dynamic subtest: pipe-A-eDP-1
[555.745902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[555.754210] Starting dynamic subtest: pipe-B-eDP-1
[555.756314] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[555.763588] Starting dynamic subtest: pipe-C-eDP-1
[555.765522] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[555.773166] Starting dynamic subtest: pipe-D-eDP-1
[555.775307] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[555.777491] Subtest bad-htotal: SUCCESS (0.300s)
[556.645610] [126/131] (464s left) kms_cursor_crc (cursor-random-128x42)
[556.875096] Starting subtest: cursor-random-128x42
[556.918574] Subtest cursor-random-128x42: SKIP (0.040s)
[557.154700] [127/131] (464s left) gem_linear_blits (interruptible)
[557.677287] Starting subtest: interruptible
[562.292206] Subtest interruptible: SUCCESS (4.613s)
[562.498846] [128/131] (459s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[562.645264] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[569.670779] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.027s)
[569.807553] [129/131] (451s left) i915_hangman (engine-engine-error)
[569.874392] Starting subtest: engine-engine-error
[569.876280] Starting dynamic subtest: rcs0
[571.892843] Dynamic subtest rcs0: SUCCESS (2.017s)
[571.905079] Starting dynamic subtest: bcs0
[573.875839] Dynamic subtest bcs0: SUCCESS (1.980s)
[573.887492] Starting dynamic subtest: vcs0
[575.858963] Dynamic subtest vcs0: SUCCESS (1.980s)
[575.870815] Starting dynamic subtest: vcs1
[577.906927] Dynamic subtest vcs1: SUCCESS (2.045s)
[577.919495] Starting dynamic subtest: vecs0
[579.828377] Dynamic subtest vecs0: SUCCESS (1.918s)
[579.848830] Starting dynamic subtest: ccs0
[581.875169] Dynamic subtest ccs0: SUCCESS (2.044s)
[581.878099] Subtest engine-engine-error: SUCCESS (12.001s)
[581.976805] [130/131] (439s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[582.084156] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[582.088090] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[582.198932] [131/131] (439s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[582.293646] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[582.295822] Starting dynamic subtest: pipe-A
[582.324743] Dynamic subtest pipe-A: SKIP (0.018s)
[582.333610] Starting dynamic subtest: pipe-B
[582.345499] Dynamic subtest pipe-B: SKIP (0.029s)
[582.354240] Starting dynamic subtest: pipe-C
[582.375618] Dynamic subtest pipe-C: SKIP (0.030s)
[582.386501] Starting dynamic subtest: pipe-D
[582.404062] Dynamic subtest pipe-D: SKIP (0.029s)
[582.407642] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.108s)
[582.509235] 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.