[103.871172] Initializing watchdogs
[103.871304]   /dev/watchdog0
[103.885426] [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]
[103.889081] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[103.891241] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[103.894427] [001/131] (960s left) gem_spin_batch (legacy-resubmit-new)
[104.009298] Starting subtest: legacy-resubmit-new
[104.011645] Starting dynamic subtest: default
[104.021914] Dynamic subtest default: SUCCESS (0.012s)
[104.029201] Starting dynamic subtest: render
[104.031442] Dynamic subtest render: SUCCESS (0.005s)
[104.038771] Starting dynamic subtest: bsd
[104.040702] Dynamic subtest bsd: SUCCESS (0.007s)
[104.047816] Starting dynamic subtest: bsd1
[104.050093] Dynamic subtest bsd1: SUCCESS (0.006s)
[104.056842] Starting dynamic subtest: bsd2
[104.059151] Dynamic subtest bsd2: SUCCESS (0.004s)
[104.064986] Starting dynamic subtest: blt
[104.066873] Dynamic subtest blt: SUCCESS (0.006s)
[104.072621] Starting dynamic subtest: vebox
[104.074528] Dynamic subtest vebox: SUCCESS (0.005s)
[104.076416] Subtest legacy-resubmit-new: SUCCESS (0.047s)
[106.001875] [002/131] (958s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[106.116313] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[106.118843] Starting dynamic subtest: pipe-A-eDP-1
[106.142345] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[106.150151] Starting dynamic subtest: pipe-B-eDP-1
[106.172124] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.178520] Starting dynamic subtest: pipe-C-eDP-1
[106.200774] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.207614] Starting dynamic subtest: pipe-D-eDP-1
[106.229601] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.234069] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[108.281225] [003/131] (956s left) prime_busy (before-wait)
[108.343078] Starting subtest: before-wait
[108.347905] Starting dynamic subtest: rcs0
[108.390068] Dynamic subtest rcs0: SUCCESS (0.043s)
[108.398618] Starting dynamic subtest: bcs0
[108.444666] Dynamic subtest bcs0: SUCCESS (0.054s)
[108.453077] Starting dynamic subtest: vcs0
[108.485342] Dynamic subtest vcs0: SUCCESS (0.040s)
[108.493642] Starting dynamic subtest: vcs1
[108.525554] Dynamic subtest vcs1: SUCCESS (0.040s)
[108.533171] Starting dynamic subtest: vecs0
[108.567068] Dynamic subtest vecs0: SUCCESS (0.041s)
[108.575158] Starting dynamic subtest: ccs0
[108.608079] Dynamic subtest ccs0: SUCCESS (0.041s)
[108.717625] Subtest before-wait: SUCCESS (0.372s)
[108.780929] [004/131] (955s left) gem_exec_schedule (timeslicing)
[108.854476] Starting subtest: timeslicing
[108.856570] Starting dynamic subtest: rcs0
[108.863340] Dynamic subtest rcs0: SUCCESS (0.021s)
[108.872574] Starting dynamic subtest: bcs0
[108.883494] Dynamic subtest bcs0: SUCCESS (0.020s)
[108.889659] Starting dynamic subtest: vcs0
[108.902776] Dynamic subtest vcs0: SUCCESS (0.019s)
[108.908946] Starting dynamic subtest: vcs1
[108.920781] Dynamic subtest vcs1: SUCCESS (0.018s)
[108.930732] Starting dynamic subtest: vecs0
[108.941404] Dynamic subtest vecs0: SUCCESS (0.020s)
[108.948083] Starting dynamic subtest: ccs0
[108.961604] Dynamic subtest ccs0: SUCCESS (0.020s)
[108.963892] Subtest timeslicing: SUCCESS (0.119s)
[110.986698] [005/131] (953s left) syncobj_eventfd (invalid-illegal-eventfd)
[111.035090] Starting subtest: invalid-illegal-eventfd
[111.037472] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[111.130037] [006/131] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[111.232798] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[111.237248] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[111.333156] [007/131] (953s left) kms_flip (flip-vs-blocking-wf-vblank)
[111.430289] Starting subtest: flip-vs-blocking-wf-vblank
[111.432679] Starting dynamic subtest: A-eDP1
[120.433899] Dynamic subtest A-eDP1: SUCCESS (9.001s)
[120.441147] Starting dynamic subtest: B-eDP1
[129.357308] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[129.365511] Starting dynamic subtest: C-eDP1
[138.277277] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[138.285332] Starting dynamic subtest: D-eDP1
[147.200743] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[147.203273] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.767s)
[148.406529] [008/131] (916s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[148.520465] Starting subtest: x-tiled-32bpp-rotate-90
[148.540944] Subtest x-tiled-32bpp-rotate-90: SKIP (0.018s)
[148.664521] [009/131] (915s left) gem_ctx_shared (create-shared-gtt)
[148.720618] Starting subtest: create-shared-gtt
[150.874388] Subtest create-shared-gtt: SUCCESS (2.152s)
[151.257425] [010/131] (913s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[151.367526] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[151.371742] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[151.460504] [011/131] (913s left) gem_eio (in-flight-external)
[151.692592] Starting subtest: in-flight-external
[153.017421] Subtest in-flight-external: SUCCESS (1.323s)
[153.162291] [012/131] (911s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[153.220220] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[153.320679] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[153.388165] [013/131] (911s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[153.436951] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[153.537092] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[153.603009] [014/131] (911s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[153.704619] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[157.274567] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.573s)
[157.392694] [015/131] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[157.496906] Starting subtest: fbcpsr-rgb565-draw-blt
[162.425757] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (4.932s)
[162.585176] [016/131] (902s left) kms_psr (fbc-pr-primary-mmap-gtt)
[162.690215] Starting subtest: fbc-pr-primary-mmap-gtt
[162.694787] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[162.753036] [017/131] (902s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[167.744913] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[167.747343] Starting dynamic subtest: pipe-A-eDP-1
[168.530442] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[168.538836] Starting dynamic subtest: pipe-B-eDP-1
[169.653159] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[169.657261] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.905s)
[170.829146] [018/131] (894s left) syncobj_basic (bad-handle-to-fd)
[170.874492] Starting subtest: bad-handle-to-fd
[170.876861] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[170.960172] [019/131] (893s left) sw_sync (sync_merge)
[170.997251] Starting subtest: sync_merge
[170.999415] Subtest sync_merge: SUCCESS (0.000s)
[171.048808] [020/131] (893s left) kms_chamelium_color (ctm-limited-range)
[171.151162] Subtest ctm-limited-range: SKIP (0.000s)
[171.185263] [021/131] (893s left) gem_flink_basic (basic)
[171.240103] Starting subtest: basic
[171.242108] Subtest basic: SUCCESS (0.000s)
[171.354438] [022/131] (893s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[171.443702] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[171.445972] Starting dynamic subtest: A-eDP1
[175.028272] Dynamic subtest A-eDP1: SUCCESS (3.582s)
[175.037061] Starting dynamic subtest: B-eDP1
[178.102706] Dynamic subtest B-eDP1: SUCCESS (3.072s)
[178.110458] Starting dynamic subtest: C-eDP1
[181.175270] Dynamic subtest C-eDP1: SUCCESS (3.073s)
[181.181674] Starting dynamic subtest: D-eDP1
[184.262904] Dynamic subtest D-eDP1: SUCCESS (3.085s)
[184.265076] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.818s)
[185.042566] [023/131] (880s left) api_intel_bb (intel-bb-blit-x)
[185.102147] Starting subtest: intel-bb-blit-x
[188.584504] Subtest intel-bb-blit-x: SUCCESS (3.481s)
[188.707839] [024/131] (876s left) gem_exec_suspend (basic-s3)
[188.765234] Starting subtest: basic-S3
[188.767687] Starting dynamic subtest: smem
[208.471109] Dynamic subtest smem: SUCCESS (6.132s)
[208.474312] Subtest basic-S3: SUCCESS (6.133s)
[208.649599] [025/131] (870s left) kms_psr (fbc-psr2-dpms)
[208.756526] Starting subtest: fbc-psr2-dpms
[208.758878] Starting dynamic subtest: eDP-1
[208.763315] Dynamic subtest eDP-1: SKIP (0.000s)
[208.767693] Subtest fbc-psr2-dpms: SKIP (0.000s)
[208.821908] [026/131] (869s left) gen3_mixed_blits
[208.956266] [027/131] (869s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[209.070976] Starting subtest: y-tiled-addfb-size-offset-overflow
[209.075481] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[209.178498] [028/131] (869s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[209.243569] Starting subtest: multi-wait-all-for-submit-signaled
[209.245850] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[209.335202] [029/131] (869s left) device_reset (unbind-reset-rebind)
[209.382429] Starting subtest: unbind-reset-rebind
[214.058567] Subtest unbind-reset-rebind: SUCCESS (4.619s)
[214.099558] [030/131] (864s left) kms_vrr (max-min)
[214.202864] Starting subtest: max-min
[214.209369] Subtest max-min: SKIP (0.000s)
[214.269281] [031/131] (864s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[214.371329] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[214.373698] Starting dynamic subtest: pipe-A-eDP-1
[246.655082] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.799s)
[246.663501] Starting dynamic subtest: pipe-B-eDP-1
[279.566958] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.405s)
[279.575679] Starting dynamic subtest: pipe-C-eDP-1
[312.560865] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.348s)
[312.569817] Starting dynamic subtest: pipe-D-eDP-1
[345.546184] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.399s)
[345.549161] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (12.954s)
[346.778569] [032/131] (850s left) gem_pxp (create-protected-buffer)
[346.904210] Starting subtest: create-protected-buffer
[346.907120] Subtest create-protected-buffer: SUCCESS (0.000s)
[347.002812] [033/131] (850s left) gem_exec_whisper (basic-contexts)
[347.073802] Starting subtest: basic-contexts
[352.493592] Subtest basic-contexts: SUCCESS (5.347s)
[352.673315] [034/131] (844s left) kms_flip (2x-plain-flip-fb-recreate)
[352.775084] Starting subtest: 2x-plain-flip-fb-recreate
[352.786856] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[352.862327] [035/131] (844s left) core_auth (many-magics)
[352.913670] Starting subtest: many-magics
[353.613870] Subtest many-magics: SUCCESS (0.698s)
[353.804781] [036/131] (843s left) kms_pwrite_crc
[355.400390] [037/131] (842s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[355.515096] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[361.981871] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.442s)
[362.100541] [038/131] (835s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[362.206973] Starting subtest: plane-downscale-factor-0-5-with-rotation
[362.209602] Starting dynamic subtest: pipe-A
[362.219299] Dynamic subtest pipe-A: SKIP (0.004s)
[362.228606] Starting dynamic subtest: pipe-B
[362.238697] Dynamic subtest pipe-B: SKIP (0.014s)
[362.247819] Starting dynamic subtest: pipe-C
[362.259034] Dynamic subtest pipe-C: SKIP (0.014s)
[362.267734] Starting dynamic subtest: pipe-D
[362.277993] Dynamic subtest pipe-D: SKIP (0.014s)
[362.283130] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.048s)
[362.332596] [039/131] (835s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[362.448672] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[366.669880] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.215s)
[366.784010] [040/131] (830s left) kms_vblank (query-forked)
[366.886965] Starting subtest: query-forked
[366.889560] Starting dynamic subtest: pipe-A-eDP-1
[368.751508] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.859s)
[368.768027] Starting dynamic subtest: pipe-D-eDP-1
[371.312239] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[371.314958] Subtest query-forked: SUCCESS (4.419s)
[372.137427] [041/131] (825s left) intel_hwmon (hwmon-read)
[372.203777] Subtest hwmon-read: SKIP (0.000s)
[372.269446] [042/131] (825s left) syncobj_timeline (invalid-signal-illegal-handle)
[372.331764] Starting subtest: invalid-signal-illegal-handle
[372.334211] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[372.422334] [043/131] (825s left) perf_pmu (busy-start)
[372.466903] Starting subtest: busy-start
[372.468970] Starting dynamic subtest: rcs0
[375.015621] Dynamic subtest rcs0: SUCCESS (2.548s)
[375.028001] Starting dynamic subtest: bcs0
[377.565642] Dynamic subtest bcs0: SUCCESS (2.548s)
[377.576938] Starting dynamic subtest: vcs0
[381.529639] Dynamic subtest vcs0: SUCCESS (3.963s)
[381.541999] Starting dynamic subtest: vcs1
[385.497686] Dynamic subtest vcs1: SUCCESS (3.967s)
[385.510339] Starting dynamic subtest: vecs0
[389.467820] Dynamic subtest vecs0: SUCCESS (3.969s)
[389.480441] Starting dynamic subtest: ccs0
[392.019729] Dynamic subtest ccs0: SUCCESS (2.551s)
[392.022831] Subtest busy-start: SUCCESS (19.557s)
[392.140765] [044/131] (805s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[392.250802] Starting subtest: extended-pageflip-modeset-hang-oldfb
[392.253352] Starting dynamic subtest: pipe-A
[400.177184] Dynamic subtest pipe-A: SUCCESS (7.924s)
[400.187098] Starting dynamic subtest: pipe-D
[408.736312] Dynamic subtest pipe-D: SUCCESS (8.554s)
[408.739363] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.482s)
[409.585584] [045/131] (788s left) gem_render_copy (linear-to-vebox-yf-tiled)
[409.642313] Starting subtest: linear-to-vebox-yf-tiled
[409.648123] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[409.823196] [046/131] (788s left) gem_exec_schedule (noreorder)
[410.010625] Starting subtest: noreorder
[410.013301] Starting dynamic subtest: rcs0
[410.093562] Dynamic subtest rcs0: SUCCESS (0.082s)
[410.106301] Starting dynamic subtest: vcs0
[411.496156] Dynamic subtest vcs0: SUCCESS (1.399s)
[411.506083] Starting dynamic subtest: vcs1
[413.484684] Dynamic subtest vcs1: SUCCESS (1.987s)
[413.496329] Starting dynamic subtest: vecs0
[415.497133] Dynamic subtest vecs0: SUCCESS (2.009s)
[415.507881] Starting dynamic subtest: ccs0
[415.588706] Dynamic subtest ccs0: SUCCESS (0.091s)
[415.591583] Subtest noreorder: SUCCESS (5.578s)
[415.773756] [047/131] (782s left) gem_exec_params (invalid-bsd1-flag-on-render)
[415.839656] Starting subtest: invalid-bsd1-flag-on-render
[415.842697] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[415.954452] [048/131] (781s left) api_intel_bb (reset-bb)
[416.020601] Starting subtest: reset-bb
[416.026195] Subtest reset-bb: SUCCESS (0.008s)
[416.151827] [049/131] (781s left) kms_psr (pr-sprite-plane-move)
[416.263089] Starting subtest: pr-sprite-plane-move
[416.268142] Subtest pr-sprite-plane-move: SKIP (0.000s)
[416.324697] [050/131] (781s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[416.434882] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[416.440230] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[416.547528] [051/131] (781s left) gem_lmem_swapping (verify-random)
[416.588605] Subtest verify-random: SKIP (0.000s)
[416.627252] [052/131] (781s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[416.683914] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[416.686234] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[416.768670] [053/131] (781s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[417.148747] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[417.991319] [054/131] (780s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[418.098186] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[418.103636] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[418.204785] [055/131] (779s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[418.307110] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[418.312121] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[418.409950] [056/131] (779s left) kms_feature_discovery (display-2x)
[418.517131] Starting subtest: display-2x
[418.522156] Subtest display-2x: SKIP (0.000s)
[418.580613] [057/131] (779s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[418.696071] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[421.884697] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (3.194s)
[422.035104] [058/131] (776s left) gen9_exec_parse (allowed-all)
[422.095842] Subtest allowed-all: SKIP (0.000s)
[422.164087] [059/131] (776s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[422.268573] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[422.270873] Starting dynamic subtest: pipe-A-eDP-1
[423.014053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[423.022832] Starting dynamic subtest: pipe-B-eDP-1
[424.777566] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.761s)
[424.787435] Starting dynamic subtest: pipe-C-eDP-1
[426.610227] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.830s)
[426.618900] Starting dynamic subtest: pipe-D-eDP-1
[428.443886] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.832s)
[428.446156] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.163s)
[429.565839] [060/131] (768s left) i915_pm_rpm (gem-execbuf)
[431.705246] Starting subtest: gem-execbuf
[431.708309] Starting dynamic subtest: smem0
[433.108028] Dynamic subtest smem0: SUCCESS (1.402s)
[433.110253] Subtest gem-execbuf: SUCCESS (1.403s)
[433.199046] [061/131] (765s left) kms_psr (psr-cursor-plane-move)
[433.297947] Starting subtest: psr-cursor-plane-move
[433.300364] Starting dynamic subtest: eDP-1
[435.046398] Dynamic subtest eDP-1: SUCCESS (1.747s)
[435.049215] Subtest psr-cursor-plane-move: SUCCESS (1.747s)
[435.903209] [062/131] (762s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[436.008165] Starting subtest: fbcpsr-slowdraw
[459.061614] Subtest fbcpsr-slowdraw: SUCCESS (23.059s)
[459.224629] [063/131] (739s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[459.345036] Starting subtest: cursorA-vs-flipB-varying-size
[459.349999] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[459.441656] [064/131] (739s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[459.549805] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[460.772851] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.225s)
[461.027781] [065/131] (737s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[461.155333] Starting subtest: cursorA-vs-flipA-toggle
[472.298690] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.145s)
[473.169659] [066/131] (725s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[473.239816] Starting subtest: basic-batch-kernel-default-cmd
[473.245203] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[473.417751] [067/131] (725s left) gem_exec_balancer (parallel-balancer)
[473.654290] Starting subtest: parallel-balancer
[474.364181] Subtest parallel-balancer: SUCCESS (0.711s)
[474.482251] [068/131] (724s left) kms_cursor_crc (cursor-sliding-64x64)
[474.643807] Starting subtest: cursor-sliding-64x64
[474.646413] Starting dynamic subtest: pipe-A-eDP-1
[478.254233] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.606s)
[478.283083] Starting dynamic subtest: pipe-D-eDP-1
[482.582936] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.308s)
[482.585559] Subtest cursor-sliding-64x64: SUCCESS (7.939s)
[483.420950] [069/131] (715s left) kms_cursor_crc (cursor-size-change)
[483.520098] Starting subtest: cursor-size-change
[483.522787] Starting dynamic subtest: pipe-A-eDP-1
[484.351577] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[484.361839] Starting dynamic subtest: pipe-D-eDP-1
[485.806215] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.453s)
[485.808315] Subtest cursor-size-change: SUCCESS (2.284s)
[486.663314] [070/131] (712s left) gem_busy (close-race)
[486.738050] Starting subtest: close-race
[512.474118] Subtest close-race: SUCCESS (25.729s)
[512.851500] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[512.857207] [071/131] (685s left) gem_mmap_wc (write-gtt-read-wc)
[512.966142] Subtest write-gtt-read-wc: SKIP (0.000s)
[513.025010] [072/131] (685s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[513.127536] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[515.851076] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.728s)
[515.999774] [073/131] (682s left) perf_pmu (frequency)
[516.041967] Starting subtest: frequency
[516.046627] Starting dynamic subtest: gt0
[518.236179] Dynamic subtest gt0: SUCCESS (2.184s)
[518.249106] Starting dynamic subtest: idle-gt0
[518.741518] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[518.753617] Starting dynamic subtest: gt1
[523.504080] Dynamic subtest gt1: SUCCESS (4.756s)
[523.516889] Starting dynamic subtest: idle-gt1
[524.007014] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[524.009931] Subtest frequency: SUCCESS (7.964s)
[524.121669] [074/131] (674s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[524.214961] Starting subtest: primary-x-tiled-reflect-x-0
[531.341963] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.125s)
[532.545644] [075/131] (666s left) gem_exec_params (invalid-fence-in)
[532.605594] Starting subtest: invalid-fence-in
[532.608243] Subtest invalid-fence-in: SUCCESS (0.000s)
[532.692276] [076/131] (666s left) kms_cursor_crc (cursor-onscreen-512x170)
[532.950912] Starting subtest: cursor-onscreen-512x170
[532.955562] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[533.091176] [077/131] (665s left) kms_lease (cursor-implicit-plane)
[533.192889] Starting subtest: cursor-implicit-plane
[533.195341] Starting dynamic subtest: pipe-A-eDP-1
[533.662482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s)
[533.673614] Starting dynamic subtest: pipe-B-eDP-1
[534.753861] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.089s)
[534.763434] Starting dynamic subtest: pipe-C-eDP-1
[535.871693] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[535.881558] Starting dynamic subtest: pipe-D-eDP-1
[537.002480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[537.005331] Subtest cursor-implicit-plane: SUCCESS (3.808s)
[537.847401] [078/131] (661s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[537.908724] Starting subtest: single-wait-for-submit-available-signaled
[537.911550] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[538.025207] [079/131] (661s left) kms_async_flips (alternate-sync-async-flip)
[538.126075] Starting subtest: alternate-sync-async-flip
[538.498899] Starting dynamic subtest: pipe-A-eDP-1
[541.240110] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.742s)
[541.608588] Starting dynamic subtest: pipe-B-eDP-1
[544.363173] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[544.746902] Starting dynamic subtest: pipe-C-eDP-1
[547.497453] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s)
[547.862088] Starting dynamic subtest: pipe-D-eDP-1
[550.622358] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[550.624811] Subtest alternate-sync-async-flip: SUCCESS (12.496s)
[551.787020] [080/131] (647s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[551.895092] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[551.900143] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[552.001695] [081/131] (647s left) kms_plane_lowres (tiling-4)
[552.097761] Starting subtest: tiling-4
[552.100099] Starting dynamic subtest: pipe-A-eDP-1
[552.104954] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[552.393052] Starting dynamic subtest: pipe-B-eDP-1
[552.397912] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[552.408308] Starting dynamic subtest: pipe-C-eDP-1
[552.413462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[552.422006] Starting dynamic subtest: pipe-D-eDP-1
[552.427009] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[552.431886] Subtest tiling-4: SKIP (0.289s)
[553.207547] [082/131] (645s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[553.300005] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[553.305017] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[554.433155] [083/131] (644s left) kms_writeback (writeback-pixel-formats)
[554.540294] Subtest writeback-pixel-formats: SKIP (0.000s)
[554.579733] [084/131] (644s left) gem_mmap (short-mmap)
[554.642084] Subtest short-mmap: SKIP (0.000s)
[554.696222] [085/131] (644s left) kms_pm_dc (dc5-dpms-negative)
[555.801976] Starting subtest: dc5-dpms-negative
[555.807151] Subtest dc5-dpms-negative: SKIP (0.000s)
[555.867771] [086/131] (643s left) gem_mmap_offset (bad-extensions)
[555.923343] Starting subtest: bad-extensions
[555.926146] Subtest bad-extensions: SUCCESS (0.000s)
[556.014231] [087/131] (643s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[556.110027] Starting subtest: plane-upscale-20x20-with-rotation
[556.112484] Starting dynamic subtest: pipe-A
[556.337322] Dynamic subtest pipe-A: SUCCESS (0.227s)
[556.347854] Starting dynamic subtest: pipe-B
[557.615340] Dynamic subtest pipe-B: SUCCESS (1.277s)
[557.625494] Starting dynamic subtest: pipe-C
[558.940991] Dynamic subtest pipe-C: SUCCESS (1.325s)
[558.950058] Starting dynamic subtest: pipe-D
[560.268043] Dynamic subtest pipe-D: SUCCESS (1.326s)
[560.270919] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.157s)
[561.440334] [088/131] (637s left) gem_mmap_gtt (big-copy-xy)
[561.501947] Subtest big-copy-XY: SKIP (0.000s)
[561.552566] [089/131] (637s left) perf (polling)
[561.665825] Starting subtest: polling
[561.668041] Starting dynamic subtest: 0-rcs0
[571.687725] Dynamic subtest 0-rcs0: SUCCESS (10.022s)
[571.698349] Starting dynamic subtest: 1-vcs0
[581.705711] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[581.708356] Subtest polling: SUCCESS (20.043s)
[581.752890] [090/131] (617s left) kms_psr (pr-cursor-plane-move)
[581.859073] Starting subtest: pr-cursor-plane-move
[581.864397] Subtest pr-cursor-plane-move: SKIP (0.000s)
[581.930893] [091/131] (617s left) gem_exec_gttfill (multigpu-basic)
[582.110037] Starting subtest: multigpu-basic
[597.974236] Subtest multigpu-basic: SUCCESS (15.867s)
[598.018201] [092/131] (601s left) i915_pm_rpm (gem-mmap-type)
[599.718712] Starting subtest: gem-mmap-type
[599.721939] Starting dynamic subtest: wb-smem0
[603.739332] Dynamic subtest wb-smem0: SUCCESS (4.019s)
[603.749737] Starting dynamic subtest: wc-smem0
[606.579171] Dynamic subtest wc-smem0: SUCCESS (2.840s)
[606.589248] Starting dynamic subtest: uc-smem0
[609.423039] Dynamic subtest uc-smem0: SUCCESS (2.841s)
[609.426073] Subtest gem-mmap-type: SUCCESS (9.705s)
[609.509698] [093/131] (590s left) gem_softpin (evict-prime)
[609.587062] Starting subtest: evict-prime
[609.589714] Starting dynamic subtest: rcs0
[610.752052] Dynamic subtest rcs0: SUCCESS (1.165s)
[610.765501] Starting dynamic subtest: bcs0
[611.896161] Dynamic subtest bcs0: SUCCESS (1.142s)
[611.908876] Starting dynamic subtest: vcs0
[613.477334] Dynamic subtest vcs0: SUCCESS (1.578s)
[613.495667] Starting dynamic subtest: vcs1
[615.475516] Dynamic subtest vcs1: SUCCESS (1.996s)
[615.488084] Starting dynamic subtest: vecs0
[617.517661] Dynamic subtest vecs0: SUCCESS (2.040s)
[617.531322] Starting dynamic subtest: ccs0
[618.647044] Dynamic subtest ccs0: SUCCESS (1.128s)
[618.657598] Starting dynamic subtest: all
[620.489576] Dynamic subtest all: SUCCESS (1.839s)
[620.492498] Subtest evict-prime: SUCCESS (10.902s)
[620.625584] [094/131] (578s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[620.899072] Starting subtest: cursor-rapid-movement-max-size
[620.907113] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[621.009805] [095/131] (578s left) gem_exec_schedule (preempt-self)
[621.099067] Starting subtest: preempt-self
[621.101564] Starting dynamic subtest: rcs0
[621.110937] Dynamic subtest rcs0: SUCCESS (0.023s)
[621.121648] Starting dynamic subtest: bcs0
[621.127494] Dynamic subtest bcs0: SUCCESS (0.014s)
[621.143115] Starting dynamic subtest: vcs0
[621.145755] Dynamic subtest vcs0: SUCCESS (0.017s)
[621.159577] Starting dynamic subtest: vcs1
[621.162181] Dynamic subtest vcs1: SUCCESS (0.016s)
[621.178097] Starting dynamic subtest: vecs0
[621.180814] Dynamic subtest vecs0: SUCCESS (0.013s)
[621.193070] Starting dynamic subtest: ccs0
[621.195763] Dynamic subtest ccs0: SUCCESS (0.016s)
[621.198316] Subtest preempt-self: SUCCESS (0.102s)
[622.592629] [096/131] (577s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[622.652718] Starting subtest: etime-multi-wait-all-submitted-signaled
[622.758362] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[622.830512] [097/131] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[622.952208] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[622.958341] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[623.040129] [098/131] (576s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[623.157296] Starting subtest: flip-vs-cursor-varying-size
[630.840590] Subtest flip-vs-cursor-varying-size: SUCCESS (7.682s)
[631.695646] [099/131] (568s left) kms_dp_link_training (non-uhbr-sst)
[631.799052] Starting subtest: non-uhbr-sst
[631.809111] Subtest non-uhbr-sst: SKIP (0.000s)
[631.868671] [100/131] (567s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[631.978141] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[631.983902] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[632.088607] [101/131] (567s left) kms_content_protection (dp-mst-lic-type-1)
[632.253974] Starting subtest: dp-mst-lic-type-1
[632.258847] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[632.400396] [102/131] (567s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[634.643315] Starting subtest: modeset-lpsp-stress-no-wait
[644.171105] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.525s)
[644.240086] [103/131] (555s left) gem_mmap_gtt (fault-concurrent-y)
[644.300164] Subtest fault-concurrent-Y: SKIP (0.000s)
[644.356521] [104/131] (555s left) kms_scaling_modes (scaling-mode-none)
[644.456053] Starting subtest: scaling-mode-none
[644.458789] Starting dynamic subtest: pipe-A-eDP-1
[644.568235] Dynamic subtest pipe-A-eDP-1: SKIP (0.112s)
[644.578549] Starting dynamic subtest: pipe-B-eDP-1
[644.619039] Dynamic subtest pipe-B-eDP-1: SKIP (0.050s)
[644.631787] Starting dynamic subtest: pipe-C-eDP-1
[644.672599] Dynamic subtest pipe-C-eDP-1: SKIP (0.050s)
[644.685333] Starting dynamic subtest: pipe-D-eDP-1
[644.720286] Dynamic subtest pipe-D-eDP-1: SKIP (0.048s)
[644.725225] Subtest scaling-mode-none: SKIP (0.264s)
[644.853670] [105/131] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[644.969109] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[649.537042] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.572s)
[649.702629] [106/131] (550s left) gen9_exec_parse (batch-zero-length)
[649.777119] Subtest batch-zero-length: SKIP (0.000s)
[649.841644] [107/131] (550s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[649.950117] Starting subtest: yf-tiled-8bpp-rotate-270
[649.955110] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[650.058753] [108/131] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[650.160610] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[650.166139] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[650.262820] [109/131] (549s left) gem_ctx_engines (execute-oneforall)
[650.324746] Starting subtest: execute-oneforall
[650.794475] Subtest execute-oneforall: SUCCESS (0.470s)
[652.618639] [110/131] (547s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[652.721957] Starting subtest: 4-tiled-32bpp-rotate-90
[652.741195] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[652.858676] [111/131] (547s left) gem_exec_params (invalid-ring)
[652.918982] Starting subtest: invalid-ring
[652.921563] Subtest invalid-ring: SUCCESS (0.000s)
[653.029790] [112/131] (547s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[658.044205] Starting subtest: pr-cursor-plane-update-sf
[658.049900] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[658.880700] [113/131] (541s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[658.971113] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[658.973855] Starting dynamic subtest: pipe-A-default-mode
[659.259296] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[659.264855] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.287s)
[660.100798] [114/131] (540s left) syncobj_basic (bad-destroy-pad)
[660.177197] Starting subtest: bad-destroy-pad
[660.179802] Subtest bad-destroy-pad: SUCCESS (0.000s)
[660.268906] [115/131] (540s left) gem_exec_capture (capture)
[660.347286] Starting subtest: capture
[660.349927] Starting dynamic subtest: rcs0-smem
[661.187627] Dynamic subtest rcs0-smem: SUCCESS (0.836s)
[661.198838] Starting dynamic subtest: bcs0-smem
[662.507743] Dynamic subtest bcs0-smem: SUCCESS (1.323s)
[662.520249] Starting dynamic subtest: vcs0-smem
[663.327250] Dynamic subtest vcs0-smem: SUCCESS (0.819s)
[663.340075] Starting dynamic subtest: vcs1-smem
[664.149848] Dynamic subtest vcs1-smem: SUCCESS (0.822s)
[664.164896] Starting dynamic subtest: vecs0-smem
[665.562911] Dynamic subtest vecs0-smem: FAIL (1.337s)
[665.573836] Starting dynamic subtest: ccs0-smem
[666.808943] Dynamic subtest ccs0-smem: SUCCESS (1.317s)
[666.811558] Subtest capture: FAIL (6.458s)
[666.929013] [116/131] (533s left) syncobj_timeline (wait-for-submit-complex)
[666.988293] Starting subtest: wait-for-submit-complex
[667.047309] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[667.120224] [117/131] (533s left) gem_busy (extended)
[667.323782] Starting subtest: extended
[667.326336] Starting dynamic subtest: rcs0
[667.438805] Dynamic subtest rcs0: SUCCESS (0.114s)
[667.451219] Starting dynamic subtest: bcs0
[667.483848] Dynamic subtest bcs0: SUCCESS (0.044s)
[667.494338] Starting dynamic subtest: vcs0
[669.465811] Dynamic subtest vcs0: SUCCESS (1.979s)
[669.479342] Starting dynamic subtest: vcs1
[671.513736] Dynamic subtest vcs1: SUCCESS (2.046s)
[671.526620] Starting dynamic subtest: vecs0
[673.498123] Dynamic subtest vecs0: SUCCESS (1.982s)
[673.511524] Starting dynamic subtest: ccs0
[673.543010] Dynamic subtest ccs0: SUCCESS (0.044s)
[673.545909] Subtest extended: SUCCESS (6.219s)
[673.792140] [118/131] (526s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[673.903808] Starting subtest: psr-indfb-scaledprimary
[677.565148] Subtest psr-indfb-scaledprimary: SUCCESS (3.667s)
[677.703877] [119/131] (522s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[677.830966] Starting subtest: 2x-flip-vs-cursor-atomic
[677.836095] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[677.922670] [120/131] (522s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[678.033098] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[678.038171] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[678.129400] [121/131] (522s left) kms_properties (connector-properties-legacy)
[678.228334] Starting subtest: connector-properties-legacy
[678.231181] Starting dynamic subtest: pipe-A-eDP-1
[685.915957] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.683s)
[685.926345] Starting dynamic subtest: pipe-None-DP-1
[685.931143] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[685.940300] Starting dynamic subtest: pipe-None-HDMI-A-1
[685.946050] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[685.955095] Starting dynamic subtest: pipe-None-DP-2
[685.959907] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[685.969121] Starting dynamic subtest: pipe-None-HDMI-A-2
[685.974328] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[685.984070] Starting dynamic subtest: pipe-None-DP-3
[685.988319] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[685.997307] Starting dynamic subtest: pipe-None-DP-4
[686.002227] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[686.004554] Subtest connector-properties-legacy: SUCCESS (7.693s)
[686.774649] [122/131] (513s left) gem_softpin (overlap)
[686.841003] Starting subtest: overlap
[687.590594] Subtest overlap: SUCCESS (0.748s)
[687.703758] [123/131] (512s left) gem_tiled_swapping (non-threaded)
[687.756172] Subtest non-threaded: SKIP (0.000s)
[687.815402] [124/131] (512s left) kms_invalid_mode (zero-vdisplay)
[687.909998] Starting subtest: zero-vdisplay
[687.912634] Starting dynamic subtest: pipe-A-eDP-1
[688.189976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.279s)
[688.201339] Starting dynamic subtest: pipe-B-eDP-1
[688.203753] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[688.213574] Starting dynamic subtest: pipe-C-eDP-1
[688.216213] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[688.226255] Starting dynamic subtest: pipe-D-eDP-1
[688.229191] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[688.231940] Subtest zero-vdisplay: SUCCESS (0.284s)
[688.993959] [125/131] (511s left) kms_plane_alpha_blend (alpha-opaque-fb)
[689.094851] Starting subtest: alpha-opaque-fb
[689.508324] Starting dynamic subtest: pipe-A-eDP-1
[690.070614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[690.082897] Starting dynamic subtest: pipe-D-eDP-1
[691.429875] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.356s)
[691.432167] Subtest alpha-opaque-fb: SUCCESS (2.333s)
[692.251561] [126/131] (508s left) drm_fdinfo (virtual-busy-all)
[692.299207] Starting subtest: virtual-busy-all
[692.304161] Subtest virtual-busy-all: SKIP (0.000s)
[692.368324] [127/131] (508s left) gem_userptr_blits (invalid-null-pointer)
[692.437301] Starting subtest: invalid-null-pointer
[692.440073] Subtest invalid-null-pointer: SUCCESS (0.001s)
[692.572423] [128/131] (508s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[692.944482] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[693.753757] [129/131] (507s left) gem_ctx_sseu (engines)
[693.808605] Subtest engines: SKIP (0.000s)
[693.875029] [130/131] (506s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[693.976110] Starting subtest: x-tiled-16bpp-rotate-180
[695.444323] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.467s)
[695.583112] [131/131] (505s left) gem_ctx_isolation (preservation-s3)
[695.644180] Starting subtest: preservation-S3
[695.647064] Starting dynamic subtest: rcs0
[711.577999] Dynamic subtest rcs0: SUCCESS (1.439s)
[711.589964] Starting dynamic subtest: bcs0
[727.512841] Dynamic subtest bcs0: SUCCESS (1.374s)
[727.530121] Starting dynamic subtest: vcs0
[743.516102] Dynamic subtest vcs0: SUCCESS (3.039s)
[743.526744] Starting dynamic subtest: vcs1
[761.576589] Dynamic subtest vcs1: SUCCESS (4.960s)
[761.590331] Starting dynamic subtest: vecs0
[779.499751] Dynamic subtest vecs0: SUCCESS (3.909s)
[779.512919] Starting dynamic subtest: ccs0
[797.505871] Dynamic subtest ccs0: SUCCESS (3.178s)
[797.509151] Subtest preservation-S3: SUCCESS (17.903s)
[797.756369] Closing watchdogs
results: parsing output: 0/ for test: gem_spin_batch
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: prime_busy
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_ctx_shared
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: syncobj_basic
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_chamelium_color
results: parsing output: 20/ for test: gem_flink_basic
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: gem_exec_suspend
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gen3_mixed_blits
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: device_reset
results: parsing output: 29/ for test: kms_vrr
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: core_auth
results: parsing output: 35/ for test: kms_pwrite_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_vblank
results: parsing output: 40/ for test: intel_hwmon
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: kms_busy
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: gem_exec_params
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_feature_discovery
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: i915_pm_rpm
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_busy
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: gem_exec_params
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_plane_lowres
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_writeback
results: parsing output: 83/ for test: gem_mmap
results: parsing output: 84/ for test: kms_pm_dc
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_exec_gttfill
results: parsing output: 91/ for test: i915_pm_rpm
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_dp_link_training
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_scaling_modes
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_ctx_engines
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: syncobj_basic
results: parsing output: 114/ for test: gem_exec_capture
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_busy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_properties
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: gem_tiled_swapping
results: parsing output: 123/ for test: kms_invalid_mode
results: parsing output: 124/ for test: kms_plane_alpha_blend
results: parsing output: 125/ for test: drm_fdinfo
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_chamelium_hpd
results: parsing output: 128/ for test: gem_ctx_sseu
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_ctx_isolation
Done.