[58.327393] Initializing watchdogs
[58.327439]   /dev/watchdog0
[58.340847] [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]
[58.344912] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.347447] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.350879] [001/131] (960s left) vgem_slow (nohang)
[58.443359] Starting subtest: nohang
[68.723637] Subtest nohang: SUCCESS (10.280s)
[68.808582] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[68.811510] [002/131] (950s left) gem_userptr_blits (unsync-overlap)
[68.888045] Subtest unsync-overlap: SKIP (0.000s)
[69.047279] [003/131] (949s left) gem_exec_schedule (u-fairslice-all)
[69.119829] Starting subtest: u-fairslice-all
[71.194166] Subtest u-fairslice-all: SUCCESS (2.075s)
[72.976526] [004/131] (945s left) gem_lmem_swapping (parallel-random)
[73.018647] Subtest parallel-random: SKIP (0.000s)
[73.072216] [005/131] (945s left) kms_sequence (queue-idle)
[73.176257] Starting subtest: queue-idle
[73.178169] Starting dynamic subtest: pipe-A-eDP-1
[75.004459] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.829s)
[75.012475] Starting dynamic subtest: pipe-B-eDP-1
[77.448665] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.441s)
[77.458749] Starting dynamic subtest: pipe-C-eDP-1
[79.954806] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.507s)
[79.964400] Starting dynamic subtest: pipe-D-eDP-1
[82.384637] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.428s)
[82.387061] Subtest queue-idle: SUCCESS (9.209s)
[83.199127] [006/131] (935s left) gem_exec_schedule (lateslice)
[83.280719] Starting subtest: lateslice
[83.282639] Starting dynamic subtest: rcs0
[83.292305] Dynamic subtest rcs0: SUCCESS (0.021s)
[83.299934] Starting dynamic subtest: bcs0
[83.309770] Dynamic subtest bcs0: SUCCESS (0.017s)
[83.317705] Starting dynamic subtest: vcs0
[83.328204] Dynamic subtest vcs0: SUCCESS (0.018s)
[83.337492] Starting dynamic subtest: vcs1
[83.345421] Dynamic subtest vcs1: SUCCESS (0.017s)
[83.352386] Starting dynamic subtest: vecs0
[83.361138] Dynamic subtest vecs0: SUCCESS (0.016s)
[83.374229] Starting dynamic subtest: ccs0
[83.378587] Dynamic subtest ccs0: SUCCESS (0.016s)
[83.380452] Subtest lateslice: SUCCESS (0.107s)
[85.012434] [007/131] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[85.114711] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[85.119236] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[85.235779] [008/131] (933s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[85.749322] Starting subtest: syncobj-timeline-invalid-wait
[85.751802] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[87.041780] [009/131] (932s left) gem_exec_params (no-vebox)
[87.100960] Starting subtest: no-vebox
[87.105924] Subtest no-vebox: SUCCESS (0.003s)
[89.039660] [010/131] (930s left) gem_exec_balancer (parallel-contexts)
[89.292526] Starting subtest: parallel-contexts
[92.992796] Subtest parallel-contexts: SUCCESS (3.672s)
[93.126735] [011/131] (926s left) kms_pm_rpm (legacy-planes-dpms)
[95.090465] Starting subtest: legacy-planes-dpms
[95.092642] Starting dynamic subtest: plane-63
[103.691358] Dynamic subtest plane-63: SUCCESS (8.604s)
[103.701096] Starting dynamic subtest: plane-93
[111.980107] Dynamic subtest plane-93: SUCCESS (8.287s)
[111.990697] Starting dynamic subtest: plane-123
[120.692285] Dynamic subtest plane-123: SUCCESS (8.709s)
[120.702217] Starting dynamic subtest: plane-133
[129.520509] Dynamic subtest plane-133: SUCCESS (8.827s)
[129.523535] Subtest legacy-planes-dpms: SUCCESS (34.432s)
[129.911020] [012/131] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[130.012637] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[130.016819] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[130.125487] [013/131] (889s left) kms_cursor_edge_walk (64x64-left-edge)
[130.218634] Starting subtest: 64x64-left-edge
[130.220918] Starting dynamic subtest: pipe-A-eDP-1
[133.655433] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s)
[133.665447] Starting dynamic subtest: pipe-D-eDP-1
[136.775090] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[136.777342] Subtest 64x64-left-edge: SUCCESS (6.557s)
[137.612227] [014/131] (881s left) gem_mmap_offset (open-flood)
[137.666956] Starting subtest: open-flood
[159.154839] Subtest open-flood: SUCCESS (21.489s)
[159.298154] [015/131] (860s left) gem_spin_batch (spin-each)
[159.367913] Starting subtest: spin-each
[162.737114] Subtest spin-each: SUCCESS (3.368s)
[163.031166] [016/131] (856s left) gem_ctx_persistence (saturated-hostile)
[163.097646] Starting subtest: saturated-hostile
[163.100170] Starting dynamic subtest: rcs0
[163.971251] Dynamic subtest rcs0: SUCCESS (0.873s)
[163.982061] Starting dynamic subtest: bcs0
[164.797913] Dynamic subtest bcs0: SUCCESS (0.826s)
[164.807952] Starting dynamic subtest: vcs0
[165.625863] Dynamic subtest vcs0: SUCCESS (0.826s)
[165.636274] Starting dynamic subtest: vcs1
[166.437714] Dynamic subtest vcs1: SUCCESS (0.810s)
[166.447738] Starting dynamic subtest: vecs0
[167.232037] Dynamic subtest vecs0: SUCCESS (0.793s)
[167.242477] Starting dynamic subtest: ccs0
[168.094210] Dynamic subtest ccs0: SUCCESS (0.861s)
[168.096673] Subtest saturated-hostile: SUCCESS (4.996s)
[168.197137] [017/131] (851s left) gem_ctx_shared (q-independent)
[168.262560] Starting subtest: Q-independent
[168.264903] Starting dynamic subtest: rcs0
[168.382805] Dynamic subtest rcs0: SUCCESS (0.118s)
[168.393618] Starting dynamic subtest: vcs0
[168.445554] Dynamic subtest vcs0: SUCCESS (0.063s)
[168.457139] Starting dynamic subtest: vcs1
[168.508898] Dynamic subtest vcs1: SUCCESS (0.064s)
[168.519234] Starting dynamic subtest: vecs0
[168.573988] Dynamic subtest vecs0: SUCCESS (0.064s)
[168.585744] Starting dynamic subtest: ccs0
[168.660590] Dynamic subtest ccs0: SUCCESS (0.087s)
[168.662918] Subtest Q-independent: SUCCESS (0.398s)
[170.009408] [018/131] (849s left) kms_psr (fbc-psr-primary-render)
[170.106943] Starting subtest: fbc-psr-primary-render
[170.109244] Starting dynamic subtest: eDP-1
[170.113313] Dynamic subtest eDP-1: SKIP (0.000s)
[170.117449] Subtest fbc-psr-primary-render: SKIP (0.001s)
[170.200277] [019/131] (849s left) perf_pmu (rc6-all-gts)
[170.242717] Starting subtest: rc6-all-gts
[176.616119] Subtest rc6-all-gts: SUCCESS (6.373s)
[177.510178] [020/131] (842s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[177.616278] Starting subtest: crc-primary-suspend-y-tiled-ccs
[177.618594] Starting dynamic subtest: pipe-A-eDP-1
[177.627798] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[177.637115] Starting dynamic subtest: pipe-B-eDP-1
[177.644896] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[177.652710] Starting dynamic subtest: pipe-C-eDP-1
[177.659895] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[177.666857] Starting dynamic subtest: pipe-D-eDP-1
[177.674025] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[177.677656] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[179.772829] [021/131] (839s left) gem_pxp (create-regular-context-1)
[179.899394] Starting subtest: create-regular-context-1
[179.901657] Subtest create-regular-context-1: SUCCESS (0.002s)
[180.048143] [022/131] (839s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[180.103388] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[180.107517] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[180.309122] [023/131] (839s left) syncobj_timeline (host-signal-points)
[180.358726] Starting subtest: host-signal-points
[180.363321] Subtest host-signal-points: SUCCESS (0.004s)
[180.469555] [024/131] (839s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[180.564803] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[180.566933] Starting dynamic subtest: pipe-A-eDP-1
[180.591147] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[180.600738] Starting dynamic subtest: pipe-B-eDP-1
[180.623106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.630673] Starting dynamic subtest: pipe-C-eDP-1
[180.653495] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.661126] Starting dynamic subtest: pipe-D-eDP-1
[180.685183] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.689571] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[182.770613] [025/131] (837s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[182.884659] Starting subtest: stress-xrgb8888-xtiled
[188.789547] Subtest stress-xrgb8888-xtiled: SUCCESS (5.905s)
[188.833844] [026/131] (830s left) kms_async_flips (test-time-stamp)
[188.932205] Starting subtest: test-time-stamp
[189.314394] Starting dynamic subtest: pipe-A-eDP-1
[190.154085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.837s)
[190.529508] Starting dynamic subtest: pipe-B-eDP-1
[191.291520] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[191.666497] Starting dynamic subtest: pipe-C-eDP-1
[192.428227] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[192.791855] Starting dynamic subtest: pipe-D-eDP-1
[193.556978] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[193.559405] Subtest test-time-stamp: SUCCESS (4.624s)
[194.748458] [027/131] (825s left) prime_self_import (basic-with_two_bos)
[194.788410] Starting subtest: basic-with_two_bos
[194.812365] Subtest basic-with_two_bos: SUCCESS (0.023s)
[194.962315] [028/131] (824s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[195.068352] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[202.513092] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.446s)
[202.658211] [029/131] (817s left) gem_mmap_gtt (close-race)
[202.732274] Subtest close-race: SKIP (0.000s)
[202.798734] [030/131] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[202.902441] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[207.352390] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.453s)
[208.570017] [031/131] (811s left) gen9_exec_parse (valid-registers)
[208.625080] Subtest valid-registers: SKIP (0.000s)
[208.724307] [032/131] (811s left) kms_color (legacy-gamma-reset)
[208.820045] Starting subtest: legacy-gamma-reset
[208.822138] Starting dynamic subtest: pipe-A-eDP-1
[209.208691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[209.217587] Starting dynamic subtest: pipe-B-eDP-1
[209.219962] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[209.227760] Starting dynamic subtest: pipe-C-eDP-1
[209.229715] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[209.237789] Starting dynamic subtest: pipe-D-eDP-1
[209.243034] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[209.245311] Subtest legacy-gamma-reset: SUCCESS (0.425s)
[210.089174] [033/131] (810s left) gem_partial_pwrite_pread (reads-snoop)
[210.143222] Subtest reads-snoop: SKIP (0.000s)
[210.223369] [034/131] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[210.332074] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[210.336134] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[210.472396] [035/131] (809s left) gem_exec_reloc (basic-gtt-noreloc)
[210.534286] Subtest basic-gtt-noreloc: SKIP (0.000s)
[210.618557] [036/131] (809s left) syncobj_timeline (invalid-transfer-illegal-handle)
[210.687770] Starting subtest: invalid-transfer-illegal-handle
[210.690080] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[210.819355] [037/131] (809s left) gem_ctx_param (invalid-get-engines)
[210.878932] Starting subtest: invalid-get-engines
[210.881247] Subtest invalid-get-engines: SUCCESS (0.001s)
[211.014156] [038/131] (809s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[211.117433] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[211.120855] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[211.262017] [039/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[211.363564] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[211.366995] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[211.499176] [040/131] (808s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[211.586902] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[211.590667] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[211.702146] [041/131] (808s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[211.791489] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[211.793446] Starting dynamic subtest: pipe-A-eDP-1
[211.811456] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.821511] Starting dynamic subtest: pipe-B-eDP-1
[211.839895] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.849156] Starting dynamic subtest: pipe-C-eDP-1
[211.866939] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.874450] Starting dynamic subtest: pipe-D-eDP-1
[211.892297] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.895644] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[213.952907] [042/131] (806s left) kms_plane_cursor (primary)
[214.060132] Starting subtest: primary
[214.064561] Starting dynamic subtest: pipe-A-eDP-1-size-64
[216.657059] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.596s)
[216.679777] Starting dynamic subtest: pipe-A-eDP-1-size-128
[219.245915] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[219.269492] Starting dynamic subtest: pipe-A-eDP-1-size-256
[221.835931] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.571s)
[222.156083] Starting dynamic subtest: pipe-B-eDP-1-size-64
[225.493452] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.345s)
[225.518785] Starting dynamic subtest: pipe-B-eDP-1-size-128
[228.050112] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[228.073642] Starting dynamic subtest: pipe-B-eDP-1-size-256
[230.617995] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.551s)
[230.942208] Starting dynamic subtest: pipe-C-eDP-1-size-64
[233.818380] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.885s)
[233.844535] Starting dynamic subtest: pipe-C-eDP-1-size-128
[235.974875] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.135s)
[235.999996] Starting dynamic subtest: pipe-C-eDP-1-size-256
[238.129307] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.135s)
[238.454626] Starting dynamic subtest: pipe-D-eDP-1-size-64
[241.279195] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.837s)
[241.305447] Starting dynamic subtest: pipe-D-eDP-1-size-128
[243.502186] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.202s)
[243.526841] Starting dynamic subtest: pipe-D-eDP-1-size-256
[245.668425] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[245.976012] Subtest primary: SUCCESS (31.916s)
[246.795565] [043/131] (773s left) kms_flip (dpms-off-confusion-interruptible)
[246.909994] Starting subtest: dpms-off-confusion-interruptible
[246.912404] Starting dynamic subtest: A-eDP1
[255.572897] Dynamic subtest A-eDP1: SUCCESS (8.662s)
[255.584677] Starting dynamic subtest: B-eDP1
[264.203690] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[264.214550] Starting dynamic subtest: C-eDP1
[272.821412] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[272.829964] Starting dynamic subtest: D-eDP1
[281.440791] Dynamic subtest D-eDP1: SUCCESS (8.618s)
[281.445648] Subtest dpms-off-confusion-interruptible: SUCCESS (34.535s)
[282.641873] [044/131] (737s left) kms_cursor_edge_walk (256x256-top-bottom)
[282.744795] Starting subtest: 256x256-top-bottom
[282.746998] Starting dynamic subtest: pipe-A-eDP-1
[286.170783] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.424s)
[286.178784] Starting dynamic subtest: pipe-D-eDP-1
[289.291405] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[289.294075] Subtest 256x256-top-bottom: SUCCESS (6.545s)
[290.122458] [045/131] (730s left) kms_psr (pr-sprite-plane-onoff)
[290.230198] Starting subtest: pr-sprite-plane-onoff
[290.234574] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[290.327643] [046/131] (730s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[290.453407] Starting subtest: short-flip-before-cursor-toggle
[291.367355] Subtest short-flip-before-cursor-toggle: SUCCESS (0.915s)
[292.248645] [047/131] (728s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[292.351594] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[292.353919] Starting dynamic subtest: A-eDP1
[301.275226] Dynamic subtest A-eDP1: SUCCESS (8.923s)
[301.284497] Starting dynamic subtest: B-eDP1
[310.204972] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[310.214090] Starting dynamic subtest: C-eDP1
[319.125616] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[319.135531] Starting dynamic subtest: D-eDP1
[327.970823] Dynamic subtest D-eDP1: SUCCESS (8.845s)
[327.976059] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.621s)
[329.223613] [048/131] (691s left) gem_exec_params (secure-non-master)
[329.286542] Starting subtest: secure-non-master
[329.291030] Subtest secure-non-master: SKIP (0.000s)
[329.420529] [049/131] (691s left) kms_flip (2x-flip-vs-dpms)
[329.522298] Starting subtest: 2x-flip-vs-dpms
[329.533203] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[329.637296] [050/131] (691s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[329.730647] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[329.734645] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[329.867086] [051/131] (690s left) drm_read (fault-buffer)
[330.010093] Starting subtest: fault-buffer
[330.012434] Subtest fault-buffer: SUCCESS (0.000s)
[330.171577] [052/131] (690s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[330.237276] Starting subtest: basic-batch-kernel-default-cmd
[330.240987] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[330.447065] [053/131] (690s left) kms_cursor_crc (cursor-offscreen-128x128)
[330.651796] Starting subtest: cursor-offscreen-128x128
[330.656698] Starting dynamic subtest: pipe-A-eDP-1
[332.591502] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[332.618590] Starting dynamic subtest: pipe-D-eDP-1
[335.194991] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.581s)
[335.197171] Subtest cursor-offscreen-128x128: SUCCESS (4.543s)
[336.072340] [054/131] (684s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[336.179224] Starting subtest: x-tiled-8bpp-rotate-90
[336.199223] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[336.350633] [055/131] (684s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[336.407559] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[336.513682] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[336.613998] [056/131] (684s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[336.712645] Starting subtest: 4-tiled-32bpp-rotate-90
[336.731891] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[336.883377] [057/131] (684s left) core_setmaster (master-drop-set-shared-fd)
[336.989723] Starting subtest: master-drop-set-shared-fd
[337.007343] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[337.044407] [058/131] (684s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[337.139523] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[337.147390] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[337.274613] [059/131] (683s left) syncobj_wait (single-wait-all-submitted)
[337.327084] Starting subtest: single-wait-all-submitted
[337.432974] Subtest single-wait-all-submitted: SUCCESS (0.106s)
[337.535845] [060/131] (683s left) kms_big_fb (linear-64bpp-rotate-270)
[337.645189] Starting subtest: linear-64bpp-rotate-270
[337.664553] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[337.826784] [061/131] (683s left) gem_exec_params (invalid-fence-in-submit)
[337.899513] Starting subtest: invalid-fence-in-submit
[337.901876] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[338.028854] [062/131] (683s left) syncobj_wait (single-wait-for-submit-submitted)
[338.092538] Starting subtest: single-wait-for-submit-submitted
[338.193086] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[338.292031] [063/131] (683s left) prime_vgem (fence-write-hang)
[338.365169] Subtest fence-write-hang: SKIP (0.000s)
[338.469771] [064/131] (682s left) syncobj_timeline (single-wait-signaled)
[338.526894] Starting subtest: single-wait-signaled
[338.528961] Subtest single-wait-signaled: SUCCESS (0.000s)
[338.638093] [065/131] (682s left) kms_chamelium_edid (vga-edid-read)
[339.019335] Subtest vga-edid-read: SKIP (0.000s)
[339.870530] [066/131] (681s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[339.985373] Starting subtest: 2x-long-flip-vs-cursor-atomic
[339.989849] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[340.155889] [067/131] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[340.256267] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[344.772998] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.520s)
[345.991018] [068/131] (675s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[346.085049] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[350.673743] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.593s)
[351.884828] [069/131] (669s left) prime_vgem (basic-read)
[351.957776] Starting subtest: basic-read
[351.977076] Subtest basic-read: SKIP (0.018s)
[352.125577] [070/131] (669s left) gem_userptr_blits (vma-merge)
[352.203914] Starting subtest: vma-merge
[352.243843] Subtest vma-merge: SUCCESS (0.040s)
[352.401235] [071/131] (669s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[352.513599] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[352.518071] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[352.619624] [072/131] (669s left) kms_vrr (negative-basic)
[352.719563] Starting subtest: negative-basic
[352.726326] Starting dynamic subtest: pipe-A-eDP-1
[358.137416] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.411s)
[358.426230] Subtest negative-basic: SUCCESS (5.706s)
[359.292154] [073/131] (662s left) gem_exec_reloc (basic-cpu-read-active)
[359.353615] Subtest basic-cpu-read-active: SKIP (0.000s)
[359.440360] [074/131] (662s left) kms_chamelium_hpd (hdmi-hpd)
[359.831028] Subtest hdmi-hpd: SKIP (0.000s)
[360.683164] [075/131] (661s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[360.790124] Starting subtest: yf-tiled-16bpp-rotate-0
[360.794537] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[360.932659] [076/131] (660s left) syncobj_timeline (reset-signaled)
[360.995979] Starting subtest: reset-signaled
[360.998213] Subtest reset-signaled: SUCCESS (0.000s)
[361.137063] [077/131] (660s left) kms_psr (fbc-psr2-basic)
[361.229294] Starting subtest: fbc-psr2-basic
[361.231211] Starting dynamic subtest: eDP-1
[361.235229] Dynamic subtest eDP-1: SKIP (0.000s)
[361.239284] Subtest fbc-psr2-basic: SKIP (0.001s)
[361.329145] [078/131] (660s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[361.428226] Starting subtest: primary-yf-tiled-reflect-x-0
[361.487319] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[361.609965] [079/131] (660s left) kms_prop_blob (basic)
[361.673323] Starting subtest: basic
[361.674944] Subtest basic: SUCCESS (0.000s)
[361.811097] [080/131] (660s left) vgem_basic (debugfs)
[361.854043] Starting subtest: debugfs
[361.855685] Subtest debugfs: SUCCESS (0.000s)
[361.930872] [081/131] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[362.043742] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[369.059279] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.017s)
[369.193870] [082/131] (652s left) gem_userptr_blits (unsync-unmap-cycles)
[369.277455] Subtest unsync-unmap-cycles: SKIP (0.000s)
[369.423338] [083/131] (652s left) perf_pmu (busy-double-start)
[369.464329] Starting subtest: busy-double-start
[369.466231] Starting dynamic subtest: rcs0
[373.103750] Dynamic subtest rcs0: FAIL (3.582s)
[373.113967] Starting dynamic subtest: bcs0
[376.613673] Dynamic subtest bcs0: SUCCESS (3.567s)
[376.624596] Starting dynamic subtest: vcs0
[380.483269] Dynamic subtest vcs0: SUCCESS (3.867s)
[380.494281] Starting dynamic subtest: vcs1
[384.456488] Dynamic subtest vcs1: SUCCESS (3.971s)
[384.467767] Starting dynamic subtest: vecs0
[388.475860] Dynamic subtest vecs0: SUCCESS (4.017s)
[388.486706] Starting dynamic subtest: ccs0
[392.108820] Dynamic subtest ccs0: FAIL (3.564s)
[392.111186] Subtest busy-double-start: FAIL (22.579s)
[392.224373] [084/131] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[392.336082] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[392.340293] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[392.469959] [085/131] (629s left) kms_chamelium_color (ctm-negative)
[392.558257] Subtest ctm-negative: SKIP (0.000s)
[392.599843] [086/131] (629s left) kms_async_flips (async-flip-dpms)
[392.689675] Starting subtest: async-flip-dpms
[393.061504] Starting dynamic subtest: pipe-A-eDP-1
[396.844165] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.780s)
[397.220209] Starting dynamic subtest: pipe-B-eDP-1
[399.999872] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.787s)
[400.388185] Starting dynamic subtest: pipe-C-eDP-1
[403.179149] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.798s)
[403.558763] Starting dynamic subtest: pipe-D-eDP-1
[406.343593] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.792s)
[406.345951] Subtest async-flip-dpms: SUCCESS (13.656s)
[407.555250] [087/131] (614s left) gem_busy (semaphore)
[407.743278] Subtest semaphore: SKIP (0.000s)
[407.991341] [088/131] (614s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[408.089384] Starting subtest: flip-vs-dpms-off-vs-modeset
[408.091750] Starting dynamic subtest: A-eDP1
[411.691838] Dynamic subtest A-eDP1: SUCCESS (3.600s)
[411.701984] Starting dynamic subtest: B-eDP1
[414.900908] Dynamic subtest B-eDP1: SUCCESS (3.206s)
[414.910160] Starting dynamic subtest: C-eDP1
[418.021408] Dynamic subtest C-eDP1: SUCCESS (3.118s)
[418.029786] Starting dynamic subtest: D-eDP1
[421.122188] Dynamic subtest D-eDP1: SUCCESS (3.103s)
[421.124858] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.036s)
[421.942272] [089/131] (600s left) prime_mmap (test_reprime)
[422.008515] Starting subtest: test_reprime
[422.010789] Starting dynamic subtest: test_reprime-smem
[422.038591] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[422.040891] Subtest test_reprime: SUCCESS (0.033s)
[422.184315] [090/131] (600s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[427.212655] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[427.217360] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[428.077859] [091/131] (594s left) gem_exec_whisper (basic-fds)
[428.135758] Starting subtest: basic-fds
[433.923071] Subtest basic-fds: SUCCESS (5.787s)
[434.133141] [092/131] (588s left) gem_ctx_param (set-priority-range)
[434.207239] Starting subtest: set-priority-range
[434.222288] Subtest set-priority-range: SUCCESS (0.015s)
[434.375883] [093/131] (588s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[434.481707] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[434.483799] Starting dynamic subtest: pipe-A-default-mode
[437.179590] Dynamic subtest pipe-A-default-mode: SUCCESS (2.698s)
[437.181761] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.700s)
[438.090159] [094/131] (584s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[438.190255] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[438.192469] Starting dynamic subtest: pipe-A-default-mode
[438.477289] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[438.481850] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.285s)
[439.307894] [095/131] (583s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[439.411548] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[439.415666] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[439.547777] [096/131] (583s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[439.654937] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[439.657052] Starting dynamic subtest: pipe-A-eDP-1
[439.801676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[439.811847] Starting dynamic subtest: pipe-B-eDP-1
[439.830590] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[439.838899] Starting dynamic subtest: pipe-C-eDP-1
[439.857784] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[439.865260] Starting dynamic subtest: pipe-D-eDP-1
[439.883747] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[439.885602] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.173s)
[442.089383] [097/131] (580s left) i915_selftest (mock)
[445.580337] Starting subtest: mock
[445.582522] Starting dynamic subtest: sanitycheck
[446.356241] Dynamic subtest sanitycheck: SUCCESS (0.776s)
[446.364369] Starting dynamic subtest: shmem
[447.122184] Dynamic subtest shmem: SUCCESS (0.763s)
[447.130757] Starting dynamic subtest: fence
[455.116896] Dynamic subtest fence: SUCCESS (7.992s)
[455.125879] Starting dynamic subtest: scatterlist
[456.833804] Dynamic subtest scatterlist: SUCCESS (1.715s)
[456.842807] Starting dynamic subtest: syncmap
[460.205586] Dynamic subtest syncmap: SUCCESS (3.370s)
[460.213739] Starting dynamic subtest: uncore
[460.921170] Dynamic subtest uncore: SUCCESS (0.713s)
[460.929771] Starting dynamic subtest: ring
[461.582479] Dynamic subtest ring: SUCCESS (0.659s)
[461.591309] Starting dynamic subtest: engine
[462.282471] Dynamic subtest engine: SUCCESS (0.698s)
[462.290697] Starting dynamic subtest: timelines
[466.272943] Dynamic subtest timelines: SUCCESS (3.988s)
[466.282045] Starting dynamic subtest: requests
[469.569794] Dynamic subtest requests: SUCCESS (3.294s)
[469.578890] Starting dynamic subtest: objects
[470.362216] Dynamic subtest objects: SUCCESS (0.792s)
[470.371157] Starting dynamic subtest: phys
[471.138260] Dynamic subtest phys: SUCCESS (0.774s)
[471.151983] Starting dynamic subtest: dmabuf
[471.933207] Dynamic subtest dmabuf: SUCCESS (0.793s)
[471.941726] Starting dynamic subtest: vma
[477.246218] Dynamic subtest vma: SUCCESS (5.310s)
[477.255048] Starting dynamic subtest: evict
[478.735918] Dynamic subtest evict: SUCCESS (1.488s)
[478.744882] Starting dynamic subtest: gtt
[481.932353] Dynamic subtest gtt: SUCCESS (3.194s)
[481.944075] Starting dynamic subtest: hugepages
[482.959629] Dynamic subtest hugepages: SUCCESS (0.997s)
[482.969203] Starting dynamic subtest: memory_region
[485.462356] Dynamic subtest memory_region: SUCCESS (2.527s)
[485.465108] Subtest mock: SUCCESS (39.882s)
[485.492697] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[485.493390] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[485.496471] [098/131] (537s left) gem_ctx_exec (basic-close-race)
[487.033831] Starting subtest: basic-close-race
[492.700910] Subtest basic-close-race: SUCCESS (5.666s)
[492.813911] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[492.815122] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[492.819200] [099/131] (529s left) prime_busy (after)
[492.898909] Starting subtest: after
[492.901120] Starting dynamic subtest: rcs0
[492.938172] Dynamic subtest rcs0: SUCCESS (0.038s)
[492.947676] Starting dynamic subtest: bcs0
[493.025545] Dynamic subtest bcs0: SUCCESS (0.086s)
[493.034670] Starting dynamic subtest: vcs0
[493.066481] Dynamic subtest vcs0: SUCCESS (0.041s)
[493.074400] Starting dynamic subtest: vcs1
[493.107291] Dynamic subtest vcs1: SUCCESS (0.040s)
[493.115286] Starting dynamic subtest: vecs0
[493.148258] Dynamic subtest vecs0: SUCCESS (0.041s)
[493.156258] Starting dynamic subtest: ccs0
[493.190844] Dynamic subtest ccs0: SUCCESS (0.042s)
[493.299678] Subtest after: SUCCESS (0.401s)
[493.394824] [100/131] (529s left) syncobj_wait (reset-signaled)
[493.450473] Starting subtest: reset-signaled
[493.452850] Subtest reset-signaled: SUCCESS (0.000s)
[493.628733] [101/131] (529s left) kms_dsc (dsc-basic)
[493.738824] Starting subtest: dsc-basic
[493.751438] Subtest dsc-basic: SKIP (0.000s)
[493.829981] [102/131] (529s left) vgem_basic (bad-flag)
[493.874760] Starting subtest: bad-flag
[493.876990] Subtest bad-flag: SUCCESS (0.000s)
[493.954412] [103/131] (529s left) kms_psr (psr2-sprite-mmap-gtt)
[494.070415] Starting subtest: psr2-sprite-mmap-gtt
[494.072647] Starting dynamic subtest: eDP-1
[495.480716] Dynamic subtest eDP-1: SKIP (1.407s)
[495.485707] Subtest psr2-sprite-mmap-gtt: SKIP (1.409s)
[495.696919] [104/131] (527s left) gem_exec_balancer (noheartbeat)
[495.960648] Starting subtest: noheartbeat
[495.965394] Subtest noheartbeat: SKIP (0.001s)
[496.080114] [105/131] (527s left) gem_tiled_wb
[496.201152] [106/131] (526s left) gem_exec_reloc (basic-softpin)
[496.270244] Subtest basic-softpin: SKIP (0.000s)
[496.347073] [107/131] (526s left) gem_pxp (hw-rejects-pxp-buffer)
[496.471774] Starting subtest: hw-rejects-pxp-buffer
[496.476200] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[496.598215] [108/131] (526s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[501.565403] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[501.567736] Starting dynamic subtest: pipe-A-eDP-1
[502.363610] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s)
[502.371511] Starting dynamic subtest: pipe-B-eDP-1
[503.492078] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[503.496237] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.926s)
[504.702684] [109/131] (518s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[504.833479] Starting subtest: 2x-cursor-vs-flip-legacy
[504.837782] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[505.007431] [110/131] (518s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[505.108255] Starting subtest: multiplane-rotation-cropping-bottom
[522.398570] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.293s)
[522.551153] [111/131] (500s left) gem_userptr_blits (sync-overlap)
[522.633340] Starting subtest: sync-overlap
[522.635186] Subtest sync-overlap: SUCCESS (0.000s)
[522.800677] [112/131] (500s left) kms_feature_discovery (psr2)
[522.916542] Starting subtest: psr2
[522.918257] Subtest psr2: SUCCESS (0.000s)
[523.013208] [113/131] (500s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[523.113556] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[529.917408] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.804s)
[530.092312] [114/131] (493s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[530.189600] Starting subtest: y-tiled-32bpp-rotate-0
[530.194055] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[530.330140] [115/131] (493s left) gem_mmap_gtt (basic-small-bo)
[530.378249] Subtest basic-small-bo: SKIP (0.000s)
[530.444623] [116/131] (493s left) api_intel_bb (simple-bb)
[530.511581] Starting subtest: simple-bb
[530.514165] Subtest simple-bb: SUCCESS (0.005s)
[530.680602] [117/131] (492s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[530.779788] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[530.792036] Starting dynamic subtest: pipe-A
[530.800646] Dynamic subtest pipe-A: SKIP (0.017s)
[530.808758] Starting dynamic subtest: pipe-B
[530.829043] Dynamic subtest pipe-B: SKIP (0.030s)
[530.836703] Starting dynamic subtest: pipe-C
[530.860096] Dynamic subtest pipe-C: SKIP (0.030s)
[530.867542] Starting dynamic subtest: pipe-D
[530.888823] Dynamic subtest pipe-D: SKIP (0.029s)
[530.893051] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.108s)
[531.027296] [118/131] (492s left) kms_lease (lease-unleased-connector)
[531.127568] Starting subtest: lease-unleased-connector
[531.129499] Starting dynamic subtest: pipe-A-eDP-1
[531.138087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.010s)
[531.145991] Starting dynamic subtest: pipe-B-eDP-1
[531.147584] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[531.154947] Starting dynamic subtest: pipe-C-eDP-1
[531.159554] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[531.169441] Starting dynamic subtest: pipe-D-eDP-1
[531.173951] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[531.175935] Subtest lease-unleased-connector: SUCCESS (0.048s)
[531.315834] [119/131] (492s left) gen9_exec_parse (bb-secure)
[531.369964] Subtest bb-secure: SKIP (0.000s)
[531.459497] [120/131] (492s left) vgem_basic (mmap)
[531.501704] Starting subtest: mmap
[531.513748] Subtest mmap: SUCCESS (0.014s)
[531.591324] [121/131] (492s left) gem_eio (in-flight-contexts-10ms)
[531.833642] Starting subtest: in-flight-contexts-10ms
[545.971682] Subtest in-flight-contexts-10ms: SUCCESS (14.136s)
[546.125169] [122/131] (477s left) i915_pm_rpm (debugfs-forcewake-user)
[548.045065] Starting subtest: debugfs-forcewake-user
[559.432435] Subtest debugfs-forcewake-user: SUCCESS (11.386s)
[559.828630] [123/131] (463s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[559.932859] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[559.936919] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[560.066628] [124/131] (463s left) kms_psr (fbc-pr-no-drrs)
[560.165168] Starting subtest: fbc-pr-no-drrs
[560.169675] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[560.261179] [125/131] (463s left) kms_invalid_mode (bad-htotal)
[560.341914] Starting subtest: bad-htotal
[560.344160] Starting dynamic subtest: pipe-A-eDP-1
[560.636443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[560.645746] Starting dynamic subtest: pipe-B-eDP-1
[560.647908] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[560.655309] Starting dynamic subtest: pipe-C-eDP-1
[560.657442] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[560.664943] Starting dynamic subtest: pipe-D-eDP-1
[560.666878] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[560.668792] Subtest bad-htotal: SUCCESS (0.301s)
[561.452928] [126/131] (462s left) kms_cursor_crc (cursor-random-128x42)
[561.675777] Starting subtest: cursor-random-128x42
[561.722154] Subtest cursor-random-128x42: SKIP (0.040s)
[561.970229] [127/131] (462s left) gem_linear_blits (interruptible)
[562.478258] Starting subtest: interruptible
[567.074985] Subtest interruptible: SUCCESS (4.595s)
[567.256226] [128/131] (456s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[567.406391] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[574.532634] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.129s)
[574.682389] [129/131] (449s left) i915_hangman (engine-engine-error)
[574.765388] Starting subtest: engine-engine-error
[574.767546] Starting dynamic subtest: rcs0
[575.862081] Dynamic subtest rcs0: SUCCESS (1.095s)
[575.873019] Starting dynamic subtest: bcs0
[577.844956] Dynamic subtest bcs0: SUCCESS (1.980s)
[577.855730] Starting dynamic subtest: vcs0
[579.892264] Dynamic subtest vcs0: SUCCESS (2.045s)
[579.903372] Starting dynamic subtest: vcs1
[581.876356] Dynamic subtest vcs1: SUCCESS (1.981s)
[581.887665] Starting dynamic subtest: vecs0
[583.860231] Dynamic subtest vecs0: SUCCESS (1.981s)
[583.872801] Starting dynamic subtest: ccs0
[585.844507] Dynamic subtest ccs0: SUCCESS (1.981s)
[585.847400] Subtest engine-engine-error: SUCCESS (11.080s)
[585.953684] [130/131] (438s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[586.062165] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[586.066153] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[586.178855] [131/131] (437s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[586.277204] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[586.279482] Starting dynamic subtest: pipe-A
[586.297535] Dynamic subtest pipe-A: SKIP (0.017s)
[586.306934] Starting dynamic subtest: pipe-B
[586.326548] Dynamic subtest pipe-B: SKIP (0.029s)
[586.335485] Starting dynamic subtest: pipe-C
[586.356477] Dynamic subtest pipe-C: SKIP (0.029s)
[586.364897] Starting dynamic subtest: pipe-D
[586.384599] Dynamic subtest pipe-D: SKIP (0.029s)
[586.388344] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.106s)
[586.505366] 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.