[57.654063] Initializing watchdogs
[57.654111]   /dev/watchdog0
[57.668651] [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]
[57.673225] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.675537] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.679072] [001/131] (960s left) vgem_slow (nohang)
[57.775234] Starting subtest: nohang
[68.214635] Subtest nohang: SUCCESS (10.450s)
[68.299633] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[68.302624] [002/131] (949s left) gem_userptr_blits (unsync-overlap)
[68.374405] Subtest unsync-overlap: SKIP (0.000s)
[68.540505] [003/131] (949s left) gem_exec_schedule (u-fairslice-all)
[68.623239] Starting subtest: u-fairslice-all
[70.694445] Subtest u-fairslice-all: SUCCESS (2.077s)
[71.963836] [004/131] (946s left) gem_lmem_swapping (parallel-random)
[72.010140] Subtest parallel-random: SKIP (0.000s)
[72.046825] [005/131] (946s left) kms_sequence (queue-idle)
[72.144789] Starting subtest: queue-idle
[72.147075] Starting dynamic subtest: pipe-A-eDP-1
[73.971393] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.828s)
[73.979292] Starting dynamic subtest: pipe-B-eDP-1
[76.415347] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.442s)
[76.424607] Starting dynamic subtest: pipe-C-eDP-1
[78.830291] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.415s)
[78.843073] Starting dynamic subtest: pipe-D-eDP-1
[81.264799] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s)
[81.267146] Subtest queue-idle: SUCCESS (9.121s)
[82.092169] [006/131] (936s left) gem_exec_schedule (lateslice)
[82.165240] Starting subtest: lateslice
[82.167227] Starting dynamic subtest: rcs0
[82.173812] Dynamic subtest rcs0: SUCCESS (0.019s)
[82.182952] Starting dynamic subtest: bcs0
[82.189095] Dynamic subtest bcs0: SUCCESS (0.015s)
[82.196264] Starting dynamic subtest: vcs0
[82.205324] Dynamic subtest vcs0: SUCCESS (0.016s)
[82.212610] Starting dynamic subtest: vcs1
[82.223975] Dynamic subtest vcs1: SUCCESS (0.018s)
[82.231481] Starting dynamic subtest: vecs0
[82.239966] Dynamic subtest vecs0: SUCCESS (0.016s)
[82.247377] Starting dynamic subtest: ccs0
[82.256117] Dynamic subtest ccs0: SUCCESS (0.016s)
[82.258368] Subtest lateslice: SUCCESS (0.101s)
[84.049018] [007/131] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[84.150218] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[84.154504] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[84.260437] [008/131] (934s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[84.808685] Starting subtest: syncobj-timeline-invalid-wait
[84.811083] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[86.019951] [009/131] (932s left) gem_exec_params (no-vebox)
[86.073877] Starting subtest: no-vebox
[86.076298] Subtest no-vebox: SUCCESS (0.003s)
[87.998770] [010/131] (930s left) gem_exec_balancer (parallel-contexts)
[88.264999] Starting subtest: parallel-contexts
[91.944682] Subtest parallel-contexts: SUCCESS (3.680s)
[92.114955] [011/131] (926s left) kms_pm_rpm (legacy-planes-dpms)
[94.078508] Starting subtest: legacy-planes-dpms
[94.081894] Starting dynamic subtest: plane-63
[102.686068] Dynamic subtest plane-63: SUCCESS (8.608s)
[102.696253] Starting dynamic subtest: plane-93
[111.372716] Dynamic subtest plane-93: SUCCESS (8.686s)
[111.383364] Starting dynamic subtest: plane-123
[119.700597] Dynamic subtest plane-123: SUCCESS (8.327s)
[119.710366] Starting dynamic subtest: plane-133
[128.025147] Dynamic subtest plane-133: SUCCESS (8.323s)
[128.027591] Subtest legacy-planes-dpms: SUCCESS (33.947s)
[128.436469] [012/131] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[128.536649] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[128.541080] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[128.665684] [013/131] (889s left) kms_cursor_edge_walk (64x64-left-edge)
[128.766815] Starting subtest: 64x64-left-edge
[128.769171] Starting dynamic subtest: pipe-A-eDP-1
[132.263690] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.496s)
[132.274048] Starting dynamic subtest: pipe-D-eDP-1
[135.385058] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[135.387355] Subtest 64x64-left-edge: SUCCESS (6.619s)
[136.210602] [014/131] (882s left) gem_mmap_offset (open-flood)
[136.273851] Starting subtest: open-flood
[157.762117] Subtest open-flood: SUCCESS (21.490s)
[157.940445] [015/131] (860s left) gem_spin_batch (spin-each)
[158.009396] Starting subtest: spin-each
[161.379936] Subtest spin-each: SUCCESS (3.369s)
[162.007259] [016/131] (856s left) gem_ctx_persistence (saturated-hostile)
[162.069122] Starting subtest: saturated-hostile
[162.071435] Starting dynamic subtest: rcs0
[162.912380] Dynamic subtest rcs0: SUCCESS (0.843s)
[162.923157] Starting dynamic subtest: bcs0
[163.706212] Dynamic subtest bcs0: SUCCESS (0.791s)
[163.717030] Starting dynamic subtest: vcs0
[164.485910] Dynamic subtest vcs0: SUCCESS (0.779s)
[164.495686] Starting dynamic subtest: vcs1
[165.302788] Dynamic subtest vcs1: SUCCESS (0.815s)
[165.313269] Starting dynamic subtest: vecs0
[166.101401] Dynamic subtest vecs0: SUCCESS (0.797s)
[166.111622] Starting dynamic subtest: ccs0
[166.964230] Dynamic subtest ccs0: SUCCESS (0.862s)
[166.966739] Subtest saturated-hostile: SUCCESS (4.896s)
[167.068938] [017/131] (851s left) gem_ctx_shared (q-independent)
[167.143135] Starting subtest: Q-independent
[167.145587] Starting dynamic subtest: rcs0
[167.268598] Dynamic subtest rcs0: SUCCESS (0.124s)
[167.279211] Starting dynamic subtest: vcs0
[167.331842] Dynamic subtest vcs0: SUCCESS (0.064s)
[167.342871] Starting dynamic subtest: vcs1
[167.397637] Dynamic subtest vcs1: SUCCESS (0.065s)
[167.405753] Starting dynamic subtest: vecs0
[167.463240] Dynamic subtest vecs0: SUCCESS (0.065s)
[167.473922] Starting dynamic subtest: ccs0
[167.549767] Dynamic subtest ccs0: SUCCESS (0.086s)
[167.552832] Subtest Q-independent: SUCCESS (0.406s)
[169.064591] [018/131] (849s left) kms_psr (fbc-psr-primary-render)
[169.165993] Starting subtest: fbc-psr-primary-render
[169.168401] Starting dynamic subtest: eDP-1
[169.172653] Dynamic subtest eDP-1: SKIP (0.000s)
[169.176944] Subtest fbc-psr-primary-render: SKIP (0.001s)
[169.266128] [019/131] (849s left) perf_pmu (rc6-all-gts)
[169.308336] Starting subtest: rc6-all-gts
[175.683043] Subtest rc6-all-gts: SUCCESS (6.373s)
[176.580314] [020/131] (842s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[176.689155] Starting subtest: crc-primary-suspend-y-tiled-ccs
[176.691377] Starting dynamic subtest: pipe-A-eDP-1
[176.700650] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[176.710068] Starting dynamic subtest: pipe-B-eDP-1
[176.717932] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[176.725722] Starting dynamic subtest: pipe-C-eDP-1
[176.732728] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[176.739964] Starting dynamic subtest: pipe-D-eDP-1
[176.747044] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[176.750428] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[178.975947] [021/131] (840s left) gem_pxp (create-regular-context-1)
[179.107820] Starting subtest: create-regular-context-1
[179.110601] Subtest create-regular-context-1: SUCCESS (0.002s)
[179.253572] [022/131] (839s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[179.331769] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[179.336361] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[179.540645] [023/131] (839s left) syncobj_timeline (host-signal-points)
[179.598924] Starting subtest: host-signal-points
[179.601579] Subtest host-signal-points: SUCCESS (0.005s)
[179.744750] [024/131] (839s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[179.838994] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[179.841302] Starting dynamic subtest: pipe-A-eDP-1
[179.866645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[179.880186] Starting dynamic subtest: pipe-B-eDP-1
[179.903677] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[179.911443] Starting dynamic subtest: pipe-C-eDP-1
[179.934808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[179.944484] Starting dynamic subtest: pipe-D-eDP-1
[179.968312] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[179.972623] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[182.131889] [025/131] (837s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[182.229469] Starting subtest: stress-xrgb8888-xtiled
[188.096661] Subtest stress-xrgb8888-xtiled: SUCCESS (5.867s)
[188.154382] [026/131] (831s left) kms_async_flips (test-time-stamp)
[188.247697] Starting subtest: test-time-stamp
[188.636504] Starting dynamic subtest: pipe-A-eDP-1
[189.421287] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.782s)
[189.797951] Starting dynamic subtest: pipe-B-eDP-1
[190.552251] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[190.932488] Starting dynamic subtest: pipe-C-eDP-1
[191.696125] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[192.079657] Starting dynamic subtest: pipe-D-eDP-1
[192.837689] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.762s)
[192.840239] Subtest test-time-stamp: SUCCESS (4.589s)
[194.059727] [027/131] (825s left) prime_self_import (basic-with_two_bos)
[194.105042] Starting subtest: basic-with_two_bos
[194.133631] Subtest basic-with_two_bos: SUCCESS (0.027s)
[194.274555] [028/131] (825s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[194.377683] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[201.956134] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.580s)
[202.116979] [029/131] (817s left) gem_mmap_gtt (close-race)
[202.193264] Subtest close-race: SKIP (0.000s)
[202.267284] [030/131] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[202.369797] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[206.757980] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.391s)
[207.951933] [031/131] (811s left) gen9_exec_parse (valid-registers)
[208.016919] Subtest valid-registers: SKIP (0.000s)
[208.107322] [032/131] (811s left) kms_color (legacy-gamma-reset)
[208.190081] Starting subtest: legacy-gamma-reset
[208.191968] Starting dynamic subtest: pipe-A-eDP-1
[208.570054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.379s)
[208.578522] Starting dynamic subtest: pipe-B-eDP-1
[208.580894] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[208.588950] Starting dynamic subtest: pipe-C-eDP-1
[208.593973] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[208.602063] Starting dynamic subtest: pipe-D-eDP-1
[208.607569] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[208.609946] Subtest legacy-gamma-reset: SUCCESS (0.418s)
[209.370619] [033/131] (810s left) gem_partial_pwrite_pread (reads-snoop)
[209.441653] Subtest reads-snoop: SKIP (0.000s)
[209.526352] [034/131] (810s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[209.625661] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[209.629806] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[209.757027] [035/131] (809s left) gem_exec_reloc (basic-gtt-noreloc)
[209.828626] Subtest basic-gtt-noreloc: SKIP (0.000s)
[209.904417] [036/131] (809s left) syncobj_timeline (invalid-transfer-illegal-handle)
[209.961290] Starting subtest: invalid-transfer-illegal-handle
[209.963628] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[210.101227] [037/131] (809s left) gem_ctx_param (invalid-get-engines)
[210.167119] Starting subtest: invalid-get-engines
[210.169465] Subtest invalid-get-engines: SUCCESS (0.001s)
[210.286820] [038/131] (809s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[210.387833] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[210.391549] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[210.506461] [039/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[210.604847] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[210.608668] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[210.746423] [040/131] (809s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[210.841964] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[210.845391] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[210.973596] [041/131] (808s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[211.058361] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[211.060267] Starting dynamic subtest: pipe-A-eDP-1
[211.079337] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.089507] Starting dynamic subtest: pipe-B-eDP-1
[211.107618] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.115128] Starting dynamic subtest: pipe-C-eDP-1
[211.132500] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.140047] Starting dynamic subtest: pipe-D-eDP-1
[211.158064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.161580] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[213.335736] [042/131] (806s left) kms_plane_cursor (primary)
[213.429354] Starting subtest: primary
[213.433860] Starting dynamic subtest: pipe-A-eDP-1-size-64
[216.002147] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.572s)
[216.025239] Starting dynamic subtest: pipe-A-eDP-1-size-128
[218.569259] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[218.594954] Starting dynamic subtest: pipe-A-eDP-1-size-256
[221.137120] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[221.451973] Starting dynamic subtest: pipe-B-eDP-1-size-64
[224.733050] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.291s)
[224.757547] Starting dynamic subtest: pipe-B-eDP-1-size-128
[227.332663] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.582s)
[227.357812] Starting dynamic subtest: pipe-B-eDP-1-size-256
[229.924023] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[230.240146] Starting dynamic subtest: pipe-C-eDP-1-size-64
[233.175448] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.946s)
[233.201769] Starting dynamic subtest: pipe-C-eDP-1-size-128
[235.353467] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.157s)
[235.379227] Starting dynamic subtest: pipe-C-eDP-1-size-256
[237.519539] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[237.845090] Starting dynamic subtest: pipe-D-eDP-1-size-64
[240.799083] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.962s)
[240.827843] Starting dynamic subtest: pipe-D-eDP-1-size-128
[242.975270] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[243.000903] Starting dynamic subtest: pipe-D-eDP-1-size-256
[245.153219] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[245.468079] Subtest primary: SUCCESS (32.039s)
[246.367626] [043/131] (773s left) kms_flip (dpms-off-confusion-interruptible)
[246.473755] Starting subtest: dpms-off-confusion-interruptible
[246.476056] Starting dynamic subtest: A-eDP1
[255.145060] Dynamic subtest A-eDP1: SUCCESS (8.670s)
[255.154846] Starting dynamic subtest: B-eDP1
[263.775540] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[263.785490] Starting dynamic subtest: C-eDP1
[272.394433] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[272.405320] Starting dynamic subtest: D-eDP1
[281.023561] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[281.028937] Subtest dpms-off-confusion-interruptible: SUCCESS (34.553s)
[282.226183] [044/131] (737s left) kms_cursor_edge_walk (256x256-top-bottom)
[282.337370] Starting subtest: 256x256-top-bottom
[282.339743] Starting dynamic subtest: pipe-A-eDP-1
[285.753061] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.415s)
[285.761723] Starting dynamic subtest: pipe-D-eDP-1
[288.891226] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[288.893509] Subtest 256x256-top-bottom: SUCCESS (6.556s)
[289.705659] [045/131] (730s left) kms_psr (pr-sprite-plane-onoff)
[289.808108] Starting subtest: pr-sprite-plane-onoff
[289.812260] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[289.907074] [046/131] (730s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[290.028099] Starting subtest: short-flip-before-cursor-toggle
[290.942950] Subtest short-flip-before-cursor-toggle: SUCCESS (0.912s)
[291.831492] [047/131] (728s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[291.924384] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[291.926662] Starting dynamic subtest: A-eDP1
[300.848117] Dynamic subtest A-eDP1: SUCCESS (8.923s)
[300.861554] Starting dynamic subtest: B-eDP1
[309.765289] Dynamic subtest B-eDP1: SUCCESS (8.914s)
[309.774963] Starting dynamic subtest: C-eDP1
[318.691989] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[318.700292] Starting dynamic subtest: D-eDP1
[327.617077] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[327.619457] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.694s)
[328.865132] [048/131] (691s left) gem_exec_params (secure-non-master)
[328.928072] Starting subtest: secure-non-master
[328.932459] Subtest secure-non-master: SKIP (0.000s)
[329.061993] [049/131] (691s left) kms_flip (2x-flip-vs-dpms)
[329.149026] Starting subtest: 2x-flip-vs-dpms
[329.160761] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[329.270046] [050/131] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[329.374441] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[329.378695] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[329.505826] [051/131] (690s left) drm_read (fault-buffer)
[329.656680] Starting subtest: fault-buffer
[329.659091] Subtest fault-buffer: SUCCESS (0.000s)
[329.827970] [052/131] (690s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[329.893102] Starting subtest: basic-batch-kernel-default-cmd
[329.896850] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[330.099740] [053/131] (690s left) kms_cursor_crc (cursor-offscreen-128x128)
[330.308782] Starting subtest: cursor-offscreen-128x128
[330.313930] Starting dynamic subtest: pipe-A-eDP-1
[332.230716] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.918s)
[332.266103] Starting dynamic subtest: pipe-D-eDP-1
[334.831561] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.572s)
[334.833806] Subtest cursor-offscreen-128x128: SUCCESS (4.519s)
[335.709926] [054/131] (684s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[335.815800] Starting subtest: x-tiled-8bpp-rotate-90
[335.841760] Subtest x-tiled-8bpp-rotate-90: SKIP (0.025s)
[335.988727] [055/131] (684s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[336.053700] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[336.157739] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[336.259682] [056/131] (684s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[336.370412] Starting subtest: 4-tiled-32bpp-rotate-90
[336.389900] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[336.537589] [057/131] (683s left) core_setmaster (master-drop-set-shared-fd)
[336.632272] Starting subtest: master-drop-set-shared-fd
[336.654386] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[336.693838] [058/131] (683s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[336.790969] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[336.800822] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[336.930296] [059/131] (683s left) syncobj_wait (single-wait-all-submitted)
[336.999073] Starting subtest: single-wait-all-submitted
[337.100602] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[337.199867] [060/131] (683s left) kms_big_fb (linear-64bpp-rotate-270)
[337.315923] Starting subtest: linear-64bpp-rotate-270
[337.334446] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[337.496437] [061/131] (683s left) gem_exec_params (invalid-fence-in-submit)
[337.564548] Starting subtest: invalid-fence-in-submit
[337.569204] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[337.726185] [062/131] (683s left) syncobj_wait (single-wait-for-submit-submitted)
[337.784436] Starting subtest: single-wait-for-submit-submitted
[337.894205] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[337.995046] [063/131] (682s left) prime_vgem (fence-write-hang)
[338.077662] Subtest fence-write-hang: SKIP (0.000s)
[338.207152] [064/131] (682s left) syncobj_timeline (single-wait-signaled)
[338.272640] Starting subtest: single-wait-signaled
[338.274602] Subtest single-wait-signaled: SUCCESS (0.000s)
[338.399905] [065/131] (682s left) kms_chamelium_edid (vga-edid-read)
[338.781704] Subtest vga-edid-read: SKIP (0.000s)
[339.618460] [066/131] (681s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[339.737934] Starting subtest: 2x-long-flip-vs-cursor-atomic
[339.742618] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[339.906220] [067/131] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[340.018101] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[344.518987] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.504s)
[345.748836] [068/131] (675s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[345.860134] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[350.452814] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.596s)
[351.666376] [069/131] (669s left) prime_vgem (basic-read)
[351.750503] Starting subtest: basic-read
[351.773291] Subtest basic-read: SKIP (0.020s)
[351.907406] [070/131] (669s left) gem_userptr_blits (vma-merge)
[351.983251] Starting subtest: vma-merge
[352.024806] Subtest vma-merge: SUCCESS (0.041s)
[352.174746] [071/131] (668s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[352.279177] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[352.283894] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[352.402940] [072/131] (668s left) kms_vrr (negative-basic)
[352.489343] Starting subtest: negative-basic
[352.495889] Starting dynamic subtest: pipe-A-eDP-1
[357.908689] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.412s)
[358.212966] Subtest negative-basic: SUCCESS (5.723s)
[359.100872] [073/131] (662s left) gem_exec_reloc (basic-cpu-read-active)
[359.156810] Subtest basic-cpu-read-active: SKIP (0.000s)
[359.275907] [074/131] (662s left) kms_chamelium_hpd (hdmi-hpd)
[359.668775] Subtest hdmi-hpd: SKIP (0.000s)
[360.482069] [075/131] (660s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[360.583611] Starting subtest: yf-tiled-16bpp-rotate-0
[360.587962] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[360.714970] [076/131] (660s left) syncobj_timeline (reset-signaled)
[360.773072] Starting subtest: reset-signaled
[360.775304] Subtest reset-signaled: SUCCESS (0.000s)
[360.904882] [077/131] (660s left) kms_psr (fbc-psr2-basic)
[360.990943] Starting subtest: fbc-psr2-basic
[360.993224] Starting dynamic subtest: eDP-1
[360.997498] Dynamic subtest eDP-1: SKIP (0.000s)
[361.001778] Subtest fbc-psr2-basic: SKIP (0.001s)
[361.090953] [078/131] (660s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[361.196111] Starting subtest: primary-yf-tiled-reflect-x-0
[361.256279] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[361.380174] [079/131] (660s left) kms_prop_blob (basic)
[361.438475] Starting subtest: basic
[361.440644] Subtest basic: SUCCESS (0.000s)
[361.565776] [080/131] (659s left) vgem_basic (debugfs)
[361.609059] Starting subtest: debugfs
[361.610759] Subtest debugfs: SUCCESS (0.000s)
[361.698297] [081/131] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[361.803037] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[368.868915] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.068s)
[369.019609] [082/131] (652s left) gem_userptr_blits (unsync-unmap-cycles)
[369.093524] Subtest unsync-unmap-cycles: SKIP (0.000s)
[369.258757] [083/131] (652s left) perf_pmu (busy-double-start)
[369.305762] Starting subtest: busy-double-start
[369.307863] Starting dynamic subtest: rcs0
[372.940958] Dynamic subtest rcs0: FAIL (3.581s)
[372.950211] Starting dynamic subtest: bcs0
[376.456507] Dynamic subtest bcs0: SUCCESS (3.570s)
[376.465710] Starting dynamic subtest: vcs0
[380.451839] Dynamic subtest vcs0: SUCCESS (3.994s)
[380.460101] Starting dynamic subtest: vcs1
[384.447707] Dynamic subtest vcs1: SUCCESS (3.994s)
[384.458667] Starting dynamic subtest: vecs0
[388.447816] Dynamic subtest vecs0: SUCCESS (3.998s)
[388.458766] Starting dynamic subtest: ccs0
[392.083190] Dynamic subtest ccs0: FAIL (3.566s)
[392.085164] Subtest busy-double-start: FAIL (22.712s)
[392.152689] [084/131] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[392.258409] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[392.262374] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[392.377108] [085/131] (629s left) kms_chamelium_color (ctm-negative)
[392.476231] Subtest ctm-negative: SKIP (0.000s)
[392.526720] [086/131] (629s left) kms_async_flips (async-flip-dpms)
[392.622684] Starting subtest: async-flip-dpms
[393.788790] Starting dynamic subtest: pipe-A-eDP-1
[397.248614] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.460s)
[397.621691] Starting dynamic subtest: pipe-B-eDP-1
[400.401085] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.787s)
[400.794845] Starting dynamic subtest: pipe-C-eDP-1
[403.571608] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.785s)
[403.945273] Starting dynamic subtest: pipe-D-eDP-1
[406.719980] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s)
[406.722350] Subtest async-flip-dpms: SUCCESS (14.098s)
[407.923973] [087/131] (613s left) gem_busy (semaphore)
[408.133792] Subtest semaphore: SKIP (0.000s)
[408.385864] [088/131] (613s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[408.494991] Starting subtest: flip-vs-dpms-off-vs-modeset
[408.496875] Starting dynamic subtest: A-eDP1
[412.142494] Dynamic subtest A-eDP1: SUCCESS (3.646s)
[412.151599] Starting dynamic subtest: B-eDP1
[415.348090] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[415.356461] Starting dynamic subtest: C-eDP1
[418.447022] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[418.457640] Starting dynamic subtest: D-eDP1
[421.562874] Dynamic subtest D-eDP1: SUCCESS (3.114s)
[421.565160] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.072s)
[422.379452] [089/131] (599s left) prime_mmap (test_reprime)
[422.434228] Starting subtest: test_reprime
[422.436119] Starting dynamic subtest: test_reprime-smem
[422.464465] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[422.466824] Subtest test_reprime: SUCCESS (0.033s)
[422.609932] [090/131] (599s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[427.632957] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[427.637747] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[428.517326] [091/131] (593s left) gem_exec_whisper (basic-fds)
[428.575604] Starting subtest: basic-fds
[435.835334] Subtest basic-fds: SUCCESS (7.255s)
[436.041641] [092/131] (586s left) gem_ctx_param (set-priority-range)
[436.107068] Starting subtest: set-priority-range
[436.121169] Subtest set-priority-range: SUCCESS (0.014s)
[436.265547] [093/131] (585s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[436.372827] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[436.375095] Starting dynamic subtest: pipe-A-default-mode
[439.124231] Dynamic subtest pipe-A-default-mode: SUCCESS (2.749s)
[439.126575] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.751s)
[440.003580] [094/131] (582s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[440.104102] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[440.106355] Starting dynamic subtest: pipe-A-default-mode
[440.413690] Dynamic subtest pipe-A-default-mode: SKIP (0.301s)
[440.418086] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.305s)
[441.244427] [095/131] (580s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[441.339792] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[441.344398] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[441.481016] [096/131] (580s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[441.571068] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[441.573192] Starting dynamic subtest: pipe-A-eDP-1
[441.722444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s)
[441.731121] Starting dynamic subtest: pipe-B-eDP-1
[441.749937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[441.758414] Starting dynamic subtest: pipe-C-eDP-1
[441.777799] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[441.785920] Starting dynamic subtest: pipe-D-eDP-1
[441.804942] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[441.806782] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.180s)
[444.011369] [097/131] (578s left) i915_selftest (mock)
[447.576028] Starting subtest: mock
[447.578295] Starting dynamic subtest: sanitycheck
[448.324924] Dynamic subtest sanitycheck: SUCCESS (0.753s)
[448.334122] Starting dynamic subtest: shmem
[449.101172] Dynamic subtest shmem: SUCCESS (0.774s)
[449.110309] Starting dynamic subtest: fence
[457.065361] Dynamic subtest fence: SUCCESS (7.961s)
[457.074261] Starting dynamic subtest: scatterlist
[458.834019] Dynamic subtest scatterlist: SUCCESS (1.767s)
[458.843471] Starting dynamic subtest: syncmap
[462.203052] Dynamic subtest syncmap: SUCCESS (3.367s)
[462.211698] Starting dynamic subtest: uncore
[462.970919] Dynamic subtest uncore: SUCCESS (0.766s)
[462.980521] Starting dynamic subtest: ring
[463.745208] Dynamic subtest ring: SUCCESS (0.772s)
[463.754533] Starting dynamic subtest: engine
[464.501095] Dynamic subtest engine: SUCCESS (0.754s)
[464.509797] Starting dynamic subtest: timelines
[468.418300] Dynamic subtest timelines: SUCCESS (3.914s)
[468.427446] Starting dynamic subtest: requests
[471.980393] Dynamic subtest requests: SUCCESS (3.560s)
[471.989812] Starting dynamic subtest: objects
[472.871475] Dynamic subtest objects: SUCCESS (0.890s)
[472.880594] Starting dynamic subtest: phys
[473.784404] Dynamic subtest phys: SUCCESS (0.911s)
[473.793485] Starting dynamic subtest: dmabuf
[474.695640] Dynamic subtest dmabuf: SUCCESS (0.909s)
[474.704451] Starting dynamic subtest: vma
[480.213361] Dynamic subtest vma: SUCCESS (5.515s)
[480.223310] Starting dynamic subtest: evict
[481.690100] Dynamic subtest evict: SUCCESS (1.475s)
[481.699287] Starting dynamic subtest: gtt
[484.922039] Dynamic subtest gtt: SUCCESS (3.229s)
[484.931435] Starting dynamic subtest: hugepages
[485.910225] Dynamic subtest hugepages: SUCCESS (0.986s)
[485.919718] Starting dynamic subtest: memory_region
[488.690242] Dynamic subtest memory_region: SUCCESS (2.778s)
[488.692924] Subtest mock: SUCCESS (41.119s)
[488.718028] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[488.718741] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[488.721864] [098/131] (533s left) gem_ctx_exec (basic-close-race)
[490.320892] Starting subtest: basic-close-race
[496.372579] Subtest basic-close-race: SUCCESS (6.051s)
[496.493849] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[496.495340] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[496.499178] [099/131] (525s left) prime_busy (after)
[496.579315] Starting subtest: after
[496.584640] Starting dynamic subtest: rcs0
[496.617352] Dynamic subtest rcs0: SUCCESS (0.034s)
[496.624909] Starting dynamic subtest: bcs0
[496.676768] Dynamic subtest bcs0: SUCCESS (0.058s)
[496.686719] Starting dynamic subtest: vcs0
[496.717796] Dynamic subtest vcs0: SUCCESS (0.040s)
[496.727600] Starting dynamic subtest: vcs1
[496.759233] Dynamic subtest vcs1: SUCCESS (0.040s)
[496.767186] Starting dynamic subtest: vecs0
[496.798790] Dynamic subtest vecs0: SUCCESS (0.039s)
[496.806977] Starting dynamic subtest: ccs0
[496.841425] Dynamic subtest ccs0: SUCCESS (0.042s)
[496.950843] Subtest after: SUCCESS (0.370s)
[497.050122] [100/131] (525s left) syncobj_wait (reset-signaled)
[497.096553] Starting subtest: reset-signaled
[497.098532] Subtest reset-signaled: SUCCESS (0.000s)
[497.230946] [101/131] (525s left) kms_dsc (dsc-basic)
[497.331982] Starting subtest: dsc-basic
[497.345075] Subtest dsc-basic: SKIP (0.000s)
[497.429994] [102/131] (525s left) vgem_basic (bad-flag)
[497.471573] Starting subtest: bad-flag
[497.473483] Subtest bad-flag: SUCCESS (0.000s)
[497.549925] [103/131] (524s left) kms_psr (psr2-sprite-mmap-gtt)
[497.673310] Starting subtest: psr2-sprite-mmap-gtt
[497.675620] Starting dynamic subtest: eDP-1
[499.143476] Dynamic subtest eDP-1: SKIP (1.464s)
[499.148456] Subtest psr2-sprite-mmap-gtt: SKIP (1.467s)
[499.319690] [104/131] (523s left) gem_exec_balancer (noheartbeat)
[499.589421] Starting subtest: noheartbeat
[499.594101] Subtest noheartbeat: SKIP (0.000s)
[499.715567] [105/131] (522s left) gem_tiled_wb
[499.857469] [106/131] (522s left) gem_exec_reloc (basic-softpin)
[499.919312] Subtest basic-softpin: SKIP (0.000s)
[500.006985] [107/131] (522s left) gem_pxp (hw-rejects-pxp-buffer)
[500.139504] Starting subtest: hw-rejects-pxp-buffer
[500.144305] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[500.285469] [108/131] (522s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[505.234754] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[505.237072] Starting dynamic subtest: pipe-A-eDP-1
[506.038896] Dynamic subtest pipe-A-eDP-1: SKIP (0.801s)
[506.047490] Starting dynamic subtest: pipe-B-eDP-1
[507.160065] Dynamic subtest pipe-B-eDP-1: SKIP (1.118s)
[507.164258] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.924s)
[508.371521] [109/131] (514s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[508.501314] Starting subtest: 2x-cursor-vs-flip-legacy
[508.505718] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[508.672321] [110/131] (514s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[508.765663] Starting subtest: multiplane-rotation-cropping-bottom
[526.112239] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.349s)
[526.249450] [111/131] (496s left) gem_userptr_blits (sync-overlap)
[526.336255] Starting subtest: sync-overlap
[526.338298] Subtest sync-overlap: SUCCESS (0.000s)
[526.502121] [112/131] (496s left) kms_feature_discovery (psr2)
[526.605461] Starting subtest: psr2
[526.607286] Subtest psr2: SUCCESS (0.000s)
[526.702406] [113/131] (496s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[526.796048] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[533.449816] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.654s)
[533.613998] [114/131] (489s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[533.721638] Starting subtest: y-tiled-32bpp-rotate-0
[533.726094] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[533.865268] [115/131] (489s left) gem_mmap_gtt (basic-small-bo)
[533.921674] Subtest basic-small-bo: SKIP (0.000s)
[533.988745] [116/131] (489s left) api_intel_bb (simple-bb)
[534.048063] Starting subtest: simple-bb
[534.053238] Subtest simple-bb: SUCCESS (0.007s)
[534.174328] [117/131] (488s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[534.284104] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[534.286346] Starting dynamic subtest: pipe-A
[534.307532] Dynamic subtest pipe-A: SKIP (0.019s)
[534.321961] Starting dynamic subtest: pipe-B
[534.339625] Dynamic subtest pipe-B: SKIP (0.032s)
[534.348453] Starting dynamic subtest: pipe-C
[534.371211] Dynamic subtest pipe-C: SKIP (0.032s)
[534.379063] Starting dynamic subtest: pipe-D
[534.404943] Dynamic subtest pipe-D: SKIP (0.031s)
[534.409242] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.116s)
[534.548788] [118/131] (488s left) kms_lease (lease-unleased-connector)
[534.640231] Starting subtest: lease-unleased-connector
[534.642009] Starting dynamic subtest: pipe-A-eDP-1
[534.646209] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[534.654522] Starting dynamic subtest: pipe-B-eDP-1
[534.656435] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[534.664695] Starting dynamic subtest: pipe-C-eDP-1
[534.666473] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[534.674323] Starting dynamic subtest: pipe-D-eDP-1
[534.676067] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[534.677806] Subtest lease-unleased-connector: SUCCESS (0.031s)
[534.809035] [119/131] (488s left) gen9_exec_parse (bb-secure)
[534.872624] Subtest bb-secure: SKIP (0.000s)
[534.941961] [120/131] (488s left) vgem_basic (mmap)
[534.978107] Starting subtest: mmap
[534.988499] Subtest mmap: SUCCESS (0.014s)
[535.065081] [121/131] (488s left) gem_eio (in-flight-contexts-10ms)
[535.301074] Starting subtest: in-flight-contexts-10ms
[548.919214] Subtest in-flight-contexts-10ms: SUCCESS (13.616s)
[549.122856] [122/131] (474s left) i915_pm_rpm (debugfs-forcewake-user)
[551.051400] Starting subtest: debugfs-forcewake-user
[562.442344] Subtest debugfs-forcewake-user: SUCCESS (11.389s)
[562.827213] [123/131] (460s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[562.929169] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[562.933654] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[563.062200] [124/131] (460s left) kms_psr (fbc-pr-no-drrs)
[563.156896] Starting subtest: fbc-pr-no-drrs
[563.161110] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[563.255592] [125/131] (460s left) kms_invalid_mode (bad-htotal)
[563.362912] Starting subtest: bad-htotal
[563.365259] Starting dynamic subtest: pipe-A-eDP-1
[563.647683] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[563.657135] Starting dynamic subtest: pipe-B-eDP-1
[563.659610] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[563.668118] Starting dynamic subtest: pipe-C-eDP-1
[563.670412] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[563.678232] Starting dynamic subtest: pipe-D-eDP-1
[563.680146] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[563.682064] Subtest bad-htotal: SUCCESS (0.289s)
[564.464562] [126/131] (458s left) kms_cursor_crc (cursor-random-128x42)
[564.694595] Starting subtest: cursor-random-128x42
[564.748339] Subtest cursor-random-128x42: SKIP (0.048s)
[565.003670] [127/131] (458s left) gem_linear_blits (interruptible)
[565.562425] Starting subtest: interruptible
[570.282991] Subtest interruptible: SUCCESS (4.719s)
[570.430034] [128/131] (453s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[570.584237] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[577.624247] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.041s)
[577.737989] [129/131] (445s left) i915_hangman (engine-engine-error)
[577.805334] Starting subtest: engine-engine-error
[577.807620] Starting dynamic subtest: rcs0
[578.873712] Dynamic subtest rcs0: SUCCESS (1.067s)
[578.888195] Starting dynamic subtest: bcs0
[580.857076] Dynamic subtest bcs0: SUCCESS (1.981s)
[580.869992] Starting dynamic subtest: vcs0
[582.903113] Dynamic subtest vcs0: SUCCESS (2.043s)
[582.915064] Starting dynamic subtest: vcs1
[584.888065] Dynamic subtest vcs1: SUCCESS (1.982s)
[584.900644] Starting dynamic subtest: vecs0
[586.871486] Dynamic subtest vecs0: SUCCESS (1.981s)
[586.883870] Starting dynamic subtest: ccs0
[588.856066] Dynamic subtest ccs0: SUCCESS (1.981s)
[588.859083] Subtest engine-engine-error: SUCCESS (11.051s)
[588.966263] [130/131] (434s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[589.073998] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[589.078586] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[589.202223] [131/131] (434s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[589.297280] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[589.299580] Starting dynamic subtest: pipe-A
[589.324515] Dynamic subtest pipe-A: SKIP (0.021s)
[589.335786] Starting dynamic subtest: pipe-B
[589.359785] Dynamic subtest pipe-B: SKIP (0.036s)
[589.369039] Starting dynamic subtest: pipe-C
[589.392361] Dynamic subtest pipe-C: SKIP (0.032s)
[589.403565] Starting dynamic subtest: pipe-D
[589.429363] Dynamic subtest pipe-D: SKIP (0.036s)
[589.433446] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.128s)
[589.558893] 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.