[54.606932] Initializing watchdogs
[54.607109]   /dev/watchdog0
[54.622897] [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]
[54.627656] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.629988] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.633071] [001/130] (960s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[54.744878] Starting subtest: plane-upscale-20x20-with-rotation
[54.747224] Starting dynamic subtest: pipe-A
[54.983397] Dynamic subtest pipe-A: SUCCESS (0.236s)
[54.991974] Starting dynamic subtest: pipe-B
[56.245507] Dynamic subtest pipe-B: SUCCESS (1.250s)
[56.253849] Starting dynamic subtest: pipe-C
[57.583698] Dynamic subtest pipe-C: SUCCESS (1.328s)
[57.592490] Starting dynamic subtest: pipe-D
[58.923381] Dynamic subtest pipe-D: SUCCESS (1.331s)
[58.925559] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.145s)
[60.119865] [002/130] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[60.214934] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[60.219086] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[60.320715] [003/130] (954s left) kms_big_fb (linear-8bpp-rotate-180)
[60.416882] Starting subtest: linear-8bpp-rotate-180
[61.600332] Subtest linear-8bpp-rotate-180: SUCCESS (1.179s)
[61.776080] [004/130] (953s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[61.872751] Starting subtest: blocking-absolute-wf_vblank-interruptible
[61.875155] Starting dynamic subtest: A-eDP1
[70.595951] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[70.603031] Starting dynamic subtest: B-eDP1
[79.333478] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[79.342100] Starting dynamic subtest: C-eDP1
[88.045864] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[88.054143] Starting dynamic subtest: D-eDP1
[96.779062] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[96.781363] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.877s)
[98.030771] [005/130] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[98.138435] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[98.142766] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[98.270612] [006/130] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[98.374066] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[105.059543] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.687s)
[105.191426] [007/130] (910s left) gem_ctx_exec (basic-norecovery)
[105.248253] Starting subtest: basic-norecovery
[105.532089] Subtest basic-norecovery: SUCCESS (0.284s)
[105.686641] [008/130] (909s left) kms_psr (psr-primary-page-flip)
[105.781973] Starting subtest: psr-primary-page-flip
[105.784320] Starting dynamic subtest: eDP-1
[107.546513] Dynamic subtest eDP-1: SUCCESS (1.765s)
[107.548829] Subtest psr-primary-page-flip: SUCCESS (1.765s)
[108.426238] [009/130] (907s left) core_getstats
[108.584609] [010/130] (906s left) i915_hangman (detector)
[108.643606] Starting subtest: detector
[108.645585] Starting dynamic subtest: rcs0
[119.860199] Dynamic subtest rcs0: SUCCESS (11.216s)
[119.871066] Starting dynamic subtest: bcs0
[131.891622] Dynamic subtest bcs0: SUCCESS (12.030s)
[131.900604] Starting dynamic subtest: vcs0
[143.795806] Dynamic subtest vcs0: SUCCESS (11.903s)
[143.806244] Starting dynamic subtest: vcs1
[153.842626] Dynamic subtest vcs1: SUCCESS (10.045s)
[153.852887] Starting dynamic subtest: vecs0
[165.876973] Dynamic subtest vecs0: SUCCESS (12.033s)
[165.885643] Starting dynamic subtest: ccs0
[177.842979] Dynamic subtest ccs0: SUCCESS (11.964s)
[177.845750] Subtest detector: SUCCESS (69.195s)
[177.924394] [011/130] (837s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[178.023298] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[178.025503] Starting dynamic subtest: pipe-A-eDP-1
[180.069749] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.048s)
[180.077663] Starting dynamic subtest: pipe-B-eDP-1
[182.155317] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.083s)
[182.163284] Starting dynamic subtest: pipe-C-eDP-1
[184.156504] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.000s)
[184.165219] Starting dynamic subtest: pipe-D-eDP-1
[186.204257] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.047s)
[186.206550] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.180s)
[187.440902] [012/130] (828s left) gem_lmem_swapping (parallel-random-engines)
[187.483507] Subtest parallel-random-engines: SKIP (0.000s)
[187.526355] [013/130] (828s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[187.615381] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[187.619445] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[187.730858] [014/130] (827s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[187.826973] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[187.831048] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[187.949703] [015/130] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[188.037414] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[188.041483] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[188.133951] [016/130] (827s left) gem_ctx_persistence (legacy-engines-hostile)
[188.191722] Starting subtest: legacy-engines-hostile
[188.194167] Starting dynamic subtest: render
[188.344064] Dynamic subtest render: SUCCESS (0.152s)
[188.356771] Starting dynamic subtest: bsd1
[188.458019] Dynamic subtest bsd1: SUCCESS (0.113s)
[188.467994] Starting dynamic subtest: bsd2
[188.583367] Dynamic subtest bsd2: SUCCESS (0.123s)
[188.593323] Starting dynamic subtest: blt
[188.705872] Dynamic subtest blt: SUCCESS (0.120s)
[188.715513] Starting dynamic subtest: vebox
[188.813147] Dynamic subtest vebox: SUCCESS (0.106s)
[188.815223] Subtest legacy-engines-hostile: SUCCESS (0.622s)
[188.901305] [017/130] (826s left) prime_vgem (shrink)
[189.012188] Starting subtest: shrink
[189.024104] Subtest shrink: SUCCESS (0.012s)
[189.153961] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[189.156940] [018/130] (826s left) gem_exec_schedule (preempt-queue-chain)
[189.221485] Subtest preempt-queue-chain: SKIP (0.000s)
[189.518271] [019/130] (826s left) kms_flip (flip-vs-panning-vs-hang)
[189.616011] Starting subtest: flip-vs-panning-vs-hang
[189.618238] Starting dynamic subtest: A-eDP1
[240.446243] Dynamic subtest A-eDP1: SUCCESS (50.830s)
[240.454869] Starting dynamic subtest: D-eDP1
[280.382336] Dynamic subtest D-eDP1: SUCCESS (39.934s)
[280.387813] Subtest flip-vs-panning-vs-hang: SUCCESS (90.768s)
[281.562459] [020/130] (734s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[281.811757] Starting subtest: cursor-rapid-movement-256x256
[281.817083] Starting dynamic subtest: pipe-A-eDP-1
[282.342385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.527s)
[282.365932] Starting dynamic subtest: pipe-D-eDP-1
[283.545294] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.183s)
[283.547199] Subtest cursor-rapid-movement-256x256: SUCCESS (1.731s)
[284.408981] [021/130] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[284.512308] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[284.516663] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[284.610740] [022/130] (731s left) gem_exec_balancer (sliced)
[284.673777] Starting subtest: sliced
[284.678277] Subtest sliced: SKIP (0.000s)
[285.005712] [023/130] (730s left) kms_psr (fbc-psr-suspend)
[285.097279] Starting subtest: fbc-psr-suspend
[285.099214] Starting dynamic subtest: eDP-1
[285.103352] Dynamic subtest eDP-1: SKIP (0.000s)
[285.107523] Subtest fbc-psr-suspend: SKIP (0.001s)
[285.192984] [024/130] (730s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[285.297818] Starting subtest: fbcpsr-stridechange
[291.387213] Subtest fbcpsr-stridechange: SUCCESS (6.093s)
[291.549682] [025/130] (724s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[291.672030] Starting subtest: 4-tiled-32bpp-rotate-180
[293.116265] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.446s)
[293.295450] [026/130] (722s left) gem_mmap_gtt (basic-read-write-distinct)
[293.351057] Subtest basic-read-write-distinct: SKIP (0.000s)
[293.415158] [027/130] (722s left) perf_pmu (busy-accuracy-2)
[293.455122] Starting subtest: busy-accuracy-2
[293.457049] Starting dynamic subtest: rcs0
[296.499198] Dynamic subtest rcs0: SUCCESS (3.041s)
[296.507047] Starting dynamic subtest: bcs0
[299.587468] Dynamic subtest bcs0: SUCCESS (3.057s)
[299.596573] Starting dynamic subtest: vcs0
[302.604310] Dynamic subtest vcs0: SUCCESS (3.045s)
[302.614868] Starting dynamic subtest: vcs1
[305.649209] Dynamic subtest vcs1: SUCCESS (3.043s)
[305.660338] Starting dynamic subtest: vecs0
[308.695249] Dynamic subtest vecs0: SUCCESS (3.043s)
[308.705273] Starting dynamic subtest: ccs0
[311.754167] Dynamic subtest ccs0: SUCCESS (3.057s)
[311.756557] Subtest busy-accuracy-2: SUCCESS (18.296s)
[311.894943] [028/130] (704s left) gem_create (create-ext-set-pat)
[312.056049] Starting subtest: create-ext-set-pat
[312.058790] Subtest create-ext-set-pat: SUCCESS (0.000s)
[312.180392] [029/130] (704s left) gem_exec_reloc (basic-wc-cpu-active)
[312.243023] Subtest basic-wc-cpu-active: SKIP (0.000s)
[312.308889] [030/130] (703s left) gem_ctx_persistence (userptr)
[312.373021] Starting subtest: userptr
[312.585425] Subtest userptr: SUCCESS (0.211s)
[312.691770] [031/130] (703s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[312.747230] Starting subtest: multi-wait-all-for-submit-unsubmitted
[312.849202] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[312.952977] [032/130] (703s left) gem_busy (close-race)
[313.019430] Starting subtest: close-race
[338.865743] Subtest close-race: SUCCESS (25.844s)
[339.249919] [033/130] (677s left) kms_addfb_basic (small-bo)
[339.377806] Starting subtest: small-bo
[339.380094] Subtest small-bo: SUCCESS (0.000s)
[339.501958] [034/130] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[339.603581] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[344.087718] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.488s)
[345.227377] [035/130] (671s left) syncobj_timeline (invalid-transfer-non-existent-point)
[345.291557] Starting subtest: invalid-transfer-non-existent-point
[345.293818] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[345.408687] [036/130] (671s left) kms_lease (lease-revoke)
[345.501257] Starting subtest: lease-revoke
[345.503896] Starting dynamic subtest: pipe-A-eDP-1
[345.533759] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[345.542708] Starting dynamic subtest: pipe-B-eDP-1
[345.561803] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[345.571192] Starting dynamic subtest: pipe-C-eDP-1
[345.590127] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[345.604922] Starting dynamic subtest: pipe-D-eDP-1
[345.618067] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[345.620439] Subtest lease-revoke: SUCCESS (0.120s)
[345.767145] [037/130] (670s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[345.858800] Starting subtest: psr-rgb101010-draw-pwrite
[353.399902] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.544s)
[353.536567] [038/130] (663s left) gem_mmap_offset (partial-remap)
[353.597995] Starting subtest: partial-remap
[353.600357] Starting dynamic subtest: smem0
[353.608533] Dynamic subtest smem0: SUCCESS (0.004s)
[353.610427] Subtest partial-remap: SUCCESS (0.004s)
[353.742689] [039/130] (662s left) gem_exec_whisper (basic-fds-priority)
[353.801549] Starting subtest: basic-fds-priority
[377.899110] Subtest basic-fds-priority: SUCCESS (24.094s)
[378.094305] [040/130] (638s left) gem_softpin (allocator-nopin)
[378.162352] Starting subtest: allocator-nopin
[378.278820] Subtest allocator-nopin: SUCCESS (0.114s)
[378.438083] [041/130] (638s left) gem_exec_reloc (basic-concurrent16)
[378.501169] Subtest basic-concurrent16: SKIP (0.000s)
[378.571564] [042/130] (638s left) kms_vrr (negative-basic)
[378.668015] Starting subtest: negative-basic
[378.674752] Starting dynamic subtest: pipe-A-eDP-1
[384.096913] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.421s)
[384.385532] Subtest negative-basic: SUCCESS (5.718s)
[385.267869] [043/130] (631s left) syncobj_timeline (single-wait-all-signaled)
[385.321469] Starting subtest: single-wait-all-signaled
[385.323953] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[385.452109] [044/130] (631s left) kms_psr (fbc-psr2-primary-page-flip)
[385.552140] Starting subtest: fbc-psr2-primary-page-flip
[385.554442] Starting dynamic subtest: eDP-1
[385.558795] Dynamic subtest eDP-1: SKIP (0.000s)
[385.563312] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[385.649856] [045/130] (631s left) kms_feature_discovery (display-4x)
[385.742196] Starting subtest: display-4x
[385.746184] Subtest display-4x: SKIP (0.000s)
[385.825327] [046/130] (631s left) kms_pm_rpm (universal-planes)
[388.068336] Starting subtest: universal-planes
[388.070931] Starting dynamic subtest: plane-33
[396.323894] Dynamic subtest plane-33: SUCCESS (8.253s)
[396.334533] Starting dynamic subtest: plane-43
[404.570716] Dynamic subtest plane-43: SUCCESS (8.246s)
[404.580220] Starting dynamic subtest: plane-53
[412.867964] Dynamic subtest plane-53: SUCCESS (8.295s)
[412.879538] Starting dynamic subtest: plane-63
[421.141176] Dynamic subtest plane-63: SUCCESS (8.271s)
[421.151148] Starting dynamic subtest: plane-73
[429.396076] Dynamic subtest plane-73: SUCCESS (8.253s)
[429.407250] Starting dynamic subtest: plane-83
[437.680921] Dynamic subtest plane-83: SUCCESS (8.281s)
[437.683755] Subtest universal-planes: SUCCESS (49.611s)
[438.067791] [047/130] (578s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[438.174016] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[439.218360] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.045s)
[439.388536] [048/130] (577s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[439.445122] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[439.528809] [049/130] (577s left) kms_scaling_modes (scaling-mode-full-aspect)
[439.628146] Starting subtest: scaling-mode-full-aspect
[439.630133] Starting dynamic subtest: pipe-A-eDP-1
[439.722387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[439.733613] Starting dynamic subtest: pipe-B-eDP-1
[440.872211] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s)
[440.884603] Starting dynamic subtest: pipe-C-eDP-1
[441.984227] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[441.994177] Starting dynamic subtest: pipe-D-eDP-1
[443.116779] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[443.119091] Subtest scaling-mode-full-aspect: SUCCESS (3.490s)
[444.297145] [050/130] (572s left) kms_color (degamma)
[444.387287] Starting subtest: degamma
[444.389365] Starting dynamic subtest: pipe-A-eDP-1
[445.067732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.681s)
[445.077892] Starting dynamic subtest: pipe-B-eDP-1
[446.449632] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[446.460294] Starting dynamic subtest: pipe-C-eDP-1
[447.842973] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[447.852391] Starting dynamic subtest: pipe-D-eDP-1
[449.159141] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[449.161553] Subtest degamma: SUCCESS (4.774s)
[450.018251] [051/130] (567s left) kms_cursor_crc (cursor-offscreen-256x85)
[450.279599] Starting subtest: cursor-offscreen-256x85
[450.320626] Subtest cursor-offscreen-256x85: SKIP (0.036s)
[450.516916] [052/130] (566s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[450.637019] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[450.641355] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[450.802064] [053/130] (566s left) perf_pmu (busy-start)
[450.843688] Starting subtest: busy-start
[450.845884] Starting dynamic subtest: rcs0
[453.393552] Dynamic subtest rcs0: SUCCESS (2.551s)
[453.405787] Starting dynamic subtest: bcs0
[455.943302] Dynamic subtest bcs0: SUCCESS (2.548s)
[455.954836] Starting dynamic subtest: vcs0
[459.923338] Dynamic subtest vcs0: SUCCESS (3.977s)
[459.934744] Starting dynamic subtest: vcs1
[463.891940] Dynamic subtest vcs1: SUCCESS (3.966s)
[463.903569] Starting dynamic subtest: vecs0
[467.924247] Dynamic subtest vecs0: SUCCESS (4.030s)
[467.935713] Starting dynamic subtest: ccs0
[470.471202] Dynamic subtest ccs0: SUCCESS (2.547s)
[470.473612] Subtest busy-start: SUCCESS (19.629s)
[470.583409] [054/130] (546s left) gem_spin_batch (spin-each)
[470.648731] Starting subtest: spin-each
[474.014185] Subtest spin-each: SUCCESS (3.365s)
[475.974663] [055/130] (541s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[476.081716] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[476.086155] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[476.202475] [056/130] (541s left) kms_chamelium_frames (hdmi-crc-multiple)
[476.583869] Subtest hdmi-crc-multiple: SKIP (0.000s)
[477.420167] [057/130] (539s left) gen9_exec_parse (bb-start-out)
[477.487457] Subtest bb-start-out: SKIP (0.000s)
[477.584106] [058/130] (539s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[477.707299] Starting subtest: cursorB-vs-flipA-atomic-transitions
[477.711791] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[477.876897] [059/130] (539s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[477.981580] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[477.985667] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[478.104923] [060/130] (539s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[478.194070] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[478.196222] Starting dynamic subtest: pipe-A-eDP-1
[478.217571] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[478.227973] Starting dynamic subtest: pipe-B-eDP-1
[478.248746] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[478.257120] Starting dynamic subtest: pipe-C-eDP-1
[478.277839] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[478.286040] Starting dynamic subtest: pipe-D-eDP-1
[478.307487] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[478.311053] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[480.414856] [061/130] (537s left) kms_flip (absolute-wf_vblank)
[480.516139] Starting subtest: absolute-wf_vblank
[480.518463] Starting dynamic subtest: A-eDP1
[489.260618] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[489.269736] Starting dynamic subtest: B-eDP1
[497.996345] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[498.008174] Starting dynamic subtest: C-eDP1
[506.716868] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[506.728060] Starting dynamic subtest: D-eDP1
[515.446753] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[515.452738] Subtest absolute-wf_vblank: SUCCESS (34.933s)
[516.692991] [062/130] (500s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[516.745856] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[516.849273] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[516.943820] [063/130] (500s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[517.003916] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[517.006211] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[517.143443] [064/130] (500s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[517.229266] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[517.240934] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[517.327729] [065/130] (500s left) kms_cursor_crc (cursor-onscreen-128x42)
[517.549605] Starting subtest: cursor-onscreen-128x42
[517.588567] Subtest cursor-onscreen-128x42: SKIP (0.035s)
[517.807826] [066/130] (499s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[517.895590] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[517.897402] Starting dynamic subtest: pipe-A-eDP-1
[517.946296] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[517.954534] Starting dynamic subtest: pipe-B-eDP-1
[518.001282] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[518.010769] Starting dynamic subtest: pipe-C-eDP-1
[518.059239] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[518.069343] Starting dynamic subtest: pipe-D-eDP-1
[518.119240] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[518.122871] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[520.052107] [067/130] (497s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[520.160171] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[520.162309] Starting dynamic subtest: pipe-A-eDP-1
[520.184980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[520.195346] Starting dynamic subtest: pipe-B-eDP-1
[520.217677] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[520.228807] Starting dynamic subtest: pipe-C-eDP-1
[520.250300] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[520.259962] Starting dynamic subtest: pipe-D-eDP-1
[520.282917] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[520.287207] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[522.321605] [068/130] (495s left) kms_vblank (query-idle)
[522.415820] Starting subtest: query-idle
[522.418175] Starting dynamic subtest: pipe-A-eDP-1
[524.177513] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[524.191178] Starting dynamic subtest: pipe-D-eDP-1
[526.649639] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.469s)
[526.651533] Subtest query-idle: SUCCESS (4.231s)
[527.503591] [069/130] (490s left) gem_exec_reloc (basic-cpu-read-active)
[527.572282] Subtest basic-cpu-read-active: SKIP (0.000s)
[527.645544] [070/130] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[527.742709] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[527.747149] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[527.868329] [071/130] (490s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[532.872644] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[532.875068] Starting dynamic subtest: pipe-A-eDP-1
[533.667128] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s)
[533.676915] Starting dynamic subtest: pipe-B-eDP-1
[534.794065] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[534.798537] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.919s)
[535.997555] [072/130] (481s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[536.101467] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[542.367125] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.269s)
[543.514406] [073/130] (474s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[543.616703] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[543.620971] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[543.735108] [074/130] (474s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[543.834578] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[551.146737] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.314s)
[551.325311] [075/130] (466s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[551.423199] Starting subtest: fbc-modesetfrombusy
[555.311742] Subtest fbc-modesetfrombusy: SUCCESS (3.893s)
[556.537947] [076/130] (461s left) gem_tiled_blits (basic)
[556.609523] Subtest basic: SKIP (0.000s)
[556.703985] [077/130] (461s left) gem_eio (context-create)
[556.924089] Starting subtest: context-create
[557.250126] Subtest context-create: SUCCESS (0.324s)
[557.374718] [078/130] (460s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[557.433169] Starting subtest: x-tiled-to-vebox-y-tiled
[557.436920] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[557.629932] [079/130] (460s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[557.744229] Starting subtest: basic-busy-flip-before-cursor-varying-size
[557.748493] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[557.901917] [080/130] (460s left) kms_plane_alpha_blend (alpha-7efc)
[558.005087] Starting subtest: alpha-7efc
[558.291444] Starting dynamic subtest: pipe-A-eDP-1
[558.866420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[558.890195] Starting dynamic subtest: pipe-D-eDP-1
[560.168533] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[560.170881] Subtest alpha-7efc: SUCCESS (2.165s)
[560.989323] [081/130] (457s left) i915_selftest (perf)
[562.908045] Starting subtest: perf
[562.910910] Starting dynamic subtest: engine_cs
[567.255712] Dynamic subtest engine_cs: SUCCESS (4.346s)
[567.264629] Starting dynamic subtest: request
[574.494467] Dynamic subtest request: SUCCESS (7.237s)
[574.503636] Starting dynamic subtest: migrate
[578.796319] Dynamic subtest migrate: SUCCESS (4.300s)
[578.805882] Starting dynamic subtest: region
[584.972415] Dynamic subtest region: SUCCESS (6.174s)
[584.974819] Subtest perf: SUCCESS (22.063s)
[585.002499] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[585.003196] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[585.006109] [082/130] (433s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[586.474558] Starting subtest: short-flip-before-cursor-toggle
[587.419839] Subtest short-flip-before-cursor-toggle: SUCCESS (0.945s)
[588.264369] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[588.265539] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true
[588.269118] [083/130] (430s left) kms_pm_rpm (modeset-lpsp-stress)
[590.084829] Starting subtest: modeset-lpsp-stress
[605.836911] Subtest modeset-lpsp-stress: SUCCESS (15.750s)
[605.938749] [084/130] (412s left) gem_exec_flush (basic-wb-rw-before-default)
[606.002604] Starting subtest: basic-wb-rw-before-default
[611.460167] Subtest basic-wb-rw-before-default: SUCCESS (5.458s)
[611.660585] [085/130] (406s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[611.756368] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[612.502123] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.748s)
[612.675457] [086/130] (405s left) i915_query (query-regions-unallocated)
[612.734188] Starting subtest: query-regions-unallocated
[612.736471] Subtest query-regions-unallocated: SUCCESS (0.000s)
[612.848860] [087/130] (405s left) gem_exec_flush (basic-batch-kernel-default-wb)
[612.913830] Starting subtest: basic-batch-kernel-default-wb
[619.764164] Subtest basic-batch-kernel-default-wb: SUCCESS (6.851s)
[619.965354] [088/130] (398s left) syncobj_wait (multi-wait-all-signaled)
[620.020143] Starting subtest: multi-wait-all-signaled
[620.022419] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[620.146211] [089/130] (398s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[620.244887] Starting subtest: fbc-dirtyfb-ioctl
[620.247195] Starting dynamic subtest: A-eDP-1
[622.848913] Dynamic subtest A-eDP-1: SUCCESS (2.604s)
[622.851288] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.605s)
[623.671184] [090/130] (395s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[628.662934] Starting subtest: psr2-overlay-plane-update-continuous-sf
[628.665259] Starting dynamic subtest: pipe-A-eDP-1
[630.403549] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.739s)
[630.412820] Starting dynamic subtest: pipe-B-eDP-1
[632.129249] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.726s)
[632.131774] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.469s)
[632.982438] [091/130] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[633.083100] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[633.087329] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[633.213823] [092/130] (385s left) kms_fbcon_fbt (fbc-suspend)
[633.266416] Starting subtest: fbc-suspend
[683.334625] Subtest fbc-suspend: SUCCESS (19.797s)
[688.449839] [093/130] (334s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[688.566631] Starting subtest: y-tiled-8bpp-rotate-270
[688.571038] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[688.692938] [094/130] (334s left) gem_exec_schedule (u-submit-early-slice)
[688.764513] Starting subtest: u-submit-early-slice
[688.766651] Starting dynamic subtest: rcs0
[688.811536] Dynamic subtest rcs0: SUCCESS (0.050s)
[688.823593] Starting dynamic subtest: bcs0
[688.846843] Dynamic subtest bcs0: SUCCESS (0.035s)
[688.856168] Starting dynamic subtest: vcs0
[688.885679] Dynamic subtest vcs0: SUCCESS (0.038s)
[688.895185] Starting dynamic subtest: vcs1
[688.922178] Dynamic subtest vcs1: SUCCESS (0.036s)
[688.932758] Starting dynamic subtest: vecs0
[688.957727] Dynamic subtest vecs0: SUCCESS (0.035s)
[688.968466] Starting dynamic subtest: ccs0
[688.997504] Dynamic subtest ccs0: SUCCESS (0.039s)
[689.000383] Subtest u-submit-early-slice: SUCCESS (0.237s)
[690.325481] [095/130] (332s left) vgem_basic (debugfs)
[690.373541] Starting subtest: debugfs
[690.375915] Subtest debugfs: SUCCESS (0.001s)
[690.441245] [096/130] (332s left) gen7_exec_parse (batch-without-end)
[690.514721] Subtest batch-without-end: SKIP (0.000s)
[690.586211] [097/130] (332s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[690.695107] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[712.667345] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (21.871s)
[712.828679] [098/130] (310s left) dmabuf_sync_file (export-basic)
[712.877805] Starting subtest: export-basic
[712.879554] Subtest export-basic: SUCCESS (0.001s)
[712.950022] [099/130] (310s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[713.031099] Starting subtest: random-ccs-data-y-tiled-ccs
[713.033049] Starting dynamic subtest: pipe-A-eDP-1
[713.053858] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[713.063269] Starting dynamic subtest: pipe-B-eDP-1
[713.082916] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[713.091833] Starting dynamic subtest: pipe-C-eDP-1
[713.111362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[713.119699] Starting dynamic subtest: pipe-D-eDP-1
[713.140383] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[713.143856] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[715.211006] [100/130] (307s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[715.323946] Starting subtest: cursorB-vs-flipB-atomic
[715.328348] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[715.482507] [101/130] (307s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[715.538788] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[715.598910] [102/130] (307s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[715.721393] Starting subtest: protected-encrypted-src-copy-not-readible
[715.832002] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[715.999217] [103/130] (307s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[716.113916] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[716.116291] Starting dynamic subtest: pipe-A-default-mode
[717.268094] Dynamic subtest pipe-A-default-mode: SKIP (1.150s)
[717.272945] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.151s)
[717.460185] [104/130] (305s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[717.547285] Starting subtest: fbcpsr-tiling-y
[717.551539] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[717.658293] [105/130] (305s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[718.209530] Starting subtest: syncobj-timeline-invalid-flags
[718.211909] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[719.290476] [106/130] (304s left) gem_basic (create-close)
[719.352154] Starting subtest: create-close
[719.356786] Subtest create-close: SUCCESS (0.000s)
[719.477513] [107/130] (304s left) api_intel_allocator (reloc-allocator)
[719.543255] Starting subtest: reloc-allocator
[719.545599] Starting dynamic subtest: basic
[719.550061] Dynamic subtest basic: SUCCESS (0.006s)
[719.560088] Starting dynamic subtest: parallel-one
[719.562390] Dynamic subtest parallel-one: SUCCESS (0.008s)
[719.574124] Starting dynamic subtest: print
[719.576026] Dynamic subtest print: SUCCESS (0.000s)
[719.587164] Starting dynamic subtest: reuse
[719.591199] Dynamic subtest reuse: SUCCESS (0.000s)
[719.601325] Starting dynamic subtest: fork-reopen-allocator
[719.603211] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[719.605087] Subtest reloc-allocator: SUCCESS (0.030s)
[719.743392] [108/130] (303s left) kms_psr (pr-primary-blt)
[719.839769] Starting subtest: pr-primary-blt
[719.844174] Subtest pr-primary-blt: SKIP (0.000s)
[719.939915] [109/130] (303s left) gem_ctx_bad_destroy (double-destroy)
[720.008409] Starting subtest: double-destroy
[720.011406] Subtest double-destroy: SUCCESS (0.000s)
[720.094792] [110/130] (303s left) core_getclient
[720.256194] [111/130] (303s left) syncobj_wait (wait-all-delayed-signal)
[720.301325] Starting subtest: wait-all-delayed-signal
[720.406214] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[720.513120] [112/130] (303s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[720.617218] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[720.621635] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[720.747879] [113/130] (302s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[720.842085] Starting subtest: yf-tiled-16bpp-rotate-0
[720.846213] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[720.962652] [114/130] (302s left) kms_async_flips (test-time-stamp)
[721.048830] Starting subtest: test-time-stamp
[721.427510] Starting dynamic subtest: pipe-A-eDP-1
[722.263527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.834s)
[722.633184] Starting dynamic subtest: pipe-B-eDP-1
[723.399475] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s)
[723.766963] Starting dynamic subtest: pipe-C-eDP-1
[724.535711] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[724.901325] Starting dynamic subtest: pipe-D-eDP-1
[725.674239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[725.676655] Subtest test-time-stamp: SUCCESS (4.623s)
[726.853373] [115/130] (296s left) kms_invalid_mode (bad-vsync-end)
[726.954082] Starting subtest: bad-vsync-end
[726.956381] Starting dynamic subtest: pipe-A-eDP-1
[727.237025] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[727.246826] Starting dynamic subtest: pipe-B-eDP-1
[727.248650] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[727.258107] Starting dynamic subtest: pipe-C-eDP-1
[727.260193] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[727.271749] Starting dynamic subtest: pipe-D-eDP-1
[727.274410] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[727.277055] Subtest bad-vsync-end: SUCCESS (0.290s)
[728.095077] [116/130] (295s left) gem_exec_suspend (basic)
[728.151808] Starting subtest: basic
[728.154287] Starting dynamic subtest: smem
[730.197789] Dynamic subtest smem: SUCCESS (2.042s)
[730.200604] Subtest basic: SUCCESS (2.044s)
[730.384982] [117/130] (293s left) api_intel_bb (blit-noreloc-purge-cache)
[730.432654] Starting subtest: blit-noreloc-purge-cache
[730.442055] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[730.584335] [118/130] (293s left) kms_plane (pixel-format-source-clamping)
[730.674408] Starting subtest: pixel-format-source-clamping
[730.701341] Starting dynamic subtest: pipe-A-plane-0
[735.470125] Dynamic subtest pipe-A-plane-0: SUCCESS (4.767s)
[735.480352] Starting dynamic subtest: pipe-A-plane-3
[737.738069] Dynamic subtest pipe-A-plane-3: SUCCESS (2.266s)
[737.747311] Starting dynamic subtest: pipe-A-plane-5
[737.748974] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[738.866801] Starting dynamic subtest: pipe-B-plane-0
[743.592222] Dynamic subtest pipe-B-plane-0: SUCCESS (4.733s)
[743.602196] Starting dynamic subtest: pipe-B-plane-3
[745.826337] Dynamic subtest pipe-B-plane-3: SUCCESS (2.233s)
[745.836114] Starting dynamic subtest: pipe-B-plane-5
[745.837731] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[746.145332] Subtest pixel-format-source-clamping: SUCCESS (15.463s)
[746.956185] [119/130] (277s left) i915_query (query-topology-kernel-writes)
[747.021199] Starting subtest: query-topology-kernel-writes
[747.023562] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[747.162048] [120/130] (276s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[747.561786] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[748.364899] [121/130] (275s left) gem_exec_reloc (basic-cpu-active)
[748.437556] Subtest basic-cpu-active: SKIP (0.000s)
[748.514330] [122/130] (275s left) gem_exec_fence (concurrent)
[748.679101] Starting subtest: concurrent
[748.683372] Subtest concurrent: SKIP (0.000s)
[750.236016] [123/130] (273s left) perf (short-reads)
[750.381435] Starting subtest: short-reads
[750.398105] Subtest short-reads: SUCCESS (0.017s)
[750.446523] [124/130] (273s left) dumb_buffer (create-clear)
[750.505555] Starting subtest: create-clear
[784.877603] Subtest create-clear: SUCCESS (34.352s)
[784.999764] [125/130] (239s left) kms_psr2_su (page_flip-p010)
[785.056136] Subtest page_flip-P010: SKIP (0.000s)
[785.112492] [126/130] (239s left) i915_pm_rc6_residency (rc6-idle)
[785.173632] Starting subtest: rc6-idle
[785.192263] Starting dynamic subtest: gt0-rcs0
[809.537693] Dynamic subtest gt0-rcs0: SUCCESS (24.333s)
[809.552601] Starting dynamic subtest: gt0-bcs0
[833.889847] Dynamic subtest gt0-bcs0: SUCCESS (24.338s)
[833.899107] Starting dynamic subtest: gt0-ccs0
[858.317181] Dynamic subtest gt0-ccs0: SUCCESS (24.413s)
[858.327157] Starting dynamic subtest: gt1-vcs0
[864.493651] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[864.505374] Starting dynamic subtest: gt1-vecs0
[870.666332] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[870.669218] Subtest rc6-idle: SUCCESS (85.454s)
[870.799992] [127/130] (153s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[870.900642] Starting subtest: plane-scaler-unity-scaling-with-rotation
[870.902881] Starting dynamic subtest: pipe-A
[871.130023] Dynamic subtest pipe-A: SUCCESS (0.229s)
[871.139927] Starting dynamic subtest: pipe-B
[872.411943] Dynamic subtest pipe-B: SUCCESS (1.281s)
[872.421528] Starting dynamic subtest: pipe-C
[873.751699] Dynamic subtest pipe-C: SUCCESS (1.338s)
[873.761505] Starting dynamic subtest: pipe-D
[875.085015] Dynamic subtest pipe-D: SUCCESS (1.332s)
[875.087302] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.183s)
[876.296969] [128/130] (148s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[876.396084] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[876.400188] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[876.529560] [129/130] (147s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[876.649345] Starting subtest: cursor-vs-flip-legacy
[905.954572] Subtest cursor-vs-flip-legacy: SUCCESS (29.290s)
[906.820908] [130/130] (117s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[906.875238] Starting subtest: multi-wait-available-submitted-signaled
[906.877201] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[907.008357] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_ctx_exec
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: core_getstats
results: parsing output: 9/ for test: i915_hangman
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_feature_discovery
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_scaling_modes
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: gem_spin_batch
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_tiled_blits
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_plane_alpha_blend
results: parsing output: 80/ for test: i915_selftest
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: gem_exec_flush
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_query
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_dirtyfb
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_fbcon_fbt
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: gen7_exec_parse
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: dmabuf_sync_file
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_basic
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_ctx_bad_destroy
results: parsing output: 109/ for test: core_getclient
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: gem_exec_suspend
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_chamelium_edid
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: dumb_buffer
results: parsing output: 124/ for test: kms_psr2_su
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: syncobj_timeline
Done.